2026-01-31 00:21:34.382688 | Job console starting 2026-01-31 00:21:34.396461 | Updating git repos 2026-01-31 00:21:34.428636 | Cloning repos into workspace 2026-01-31 00:21:34.496372 | Restoring repo states 2026-01-31 00:21:34.514450 | Merging changes 2026-01-31 00:21:35.026536 | Checking out repos 2026-01-31 00:21:35.085995 | Preparing playbooks 2026-01-31 00:21:35.825530 | Running Ansible setup 2026-01-31 00:21:41.202790 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-31 00:21:42.165153 | 2026-01-31 00:21:42.165325 | PLAY [Base pre] 2026-01-31 00:21:42.182744 | 2026-01-31 00:21:42.182944 | TASK [Setup log path fact] 2026-01-31 00:21:42.221881 | debian-bookworm | ok 2026-01-31 00:21:42.236894 | 2026-01-31 00:21:42.237050 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-31 00:21:42.266498 | debian-bookworm | ok 2026-01-31 00:21:42.277332 | 2026-01-31 00:21:42.277475 | TASK [emit-job-header : Print job information] 2026-01-31 00:21:42.316588 | # Job Information 2026-01-31 00:21:42.316845 | Ansible Version: 2.16.14 2026-01-31 00:21:42.316883 | Job: tox 2026-01-31 00:21:42.316916 | Pipeline: check 2026-01-31 00:21:42.316940 | Executor: 521e9411259a 2026-01-31 00:21:42.316961 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1117 2026-01-31 00:21:42.316983 | Event ID: c6ad4d90-fe3a-11f0-9960-e3b8f757596e 2026-01-31 00:21:42.322065 | 2026-01-31 00:21:42.322179 | LOOP [emit-job-header : Print node information] 2026-01-31 00:21:42.480401 | debian-bookworm | ok: 2026-01-31 00:21:42.480656 | debian-bookworm | # Node Information 2026-01-31 00:21:42.480698 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-31 00:21:42.480724 | debian-bookworm | Hostname: debian 2026-01-31 00:21:42.480747 | debian-bookworm | Username: zuul 2026-01-31 00:21:42.480769 | debian-bookworm | Distro: Debian 12.13 2026-01-31 00:21:42.480792 | debian-bookworm | Provider: regiocloud-a 2026-01-31 00:21:42.480814 | debian-bookworm | Region: 2026-01-31 00:21:42.480835 | debian-bookworm | Label: debian-bookworm 2026-01-31 00:21:42.480855 | debian-bookworm | Product Name: OpenStack Nova 2026-01-31 00:21:42.480874 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe29:5abd 2026-01-31 00:21:42.501465 | 2026-01-31 00:21:42.501608 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-31 00:21:43.103582 | debian-bookworm -> localhost | changed 2026-01-31 00:21:43.110978 | 2026-01-31 00:21:43.111109 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-31 00:21:44.487695 | debian-bookworm -> localhost | changed 2026-01-31 00:21:44.500686 | 2026-01-31 00:21:44.500829 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-31 00:21:45.056491 | debian-bookworm -> localhost | ok 2026-01-31 00:21:45.063279 | 2026-01-31 00:21:45.063440 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-31 00:21:45.094510 | debian-bookworm | ok 2026-01-31 00:21:45.136023 | debian-bookworm | included: /var/lib/zuul/builds/9a9992d73a0f4fca87bbffbda7b1c87b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-31 00:21:45.142655 | 2026-01-31 00:21:45.142782 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-31 00:21:46.794358 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-31 00:21:46.794761 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/9a9992d73a0f4fca87bbffbda7b1c87b/work/9a9992d73a0f4fca87bbffbda7b1c87b_id_rsa 2026-01-31 00:21:46.794865 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/9a9992d73a0f4fca87bbffbda7b1c87b/work/9a9992d73a0f4fca87bbffbda7b1c87b_id_rsa.pub 2026-01-31 00:21:46.794919 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-31 00:21:46.794966 | debian-bookworm -> localhost | SHA256:yQ2TXjesrymF6E/X3qtZNY+ODOFFa97oR45wh8i9/OY zuul-build-sshkey 2026-01-31 00:21:46.795005 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-31 00:21:46.795053 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-31 00:21:46.795090 | debian-bookworm -> localhost | | | 2026-01-31 00:21:46.795126 | debian-bookworm -> localhost | | . . | 2026-01-31 00:21:46.795159 | debian-bookworm -> localhost | | + . = | 2026-01-31 00:21:46.795191 | debian-bookworm -> localhost | | o * + o | 2026-01-31 00:21:46.795224 | debian-bookworm -> localhost | | .So+o+. ..| 2026-01-31 00:21:46.795271 | debian-bookworm -> localhost | | . ..=B+oooo| 2026-01-31 00:21:46.795305 | debian-bookworm -> localhost | | . ..++=*+ .| 2026-01-31 00:21:46.795338 | debian-bookworm -> localhost | | .... B+*+ | 2026-01-31 00:21:46.795386 | debian-bookworm -> localhost | | ...o B*E. | 2026-01-31 00:21:46.795421 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-31 00:21:46.795499 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.077804 2026-01-31 00:21:46.807565 | 2026-01-31 00:21:46.807686 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-31 00:21:46.826066 | debian-bookworm | ok 2026-01-31 00:21:46.835044 | debian-bookworm | included: /var/lib/zuul/builds/9a9992d73a0f4fca87bbffbda7b1c87b/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-31 00:21:46.843591 | 2026-01-31 00:21:46.843666 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-31 00:21:46.856274 | debian-bookworm | skipping: Conditional result was False 2026-01-31 00:21:46.861695 | 2026-01-31 00:21:46.861777 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-31 00:21:47.489589 | debian-bookworm | changed 2026-01-31 00:21:47.496531 | 2026-01-31 00:21:47.496655 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-31 00:21:47.760806 | debian-bookworm | ok 2026-01-31 00:21:47.774890 | 2026-01-31 00:21:47.774993 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-31 00:21:48.406275 | debian-bookworm | changed 2026-01-31 00:21:48.415902 | 2026-01-31 00:21:48.416023 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-31 00:21:49.014971 | debian-bookworm | changed 2026-01-31 00:21:49.025510 | 2026-01-31 00:21:49.025614 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-31 00:21:49.048410 | debian-bookworm | skipping: Conditional result was False 2026-01-31 00:21:49.054320 | 2026-01-31 00:21:49.054469 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-31 00:21:49.555275 | debian-bookworm -> localhost | changed 2026-01-31 00:21:49.576334 | 2026-01-31 00:21:49.576505 | TASK [add-build-sshkey : Add back temp key] 2026-01-31 00:21:49.939807 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/9a9992d73a0f4fca87bbffbda7b1c87b/work/9a9992d73a0f4fca87bbffbda7b1c87b_id_rsa (zuul-build-sshkey) 2026-01-31 00:21:49.940038 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015447 2026-01-31 00:21:49.947512 | 2026-01-31 00:21:49.947664 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-31 00:21:50.335044 | debian-bookworm | ok 2026-01-31 00:21:50.340044 | 2026-01-31 00:21:50.340145 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-31 00:21:50.363109 | debian-bookworm | skipping: Conditional result was False 2026-01-31 00:21:50.373031 | 2026-01-31 00:21:50.373125 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-31 00:21:50.776764 | debian-bookworm | ok 2026-01-31 00:21:50.788411 | 2026-01-31 00:21:50.788510 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-31 00:21:50.820016 | debian-bookworm | ok 2026-01-31 00:21:50.824845 | 2026-01-31 00:21:50.824943 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-31 00:21:51.091206 | debian-bookworm -> localhost | ok 2026-01-31 00:21:51.098543 | 2026-01-31 00:21:51.098671 | TASK [validate-host : Collect information about the host] 2026-01-31 00:21:52.153107 | debian-bookworm | ok 2026-01-31 00:21:52.174428 | 2026-01-31 00:21:52.174604 | TASK [validate-host : Sanitize hostname] 2026-01-31 00:21:52.276678 | debian-bookworm | ok 2026-01-31 00:21:52.318473 | 2026-01-31 00:21:52.318617 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-31 00:21:52.959293 | debian-bookworm -> localhost | changed 2026-01-31 00:21:52.965220 | 2026-01-31 00:21:52.965345 | TASK [validate-host : Collect information about zuul worker] 2026-01-31 00:21:53.399187 | debian-bookworm | ok 2026-01-31 00:21:53.404263 | 2026-01-31 00:21:53.404397 | TASK [validate-host : Write out all zuul information for each host] 2026-01-31 00:21:54.038717 | debian-bookworm -> localhost | changed 2026-01-31 00:21:54.053839 | 2026-01-31 00:21:54.053976 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-31 00:21:54.337346 | debian-bookworm | ok 2026-01-31 00:21:54.346934 | 2026-01-31 00:21:54.347079 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-31 00:21:55.237573 | debian-bookworm | changed: 2026-01-31 00:21:55.237876 | debian-bookworm | cd+++++++++ src/ 2026-01-31 00:21:55.237917 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-31 00:21:55.237940 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-31 00:21:55.237960 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-01-31 00:21:55.237980 | debian-bookworm | =6.2.4 2026-01-31 00:22:17.156525 | debian-bookworm | Downloading cachetools-6.2.6-py3-none-any.whl (11 kB) 2026-01-31 00:22:17.207236 | debian-bookworm | Collecting chardet>=5.2 2026-01-31 00:22:17.223079 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2026-01-31 00:22:17.235997 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 21.3 MB/s eta 0:00:00 2026-01-31 00:22:17.286036 | debian-bookworm | Collecting colorama>=0.4.6 2026-01-31 00:22:17.301521 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-01-31 00:22:17.364220 | debian-bookworm | Collecting filelock>=3.20.2 2026-01-31 00:22:17.379011 | debian-bookworm | Downloading filelock-3.20.3-py3-none-any.whl (16 kB) 2026-01-31 00:22:17.429818 | debian-bookworm | Collecting packaging>=25 2026-01-31 00:22:17.444797 | debian-bookworm | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-01-31 00:22:17.452266 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 12.5 MB/s eta 0:00:00 2026-01-31 00:22:17.499577 | debian-bookworm | Collecting platformdirs>=4.5.1 2026-01-31 00:22:17.514538 | debian-bookworm | Downloading platformdirs-4.5.1-py3-none-any.whl (18 kB) 2026-01-31 00:22:17.556455 | debian-bookworm | Collecting pluggy>=1.6 2026-01-31 00:22:17.571207 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-01-31 00:22:17.610966 | debian-bookworm | Collecting pyproject-api>=1.10 2026-01-31 00:22:17.627104 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-01-31 00:22:17.759847 | debian-bookworm | Collecting virtualenv>=20.35.4 2026-01-31 00:22:17.774789 | debian-bookworm | Downloading virtualenv-20.36.1-py3-none-any.whl (6.0 MB) 2026-01-31 00:22:18.064803 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 21.0 MB/s eta 0:00:00 2026-01-31 00:22:18.171199 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-01-31 00:22:18.186155 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-01-31 00:22:18.210866 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 20.7 MB/s eta 0:00:00 2026-01-31 00:22:18.342181 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2026-01-31 00:22:19.235839 | debian-bookworm | Successfully installed cachetools-6.2.6 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.20.3 packaging-26.0 platformdirs-4.5.1 pluggy-1.6.0 pyproject-api-1.10.0 tox-4.34.1 virtualenv-20.36.1 2026-01-31 00:22:19.614126 | debian-bookworm | ok: Runtime: 0:00:03.011706 2026-01-31 00:22:19.621336 | 2026-01-31 00:22:19.621515 | TASK [ensure-tox : Export installed tox_executable path] 2026-01-31 00:22:19.654277 | debian-bookworm | ok 2026-01-31 00:22:19.661007 | 2026-01-31 00:22:19.661131 | TASK [ensure-tox : Output tox version] 2026-01-31 00:22:20.199990 | 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-31 00:22:20.218787 | debian-bookworm | 4.34.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-01-31 00:22:20.692909 | debian-bookworm | ok: Runtime: 0:00:00.314264 2026-01-31 00:22:20.698755 | 2026-01-31 00:22:20.699137 | TASK [ensure-tox : Make global symlink] 2026-01-31 00:22:20.723447 | debian-bookworm | skipping: Conditional result was False 2026-01-31 00:22:20.730255 | 2026-01-31 00:22:20.730346 | PLAY RECAP 2026-01-31 00:22:20.730399 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-01-31 00:22:20.730457 | 2026-01-31 00:22:20.911918 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-01-31 00:22:20.913018 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-01-31 00:22:21.677759 | 2026-01-31 00:22:21.677931 | PLAY [all] 2026-01-31 00:22:21.700960 | 2026-01-31 00:22:21.701134 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-01-31 00:22:22.167535 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-01-31 00:22:22.228802 | debian-bookworm | ok: Runtime: 0:00:00.032339 2026-01-31 00:22:22.234557 | 2026-01-31 00:22:22.234691 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-01-31 00:22:22.784348 | debian-bookworm | ok: Runtime: 0:00:00.006609 2026-01-31 00:22:22.795147 | 2026-01-31 00:22:22.795291 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-01-31 00:22:23.083414 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-01-31 00:22:23.084883 | debian-bookworm | sudo: a password is required 2026-01-31 00:22:23.328694 | debian-bookworm | ok: Runtime: 0:00:00.022531 2026-01-31 00:22:23.350532 | 2026-01-31 00:22:23.350659 | TASK [tox : Check to see if the constraints file exists] 2026-01-31 00:22:23.375176 | debian-bookworm | skipping: Conditional result was False 2026-01-31 00:22:23.382466 | 2026-01-31 00:22:23.382585 | TASK [tox : Fail if constraints file is missing] 2026-01-31 00:22:23.405950 | debian-bookworm | skipping: Conditional result was False 2026-01-31 00:22:23.412702 | 2026-01-31 00:22:23.412815 | TASK [tox : Record file location] 2026-01-31 00:22:23.437848 | debian-bookworm | skipping: Conditional result was False 2026-01-31 00:22:23.459854 | 2026-01-31 00:22:23.459979 | TASK [tox : Install tox siblings] 2026-01-31 00:22:23.480056 | debian-bookworm | ok 2026-01-31 00:22:23.491937 | debian-bookworm | included: /var/lib/zuul/builds/9a9992d73a0f4fca87bbffbda7b1c87b/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-01-31 00:22:23.497740 | 2026-01-31 00:22:23.497849 | TASK [tox : Run tox without tests] 2026-01-31 00:22:24.591988 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-01-31 00:22:39.293217 | debian-bookworm | test: OK (15.22 seconds) 2026-01-31 00:22:39.293270 | debian-bookworm | congratulations :) (15.25 seconds) 2026-01-31 00:22:39.545065 | debian-bookworm | ok: Runtime: 0:00:15.568702 2026-01-31 00:22:39.557491 | 2026-01-31 00:22:39.557658 | TASK [tox : Create a tempfile to save tox showconfig] 2026-01-31 00:22:39.974116 | debian-bookworm | changed 2026-01-31 00:22:39.991731 | 2026-01-31 00:22:39.991923 | TASK [tox : Get tox envlist config] 2026-01-31 00:22:41.025976 | debian-bookworm | ok: Runtime: 0:00:00.344782 2026-01-31 00:22:41.038170 | 2026-01-31 00:22:41.038322 | TASK [tox : Install any sibling python packages] 2026-01-31 00:22:41.500370 | debian-bookworm | ok: No setup.cfg, no action needed 2026-01-31 00:22:41.508991 | 2026-01-31 00:22:41.509145 | TASK [tox : Remove tempfile] 2026-01-31 00:22:41.941079 | debian-bookworm | changed 2026-01-31 00:22:41.950213 | 2026-01-31 00:22:41.950348 | TASK [tox : Emit tox command] 2026-01-31 00:22:41.999547 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-01-31 00:22:42.008048 | 2026-01-31 00:22:42.008189 | TASK [tox : Run tox] 2026-01-31 00:22:42.584013 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-01-31 00:22:43.162482 | debian-bookworm | ............... 2026-01-31 00:22:43.162550 | debian-bookworm | ---------------------------------------------------------------------- 2026-01-31 00:22:43.162730 | debian-bookworm | Ran 15 tests in 0.180s 2026-01-31 00:22:43.162738 | debian-bookworm | 2026-01-31 00:22:43.162745 | debian-bookworm | OK 2026-01-31 00:22:43.228230 | debian-bookworm | test: OK (0.68=setup[0.04]+cmd[0.64] seconds) 2026-01-31 00:22:43.228274 | debian-bookworm | congratulations :) (0.71 seconds) 2026-01-31 00:22:43.574689 | debian-bookworm | ok: Runtime: 0:00:00.954844 2026-01-31 00:22:43.586671 | 2026-01-31 00:22:43.586821 | TASK [tox : Look for output] 2026-01-31 00:22:43.968987 | debian-bookworm | ok 2026-01-31 00:22:43.987616 | 2026-01-31 00:22:43.987747 | TASK [tox : Return file comments to Zuul] 2026-01-31 00:22:44.032529 | debian-bookworm | skipping: Conditional result was False 2026-01-31 00:22:44.044524 | 2026-01-31 00:22:44.044646 | PLAY RECAP 2026-01-31 00:22:44.044727 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-01-31 00:22:44.044768 | 2026-01-31 00:22:44.176272 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-01-31 00:22:44.177369 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-01-31 00:22:44.913896 | 2026-01-31 00:22:44.914057 | PLAY [all] 2026-01-31 00:22:44.929593 | 2026-01-31 00:22:44.929742 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-01-31 00:22:44.995241 | debian-bookworm | skipping: Conditional result was False 2026-01-31 00:22:45.008993 | 2026-01-31 00:22:45.009201 | TASK [fetch-tox-output : Set tox log path for single node] 2026-01-31 00:22:45.065318 | debian-bookworm | ok 2026-01-31 00:22:45.073180 | 2026-01-31 00:22:45.073332 | TASK [fetch-tox-output : Ensure local tox dir] 2026-01-31 00:22:45.564966 | debian-bookworm -> localhost | changed 2026-01-31 00:22:45.583546 | 2026-01-31 00:22:45.583740 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-01-31 00:22:45.639185 | debian-bookworm | skipping: Conditional result was False 2026-01-31 00:22:45.651253 | 2026-01-31 00:22:45.651430 | TASK [fetch-tox-output : Set envlist fact] 2026-01-31 00:22:45.688268 | debian-bookworm | ok 2026-01-31 00:22:45.697285 | 2026-01-31 00:22:45.697427 | TASK [fetch-tox-output : Get tox version] 2026-01-31 00:22:46.373510 | 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-31 00:22:46.391853 | debian-bookworm | 4.34.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-01-31 00:22:46.730249 | debian-bookworm | ok: Runtime: 0:00:00.294698 2026-01-31 00:22:46.743582 | 2026-01-31 00:22:46.743762 | TASK [fetch-tox-output : Find all default environments] 2026-01-31 00:22:47.278298 | debian-bookworm | skipping: Conditional result was False 2026-01-31 00:22:47.291983 | 2026-01-31 00:22:47.292168 | TASK [fetch-tox-output : Set envlist fact] 2026-01-31 00:22:47.317277 | debian-bookworm | skipping: Conditional result was False 2026-01-31 00:22:47.326024 | 2026-01-31 00:22:47.326175 | TASK [fetch-tox-output : Find all default environments] 2026-01-31 00:22:47.859105 | debian-bookworm | skipping: Conditional result was False 2026-01-31 00:22:47.871744 | 2026-01-31 00:22:47.871918 | TASK [fetch-tox-output : Set envlist fact] 2026-01-31 00:22:47.907092 | debian-bookworm | skipping: Conditional result was False 2026-01-31 00:22:47.921631 | 2026-01-31 00:22:47.921788 | LOOP [fetch-tox-output : Copy tox logs] 2026-01-31 00:22:47.973348 | debian-bookworm | skipping: Conditional result was False 2026-01-31 00:22:47.988584 | 2026-01-31 00:22:47.988741 | LOOP [fetch-tox-output : Collect tox logs] 2026-01-31 00:22:48.764131 | debian-bookworm | changed: 2026-01-31 00:22:48.764366 | debian-bookworm | created directory /var/lib/zuul/builds/9a9992d73a0f4fca87bbffbda7b1c87b/work/logs/tox/test 2026-01-31 00:22:48.764486 | debian-bookworm | cd+++++++++ ./ 2026-01-31 00:22:48.764520 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-01-31 00:22:48.764553 | 2026-01-31 00:22:48.781047 | 2026-01-31 00:22:48.781157 | PLAY RECAP 2026-01-31 00:22:48.781223 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-01-31 00:22:48.781250 | 2026-01-31 00:22:48.900156 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-01-31 00:22:48.901238 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-01-31 00:22:49.677001 | 2026-01-31 00:22:49.677248 | PLAY [all] 2026-01-31 00:22:49.697540 | 2026-01-31 00:22:49.697697 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-01-31 00:22:49.916178 | debian-bookworm | changed: non-zero return code 2026-01-31 00:22:49.925798 | 2026-01-31 00:22:49.926005 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-01-31 00:22:49.951615 | debian-bookworm | skipping: Conditional result was False 2026-01-31 00:22:49.965016 | 2026-01-31 00:22:49.965360 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-01-31 00:22:50.002272 | 2026-01-31 00:22:50.002621 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-01-31 00:22:50.042567 | 2026-01-31 00:22:50.042877 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-01-31 00:22:50.068096 | debian-bookworm | skipping: Conditional result was False 2026-01-31 00:22:50.082068 | 2026-01-31 00:22:50.082248 | LOOP [fetch-subunit-output : Generate subunit file] 2026-01-31 00:22:50.117775 | 2026-01-31 00:22:50.118128 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-01-31 00:22:50.132989 | debian-bookworm | skipping: Conditional result was False 2026-01-31 00:22:50.141927 | 2026-01-31 00:22:50.142075 | TASK [fetch-subunit-output : Remove the temporary file] 2026-01-31 00:22:50.155858 | debian-bookworm | skipping: Conditional result was False 2026-01-31 00:22:50.163849 | 2026-01-31 00:22:50.163970 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-01-31 00:22:50.178024 | debian-bookworm | skipping: Conditional result was False 2026-01-31 00:22:50.185971 | 2026-01-31 00:22:50.186060 | PLAY RECAP 2026-01-31 00:22:50.186115 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-01-31 00:22:50.186142 | 2026-01-31 00:22:50.307247 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-01-31 00:22:50.310071 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-01-31 00:22:51.040722 | 2026-01-31 00:22:51.040891 | PLAY [Base post] 2026-01-31 00:22:51.054742 | 2026-01-31 00:22:51.054924 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-01-31 00:22:51.627525 | debian-bookworm | changed 2026-01-31 00:22:51.636355 | 2026-01-31 00:22:51.636492 | PLAY RECAP 2026-01-31 00:22:51.636567 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-01-31 00:22:51.636641 | 2026-01-31 00:22:51.752860 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-01-31 00:22:51.754006 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-01-31 00:22:52.530919 | 2026-01-31 00:22:52.531082 | PLAY [Base post-logs] 2026-01-31 00:22:52.541412 | 2026-01-31 00:22:52.541565 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-01-31 00:22:52.985140 | localhost | changed 2026-01-31 00:22:53.001850 | 2026-01-31 00:22:53.002030 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-01-31 00:22:53.030973 | localhost | ok 2026-01-31 00:22:53.037996 | 2026-01-31 00:22:53.038171 | TASK [Set zuul-log-path fact] 2026-01-31 00:22:53.055751 | localhost | ok 2026-01-31 00:22:53.064319 | 2026-01-31 00:22:53.064431 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-31 00:22:53.090285 | localhost | ok 2026-01-31 00:22:53.094007 | 2026-01-31 00:22:53.094125 | TASK [upload-logs : Create log directories] 2026-01-31 00:22:53.597218 | localhost | changed 2026-01-31 00:22:53.603253 | 2026-01-31 00:22:53.603450 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-01-31 00:22:54.117516 | localhost -> localhost | ok: Runtime: 0:00:00.005216 2026-01-31 00:22:54.124109 | 2026-01-31 00:22:54.124278 | TASK [upload-logs : Upload logs to log server] 2026-01-31 00:22:54.701297 | localhost | Output suppressed because no_log was given 2026-01-31 00:22:54.705813 | 2026-01-31 00:22:54.706027 | LOOP [upload-logs : Compress console log and json output] 2026-01-31 00:22:54.755808 | localhost | skipping: Conditional result was False 2026-01-31 00:22:54.760659 | localhost | skipping: Conditional result was False 2026-01-31 00:22:54.768084 | 2026-01-31 00:22:54.768307 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-31 00:22:54.815298 | localhost | skipping: Conditional result was False 2026-01-31 00:22:54.816030 | 2026-01-31 00:22:54.819277 | localhost | skipping: Conditional result was False 2026-01-31 00:22:54.833118 | 2026-01-31 00:22:54.833339 | LOOP [upload-logs : Upload console log and json output]