2026-07-20 05:08:02.540044 | Job console starting 2026-07-20 05:08:02.558535 | Updating git repos 2026-07-20 05:08:02.616242 | Cloning repos into workspace 2026-07-20 05:08:02.882735 | Restoring repo states 2026-07-20 05:08:02.901320 | Merging changes 2026-07-20 05:08:03.435266 | Checking out repos 2026-07-20 05:08:03.478950 | Preparing playbooks 2026-07-20 05:08:05.210510 | Running Ansible setup 2026-07-20 05:08:11.000385 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-20 05:08:12.244396 | 2026-07-20 05:08:12.244603 | PLAY [Base pre] 2026-07-20 05:08:12.273729 | 2026-07-20 05:08:12.273913 | TASK [Setup log path fact] 2026-07-20 05:08:12.314364 | debian-bookworm | ok 2026-07-20 05:08:12.335585 | 2026-07-20 05:08:12.335772 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-20 05:08:12.365507 | debian-bookworm | ok 2026-07-20 05:08:12.376075 | 2026-07-20 05:08:12.376220 | TASK [emit-job-header : Print job information] 2026-07-20 05:08:12.417820 | # Job Information 2026-07-20 05:08:12.418116 | Ansible Version: 2.16.14 2026-07-20 05:08:12.418154 | Job: tox 2026-07-20 05:08:12.418188 | Pipeline: check 2026-07-20 05:08:12.418211 | Executor: 521e9411259a 2026-07-20 05:08:12.418232 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1254 2026-07-20 05:08:12.418254 | Event ID: f3a941c0-83f8-11f1-9ab8-10ca0d7c8b3a 2026-07-20 05:08:12.423907 | 2026-07-20 05:08:12.424035 | LOOP [emit-job-header : Print node information] 2026-07-20 05:08:12.545984 | debian-bookworm | ok: 2026-07-20 05:08:12.546206 | debian-bookworm | # Node Information 2026-07-20 05:08:12.546241 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-20 05:08:12.546269 | debian-bookworm | Hostname: debian 2026-07-20 05:08:12.546292 | debian-bookworm | Username: zuul 2026-07-20 05:08:12.546314 | debian-bookworm | Distro: Debian 12.15 2026-07-20 05:08:12.546338 | debian-bookworm | Provider: regiocloud-a 2026-07-20 05:08:12.546359 | debian-bookworm | Region: 2026-07-20 05:08:12.546380 | debian-bookworm | Label: debian-bookworm 2026-07-20 05:08:12.546400 | debian-bookworm | Product Name: OpenStack Nova 2026-07-20 05:08:12.546420 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe07:dbb0 2026-07-20 05:08:12.562280 | 2026-07-20 05:08:12.562432 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-20 05:08:13.176324 | debian-bookworm -> localhost | changed 2026-07-20 05:08:13.184108 | 2026-07-20 05:08:13.184249 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-20 05:08:14.835726 | debian-bookworm -> localhost | changed 2026-07-20 05:08:14.844634 | 2026-07-20 05:08:14.844731 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-20 05:08:15.225712 | debian-bookworm -> localhost | ok 2026-07-20 05:08:15.230754 | 2026-07-20 05:08:15.230944 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-20 05:08:15.258773 | debian-bookworm | ok 2026-07-20 05:08:15.285922 | debian-bookworm | included: /var/lib/zuul/builds/a6be6d6e52284b4ebea8e86f186b4504/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-20 05:08:15.294056 | 2026-07-20 05:08:15.294176 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-20 05:08:17.765601 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-20 05:08:17.765780 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/a6be6d6e52284b4ebea8e86f186b4504/work/a6be6d6e52284b4ebea8e86f186b4504_id_rsa 2026-07-20 05:08:17.765811 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/a6be6d6e52284b4ebea8e86f186b4504/work/a6be6d6e52284b4ebea8e86f186b4504_id_rsa.pub 2026-07-20 05:08:17.765833 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-20 05:08:17.765867 | debian-bookworm -> localhost | SHA256:lElu3NaJvxOPkJFWazWBlHY958GnVPwvrD4XcaOQcow zuul-build-sshkey 2026-07-20 05:08:17.765886 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-20 05:08:17.765914 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-20 05:08:17.765932 | debian-bookworm -> localhost | | . .oo==.| 2026-07-20 05:08:17.765949 | debian-bookworm -> localhost | | + + =++o==| 2026-07-20 05:08:17.765966 | debian-bookworm -> localhost | | B X.*o o*| 2026-07-20 05:08:17.765982 | debian-bookworm -> localhost | | o E X o.+| 2026-07-20 05:08:17.765997 | debian-bookworm -> localhost | | S = +..oo| 2026-07-20 05:08:17.766017 | debian-bookworm -> localhost | | . *+ .| 2026-07-20 05:08:17.766034 | debian-bookworm -> localhost | | +..o | 2026-07-20 05:08:17.766051 | debian-bookworm -> localhost | | o.. | 2026-07-20 05:08:17.766068 | debian-bookworm -> localhost | | ..o | 2026-07-20 05:08:17.766085 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-20 05:08:17.766125 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.830974 2026-07-20 05:08:17.771265 | 2026-07-20 05:08:17.771348 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-20 05:08:17.788100 | debian-bookworm | ok 2026-07-20 05:08:17.796131 | debian-bookworm | included: /var/lib/zuul/builds/a6be6d6e52284b4ebea8e86f186b4504/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-20 05:08:17.802581 | 2026-07-20 05:08:17.802647 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-20 05:08:17.816323 | debian-bookworm | skipping: Conditional result was False 2026-07-20 05:08:17.820813 | 2026-07-20 05:08:17.820893 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-20 05:08:18.414216 | debian-bookworm | changed 2026-07-20 05:08:18.419854 | 2026-07-20 05:08:18.419961 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-20 05:08:18.684492 | debian-bookworm | ok 2026-07-20 05:08:18.691889 | 2026-07-20 05:08:18.692014 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-20 05:08:19.342530 | debian-bookworm | changed 2026-07-20 05:08:19.349235 | 2026-07-20 05:08:19.349323 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-20 05:08:19.956710 | debian-bookworm | changed 2026-07-20 05:08:19.962143 | 2026-07-20 05:08:19.962231 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-20 05:08:19.986343 | debian-bookworm | skipping: Conditional result was False 2026-07-20 05:08:19.992350 | 2026-07-20 05:08:19.992452 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-20 05:08:20.462327 | debian-bookworm -> localhost | changed 2026-07-20 05:08:20.475871 | 2026-07-20 05:08:20.476004 | TASK [add-build-sshkey : Add back temp key] 2026-07-20 05:08:20.806379 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/a6be6d6e52284b4ebea8e86f186b4504/work/a6be6d6e52284b4ebea8e86f186b4504_id_rsa (zuul-build-sshkey) 2026-07-20 05:08:20.806604 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.032120 2026-07-20 05:08:20.815237 | 2026-07-20 05:08:20.815345 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-20 05:08:21.206452 | debian-bookworm | ok 2026-07-20 05:08:21.218775 | 2026-07-20 05:08:21.218959 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-20 05:08:21.270926 | debian-bookworm | skipping: Conditional result was False 2026-07-20 05:08:21.283962 | 2026-07-20 05:08:21.284116 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-20 05:08:21.930042 | debian-bookworm | ok 2026-07-20 05:08:21.945787 | 2026-07-20 05:08:21.945958 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-20 05:08:21.987179 | debian-bookworm | ok 2026-07-20 05:08:21.993978 | 2026-07-20 05:08:21.994143 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-20 05:08:22.319043 | debian-bookworm -> localhost | ok 2026-07-20 05:08:22.326815 | 2026-07-20 05:08:22.327101 | TASK [validate-host : Collect information about the host] 2026-07-20 05:08:23.605641 | debian-bookworm | ok 2026-07-20 05:08:23.619143 | 2026-07-20 05:08:23.619296 | TASK [validate-host : Sanitize hostname] 2026-07-20 05:08:23.793534 | debian-bookworm | ok 2026-07-20 05:08:23.799459 | 2026-07-20 05:08:23.799589 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-20 05:08:24.689025 | debian-bookworm -> localhost | changed 2026-07-20 05:08:24.695357 | 2026-07-20 05:08:24.695493 | TASK [validate-host : Collect information about zuul worker] 2026-07-20 05:08:25.153631 | debian-bookworm | ok 2026-07-20 05:08:25.163102 | 2026-07-20 05:08:25.163249 | TASK [validate-host : Write out all zuul information for each host] 2026-07-20 05:08:25.795314 | debian-bookworm -> localhost | changed 2026-07-20 05:08:25.805328 | 2026-07-20 05:08:25.805450 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-20 05:08:26.098109 | debian-bookworm | ok 2026-07-20 05:08:26.116264 | 2026-07-20 05:08:26.116408 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-20 05:08:27.129940 | debian-bookworm | changed: 2026-07-20 05:08:27.130227 | debian-bookworm | cd+++++++++ src/ 2026-07-20 05:08:27.130265 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-20 05:08:27.130289 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-20 05:08:27.130312 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-07-20 05:08:27.130333 | debian-bookworm | =7.0.3 2026-07-20 05:09:03.567362 | debian-bookworm | Downloading cachetools-7.1.4-py3-none-any.whl (16 kB) 2026-07-20 05:09:03.603422 | debian-bookworm | Collecting colorama>=0.4.6 2026-07-20 05:09:03.615418 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-07-20 05:09:03.690563 | debian-bookworm | Collecting filelock>=3.25 2026-07-20 05:09:03.701034 | debian-bookworm | Downloading filelock-3.31.1-py3-none-any.whl (97 kB) 2026-07-20 05:09:03.715285 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 97.2/97.2 kB 7.4 MB/s eta 0:00:00 2026-07-20 05:09:03.757000 | debian-bookworm | Collecting packaging>=26 2026-07-20 05:09:03.767194 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-07-20 05:09:03.781895 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 7.4 MB/s eta 0:00:00 2026-07-20 05:09:03.828059 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-07-20 05:09:03.838382 | debian-bookworm | Downloading platformdirs-4.10.1-py3-none-any.whl (22 kB) 2026-07-20 05:09:03.874573 | debian-bookworm | Collecting pluggy>=1.6 2026-07-20 05:09:03.884593 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-07-20 05:09:03.920019 | debian-bookworm | Collecting pyproject-api>=1.10 2026-07-20 05:09:03.930455 | debian-bookworm | Downloading pyproject_api-1.10.1-py3-none-any.whl (12 kB) 2026-07-20 05:09:03.966035 | debian-bookworm | Collecting python-discovery>=1.4.4 2026-07-20 05:09:03.976697 | debian-bookworm | Downloading python_discovery-1.4.4-py3-none-any.whl (34 kB) 2026-07-20 05:09:04.015448 | debian-bookworm | Collecting tomli-w>=1.2 2026-07-20 05:09:04.026639 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-07-20 05:09:04.185446 | debian-bookworm | Collecting virtualenv>=21.1 2026-07-20 05:09:04.195506 | debian-bookworm | Downloading virtualenv-21.6.1-py3-none-any.whl (5.5 MB) 2026-07-20 05:09:04.479266 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.5/5.5 MB 19.6 MB/s eta 0:00:00 2026-07-20 05:09:04.573858 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-07-20 05:09:04.584823 | debian-bookworm | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-07-20 05:09:04.604223 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.6/470.6 kB 28.8 MB/s eta 0:00:00 2026-07-20 05:09:04.705348 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-07-20 05:09:05.493993 | debian-bookworm | Successfully installed cachetools-7.1.4 colorama-0.4.6 distlib-0.4.3 filelock-3.31.1 packaging-26.2 platformdirs-4.10.1 pluggy-1.6.0 pyproject-api-1.10.1 python-discovery-1.4.4 tomli-w-1.2.0 tox-4.57.0 virtualenv-21.6.1 2026-07-20 05:09:05.595658 | debian-bookworm | ok: Runtime: 0:00:02.761163 2026-07-20 05:09:05.606500 | 2026-07-20 05:09:05.606644 | TASK [ensure-tox : Export installed tox_executable path] 2026-07-20 05:09:05.658206 | debian-bookworm | ok 2026-07-20 05:09:05.665590 | 2026-07-20 05:09:05.665719 | TASK [ensure-tox : Output tox version] 2026-07-20 05:09:06.155476 | 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-07-20 05:09:06.169117 | debian-bookworm | 4.57.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-20 05:09:06.695979 | debian-bookworm | ok: Runtime: 0:00:00.255465 2026-07-20 05:09:06.704929 | 2026-07-20 05:09:06.705081 | TASK [ensure-tox : Make global symlink] 2026-07-20 05:09:06.741557 | debian-bookworm | skipping: Conditional result was False 2026-07-20 05:09:06.753347 | 2026-07-20 05:09:06.753583 | PLAY RECAP 2026-07-20 05:09:06.753664 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-07-20 05:09:06.753696 | 2026-07-20 05:09:07.001782 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-07-20 05:09:07.003730 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-07-20 05:09:07.894566 | 2026-07-20 05:09:07.894767 | PLAY [all] 2026-07-20 05:09:07.912235 | 2026-07-20 05:09:07.912406 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-07-20 05:09:08.364029 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-07-20 05:09:08.444590 | debian-bookworm | ok: Runtime: 0:00:00.022672 2026-07-20 05:09:08.451638 | 2026-07-20 05:09:08.451781 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-07-20 05:09:08.982515 | debian-bookworm | ok: Runtime: 0:00:00.005599 2026-07-20 05:09:08.995651 | 2026-07-20 05:09:08.995864 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-07-20 05:09:09.297214 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-07-20 05:09:09.298700 | debian-bookworm | sudo: a password is required 2026-07-20 05:09:09.528653 | debian-bookworm | ok: Runtime: 0:00:00.018375 2026-07-20 05:09:09.548881 | 2026-07-20 05:09:09.549108 | TASK [tox : Check to see if the constraints file exists] 2026-07-20 05:09:09.580728 | debian-bookworm | skipping: Conditional result was False 2026-07-20 05:09:09.589810 | 2026-07-20 05:09:09.590007 | TASK [tox : Fail if constraints file is missing] 2026-07-20 05:09:09.626950 | debian-bookworm | skipping: Conditional result was False 2026-07-20 05:09:09.642442 | 2026-07-20 05:09:09.642660 | TASK [tox : Record file location] 2026-07-20 05:09:09.689565 | debian-bookworm | skipping: Conditional result was False 2026-07-20 05:09:09.704117 | 2026-07-20 05:09:09.704341 | TASK [tox : Install tox siblings] 2026-07-20 05:09:09.739639 | debian-bookworm | ok 2026-07-20 05:09:09.750374 | debian-bookworm | included: /var/lib/zuul/builds/a6be6d6e52284b4ebea8e86f186b4504/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-07-20 05:09:09.756387 | 2026-07-20 05:09:09.756512 | TASK [tox : Run tox without tests] 2026-07-20 05:09:11.063534 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-07-20 05:09:23.728028 | debian-bookworm | test: OK (13.40 seconds) 2026-07-20 05:09:23.728078 | debian-bookworm | congratulations :) (13.43 seconds) 2026-07-20 05:09:23.833882 | debian-bookworm | ok: Runtime: 0:00:13.736648 2026-07-20 05:09:23.843416 | 2026-07-20 05:09:23.843557 | TASK [tox : Create a tempfile to save tox showconfig] 2026-07-20 05:09:24.298052 | debian-bookworm | changed 2026-07-20 05:09:24.306057 | 2026-07-20 05:09:24.306254 | TASK [tox : Detect tox version] 2026-07-20 05:09:24.862362 | debian-bookworm | 4.57.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-20 05:09:25.337626 | debian-bookworm | ok: Runtime: 0:00:00.311128 2026-07-20 05:09:25.345683 | 2026-07-20 05:09:25.345895 | TASK [tox : Get tox envlist config] 2026-07-20 05:09:26.379758 | debian-bookworm | ok: Runtime: 0:00:00.385013 2026-07-20 05:09:26.387481 | 2026-07-20 05:09:26.387605 | TASK [tox : Install any sibling python packages] 2026-07-20 05:09:26.842777 | debian-bookworm | ok: No setup.cfg, no action needed 2026-07-20 05:09:26.852216 | 2026-07-20 05:09:26.852398 | TASK [tox : Remove tempfile] 2026-07-20 05:09:27.342357 | debian-bookworm | changed 2026-07-20 05:09:27.348557 | 2026-07-20 05:09:27.348675 | TASK [tox : Emit tox command] 2026-07-20 05:09:27.405537 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-07-20 05:09:27.413421 | 2026-07-20 05:09:27.413579 | TASK [tox : Run tox] 2026-07-20 05:09:28.041351 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-07-20 05:09:29.901083 | debian-bookworm | ............................................. 2026-07-20 05:09:29.901199 | debian-bookworm | ---------------------------------------------------------------------- 2026-07-20 05:09:29.901222 | debian-bookworm | Ran 45 tests in 1.377s 2026-07-20 05:09:29.901237 | debian-bookworm | 2026-07-20 05:09:29.901253 | debian-bookworm | OK 2026-07-20 05:09:30.004670 | debian-bookworm | test: OK (2.01=setup[0.05]+cmd[1.96] seconds) 2026-07-20 05:09:30.004770 | debian-bookworm | congratulations :) (2.03 seconds) 2026-07-20 05:09:30.448004 | debian-bookworm | ok: Runtime: 0:00:02.356113 2026-07-20 05:09:30.454214 | 2026-07-20 05:09:30.454327 | TASK [tox : Look for output] 2026-07-20 05:09:30.857201 | debian-bookworm | ok 2026-07-20 05:09:30.875467 | 2026-07-20 05:09:30.875684 | TASK [tox : Return file comments to Zuul] 2026-07-20 05:09:30.915965 | debian-bookworm | skipping: Conditional result was False 2026-07-20 05:09:30.923799 | 2026-07-20 05:09:30.923930 | PLAY RECAP 2026-07-20 05:09:30.923988 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-07-20 05:09:30.924013 | 2026-07-20 05:09:31.094743 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-07-20 05:09:31.095971 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-07-20 05:09:31.890873 | 2026-07-20 05:09:31.891113 | PLAY [all] 2026-07-20 05:09:31.909517 | 2026-07-20 05:09:31.909844 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-07-20 05:09:31.994631 | debian-bookworm | skipping: Conditional result was False 2026-07-20 05:09:32.001170 | 2026-07-20 05:09:32.001359 | TASK [fetch-tox-output : Set tox log path for single node] 2026-07-20 05:09:32.054238 | debian-bookworm | ok 2026-07-20 05:09:32.060330 | 2026-07-20 05:09:32.060487 | TASK [fetch-tox-output : Ensure local tox dir] 2026-07-20 05:09:32.589441 | debian-bookworm -> localhost | changed 2026-07-20 05:09:32.598048 | 2026-07-20 05:09:32.598191 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-07-20 05:09:32.663435 | debian-bookworm | skipping: Conditional result was False 2026-07-20 05:09:32.669497 | 2026-07-20 05:09:32.669624 | TASK [fetch-tox-output : Set envlist fact] 2026-07-20 05:09:32.709244 | debian-bookworm | ok 2026-07-20 05:09:32.715339 | 2026-07-20 05:09:32.715458 | TASK [fetch-tox-output : Get tox version] 2026-07-20 05:09:33.445402 | 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-07-20 05:09:33.462667 | debian-bookworm | 4.57.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-20 05:09:33.746933 | debian-bookworm | ok: Runtime: 0:00:00.326571 2026-07-20 05:09:33.753001 | 2026-07-20 05:09:33.753123 | TASK [fetch-tox-output : Find all default environments] 2026-07-20 05:09:34.298132 | debian-bookworm | skipping: Conditional result was False 2026-07-20 05:09:34.304703 | 2026-07-20 05:09:34.304909 | TASK [fetch-tox-output : Set envlist fact] 2026-07-20 05:09:34.339952 | debian-bookworm | skipping: Conditional result was False 2026-07-20 05:09:34.353323 | 2026-07-20 05:09:34.353531 | TASK [fetch-tox-output : Find all default environments] 2026-07-20 05:09:34.884062 | debian-bookworm | skipping: Conditional result was False 2026-07-20 05:09:34.890588 | 2026-07-20 05:09:34.890740 | TASK [fetch-tox-output : Set envlist fact] 2026-07-20 05:09:34.915213 | debian-bookworm | skipping: Conditional result was False 2026-07-20 05:09:34.922528 | 2026-07-20 05:09:34.922672 | LOOP [fetch-tox-output : Copy tox logs] 2026-07-20 05:09:34.969206 | debian-bookworm | skipping: Conditional result was False 2026-07-20 05:09:34.985405 | 2026-07-20 05:09:34.985556 | LOOP [fetch-tox-output : Collect tox logs] 2026-07-20 05:09:35.810027 | debian-bookworm | changed: 2026-07-20 05:09:35.810255 | debian-bookworm | created directory /var/lib/zuul/builds/a6be6d6e52284b4ebea8e86f186b4504/work/logs/tox/test 2026-07-20 05:09:35.810294 | debian-bookworm | cd+++++++++ ./ 2026-07-20 05:09:35.810320 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-07-20 05:09:35.810352 | 2026-07-20 05:09:35.817976 | 2026-07-20 05:09:35.818081 | PLAY RECAP 2026-07-20 05:09:35.818135 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-07-20 05:09:35.818173 | 2026-07-20 05:09:36.016588 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-07-20 05:09:36.017726 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-07-20 05:09:36.944075 | 2026-07-20 05:09:36.944278 | PLAY [all] 2026-07-20 05:09:36.967652 | 2026-07-20 05:09:36.967874 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-07-20 05:09:37.162799 | debian-bookworm | changed: non-zero return code 2026-07-20 05:09:37.171393 | 2026-07-20 05:09:37.171570 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-07-20 05:09:37.197960 | debian-bookworm | skipping: Conditional result was False 2026-07-20 05:09:37.208786 | 2026-07-20 05:09:37.209421 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-07-20 05:09:37.246892 | 2026-07-20 05:09:37.247113 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-07-20 05:09:37.305098 | 2026-07-20 05:09:37.305349 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-07-20 05:09:37.331105 | debian-bookworm | skipping: Conditional result was False 2026-07-20 05:09:37.339210 | 2026-07-20 05:09:37.341071 | LOOP [fetch-subunit-output : Generate subunit file] 2026-07-20 05:09:37.372789 | 2026-07-20 05:09:37.373045 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-07-20 05:09:37.397744 | debian-bookworm | skipping: Conditional result was False 2026-07-20 05:09:37.405749 | 2026-07-20 05:09:37.405897 | TASK [fetch-subunit-output : Remove the temporary file] 2026-07-20 05:09:37.441060 | debian-bookworm | skipping: Conditional result was False 2026-07-20 05:09:37.454766 | 2026-07-20 05:09:37.455137 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-07-20 05:09:37.480857 | debian-bookworm | skipping: Conditional result was False 2026-07-20 05:09:37.489063 | 2026-07-20 05:09:37.489163 | PLAY RECAP 2026-07-20 05:09:37.489219 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-07-20 05:09:37.489243 | 2026-07-20 05:09:37.688990 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-07-20 05:09:37.694268 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-20 05:09:38.529137 | 2026-07-20 05:09:38.529336 | PLAY [Base post-fetch] 2026-07-20 05:09:38.545634 | 2026-07-20 05:09:38.545812 | TASK [diagnose-network : Ensure log directory exists] 2026-07-20 05:09:38.955019 | debian-bookworm | ok 2026-07-20 05:09:38.965653 | 2026-07-20 05:09:38.965859 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-07-20 05:09:50.734673 | debian-bookworm | ok: Runtime: 0:00:05.787543 2026-07-20 05:09:50.742427 | 2026-07-20 05:09:50.742575 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-07-20 05:09:56.715885 | debian-bookworm | ok: Runtime: 0:00:00.007809 2026-07-20 05:09:56.723204 | 2026-07-20 05:09:56.723366 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-07-20 05:10:02.721611 | debian-bookworm | ok: Runtime: 0:00:00.008104 2026-07-20 05:10:02.736381 | 2026-07-20 05:10:02.736523 | TASK [fetch-output : Set log path for multiple nodes] 2026-07-20 05:10:02.791398 | debian-bookworm | skipping: Conditional result was False 2026-07-20 05:10:02.797570 | 2026-07-20 05:10:02.797703 | TASK [fetch-output : Set log path for single node] 2026-07-20 05:10:02.857651 | debian-bookworm | ok 2026-07-20 05:10:02.865564 | 2026-07-20 05:10:02.865716 | LOOP [fetch-output : Ensure local output dirs] 2026-07-20 05:10:03.163772 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/a6be6d6e52284b4ebea8e86f186b4504/work/logs" 2026-07-20 05:10:03.481617 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/a6be6d6e52284b4ebea8e86f186b4504/work/artifacts" 2026-07-20 05:10:03.760852 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/a6be6d6e52284b4ebea8e86f186b4504/work/docs" 2026-07-20 05:10:03.770615 | 2026-07-20 05:10:03.770759 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-20 05:10:04.639655 | debian-bookworm | changed: 2026-07-20 05:10:04.639932 | debian-bookworm | .d..t...... ./ 2026-07-20 05:10:04.639969 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-20 05:10:04.639993 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-20 05:10:04.640015 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-20 05:10:04.640036 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-20 05:10:04.640056 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-20 05:10:04.640097 | debian-bookworm | changed: All items complete 2026-07-20 05:10:04.640120 | 2026-07-20 05:10:05.203779 | debian-bookworm | changed: .d..t...... ./ 2026-07-20 05:10:05.787266 | debian-bookworm | changed: .d..t...... ./ 2026-07-20 05:10:05.807108 | 2026-07-20 05:10:05.807262 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-20 05:10:06.174064 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.009992 2026-07-20 05:10:06.472306 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.009575 2026-07-20 05:10:06.482389 | 2026-07-20 05:10:06.482494 | PLAY RECAP 2026-07-20 05:10:06.482548 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-07-20 05:10:06.482573 | 2026-07-20 05:10:06.650351 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-20 05:10:06.651559 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-20 05:10:07.509733 | 2026-07-20 05:10:07.509934 | PLAY [Base post] 2026-07-20 05:10:07.524993 | 2026-07-20 05:10:07.525158 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-20 05:10:08.118246 | debian-bookworm | changed 2026-07-20 05:10:08.128736 | 2026-07-20 05:10:08.128992 | PLAY RECAP 2026-07-20 05:10:08.129102 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-20 05:10:08.129196 | 2026-07-20 05:10:08.297544 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-20 05:10:08.302137 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-20 05:10:09.127424 | 2026-07-20 05:10:09.127637 | PLAY [Base post-logs] 2026-07-20 05:10:09.139930 | 2026-07-20 05:10:09.140143 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-20 05:10:09.656267 | localhost | changed 2026-07-20 05:10:09.668951 | 2026-07-20 05:10:09.669121 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-20 05:10:09.705754 | localhost | ok 2026-07-20 05:10:09.711895 | 2026-07-20 05:10:09.712064 | TASK [Set zuul-log-path fact] 2026-07-20 05:10:09.729322 | localhost | ok 2026-07-20 05:10:09.739140 | 2026-07-20 05:10:09.739342 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-20 05:10:09.767183 | localhost | ok 2026-07-20 05:10:09.770713 | 2026-07-20 05:10:09.770920 | TASK [upload-logs : Create log directories] 2026-07-20 05:10:10.304911 | localhost | changed 2026-07-20 05:10:10.309013 | 2026-07-20 05:10:10.309167 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-20 05:10:10.835286 | localhost -> localhost | ok: Runtime: 0:00:00.007450 2026-07-20 05:10:10.845033 | 2026-07-20 05:10:10.845274 | TASK [upload-logs : Upload logs to log server] 2026-07-20 05:10:11.433957 | localhost | Output suppressed because no_log was given 2026-07-20 05:10:11.438275 | 2026-07-20 05:10:11.438473 | LOOP [upload-logs : Compress console log and json output] 2026-07-20 05:10:11.500760 | localhost | skipping: Conditional result was False 2026-07-20 05:10:11.505954 | localhost | skipping: Conditional result was False 2026-07-20 05:10:11.523203 | 2026-07-20 05:10:11.523493 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-20 05:10:11.575395 | localhost | skipping: Conditional result was False 2026-07-20 05:10:11.576053 | 2026-07-20 05:10:11.578988 | localhost | skipping: Conditional result was False 2026-07-20 05:10:11.587121 | 2026-07-20 05:10:11.587438 | LOOP [upload-logs : Upload console log and json output]