2026-07-19 02:26:18.281326 | Job console starting 2026-07-19 02:26:18.303594 | Updating git repos 2026-07-19 02:26:18.347492 | Cloning repos into workspace 2026-07-19 02:26:18.398461 | Restoring repo states 2026-07-19 02:26:18.417210 | Merging changes 2026-07-19 02:26:18.956431 | Checking out repos 2026-07-19 02:26:19.000320 | Preparing playbooks 2026-07-19 02:26:19.941676 | Running Ansible setup 2026-07-19 02:26:24.225874 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-19 02:26:25.071841 | 2026-07-19 02:26:25.072085 | PLAY [Base pre] 2026-07-19 02:26:25.091321 | 2026-07-19 02:26:25.091472 | TASK [Setup log path fact] 2026-07-19 02:26:25.122149 | debian-bookworm | ok 2026-07-19 02:26:25.140633 | 2026-07-19 02:26:25.140780 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-19 02:26:25.183941 | debian-bookworm | ok 2026-07-19 02:26:25.197492 | 2026-07-19 02:26:25.197614 | TASK [emit-job-header : Print job information] 2026-07-19 02:26:25.249073 | # Job Information 2026-07-19 02:26:25.249289 | Ansible Version: 2.16.14 2026-07-19 02:26:25.249325 | Job: tox 2026-07-19 02:26:25.249359 | Pipeline: check 2026-07-19 02:26:25.249383 | Executor: 521e9411259a 2026-07-19 02:26:25.249403 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1246 2026-07-19 02:26:25.249426 | Event ID: 1a85e680-8319-11f1-9ca1-383cd219969b 2026-07-19 02:26:25.254623 | 2026-07-19 02:26:25.254747 | LOOP [emit-job-header : Print node information] 2026-07-19 02:26:25.384508 | debian-bookworm | ok: 2026-07-19 02:26:25.384765 | debian-bookworm | # Node Information 2026-07-19 02:26:25.384810 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-19 02:26:25.384836 | debian-bookworm | Hostname: debian 2026-07-19 02:26:25.384868 | debian-bookworm | Username: zuul 2026-07-19 02:26:25.384888 | debian-bookworm | Distro: Debian 12.15 2026-07-19 02:26:25.384921 | debian-bookworm | Provider: regiocloud-a 2026-07-19 02:26:25.384951 | debian-bookworm | Region: 2026-07-19 02:26:25.384981 | debian-bookworm | Label: debian-bookworm 2026-07-19 02:26:25.385026 | debian-bookworm | Product Name: OpenStack Nova 2026-07-19 02:26:25.385057 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:feec:3608 2026-07-19 02:26:25.405553 | 2026-07-19 02:26:25.405762 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-19 02:26:25.928513 | debian-bookworm -> localhost | changed 2026-07-19 02:26:25.937303 | 2026-07-19 02:26:25.937573 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-19 02:26:27.114383 | debian-bookworm -> localhost | changed 2026-07-19 02:26:27.130578 | 2026-07-19 02:26:27.130737 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-19 02:26:27.411965 | debian-bookworm -> localhost | ok 2026-07-19 02:26:27.425316 | 2026-07-19 02:26:27.425505 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-19 02:26:27.465419 | debian-bookworm | ok 2026-07-19 02:26:27.484719 | debian-bookworm | included: /var/lib/zuul/builds/fcbfe5973cef4fecb849e77fb3f12ba7/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-19 02:26:27.491854 | 2026-07-19 02:26:27.491969 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-19 02:26:29.291603 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-19 02:26:29.291885 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/fcbfe5973cef4fecb849e77fb3f12ba7/work/fcbfe5973cef4fecb849e77fb3f12ba7_id_rsa 2026-07-19 02:26:29.291926 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/fcbfe5973cef4fecb849e77fb3f12ba7/work/fcbfe5973cef4fecb849e77fb3f12ba7_id_rsa.pub 2026-07-19 02:26:29.291952 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-19 02:26:29.291977 | debian-bookworm -> localhost | SHA256:SR4yDoaih75bam65qY/niF4A3cW6H4s8RrTrLr9YuOU zuul-build-sshkey 2026-07-19 02:26:29.292016 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-19 02:26:29.292052 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-19 02:26:29.292073 | debian-bookworm -> localhost | | .. | 2026-07-19 02:26:29.292094 | debian-bookworm -> localhost | | . o .. | 2026-07-19 02:26:29.292113 | debian-bookworm -> localhost | |o o +.o o | 2026-07-19 02:26:29.292133 | debian-bookworm -> localhost | |oo .oo = o | 2026-07-19 02:26:29.292152 | debian-bookworm -> localhost | |o... o. S | 2026-07-19 02:26:29.292173 | debian-bookworm -> localhost | |....+ . | 2026-07-19 02:26:29.292193 | debian-bookworm -> localhost | | .o=o+ o | 2026-07-19 02:26:29.292212 | debian-bookworm -> localhost | |.*O** o | 2026-07-19 02:26:29.292233 | debian-bookworm -> localhost | |@%B*Eo | 2026-07-19 02:26:29.292252 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-19 02:26:29.292309 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.243980 2026-07-19 02:26:29.300621 | 2026-07-19 02:26:29.300743 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-19 02:26:29.329772 | debian-bookworm | ok 2026-07-19 02:26:29.341057 | debian-bookworm | included: /var/lib/zuul/builds/fcbfe5973cef4fecb849e77fb3f12ba7/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-19 02:26:29.349692 | 2026-07-19 02:26:29.349804 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-19 02:26:29.374059 | debian-bookworm | skipping: Conditional result was False 2026-07-19 02:26:29.380171 | 2026-07-19 02:26:29.380281 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-19 02:26:30.137183 | debian-bookworm | changed 2026-07-19 02:26:30.146132 | 2026-07-19 02:26:30.146297 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-19 02:26:30.418977 | debian-bookworm | ok 2026-07-19 02:26:30.427483 | 2026-07-19 02:26:30.427630 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-19 02:26:31.078561 | debian-bookworm | changed 2026-07-19 02:26:31.087452 | 2026-07-19 02:26:31.087629 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-19 02:26:31.718962 | debian-bookworm | changed 2026-07-19 02:26:31.725126 | 2026-07-19 02:26:31.725253 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-19 02:26:31.751053 | debian-bookworm | skipping: Conditional result was False 2026-07-19 02:26:31.765869 | 2026-07-19 02:26:31.766089 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-19 02:26:32.264309 | debian-bookworm -> localhost | changed 2026-07-19 02:26:32.276232 | 2026-07-19 02:26:32.276385 | TASK [add-build-sshkey : Add back temp key] 2026-07-19 02:26:32.681915 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/fcbfe5973cef4fecb849e77fb3f12ba7/work/fcbfe5973cef4fecb849e77fb3f12ba7_id_rsa (zuul-build-sshkey) 2026-07-19 02:26:32.682202 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.013656 2026-07-19 02:26:32.690799 | 2026-07-19 02:26:32.695152 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-19 02:26:33.290532 | debian-bookworm | ok 2026-07-19 02:26:33.299412 | 2026-07-19 02:26:33.299661 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-19 02:26:33.325466 | debian-bookworm | skipping: Conditional result was False 2026-07-19 02:26:33.346183 | 2026-07-19 02:26:33.346351 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-19 02:26:33.792869 | debian-bookworm | ok 2026-07-19 02:26:33.805267 | 2026-07-19 02:26:33.805405 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-19 02:26:33.858118 | debian-bookworm | ok 2026-07-19 02:26:33.865640 | 2026-07-19 02:26:33.865779 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-19 02:26:34.198569 | debian-bookworm -> localhost | ok 2026-07-19 02:26:34.205484 | 2026-07-19 02:26:34.205606 | TASK [validate-host : Collect information about the host] 2026-07-19 02:26:35.353842 | debian-bookworm | ok 2026-07-19 02:26:35.377464 | 2026-07-19 02:26:35.377697 | TASK [validate-host : Sanitize hostname] 2026-07-19 02:26:35.554624 | debian-bookworm | ok 2026-07-19 02:26:35.559826 | 2026-07-19 02:26:35.559944 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-19 02:26:36.189568 | debian-bookworm -> localhost | changed 2026-07-19 02:26:36.200921 | 2026-07-19 02:26:36.201105 | TASK [validate-host : Collect information about zuul worker] 2026-07-19 02:26:36.612478 | debian-bookworm | ok 2026-07-19 02:26:36.618424 | 2026-07-19 02:26:36.618573 | TASK [validate-host : Write out all zuul information for each host] 2026-07-19 02:26:37.190620 | debian-bookworm -> localhost | changed 2026-07-19 02:26:37.200715 | 2026-07-19 02:26:37.200896 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-19 02:26:37.498867 | debian-bookworm | ok 2026-07-19 02:26:37.507871 | 2026-07-19 02:26:37.508025 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-19 02:26:38.483954 | debian-bookworm | changed: 2026-07-19 02:26:38.484318 | debian-bookworm | cd+++++++++ src/ 2026-07-19 02:26:38.484380 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-19 02:26:38.484423 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-19 02:26:38.484461 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-07-19 02:26:38.484496 | debian-bookworm | =7.0.3 2026-07-19 02:27:13.469271 | debian-bookworm | Downloading cachetools-7.1.4-py3-none-any.whl (16 kB) 2026-07-19 02:27:13.508811 | debian-bookworm | Collecting colorama>=0.4.6 2026-07-19 02:27:13.522000 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-07-19 02:27:13.582890 | debian-bookworm | Collecting filelock>=3.25 2026-07-19 02:27:13.596165 | debian-bookworm | Downloading filelock-3.31.0-py3-none-any.whl (96 kB) 2026-07-19 02:27:13.602970 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 96.1/96.1 kB 19.3 MB/s eta 0:00:00 2026-07-19 02:27:13.646702 | debian-bookworm | Collecting packaging>=26 2026-07-19 02:27:13.659879 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-07-19 02:27:13.666884 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 20.4 MB/s eta 0:00:00 2026-07-19 02:27:13.727806 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-07-19 02:27:13.741171 | debian-bookworm | Downloading platformdirs-4.10.1-py3-none-any.whl (22 kB) 2026-07-19 02:27:13.781049 | debian-bookworm | Collecting pluggy>=1.6 2026-07-19 02:27:13.794238 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-07-19 02:27:13.829718 | debian-bookworm | Collecting pyproject-api>=1.10 2026-07-19 02:27:13.842732 | debian-bookworm | Downloading pyproject_api-1.10.1-py3-none-any.whl (12 kB) 2026-07-19 02:27:13.874335 | debian-bookworm | Collecting python-discovery>=1.4.4 2026-07-19 02:27:13.887292 | debian-bookworm | Downloading python_discovery-1.4.4-py3-none-any.whl (34 kB) 2026-07-19 02:27:13.916370 | debian-bookworm | Collecting tomli-w>=1.2 2026-07-19 02:27:13.929466 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-07-19 02:27:14.061414 | debian-bookworm | Collecting virtualenv>=21.1 2026-07-19 02:27:14.074903 | debian-bookworm | Downloading virtualenv-21.6.1-py3-none-any.whl (5.5 MB) 2026-07-19 02:27:14.222108 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.5/5.5 MB 38.7 MB/s eta 0:00:00 2026-07-19 02:27:14.318820 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-07-19 02:27:14.332621 | debian-bookworm | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-07-19 02:27:14.344186 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.6/470.6 kB 53.1 MB/s eta 0:00:00 2026-07-19 02:27:14.450818 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-07-19 02:27:15.180592 | debian-bookworm | Successfully installed cachetools-7.1.4 colorama-0.4.6 distlib-0.4.3 filelock-3.31.0 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-19 02:27:15.415069 | debian-bookworm | ok: Runtime: 0:00:02.640517 2026-07-19 02:27:15.430138 | 2026-07-19 02:27:15.430343 | TASK [ensure-tox : Export installed tox_executable path] 2026-07-19 02:27:15.481022 | debian-bookworm | ok 2026-07-19 02:27:15.489289 | 2026-07-19 02:27:15.489433 | TASK [ensure-tox : Output tox version] 2026-07-19 02:27:15.994537 | 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-19 02:27:16.011171 | debian-bookworm | 4.57.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-19 02:27:16.521505 | debian-bookworm | ok: Runtime: 0:00:00.290923 2026-07-19 02:27:16.529638 | 2026-07-19 02:27:16.529779 | TASK [ensure-tox : Make global symlink] 2026-07-19 02:27:16.557763 | debian-bookworm | skipping: Conditional result was False 2026-07-19 02:27:16.575090 | 2026-07-19 02:27:16.575247 | PLAY RECAP 2026-07-19 02:27:16.575336 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-07-19 02:27:16.575373 | 2026-07-19 02:27:16.741122 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-07-19 02:27:16.745052 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-07-19 02:27:17.530211 | 2026-07-19 02:27:17.530402 | PLAY [all] 2026-07-19 02:27:17.547616 | 2026-07-19 02:27:17.547777 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-07-19 02:27:18.211782 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-07-19 02:27:18.580219 | debian-bookworm | ok: Runtime: 0:00:00.177448 2026-07-19 02:27:18.592662 | 2026-07-19 02:27:18.592873 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-07-19 02:27:19.125693 | debian-bookworm | ok: Runtime: 0:00:00.007764 2026-07-19 02:27:19.133462 | 2026-07-19 02:27:19.133613 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-07-19 02:27:19.437361 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-07-19 02:27:19.440624 | debian-bookworm | sudo: a password is required 2026-07-19 02:27:19.667749 | debian-bookworm | ok: Runtime: 0:00:00.022651 2026-07-19 02:27:19.688349 | 2026-07-19 02:27:19.688519 | TASK [tox : Check to see if the constraints file exists] 2026-07-19 02:27:19.724733 | debian-bookworm | skipping: Conditional result was False 2026-07-19 02:27:19.739562 | 2026-07-19 02:27:19.739757 | TASK [tox : Fail if constraints file is missing] 2026-07-19 02:27:19.776713 | debian-bookworm | skipping: Conditional result was False 2026-07-19 02:27:19.790872 | 2026-07-19 02:27:19.791136 | TASK [tox : Record file location] 2026-07-19 02:27:19.826965 | debian-bookworm | skipping: Conditional result was False 2026-07-19 02:27:19.841366 | 2026-07-19 02:27:19.841574 | TASK [tox : Install tox siblings] 2026-07-19 02:27:19.877758 | debian-bookworm | ok 2026-07-19 02:27:19.888332 | debian-bookworm | included: /var/lib/zuul/builds/fcbfe5973cef4fecb849e77fb3f12ba7/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-07-19 02:27:19.894316 | 2026-07-19 02:27:19.894445 | TASK [tox : Run tox without tests] 2026-07-19 02:27:21.262886 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-07-19 02:27:33.930216 | debian-bookworm | test: OK (13.45 seconds) 2026-07-19 02:27:33.930296 | debian-bookworm | congratulations :) (13.48 seconds) 2026-07-19 02:27:34.433831 | debian-bookworm | ok: Runtime: 0:00:13.800620 2026-07-19 02:27:34.449112 | 2026-07-19 02:27:34.449283 | TASK [tox : Create a tempfile to save tox showconfig] 2026-07-19 02:27:34.868536 | debian-bookworm | changed 2026-07-19 02:27:34.878370 | 2026-07-19 02:27:34.878644 | TASK [tox : Detect tox version] 2026-07-19 02:27:35.468959 | debian-bookworm | 4.57.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-19 02:27:35.917437 | debian-bookworm | ok: Runtime: 0:00:00.334501 2026-07-19 02:27:35.933829 | 2026-07-19 02:27:35.934067 | TASK [tox : Get tox envlist config] 2026-07-19 02:27:36.976694 | debian-bookworm | ok: Runtime: 0:00:00.382511 2026-07-19 02:27:36.993187 | 2026-07-19 02:27:36.993460 | TASK [tox : Install any sibling python packages] 2026-07-19 02:27:37.463984 | debian-bookworm | ok: No setup.cfg, no action needed 2026-07-19 02:27:37.471818 | 2026-07-19 02:27:37.471964 | TASK [tox : Remove tempfile] 2026-07-19 02:27:37.957802 | debian-bookworm | changed 2026-07-19 02:27:37.963421 | 2026-07-19 02:27:37.963525 | TASK [tox : Emit tox command] 2026-07-19 02:27:38.019440 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-07-19 02:27:38.026949 | 2026-07-19 02:27:38.027087 | TASK [tox : Run tox] 2026-07-19 02:27:38.638173 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-07-19 02:27:40.414999 | debian-bookworm | ............................................. 2026-07-19 02:27:40.415055 | debian-bookworm | ---------------------------------------------------------------------- 2026-07-19 02:27:40.415064 | debian-bookworm | Ran 45 tests in 1.305s 2026-07-19 02:27:40.415069 | debian-bookworm | 2026-07-19 02:27:40.415075 | debian-bookworm | OK 2026-07-19 02:27:40.521404 | debian-bookworm | test: OK (1.93=setup[0.05]+cmd[1.88] seconds) 2026-07-19 02:27:40.521466 | debian-bookworm | congratulations :) (1.96 seconds) 2026-07-19 02:27:41.058908 | debian-bookworm | ok: Runtime: 0:00:02.269538 2026-07-19 02:27:41.065816 | 2026-07-19 02:27:41.065982 | TASK [tox : Look for output] 2026-07-19 02:27:41.470748 | debian-bookworm | ok 2026-07-19 02:27:41.488452 | 2026-07-19 02:27:41.488603 | TASK [tox : Return file comments to Zuul] 2026-07-19 02:27:41.534227 | debian-bookworm | skipping: Conditional result was False 2026-07-19 02:27:41.548789 | 2026-07-19 02:27:41.548941 | PLAY RECAP 2026-07-19 02:27:41.549030 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-07-19 02:27:41.549071 | 2026-07-19 02:27:41.699165 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-07-19 02:27:41.703538 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-07-19 02:27:42.483631 | 2026-07-19 02:27:42.483831 | PLAY [all] 2026-07-19 02:27:42.501015 | 2026-07-19 02:27:42.501200 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-07-19 02:27:42.556828 | debian-bookworm | skipping: Conditional result was False 2026-07-19 02:27:42.563217 | 2026-07-19 02:27:42.563376 | TASK [fetch-tox-output : Set tox log path for single node] 2026-07-19 02:27:42.619166 | debian-bookworm | ok 2026-07-19 02:27:42.629027 | 2026-07-19 02:27:42.629183 | TASK [fetch-tox-output : Ensure local tox dir] 2026-07-19 02:27:43.134107 | debian-bookworm -> localhost | changed 2026-07-19 02:27:43.152376 | 2026-07-19 02:27:43.152548 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-07-19 02:27:43.208363 | debian-bookworm | skipping: Conditional result was False 2026-07-19 02:27:43.221265 | 2026-07-19 02:27:43.221442 | TASK [fetch-tox-output : Set envlist fact] 2026-07-19 02:27:43.266859 | debian-bookworm | ok 2026-07-19 02:27:43.275184 | 2026-07-19 02:27:43.275307 | TASK [fetch-tox-output : Get tox version] 2026-07-19 02:27:44.023248 | 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-19 02:27:44.039332 | debian-bookworm | 4.57.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-19 02:27:44.311628 | debian-bookworm | ok: Runtime: 0:00:00.404017 2026-07-19 02:27:44.325076 | 2026-07-19 02:27:44.325267 | TASK [fetch-tox-output : Find all default environments] 2026-07-19 02:27:44.871195 | debian-bookworm | skipping: Conditional result was False 2026-07-19 02:27:44.884230 | 2026-07-19 02:27:44.884443 | TASK [fetch-tox-output : Set envlist fact] 2026-07-19 02:27:44.921350 | debian-bookworm | skipping: Conditional result was False 2026-07-19 02:27:44.935103 | 2026-07-19 02:27:44.935298 | TASK [fetch-tox-output : Find all default environments] 2026-07-19 02:27:45.470767 | debian-bookworm | skipping: Conditional result was False 2026-07-19 02:27:45.478515 | 2026-07-19 02:27:45.478663 | TASK [fetch-tox-output : Set envlist fact] 2026-07-19 02:27:45.513517 | debian-bookworm | skipping: Conditional result was False 2026-07-19 02:27:45.524057 | 2026-07-19 02:27:45.524214 | LOOP [fetch-tox-output : Copy tox logs] 2026-07-19 02:27:45.583026 | debian-bookworm | skipping: Conditional result was False 2026-07-19 02:27:45.603407 | 2026-07-19 02:27:45.603576 | LOOP [fetch-tox-output : Collect tox logs] 2026-07-19 02:27:46.413619 | debian-bookworm | changed: 2026-07-19 02:27:46.413838 | debian-bookworm | created directory /var/lib/zuul/builds/fcbfe5973cef4fecb849e77fb3f12ba7/work/logs/tox/test 2026-07-19 02:27:46.413917 | debian-bookworm | cd+++++++++ ./ 2026-07-19 02:27:46.413959 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-07-19 02:27:46.414005 | 2026-07-19 02:27:46.427676 | 2026-07-19 02:27:46.427787 | PLAY RECAP 2026-07-19 02:27:46.427844 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-07-19 02:27:46.427868 | 2026-07-19 02:27:46.580251 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-07-19 02:27:46.582984 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-07-19 02:27:47.408089 | 2026-07-19 02:27:47.408296 | PLAY [all] 2026-07-19 02:27:47.425141 | 2026-07-19 02:27:47.425317 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-07-19 02:27:47.693743 | debian-bookworm | changed: non-zero return code 2026-07-19 02:27:47.701389 | 2026-07-19 02:27:47.701573 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-07-19 02:27:47.727041 | debian-bookworm | skipping: Conditional result was False 2026-07-19 02:27:47.735660 | 2026-07-19 02:27:47.735843 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-07-19 02:27:47.776499 | 2026-07-19 02:27:47.776811 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-07-19 02:27:47.817146 | 2026-07-19 02:27:47.817450 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-07-19 02:27:47.842810 | debian-bookworm | skipping: Conditional result was False 2026-07-19 02:27:47.856679 | 2026-07-19 02:27:47.856857 | LOOP [fetch-subunit-output : Generate subunit file] 2026-07-19 02:27:47.896963 | 2026-07-19 02:27:47.897307 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-07-19 02:27:47.923624 | debian-bookworm | skipping: Conditional result was False 2026-07-19 02:27:47.935955 | 2026-07-19 02:27:47.936122 | TASK [fetch-subunit-output : Remove the temporary file] 2026-07-19 02:27:47.961012 | debian-bookworm | skipping: Conditional result was False 2026-07-19 02:27:47.972437 | 2026-07-19 02:27:47.972592 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-07-19 02:27:47.997207 | debian-bookworm | skipping: Conditional result was False 2026-07-19 02:27:48.008981 | 2026-07-19 02:27:48.009092 | PLAY RECAP 2026-07-19 02:27:48.009164 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-07-19 02:27:48.009200 | 2026-07-19 02:27:48.146522 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-07-19 02:27:48.149469 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-19 02:27:48.955557 | 2026-07-19 02:27:48.955756 | PLAY [Base post-fetch] 2026-07-19 02:27:48.970593 | 2026-07-19 02:27:48.970741 | TASK [diagnose-network : Ensure log directory exists] 2026-07-19 02:27:49.374190 | debian-bookworm | ok 2026-07-19 02:27:49.384420 | 2026-07-19 02:27:49.384601 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-07-19 02:28:06.432248 | debian-bookworm | ok: Runtime: 0:00:12.758968 2026-07-19 02:28:06.441919 | 2026-07-19 02:28:06.442069 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-07-19 02:28:12.486099 | debian-bookworm | ok: Runtime: 0:00:00.008746 2026-07-19 02:28:12.493772 | 2026-07-19 02:28:12.493934 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-07-19 02:28:18.472554 | debian-bookworm | ok: Runtime: 0:00:00.007559 2026-07-19 02:28:18.491471 | 2026-07-19 02:28:18.491766 | TASK [fetch-output : Set log path for multiple nodes] 2026-07-19 02:28:18.551923 | debian-bookworm | skipping: Conditional result was False 2026-07-19 02:28:18.567692 | 2026-07-19 02:28:18.567945 | TASK [fetch-output : Set log path for single node] 2026-07-19 02:28:18.619974 | debian-bookworm | ok 2026-07-19 02:28:18.627489 | 2026-07-19 02:28:18.627703 | LOOP [fetch-output : Ensure local output dirs] 2026-07-19 02:28:18.969803 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/fcbfe5973cef4fecb849e77fb3f12ba7/work/logs" 2026-07-19 02:28:19.295410 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/fcbfe5973cef4fecb849e77fb3f12ba7/work/artifacts" 2026-07-19 02:28:19.575968 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/fcbfe5973cef4fecb849e77fb3f12ba7/work/docs" 2026-07-19 02:28:19.595482 | 2026-07-19 02:28:19.595689 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-19 02:28:20.459091 | debian-bookworm | changed: 2026-07-19 02:28:20.459370 | debian-bookworm | .d..t...... ./ 2026-07-19 02:28:20.459406 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-19 02:28:20.459434 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-19 02:28:20.459456 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-19 02:28:20.459477 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-19 02:28:20.459498 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-19 02:28:20.459541 | debian-bookworm | changed: All items complete 2026-07-19 02:28:20.459571 | 2026-07-19 02:28:21.064939 | debian-bookworm | changed: .d..t...... ./ 2026-07-19 02:28:21.704177 | debian-bookworm | changed: .d..t...... ./ 2026-07-19 02:28:21.728540 | 2026-07-19 02:28:21.728683 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-19 02:28:22.106435 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.011146 2026-07-19 02:28:22.428439 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.012103 2026-07-19 02:28:22.447289 | 2026-07-19 02:28:22.447478 | PLAY RECAP 2026-07-19 02:28:22.447535 | debian-bookworm | ok: 8 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-07-19 02:28:22.447561 | 2026-07-19 02:28:22.590217 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-19 02:28:22.591461 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-19 02:28:23.361906 | 2026-07-19 02:28:23.362107 | PLAY [Base post] 2026-07-19 02:28:23.376643 | 2026-07-19 02:28:23.376797 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-19 02:28:23.993913 | debian-bookworm | changed 2026-07-19 02:28:24.002786 | 2026-07-19 02:28:24.002988 | PLAY RECAP 2026-07-19 02:28:24.003085 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-19 02:28:24.003194 | 2026-07-19 02:28:24.135987 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-19 02:28:24.138424 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-19 02:28:24.983100 | 2026-07-19 02:28:24.983307 | PLAY [Base post-logs] 2026-07-19 02:28:24.995084 | 2026-07-19 02:28:24.995231 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-19 02:28:25.481774 | localhost | changed 2026-07-19 02:28:25.499057 | 2026-07-19 02:28:25.499259 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-19 02:28:25.538986 | localhost | ok 2026-07-19 02:28:25.547434 | 2026-07-19 02:28:25.547687 | TASK [Set zuul-log-path fact] 2026-07-19 02:28:25.578215 | localhost | ok 2026-07-19 02:28:25.593483 | 2026-07-19 02:28:25.593671 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-19 02:28:25.634354 | localhost | ok 2026-07-19 02:28:25.643261 | 2026-07-19 02:28:25.643489 | TASK [upload-logs : Create log directories] 2026-07-19 02:28:26.187018 | localhost | changed 2026-07-19 02:28:26.193437 | 2026-07-19 02:28:26.193636 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-19 02:28:26.711344 | localhost -> localhost | ok: Runtime: 0:00:00.007733 2026-07-19 02:28:26.721586 | 2026-07-19 02:28:26.721782 | TASK [upload-logs : Upload logs to log server] 2026-07-19 02:28:27.323516 | localhost | Output suppressed because no_log was given 2026-07-19 02:28:27.327803 | 2026-07-19 02:28:27.328080 | LOOP [upload-logs : Compress console log and json output] 2026-07-19 02:28:27.392318 | localhost | skipping: Conditional result was False 2026-07-19 02:28:27.395497 | localhost | skipping: Conditional result was False 2026-07-19 02:28:27.410092 | 2026-07-19 02:28:27.410286 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-19 02:28:27.458888 | localhost | skipping: Conditional result was False 2026-07-19 02:28:27.459734 | 2026-07-19 02:28:27.462089 | localhost | skipping: Conditional result was False 2026-07-19 02:28:27.473440 | 2026-07-19 02:28:27.473592 | LOOP [upload-logs : Upload console log and json output]