2026-07-17 03:05:55.623792 | Job console starting 2026-07-17 03:05:55.641032 | Updating git repos 2026-07-17 03:05:55.713653 | Cloning repos into workspace 2026-07-17 03:05:55.787006 | Restoring repo states 2026-07-17 03:05:55.806011 | Merging changes 2026-07-17 03:05:55.806035 | Checking out repos 2026-07-17 03:05:55.889148 | Preparing playbooks 2026-07-17 03:05:57.493196 | Running Ansible setup 2026-07-17 03:06:03.608141 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-17 03:06:04.429440 | 2026-07-17 03:06:04.429578 | PLAY [Base pre] 2026-07-17 03:06:04.446453 | 2026-07-17 03:06:04.446561 | TASK [Setup log path fact] 2026-07-17 03:06:04.485517 | debian-bookworm | ok 2026-07-17 03:06:04.505115 | 2026-07-17 03:06:04.505249 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-17 03:06:04.534227 | debian-bookworm | ok 2026-07-17 03:06:04.544776 | 2026-07-17 03:06:04.544895 | TASK [emit-job-header : Print job information] 2026-07-17 03:06:04.594128 | # Job Information 2026-07-17 03:06:04.594323 | Ansible Version: 2.16.14 2026-07-17 03:06:04.594363 | Job: tox 2026-07-17 03:06:04.594401 | Pipeline: periodic-daily 2026-07-17 03:06:04.594427 | Executor: 521e9411259a 2026-07-17 03:06:04.594450 | Triggered by: https://github.com/osism/openstack-image-manager 2026-07-17 03:06:04.594475 | Event ID: 212e7feecb164370a4a1cb15f7538910 2026-07-17 03:06:04.599718 | 2026-07-17 03:06:04.599828 | LOOP [emit-job-header : Print node information] 2026-07-17 03:06:04.735023 | debian-bookworm | ok: 2026-07-17 03:06:04.735225 | debian-bookworm | # Node Information 2026-07-17 03:06:04.735267 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-17 03:06:04.735297 | debian-bookworm | Hostname: debian 2026-07-17 03:06:04.735324 | debian-bookworm | Username: zuul 2026-07-17 03:06:04.735349 | debian-bookworm | Distro: Debian 12.15 2026-07-17 03:06:04.735377 | debian-bookworm | Provider: regiocloud-a 2026-07-17 03:06:04.735402 | debian-bookworm | Region: 2026-07-17 03:06:04.735427 | debian-bookworm | Label: debian-bookworm 2026-07-17 03:06:04.735451 | debian-bookworm | Product Name: OpenStack Nova 2026-07-17 03:06:04.735474 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe6c:142f 2026-07-17 03:06:04.746971 | 2026-07-17 03:06:04.747085 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-17 03:06:05.237997 | debian-bookworm -> localhost | changed 2026-07-17 03:06:05.245464 | 2026-07-17 03:06:05.245617 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-17 03:06:06.321576 | debian-bookworm -> localhost | changed 2026-07-17 03:06:06.334224 | 2026-07-17 03:06:06.334406 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-17 03:06:06.643463 | debian-bookworm -> localhost | ok 2026-07-17 03:06:06.656224 | 2026-07-17 03:06:06.656453 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-17 03:06:06.690997 | debian-bookworm | ok 2026-07-17 03:06:06.709674 | debian-bookworm | included: /var/lib/zuul/builds/c09207f6b4d249b1bfd1aef161f49986/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-17 03:06:06.716174 | 2026-07-17 03:06:06.716291 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-17 03:06:08.089203 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-17 03:06:08.089562 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/c09207f6b4d249b1bfd1aef161f49986/work/c09207f6b4d249b1bfd1aef161f49986_id_rsa 2026-07-17 03:06:08.089639 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/c09207f6b4d249b1bfd1aef161f49986/work/c09207f6b4d249b1bfd1aef161f49986_id_rsa.pub 2026-07-17 03:06:08.089679 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-17 03:06:08.089714 | debian-bookworm -> localhost | SHA256:RIE5jMuiKorxSqZN9527Q4SLhXAbuOV2c4/KiEXQlxc zuul-build-sshkey 2026-07-17 03:06:08.089747 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-17 03:06:08.089795 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-17 03:06:08.089825 | debian-bookworm -> localhost | | o o +Eo | 2026-07-17 03:06:08.089880 | debian-bookworm -> localhost | | + * B.. | 2026-07-17 03:06:08.089913 | debian-bookworm -> localhost | | O * +. | 2026-07-17 03:06:08.089945 | debian-bookworm -> localhost | | o O =.o | 2026-07-17 03:06:08.089978 | debian-bookworm -> localhost | | . + + =So | 2026-07-17 03:06:08.090018 | debian-bookworm -> localhost | |. o . o . | 2026-07-17 03:06:08.090048 | debian-bookworm -> localhost | |oo.o.o o | 2026-07-17 03:06:08.090076 | debian-bookworm -> localhost | |B=....o... | 2026-07-17 03:06:08.090106 | debian-bookworm -> localhost | |B.o . =+ | 2026-07-17 03:06:08.090135 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-17 03:06:08.090227 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.763199 2026-07-17 03:06:08.103070 | 2026-07-17 03:06:08.103260 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-17 03:06:08.133201 | debian-bookworm | ok 2026-07-17 03:06:08.144451 | debian-bookworm | included: /var/lib/zuul/builds/c09207f6b4d249b1bfd1aef161f49986/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-17 03:06:08.152808 | 2026-07-17 03:06:08.152951 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-17 03:06:08.177560 | debian-bookworm | skipping: Conditional result was False 2026-07-17 03:06:08.183979 | 2026-07-17 03:06:08.184108 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-17 03:06:08.925765 | debian-bookworm | changed 2026-07-17 03:06:08.934274 | 2026-07-17 03:06:08.934451 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-17 03:06:09.196641 | debian-bookworm | ok 2026-07-17 03:06:09.211527 | 2026-07-17 03:06:09.211692 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-17 03:06:09.887777 | debian-bookworm | changed 2026-07-17 03:06:09.895318 | 2026-07-17 03:06:09.895477 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-17 03:06:10.642007 | debian-bookworm | changed 2026-07-17 03:06:10.659579 | 2026-07-17 03:06:10.659792 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-17 03:06:10.685497 | debian-bookworm | skipping: Conditional result was False 2026-07-17 03:06:10.693111 | 2026-07-17 03:06:10.693245 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-17 03:06:11.273682 | debian-bookworm -> localhost | changed 2026-07-17 03:06:11.296666 | 2026-07-17 03:06:11.296810 | TASK [add-build-sshkey : Add back temp key] 2026-07-17 03:06:11.993754 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/c09207f6b4d249b1bfd1aef161f49986/work/c09207f6b4d249b1bfd1aef161f49986_id_rsa (zuul-build-sshkey) 2026-07-17 03:06:11.994085 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.024987 2026-07-17 03:06:12.004256 | 2026-07-17 03:06:12.004382 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-17 03:06:12.716587 | debian-bookworm | ok 2026-07-17 03:06:12.726957 | 2026-07-17 03:06:12.727126 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-17 03:06:12.795046 | debian-bookworm | skipping: Conditional result was False 2026-07-17 03:06:12.819410 | 2026-07-17 03:06:12.819709 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-17 03:06:13.427902 | debian-bookworm | ok 2026-07-17 03:06:13.441993 | 2026-07-17 03:06:13.442145 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-17 03:06:13.473506 | debian-bookworm | ok 2026-07-17 03:06:13.479410 | 2026-07-17 03:06:13.479551 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-17 03:06:13.977306 | debian-bookworm -> localhost | ok 2026-07-17 03:06:13.986110 | 2026-07-17 03:06:13.986254 | TASK [validate-host : Collect information about the host] 2026-07-17 03:06:15.699910 | debian-bookworm | ok 2026-07-17 03:06:15.713311 | 2026-07-17 03:06:15.713453 | TASK [validate-host : Sanitize hostname] 2026-07-17 03:06:15.906390 | debian-bookworm | ok 2026-07-17 03:06:15.911964 | 2026-07-17 03:06:15.912090 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-17 03:06:16.620627 | debian-bookworm -> localhost | changed 2026-07-17 03:06:16.627707 | 2026-07-17 03:06:16.627890 | TASK [validate-host : Collect information about zuul worker] 2026-07-17 03:06:17.096207 | debian-bookworm | ok 2026-07-17 03:06:17.101872 | 2026-07-17 03:06:17.102007 | TASK [validate-host : Write out all zuul information for each host] 2026-07-17 03:06:18.137778 | debian-bookworm -> localhost | changed 2026-07-17 03:06:18.157789 | 2026-07-17 03:06:18.157971 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-17 03:06:18.477333 | debian-bookworm | ok 2026-07-17 03:06:18.483659 | 2026-07-17 03:06:18.483777 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-17 03:06:19.431166 | debian-bookworm | changed: 2026-07-17 03:06:19.431531 | debian-bookworm | cd+++++++++ src/ 2026-07-17 03:06:19.431587 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-17 03:06:19.431614 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-17 03:06:19.431638 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-07-17 03:06:19.431660 | debian-bookworm | =7.0.3 2026-07-17 03:06:58.002019 | debian-bookworm | Downloading cachetools-7.1.4-py3-none-any.whl (16 kB) 2026-07-17 03:06:58.059038 | debian-bookworm | Collecting colorama>=0.4.6 2026-07-17 03:06:58.072187 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-07-17 03:06:58.156508 | debian-bookworm | Collecting filelock>=3.25 2026-07-17 03:06:58.167996 | debian-bookworm | Downloading filelock-3.30.2-py3-none-any.whl (94 kB) 2026-07-17 03:06:58.178191 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 94.1/94.1 kB 11.4 MB/s eta 0:00:00 2026-07-17 03:06:58.248623 | debian-bookworm | Collecting packaging>=26 2026-07-17 03:06:58.259824 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-07-17 03:06:58.271099 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 11.5 MB/s eta 0:00:00 2026-07-17 03:06:58.322022 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-07-17 03:06:58.333205 | debian-bookworm | Downloading platformdirs-4.10.0-py3-none-any.whl (22 kB) 2026-07-17 03:06:58.379540 | debian-bookworm | Collecting pluggy>=1.6 2026-07-17 03:06:58.391073 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-07-17 03:06:58.434781 | debian-bookworm | Collecting pyproject-api>=1.10 2026-07-17 03:06:58.447116 | debian-bookworm | Downloading pyproject_api-1.10.1-py3-none-any.whl (12 kB) 2026-07-17 03:06:58.492258 | debian-bookworm | Collecting python-discovery>=1.4.4 2026-07-17 03:06:58.504540 | debian-bookworm | Downloading python_discovery-1.4.4-py3-none-any.whl (34 kB) 2026-07-17 03:06:58.541022 | debian-bookworm | Collecting tomli-w>=1.2 2026-07-17 03:06:58.552766 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-07-17 03:06:58.691073 | debian-bookworm | Collecting virtualenv>=21.1 2026-07-17 03:06:58.702822 | debian-bookworm | Downloading virtualenv-21.6.1-py3-none-any.whl (5.5 MB) 2026-07-17 03:06:58.974434 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.5/5.5 MB 20.6 MB/s eta 0:00:00 2026-07-17 03:06:59.073166 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-07-17 03:06:59.085480 | debian-bookworm | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-07-17 03:06:59.108316 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.6/470.6 kB 24.1 MB/s eta 0:00:00 2026-07-17 03:06:59.216072 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-07-17 03:07:00.070518 | debian-bookworm | Successfully installed cachetools-7.1.4 colorama-0.4.6 distlib-0.4.3 filelock-3.30.2 packaging-26.2 platformdirs-4.10.0 pluggy-1.6.0 pyproject-api-1.10.1 python-discovery-1.4.4 tomli-w-1.2.0 tox-4.56.4 virtualenv-21.6.1 2026-07-17 03:07:00.299111 | debian-bookworm | ok: Runtime: 0:00:03.109607 2026-07-17 03:07:00.317824 | 2026-07-17 03:07:00.318133 | TASK [ensure-tox : Export installed tox_executable path] 2026-07-17 03:07:00.363052 | debian-bookworm | ok 2026-07-17 03:07:00.369112 | 2026-07-17 03:07:00.369247 | TASK [ensure-tox : Output tox version] 2026-07-17 03:07:00.933545 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2026-07-17 03:07:00.951190 | debian-bookworm | 4.56.4 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-17 03:07:01.401735 | debian-bookworm | ok: Runtime: 0:00:00.339467 2026-07-17 03:07:01.410228 | 2026-07-17 03:07:01.410352 | TASK [ensure-tox : Make global symlink] 2026-07-17 03:07:01.435427 | debian-bookworm | skipping: Conditional result was False 2026-07-17 03:07:01.443264 | 2026-07-17 03:07:01.443351 | PLAY RECAP 2026-07-17 03:07:01.443409 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-07-17 03:07:01.443436 | 2026-07-17 03:07:01.636637 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-07-17 03:07:01.637941 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-07-17 03:07:02.560788 | 2026-07-17 03:07:02.560994 | PLAY [all] 2026-07-17 03:07:02.580223 | 2026-07-17 03:07:02.580390 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-07-17 03:07:03.083751 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-07-17 03:07:03.137593 | debian-bookworm | ok: Runtime: 0:00:00.038291 2026-07-17 03:07:03.147805 | 2026-07-17 03:07:03.147986 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-07-17 03:07:03.678442 | debian-bookworm | ok: Runtime: 0:00:00.007603 2026-07-17 03:07:03.685324 | 2026-07-17 03:07:03.685471 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-07-17 03:07:03.987762 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-07-17 03:07:03.987906 | debian-bookworm | sudo: a password is required 2026-07-17 03:07:04.217122 | debian-bookworm | ok: Runtime: 0:00:00.025688 2026-07-17 03:07:04.228327 | 2026-07-17 03:07:04.228466 | TASK [tox : Check to see if the constraints file exists] 2026-07-17 03:07:04.254214 | debian-bookworm | skipping: Conditional result was False 2026-07-17 03:07:04.262004 | 2026-07-17 03:07:04.262158 | TASK [tox : Fail if constraints file is missing] 2026-07-17 03:07:04.290315 | debian-bookworm | skipping: Conditional result was False 2026-07-17 03:07:04.298175 | 2026-07-17 03:07:04.298332 | TASK [tox : Record file location] 2026-07-17 03:07:04.325449 | debian-bookworm | skipping: Conditional result was False 2026-07-17 03:07:04.333090 | 2026-07-17 03:07:04.333273 | TASK [tox : Install tox siblings] 2026-07-17 03:07:04.368792 | debian-bookworm | ok 2026-07-17 03:07:04.378607 | debian-bookworm | included: /var/lib/zuul/builds/c09207f6b4d249b1bfd1aef161f49986/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-07-17 03:07:04.384820 | 2026-07-17 03:07:04.385005 | TASK [tox : Run tox without tests] 2026-07-17 03:07:05.656140 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-07-17 03:07:18.860225 | debian-bookworm | test: OK (13.90 seconds) 2026-07-17 03:07:18.860314 | debian-bookworm | congratulations :) (13.93 seconds) 2026-07-17 03:07:18.960962 | debian-bookworm | ok: Runtime: 0:00:14.249673 2026-07-17 03:07:18.975014 | 2026-07-17 03:07:18.975186 | TASK [tox : Create a tempfile to save tox showconfig] 2026-07-17 03:07:19.418333 | debian-bookworm | changed 2026-07-17 03:07:19.429763 | 2026-07-17 03:07:19.429989 | TASK [tox : Detect tox version] 2026-07-17 03:07:19.992348 | debian-bookworm | 4.56.4 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-17 03:07:20.464000 | debian-bookworm | ok: Runtime: 0:00:00.329631 2026-07-17 03:07:20.470505 | 2026-07-17 03:07:20.470622 | TASK [tox : Get tox envlist config] 2026-07-17 03:07:21.523232 | debian-bookworm | ok: Runtime: 0:00:00.378002 2026-07-17 03:07:21.530163 | 2026-07-17 03:07:21.530313 | TASK [tox : Install any sibling python packages] 2026-07-17 03:07:22.169574 | debian-bookworm | ok: No setup.cfg, no action needed 2026-07-17 03:07:22.180332 | 2026-07-17 03:07:22.180493 | TASK [tox : Remove tempfile] 2026-07-17 03:07:22.743580 | debian-bookworm | changed 2026-07-17 03:07:22.750009 | 2026-07-17 03:07:22.750135 | TASK [tox : Emit tox command] 2026-07-17 03:07:22.791648 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-07-17 03:07:22.797136 | 2026-07-17 03:07:22.797267 | TASK [tox : Run tox] 2026-07-17 03:07:23.447764 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-07-17 03:07:25.304423 | debian-bookworm | ............................................. 2026-07-17 03:07:25.304478 | debian-bookworm | ---------------------------------------------------------------------- 2026-07-17 03:07:25.304486 | debian-bookworm | Ran 45 tests in 1.366s 2026-07-17 03:07:25.304491 | debian-bookworm | 2026-07-17 03:07:25.304955 | debian-bookworm | OK 2026-07-17 03:07:25.400602 | debian-bookworm | test: OK (2.01=setup[0.06]+cmd[1.95] seconds) 2026-07-17 03:07:25.400665 | debian-bookworm | congratulations :) (2.04 seconds) 2026-07-17 03:07:25.835116 | debian-bookworm | ok: Runtime: 0:00:02.360470 2026-07-17 03:07:25.843381 | 2026-07-17 03:07:25.843619 | TASK [tox : Look for output] 2026-07-17 03:07:26.330310 | debian-bookworm | ok 2026-07-17 03:07:26.351298 | 2026-07-17 03:07:26.351563 | TASK [tox : Return file comments to Zuul] 2026-07-17 03:07:26.387290 | debian-bookworm | skipping: Conditional result was False 2026-07-17 03:07:26.395015 | 2026-07-17 03:07:26.395113 | PLAY RECAP 2026-07-17 03:07:26.395172 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-07-17 03:07:26.395198 | 2026-07-17 03:07:26.558133 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-07-17 03:07:26.559450 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-07-17 03:07:27.554482 | 2026-07-17 03:07:27.554690 | PLAY [all] 2026-07-17 03:07:27.616667 | 2026-07-17 03:07:27.616882 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-07-17 03:07:27.749240 | debian-bookworm | skipping: Conditional result was False 2026-07-17 03:07:27.756305 | 2026-07-17 03:07:27.756489 | TASK [fetch-tox-output : Set tox log path for single node] 2026-07-17 03:07:27.840954 | debian-bookworm | ok 2026-07-17 03:07:27.846756 | 2026-07-17 03:07:27.859063 | TASK [fetch-tox-output : Ensure local tox dir] 2026-07-17 03:07:29.241507 | debian-bookworm -> localhost | changed 2026-07-17 03:07:29.250476 | 2026-07-17 03:07:29.250621 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-07-17 03:07:29.372834 | debian-bookworm | skipping: Conditional result was False 2026-07-17 03:07:29.380071 | 2026-07-17 03:07:29.380209 | TASK [fetch-tox-output : Set envlist fact] 2026-07-17 03:07:29.455659 | debian-bookworm | ok 2026-07-17 03:07:29.462464 | 2026-07-17 03:07:29.462589 | TASK [fetch-tox-output : Get tox version] 2026-07-17 03:07:30.583803 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2026-07-17 03:07:30.601522 | debian-bookworm | 4.56.4 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-17 03:07:31.021103 | debian-bookworm | ok: Runtime: 0:00:00.353223 2026-07-17 03:07:31.025838 | 2026-07-17 03:07:31.025956 | TASK [fetch-tox-output : Find all default environments] 2026-07-17 03:07:31.550017 | debian-bookworm | skipping: Conditional result was False 2026-07-17 03:07:31.554861 | 2026-07-17 03:07:31.554966 | TASK [fetch-tox-output : Set envlist fact] 2026-07-17 03:07:31.578284 | debian-bookworm | skipping: Conditional result was False 2026-07-17 03:07:31.582801 | 2026-07-17 03:07:31.582921 | TASK [fetch-tox-output : Find all default environments] 2026-07-17 03:07:32.107901 | debian-bookworm | skipping: Conditional result was False 2026-07-17 03:07:32.112939 | 2026-07-17 03:07:32.113029 | TASK [fetch-tox-output : Set envlist fact] 2026-07-17 03:07:32.156287 | debian-bookworm | skipping: Conditional result was False 2026-07-17 03:07:32.161880 | 2026-07-17 03:07:32.161991 | LOOP [fetch-tox-output : Copy tox logs] 2026-07-17 03:07:32.243297 | debian-bookworm | skipping: Conditional result was False 2026-07-17 03:07:32.260433 | 2026-07-17 03:07:32.260546 | LOOP [fetch-tox-output : Collect tox logs] 2026-07-17 03:07:33.137721 | debian-bookworm | changed: 2026-07-17 03:07:33.137929 | debian-bookworm | created directory /var/lib/zuul/builds/c09207f6b4d249b1bfd1aef161f49986/work/logs/tox/test 2026-07-17 03:07:33.137966 | debian-bookworm | cd+++++++++ ./ 2026-07-17 03:07:33.137991 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-07-17 03:07:33.138020 | 2026-07-17 03:07:33.147322 | 2026-07-17 03:07:33.147407 | PLAY RECAP 2026-07-17 03:07:33.147448 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-07-17 03:07:33.147469 | 2026-07-17 03:07:33.262914 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-07-17 03:07:33.263728 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-07-17 03:07:33.996420 | 2026-07-17 03:07:33.996541 | PLAY [all] 2026-07-17 03:07:34.008771 | 2026-07-17 03:07:34.008876 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-07-17 03:07:34.259293 | debian-bookworm | changed: non-zero return code 2026-07-17 03:07:34.264153 | 2026-07-17 03:07:34.264250 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-07-17 03:07:34.287706 | debian-bookworm | skipping: Conditional result was False 2026-07-17 03:07:34.292977 | 2026-07-17 03:07:34.293075 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-07-17 03:07:34.312955 | 2026-07-17 03:07:34.313172 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-07-17 03:07:34.343816 | 2026-07-17 03:07:34.343997 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-07-17 03:07:34.356962 | debian-bookworm | skipping: Conditional result was False 2026-07-17 03:07:34.361626 | 2026-07-17 03:07:34.361708 | LOOP [fetch-subunit-output : Generate subunit file] 2026-07-17 03:07:34.380070 | 2026-07-17 03:07:34.380212 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-07-17 03:07:34.392817 | debian-bookworm | skipping: Conditional result was False 2026-07-17 03:07:34.397528 | 2026-07-17 03:07:34.397628 | TASK [fetch-subunit-output : Remove the temporary file] 2026-07-17 03:07:34.425737 | debian-bookworm | skipping: Conditional result was False 2026-07-17 03:07:34.432991 | 2026-07-17 03:07:34.433104 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-07-17 03:07:34.466701 | debian-bookworm | skipping: Conditional result was False 2026-07-17 03:07:34.473349 | 2026-07-17 03:07:34.473638 | PLAY RECAP 2026-07-17 03:07:34.473698 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-07-17 03:07:34.473731 | 2026-07-17 03:07:34.596066 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-07-17 03:07:34.597170 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-17 03:07:35.585998 | 2026-07-17 03:07:35.586125 | PLAY [Base post-fetch] 2026-07-17 03:07:35.604300 | 2026-07-17 03:07:35.604416 | TASK [diagnose-network : Ensure log directory exists] 2026-07-17 03:07:35.972121 | debian-bookworm | ok 2026-07-17 03:07:35.979640 | 2026-07-17 03:07:35.979768 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-07-17 03:07:47.770977 | debian-bookworm | ok: Runtime: 0:00:05.970798 2026-07-17 03:07:47.784291 | 2026-07-17 03:07:47.784450 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-07-17 03:07:53.860562 | debian-bookworm | ok: Runtime: 0:00:00.008161 2026-07-17 03:07:53.866399 | 2026-07-17 03:07:53.866505 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-07-17 03:07:59.935167 | debian-bookworm | ok: Runtime: 0:00:00.006787 2026-07-17 03:07:59.951449 | 2026-07-17 03:07:59.951636 | TASK [fetch-output : Set log path for multiple nodes] 2026-07-17 03:08:00.015992 | debian-bookworm | skipping: Conditional result was False 2026-07-17 03:08:00.028973 | 2026-07-17 03:08:00.029416 | TASK [fetch-output : Set log path for single node] 2026-07-17 03:08:00.084637 | debian-bookworm | ok 2026-07-17 03:08:00.089857 | 2026-07-17 03:08:00.090004 | LOOP [fetch-output : Ensure local output dirs] 2026-07-17 03:08:00.464569 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/c09207f6b4d249b1bfd1aef161f49986/work/logs" 2026-07-17 03:08:00.762514 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/c09207f6b4d249b1bfd1aef161f49986/work/artifacts" 2026-07-17 03:08:01.084152 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/c09207f6b4d249b1bfd1aef161f49986/work/docs" 2026-07-17 03:08:01.099691 | 2026-07-17 03:08:01.099896 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-17 03:08:01.879863 | debian-bookworm | changed: 2026-07-17 03:08:01.880104 | debian-bookworm | .d..t...... ./ 2026-07-17 03:08:01.880147 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-17 03:08:01.880179 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-17 03:08:01.880205 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-17 03:08:01.880232 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-17 03:08:01.880259 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-17 03:08:01.880309 | debian-bookworm | changed: All items complete 2026-07-17 03:08:01.880338 | 2026-07-17 03:08:02.459978 | debian-bookworm | changed: .d..t...... ./ 2026-07-17 03:08:03.075976 | debian-bookworm | changed: .d..t...... ./ 2026-07-17 03:08:03.090710 | 2026-07-17 03:08:03.090825 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-17 03:08:03.143530 | debian-bookworm | skipping: Conditional result was False 2026-07-17 03:08:03.157418 | debian-bookworm | skipping: Conditional result was False 2026-07-17 03:08:03.175349 | 2026-07-17 03:08:03.175443 | PLAY RECAP 2026-07-17 03:08:03.175497 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-07-17 03:08:03.175525 | 2026-07-17 03:08:03.336599 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-17 03:08:03.337746 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-17 03:08:04.245591 | 2026-07-17 03:08:04.245732 | PLAY [Base post] 2026-07-17 03:08:04.260735 | 2026-07-17 03:08:04.260858 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-17 03:08:04.842369 | debian-bookworm | changed 2026-07-17 03:08:04.853446 | 2026-07-17 03:08:04.853619 | PLAY RECAP 2026-07-17 03:08:04.853717 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-17 03:08:04.853836 | 2026-07-17 03:08:04.953362 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-17 03:08:04.956126 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-17 03:08:06.058015 | 2026-07-17 03:08:06.058169 | PLAY [Base post-logs] 2026-07-17 03:08:06.068619 | 2026-07-17 03:08:06.068749 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-17 03:08:06.674513 | localhost | changed 2026-07-17 03:08:06.687096 | 2026-07-17 03:08:06.687284 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-17 03:08:06.737895 | localhost | ok 2026-07-17 03:08:06.742253 | 2026-07-17 03:08:06.742376 | TASK [Set zuul-log-path fact] 2026-07-17 03:08:06.759650 | localhost | ok 2026-07-17 03:08:06.773600 | 2026-07-17 03:08:06.773758 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-17 03:08:06.802116 | localhost | ok 2026-07-17 03:08:06.807260 | 2026-07-17 03:08:06.807403 | TASK [upload-logs : Create log directories] 2026-07-17 03:08:07.681522 | localhost | changed 2026-07-17 03:08:07.685297 | 2026-07-17 03:08:07.685427 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-17 03:08:08.592688 | localhost -> localhost | ok: Runtime: 0:00:00.007482 2026-07-17 03:08:08.597478 | 2026-07-17 03:08:08.597606 | TASK [upload-logs : Upload logs to log server] 2026-07-17 03:08:09.862525 | localhost | Output suppressed because no_log was given 2026-07-17 03:08:09.868977 | 2026-07-17 03:08:09.869132 | LOOP [upload-logs : Compress console log and json output] 2026-07-17 03:08:09.994092 | localhost | skipping: Conditional result was False 2026-07-17 03:08:10.012460 | localhost | skipping: Conditional result was False 2026-07-17 03:08:10.029994 | 2026-07-17 03:08:10.030168 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-17 03:08:10.134371 | localhost | skipping: Conditional result was False 2026-07-17 03:08:10.134735 | 2026-07-17 03:08:10.145040 | localhost | skipping: Conditional result was False 2026-07-17 03:08:10.149309 | 2026-07-17 03:08:10.149489 | LOOP [upload-logs : Upload console log and json output]