2026-06-27 18:41:48.154799 | Job console starting 2026-06-27 18:41:48.180851 | Updating git repos 2026-06-27 18:41:48.243403 | Cloning repos into workspace 2026-06-27 18:41:48.327989 | Restoring repo states 2026-06-27 18:41:48.363205 | Merging changes 2026-06-27 18:41:49.062950 | Checking out repos 2026-06-27 18:41:49.111994 | Preparing playbooks 2026-06-27 18:41:50.270819 | Running Ansible setup 2026-06-27 18:41:55.738506 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-06-27 18:41:57.213751 | 2026-06-27 18:41:57.213936 | PLAY [Base pre] 2026-06-27 18:41:57.254682 | 2026-06-27 18:41:57.258122 | TASK [Setup log path fact] 2026-06-27 18:41:57.308306 | debian-bookworm | ok 2026-06-27 18:41:57.337483 | 2026-06-27 18:41:57.337650 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-27 18:41:57.387381 | debian-bookworm | ok 2026-06-27 18:41:57.406771 | 2026-06-27 18:41:57.406947 | TASK [emit-job-header : Print job information] 2026-06-27 18:41:57.473166 | # Job Information 2026-06-27 18:41:57.473416 | Ansible Version: 2.16.14 2026-06-27 18:41:57.473453 | Job: tox 2026-06-27 18:41:57.473483 | Pipeline: check 2026-06-27 18:41:57.473506 | Executor: 521e9411259a 2026-06-27 18:41:57.473527 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1244 2026-06-27 18:41:57.473549 | Event ID: d4afd390-7257-11f1-937e-a967bcd30b3e 2026-06-27 18:41:57.479662 | 2026-06-27 18:41:57.479812 | LOOP [emit-job-header : Print node information] 2026-06-27 18:41:57.653876 | debian-bookworm | ok: 2026-06-27 18:41:57.654168 | debian-bookworm | # Node Information 2026-06-27 18:41:57.654207 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-06-27 18:41:57.654233 | debian-bookworm | Hostname: debian 2026-06-27 18:41:57.654256 | debian-bookworm | Username: zuul 2026-06-27 18:41:57.654277 | debian-bookworm | Distro: Debian 12.14 2026-06-27 18:41:57.654305 | debian-bookworm | Provider: regiocloud-a 2026-06-27 18:41:57.654328 | debian-bookworm | Region: 2026-06-27 18:41:57.654350 | debian-bookworm | Label: debian-bookworm 2026-06-27 18:41:57.654369 | debian-bookworm | Product Name: OpenStack Nova 2026-06-27 18:41:57.654389 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe6a:c262 2026-06-27 18:41:57.670572 | 2026-06-27 18:41:57.670713 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-06-27 18:41:58.607821 | debian-bookworm -> localhost | changed 2026-06-27 18:41:58.615480 | 2026-06-27 18:41:58.615622 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-06-27 18:42:00.192178 | debian-bookworm -> localhost | changed 2026-06-27 18:42:00.206131 | 2026-06-27 18:42:00.206265 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-06-27 18:42:00.689646 | debian-bookworm -> localhost | ok 2026-06-27 18:42:00.696084 | 2026-06-27 18:42:00.696213 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-06-27 18:42:00.736084 | debian-bookworm | ok 2026-06-27 18:42:00.760904 | debian-bookworm | included: /var/lib/zuul/builds/289995f9f381408489c09f1f4de945bf/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-06-27 18:42:00.783912 | 2026-06-27 18:42:00.784069 | TASK [add-build-sshkey : Create Temp SSH key] 2026-06-27 18:42:03.625526 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-06-27 18:42:03.625854 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/289995f9f381408489c09f1f4de945bf/work/289995f9f381408489c09f1f4de945bf_id_rsa 2026-06-27 18:42:03.625915 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/289995f9f381408489c09f1f4de945bf/work/289995f9f381408489c09f1f4de945bf_id_rsa.pub 2026-06-27 18:42:03.625954 | debian-bookworm -> localhost | The key fingerprint is: 2026-06-27 18:42:03.625992 | debian-bookworm -> localhost | SHA256:TpKl57VUQ3cVXy7vCoEraOFzqrlCy6HgqFuguNukEuo zuul-build-sshkey 2026-06-27 18:42:03.626043 | debian-bookworm -> localhost | The key's randomart image is: 2026-06-27 18:42:03.626089 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-06-27 18:42:03.626121 | debian-bookworm -> localhost | | . ..*| 2026-06-27 18:42:03.626152 | debian-bookworm -> localhost | | . . oo| 2026-06-27 18:42:03.626181 | debian-bookworm -> localhost | | . o . o| 2026-06-27 18:42:03.626209 | debian-bookworm -> localhost | | + o . o | 2026-06-27 18:42:03.626238 | debian-bookworm -> localhost | |. = S + . .| 2026-06-27 18:42:03.626272 | debian-bookworm -> localhost | |=.o . O o o . . | 2026-06-27 18:42:03.626302 | debian-bookworm -> localhost | |B=oo = = o . .| 2026-06-27 18:42:03.626329 | debian-bookworm -> localhost | |=B+ o + . . . | 2026-06-27 18:42:03.626359 | debian-bookworm -> localhost | |XE..+o. . | 2026-06-27 18:42:03.626395 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-06-27 18:42:03.626465 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.795594 2026-06-27 18:42:03.637986 | 2026-06-27 18:42:03.638153 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-06-27 18:42:03.664613 | debian-bookworm | ok 2026-06-27 18:42:03.678484 | debian-bookworm | included: /var/lib/zuul/builds/289995f9f381408489c09f1f4de945bf/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-06-27 18:42:03.687086 | 2026-06-27 18:42:03.687197 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-06-27 18:42:03.721114 | debian-bookworm | skipping: Conditional result was False 2026-06-27 18:42:03.728560 | 2026-06-27 18:42:03.728671 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-06-27 18:42:04.415277 | debian-bookworm | changed 2026-06-27 18:42:04.425902 | 2026-06-27 18:42:04.426137 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-06-27 18:42:04.704473 | debian-bookworm | ok 2026-06-27 18:42:04.713857 | 2026-06-27 18:42:04.713999 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-06-27 18:42:05.377537 | debian-bookworm | changed 2026-06-27 18:42:05.383531 | 2026-06-27 18:42:05.383664 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-06-27 18:42:06.047004 | debian-bookworm | changed 2026-06-27 18:42:06.052997 | 2026-06-27 18:42:06.053145 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-06-27 18:42:06.097271 | debian-bookworm | skipping: Conditional result was False 2026-06-27 18:42:06.104518 | 2026-06-27 18:42:06.104654 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-06-27 18:42:06.842588 | debian-bookworm -> localhost | changed 2026-06-27 18:42:06.864054 | 2026-06-27 18:42:06.864231 | TASK [add-build-sshkey : Add back temp key] 2026-06-27 18:42:07.355532 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/289995f9f381408489c09f1f4de945bf/work/289995f9f381408489c09f1f4de945bf_id_rsa (zuul-build-sshkey) 2026-06-27 18:42:07.355793 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.011782 2026-06-27 18:42:07.364418 | 2026-06-27 18:42:07.364566 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-06-27 18:42:07.900898 | debian-bookworm | ok 2026-06-27 18:42:07.906589 | 2026-06-27 18:42:07.906719 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-06-27 18:42:07.967036 | debian-bookworm | skipping: Conditional result was False 2026-06-27 18:42:07.978423 | 2026-06-27 18:42:07.978568 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-06-27 18:42:08.444465 | debian-bookworm | ok 2026-06-27 18:42:08.459211 | 2026-06-27 18:42:08.459357 | TASK [validate-host : Define zuul_info_dir fact] 2026-06-27 18:42:08.501468 | debian-bookworm | ok 2026-06-27 18:42:08.509216 | 2026-06-27 18:42:08.509350 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-06-27 18:42:08.808938 | debian-bookworm -> localhost | ok 2026-06-27 18:42:08.816104 | 2026-06-27 18:42:08.816233 | TASK [validate-host : Collect information about the host] 2026-06-27 18:42:09.975702 | debian-bookworm | ok 2026-06-27 18:42:09.989450 | 2026-06-27 18:42:09.989594 | TASK [validate-host : Sanitize hostname] 2026-06-27 18:42:10.143727 | debian-bookworm | ok 2026-06-27 18:42:10.149029 | 2026-06-27 18:42:10.149150 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-06-27 18:42:10.771159 | debian-bookworm -> localhost | changed 2026-06-27 18:42:10.777296 | 2026-06-27 18:42:10.777420 | TASK [validate-host : Collect information about zuul worker] 2026-06-27 18:42:11.271986 | debian-bookworm | ok 2026-06-27 18:42:11.279219 | 2026-06-27 18:42:11.279416 | TASK [validate-host : Write out all zuul information for each host] 2026-06-27 18:42:11.892991 | debian-bookworm -> localhost | changed 2026-06-27 18:42:11.906499 | 2026-06-27 18:42:11.906648 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-06-27 18:42:12.180228 | debian-bookworm | ok 2026-06-27 18:42:12.185995 | 2026-06-27 18:42:12.186129 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-06-27 18:42:13.070135 | debian-bookworm | changed: 2026-06-27 18:42:13.070374 | debian-bookworm | cd+++++++++ src/ 2026-06-27 18:42:13.070414 | debian-bookworm | cd+++++++++ src/github.com/ 2026-06-27 18:42:13.070440 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-06-27 18:42:13.070465 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-06-27 18:42:13.072355 | debian-bookworm | =7.0.3 2026-06-27 18:42:49.198835 | debian-bookworm | Downloading cachetools-7.1.4-py3-none-any.whl (16 kB) 2026-06-27 18:42:49.254432 | debian-bookworm | Collecting colorama>=0.4.6 2026-06-27 18:42:49.270773 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-06-27 18:42:49.355574 | debian-bookworm | Collecting filelock>=3.25 2026-06-27 18:42:49.370127 | debian-bookworm | Downloading filelock-3.29.4-py3-none-any.whl (42 kB) 2026-06-27 18:42:49.377936 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 42.8/42.8 kB 6.8 MB/s eta 0:00:00 2026-06-27 18:42:49.436976 | debian-bookworm | Collecting packaging>=26 2026-06-27 18:42:49.451623 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-06-27 18:42:49.461705 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 17.0 MB/s eta 0:00:00 2026-06-27 18:42:49.524143 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-06-27 18:42:49.539184 | debian-bookworm | Downloading platformdirs-4.10.0-py3-none-any.whl (22 kB) 2026-06-27 18:42:49.578146 | debian-bookworm | Collecting pluggy>=1.6 2026-06-27 18:42:49.592930 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-06-27 18:42:49.632045 | debian-bookworm | Collecting pyproject-api>=1.10 2026-06-27 18:42:49.648375 | debian-bookworm | Downloading pyproject_api-1.10.1-py3-none-any.whl (12 kB) 2026-06-27 18:42:49.701324 | debian-bookworm | Collecting python-discovery>=1.2.2 2026-06-27 18:42:49.718668 | debian-bookworm | Downloading python_discovery-1.4.2-py3-none-any.whl (33 kB) 2026-06-27 18:42:49.758384 | debian-bookworm | Collecting tomli-w>=1.2 2026-06-27 18:42:49.772595 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-06-27 18:42:49.939733 | debian-bookworm | Collecting virtualenv>=21.1 2026-06-27 18:42:49.955917 | debian-bookworm | Downloading virtualenv-21.5.1-py3-none-any.whl (4.6 MB) 2026-06-27 18:42:50.060106 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.6/4.6 MB 45.5 MB/s eta 0:00:00 2026-06-27 18:42:50.155361 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-06-27 18:42:50.172547 | debian-bookworm | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-06-27 18:42:50.189781 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.6/470.6 kB 34.3 MB/s eta 0:00:00 2026-06-27 18:42:50.302353 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-06-27 18:42:51.066111 | 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-27 18:42:51.531023 | debian-bookworm | ok: Runtime: 0:00:02.898015 2026-06-27 18:42:51.537243 | 2026-06-27 18:42:51.537355 | TASK [ensure-tox : Export installed tox_executable path] 2026-06-27 18:42:51.595414 | debian-bookworm | ok 2026-06-27 18:42:51.604162 | 2026-06-27 18:42:51.604330 | TASK [ensure-tox : Output tox version] 2026-06-27 18:42:52.127115 | 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-27 18:42:52.144841 | debian-bookworm | 4.56.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-06-27 18:42:52.635937 | debian-bookworm | ok: Runtime: 0:00:00.324011 2026-06-27 18:42:52.641776 | 2026-06-27 18:42:52.641884 | TASK [ensure-tox : Make global symlink] 2026-06-27 18:42:52.666450 | debian-bookworm | skipping: Conditional result was False 2026-06-27 18:42:52.681972 | 2026-06-27 18:42:52.682249 | PLAY RECAP 2026-06-27 18:42:52.682341 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-06-27 18:42:52.682378 | 2026-06-27 18:42:52.821285 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-06-27 18:42:52.822970 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-06-27 18:42:53.588944 | 2026-06-27 18:42:53.589156 | PLAY [all] 2026-06-27 18:42:53.606255 | 2026-06-27 18:42:53.606455 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-06-27 18:42:54.081611 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-06-27 18:42:54.149314 | debian-bookworm | ok: Runtime: 0:00:00.030575 2026-06-27 18:42:54.161275 | 2026-06-27 18:42:54.161437 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-06-27 18:42:54.691098 | debian-bookworm | ok: Runtime: 0:00:00.006946 2026-06-27 18:42:54.707870 | 2026-06-27 18:42:54.708141 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-06-27 18:42:55.027121 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-06-27 18:42:55.028579 | debian-bookworm | sudo: a password is required 2026-06-27 18:42:55.260859 | debian-bookworm | ok: Runtime: 0:00:00.018411 2026-06-27 18:42:55.280436 | 2026-06-27 18:42:55.280570 | TASK [tox : Check to see if the constraints file exists] 2026-06-27 18:42:55.315200 | debian-bookworm | skipping: Conditional result was False 2026-06-27 18:42:55.321447 | 2026-06-27 18:42:55.321575 | TASK [tox : Fail if constraints file is missing] 2026-06-27 18:42:55.346122 | debian-bookworm | skipping: Conditional result was False 2026-06-27 18:42:55.366825 | 2026-06-27 18:42:55.367078 | TASK [tox : Record file location] 2026-06-27 18:42:55.391755 | debian-bookworm | skipping: Conditional result was False 2026-06-27 18:42:55.398793 | 2026-06-27 18:42:55.398957 | TASK [tox : Install tox siblings] 2026-06-27 18:42:55.430330 | debian-bookworm | ok 2026-06-27 18:42:55.439556 | debian-bookworm | included: /var/lib/zuul/builds/289995f9f381408489c09f1f4de945bf/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-06-27 18:42:55.445403 | 2026-06-27 18:42:55.445528 | TASK [tox : Run tox without tests] 2026-06-27 18:42:56.744808 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-06-27 18:43:09.621724 | debian-bookworm | test: OK (13.62 seconds) 2026-06-27 18:43:09.621782 | debian-bookworm | congratulations :) (13.65 seconds) 2026-06-27 18:43:09.992726 | debian-bookworm | ok: Runtime: 0:00:13.944950 2026-06-27 18:43:10.007878 | 2026-06-27 18:43:10.008176 | TASK [tox : Create a tempfile to save tox showconfig] 2026-06-27 18:43:10.452399 | debian-bookworm | changed 2026-06-27 18:43:10.460405 | 2026-06-27 18:43:10.460550 | TASK [tox : Detect tox version] 2026-06-27 18:43:11.006377 | debian-bookworm | 4.56.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-06-27 18:43:11.494096 | debian-bookworm | ok: Runtime: 0:00:00.312805 2026-06-27 18:43:11.507799 | 2026-06-27 18:43:11.507983 | TASK [tox : Get tox envlist config] 2026-06-27 18:43:12.544158 | debian-bookworm | ok: Runtime: 0:00:00.357470 2026-06-27 18:43:12.556944 | 2026-06-27 18:43:12.557311 | TASK [tox : Install any sibling python packages] 2026-06-27 18:43:13.012303 | debian-bookworm | ok: No setup.cfg, no action needed 2026-06-27 18:43:13.021269 | 2026-06-27 18:43:13.021457 | TASK [tox : Remove tempfile] 2026-06-27 18:43:13.536339 | debian-bookworm | changed 2026-06-27 18:43:13.543380 | 2026-06-27 18:43:13.543511 | TASK [tox : Emit tox command] 2026-06-27 18:43:13.582680 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-06-27 18:43:13.587932 | 2026-06-27 18:43:13.588073 | TASK [tox : Run tox] 2026-06-27 18:43:14.193891 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-06-27 18:43:15.012408 | debian-bookworm | .......................... 2026-06-27 18:43:15.012458 | debian-bookworm | ---------------------------------------------------------------------- 2026-06-27 18:43:15.012470 | debian-bookworm | Ran 26 tests in 0.228s 2026-06-27 18:43:15.012476 | debian-bookworm | 2026-06-27 18:43:15.012482 | debian-bookworm | OK 2026-06-27 18:43:15.108252 | debian-bookworm | test: OK (0.96=setup[0.05]+cmd[0.91] seconds) 2026-06-27 18:43:15.108316 | debian-bookworm | congratulations :) (0.99 seconds) 2026-06-27 18:43:15.619792 | debian-bookworm | ok: Runtime: 0:00:01.299876 2026-06-27 18:43:15.625832 | 2026-06-27 18:43:15.625963 | TASK [tox : Look for output] 2026-06-27 18:43:16.052961 | debian-bookworm | ok 2026-06-27 18:43:16.067950 | 2026-06-27 18:43:16.068132 | TASK [tox : Return file comments to Zuul] 2026-06-27 18:43:16.109462 | debian-bookworm | skipping: Conditional result was False 2026-06-27 18:43:16.119098 | 2026-06-27 18:43:16.119225 | PLAY RECAP 2026-06-27 18:43:16.119287 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-06-27 18:43:16.119314 | 2026-06-27 18:43:16.318210 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-06-27 18:43:16.319983 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-06-27 18:43:17.110701 | 2026-06-27 18:43:17.110928 | PLAY [all] 2026-06-27 18:43:17.127866 | 2026-06-27 18:43:17.128058 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-06-27 18:43:17.183718 | debian-bookworm | skipping: Conditional result was False 2026-06-27 18:43:17.193751 | 2026-06-27 18:43:17.193937 | TASK [fetch-tox-output : Set tox log path for single node] 2026-06-27 18:43:17.234157 | debian-bookworm | ok 2026-06-27 18:43:17.240153 | 2026-06-27 18:43:17.240317 | TASK [fetch-tox-output : Ensure local tox dir] 2026-06-27 18:43:17.752235 | debian-bookworm -> localhost | changed 2026-06-27 18:43:17.760613 | 2026-06-27 18:43:17.760749 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-06-27 18:43:17.806698 | debian-bookworm | skipping: Conditional result was False 2026-06-27 18:43:17.813291 | 2026-06-27 18:43:17.813446 | TASK [fetch-tox-output : Set envlist fact] 2026-06-27 18:43:17.854908 | debian-bookworm | ok 2026-06-27 18:43:17.874313 | 2026-06-27 18:43:17.874458 | TASK [fetch-tox-output : Get tox version] 2026-06-27 18:43:18.582505 | 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-27 18:43:18.600134 | debian-bookworm | 4.56.1 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-06-27 18:43:18.908201 | debian-bookworm | ok: Runtime: 0:00:00.320306 2026-06-27 18:43:18.923340 | 2026-06-27 18:43:18.923512 | TASK [fetch-tox-output : Find all default environments] 2026-06-27 18:43:19.455258 | debian-bookworm | skipping: Conditional result was False 2026-06-27 18:43:19.462015 | 2026-06-27 18:43:19.462158 | TASK [fetch-tox-output : Set envlist fact] 2026-06-27 18:43:19.506501 | debian-bookworm | skipping: Conditional result was False 2026-06-27 18:43:19.512679 | 2026-06-27 18:43:19.512826 | TASK [fetch-tox-output : Find all default environments] 2026-06-27 18:43:20.053507 | debian-bookworm | skipping: Conditional result was False 2026-06-27 18:43:20.064276 | 2026-06-27 18:43:20.064477 | TASK [fetch-tox-output : Set envlist fact] 2026-06-27 18:43:20.090205 | debian-bookworm | skipping: Conditional result was False 2026-06-27 18:43:20.103791 | 2026-06-27 18:43:20.103969 | LOOP [fetch-tox-output : Copy tox logs] 2026-06-27 18:43:20.170322 | debian-bookworm | skipping: Conditional result was False 2026-06-27 18:43:20.186239 | 2026-06-27 18:43:20.186410 | LOOP [fetch-tox-output : Collect tox logs] 2026-06-27 18:43:21.054098 | debian-bookworm | changed: 2026-06-27 18:43:21.054307 | debian-bookworm | created directory /var/lib/zuul/builds/289995f9f381408489c09f1f4de945bf/work/logs/tox/test 2026-06-27 18:43:21.054343 | debian-bookworm | cd+++++++++ ./ 2026-06-27 18:43:21.054368 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-06-27 18:43:21.054400 | 2026-06-27 18:43:21.063073 | 2026-06-27 18:43:21.063313 | PLAY RECAP 2026-06-27 18:43:21.063381 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-06-27 18:43:21.063407 | 2026-06-27 18:43:21.272683 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-06-27 18:43:21.273815 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-06-27 18:43:22.078516 | 2026-06-27 18:43:22.078694 | PLAY [all] 2026-06-27 18:43:22.116245 | 2026-06-27 18:43:22.116482 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-06-27 18:43:22.336919 | debian-bookworm | changed: non-zero return code 2026-06-27 18:43:22.343671 | 2026-06-27 18:43:22.343831 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-06-27 18:43:22.368219 | debian-bookworm | skipping: Conditional result was False 2026-06-27 18:43:22.374464 | 2026-06-27 18:43:22.374594 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-06-27 18:43:22.404943 | 2026-06-27 18:43:22.405164 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-06-27 18:43:22.456555 | 2026-06-27 18:43:22.456772 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-06-27 18:43:22.506417 | debian-bookworm | skipping: Conditional result was False 2026-06-27 18:43:22.513194 | 2026-06-27 18:43:22.513336 | LOOP [fetch-subunit-output : Generate subunit file] 2026-06-27 18:43:22.563960 | 2026-06-27 18:43:22.564203 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-06-27 18:43:22.598219 | debian-bookworm | skipping: Conditional result was False 2026-06-27 18:43:22.605172 | 2026-06-27 18:43:22.605320 | TASK [fetch-subunit-output : Remove the temporary file] 2026-06-27 18:43:22.655244 | debian-bookworm | skipping: Conditional result was False 2026-06-27 18:43:22.661321 | 2026-06-27 18:43:22.661458 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-06-27 18:43:22.685662 | debian-bookworm | skipping: Conditional result was False 2026-06-27 18:43:22.693138 | 2026-06-27 18:43:22.693300 | PLAY RECAP 2026-06-27 18:43:22.693354 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-06-27 18:43:22.693379 | 2026-06-27 18:43:22.986868 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-06-27 18:43:22.987937 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-27 18:43:23.870318 | 2026-06-27 18:43:23.870486 | PLAY [Base post-fetch] 2026-06-27 18:43:23.893872 | 2026-06-27 18:43:23.894082 | TASK [diagnose-network : Ensure log directory exists] 2026-06-27 18:43:24.341981 | debian-bookworm | ok 2026-06-27 18:43:24.350366 | 2026-06-27 18:43:24.350548 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-06-27 18:43:36.114460 | debian-bookworm | ok: Runtime: 0:00:05.890600 2026-06-27 18:43:36.121746 | 2026-06-27 18:43:36.121963 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-06-27 18:43:42.158250 | debian-bookworm | ok: Runtime: 0:00:00.008859 2026-06-27 18:43:42.169312 | 2026-06-27 18:43:42.169542 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-06-27 18:43:48.216912 | debian-bookworm | ok: Runtime: 0:00:00.006750 2026-06-27 18:43:48.230409 | 2026-06-27 18:43:48.230551 | TASK [fetch-output : Set log path for multiple nodes] 2026-06-27 18:43:48.298201 | debian-bookworm | skipping: Conditional result was False 2026-06-27 18:43:48.312979 | 2026-06-27 18:43:48.313222 | TASK [fetch-output : Set log path for single node] 2026-06-27 18:43:48.361610 | debian-bookworm | ok 2026-06-27 18:43:48.368774 | 2026-06-27 18:43:48.368925 | LOOP [fetch-output : Ensure local output dirs] 2026-06-27 18:43:48.697612 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/289995f9f381408489c09f1f4de945bf/work/logs" 2026-06-27 18:43:48.975222 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/289995f9f381408489c09f1f4de945bf/work/artifacts" 2026-06-27 18:43:49.290876 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/289995f9f381408489c09f1f4de945bf/work/docs" 2026-06-27 18:43:49.309224 | 2026-06-27 18:43:49.309381 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-06-27 18:43:50.099754 | debian-bookworm | changed: 2026-06-27 18:43:50.100167 | debian-bookworm | .d..t...... ./ 2026-06-27 18:43:50.100230 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-06-27 18:43:50.100270 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-06-27 18:43:50.100305 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-06-27 18:43:50.100339 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-06-27 18:43:50.100373 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-06-27 18:43:50.100439 | debian-bookworm | changed: All items complete 2026-06-27 18:43:50.100481 | 2026-06-27 18:43:50.671157 | debian-bookworm | changed: .d..t...... ./ 2026-06-27 18:43:51.261366 | debian-bookworm | changed: .d..t...... ./ 2026-06-27 18:43:51.294407 | 2026-06-27 18:43:51.294591 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-06-27 18:43:51.659070 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.010276 2026-06-27 18:43:51.971257 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.010221 2026-06-27 18:43:51.986126 | 2026-06-27 18:43:51.986257 | PLAY RECAP 2026-06-27 18:43:51.986327 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-06-27 18:43:51.986361 | 2026-06-27 18:43:52.125604 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-06-27 18:43:52.128765 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-27 18:43:52.909996 | 2026-06-27 18:43:52.910187 | PLAY [Base post] 2026-06-27 18:43:52.924574 | 2026-06-27 18:43:52.924722 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-06-27 18:43:53.520049 | debian-bookworm | changed 2026-06-27 18:43:53.530653 | 2026-06-27 18:43:53.530823 | PLAY RECAP 2026-06-27 18:43:53.530962 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-06-27 18:43:53.531098 | 2026-06-27 18:43:53.660762 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-06-27 18:43:53.663949 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-06-27 18:43:54.542922 | 2026-06-27 18:43:54.543190 | PLAY [Base post-logs] 2026-06-27 18:43:54.554781 | 2026-06-27 18:43:54.554961 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-06-27 18:43:55.031603 | localhost | changed 2026-06-27 18:43:55.048617 | 2026-06-27 18:43:55.048816 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-06-27 18:43:55.086646 | localhost | ok 2026-06-27 18:43:55.091513 | 2026-06-27 18:43:55.091710 | TASK [Set zuul-log-path fact] 2026-06-27 18:43:55.121379 | localhost | ok 2026-06-27 18:43:55.140209 | 2026-06-27 18:43:55.140402 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-06-27 18:43:55.181734 | localhost | ok 2026-06-27 18:43:55.189419 | 2026-06-27 18:43:55.189603 | TASK [upload-logs : Create log directories] 2026-06-27 18:43:55.707934 | localhost | changed 2026-06-27 18:43:55.710821 | 2026-06-27 18:43:55.710994 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-06-27 18:43:56.222724 | localhost -> localhost | ok: Runtime: 0:00:00.005655 2026-06-27 18:43:56.231668 | 2026-06-27 18:43:56.231901 | TASK [upload-logs : Upload logs to log server] 2026-06-27 18:43:56.797196 | localhost | Output suppressed because no_log was given 2026-06-27 18:43:56.799412 | 2026-06-27 18:43:56.799537 | LOOP [upload-logs : Compress console log and json output] 2026-06-27 18:43:56.851607 | localhost | skipping: Conditional result was False 2026-06-27 18:43:56.857509 | localhost | skipping: Conditional result was False 2026-06-27 18:43:56.866576 | 2026-06-27 18:43:56.866706 | LOOP [upload-logs : Upload compressed console log and json output] 2026-06-27 18:43:56.915895 | localhost | skipping: Conditional result was False 2026-06-27 18:43:56.916237 | 2026-06-27 18:43:56.920900 | localhost | skipping: Conditional result was False 2026-06-27 18:43:56.928991 | 2026-06-27 18:43:56.929285 | LOOP [upload-logs : Upload console log and json output]