2025-02-28 21:43:25.210160 | Job console starting... 2025-02-28 21:43:25.260331 | Updating repositories 2025-02-28 21:43:25.319583 | Preparing job workspace 2025-02-28 21:43:27.536273 | Running Ansible setup... 2025-02-28 21:43:34.138467 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-02-28 21:43:35.286015 | 2025-02-28 21:43:35.286123 | PLAY [Base pre] 2025-02-28 21:43:35.324968 | 2025-02-28 21:43:35.325090 | TASK [Setup log path fact] 2025-02-28 21:43:35.364769 | ubuntu-noble | ok 2025-02-28 21:43:35.438593 | 2025-02-28 21:43:35.438711 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-28 21:43:35.497594 | ubuntu-noble | ok 2025-02-28 21:43:35.502925 | 2025-02-28 21:43:35.503005 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-28 21:43:35.561702 | ubuntu-noble | skipping: Conditional result was False 2025-02-28 21:43:35.567470 | 2025-02-28 21:43:35.567556 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-28 21:43:35.651605 | ubuntu-noble | skipping: Conditional result was False 2025-02-28 21:43:35.660032 | 2025-02-28 21:43:35.660124 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-28 21:43:35.703643 | ubuntu-noble | skipping: Conditional result was False 2025-02-28 21:43:35.710430 | 2025-02-28 21:43:35.710520 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-28 21:43:35.733599 | ubuntu-noble | skipping: Conditional result was False 2025-02-28 21:43:35.740230 | 2025-02-28 21:43:35.740314 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-28 21:43:35.777594 | ubuntu-noble | skipping: Conditional result was False 2025-02-28 21:43:35.788425 | 2025-02-28 21:43:35.788515 | TASK [emit-job-header : Print job information] 2025-02-28 21:43:35.849387 | # Job Information 2025-02-28 21:43:35.849525 | Ansible Version: 2.15.3 2025-02-28 21:43:35.849552 | Job: tox 2025-02-28 21:43:35.849576 | Pipeline: check 2025-02-28 21:43:35.849592 | Executor: 7d211f194f6a 2025-02-28 21:43:35.849608 | Triggered by: https://github.com/osism/openstack-image-manager/pull/884 2025-02-28 21:43:35.849623 | Event ID: 03d30420-f61d-11ef-9457-232aa5c933ca 2025-02-28 21:43:35.854990 | 2025-02-28 21:43:35.855072 | LOOP [emit-job-header : Print node information] 2025-02-28 21:43:36.108535 | ubuntu-noble | ok: 2025-02-28 21:43:36.108672 | ubuntu-noble | # Node Information 2025-02-28 21:43:36.108700 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-02-28 21:43:36.108720 | ubuntu-noble | Hostname: ubuntu 2025-02-28 21:43:36.108737 | ubuntu-noble | Username: zuul 2025-02-28 21:43:36.108753 | ubuntu-noble | Distro: Ubuntu 24.04 2025-02-28 21:43:36.108769 | ubuntu-noble | Provider: regiocloud-a 2025-02-28 21:43:36.108785 | ubuntu-noble | Label: ubuntu-noble 2025-02-28 21:43:36.108800 | ubuntu-noble | Product Name: OpenStack Nova 2025-02-28 21:43:36.108816 | ubuntu-noble | Interface IP: 81.163.192.61 2025-02-28 21:43:36.127247 | 2025-02-28 21:43:36.127340 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-02-28 21:43:37.098664 | ubuntu-noble -> localhost | changed 2025-02-28 21:43:37.106618 | 2025-02-28 21:43:37.106720 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-02-28 21:43:38.332598 | ubuntu-noble -> localhost | changed 2025-02-28 21:43:38.358958 | 2025-02-28 21:43:38.359056 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-02-28 21:43:38.831922 | ubuntu-noble -> localhost | ok 2025-02-28 21:43:38.838070 | 2025-02-28 21:43:38.838151 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-02-28 21:43:38.886733 | ubuntu-noble | ok 2025-02-28 21:43:38.908148 | ubuntu-noble | included: /var/lib/zuul/builds/4b51732c843049d08943a80ecfbaaef6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-02-28 21:43:38.920921 | 2025-02-28 21:43:38.920998 | TASK [add-build-sshkey : Create Temp SSH key] 2025-02-28 21:43:39.727947 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-02-28 21:43:39.728127 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/4b51732c843049d08943a80ecfbaaef6/work/4b51732c843049d08943a80ecfbaaef6_id_rsa 2025-02-28 21:43:39.728162 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/4b51732c843049d08943a80ecfbaaef6/work/4b51732c843049d08943a80ecfbaaef6_id_rsa.pub 2025-02-28 21:43:39.728198 | ubuntu-noble -> localhost | The key fingerprint is: 2025-02-28 21:43:39.728221 | ubuntu-noble -> localhost | SHA256:s2ypqbmxjlR0BB4OJeK+4rjSpVncLdN+GxhSruXVUv8 zuul-build-sshkey 2025-02-28 21:43:39.728243 | ubuntu-noble -> localhost | The key's randomart image is: 2025-02-28 21:43:39.728268 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-02-28 21:43:39.728290 | ubuntu-noble -> localhost | |. o.+.. | 2025-02-28 21:43:39.728310 | ubuntu-noble -> localhost | |.. = o | 2025-02-28 21:43:39.728329 | ubuntu-noble -> localhost | | . + . . . | 2025-02-28 21:43:39.728349 | ubuntu-noble -> localhost | |. . . o o . | 2025-02-28 21:43:39.728368 | ubuntu-noble -> localhost | | . ....oS o . . | 2025-02-28 21:43:39.728402 | ubuntu-noble -> localhost | | ..+ +*oB . . | 2025-02-28 21:43:39.728424 | ubuntu-noble -> localhost | |.o.=. .+B . E| 2025-02-28 21:43:39.728445 | ubuntu-noble -> localhost | |=.+. + +. .. | 2025-02-28 21:43:39.728464 | ubuntu-noble -> localhost | |+o..*oo ... | 2025-02-28 21:43:39.728483 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-02-28 21:43:39.728535 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.180149 2025-02-28 21:43:39.735807 | 2025-02-28 21:43:39.735892 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-02-28 21:43:39.780672 | ubuntu-noble | ok 2025-02-28 21:43:39.791267 | ubuntu-noble | included: /var/lib/zuul/builds/4b51732c843049d08943a80ecfbaaef6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-02-28 21:43:39.800811 | 2025-02-28 21:43:39.800892 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-02-28 21:43:39.824438 | ubuntu-noble | skipping: Conditional result was False 2025-02-28 21:43:39.832751 | 2025-02-28 21:43:39.832839 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-02-28 21:43:40.526833 | ubuntu-noble | changed 2025-02-28 21:43:40.536690 | 2025-02-28 21:43:40.536807 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-02-28 21:43:40.841432 | ubuntu-noble | ok 2025-02-28 21:43:40.851315 | 2025-02-28 21:43:40.851424 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-02-28 21:43:41.599987 | ubuntu-noble | changed 2025-02-28 21:43:41.607939 | 2025-02-28 21:43:41.608039 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-02-28 21:43:42.262305 | ubuntu-noble | changed 2025-02-28 21:43:42.269551 | 2025-02-28 21:43:42.269664 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-02-28 21:43:42.304625 | ubuntu-noble | skipping: Conditional result was False 2025-02-28 21:43:42.311771 | 2025-02-28 21:43:42.311867 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-02-28 21:43:42.751845 | ubuntu-noble -> localhost | changed 2025-02-28 21:43:42.768271 | 2025-02-28 21:43:42.768538 | TASK [add-build-sshkey : Add back temp key] 2025-02-28 21:43:43.149984 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/4b51732c843049d08943a80ecfbaaef6/work/4b51732c843049d08943a80ecfbaaef6_id_rsa (zuul-build-sshkey) 2025-02-28 21:43:43.150134 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.009284 2025-02-28 21:43:43.157521 | 2025-02-28 21:43:43.157644 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-02-28 21:43:43.537688 | ubuntu-noble | ok 2025-02-28 21:43:43.544201 | 2025-02-28 21:43:43.544291 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-02-28 21:43:43.567843 | ubuntu-noble | skipping: Conditional result was False 2025-02-28 21:43:43.581198 | 2025-02-28 21:43:43.581294 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-02-28 21:43:44.044512 | ubuntu-noble | ok 2025-02-28 21:43:44.059585 | 2025-02-28 21:43:44.059696 | TASK [validate-host : Define zuul_info_dir fact] 2025-02-28 21:43:44.089445 | ubuntu-noble | ok 2025-02-28 21:43:44.095695 | 2025-02-28 21:43:44.095788 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-02-28 21:43:44.413661 | ubuntu-noble -> localhost | ok 2025-02-28 21:43:44.421590 | 2025-02-28 21:43:44.421686 | TASK [validate-host : Collect information about the host] 2025-02-28 21:43:45.513610 | ubuntu-noble | ok 2025-02-28 21:43:45.536567 | 2025-02-28 21:43:45.536678 | TASK [validate-host : Sanitize hostname] 2025-02-28 21:43:45.596082 | ubuntu-noble | ok 2025-02-28 21:43:45.602970 | 2025-02-28 21:43:45.603079 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-02-28 21:43:46.190235 | ubuntu-noble -> localhost | changed 2025-02-28 21:43:46.197434 | 2025-02-28 21:43:46.197530 | TASK [validate-host : Collect information about zuul worker] 2025-02-28 21:43:46.535424 | ubuntu-noble | ok 2025-02-28 21:43:46.541460 | 2025-02-28 21:43:46.541549 | TASK [validate-host : Write out all zuul information for each host] 2025-02-28 21:43:47.240046 | ubuntu-noble -> localhost | changed 2025-02-28 21:43:47.253033 | 2025-02-28 21:43:47.253881 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-02-28 21:43:47.521383 | ubuntu-noble | ok 2025-02-28 21:43:47.526759 | 2025-02-28 21:43:47.526838 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-02-28 21:43:48.399292 | ubuntu-noble | changed: 2025-02-28 21:43:48.399439 | ubuntu-noble | cd+++++++++ src/ 2025-02-28 21:43:48.399465 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-02-28 21:43:48.399484 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-02-28 21:43:48.399501 | ubuntu-noble | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-02-28 21:43:48.399518 | ubuntu-noble | =5.5 (from tox) 2025-02-28 21:44:13.964024 | ubuntu-noble | Downloading cachetools-5.5.2-py3-none-any.whl.metadata (5.4 kB) 2025-02-28 21:44:14.016695 | ubuntu-noble | Collecting chardet>=5.2 (from tox) 2025-02-28 21:44:14.033674 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl.metadata (3.4 kB) 2025-02-28 21:44:14.101498 | ubuntu-noble | Collecting colorama>=0.4.6 (from tox) 2025-02-28 21:44:14.113869 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2025-02-28 21:44:14.206344 | ubuntu-noble | Collecting filelock>=3.16.1 (from tox) 2025-02-28 21:44:14.222258 | ubuntu-noble | Downloading filelock-3.17.0-py3-none-any.whl.metadata (2.9 kB) 2025-02-28 21:44:14.359780 | ubuntu-noble | Collecting packaging>=24.2 (from tox) 2025-02-28 21:44:14.373996 | ubuntu-noble | Downloading packaging-24.2-py3-none-any.whl.metadata (3.2 kB) 2025-02-28 21:44:14.455005 | ubuntu-noble | Collecting platformdirs>=4.3.6 (from tox) 2025-02-28 21:44:14.469401 | ubuntu-noble | Downloading platformdirs-4.3.6-py3-none-any.whl.metadata (11 kB) 2025-02-28 21:44:14.536404 | ubuntu-noble | Collecting pluggy>=1.5 (from tox) 2025-02-28 21:44:14.551298 | ubuntu-noble | Downloading pluggy-1.5.0-py3-none-any.whl.metadata (4.8 kB) 2025-02-28 21:44:14.614022 | ubuntu-noble | Collecting pyproject-api>=1.8 (from tox) 2025-02-28 21:44:14.630074 | ubuntu-noble | Downloading pyproject_api-1.9.0-py3-none-any.whl.metadata (2.7 kB) 2025-02-28 21:44:14.814595 | ubuntu-noble | Collecting virtualenv>=20.27.1 (from tox) 2025-02-28 21:44:14.827886 | ubuntu-noble | Downloading virtualenv-20.29.2-py3-none-any.whl.metadata (4.5 kB) 2025-02-28 21:44:15.012351 | ubuntu-noble | Collecting distlib<1,>=0.3.7 (from virtualenv>=20.27.1->tox) 2025-02-28 21:44:15.027743 | ubuntu-noble | Downloading distlib-0.3.9-py2.py3-none-any.whl.metadata (5.2 kB) 2025-02-28 21:44:15.079480 | ubuntu-noble | Downloading tox-4.24.1-py3-none-any.whl (171 kB) 2025-02-28 21:44:15.115830 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 171.8/171.8 kB 5.5 MB/s eta 0:00:00 2025-02-28 21:44:15.129550 | ubuntu-noble | Downloading cachetools-5.5.2-py3-none-any.whl (10 kB) 2025-02-28 21:44:15.150615 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-02-28 21:44:15.166675 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 17.8 MB/s eta 0:00:00 2025-02-28 21:44:15.178914 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-02-28 21:44:15.203567 | ubuntu-noble | Downloading filelock-3.17.0-py3-none-any.whl (16 kB) 2025-02-28 21:44:15.224573 | ubuntu-noble | Downloading packaging-24.2-py3-none-any.whl (65 kB) 2025-02-28 21:44:15.238171 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 65.5/65.5 kB 8.2 MB/s eta 0:00:00 2025-02-28 21:44:15.250862 | ubuntu-noble | Downloading platformdirs-4.3.6-py3-none-any.whl (18 kB) 2025-02-28 21:44:15.271884 | ubuntu-noble | Downloading pluggy-1.5.0-py3-none-any.whl (20 kB) 2025-02-28 21:44:15.293243 | ubuntu-noble | Downloading pyproject_api-1.9.0-py3-none-any.whl (13 kB) 2025-02-28 21:44:15.315047 | ubuntu-noble | Downloading virtualenv-20.29.2-py3-none-any.whl (4.3 MB) 2025-02-28 21:44:15.483229 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.3/4.3 MB 26.1 MB/s eta 0:00:00 2025-02-28 21:44:15.497918 | ubuntu-noble | Downloading distlib-0.3.9-py2.py3-none-any.whl (468 kB) 2025-02-28 21:44:15.525022 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 20.2 MB/s eta 0:00:00 2025-02-28 21:44:15.617768 | ubuntu-noble | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-02-28 21:44:16.488735 | ubuntu-noble | Successfully installed cachetools-5.5.2 chardet-5.2.0 colorama-0.4.6 distlib-0.3.9 filelock-3.17.0 packaging-24.2 platformdirs-4.3.6 pluggy-1.5.0 pyproject-api-1.9.0 tox-4.24.1 virtualenv-20.29.2 2025-02-28 21:44:16.963688 | ubuntu-noble | ok: Runtime: 0:00:03.769072 2025-02-28 21:44:16.971313 | 2025-02-28 21:44:16.971426 | TASK [ensure-tox : Export installed tox_executable path] 2025-02-28 21:44:17.028151 | ubuntu-noble | ok 2025-02-28 21:44:17.035477 | 2025-02-28 21:44:17.035582 | TASK [ensure-tox : Output tox version] 2025-02-28 21:44:17.855727 | ubuntu-noble | ROOT: No tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-02-28 21:44:17.888694 | ubuntu-noble | 4.24.1 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2025-02-28 21:44:18.072946 | ubuntu-noble | ok: Runtime: 0:00:00.511507 2025-02-28 21:44:18.080603 | 2025-02-28 21:44:18.080716 | TASK [ensure-tox : Make global symlink] 2025-02-28 21:44:18.116702 | ubuntu-noble | skipping: Conditional result was False 2025-02-28 21:44:18.161232 | 2025-02-28 21:44:18.161347 | PLAY RECAP 2025-02-28 21:44:18.161406 | ubuntu-noble | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-02-28 21:44:18.161432 | 2025-02-28 21:44:18.293763 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2025-02-28 21:44:18.307125 | RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/run.yaml@master] 2025-02-28 21:44:19.039810 | 2025-02-28 21:44:19.039977 | PLAY [all] 2025-02-28 21:44:19.075419 | 2025-02-28 21:44:19.075586 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-02-28 21:44:20.115538 | ubuntu-noble | ok: Runtime: 0:00:00.025292 2025-02-28 21:44:20.126384 | 2025-02-28 21:44:20.126725 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-02-28 21:44:20.678835 | ubuntu-noble | ok: Runtime: 0:00:00.004360 2025-02-28 21:44:20.692723 | 2025-02-28 21:44:20.693290 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-02-28 21:44:21.079237 | ubuntu-noble | sudo: a password is required 2025-02-28 21:44:21.245740 | ubuntu-noble | ok: Runtime: 0:00:00.014736 2025-02-28 21:44:21.258939 | 2025-02-28 21:44:21.259062 | TASK [tox : Check to see if the constraints file exists] 2025-02-28 21:44:21.294426 | ubuntu-noble | skipping: Conditional result was False 2025-02-28 21:44:21.302118 | 2025-02-28 21:44:21.302283 | TASK [tox : Fail if constraints file is missing] 2025-02-28 21:44:21.337023 | ubuntu-noble | skipping: Conditional result was False 2025-02-28 21:44:21.345354 | 2025-02-28 21:44:21.345476 | TASK [tox : Record file location] 2025-02-28 21:44:21.370710 | ubuntu-noble | skipping: Conditional result was False 2025-02-28 21:44:21.378743 | 2025-02-28 21:44:21.378866 | TASK [tox : Install tox siblings] 2025-02-28 21:44:21.410290 | ubuntu-noble | ok 2025-02-28 21:44:21.420380 | ubuntu-noble | included: /var/lib/zuul/builds/4b51732c843049d08943a80ecfbaaef6/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/tox/tasks/siblings.yaml 2025-02-28 21:44:21.427792 | 2025-02-28 21:44:21.427909 | TASK [tox : Run tox without tests] 2025-02-28 21:44:22.471728 | ubuntu-noble | test: install_deps> python -I -m pip install -r requirements.txt 2025-02-28 21:44:39.061352 | ubuntu-noble | test: OK (16.87 seconds) 2025-02-28 21:44:39.114202 | ubuntu-noble | congratulations :) (16.97 seconds) 2025-02-28 21:44:39.506807 | ubuntu-noble | ok: Runtime: 0:00:17.264654 2025-02-28 21:44:39.521390 | 2025-02-28 21:44:39.521552 | TASK [tox : Create a tempfile to save tox showconfig] 2025-02-28 21:44:39.920230 | ubuntu-noble | changed 2025-02-28 21:44:39.930157 | 2025-02-28 21:44:39.930299 | TASK [tox : Get tox envlist config] 2025-02-28 21:44:40.971726 | ubuntu-noble | ok: Runtime: 0:00:00.361288 2025-02-28 21:44:40.986119 | 2025-02-28 21:44:40.986296 | TASK [tox : Install any sibling python packages] 2025-02-28 21:44:41.608737 | ubuntu-noble | ok: No setup.cfg, no action needed 2025-02-28 21:44:41.618610 | 2025-02-28 21:44:41.618735 | TASK [tox : Remove tempfile] 2025-02-28 21:44:42.181979 | ubuntu-noble | changed 2025-02-28 21:44:42.192504 | 2025-02-28 21:44:42.192632 | TASK [tox : Emit tox command] 2025-02-28 21:44:42.252660 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-02-28 21:44:42.261663 | 2025-02-28 21:44:42.261789 | TASK [tox : Run tox] 2025-02-28 21:44:43.108581 | ubuntu-noble | test: commands[0]> python -m unittest discover test/unit 2025-02-28 21:44:44.570892 | ubuntu-noble | ............... 2025-02-28 21:44:44.669584 | ubuntu-noble | ---------------------------------------------------------------------- 2025-02-28 21:44:44.669617 | ubuntu-noble | Ran 15 tests in 0.370s 2025-02-28 21:44:44.669626 | ubuntu-noble | 2025-02-28 21:44:44.669632 | ubuntu-noble | OK 2025-02-28 21:44:44.669642 | ubuntu-noble | test: OK (1.63=setup[0.07]+cmd[1.56] seconds) 2025-02-28 21:44:44.732196 | ubuntu-noble | congratulations :) (1.70 seconds) 2025-02-28 21:44:44.803271 | ubuntu-noble | ok: Runtime: 0:00:02.003438 2025-02-28 21:44:44.816279 | 2025-02-28 21:44:44.816476 | TASK [tox : Look for output] 2025-02-28 21:44:45.382630 | ubuntu-noble | ok 2025-02-28 21:44:45.390084 | 2025-02-28 21:44:45.390220 | TASK [tox : Return file comments to Zuul] 2025-02-28 21:44:45.435732 | ubuntu-noble | skipping: Conditional result was False 2025-02-28 21:44:45.468070 | 2025-02-28 21:44:45.468182 | PLAY RECAP 2025-02-28 21:44:45.468262 | ubuntu-noble | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-02-28 21:44:45.468298 | 2025-02-28 21:44:45.589341 | RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/run.yaml@master] 2025-02-28 21:44:45.593172 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2025-02-28 21:44:46.317869 | 2025-02-28 21:44:46.318020 | PLAY [all] 2025-02-28 21:44:46.345869 | 2025-02-28 21:44:46.346004 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-02-28 21:44:46.413435 | ubuntu-noble | skipping: Conditional result was False 2025-02-28 21:44:46.429257 | 2025-02-28 21:44:46.429481 | TASK [fetch-tox-output : Set tox log path for single node] 2025-02-28 21:44:46.480592 | ubuntu-noble | ok 2025-02-28 21:44:46.491695 | 2025-02-28 21:44:46.491829 | TASK [fetch-tox-output : Ensure local tox dir] 2025-02-28 21:44:46.954214 | ubuntu-noble -> localhost | changed 2025-02-28 21:44:46.971334 | 2025-02-28 21:44:46.971499 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-02-28 21:44:47.037991 | ubuntu-noble | skipping: Conditional result was False 2025-02-28 21:44:47.053559 | 2025-02-28 21:44:47.053728 | TASK [fetch-tox-output : Set envlist fact] 2025-02-28 21:44:47.100105 | ubuntu-noble | ok 2025-02-28 21:44:47.112120 | 2025-02-28 21:44:47.112301 | TASK [fetch-tox-output : Get tox version] 2025-02-28 21:44:48.260799 | ubuntu-noble | ROOT: No tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-02-28 21:44:48.292825 | ubuntu-noble | 4.24.1 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2025-02-28 21:44:48.667081 | ubuntu-noble | ok: Runtime: 0:00:00.579522 2025-02-28 21:44:48.683034 | 2025-02-28 21:44:48.683219 | TASK [fetch-tox-output : Find all default environments] 2025-02-28 21:44:48.768493 | ubuntu-noble | skipping: Conditional result was False 2025-02-28 21:44:48.781449 | 2025-02-28 21:44:48.781600 | TASK [fetch-tox-output : Set envlist fact] 2025-02-28 21:44:48.817065 | ubuntu-noble | skipping: Conditional result was False 2025-02-28 21:44:48.831664 | 2025-02-28 21:44:48.831812 | TASK [fetch-tox-output : Find all default environments] 2025-02-28 21:44:48.920437 | ubuntu-noble | skipping: Conditional result was False 2025-02-28 21:44:48.934171 | 2025-02-28 21:44:48.934343 | TASK [fetch-tox-output : Set envlist fact] 2025-02-28 21:44:48.970083 | ubuntu-noble | skipping: Conditional result was False 2025-02-28 21:44:48.987052 | 2025-02-28 21:44:48.987277 | LOOP [fetch-tox-output : Copy tox logs] 2025-02-28 21:44:49.055819 | ubuntu-noble | skipping: Conditional result was False 2025-02-28 21:44:49.079907 | 2025-02-28 21:44:49.080077 | LOOP [fetch-tox-output : Collect tox logs] 2025-02-28 21:44:49.831727 | ubuntu-noble | changed: 2025-02-28 21:44:49.831968 | ubuntu-noble | cd+++++++++ ./ 2025-02-28 21:44:49.832013 | ubuntu-noble | >f+++++++++ 1-commands[0].log 2025-02-28 21:44:49.832056 | 2025-02-28 21:44:49.878426 | 2025-02-28 21:44:49.878524 | PLAY RECAP 2025-02-28 21:44:49.878581 | ubuntu-noble | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-02-28 21:44:49.878606 | 2025-02-28 21:44:49.992986 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2025-02-28 21:44:49.996591 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2025-02-28 21:44:50.693826 | 2025-02-28 21:44:50.693972 | PLAY [all] 2025-02-28 21:44:50.722820 | 2025-02-28 21:44:50.722958 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-02-28 21:44:50.928808 | ubuntu-noble | changed: non-zero return code 2025-02-28 21:44:50.938517 | 2025-02-28 21:44:50.938656 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-02-28 21:44:50.974493 | ubuntu-noble | skipping: Conditional result was False 2025-02-28 21:44:50.991507 | 2025-02-28 21:44:50.991665 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-02-28 21:44:51.032917 | 2025-02-28 21:44:51.033168 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-02-28 21:44:51.074778 | 2025-02-28 21:44:51.075048 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-02-28 21:44:51.100720 | ubuntu-noble | skipping: Conditional result was False 2025-02-28 21:44:51.116943 | 2025-02-28 21:44:51.117105 | LOOP [fetch-subunit-output : Generate subunit file] 2025-02-28 21:44:51.160482 | 2025-02-28 21:44:51.160768 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-02-28 21:44:51.186653 | ubuntu-noble | skipping: Conditional result was False 2025-02-28 21:44:51.200124 | 2025-02-28 21:44:51.200298 | TASK [fetch-subunit-output : Remove the temporary file] 2025-02-28 21:44:51.226085 | ubuntu-noble | skipping: Conditional result was False 2025-02-28 21:44:51.240171 | 2025-02-28 21:44:51.240333 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-02-28 21:44:51.265945 | ubuntu-noble | skipping: Conditional result was False 2025-02-28 21:44:51.308059 | 2025-02-28 21:44:51.308143 | PLAY RECAP 2025-02-28 21:44:51.308212 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-02-28 21:44:51.308239 | 2025-02-28 21:44:51.417147 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2025-02-28 21:44:51.420845 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-02-28 21:44:52.092506 | 2025-02-28 21:44:52.092661 | PLAY [Base post] 2025-02-28 21:44:52.117999 | 2025-02-28 21:44:52.118134 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-02-28 21:44:52.906642 | ubuntu-noble | changed 2025-02-28 21:44:52.941586 | 2025-02-28 21:44:52.941714 | PLAY RECAP 2025-02-28 21:44:52.941778 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-02-28 21:44:52.941842 | 2025-02-28 21:44:53.050063 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-02-28 21:44:53.059745 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-02-28 21:44:53.833249 | 2025-02-28 21:44:53.833416 | PLAY [Base post-logs] 2025-02-28 21:44:53.849410 | 2025-02-28 21:44:53.849531 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-02-28 21:44:54.259442 | localhost | changed 2025-02-28 21:44:54.266759 | 2025-02-28 21:44:54.266929 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-02-28 21:44:54.299597 | localhost | ok 2025-02-28 21:44:54.309695 | 2025-02-28 21:44:54.309824 | TASK [Set zuul-log-path fact] 2025-02-28 21:44:54.330684 | localhost | ok 2025-02-28 21:44:54.348252 | 2025-02-28 21:44:54.348349 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-28 21:44:54.401867 | localhost | ok 2025-02-28 21:44:54.407167 | 2025-02-28 21:44:54.407311 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-28 21:44:54.442239 | localhost | skipping: Conditional result was False 2025-02-28 21:44:54.450332 | 2025-02-28 21:44:54.450535 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-28 21:44:54.500147 | localhost | skipping: Conditional result was False 2025-02-28 21:44:54.508349 | 2025-02-28 21:44:54.508550 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-28 21:44:54.524007 | localhost | skipping: Conditional result was False 2025-02-28 21:44:54.529812 | 2025-02-28 21:44:54.529947 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-28 21:44:54.544490 | localhost | skipping: Conditional result was False 2025-02-28 21:44:54.550395 | 2025-02-28 21:44:54.550530 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-28 21:44:54.565475 | localhost | skipping: Conditional result was False 2025-02-28 21:44:54.575793 | 2025-02-28 21:44:54.575930 | TASK [upload-logs : Create log directories] 2025-02-28 21:44:55.035796 | localhost | changed 2025-02-28 21:44:55.042960 | 2025-02-28 21:44:55.043083 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-02-28 21:44:55.507284 | localhost -> localhost | ok: Runtime: 0:00:00.007460 2025-02-28 21:44:55.519034 | 2025-02-28 21:44:55.519215 | TASK [upload-logs : Upload logs to log server] 2025-02-28 21:44:56.065909 | localhost | Output suppressed because no_log was given 2025-02-28 21:44:56.072821 | 2025-02-28 21:44:56.073004 | LOOP [upload-logs : Compress console log and json output] 2025-02-28 21:44:56.137661 | localhost | skipping: Conditional result was False 2025-02-28 21:44:56.154833 | localhost | skipping: Conditional result was False 2025-02-28 21:44:56.169515 | 2025-02-28 21:44:56.169707 | LOOP [upload-logs : Upload compressed console log and json output] 2025-02-28 21:44:56.231990 | localhost | skipping: Conditional result was False 2025-02-28 21:44:56.232687 | 2025-02-28 21:44:56.243765 | localhost | skipping: Conditional result was False 2025-02-28 21:44:56.251259 | 2025-02-28 21:44:56.251369 | LOOP [upload-logs : Upload console log and json output]