2026-07-16 03:03:57.272756 | Job console starting 2026-07-16 03:03:57.317967 | Updating git repos 2026-07-16 03:03:57.381609 | Cloning repos into workspace 2026-07-16 03:03:57.465487 | Restoring repo states 2026-07-16 03:03:57.480014 | Merging changes 2026-07-16 03:03:57.480034 | Checking out repos 2026-07-16 03:03:57.543086 | Preparing playbooks 2026-07-16 03:03:58.702713 | Running Ansible setup 2026-07-16 03:04:07.045340 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-07-16 03:04:08.134086 | 2026-07-16 03:04:08.134276 | PLAY [Base pre] 2026-07-16 03:04:08.155240 | 2026-07-16 03:04:08.155412 | TASK [Setup log path fact] 2026-07-16 03:04:08.176962 | debian-bookworm | ok 2026-07-16 03:04:08.197762 | 2026-07-16 03:04:08.197940 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-16 03:04:08.234121 | debian-bookworm | ok 2026-07-16 03:04:08.244454 | 2026-07-16 03:04:08.244571 | TASK [emit-job-header : Print job information] 2026-07-16 03:04:08.296273 | # Job Information 2026-07-16 03:04:08.296456 | Ansible Version: 2.16.14 2026-07-16 03:04:08.296491 | Job: tox 2026-07-16 03:04:08.296525 | Pipeline: periodic-daily 2026-07-16 03:04:08.296547 | Executor: 521e9411259a 2026-07-16 03:04:08.296568 | Triggered by: https://github.com/osism/openstack-image-manager 2026-07-16 03:04:08.296592 | Event ID: abca94b784fe42bd8d201e6caf4fedb9 2026-07-16 03:04:08.306229 | 2026-07-16 03:04:08.306352 | LOOP [emit-job-header : Print node information] 2026-07-16 03:04:08.459523 | debian-bookworm | ok: 2026-07-16 03:04:08.459842 | debian-bookworm | # Node Information 2026-07-16 03:04:08.459889 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-07-16 03:04:08.459915 | debian-bookworm | Hostname: debian 2026-07-16 03:04:08.459938 | debian-bookworm | Username: zuul 2026-07-16 03:04:08.459958 | debian-bookworm | Distro: Debian 12.15 2026-07-16 03:04:08.459982 | debian-bookworm | Provider: regiocloud-a 2026-07-16 03:04:08.460002 | debian-bookworm | Region: 2026-07-16 03:04:08.460023 | debian-bookworm | Label: debian-bookworm 2026-07-16 03:04:08.460042 | debian-bookworm | Product Name: OpenStack Nova 2026-07-16 03:04:08.460062 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe69:6848 2026-07-16 03:04:08.478029 | 2026-07-16 03:04:08.478176 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-16 03:04:09.095318 | debian-bookworm -> localhost | changed 2026-07-16 03:04:09.105787 | 2026-07-16 03:04:09.105959 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-16 03:04:10.253442 | debian-bookworm -> localhost | changed 2026-07-16 03:04:10.270270 | 2026-07-16 03:04:10.270400 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-16 03:04:10.600256 | debian-bookworm -> localhost | ok 2026-07-16 03:04:10.607226 | 2026-07-16 03:04:10.607370 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-16 03:04:10.639378 | debian-bookworm | ok 2026-07-16 03:04:10.656028 | debian-bookworm | included: /var/lib/zuul/builds/1fe16e3753d04e62881274784f76b14d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-16 03:04:10.662467 | 2026-07-16 03:04:10.662578 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-16 03:04:12.286286 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-07-16 03:04:12.287115 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/1fe16e3753d04e62881274784f76b14d/work/1fe16e3753d04e62881274784f76b14d_id_rsa 2026-07-16 03:04:12.287574 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/1fe16e3753d04e62881274784f76b14d/work/1fe16e3753d04e62881274784f76b14d_id_rsa.pub 2026-07-16 03:04:12.287633 | debian-bookworm -> localhost | The key fingerprint is: 2026-07-16 03:04:12.287680 | debian-bookworm -> localhost | SHA256:tleqrJCVtUou3OmPtKMbEBj5MdMc15JXYxqADZubyYA zuul-build-sshkey 2026-07-16 03:04:12.288426 | debian-bookworm -> localhost | The key's randomart image is: 2026-07-16 03:04:12.288536 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-07-16 03:04:12.288588 | debian-bookworm -> localhost | |.. oo=o+..+ | 2026-07-16 03:04:12.288634 | debian-bookworm -> localhost | |.++ +++ o+ . | 2026-07-16 03:04:12.288673 | debian-bookworm -> localhost | |E.o+o oo | 2026-07-16 03:04:12.288710 | debian-bookworm -> localhost | | .+ + o . | 2026-07-16 03:04:12.288747 | debian-bookworm -> localhost | | . = + S . | 2026-07-16 03:04:12.288854 | debian-bookworm -> localhost | | o * + . o | 2026-07-16 03:04:12.288898 | debian-bookworm -> localhost | | * * . o | 2026-07-16 03:04:12.288935 | debian-bookworm -> localhost | | *.+ o | 2026-07-16 03:04:12.295932 | debian-bookworm -> localhost | | oo=++ | 2026-07-16 03:04:12.296086 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-07-16 03:04:12.296214 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.960492 2026-07-16 03:04:12.312132 | 2026-07-16 03:04:12.312257 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-16 03:04:12.382008 | debian-bookworm | ok 2026-07-16 03:04:12.404402 | debian-bookworm | included: /var/lib/zuul/builds/1fe16e3753d04e62881274784f76b14d/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-16 03:04:12.417380 | 2026-07-16 03:04:12.417527 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-16 03:04:12.446221 | debian-bookworm | skipping: Conditional result was False 2026-07-16 03:04:12.455861 | 2026-07-16 03:04:12.456015 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-16 03:04:13.224635 | debian-bookworm | changed 2026-07-16 03:04:13.230853 | 2026-07-16 03:04:13.230984 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-16 03:04:13.596151 | debian-bookworm | ok 2026-07-16 03:04:13.603622 | 2026-07-16 03:04:13.603757 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-16 03:04:14.555472 | debian-bookworm | changed 2026-07-16 03:04:14.567484 | 2026-07-16 03:04:14.567636 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-16 03:04:15.437061 | debian-bookworm | changed 2026-07-16 03:04:15.451273 | 2026-07-16 03:04:15.451443 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-16 03:04:15.511091 | debian-bookworm | skipping: Conditional result was False 2026-07-16 03:04:15.529534 | 2026-07-16 03:04:15.529666 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-16 03:04:16.565555 | debian-bookworm -> localhost | changed 2026-07-16 03:04:16.579267 | 2026-07-16 03:04:16.579392 | TASK [add-build-sshkey : Add back temp key] 2026-07-16 03:04:17.195551 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/1fe16e3753d04e62881274784f76b14d/work/1fe16e3753d04e62881274784f76b14d_id_rsa (zuul-build-sshkey) 2026-07-16 03:04:17.195922 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.032031 2026-07-16 03:04:17.206867 | 2026-07-16 03:04:17.207025 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-16 03:04:17.727638 | debian-bookworm | ok 2026-07-16 03:04:17.744072 | 2026-07-16 03:04:17.744299 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-16 03:04:17.792243 | debian-bookworm | skipping: Conditional result was False 2026-07-16 03:04:17.805952 | 2026-07-16 03:04:17.806086 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-07-16 03:04:18.296927 | debian-bookworm | ok 2026-07-16 03:04:18.319687 | 2026-07-16 03:04:18.319930 | TASK [validate-host : Define zuul_info_dir fact] 2026-07-16 03:04:18.363746 | debian-bookworm | ok 2026-07-16 03:04:18.370498 | 2026-07-16 03:04:18.370637 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-07-16 03:04:19.127444 | debian-bookworm -> localhost | ok 2026-07-16 03:04:19.143010 | 2026-07-16 03:04:19.143194 | TASK [validate-host : Collect information about the host] 2026-07-16 03:04:20.624827 | debian-bookworm | ok 2026-07-16 03:04:20.658704 | 2026-07-16 03:04:20.658927 | TASK [validate-host : Sanitize hostname] 2026-07-16 03:04:20.839409 | debian-bookworm | ok 2026-07-16 03:04:20.844857 | 2026-07-16 03:04:20.844974 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-07-16 03:04:21.771476 | debian-bookworm -> localhost | changed 2026-07-16 03:04:21.778429 | 2026-07-16 03:04:21.778569 | TASK [validate-host : Collect information about zuul worker] 2026-07-16 03:04:22.476530 | debian-bookworm | ok 2026-07-16 03:04:22.487011 | 2026-07-16 03:04:22.487180 | TASK [validate-host : Write out all zuul information for each host] 2026-07-16 03:04:23.239479 | debian-bookworm -> localhost | changed 2026-07-16 03:04:23.252707 | 2026-07-16 03:04:23.252870 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-07-16 03:04:23.645121 | debian-bookworm | ok 2026-07-16 03:04:23.663125 | 2026-07-16 03:04:23.663259 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-07-16 03:04:25.507487 | debian-bookworm | changed: 2026-07-16 03:04:25.507727 | debian-bookworm | cd+++++++++ src/ 2026-07-16 03:04:25.507837 | debian-bookworm | cd+++++++++ src/github.com/ 2026-07-16 03:04:25.507865 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-07-16 03:04:25.507887 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-07-16 03:04:25.507908 | debian-bookworm | =7.0.3 2026-07-16 03:05:07.569266 | debian-bookworm | Downloading cachetools-7.1.4-py3-none-any.whl (16 kB) 2026-07-16 03:05:07.613492 | debian-bookworm | Collecting colorama>=0.4.6 2026-07-16 03:05:07.624877 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-07-16 03:05:07.689405 | debian-bookworm | Collecting filelock>=3.25 2026-07-16 03:05:07.701227 | debian-bookworm | Downloading filelock-3.29.7-py3-none-any.whl (46 kB) 2026-07-16 03:05:07.709443 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 46.0/46.0 kB 7.0 MB/s eta 0:00:00 2026-07-16 03:05:07.763649 | debian-bookworm | Collecting packaging>=26 2026-07-16 03:05:07.775264 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-07-16 03:05:07.785523 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 13.0 MB/s eta 0:00:00 2026-07-16 03:05:07.834848 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-07-16 03:05:07.846047 | debian-bookworm | Downloading platformdirs-4.10.0-py3-none-any.whl (22 kB) 2026-07-16 03:05:07.888437 | debian-bookworm | Collecting pluggy>=1.6 2026-07-16 03:05:07.899836 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-07-16 03:05:07.949629 | debian-bookworm | Collecting pyproject-api>=1.10 2026-07-16 03:05:07.961729 | debian-bookworm | Downloading pyproject_api-1.10.1-py3-none-any.whl (12 kB) 2026-07-16 03:05:08.003318 | debian-bookworm | Collecting python-discovery>=1.4.4 2026-07-16 03:05:08.015153 | debian-bookworm | Downloading python_discovery-1.4.4-py3-none-any.whl (34 kB) 2026-07-16 03:05:08.052698 | debian-bookworm | Collecting tomli-w>=1.2 2026-07-16 03:05:08.064300 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-07-16 03:05:08.215218 | debian-bookworm | Collecting virtualenv>=21.1 2026-07-16 03:05:08.226577 | debian-bookworm | Downloading virtualenv-21.6.1-py3-none-any.whl (5.5 MB) 2026-07-16 03:05:08.523375 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.5/5.5 MB 18.9 MB/s eta 0:00:00 2026-07-16 03:05:08.639135 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-07-16 03:05:08.650938 | debian-bookworm | Downloading distlib-0.4.3-py2.py3-none-any.whl (470 kB) 2026-07-16 03:05:08.671995 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 470.6/470.6 kB 26.9 MB/s eta 0:00:00 2026-07-16 03:05:08.794835 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-07-16 03:05:09.647393 | 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.1 2026-07-16 03:05:09.904265 | debian-bookworm | ok: Runtime: 0:00:03.119923 2026-07-16 03:05:09.911192 | 2026-07-16 03:05:09.911267 | TASK [ensure-tox : Export installed tox_executable path] 2026-07-16 03:05:09.939240 | debian-bookworm | ok 2026-07-16 03:05:09.943259 | 2026-07-16 03:05:09.943332 | TASK [ensure-tox : Output tox version] 2026-07-16 03:05:10.540357 | 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-16 03:05:10.558216 | debian-bookworm | 4.56.4 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-16 03:05:10.983336 | debian-bookworm | ok: Runtime: 0:00:00.360669 2026-07-16 03:05:10.989499 | 2026-07-16 03:05:10.989619 | TASK [ensure-tox : Make global symlink] 2026-07-16 03:05:11.023883 | debian-bookworm | skipping: Conditional result was False 2026-07-16 03:05:11.033805 | 2026-07-16 03:05:11.033880 | PLAY RECAP 2026-07-16 03:05:11.033933 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-07-16 03:05:11.034110 | 2026-07-16 03:05:11.318685 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-07-16 03:05:11.319819 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-07-16 03:05:12.449104 | 2026-07-16 03:05:12.449243 | PLAY [all] 2026-07-16 03:05:12.503168 | 2026-07-16 03:05:12.503317 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-07-16 03:05:13.106968 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-07-16 03:05:13.572754 | debian-bookworm | ok: Runtime: 0:00:00.020994 2026-07-16 03:05:13.578667 | 2026-07-16 03:05:13.578772 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-07-16 03:05:14.102924 | debian-bookworm | ok: Runtime: 0:00:00.005439 2026-07-16 03:05:14.107853 | 2026-07-16 03:05:14.107950 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-07-16 03:05:14.397330 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-07-16 03:05:14.398947 | debian-bookworm | sudo: a password is required 2026-07-16 03:05:14.636457 | debian-bookworm | ok: Runtime: 0:00:00.027129 2026-07-16 03:05:14.644468 | 2026-07-16 03:05:14.644552 | TASK [tox : Check to see if the constraints file exists] 2026-07-16 03:05:14.668025 | debian-bookworm | skipping: Conditional result was False 2026-07-16 03:05:14.673007 | 2026-07-16 03:05:14.673098 | TASK [tox : Fail if constraints file is missing] 2026-07-16 03:05:14.698818 | debian-bookworm | skipping: Conditional result was False 2026-07-16 03:05:14.703841 | 2026-07-16 03:05:14.703943 | TASK [tox : Record file location] 2026-07-16 03:05:14.726938 | debian-bookworm | skipping: Conditional result was False 2026-07-16 03:05:14.731671 | 2026-07-16 03:05:14.731759 | TASK [tox : Install tox siblings] 2026-07-16 03:05:14.766963 | debian-bookworm | ok 2026-07-16 03:05:14.774280 | debian-bookworm | included: /var/lib/zuul/builds/1fe16e3753d04e62881274784f76b14d/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-07-16 03:05:14.781083 | 2026-07-16 03:05:14.781174 | TASK [tox : Run tox without tests] 2026-07-16 03:05:16.293395 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-07-16 03:05:30.582681 | debian-bookworm | test: OK (15.14 seconds) 2026-07-16 03:05:30.582770 | debian-bookworm | congratulations :) (15.17 seconds) 2026-07-16 03:05:30.837286 | debian-bookworm | ok: Runtime: 0:00:15.482679 2026-07-16 03:05:30.843917 | 2026-07-16 03:05:30.844043 | TASK [tox : Create a tempfile to save tox showconfig] 2026-07-16 03:05:31.339562 | debian-bookworm | changed 2026-07-16 03:05:31.354020 | 2026-07-16 03:05:31.354216 | TASK [tox : Detect tox version] 2026-07-16 03:05:31.961600 | debian-bookworm | 4.56.4 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-16 03:05:32.401898 | debian-bookworm | ok: Runtime: 0:00:00.343357 2026-07-16 03:05:32.409412 | 2026-07-16 03:05:32.409603 | TASK [tox : Get tox envlist config] 2026-07-16 03:05:33.457606 | debian-bookworm | ok: Runtime: 0:00:00.530002 2026-07-16 03:05:33.464000 | 2026-07-16 03:05:33.464133 | TASK [tox : Install any sibling python packages] 2026-07-16 03:05:34.085778 | debian-bookworm | ok: No setup.cfg, no action needed 2026-07-16 03:05:34.091976 | 2026-07-16 03:05:34.092110 | TASK [tox : Remove tempfile] 2026-07-16 03:05:34.872725 | debian-bookworm | changed 2026-07-16 03:05:34.879050 | 2026-07-16 03:05:34.879186 | TASK [tox : Emit tox command] 2026-07-16 03:05:34.933564 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-07-16 03:05:34.948268 | 2026-07-16 03:05:34.948445 | TASK [tox : Run tox] 2026-07-16 03:05:35.651296 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-07-16 03:05:37.989432 | debian-bookworm | ............................................. 2026-07-16 03:05:37.989525 | debian-bookworm | ---------------------------------------------------------------------- 2026-07-16 03:05:37.989541 | debian-bookworm | Ran 45 tests in 1.766s 2026-07-16 03:05:37.989551 | debian-bookworm | 2026-07-16 03:05:37.989561 | debian-bookworm | OK 2026-07-16 03:05:38.165010 | debian-bookworm | test: OK (2.56=setup[0.05]+cmd[2.51] seconds) 2026-07-16 03:05:38.165113 | debian-bookworm | congratulations :) (2.59 seconds) 2026-07-16 03:05:38.492343 | debian-bookworm | ok: Runtime: 0:00:02.948293 2026-07-16 03:05:38.502433 | 2026-07-16 03:05:38.502569 | TASK [tox : Look for output] 2026-07-16 03:05:39.068677 | debian-bookworm | ok 2026-07-16 03:05:39.095400 | 2026-07-16 03:05:39.095595 | TASK [tox : Return file comments to Zuul] 2026-07-16 03:05:39.130804 | debian-bookworm | skipping: Conditional result was False 2026-07-16 03:05:39.140361 | 2026-07-16 03:05:39.140489 | PLAY RECAP 2026-07-16 03:05:39.140579 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-07-16 03:05:39.140605 | 2026-07-16 03:05:39.343161 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-07-16 03:05:39.346704 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-07-16 03:05:40.246444 | 2026-07-16 03:05:40.246705 | PLAY [all] 2026-07-16 03:05:40.290602 | 2026-07-16 03:05:40.290808 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-07-16 03:05:40.405802 | debian-bookworm | skipping: Conditional result was False 2026-07-16 03:05:40.412697 | 2026-07-16 03:05:40.412931 | TASK [fetch-tox-output : Set tox log path for single node] 2026-07-16 03:05:40.491104 | debian-bookworm | ok 2026-07-16 03:05:40.500698 | 2026-07-16 03:05:40.500835 | TASK [fetch-tox-output : Ensure local tox dir] 2026-07-16 03:05:41.135444 | debian-bookworm -> localhost | changed 2026-07-16 03:05:41.144328 | 2026-07-16 03:05:41.144566 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-07-16 03:05:41.221158 | debian-bookworm | skipping: Conditional result was False 2026-07-16 03:05:41.228556 | 2026-07-16 03:05:41.228712 | TASK [fetch-tox-output : Set envlist fact] 2026-07-16 03:05:41.289833 | debian-bookworm | ok 2026-07-16 03:05:41.296151 | 2026-07-16 03:05:41.296273 | TASK [fetch-tox-output : Get tox version] 2026-07-16 03:05:42.105196 | 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-16 03:05:42.122720 | debian-bookworm | 4.56.4 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-07-16 03:05:42.364155 | debian-bookworm | ok: Runtime: 0:00:00.317568 2026-07-16 03:05:42.372217 | 2026-07-16 03:05:42.372345 | TASK [fetch-tox-output : Find all default environments] 2026-07-16 03:05:42.926602 | debian-bookworm | skipping: Conditional result was False 2026-07-16 03:05:42.939955 | 2026-07-16 03:05:42.940124 | TASK [fetch-tox-output : Set envlist fact] 2026-07-16 03:05:42.979086 | debian-bookworm | skipping: Conditional result was False 2026-07-16 03:05:42.988346 | 2026-07-16 03:05:42.988587 | TASK [fetch-tox-output : Find all default environments] 2026-07-16 03:05:43.524234 | debian-bookworm | skipping: Conditional result was False 2026-07-16 03:05:43.531015 | 2026-07-16 03:05:43.531169 | TASK [fetch-tox-output : Set envlist fact] 2026-07-16 03:05:43.557204 | debian-bookworm | skipping: Conditional result was False 2026-07-16 03:05:43.566126 | 2026-07-16 03:05:43.566311 | LOOP [fetch-tox-output : Copy tox logs] 2026-07-16 03:05:43.631294 | debian-bookworm | skipping: Conditional result was False 2026-07-16 03:05:43.645232 | 2026-07-16 03:05:43.645391 | LOOP [fetch-tox-output : Collect tox logs] 2026-07-16 03:05:44.537593 | debian-bookworm | changed: 2026-07-16 03:05:44.537840 | debian-bookworm | created directory /var/lib/zuul/builds/1fe16e3753d04e62881274784f76b14d/work/logs/tox/test 2026-07-16 03:05:44.537877 | debian-bookworm | cd+++++++++ ./ 2026-07-16 03:05:44.537903 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-07-16 03:05:44.537935 | 2026-07-16 03:05:44.554287 | 2026-07-16 03:05:44.554434 | PLAY RECAP 2026-07-16 03:05:44.554513 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-07-16 03:05:44.554540 | 2026-07-16 03:05:44.731186 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-07-16 03:05:44.732775 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-07-16 03:05:45.999578 | 2026-07-16 03:05:45.999804 | PLAY [all] 2026-07-16 03:05:46.018691 | 2026-07-16 03:05:46.018952 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-07-16 03:05:46.254463 | debian-bookworm | changed: non-zero return code 2026-07-16 03:05:46.260726 | 2026-07-16 03:05:46.260880 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-07-16 03:05:46.286526 | debian-bookworm | skipping: Conditional result was False 2026-07-16 03:05:46.293821 | 2026-07-16 03:05:46.294018 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-07-16 03:05:46.340653 | 2026-07-16 03:05:46.341017 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-07-16 03:05:46.394568 | 2026-07-16 03:05:46.394942 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-07-16 03:05:46.421586 | debian-bookworm | skipping: Conditional result was False 2026-07-16 03:05:46.438420 | 2026-07-16 03:05:46.438757 | LOOP [fetch-subunit-output : Generate subunit file] 2026-07-16 03:05:46.475231 | 2026-07-16 03:05:46.475612 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-07-16 03:05:46.510426 | debian-bookworm | skipping: Conditional result was False 2026-07-16 03:05:46.517940 | 2026-07-16 03:05:46.518098 | TASK [fetch-subunit-output : Remove the temporary file] 2026-07-16 03:05:46.542789 | debian-bookworm | skipping: Conditional result was False 2026-07-16 03:05:46.550074 | 2026-07-16 03:05:46.550221 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-07-16 03:05:46.585930 | debian-bookworm | skipping: Conditional result was False 2026-07-16 03:05:46.605908 | 2026-07-16 03:05:46.606101 | PLAY RECAP 2026-07-16 03:05:46.606197 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-07-16 03:05:46.606243 | 2026-07-16 03:05:46.800374 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-07-16 03:05:46.803437 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-16 03:05:47.704368 | 2026-07-16 03:05:47.704758 | PLAY [Base post-fetch] 2026-07-16 03:05:47.743347 | 2026-07-16 03:05:47.743620 | TASK [diagnose-network : Ensure log directory exists] 2026-07-16 03:05:48.149102 | debian-bookworm | ok 2026-07-16 03:05:48.159204 | 2026-07-16 03:05:48.159384 | TASK [diagnose-network : Snapshot dual-stack network state (post)] 2026-07-16 03:06:00.262478 | debian-bookworm | ok: Runtime: 0:00:05.976295 2026-07-16 03:06:00.269818 | 2026-07-16 03:06:00.269947 | TASK [diagnose-network : Snapshot Docker/BuildKit IPv6 config (teardown)] 2026-07-16 03:06:06.365440 | debian-bookworm | ok: Runtime: 0:00:00.010069 2026-07-16 03:06:06.380771 | 2026-07-16 03:06:06.380930 | TASK [diagnose-network : Probe container network namespace (teardown)] 2026-07-16 03:06:12.529611 | debian-bookworm | ok: Runtime: 0:00:00.008229 2026-07-16 03:06:12.549284 | 2026-07-16 03:06:12.549480 | TASK [fetch-output : Set log path for multiple nodes] 2026-07-16 03:06:12.615058 | debian-bookworm | skipping: Conditional result was False 2026-07-16 03:06:12.623216 | 2026-07-16 03:06:12.623444 | TASK [fetch-output : Set log path for single node] 2026-07-16 03:06:12.690269 | debian-bookworm | ok 2026-07-16 03:06:12.695721 | 2026-07-16 03:06:12.695873 | LOOP [fetch-output : Ensure local output dirs] 2026-07-16 03:06:13.395625 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/1fe16e3753d04e62881274784f76b14d/work/logs" 2026-07-16 03:06:14.133681 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/1fe16e3753d04e62881274784f76b14d/work/artifacts" 2026-07-16 03:06:14.473456 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/1fe16e3753d04e62881274784f76b14d/work/docs" 2026-07-16 03:06:14.487392 | 2026-07-16 03:06:14.487519 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-16 03:06:15.657218 | debian-bookworm | changed: 2026-07-16 03:06:15.657470 | debian-bookworm | .d..t...... ./ 2026-07-16 03:06:15.657515 | debian-bookworm | >f+++++++++ net-debug.post.txt 2026-07-16 03:06:15.657551 | debian-bookworm | >f+++++++++ net-debug.pre.txt 2026-07-16 03:06:15.657575 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-07-16 03:06:15.657597 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-07-16 03:06:15.657618 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-07-16 03:06:15.657660 | debian-bookworm | changed: All items complete 2026-07-16 03:06:15.657686 | 2026-07-16 03:06:16.788697 | debian-bookworm | changed: .d..t...... ./ 2026-07-16 03:06:17.610597 | debian-bookworm | changed: .d..t...... ./ 2026-07-16 03:06:17.634310 | 2026-07-16 03:06:17.634488 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-16 03:06:17.677821 | debian-bookworm | skipping: Conditional result was False 2026-07-16 03:06:17.692250 | debian-bookworm | skipping: Conditional result was False 2026-07-16 03:06:17.706586 | 2026-07-16 03:06:17.706675 | PLAY RECAP 2026-07-16 03:06:17.706729 | debian-bookworm | ok: 7 changed: 2 unreachable: 0 failed: 0 skipped: 2 rescued: 0 ignored: 0 2026-07-16 03:06:17.706754 | 2026-07-16 03:06:17.947118 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-07-16 03:06:17.948108 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-16 03:06:19.023125 | 2026-07-16 03:06:19.023265 | PLAY [Base post] 2026-07-16 03:06:19.049385 | 2026-07-16 03:06:19.049516 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-16 03:06:19.655757 | debian-bookworm | changed 2026-07-16 03:06:19.666721 | 2026-07-16 03:06:19.666822 | PLAY RECAP 2026-07-16 03:06:19.666919 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-16 03:06:19.666982 | 2026-07-16 03:06:19.772177 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-07-16 03:06:19.773187 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-16 03:06:21.352129 | 2026-07-16 03:06:21.352342 | PLAY [Base post-logs] 2026-07-16 03:06:21.378204 | 2026-07-16 03:06:21.378407 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-16 03:06:22.351821 | localhost | changed 2026-07-16 03:06:22.378795 | 2026-07-16 03:06:22.378984 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-16 03:06:22.418280 | localhost | ok 2026-07-16 03:06:22.424151 | 2026-07-16 03:06:22.424251 | TASK [Set zuul-log-path fact] 2026-07-16 03:06:22.442215 | localhost | ok 2026-07-16 03:06:22.460150 | 2026-07-16 03:06:22.460276 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-16 03:06:22.497823 | localhost | ok 2026-07-16 03:06:22.503576 | 2026-07-16 03:06:22.503686 | TASK [upload-logs : Create log directories] 2026-07-16 03:06:23.467679 | localhost | changed 2026-07-16 03:06:23.470306 | 2026-07-16 03:06:23.470428 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-16 03:06:24.199995 | localhost -> localhost | ok: Runtime: 0:00:00.031051 2026-07-16 03:06:24.203782 | 2026-07-16 03:06:24.203884 | TASK [upload-logs : Upload logs to log server] 2026-07-16 03:06:25.144413 | localhost | Output suppressed because no_log was given 2026-07-16 03:06:25.146072 | 2026-07-16 03:06:25.146158 | LOOP [upload-logs : Compress console log and json output] 2026-07-16 03:06:25.252177 | localhost | skipping: Conditional result was False 2026-07-16 03:06:25.264010 | localhost | skipping: Conditional result was False 2026-07-16 03:06:25.273178 | 2026-07-16 03:06:25.273305 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-16 03:06:25.359848 | localhost | skipping: Conditional result was False 2026-07-16 03:06:25.360154 | 2026-07-16 03:06:25.382850 | localhost | skipping: Conditional result was False 2026-07-16 03:06:25.391004 | 2026-07-16 03:06:25.391164 | LOOP [upload-logs : Upload console log and json output]