2026-01-16 03:17:25.631723 | Job console starting 2026-01-16 03:17:25.645373 | Updating git repos 2026-01-16 03:17:25.675981 | Cloning repos into workspace 2026-01-16 03:17:25.759140 | Restoring repo states 2026-01-16 03:17:25.774695 | Merging changes 2026-01-16 03:17:25.774717 | Checking out repos 2026-01-16 03:17:25.824944 | Preparing playbooks 2026-01-16 03:17:26.752919 | Running Ansible setup 2026-01-16 03:17:32.238490 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-01-16 03:17:33.114181 | 2026-01-16 03:17:33.114309 | PLAY [Base pre] 2026-01-16 03:17:33.142010 | 2026-01-16 03:17:33.142116 | TASK [Setup log path fact] 2026-01-16 03:17:33.172117 | debian-bookworm | ok 2026-01-16 03:17:33.196368 | 2026-01-16 03:17:33.196492 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-16 03:17:33.240694 | debian-bookworm | ok 2026-01-16 03:17:33.259217 | 2026-01-16 03:17:33.259766 | TASK [emit-job-header : Print job information] 2026-01-16 03:17:33.305505 | # Job Information 2026-01-16 03:17:33.305643 | Ansible Version: 2.16.14 2026-01-16 03:17:33.305673 | Job: tox 2026-01-16 03:17:33.305699 | Pipeline: periodic-daily 2026-01-16 03:17:33.305718 | Executor: 521e9411259a 2026-01-16 03:17:33.305735 | Triggered by: https://github.com/osism/openstack-image-manager 2026-01-16 03:17:33.305754 | Event ID: cd5e1e8cde194f788687c774d817be71 2026-01-16 03:17:33.313568 | 2026-01-16 03:17:33.313664 | LOOP [emit-job-header : Print node information] 2026-01-16 03:17:33.443348 | debian-bookworm | ok: 2026-01-16 03:17:33.443563 | debian-bookworm | # Node Information 2026-01-16 03:17:33.443641 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-01-16 03:17:33.443667 | debian-bookworm | Hostname: debian 2026-01-16 03:17:33.443689 | debian-bookworm | Username: zuul 2026-01-16 03:17:33.443713 | debian-bookworm | Distro: Debian 12.13 2026-01-16 03:17:33.443734 | debian-bookworm | Provider: regiocloud-a 2026-01-16 03:17:33.443752 | debian-bookworm | Region: 2026-01-16 03:17:33.443778 | debian-bookworm | Label: debian-bookworm 2026-01-16 03:17:33.443796 | debian-bookworm | Product Name: OpenStack Nova 2026-01-16 03:17:33.443812 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe6c:d2b4 2026-01-16 03:17:33.468474 | 2026-01-16 03:17:33.468578 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-16 03:17:34.320566 | debian-bookworm -> localhost | changed 2026-01-16 03:17:34.326488 | 2026-01-16 03:17:34.326576 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-16 03:17:35.571108 | debian-bookworm -> localhost | changed 2026-01-16 03:17:35.594063 | 2026-01-16 03:17:35.594164 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-16 03:17:35.901383 | debian-bookworm -> localhost | ok 2026-01-16 03:17:35.906519 | 2026-01-16 03:17:35.906610 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-16 03:17:35.944624 | debian-bookworm | ok 2026-01-16 03:17:35.969312 | debian-bookworm | included: /var/lib/zuul/builds/3ba22d2abc86476094c210ef1215384f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-16 03:17:35.975755 | 2026-01-16 03:17:35.975853 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-16 03:17:37.158380 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-01-16 03:17:37.158574 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/3ba22d2abc86476094c210ef1215384f/work/3ba22d2abc86476094c210ef1215384f_id_rsa 2026-01-16 03:17:37.158609 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/3ba22d2abc86476094c210ef1215384f/work/3ba22d2abc86476094c210ef1215384f_id_rsa.pub 2026-01-16 03:17:37.158631 | debian-bookworm -> localhost | The key fingerprint is: 2026-01-16 03:17:37.158650 | debian-bookworm -> localhost | SHA256:q1ZvNYCntSQmbf/JPI3Czgdls+QfAhS1WR0yMSIm8JA zuul-build-sshkey 2026-01-16 03:17:37.158668 | debian-bookworm -> localhost | The key's randomart image is: 2026-01-16 03:17:37.158693 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-01-16 03:17:37.158711 | debian-bookworm -> localhost | | oo. o.+.=oo.| 2026-01-16 03:17:37.158728 | debian-bookworm -> localhost | | Eo o o .++ .| 2026-01-16 03:17:37.158745 | debian-bookworm -> localhost | | o o o | 2026-01-16 03:17:37.158761 | debian-bookworm -> localhost | | . * * = | 2026-01-16 03:17:37.158777 | debian-bookworm -> localhost | | +SB O o | 2026-01-16 03:17:37.158796 | debian-bookworm -> localhost | | o.+ * . | 2026-01-16 03:17:37.158812 | debian-bookworm -> localhost | | ..o * B . | 2026-01-16 03:17:37.158829 | debian-bookworm -> localhost | | .. .= O o | 2026-01-16 03:17:37.158884 | debian-bookworm -> localhost | | .. ooo . | 2026-01-16 03:17:37.158902 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-01-16 03:17:37.158945 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.603801 2026-01-16 03:17:37.163997 | 2026-01-16 03:17:37.164071 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-16 03:17:37.180362 | debian-bookworm | ok 2026-01-16 03:17:37.187602 | debian-bookworm | included: /var/lib/zuul/builds/3ba22d2abc86476094c210ef1215384f/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-16 03:17:37.194600 | 2026-01-16 03:17:37.194669 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-16 03:17:37.227447 | debian-bookworm | skipping: Conditional result was False 2026-01-16 03:17:37.232081 | 2026-01-16 03:17:37.232161 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-16 03:17:37.878091 | debian-bookworm | changed 2026-01-16 03:17:37.882650 | 2026-01-16 03:17:37.882728 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-16 03:17:38.141978 | debian-bookworm | ok 2026-01-16 03:17:38.151889 | 2026-01-16 03:17:38.152086 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-16 03:17:38.779399 | debian-bookworm | changed 2026-01-16 03:17:38.786002 | 2026-01-16 03:17:38.786099 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-16 03:17:39.494861 | debian-bookworm | changed 2026-01-16 03:17:39.505469 | 2026-01-16 03:17:39.505897 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-16 03:17:39.541976 | debian-bookworm | skipping: Conditional result was False 2026-01-16 03:17:39.556021 | 2026-01-16 03:17:39.556370 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-16 03:17:39.980348 | debian-bookworm -> localhost | changed 2026-01-16 03:17:39.992796 | 2026-01-16 03:17:39.992900 | TASK [add-build-sshkey : Add back temp key] 2026-01-16 03:17:40.419154 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/3ba22d2abc86476094c210ef1215384f/work/3ba22d2abc86476094c210ef1215384f_id_rsa (zuul-build-sshkey) 2026-01-16 03:17:40.419388 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.017957 2026-01-16 03:17:40.430473 | 2026-01-16 03:17:40.430568 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-16 03:17:40.840531 | debian-bookworm | ok 2026-01-16 03:17:40.846336 | 2026-01-16 03:17:40.846433 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-16 03:17:40.880744 | debian-bookworm | skipping: Conditional result was False 2026-01-16 03:17:40.892345 | 2026-01-16 03:17:40.892440 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-16 03:17:41.426131 | debian-bookworm | ok 2026-01-16 03:17:41.445433 | 2026-01-16 03:17:41.445537 | TASK [validate-host : Define zuul_info_dir fact] 2026-01-16 03:17:41.499402 | debian-bookworm | ok 2026-01-16 03:17:41.504437 | 2026-01-16 03:17:41.504525 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-01-16 03:17:41.860992 | debian-bookworm -> localhost | ok 2026-01-16 03:17:41.867514 | 2026-01-16 03:17:41.867600 | TASK [validate-host : Collect information about the host] 2026-01-16 03:17:42.968012 | debian-bookworm | ok 2026-01-16 03:17:42.997385 | 2026-01-16 03:17:42.997517 | TASK [validate-host : Sanitize hostname] 2026-01-16 03:17:43.123371 | debian-bookworm | ok 2026-01-16 03:17:43.169136 | 2026-01-16 03:17:43.169323 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-01-16 03:17:43.987481 | debian-bookworm -> localhost | changed 2026-01-16 03:17:43.994102 | 2026-01-16 03:17:43.994241 | TASK [validate-host : Collect information about zuul worker] 2026-01-16 03:17:44.441508 | debian-bookworm | ok 2026-01-16 03:17:44.448576 | 2026-01-16 03:17:44.448695 | TASK [validate-host : Write out all zuul information for each host] 2026-01-16 03:17:45.185621 | debian-bookworm -> localhost | changed 2026-01-16 03:17:45.200268 | 2026-01-16 03:17:45.200398 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-01-16 03:17:45.520767 | debian-bookworm | ok 2026-01-16 03:17:45.526465 | 2026-01-16 03:17:45.526583 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-01-16 03:17:46.568313 | debian-bookworm | changed: 2026-01-16 03:17:46.568564 | debian-bookworm | cd+++++++++ src/ 2026-01-16 03:17:46.568599 | debian-bookworm | cd+++++++++ src/github.com/ 2026-01-16 03:17:46.568623 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-01-16 03:17:46.568645 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-01-16 03:17:46.568665 | debian-bookworm | =6.2.4 2026-01-16 03:18:11.760694 | debian-bookworm | Downloading cachetools-6.2.4-py3-none-any.whl (11 kB) 2026-01-16 03:18:11.808140 | debian-bookworm | Collecting chardet>=5.2 2026-01-16 03:18:11.820365 | debian-bookworm | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2026-01-16 03:18:11.838632 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 12.9 MB/s eta 0:00:00 2026-01-16 03:18:11.878234 | debian-bookworm | Collecting colorama>=0.4.6 2026-01-16 03:18:11.890567 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-01-16 03:18:11.947941 | debian-bookworm | Collecting filelock>=3.20.2 2026-01-16 03:18:11.960031 | debian-bookworm | Downloading filelock-3.20.3-py3-none-any.whl (16 kB) 2026-01-16 03:18:12.014061 | debian-bookworm | Collecting packaging>=25 2026-01-16 03:18:12.025716 | debian-bookworm | Downloading packaging-25.0-py3-none-any.whl (66 kB) 2026-01-16 03:18:12.059322 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 66.5/66.5 kB 1.9 MB/s eta 0:00:00 2026-01-16 03:18:12.118180 | debian-bookworm | Collecting platformdirs>=4.5.1 2026-01-16 03:18:12.130092 | debian-bookworm | Downloading platformdirs-4.5.1-py3-none-any.whl (18 kB) 2026-01-16 03:18:12.176262 | debian-bookworm | Collecting pluggy>=1.6 2026-01-16 03:18:12.189079 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-01-16 03:18:12.249785 | debian-bookworm | Collecting pyproject-api>=1.10 2026-01-16 03:18:12.264353 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-01-16 03:18:12.417795 | debian-bookworm | Collecting virtualenv>=20.35.4 2026-01-16 03:18:12.431406 | debian-bookworm | Downloading virtualenv-20.36.1-py3-none-any.whl (6.0 MB) 2026-01-16 03:18:12.706126 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 6.0/6.0 MB 22.5 MB/s eta 0:00:00 2026-01-16 03:18:12.814469 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-01-16 03:18:12.827929 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-01-16 03:18:12.854854 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 21.5 MB/s eta 0:00:00 2026-01-16 03:18:13.098569 | debian-bookworm | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2026-01-16 03:18:14.220145 | debian-bookworm | Successfully installed cachetools-6.2.4 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.20.3 packaging-25.0 platformdirs-4.5.1 pluggy-1.6.0 pyproject-api-1.10.0 tox-4.34.1 virtualenv-20.36.1 2026-01-16 03:18:14.513690 | debian-bookworm | ok: Runtime: 0:00:03.579324 2026-01-16 03:18:14.519357 | 2026-01-16 03:18:14.519444 | TASK [ensure-tox : Export installed tox_executable path] 2026-01-16 03:18:14.559570 | debian-bookworm | ok 2026-01-16 03:18:14.564371 | 2026-01-16 03:18:14.564457 | TASK [ensure-tox : Output tox version] 2026-01-16 03:18:15.154785 | 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-16 03:18:15.173662 | debian-bookworm | 4.34.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-01-16 03:18:15.620505 | debian-bookworm | ok: Runtime: 0:00:00.321285 2026-01-16 03:18:15.625992 | 2026-01-16 03:18:15.626079 | TASK [ensure-tox : Make global symlink] 2026-01-16 03:18:15.638965 | debian-bookworm | skipping: Conditional result was False 2026-01-16 03:18:15.645114 | 2026-01-16 03:18:15.645222 | PLAY RECAP 2026-01-16 03:18:15.645271 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-01-16 03:18:15.645303 | 2026-01-16 03:18:15.861903 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-01-16 03:18:15.862897 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-01-16 03:18:16.830936 | 2026-01-16 03:18:16.831071 | PLAY [all] 2026-01-16 03:18:16.845637 | 2026-01-16 03:18:16.845759 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-01-16 03:18:17.325534 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-01-16 03:18:17.376901 | debian-bookworm | ok: Runtime: 0:00:00.029448 2026-01-16 03:18:17.382148 | 2026-01-16 03:18:17.385997 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-01-16 03:18:17.924148 | debian-bookworm | ok: Runtime: 0:00:00.007395 2026-01-16 03:18:17.930036 | 2026-01-16 03:18:17.930134 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-01-16 03:18:18.252832 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-01-16 03:18:18.258376 | debian-bookworm | sudo: a password is required 2026-01-16 03:18:18.483033 | debian-bookworm | ok: Runtime: 0:00:00.028162 2026-01-16 03:18:18.504293 | 2026-01-16 03:18:18.504428 | TASK [tox : Check to see if the constraints file exists] 2026-01-16 03:18:18.538989 | debian-bookworm | skipping: Conditional result was False 2026-01-16 03:18:18.545865 | 2026-01-16 03:18:18.546006 | TASK [tox : Fail if constraints file is missing] 2026-01-16 03:18:18.571457 | debian-bookworm | skipping: Conditional result was False 2026-01-16 03:18:18.588380 | 2026-01-16 03:18:18.588640 | TASK [tox : Record file location] 2026-01-16 03:18:18.626607 | debian-bookworm | skipping: Conditional result was False 2026-01-16 03:18:18.636769 | 2026-01-16 03:18:18.636926 | TASK [tox : Install tox siblings] 2026-01-16 03:18:18.663064 | debian-bookworm | ok 2026-01-16 03:18:18.671931 | debian-bookworm | included: /var/lib/zuul/builds/3ba22d2abc86476094c210ef1215384f/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-01-16 03:18:18.677396 | 2026-01-16 03:18:18.677491 | TASK [tox : Run tox without tests] 2026-01-16 03:18:19.879380 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-01-16 03:18:34.475481 | debian-bookworm | test: OK (15.23 seconds) 2026-01-16 03:18:34.475572 | debian-bookworm | congratulations :) (15.26 seconds) 2026-01-16 03:18:34.719007 | debian-bookworm | ok: Runtime: 0:00:15.552352 2026-01-16 03:18:34.724293 | 2026-01-16 03:18:34.724383 | TASK [tox : Create a tempfile to save tox showconfig] 2026-01-16 03:18:35.290279 | debian-bookworm | changed 2026-01-16 03:18:35.298327 | 2026-01-16 03:18:35.298429 | TASK [tox : Get tox envlist config] 2026-01-16 03:18:36.341517 | debian-bookworm | ok: Runtime: 0:00:00.307551 2026-01-16 03:18:36.346720 | 2026-01-16 03:18:36.346811 | TASK [tox : Install any sibling python packages] 2026-01-16 03:18:36.783270 | debian-bookworm | ok: No setup.cfg, no action needed 2026-01-16 03:18:36.795190 | 2026-01-16 03:18:36.795600 | TASK [tox : Remove tempfile] 2026-01-16 03:18:37.225330 | debian-bookworm | changed 2026-01-16 03:18:37.230745 | 2026-01-16 03:18:37.230859 | TASK [tox : Emit tox command] 2026-01-16 03:18:37.295776 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-01-16 03:18:37.303813 | 2026-01-16 03:18:37.303979 | TASK [tox : Run tox] 2026-01-16 03:18:37.970764 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-01-16 03:18:38.624593 | debian-bookworm | ............... 2026-01-16 03:18:38.624636 | debian-bookworm | ---------------------------------------------------------------------- 2026-01-16 03:18:38.624649 | debian-bookworm | Ran 15 tests in 0.175s 2026-01-16 03:18:38.624654 | debian-bookworm | 2026-01-16 03:18:38.624663 | debian-bookworm | OK 2026-01-16 03:18:38.700849 | debian-bookworm | test: OK (0.77=setup[0.04]+cmd[0.73] seconds) 2026-01-16 03:18:38.700904 | debian-bookworm | congratulations :) (0.80 seconds) 2026-01-16 03:18:38.860426 | debian-bookworm | ok: Runtime: 0:00:01.142376 2026-01-16 03:18:38.866020 | 2026-01-16 03:18:38.866109 | TASK [tox : Look for output] 2026-01-16 03:18:39.275052 | debian-bookworm | ok 2026-01-16 03:18:39.294309 | 2026-01-16 03:18:39.294418 | TASK [tox : Return file comments to Zuul] 2026-01-16 03:18:39.327805 | debian-bookworm | skipping: Conditional result was False 2026-01-16 03:18:39.333709 | 2026-01-16 03:18:39.333782 | PLAY RECAP 2026-01-16 03:18:39.333830 | debian-bookworm | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-01-16 03:18:39.333854 | 2026-01-16 03:18:39.430202 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-01-16 03:18:39.432867 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-01-16 03:18:40.093078 | 2026-01-16 03:18:40.093209 | PLAY [all] 2026-01-16 03:18:40.112458 | 2026-01-16 03:18:40.112568 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-01-16 03:18:40.196235 | debian-bookworm | skipping: Conditional result was False 2026-01-16 03:18:40.200855 | 2026-01-16 03:18:40.200950 | TASK [fetch-tox-output : Set tox log path for single node] 2026-01-16 03:18:40.237250 | debian-bookworm | ok 2026-01-16 03:18:40.241437 | 2026-01-16 03:18:40.241514 | TASK [fetch-tox-output : Ensure local tox dir] 2026-01-16 03:18:40.946818 | debian-bookworm -> localhost | changed 2026-01-16 03:18:40.954229 | 2026-01-16 03:18:40.954356 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-01-16 03:18:40.998037 | debian-bookworm | skipping: Conditional result was False 2026-01-16 03:18:41.003395 | 2026-01-16 03:18:41.003492 | TASK [fetch-tox-output : Set envlist fact] 2026-01-16 03:18:41.030781 | debian-bookworm | ok 2026-01-16 03:18:41.036343 | 2026-01-16 03:18:41.036428 | TASK [fetch-tox-output : Get tox version] 2026-01-16 03:18:41.671524 | 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-16 03:18:41.688566 | debian-bookworm | 4.34.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-01-16 03:18:42.087251 | debian-bookworm | ok: Runtime: 0:00:00.259001 2026-01-16 03:18:42.092450 | 2026-01-16 03:18:42.092540 | TASK [fetch-tox-output : Find all default environments] 2026-01-16 03:18:42.632927 | debian-bookworm | skipping: Conditional result was False 2026-01-16 03:18:42.645043 | 2026-01-16 03:18:42.645221 | TASK [fetch-tox-output : Set envlist fact] 2026-01-16 03:18:42.679472 | debian-bookworm | skipping: Conditional result was False 2026-01-16 03:18:42.686575 | 2026-01-16 03:18:42.686681 | TASK [fetch-tox-output : Find all default environments] 2026-01-16 03:18:43.212003 | debian-bookworm | skipping: Conditional result was False 2026-01-16 03:18:43.217519 | 2026-01-16 03:18:43.217610 | TASK [fetch-tox-output : Set envlist fact] 2026-01-16 03:18:43.260741 | debian-bookworm | skipping: Conditional result was False 2026-01-16 03:18:43.266674 | 2026-01-16 03:18:43.266762 | LOOP [fetch-tox-output : Copy tox logs] 2026-01-16 03:18:43.327332 | debian-bookworm | skipping: Conditional result was False 2026-01-16 03:18:43.335990 | 2026-01-16 03:18:43.336097 | LOOP [fetch-tox-output : Collect tox logs] 2026-01-16 03:18:44.235092 | debian-bookworm | changed: 2026-01-16 03:18:44.235263 | debian-bookworm | created directory /var/lib/zuul/builds/3ba22d2abc86476094c210ef1215384f/work/logs/tox/test 2026-01-16 03:18:44.235297 | debian-bookworm | cd+++++++++ ./ 2026-01-16 03:18:44.235322 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-01-16 03:18:44.235352 | 2026-01-16 03:18:44.251049 | 2026-01-16 03:18:44.251131 | PLAY RECAP 2026-01-16 03:18:44.251194 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-01-16 03:18:44.251218 | 2026-01-16 03:18:44.376836 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-01-16 03:18:44.377795 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-01-16 03:18:45.338717 | 2026-01-16 03:18:45.338858 | PLAY [all] 2026-01-16 03:18:45.361557 | 2026-01-16 03:18:45.361670 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-01-16 03:18:45.562241 | debian-bookworm | changed: non-zero return code 2026-01-16 03:18:45.577056 | 2026-01-16 03:18:45.577224 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-01-16 03:18:45.601872 | debian-bookworm | skipping: Conditional result was False 2026-01-16 03:18:45.607625 | 2026-01-16 03:18:45.607726 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-01-16 03:18:45.626338 | 2026-01-16 03:18:45.626486 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-01-16 03:18:45.646185 | 2026-01-16 03:18:45.646336 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-01-16 03:18:45.679945 | debian-bookworm | skipping: Conditional result was False 2026-01-16 03:18:45.685535 | 2026-01-16 03:18:45.685630 | LOOP [fetch-subunit-output : Generate subunit file] 2026-01-16 03:18:45.723949 | 2026-01-16 03:18:45.724116 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-01-16 03:18:45.767288 | debian-bookworm | skipping: Conditional result was False 2026-01-16 03:18:45.772756 | 2026-01-16 03:18:45.772849 | TASK [fetch-subunit-output : Remove the temporary file] 2026-01-16 03:18:45.806005 | debian-bookworm | skipping: Conditional result was False 2026-01-16 03:18:45.811446 | 2026-01-16 03:18:45.811536 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-01-16 03:18:45.844652 | debian-bookworm | skipping: Conditional result was False 2026-01-16 03:18:45.851511 | 2026-01-16 03:18:45.851582 | PLAY RECAP 2026-01-16 03:18:45.851627 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-01-16 03:18:45.851653 | 2026-01-16 03:18:45.943568 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-01-16 03:18:45.944514 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-01-16 03:18:46.624097 | 2026-01-16 03:18:46.624248 | PLAY [Base post] 2026-01-16 03:18:46.636243 | 2026-01-16 03:18:46.636356 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-01-16 03:18:47.159209 | debian-bookworm | changed 2026-01-16 03:18:47.168564 | 2026-01-16 03:18:47.168659 | PLAY RECAP 2026-01-16 03:18:47.168710 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-01-16 03:18:47.168762 | 2026-01-16 03:18:47.255899 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-01-16 03:18:47.256886 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-01-16 03:18:48.059515 | 2026-01-16 03:18:48.059656 | PLAY [Base post-logs] 2026-01-16 03:18:48.069265 | 2026-01-16 03:18:48.069387 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-01-16 03:18:48.579900 | localhost | changed 2026-01-16 03:18:48.588939 | 2026-01-16 03:18:48.589057 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-01-16 03:18:48.638404 | localhost | ok 2026-01-16 03:18:48.641231 | 2026-01-16 03:18:48.641316 | TASK [Set zuul-log-path fact] 2026-01-16 03:18:48.655944 | localhost | ok 2026-01-16 03:18:48.663510 | 2026-01-16 03:18:48.663598 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-16 03:18:48.687755 | localhost | ok 2026-01-16 03:18:48.690554 | 2026-01-16 03:18:48.690642 | TASK [upload-logs : Create log directories] 2026-01-16 03:18:49.171457 | localhost | changed 2026-01-16 03:18:49.173524 | 2026-01-16 03:18:49.173593 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-01-16 03:18:49.545785 | localhost -> localhost | ok: Runtime: 0:00:00.009814 2026-01-16 03:18:49.551811 | 2026-01-16 03:18:49.551950 | TASK [upload-logs : Upload logs to log server] 2026-01-16 03:18:50.045169 | localhost | Output suppressed because no_log was given 2026-01-16 03:18:50.048475 | 2026-01-16 03:18:50.048923 | LOOP [upload-logs : Compress console log and json output] 2026-01-16 03:18:50.094436 | localhost | skipping: Conditional result was False 2026-01-16 03:18:50.100156 | localhost | skipping: Conditional result was False 2026-01-16 03:18:50.104824 | 2026-01-16 03:18:50.104915 | LOOP [upload-logs : Upload compressed console log and json output] 2026-01-16 03:18:50.138889 | localhost | skipping: Conditional result was False 2026-01-16 03:18:50.139096 | 2026-01-16 03:18:50.145324 | localhost | skipping: Conditional result was False 2026-01-16 03:18:50.149858 | 2026-01-16 03:18:50.149949 | LOOP [upload-logs : Upload console log and json output]