2026-07-21 02:39:43.309877 | Job console starting 2026-07-21 02:39:43.349083 | Updating git repos 2026-07-21 02:39:43.404612 | Cloning repos into workspace 2026-07-21 02:39:43.477336 | Restoring repo states 2026-07-21 02:39:43.485083 | Merging changes 2026-07-21 02:39:43.986610 | Checking out repos 2026-07-21 02:39:44.049805 | Preparing playbooks 2026-07-21 02:39:45.165710 | Running Ansible setup 2026-07-21 02:39:50.107411 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-21 02:39:50.935370 | 2026-07-21 02:39:50.936063 | PLAY [Base pre] 2026-07-21 02:39:50.967311 | 2026-07-21 02:39:50.967506 | TASK [Setup log path fact] 2026-07-21 02:39:51.013402 | debian-bookworm | ok 2026-07-21 02:39:51.032197 | 2026-07-21 02:39:51.032382 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-21 02:39:51.073682 | debian-bookworm | ok 2026-07-21 02:39:51.088366 | 2026-07-21 02:39:51.088528 | TASK [emit-job-header : Print job information] 2026-07-21 02:39:51.129514 | # Job Information 2026-07-21 02:39:51.129719 | Ansible Version: 2.16.14 2026-07-21 02:39:51.129754 | Job: tox 2026-07-21 02:39:51.129786 | Pipeline: check 2026-07-21 02:39:51.129809 | Executor: 521e9411259a 2026-07-21 02:39:51.129830 | Triggered by: https://github.com/osism/openstack-image-manager/pull/944 2026-07-21 02:39:51.129851 | Event ID: 67fd53e0-84ad-11f1-8523-ca5fcf8619cd 2026-07-21 02:39:51.134991 | 2026-07-21 02:39:51.135118 | LOOP [emit-job-header : Print node information] 2026-07-21 02:39:51.253655 | debian-bookworm | ok: 2026-07-21 02:39:51.253948 | debian-bookworm | # Node Information 2026-07-21 02:39:51.254937 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-21 02:39:51.255037 | debian-bookworm | Hostname: debian 2026-07-21 02:39:51.255067 | debian-bookworm | Username: zuul 2026-07-21 02:39:51.255090 | debian-bookworm | Distro: Debian 12.15 2026-07-21 02:39:51.255119 | debian-bookworm | Provider: regiocloud-a 2026-07-21 02:39:51.255183 | debian-bookworm | Region: 2026-07-21 02:39:51.255206 | debian-bookworm | Label: debian-bookworm 2026-07-21 02:39:51.255229 | debian-bookworm | Product Name: OpenStack Nova 2026-07-21 02:39:51.255250 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fef5:d2af 2026-07-21 02:39:51.274292 | 2026-07-21 02:39:51.274452 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-21 02:39:51.884351 | debian-bookworm -> localhost | changed 2026-07-21 02:39:51.892481 | 2026-07-21 02:39:51.892643 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-21 02:39:53.530491 | debian-bookworm -> localhost | changed 2026-07-21 02:39:53.551734 | 2026-07-21 02:39:53.551914 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-21 02:39:53.891574 | debian-bookworm -> localhost | ok 2026-07-21 02:39:53.898495 | 2026-07-21 02:39:53.898646 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-21 02:39:53.930423 | debian-bookworm | ok 2026-07-21 02:39:53.947301 | debian-bookworm | included: /var/lib/zuul/builds/fb303296722d4ea5a0ba28a6e9bbbf40/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-21 02:39:53.953963 | 2026-07-21 02:39:53.954094 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-21 02:39:55.045098 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-21 02:39:55.045324 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/fb303296722d4ea5a0ba28a6e9bbbf40/work/fb303296722d4ea5a0ba28a6e9bbbf40_id_rsa 2026-07-21 02:39:55.045362 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/fb303296722d4ea5a0ba28a6e9bbbf40/work/fb303296722d4ea5a0ba28a6e9bbbf40_id_rsa.pub 2026-07-21 02:39:55.045389 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-21 02:39:55.045414 | debian-bookworm -> localhost | SHA256:La1IL7te23LWEep2CnsVJ06YbpzhO2rOwz4D4BlLCmo zuul-build-sshkey 2026-07-21 02:39:55.045437 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-21 02:39:55.045473 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-21 02:39:55.045495 | debian-bookworm -> localhost | | | 2026-07-21 02:39:55.045516 | debian-bookworm -> localhost | | | 2026-07-21 02:39:55.045536 | debian-bookworm -> localhost | | o | 2026-07-21 02:39:55.045556 | debian-bookworm -> localhost | |. + o+ = . | 2026-07-21 02:39:55.045575 | debian-bookworm -> localhost | |.. + =. S+o* = | 2026-07-21 02:39:55.045601 | debian-bookworm -> localhost | |.E. +..o oB + | 2026-07-21 02:39:55.045622 | debian-bookworm -> localhost | |. oo=o + . | 2026-07-21 02:39:55.045641 | debian-bookworm -> localhost | | =B=O o | 2026-07-21 02:39:55.045662 | debian-bookworm -> localhost | | .+=B@o+ | 2026-07-21 02:39:55.045681 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-21 02:39:55.045729 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.470656 2026-07-21 02:39:55.051882 | 2026-07-21 02:39:55.051976 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-21 02:39:55.080206 | debian-bookworm | ok 2026-07-21 02:39:55.106229 | debian-bookworm | included: /var/lib/zuul/builds/fb303296722d4ea5a0ba28a6e9bbbf40/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-21 02:39:55.114352 | 2026-07-21 02:39:55.114443 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-21 02:39:55.127490 | debian-bookworm | skipping: Conditional result was False 2026-07-21 02:39:55.133191 | 2026-07-21 02:39:55.133279 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-21 02:39:55.739361 | debian-bookworm | changed 2026-07-21 02:39:55.744597 | 2026-07-21 02:39:55.744693 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-21 02:39:56.007116 | debian-bookworm | ok 2026-07-21 02:39:56.012744 | 2026-07-21 02:39:56.012834 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-21 02:39:56.631307 | debian-bookworm | changed 2026-07-21 02:39:56.638247 | 2026-07-21 02:39:56.638366 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-21 02:39:57.246184 | debian-bookworm | changed 2026-07-21 02:39:57.252279 | 2026-07-21 02:39:57.252381 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-21 02:39:57.275823 | debian-bookworm | skipping: Conditional result was False 2026-07-21 02:39:57.282367 | 2026-07-21 02:39:57.282467 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-21 02:39:57.691396 | debian-bookworm -> localhost | changed 2026-07-21 02:39:57.701871 | 2026-07-21 02:39:57.701979 | TASK [add-build-sshkey : Add back temp key] 2026-07-21 02:39:58.017985 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/fb303296722d4ea5a0ba28a6e9bbbf40/work/fb303296722d4ea5a0ba28a6e9bbbf40_id_rsa (zuul-build-sshkey) 2026-07-21 02:39:58.018200 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018566 2026-07-21 02:39:58.024753 | 2026-07-21 02:39:58.024845 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-21 02:39:58.430498 | debian-bookworm | ok 2026-07-21 02:39:58.435757 | 2026-07-21 02:39:58.435862 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-21 02:39:58.469674 | debian-bookworm | skipping: Conditional result was False 2026-07-21 02:39:58.480167 | 2026-07-21 02:39:58.480287 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-21 02:39:58.901671 | debian-bookworm | ok 2026-07-21 02:39:58.912300 | 2026-07-21 02:39:58.912411 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-21 02:39:58.939393 | debian-bookworm | ok 2026-07-21 02:39:58.948077 | 2026-07-21 02:39:58.948183 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-21 02:39:59.277326 | debian-bookworm -> localhost | ok 2026-07-21 02:39:59.282513 | 2026-07-21 02:39:59.282599 | TASK [validate-host : Collect information about the host] 2026-07-21 02:40:00.381282 | debian-bookworm | ok 2026-07-21 02:40:00.411769 | 2026-07-21 02:40:00.411897 | TASK [validate-host : Sanitize hostname] 2026-07-21 02:40:00.530191 | debian-bookworm | ok 2026-07-21 02:40:00.534993 | 2026-07-21 02:40:00.535089 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-21 02:40:00.993306 | debian-bookworm -> localhost | changed 2026-07-21 02:40:00.998981 | 2026-07-21 02:40:00.999089 | TASK [validate-host : Collect information about zuul worker] 2026-07-21 02:40:01.407099 | debian-bookworm | ok 2026-07-21 02:40:01.413820 | 2026-07-21 02:40:01.413922 | TASK [validate-host : Write out all zuul information for each host] 2026-07-21 02:40:01.987437 | debian-bookworm -> localhost | changed 2026-07-21 02:40:01.997326 | 2026-07-21 02:40:01.997430 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-21 02:40:02.287279 | debian-bookworm | ok 2026-07-21 02:40:02.292719 | 2026-07-21 02:40:02.292818 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-21 02:40:03.453196 | debian-bookworm | changed: 2026-07-21 02:40:03.453639 | debian-bookworm | cd+++++++++ src/ 2026-07-21 02:40:03.453686 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-21 02:40:03.453712 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-21 02:40:03.453733 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-07-21 02:40:03.453754 | debian-bookworm | =7.0.3 2026-07-21 02:40:39.544988 | debian-bookworm | Downloading cachetools-7.1.4-py3-none-any.whl (16 kB) 2026-07-21 02:40:39.582678 | debian-bookworm | Collecting colorama>=0.4.6 2026-07-21 02:40:39.592957 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-07-21 02:40:39.654960 | debian-bookworm | Collecting filelock>=3.25 2026-07-21 02:40:39.665236 | debian-bookworm | Downloading filelock-3.31.1-py3-none-any.whl (97 kB) 2026-07-21 02:40:39.683796 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 97.2/97.2 kB 6.5 MB/s eta 0:00:00 2026-07-21 02:40:39.741155 | debian-bookworm | Collecting packaging>=26 2026-07-21 02:40:39.751448 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-07-21 02:40:39.766756 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 7.2 MB/s eta 0:00:00 2026-07-21 02:40:39.815050 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-07-21 02:40:39.825362 | debian-bookworm | Downloading platformdirs-4.10.1-py3-none-any.whl (22 kB) 2026-07-21 02:40:39.875925 | debian-bookworm | Collecting pluggy>=1.6 2026-07-21 02:40:39.886531 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-07-21 02:40:39.930401 | debian-bookworm | Collecting pyproject-api>=1.10 2026-07-21 02:40:39.941533 | debian-bookworm | Downloading pyproject_api-1.10.1-py3-none-any.whl (12 kB) 2026-07-21 02:40:39.974609 | debian-bookworm | Collecting python-discovery>=1.4.4 2026-07-21 02:40:39.984795 | debian-bookworm | Downloading python_discovery-1.4.4-py3-none-any.whl (34 kB) 2026-07-21 02:40:40.016023 | debian-bookworm | Collecting tomli-w>=1.2 2026-07-21 02:40:40.026504 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-07-21 02:40:40.159927 | debian-bookworm | Collecting virtualenv>=21.1 2026-07-21 02:40:40.170156 | debian-bookworm | Downloading virtualenv-21.6.1-py3-none-any.whl (5.5 MB) 2026-07-21 02:40:40.501209 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.5/5.5 MB 16.8 MB/s eta 0:00:00 2026-07-21 02:40:40.623328 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-07-21 02:40:40.633678 | debian-bookworm | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-07-21 02:40:40.655242 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.6/470.6 kB 24.8 MB/s eta 0:00:00 2026-07-21 02:40:40.760415 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-07-21 02:40:41.500191 | 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.2 virtualenv-21.6.1 2026-07-21 02:40:41.966085 | debian-bookworm | ok: Runtime: 0:00:02.849573 2026-07-21 02:40:41.978039 | 2026-07-21 02:40:41.978223 | TASK [ensure-tox : Export installed tox_executable path] 2026-07-21 02:40:42.021521 | debian-bookworm | ok 2026-07-21 02:40:42.026540 | 2026-07-21 02:40:42.026649 | TASK [ensure-tox : Output tox version] 2026-07-21 02:40:42.501054 | 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-21 02:40:42.514606 | debian-bookworm | 4.57.2 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-21 02:40:42.589965 | debian-bookworm | ok: Runtime: 0:00:00.257428 2026-07-21 02:40:42.597077 | 2026-07-21 02:40:42.597253 | TASK [ensure-tox : Make global symlink] 2026-07-21 02:40:42.621789 | debian-bookworm | skipping: Conditional result was False 2026-07-21 02:40:42.629304 | 2026-07-21 02:40:42.629385 | PLAY RECAP 2026-07-21 02:40:42.629441 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-07-21 02:40:42.629467 | 2026-07-21 02:40:42.780819 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-07-21 02:40:42.783275 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-07-21 02:40:43.640563 | 2026-07-21 02:40:43.640744 | PLAY [all] 2026-07-21 02:40:43.657118 | 2026-07-21 02:40:43.657327 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-07-21 02:40:44.103979 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-07-21 02:40:44.193177 | debian-bookworm | ok: Runtime: 0:00:00.023978 2026-07-21 02:40:44.206893 | 2026-07-21 02:40:44.207094 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-07-21 02:40:44.739098 | debian-bookworm | ok: Runtime: 0:00:00.006113 2026-07-21 02:40:44.745618 | 2026-07-21 02:40:44.745751 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-07-21 02:40:45.028832 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-07-21 02:40:45.030044 | debian-bookworm | sudo: a password is required 2026-07-21 02:40:45.275176 | debian-bookworm | ok: Runtime: 0:00:00.015303 2026-07-21 02:40:45.295184 | 2026-07-21 02:40:45.295362 | TASK [tox : Check to see if the constraints file exists] 2026-07-21 02:40:45.322305 | debian-bookworm | skipping: Conditional result was False 2026-07-21 02:40:45.340282 | 2026-07-21 02:40:45.340522 | TASK [tox : Fail if constraints file is missing] 2026-07-21 02:40:45.376316 | debian-bookworm | skipping: Conditional result was False 2026-07-21 02:40:45.389985 | 2026-07-21 02:40:45.390203 | TASK [tox : Record file location] 2026-07-21 02:40:45.416147 | debian-bookworm | skipping: Conditional result was False 2026-07-21 02:40:45.428836 | 2026-07-21 02:40:45.428995 | TASK [tox : Install tox siblings] 2026-07-21 02:40:45.473064 | debian-bookworm | ok 2026-07-21 02:40:45.487683 | debian-bookworm | included: /var/lib/zuul/builds/fb303296722d4ea5a0ba28a6e9bbbf40/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-07-21 02:40:45.493952 | 2026-07-21 02:40:45.494066 | TASK [tox : Run tox without tests] 2026-07-21 02:40:46.674428 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-07-21 02:40:59.090481 | debian-bookworm | test: OK (13.06 seconds) 2026-07-21 02:40:59.090542 | debian-bookworm | congratulations :) (13.09 seconds) 2026-07-21 02:40:59.532270 | debian-bookworm | ok: Runtime: 0:00:13.353951 2026-07-21 02:40:59.544511 | 2026-07-21 02:40:59.544686 | TASK [tox : Create a tempfile to save tox showconfig] 2026-07-21 02:40:59.994480 | debian-bookworm | changed 2026-07-21 02:41:00.002686 | 2026-07-21 02:41:00.002873 | TASK [tox : Detect tox version] 2026-07-21 02:41:00.522253 | debian-bookworm | 4.57.2 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-21 02:41:01.036146 | debian-bookworm | ok: Runtime: 0:00:00.282483 2026-07-21 02:41:01.042676 | 2026-07-21 02:41:01.042815 | TASK [tox : Get tox envlist config] 2026-07-21 02:41:02.080763 | debian-bookworm | ok: Runtime: 0:00:00.368816 2026-07-21 02:41:02.094654 | 2026-07-21 02:41:02.094879 | TASK [tox : Install any sibling python packages] 2026-07-21 02:41:02.563248 | debian-bookworm | ok: No setup.cfg, no action needed 2026-07-21 02:41:02.572808 | 2026-07-21 02:41:02.573099 | TASK [tox : Remove tempfile] 2026-07-21 02:41:03.035488 | debian-bookworm | changed 2026-07-21 02:41:03.041048 | 2026-07-21 02:41:03.041197 | TASK [tox : Emit tox command] 2026-07-21 02:41:03.095688 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-07-21 02:41:03.105403 | 2026-07-21 02:41:03.105562 | TASK [tox : Run tox] 2026-07-21 02:41:03.679997 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-07-21 02:41:05.412457 | debian-bookworm | ............................................. 2026-07-21 02:41:05.412512 | debian-bookworm | ---------------------------------------------------------------------- 2026-07-21 02:41:05.412521 | debian-bookworm | Ran 45 tests in 1.316s 2026-07-21 02:41:05.412525 | debian-bookworm | 2026-07-21 02:41:05.412531 | debian-bookworm | OK 2026-07-21 02:41:05.499810 | debian-bookworm | test: OK (1.86=setup[0.04]+cmd[1.82] seconds) 2026-07-21 02:41:05.499875 | debian-bookworm | congratulations :) (1.89 seconds) 2026-07-21 02:41:05.638020 | debian-bookworm | ok: Runtime: 0:00:02.176675 2026-07-21 02:41:05.652569 | 2026-07-21 02:41:05.652741 | TASK [tox : Look for output] 2026-07-21 02:41:06.070894 | debian-bookworm | ok 2026-07-21 02:41:06.096565 | 2026-07-21 02:41:06.096806 | TASK [tox : Return file comments to Zuul] 2026-07-21 02:41:06.144149 | debian-bookworm | skipping: Conditional result was False 2026-07-21 02:41:06.155207 | 2026-07-21 02:41:06.155322 | PLAY RECAP 2026-07-21 02:41:06.155389 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-07-21 02:41:06.155418 | 2026-07-21 02:41:06.319819 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-07-21 02:41:06.321049 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-07-21 02:41:07.131562 | 2026-07-21 02:41:07.131758 | PLAY [all] 2026-07-21 02:41:07.148365 | 2026-07-21 02:41:07.148528 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-07-21 02:41:07.194430 | debian-bookworm | skipping: Conditional result was False 2026-07-21 02:41:07.201819 | 2026-07-21 02:41:07.202005 | TASK [fetch-tox-output : Set tox log path for single node] 2026-07-21 02:41:07.245584 | debian-bookworm | ok 2026-07-21 02:41:07.252609 | 2026-07-21 02:41:07.252757 | TASK [fetch-tox-output : Ensure local tox dir] 2026-07-21 02:41:07.775255 | debian-bookworm -> localhost | changed 2026-07-21 02:41:07.783658 | 2026-07-21 02:41:07.783803 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-07-21 02:41:07.828104 | debian-bookworm | skipping: Conditional result was False 2026-07-21 02:41:07.834776 | 2026-07-21 02:41:07.834965 | TASK [fetch-tox-output : Set envlist fact] 2026-07-21 02:41:07.874752 | debian-bookworm | ok 2026-07-21 02:41:07.881490 | 2026-07-21 02:41:07.881608 | TASK [fetch-tox-output : Get tox version] 2026-07-21 02:41:08.611161 | 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-21 02:41:08.628290 | debian-bookworm | 4.57.2 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-21 02:41:08.914529 | debian-bookworm | ok: Runtime: 0:00:00.321038 2026-07-21 02:41:08.921389 | 2026-07-21 02:41:08.921518 | TASK [fetch-tox-output : Find all default environments] 2026-07-21 02:41:09.458186 | debian-bookworm | skipping: Conditional result was False 2026-07-21 02:41:09.468311 | 2026-07-21 02:41:09.468506 | TASK [fetch-tox-output : Set envlist fact] 2026-07-21 02:41:09.504150 | debian-bookworm | skipping: Conditional result was False 2026-07-21 02:41:09.510403 | 2026-07-21 02:41:09.510568 | TASK [fetch-tox-output : Find all default environments] 2026-07-21 02:41:10.042574 | debian-bookworm | skipping: Conditional result was False 2026-07-21 02:41:10.056461 | 2026-07-21 02:41:10.056684 | TASK [fetch-tox-output : Set envlist fact] 2026-07-21 02:41:10.103831 | debian-bookworm | skipping: Conditional result was False 2026-07-21 02:41:10.112518 | 2026-07-21 02:41:10.112660 | LOOP [fetch-tox-output : Copy tox logs] 2026-07-21 02:41:10.163972 | debian-bookworm | skipping: Conditional result was False 2026-07-21 02:41:10.175496 | 2026-07-21 02:41:10.175655 | LOOP [fetch-tox-output : Collect tox logs] 2026-07-21 02:41:10.989201 | debian-bookworm | changed: 2026-07-21 02:41:10.989421 | debian-bookworm | created directory /var/lib/zuul/builds/fb303296722d4ea5a0ba28a6e9bbbf40/work/logs/tox/test 2026-07-21 02:41:10.989456 | debian-bookworm | cd+++++++++ ./ 2026-07-21 02:41:10.989483 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-07-21 02:41:10.989516 | 2026-07-21 02:41:11.005381 | 2026-07-21 02:41:11.005520 | PLAY RECAP 2026-07-21 02:41:11.005579 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-07-21 02:41:11.005606 | 2026-07-21 02:41:11.181922 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-07-21 02:41:11.184757 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-07-21 02:41:12.073431 | 2026-07-21 02:41:12.073627 | PLAY [all] 2026-07-21 02:41:12.093347 | 2026-07-21 02:41:12.093520 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-07-21 02:41:12.325389 | debian-bookworm | changed: non-zero return code 2026-07-21 02:41:12.333381 | 2026-07-21 02:41:12.333586 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-07-21 02:41:12.358583 | debian-bookworm | skipping: Conditional result was False 2026-07-21 02:41:12.365069 | 2026-07-21 02:41:12.365227 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-07-21 02:41:12.397979 | 2026-07-21 02:41:12.398258 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-07-21 02:41:12.430598 | 2026-07-21 02:41:12.430851 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-07-21 02:41:12.455524 | debian-bookworm | skipping: Conditional result was False 2026-07-21 02:41:12.462330 | 2026-07-21 02:41:12.462498 | LOOP [fetch-subunit-output : Generate subunit file] 2026-07-21 02:41:12.493059 | 2026-07-21 02:41:12.493321 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-07-21 02:41:12.517535 | debian-bookworm | skipping: Conditional result was False 2026-07-21 02:41:12.524248 | 2026-07-21 02:41:12.524399 | TASK [fetch-subunit-output : Remove the temporary file] 2026-07-21 02:41:12.548758 | debian-bookworm | skipping: Conditional result was False 2026-07-21 02:41:12.555992 | 2026-07-21 02:41:12.556177 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-07-21 02:41:12.581858 | debian-bookworm | skipping: Conditional result was False 2026-07-21 02:41:12.599060 | 2026-07-21 02:41:12.599205 | PLAY RECAP 2026-07-21 02:41:12.599268 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-07-21 02:41:12.599294 | 2026-07-21 02:41:12.759317 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-07-21 02:41:12.760515 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-21 02:41:13.637114 | 2026-07-21 02:41:13.637331 | PLAY [Base post-fetch] 2026-07-21 02:41:13.652434 | 2026-07-21 02:41:13.652606 | TASK [diagnose-network : Ensure log directory exists] 2026-07-21 02:41:14.027577 | debian-bookworm | ok 2026-07-21 02:41:14.036156 | 2026-07-21 02:41:14.036373 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-07-21 02:41:25.767673 | debian-bookworm | ok: Runtime: 0:00:05.971013 2026-07-21 02:41:25.775370 | 2026-07-21 02:41:25.775504 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-07-21 02:41:31.805233 | debian-bookworm | ok: Runtime: 0:00:00.007659 2026-07-21 02:41:31.815381 | 2026-07-21 02:41:31.815606 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-07-21 02:41:37.836774 | debian-bookworm | ok: Runtime: 0:00:00.009167 2026-07-21 02:41:37.847240 | 2026-07-21 02:41:37.847374 | TASK [fetch-output : Set log path for multiple nodes] 2026-07-21 02:41:37.913095 | debian-bookworm | skipping: Conditional result was False 2026-07-21 02:41:37.922797 | 2026-07-21 02:41:37.923013 | TASK [fetch-output : Set log path for single node] 2026-07-21 02:41:37.968005 | debian-bookworm | ok 2026-07-21 02:41:37.973377 | 2026-07-21 02:41:37.973515 | LOOP [fetch-output : Ensure local output dirs] 2026-07-21 02:41:38.283462 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/fb303296722d4ea5a0ba28a6e9bbbf40/work/logs" 2026-07-21 02:41:38.545973 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/fb303296722d4ea5a0ba28a6e9bbbf40/work/artifacts" 2026-07-21 02:41:38.829166 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/fb303296722d4ea5a0ba28a6e9bbbf40/work/docs" 2026-07-21 02:41:38.844358 | 2026-07-21 02:41:38.844531 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-21 02:41:39.625760 | debian-bookworm | changed: 2026-07-21 02:41:39.626000 | debian-bookworm | .d..t...... ./ 2026-07-21 02:41:39.626035 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-21 02:41:39.626059 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-21 02:41:39.626079 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-21 02:41:39.626100 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-21 02:41:39.626161 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-21 02:41:39.626212 | debian-bookworm | changed: All items complete 2026-07-21 02:41:39.626237 | 2026-07-21 02:41:40.231387 | debian-bookworm | changed: .d..t...... ./ 2026-07-21 02:41:40.818994 | debian-bookworm | changed: .d..t...... ./ 2026-07-21 02:41:40.848361 | 2026-07-21 02:41:40.848546 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-21 02:41:41.190630 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.011011 2026-07-21 02:41:41.480301 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.011415 2026-07-21 02:41:41.506507 | 2026-07-21 02:41:41.506732 | PLAY RECAP 2026-07-21 02:41:41.506898 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-07-21 02:41:41.506969 | 2026-07-21 02:41:41.660601 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-21 02:41:41.663741 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-21 02:41:42.438395 | 2026-07-21 02:41:42.438595 | PLAY [Base post] 2026-07-21 02:41:42.456375 | 2026-07-21 02:41:42.456552 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-21 02:41:43.030161 | debian-bookworm | changed 2026-07-21 02:41:43.039339 | 2026-07-21 02:41:43.039481 | PLAY RECAP 2026-07-21 02:41:43.039561 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-21 02:41:43.039635 | 2026-07-21 02:41:43.182102 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-21 02:41:43.185356 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-21 02:41:44.027857 | 2026-07-21 02:41:44.028049 | PLAY [Base post-logs] 2026-07-21 02:41:44.039834 | 2026-07-21 02:41:44.040009 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-21 02:41:44.566706 | localhost | changed 2026-07-21 02:41:44.585168 | 2026-07-21 02:41:44.585384 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-21 02:41:44.625840 | localhost | ok 2026-07-21 02:41:44.634716 | 2026-07-21 02:41:44.634932 | TASK [Set zuul-log-path fact] 2026-07-21 02:41:44.655529 | localhost | ok 2026-07-21 02:41:44.675607 | 2026-07-21 02:41:44.675851 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-21 02:41:44.715290 | localhost | ok 2026-07-21 02:41:44.721660 | 2026-07-21 02:41:44.721816 | TASK [upload-logs : Create log directories] 2026-07-21 02:41:45.243983 | localhost | changed 2026-07-21 02:41:45.249297 | 2026-07-21 02:41:45.249480 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-21 02:41:45.753558 | localhost -> localhost | ok: Runtime: 0:00:00.007846 2026-07-21 02:41:45.763030 | 2026-07-21 02:41:45.763309 | TASK [upload-logs : Upload logs to log server] 2026-07-21 02:41:46.381050 | localhost | Output suppressed because no_log was given 2026-07-21 02:41:46.385163 | 2026-07-21 02:41:46.385377 | LOOP [upload-logs : Compress console log and json output] 2026-07-21 02:41:46.452352 | localhost | skipping: Conditional result was False 2026-07-21 02:41:46.456965 | localhost | skipping: Conditional result was False 2026-07-21 02:41:46.469216 | 2026-07-21 02:41:46.469500 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-21 02:41:46.530192 | localhost | skipping: Conditional result was False 2026-07-21 02:41:46.530921 | 2026-07-21 02:41:46.534285 | localhost | skipping: Conditional result was False 2026-07-21 02:41:46.543953 | 2026-07-21 02:41:46.544351 | LOOP [upload-logs : Upload console log and json output]