2026-01-04 00:23:42.975018 | Job console starting 2026-01-04 00:23:42.985172 | Updating git repos 2026-01-04 00:23:43.011514 | Cloning repos into workspace 2026-01-04 00:23:43.144987 | Restoring repo states 2026-01-04 00:23:43.184441 | Merging changes 2026-01-04 00:23:44.015066 | Checking out repos 2026-01-04 00:23:44.089376 | Preparing playbooks 2026-01-04 00:23:45.346296 | Running Ansible setup 2026-01-04 00:23:52.618619 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-04 00:23:53.965228 | 2026-01-04 00:23:53.965403 | PLAY [Base pre] 2026-01-04 00:23:53.983102 | 2026-01-04 00:23:53.983255 | TASK [Setup log path fact] 2026-01-04 00:23:54.002747 | debian-bookworm | ok 2026-01-04 00:23:54.019299 | 2026-01-04 00:23:54.019467 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-04 00:23:54.049816 | debian-bookworm | ok 2026-01-04 00:23:54.066756 | 2026-01-04 00:23:54.066946 | TASK [emit-job-header : Print job information] 2026-01-04 00:23:54.138916 | # Job Information 2026-01-04 00:23:54.139180 | Ansible Version: 2.16.14 2026-01-04 00:23:54.139217 | Job: tox 2026-01-04 00:23:54.139249 | Pipeline: check 2026-01-04 00:23:54.139271 | Executor: 521e9411259a 2026-01-04 00:23:54.139291 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1073 2026-01-04 00:23:54.139313 | Event ID: 3ef5df80-e903-11f0-9f88-b9ca978b3d0d 2026-01-04 00:23:54.144766 | 2026-01-04 00:23:54.144908 | LOOP [emit-job-header : Print node information] 2026-01-04 00:23:54.308467 | debian-bookworm | ok: 2026-01-04 00:23:54.308766 | debian-bookworm | # Node Information 2026-01-04 00:23:54.308805 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-04 00:23:54.308830 | debian-bookworm | Hostname: debian 2026-01-04 00:23:54.308852 | debian-bookworm | Username: zuul 2026-01-04 00:23:54.308874 | debian-bookworm | Distro: Debian 12.12 2026-01-04 00:23:54.308897 | debian-bookworm | Provider: regiocloud-a 2026-01-04 00:23:54.308919 | debian-bookworm | Region: 2026-01-04 00:23:54.308940 | debian-bookworm | Label: debian-bookworm 2026-01-04 00:23:54.308959 | debian-bookworm | Product Name: OpenStack Nova 2026-01-04 00:23:54.308978 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fead:edde 2026-01-04 00:23:54.351339 | 2026-01-04 00:23:54.351543 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-04 00:23:55.349947 | debian-bookworm -> localhost | changed 2026-01-04 00:23:55.358092 | 2026-01-04 00:23:55.358231 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-04 00:23:58.065332 | debian-bookworm -> localhost | changed 2026-01-04 00:23:58.077812 | 2026-01-04 00:23:58.077951 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-04 00:23:59.139197 | debian-bookworm -> localhost | ok 2026-01-04 00:23:59.149826 | 2026-01-04 00:23:59.149975 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-04 00:23:59.261409 | debian-bookworm | ok 2026-01-04 00:23:59.338485 | debian-bookworm | included: /var/lib/zuul/builds/57cd3271298b481ab4c29b6b9a778d11/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-04 00:23:59.358348 | 2026-01-04 00:23:59.358559 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-04 00:24:01.685366 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-04 00:24:01.685622 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/57cd3271298b481ab4c29b6b9a778d11/work/57cd3271298b481ab4c29b6b9a778d11_id_rsa 2026-01-04 00:24:01.685665 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/57cd3271298b481ab4c29b6b9a778d11/work/57cd3271298b481ab4c29b6b9a778d11_id_rsa.pub 2026-01-04 00:24:01.685692 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-04 00:24:01.685719 | debian-bookworm -> localhost | SHA256:IAxUWPga+wU2YnZDKeNd1sraun6YmbmwI9Ihg4JB3r8 zuul-build-sshkey 2026-01-04 00:24:01.685742 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-04 00:24:01.685774 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-04 00:24:01.685796 | debian-bookworm -> localhost | | .o=o. . | 2026-01-04 00:24:01.685818 | debian-bookworm -> localhost | | .=oo o . | 2026-01-04 00:24:01.685838 | debian-bookworm -> localhost | |o..*o+.. | 2026-01-04 00:24:01.685857 | debian-bookworm -> localhost | |..*.O.o. | 2026-01-04 00:24:01.685876 | debian-bookworm -> localhost | |o+ B.* S | 2026-01-04 00:24:01.685900 | debian-bookworm -> localhost | |* + ..o | 2026-01-04 00:24:01.685920 | debian-bookworm -> localhost | |.+.o O. | 2026-01-04 00:24:01.685939 | debian-bookworm -> localhost | |o ooOE. | 2026-01-04 00:24:01.685959 | debian-bookworm -> localhost | |...o++ | 2026-01-04 00:24:01.685979 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-04 00:24:01.686035 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.750667 2026-01-04 00:24:01.692942 | 2026-01-04 00:24:01.693055 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-04 00:24:01.750129 | debian-bookworm | ok 2026-01-04 00:24:01.770950 | debian-bookworm | included: /var/lib/zuul/builds/57cd3271298b481ab4c29b6b9a778d11/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-04 00:24:01.788376 | 2026-01-04 00:24:01.788551 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-04 00:24:01.851551 | debian-bookworm | skipping: Conditional result was False 2026-01-04 00:24:01.875177 | 2026-01-04 00:24:01.875358 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-04 00:24:03.109111 | debian-bookworm | changed 2026-01-04 00:24:03.120598 | 2026-01-04 00:24:03.120754 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-04 00:24:03.426087 | debian-bookworm | ok 2026-01-04 00:24:03.438821 | 2026-01-04 00:24:03.439168 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-04 00:24:04.348997 | debian-bookworm | changed 2026-01-04 00:24:04.360200 | 2026-01-04 00:24:04.360346 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-04 00:24:05.251108 | debian-bookworm | changed 2026-01-04 00:24:05.260839 | 2026-01-04 00:24:05.260976 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-04 00:24:05.312058 | debian-bookworm | skipping: Conditional result was False 2026-01-04 00:24:05.319267 | 2026-01-04 00:24:05.319476 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-04 00:24:06.477567 | debian-bookworm -> localhost | changed 2026-01-04 00:24:06.502074 | 2026-01-04 00:24:06.502290 | TASK [add-build-sshkey : Add back temp key] 2026-01-04 00:24:07.093141 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/57cd3271298b481ab4c29b6b9a778d11/work/57cd3271298b481ab4c29b6b9a778d11_id_rsa (zuul-build-sshkey) 2026-01-04 00:24:07.093397 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.024290 2026-01-04 00:24:07.112903 | 2026-01-04 00:24:07.113053 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-04 00:24:08.059305 | debian-bookworm | ok 2026-01-04 00:24:08.071731 | 2026-01-04 00:24:08.071872 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-04 00:24:08.153382 | debian-bookworm | skipping: Conditional result was False 2026-01-04 00:24:08.169634 | 2026-01-04 00:24:08.169771 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-04 00:24:09.126042 | debian-bookworm | ok 2026-01-04 00:24:09.153916 | 2026-01-04 00:24:09.154068 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-04 00:24:09.208347 | debian-bookworm | ok 2026-01-04 00:24:09.223685 | 2026-01-04 00:24:09.223839 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-04 00:24:10.710391 | debian-bookworm -> localhost | ok 2026-01-04 00:24:10.717831 | 2026-01-04 00:24:10.717966 | TASK [validate-host : Collect information about the host] 2026-01-04 00:24:12.932923 | debian-bookworm | ok 2026-01-04 00:24:12.966965 | 2026-01-04 00:24:12.967123 | TASK [validate-host : Sanitize hostname] 2026-01-04 00:24:13.403724 | debian-bookworm | ok 2026-01-04 00:24:13.534635 | 2026-01-04 00:24:13.534781 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-04 00:24:14.955347 | debian-bookworm -> localhost | changed 2026-01-04 00:24:14.963697 | 2026-01-04 00:24:14.963958 | TASK [validate-host : Collect information about zuul worker] 2026-01-04 00:24:15.757389 | debian-bookworm | ok 2026-01-04 00:24:15.770247 | 2026-01-04 00:24:15.770389 | TASK [validate-host : Write out all zuul information for each host] 2026-01-04 00:24:16.797250 | debian-bookworm -> localhost | changed 2026-01-04 00:24:16.810367 | 2026-01-04 00:24:16.810563 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-04 00:24:17.178226 | debian-bookworm | ok 2026-01-04 00:24:17.193433 | 2026-01-04 00:24:17.193603 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-04 00:24:18.867485 | debian-bookworm | changed: 2026-01-04 00:24:18.867719 | debian-bookworm | cd+++++++++ src/ 2026-01-04 00:24:18.867957 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-04 00:24:18.867999 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-04 00:24:18.868025 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-01-04 00:24:18.868048 | debian-bookworm | =6.2.4 2026-01-04 00:24:39.986853 | debian-bookworm | Downloading cachetools-6.2.4-py3-none-any.whl (11 kB) 2026-01-04 00:24:40.036180 | debian-bookworm | Collecting chardet>=5.2 2026-01-04 00:24:40.047969 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2026-01-04 00:24:40.078701 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 7.0 MB/s eta 0:00:00 2026-01-04 00:24:40.124097 | debian-bookworm | Collecting colorama>=0.4.6 2026-01-04 00:24:40.136718 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-01-04 00:24:40.196423 | debian-bookworm | Collecting filelock>=3.20.2 2026-01-04 00:24:40.207599 | debian-bookworm | Downloading filelock-3.20.2-py3-none-any.whl (16 kB) 2026-01-04 00:24:40.260867 | debian-bookworm | Collecting packaging>=25 2026-01-04 00:24:40.274273 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2026-01-04 00:24:40.286447 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 8.1 MB/s eta 0:00:00 2026-01-04 00:24:40.346652 | debian-bookworm | Collecting platformdirs>=4.5.1 2026-01-04 00:24:40.358857 | debian-bookworm | Downloading platformdirs-4.5.1-py3-none-any.whl (18 kB) 2026-01-04 00:24:40.418352 | debian-bookworm | Collecting pluggy>=1.6 2026-01-04 00:24:40.431215 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-01-04 00:24:40.491632 | debian-bookworm | Collecting pyproject-api>=1.10 2026-01-04 00:24:40.503389 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-01-04 00:24:40.646382 | debian-bookworm | Collecting virtualenv>=20.35.4 2026-01-04 00:24:40.660357 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2026-01-04 00:24:41.032733 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 16.4 MB/s eta 0:00:00 2026-01-04 00:24:41.152570 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-01-04 00:24:41.167767 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-01-04 00:24:41.191488 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 25.7 MB/s eta 0:00:00 2026-01-04 00:24:41.348602 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2026-01-04 00:24:42.180986 | debian-bookworm | Successfully installed cachetools-6.2.4 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.20.2 packaging-25.0 platformdirs-4.5.1 pluggy-1.6.0 pyproject-api-1.10.0 tox-4.33.0 virtualenv-20.35.4 2026-01-04 00:24:42.461222 | debian-bookworm | ok: Runtime: 0:00:03.081836 2026-01-04 00:24:42.477067 | 2026-01-04 00:24:42.477254 | TASK [ensure-tox : Export installed tox_executable path] 2026-01-04 00:24:42.510118 | debian-bookworm | ok 2026-01-04 00:24:42.517323 | 2026-01-04 00:24:42.517442 | TASK [ensure-tox : Output tox version] 2026-01-04 00:24:43.053274 | 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-04 00:24:43.071282 | debian-bookworm | 4.33.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-01-04 00:24:43.553869 | debian-bookworm | ok: Runtime: 0:00:00.284712 2026-01-04 00:24:43.576647 | 2026-01-04 00:24:43.576944 | TASK [ensure-tox : Make global symlink] 2026-01-04 00:24:43.622620 | debian-bookworm | skipping: Conditional result was False 2026-01-04 00:24:43.641939 | 2026-01-04 00:24:43.642159 | PLAY RECAP 2026-01-04 00:24:43.642231 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-01-04 00:24:43.642263 | 2026-01-04 00:24:43.861135 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-01-04 00:24:43.862270 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-01-04 00:24:44.708647 | 2026-01-04 00:24:44.708835 | PLAY [all] 2026-01-04 00:24:44.726265 | 2026-01-04 00:24:44.726433 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-01-04 00:24:45.234071 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-01-04 00:24:45.303728 | debian-bookworm | ok: Runtime: 0:00:00.035517 2026-01-04 00:24:45.309485 | 2026-01-04 00:24:45.309662 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-01-04 00:24:45.840157 | debian-bookworm | ok: Runtime: 0:00:00.006143 2026-01-04 00:24:45.846633 | 2026-01-04 00:24:45.846772 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-01-04 00:24:46.116882 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-01-04 00:24:46.119873 | debian-bookworm | sudo: a password is required 2026-01-04 00:24:46.379796 | debian-bookworm | ok: Runtime: 0:00:00.022378 2026-01-04 00:24:46.395224 | 2026-01-04 00:24:46.396012 | TASK [tox : Check to see if the constraints file exists] 2026-01-04 00:24:46.435753 | debian-bookworm | skipping: Conditional result was False 2026-01-04 00:24:46.442366 | 2026-01-04 00:24:46.442526 | TASK [tox : Fail if constraints file is missing] 2026-01-04 00:24:46.479833 | debian-bookworm | skipping: Conditional result was False 2026-01-04 00:24:46.492910 | 2026-01-04 00:24:46.493541 | TASK [tox : Record file location] 2026-01-04 00:24:46.530603 | debian-bookworm | skipping: Conditional result was False 2026-01-04 00:24:46.540810 | 2026-01-04 00:24:46.540959 | TASK [tox : Install tox siblings] 2026-01-04 00:24:46.577837 | debian-bookworm | ok 2026-01-04 00:24:46.586692 | debian-bookworm | included: /var/lib/zuul/builds/57cd3271298b481ab4c29b6b9a778d11/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-01-04 00:24:46.592812 | 2026-01-04 00:24:46.592949 | TASK [tox : Run tox without tests] 2026-01-04 00:24:47.769125 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-01-04 00:25:02.013768 | debian-bookworm | test: OK (14.81 seconds) 2026-01-04 00:25:02.013856 | debian-bookworm | congratulations :) (14.84 seconds) 2026-01-04 00:25:02.151238 | debian-bookworm | ok: Runtime: 0:00:15.120705 2026-01-04 00:25:02.164642 | 2026-01-04 00:25:02.164818 | TASK [tox : Create a tempfile to save tox showconfig] 2026-01-04 00:25:02.608997 | debian-bookworm | changed 2026-01-04 00:25:02.619383 | 2026-01-04 00:25:02.619659 | TASK [tox : Get tox envlist config] 2026-01-04 00:25:03.657811 | debian-bookworm | ok: Runtime: 0:00:00.371863 2026-01-04 00:25:03.670999 | 2026-01-04 00:25:03.671188 | TASK [tox : Install any sibling python packages] 2026-01-04 00:25:04.137987 | debian-bookworm | ok: No setup.cfg, no action needed 2026-01-04 00:25:04.145384 | 2026-01-04 00:25:04.145569 | TASK [tox : Remove tempfile] 2026-01-04 00:25:04.592923 | debian-bookworm | changed 2026-01-04 00:25:04.599483 | 2026-01-04 00:25:04.599666 | TASK [tox : Emit tox command] 2026-01-04 00:25:04.640750 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-01-04 00:25:04.646074 | 2026-01-04 00:25:04.646827 | TASK [tox : Run tox] 2026-01-04 00:25:05.284872 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-01-04 00:25:05.933190 | debian-bookworm | ............... 2026-01-04 00:25:05.933255 | debian-bookworm | ---------------------------------------------------------------------- 2026-01-04 00:25:05.933273 | debian-bookworm | Ran 15 tests in 0.169s 2026-01-04 00:25:05.933279 | debian-bookworm | 2026-01-04 00:25:05.933288 | debian-bookworm | OK 2026-01-04 00:25:06.031434 | debian-bookworm | test: OK (0.79=setup[0.05]+cmd[0.74] seconds) 2026-01-04 00:25:06.031525 | debian-bookworm | congratulations :) (0.82 seconds) 2026-01-04 00:25:06.231781 | debian-bookworm | ok: Runtime: 0:00:01.114642 2026-01-04 00:25:06.246896 | 2026-01-04 00:25:06.247085 | TASK [tox : Look for output] 2026-01-04 00:25:06.660768 | debian-bookworm | ok 2026-01-04 00:25:06.690625 | 2026-01-04 00:25:06.690806 | TASK [tox : Return file comments to Zuul] 2026-01-04 00:25:06.725938 | debian-bookworm | skipping: Conditional result was False 2026-01-04 00:25:06.732782 | 2026-01-04 00:25:06.732938 | PLAY RECAP 2026-01-04 00:25:06.732998 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-01-04 00:25:06.733028 | 2026-01-04 00:25:06.882243 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-01-04 00:25:06.883473 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-01-04 00:25:07.626063 | 2026-01-04 00:25:07.626231 | PLAY [all] 2026-01-04 00:25:07.641856 | 2026-01-04 00:25:07.642014 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-01-04 00:25:07.696740 | debian-bookworm | skipping: Conditional result was False 2026-01-04 00:25:07.702696 | 2026-01-04 00:25:07.702901 | TASK [fetch-tox-output : Set tox log path for single node] 2026-01-04 00:25:07.741696 | debian-bookworm | ok 2026-01-04 00:25:07.747124 | 2026-01-04 00:25:07.747259 | TASK [fetch-tox-output : Ensure local tox dir] 2026-01-04 00:25:08.267394 | debian-bookworm -> localhost | changed 2026-01-04 00:25:08.275474 | 2026-01-04 00:25:08.275660 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-01-04 00:25:08.323777 | debian-bookworm | skipping: Conditional result was False 2026-01-04 00:25:08.337330 | 2026-01-04 00:25:08.337624 | TASK [fetch-tox-output : Set envlist fact] 2026-01-04 00:25:08.398757 | debian-bookworm | ok 2026-01-04 00:25:08.416182 | 2026-01-04 00:25:08.416355 | TASK [fetch-tox-output : Get tox version] 2026-01-04 00:25:09.161062 | 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-04 00:25:09.179133 | debian-bookworm | 4.33.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-01-04 00:25:09.485835 | debian-bookworm | ok: Runtime: 0:00:00.289924 2026-01-04 00:25:09.492636 | 2026-01-04 00:25:09.492763 | TASK [fetch-tox-output : Find all default environments] 2026-01-04 00:25:10.029929 | debian-bookworm | skipping: Conditional result was False 2026-01-04 00:25:10.043155 | 2026-01-04 00:25:10.043361 | TASK [fetch-tox-output : Set envlist fact] 2026-01-04 00:25:10.079751 | debian-bookworm | skipping: Conditional result was False 2026-01-04 00:25:10.100130 | 2026-01-04 00:25:10.100401 | TASK [fetch-tox-output : Find all default environments] 2026-01-04 00:25:10.637660 | debian-bookworm | skipping: Conditional result was False 2026-01-04 00:25:10.647321 | 2026-01-04 00:25:10.647468 | TASK [fetch-tox-output : Set envlist fact] 2026-01-04 00:25:10.673228 | debian-bookworm | skipping: Conditional result was False 2026-01-04 00:25:10.681387 | 2026-01-04 00:25:10.681540 | LOOP [fetch-tox-output : Copy tox logs] 2026-01-04 00:25:10.738625 | debian-bookworm | skipping: Conditional result was False 2026-01-04 00:25:10.753059 | 2026-01-04 00:25:10.753303 | LOOP [fetch-tox-output : Collect tox logs] 2026-01-04 00:25:11.679119 | debian-bookworm | changed: 2026-01-04 00:25:11.680325 | debian-bookworm | created directory /var/lib/zuul/builds/57cd3271298b481ab4c29b6b9a778d11/work/logs/tox/test 2026-01-04 00:25:11.680629 | debian-bookworm | cd+++++++++ ./ 2026-01-04 00:25:11.680721 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-01-04 00:25:11.681119 | 2026-01-04 00:25:11.694766 | 2026-01-04 00:25:11.694900 | PLAY RECAP 2026-01-04 00:25:11.694959 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-01-04 00:25:11.694985 | 2026-01-04 00:25:11.858189 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-01-04 00:25:11.860961 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-01-04 00:25:12.741086 | 2026-01-04 00:25:12.741264 | PLAY [all] 2026-01-04 00:25:12.758060 | 2026-01-04 00:25:12.758223 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-01-04 00:25:12.966709 | debian-bookworm | changed: non-zero return code 2026-01-04 00:25:12.973199 | 2026-01-04 00:25:12.973371 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-01-04 00:25:12.989835 | debian-bookworm | skipping: Conditional result was False 2026-01-04 00:25:13.003182 | 2026-01-04 00:25:13.003519 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-01-04 00:25:13.041490 | 2026-01-04 00:25:13.041761 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-01-04 00:25:13.084475 | 2026-01-04 00:25:13.084773 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-01-04 00:25:13.109556 | debian-bookworm | skipping: Conditional result was False 2026-01-04 00:25:13.116234 | 2026-01-04 00:25:13.116358 | LOOP [fetch-subunit-output : Generate subunit file] 2026-01-04 00:25:13.153752 | 2026-01-04 00:25:13.154082 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-01-04 00:25:13.180737 | debian-bookworm | skipping: Conditional result was False 2026-01-04 00:25:13.195732 | 2026-01-04 00:25:13.195929 | TASK [fetch-subunit-output : Remove the temporary file] 2026-01-04 00:25:13.221182 | debian-bookworm | skipping: Conditional result was False 2026-01-04 00:25:13.234356 | 2026-01-04 00:25:13.234563 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-01-04 00:25:13.260612 | debian-bookworm | skipping: Conditional result was False 2026-01-04 00:25:13.268089 | 2026-01-04 00:25:13.268195 | PLAY RECAP 2026-01-04 00:25:13.268247 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-01-04 00:25:13.268271 | 2026-01-04 00:25:13.417094 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-01-04 00:25:13.418212 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-01-04 00:25:14.260831 | 2026-01-04 00:25:14.261025 | PLAY [Base post] 2026-01-04 00:25:14.276936 | 2026-01-04 00:25:14.277098 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-01-04 00:25:14.861370 | debian-bookworm | changed 2026-01-04 00:25:14.868117 | 2026-01-04 00:25:14.868233 | PLAY RECAP 2026-01-04 00:25:14.868294 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-01-04 00:25:14.868356 | 2026-01-04 00:25:15.005063 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-01-04 00:25:15.006134 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-01-04 00:25:15.863727 | 2026-01-04 00:25:15.863906 | PLAY [Base post-logs] 2026-01-04 00:25:15.875122 | 2026-01-04 00:25:15.875284 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-01-04 00:25:16.345682 | localhost | changed 2026-01-04 00:25:16.359171 | 2026-01-04 00:25:16.359360 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-01-04 00:25:16.399648 | localhost | ok 2026-01-04 00:25:16.407093 | 2026-01-04 00:25:16.407296 | TASK [Set zuul-log-path fact] 2026-01-04 00:25:16.430795 | localhost | ok 2026-01-04 00:25:16.445724 | 2026-01-04 00:25:16.445915 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-04 00:25:16.485015 | localhost | ok 2026-01-04 00:25:16.491426 | 2026-01-04 00:25:16.491627 | TASK [upload-logs : Create log directories] 2026-01-04 00:25:17.047132 | localhost | changed 2026-01-04 00:25:17.050130 | 2026-01-04 00:25:17.050248 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-01-04 00:25:17.573540 | localhost -> localhost | ok: Runtime: 0:00:00.008561 2026-01-04 00:25:17.579437 | 2026-01-04 00:25:17.579607 | TASK [upload-logs : Upload logs to log server] 2026-01-04 00:25:18.150429 | localhost | Output suppressed because no_log was given 2026-01-04 00:25:18.153179 | 2026-01-04 00:25:18.153326 | LOOP [upload-logs : Compress console log and json output] 2026-01-04 00:25:18.210984 | localhost | skipping: Conditional result was False 2026-01-04 00:25:18.220032 | localhost | skipping: Conditional result was False 2026-01-04 00:25:18.229006 | 2026-01-04 00:25:18.229258 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-04 00:25:18.283424 | localhost | skipping: Conditional result was False 2026-01-04 00:25:18.283745 | 2026-01-04 00:25:18.290598 | localhost | skipping: Conditional result was False 2026-01-04 00:25:18.308999 | 2026-01-04 00:25:18.309235 | LOOP [upload-logs : Upload console log and json output]