2026-05-28 12:06:17.256481 | Job console starting 2026-05-28 12:06:17.308793 | Updating git repos 2026-05-28 12:06:17.352384 | Cloning repos into workspace 2026-05-28 12:06:17.395841 | Restoring repo states 2026-05-28 12:06:17.404384 | Merging changes 2026-05-28 12:06:18.050442 | Checking out repos 2026-05-28 12:06:18.103373 | Preparing playbooks 2026-05-28 12:06:18.780707 | Running Ansible setup 2026-05-28 12:06:23.530476 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2026-05-28 12:06:24.487041 | 2026-05-28 12:06:24.487224 | PLAY [Base pre] 2026-05-28 12:06:24.504525 | 2026-05-28 12:06:24.504669 | TASK [Setup log path fact] 2026-05-28 12:06:24.524045 | debian-bookworm | ok 2026-05-28 12:06:24.542255 | 2026-05-28 12:06:24.542388 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-28 12:06:24.581219 | debian-bookworm | ok 2026-05-28 12:06:24.591573 | 2026-05-28 12:06:24.591701 | TASK [emit-job-header : Print job information] 2026-05-28 12:06:24.651846 | # Job Information 2026-05-28 12:06:24.652047 | Ansible Version: 2.16.14 2026-05-28 12:06:24.652084 | Job: tox 2026-05-28 12:06:24.652116 | Pipeline: check 2026-05-28 12:06:24.652156 | Executor: 521e9411259a 2026-05-28 12:06:24.652177 | Triggered by: https://github.com/osism/openstack-image-manager/pull/1207 2026-05-28 12:06:24.652199 | Event ID: 80914a50-5a8d-11f1-83ae-1f40b7ddb312 2026-05-28 12:06:24.657381 | 2026-05-28 12:06:24.657506 | LOOP [emit-job-header : Print node information] 2026-05-28 12:06:24.794377 | debian-bookworm | ok: 2026-05-28 12:06:24.794684 | debian-bookworm | # Node Information 2026-05-28 12:06:24.794725 | debian-bookworm | Inventory Hostname: debian-bookworm 2026-05-28 12:06:24.794753 | debian-bookworm | Hostname: debian 2026-05-28 12:06:24.794776 | debian-bookworm | Username: zuul 2026-05-28 12:06:24.794798 | debian-bookworm | Distro: Debian 12.14 2026-05-28 12:06:24.794822 | debian-bookworm | Provider: regiocloud-a 2026-05-28 12:06:24.794875 | debian-bookworm | Region: 2026-05-28 12:06:24.794897 | debian-bookworm | Label: debian-bookworm 2026-05-28 12:06:24.794917 | debian-bookworm | Product Name: OpenStack Nova 2026-05-28 12:06:24.794938 | debian-bookworm | Interface IP: 2a13:1a81:8000:3124:f816:3eff:fecc:fbbc 2026-05-28 12:06:24.828889 | 2026-05-28 12:06:24.830456 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-28 12:06:25.719849 | debian-bookworm -> localhost | changed 2026-05-28 12:06:25.727986 | 2026-05-28 12:06:25.728117 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-28 12:06:27.383559 | debian-bookworm -> localhost | changed 2026-05-28 12:06:27.408079 | 2026-05-28 12:06:27.408408 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-28 12:06:28.259636 | debian-bookworm -> localhost | ok 2026-05-28 12:06:28.267624 | 2026-05-28 12:06:28.267819 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-28 12:06:28.326140 | debian-bookworm | ok 2026-05-28 12:06:28.361767 | debian-bookworm | included: /var/lib/zuul/builds/043ede016c9b4b498846a46ba5a8af94/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-28 12:06:28.369253 | 2026-05-28 12:06:28.369411 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-28 12:06:30.351588 | debian-bookworm -> localhost | Generating public/private rsa key pair. 2026-05-28 12:06:30.351923 | debian-bookworm -> localhost | Your identification has been saved in /var/lib/zuul/builds/043ede016c9b4b498846a46ba5a8af94/work/043ede016c9b4b498846a46ba5a8af94_id_rsa 2026-05-28 12:06:30.351968 | debian-bookworm -> localhost | Your public key has been saved in /var/lib/zuul/builds/043ede016c9b4b498846a46ba5a8af94/work/043ede016c9b4b498846a46ba5a8af94_id_rsa.pub 2026-05-28 12:06:30.351999 | debian-bookworm -> localhost | The key fingerprint is: 2026-05-28 12:06:30.352027 | debian-bookworm -> localhost | SHA256:DxPbyQHNqIlOV5ffyU9VR7q9zIj3nIIBDOcIYrQnDHU zuul-build-sshkey 2026-05-28 12:06:30.352053 | debian-bookworm -> localhost | The key's randomart image is: 2026-05-28 12:06:30.352098 | debian-bookworm -> localhost | +---[RSA 3072]----+ 2026-05-28 12:06:30.352164 | debian-bookworm -> localhost | | .oo E .+ . .=| 2026-05-28 12:06:30.352194 | debian-bookworm -> localhost | | ooo. .oo= .o| 2026-05-28 12:06:30.352218 | debian-bookworm -> localhost | | .+.o.+B... o...| 2026-05-28 12:06:30.352241 | debian-bookworm -> localhost | | = +. O o. +o.| 2026-05-28 12:06:30.352264 | debian-bookworm -> localhost | | o . S = .o.| 2026-05-28 12:06:30.352294 | debian-bookworm -> localhost | | . + .. + o| 2026-05-28 12:06:30.352315 | debian-bookworm -> localhost | | ..oo + | 2026-05-28 12:06:30.352336 | debian-bookworm -> localhost | | ...o .| 2026-05-28 12:06:30.352358 | debian-bookworm -> localhost | | .+ | 2026-05-28 12:06:30.352378 | debian-bookworm -> localhost | +----[SHA256]-----+ 2026-05-28 12:06:30.352443 | debian-bookworm -> localhost | ok: Runtime: 0:00:01.394344 2026-05-28 12:06:30.360978 | 2026-05-28 12:06:30.366243 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-28 12:06:30.417865 | debian-bookworm | ok 2026-05-28 12:06:30.434553 | debian-bookworm | included: /var/lib/zuul/builds/043ede016c9b4b498846a46ba5a8af94/trusted/project_1/github.com/osism/openinfra-zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-28 12:06:30.462534 | 2026-05-28 12:06:30.462698 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-28 12:06:30.489425 | debian-bookworm | skipping: Conditional result was False 2026-05-28 12:06:30.502320 | 2026-05-28 12:06:30.502457 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-28 12:06:31.303579 | debian-bookworm | changed 2026-05-28 12:06:31.310442 | 2026-05-28 12:06:31.310573 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-28 12:06:31.567966 | debian-bookworm | ok 2026-05-28 12:06:31.574029 | 2026-05-28 12:06:31.574175 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-28 12:06:32.313044 | debian-bookworm | changed 2026-05-28 12:06:32.320806 | 2026-05-28 12:06:32.320935 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-28 12:06:33.113648 | debian-bookworm | changed 2026-05-28 12:06:33.126491 | 2026-05-28 12:06:33.126652 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-28 12:06:33.158794 | debian-bookworm | skipping: Conditional result was False 2026-05-28 12:06:33.165889 | 2026-05-28 12:06:33.166006 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-28 12:06:33.809574 | debian-bookworm -> localhost | changed 2026-05-28 12:06:33.834271 | 2026-05-28 12:06:33.834439 | TASK [add-build-sshkey : Add back temp key] 2026-05-28 12:06:34.526440 | debian-bookworm -> localhost | Identity added: /var/lib/zuul/builds/043ede016c9b4b498846a46ba5a8af94/work/043ede016c9b4b498846a46ba5a8af94_id_rsa (zuul-build-sshkey) 2026-05-28 12:06:34.527086 | debian-bookworm -> localhost | ok: Runtime: 0:00:00.030135 2026-05-28 12:06:34.549649 | 2026-05-28 12:06:34.549777 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-28 12:06:35.123395 | debian-bookworm | ok 2026-05-28 12:06:35.130714 | 2026-05-28 12:06:35.130872 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-28 12:06:35.176578 | debian-bookworm | skipping: Conditional result was False 2026-05-28 12:06:35.204470 | 2026-05-28 12:06:35.204610 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-05-28 12:06:35.824348 | debian-bookworm | ok 2026-05-28 12:06:35.873155 | 2026-05-28 12:06:35.873318 | TASK [validate-host : Define zuul_info_dir fact] 2026-05-28 12:06:35.911329 | debian-bookworm | ok 2026-05-28 12:06:35.919266 | 2026-05-28 12:06:35.919399 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2026-05-28 12:06:36.464899 | debian-bookworm -> localhost | ok 2026-05-28 12:06:36.478677 | 2026-05-28 12:06:36.478820 | TASK [validate-host : Collect information about the host] 2026-05-28 12:06:37.693288 | debian-bookworm | ok 2026-05-28 12:06:37.718693 | 2026-05-28 12:06:37.718801 | TASK [validate-host : Sanitize hostname] 2026-05-28 12:06:37.845995 | debian-bookworm | ok 2026-05-28 12:06:37.876992 | 2026-05-28 12:06:37.877096 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2026-05-28 12:06:38.881608 | debian-bookworm -> localhost | changed 2026-05-28 12:06:38.887274 | 2026-05-28 12:06:38.887382 | TASK [validate-host : Collect information about zuul worker] 2026-05-28 12:06:39.486187 | debian-bookworm | ok 2026-05-28 12:06:39.490977 | 2026-05-28 12:06:39.491074 | TASK [validate-host : Write out all zuul information for each host] 2026-05-28 12:06:40.217330 | debian-bookworm -> localhost | changed 2026-05-28 12:06:40.237978 | 2026-05-28 12:06:40.238121 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2026-05-28 12:06:40.573012 | debian-bookworm | ok 2026-05-28 12:06:40.585631 | 2026-05-28 12:06:40.585796 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2026-05-28 12:06:42.300839 | debian-bookworm | changed: 2026-05-28 12:06:42.301078 | debian-bookworm | cd+++++++++ src/ 2026-05-28 12:06:42.301154 | debian-bookworm | cd+++++++++ src/github.com/ 2026-05-28 12:06:42.301182 | debian-bookworm | cd+++++++++ src/github.com/osism/ 2026-05-28 12:06:42.301203 | debian-bookworm | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2026-05-28 12:06:42.301224 | debian-bookworm | =7.0.3 2026-05-28 12:07:07.505908 | debian-bookworm | Downloading cachetools-7.1.4-py3-none-any.whl (16 kB) 2026-05-28 12:07:07.546893 | debian-bookworm | Collecting colorama>=0.4.6 2026-05-28 12:07:07.558205 | debian-bookworm | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-05-28 12:07:07.619119 | debian-bookworm | Collecting filelock>=3.25 2026-05-28 12:07:07.631022 | debian-bookworm | Downloading filelock-3.29.0-py3-none-any.whl (39 kB) 2026-05-28 12:07:07.680174 | debian-bookworm | Collecting packaging>=26 2026-05-28 12:07:07.691186 | debian-bookworm | Downloading packaging-26.2-py3-none-any.whl (100 kB) 2026-05-28 12:07:07.707381 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 100.2/100.2 kB 9.0 MB/s eta 0:00:00 2026-05-28 12:07:07.769340 | debian-bookworm | Collecting platformdirs>=4.9.4 2026-05-28 12:07:07.780822 | debian-bookworm | Downloading platformdirs-4.10.0-py3-none-any.whl (22 kB) 2026-05-28 12:07:07.840753 | debian-bookworm | Collecting pluggy>=1.6 2026-05-28 12:07:07.852551 | debian-bookworm | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-05-28 12:07:07.903229 | debian-bookworm | Collecting pyproject-api>=1.10 2026-05-28 12:07:07.915357 | debian-bookworm | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-05-28 12:07:07.961938 | debian-bookworm | Collecting python-discovery>=1.2.2 2026-05-28 12:07:07.974968 | debian-bookworm | Downloading python_discovery-1.4.0-py3-none-any.whl (33 kB) 2026-05-28 12:07:08.032230 | debian-bookworm | Collecting tomli-w>=1.2 2026-05-28 12:07:08.044295 | debian-bookworm | Downloading tomli_w-1.2.0-py3-none-any.whl (6.7 kB) 2026-05-28 12:07:08.189070 | debian-bookworm | Collecting virtualenv>=21.1 2026-05-28 12:07:08.201123 | debian-bookworm | Downloading virtualenv-21.4.1-py3-none-any.whl (7.6 MB) 2026-05-28 12:07:08.533990 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 7.6/7.6 MB 23.1 MB/s eta 0:00:00 2026-05-28 12:07:08.644360 | debian-bookworm | Collecting distlib<1,>=0.3.7 2026-05-28 12:07:08.656059 | debian-bookworm | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-05-28 12:07:08.679968 | debian-bookworm | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 23.0 MB/s eta 0:00:00 2026-05-28 12:07:08.793952 | debian-bookworm | Installing collected packages: distlib, tomli-w, pluggy, platformdirs, packaging, filelock, colorama, cachetools, python-discovery, pyproject-api, virtualenv, tox 2026-05-28 12:07:09.630536 | 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 12:07:09.865151 | debian-bookworm | ok: Runtime: 0:00:03.142107 2026-05-28 12:07:09.873112 | 2026-05-28 12:07:09.873271 | TASK [ensure-tox : Export installed tox_executable path] 2026-05-28 12:07:09.908401 | debian-bookworm | ok 2026-05-28 12:07:09.913969 | 2026-05-28 12:07:09.914109 | TASK [ensure-tox : Output tox version] 2026-05-28 12:07:10.472258 | 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 12:07:10.490445 | debian-bookworm | 4.55.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-28 12:07:10.947683 | debian-bookworm | ok: Runtime: 0:00:00.324696 2026-05-28 12:07:10.960975 | 2026-05-28 12:07:10.961158 | TASK [ensure-tox : Make global symlink] 2026-05-28 12:07:10.977618 | debian-bookworm | skipping: Conditional result was False 2026-05-28 12:07:10.986474 | 2026-05-28 12:07:10.986567 | PLAY RECAP 2026-05-28 12:07:10.986632 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-05-28 12:07:10.986663 | 2026-05-28 12:07:11.161477 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/pre.yaml@master] 2026-05-28 12:07:11.164625 | RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-05-28 12:07:11.989397 | 2026-05-28 12:07:11.989569 | PLAY [all] 2026-05-28 12:07:12.019351 | 2026-05-28 12:07:12.019507 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-05-28 12:07:12.528179 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-05-28 12:07:12.575399 | debian-bookworm | ok: Runtime: 0:00:00.024572 2026-05-28 12:07:12.581048 | 2026-05-28 12:07:12.581208 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-05-28 12:07:13.111401 | debian-bookworm | ok: Runtime: 0:00:00.007399 2026-05-28 12:07:13.117623 | 2026-05-28 12:07:13.117768 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-05-28 12:07:13.412791 | debian-bookworm | sudo: unable to resolve host debian: Name or service not known 2026-05-28 12:07:13.414358 | debian-bookworm | sudo: a password is required 2026-05-28 12:07:13.648146 | debian-bookworm | ok: Runtime: 0:00:00.017820 2026-05-28 12:07:13.663363 | 2026-05-28 12:07:13.663505 | TASK [tox : Check to see if the constraints file exists] 2026-05-28 12:07:13.688286 | debian-bookworm | skipping: Conditional result was False 2026-05-28 12:07:13.695097 | 2026-05-28 12:07:13.695241 | TASK [tox : Fail if constraints file is missing] 2026-05-28 12:07:13.719575 | debian-bookworm | skipping: Conditional result was False 2026-05-28 12:07:13.726058 | 2026-05-28 12:07:13.726220 | TASK [tox : Record file location] 2026-05-28 12:07:13.750593 | debian-bookworm | skipping: Conditional result was False 2026-05-28 12:07:13.761164 | 2026-05-28 12:07:13.761347 | TASK [tox : Install tox siblings] 2026-05-28 12:07:13.792608 | debian-bookworm | ok 2026-05-28 12:07:13.803186 | debian-bookworm | included: /var/lib/zuul/builds/043ede016c9b4b498846a46ba5a8af94/untrusted/project_0/github.com/osism/openinfra-zuul-jobs/roles/tox/tasks/siblings.yaml 2026-05-28 12:07:13.809434 | 2026-05-28 12:07:13.809552 | TASK [tox : Run tox without tests] 2026-05-28 12:07:15.130782 | debian-bookworm | test: install_deps> python -I -m pip install -r requirements.txt 2026-05-28 12:07:27.512195 | debian-bookworm | test: OK (13.12 seconds) 2026-05-28 12:07:27.512265 | debian-bookworm | congratulations :) (13.15 seconds) 2026-05-28 12:07:27.854167 | debian-bookworm | ok: Runtime: 0:00:13.469738 2026-05-28 12:07:27.867761 | 2026-05-28 12:07:27.867931 | TASK [tox : Create a tempfile to save tox showconfig] 2026-05-28 12:07:28.294557 | debian-bookworm | changed 2026-05-28 12:07:28.300011 | 2026-05-28 12:07:28.300141 | TASK [tox : Detect tox version] 2026-05-28 12:07:28.845323 | debian-bookworm | 4.55.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-28 12:07:29.331383 | debian-bookworm | ok: Runtime: 0:00:00.316363 2026-05-28 12:07:29.337481 | 2026-05-28 12:07:29.337614 | TASK [tox : Get tox envlist config] 2026-05-28 12:07:30.367449 | debian-bookworm | ok: Runtime: 0:00:00.347809 2026-05-28 12:07:30.374194 | 2026-05-28 12:07:30.374315 | TASK [tox : Install any sibling python packages] 2026-05-28 12:07:30.838386 | debian-bookworm | ok: No setup.cfg, no action needed 2026-05-28 12:07:30.847356 | 2026-05-28 12:07:30.847495 | TASK [tox : Remove tempfile] 2026-05-28 12:07:31.347602 | debian-bookworm | changed 2026-05-28 12:07:31.355413 | 2026-05-28 12:07:31.355552 | TASK [tox : Emit tox command] 2026-05-28 12:07:31.415116 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2026-05-28 12:07:31.423198 | 2026-05-28 12:07:31.423352 | TASK [tox : Run tox] 2026-05-28 12:07:32.022990 | debian-bookworm | test: commands[0]> python -m unittest discover test/unit 2026-05-28 12:07:32.570502 | debian-bookworm | /home/zuul/src/github.com/osism/openstack-image-manager/.tox/test/lib/python3.11/site-packages/openstack/resource.py:839: RemovedInSDK50Warning: The _compute_attributes method is deprecated for removal 2026-05-28 12:07:32.570625 | debian-bookworm | warnings.warn( 2026-05-28 12:07:32.738959 | debian-bookworm | ............... 2026-05-28 12:07:32.739077 | debian-bookworm | ---------------------------------------------------------------------- 2026-05-28 12:07:32.739111 | debian-bookworm | Ran 15 tests in 0.170s 2026-05-28 12:07:32.739126 | debian-bookworm | 2026-05-28 12:07:32.739197 | debian-bookworm | OK 2026-05-28 12:07:32.850219 | debian-bookworm | test: OK (0.87=setup[0.05]+cmd[0.82] seconds) 2026-05-28 12:07:32.850283 | debian-bookworm | congratulations :) (0.90 seconds) 2026-05-28 12:07:32.958246 | debian-bookworm | ok: Runtime: 0:00:01.209822 2026-05-28 12:07:32.973810 | 2026-05-28 12:07:32.973928 | TASK [tox : Look for output] 2026-05-28 12:07:33.386427 | debian-bookworm | ok 2026-05-28 12:07:33.404960 | 2026-05-28 12:07:33.405106 | TASK [tox : Return file comments to Zuul] 2026-05-28 12:07:33.449798 | debian-bookworm | skipping: Conditional result was False 2026-05-28 12:07:33.465410 | 2026-05-28 12:07:33.465529 | PLAY RECAP 2026-05-28 12:07:33.465613 | debian-bookworm | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2026-05-28 12:07:33.465653 | 2026-05-28 12:07:33.604018 | RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/run.yaml@master] 2026-05-28 12:07:33.605806 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-05-28 12:07:34.376880 | 2026-05-28 12:07:34.377083 | PLAY [all] 2026-05-28 12:07:34.393854 | 2026-05-28 12:07:34.394022 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-05-28 12:07:34.460026 | debian-bookworm | skipping: Conditional result was False 2026-05-28 12:07:34.473786 | 2026-05-28 12:07:34.474071 | TASK [fetch-tox-output : Set tox log path for single node] 2026-05-28 12:07:34.519302 | debian-bookworm | ok 2026-05-28 12:07:34.527998 | 2026-05-28 12:07:34.528198 | TASK [fetch-tox-output : Ensure local tox dir] 2026-05-28 12:07:35.071449 | debian-bookworm -> localhost | changed 2026-05-28 12:07:35.083942 | 2026-05-28 12:07:35.084112 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-05-28 12:07:35.129323 | debian-bookworm | skipping: Conditional result was False 2026-05-28 12:07:35.143234 | 2026-05-28 12:07:35.143464 | TASK [fetch-tox-output : Set envlist fact] 2026-05-28 12:07:35.196245 | debian-bookworm | ok 2026-05-28 12:07:35.206305 | 2026-05-28 12:07:35.206472 | TASK [fetch-tox-output : Get tox version] 2026-05-28 12:07:35.887521 | 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 12:07:35.904711 | debian-bookworm | 4.55.0 from /home/zuul/.local/tox/lib/python3.11/site-packages/tox/__init__.py 2026-05-28 12:07:36.240922 | debian-bookworm | ok: Runtime: 0:00:00.299505 2026-05-28 12:07:36.250817 | 2026-05-28 12:07:36.250991 | TASK [fetch-tox-output : Find all default environments] 2026-05-28 12:07:36.783222 | debian-bookworm | skipping: Conditional result was False 2026-05-28 12:07:36.794866 | 2026-05-28 12:07:36.795128 | TASK [fetch-tox-output : Set envlist fact] 2026-05-28 12:07:36.831011 | debian-bookworm | skipping: Conditional result was False 2026-05-28 12:07:36.837749 | 2026-05-28 12:07:36.837888 | TASK [fetch-tox-output : Find all default environments] 2026-05-28 12:07:37.370555 | debian-bookworm | skipping: Conditional result was False 2026-05-28 12:07:37.385745 | 2026-05-28 12:07:37.385960 | TASK [fetch-tox-output : Set envlist fact] 2026-05-28 12:07:37.422294 | debian-bookworm | skipping: Conditional result was False 2026-05-28 12:07:37.439534 | 2026-05-28 12:07:37.439710 | LOOP [fetch-tox-output : Copy tox logs] 2026-05-28 12:07:37.489128 | debian-bookworm | skipping: Conditional result was False 2026-05-28 12:07:37.510495 | 2026-05-28 12:07:37.510712 | LOOP [fetch-tox-output : Collect tox logs] 2026-05-28 12:07:38.322529 | debian-bookworm | changed: 2026-05-28 12:07:38.322911 | debian-bookworm | created directory /var/lib/zuul/builds/043ede016c9b4b498846a46ba5a8af94/work/logs/tox/test 2026-05-28 12:07:38.323005 | debian-bookworm | cd+++++++++ ./ 2026-05-28 12:07:38.323069 | debian-bookworm | >f+++++++++ 1-commands[0].log 2026-05-28 12:07:38.323121 | 2026-05-28 12:07:38.339462 | 2026-05-28 12:07:38.339599 | PLAY RECAP 2026-05-28 12:07:38.339667 | debian-bookworm | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-05-28 12:07:38.339698 | 2026-05-28 12:07:38.483587 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/tox/post.yaml@master] 2026-05-28 12:07:38.484832 | POST-RUN START: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-05-28 12:07:39.295199 | 2026-05-28 12:07:39.295441 | PLAY [all] 2026-05-28 12:07:39.311381 | 2026-05-28 12:07:39.311525 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-05-28 12:07:39.567315 | debian-bookworm | changed: non-zero return code 2026-05-28 12:07:39.575352 | 2026-05-28 12:07:39.575512 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-05-28 12:07:39.600912 | debian-bookworm | skipping: Conditional result was False 2026-05-28 12:07:39.611895 | 2026-05-28 12:07:39.612072 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-05-28 12:07:39.647882 | 2026-05-28 12:07:39.648201 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-05-28 12:07:39.701951 | 2026-05-28 12:07:39.702339 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-05-28 12:07:39.728898 | debian-bookworm | skipping: Conditional result was False 2026-05-28 12:07:39.743645 | 2026-05-28 12:07:39.743855 | LOOP [fetch-subunit-output : Generate subunit file] 2026-05-28 12:07:39.783121 | 2026-05-28 12:07:39.783458 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-05-28 12:07:39.809614 | debian-bookworm | skipping: Conditional result was False 2026-05-28 12:07:39.823204 | 2026-05-28 12:07:39.823410 | TASK [fetch-subunit-output : Remove the temporary file] 2026-05-28 12:07:39.849346 | debian-bookworm | skipping: Conditional result was False 2026-05-28 12:07:39.863100 | 2026-05-28 12:07:39.863314 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-05-28 12:07:39.888929 | debian-bookworm | skipping: Conditional result was False 2026-05-28 12:07:39.903314 | 2026-05-28 12:07:39.903456 | PLAY RECAP 2026-05-28 12:07:39.903544 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-05-28 12:07:39.903586 | 2026-05-28 12:07:40.074340 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/osism/openinfra-zuul-jobs/playbooks/unittests/post.yaml@master] 2026-05-28 12:07:40.077193 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-28 12:07:40.891810 | 2026-05-28 12:07:40.891990 | PLAY [Base post-fetch] 2026-05-28 12:07:40.908774 | 2026-05-28 12:07:40.908936 | TASK [fetch-output : Set log path for multiple nodes] 2026-05-28 12:07:40.968586 | debian-bookworm | skipping: Conditional result was False 2026-05-28 12:07:40.977359 | 2026-05-28 12:07:40.977522 | TASK [fetch-output : Set log path for single node] 2026-05-28 12:07:41.016802 | debian-bookworm | ok 2026-05-28 12:07:41.022719 | 2026-05-28 12:07:41.022910 | LOOP [fetch-output : Ensure local output dirs] 2026-05-28 12:07:41.544585 | debian-bookworm -> localhost | ok: "/var/lib/zuul/builds/043ede016c9b4b498846a46ba5a8af94/work/logs" 2026-05-28 12:07:41.844396 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/043ede016c9b4b498846a46ba5a8af94/work/artifacts" 2026-05-28 12:07:42.140367 | debian-bookworm -> localhost | changed: "/var/lib/zuul/builds/043ede016c9b4b498846a46ba5a8af94/work/docs" 2026-05-28 12:07:42.171082 | 2026-05-28 12:07:42.171367 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-28 12:07:42.958733 | debian-bookworm | changed: 2026-05-28 12:07:42.958979 | debian-bookworm | .d..t...... ./ 2026-05-28 12:07:42.959025 | debian-bookworm | >f+++++++++ sudo-debug.txt 2026-05-28 12:07:42.959070 | debian-bookworm | >f+++++++++ sudo-strace.log 2026-05-28 12:07:42.959095 | debian-bookworm | >f+++++++++ sudo-strace.log.time 2026-05-28 12:07:42.959141 | debian-bookworm | changed: All items complete 2026-05-28 12:07:42.959168 | 2026-05-28 12:07:43.561768 | debian-bookworm | changed: .d..t...... ./ 2026-05-28 12:07:44.169865 | debian-bookworm | changed: .d..t...... ./ 2026-05-28 12:07:44.185009 | 2026-05-28 12:07:44.185200 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-28 12:07:44.692668 | debian-bookworm -> localhost | ok: Item: artifacts Runtime: 0:00:00.012025 2026-05-28 12:07:44.971344 | debian-bookworm -> localhost | ok: Item: docs Runtime: 0:00:00.013026 2026-05-28 12:07:44.989891 | 2026-05-28 12:07:44.990007 | PLAY RECAP 2026-05-28 12:07:44.990132 | debian-bookworm | ok: 4 changed: 3 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-28 12:07:44.990170 | 2026-05-28 12:07:45.125069 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post-fetch.yaml@main] 2026-05-28 12:07:45.126553 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-28 12:07:45.909137 | 2026-05-28 12:07:45.909313 | PLAY [Base post] 2026-05-28 12:07:45.923779 | 2026-05-28 12:07:45.923931 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-28 12:07:46.552828 | debian-bookworm | changed 2026-05-28 12:07:46.563257 | 2026-05-28 12:07:46.563431 | PLAY RECAP 2026-05-28 12:07:46.563527 | debian-bookworm | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-28 12:07:46.563615 | 2026-05-28 12:07:46.725800 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2026-05-28 12:07:46.727073 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-28 12:07:47.591292 | 2026-05-28 12:07:47.591553 | PLAY [Base post-logs] 2026-05-28 12:07:47.604565 | 2026-05-28 12:07:47.604767 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-28 12:07:48.109566 | localhost | changed 2026-05-28 12:07:48.129803 | 2026-05-28 12:07:48.130136 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-28 12:07:48.160725 | localhost | ok 2026-05-28 12:07:48.166906 | 2026-05-28 12:07:48.167107 | TASK [Set zuul-log-path fact] 2026-05-28 12:07:48.185756 | localhost | ok 2026-05-28 12:07:48.196369 | 2026-05-28 12:07:48.196540 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-28 12:07:48.233536 | localhost | ok 2026-05-28 12:07:48.237557 | 2026-05-28 12:07:48.237710 | TASK [upload-logs : Create log directories] 2026-05-28 12:07:48.849191 | localhost | changed 2026-05-28 12:07:48.853346 | 2026-05-28 12:07:48.853455 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-28 12:07:49.369541 | localhost -> localhost | ok: Runtime: 0:00:00.008570 2026-05-28 12:07:49.375611 | 2026-05-28 12:07:49.375781 | TASK [upload-logs : Upload logs to log server] 2026-05-28 12:07:49.975141 | localhost | Output suppressed because no_log was given 2026-05-28 12:07:49.978367 | 2026-05-28 12:07:49.978525 | LOOP [upload-logs : Compress console log and json output] 2026-05-28 12:07:50.034344 | localhost | skipping: Conditional result was False 2026-05-28 12:07:50.039779 | localhost | skipping: Conditional result was False 2026-05-28 12:07:50.052469 | 2026-05-28 12:07:50.052706 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-28 12:07:50.112131 | localhost | skipping: Conditional result was False 2026-05-28 12:07:50.112722 | 2026-05-28 12:07:50.115465 | localhost | skipping: Conditional result was False 2026-05-28 12:07:50.130313 | 2026-05-28 12:07:50.130484 | LOOP [upload-logs : Upload console log and json output]