2026-03-25 03:14:53.359851 | Job console starting 2026-03-25 03:14:53.376564 | Updating git repos 2026-03-25 03:14:53.422132 | Cloning repos into workspace 2026-03-25 03:14:53.505380 | Restoring repo states 2026-03-25 03:14:53.521273 | Merging changes 2026-03-25 03:14:53.521289 | Checking out repos 2026-03-25 03:14:53.611575 | Preparing playbooks 2026-03-25 03:14:54.336904 | Running Ansible setup 2026-03-25 03:14:59.570915 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-03-25 03:15:00.497592 | 2026-03-25 03:15:00.497718 | PLAY [Base pre] 2026-03-25 03:15:00.513000 | 2026-03-25 03:15:00.513126 | TASK [Setup log path fact] 2026-03-25 03:15:00.531853 | debian-bookworm | ok 2026-03-25 03:15:00.559224 | 2026-03-25 03:15:00.559357 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-25 03:15:00.599292 | debian-bookworm | ok 2026-03-25 03:15:00.617738 | 2026-03-25 03:15:00.617861 | TASK [emit-job-header : Print job information] 2026-03-25 03:15:00.699413 | # Job Information 2026-03-25 03:15:00.699577 | Ansible Version: 2.16.14 2026-03-25 03:15:00.699613 | Job: tox 2026-03-25 03:15:00.699645 | Pipeline: periodic-daily 2026-03-25 03:15:00.699667 | Executor: 521e9411259a 2026-03-25 03:15:00.699688 | Triggered by: https://github.com/osism/openstack-image-manager 2026-03-25 03:15:00.699710 | Event ID: 8f3c3ea902334e3eafd50bcb37ceec70 2026-03-25 03:15:00.704422 | 2026-03-25 03:15:00.704513 | LOOP [emit-job-header : Print node information] 2026-03-25 03:15:00.938515 | debian-bookworm | ok: 2026-03-25 03:15:00.938741 | debian-bookworm | # Node Information 2026-03-25 03:15:00.938777 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-03-25 03:15:00.938803 | debian-bookworm | Hostname: debian 2026-03-25 03:15:00.938825 | debian-bookworm | Username: zuul 2026-03-25 03:15:00.939013 | debian-bookworm | Distro: Debian 12.13 2026-03-25 03:15:00.939041 | debian-bookworm | Provider: regiocloud-a 2026-03-25 03:15:00.939072 | debian-bookworm | Region: 2026-03-25 03:15:00.939094 | debian-bookworm | Label: debian-bookworm 2026-03-25 03:15:00.939114 | debian-bookworm | Product Name: OpenStack Nova 2026-03-25 03:15:00.939134 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe21:13a5 2026-03-25 03:15:00.961464 | 2026-03-25 03:15:00.961572 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-25 03:15:01.923116 | debian-bookworm -> localhost | changed 2026-03-25 03:15:01.929015 | 2026-03-25 03:15:01.929111 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-25 03:15:03.430605 | debian-bookworm -> localhost | changed 2026-03-25 03:15:03.439986 | 2026-03-25 03:15:03.440112 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-25 03:15:03.882937 | debian-bookworm -> localhost | ok 2026-03-25 03:15:03.887934 | 2026-03-25 03:15:03.888028 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-25 03:15:03.925445 | debian-bookworm | ok 2026-03-25 03:15:03.968730 | debian-bookworm | included: /var/lib/zuul/builds/062e6f31a18e4415a203f98841da497d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-25 03:15:03.983612 | 2026-03-25 03:15:03.983720 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-25 03:15:06.587136 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-03-25 03:15:06.587666 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/062e6f31a18e4415a203f98841da497d/work/062e6f31a18e4415a203f98841da497d_id_rsa 2026-03-25 03:15:06.587709 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/062e6f31a18e4415a203f98841da497d/work/062e6f31a18e4415a203f98841da497d_id_rsa.pub 2026-03-25 03:15:06.587843 | debian-bookworm -> localhost | The key fingerprint is: 2026-03-25 03:15:06.587877 | debian-bookworm -> localhost | SHA256:rUq/aAEvn6GRObZpSrPj3EBi7wMPQlpggPYGfj7+y+s zuul-build-sshkey 2026-03-25 03:15:06.587901 | debian-bookworm -> localhost | The key's randomart image is: 2026-03-25 03:15:06.587937 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-03-25 03:15:06.587961 | debian-bookworm -> localhost | |+ | 2026-03-25 03:15:06.587984 | debian-bookworm -> localhost | |o+ | 2026-03-25 03:15:06.588006 | debian-bookworm -> localhost | |+.o | 2026-03-25 03:15:06.588027 | debian-bookworm -> localhost | | o.+. . | 2026-03-25 03:15:06.588058 | debian-bookworm -> localhost | |+o= = S . | 2026-03-25 03:15:06.588085 | debian-bookworm -> localhost | |+=.oB + . | 2026-03-25 03:15:06.588107 | debian-bookworm -> localhost | |. Oo.O.+. | 2026-03-25 03:15:06.588128 | debian-bookworm -> localhost | | ooO*.++ | 2026-03-25 03:15:06.588224 | debian-bookworm -> localhost | | .===E= o. | 2026-03-25 03:15:06.588259 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-03-25 03:15:06.588316 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.437526 2026-03-25 03:15:06.596480 | 2026-03-25 03:15:06.596651 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-25 03:15:06.637326 | debian-bookworm | ok 2026-03-25 03:15:06.650628 | debian-bookworm | included: /var/lib/zuul/builds/062e6f31a18e4415a203f98841da497d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-25 03:15:06.667430 | 2026-03-25 03:15:06.667521 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-25 03:15:06.701030 | debian-bookworm | skipping: Conditional result was False 2026-03-25 03:15:06.709587 | 2026-03-25 03:15:06.709677 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-25 03:15:07.522873 | debian-bookworm | changed 2026-03-25 03:15:07.535899 | 2026-03-25 03:15:07.535989 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-25 03:15:07.810764 | debian-bookworm | ok 2026-03-25 03:15:07.815609 | 2026-03-25 03:15:07.815691 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-25 03:15:08.569400 | debian-bookworm | changed 2026-03-25 03:15:08.580615 | 2026-03-25 03:15:08.580816 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-25 03:15:09.314222 | debian-bookworm | changed 2026-03-25 03:15:09.321938 | 2026-03-25 03:15:09.322033 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-25 03:15:09.347755 | debian-bookworm | skipping: Conditional result was False 2026-03-25 03:15:09.355221 | 2026-03-25 03:15:09.355321 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-25 03:15:09.959356 | debian-bookworm -> localhost | changed 2026-03-25 03:15:09.971547 | 2026-03-25 03:15:09.971644 | TASK [add-build-sshkey : Add back temp key] 2026-03-25 03:15:10.299110 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/062e6f31a18e4415a203f98841da497d/work/062e6f31a18e4415a203f98841da497d_id_rsa (zuul-build-sshkey) 2026-03-25 03:15:10.299331 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009826 2026-03-25 03:15:10.306950 | 2026-03-25 03:15:10.307066 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-25 03:15:10.657904 | debian-bookworm | ok 2026-03-25 03:15:10.665496 | 2026-03-25 03:15:10.665612 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-25 03:15:10.692334 | debian-bookworm | skipping: Conditional result was False 2026-03-25 03:15:10.703414 | 2026-03-25 03:15:10.703495 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-25 03:15:11.140730 | debian-bookworm | ok 2026-03-25 03:15:11.154219 | 2026-03-25 03:15:11.154331 | TASK [validate-host : Define zuul_info_dir fact] 2026-03-25 03:15:11.181999 | debian-bookworm | ok 2026-03-25 03:15:11.186747 | 2026-03-25 03:15:11.186825 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-03-25 03:15:11.464231 | debian-bookworm -> localhost | ok 2026-03-25 03:15:11.476549 | 2026-03-25 03:15:11.476726 | TASK [validate-host : Collect information about the host] 2026-03-25 03:15:12.536999 | debian-bookworm | ok 2026-03-25 03:15:12.546963 | 2026-03-25 03:15:12.547070 | TASK [validate-host : Sanitize hostname] 2026-03-25 03:15:12.643720 | debian-bookworm | ok 2026-03-25 03:15:12.678755 | 2026-03-25 03:15:12.678921 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-03-25 03:15:13.224956 | debian-bookworm -> localhost | changed 2026-03-25 03:15:13.238339 | 2026-03-25 03:15:13.238487 | TASK [validate-host : Collect information about zuul worker] 2026-03-25 03:15:13.626756 | debian-bookworm | ok 2026-03-25 03:15:13.636166 | 2026-03-25 03:15:13.636301 | TASK [validate-host : Write out all zuul information for each host] 2026-03-25 03:15:14.124980 | debian-bookworm -> localhost | changed 2026-03-25 03:15:14.134264 | 2026-03-25 03:15:14.134355 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-03-25 03:15:14.394373 | debian-bookworm | ok 2026-03-25 03:15:14.399916 | 2026-03-25 03:15:14.400007 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-03-25 03:15:15.185369 | debian-bookworm | changed: 2026-03-25 03:15:15.185546 | debian-bookworm | cd+++++++++ src/ 2026-03-25 03:15:15.185580 | debian-bookworm | cd+++++++++ src/github.com/ 2026-03-25 03:15:15.185605 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-03-25 03:15:15.185626 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-03-25 03:15:15.185646 | debian-bookworm | =7.0.3 2026-03-25 03:15:36.078649 | debian-bookworm | Downloading cachetools-7.0.5-py3-none-any.whl (13 kB) 2026-03-25 03:15:36.118198 | debian-bookworm | Collecting colorama>=0.4.6 2026-03-25 03:15:36.129215 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-03-25 03:15:36.186044 | debian-bookworm | Collecting filelock>=3.25 2026-03-25 03:15:36.197184 | debian-bookworm | Downloading filelock-3.25.2-py3-none-any.whl (26 kB) 2026-03-25 03:15:36.244876 | debian-bookworm | Collecting packaging>=26 2026-03-25 03:15:36.255669 | debian-bookworm | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-03-25 03:15:36.265291 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 9.5 MB/s eta 0:00:00 2026-03-25 03:15:36.312404 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-03-25 03:15:36.323266 | debian-bookworm | Downloading platformdirs-4.9.4-py3-none-any.whl (21 kB) 2026-03-25 03:15:36.360975 | debian-bookworm | Collecting pluggy>=1.6 2026-03-25 03:15:36.371890 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-03-25 03:15:36.409181 | debian-bookworm | Collecting pyproject-api>=1.10 2026-03-25 03:15:36.421229 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-03-25 03:15:36.572288 | debian-bookworm | Collecting tomli-w>=1.2 2026-03-25 03:15:36.583622 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-03-25 03:15:36.742371 | debian-bookworm | Collecting virtualenv>=21.1 2026-03-25 03:15:36.753103 | debian-bookworm | Downloading virtualenv-21.2.0-py3-none-any.whl (5.8 MB) 2026-03-25 03:15:37.018304 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.8/5.8 MB 22.4 MB/s eta 0:00:00 2026-03-25 03:15:37.099419 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-03-25 03:15:37.110403 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-03-25 03:15:37.141037 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 16.5 MB/s eta 0:00:00 2026-03-25 03:15:37.177330 | debian-bookworm | Collecting python-discovery>=1 2026-03-25 03:15:37.188011 | debian-bookworm | Downloading python_discovery-1.2.0-py3-none-any.whl (31 kB) 2026-03-25 03:15:37.308908 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-03-25 03:15:38.020067 | debian-bookworm | Successfully installed cachetools-7.0.5 colorama-0.4.6 distlib-0.4.0 filelock-3.25.2 packaging-26.0 platformdirs-4.9.4 pluggy-1.6.0 pyproject-api-1.10.0 python-discovery-1.2.0 tomli-w-1.2.0 tox-4.50.3 virtualenv-21.2.0 2026-03-25 03:15:38.492037 | debian-bookworm | ok: Runtime: 0:00:02.913057 2026-03-25 03:15:38.498673 | 2026-03-25 03:15:38.498777 | TASK [ensure-tox : Export installed tox_executable path] 2026-03-25 03:15:38.528027 | debian-bookworm | ok 2026-03-25 03:15:38.532801 | 2026-03-25 03:15:38.532889 | TASK [ensure-tox : Output tox version] 2026-03-25 03:15:39.021788 | 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-03-25 03:15:39.040444 | debian-bookworm | 4.50.3 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-03-25 03:15:39.559912 | debian-bookworm | ok: Runtime: 0:00:00.302132 2026-03-25 03:15:39.566786 | 2026-03-25 03:15:39.566917 | TASK [ensure-tox : Make global symlink] 2026-03-25 03:15:39.600027 | debian-bookworm | skipping: Conditional result was False 2026-03-25 03:15:39.606234 | 2026-03-25 03:15:39.606313 | PLAY RECAP 2026-03-25 03:15:39.606363 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-03-25 03:15:39.606388 | 2026-03-25 03:15:39.703380 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-03-25 03:15:39.704509 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-03-25 03:15:40.408713 | 2026-03-25 03:15:40.408840 | PLAY [all] 2026-03-25 03:15:40.430748 | 2026-03-25 03:15:40.430908 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-03-25 03:15:40.856166 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-03-25 03:15:40.967279 | debian-bookworm | ok: Runtime: 0:00:00.025013 2026-03-25 03:15:40.980061 | 2026-03-25 03:15:40.980315 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-03-25 03:15:41.511915 | debian-bookworm | ok: Runtime: 0:00:00.007383 2026-03-25 03:15:41.526359 | 2026-03-25 03:15:41.526519 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-03-25 03:15:41.819389 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-03-25 03:15:41.822371 | debian-bookworm | sudo: a password is required 2026-03-25 03:15:42.061277 | debian-bookworm | ok: Runtime: 0:00:00.023919 2026-03-25 03:15:42.070778 | 2026-03-25 03:15:42.071527 | TASK [tox : Check to see if the constraints file exists] 2026-03-25 03:15:42.096381 | debian-bookworm | skipping: Conditional result was False 2026-03-25 03:15:42.103007 | 2026-03-25 03:15:42.103108 | TASK [tox : Fail if constraints file is missing] 2026-03-25 03:15:42.125943 | debian-bookworm | skipping: Conditional result was False 2026-03-25 03:15:42.131681 | 2026-03-25 03:15:42.131774 | TASK [tox : Record file location] 2026-03-25 03:15:42.154674 | debian-bookworm | skipping: Conditional result was False 2026-03-25 03:15:42.160239 | 2026-03-25 03:15:42.160333 | TASK [tox : Install tox siblings] 2026-03-25 03:15:42.188810 | debian-bookworm | ok 2026-03-25 03:15:42.196504 | debian-bookworm | included: /var/lib/zuul/builds/062e6f31a18e4415a203f98841da497d/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-03-25 03:15:42.201728 | 2026-03-25 03:15:42.201811 | TASK [tox : Run tox without tests] 2026-03-25 03:15:43.286578 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-03-25 03:15:56.482005 | debian-bookworm | test: OK (13.75 seconds) 2026-03-25 03:15:56.482042 | debian-bookworm | congratulations :) (13.78 seconds) 2026-03-25 03:15:56.732902 | debian-bookworm | ok: Runtime: 0:00:14.055038 2026-03-25 03:15:56.748431 | 2026-03-25 03:15:56.748616 | TASK [tox : Create a tempfile to save tox showconfig] 2026-03-25 03:15:57.125355 | debian-bookworm | changed 2026-03-25 03:15:57.132480 | 2026-03-25 03:15:57.132605 | TASK [tox : Get tox envlist config] 2026-03-25 03:15:58.170563 | debian-bookworm | ok: Runtime: 0:00:00.294668 2026-03-25 03:15:58.177748 | 2026-03-25 03:15:58.177848 | TASK [tox : Install any sibling python packages] 2026-03-25 03:15:58.658050 | debian-bookworm | ok: No setup.cfg, no action needed 2026-03-25 03:15:58.675031 | 2026-03-25 03:15:58.675152 | TASK [tox : Remove tempfile] 2026-03-25 03:15:59.343363 | debian-bookworm | changed 2026-03-25 03:15:59.353033 | 2026-03-25 03:15:59.353334 | TASK [tox : Emit tox command] 2026-03-25 03:15:59.402649 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-03-25 03:15:59.408338 | 2026-03-25 03:15:59.408446 | TASK [tox : Run tox] 2026-03-25 03:16:00.099626 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-03-25 03:16:00.750514 | debian-bookworm | ............... 2026-03-25 03:16:00.750562 | debian-bookworm | ---------------------------------------------------------------------- 2026-03-25 03:16:00.750578 | debian-bookworm | Ran 15 tests in 0.166s 2026-03-25 03:16:00.750583 | debian-bookworm | 2026-03-25 03:16:00.750590 | debian-bookworm | OK 2026-03-25 03:16:00.839374 | debian-bookworm | test: OK (0.78=setup[0.04]+cmd[0.74] seconds) 2026-03-25 03:16:00.839435 | debian-bookworm | congratulations :) (0.81 seconds) 2026-03-25 03:16:00.977860 | debian-bookworm | ok: Runtime: 0:00:01.062687 2026-03-25 03:16:00.983423 | 2026-03-25 03:16:00.983516 | TASK [tox : Look for output] 2026-03-25 03:16:01.480490 | debian-bookworm | ok 2026-03-25 03:16:01.503172 | 2026-03-25 03:16:01.503292 | TASK [tox : Return file comments to Zuul] 2026-03-25 03:16:01.575921 | debian-bookworm | skipping: Conditional result was False 2026-03-25 03:16:01.595003 | 2026-03-25 03:16:01.595093 | PLAY RECAP 2026-03-25 03:16:01.604748 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-03-25 03:16:01.604831 | 2026-03-25 03:16:01.711958 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-03-25 03:16:01.713640 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-03-25 03:16:02.588490 | 2026-03-25 03:16:02.588632 | PLAY [all] 2026-03-25 03:16:02.624797 | 2026-03-25 03:16:02.624927 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-03-25 03:16:02.756755 | debian-bookworm | skipping: Conditional result was False 2026-03-25 03:16:02.762668 | 2026-03-25 03:16:02.762867 | TASK [fetch-tox-output : Set tox log path for single node] 2026-03-25 03:16:02.815796 | debian-bookworm | ok 2026-03-25 03:16:02.824186 | 2026-03-25 03:16:02.824302 | TASK [fetch-tox-output : Ensure local tox dir] 2026-03-25 03:16:03.646072 | debian-bookworm -> localhost | changed 2026-03-25 03:16:03.654170 | 2026-03-25 03:16:03.654280 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-03-25 03:16:03.710507 | debian-bookworm | skipping: Conditional result was False 2026-03-25 03:16:03.716258 | 2026-03-25 03:16:03.716374 | TASK [fetch-tox-output : Set envlist fact] 2026-03-25 03:16:03.754732 | debian-bookworm | ok 2026-03-25 03:16:03.760821 | 2026-03-25 03:16:03.760916 | TASK [fetch-tox-output : Get tox version] 2026-03-25 03:16:04.408994 | 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-03-25 03:16:04.427841 | debian-bookworm | 4.50.3 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-03-25 03:16:04.791630 | debian-bookworm | ok: Runtime: 0:00:00.294420 2026-03-25 03:16:04.797245 | 2026-03-25 03:16:04.797334 | TASK [fetch-tox-output : Find all default environments] 2026-03-25 03:16:05.357265 | debian-bookworm | skipping: Conditional result was False 2026-03-25 03:16:05.362867 | 2026-03-25 03:16:05.362988 | TASK [fetch-tox-output : Set envlist fact] 2026-03-25 03:16:05.436894 | debian-bookworm | skipping: Conditional result was False 2026-03-25 03:16:05.442486 | 2026-03-25 03:16:05.442590 | TASK [fetch-tox-output : Find all default environments] 2026-03-25 03:16:06.012836 | debian-bookworm | skipping: Conditional result was False 2026-03-25 03:16:06.020887 | 2026-03-25 03:16:06.020997 | TASK [fetch-tox-output : Set envlist fact] 2026-03-25 03:16:06.084312 | debian-bookworm | skipping: Conditional result was False 2026-03-25 03:16:06.090310 | 2026-03-25 03:16:06.090409 | LOOP [fetch-tox-output : Copy tox logs] 2026-03-25 03:16:06.180155 | debian-bookworm | skipping: Conditional result was False 2026-03-25 03:16:06.192190 | 2026-03-25 03:16:06.192300 | LOOP [fetch-tox-output : Collect tox logs] 2026-03-25 03:16:07.426088 | debian-bookworm | changed: 2026-03-25 03:16:07.426253 | debian-bookworm | created directory /var/lib/zuul/builds/062e6f31a18e4415a203f98841da497d/work/logs/tox/test 2026-03-25 03:16:07.426288 | debian-bookworm | cd+++++++++ ./ 2026-03-25 03:16:07.426313 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-03-25 03:16:07.426341 | 2026-03-25 03:16:07.435366 | 2026-03-25 03:16:07.435446 | PLAY RECAP 2026-03-25 03:16:07.435496 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-03-25 03:16:07.435520 | 2026-03-25 03:16:07.537779 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-03-25 03:16:07.538758 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-25 03:16:08.605750 | 2026-03-25 03:16:08.606332 | PLAY [all] 2026-03-25 03:16:08.629703 | 2026-03-25 03:16:08.629844 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-03-25 03:16:08.850607 | debian-bookworm | changed: non-zero return code 2026-03-25 03:16:08.860202 | 2026-03-25 03:16:08.860337 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-03-25 03:16:08.873985 | debian-bookworm | skipping: Conditional result was False 2026-03-25 03:16:08.880170 | 2026-03-25 03:16:08.880290 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-03-25 03:16:08.911334 | 2026-03-25 03:16:08.911601 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-03-25 03:16:08.940919 | 2026-03-25 03:16:08.941107 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-03-25 03:16:08.954087 | debian-bookworm | skipping: Conditional result was False 2026-03-25 03:16:08.959621 | 2026-03-25 03:16:08.959716 | LOOP [fetch-subunit-output : Generate subunit file] 2026-03-25 03:16:08.977577 | 2026-03-25 03:16:08.977738 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-03-25 03:16:08.990589 | debian-bookworm | skipping: Conditional result was False 2026-03-25 03:16:08.996398 | 2026-03-25 03:16:08.996500 | TASK [fetch-subunit-output : Remove the temporary file] 2026-03-25 03:16:09.019516 | debian-bookworm | skipping: Conditional result was False 2026-03-25 03:16:09.025028 | 2026-03-25 03:16:09.025127 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-03-25 03:16:09.048065 | debian-bookworm | skipping: Conditional result was False 2026-03-25 03:16:09.067412 | 2026-03-25 03:16:09.067500 | PLAY RECAP 2026-03-25 03:16:09.067554 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-03-25 03:16:09.067583 | 2026-03-25 03:16:09.175013 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-25 03:16:09.175936 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-03-25 03:16:09.761764 | 2026-03-25 03:16:09.761873 | PLAY [Base post] 2026-03-25 03:16:09.799445 | 2026-03-25 03:16:09.799548 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-25 03:16:10.493988 | debian-bookworm | changed 2026-03-25 03:16:10.503077 | 2026-03-25 03:16:10.503214 | PLAY RECAP 2026-03-25 03:16:10.503305 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-25 03:16:10.503397 | 2026-03-25 03:16:10.592417 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-03-25 03:16:10.593383 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-25 03:16:11.339887 | 2026-03-25 03:16:11.340043 | PLAY [Base post-logs] 2026-03-25 03:16:11.349388 | 2026-03-25 03:16:11.349499 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-25 03:16:11.984401 | localhost | changed 2026-03-25 03:16:11.997070 | 2026-03-25 03:16:11.997200 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-25 03:16:12.048230 | localhost | ok 2026-03-25 03:16:12.052186 | 2026-03-25 03:16:12.052282 | TASK [Set zuul-log-path fact] 2026-03-25 03:16:12.077501 | localhost | ok 2026-03-25 03:16:12.087383 | 2026-03-25 03:16:12.087982 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-25 03:16:12.136669 | localhost | ok 2026-03-25 03:16:12.142249 | 2026-03-25 03:16:12.142355 | TASK [upload-logs : Create log directories] 2026-03-25 03:16:12.862946 | localhost | changed 2026-03-25 03:16:12.866065 | 2026-03-25 03:16:12.866159 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-25 03:16:13.978305 | localhost -> localhost | ok: Runtime: 0:00:00.010089 2026-03-25 03:16:13.981933 | 2026-03-25 03:16:13.982038 | TASK [upload-logs : Upload logs to log server] 2026-03-25 03:16:14.600773 | localhost | Output suppressed because no_log was given 2026-03-25 03:16:14.602408 | 2026-03-25 03:16:14.602493 | LOOP [upload-logs : Compress console log and json output] 2026-03-25 03:16:14.645275 | localhost | skipping: Conditional result was False 2026-03-25 03:16:14.650830 | localhost | skipping: Conditional result was False 2026-03-25 03:16:14.661140 | 2026-03-25 03:16:14.661288 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-25 03:16:14.717354 | localhost | skipping: Conditional result was False 2026-03-25 03:16:14.717603 | 2026-03-25 03:16:14.722546 | localhost | skipping: Conditional result was False 2026-03-25 03:16:14.735060 | 2026-03-25 03:16:14.735282 | LOOP [upload-logs : Upload console log and json output]