2026-03-22 03:02:51.312752 | Job console starting 2026-03-22 03:02:51.322898 | Updating git repos 2026-03-22 03:02:51.342272 | Cloning repos into workspace 2026-03-22 03:02:51.431379 | Restoring repo states 2026-03-22 03:02:51.455055 | Merging changes 2026-03-22 03:02:51.455071 | Checking out repos 2026-03-22 03:02:51.485085 | Preparing playbooks 2026-03-22 03:02:52.002371 | Running Ansible setup 2026-03-22 03:02:56.486892 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-03-22 03:02:57.270639 | 2026-03-22 03:02:57.270800 | PLAY [Base pre] 2026-03-22 03:02:57.287433 | 2026-03-22 03:02:57.287559 | TASK [Setup log path fact] 2026-03-22 03:02:57.316515 | debian-bookworm | ok 2026-03-22 03:02:57.331618 | 2026-03-22 03:02:57.331738 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-22 03:02:57.373311 | debian-bookworm | ok 2026-03-22 03:02:57.384257 | 2026-03-22 03:02:57.384365 | TASK [emit-job-header : Print job information] 2026-03-22 03:02:57.423488 | # Job Information 2026-03-22 03:02:57.423660 | Ansible Version: 2.16.14 2026-03-22 03:02:57.423695 | Job: tox 2026-03-22 03:02:57.423728 | Pipeline: periodic-daily 2026-03-22 03:02:57.423750 | Executor: 521e9411259a 2026-03-22 03:02:57.423770 | Triggered by: https://github.com/osism/openstack-image-manager 2026-03-22 03:02:57.423793 | Event ID: c90b95cc6d984f42868b597415ebc7f5 2026-03-22 03:02:57.428943 | 2026-03-22 03:02:57.429096 | LOOP [emit-job-header : Print node information] 2026-03-22 03:02:57.543703 | debian-bookworm | ok: 2026-03-22 03:02:57.543973 | debian-bookworm | # Node Information 2026-03-22 03:02:57.544038 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-03-22 03:02:57.544065 | debian-bookworm | Hostname: debian 2026-03-22 03:02:57.544087 | debian-bookworm | Username: zuul 2026-03-22 03:02:57.544120 | debian-bookworm | Distro: Debian 12.13 2026-03-22 03:02:57.544149 | debian-bookworm | Provider: regiocloud-a 2026-03-22 03:02:57.544178 | debian-bookworm | Region: 2026-03-22 03:02:57.544200 | debian-bookworm | Label: debian-bookworm 2026-03-22 03:02:57.544220 | debian-bookworm | Product Name: OpenStack Nova 2026-03-22 03:02:57.544240 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe09:f94e 2026-03-22 03:02:57.571249 | 2026-03-22 03:02:57.571401 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-22 03:02:58.225606 | debian-bookworm -> localhost | changed 2026-03-22 03:02:58.233897 | 2026-03-22 03:02:58.234086 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-22 03:02:59.538452 | debian-bookworm -> localhost | changed 2026-03-22 03:02:59.550086 | 2026-03-22 03:02:59.550220 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-22 03:03:00.026160 | debian-bookworm -> localhost | ok 2026-03-22 03:03:00.037588 | 2026-03-22 03:03:00.037727 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-22 03:03:00.071228 | debian-bookworm | ok 2026-03-22 03:03:00.090643 | debian-bookworm | included: /var/lib/zuul/builds/0d4482444e4647c39a01bb2dc610a74d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-22 03:03:00.097447 | 2026-03-22 03:03:00.097570 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-22 03:03:01.777914 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-03-22 03:03:01.778632 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/0d4482444e4647c39a01bb2dc610a74d/work/0d4482444e4647c39a01bb2dc610a74d_id_rsa 2026-03-22 03:03:01.778766 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/0d4482444e4647c39a01bb2dc610a74d/work/0d4482444e4647c39a01bb2dc610a74d_id_rsa.pub 2026-03-22 03:03:01.778886 | debian-bookworm -> localhost | The key fingerprint is: 2026-03-22 03:03:01.778961 | debian-bookworm -> localhost | SHA256:8paFU4s7cTdW3+BdlE3+9sdvkp3K/MzGiIq/bBlzEeM zuul-build-sshkey 2026-03-22 03:03:01.779068 | debian-bookworm -> localhost | The key's randomart image is: 2026-03-22 03:03:01.779200 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-03-22 03:03:01.779312 | debian-bookworm -> localhost | | .=| 2026-03-22 03:03:01.779416 | debian-bookworm -> localhost | | o +.| 2026-03-22 03:03:01.779518 | debian-bookworm -> localhost | | o o o o| 2026-03-22 03:03:01.779618 | debian-bookworm -> localhost | | + E o ++| 2026-03-22 03:03:01.779718 | debian-bookworm -> localhost | | . S + = . *| 2026-03-22 03:03:01.779855 | debian-bookworm -> localhost | | o X + . o.| 2026-03-22 03:03:01.779962 | debian-bookworm -> localhost | | * = . oo=| 2026-03-22 03:03:01.780117 | debian-bookworm -> localhost | | .o+ .o.=+=| 2026-03-22 03:03:01.780188 | debian-bookworm -> localhost | | .o=o ++*.| 2026-03-22 03:03:01.780251 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-03-22 03:03:01.780402 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.082875 2026-03-22 03:03:01.794752 | 2026-03-22 03:03:01.794966 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-22 03:03:01.825878 | debian-bookworm | ok 2026-03-22 03:03:01.835952 | debian-bookworm | included: /var/lib/zuul/builds/0d4482444e4647c39a01bb2dc610a74d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-22 03:03:01.845548 | 2026-03-22 03:03:01.845665 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-22 03:03:01.869719 | debian-bookworm | skipping: Conditional result was False 2026-03-22 03:03:01.876216 | 2026-03-22 03:03:01.876343 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-22 03:03:02.593246 | debian-bookworm | changed 2026-03-22 03:03:02.604725 | 2026-03-22 03:03:02.604873 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-22 03:03:02.867928 | debian-bookworm | ok 2026-03-22 03:03:02.877123 | 2026-03-22 03:03:02.877256 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-22 03:03:03.597147 | debian-bookworm | changed 2026-03-22 03:03:03.606764 | 2026-03-22 03:03:03.606914 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-22 03:03:04.290509 | debian-bookworm | changed 2026-03-22 03:03:04.298155 | 2026-03-22 03:03:04.298286 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-22 03:03:04.323291 | debian-bookworm | skipping: Conditional result was False 2026-03-22 03:03:04.335593 | 2026-03-22 03:03:04.335754 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-22 03:03:04.855813 | debian-bookworm -> localhost | changed 2026-03-22 03:03:04.875959 | 2026-03-22 03:03:04.876146 | TASK [add-build-sshkey : Add back temp key] 2026-03-22 03:03:05.265638 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/0d4482444e4647c39a01bb2dc610a74d/work/0d4482444e4647c39a01bb2dc610a74d_id_rsa (zuul-build-sshkey) 2026-03-22 03:03:05.265976 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018162 2026-03-22 03:03:05.274556 | 2026-03-22 03:03:05.274676 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-22 03:03:05.712703 | debian-bookworm | ok 2026-03-22 03:03:05.722546 | 2026-03-22 03:03:05.722977 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-22 03:03:05.747870 | debian-bookworm | skipping: Conditional result was False 2026-03-22 03:03:05.761034 | 2026-03-22 03:03:05.761322 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-22 03:03:06.236231 | debian-bookworm | ok 2026-03-22 03:03:06.250781 | 2026-03-22 03:03:06.250943 | TASK [validate-host : Define zuul_info_dir fact] 2026-03-22 03:03:06.317401 | debian-bookworm | ok 2026-03-22 03:03:06.329209 | 2026-03-22 03:03:06.329751 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-03-22 03:03:06.693470 | debian-bookworm -> localhost | ok 2026-03-22 03:03:06.709768 | 2026-03-22 03:03:06.709908 | TASK [validate-host : Collect information about the host] 2026-03-22 03:03:08.047136 | debian-bookworm | ok 2026-03-22 03:03:08.065636 | 2026-03-22 03:03:08.065776 | TASK [validate-host : Sanitize hostname] 2026-03-22 03:03:08.199546 | debian-bookworm | ok 2026-03-22 03:03:08.256884 | 2026-03-22 03:03:08.257060 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-03-22 03:03:09.103384 | debian-bookworm -> localhost | changed 2026-03-22 03:03:09.109798 | 2026-03-22 03:03:09.109939 | TASK [validate-host : Collect information about zuul worker] 2026-03-22 03:03:09.550853 | debian-bookworm | ok 2026-03-22 03:03:09.568913 | 2026-03-22 03:03:09.569117 | TASK [validate-host : Write out all zuul information for each host] 2026-03-22 03:03:10.276281 | debian-bookworm -> localhost | changed 2026-03-22 03:03:10.288389 | 2026-03-22 03:03:10.288520 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-03-22 03:03:10.591117 | debian-bookworm | ok 2026-03-22 03:03:10.597403 | 2026-03-22 03:03:10.597528 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-03-22 03:03:11.580716 | debian-bookworm | changed: 2026-03-22 03:03:11.580920 | debian-bookworm | cd+++++++++ src/ 2026-03-22 03:03:11.580955 | debian-bookworm | cd+++++++++ src/github.com/ 2026-03-22 03:03:11.580979 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-03-22 03:03:11.581026 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-03-22 03:03:11.581058 | debian-bookworm | =7.0.3 2026-03-22 03:03:36.760067 | debian-bookworm | Downloading cachetools-7.0.5-py3-none-any.whl (13 kB) 2026-03-22 03:03:36.865028 | debian-bookworm | Collecting colorama>=0.4.6 2026-03-22 03:03:36.877818 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-03-22 03:03:36.958584 | debian-bookworm | Collecting filelock>=3.25 2026-03-22 03:03:36.970173 | debian-bookworm | Downloading filelock-3.25.2-py3-none-any.whl (26 kB) 2026-03-22 03:03:37.041082 | debian-bookworm | Collecting packaging>=26 2026-03-22 03:03:37.052532 | debian-bookworm | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-03-22 03:03:37.062548 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 9.8 MB/s eta 0:00:00 2026-03-22 03:03:37.126353 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-03-22 03:03:37.138114 | debian-bookworm | Downloading platformdirs-4.9.4-py3-none-any.whl (21 kB) 2026-03-22 03:03:37.198768 | debian-bookworm | Collecting pluggy>=1.6 2026-03-22 03:03:37.210442 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-03-22 03:03:37.256011 | debian-bookworm | Collecting pyproject-api>=1.10 2026-03-22 03:03:37.268044 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-03-22 03:03:37.314934 | debian-bookworm | Collecting tomli-w>=1.2 2026-03-22 03:03:37.327340 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-03-22 03:03:37.481893 | debian-bookworm | Collecting virtualenv>=21.1 2026-03-22 03:03:37.498473 | debian-bookworm | Downloading virtualenv-21.2.0-py3-none-any.whl (5.8 MB) 2026-03-22 03:03:37.786189 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.8/5.8 MB 20.6 MB/s eta 0:00:00 2026-03-22 03:03:37.875094 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-03-22 03:03:37.887305 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-03-22 03:03:37.911013 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 24.4 MB/s eta 0:00:00 2026-03-22 03:03:37.974490 | debian-bookworm | Collecting python-discovery>=1 2026-03-22 03:03:37.986747 | debian-bookworm | Downloading python_discovery-1.2.0-py3-none-any.whl (31 kB) 2026-03-22 03:03:38.115705 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-03-22 03:03:38.917932 | 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-22 03:03:39.177973 | debian-bookworm | ok: Runtime: 0:00:03.183948 2026-03-22 03:03:39.202362 | 2026-03-22 03:03:39.202520 | TASK [ensure-tox : Export installed tox_executable path] 2026-03-22 03:03:39.292874 | debian-bookworm | ok 2026-03-22 03:03:39.305828 | 2026-03-22 03:03:39.306684 | TASK [ensure-tox : Output tox version] 2026-03-22 03:03:39.951928 | 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-22 03:03:39.971330 | debian-bookworm | 4.50.3 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-03-22 03:03:40.370917 | debian-bookworm | ok: Runtime: 0:00:00.337429 2026-03-22 03:03:40.388921 | 2026-03-22 03:03:40.389230 | TASK [ensure-tox : Make global symlink] 2026-03-22 03:03:40.507816 | debian-bookworm | skipping: Conditional result was False 2026-03-22 03:03:40.517854 | 2026-03-22 03:03:40.517968 | PLAY RECAP 2026-03-22 03:03:40.518045 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-03-22 03:03:40.518072 | 2026-03-22 03:03:41.098074 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-03-22 03:03:41.099598 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-03-22 03:03:42.595861 | 2026-03-22 03:03:42.596092 | PLAY [all] 2026-03-22 03:03:42.653405 | 2026-03-22 03:03:42.663033 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-03-22 03:03:43.310322 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-03-22 03:03:43.749198 | debian-bookworm | ok: Runtime: 0:00:00.034983 2026-03-22 03:03:43.755851 | 2026-03-22 03:03:43.756029 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-03-22 03:03:44.298737 | debian-bookworm | ok: Runtime: 0:00:00.007932 2026-03-22 03:03:44.308931 | 2026-03-22 03:03:44.309136 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-03-22 03:03:44.657369 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-03-22 03:03:44.658415 | debian-bookworm | sudo: a password is required 2026-03-22 03:03:44.890576 | debian-bookworm | ok: Runtime: 0:00:00.022503 2026-03-22 03:03:44.923913 | 2026-03-22 03:03:44.924107 | TASK [tox : Check to see if the constraints file exists] 2026-03-22 03:03:44.974299 | debian-bookworm | skipping: Conditional result was False 2026-03-22 03:03:44.982409 | 2026-03-22 03:03:44.982556 | TASK [tox : Fail if constraints file is missing] 2026-03-22 03:03:45.057222 | debian-bookworm | skipping: Conditional result was False 2026-03-22 03:03:45.065166 | 2026-03-22 03:03:45.065341 | TASK [tox : Record file location] 2026-03-22 03:03:45.158542 | debian-bookworm | skipping: Conditional result was False 2026-03-22 03:03:45.164770 | 2026-03-22 03:03:45.164907 | TASK [tox : Install tox siblings] 2026-03-22 03:03:45.206752 | debian-bookworm | ok 2026-03-22 03:03:45.221329 | debian-bookworm | included: /var/lib/zuul/builds/0d4482444e4647c39a01bb2dc610a74d/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-03-22 03:03:45.262463 | 2026-03-22 03:03:45.262688 | TASK [tox : Run tox without tests] 2026-03-22 03:03:46.490153 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-03-22 03:04:01.952162 | debian-bookworm | test: OK (16.04 seconds) 2026-03-22 03:04:01.952255 | debian-bookworm | congratulations :) (16.07 seconds) 2026-03-22 03:04:02.343083 | debian-bookworm | ok: Runtime: 0:00:16.398072 2026-03-22 03:04:02.349020 | 2026-03-22 03:04:02.349116 | TASK [tox : Create a tempfile to save tox showconfig] 2026-03-22 03:04:02.956430 | debian-bookworm | changed 2026-03-22 03:04:02.961445 | 2026-03-22 03:04:02.961535 | TASK [tox : Get tox envlist config] 2026-03-22 03:04:04.061775 | debian-bookworm | ok: Runtime: 0:00:00.380295 2026-03-22 03:04:04.067037 | 2026-03-22 03:04:04.067133 | TASK [tox : Install any sibling python packages] 2026-03-22 03:04:04.833221 | debian-bookworm | ok: No setup.cfg, no action needed 2026-03-22 03:04:04.846873 | 2026-03-22 03:04:04.848089 | TASK [tox : Remove tempfile] 2026-03-22 03:04:05.436689 | debian-bookworm | changed 2026-03-22 03:04:05.450183 | 2026-03-22 03:04:05.450299 | TASK [tox : Emit tox command] 2026-03-22 03:04:05.518110 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-03-22 03:04:05.523772 | 2026-03-22 03:04:05.523879 | TASK [tox : Run tox] 2026-03-22 03:04:06.261426 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-03-22 03:04:06.982728 | debian-bookworm | ............... 2026-03-22 03:04:06.982782 | debian-bookworm | ---------------------------------------------------------------------- 2026-03-22 03:04:06.982797 | debian-bookworm | Ran 15 tests in 0.168s 2026-03-22 03:04:06.982802 | debian-bookworm | 2026-03-22 03:04:06.982810 | debian-bookworm | OK 2026-03-22 03:04:07.080291 | debian-bookworm | test: OK (0.86=setup[0.05]+cmd[0.82] seconds) 2026-03-22 03:04:07.080358 | debian-bookworm | congratulations :) (0.89 seconds) 2026-03-22 03:04:07.628415 | debian-bookworm | ok: Runtime: 0:00:01.176168 2026-03-22 03:04:07.633735 | 2026-03-22 03:04:07.633825 | TASK [tox : Look for output] 2026-03-22 03:04:08.131900 | debian-bookworm | ok 2026-03-22 03:04:08.160450 | 2026-03-22 03:04:08.161231 | TASK [tox : Return file comments to Zuul] 2026-03-22 03:04:08.199461 | debian-bookworm | skipping: Conditional result was False 2026-03-22 03:04:08.204922 | 2026-03-22 03:04:08.205005 | PLAY RECAP 2026-03-22 03:04:08.205051 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-03-22 03:04:08.205074 | 2026-03-22 03:04:08.344520 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-03-22 03:04:08.345502 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-03-22 03:04:09.818044 | 2026-03-22 03:04:09.818167 | PLAY [all] 2026-03-22 03:04:09.849982 | 2026-03-22 03:04:09.850099 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-03-22 03:04:09.966303 | debian-bookworm | skipping: Conditional result was False 2026-03-22 03:04:09.971193 | 2026-03-22 03:04:09.971299 | TASK [fetch-tox-output : Set tox log path for single node] 2026-03-22 03:04:10.093439 | debian-bookworm | ok 2026-03-22 03:04:10.097693 | 2026-03-22 03:04:10.097792 | TASK [fetch-tox-output : Ensure local tox dir] 2026-03-22 03:04:11.237097 | debian-bookworm -> localhost | changed 2026-03-22 03:04:11.244477 | 2026-03-22 03:04:11.244577 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-03-22 03:04:11.383296 | debian-bookworm | skipping: Conditional result was False 2026-03-22 03:04:11.387996 | 2026-03-22 03:04:11.388088 | TASK [fetch-tox-output : Set envlist fact] 2026-03-22 03:04:11.459495 | debian-bookworm | ok 2026-03-22 03:04:11.464118 | 2026-03-22 03:04:11.464197 | TASK [fetch-tox-output : Get tox version] 2026-03-22 03:04:12.474399 | 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-22 03:04:12.493743 | debian-bookworm | 4.50.3 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-03-22 03:04:13.043786 | debian-bookworm | ok: Runtime: 0:00:00.329586 2026-03-22 03:04:13.049083 | 2026-03-22 03:04:13.049200 | TASK [fetch-tox-output : Find all default environments] 2026-03-22 03:04:13.604210 | debian-bookworm | skipping: Conditional result was False 2026-03-22 03:04:13.608902 | 2026-03-22 03:04:13.609017 | TASK [fetch-tox-output : Set envlist fact] 2026-03-22 03:04:13.631898 | debian-bookworm | skipping: Conditional result was False 2026-03-22 03:04:13.636394 | 2026-03-22 03:04:13.636470 | TASK [fetch-tox-output : Find all default environments] 2026-03-22 03:04:14.160483 | debian-bookworm | skipping: Conditional result was False 2026-03-22 03:04:14.165891 | 2026-03-22 03:04:14.165994 | TASK [fetch-tox-output : Set envlist fact] 2026-03-22 03:04:14.209147 | debian-bookworm | skipping: Conditional result was False 2026-03-22 03:04:14.214468 | 2026-03-22 03:04:14.214559 | LOOP [fetch-tox-output : Copy tox logs] 2026-03-22 03:04:14.283192 | debian-bookworm | skipping: Conditional result was False 2026-03-22 03:04:14.293549 | 2026-03-22 03:04:14.293662 | LOOP [fetch-tox-output : Collect tox logs] 2026-03-22 03:04:15.250565 | debian-bookworm | changed: 2026-03-22 03:04:15.250990 | debian-bookworm | created directory /var/lib/zuul/builds/0d4482444e4647c39a01bb2dc610a74d/work/logs/tox/test 2026-03-22 03:04:15.251022 | debian-bookworm | cd+++++++++ ./ 2026-03-22 03:04:15.251043 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-03-22 03:04:15.251068 | 2026-03-22 03:04:15.282028 | 2026-03-22 03:04:15.282128 | PLAY RECAP 2026-03-22 03:04:15.282196 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-03-22 03:04:15.282228 | 2026-03-22 03:04:15.411678 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-03-22 03:04:15.412714 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-22 03:04:16.243325 | 2026-03-22 03:04:16.243489 | PLAY [all] 2026-03-22 03:04:16.258007 | 2026-03-22 03:04:16.258132 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-03-22 03:04:16.515610 | debian-bookworm | changed: non-zero return code 2026-03-22 03:04:16.521415 | 2026-03-22 03:04:16.521540 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-03-22 03:04:16.555051 | debian-bookworm | skipping: Conditional result was False 2026-03-22 03:04:16.561211 | 2026-03-22 03:04:16.561323 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-03-22 03:04:16.601106 | 2026-03-22 03:04:16.601298 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-03-22 03:04:16.651791 | 2026-03-22 03:04:16.651978 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-03-22 03:04:16.665378 | debian-bookworm | skipping: Conditional result was False 2026-03-22 03:04:16.672719 | 2026-03-22 03:04:16.672843 | LOOP [fetch-subunit-output : Generate subunit file] 2026-03-22 03:04:16.712360 | 2026-03-22 03:04:16.712589 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-03-22 03:04:16.746950 | debian-bookworm | skipping: Conditional result was False 2026-03-22 03:04:16.756561 | 2026-03-22 03:04:16.756731 | TASK [fetch-subunit-output : Remove the temporary file] 2026-03-22 03:04:16.793467 | debian-bookworm | skipping: Conditional result was False 2026-03-22 03:04:16.799493 | 2026-03-22 03:04:16.799610 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-03-22 03:04:16.850795 | debian-bookworm | skipping: Conditional result was False 2026-03-22 03:04:16.864782 | 2026-03-22 03:04:16.864923 | PLAY RECAP 2026-03-22 03:04:16.864997 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-03-22 03:04:16.865024 | 2026-03-22 03:04:17.293258 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-22 03:04:17.294394 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-03-22 03:04:18.715161 | 2026-03-22 03:04:18.715353 | PLAY [Base post] 2026-03-22 03:04:18.845182 | 2026-03-22 03:04:18.845367 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-22 03:04:19.711225 | debian-bookworm | changed 2026-03-22 03:04:19.725297 | 2026-03-22 03:04:19.725443 | PLAY RECAP 2026-03-22 03:04:19.725511 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-22 03:04:19.725575 | 2026-03-22 03:04:20.127796 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-03-22 03:04:20.129033 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-22 03:04:21.649299 | 2026-03-22 03:04:21.649638 | PLAY [Base post-logs] 2026-03-22 03:04:21.672640 | 2026-03-22 03:04:21.672812 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-22 03:04:22.464051 | localhost | changed 2026-03-22 03:04:22.473296 | 2026-03-22 03:04:22.473416 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-22 03:04:22.538555 | localhost | ok 2026-03-22 03:04:22.541773 | 2026-03-22 03:04:22.541859 | TASK [Set zuul-log-path fact] 2026-03-22 03:04:22.566037 | localhost | ok 2026-03-22 03:04:22.579328 | 2026-03-22 03:04:22.579430 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-22 03:04:22.626607 | localhost | ok 2026-03-22 03:04:22.629408 | 2026-03-22 03:04:22.629495 | TASK [upload-logs : Create log directories] 2026-03-22 03:04:23.667824 | localhost | changed 2026-03-22 03:04:23.670724 | 2026-03-22 03:04:23.670977 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-22 03:04:24.484722 | localhost -> localhost | ok: Runtime: 0:00:00.010107 2026-03-22 03:04:24.488365 | 2026-03-22 03:04:24.488459 | TASK [upload-logs : Upload logs to log server] 2026-03-22 03:04:25.716765 | localhost | Output suppressed because no_log was given 2026-03-22 03:04:25.718672 | 2026-03-22 03:04:25.718809 | LOOP [upload-logs : Compress console log and json output] 2026-03-22 03:04:25.900437 | localhost | skipping: Conditional result was False 2026-03-22 03:04:25.913149 | localhost | skipping: Conditional result was False 2026-03-22 03:04:25.922209 | 2026-03-22 03:04:25.922322 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-22 03:04:26.063776 | localhost | skipping: Conditional result was False 2026-03-22 03:04:26.064064 | 2026-03-22 03:04:26.096532 | localhost | skipping: Conditional result was False 2026-03-22 03:04:26.106324 | 2026-03-22 03:04:26.106456 | LOOP [upload-logs : Upload console log and json output]