2026-05-28 08:20:08.785672 | Job console starting 2026-05-28 08:20:08.795365 | Updating git repos 2026-05-28 08:20:08.827109 | Cloning repos into workspace 2026-05-28 08:20:08.867010 | Restoring repo states 2026-05-28 08:20:08.885915 | Merging changes 2026-05-28 08:20:09.571640 | Checking out repos 2026-05-28 08:20:09.648789 | Preparing playbooks 2026-05-28 08:20:11.082152 | Running Ansible setup 2026-05-28 08:20:15.651197 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-28 08:20:16.289378 | 2026-05-28 08:20:16.289499 | PLAY [Base pre] 2026-05-28 08:20:16.303220 | 2026-05-28 08:20:16.303326 | TASK [Setup log path fact] 2026-05-28 08:20:16.330921 | debian-bookworm | ok 2026-05-28 08:20:16.355820 | 2026-05-28 08:20:16.355940 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-28 08:20:16.384012 | debian-bookworm | ok 2026-05-28 08:20:16.392852 | 2026-05-28 08:20:16.393171 | TASK [emit-job-header : Print job information] 2026-05-28 08:20:16.465361 | # Job Information 2026-05-28 08:20:16.465574 | Ansible Version: 2.16.14 2026-05-28 08:20:16.465610 | Job: tox 2026-05-28 08:20:16.465643 | Pipeline: check 2026-05-28 08:20:16.465666 | Executor: 521e9411259a 2026-05-28 08:20:16.465683 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1218 2026-05-28 08:20:16.465701 | Event ID: fc293490-5a6d-11f1-991c-ca3aca0446eb 2026-05-28 08:20:16.470048 | 2026-05-28 08:20:16.470139 | LOOP [emit-job-header : Print node information] 2026-05-28 08:20:16.630103 | debian-bookworm | ok: 2026-05-28 08:20:16.630332 | debian-bookworm | # Node Information 2026-05-28 08:20:16.630369 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-28 08:20:16.630394 | debian-bookworm | Hostname: debian 2026-05-28 08:20:16.630416 | debian-bookworm | Username: zuul 2026-05-28 08:20:16.630436 | debian-bookworm | Distro: Debian 12.14 2026-05-28 08:20:16.630460 | debian-bookworm | Provider: regiocloud-a 2026-05-28 08:20:16.630481 | debian-bookworm | Region: 2026-05-28 08:20:16.630524 | debian-bookworm | Label: debian-bookworm 2026-05-28 08:20:16.630548 | debian-bookworm | Product Name: OpenStack Nova 2026-05-28 08:20:16.630568 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fe72:4a24 2026-05-28 08:20:16.649131 | 2026-05-28 08:20:16.649237 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-28 08:20:17.071936 | debian-bookworm -> localhost | changed 2026-05-28 08:20:17.077944 | 2026-05-28 08:20:17.078040 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-28 08:20:18.157273 | debian-bookworm -> localhost | changed 2026-05-28 08:20:18.168657 | 2026-05-28 08:20:18.168790 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-28 08:20:18.711171 | debian-bookworm -> localhost | ok 2026-05-28 08:20:18.717605 | 2026-05-28 08:20:18.717716 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-28 08:20:18.750589 | debian-bookworm | ok 2026-05-28 08:20:18.775419 | debian-bookworm | included: /var/lib/zuul/builds/2ed3c87eeb2146708f404a773a840722/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-28 08:20:18.792634 | 2026-05-28 08:20:18.792742 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-28 08:20:21.908672 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-28 08:20:21.908862 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/2ed3c87eeb2146708f404a773a840722/work/2ed3c87eeb2146708f404a773a840722_id_rsa 2026-05-28 08:20:21.908898 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/2ed3c87eeb2146708f404a773a840722/work/2ed3c87eeb2146708f404a773a840722_id_rsa.pub 2026-05-28 08:20:21.908924 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-28 08:20:21.908947 | debian-bookworm -> localhost | SHA256:YhOtnnB1EyDj1XdCFU1bzjvxFxyhysESS1aqAR7Gzko zuul-build-sshkey 2026-05-28 08:20:21.908969 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-28 08:20:21.908999 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-28 08:20:21.909020 | debian-bookworm -> localhost | | .+o o*oo..o*+| 2026-05-28 08:20:21.909041 | debian-bookworm -> localhost | | ooo=o *.o +o=| 2026-05-28 08:20:21.909062 | debian-bookworm -> localhost | | o.o.o+o+ + =o| 2026-05-28 08:20:21.909082 | debian-bookworm -> localhost | | E o +o.o.o =| 2026-05-28 08:20:21.909101 | debian-bookworm -> localhost | | . o *.S o oo| 2026-05-28 08:20:21.909128 | debian-bookworm -> localhost | | . = + o| 2026-05-28 08:20:21.909150 | debian-bookworm -> localhost | | o | 2026-05-28 08:20:21.909170 | debian-bookworm -> localhost | | | 2026-05-28 08:20:21.909191 | debian-bookworm -> localhost | | | 2026-05-28 08:20:21.909212 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-28 08:20:21.909260 | debian-bookworm -> localhost | ok: Runtime: 0:00:02.169765 2026-05-28 08:20:21.915896 | 2026-05-28 08:20:21.916001 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-28 08:20:21.960255 | debian-bookworm | ok 2026-05-28 08:20:21.996045 | debian-bookworm | included: /var/lib/zuul/builds/2ed3c87eeb2146708f404a773a840722/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-28 08:20:22.056158 | 2026-05-28 08:20:22.056273 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-28 08:20:22.086372 | debian-bookworm | skipping: Conditional result was False 2026-05-28 08:20:22.092653 | 2026-05-28 08:20:22.092783 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-28 08:20:23.495825 | debian-bookworm | changed 2026-05-28 08:20:23.502802 | 2026-05-28 08:20:23.502942 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-28 08:20:23.828888 | debian-bookworm | ok 2026-05-28 08:20:23.847926 | 2026-05-28 08:20:23.848041 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-28 08:20:24.749981 | debian-bookworm | changed 2026-05-28 08:20:24.757992 | 2026-05-28 08:20:24.758092 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-28 08:20:25.596127 | debian-bookworm | changed 2026-05-28 08:20:25.602786 | 2026-05-28 08:20:25.602894 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-28 08:20:25.659561 | debian-bookworm | skipping: Conditional result was False 2026-05-28 08:20:25.666243 | 2026-05-28 08:20:25.666343 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-28 08:20:27.002154 | debian-bookworm -> localhost | changed 2026-05-28 08:20:27.013718 | 2026-05-28 08:20:27.013827 | TASK [add-build-sshkey : Add back temp key] 2026-05-28 08:20:27.592318 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/2ed3c87eeb2146708f404a773a840722/work/2ed3c87eeb2146708f404a773a840722_id_rsa (zuul-build-sshkey) 2026-05-28 08:20:27.592669 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.009403 2026-05-28 08:20:27.600165 | 2026-05-28 08:20:27.600265 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-28 08:20:28.042756 | debian-bookworm | ok 2026-05-28 08:20:28.061372 | 2026-05-28 08:20:28.061482 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-28 08:20:28.098715 | debian-bookworm | skipping: Conditional result was False 2026-05-28 08:20:28.108354 | 2026-05-28 08:20:28.108446 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-28 08:20:28.892109 | debian-bookworm | ok 2026-05-28 08:20:28.904878 | 2026-05-28 08:20:28.904972 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-28 08:20:28.935675 | debian-bookworm | ok 2026-05-28 08:20:28.939823 | 2026-05-28 08:20:28.939900 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-28 08:20:29.311348 | debian-bookworm -> localhost | ok 2026-05-28 08:20:29.317749 | 2026-05-28 08:20:29.317846 | TASK [validate-host : Collect information about the host] 2026-05-28 08:20:30.734566 | debian-bookworm | ok 2026-05-28 08:20:30.776174 | 2026-05-28 08:20:30.776282 | TASK [validate-host : Sanitize hostname] 2026-05-28 08:20:30.874977 | debian-bookworm | ok 2026-05-28 08:20:30.955449 | 2026-05-28 08:20:30.955566 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-28 08:20:32.291037 | debian-bookworm -> localhost | changed 2026-05-28 08:20:32.296619 | 2026-05-28 08:20:32.296705 | TASK [validate-host : Collect information about zuul worker] 2026-05-28 08:20:32.855026 | debian-bookworm | ok 2026-05-28 08:20:32.858827 | 2026-05-28 08:20:32.858921 | TASK [validate-host : Write out all zuul information for each host] 2026-05-28 08:20:33.756096 | debian-bookworm -> localhost | changed 2026-05-28 08:20:33.763722 | 2026-05-28 08:20:33.763807 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-28 08:20:34.052211 | debian-bookworm | ok 2026-05-28 08:20:34.061124 | 2026-05-28 08:20:34.061215 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-28 08:20:35.387063 | debian-bookworm | changed: 2026-05-28 08:20:35.387766 | debian-bookworm | cd+++++++++ src/ 2026-05-28 08:20:35.387923 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-28 08:20:35.387949 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-28 08:20:35.387967 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-05-28 08:20:35.387985 | debian-bookworm | =7.0.3 2026-05-28 08:21:02.507758 | debian-bookworm | Downloading cachetools-7.1.4-py3-none-any.whl (16 kB) 2026-05-28 08:21:02.560849 | debian-bookworm | Collecting colorama>=0.4.6 2026-05-28 08:21:02.573036 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-05-28 08:21:02.642656 | debian-bookworm | Collecting filelock>=3.25 2026-05-28 08:21:02.654824 | debian-bookworm | Downloading filelock-3.29.0-py3-none-any.whl (39 kB) 2026-05-28 08:21:02.709692 | debian-bookworm | Collecting packaging>=26 2026-05-28 08:21:02.722092 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-05-28 08:21:02.735021 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 10.3 MB/s eta 0:00:00 2026-05-28 08:21:02.792054 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-05-28 08:21:02.804890 | debian-bookworm | Downloading platformdirs-4.10.0-py3-none-any.whl (22 kB) 2026-05-28 08:21:02.861518 | debian-bookworm | Collecting pluggy>=1.6 2026-05-28 08:21:02.874086 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-05-28 08:21:02.920163 | debian-bookworm | Collecting pyproject-api>=1.10 2026-05-28 08:21:02.933830 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-05-28 08:21:02.971684 | debian-bookworm | Collecting python-discovery>=1.2.2 2026-05-28 08:21:02.983847 | debian-bookworm | Downloading python_discovery-1.4.0-py3-none-any.whl (33 kB) 2026-05-28 08:21:03.035669 | debian-bookworm | Collecting tomli-w>=1.2 2026-05-28 08:21:03.048474 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-05-28 08:21:03.198471 | debian-bookworm | Collecting virtualenv>=21.1 2026-05-28 08:21:03.212436 | debian-bookworm | Downloading virtualenv-21.4.1-py3-none-any.whl (7.6 MB) 2026-05-28 08:21:03.555012 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 7.6/7.6 MB 22.6 MB/s eta 0:00:00 2026-05-28 08:21:03.707425 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-05-28 08:21:03.720848 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-05-28 08:21:03.864028 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 3.4 MB/s eta 0:00:00 2026-05-28 08:21:03.985236 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-05-28 08:21:04.844420 | debian-bookworm | Successfully installed cachetools-7.1.4 colorama-0.4.6 distlib-0.4.0 filelock-3.29.0 packaging-26.2 platformdirs-4.10.0 pluggy-1.6.0 pyproject-api-1.10.0 python-discovery-1.4.0 tomli-w-1.2.0 tox-4.55.0 virtualenv-21.4.1 2026-05-28 08:21:05.339810 | debian-bookworm | ok: Runtime: 0:00:03.367366 2026-05-28 08:21:05.346865 | 2026-05-28 08:21:05.346967 | TASK [ensure-tox : Export installed tox_executable path] 2026-05-28 08:21:05.388583 | debian-bookworm | ok 2026-05-28 08:21:05.394333 | 2026-05-28 08:21:05.394477 | TASK [ensure-tox : Output tox version] 2026-05-28 08:21:06.008662 | 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-05-28 08:21:06.030582 | debian-bookworm | 4.55.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-28 08:21:06.428641 | debian-bookworm | ok: Runtime: 0:00:00.382699 2026-05-28 08:21:06.433913 | 2026-05-28 08:21:06.433994 | TASK [ensure-tox : Make global symlink] 2026-05-28 08:21:06.467401 | debian-bookworm | skipping: Conditional result was False 2026-05-28 08:21:06.476127 | 2026-05-28 08:21:06.476210 | PLAY RECAP 2026-05-28 08:21:06.476259 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-05-28 08:21:06.476285 | 2026-05-28 08:21:06.725940 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-05-28 08:21:06.726965 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-05-28 08:21:07.574660 | 2026-05-28 08:21:07.574779 | PLAY [all] 2026-05-28 08:21:07.589746 | 2026-05-28 08:21:07.589854 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-05-28 08:21:08.197289 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-05-28 08:21:08.627448 | debian-bookworm | ok: Runtime: 0:00:00.028407 2026-05-28 08:21:08.632329 | 2026-05-28 08:21:08.632437 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-05-28 08:21:09.178768 | debian-bookworm | ok: Runtime: 0:00:00.006445 2026-05-28 08:21:09.184981 | 2026-05-28 08:21:09.185081 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-05-28 08:21:09.479143 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-05-28 08:21:09.481009 | debian-bookworm | sudo: a password is required 2026-05-28 08:21:09.720285 | debian-bookworm | ok: Runtime: 0:00:00.023667 2026-05-28 08:21:09.742573 | 2026-05-28 08:21:09.742702 | TASK [tox : Check to see if the constraints file exists] 2026-05-28 08:21:09.798167 | debian-bookworm | skipping: Conditional result was False 2026-05-28 08:21:09.807871 | 2026-05-28 08:21:09.808038 | TASK [tox : Fail if constraints file is missing] 2026-05-28 08:21:09.831712 | debian-bookworm | skipping: Conditional result was False 2026-05-28 08:21:09.838875 | 2026-05-28 08:21:09.839033 | TASK [tox : Record file location] 2026-05-28 08:21:09.863678 | debian-bookworm | skipping: Conditional result was False 2026-05-28 08:21:09.869499 | 2026-05-28 08:21:09.869624 | TASK [tox : Install tox siblings] 2026-05-28 08:21:09.889659 | debian-bookworm | ok 2026-05-28 08:21:09.899589 | debian-bookworm | included: /var/lib/zuul/builds/2ed3c87eeb2146708f404a773a840722/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-05-28 08:21:09.905013 | 2026-05-28 08:21:09.905101 | TASK [tox : Run tox without tests] 2026-05-28 08:21:11.247178 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-05-28 08:21:24.897080 | debian-bookworm | test: OK (14.43 seconds) 2026-05-28 08:21:24.897210 | debian-bookworm | congratulations :) (14.45 seconds) 2026-05-28 08:21:25.443515 | debian-bookworm | ok: Runtime: 0:00:14.760704 2026-05-28 08:21:25.458559 | 2026-05-28 08:21:25.458803 | TASK [tox : Create a tempfile to save tox showconfig] 2026-05-28 08:21:25.899488 | debian-bookworm | changed 2026-05-28 08:21:25.907512 | 2026-05-28 08:21:25.907714 | TASK [tox : Detect tox version] 2026-05-28 08:21:26.480390 | debian-bookworm | 4.55.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-28 08:21:26.943733 | debian-bookworm | ok: Runtime: 0:00:00.328484 2026-05-28 08:21:26.956616 | 2026-05-28 08:21:26.956779 | TASK [tox : Get tox envlist config] 2026-05-28 08:21:27.996191 | debian-bookworm | ok: Runtime: 0:00:00.382190 2026-05-28 08:21:28.008032 | 2026-05-28 08:21:28.008185 | TASK [tox : Install any sibling python packages] 2026-05-28 08:21:28.506611 | debian-bookworm | ok: No setup.cfg, no action needed 2026-05-28 08:21:28.515872 | 2026-05-28 08:21:28.516008 | TASK [tox : Remove tempfile] 2026-05-28 08:21:29.025937 | debian-bookworm | changed 2026-05-28 08:21:29.033484 | 2026-05-28 08:21:29.033634 | TASK [tox : Emit tox command] 2026-05-28 08:21:29.078930 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-05-28 08:21:29.086819 | 2026-05-28 08:21:29.087003 | TASK [tox : Run tox] 2026-05-28 08:21:29.752014 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-05-28 08:21:30.557285 | debian-bookworm | ............... 2026-05-28 08:21:30.557365 | debian-bookworm | ---------------------------------------------------------------------- 2026-05-28 08:21:30.557380 | debian-bookworm | Ran 15 tests in 0.223s 2026-05-28 08:21:30.557386 | debian-bookworm | 2026-05-28 08:21:30.557394 | debian-bookworm | OK 2026-05-28 08:21:30.665657 | debian-bookworm | test: OK (0.96=setup[0.05]+cmd[0.91] seconds) 2026-05-28 08:21:30.665730 | debian-bookworm | congratulations :) (0.99 seconds) 2026-05-28 08:21:31.123524 | debian-bookworm | ok: Runtime: 0:00:01.322689 2026-05-28 08:21:31.137812 | 2026-05-28 08:21:31.137987 | TASK [tox : Look for output] 2026-05-28 08:21:31.561838 | debian-bookworm | ok 2026-05-28 08:21:31.579455 | 2026-05-28 08:21:31.579624 | TASK [tox : Return file comments to Zuul] 2026-05-28 08:21:31.614323 | debian-bookworm | skipping: Conditional result was False 2026-05-28 08:21:31.623797 | 2026-05-28 08:21:31.623908 | PLAY RECAP 2026-05-28 08:21:31.623981 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-05-28 08:21:31.624014 | 2026-05-28 08:21:31.774186 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-05-28 08:21:31.776674 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-05-28 08:21:32.529651 | 2026-05-28 08:21:32.529817 | PLAY [all] 2026-05-28 08:21:32.546032 | 2026-05-28 08:21:32.546183 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-05-28 08:21:32.611841 | debian-bookworm | skipping: Conditional result was False 2026-05-28 08:21:32.624623 | 2026-05-28 08:21:32.624857 | TASK [fetch-tox-output : Set tox log path for single node] 2026-05-28 08:21:32.673532 | debian-bookworm | ok 2026-05-28 08:21:32.681399 | 2026-05-28 08:21:32.681545 | TASK [fetch-tox-output : Ensure local tox dir] 2026-05-28 08:21:33.161320 | debian-bookworm -> localhost | changed 2026-05-28 08:21:33.169496 | 2026-05-28 08:21:33.169641 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-05-28 08:21:33.223917 | debian-bookworm | skipping: Conditional result was False 2026-05-28 08:21:33.236055 | 2026-05-28 08:21:33.236308 | TASK [fetch-tox-output : Set envlist fact] 2026-05-28 08:21:33.282313 | debian-bookworm | ok 2026-05-28 08:21:33.292394 | 2026-05-28 08:21:33.292529 | TASK [fetch-tox-output : Get tox version] 2026-05-28 08:21:33.999332 | 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-05-28 08:21:34.017696 | debian-bookworm | 4.55.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-28 08:21:34.324453 | debian-bookworm | ok: Runtime: 0:00:00.324834 2026-05-28 08:21:34.337248 | 2026-05-28 08:21:34.337479 | TASK [fetch-tox-output : Find all default environments] 2026-05-28 08:21:34.883283 | debian-bookworm | skipping: Conditional result was False 2026-05-28 08:21:34.890517 | 2026-05-28 08:21:34.890744 | TASK [fetch-tox-output : Set envlist fact] 2026-05-28 08:21:34.915107 | debian-bookworm | skipping: Conditional result was False 2026-05-28 08:21:34.923316 | 2026-05-28 08:21:34.923442 | TASK [fetch-tox-output : Find all default environments] 2026-05-28 08:21:35.453208 | debian-bookworm | skipping: Conditional result was False 2026-05-28 08:21:35.467873 | 2026-05-28 08:21:35.468083 | TASK [fetch-tox-output : Set envlist fact] 2026-05-28 08:21:35.504822 | debian-bookworm | skipping: Conditional result was False 2026-05-28 08:21:35.523462 | 2026-05-28 08:21:35.523722 | LOOP [fetch-tox-output : Copy tox logs] 2026-05-28 08:21:35.584810 | debian-bookworm | skipping: Conditional result was False 2026-05-28 08:21:35.606673 | 2026-05-28 08:21:35.606907 | LOOP [fetch-tox-output : Collect tox logs] 2026-05-28 08:21:36.430037 | debian-bookworm | changed: 2026-05-28 08:21:36.430382 | debian-bookworm | created directory /var/lib/zuul/builds/2ed3c87eeb2146708f404a773a840722/work/logs/tox/test 2026-05-28 08:21:36.430458 | debian-bookworm | cd+++++++++ ./ 2026-05-28 08:21:36.430514 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-05-28 08:21:36.430624 | 2026-05-28 08:21:36.442340 | 2026-05-28 08:21:36.442448 | PLAY RECAP 2026-05-28 08:21:36.442517 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-05-28 08:21:36.442547 | 2026-05-28 08:21:36.585943 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-05-28 08:21:36.588110 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-05-28 08:21:37.389405 | 2026-05-28 08:21:37.389605 | PLAY [all] 2026-05-28 08:21:37.405953 | 2026-05-28 08:21:37.406125 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-05-28 08:21:37.639278 | debian-bookworm | changed: non-zero return code 2026-05-28 08:21:37.648113 | 2026-05-28 08:21:37.648273 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-05-28 08:21:37.676093 | debian-bookworm | skipping: Conditional result was False 2026-05-28 08:21:37.682284 | 2026-05-28 08:21:37.682425 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-05-28 08:21:37.721119 | 2026-05-28 08:21:37.721328 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-05-28 08:21:37.752399 | 2026-05-28 08:21:37.752630 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-05-28 08:21:37.776261 | debian-bookworm | skipping: Conditional result was False 2026-05-28 08:21:37.783478 | 2026-05-28 08:21:37.783631 | LOOP [fetch-subunit-output : Generate subunit file] 2026-05-28 08:21:37.817312 | 2026-05-28 08:21:37.817709 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-05-28 08:21:37.843133 | debian-bookworm | skipping: Conditional result was False 2026-05-28 08:21:37.856736 | 2026-05-28 08:21:37.856912 | TASK [fetch-subunit-output : Remove the temporary file] 2026-05-28 08:21:37.881909 | debian-bookworm | skipping: Conditional result was False 2026-05-28 08:21:37.893792 | 2026-05-28 08:21:37.893961 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-05-28 08:21:37.919143 | debian-bookworm | skipping: Conditional result was False 2026-05-28 08:21:37.935051 | 2026-05-28 08:21:37.935191 | PLAY RECAP 2026-05-28 08:21:37.935278 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-05-28 08:21:37.935318 | 2026-05-28 08:21:38.079722 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-05-28 08:21:38.082347 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-28 08:21:38.856632 | 2026-05-28 08:21:38.856815 | PLAY [Base post-fetch] 2026-05-28 08:21:38.871898 | 2026-05-28 08:21:38.872062 | TASK [fetch-output : Set log path for multiple nodes] 2026-05-28 08:21:38.918007 | debian-bookworm | skipping: Conditional result was False 2026-05-28 08:21:38.924792 | 2026-05-28 08:21:38.924972 | TASK [fetch-output : Set log path for single node] 2026-05-28 08:21:38.967488 | debian-bookworm | ok 2026-05-28 08:21:38.972895 | 2026-05-28 08:21:38.973022 | LOOP [fetch-output : Ensure local output dirs] 2026-05-28 08:21:39.488252 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/2ed3c87eeb2146708f404a773a840722/work/logs" 2026-05-28 08:21:39.777941 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/2ed3c87eeb2146708f404a773a840722/work/artifacts" 2026-05-28 08:21:40.062790 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/2ed3c87eeb2146708f404a773a840722/work/docs" 2026-05-28 08:21:40.078506 | 2026-05-28 08:21:40.078737 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-28 08:21:40.873439 | debian-bookworm | changed: 2026-05-28 08:21:40.873737 | debian-bookworm | .d..t...... ./ 2026-05-28 08:21:40.873779 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-28 08:21:40.873810 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-28 08:21:40.873837 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-28 08:21:40.873878 | debian-bookworm | changed: All items complete 2026-05-28 08:21:40.873903 | 2026-05-28 08:21:41.504732 | debian-bookworm | changed: .d..t...... ./ 2026-05-28 08:21:42.079037 | debian-bookworm | changed: .d..t...... ./ 2026-05-28 08:21:42.096149 | 2026-05-28 08:21:42.096287 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-28 08:21:42.637616 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.005352 2026-05-28 08:21:42.926235 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.008935 2026-05-28 08:21:42.942335 | 2026-05-28 08:21:42.943328 | PLAY RECAP 2026-05-28 08:21:42.943426 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-28 08:21:42.943465 | 2026-05-28 08:21:43.091344 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-28 08:21:43.092889 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-28 08:21:43.863662 | 2026-05-28 08:21:43.863840 | PLAY [Base post] 2026-05-28 08:21:43.877752 | 2026-05-28 08:21:43.877891 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-28 08:21:44.502348 | debian-bookworm | changed 2026-05-28 08:21:44.509178 | 2026-05-28 08:21:44.509316 | PLAY RECAP 2026-05-28 08:21:44.509379 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-28 08:21:44.509441 | 2026-05-28 08:21:44.648234 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-28 08:21:44.649443 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-28 08:21:45.569445 | 2026-05-28 08:21:45.569635 | PLAY [Base post-logs] 2026-05-28 08:21:45.580676 | 2026-05-28 08:21:45.580855 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-28 08:21:46.053840 | localhost | changed 2026-05-28 08:21:46.068102 | 2026-05-28 08:21:46.068288 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-28 08:21:46.108136 | localhost | ok 2026-05-28 08:21:46.115888 | 2026-05-28 08:21:46.116088 | TASK [Set zuul-log-path fact] 2026-05-28 08:21:46.134270 | localhost | ok 2026-05-28 08:21:46.146919 | 2026-05-28 08:21:46.147080 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-28 08:21:46.174658 | localhost | ok 2026-05-28 08:21:46.178703 | 2026-05-28 08:21:46.178829 | TASK [upload-logs : Create log directories] 2026-05-28 08:21:46.707785 | localhost | changed 2026-05-28 08:21:46.710679 | 2026-05-28 08:21:46.710796 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-28 08:21:47.204865 | localhost -> localhost | ok: Runtime: 0:00:00.005375 2026-05-28 08:21:47.209791 | 2026-05-28 08:21:47.209924 | TASK [upload-logs : Upload logs to log server] 2026-05-28 08:21:47.805303 | localhost | Output suppressed because no_log was given 2026-05-28 08:21:47.811228 | 2026-05-28 08:21:47.811358 | LOOP [upload-logs : Compress console log and json output] 2026-05-28 08:21:47.863412 | localhost | skipping: Conditional result was False 2026-05-28 08:21:47.872077 | localhost | skipping: Conditional result was False 2026-05-28 08:21:47.879189 | 2026-05-28 08:21:47.879315 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-28 08:21:47.928212 | localhost | skipping: Conditional result was False 2026-05-28 08:21:47.928540 | 2026-05-28 08:21:47.933529 | localhost | skipping: Conditional result was False 2026-05-28 08:21:47.937381 | 2026-05-28 08:21:47.937495 | LOOP [upload-logs : Upload console log and json output]