2025-04-07 15:21:54.773878 | Job console starting... 2025-04-07 15:21:54.793506 | Updating repositories 2025-04-07 15:21:54.821066 | Preparing job workspace 2025-04-07 15:21:56.554913 | Running Ansible setup... 2025-04-07 15:22:03.189800 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-04-07 15:22:04.369043 | 2025-04-07 15:22:04.369181 | PLAY [Base pre] 2025-04-07 15:22:04.404327 | 2025-04-07 15:22:04.404515 | TASK [Setup log path fact] 2025-04-07 15:22:04.486022 | ubuntu-noble | ok 2025-04-07 15:22:04.530875 | 2025-04-07 15:22:04.540450 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-04-07 15:22:04.610922 | ubuntu-noble | ok 2025-04-07 15:22:04.635471 | 2025-04-07 15:22:04.635578 | TASK [emit-job-header : Print job information] 2025-04-07 15:22:04.756819 | # Job Information 2025-04-07 15:22:04.756973 | Ansible Version: 2.15.3 2025-04-07 15:22:04.757018 | Job: tox 2025-04-07 15:22:04.757047 | Pipeline: check 2025-04-07 15:22:04.757069 | Executor: 7d211f194f6a 2025-04-07 15:22:04.757088 | Triggered by: https://github.com/osism/openstack-image-manager/pull/905 2025-04-07 15:22:04.757108 | Event ID: 04585160-13c4-11f0-9e9d-767853d662e0 2025-04-07 15:22:04.767186 | 2025-04-07 15:22:04.767284 | LOOP [emit-job-header : Print node information] 2025-04-07 15:22:04.952117 | ubuntu-noble | ok: 2025-04-07 15:22:04.952575 | ubuntu-noble | # Node Information 2025-04-07 15:22:04.952632 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-04-07 15:22:04.952654 | ubuntu-noble | Hostname: ubuntu 2025-04-07 15:22:04.952672 | ubuntu-noble | Username: zuul 2025-04-07 15:22:04.952689 | ubuntu-noble | Distro: Ubuntu 24.04 2025-04-07 15:22:04.952713 | ubuntu-noble | Provider: regiocloud-a 2025-04-07 15:22:04.952731 | ubuntu-noble | Label: ubuntu-noble 2025-04-07 15:22:04.952748 | ubuntu-noble | Product Name: OpenStack Nova 2025-04-07 15:22:04.952765 | ubuntu-noble | Interface IP: 81.163.192.54 2025-04-07 15:22:05.012261 | 2025-04-07 15:22:05.013001 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-04-07 15:22:05.882065 | ubuntu-noble -> localhost | changed 2025-04-07 15:22:05.889901 | 2025-04-07 15:22:05.890012 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-04-07 15:22:07.024246 | ubuntu-noble -> localhost | changed 2025-04-07 15:22:07.041399 | 2025-04-07 15:22:07.041527 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-04-07 15:22:07.454295 | ubuntu-noble -> localhost | ok 2025-04-07 15:22:07.462109 | 2025-04-07 15:22:07.462221 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-04-07 15:22:07.495664 | ubuntu-noble | ok 2025-04-07 15:22:07.511101 | ubuntu-noble | included: /var/lib/zuul/builds/bef94550a9094c7ba8e431853af3f45c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-04-07 15:22:07.519467 | 2025-04-07 15:22:07.519568 | TASK [add-build-sshkey : Create Temp SSH key] 2025-04-07 15:22:08.243702 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-04-07 15:22:08.244033 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/bef94550a9094c7ba8e431853af3f45c/work/bef94550a9094c7ba8e431853af3f45c_id_rsa 2025-04-07 15:22:08.244098 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/bef94550a9094c7ba8e431853af3f45c/work/bef94550a9094c7ba8e431853af3f45c_id_rsa.pub 2025-04-07 15:22:08.244141 | ubuntu-noble -> localhost | The key fingerprint is: 2025-04-07 15:22:08.244178 | ubuntu-noble -> localhost | SHA256:LzWrSqSv8s2VO4uT1gljbPItuFU7WI9VT8qsRzpjj1Q zuul-build-sshkey 2025-04-07 15:22:08.244213 | ubuntu-noble -> localhost | The key's randomart image is: 2025-04-07 15:22:08.244247 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-04-07 15:22:08.244281 | ubuntu-noble -> localhost | | | 2025-04-07 15:22:08.244313 | ubuntu-noble -> localhost | | | 2025-04-07 15:22:08.244344 | ubuntu-noble -> localhost | | . . | 2025-04-07 15:22:08.244410 | ubuntu-noble -> localhost | | + + | 2025-04-07 15:22:08.244449 | ubuntu-noble -> localhost | | .. S + E . | 2025-04-07 15:22:08.244482 | ubuntu-noble -> localhost | | .o*+ O B | 2025-04-07 15:22:08.244523 | ubuntu-noble -> localhost | | .*+*B.@ . | 2025-04-07 15:22:08.244556 | ubuntu-noble -> localhost | | . .**o=B * | 2025-04-07 15:22:08.244589 | ubuntu-noble -> localhost | | o++*++o. . | 2025-04-07 15:22:08.244620 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-04-07 15:22:08.244700 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.239243 2025-04-07 15:22:08.257768 | 2025-04-07 15:22:08.257869 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-04-07 15:22:08.297762 | ubuntu-noble | ok 2025-04-07 15:22:08.308313 | ubuntu-noble | included: /var/lib/zuul/builds/bef94550a9094c7ba8e431853af3f45c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-04-07 15:22:08.317430 | 2025-04-07 15:22:08.317508 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-04-07 15:22:08.341163 | ubuntu-noble | skipping: Conditional result was False 2025-04-07 15:22:08.347923 | 2025-04-07 15:22:08.348014 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-04-07 15:22:09.048370 | ubuntu-noble | changed 2025-04-07 15:22:09.056278 | 2025-04-07 15:22:09.056371 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-04-07 15:22:09.353134 | ubuntu-noble | ok 2025-04-07 15:22:09.359905 | 2025-04-07 15:22:09.360014 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-04-07 15:22:10.101885 | ubuntu-noble | changed 2025-04-07 15:22:10.108428 | 2025-04-07 15:22:10.108516 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-04-07 15:22:10.897536 | ubuntu-noble | changed 2025-04-07 15:22:10.904290 | 2025-04-07 15:22:10.904377 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-04-07 15:22:10.928682 | ubuntu-noble | skipping: Conditional result was False 2025-04-07 15:22:10.935672 | 2025-04-07 15:22:10.935758 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-04-07 15:22:11.369549 | ubuntu-noble -> localhost | changed 2025-04-07 15:22:11.383280 | 2025-04-07 15:22:11.383379 | TASK [add-build-sshkey : Add back temp key] 2025-04-07 15:22:11.685042 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/bef94550a9094c7ba8e431853af3f45c/work/bef94550a9094c7ba8e431853af3f45c_id_rsa (zuul-build-sshkey) 2025-04-07 15:22:11.685227 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.008873 2025-04-07 15:22:11.692897 | 2025-04-07 15:22:11.693000 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-04-07 15:22:12.129977 | ubuntu-noble | ok 2025-04-07 15:22:12.136618 | 2025-04-07 15:22:12.136711 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-04-07 15:22:12.160381 | ubuntu-noble | skipping: Conditional result was False 2025-04-07 15:22:12.174476 | 2025-04-07 15:22:12.174580 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-04-07 15:22:12.652552 | ubuntu-noble | ok 2025-04-07 15:22:12.663846 | 2025-04-07 15:22:12.663928 | TASK [validate-host : Define zuul_info_dir fact] 2025-04-07 15:22:12.702943 | ubuntu-noble | ok 2025-04-07 15:22:12.709035 | 2025-04-07 15:22:12.709115 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-04-07 15:22:12.968470 | ubuntu-noble -> localhost | ok 2025-04-07 15:22:12.986277 | 2025-04-07 15:22:12.986409 | TASK [validate-host : Collect information about the host] 2025-04-07 15:22:14.069804 | ubuntu-noble | ok 2025-04-07 15:22:14.085113 | 2025-04-07 15:22:14.085209 | TASK [validate-host : Sanitize hostname] 2025-04-07 15:22:14.169792 | ubuntu-noble | ok 2025-04-07 15:22:14.178787 | 2025-04-07 15:22:14.178885 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-04-07 15:22:14.844840 | ubuntu-noble -> localhost | changed 2025-04-07 15:22:14.851181 | 2025-04-07 15:22:14.851277 | TASK [validate-host : Collect information about zuul worker] 2025-04-07 15:22:15.287436 | ubuntu-noble | ok 2025-04-07 15:22:15.293288 | 2025-04-07 15:22:15.293381 | TASK [validate-host : Write out all zuul information for each host] 2025-04-07 15:22:15.885910 | ubuntu-noble -> localhost | changed 2025-04-07 15:22:15.898109 | 2025-04-07 15:22:15.898210 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-04-07 15:22:16.196090 | ubuntu-noble | ok 2025-04-07 15:22:16.208363 | 2025-04-07 15:22:16.208519 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-04-07 15:22:17.368283 | ubuntu-noble | changed: 2025-04-07 15:22:17.368712 | ubuntu-noble | cd+++++++++ src/ 2025-04-07 15:22:17.368764 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-04-07 15:22:17.368790 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-04-07 15:22:17.368812 | ubuntu-noble | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-04-07 15:22:17.368832 | ubuntu-noble | =5.5.1 (from tox) 2025-04-07 15:22:43.824140 | ubuntu-noble | Downloading cachetools-5.5.2-py3-none-any.whl.metadata (5.4 kB) 2025-04-07 15:22:43.876090 | ubuntu-noble | Collecting chardet>=5.2 (from tox) 2025-04-07 15:22:43.889035 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl.metadata (3.4 kB) 2025-04-07 15:22:43.965101 | ubuntu-noble | Collecting colorama>=0.4.6 (from tox) 2025-04-07 15:22:43.979336 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2025-04-07 15:22:44.075469 | ubuntu-noble | Collecting filelock>=3.16.1 (from tox) 2025-04-07 15:22:44.089090 | ubuntu-noble | Downloading filelock-3.18.0-py3-none-any.whl.metadata (2.9 kB) 2025-04-07 15:22:44.174083 | ubuntu-noble | Collecting packaging>=24.2 (from tox) 2025-04-07 15:22:44.188963 | ubuntu-noble | Downloading packaging-24.2-py3-none-any.whl.metadata (3.2 kB) 2025-04-07 15:22:44.277918 | ubuntu-noble | Collecting platformdirs>=4.3.6 (from tox) 2025-04-07 15:22:44.293520 | ubuntu-noble | Downloading platformdirs-4.3.7-py3-none-any.whl.metadata (11 kB) 2025-04-07 15:22:44.441882 | ubuntu-noble | Collecting pluggy>=1.5 (from tox) 2025-04-07 15:22:44.457023 | ubuntu-noble | Downloading pluggy-1.5.0-py3-none-any.whl.metadata (4.8 kB) 2025-04-07 15:22:44.526409 | ubuntu-noble | Collecting pyproject-api>=1.8 (from tox) 2025-04-07 15:22:44.540023 | ubuntu-noble | Downloading pyproject_api-1.9.0-py3-none-any.whl.metadata (2.7 kB) 2025-04-07 15:22:44.779559 | ubuntu-noble | Collecting virtualenv>=20.29.1 (from tox) 2025-04-07 15:22:44.793212 | ubuntu-noble | Downloading virtualenv-20.30.0-py3-none-any.whl.metadata (4.5 kB) 2025-04-07 15:22:44.990676 | ubuntu-noble | Collecting distlib<1,>=0.3.7 (from virtualenv>=20.29.1->tox) 2025-04-07 15:22:45.004854 | ubuntu-noble | Downloading distlib-0.3.9-py2.py3-none-any.whl.metadata (5.2 kB) 2025-04-07 15:22:45.065712 | ubuntu-noble | Downloading tox-4.25.0-py3-none-any.whl (172 kB) 2025-04-07 15:22:45.100404 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 172.4/172.4 kB 6.2 MB/s eta 0:00:00 2025-04-07 15:22:45.116106 | ubuntu-noble | Downloading cachetools-5.5.2-py3-none-any.whl (10 kB) 2025-04-07 15:22:45.135129 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-04-07 15:22:45.151791 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 17.6 MB/s eta 0:00:00 2025-04-07 15:22:45.166134 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-04-07 15:22:45.188116 | ubuntu-noble | Downloading filelock-3.18.0-py3-none-any.whl (16 kB) 2025-04-07 15:22:45.206566 | ubuntu-noble | Downloading packaging-24.2-py3-none-any.whl (65 kB) 2025-04-07 15:22:45.220450 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 65.5/65.5 kB 7.4 MB/s eta 0:00:00 2025-04-07 15:22:45.236887 | ubuntu-noble | Downloading platformdirs-4.3.7-py3-none-any.whl (18 kB) 2025-04-07 15:22:45.258432 | ubuntu-noble | Downloading pluggy-1.5.0-py3-none-any.whl (20 kB) 2025-04-07 15:22:45.280791 | ubuntu-noble | Downloading pyproject_api-1.9.0-py3-none-any.whl (13 kB) 2025-04-07 15:22:45.306389 | ubuntu-noble | Downloading virtualenv-20.30.0-py3-none-any.whl (4.3 MB) 2025-04-07 15:22:45.486986 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.3/4.3 MB 24.9 MB/s eta 0:00:00 2025-04-07 15:22:45.501557 | ubuntu-noble | Downloading distlib-0.3.9-py2.py3-none-any.whl (468 kB) 2025-04-07 15:22:45.532886 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 18.2 MB/s eta 0:00:00 2025-04-07 15:22:45.635274 | ubuntu-noble | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-04-07 15:22:46.654037 | ubuntu-noble | Successfully installed cachetools-5.5.2 chardet-5.2.0 colorama-0.4.6 distlib-0.3.9 filelock-3.18.0 packaging-24.2 platformdirs-4.3.7 pluggy-1.5.0 pyproject-api-1.9.0 tox-4.25.0 virtualenv-20.30.0 2025-04-07 15:22:46.963432 | ubuntu-noble | ok: Runtime: 0:00:03.997149 2025-04-07 15:22:46.980605 | 2025-04-07 15:22:46.980777 | TASK [ensure-tox : Export installed tox_executable path] 2025-04-07 15:22:47.030835 | ubuntu-noble | ok 2025-04-07 15:22:47.043119 | 2025-04-07 15:22:47.043313 | TASK [ensure-tox : Output tox version] 2025-04-07 15:22:48.052098 | ubuntu-noble | ROOT: No tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-04-07 15:22:48.088110 | ubuntu-noble | 4.25.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2025-04-07 15:22:48.609604 | ubuntu-noble | ok: Runtime: 0:00:00.547149 2025-04-07 15:22:48.621436 | 2025-04-07 15:22:48.621574 | TASK [ensure-tox : Make global symlink] 2025-04-07 15:22:48.657292 | ubuntu-noble | skipping: Conditional result was False 2025-04-07 15:22:48.710889 | 2025-04-07 15:22:48.711035 | PLAY RECAP 2025-04-07 15:22:48.711092 | ubuntu-noble | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-04-07 15:22:48.711117 | 2025-04-07 15:22:48.866727 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2025-04-07 15:22:48.870842 | RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/run.yaml@master] 2025-04-07 15:22:49.679212 | 2025-04-07 15:22:49.679372 | PLAY [all] 2025-04-07 15:22:49.713476 | 2025-04-07 15:22:49.713627 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-04-07 15:22:50.762555 | ubuntu-noble | ok: Runtime: 0:00:00.013644 2025-04-07 15:22:50.771915 | 2025-04-07 15:22:50.772100 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-04-07 15:22:51.311361 | ubuntu-noble | ok: Runtime: 0:00:00.004999 2025-04-07 15:22:51.327056 | 2025-04-07 15:22:51.327237 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-04-07 15:22:51.691187 | ubuntu-noble | sudo: a password is required 2025-04-07 15:22:51.867670 | ubuntu-noble | ok: Runtime: 0:00:00.018833 2025-04-07 15:22:51.891603 | 2025-04-07 15:22:51.891757 | TASK [tox : Check to see if the constraints file exists] 2025-04-07 15:22:51.969547 | ubuntu-noble | skipping: Conditional result was False 2025-04-07 15:22:51.984592 | 2025-04-07 15:22:51.984762 | TASK [tox : Fail if constraints file is missing] 2025-04-07 15:22:52.020978 | ubuntu-noble | skipping: Conditional result was False 2025-04-07 15:22:52.029228 | 2025-04-07 15:22:52.029353 | TASK [tox : Record file location] 2025-04-07 15:22:52.064928 | ubuntu-noble | skipping: Conditional result was False 2025-04-07 15:22:52.085560 | 2025-04-07 15:22:52.085726 | TASK [tox : Install tox siblings] 2025-04-07 15:22:52.123600 | ubuntu-noble | ok 2025-04-07 15:22:52.135551 | ubuntu-noble | included: /var/lib/zuul/builds/bef94550a9094c7ba8e431853af3f45c/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/tox/tasks/siblings.yaml 2025-04-07 15:22:52.145188 | 2025-04-07 15:22:52.145307 | TASK [tox : Run tox without tests] 2025-04-07 15:22:53.275958 | ubuntu-noble | test: install_deps> python -I -m pip install -r requirements.txt 2025-04-07 15:23:09.091181 | ubuntu-noble | test: OK (16.14 seconds) 2025-04-07 15:23:09.124303 | ubuntu-noble | congratulations :) (16.24 seconds) 2025-04-07 15:23:09.223127 | ubuntu-noble | ok: Runtime: 0:00:16.533974 2025-04-07 15:23:09.239157 | 2025-04-07 15:23:09.239313 | TASK [tox : Create a tempfile to save tox showconfig] 2025-04-07 15:23:09.601177 | ubuntu-noble | changed 2025-04-07 15:23:09.611226 | 2025-04-07 15:23:09.611491 | TASK [tox : Get tox envlist config] 2025-04-07 15:23:10.662412 | ubuntu-noble | ok: Runtime: 0:00:00.318905 2025-04-07 15:23:10.669741 | 2025-04-07 15:23:10.669854 | TASK [tox : Install any sibling python packages] 2025-04-07 15:23:11.179843 | ubuntu-noble | ok: No setup.cfg, no action needed 2025-04-07 15:23:11.188967 | 2025-04-07 15:23:11.189132 | TASK [tox : Remove tempfile] 2025-04-07 15:23:11.689569 | ubuntu-noble | changed 2025-04-07 15:23:11.699597 | 2025-04-07 15:23:11.699755 | TASK [tox : Emit tox command] 2025-04-07 15:23:11.761513 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-04-07 15:23:11.767799 | 2025-04-07 15:23:11.767907 | TASK [tox : Run tox] 2025-04-07 15:23:12.802063 | ubuntu-noble | test: commands[0]> python -m unittest discover test/unit 2025-04-07 15:23:13.592394 | ubuntu-noble | ............... 2025-04-07 15:23:13.592540 | ubuntu-noble | ---------------------------------------------------------------------- 2025-04-07 15:23:13.592659 | ubuntu-noble | Ran 15 tests in 0.176s 2025-04-07 15:23:13.593863 | ubuntu-noble | 2025-04-07 15:23:13.666218 | ubuntu-noble | OK 2025-04-07 15:23:13.666253 | ubuntu-noble | test: OK (0.92=setup[0.06]+cmd[0.86] seconds) 2025-04-07 15:23:13.740878 | ubuntu-noble | congratulations :) (1.06 seconds) 2025-04-07 15:23:13.807433 | ubuntu-noble | ok: Runtime: 0:00:01.490195 2025-04-07 15:23:13.818896 | 2025-04-07 15:23:13.819097 | TASK [tox : Look for output] 2025-04-07 15:23:14.382101 | ubuntu-noble | ok 2025-04-07 15:23:14.392954 | 2025-04-07 15:23:14.393128 | TASK [tox : Return file comments to Zuul] 2025-04-07 15:23:14.444543 | ubuntu-noble | skipping: Conditional result was False 2025-04-07 15:23:14.482503 | 2025-04-07 15:23:14.482595 | PLAY RECAP 2025-04-07 15:23:14.482651 | ubuntu-noble | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-04-07 15:23:14.482676 | 2025-04-07 15:23:14.608877 | RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/run.yaml@master] 2025-04-07 15:23:14.612515 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2025-04-07 15:23:15.272724 | 2025-04-07 15:23:15.272862 | PLAY [all] 2025-04-07 15:23:15.299371 | 2025-04-07 15:23:15.299494 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-04-07 15:23:15.366499 | ubuntu-noble | skipping: Conditional result was False 2025-04-07 15:23:15.378678 | 2025-04-07 15:23:15.378852 | TASK [fetch-tox-output : Set tox log path for single node] 2025-04-07 15:23:15.437579 | ubuntu-noble | ok 2025-04-07 15:23:15.447092 | 2025-04-07 15:23:15.447211 | TASK [fetch-tox-output : Ensure local tox dir] 2025-04-07 15:23:15.911173 | ubuntu-noble -> localhost | changed 2025-04-07 15:23:15.922025 | 2025-04-07 15:23:15.922158 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-04-07 15:23:15.977542 | ubuntu-noble | skipping: Conditional result was False 2025-04-07 15:23:15.990905 | 2025-04-07 15:23:15.991078 | TASK [fetch-tox-output : Set envlist fact] 2025-04-07 15:23:16.040327 | ubuntu-noble | ok 2025-04-07 15:23:16.051223 | 2025-04-07 15:23:16.051337 | TASK [fetch-tox-output : Get tox version] 2025-04-07 15:23:17.083098 | ubuntu-noble | ROOT: No tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-04-07 15:23:17.110855 | ubuntu-noble | 4.25.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2025-04-07 15:23:17.590297 | ubuntu-noble | ok: Runtime: 0:00:00.585549 2025-04-07 15:23:17.605422 | 2025-04-07 15:23:17.605596 | TASK [fetch-tox-output : Find all default environments] 2025-04-07 15:23:17.682221 | ubuntu-noble | skipping: Conditional result was False 2025-04-07 15:23:17.694282 | 2025-04-07 15:23:17.694405 | TASK [fetch-tox-output : Set envlist fact] 2025-04-07 15:23:17.732315 | ubuntu-noble | skipping: Conditional result was False 2025-04-07 15:23:17.741516 | 2025-04-07 15:23:17.741643 | TASK [fetch-tox-output : Find all default environments] 2025-04-07 15:23:17.804642 | ubuntu-noble | skipping: Conditional result was False 2025-04-07 15:23:17.816004 | 2025-04-07 15:23:17.816144 | TASK [fetch-tox-output : Set envlist fact] 2025-04-07 15:23:17.842226 | ubuntu-noble | skipping: Conditional result was False 2025-04-07 15:23:17.857488 | 2025-04-07 15:23:17.857664 | LOOP [fetch-tox-output : Copy tox logs] 2025-04-07 15:23:17.944274 | ubuntu-noble | skipping: Conditional result was False 2025-04-07 15:23:17.963843 | 2025-04-07 15:23:17.964033 | LOOP [fetch-tox-output : Collect tox logs] 2025-04-07 15:23:18.672532 | ubuntu-noble | changed: 2025-04-07 15:23:18.672864 | ubuntu-noble | cd+++++++++ ./ 2025-04-07 15:23:18.672917 | ubuntu-noble | >f+++++++++ 1-commands[0].log 2025-04-07 15:23:18.672959 | 2025-04-07 15:23:18.725858 | 2025-04-07 15:23:18.725958 | PLAY RECAP 2025-04-07 15:23:18.726030 | ubuntu-noble | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-04-07 15:23:18.726058 | 2025-04-07 15:23:18.854491 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2025-04-07 15:23:18.858051 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2025-04-07 15:23:19.573333 | 2025-04-07 15:23:19.573493 | PLAY [all] 2025-04-07 15:23:19.601097 | 2025-04-07 15:23:19.601249 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-04-07 15:23:19.764208 | ubuntu-noble | changed: non-zero return code 2025-04-07 15:23:19.773221 | 2025-04-07 15:23:19.773373 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-04-07 15:23:19.798221 | ubuntu-noble | skipping: Conditional result was False 2025-04-07 15:23:19.807777 | 2025-04-07 15:23:19.807890 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-04-07 15:23:19.848474 | 2025-04-07 15:23:19.848696 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-04-07 15:23:19.880314 | 2025-04-07 15:23:19.880539 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-04-07 15:23:19.936807 | ubuntu-noble | skipping: Conditional result was False 2025-04-07 15:23:19.948919 | 2025-04-07 15:23:19.949103 | LOOP [fetch-subunit-output : Generate subunit file] 2025-04-07 15:23:19.981138 | 2025-04-07 15:23:19.981346 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-04-07 15:23:20.005827 | ubuntu-noble | skipping: Conditional result was False 2025-04-07 15:23:20.013309 | 2025-04-07 15:23:20.013434 | TASK [fetch-subunit-output : Remove the temporary file] 2025-04-07 15:23:20.031507 | ubuntu-noble | skipping: Conditional result was False 2025-04-07 15:23:20.047686 | 2025-04-07 15:23:20.047854 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-04-07 15:23:20.067953 | ubuntu-noble | skipping: Conditional result was False 2025-04-07 15:23:20.106849 | 2025-04-07 15:23:20.106966 | PLAY RECAP 2025-04-07 15:23:20.107043 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-04-07 15:23:20.107076 | 2025-04-07 15:23:20.230788 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2025-04-07 15:23:20.234509 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-04-07 15:23:20.923261 | 2025-04-07 15:23:20.923414 | PLAY [Base post] 2025-04-07 15:23:20.949329 | 2025-04-07 15:23:20.949475 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-04-07 15:23:21.764794 | ubuntu-noble | changed 2025-04-07 15:23:21.795375 | 2025-04-07 15:23:21.795642 | PLAY RECAP 2025-04-07 15:23:21.795815 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-04-07 15:23:21.796027 | 2025-04-07 15:23:21.924651 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-04-07 15:23:21.928318 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-04-07 15:23:22.686256 | 2025-04-07 15:23:22.686406 | PLAY [Base post-logs] 2025-04-07 15:23:22.702965 | 2025-04-07 15:23:22.703111 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-04-07 15:23:23.171863 | localhost | changed 2025-04-07 15:23:23.175779 | 2025-04-07 15:23:23.175912 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-04-07 15:23:23.231750 | localhost | ok 2025-04-07 15:23:23.241835 | 2025-04-07 15:23:23.241967 | TASK [Set zuul-log-path fact] 2025-04-07 15:23:23.274814 | localhost | ok 2025-04-07 15:23:23.288913 | 2025-04-07 15:23:23.289141 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-04-07 15:23:23.325487 | localhost | ok 2025-04-07 15:23:23.338371 | 2025-04-07 15:23:23.338744 | TASK [upload-logs : Create log directories] 2025-04-07 15:23:23.858890 | localhost | changed 2025-04-07 15:23:23.872960 | 2025-04-07 15:23:23.873192 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-04-07 15:23:24.370526 | localhost -> localhost | ok: Runtime: 0:00:00.005858 2025-04-07 15:23:24.377171 | 2025-04-07 15:23:24.377295 | TASK [upload-logs : Upload logs to log server] 2025-04-07 15:23:24.938342 | localhost | Output suppressed because no_log was given 2025-04-07 15:23:24.944446 | 2025-04-07 15:23:24.944613 | LOOP [upload-logs : Compress console log and json output] 2025-04-07 15:23:25.022178 | localhost | skipping: Conditional result was False 2025-04-07 15:23:25.048465 | localhost | skipping: Conditional result was False 2025-04-07 15:23:25.063036 | 2025-04-07 15:23:25.063226 | LOOP [upload-logs : Upload compressed console log and json output] 2025-04-07 15:23:25.129224 | localhost | skipping: Conditional result was False 2025-04-07 15:23:25.129879 | 2025-04-07 15:23:25.141409 | localhost | skipping: Conditional result was False 2025-04-07 15:23:25.151841 | 2025-04-07 15:23:25.152052 | LOOP [upload-logs : Upload console log and json output]