2026-01-15 03:02:59.491060 | Job console starting 2026-01-15 03:02:59.535328 | Updating git repos 2026-01-15 03:02:59.582460 | Cloning repos into workspace 2026-01-15 03:02:59.824129 | Restoring repo states 2026-01-15 03:02:59.845177 | Merging changes 2026-01-15 03:02:59.845198 | Checking out repos 2026-01-15 03:02:59.972814 | Preparing playbooks 2026-01-15 03:03:01.468733 | Running Ansible setup 2026-01-15 03:03:09.228874 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-15 03:03:11.072851 | 2026-01-15 03:03:11.073028 | PLAY [Base pre] 2026-01-15 03:03:11.116934 | 2026-01-15 03:03:11.117549 | TASK [Setup log path fact] 2026-01-15 03:03:11.227366 | debian-bookworm | ok 2026-01-15 03:03:11.321806 | 2026-01-15 03:03:11.321987 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-15 03:03:11.393495 | debian-bookworm | ok 2026-01-15 03:03:11.420959 | 2026-01-15 03:03:11.421131 | TASK [emit-job-header : Print job information] 2026-01-15 03:03:11.554111 | # Job Information 2026-01-15 03:03:11.554400 | Ansible Version: 2.16.14 2026-01-15 03:03:11.554442 | Job: tox 2026-01-15 03:03:11.554478 | Pipeline: periodic-daily 2026-01-15 03:03:11.554501 | Executor: 521e9411259a 2026-01-15 03:03:11.554522 | Triggered by: https://github.com/osism/openstack-image-manager 2026-01-15 03:03:11.554545 | Event ID: fa1195fb41de48a0913a202692ae0f75 2026-01-15 03:03:11.572461 | 2026-01-15 03:03:11.572611 | LOOP [emit-job-header : Print node information] 2026-01-15 03:03:11.938408 | debian-bookworm | ok: 2026-01-15 03:03:11.938787 | debian-bookworm | # Node Information 2026-01-15 03:03:11.938855 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-15 03:03:11.938884 | debian-bookworm | Hostname: debian 2026-01-15 03:03:11.938908 | debian-bookworm | Username: zuul 2026-01-15 03:03:11.938930 | debian-bookworm | Distro: Debian 12.13 2026-01-15 03:03:11.938954 | debian-bookworm | Provider: regiocloud-a 2026-01-15 03:03:11.938975 | debian-bookworm | Region: 2026-01-15 03:03:11.938996 | debian-bookworm | Label: debian-bookworm 2026-01-15 03:03:11.939016 | debian-bookworm | Product Name: OpenStack Nova 2026-01-15 03:03:11.939036 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe7a:f00b 2026-01-15 03:03:11.959399 | 2026-01-15 03:03:11.959554 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-15 03:03:13.510611 | debian-bookworm -> localhost | changed 2026-01-15 03:03:13.529373 | 2026-01-15 03:03:13.531518 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-15 03:03:16.654026 | debian-bookworm -> localhost | changed 2026-01-15 03:03:16.725943 | 2026-01-15 03:03:16.726174 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-15 03:03:18.084439 | debian-bookworm -> localhost | ok 2026-01-15 03:03:18.091578 | 2026-01-15 03:03:18.091731 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-15 03:03:18.135251 | debian-bookworm | ok 2026-01-15 03:03:18.243426 | debian-bookworm | included: /var/lib/zuul/builds/43fd7fbb99824f2f821ba3b85cc476f8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-15 03:03:18.259917 | 2026-01-15 03:03:18.260060 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-15 03:03:21.507796 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-15 03:03:21.508085 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/43fd7fbb99824f2f821ba3b85cc476f8/work/43fd7fbb99824f2f821ba3b85cc476f8_id_rsa 2026-01-15 03:03:21.508130 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/43fd7fbb99824f2f821ba3b85cc476f8/work/43fd7fbb99824f2f821ba3b85cc476f8_id_rsa.pub 2026-01-15 03:03:21.508159 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-15 03:03:21.508186 | debian-bookworm -> localhost | SHA256:E67ACBjrucgkN3uY1nMeiGezmDEh2FumH+8OFK1bFuM zuul-build-sshkey 2026-01-15 03:03:21.508209 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-15 03:03:21.508248 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-15 03:03:21.508271 | debian-bookworm -> localhost | |. | 2026-01-15 03:03:21.508293 | debian-bookworm -> localhost | |.o . | 2026-01-15 03:03:21.508314 | debian-bookworm -> localhost | |+ . + . | 2026-01-15 03:03:21.508335 | debian-bookworm -> localhost | |oo.o + + . | 2026-01-15 03:03:21.508355 | debian-bookworm -> localhost | |++* B E S | 2026-01-15 03:03:21.508379 | debian-bookworm -> localhost | |=o.# * . . | 2026-01-15 03:03:21.508400 | debian-bookworm -> localhost | |.o@ % + | 2026-01-15 03:03:21.508419 | debian-bookworm -> localhost | | . X X . | 2026-01-15 03:03:21.508441 | debian-bookworm -> localhost | | o oo= | 2026-01-15 03:03:21.508461 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-15 03:03:21.508512 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.374848 2026-01-15 03:03:21.515883 | 2026-01-15 03:03:21.516025 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-15 03:03:21.559527 | debian-bookworm | ok 2026-01-15 03:03:21.590052 | debian-bookworm | included: /var/lib/zuul/builds/43fd7fbb99824f2f821ba3b85cc476f8/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-15 03:03:21.616123 | 2026-01-15 03:03:21.616272 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-15 03:03:21.670381 | debian-bookworm | skipping: Conditional result was False 2026-01-15 03:03:21.677412 | 2026-01-15 03:03:21.677542 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-15 03:03:22.577030 | debian-bookworm | changed 2026-01-15 03:03:22.597587 | 2026-01-15 03:03:22.597769 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-15 03:03:22.907480 | debian-bookworm | ok 2026-01-15 03:03:22.913220 | 2026-01-15 03:03:22.913348 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-15 03:03:23.754784 | debian-bookworm | changed 2026-01-15 03:03:23.778216 | 2026-01-15 03:03:23.778356 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-15 03:03:24.648978 | debian-bookworm | changed 2026-01-15 03:03:24.667535 | 2026-01-15 03:03:24.667703 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-15 03:03:24.715972 | debian-bookworm | skipping: Conditional result was False 2026-01-15 03:03:24.723501 | 2026-01-15 03:03:24.723629 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-15 03:03:25.983527 | debian-bookworm -> localhost | changed 2026-01-15 03:03:26.030065 | 2026-01-15 03:03:26.030214 | TASK [add-build-sshkey : Add back temp key] 2026-01-15 03:03:27.281169 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/43fd7fbb99824f2f821ba3b85cc476f8/work/43fd7fbb99824f2f821ba3b85cc476f8_id_rsa (zuul-build-sshkey) 2026-01-15 03:03:27.281434 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.051331 2026-01-15 03:03:27.297733 | 2026-01-15 03:03:27.297871 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-15 03:03:28.292209 | debian-bookworm | ok 2026-01-15 03:03:28.298399 | 2026-01-15 03:03:28.298522 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-15 03:03:28.375396 | debian-bookworm | skipping: Conditional result was False 2026-01-15 03:03:28.397020 | 2026-01-15 03:03:28.397170 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-15 03:03:29.768145 | debian-bookworm | ok 2026-01-15 03:03:29.785820 | 2026-01-15 03:03:29.785930 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-15 03:03:29.824635 | debian-bookworm | ok 2026-01-15 03:03:29.828809 | 2026-01-15 03:03:29.828886 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-15 03:03:31.159264 | debian-bookworm -> localhost | ok 2026-01-15 03:03:31.192454 | 2026-01-15 03:03:31.192611 | TASK [validate-host : Collect information about the host] 2026-01-15 03:03:32.528550 | debian-bookworm | ok 2026-01-15 03:03:32.551788 | 2026-01-15 03:03:32.551898 | TASK [validate-host : Sanitize hostname] 2026-01-15 03:03:32.877703 | debian-bookworm | ok 2026-01-15 03:03:33.009292 | 2026-01-15 03:03:33.009408 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-15 03:03:34.593146 | debian-bookworm -> localhost | changed 2026-01-15 03:03:34.599689 | 2026-01-15 03:03:34.599827 | TASK [validate-host : Collect information about zuul worker] 2026-01-15 03:03:35.409510 | debian-bookworm | ok 2026-01-15 03:03:35.418017 | 2026-01-15 03:03:35.418155 | TASK [validate-host : Write out all zuul information for each host] 2026-01-15 03:03:36.644915 | debian-bookworm -> localhost | changed 2026-01-15 03:03:36.654264 | 2026-01-15 03:03:36.654360 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-15 03:03:36.985877 | debian-bookworm | ok 2026-01-15 03:03:36.991142 | 2026-01-15 03:03:36.991236 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-15 03:03:38.374553 | debian-bookworm | changed: 2026-01-15 03:03:38.375282 | debian-bookworm | cd+++++++++ src/ 2026-01-15 03:03:38.375344 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-15 03:03:38.375386 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-15 03:03:38.375444 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-01-15 03:03:38.375499 | debian-bookworm | =6.2.4 2026-01-15 03:04:03.060056 | debian-bookworm | Downloading cachetools-6.2.4-py3-none-any.whl (11 kB) 2026-01-15 03:04:03.102164 | debian-bookworm | Collecting chardet>=5.2 2026-01-15 03:04:03.116492 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2026-01-15 03:04:03.137597 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 11.3 MB/s eta 0:00:00 2026-01-15 03:04:03.180382 | debian-bookworm | Collecting colorama>=0.4.6 2026-01-15 03:04:03.194384 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-01-15 03:04:03.250252 | debian-bookworm | Collecting filelock>=3.20.2 2026-01-15 03:04:03.263404 | debian-bookworm | Downloading filelock-3.20.3-py3-none-any.whl (16 kB) 2026-01-15 03:04:03.314716 | debian-bookworm | Collecting packaging>=25 2026-01-15 03:04:03.328037 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2026-01-15 03:04:03.336762 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 9.9 MB/s eta 0:00:00 2026-01-15 03:04:03.383585 | debian-bookworm | Collecting platformdirs>=4.5.1 2026-01-15 03:04:03.396853 | debian-bookworm | Downloading platformdirs-4.5.1-py3-none-any.whl (18 kB) 2026-01-15 03:04:03.439395 | debian-bookworm | Collecting pluggy>=1.6 2026-01-15 03:04:03.452535 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-01-15 03:04:03.494107 | debian-bookworm | Collecting pyproject-api>=1.10 2026-01-15 03:04:03.507600 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-01-15 03:04:03.638395 | debian-bookworm | Collecting virtualenv>=20.35.4 2026-01-15 03:04:03.651506 | debian-bookworm | Downloading virtualenv-20.36.1-py3-none-any.whl (6.0 MB) 2026-01-15 03:04:03.952504 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 20.3 MB/s eta 0:00:00 2026-01-15 03:04:04.059353 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-01-15 03:04:04.072611 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-01-15 03:04:04.093693 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 26.1 MB/s eta 0:00:00 2026-01-15 03:04:04.248021 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2026-01-15 03:04:05.147217 | debian-bookworm | Successfully installed cachetools-6.2.4 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.20.3 packaging-25.0 platformdirs-4.5.1 pluggy-1.6.0 pyproject-api-1.10.0 tox-4.34.1 virtualenv-20.36.1 2026-01-15 03:04:05.338117 | debian-bookworm | ok: Runtime: 0:00:03.077241 2026-01-15 03:04:05.344700 | 2026-01-15 03:04:05.344823 | TASK [ensure-tox : Export installed tox_executable path] 2026-01-15 03:04:05.438263 | debian-bookworm | ok 2026-01-15 03:04:05.445193 | 2026-01-15 03:04:05.445343 | TASK [ensure-tox : Output tox version] 2026-01-15 03:04:06.171940 | 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-01-15 03:04:06.190354 | debian-bookworm | 4.34.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-01-15 03:04:06.531686 | debian-bookworm | ok: Runtime: 0:00:00.311022 2026-01-15 03:04:06.539406 | 2026-01-15 03:04:06.539525 | TASK [ensure-tox : Make global symlink] 2026-01-15 03:04:06.632026 | debian-bookworm | skipping: Conditional result was False 2026-01-15 03:04:06.644180 | 2026-01-15 03:04:06.644342 | PLAY RECAP 2026-01-15 03:04:06.644405 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-01-15 03:04:06.644431 | 2026-01-15 03:04:07.085964 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-01-15 03:04:07.088223 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-01-15 03:04:09.152926 | 2026-01-15 03:04:09.153119 | PLAY [all] 2026-01-15 03:04:09.210610 | 2026-01-15 03:04:09.210822 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-01-15 03:04:10.067046 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-01-15 03:04:10.286821 | debian-bookworm | ok: Runtime: 0:00:00.029705 2026-01-15 03:04:10.293383 | 2026-01-15 03:04:10.293531 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-01-15 03:04:11.377429 | debian-bookworm | ok: Runtime: 0:00:00.006792 2026-01-15 03:04:11.384439 | 2026-01-15 03:04:11.384580 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-01-15 03:04:11.749632 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-01-15 03:04:11.751385 | debian-bookworm | sudo: a password is required 2026-01-15 03:04:11.943515 | debian-bookworm | ok: Runtime: 0:00:00.018247 2026-01-15 03:04:11.968303 | 2026-01-15 03:04:11.968453 | TASK [tox : Check to see if the constraints file exists] 2026-01-15 03:04:12.050542 | debian-bookworm | skipping: Conditional result was False 2026-01-15 03:04:12.058340 | 2026-01-15 03:04:12.058503 | TASK [tox : Fail if constraints file is missing] 2026-01-15 03:04:12.168397 | debian-bookworm | skipping: Conditional result was False 2026-01-15 03:04:12.177617 | 2026-01-15 03:04:12.177814 | TASK [tox : Record file location] 2026-01-15 03:04:12.237016 | debian-bookworm | skipping: Conditional result was False 2026-01-15 03:04:12.244208 | 2026-01-15 03:04:12.244371 | TASK [tox : Install tox siblings] 2026-01-15 03:04:12.302627 | debian-bookworm | ok 2026-01-15 03:04:12.336842 | debian-bookworm | included: /var/lib/zuul/builds/43fd7fbb99824f2f821ba3b85cc476f8/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-01-15 03:04:12.360282 | 2026-01-15 03:04:12.360443 | TASK [tox : Run tox without tests] 2026-01-15 03:04:13.694717 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-01-15 03:04:27.666217 | debian-bookworm | test: OK (14.57 seconds) 2026-01-15 03:04:27.666289 | debian-bookworm | congratulations :) (14.60 seconds) 2026-01-15 03:04:27.967474 | debian-bookworm | ok: Runtime: 0:00:14.875265 2026-01-15 03:04:27.981913 | 2026-01-15 03:04:27.982059 | TASK [tox : Create a tempfile to save tox showconfig] 2026-01-15 03:04:28.922709 | debian-bookworm | changed 2026-01-15 03:04:28.934752 | 2026-01-15 03:04:28.934937 | TASK [tox : Get tox envlist config] 2026-01-15 03:04:29.980006 | debian-bookworm | ok: Runtime: 0:00:00.292513 2026-01-15 03:04:29.989528 | 2026-01-15 03:04:29.989716 | TASK [tox : Install any sibling python packages] 2026-01-15 03:04:30.766067 | debian-bookworm | ok: No setup.cfg, no action needed 2026-01-15 03:04:30.774473 | 2026-01-15 03:04:30.774705 | TASK [tox : Remove tempfile] 2026-01-15 03:04:31.409193 | debian-bookworm | changed 2026-01-15 03:04:31.415470 | 2026-01-15 03:04:31.415587 | TASK [tox : Emit tox command] 2026-01-15 03:04:31.533132 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-01-15 03:04:31.546740 | 2026-01-15 03:04:31.546927 | TASK [tox : Run tox] 2026-01-15 03:04:32.221244 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-01-15 03:04:32.852818 | debian-bookworm | ............... 2026-01-15 03:04:32.852874 | debian-bookworm | ---------------------------------------------------------------------- 2026-01-15 03:04:32.852890 | debian-bookworm | Ran 15 tests in 0.172s 2026-01-15 03:04:32.852895 | debian-bookworm | 2026-01-15 03:04:32.852902 | debian-bookworm | OK 2026-01-15 03:04:32.941975 | debian-bookworm | test: OK (0.76=setup[0.04]+cmd[0.72] seconds) 2026-01-15 03:04:32.942081 | debian-bookworm | congratulations :) (0.79 seconds) 2026-01-15 03:04:33.197064 | debian-bookworm | ok: Runtime: 0:00:01.062327 2026-01-15 03:04:33.213122 | 2026-01-15 03:04:33.213292 | TASK [tox : Look for output] 2026-01-15 03:04:33.646336 | debian-bookworm | ok 2026-01-15 03:04:33.686817 | 2026-01-15 03:04:33.694343 | TASK [tox : Return file comments to Zuul] 2026-01-15 03:04:33.749678 | debian-bookworm | skipping: Conditional result was False 2026-01-15 03:04:33.761321 | 2026-01-15 03:04:33.761445 | PLAY RECAP 2026-01-15 03:04:33.761503 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-01-15 03:04:33.761527 | 2026-01-15 03:04:34.026344 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-01-15 03:04:34.027577 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-01-15 03:04:35.178103 | 2026-01-15 03:04:35.178513 | PLAY [all] 2026-01-15 03:04:35.194975 | 2026-01-15 03:04:35.195135 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-01-15 03:04:35.260827 | debian-bookworm | skipping: Conditional result was False 2026-01-15 03:04:35.266824 | 2026-01-15 03:04:35.267006 | TASK [fetch-tox-output : Set tox log path for single node] 2026-01-15 03:04:35.308056 | debian-bookworm | ok 2026-01-15 03:04:35.314181 | 2026-01-15 03:04:35.314332 | TASK [fetch-tox-output : Ensure local tox dir] 2026-01-15 03:04:36.059771 | debian-bookworm -> localhost | changed 2026-01-15 03:04:36.068904 | 2026-01-15 03:04:36.069044 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-01-15 03:04:36.123985 | debian-bookworm | skipping: Conditional result was False 2026-01-15 03:04:36.131491 | 2026-01-15 03:04:36.131746 | TASK [fetch-tox-output : Set envlist fact] 2026-01-15 03:04:36.181488 | debian-bookworm | ok 2026-01-15 03:04:36.189430 | 2026-01-15 03:04:36.189564 | TASK [fetch-tox-output : Get tox version] 2026-01-15 03:04:37.010098 | 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-01-15 03:04:37.027174 | debian-bookworm | 4.34.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-01-15 03:04:37.263871 | debian-bookworm | ok: Runtime: 0:00:00.253829 2026-01-15 03:04:37.270539 | 2026-01-15 03:04:37.270686 | TASK [fetch-tox-output : Find all default environments] 2026-01-15 03:04:37.835347 | debian-bookworm | skipping: Conditional result was False 2026-01-15 03:04:37.841709 | 2026-01-15 03:04:37.841865 | TASK [fetch-tox-output : Set envlist fact] 2026-01-15 03:04:37.905381 | debian-bookworm | skipping: Conditional result was False 2026-01-15 03:04:37.911805 | 2026-01-15 03:04:37.911949 | TASK [fetch-tox-output : Find all default environments] 2026-01-15 03:04:38.486044 | debian-bookworm | skipping: Conditional result was False 2026-01-15 03:04:38.495103 | 2026-01-15 03:04:38.495344 | TASK [fetch-tox-output : Set envlist fact] 2026-01-15 03:04:38.729422 | debian-bookworm | skipping: Conditional result was False 2026-01-15 03:04:38.738153 | 2026-01-15 03:04:38.738294 | LOOP [fetch-tox-output : Copy tox logs] 2026-01-15 03:04:38.876360 | debian-bookworm | skipping: Conditional result was False 2026-01-15 03:04:38.891091 | 2026-01-15 03:04:38.891240 | LOOP [fetch-tox-output : Collect tox logs] 2026-01-15 03:04:40.360292 | debian-bookworm | changed: 2026-01-15 03:04:40.360482 | debian-bookworm | created directory /var/lib/zuul/builds/43fd7fbb99824f2f821ba3b85cc476f8/work/logs/tox/test 2026-01-15 03:04:40.360516 | debian-bookworm | cd+++++++++ ./ 2026-01-15 03:04:40.360541 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-01-15 03:04:40.360570 | 2026-01-15 03:04:40.371351 | 2026-01-15 03:04:40.371458 | PLAY RECAP 2026-01-15 03:04:40.371510 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-01-15 03:04:40.371534 | 2026-01-15 03:04:41.056353 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-01-15 03:04:41.057512 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-01-15 03:04:42.685028 | 2026-01-15 03:04:42.685214 | PLAY [all] 2026-01-15 03:04:42.732917 | 2026-01-15 03:04:42.733111 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-01-15 03:04:43.140979 | debian-bookworm | changed: non-zero return code 2026-01-15 03:04:43.159089 | 2026-01-15 03:04:43.160421 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-01-15 03:04:43.200904 | debian-bookworm | skipping: Conditional result was False 2026-01-15 03:04:43.212519 | 2026-01-15 03:04:43.212697 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-01-15 03:04:43.269134 | 2026-01-15 03:04:43.269360 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-01-15 03:04:43.358617 | 2026-01-15 03:04:43.359216 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-01-15 03:04:43.422411 | debian-bookworm | skipping: Conditional result was False 2026-01-15 03:04:43.432955 | 2026-01-15 03:04:43.433109 | LOOP [fetch-subunit-output : Generate subunit file] 2026-01-15 03:04:43.479432 | 2026-01-15 03:04:43.479974 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-01-15 03:04:43.520603 | debian-bookworm | skipping: Conditional result was False 2026-01-15 03:04:43.526724 | 2026-01-15 03:04:43.527224 | TASK [fetch-subunit-output : Remove the temporary file] 2026-01-15 03:04:43.578167 | debian-bookworm | skipping: Conditional result was False 2026-01-15 03:04:43.588545 | 2026-01-15 03:04:43.588742 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-01-15 03:04:43.638081 | debian-bookworm | skipping: Conditional result was False 2026-01-15 03:04:43.648906 | 2026-01-15 03:04:43.649018 | PLAY RECAP 2026-01-15 03:04:43.649068 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-01-15 03:04:43.649094 | 2026-01-15 03:04:44.171360 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-01-15 03:04:44.172507 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-01-15 03:04:45.856857 | 2026-01-15 03:04:45.857052 | PLAY [Base post] 2026-01-15 03:04:45.923598 | 2026-01-15 03:04:45.923795 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-01-15 03:04:47.064741 | debian-bookworm | changed 2026-01-15 03:04:47.079792 | 2026-01-15 03:04:47.079939 | PLAY RECAP 2026-01-15 03:04:47.080006 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-01-15 03:04:47.080069 | 2026-01-15 03:04:47.730510 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-01-15 03:04:47.731699 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-01-15 03:04:49.325674 | 2026-01-15 03:04:49.325870 | PLAY [Base post-logs] 2026-01-15 03:04:49.381950 | 2026-01-15 03:04:49.382130 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-01-15 03:04:50.323448 | localhost | changed 2026-01-15 03:04:50.350005 | 2026-01-15 03:04:50.350337 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-01-15 03:04:50.410283 | localhost | ok 2026-01-15 03:04:50.413908 | 2026-01-15 03:04:50.414038 | TASK [Set zuul-log-path fact] 2026-01-15 03:04:50.450365 | localhost | ok 2026-01-15 03:04:50.460073 | 2026-01-15 03:04:50.460230 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-15 03:04:50.507068 | localhost | ok 2026-01-15 03:04:50.510257 | 2026-01-15 03:04:50.510418 | TASK [upload-logs : Create log directories] 2026-01-15 03:04:51.408258 | localhost | changed 2026-01-15 03:04:51.411307 | 2026-01-15 03:04:51.411428 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-01-15 03:04:52.618371 | localhost -> localhost | ok: Runtime: 0:00:00.009864 2026-01-15 03:04:52.623115 | 2026-01-15 03:04:52.623255 | TASK [upload-logs : Upload logs to log server] 2026-01-15 03:04:53.760190 | localhost | Output suppressed because no_log was given 2026-01-15 03:04:53.762118 | 2026-01-15 03:04:53.762242 | LOOP [upload-logs : Compress console log and json output] 2026-01-15 03:04:53.860715 | localhost | skipping: Conditional result was False 2026-01-15 03:04:53.867057 | localhost | skipping: Conditional result was False 2026-01-15 03:04:53.870513 | 2026-01-15 03:04:53.870733 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-15 03:04:53.974954 | localhost | skipping: Conditional result was False 2026-01-15 03:04:53.975251 | 2026-01-15 03:04:53.993095 | localhost | skipping: Conditional result was False 2026-01-15 03:04:54.002418 | 2026-01-15 03:04:54.002569 | LOOP [upload-logs : Upload console log and json output]