2025-02-27 11:21:57.096594 | Job console starting... 2025-02-27 11:21:57.198611 | Updating repositories 2025-02-27 11:21:57.284803 | Preparing job workspace 2025-02-27 11:21:59.905657 | Running Ansible setup... 2025-02-27 11:22:07.522655 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-02-27 11:22:08.643648 | 2025-02-27 11:22:08.643758 | PLAY [Base pre] 2025-02-27 11:22:08.694226 | 2025-02-27 11:22:08.694349 | TASK [Setup log path fact] 2025-02-27 11:22:08.737528 | ubuntu-noble | ok 2025-02-27 11:22:08.759867 | 2025-02-27 11:22:08.759970 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-27 11:22:08.829986 | ubuntu-noble | ok 2025-02-27 11:22:08.835516 | 2025-02-27 11:22:08.835600 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-27 11:22:08.863167 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 11:22:08.869671 | 2025-02-27 11:22:08.869758 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-27 11:22:08.934008 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 11:22:08.940224 | 2025-02-27 11:22:08.940334 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-27 11:22:08.973907 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 11:22:08.979556 | 2025-02-27 11:22:08.979637 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-27 11:22:08.993358 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 11:22:09.000921 | 2025-02-27 11:22:09.001006 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-27 11:22:09.044926 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 11:22:09.056003 | 2025-02-27 11:22:09.056091 | TASK [emit-job-header : Print job information] 2025-02-27 11:22:09.137827 | # Job Information 2025-02-27 11:22:09.137977 | Ansible Version: 2.15.3 2025-02-27 11:22:09.138003 | Job: tox 2025-02-27 11:22:09.138028 | Pipeline: check 2025-02-27 11:22:09.138045 | Executor: 7d211f194f6a 2025-02-27 11:22:09.138060 | Triggered by: https://github.com/osism/openstack-image-manager/pull/882 2025-02-27 11:22:09.138074 | Event ID: 08c44b40-f4fd-11ef-8c09-b9776932627e 2025-02-27 11:22:09.143164 | 2025-02-27 11:22:09.143238 | LOOP [emit-job-header : Print node information] 2025-02-27 11:22:09.342054 | ubuntu-noble | ok: 2025-02-27 11:22:09.342221 | ubuntu-noble | # Node Information 2025-02-27 11:22:09.342249 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-02-27 11:22:09.342278 | ubuntu-noble | Hostname: ubuntu 2025-02-27 11:22:09.342297 | ubuntu-noble | Username: zuul 2025-02-27 11:22:09.342314 | ubuntu-noble | Distro: Ubuntu 24.04 2025-02-27 11:22:09.342330 | ubuntu-noble | Provider: regiocloud-a 2025-02-27 11:22:09.342346 | ubuntu-noble | Label: ubuntu-noble 2025-02-27 11:22:09.342361 | ubuntu-noble | Product Name: OpenStack Nova 2025-02-27 11:22:09.342378 | ubuntu-noble | Interface IP: 81.163.193.159 2025-02-27 11:22:09.371040 | 2025-02-27 11:22:09.371140 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-02-27 11:22:10.146354 | ubuntu-noble -> localhost | changed 2025-02-27 11:22:10.153415 | 2025-02-27 11:22:10.153502 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-02-27 11:22:11.940576 | ubuntu-noble -> localhost | changed 2025-02-27 11:22:11.963046 | 2025-02-27 11:22:11.963166 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-02-27 11:22:12.361675 | ubuntu-noble -> localhost | ok 2025-02-27 11:22:12.367958 | 2025-02-27 11:22:12.368046 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-02-27 11:22:12.397076 | ubuntu-noble | ok 2025-02-27 11:22:12.416367 | ubuntu-noble | included: /var/lib/zuul/builds/9529debfbd2048389338cb5799dfce09/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-02-27 11:22:12.423051 | 2025-02-27 11:22:12.423125 | TASK [add-build-sshkey : Create Temp SSH key] 2025-02-27 11:22:13.205383 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-02-27 11:22:13.205708 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/9529debfbd2048389338cb5799dfce09/work/9529debfbd2048389338cb5799dfce09_id_rsa 2025-02-27 11:22:13.205781 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/9529debfbd2048389338cb5799dfce09/work/9529debfbd2048389338cb5799dfce09_id_rsa.pub 2025-02-27 11:22:13.205834 | ubuntu-noble -> localhost | The key fingerprint is: 2025-02-27 11:22:13.205882 | ubuntu-noble -> localhost | SHA256:pWOttAQOlpVFf1r5hjxBpsfwFp9paRCE7INSmeVX6YE zuul-build-sshkey 2025-02-27 11:22:13.205927 | ubuntu-noble -> localhost | The key's randomart image is: 2025-02-27 11:22:13.205977 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-02-27 11:22:13.206022 | ubuntu-noble -> localhost | | .+o=ooBo.. | 2025-02-27 11:22:13.206062 | ubuntu-noble -> localhost | | o. +ooBE*o+ | 2025-02-27 11:22:13.206102 | ubuntu-noble -> localhost | | + .. o= @.B. | 2025-02-27 11:22:13.206141 | ubuntu-noble -> localhost | | . o...+oO *. | 2025-02-27 11:22:13.206179 | ubuntu-noble -> localhost | | ..S o.+ o | 2025-02-27 11:22:13.206218 | ubuntu-noble -> localhost | | + + o | 2025-02-27 11:22:13.206309 | ubuntu-noble -> localhost | | o | 2025-02-27 11:22:13.206356 | ubuntu-noble -> localhost | | | 2025-02-27 11:22:13.206398 | ubuntu-noble -> localhost | | | 2025-02-27 11:22:13.206440 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-02-27 11:22:13.206535 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.305109 2025-02-27 11:22:13.219475 | 2025-02-27 11:22:13.219586 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-02-27 11:22:13.250443 | ubuntu-noble | ok 2025-02-27 11:22:13.259321 | ubuntu-noble | included: /var/lib/zuul/builds/9529debfbd2048389338cb5799dfce09/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-02-27 11:22:13.266966 | 2025-02-27 11:22:13.267038 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-02-27 11:22:13.290741 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 11:22:13.306054 | 2025-02-27 11:22:13.306192 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-02-27 11:22:14.155490 | ubuntu-noble | changed 2025-02-27 11:22:14.170774 | 2025-02-27 11:22:14.170891 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-02-27 11:22:14.520024 | ubuntu-noble | ok 2025-02-27 11:22:14.526763 | 2025-02-27 11:22:14.526850 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-02-27 11:22:15.319881 | ubuntu-noble | changed 2025-02-27 11:22:15.326660 | 2025-02-27 11:22:15.326742 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-02-27 11:22:16.140228 | ubuntu-noble | changed 2025-02-27 11:22:16.147163 | 2025-02-27 11:22:16.147269 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-02-27 11:22:16.181430 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 11:22:16.188525 | 2025-02-27 11:22:16.188613 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-02-27 11:22:16.805457 | ubuntu-noble -> localhost | changed 2025-02-27 11:22:16.848479 | 2025-02-27 11:22:16.848583 | TASK [add-build-sshkey : Add back temp key] 2025-02-27 11:22:17.263087 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/9529debfbd2048389338cb5799dfce09/work/9529debfbd2048389338cb5799dfce09_id_rsa (zuul-build-sshkey) 2025-02-27 11:22:17.263299 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.007340 2025-02-27 11:22:17.270692 | 2025-02-27 11:22:17.270780 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-02-27 11:22:17.702662 | ubuntu-noble | ok 2025-02-27 11:22:17.710838 | 2025-02-27 11:22:17.710929 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-02-27 11:22:17.760494 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 11:22:17.774994 | 2025-02-27 11:22:17.775086 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-02-27 11:22:18.312916 | ubuntu-noble | ok 2025-02-27 11:22:18.337072 | 2025-02-27 11:22:18.337195 | TASK [validate-host : Define zuul_info_dir fact] 2025-02-27 11:22:18.402651 | ubuntu-noble | ok 2025-02-27 11:22:18.413588 | 2025-02-27 11:22:18.413687 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-02-27 11:22:18.772913 | ubuntu-noble -> localhost | ok 2025-02-27 11:22:18.781682 | 2025-02-27 11:22:18.781772 | TASK [validate-host : Collect information about the host] 2025-02-27 11:22:20.071161 | ubuntu-noble | ok 2025-02-27 11:22:20.083893 | 2025-02-27 11:22:20.083991 | TASK [validate-host : Sanitize hostname] 2025-02-27 11:22:20.155252 | ubuntu-noble | ok 2025-02-27 11:22:20.161383 | 2025-02-27 11:22:20.161479 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-02-27 11:22:20.899922 | ubuntu-noble -> localhost | changed 2025-02-27 11:22:20.907134 | 2025-02-27 11:22:20.907244 | TASK [validate-host : Collect information about zuul worker] 2025-02-27 11:22:21.469075 | ubuntu-noble | ok 2025-02-27 11:22:21.476439 | 2025-02-27 11:22:21.476620 | TASK [validate-host : Write out all zuul information for each host] 2025-02-27 11:22:21.968635 | ubuntu-noble -> localhost | changed 2025-02-27 11:22:21.981032 | 2025-02-27 11:22:21.981132 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-02-27 11:22:22.385189 | ubuntu-noble | ok 2025-02-27 11:22:22.395624 | 2025-02-27 11:22:22.395718 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-02-27 11:22:23.553435 | ubuntu-noble | changed: 2025-02-27 11:22:23.553598 | ubuntu-noble | cd+++++++++ src/ 2025-02-27 11:22:23.553628 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-02-27 11:22:23.553651 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-02-27 11:22:23.553672 | ubuntu-noble | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-02-27 11:22:23.553691 | ubuntu-noble | =5.5 (from tox) 2025-02-27 11:22:57.973481 | ubuntu-noble | Downloading cachetools-5.5.2-py3-none-any.whl.metadata (5.4 kB) 2025-02-27 11:22:58.026438 | ubuntu-noble | Collecting chardet>=5.2 (from tox) 2025-02-27 11:22:58.041328 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl.metadata (3.4 kB) 2025-02-27 11:22:58.123630 | ubuntu-noble | Collecting colorama>=0.4.6 (from tox) 2025-02-27 11:22:58.138794 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2025-02-27 11:22:58.226283 | ubuntu-noble | Collecting filelock>=3.16.1 (from tox) 2025-02-27 11:22:58.240314 | ubuntu-noble | Downloading filelock-3.17.0-py3-none-any.whl.metadata (2.9 kB) 2025-02-27 11:22:58.309018 | ubuntu-noble | Collecting packaging>=24.2 (from tox) 2025-02-27 11:22:58.323431 | ubuntu-noble | Downloading packaging-24.2-py3-none-any.whl.metadata (3.2 kB) 2025-02-27 11:22:58.450455 | ubuntu-noble | Collecting platformdirs>=4.3.6 (from tox) 2025-02-27 11:22:58.464676 | ubuntu-noble | Downloading platformdirs-4.3.6-py3-none-any.whl.metadata (11 kB) 2025-02-27 11:22:58.523426 | ubuntu-noble | Collecting pluggy>=1.5 (from tox) 2025-02-27 11:22:58.535227 | ubuntu-noble | Downloading pluggy-1.5.0-py3-none-any.whl.metadata (4.8 kB) 2025-02-27 11:22:58.595502 | ubuntu-noble | Collecting pyproject-api>=1.8 (from tox) 2025-02-27 11:22:58.609191 | ubuntu-noble | Downloading pyproject_api-1.9.0-py3-none-any.whl.metadata (2.7 kB) 2025-02-27 11:22:58.762434 | ubuntu-noble | Collecting virtualenv>=20.27.1 (from tox) 2025-02-27 11:22:58.776812 | ubuntu-noble | Downloading virtualenv-20.29.2-py3-none-any.whl.metadata (4.5 kB) 2025-02-27 11:22:58.936137 | ubuntu-noble | Collecting distlib<1,>=0.3.7 (from virtualenv>=20.27.1->tox) 2025-02-27 11:22:58.950542 | ubuntu-noble | Downloading distlib-0.3.9-py2.py3-none-any.whl.metadata (5.2 kB) 2025-02-27 11:22:58.995698 | ubuntu-noble | Downloading tox-4.24.1-py3-none-any.whl (171 kB) 2025-02-27 11:22:59.033134 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 171.8/171.8 kB 5.2 MB/s eta 0:00:00 2025-02-27 11:22:59.047804 | ubuntu-noble | Downloading cachetools-5.5.2-py3-none-any.whl (10 kB) 2025-02-27 11:22:59.075865 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-02-27 11:22:59.095471 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 13.3 MB/s eta 0:00:00 2025-02-27 11:22:59.109601 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-02-27 11:22:59.135452 | ubuntu-noble | Downloading filelock-3.17.0-py3-none-any.whl (16 kB) 2025-02-27 11:22:59.160482 | ubuntu-noble | Downloading packaging-24.2-py3-none-any.whl (65 kB) 2025-02-27 11:22:59.172853 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 65.5/65.5 kB 6.5 MB/s eta 0:00:00 2025-02-27 11:22:59.187185 | ubuntu-noble | Downloading platformdirs-4.3.6-py3-none-any.whl (18 kB) 2025-02-27 11:22:59.212497 | ubuntu-noble | Downloading pluggy-1.5.0-py3-none-any.whl (20 kB) 2025-02-27 11:22:59.235107 | ubuntu-noble | Downloading pyproject_api-1.9.0-py3-none-any.whl (13 kB) 2025-02-27 11:22:59.258535 | ubuntu-noble | Downloading virtualenv-20.29.2-py3-none-any.whl (4.3 MB) 2025-02-27 11:22:59.417176 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.3/4.3 MB 29.9 MB/s eta 0:00:00 2025-02-27 11:22:59.431611 | ubuntu-noble | Downloading distlib-0.3.9-py2.py3-none-any.whl (468 kB) 2025-02-27 11:22:59.461494 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 19.2 MB/s eta 0:00:00 2025-02-27 11:22:59.594235 | ubuntu-noble | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-02-27 11:23:01.046872 | 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-27 11:23:01.398222 | ubuntu-noble | ok: Runtime: 0:00:04.381678 2025-02-27 11:23:01.408132 | 2025-02-27 11:23:01.408250 | TASK [ensure-tox : Export installed tox_executable path] 2025-02-27 11:23:01.469451 | ubuntu-noble | ok 2025-02-27 11:23:01.476213 | 2025-02-27 11:23:01.478624 | TASK [ensure-tox : Output tox version] 2025-02-27 11:23:02.536429 | 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-27 11:23:02.553856 | ubuntu-noble | 4.24.1 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2025-02-27 11:23:03.078509 | ubuntu-noble | ok: Runtime: 0:00:00.629874 2025-02-27 11:23:03.094732 | 2025-02-27 11:23:03.094905 | TASK [ensure-tox : Make global symlink] 2025-02-27 11:23:03.131698 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 11:23:03.174036 | 2025-02-27 11:23:03.174150 | PLAY RECAP 2025-02-27 11:23:03.174209 | ubuntu-noble | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-02-27 11:23:03.174235 | 2025-02-27 11:23:03.306357 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2025-02-27 11:23:03.309968 | RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/run.yaml@master] 2025-02-27 11:23:04.066713 | 2025-02-27 11:23:04.066889 | PLAY [all] 2025-02-27 11:23:04.098743 | 2025-02-27 11:23:04.098906 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-02-27 11:23:05.146804 | ubuntu-noble | ok: Runtime: 0:00:00.039709 2025-02-27 11:23:05.170970 | 2025-02-27 11:23:05.171508 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-02-27 11:23:05.776709 | ubuntu-noble | ok: Runtime: 0:00:00.008757 2025-02-27 11:23:05.793488 | 2025-02-27 11:23:05.793652 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-02-27 11:23:06.369542 | ubuntu-noble | sudo: a password is required 2025-02-27 11:23:06.837951 | ubuntu-noble | ok: Runtime: 0:00:00.019573 2025-02-27 11:23:06.852069 | 2025-02-27 11:23:06.852200 | TASK [tox : Check to see if the constraints file exists] 2025-02-27 11:23:06.900972 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 11:23:06.912454 | 2025-02-27 11:23:06.912627 | TASK [tox : Fail if constraints file is missing] 2025-02-27 11:23:06.959275 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 11:23:06.967730 | 2025-02-27 11:23:06.967856 | TASK [tox : Record file location] 2025-02-27 11:23:07.013582 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 11:23:07.022951 | 2025-02-27 11:23:07.023094 | TASK [tox : Install tox siblings] 2025-02-27 11:23:07.061594 | ubuntu-noble | ok 2025-02-27 11:23:07.074715 | ubuntu-noble | included: /var/lib/zuul/builds/9529debfbd2048389338cb5799dfce09/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/tox/tasks/siblings.yaml 2025-02-27 11:23:07.082498 | 2025-02-27 11:23:07.082630 | TASK [tox : Run tox without tests] 2025-02-27 11:23:08.547059 | ubuntu-noble | test: install_deps> python -I -m pip install -r requirements.txt 2025-02-27 11:23:29.213511 | ubuntu-noble | test: OK (21.12 seconds) 2025-02-27 11:23:29.288581 | ubuntu-noble | congratulations :) (21.27 seconds) 2025-02-27 11:23:29.651524 | ubuntu-noble | ok: Runtime: 0:00:21.710467 2025-02-27 11:23:29.659027 | 2025-02-27 11:23:29.659144 | TASK [tox : Create a tempfile to save tox showconfig] 2025-02-27 11:23:30.141439 | ubuntu-noble | changed 2025-02-27 11:23:30.151495 | 2025-02-27 11:23:30.151633 | TASK [tox : Get tox envlist config] 2025-02-27 11:23:31.211447 | ubuntu-noble | ok: Runtime: 0:00:00.546903 2025-02-27 11:23:31.221209 | 2025-02-27 11:23:31.221333 | TASK [tox : Install any sibling python packages] 2025-02-27 11:23:31.897370 | ubuntu-noble | ok: No setup.cfg, no action needed 2025-02-27 11:23:31.906794 | 2025-02-27 11:23:31.906915 | TASK [tox : Remove tempfile] 2025-02-27 11:23:32.661009 | ubuntu-noble | changed 2025-02-27 11:23:32.671637 | 2025-02-27 11:23:32.671753 | TASK [tox : Emit tox command] 2025-02-27 11:23:32.742859 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-02-27 11:23:32.751577 | 2025-02-27 11:23:32.751702 | TASK [tox : Run tox] 2025-02-27 11:23:34.148253 | ubuntu-noble | test: commands[0]> python -m unittest discover test/unit 2025-02-27 11:23:36.654625 | ubuntu-noble | ............... 2025-02-27 11:23:36.936408 | ubuntu-noble | ---------------------------------------------------------------------- 2025-02-27 11:23:36.936448 | ubuntu-noble | Ran 15 tests in 0.467s 2025-02-27 11:23:36.936456 | ubuntu-noble | 2025-02-27 11:23:36.936461 | ubuntu-noble | OK 2025-02-27 11:23:36.936471 | ubuntu-noble | test: OK (2.95=setup[0.16]+cmd[2.79] seconds) 2025-02-27 11:23:37.054703 | ubuntu-noble | congratulations :) (3.05 seconds) 2025-02-27 11:23:37.295506 | ubuntu-noble | ok: Runtime: 0:00:03.633833 2025-02-27 11:23:37.315371 | 2025-02-27 11:23:37.315511 | TASK [tox : Look for output] 2025-02-27 11:23:37.988060 | ubuntu-noble | ok 2025-02-27 11:23:37.997637 | 2025-02-27 11:23:37.997761 | TASK [tox : Return file comments to Zuul] 2025-02-27 11:23:38.053842 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 11:23:38.101326 | 2025-02-27 11:23:38.101412 | PLAY RECAP 2025-02-27 11:23:38.101471 | ubuntu-noble | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-02-27 11:23:38.101497 | 2025-02-27 11:23:38.212900 | RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/run.yaml@master] 2025-02-27 11:23:38.216496 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2025-02-27 11:23:38.944082 | 2025-02-27 11:23:38.944235 | PLAY [all] 2025-02-27 11:23:38.972366 | 2025-02-27 11:23:38.972526 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-02-27 11:23:39.040203 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 11:23:39.054403 | 2025-02-27 11:23:39.054599 | TASK [fetch-tox-output : Set tox log path for single node] 2025-02-27 11:23:39.126146 | ubuntu-noble | ok 2025-02-27 11:23:39.137299 | 2025-02-27 11:23:39.137428 | TASK [fetch-tox-output : Ensure local tox dir] 2025-02-27 11:23:39.636341 | ubuntu-noble -> localhost | changed 2025-02-27 11:23:39.652338 | 2025-02-27 11:23:39.652540 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-02-27 11:23:39.719601 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 11:23:39.734479 | 2025-02-27 11:23:39.734636 | TASK [fetch-tox-output : Set envlist fact] 2025-02-27 11:23:39.790495 | ubuntu-noble | ok 2025-02-27 11:23:39.798133 | 2025-02-27 11:23:39.798253 | TASK [fetch-tox-output : Get tox version] 2025-02-27 11:23:40.928425 | 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-27 11:23:40.947983 | ubuntu-noble | 4.24.1 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2025-02-27 11:23:41.341786 | ubuntu-noble | ok: Runtime: 0:00:00.489939 2025-02-27 11:23:41.357294 | 2025-02-27 11:23:41.357486 | TASK [fetch-tox-output : Find all default environments] 2025-02-27 11:23:41.436192 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 11:23:41.444894 | 2025-02-27 11:23:41.445077 | TASK [fetch-tox-output : Set envlist fact] 2025-02-27 11:23:41.481465 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 11:23:41.497257 | 2025-02-27 11:23:41.497551 | TASK [fetch-tox-output : Find all default environments] 2025-02-27 11:23:41.585398 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 11:23:41.601326 | 2025-02-27 11:23:41.601504 | TASK [fetch-tox-output : Set envlist fact] 2025-02-27 11:23:41.638183 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 11:23:41.653258 | 2025-02-27 11:23:41.653412 | LOOP [fetch-tox-output : Copy tox logs] 2025-02-27 11:23:41.709811 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 11:23:41.741581 | 2025-02-27 11:23:41.741806 | LOOP [fetch-tox-output : Collect tox logs] 2025-02-27 11:23:42.521258 | ubuntu-noble | changed: 2025-02-27 11:23:42.521565 | ubuntu-noble | cd+++++++++ ./ 2025-02-27 11:23:42.521632 | ubuntu-noble | >f+++++++++ 1-commands[0].log 2025-02-27 11:23:42.521689 | 2025-02-27 11:23:42.554590 | 2025-02-27 11:23:42.554690 | PLAY RECAP 2025-02-27 11:23:42.554749 | ubuntu-noble | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-02-27 11:23:42.554775 | 2025-02-27 11:23:42.665493 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2025-02-27 11:23:42.669075 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2025-02-27 11:23:43.341568 | 2025-02-27 11:23:43.341680 | PLAY [all] 2025-02-27 11:23:43.367327 | 2025-02-27 11:23:43.367428 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-02-27 11:23:43.614219 | ubuntu-noble | changed: non-zero return code 2025-02-27 11:23:43.624826 | 2025-02-27 11:23:43.624967 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-02-27 11:23:43.660990 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 11:23:43.678103 | 2025-02-27 11:23:43.678248 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-02-27 11:23:43.730671 | 2025-02-27 11:23:43.731023 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-02-27 11:23:43.773815 | 2025-02-27 11:23:43.774163 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-02-27 11:23:43.801151 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 11:23:43.815332 | 2025-02-27 11:23:43.815470 | LOOP [fetch-subunit-output : Generate subunit file] 2025-02-27 11:23:43.866129 | 2025-02-27 11:23:43.866383 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-02-27 11:23:43.901907 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 11:23:43.918105 | 2025-02-27 11:23:43.918261 | TASK [fetch-subunit-output : Remove the temporary file] 2025-02-27 11:23:43.945475 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 11:23:43.962335 | 2025-02-27 11:23:43.962479 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-02-27 11:23:43.987957 | ubuntu-noble | skipping: Conditional result was False 2025-02-27 11:23:44.027881 | 2025-02-27 11:23:44.027969 | PLAY RECAP 2025-02-27 11:23:44.028021 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-02-27 11:23:44.028047 | 2025-02-27 11:23:44.119383 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2025-02-27 11:23:44.128651 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-02-27 11:23:44.764286 | 2025-02-27 11:23:44.764432 | PLAY [Base post] 2025-02-27 11:23:44.788483 | 2025-02-27 11:23:44.788589 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-02-27 11:23:45.906262 | ubuntu-noble | changed 2025-02-27 11:23:45.940865 | 2025-02-27 11:23:45.941021 | PLAY RECAP 2025-02-27 11:23:45.941100 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-02-27 11:23:45.941175 | 2025-02-27 11:23:46.027662 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-02-27 11:23:46.037157 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-02-27 11:23:46.804730 | 2025-02-27 11:23:46.804884 | PLAY [Base post-logs] 2025-02-27 11:23:46.820888 | 2025-02-27 11:23:46.821066 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-02-27 11:23:47.233545 | localhost | changed 2025-02-27 11:23:47.240322 | 2025-02-27 11:23:47.240528 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-02-27 11:23:47.283389 | localhost | ok 2025-02-27 11:23:47.296442 | 2025-02-27 11:23:47.296606 | TASK [Set zuul-log-path fact] 2025-02-27 11:23:47.331366 | localhost | ok 2025-02-27 11:23:47.351251 | 2025-02-27 11:23:47.351434 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-27 11:23:47.418282 | localhost | ok 2025-02-27 11:23:47.423400 | 2025-02-27 11:23:47.423546 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-27 11:23:47.460841 | localhost | skipping: Conditional result was False 2025-02-27 11:23:47.470500 | 2025-02-27 11:23:47.470692 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-27 11:23:47.518262 | localhost | skipping: Conditional result was False 2025-02-27 11:23:47.527544 | 2025-02-27 11:23:47.527715 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-02-27 11:23:47.545481 | localhost | skipping: Conditional result was False 2025-02-27 11:23:47.553188 | 2025-02-27 11:23:47.553356 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-02-27 11:23:47.570220 | localhost | skipping: Conditional result was False 2025-02-27 11:23:47.579497 | 2025-02-27 11:23:47.579661 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-02-27 11:23:47.606543 | localhost | skipping: Conditional result was False 2025-02-27 11:23:47.620834 | 2025-02-27 11:23:47.620993 | TASK [upload-logs : Create log directories] 2025-02-27 11:23:48.120198 | localhost | changed 2025-02-27 11:23:48.128870 | 2025-02-27 11:23:48.129034 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-02-27 11:23:48.618045 | localhost -> localhost | ok: Runtime: 0:00:00.007584 2025-02-27 11:23:48.628729 | 2025-02-27 11:23:48.628872 | TASK [upload-logs : Upload logs to log server] 2025-02-27 11:23:49.166965 | localhost | Output suppressed because no_log was given 2025-02-27 11:23:49.169831 | 2025-02-27 11:23:49.169913 | LOOP [upload-logs : Compress console log and json output] 2025-02-27 11:23:49.242767 | localhost | skipping: Conditional result was False 2025-02-27 11:23:49.259128 | localhost | skipping: Conditional result was False 2025-02-27 11:23:49.268931 | 2025-02-27 11:23:49.269026 | LOOP [upload-logs : Upload compressed console log and json output] 2025-02-27 11:23:49.344416 | localhost | skipping: Conditional result was False 2025-02-27 11:23:49.344723 | 2025-02-27 11:23:49.359182 | localhost | skipping: Conditional result was False 2025-02-27 11:23:49.376817 | 2025-02-27 11:23:49.377001 | LOOP [upload-logs : Upload console log and json output]