2026-06-14 00:52:46.548512 | Job console starting 2026-06-14 00:52:46.620432 | Updating git repos 2026-06-14 00:52:46.665151 | Cloning repos into workspace 2026-06-14 00:52:46.731063 | Restoring repo states 2026-06-14 00:52:46.758188 | Merging changes 2026-06-14 00:52:47.843143 | Checking out repos 2026-06-14 00:52:47.963634 | Preparing playbooks 2026-06-14 00:52:49.495495 | Running Ansible setup 2026-06-14 00:52:54.508558 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-14 00:52:55.412073 | 2026-06-14 00:52:55.412231 | PLAY [Base pre] 2026-06-14 00:52:55.455129 | 2026-06-14 00:52:55.455576 | TASK [Setup log path fact] 2026-06-14 00:52:55.501320 | debian-bookworm | ok 2026-06-14 00:52:55.534536 | 2026-06-14 00:52:55.534715 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-14 00:52:55.583040 | debian-bookworm | ok 2026-06-14 00:52:55.601101 | 2026-06-14 00:52:55.601228 | TASK [emit-job-header : Print job information] 2026-06-14 00:52:55.663991 | # Job Information 2026-06-14 00:52:55.664230 | Ansible Version: 2.16.14 2026-06-14 00:52:55.664270 | Job: tox 2026-06-14 00:52:55.664308 | Pipeline: check 2026-06-14 00:52:55.664335 | Executor: 521e9411259a 2026-06-14 00:52:55.664357 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1213 2026-06-14 00:52:55.664378 | Event ID: ef1d7930-678a-11f1-95cf-92ab19b677a5 2026-06-14 00:52:55.669868 | 2026-06-14 00:52:55.670026 | LOOP [emit-job-header : Print node information] 2026-06-14 00:52:55.860218 | debian-bookworm | ok: 2026-06-14 00:52:55.860448 | debian-bookworm | # Node Information 2026-06-14 00:52:55.860485 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-14 00:52:55.860511 | debian-bookworm | Hostname: debian 2026-06-14 00:52:55.860534 | debian-bookworm | Username: zuul 2026-06-14 00:52:55.860555 | debian-bookworm | Distro: Debian 12.14 2026-06-14 00:52:55.860581 | debian-bookworm | Provider: regiocloud-a 2026-06-14 00:52:55.860603 | debian-bookworm | Region: 2026-06-14 00:52:55.860641 | debian-bookworm | Label: debian-bookworm 2026-06-14 00:52:55.860663 | debian-bookworm | Product Name: OpenStack Nova 2026-06-14 00:52:55.860684 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feeb:4810 2026-06-14 00:52:55.879944 | 2026-06-14 00:52:55.889689 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-14 00:52:56.808234 | debian-bookworm -> localhost | changed 2026-06-14 00:52:56.816874 | 2026-06-14 00:52:56.817003 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-14 00:52:58.984533 | debian-bookworm -> localhost | changed 2026-06-14 00:52:59.023038 | 2026-06-14 00:52:59.023224 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-14 00:52:59.601226 | debian-bookworm -> localhost | ok 2026-06-14 00:52:59.608755 | 2026-06-14 00:52:59.608877 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-14 00:52:59.639505 | debian-bookworm | ok 2026-06-14 00:52:59.667108 | debian-bookworm | included: /var/lib/zuul/builds/8897ef1efaee4a7abe825f1353d508d6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-14 00:52:59.673769 | 2026-06-14 00:52:59.673870 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-14 00:53:01.502251 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-14 00:53:01.502471 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/8897ef1efaee4a7abe825f1353d508d6/work/8897ef1efaee4a7abe825f1353d508d6_id_rsa 2026-06-14 00:53:01.502508 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/8897ef1efaee4a7abe825f1353d508d6/work/8897ef1efaee4a7abe825f1353d508d6_id_rsa.pub 2026-06-14 00:53:01.502534 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-14 00:53:01.502560 | debian-bookworm -> localhost | SHA256:YumeXUcdtIsBDu/u5qBkjx/4rUXbkye2/1PP6c26Ufs zuul-build-sshkey 2026-06-14 00:53:01.502583 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-14 00:53:01.502613 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-14 00:53:01.502648 | debian-bookworm -> localhost | | . . . | 2026-06-14 00:53:01.502669 | debian-bookworm -> localhost | | + . . . | 2026-06-14 00:53:01.502689 | debian-bookworm -> localhost | | o . o | 2026-06-14 00:53:01.502708 | debian-bookworm -> localhost | | . . + o | 2026-06-14 00:53:01.502727 | debian-bookworm -> localhost | | + S o o o .| 2026-06-14 00:53:01.502753 | debian-bookworm -> localhost | | o o o + . .o| 2026-06-14 00:53:01.502772 | debian-bookworm -> localhost | | = o = B oo+| 2026-06-14 00:53:01.502792 | debian-bookworm -> localhost | | + B B.o = ==| 2026-06-14 00:53:01.502814 | debian-bookworm -> localhost | | =.*++ ..==E| 2026-06-14 00:53:01.503135 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-14 00:53:01.503211 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.321188 2026-06-14 00:53:01.510101 | 2026-06-14 00:53:01.510202 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-14 00:53:01.548736 | debian-bookworm | ok 2026-06-14 00:53:01.568327 | debian-bookworm | included: /var/lib/zuul/builds/8897ef1efaee4a7abe825f1353d508d6/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-14 00:53:01.587163 | 2026-06-14 00:53:01.587573 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-14 00:53:01.632863 | debian-bookworm | skipping: Conditional result was False 2026-06-14 00:53:01.644956 | 2026-06-14 00:53:01.645071 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-14 00:53:02.284733 | debian-bookworm | changed 2026-06-14 00:53:02.295301 | 2026-06-14 00:53:02.295620 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-14 00:53:02.560093 | debian-bookworm | ok 2026-06-14 00:53:02.566371 | 2026-06-14 00:53:02.566524 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-14 00:53:03.247900 | debian-bookworm | changed 2026-06-14 00:53:03.290445 | 2026-06-14 00:53:03.290681 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-14 00:53:04.063048 | debian-bookworm | changed 2026-06-14 00:53:04.070211 | 2026-06-14 00:53:04.070359 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-14 00:53:04.096059 | debian-bookworm | skipping: Conditional result was False 2026-06-14 00:53:04.103768 | 2026-06-14 00:53:04.103912 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-14 00:53:04.718611 | debian-bookworm -> localhost | changed 2026-06-14 00:53:04.733269 | 2026-06-14 00:53:04.733501 | TASK [add-build-sshkey : Add back temp key] 2026-06-14 00:53:05.173601 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/8897ef1efaee4a7abe825f1353d508d6/work/8897ef1efaee4a7abe825f1353d508d6_id_rsa (zuul-build-sshkey) 2026-06-14 00:53:05.173882 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.015960 2026-06-14 00:53:05.188860 | 2026-06-14 00:53:05.189006 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-14 00:53:05.740461 | debian-bookworm | ok 2026-06-14 00:53:05.750365 | 2026-06-14 00:53:05.750540 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-14 00:53:05.777024 | debian-bookworm | skipping: Conditional result was False 2026-06-14 00:53:05.790146 | 2026-06-14 00:53:05.790297 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-14 00:53:06.283949 | debian-bookworm | ok 2026-06-14 00:53:06.298539 | 2026-06-14 00:53:06.298727 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-14 00:53:06.335868 | debian-bookworm | ok 2026-06-14 00:53:06.345906 | 2026-06-14 00:53:06.346069 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-14 00:53:06.667544 | debian-bookworm -> localhost | ok 2026-06-14 00:53:06.676213 | 2026-06-14 00:53:06.676519 | TASK [validate-host : Collect information about the host] 2026-06-14 00:53:08.013439 | debian-bookworm | ok 2026-06-14 00:53:08.053574 | 2026-06-14 00:53:08.053768 | TASK [validate-host : Sanitize hostname] 2026-06-14 00:53:08.492356 | debian-bookworm | ok 2026-06-14 00:53:08.502322 | 2026-06-14 00:53:08.502467 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-14 00:53:09.328246 | debian-bookworm -> localhost | changed 2026-06-14 00:53:09.334728 | 2026-06-14 00:53:09.334994 | TASK [validate-host : Collect information about zuul worker] 2026-06-14 00:53:09.807472 | debian-bookworm | ok 2026-06-14 00:53:09.817242 | 2026-06-14 00:53:09.817511 | TASK [validate-host : Write out all zuul information for each host] 2026-06-14 00:53:10.535870 | debian-bookworm -> localhost | changed 2026-06-14 00:53:10.546377 | 2026-06-14 00:53:10.546534 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-14 00:53:10.841041 | debian-bookworm | ok 2026-06-14 00:53:10.849673 | 2026-06-14 00:53:10.850220 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-14 00:53:11.911228 | debian-bookworm | changed: 2026-06-14 00:53:11.911474 | debian-bookworm | cd+++++++++ src/ 2026-06-14 00:53:11.911514 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-14 00:53:11.911540 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-14 00:53:11.911563 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-06-14 00:53:11.911584 | debian-bookworm | =7.0.3 2026-06-14 00:53:55.057377 | debian-bookworm | Downloading cachetools-7.1.4-py3-none-any.whl (16 kB) 2026-06-14 00:53:55.099528 | debian-bookworm | Collecting colorama>=0.4.6 2026-06-14 00:53:55.111504 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-06-14 00:53:55.175345 | debian-bookworm | Collecting filelock>=3.25 2026-06-14 00:53:55.187552 | debian-bookworm | Downloading filelock-3.29.4-py3-none-any.whl (42 kB) 2026-06-14 00:53:55.195786 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 42.8/42.8 kB 6.2 MB/s eta 0:00:00 2026-06-14 00:53:55.242114 | debian-bookworm | Collecting packaging>=26 2026-06-14 00:53:55.253880 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-06-14 00:53:55.266329 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 9.5 MB/s eta 0:00:00 2026-06-14 00:53:55.316874 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-06-14 00:53:55.328968 | debian-bookworm | Downloading platformdirs-4.10.0-py3-none-any.whl (22 kB) 2026-06-14 00:53:55.371019 | debian-bookworm | Collecting pluggy>=1.6 2026-06-14 00:53:55.382855 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-06-14 00:53:55.430058 | debian-bookworm | Collecting pyproject-api>=1.10 2026-06-14 00:53:55.442049 | debian-bookworm | Downloading pyproject_api-1.10.1-py3-none-any.whl (12 kB) 2026-06-14 00:53:55.478566 | debian-bookworm | Collecting python-discovery>=1.2.2 2026-06-14 00:53:55.490240 | debian-bookworm | Downloading python_discovery-1.4.2-py3-none-any.whl (33 kB) 2026-06-14 00:53:55.535748 | debian-bookworm | Collecting tomli-w>=1.2 2026-06-14 00:53:55.548145 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-06-14 00:53:55.695306 | debian-bookworm | Collecting virtualenv>=21.1 2026-06-14 00:53:55.706917 | debian-bookworm | Downloading virtualenv-21.5.0-py3-none-any.whl (4.6 MB) 2026-06-14 00:53:55.983767 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.6/4.6 MB 16.8 MB/s eta 0:00:00 2026-06-14 00:53:56.092524 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-06-14 00:53:56.106217 | debian-bookworm | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-06-14 00:53:56.132243 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.6/470.6 kB 24.2 MB/s eta 0:00:00 2026-06-14 00:53:56.253984 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-06-14 00:53:57.137016 | 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.55.1 virtualenv-21.5.0 2026-06-14 00:53:57.503538 | debian-bookworm | ok: Runtime: 0:00:03.070289 2026-06-14 00:53:57.522156 | 2026-06-14 00:53:57.522418 | TASK [ensure-tox : Export installed tox_executable path] 2026-06-14 00:53:57.573745 | debian-bookworm | ok 2026-06-14 00:53:57.581878 | 2026-06-14 00:53:57.582035 | TASK [ensure-tox : Output tox version] 2026-06-14 00:53:58.043546 | 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-14 00:53:58.061207 | debian-bookworm | 4.55.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-06-14 00:53:58.615497 | debian-bookworm | ok: Runtime: 0:00:00.321965 2026-06-14 00:53:58.628671 | 2026-06-14 00:53:58.628935 | TASK [ensure-tox : Make global symlink] 2026-06-14 00:53:58.664062 | debian-bookworm | skipping: Conditional result was False 2026-06-14 00:53:58.679010 | 2026-06-14 00:53:58.679152 | PLAY RECAP 2026-06-14 00:53:58.679232 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-06-14 00:53:58.679271 | 2026-06-14 00:53:58.852573 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-06-14 00:53:58.853788 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-06-14 00:53:59.714479 | 2026-06-14 00:53:59.714657 | PLAY [all] 2026-06-14 00:53:59.742291 | 2026-06-14 00:53:59.742458 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-06-14 00:54:00.178598 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-06-14 00:54:00.296540 | debian-bookworm | ok: Runtime: 0:00:00.031169 2026-06-14 00:54:00.302765 | 2026-06-14 00:54:00.302930 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-06-14 00:54:00.836239 | debian-bookworm | ok: Runtime: 0:00:00.005740 2026-06-14 00:54:00.851038 | 2026-06-14 00:54:00.851266 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-06-14 00:54:01.098796 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-06-14 00:54:01.100310 | debian-bookworm | sudo: a password is required 2026-06-14 00:54:01.391329 | debian-bookworm | ok: Runtime: 0:00:00.019276 2026-06-14 00:54:01.413192 | 2026-06-14 00:54:01.413366 | TASK [tox : Check to see if the constraints file exists] 2026-06-14 00:54:01.440618 | debian-bookworm | skipping: Conditional result was False 2026-06-14 00:54:01.447857 | 2026-06-14 00:54:01.449422 | TASK [tox : Fail if constraints file is missing] 2026-06-14 00:54:01.474471 | debian-bookworm | skipping: Conditional result was False 2026-06-14 00:54:01.481631 | 2026-06-14 00:54:01.481811 | TASK [tox : Record file location] 2026-06-14 00:54:01.520843 | debian-bookworm | skipping: Conditional result was False 2026-06-14 00:54:01.533905 | 2026-06-14 00:54:01.534119 | TASK [tox : Install tox siblings] 2026-06-14 00:54:01.584062 | debian-bookworm | ok 2026-06-14 00:54:01.600827 | debian-bookworm | included: /var/lib/zuul/builds/8897ef1efaee4a7abe825f1353d508d6/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-06-14 00:54:01.608505 | 2026-06-14 00:54:01.608687 | TASK [tox : Run tox without tests] 2026-06-14 00:54:02.828307 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-06-14 00:54:15.609732 | debian-bookworm | test: OK (13.50 seconds) 2026-06-14 00:54:15.609856 | debian-bookworm | congratulations :) (13.53 seconds) 2026-06-14 00:54:16.144511 | debian-bookworm | ok: Runtime: 0:00:13.825051 2026-06-14 00:54:16.152411 | 2026-06-14 00:54:16.152551 | TASK [tox : Create a tempfile to save tox showconfig] 2026-06-14 00:54:16.609085 | debian-bookworm | changed 2026-06-14 00:54:16.619193 | 2026-06-14 00:54:16.619396 | TASK [tox : Detect tox version] 2026-06-14 00:54:17.133231 | debian-bookworm | 4.55.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-06-14 00:54:17.666261 | debian-bookworm | ok: Runtime: 0:00:00.318773 2026-06-14 00:54:17.679696 | 2026-06-14 00:54:17.680011 | TASK [tox : Get tox envlist config] 2026-06-14 00:54:18.717166 | debian-bookworm | ok: Runtime: 0:00:00.397352 2026-06-14 00:54:18.729978 | 2026-06-14 00:54:18.730269 | TASK [tox : Install any sibling python packages] 2026-06-14 00:54:19.195759 | debian-bookworm | ok: No setup.cfg, no action needed 2026-06-14 00:54:19.205214 | 2026-06-14 00:54:19.205634 | TASK [tox : Remove tempfile] 2026-06-14 00:54:19.713952 | debian-bookworm | changed 2026-06-14 00:54:19.720141 | 2026-06-14 00:54:19.720284 | TASK [tox : Emit tox command] 2026-06-14 00:54:19.774058 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-06-14 00:54:19.779647 | 2026-06-14 00:54:19.779827 | TASK [tox : Run tox] 2026-06-14 00:54:20.346589 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-06-14 00:54:21.098010 | debian-bookworm | ............... 2026-06-14 00:54:21.098062 | debian-bookworm | ---------------------------------------------------------------------- 2026-06-14 00:54:21.098075 | debian-bookworm | Ran 15 tests in 0.172s 2026-06-14 00:54:21.098080 | debian-bookworm | 2026-06-14 00:54:21.098088 | debian-bookworm | OK 2026-06-14 00:54:21.202992 | debian-bookworm | test: OK (0.90=setup[0.05]+cmd[0.85] seconds) 2026-06-14 00:54:21.203054 | debian-bookworm | congratulations :) (0.94 seconds) 2026-06-14 00:54:21.811922 | debian-bookworm | ok: Runtime: 0:00:01.242821 2026-06-14 00:54:21.819141 | 2026-06-14 00:54:21.819317 | TASK [tox : Look for output] 2026-06-14 00:54:22.226445 | debian-bookworm | ok 2026-06-14 00:54:22.245085 | 2026-06-14 00:54:22.245249 | TASK [tox : Return file comments to Zuul] 2026-06-14 00:54:22.280467 | debian-bookworm | skipping: Conditional result was False 2026-06-14 00:54:22.288116 | 2026-06-14 00:54:22.288222 | PLAY RECAP 2026-06-14 00:54:22.288277 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-06-14 00:54:22.288302 | 2026-06-14 00:54:22.444761 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-06-14 00:54:22.447563 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-06-14 00:54:23.251637 | 2026-06-14 00:54:23.251980 | PLAY [all] 2026-06-14 00:54:23.270034 | 2026-06-14 00:54:23.270225 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-06-14 00:54:23.328312 | debian-bookworm | skipping: Conditional result was False 2026-06-14 00:54:23.334785 | 2026-06-14 00:54:23.335447 | TASK [fetch-tox-output : Set tox log path for single node] 2026-06-14 00:54:23.386458 | debian-bookworm | ok 2026-06-14 00:54:23.393672 | 2026-06-14 00:54:23.393867 | TASK [fetch-tox-output : Ensure local tox dir] 2026-06-14 00:54:23.895708 | debian-bookworm -> localhost | changed 2026-06-14 00:54:23.904902 | 2026-06-14 00:54:23.905046 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-06-14 00:54:23.960027 | debian-bookworm | skipping: Conditional result was False 2026-06-14 00:54:23.972674 | 2026-06-14 00:54:23.972898 | TASK [fetch-tox-output : Set envlist fact] 2026-06-14 00:54:24.015883 | debian-bookworm | ok 2026-06-14 00:54:24.023097 | 2026-06-14 00:54:24.023231 | TASK [fetch-tox-output : Get tox version] 2026-06-14 00:54:24.690331 | 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-14 00:54:24.707684 | debian-bookworm | 4.55.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-06-14 00:54:25.059571 | debian-bookworm | ok: Runtime: 0:00:00.308849 2026-06-14 00:54:25.066095 | 2026-06-14 00:54:25.066235 | TASK [fetch-tox-output : Find all default environments] 2026-06-14 00:54:25.600214 | debian-bookworm | skipping: Conditional result was False 2026-06-14 00:54:25.607875 | 2026-06-14 00:54:25.608032 | TASK [fetch-tox-output : Set envlist fact] 2026-06-14 00:54:25.642542 | debian-bookworm | skipping: Conditional result was False 2026-06-14 00:54:25.649234 | 2026-06-14 00:54:25.649453 | TASK [fetch-tox-output : Find all default environments] 2026-06-14 00:54:26.179289 | debian-bookworm | skipping: Conditional result was False 2026-06-14 00:54:26.194350 | 2026-06-14 00:54:26.194550 | TASK [fetch-tox-output : Set envlist fact] 2026-06-14 00:54:26.230451 | debian-bookworm | skipping: Conditional result was False 2026-06-14 00:54:26.241986 | 2026-06-14 00:54:26.242157 | LOOP [fetch-tox-output : Copy tox logs] 2026-06-14 00:54:26.301424 | debian-bookworm | skipping: Conditional result was False 2026-06-14 00:54:26.323685 | 2026-06-14 00:54:26.324004 | LOOP [fetch-tox-output : Collect tox logs] 2026-06-14 00:54:27.152660 | debian-bookworm | changed: 2026-06-14 00:54:27.152943 | debian-bookworm | created directory /var/lib/zuul/builds/8897ef1efaee4a7abe825f1353d508d6/work/logs/tox/test 2026-06-14 00:54:27.152993 | debian-bookworm | cd+++++++++ ./ 2026-06-14 00:54:27.153019 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-06-14 00:54:27.153055 | 2026-06-14 00:54:27.165555 | 2026-06-14 00:54:27.165673 | PLAY RECAP 2026-06-14 00:54:27.165757 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-06-14 00:54:27.165786 | 2026-06-14 00:54:27.335550 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-06-14 00:54:27.336742 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-06-14 00:54:28.132684 | 2026-06-14 00:54:28.133094 | PLAY [all] 2026-06-14 00:54:28.151124 | 2026-06-14 00:54:28.151287 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-06-14 00:54:28.368374 | debian-bookworm | changed: non-zero return code 2026-06-14 00:54:28.376380 | 2026-06-14 00:54:28.376586 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-06-14 00:54:28.402327 | debian-bookworm | skipping: Conditional result was False 2026-06-14 00:54:28.412545 | 2026-06-14 00:54:28.412770 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-06-14 00:54:28.446865 | 2026-06-14 00:54:28.447120 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-06-14 00:54:28.481257 | 2026-06-14 00:54:28.481577 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-06-14 00:54:28.505746 | debian-bookworm | skipping: Conditional result was False 2026-06-14 00:54:28.513058 | 2026-06-14 00:54:28.513187 | LOOP [fetch-subunit-output : Generate subunit file] 2026-06-14 00:54:28.543977 | 2026-06-14 00:54:28.544212 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-06-14 00:54:28.568790 | debian-bookworm | skipping: Conditional result was False 2026-06-14 00:54:28.575836 | 2026-06-14 00:54:28.575983 | TASK [fetch-subunit-output : Remove the temporary file] 2026-06-14 00:54:28.600203 | debian-bookworm | skipping: Conditional result was False 2026-06-14 00:54:28.609615 | 2026-06-14 00:54:28.609829 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-06-14 00:54:28.634683 | debian-bookworm | skipping: Conditional result was False 2026-06-14 00:54:28.652575 | 2026-06-14 00:54:28.652768 | PLAY RECAP 2026-06-14 00:54:28.652857 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-06-14 00:54:28.652897 | 2026-06-14 00:54:28.819958 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-06-14 00:54:28.821909 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-14 00:54:29.627162 | 2026-06-14 00:54:29.627356 | PLAY [Base post-fetch] 2026-06-14 00:54:29.645393 | 2026-06-14 00:54:29.645566 | TASK [diagnose-network : Ensure log directory exists] 2026-06-14 00:54:30.047645 | debian-bookworm | ok 2026-06-14 00:54:30.060530 | 2026-06-14 00:54:30.060799 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-06-14 00:55:00.098466 | debian-bookworm | ok: Runtime: 0:00:29.450923 2026-06-14 00:55:00.112147 | 2026-06-14 00:55:00.112341 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-06-14 00:55:00.647223 | debian-bookworm | ok: Runtime: 0:00:00.006255 2026-06-14 00:55:00.666497 | 2026-06-14 00:55:00.666781 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-06-14 00:55:01.219599 | debian-bookworm | ok: Runtime: 0:00:00.009134 2026-06-14 00:55:01.232060 | 2026-06-14 00:55:01.232209 | TASK [fetch-output : Set log path for multiple nodes] 2026-06-14 00:55:01.288958 | debian-bookworm | skipping: Conditional result was False 2026-06-14 00:55:01.296406 | 2026-06-14 00:55:01.296559 | TASK [fetch-output : Set log path for single node] 2026-06-14 00:55:01.337899 | debian-bookworm | ok 2026-06-14 00:55:01.343411 | 2026-06-14 00:55:01.343535 | LOOP [fetch-output : Ensure local output dirs] 2026-06-14 00:55:01.656023 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/8897ef1efaee4a7abe825f1353d508d6/work/logs" 2026-06-14 00:55:01.952414 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/8897ef1efaee4a7abe825f1353d508d6/work/artifacts" 2026-06-14 00:55:02.228792 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/8897ef1efaee4a7abe825f1353d508d6/work/docs" 2026-06-14 00:55:02.249678 | 2026-06-14 00:55:02.249866 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-14 00:55:03.075979 | debian-bookworm | changed: 2026-06-14 00:55:03.076233 | debian-bookworm | .d..t...... ./ 2026-06-14 00:55:03.076273 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-06-14 00:55:03.076301 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-06-14 00:55:03.076325 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-14 00:55:03.076348 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-14 00:55:03.076371 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-14 00:55:03.076417 | debian-bookworm | changed: All items complete 2026-06-14 00:55:03.076447 | 2026-06-14 00:55:03.740231 | debian-bookworm | changed: .d..t...... ./ 2026-06-14 00:55:04.328340 | debian-bookworm | changed: .d..t...... ./ 2026-06-14 00:55:04.353813 | 2026-06-14 00:55:04.353971 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-14 00:55:04.744872 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.027743 2026-06-14 00:55:05.055581 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.008172 2026-06-14 00:55:05.069033 | 2026-06-14 00:55:05.069142 | PLAY RECAP 2026-06-14 00:55:05.069196 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-14 00:55:05.069221 | 2026-06-14 00:55:05.232118 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-14 00:55:05.233242 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-14 00:55:06.128066 | 2026-06-14 00:55:06.128320 | PLAY [Base post] 2026-06-14 00:55:06.149712 | 2026-06-14 00:55:06.149985 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-14 00:55:06.732860 | debian-bookworm | changed 2026-06-14 00:55:06.739909 | 2026-06-14 00:55:06.740049 | PLAY RECAP 2026-06-14 00:55:06.740114 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-14 00:55:06.740178 | 2026-06-14 00:55:06.898168 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-14 00:55:06.899322 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-14 00:55:07.789961 | 2026-06-14 00:55:07.790165 | PLAY [Base post-logs] 2026-06-14 00:55:07.803210 | 2026-06-14 00:55:07.803390 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-14 00:55:08.288190 | localhost | changed 2026-06-14 00:55:08.300905 | 2026-06-14 00:55:08.301199 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-14 00:55:08.342760 | localhost | ok 2026-06-14 00:55:08.346228 | 2026-06-14 00:55:08.346350 | TASK [Set zuul-log-path fact] 2026-06-14 00:55:08.367231 | localhost | ok 2026-06-14 00:55:08.385227 | 2026-06-14 00:55:08.385418 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-14 00:55:08.415143 | localhost | ok 2026-06-14 00:55:08.418609 | 2026-06-14 00:55:08.418728 | TASK [upload-logs : Create log directories] 2026-06-14 00:55:08.978450 | localhost | changed 2026-06-14 00:55:08.982866 | 2026-06-14 00:55:08.983012 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-14 00:55:09.691187 | localhost -> localhost | ok: Runtime: 0:00:00.010994 2026-06-14 00:55:09.701617 | 2026-06-14 00:55:09.701804 | TASK [upload-logs : Upload logs to log server] 2026-06-14 00:55:10.414591 | localhost | Output suppressed because no_log was given 2026-06-14 00:55:10.417825 | 2026-06-14 00:55:10.418182 | LOOP [upload-logs : Compress console log and json output] 2026-06-14 00:55:10.477456 | localhost | skipping: Conditional result was False 2026-06-14 00:55:10.482669 | localhost | skipping: Conditional result was False 2026-06-14 00:55:10.494988 | 2026-06-14 00:55:10.495165 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-14 00:55:10.548010 | localhost | skipping: Conditional result was False 2026-06-14 00:55:10.548545 | 2026-06-14 00:55:10.553281 | localhost | skipping: Conditional result was False 2026-06-14 00:55:10.566930 | 2026-06-14 00:55:10.567109 | LOOP [upload-logs : Upload console log and json output]