2026-07-10 03:06:06.169378 | Job console starting 2026-07-10 03:06:06.188057 | Updating git repos 2026-07-10 03:06:06.223236 | Cloning repos into workspace 2026-07-10 03:06:06.266564 | Restoring repo states 2026-07-10 03:06:06.280082 | Merging changes 2026-07-10 03:06:06.280099 | Checking out repos 2026-07-10 03:06:06.344741 | Preparing playbooks 2026-07-10 03:06:07.999353 | Running Ansible setup 2026-07-10 03:06:12.897026 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-10 03:06:13.968782 | 2026-07-10 03:06:13.968992 | PLAY [Base pre] 2026-07-10 03:06:13.988137 | 2026-07-10 03:06:13.988338 | TASK [Setup log path fact] 2026-07-10 03:06:14.019792 | debian-bookworm | ok 2026-07-10 03:06:14.039318 | 2026-07-10 03:06:14.039584 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-10 03:06:14.069922 | debian-bookworm | ok 2026-07-10 03:06:14.080443 | 2026-07-10 03:06:14.080589 | TASK [emit-job-header : Print job information] 2026-07-10 03:06:14.120741 | # Job Information 2026-07-10 03:06:14.120976 | Ansible Version: 2.16.14 2026-07-10 03:06:14.121014 | Job: tox 2026-07-10 03:06:14.121047 | Pipeline: periodic-daily 2026-07-10 03:06:14.121069 | Executor: 521e9411259a 2026-07-10 03:06:14.121090 | Triggered by: https://github.com/osism/openstack-image-manager 2026-07-10 03:06:14.121112 | Event ID: 7244bce8ce454c8cada5821089d2fc59 2026-07-10 03:06:14.126452 | 2026-07-10 03:06:14.126592 | LOOP [emit-job-header : Print node information] 2026-07-10 03:06:14.305972 | debian-bookworm | ok: 2026-07-10 03:06:14.306280 | debian-bookworm | # Node Information 2026-07-10 03:06:14.306352 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-10 03:06:14.306378 | debian-bookworm | Hostname: debian 2026-07-10 03:06:14.306401 | debian-bookworm | Username: zuul 2026-07-10 03:06:14.306422 | debian-bookworm | Distro: Debian 12.14 2026-07-10 03:06:14.306446 | debian-bookworm | Provider: regiocloud-a 2026-07-10 03:06:14.306466 | debian-bookworm | Region: 2026-07-10 03:06:14.306487 | debian-bookworm | Label: debian-bookworm 2026-07-10 03:06:14.306507 | debian-bookworm | Product Name: OpenStack Nova 2026-07-10 03:06:14.306526 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe3a:6f85 2026-07-10 03:06:14.339212 | 2026-07-10 03:06:14.339407 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-10 03:06:14.944134 | debian-bookworm -> localhost | changed 2026-07-10 03:06:14.952456 | 2026-07-10 03:06:14.952598 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-10 03:06:16.342757 | debian-bookworm -> localhost | changed 2026-07-10 03:06:16.357127 | 2026-07-10 03:06:16.357312 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-10 03:06:16.718116 | debian-bookworm -> localhost | ok 2026-07-10 03:06:16.726205 | 2026-07-10 03:06:16.726394 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-10 03:06:16.778576 | debian-bookworm | ok 2026-07-10 03:06:16.801757 | debian-bookworm | included: /var/lib/zuul/builds/641b6a53773d4507828da8d2be3c0ff9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-10 03:06:16.808486 | 2026-07-10 03:06:16.808635 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-10 03:06:18.663690 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-10 03:06:18.664027 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/641b6a53773d4507828da8d2be3c0ff9/work/641b6a53773d4507828da8d2be3c0ff9_id_rsa 2026-07-10 03:06:18.664071 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/641b6a53773d4507828da8d2be3c0ff9/work/641b6a53773d4507828da8d2be3c0ff9_id_rsa.pub 2026-07-10 03:06:18.664098 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-10 03:06:18.664123 | debian-bookworm -> localhost | SHA256:9H7jkFO81x9rxm1mJik49BOg8TQ74hozGYhT2HPsj5M zuul-build-sshkey 2026-07-10 03:06:18.664147 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-10 03:06:18.664182 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-10 03:06:18.664206 | debian-bookworm -> localhost | | | 2026-07-10 03:06:18.664228 | debian-bookworm -> localhost | | o . | 2026-07-10 03:06:18.664249 | debian-bookworm -> localhost | | . + o . | 2026-07-10 03:06:18.664270 | debian-bookworm -> localhost | | o = ...+. | 2026-07-10 03:06:18.664290 | debian-bookworm -> localhost | | o . o S=.+o | 2026-07-10 03:06:18.664345 | debian-bookworm -> localhost | | . *o.=o.. . | 2026-07-10 03:06:18.664369 | debian-bookworm -> localhost | | E..o=++.ooo| 2026-07-10 03:06:18.664391 | debian-bookworm -> localhost | | =. o=+oo+X| 2026-07-10 03:06:18.664414 | debian-bookworm -> localhost | | .. ..ooB.| 2026-07-10 03:06:18.664435 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-10 03:06:18.664494 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.279248 2026-07-10 03:06:18.671705 | 2026-07-10 03:06:18.671848 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-10 03:06:18.704827 | debian-bookworm | ok 2026-07-10 03:06:18.721584 | debian-bookworm | included: /var/lib/zuul/builds/641b6a53773d4507828da8d2be3c0ff9/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-10 03:06:18.735259 | 2026-07-10 03:06:18.735517 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-10 03:06:18.762135 | debian-bookworm | skipping: Conditional result was False 2026-07-10 03:06:18.776280 | 2026-07-10 03:06:18.776571 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-10 03:06:19.505641 | debian-bookworm | changed 2026-07-10 03:06:19.513769 | 2026-07-10 03:06:19.513903 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-10 03:06:19.748491 | debian-bookworm | ok 2026-07-10 03:06:19.759661 | 2026-07-10 03:06:19.759832 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-10 03:06:20.629917 | debian-bookworm | changed 2026-07-10 03:06:20.637117 | 2026-07-10 03:06:20.637407 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-10 03:06:21.336841 | debian-bookworm | changed 2026-07-10 03:06:21.348173 | 2026-07-10 03:06:21.348376 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-10 03:06:21.394637 | debian-bookworm | skipping: Conditional result was False 2026-07-10 03:06:21.403030 | 2026-07-10 03:06:21.403185 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-10 03:06:22.201661 | debian-bookworm -> localhost | changed 2026-07-10 03:06:22.215814 | 2026-07-10 03:06:22.215979 | TASK [add-build-sshkey : Add back temp key] 2026-07-10 03:06:22.764697 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/641b6a53773d4507828da8d2be3c0ff9/work/641b6a53773d4507828da8d2be3c0ff9_id_rsa (zuul-build-sshkey) 2026-07-10 03:06:22.765020 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.018805 2026-07-10 03:06:22.773422 | 2026-07-10 03:06:22.773566 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-10 03:06:23.248768 | debian-bookworm | ok 2026-07-10 03:06:23.254346 | 2026-07-10 03:06:23.254467 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-10 03:06:23.279001 | debian-bookworm | skipping: Conditional result was False 2026-07-10 03:06:23.289820 | 2026-07-10 03:06:23.289961 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-10 03:06:23.770235 | debian-bookworm | ok 2026-07-10 03:06:23.798520 | 2026-07-10 03:06:23.798704 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-10 03:06:23.861536 | debian-bookworm | ok 2026-07-10 03:06:23.867233 | 2026-07-10 03:06:23.867385 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-10 03:06:24.333154 | debian-bookworm -> localhost | ok 2026-07-10 03:06:24.340278 | 2026-07-10 03:06:24.340433 | TASK [validate-host : Collect information about the host] 2026-07-10 03:06:25.571350 | debian-bookworm | ok 2026-07-10 03:06:25.587392 | 2026-07-10 03:06:25.587540 | TASK [validate-host : Sanitize hostname] 2026-07-10 03:06:25.772645 | debian-bookworm | ok 2026-07-10 03:06:25.777855 | 2026-07-10 03:06:25.777975 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-10 03:06:26.569752 | debian-bookworm -> localhost | changed 2026-07-10 03:06:26.578204 | 2026-07-10 03:06:26.578392 | TASK [validate-host : Collect information about zuul worker] 2026-07-10 03:06:27.161728 | debian-bookworm | ok 2026-07-10 03:06:27.170813 | 2026-07-10 03:06:27.171028 | TASK [validate-host : Write out all zuul information for each host] 2026-07-10 03:06:27.789962 | debian-bookworm -> localhost | changed 2026-07-10 03:06:27.801043 | 2026-07-10 03:06:27.801186 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-10 03:06:28.114071 | debian-bookworm | ok 2026-07-10 03:06:28.122465 | 2026-07-10 03:06:28.122622 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-10 03:06:29.047924 | debian-bookworm | changed: 2026-07-10 03:06:29.048170 | debian-bookworm | cd+++++++++ src/ 2026-07-10 03:06:29.048209 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-10 03:06:29.048234 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-10 03:06:29.048258 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-07-10 03:06:29.048281 | debian-bookworm | =7.0.3 2026-07-10 03:07:11.389593 | debian-bookworm | Downloading cachetools-7.1.4-py3-none-any.whl (16 kB) 2026-07-10 03:07:11.484579 | debian-bookworm | Collecting colorama>=0.4.6 2026-07-10 03:07:11.496082 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-07-10 03:07:11.579550 | debian-bookworm | Collecting filelock>=3.25 2026-07-10 03:07:11.590469 | debian-bookworm | Downloading filelock-3.29.7-py3-none-any.whl (46 kB) 2026-07-10 03:07:11.597860 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 46.0/46.0 kB 7.4 MB/s eta 0:00:00 2026-07-10 03:07:11.660650 | debian-bookworm | Collecting packaging>=26 2026-07-10 03:07:11.671297 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-07-10 03:07:11.688716 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 8.3 MB/s eta 0:00:00 2026-07-10 03:07:11.746617 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-07-10 03:07:11.757890 | debian-bookworm | Downloading platformdirs-4.10.0-py3-none-any.whl (22 kB) 2026-07-10 03:07:11.813200 | debian-bookworm | Collecting pluggy>=1.6 2026-07-10 03:07:11.823634 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-07-10 03:07:11.865374 | debian-bookworm | Collecting pyproject-api>=1.10 2026-07-10 03:07:11.876969 | debian-bookworm | Downloading pyproject_api-1.10.1-py3-none-any.whl (12 kB) 2026-07-10 03:07:11.916992 | debian-bookworm | Collecting python-discovery>=1.4.4 2026-07-10 03:07:11.929561 | debian-bookworm | Downloading python_discovery-1.4.4-py3-none-any.whl (34 kB) 2026-07-10 03:07:11.985502 | debian-bookworm | Collecting tomli-w>=1.2 2026-07-10 03:07:11.996956 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-07-10 03:07:12.169645 | debian-bookworm | Collecting virtualenv>=21.1 2026-07-10 03:07:12.180398 | debian-bookworm | Downloading virtualenv-21.6.0-py3-none-any.whl (5.5 MB) 2026-07-10 03:07:12.473142 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.5/5.5 MB 19.1 MB/s eta 0:00:00 2026-07-10 03:07:12.593436 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-07-10 03:07:12.604493 | debian-bookworm | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-07-10 03:07:12.631443 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.6/470.6 kB 21.8 MB/s eta 0:00:00 2026-07-10 03:07:12.780374 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-07-10 03:07:13.600956 | debian-bookworm | Successfully installed cachetools-7.1.4 colorama-0.4.6 distlib-0.4.3 filelock-3.29.7 packaging-26.2 platformdirs-4.10.0 pluggy-1.6.0 pyproject-api-1.10.1 python-discovery-1.4.4 tomli-w-1.2.0 tox-4.56.4 virtualenv-21.6.0 2026-07-10 03:07:14.165112 | debian-bookworm | ok: Runtime: 0:00:03.271389 2026-07-10 03:07:14.170942 | 2026-07-10 03:07:14.171046 | TASK [ensure-tox : Export installed tox_executable path] 2026-07-10 03:07:14.232523 | debian-bookworm | ok 2026-07-10 03:07:14.238480 | 2026-07-10 03:07:14.238599 | TASK [ensure-tox : Output tox version] 2026-07-10 03:07:14.955786 | 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-10 03:07:14.974281 | debian-bookworm | 4.56.4 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-10 03:07:15.329142 | debian-bookworm | ok: Runtime: 0:00:00.377435 2026-07-10 03:07:15.339870 | 2026-07-10 03:07:15.340013 | TASK [ensure-tox : Make global symlink] 2026-07-10 03:07:15.372817 | debian-bookworm | skipping: Conditional result was False 2026-07-10 03:07:15.382730 | 2026-07-10 03:07:15.382889 | PLAY RECAP 2026-07-10 03:07:15.382951 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-07-10 03:07:15.382976 | 2026-07-10 03:07:15.591195 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-07-10 03:07:15.592501 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-07-10 03:07:17.137432 | 2026-07-10 03:07:17.137631 | PLAY [all] 2026-07-10 03:07:17.177154 | 2026-07-10 03:07:17.177355 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-07-10 03:07:17.725456 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-07-10 03:07:18.232605 | debian-bookworm | ok: Runtime: 0:00:00.034421 2026-07-10 03:07:18.238214 | 2026-07-10 03:07:18.238339 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-07-10 03:07:18.782030 | debian-bookworm | ok: Runtime: 0:00:00.004690 2026-07-10 03:07:18.788423 | 2026-07-10 03:07:18.788539 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-07-10 03:07:19.233266 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-07-10 03:07:19.236836 | debian-bookworm | sudo: a password is required 2026-07-10 03:07:19.361793 | debian-bookworm | ok: Runtime: 0:00:00.024828 2026-07-10 03:07:19.371459 | 2026-07-10 03:07:19.371547 | TASK [tox : Check to see if the constraints file exists] 2026-07-10 03:07:19.409090 | debian-bookworm | skipping: Conditional result was False 2026-07-10 03:07:19.417589 | 2026-07-10 03:07:19.417704 | TASK [tox : Fail if constraints file is missing] 2026-07-10 03:07:19.473739 | debian-bookworm | skipping: Conditional result was False 2026-07-10 03:07:19.493133 | 2026-07-10 03:07:19.493264 | TASK [tox : Record file location] 2026-07-10 03:07:19.528536 | debian-bookworm | skipping: Conditional result was False 2026-07-10 03:07:19.536354 | 2026-07-10 03:07:19.536477 | TASK [tox : Install tox siblings] 2026-07-10 03:07:19.585771 | debian-bookworm | ok 2026-07-10 03:07:19.616654 | debian-bookworm | included: /var/lib/zuul/builds/641b6a53773d4507828da8d2be3c0ff9/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-07-10 03:07:19.623003 | 2026-07-10 03:07:19.623112 | TASK [tox : Run tox without tests] 2026-07-10 03:07:21.070454 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-07-10 03:07:34.716249 | debian-bookworm | test: OK (14.43 seconds) 2026-07-10 03:07:34.716291 | debian-bookworm | congratulations :) (14.46 seconds) 2026-07-10 03:07:35.161840 | debian-bookworm | ok: Runtime: 0:00:14.774651 2026-07-10 03:07:35.166647 | 2026-07-10 03:07:35.166726 | TASK [tox : Create a tempfile to save tox showconfig] 2026-07-10 03:07:35.688761 | debian-bookworm | changed 2026-07-10 03:07:35.692918 | 2026-07-10 03:07:35.693002 | TASK [tox : Detect tox version] 2026-07-10 03:07:36.317240 | debian-bookworm | 4.56.4 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-10 03:07:36.743886 | debian-bookworm | ok: Runtime: 0:00:00.356051 2026-07-10 03:07:36.748392 | 2026-07-10 03:07:36.748491 | TASK [tox : Get tox envlist config] 2026-07-10 03:07:37.806940 | debian-bookworm | ok: Runtime: 0:00:00.331076 2026-07-10 03:07:37.812509 | 2026-07-10 03:07:37.813786 | TASK [tox : Install any sibling python packages] 2026-07-10 03:07:38.476155 | debian-bookworm | ok: No setup.cfg, no action needed 2026-07-10 03:07:38.480718 | 2026-07-10 03:07:38.480807 | TASK [tox : Remove tempfile] 2026-07-10 03:07:39.157517 | debian-bookworm | changed 2026-07-10 03:07:39.166062 | 2026-07-10 03:07:39.166156 | TASK [tox : Emit tox command] 2026-07-10 03:07:39.208712 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-07-10 03:07:39.213388 | 2026-07-10 03:07:39.213501 | TASK [tox : Run tox] 2026-07-10 03:07:39.843093 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-07-10 03:07:40.658550 | debian-bookworm | .......................... 2026-07-10 03:07:40.659057 | debian-bookworm | ---------------------------------------------------------------------- 2026-07-10 03:07:40.659085 | debian-bookworm | Ran 26 tests in 0.253s 2026-07-10 03:07:40.659091 | debian-bookworm | 2026-07-10 03:07:40.659097 | debian-bookworm | OK 2026-07-10 03:07:40.778373 | debian-bookworm | test: OK (0.98=setup[0.05]+cmd[0.93] seconds) 2026-07-10 03:07:40.778440 | debian-bookworm | congratulations :) (1.01 seconds) 2026-07-10 03:07:41.257103 | debian-bookworm | ok: Runtime: 0:00:01.324789 2026-07-10 03:07:41.261737 | 2026-07-10 03:07:41.261815 | TASK [tox : Look for output] 2026-07-10 03:07:41.661952 | debian-bookworm | ok 2026-07-10 03:07:41.689886 | 2026-07-10 03:07:41.690004 | TASK [tox : Return file comments to Zuul] 2026-07-10 03:07:41.726299 | debian-bookworm | skipping: Conditional result was False 2026-07-10 03:07:41.733450 | 2026-07-10 03:07:41.733618 | PLAY RECAP 2026-07-10 03:07:41.733671 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-07-10 03:07:41.733696 | 2026-07-10 03:07:41.870761 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-07-10 03:07:41.871680 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-07-10 03:07:42.464862 | 2026-07-10 03:07:42.464989 | PLAY [all] 2026-07-10 03:07:42.476690 | 2026-07-10 03:07:42.476792 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-07-10 03:07:42.510551 | debian-bookworm | skipping: Conditional result was False 2026-07-10 03:07:42.515329 | 2026-07-10 03:07:42.515452 | TASK [fetch-tox-output : Set tox log path for single node] 2026-07-10 03:07:42.542511 | debian-bookworm | ok 2026-07-10 03:07:42.546630 | 2026-07-10 03:07:42.546708 | TASK [fetch-tox-output : Ensure local tox dir] 2026-07-10 03:07:42.997767 | debian-bookworm -> localhost | changed 2026-07-10 03:07:43.011671 | 2026-07-10 03:07:43.011828 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-07-10 03:07:43.057432 | debian-bookworm | skipping: Conditional result was False 2026-07-10 03:07:43.068252 | 2026-07-10 03:07:43.068433 | TASK [fetch-tox-output : Set envlist fact] 2026-07-10 03:07:43.111151 | debian-bookworm | ok 2026-07-10 03:07:43.117051 | 2026-07-10 03:07:43.117155 | TASK [fetch-tox-output : Get tox version] 2026-07-10 03:07:43.806324 | 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-10 03:07:43.824770 | debian-bookworm | 4.56.4 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-10 03:07:44.152013 | debian-bookworm | ok: Runtime: 0:00:00.356850 2026-07-10 03:07:44.165923 | 2026-07-10 03:07:44.166076 | TASK [fetch-tox-output : Find all default environments] 2026-07-10 03:07:44.697948 | debian-bookworm | skipping: Conditional result was False 2026-07-10 03:07:44.703358 | 2026-07-10 03:07:44.703474 | TASK [fetch-tox-output : Set envlist fact] 2026-07-10 03:07:44.736785 | debian-bookworm | skipping: Conditional result was False 2026-07-10 03:07:44.743524 | 2026-07-10 03:07:44.743631 | TASK [fetch-tox-output : Find all default environments] 2026-07-10 03:07:45.292004 | debian-bookworm | skipping: Conditional result was False 2026-07-10 03:07:45.297920 | 2026-07-10 03:07:45.298029 | TASK [fetch-tox-output : Set envlist fact] 2026-07-10 03:07:45.321410 | debian-bookworm | skipping: Conditional result was False 2026-07-10 03:07:45.328471 | 2026-07-10 03:07:45.328592 | LOOP [fetch-tox-output : Copy tox logs] 2026-07-10 03:07:45.368484 | debian-bookworm | skipping: Conditional result was False 2026-07-10 03:07:45.378889 | 2026-07-10 03:07:45.379013 | LOOP [fetch-tox-output : Collect tox logs] 2026-07-10 03:07:46.132181 | debian-bookworm | changed: 2026-07-10 03:07:46.132508 | debian-bookworm | created directory /var/lib/zuul/builds/641b6a53773d4507828da8d2be3c0ff9/work/logs/tox/test 2026-07-10 03:07:46.132565 | debian-bookworm | cd+++++++++ ./ 2026-07-10 03:07:46.132607 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-07-10 03:07:46.132654 | 2026-07-10 03:07:46.147060 | 2026-07-10 03:07:46.147184 | PLAY RECAP 2026-07-10 03:07:46.147245 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-07-10 03:07:46.147274 | 2026-07-10 03:07:46.308093 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-07-10 03:07:46.312414 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-07-10 03:07:47.167926 | 2026-07-10 03:07:47.168137 | PLAY [all] 2026-07-10 03:07:47.194393 | 2026-07-10 03:07:47.194642 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-07-10 03:07:47.454899 | debian-bookworm | changed: non-zero return code 2026-07-10 03:07:47.462064 | 2026-07-10 03:07:47.462227 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-07-10 03:07:47.488782 | debian-bookworm | skipping: Conditional result was False 2026-07-10 03:07:47.498809 | 2026-07-10 03:07:47.499052 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-07-10 03:07:47.536420 | 2026-07-10 03:07:47.536785 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-07-10 03:07:47.578480 | 2026-07-10 03:07:47.578718 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-07-10 03:07:47.604666 | debian-bookworm | skipping: Conditional result was False 2026-07-10 03:07:47.611459 | 2026-07-10 03:07:47.611612 | LOOP [fetch-subunit-output : Generate subunit file] 2026-07-10 03:07:47.649577 | 2026-07-10 03:07:47.649927 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-07-10 03:07:47.676553 | debian-bookworm | skipping: Conditional result was False 2026-07-10 03:07:47.688482 | 2026-07-10 03:07:47.688686 | TASK [fetch-subunit-output : Remove the temporary file] 2026-07-10 03:07:47.714116 | debian-bookworm | skipping: Conditional result was False 2026-07-10 03:07:47.723489 | 2026-07-10 03:07:47.723633 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-07-10 03:07:47.748100 | debian-bookworm | skipping: Conditional result was False 2026-07-10 03:07:47.757579 | 2026-07-10 03:07:47.757670 | PLAY RECAP 2026-07-10 03:07:47.757728 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-07-10 03:07:47.757757 | 2026-07-10 03:07:47.925261 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-07-10 03:07:47.927046 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-10 03:07:48.886469 | 2026-07-10 03:07:48.886740 | PLAY [Base post-fetch] 2026-07-10 03:07:48.903304 | 2026-07-10 03:07:48.903506 | TASK [diagnose-network : Ensure log directory exists] 2026-07-10 03:07:49.329380 | debian-bookworm | ok 2026-07-10 03:07:49.338917 | 2026-07-10 03:07:49.339129 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-07-10 03:08:01.456217 | debian-bookworm | ok: Runtime: 0:00:05.916985 2026-07-10 03:08:01.464973 | 2026-07-10 03:08:01.465126 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-07-10 03:08:07.528230 | debian-bookworm | ok: Runtime: 0:00:00.003740 2026-07-10 03:08:07.535020 | 2026-07-10 03:08:07.535176 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-07-10 03:08:13.812325 | debian-bookworm | ok: Runtime: 0:00:00.009160 2026-07-10 03:08:13.822846 | 2026-07-10 03:08:13.822976 | TASK [fetch-output : Set log path for multiple nodes] 2026-07-10 03:08:13.867150 | debian-bookworm | skipping: Conditional result was False 2026-07-10 03:08:13.873415 | 2026-07-10 03:08:13.873560 | TASK [fetch-output : Set log path for single node] 2026-07-10 03:08:13.921814 | debian-bookworm | ok 2026-07-10 03:08:13.929505 | 2026-07-10 03:08:13.929637 | LOOP [fetch-output : Ensure local output dirs] 2026-07-10 03:08:14.413495 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/641b6a53773d4507828da8d2be3c0ff9/work/logs" 2026-07-10 03:08:15.190815 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/641b6a53773d4507828da8d2be3c0ff9/work/artifacts" 2026-07-10 03:08:15.943834 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/641b6a53773d4507828da8d2be3c0ff9/work/docs" 2026-07-10 03:08:15.956086 | 2026-07-10 03:08:15.956200 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-10 03:08:17.030312 | debian-bookworm | changed: 2026-07-10 03:08:17.030614 | debian-bookworm | .d..t...... ./ 2026-07-10 03:08:17.030654 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-10 03:08:17.030679 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-10 03:08:17.030701 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-10 03:08:17.030722 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-10 03:08:17.030743 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-10 03:08:17.030790 | debian-bookworm | changed: All items complete 2026-07-10 03:08:17.030817 | 2026-07-10 03:08:18.038337 | debian-bookworm | changed: .d..t...... ./ 2026-07-10 03:08:19.091604 | debian-bookworm | changed: .d..t...... ./ 2026-07-10 03:08:19.105617 | 2026-07-10 03:08:19.105731 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-10 03:08:19.195809 | debian-bookworm | skipping: Conditional result was False 2026-07-10 03:08:19.276555 | debian-bookworm | skipping: Conditional result was False 2026-07-10 03:08:19.316007 | 2026-07-10 03:08:19.316101 | PLAY RECAP 2026-07-10 03:08:19.316149 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-07-10 03:08:19.316180 | 2026-07-10 03:08:19.616790 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-10 03:08:19.618201 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-10 03:08:20.636107 | 2026-07-10 03:08:20.636256 | PLAY [Base post] 2026-07-10 03:08:20.649531 | 2026-07-10 03:08:20.649678 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-10 03:08:21.259939 | debian-bookworm | changed 2026-07-10 03:08:21.266376 | 2026-07-10 03:08:21.266487 | PLAY RECAP 2026-07-10 03:08:21.266555 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-10 03:08:21.266616 | 2026-07-10 03:08:21.398712 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-10 03:08:21.399838 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-10 03:08:23.111045 | 2026-07-10 03:08:23.111194 | PLAY [Base post-logs] 2026-07-10 03:08:23.130177 | 2026-07-10 03:08:23.130315 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-10 03:08:23.842330 | localhost | changed 2026-07-10 03:08:23.852075 | 2026-07-10 03:08:23.852236 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-10 03:08:23.877891 | localhost | ok 2026-07-10 03:08:23.885035 | 2026-07-10 03:08:23.885145 | TASK [Set zuul-log-path fact] 2026-07-10 03:08:23.899787 | localhost | ok 2026-07-10 03:08:23.907520 | 2026-07-10 03:08:23.907625 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-10 03:08:23.932018 | localhost | ok 2026-07-10 03:08:23.934874 | 2026-07-10 03:08:23.934960 | TASK [upload-logs : Create log directories] 2026-07-10 03:08:24.358373 | localhost | changed 2026-07-10 03:08:24.361090 | 2026-07-10 03:08:24.361182 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-10 03:08:24.915399 | localhost -> localhost | ok: Runtime: 0:00:00.005085 2026-07-10 03:08:24.919285 | 2026-07-10 03:08:24.919380 | TASK [upload-logs : Upload logs to log server] 2026-07-10 03:08:25.620758 | localhost | Output suppressed because no_log was given 2026-07-10 03:08:25.622490 | 2026-07-10 03:08:25.622587 | LOOP [upload-logs : Compress console log and json output] 2026-07-10 03:08:25.711925 | localhost | skipping: Conditional result was False 2026-07-10 03:08:25.722764 | localhost | skipping: Conditional result was False 2026-07-10 03:08:25.729540 | 2026-07-10 03:08:25.729665 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-10 03:08:25.791742 | localhost | skipping: Conditional result was False 2026-07-10 03:08:25.792018 | 2026-07-10 03:08:25.797090 | localhost | skipping: Conditional result was False 2026-07-10 03:08:25.804530 | 2026-07-10 03:08:25.804642 | LOOP [upload-logs : Upload console log and json output]