2025-10-20 08:19:57.452088 | Job console starting 2025-10-20 08:19:57.473826 | Updating git repos 2025-10-20 08:19:57.506942 | Cloning repos into workspace 2025-10-20 08:19:57.566196 | Restoring repo states 2025-10-20 08:19:57.577220 | Merging changes 2025-10-20 08:19:58.136113 | Checking out repos 2025-10-20 08:19:58.186345 | Preparing playbooks 2025-10-20 08:19:59.224858 | Running Ansible setup 2025-10-20 08:20:04.660911 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-10-20 08:20:05.720777 | 2025-10-20 08:20:05.720948 | PLAY [Base pre] 2025-10-20 08:20:05.748666 | 2025-10-20 08:20:05.748818 | TASK [Setup log path fact] 2025-10-20 08:20:05.777967 | debian-bookworm | ok 2025-10-20 08:20:05.822181 | 2025-10-20 08:20:05.822328 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-20 08:20:05.891222 | debian-bookworm | ok 2025-10-20 08:20:05.903642 | 2025-10-20 08:20:05.903735 | TASK [emit-job-header : Print job information] 2025-10-20 08:20:05.940650 | # Job Information 2025-10-20 08:20:05.940791 | Ansible Version: 2.16.14 2025-10-20 08:20:05.940819 | Job: tox 2025-10-20 08:20:05.940846 | Pipeline: check 2025-10-20 08:20:05.940865 | Executor: 521e9411259a 2025-10-20 08:20:05.940881 | Triggered by: https://github.com/osism/openstack-image-manager/pull/974 2025-10-20 08:20:05.940899 | Event ID: 8b179d60-ad8d-11f0-95ca-31728e3b1e81 2025-10-20 08:20:05.944828 | 2025-10-20 08:20:05.944906 | LOOP [emit-job-header : Print node information] 2025-10-20 08:20:06.073927 | debian-bookworm | ok: 2025-10-20 08:20:06.074072 | debian-bookworm | # Node Information 2025-10-20 08:20:06.074100 | debian-bookworm | Inventory Hostname: debian-bookworm 2025-10-20 08:20:06.074121 | debian-bookworm | Hostname: debian 2025-10-20 08:20:06.074139 | debian-bookworm | Username: zuul 2025-10-20 08:20:06.074157 | debian-bookworm | Distro: Debian 12.12 2025-10-20 08:20:06.074177 | debian-bookworm | Provider: regiocloud-a 2025-10-20 08:20:06.074195 | debian-bookworm | Region: 2025-10-20 08:20:06.074212 | debian-bookworm | Label: debian-bookworm 2025-10-20 08:20:06.074229 | debian-bookworm | Product Name: OpenStack Nova 2025-10-20 08:20:06.074244 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fed3:2479 2025-10-20 08:20:06.083051 | 2025-10-20 08:20:06.083150 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-20 08:20:06.555801 | debian-bookworm -> localhost | changed 2025-10-20 08:20:06.561368 | 2025-10-20 08:20:06.561467 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-20 08:20:08.003504 | debian-bookworm -> localhost | changed 2025-10-20 08:20:08.011897 | 2025-10-20 08:20:08.011984 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-20 08:20:08.271058 | debian-bookworm -> localhost | ok 2025-10-20 08:20:08.276325 | 2025-10-20 08:20:08.276435 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-20 08:20:08.293211 | debian-bookworm | ok 2025-10-20 08:20:08.309480 | debian-bookworm | included: /var/lib/zuul/builds/3a9efd5159bf4995b9623a8c59e753cd/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-20 08:20:08.314168 | 2025-10-20 08:20:08.314238 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-20 08:20:09.875462 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2025-10-20 08:20:09.875648 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/3a9efd5159bf4995b9623a8c59e753cd/work/3a9efd5159bf4995b9623a8c59e753cd_id_rsa 2025-10-20 08:20:09.875681 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/3a9efd5159bf4995b9623a8c59e753cd/work/3a9efd5159bf4995b9623a8c59e753cd_id_rsa.pub 2025-10-20 08:20:09.875703 | debian-bookworm -> localhost | The key fingerprint is: 2025-10-20 08:20:09.875726 | debian-bookworm -> localhost | SHA256:/QfH728r+OUqCPE8+1LfNxs9jM/+eI+4Y3/mx8F/UyQ zuul-build-sshkey 2025-10-20 08:20:09.875745 | debian-bookworm -> localhost | The key's randomart image is: 2025-10-20 08:20:09.875773 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2025-10-20 08:20:09.875792 | debian-bookworm -> localhost | | | 2025-10-20 08:20:09.875810 | debian-bookworm -> localhost | | | 2025-10-20 08:20:09.875826 | debian-bookworm -> localhost | | | 2025-10-20 08:20:09.875843 | debian-bookworm -> localhost | | . . .E .| 2025-10-20 08:20:09.875859 | debian-bookworm -> localhost | | S . . +o | 2025-10-20 08:20:09.875877 | debian-bookworm -> localhost | | . + o oo+o| 2025-10-20 08:20:09.875895 | debian-bookworm -> localhost | | . = +.o**| 2025-10-20 08:20:09.875911 | debian-bookworm -> localhost | | + oo==B&| 2025-10-20 08:20:09.875928 | debian-bookworm -> localhost | | oo=*B&^| 2025-10-20 08:20:09.875946 | debian-bookworm -> localhost | +----[SHA256]-----+ 2025-10-20 08:20:09.875984 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.994003 2025-10-20 08:20:09.888012 | 2025-10-20 08:20:09.888101 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-20 08:20:09.924366 | debian-bookworm | ok 2025-10-20 08:20:09.931679 | debian-bookworm | included: /var/lib/zuul/builds/3a9efd5159bf4995b9623a8c59e753cd/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-20 08:20:09.948890 | 2025-10-20 08:20:09.948960 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-20 08:20:09.988019 | debian-bookworm | skipping: Conditional result was False 2025-10-20 08:20:09.992617 | 2025-10-20 08:20:09.992692 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-20 08:20:10.576886 | debian-bookworm | changed 2025-10-20 08:20:10.582206 | 2025-10-20 08:20:10.582295 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-20 08:20:10.839176 | debian-bookworm | ok 2025-10-20 08:20:10.844855 | 2025-10-20 08:20:10.844945 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-20 08:20:11.532263 | debian-bookworm | changed 2025-10-20 08:20:11.540125 | 2025-10-20 08:20:11.540225 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-20 08:20:12.168089 | debian-bookworm | changed 2025-10-20 08:20:12.173221 | 2025-10-20 08:20:12.173306 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-20 08:20:12.186547 | debian-bookworm | skipping: Conditional result was False 2025-10-20 08:20:12.192349 | 2025-10-20 08:20:12.192460 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-20 08:20:12.602296 | debian-bookworm -> localhost | changed 2025-10-20 08:20:12.612670 | 2025-10-20 08:20:12.612765 | TASK [add-build-sshkey : Add back temp key] 2025-10-20 08:20:12.902195 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/3a9efd5159bf4995b9623a8c59e753cd/work/3a9efd5159bf4995b9623a8c59e753cd_id_rsa (zuul-build-sshkey) 2025-10-20 08:20:12.902433 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011235 2025-10-20 08:20:12.909907 | 2025-10-20 08:20:12.910007 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-20 08:20:13.282015 | debian-bookworm | ok 2025-10-20 08:20:13.286776 | 2025-10-20 08:20:13.286885 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-20 08:20:13.309994 | debian-bookworm | skipping: Conditional result was False 2025-10-20 08:20:13.333642 | 2025-10-20 08:20:13.333869 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-20 08:20:13.759723 | debian-bookworm | ok 2025-10-20 08:20:13.776384 | 2025-10-20 08:20:13.776491 | TASK [validate-host : Define zuul_info_dir fact] 2025-10-20 08:20:13.834203 | debian-bookworm | ok 2025-10-20 08:20:13.839202 | 2025-10-20 08:20:13.839293 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-10-20 08:20:14.329226 | debian-bookworm -> localhost | ok 2025-10-20 08:20:14.335309 | 2025-10-20 08:20:14.335414 | TASK [validate-host : Collect information about the host] 2025-10-20 08:20:15.406024 | debian-bookworm | ok 2025-10-20 08:20:15.427909 | 2025-10-20 08:20:15.428015 | TASK [validate-host : Sanitize hostname] 2025-10-20 08:20:15.557014 | debian-bookworm | ok 2025-10-20 08:20:15.590098 | 2025-10-20 08:20:15.590198 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-10-20 08:20:16.090528 | debian-bookworm -> localhost | changed 2025-10-20 08:20:16.099296 | 2025-10-20 08:20:16.099429 | TASK [validate-host : Collect information about zuul worker] 2025-10-20 08:20:16.523828 | debian-bookworm | ok 2025-10-20 08:20:16.528271 | 2025-10-20 08:20:16.528358 | TASK [validate-host : Write out all zuul information for each host] 2025-10-20 08:20:17.197091 | debian-bookworm -> localhost | changed 2025-10-20 08:20:17.205760 | 2025-10-20 08:20:17.205850 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-10-20 08:20:17.468546 | debian-bookworm | ok 2025-10-20 08:20:17.480209 | 2025-10-20 08:20:17.480307 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-10-20 08:20:18.346207 | debian-bookworm | changed: 2025-10-20 08:20:18.346457 | debian-bookworm | cd+++++++++ src/ 2025-10-20 08:20:18.346497 | debian-bookworm | cd+++++++++ src/github.com/ 2025-10-20 08:20:18.346523 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2025-10-20 08:20:18.346545 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-10-20 08:20:18.346566 | debian-bookworm | =6.2 2025-10-20 08:20:41.089759 | debian-bookworm | Downloading cachetools-6.2.1-py3-none-any.whl (11 kB) 2025-10-20 08:20:41.138346 | debian-bookworm | Collecting chardet>=5.2 2025-10-20 08:20:41.150566 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-10-20 08:20:41.172104 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 10.9 MB/s eta 0:00:00 2025-10-20 08:20:41.229244 | debian-bookworm | Collecting colorama>=0.4.6 2025-10-20 08:20:41.242359 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-10-20 08:20:41.312394 | debian-bookworm | Collecting filelock>=3.20 2025-10-20 08:20:41.324292 | debian-bookworm | Downloading filelock-3.20.0-py3-none-any.whl (16 kB) 2025-10-20 08:20:41.374749 | debian-bookworm | Collecting packaging>=25 2025-10-20 08:20:41.386966 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2025-10-20 08:20:41.398246 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 9.1 MB/s eta 0:00:00 2025-10-20 08:20:41.452688 | debian-bookworm | Collecting platformdirs>=4.5 2025-10-20 08:20:41.464590 | debian-bookworm | Downloading platformdirs-4.5.0-py3-none-any.whl (18 kB) 2025-10-20 08:20:41.514752 | debian-bookworm | Collecting pluggy>=1.6 2025-10-20 08:20:41.526145 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2025-10-20 08:20:41.567054 | debian-bookworm | Collecting pyproject-api>=1.9.1 2025-10-20 08:20:41.583354 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2025-10-20 08:20:41.716938 | debian-bookworm | Collecting virtualenv>=20.34 2025-10-20 08:20:41.728703 | debian-bookworm | Downloading virtualenv-20.35.3-py3-none-any.whl (6.0 MB) 2025-10-20 08:20:42.004000 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 22.0 MB/s eta 0:00:00 2025-10-20 08:20:42.123910 | debian-bookworm | Collecting distlib<1,>=0.3.7 2025-10-20 08:20:42.136407 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2025-10-20 08:20:42.177184 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 13.1 MB/s eta 0:00:00 2025-10-20 08:20:42.335935 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-10-20 08:20:43.227889 | debian-bookworm | Successfully installed cachetools-6.2.1 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.20.0 packaging-25.0 platformdirs-4.5.0 pluggy-1.6.0 pyproject-api-1.10.0 tox-4.31.0 virtualenv-20.35.3 2025-10-20 08:20:43.462319 | debian-bookworm | ok: Runtime: 0:00:03.139874 2025-10-20 08:20:43.474611 | 2025-10-20 08:20:43.474786 | TASK [ensure-tox : Export installed tox_executable path] 2025-10-20 08:20:43.516568 | debian-bookworm | ok 2025-10-20 08:20:43.521581 | 2025-10-20 08:20:43.521697 | TASK [ensure-tox : Output tox version] 2025-10-20 08:20:44.071326 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-10-20 08:20:44.090630 | debian-bookworm | 4.31.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-10-20 08:20:44.553463 | debian-bookworm | ok: Runtime: 0:00:00.302633 2025-10-20 08:20:44.559319 | 2025-10-20 08:20:44.559448 | TASK [ensure-tox : Make global symlink] 2025-10-20 08:20:44.583473 | debian-bookworm | skipping: Conditional result was False 2025-10-20 08:20:44.590126 | 2025-10-20 08:20:44.590209 | PLAY RECAP 2025-10-20 08:20:44.590264 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-10-20 08:20:44.590289 | 2025-10-20 08:20:44.743056 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2025-10-20 08:20:44.744156 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-10-20 08:20:45.573437 | 2025-10-20 08:20:45.573611 | PLAY [all] 2025-10-20 08:20:45.592222 | 2025-10-20 08:20:45.592386 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-10-20 08:20:46.103459 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-10-20 08:20:46.163102 | debian-bookworm | ok: Runtime: 0:00:00.023750 2025-10-20 08:20:46.168838 | 2025-10-20 08:20:46.168965 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-10-20 08:20:46.706021 | debian-bookworm | ok: Runtime: 0:00:00.007428 2025-10-20 08:20:46.712301 | 2025-10-20 08:20:46.712443 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-10-20 08:20:47.003659 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2025-10-20 08:20:47.003846 | debian-bookworm | sudo: a password is required 2025-10-20 08:20:47.241012 | debian-bookworm | ok: Runtime: 0:00:00.017522 2025-10-20 08:20:47.261593 | 2025-10-20 08:20:47.261738 | TASK [tox : Check to see if the constraints file exists] 2025-10-20 08:20:47.289856 | debian-bookworm | skipping: Conditional result was False 2025-10-20 08:20:47.296847 | 2025-10-20 08:20:47.296965 | TASK [tox : Fail if constraints file is missing] 2025-10-20 08:20:47.330628 | debian-bookworm | skipping: Conditional result was False 2025-10-20 08:20:47.342670 | 2025-10-20 08:20:47.342824 | TASK [tox : Record file location] 2025-10-20 08:20:47.367144 | debian-bookworm | skipping: Conditional result was False 2025-10-20 08:20:47.376410 | 2025-10-20 08:20:47.376549 | TASK [tox : Install tox siblings] 2025-10-20 08:20:47.397422 | debian-bookworm | ok 2025-10-20 08:20:47.405790 | debian-bookworm | included: /var/lib/zuul/builds/3a9efd5159bf4995b9623a8c59e753cd/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2025-10-20 08:20:47.411378 | 2025-10-20 08:20:47.411486 | TASK [tox : Run tox without tests] 2025-10-20 08:20:48.605833 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2025-10-20 08:21:02.681657 | debian-bookworm | test: OK (14.69 seconds) 2025-10-20 08:21:02.681788 | debian-bookworm | congratulations :) (14.72 seconds) 2025-10-20 08:21:02.947954 | debian-bookworm | ok: Runtime: 0:00:15.014104 2025-10-20 08:21:02.961009 | 2025-10-20 08:21:02.961163 | TASK [tox : Create a tempfile to save tox showconfig] 2025-10-20 08:21:03.382438 | debian-bookworm | changed 2025-10-20 08:21:03.391819 | 2025-10-20 08:21:03.391978 | TASK [tox : Get tox envlist config] 2025-10-20 08:21:04.423783 | debian-bookworm | ok: Runtime: 0:00:00.376825 2025-10-20 08:21:04.437233 | 2025-10-20 08:21:04.437476 | TASK [tox : Install any sibling python packages] 2025-10-20 08:21:04.909325 | debian-bookworm | ok: No setup.cfg, no action needed 2025-10-20 08:21:04.917198 | 2025-10-20 08:21:04.917329 | TASK [tox : Remove tempfile] 2025-10-20 08:21:05.378585 | debian-bookworm | changed 2025-10-20 08:21:05.387426 | 2025-10-20 08:21:05.387566 | TASK [tox : Emit tox command] 2025-10-20 08:21:05.442212 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-10-20 08:21:05.449922 | 2025-10-20 08:21:05.450057 | TASK [tox : Run tox] 2025-10-20 08:21:06.074127 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2025-10-20 08:21:06.738550 | debian-bookworm | ............... 2025-10-20 08:21:06.738619 | debian-bookworm | ---------------------------------------------------------------------- 2025-10-20 08:21:06.738637 | debian-bookworm | Ran 15 tests in 0.175s 2025-10-20 08:21:06.738642 | debian-bookworm | 2025-10-20 08:21:06.739111 | debian-bookworm | OK 2025-10-20 08:21:06.841653 | debian-bookworm | test: OK (0.81=setup[0.05]+cmd[0.76] seconds) 2025-10-20 08:21:06.841743 | debian-bookworm | congratulations :) (0.84 seconds) 2025-10-20 08:21:07.011835 | debian-bookworm | ok: Runtime: 0:00:01.140981 2025-10-20 08:21:07.025285 | 2025-10-20 08:21:07.025464 | TASK [tox : Look for output] 2025-10-20 08:21:07.448409 | debian-bookworm | ok 2025-10-20 08:21:07.467516 | 2025-10-20 08:21:07.467651 | TASK [tox : Return file comments to Zuul] 2025-10-20 08:21:07.502885 | debian-bookworm | skipping: Conditional result was False 2025-10-20 08:21:07.515384 | 2025-10-20 08:21:07.515495 | PLAY RECAP 2025-10-20 08:21:07.515576 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-10-20 08:21:07.515615 | 2025-10-20 08:21:07.631710 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2025-10-20 08:21:07.632791 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-10-20 08:21:08.356626 | 2025-10-20 08:21:08.356768 | PLAY [all] 2025-10-20 08:21:08.371675 | 2025-10-20 08:21:08.371801 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-10-20 08:21:08.437459 | debian-bookworm | skipping: Conditional result was False 2025-10-20 08:21:08.450136 | 2025-10-20 08:21:08.450414 | TASK [fetch-tox-output : Set tox log path for single node] 2025-10-20 08:21:08.499552 | debian-bookworm | ok 2025-10-20 08:21:08.507993 | 2025-10-20 08:21:08.508142 | TASK [fetch-tox-output : Ensure local tox dir] 2025-10-20 08:21:08.977754 | debian-bookworm -> localhost | changed 2025-10-20 08:21:08.985644 | 2025-10-20 08:21:08.985757 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-10-20 08:21:09.040502 | debian-bookworm | skipping: Conditional result was False 2025-10-20 08:21:09.046863 | 2025-10-20 08:21:09.047006 | TASK [fetch-tox-output : Set envlist fact] 2025-10-20 08:21:09.081000 | debian-bookworm | ok 2025-10-20 08:21:09.089021 | 2025-10-20 08:21:09.089143 | TASK [fetch-tox-output : Get tox version] 2025-10-20 08:21:09.780307 | debian-bookworm | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-10-20 08:21:09.798611 | debian-bookworm | 4.31.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2025-10-20 08:21:10.120193 | debian-bookworm | ok: Runtime: 0:00:00.300521 2025-10-20 08:21:10.133298 | 2025-10-20 08:21:10.133484 | TASK [fetch-tox-output : Find all default environments] 2025-10-20 08:21:10.667475 | debian-bookworm | skipping: Conditional result was False 2025-10-20 08:21:10.679939 | 2025-10-20 08:21:10.680118 | TASK [fetch-tox-output : Set envlist fact] 2025-10-20 08:21:10.715441 | debian-bookworm | skipping: Conditional result was False 2025-10-20 08:21:10.728944 | 2025-10-20 08:21:10.729102 | TASK [fetch-tox-output : Find all default environments] 2025-10-20 08:21:11.262550 | debian-bookworm | skipping: Conditional result was False 2025-10-20 08:21:11.276578 | 2025-10-20 08:21:11.276756 | TASK [fetch-tox-output : Set envlist fact] 2025-10-20 08:21:11.313051 | debian-bookworm | skipping: Conditional result was False 2025-10-20 08:21:11.322721 | 2025-10-20 08:21:11.322878 | LOOP [fetch-tox-output : Copy tox logs] 2025-10-20 08:21:11.372937 | debian-bookworm | skipping: Conditional result was False 2025-10-20 08:21:11.391677 | 2025-10-20 08:21:11.391832 | LOOP [fetch-tox-output : Collect tox logs] 2025-10-20 08:21:12.180797 | debian-bookworm | changed: 2025-10-20 08:21:12.181102 | debian-bookworm | created directory /var/lib/zuul/builds/3a9efd5159bf4995b9623a8c59e753cd/work/logs/tox/test 2025-10-20 08:21:12.181162 | debian-bookworm | cd+++++++++ ./ 2025-10-20 08:21:12.181205 | debian-bookworm | >f+++++++++ 1-commands[0].log 2025-10-20 08:21:12.181257 | 2025-10-20 08:21:12.204022 | 2025-10-20 08:21:12.204156 | PLAY RECAP 2025-10-20 08:21:12.204237 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-10-20 08:21:12.204276 | 2025-10-20 08:21:12.330061 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2025-10-20 08:21:12.332665 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-10-20 08:21:13.042680 | 2025-10-20 08:21:13.042863 | PLAY [all] 2025-10-20 08:21:13.057773 | 2025-10-20 08:21:13.057895 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-10-20 08:21:13.277521 | debian-bookworm | changed: non-zero return code 2025-10-20 08:21:13.285835 | 2025-10-20 08:21:13.285993 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-10-20 08:21:13.310876 | debian-bookworm | skipping: Conditional result was False 2025-10-20 08:21:13.323937 | 2025-10-20 08:21:13.324110 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-10-20 08:21:13.360047 | 2025-10-20 08:21:13.360284 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-10-20 08:21:13.402913 | 2025-10-20 08:21:13.403107 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-10-20 08:21:13.426795 | debian-bookworm | skipping: Conditional result was False 2025-10-20 08:21:13.438773 | 2025-10-20 08:21:13.438962 | LOOP [fetch-subunit-output : Generate subunit file] 2025-10-20 08:21:13.474679 | 2025-10-20 08:21:13.474987 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-10-20 08:21:13.499267 | debian-bookworm | skipping: Conditional result was False 2025-10-20 08:21:13.509971 | 2025-10-20 08:21:13.510129 | TASK [fetch-subunit-output : Remove the temporary file] 2025-10-20 08:21:13.534628 | debian-bookworm | skipping: Conditional result was False 2025-10-20 08:21:13.543263 | 2025-10-20 08:21:13.543412 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-10-20 08:21:13.566957 | debian-bookworm | skipping: Conditional result was False 2025-10-20 08:21:13.576500 | 2025-10-20 08:21:13.576688 | PLAY RECAP 2025-10-20 08:21:13.576751 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-10-20 08:21:13.576784 | 2025-10-20 08:21:13.699091 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2025-10-20 08:21:13.701804 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-10-20 08:21:14.438067 | 2025-10-20 08:21:14.438230 | PLAY [Base post] 2025-10-20 08:21:14.451757 | 2025-10-20 08:21:14.451893 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-10-20 08:21:15.009129 | debian-bookworm | changed 2025-10-20 08:21:15.015558 | 2025-10-20 08:21:15.015659 | PLAY RECAP 2025-10-20 08:21:15.015719 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-20 08:21:15.015781 | 2025-10-20 08:21:15.131626 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-10-20 08:21:15.132732 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-10-20 08:21:15.957172 | 2025-10-20 08:21:15.957357 | PLAY [Base post-logs] 2025-10-20 08:21:15.967981 | 2025-10-20 08:21:15.968116 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-10-20 08:21:16.415556 | localhost | changed 2025-10-20 08:21:16.432193 | 2025-10-20 08:21:16.432435 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-10-20 08:21:16.459888 | localhost | ok 2025-10-20 08:21:16.465989 | 2025-10-20 08:21:16.466140 | TASK [Set zuul-log-path fact] 2025-10-20 08:21:16.483789 | localhost | ok 2025-10-20 08:21:16.495831 | 2025-10-20 08:21:16.495991 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-20 08:21:16.522379 | localhost | ok 2025-10-20 08:21:16.526917 | 2025-10-20 08:21:16.527062 | TASK [upload-logs : Create log directories] 2025-10-20 08:21:16.991988 | localhost | changed 2025-10-20 08:21:16.996741 | 2025-10-20 08:21:16.996899 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-10-20 08:21:17.467107 | localhost -> localhost | ok: Runtime: 0:00:00.006966 2025-10-20 08:21:17.471171 | 2025-10-20 08:21:17.471283 | TASK [upload-logs : Upload logs to log server] 2025-10-20 08:21:18.025200 | localhost | Output suppressed because no_log was given 2025-10-20 08:21:18.029424 | 2025-10-20 08:21:18.029604 | LOOP [upload-logs : Compress console log and json output] 2025-10-20 08:21:18.074672 | localhost | skipping: Conditional result was False 2025-10-20 08:21:18.082288 | localhost | skipping: Conditional result was False 2025-10-20 08:21:18.091307 | 2025-10-20 08:21:18.091542 | LOOP [upload-logs : Upload compressed console log and json output] 2025-10-20 08:21:18.135817 | localhost | skipping: Conditional result was False 2025-10-20 08:21:18.136167 | 2025-10-20 08:21:18.140598 | localhost | skipping: Conditional result was False 2025-10-20 08:21:18.151864 | 2025-10-20 08:21:18.152052 | LOOP [upload-logs : Upload console log and json output]