2026-01-06 03:17:16.578936 | Job console starting 2026-01-06 03:17:16.589767 | Updating git repos 2026-01-06 03:17:16.644840 | Cloning repos into workspace 2026-01-06 03:17:16.779868 | Restoring repo states 2026-01-06 03:17:16.805008 | Merging changes 2026-01-06 03:17:16.805035 | Checking out repos 2026-01-06 03:17:16.952813 | Preparing playbooks 2026-01-06 03:17:18.003019 | Running Ansible setup 2026-01-06 03:17:24.893697 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-06 03:17:25.810704 | 2026-01-06 03:17:25.811020 | PLAY [Base pre] 2026-01-06 03:17:25.839155 | 2026-01-06 03:17:25.839336 | TASK [Setup log path fact] 2026-01-06 03:17:25.868863 | debian-bookworm | ok 2026-01-06 03:17:25.884483 | 2026-01-06 03:17:25.884898 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-06 03:17:25.913679 | debian-bookworm | ok 2026-01-06 03:17:25.925848 | 2026-01-06 03:17:25.925959 | TASK [emit-job-header : Print job information] 2026-01-06 03:17:25.965001 | # Job Information 2026-01-06 03:17:25.965171 | Ansible Version: 2.16.14 2026-01-06 03:17:25.965232 | Job: tox 2026-01-06 03:17:25.965270 | Pipeline: periodic-daily 2026-01-06 03:17:25.965293 | Executor: 521e9411259a 2026-01-06 03:17:25.965313 | Triggered by: https://github.com/osism/openstack-image-manager 2026-01-06 03:17:25.965336 | Event ID: 5db5d3b4a22b48709a9c907240447ed4 2026-01-06 03:17:25.970289 | 2026-01-06 03:17:25.970401 | LOOP [emit-job-header : Print node information] 2026-01-06 03:17:26.131162 | debian-bookworm | ok: 2026-01-06 03:17:26.132178 | debian-bookworm | # Node Information 2026-01-06 03:17:26.132289 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-06 03:17:26.132315 | debian-bookworm | Hostname: debian 2026-01-06 03:17:26.132714 | debian-bookworm | Username: zuul 2026-01-06 03:17:26.132819 | debian-bookworm | Distro: Debian 12.12 2026-01-06 03:17:26.132845 | debian-bookworm | Provider: regiocloud-a 2026-01-06 03:17:26.132864 | debian-bookworm | Region: 2026-01-06 03:17:26.133324 | debian-bookworm | Label: debian-bookworm 2026-01-06 03:17:26.133455 | debian-bookworm | Product Name: OpenStack Nova 2026-01-06 03:17:26.133485 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fed9:f838 2026-01-06 03:17:26.168325 | 2026-01-06 03:17:26.168446 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-06 03:17:27.329960 | debian-bookworm -> localhost | changed 2026-01-06 03:17:27.340114 | 2026-01-06 03:17:27.340241 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-06 03:17:29.743992 | debian-bookworm -> localhost | changed 2026-01-06 03:17:29.756791 | 2026-01-06 03:17:29.756905 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-06 03:17:30.434048 | debian-bookworm -> localhost | ok 2026-01-06 03:17:30.440300 | 2026-01-06 03:17:30.440409 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-06 03:17:30.478869 | debian-bookworm | ok 2026-01-06 03:17:30.500992 | debian-bookworm | included: /var/lib/zuul/builds/1e70ae5562c24bce8271f252d437c28a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-06 03:17:30.507809 | 2026-01-06 03:17:30.507909 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-06 03:17:31.936646 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-06 03:17:31.936875 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/1e70ae5562c24bce8271f252d437c28a/work/1e70ae5562c24bce8271f252d437c28a_id_rsa 2026-01-06 03:17:31.936916 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/1e70ae5562c24bce8271f252d437c28a/work/1e70ae5562c24bce8271f252d437c28a_id_rsa.pub 2026-01-06 03:17:31.936942 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-06 03:17:31.936968 | debian-bookworm -> localhost | SHA256:XmOBXBqL6EIB9cI3JOPsLsngTX8AO4d0e9gmLtBIyDM zuul-build-sshkey 2026-01-06 03:17:31.936990 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-06 03:17:31.937037 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-06 03:17:31.937076 | debian-bookworm -> localhost | |.o= . . . | 2026-01-06 03:17:31.937100 | debian-bookworm -> localhost | |o+ * . o * | 2026-01-06 03:17:31.937121 | debian-bookworm -> localhost | |.E*o=.. = . | 2026-01-06 03:17:31.937140 | debian-bookworm -> localhost | |.o*+=.+ . | 2026-01-06 03:17:31.937160 | debian-bookworm -> localhost | |.oo*.* +S + | 2026-01-06 03:17:31.937185 | debian-bookworm -> localhost | |+o+.= =. o . | 2026-01-06 03:17:31.937219 | debian-bookworm -> localhost | |oo.o o .. | 2026-01-06 03:17:31.937241 | debian-bookworm -> localhost | | . . . | 2026-01-06 03:17:31.937262 | debian-bookworm -> localhost | | | 2026-01-06 03:17:31.937283 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-06 03:17:31.937333 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.656595 2026-01-06 03:17:31.949956 | 2026-01-06 03:17:31.950249 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-06 03:17:31.983362 | debian-bookworm | ok 2026-01-06 03:17:31.994398 | debian-bookworm | included: /var/lib/zuul/builds/1e70ae5562c24bce8271f252d437c28a/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-06 03:17:32.003771 | 2026-01-06 03:17:32.003885 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-06 03:17:32.027692 | debian-bookworm | skipping: Conditional result was False 2026-01-06 03:17:32.043790 | 2026-01-06 03:17:32.043930 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-06 03:17:32.866286 | debian-bookworm | changed 2026-01-06 03:17:32.878808 | 2026-01-06 03:17:32.878973 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-06 03:17:33.151585 | debian-bookworm | ok 2026-01-06 03:17:33.161995 | 2026-01-06 03:17:33.162124 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-06 03:17:33.861860 | debian-bookworm | changed 2026-01-06 03:17:33.878447 | 2026-01-06 03:17:33.878650 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-06 03:17:34.657617 | debian-bookworm | changed 2026-01-06 03:17:34.667114 | 2026-01-06 03:17:34.667297 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-06 03:17:34.723293 | debian-bookworm | skipping: Conditional result was False 2026-01-06 03:17:34.730483 | 2026-01-06 03:17:34.731563 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-06 03:17:35.943454 | debian-bookworm -> localhost | changed 2026-01-06 03:17:35.964531 | 2026-01-06 03:17:35.964763 | TASK [add-build-sshkey : Add back temp key] 2026-01-06 03:17:37.681833 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/1e70ae5562c24bce8271f252d437c28a/work/1e70ae5562c24bce8271f252d437c28a_id_rsa (zuul-build-sshkey) 2026-01-06 03:17:37.682158 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.036960 2026-01-06 03:17:37.692954 | 2026-01-06 03:17:37.693084 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-06 03:17:38.323572 | debian-bookworm | ok 2026-01-06 03:17:38.335387 | 2026-01-06 03:17:38.335528 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-06 03:17:38.418963 | debian-bookworm | skipping: Conditional result was False 2026-01-06 03:17:38.444194 | 2026-01-06 03:17:38.444360 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-06 03:17:39.417842 | debian-bookworm | ok 2026-01-06 03:17:39.462253 | 2026-01-06 03:17:39.462406 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-06 03:17:39.628727 | debian-bookworm | ok 2026-01-06 03:17:39.690150 | 2026-01-06 03:17:39.690314 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-06 03:17:41.038970 | debian-bookworm -> localhost | ok 2026-01-06 03:17:41.046153 | 2026-01-06 03:17:41.046311 | TASK [validate-host : Collect information about the host] 2026-01-06 03:17:42.824950 | debian-bookworm | ok 2026-01-06 03:17:42.855739 | 2026-01-06 03:17:42.855889 | TASK [validate-host : Sanitize hostname] 2026-01-06 03:17:43.110028 | debian-bookworm | ok 2026-01-06 03:17:43.223760 | 2026-01-06 03:17:43.223933 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-06 03:17:45.276999 | debian-bookworm -> localhost | changed 2026-01-06 03:17:45.289861 | 2026-01-06 03:17:45.290255 | TASK [validate-host : Collect information about zuul worker] 2026-01-06 03:17:45.949347 | debian-bookworm | ok 2026-01-06 03:17:45.957852 | 2026-01-06 03:17:45.957983 | TASK [validate-host : Write out all zuul information for each host] 2026-01-06 03:17:46.814391 | debian-bookworm -> localhost | changed 2026-01-06 03:17:46.834762 | 2026-01-06 03:17:46.835034 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-06 03:17:47.189436 | debian-bookworm | ok 2026-01-06 03:17:47.211294 | 2026-01-06 03:17:47.211446 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-06 03:17:49.285239 | debian-bookworm | changed: 2026-01-06 03:17:49.285482 | debian-bookworm | cd+++++++++ src/ 2026-01-06 03:17:49.285518 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-06 03:17:49.285543 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-06 03:17:49.285565 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-01-06 03:17:49.285586 | debian-bookworm | =6.2.4 2026-01-06 03:18:16.619881 | debian-bookworm | Downloading cachetools-6.2.4-py3-none-any.whl (11 kB) 2026-01-06 03:18:16.660978 | debian-bookworm | Collecting chardet>=5.2 2026-01-06 03:18:16.673905 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2026-01-06 03:18:16.698131 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 9.5 MB/s eta 0:00:00 2026-01-06 03:18:16.769702 | debian-bookworm | Collecting colorama>=0.4.6 2026-01-06 03:18:16.784734 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-01-06 03:18:16.859721 | debian-bookworm | Collecting filelock>=3.20.2 2026-01-06 03:18:16.872217 | debian-bookworm | Downloading filelock-3.20.2-py3-none-any.whl (16 kB) 2026-01-06 03:18:16.926718 | debian-bookworm | Collecting packaging>=25 2026-01-06 03:18:16.939035 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2026-01-06 03:18:16.950327 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 7.0 MB/s eta 0:00:00 2026-01-06 03:18:17.001285 | debian-bookworm | Collecting platformdirs>=4.5.1 2026-01-06 03:18:17.013930 | debian-bookworm | Downloading platformdirs-4.5.1-py3-none-any.whl (18 kB) 2026-01-06 03:18:17.058334 | debian-bookworm | Collecting pluggy>=1.6 2026-01-06 03:18:17.070996 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-01-06 03:18:17.114024 | debian-bookworm | Collecting pyproject-api>=1.10 2026-01-06 03:18:17.126688 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-01-06 03:18:17.271383 | debian-bookworm | Collecting virtualenv>=20.35.4 2026-01-06 03:18:17.284547 | debian-bookworm | Downloading virtualenv-20.35.4-py3-none-any.whl (6.0 MB) 2026-01-06 03:18:17.605709 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 19.0 MB/s eta 0:00:00 2026-01-06 03:18:17.713379 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-01-06 03:18:17.725932 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-01-06 03:18:17.747598 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 25.5 MB/s eta 0:00:00 2026-01-06 03:18:17.900948 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2026-01-06 03:18:18.829753 | 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-06 03:18:19.366583 | debian-bookworm | ok: Runtime: 0:00:03.385981 2026-01-06 03:18:19.374072 | 2026-01-06 03:18:19.374253 | TASK [ensure-tox : Export installed tox_executable path] 2026-01-06 03:18:19.416563 | debian-bookworm | ok 2026-01-06 03:18:19.425094 | 2026-01-06 03:18:19.425252 | TASK [ensure-tox : Output tox version] 2026-01-06 03:18:20.019931 | 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-06 03:18:20.039228 | debian-bookworm | 4.33.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-01-06 03:18:20.500112 | debian-bookworm | ok: Runtime: 0:00:00.314160 2026-01-06 03:18:20.506969 | 2026-01-06 03:18:20.507098 | TASK [ensure-tox : Make global symlink] 2026-01-06 03:18:20.532884 | debian-bookworm | skipping: Conditional result was False 2026-01-06 03:18:20.549975 | 2026-01-06 03:18:20.550094 | PLAY RECAP 2026-01-06 03:18:20.550154 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-01-06 03:18:20.550224 | 2026-01-06 03:18:21.070111 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-01-06 03:18:21.071297 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-01-06 03:18:22.781674 | 2026-01-06 03:18:22.781867 | PLAY [all] 2026-01-06 03:18:22.810218 | 2026-01-06 03:18:22.810389 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-01-06 03:18:23.933953 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-01-06 03:18:24.381465 | debian-bookworm | ok: Runtime: 0:00:00.020721 2026-01-06 03:18:24.400326 | 2026-01-06 03:18:24.400515 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-01-06 03:18:25.010889 | debian-bookworm | ok: Runtime: 0:00:00.006598 2026-01-06 03:18:25.017566 | 2026-01-06 03:18:25.017717 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-01-06 03:18:25.590810 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-01-06 03:18:25.593631 | debian-bookworm | sudo: a password is required 2026-01-06 03:18:25.656515 | debian-bookworm | ok: Runtime: 0:00:00.022211 2026-01-06 03:18:25.684137 | 2026-01-06 03:18:25.684306 | TASK [tox : Check to see if the constraints file exists] 2026-01-06 03:18:25.747404 | debian-bookworm | skipping: Conditional result was False 2026-01-06 03:18:25.761465 | 2026-01-06 03:18:25.761612 | TASK [tox : Fail if constraints file is missing] 2026-01-06 03:18:25.849536 | debian-bookworm | skipping: Conditional result was False 2026-01-06 03:18:25.861770 | 2026-01-06 03:18:25.861927 | TASK [tox : Record file location] 2026-01-06 03:18:25.892329 | debian-bookworm | skipping: Conditional result was False 2026-01-06 03:18:25.901471 | 2026-01-06 03:18:25.901626 | TASK [tox : Install tox siblings] 2026-01-06 03:18:25.978324 | debian-bookworm | ok 2026-01-06 03:18:26.018619 | debian-bookworm | included: /var/lib/zuul/builds/1e70ae5562c24bce8271f252d437c28a/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-01-06 03:18:26.077001 | 2026-01-06 03:18:26.077162 | TASK [tox : Run tox without tests] 2026-01-06 03:18:27.434627 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-01-06 03:18:42.613539 | debian-bookworm | test: OK (15.71 seconds) 2026-01-06 03:18:42.613601 | debian-bookworm | congratulations :) (15.74 seconds) 2026-01-06 03:18:42.749910 | debian-bookworm | ok: Runtime: 0:00:16.060093 2026-01-06 03:18:42.756142 | 2026-01-06 03:18:42.756278 | TASK [tox : Create a tempfile to save tox showconfig] 2026-01-06 03:18:43.278553 | debian-bookworm | changed 2026-01-06 03:18:43.292056 | 2026-01-06 03:18:43.292220 | TASK [tox : Get tox envlist config] 2026-01-06 03:18:44.350321 | debian-bookworm | ok: Runtime: 0:00:00.416443 2026-01-06 03:18:44.356924 | 2026-01-06 03:18:44.357122 | TASK [tox : Install any sibling python packages] 2026-01-06 03:18:45.237326 | debian-bookworm | ok: No setup.cfg, no action needed 2026-01-06 03:18:45.249048 | 2026-01-06 03:18:45.249209 | TASK [tox : Remove tempfile] 2026-01-06 03:18:45.731645 | debian-bookworm | changed 2026-01-06 03:18:45.737756 | 2026-01-06 03:18:45.737891 | TASK [tox : Emit tox command] 2026-01-06 03:18:45.815425 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-01-06 03:18:45.821350 | 2026-01-06 03:18:45.821491 | TASK [tox : Run tox] 2026-01-06 03:18:46.535824 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-01-06 03:18:47.167508 | debian-bookworm | ............... 2026-01-06 03:18:47.167559 | debian-bookworm | ---------------------------------------------------------------------- 2026-01-06 03:18:47.167574 | debian-bookworm | Ran 15 tests in 0.169s 2026-01-06 03:18:47.167579 | debian-bookworm | 2026-01-06 03:18:47.167587 | debian-bookworm | OK 2026-01-06 03:18:47.260707 | debian-bookworm | test: OK (0.76=setup[0.04]+cmd[0.72] seconds) 2026-01-06 03:18:47.260822 | debian-bookworm | congratulations :) (0.79 seconds) 2026-01-06 03:18:47.449728 | debian-bookworm | ok: Runtime: 0:00:01.103019 2026-01-06 03:18:47.455906 | 2026-01-06 03:18:47.456018 | TASK [tox : Look for output] 2026-01-06 03:18:48.062039 | debian-bookworm | ok 2026-01-06 03:18:48.093886 | 2026-01-06 03:18:48.094067 | TASK [tox : Return file comments to Zuul] 2026-01-06 03:18:48.191118 | debian-bookworm | skipping: Conditional result was False 2026-01-06 03:18:48.200252 | 2026-01-06 03:18:48.200365 | PLAY RECAP 2026-01-06 03:18:48.200424 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-01-06 03:18:48.200449 | 2026-01-06 03:18:48.483277 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-01-06 03:18:48.484429 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-01-06 03:18:49.956075 | 2026-01-06 03:18:49.956290 | PLAY [all] 2026-01-06 03:18:49.990695 | 2026-01-06 03:18:49.991394 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-01-06 03:18:50.118559 | debian-bookworm | skipping: Conditional result was False 2026-01-06 03:18:50.127025 | 2026-01-06 03:18:50.127218 | TASK [fetch-tox-output : Set tox log path for single node] 2026-01-06 03:18:50.198415 | debian-bookworm | ok 2026-01-06 03:18:50.208825 | 2026-01-06 03:18:50.209217 | TASK [fetch-tox-output : Ensure local tox dir] 2026-01-06 03:18:51.520385 | debian-bookworm -> localhost | changed 2026-01-06 03:18:51.533781 | 2026-01-06 03:18:51.533985 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-01-06 03:18:51.654689 | debian-bookworm | skipping: Conditional result was False 2026-01-06 03:18:51.660940 | 2026-01-06 03:18:51.661079 | TASK [fetch-tox-output : Set envlist fact] 2026-01-06 03:18:51.727532 | debian-bookworm | ok 2026-01-06 03:18:51.750899 | 2026-01-06 03:18:51.751123 | TASK [fetch-tox-output : Get tox version] 2026-01-06 03:18:52.569218 | 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-06 03:18:52.588404 | debian-bookworm | 4.33.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-01-06 03:18:52.819803 | debian-bookworm | ok: Runtime: 0:00:00.323043 2026-01-06 03:18:52.826128 | 2026-01-06 03:18:52.826281 | TASK [fetch-tox-output : Find all default environments] 2026-01-06 03:18:53.381795 | debian-bookworm | skipping: Conditional result was False 2026-01-06 03:18:53.388156 | 2026-01-06 03:18:53.388336 | TASK [fetch-tox-output : Set envlist fact] 2026-01-06 03:18:53.433154 | debian-bookworm | skipping: Conditional result was False 2026-01-06 03:18:53.439542 | 2026-01-06 03:18:53.439686 | TASK [fetch-tox-output : Find all default environments] 2026-01-06 03:18:53.996237 | debian-bookworm | skipping: Conditional result was False 2026-01-06 03:18:54.002432 | 2026-01-06 03:18:54.002561 | TASK [fetch-tox-output : Set envlist fact] 2026-01-06 03:18:54.037374 | debian-bookworm | skipping: Conditional result was False 2026-01-06 03:18:54.044359 | 2026-01-06 03:18:54.044525 | LOOP [fetch-tox-output : Copy tox logs] 2026-01-06 03:18:54.127603 | debian-bookworm | skipping: Conditional result was False 2026-01-06 03:18:54.137320 | 2026-01-06 03:18:54.137466 | LOOP [fetch-tox-output : Collect tox logs] 2026-01-06 03:18:55.744520 | debian-bookworm | changed: 2026-01-06 03:18:55.747990 | debian-bookworm | created directory /var/lib/zuul/builds/1e70ae5562c24bce8271f252d437c28a/work/logs/tox/test 2026-01-06 03:18:55.748106 | debian-bookworm | cd+++++++++ ./ 2026-01-06 03:18:55.748287 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-01-06 03:18:55.748343 | 2026-01-06 03:18:55.767532 | 2026-01-06 03:18:55.767668 | PLAY RECAP 2026-01-06 03:18:55.767729 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-01-06 03:18:55.767753 | 2026-01-06 03:18:55.956341 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-01-06 03:18:55.957411 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-01-06 03:18:57.558303 | 2026-01-06 03:18:57.558478 | PLAY [all] 2026-01-06 03:18:57.611424 | 2026-01-06 03:18:57.611595 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-01-06 03:18:57.982915 | debian-bookworm | changed: non-zero return code 2026-01-06 03:18:57.989587 | 2026-01-06 03:18:57.989749 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-01-06 03:18:58.055933 | debian-bookworm | skipping: Conditional result was False 2026-01-06 03:18:58.063486 | 2026-01-06 03:18:58.063623 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-01-06 03:18:58.119859 | 2026-01-06 03:18:58.120073 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-01-06 03:18:58.198066 | 2026-01-06 03:18:58.198338 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-01-06 03:18:58.245657 | debian-bookworm | skipping: Conditional result was False 2026-01-06 03:18:58.252801 | 2026-01-06 03:18:58.252936 | LOOP [fetch-subunit-output : Generate subunit file] 2026-01-06 03:18:58.318689 | 2026-01-06 03:18:58.318948 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-01-06 03:18:58.371274 | debian-bookworm | skipping: Conditional result was False 2026-01-06 03:18:58.378897 | 2026-01-06 03:18:58.379044 | TASK [fetch-subunit-output : Remove the temporary file] 2026-01-06 03:18:58.432908 | debian-bookworm | skipping: Conditional result was False 2026-01-06 03:18:58.440567 | 2026-01-06 03:18:58.440708 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-01-06 03:18:58.522201 | debian-bookworm | skipping: Conditional result was False 2026-01-06 03:18:58.535046 | 2026-01-06 03:18:58.535185 | PLAY RECAP 2026-01-06 03:18:58.535241 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-01-06 03:18:58.535266 | 2026-01-06 03:18:59.331201 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-01-06 03:18:59.332323 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-01-06 03:19:01.047018 | 2026-01-06 03:19:01.047240 | PLAY [Base post] 2026-01-06 03:19:01.062407 | 2026-01-06 03:19:01.062577 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-01-06 03:19:01.654299 | debian-bookworm | changed 2026-01-06 03:19:01.672443 | 2026-01-06 03:19:01.672582 | PLAY RECAP 2026-01-06 03:19:01.672648 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-01-06 03:19:01.672709 | 2026-01-06 03:19:01.947150 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-01-06 03:19:01.948303 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-01-06 03:19:03.755529 | 2026-01-06 03:19:03.755757 | PLAY [Base post-logs] 2026-01-06 03:19:03.785052 | 2026-01-06 03:19:03.785269 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-01-06 03:19:05.399097 | localhost | changed 2026-01-06 03:19:05.416153 | 2026-01-06 03:19:05.416385 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-01-06 03:19:05.523315 | localhost | ok 2026-01-06 03:19:05.527092 | 2026-01-06 03:19:05.527227 | TASK [Set zuul-log-path fact] 2026-01-06 03:19:05.554107 | localhost | ok 2026-01-06 03:19:05.563540 | 2026-01-06 03:19:05.563672 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-06 03:19:05.613422 | localhost | ok 2026-01-06 03:19:05.618269 | 2026-01-06 03:19:05.618401 | TASK [upload-logs : Create log directories] 2026-01-06 03:19:07.036356 | localhost | changed 2026-01-06 03:19:07.041188 | 2026-01-06 03:19:07.041429 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-01-06 03:19:08.995720 | localhost -> localhost | ok: Runtime: 0:00:00.016586 2026-01-06 03:19:09.000823 | 2026-01-06 03:19:09.000958 | TASK [upload-logs : Upload logs to log server] 2026-01-06 03:19:10.313931 | localhost | Output suppressed because no_log was given 2026-01-06 03:19:10.320373 | 2026-01-06 03:19:10.322369 | LOOP [upload-logs : Compress console log and json output] 2026-01-06 03:19:10.435892 | localhost | skipping: Conditional result was False 2026-01-06 03:19:10.453437 | localhost | skipping: Conditional result was False 2026-01-06 03:19:10.464642 | 2026-01-06 03:19:10.464849 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-06 03:19:10.570024 | localhost | skipping: Conditional result was False 2026-01-06 03:19:10.570348 | 2026-01-06 03:19:10.578352 | localhost | skipping: Conditional result was False 2026-01-06 03:19:10.591893 | 2026-01-06 03:19:10.592057 | LOOP [upload-logs : Upload console log and json output]