2026-06-26 14:10:35.650626 | Job console starting 2026-06-26 14:10:35.666243 | Updating git repos 2026-06-26 14:10:35.729907 | Cloning repos into workspace 2026-06-26 14:10:35.797059 | Restoring repo states 2026-06-26 14:10:35.832507 | Merging changes 2026-06-26 14:10:36.405525 | Checking out repos 2026-06-26 14:10:36.463229 | Preparing playbooks 2026-06-26 14:10:37.358031 | Running Ansible setup 2026-06-26 14:10:42.141394 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-26 14:10:43.002417 | 2026-06-26 14:10:43.002638 | PLAY [Base pre] 2026-06-26 14:10:43.022882 | 2026-06-26 14:10:43.023063 | TASK [Setup log path fact] 2026-06-26 14:10:43.054112 | debian-bookworm | ok 2026-06-26 14:10:43.072838 | 2026-06-26 14:10:43.073056 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-26 14:10:43.113638 | debian-bookworm | ok 2026-06-26 14:10:43.135687 | 2026-06-26 14:10:43.135856 | TASK [emit-job-header : Print job information] 2026-06-26 14:10:43.229699 | # Job Information 2026-06-26 14:10:43.229996 | Ansible Version: 2.16.14 2026-06-26 14:10:43.230036 | Job: tox 2026-06-26 14:10:43.230078 | Pipeline: check 2026-06-26 14:10:43.230107 | Executor: 521e9411259a 2026-06-26 14:10:43.230127 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1241 2026-06-26 14:10:43.230149 | Event ID: f2a7f2f0-7163-11f1-813e-cc6099b19760 2026-06-26 14:10:43.236241 | 2026-06-26 14:10:43.236394 | LOOP [emit-job-header : Print node information] 2026-06-26 14:10:43.366104 | debian-bookworm | ok: 2026-06-26 14:10:43.366428 | debian-bookworm | # Node Information 2026-06-26 14:10:43.366463 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-26 14:10:43.366489 | debian-bookworm | Hostname: debian 2026-06-26 14:10:43.366511 | debian-bookworm | Username: zuul 2026-06-26 14:10:43.366532 | debian-bookworm | Distro: Debian 12.14 2026-06-26 14:10:43.366555 | debian-bookworm | Provider: regiocloud-a 2026-06-26 14:10:43.366576 | debian-bookworm | Region: 2026-06-26 14:10:43.366597 | debian-bookworm | Label: debian-bookworm 2026-06-26 14:10:43.366617 | debian-bookworm | Product Name: OpenStack Nova 2026-06-26 14:10:43.366636 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe10:cac 2026-06-26 14:10:43.380667 | 2026-06-26 14:10:43.380842 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-26 14:10:43.932869 | debian-bookworm -> localhost | changed 2026-06-26 14:10:43.950139 | 2026-06-26 14:10:43.950329 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-26 14:10:45.416432 | debian-bookworm -> localhost | changed 2026-06-26 14:10:45.428051 | 2026-06-26 14:10:45.428192 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-26 14:10:45.769091 | debian-bookworm -> localhost | ok 2026-06-26 14:10:45.776555 | 2026-06-26 14:10:45.776821 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-26 14:10:45.815459 | debian-bookworm | ok 2026-06-26 14:10:45.834050 | debian-bookworm | included: /var/lib/zuul/builds/12c877a03a2d4c8d842a63c60cf87dc1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-26 14:10:45.840954 | 2026-06-26 14:10:45.841100 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-26 14:10:47.295682 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-26 14:10:47.295969 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/12c877a03a2d4c8d842a63c60cf87dc1/work/12c877a03a2d4c8d842a63c60cf87dc1_id_rsa 2026-06-26 14:10:47.296008 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/12c877a03a2d4c8d842a63c60cf87dc1/work/12c877a03a2d4c8d842a63c60cf87dc1_id_rsa.pub 2026-06-26 14:10:47.296035 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-26 14:10:47.296061 | debian-bookworm -> localhost | SHA256:j0/YSP9C8Ta4rn2dCL9ID4BBBiyfmDOJ8XPQB8VEMR0 zuul-build-sshkey 2026-06-26 14:10:47.296085 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-26 14:10:47.296126 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-26 14:10:47.296148 | debian-bookworm -> localhost | | ooBOoE. | 2026-06-26 14:10:47.296170 | debian-bookworm -> localhost | |. o ooo.. | 2026-06-26 14:10:47.296190 | debian-bookworm -> localhost | | + B o. | 2026-06-26 14:10:47.296209 | debian-bookworm -> localhost | |. O + o . | 2026-06-26 14:10:47.296248 | debian-bookworm -> localhost | | = . S + | 2026-06-26 14:10:47.296275 | debian-bookworm -> localhost | | . O+ + | 2026-06-26 14:10:47.296295 | debian-bookworm -> localhost | | +.B= + . | 2026-06-26 14:10:47.296314 | debian-bookworm -> localhost | | =o=+ o | 2026-06-26 14:10:47.296335 | debian-bookworm -> localhost | | .o=o+. | 2026-06-26 14:10:47.296355 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-26 14:10:47.296409 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.862814 2026-06-26 14:10:47.303574 | 2026-06-26 14:10:47.303716 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-26 14:10:47.337482 | debian-bookworm | ok 2026-06-26 14:10:47.353648 | debian-bookworm | included: /var/lib/zuul/builds/12c877a03a2d4c8d842a63c60cf87dc1/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-26 14:10:47.362854 | 2026-06-26 14:10:47.362986 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-26 14:10:47.397827 | debian-bookworm | skipping: Conditional result was False 2026-06-26 14:10:47.406456 | 2026-06-26 14:10:47.406613 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-26 14:10:48.078506 | debian-bookworm | changed 2026-06-26 14:10:48.087614 | 2026-06-26 14:10:48.087776 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-26 14:10:48.377987 | debian-bookworm | ok 2026-06-26 14:10:48.386791 | 2026-06-26 14:10:48.387022 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-26 14:10:49.091450 | debian-bookworm | changed 2026-06-26 14:10:49.097294 | 2026-06-26 14:10:49.097423 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-26 14:10:49.770921 | debian-bookworm | changed 2026-06-26 14:10:49.777720 | 2026-06-26 14:10:49.777911 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-26 14:10:49.804132 | debian-bookworm | skipping: Conditional result was False 2026-06-26 14:10:49.812028 | 2026-06-26 14:10:49.812177 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-26 14:10:50.585800 | debian-bookworm -> localhost | changed 2026-06-26 14:10:50.616052 | 2026-06-26 14:10:50.616199 | TASK [add-build-sshkey : Add back temp key] 2026-06-26 14:10:51.408844 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/12c877a03a2d4c8d842a63c60cf87dc1/work/12c877a03a2d4c8d842a63c60cf87dc1_id_rsa (zuul-build-sshkey) 2026-06-26 14:10:51.409102 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.057270 2026-06-26 14:10:51.428303 | 2026-06-26 14:10:51.428451 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-26 14:10:52.564839 | debian-bookworm | ok 2026-06-26 14:10:52.580280 | 2026-06-26 14:10:52.580449 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-26 14:10:52.627362 | debian-bookworm | skipping: Conditional result was False 2026-06-26 14:10:52.646557 | 2026-06-26 14:10:52.646723 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-26 14:10:53.305924 | debian-bookworm | ok 2026-06-26 14:10:53.383048 | 2026-06-26 14:10:53.383882 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-26 14:10:53.450539 | debian-bookworm | ok 2026-06-26 14:10:53.459157 | 2026-06-26 14:10:53.459317 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-26 14:10:54.572608 | debian-bookworm -> localhost | ok 2026-06-26 14:10:54.587687 | 2026-06-26 14:10:54.588369 | TASK [validate-host : Collect information about the host] 2026-06-26 14:10:56.539985 | debian-bookworm | ok 2026-06-26 14:10:56.558313 | 2026-06-26 14:10:56.558439 | TASK [validate-host : Sanitize hostname] 2026-06-26 14:10:56.689825 | debian-bookworm | ok 2026-06-26 14:10:56.694191 | 2026-06-26 14:10:56.694298 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-26 14:10:57.328507 | debian-bookworm -> localhost | changed 2026-06-26 14:10:57.338202 | 2026-06-26 14:10:57.338327 | TASK [validate-host : Collect information about zuul worker] 2026-06-26 14:10:57.826050 | debian-bookworm | ok 2026-06-26 14:10:57.841042 | 2026-06-26 14:10:57.841166 | TASK [validate-host : Write out all zuul information for each host] 2026-06-26 14:10:59.844655 | debian-bookworm -> localhost | changed 2026-06-26 14:10:59.872186 | 2026-06-26 14:10:59.872426 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-26 14:11:00.175782 | debian-bookworm | ok 2026-06-26 14:11:00.182180 | 2026-06-26 14:11:00.182333 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-26 14:11:01.508675 | debian-bookworm | changed: 2026-06-26 14:11:01.508860 | debian-bookworm | cd+++++++++ src/ 2026-06-26 14:11:01.508894 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-26 14:11:01.508919 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-26 14:11:01.508941 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-06-26 14:11:01.508961 | debian-bookworm | =7.0.3 2026-06-26 14:11:42.392512 | debian-bookworm | Downloading cachetools-7.1.4-py3-none-any.whl (16 kB) 2026-06-26 14:11:42.442268 | debian-bookworm | Collecting colorama>=0.4.6 2026-06-26 14:11:42.458822 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-06-26 14:11:42.550016 | debian-bookworm | Collecting filelock>=3.25 2026-06-26 14:11:42.568485 | debian-bookworm | Downloading filelock-3.29.4-py3-none-any.whl (42 kB) 2026-06-26 14:11:42.580478 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 42.8/42.8 kB 4.8 MB/s eta 0:00:00 2026-06-26 14:11:42.638920 | debian-bookworm | Collecting packaging>=26 2026-06-26 14:11:42.654092 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-06-26 14:11:42.663532 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 15.3 MB/s eta 0:00:00 2026-06-26 14:11:42.718590 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-06-26 14:11:42.735107 | debian-bookworm | Downloading platformdirs-4.10.0-py3-none-any.whl (22 kB) 2026-06-26 14:11:42.803105 | debian-bookworm | Collecting pluggy>=1.6 2026-06-26 14:11:42.818535 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-06-26 14:11:42.875463 | debian-bookworm | Collecting pyproject-api>=1.10 2026-06-26 14:11:42.891346 | debian-bookworm | Downloading pyproject_api-1.10.1-py3-none-any.whl (12 kB) 2026-06-26 14:11:42.947161 | debian-bookworm | Collecting python-discovery>=1.2.2 2026-06-26 14:11:42.963543 | debian-bookworm | Downloading python_discovery-1.4.2-py3-none-any.whl (33 kB) 2026-06-26 14:11:43.018834 | debian-bookworm | Collecting tomli-w>=1.2 2026-06-26 14:11:43.035294 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-06-26 14:11:43.194578 | debian-bookworm | Collecting virtualenv>=21.1 2026-06-26 14:11:43.209002 | debian-bookworm | Downloading virtualenv-21.5.1-py3-none-any.whl (4.6 MB) 2026-06-26 14:11:43.623850 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.6/4.6 MB 11.1 MB/s eta 0:00:00 2026-06-26 14:11:43.726009 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-06-26 14:11:43.737187 | debian-bookworm | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-06-26 14:11:43.750627 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.6/470.6 kB 46.2 MB/s eta 0:00:00 2026-06-26 14:11:43.855144 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-06-26 14:11:44.715863 | debian-bookworm | Successfully installed cachetools-7.1.4 colorama-0.4.6 distlib-0.4.3 filelock-3.29.4 packaging-26.2 platformdirs-4.10.0 pluggy-1.6.0 pyproject-api-1.10.1 python-discovery-1.4.2 tomli-w-1.2.0 tox-4.56.1 virtualenv-21.5.1 2026-06-26 14:11:45.128715 | debian-bookworm | ok: Runtime: 0:00:03.451881 2026-06-26 14:11:45.138495 | 2026-06-26 14:11:45.138671 | TASK [ensure-tox : Export installed tox_executable path] 2026-06-26 14:11:45.191112 | debian-bookworm | ok 2026-06-26 14:11:45.198949 | 2026-06-26 14:11:45.199157 | TASK [ensure-tox : Output tox version] 2026-06-26 14:11:45.805599 | 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-06-26 14:11:45.823695 | debian-bookworm | 4.56.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-06-26 14:11:46.255412 | debian-bookworm | ok: Runtime: 0:00:00.345587 2026-06-26 14:11:46.261672 | 2026-06-26 14:11:46.261793 | TASK [ensure-tox : Make global symlink] 2026-06-26 14:11:46.289197 | debian-bookworm | skipping: Conditional result was False 2026-06-26 14:11:46.312334 | 2026-06-26 14:11:46.312553 | PLAY RECAP 2026-06-26 14:11:46.312690 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-06-26 14:11:46.312753 | 2026-06-26 14:11:46.500229 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-06-26 14:11:46.502187 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-06-26 14:11:47.361507 | 2026-06-26 14:11:47.361713 | PLAY [all] 2026-06-26 14:11:47.378502 | 2026-06-26 14:11:47.378660 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-06-26 14:11:47.878445 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-06-26 14:11:47.935697 | debian-bookworm | ok: Runtime: 0:00:00.033070 2026-06-26 14:11:47.945617 | 2026-06-26 14:11:47.945826 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-06-26 14:11:48.479669 | debian-bookworm | ok: Runtime: 0:00:00.008337 2026-06-26 14:11:48.487667 | 2026-06-26 14:11:48.487821 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-06-26 14:11:48.823604 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-06-26 14:11:48.825349 | debian-bookworm | sudo: a password is required 2026-06-26 14:11:49.033390 | debian-bookworm | ok: Runtime: 0:00:00.027267 2026-06-26 14:11:49.044379 | 2026-06-26 14:11:49.044520 | TASK [tox : Check to see if the constraints file exists] 2026-06-26 14:11:49.102016 | debian-bookworm | skipping: Conditional result was False 2026-06-26 14:11:49.109122 | 2026-06-26 14:11:49.109306 | TASK [tox : Fail if constraints file is missing] 2026-06-26 14:11:49.162529 | debian-bookworm | skipping: Conditional result was False 2026-06-26 14:11:49.169963 | 2026-06-26 14:11:49.170125 | TASK [tox : Record file location] 2026-06-26 14:11:49.233825 | debian-bookworm | skipping: Conditional result was False 2026-06-26 14:11:49.240660 | 2026-06-26 14:11:49.240820 | TASK [tox : Install tox siblings] 2026-06-26 14:11:49.283610 | debian-bookworm | ok 2026-06-26 14:11:49.303390 | debian-bookworm | included: /var/lib/zuul/builds/12c877a03a2d4c8d842a63c60cf87dc1/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-06-26 14:11:49.309336 | 2026-06-26 14:11:49.309459 | TASK [tox : Run tox without tests] 2026-06-26 14:11:50.612912 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-06-26 14:12:03.821130 | debian-bookworm | test: OK (13.91 seconds) 2026-06-26 14:12:03.821233 | debian-bookworm | congratulations :) (13.94 seconds) 2026-06-26 14:12:04.352953 | debian-bookworm | ok: Runtime: 0:00:14.278267 2026-06-26 14:12:04.370070 | 2026-06-26 14:12:04.370284 | TASK [tox : Create a tempfile to save tox showconfig] 2026-06-26 14:12:04.924963 | debian-bookworm | changed 2026-06-26 14:12:04.934758 | 2026-06-26 14:12:04.934915 | TASK [tox : Detect tox version] 2026-06-26 14:12:05.527243 | debian-bookworm | 4.56.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-06-26 14:12:05.972179 | debian-bookworm | ok: Runtime: 0:00:00.346718 2026-06-26 14:12:05.979316 | 2026-06-26 14:12:05.979847 | TASK [tox : Get tox envlist config] 2026-06-26 14:12:07.063428 | debian-bookworm | ok: Runtime: 0:00:00.420001 2026-06-26 14:12:07.070685 | 2026-06-26 14:12:07.070896 | TASK [tox : Install any sibling python packages] 2026-06-26 14:12:07.558602 | debian-bookworm | ok: No setup.cfg, no action needed 2026-06-26 14:12:07.571652 | 2026-06-26 14:12:07.571926 | TASK [tox : Remove tempfile] 2026-06-26 14:12:08.262596 | debian-bookworm | changed 2026-06-26 14:12:08.268625 | 2026-06-26 14:12:08.268738 | TASK [tox : Emit tox command] 2026-06-26 14:12:08.319190 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-06-26 14:12:08.324492 | 2026-06-26 14:12:08.324639 | TASK [tox : Run tox] 2026-06-26 14:12:09.075741 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-06-26 14:12:09.940934 | debian-bookworm | .......................... 2026-06-26 14:12:09.941599 | debian-bookworm | ---------------------------------------------------------------------- 2026-06-26 14:12:09.941632 | debian-bookworm | Ran 26 tests in 0.237s 2026-06-26 14:12:09.941654 | debian-bookworm | 2026-06-26 14:12:09.941662 | debian-bookworm | OK 2026-06-26 14:12:10.075685 | debian-bookworm | test: OK (1.07=setup[0.08]+cmd[1.00] seconds) 2026-06-26 14:12:10.075769 | debian-bookworm | congratulations :) (1.11 seconds) 2026-06-26 14:12:10.358527 | debian-bookworm | ok: Runtime: 0:00:01.467588 2026-06-26 14:12:10.372445 | 2026-06-26 14:12:10.372617 | TASK [tox : Look for output] 2026-06-26 14:12:10.848399 | debian-bookworm | ok 2026-06-26 14:12:10.868022 | 2026-06-26 14:12:10.868166 | TASK [tox : Return file comments to Zuul] 2026-06-26 14:12:10.924727 | debian-bookworm | skipping: Conditional result was False 2026-06-26 14:12:10.940354 | 2026-06-26 14:12:10.940485 | PLAY RECAP 2026-06-26 14:12:10.940566 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-06-26 14:12:10.940604 | 2026-06-26 14:12:11.162806 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-06-26 14:12:11.164610 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-06-26 14:12:11.985103 | 2026-06-26 14:12:11.985313 | PLAY [all] 2026-06-26 14:12:12.002967 | 2026-06-26 14:12:12.003149 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-06-26 14:12:12.060348 | debian-bookworm | skipping: Conditional result was False 2026-06-26 14:12:12.072668 | 2026-06-26 14:12:12.072904 | TASK [fetch-tox-output : Set tox log path for single node] 2026-06-26 14:12:12.139739 | debian-bookworm | ok 2026-06-26 14:12:12.147991 | 2026-06-26 14:12:12.148148 | TASK [fetch-tox-output : Ensure local tox dir] 2026-06-26 14:12:12.681694 | debian-bookworm -> localhost | changed 2026-06-26 14:12:12.694881 | 2026-06-26 14:12:12.695045 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-06-26 14:12:12.741649 | debian-bookworm | skipping: Conditional result was False 2026-06-26 14:12:12.754503 | 2026-06-26 14:12:12.754703 | TASK [fetch-tox-output : Set envlist fact] 2026-06-26 14:12:12.800720 | debian-bookworm | ok 2026-06-26 14:12:12.809790 | 2026-06-26 14:12:12.810042 | TASK [fetch-tox-output : Get tox version] 2026-06-26 14:12:13.585859 | 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-06-26 14:12:13.604492 | debian-bookworm | 4.56.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-06-26 14:12:13.845237 | debian-bookworm | ok: Runtime: 0:00:00.382462 2026-06-26 14:12:13.853043 | 2026-06-26 14:12:13.853207 | TASK [fetch-tox-output : Find all default environments] 2026-06-26 14:12:14.385128 | debian-bookworm | skipping: Conditional result was False 2026-06-26 14:12:14.401325 | 2026-06-26 14:12:14.401552 | TASK [fetch-tox-output : Set envlist fact] 2026-06-26 14:12:14.443670 | debian-bookworm | skipping: Conditional result was False 2026-06-26 14:12:14.451814 | 2026-06-26 14:12:14.451982 | TASK [fetch-tox-output : Find all default environments] 2026-06-26 14:12:15.008493 | debian-bookworm | skipping: Conditional result was False 2026-06-26 14:12:15.015395 | 2026-06-26 14:12:15.015538 | TASK [fetch-tox-output : Set envlist fact] 2026-06-26 14:12:15.050583 | debian-bookworm | skipping: Conditional result was False 2026-06-26 14:12:15.057836 | 2026-06-26 14:12:15.057967 | LOOP [fetch-tox-output : Copy tox logs] 2026-06-26 14:12:15.119002 | debian-bookworm | skipping: Conditional result was False 2026-06-26 14:12:15.130991 | 2026-06-26 14:12:15.131169 | LOOP [fetch-tox-output : Collect tox logs] 2026-06-26 14:12:16.098348 | debian-bookworm | changed: 2026-06-26 14:12:16.098714 | debian-bookworm | created directory /var/lib/zuul/builds/12c877a03a2d4c8d842a63c60cf87dc1/work/logs/tox/test 2026-06-26 14:12:16.098773 | debian-bookworm | cd+++++++++ ./ 2026-06-26 14:12:16.098814 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-06-26 14:12:16.098993 | 2026-06-26 14:12:16.113600 | 2026-06-26 14:12:16.113767 | PLAY RECAP 2026-06-26 14:12:16.113837 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-06-26 14:12:16.113864 | 2026-06-26 14:12:16.304714 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-06-26 14:12:16.305918 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-06-26 14:12:17.107096 | 2026-06-26 14:12:17.107484 | PLAY [all] 2026-06-26 14:12:17.127154 | 2026-06-26 14:12:17.127356 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-06-26 14:12:17.395013 | debian-bookworm | changed: non-zero return code 2026-06-26 14:12:17.407587 | 2026-06-26 14:12:17.407779 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-06-26 14:12:17.454324 | debian-bookworm | skipping: Conditional result was False 2026-06-26 14:12:17.463911 | 2026-06-26 14:12:17.464085 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-06-26 14:12:17.516791 | 2026-06-26 14:12:17.517184 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-06-26 14:12:17.569979 | 2026-06-26 14:12:17.570305 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-06-26 14:12:17.596753 | debian-bookworm | skipping: Conditional result was False 2026-06-26 14:12:17.610192 | 2026-06-26 14:12:17.610438 | LOOP [fetch-subunit-output : Generate subunit file] 2026-06-26 14:12:17.654411 | 2026-06-26 14:12:17.654661 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-06-26 14:12:17.689393 | debian-bookworm | skipping: Conditional result was False 2026-06-26 14:12:17.700412 | 2026-06-26 14:12:17.700614 | TASK [fetch-subunit-output : Remove the temporary file] 2026-06-26 14:12:17.726411 | debian-bookworm | skipping: Conditional result was False 2026-06-26 14:12:17.735829 | 2026-06-26 14:12:17.735962 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-06-26 14:12:17.761971 | debian-bookworm | skipping: Conditional result was False 2026-06-26 14:12:17.771281 | 2026-06-26 14:12:17.771406 | PLAY RECAP 2026-06-26 14:12:17.771469 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-06-26 14:12:17.771494 | 2026-06-26 14:12:17.935406 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-06-26 14:12:17.936582 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-26 14:12:18.757441 | 2026-06-26 14:12:18.757654 | PLAY [Base post-fetch] 2026-06-26 14:12:18.774745 | 2026-06-26 14:12:18.775018 | TASK [diagnose-network : Ensure log directory exists] 2026-06-26 14:12:19.185697 | debian-bookworm | ok 2026-06-26 14:12:19.196729 | 2026-06-26 14:12:19.196934 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-06-26 14:12:31.061492 | debian-bookworm | ok: Runtime: 0:00:05.922139 2026-06-26 14:12:31.073223 | 2026-06-26 14:12:31.073463 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-06-26 14:12:37.150506 | debian-bookworm | ok: Runtime: 0:00:00.008802 2026-06-26 14:12:37.172497 | 2026-06-26 14:12:37.172669 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-06-26 14:12:43.254280 | debian-bookworm | ok: Runtime: 0:00:00.009036 2026-06-26 14:12:43.267764 | 2026-06-26 14:12:43.267933 | TASK [fetch-output : Set log path for multiple nodes] 2026-06-26 14:12:43.339886 | debian-bookworm | skipping: Conditional result was False 2026-06-26 14:12:43.347526 | 2026-06-26 14:12:43.347673 | TASK [fetch-output : Set log path for single node] 2026-06-26 14:12:43.404814 | debian-bookworm | ok 2026-06-26 14:12:43.410505 | 2026-06-26 14:12:43.410644 | LOOP [fetch-output : Ensure local output dirs] 2026-06-26 14:12:43.796180 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/12c877a03a2d4c8d842a63c60cf87dc1/work/logs" 2026-06-26 14:12:44.127700 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/12c877a03a2d4c8d842a63c60cf87dc1/work/artifacts" 2026-06-26 14:12:44.506298 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/12c877a03a2d4c8d842a63c60cf87dc1/work/docs" 2026-06-26 14:12:44.517466 | 2026-06-26 14:12:44.517641 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-26 14:12:45.350910 | debian-bookworm | changed: 2026-06-26 14:12:45.351294 | debian-bookworm | .d..t...... ./ 2026-06-26 14:12:45.351358 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-06-26 14:12:45.351386 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-06-26 14:12:45.351409 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-26 14:12:45.351431 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-26 14:12:45.351452 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-26 14:12:45.351507 | debian-bookworm | changed: All items complete 2026-06-26 14:12:45.351538 | 2026-06-26 14:12:45.988862 | debian-bookworm | changed: .d..t...... ./ 2026-06-26 14:12:46.643818 | debian-bookworm | changed: .d..t...... ./ 2026-06-26 14:12:46.663663 | 2026-06-26 14:12:46.663825 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-26 14:12:47.114222 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.010558 2026-06-26 14:12:47.479768 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.009726 2026-06-26 14:12:47.492759 | 2026-06-26 14:12:47.492986 | PLAY RECAP 2026-06-26 14:12:47.493255 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-26 14:12:47.493311 | 2026-06-26 14:12:47.941172 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-26 14:12:47.943393 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-26 14:12:48.833061 | 2026-06-26 14:12:48.833312 | PLAY [Base post] 2026-06-26 14:12:48.849385 | 2026-06-26 14:12:48.849607 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-26 14:12:49.505956 | debian-bookworm | changed 2026-06-26 14:12:49.513148 | 2026-06-26 14:12:49.513301 | PLAY RECAP 2026-06-26 14:12:49.513374 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-26 14:12:49.513438 | 2026-06-26 14:12:49.748905 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-26 14:12:49.750101 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-26 14:12:50.967735 | 2026-06-26 14:12:50.967960 | PLAY [Base post-logs] 2026-06-26 14:12:50.980645 | 2026-06-26 14:12:50.980831 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-26 14:12:51.653857 | localhost | changed 2026-06-26 14:12:51.672412 | 2026-06-26 14:12:51.672642 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-26 14:12:51.699792 | localhost | ok 2026-06-26 14:12:51.703966 | 2026-06-26 14:12:51.704109 | TASK [Set zuul-log-path fact] 2026-06-26 14:12:51.742991 | localhost | ok 2026-06-26 14:12:51.757067 | 2026-06-26 14:12:51.757223 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-26 14:12:51.796757 | localhost | ok 2026-06-26 14:12:51.802118 | 2026-06-26 14:12:51.802305 | TASK [upload-logs : Create log directories] 2026-06-26 14:12:52.389771 | localhost | changed 2026-06-26 14:12:52.393151 | 2026-06-26 14:12:52.393311 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-26 14:12:53.008733 | localhost -> localhost | ok: Runtime: 0:00:00.008092 2026-06-26 14:12:53.015360 | 2026-06-26 14:12:53.015566 | TASK [upload-logs : Upload logs to log server] 2026-06-26 14:12:53.714155 | localhost | Output suppressed because no_log was given 2026-06-26 14:12:53.716398 | 2026-06-26 14:12:53.716522 | LOOP [upload-logs : Compress console log and json output] 2026-06-26 14:12:53.780199 | localhost | skipping: Conditional result was False 2026-06-26 14:12:53.787040 | localhost | skipping: Conditional result was False 2026-06-26 14:12:53.794554 | 2026-06-26 14:12:53.794677 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-26 14:12:53.848190 | localhost | skipping: Conditional result was False 2026-06-26 14:12:53.848791 | 2026-06-26 14:12:53.854030 | localhost | skipping: Conditional result was False 2026-06-26 14:12:53.866101 | 2026-06-26 14:12:53.866311 | LOOP [upload-logs : Upload console log and json output]