2025-01-27 18:31:57.047911 | Job console starting... 2025-01-27 18:31:57.080965 | Updating repositories 2025-01-27 18:31:57.126914 | Preparing job workspace 2025-01-27 18:31:59.934723 | Running Ansible setup... 2025-01-27 18:32:07.627633 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-27 18:32:08.731272 | 2025-01-27 18:32:08.731385 | PLAY [Base pre] 2025-01-27 18:32:08.754339 | 2025-01-27 18:32:08.754438 | TASK [Setup log path fact] 2025-01-27 18:32:08.773028 | ubuntu-noble | ok 2025-01-27 18:32:08.806759 | 2025-01-27 18:32:08.806864 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-27 18:32:08.893269 | ubuntu-noble | ok 2025-01-27 18:32:08.903554 | 2025-01-27 18:32:08.903645 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-27 18:32:08.982921 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:32:08.988907 | 2025-01-27 18:32:08.989008 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-27 18:32:09.074853 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:32:09.080743 | 2025-01-27 18:32:09.080829 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-27 18:32:09.129055 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:32:09.134830 | 2025-01-27 18:32:09.134917 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-27 18:32:09.169060 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:32:09.175987 | 2025-01-27 18:32:09.176076 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-27 18:32:09.202151 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:32:09.212947 | 2025-01-27 18:32:09.213059 | TASK [emit-job-header : Print job information] 2025-01-27 18:32:09.292718 | # Job Information 2025-01-27 18:32:09.292852 | Ansible Version: 2.15.3 2025-01-27 18:32:09.292877 | Job: tox 2025-01-27 18:32:09.292901 | Pipeline: check 2025-01-27 18:32:09.292918 | Executor: 7d211f194f6a 2025-01-27 18:32:09.292940 | Triggered by: https://github.com/osism/openstack-image-manager/pull/873 2025-01-27 18:32:09.292965 | Event ID: f7d63060-dcdc-11ef-9eb2-4f89d75c0d57 2025-01-27 18:32:09.297952 | 2025-01-27 18:32:09.298044 | LOOP [emit-job-header : Print node information] 2025-01-27 18:32:09.520621 | ubuntu-noble | ok: 2025-01-27 18:32:09.528702 | ubuntu-noble | # Node Information 2025-01-27 18:32:09.528793 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-27 18:32:09.528823 | ubuntu-noble | Hostname: ubuntu 2025-01-27 18:32:09.528846 | ubuntu-noble | Username: zuul 2025-01-27 18:32:09.528871 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-27 18:32:09.528891 | ubuntu-noble | Provider: regiocloud-a 2025-01-27 18:32:09.528910 | ubuntu-noble | Label: ubuntu-noble 2025-01-27 18:32:09.528930 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-27 18:32:09.528951 | ubuntu-noble | Interface IP: 81.163.193.234 2025-01-27 18:32:09.541724 | 2025-01-27 18:32:09.541816 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-27 18:32:10.611672 | ubuntu-noble -> localhost | changed 2025-01-27 18:32:10.620093 | 2025-01-27 18:32:10.620195 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-27 18:32:12.300865 | ubuntu-noble -> localhost | changed 2025-01-27 18:32:12.315716 | 2025-01-27 18:32:12.315832 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-27 18:32:12.860446 | ubuntu-noble -> localhost | ok 2025-01-27 18:32:12.867609 | 2025-01-27 18:32:12.867701 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-27 18:32:12.927939 | ubuntu-noble | ok 2025-01-27 18:32:12.955671 | ubuntu-noble | included: /var/lib/zuul/builds/77093b2947d34e18ba312532278d2dd8/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-27 18:32:12.964815 | 2025-01-27 18:32:12.964900 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-27 18:32:13.596875 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-27 18:32:13.597123 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/77093b2947d34e18ba312532278d2dd8/work/77093b2947d34e18ba312532278d2dd8_id_rsa 2025-01-27 18:32:13.597162 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/77093b2947d34e18ba312532278d2dd8/work/77093b2947d34e18ba312532278d2dd8_id_rsa.pub 2025-01-27 18:32:13.597189 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-27 18:32:13.597212 | ubuntu-noble -> localhost | SHA256:N5CVTg6gylfemAHAN3EpFpjEEWZYB93xlDreU7w78yE zuul-build-sshkey 2025-01-27 18:32:13.597235 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-27 18:32:13.597260 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-27 18:32:13.597282 | ubuntu-noble -> localhost | | *XO=+++.... | 2025-01-27 18:32:13.597302 | ubuntu-noble -> localhost | |.o=.*+ooooo | 2025-01-27 18:32:13.597322 | ubuntu-noble -> localhost | | o.oo.+* | 2025-01-27 18:32:13.597342 | ubuntu-noble -> localhost | | . . oo= .= | 2025-01-27 18:32:13.597361 | ubuntu-noble -> localhost | | o ..+oS.o. | 2025-01-27 18:32:13.597381 | ubuntu-noble -> localhost | | . . o... | 2025-01-27 18:32:13.597400 | ubuntu-noble -> localhost | | .E.. | 2025-01-27 18:32:13.597420 | ubuntu-noble -> localhost | | +. . | 2025-01-27 18:32:13.597438 | ubuntu-noble -> localhost | | +. | 2025-01-27 18:32:13.597457 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-27 18:32:13.597508 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.062906 2025-01-27 18:32:13.605312 | 2025-01-27 18:32:13.605418 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-27 18:32:13.626014 | ubuntu-noble | ok 2025-01-27 18:32:13.638079 | ubuntu-noble | included: /var/lib/zuul/builds/77093b2947d34e18ba312532278d2dd8/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-27 18:32:13.647675 | 2025-01-27 18:32:13.647757 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-27 18:32:13.662494 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:32:13.670032 | 2025-01-27 18:32:13.670124 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-27 18:32:14.336859 | ubuntu-noble | changed 2025-01-27 18:32:14.346381 | 2025-01-27 18:32:14.346481 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-27 18:32:14.648314 | ubuntu-noble | ok 2025-01-27 18:32:14.657609 | 2025-01-27 18:32:14.657859 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-27 18:32:15.378784 | ubuntu-noble | changed 2025-01-27 18:32:15.384423 | 2025-01-27 18:32:15.384499 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-27 18:32:16.131620 | ubuntu-noble | changed 2025-01-27 18:32:16.138360 | 2025-01-27 18:32:16.138447 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-27 18:32:16.164731 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:32:16.172094 | 2025-01-27 18:32:16.172184 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-27 18:32:16.829975 | ubuntu-noble -> localhost | changed 2025-01-27 18:32:16.939704 | 2025-01-27 18:32:16.939825 | TASK [add-build-sshkey : Add back temp key] 2025-01-27 18:32:17.513505 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/77093b2947d34e18ba312532278d2dd8/work/77093b2947d34e18ba312532278d2dd8_id_rsa (zuul-build-sshkey) 2025-01-27 18:32:17.513793 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.019723 2025-01-27 18:32:17.521075 | 2025-01-27 18:32:17.521159 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-27 18:32:17.906545 | ubuntu-noble | ok 2025-01-27 18:32:17.913245 | 2025-01-27 18:32:17.913342 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-27 18:32:17.947267 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:32:17.961754 | 2025-01-27 18:32:17.961852 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-27 18:32:18.374000 | ubuntu-noble | ok 2025-01-27 18:32:18.393856 | 2025-01-27 18:32:18.393958 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-27 18:32:18.479862 | ubuntu-noble | ok 2025-01-27 18:32:18.513050 | 2025-01-27 18:32:18.513156 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-27 18:32:18.964507 | ubuntu-noble -> localhost | ok 2025-01-27 18:32:18.973365 | 2025-01-27 18:32:18.973450 | TASK [validate-host : Collect information about the host] 2025-01-27 18:32:20.167373 | ubuntu-noble | ok 2025-01-27 18:32:20.190503 | 2025-01-27 18:32:20.190654 | TASK [validate-host : Sanitize hostname] 2025-01-27 18:32:20.378010 | ubuntu-noble | ok 2025-01-27 18:32:20.387523 | 2025-01-27 18:32:20.387662 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-27 18:32:21.561709 | ubuntu-noble -> localhost | changed 2025-01-27 18:32:21.570869 | 2025-01-27 18:32:21.571022 | TASK [validate-host : Collect information about zuul worker] 2025-01-27 18:32:22.214112 | ubuntu-noble | ok 2025-01-27 18:32:22.244179 | 2025-01-27 18:32:22.244368 | TASK [validate-host : Write out all zuul information for each host] 2025-01-27 18:32:23.468460 | ubuntu-noble -> localhost | changed 2025-01-27 18:32:23.483062 | 2025-01-27 18:32:23.493104 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-27 18:32:23.838816 | ubuntu-noble | ok 2025-01-27 18:32:23.846306 | 2025-01-27 18:32:23.846427 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-27 18:32:25.042949 | ubuntu-noble | changed: 2025-01-27 18:32:25.043145 | ubuntu-noble | cd+++++++++ src/ 2025-01-27 18:32:25.043173 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-27 18:32:25.043193 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-27 18:32:25.043212 | ubuntu-noble | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-01-27 18:32:25.043229 | ubuntu-noble | =5.5 (from tox) 2025-01-27 18:32:54.932199 | ubuntu-noble | Downloading cachetools-5.5.1-py3-none-any.whl.metadata (5.4 kB) 2025-01-27 18:32:54.996932 | ubuntu-noble | Collecting chardet>=5.2 (from tox) 2025-01-27 18:32:55.013256 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl.metadata (3.4 kB) 2025-01-27 18:32:55.075918 | ubuntu-noble | Collecting colorama>=0.4.6 (from tox) 2025-01-27 18:32:55.090772 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2025-01-27 18:32:55.157885 | ubuntu-noble | Collecting filelock>=3.16.1 (from tox) 2025-01-27 18:32:55.171494 | ubuntu-noble | Downloading filelock-3.17.0-py3-none-any.whl.metadata (2.9 kB) 2025-01-27 18:32:55.326730 | ubuntu-noble | Collecting packaging>=24.2 (from tox) 2025-01-27 18:32:55.342027 | ubuntu-noble | Downloading packaging-24.2-py3-none-any.whl.metadata (3.2 kB) 2025-01-27 18:32:55.483879 | ubuntu-noble | Collecting platformdirs>=4.3.6 (from tox) 2025-01-27 18:32:55.498361 | ubuntu-noble | Downloading platformdirs-4.3.6-py3-none-any.whl.metadata (11 kB) 2025-01-27 18:32:55.548282 | ubuntu-noble | Collecting pluggy>=1.5 (from tox) 2025-01-27 18:32:55.562497 | ubuntu-noble | Downloading pluggy-1.5.0-py3-none-any.whl.metadata (4.8 kB) 2025-01-27 18:32:55.611027 | ubuntu-noble | Collecting pyproject-api>=1.8 (from tox) 2025-01-27 18:32:55.627808 | ubuntu-noble | Downloading pyproject_api-1.9.0-py3-none-any.whl.metadata (2.7 kB) 2025-01-27 18:32:55.812251 | ubuntu-noble | Collecting virtualenv>=20.27.1 (from tox) 2025-01-27 18:32:55.826835 | ubuntu-noble | Downloading virtualenv-20.29.1-py3-none-any.whl.metadata (4.5 kB) 2025-01-27 18:32:55.928103 | ubuntu-noble | Collecting distlib<1,>=0.3.7 (from virtualenv>=20.27.1->tox) 2025-01-27 18:32:55.941377 | ubuntu-noble | Downloading distlib-0.3.9-py2.py3-none-any.whl.metadata (5.2 kB) 2025-01-27 18:32:55.978697 | ubuntu-noble | Downloading tox-4.24.1-py3-none-any.whl (171 kB) 2025-01-27 18:32:56.019167 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 171.8/171.8 kB 4.6 MB/s eta 0:00:00 2025-01-27 18:32:56.035401 | ubuntu-noble | Downloading cachetools-5.5.1-py3-none-any.whl (9.5 kB) 2025-01-27 18:32:56.067206 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-01-27 18:32:56.087737 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 13.1 MB/s eta 0:00:00 2025-01-27 18:32:56.105293 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-01-27 18:32:56.136805 | ubuntu-noble | Downloading filelock-3.17.0-py3-none-any.whl (16 kB) 2025-01-27 18:32:56.167762 | ubuntu-noble | Downloading packaging-24.2-py3-none-any.whl (65 kB) 2025-01-27 18:32:56.186493 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 65.5/65.5 kB 5.8 MB/s eta 0:00:00 2025-01-27 18:32:56.201687 | ubuntu-noble | Downloading platformdirs-4.3.6-py3-none-any.whl (18 kB) 2025-01-27 18:32:56.228140 | ubuntu-noble | Downloading pluggy-1.5.0-py3-none-any.whl (20 kB) 2025-01-27 18:32:56.260167 | ubuntu-noble | Downloading pyproject_api-1.9.0-py3-none-any.whl (13 kB) 2025-01-27 18:32:56.289311 | ubuntu-noble | Downloading virtualenv-20.29.1-py3-none-any.whl (4.3 MB) 2025-01-27 18:32:56.467932 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.3/4.3 MB 24.6 MB/s eta 0:00:00 2025-01-27 18:32:56.484010 | ubuntu-noble | Downloading distlib-0.3.9-py2.py3-none-any.whl (468 kB) 2025-01-27 18:32:56.515001 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 18.0 MB/s eta 0:00:00 2025-01-27 18:32:56.615438 | ubuntu-noble | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-01-27 18:32:57.524351 | ubuntu-noble | Successfully installed cachetools-5.5.1 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.1 2025-01-27 18:32:57.749242 | ubuntu-noble | ok: Runtime: 0:00:04.003565 2025-01-27 18:32:57.761831 | 2025-01-27 18:32:57.761979 | TASK [ensure-tox : Export installed tox_executable path] 2025-01-27 18:32:57.874263 | ubuntu-noble | ok 2025-01-27 18:32:57.885469 | 2025-01-27 18:32:57.885620 | TASK [ensure-tox : Output tox version] 2025-01-27 18:32:58.827539 | ubuntu-noble | ROOT: No tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-01-27 18:32:58.842902 | ubuntu-noble | 4.24.1 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2025-01-27 18:32:58.952637 | ubuntu-noble | ok: Runtime: 0:00:00.547752 2025-01-27 18:32:58.968504 | 2025-01-27 18:32:58.969373 | TASK [ensure-tox : Make global symlink] 2025-01-27 18:32:59.014858 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:32:59.115431 | 2025-01-27 18:32:59.115584 | PLAY RECAP 2025-01-27 18:32:59.115643 | ubuntu-noble | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-01-27 18:32:59.115670 | 2025-01-27 18:32:59.232458 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2025-01-27 18:32:59.236127 | RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/run.yaml@master] 2025-01-27 18:32:59.960521 | 2025-01-27 18:32:59.960689 | PLAY [all] 2025-01-27 18:32:59.989354 | 2025-01-27 18:32:59.989522 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-01-27 18:33:01.028896 | ubuntu-noble | ok: Runtime: 0:00:00.023062 2025-01-27 18:33:01.044510 | 2025-01-27 18:33:01.044714 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-01-27 18:33:01.587770 | ubuntu-noble | ok: Runtime: 0:00:00.006256 2025-01-27 18:33:01.602628 | 2025-01-27 18:33:01.602770 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-01-27 18:33:02.013541 | ubuntu-noble | sudo: a password is required 2025-01-27 18:33:02.145706 | ubuntu-noble | ok: Runtime: 0:00:00.012012 2025-01-27 18:33:02.172007 | 2025-01-27 18:33:02.172173 | TASK [tox : Check to see if the constraints file exists] 2025-01-27 18:33:02.219321 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:33:02.236143 | 2025-01-27 18:33:02.236317 | TASK [tox : Fail if constraints file is missing] 2025-01-27 18:33:02.273642 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:33:02.289461 | 2025-01-27 18:33:02.289611 | TASK [tox : Record file location] 2025-01-27 18:33:02.326336 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:33:02.343177 | 2025-01-27 18:33:02.343344 | TASK [tox : Install tox siblings] 2025-01-27 18:33:02.382416 | ubuntu-noble | ok 2025-01-27 18:33:02.394751 | ubuntu-noble | included: /var/lib/zuul/builds/77093b2947d34e18ba312532278d2dd8/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/tox/tasks/siblings.yaml 2025-01-27 18:33:02.402143 | 2025-01-27 18:33:02.402252 | TASK [tox : Run tox without tests] 2025-01-27 18:33:03.535551 | ubuntu-noble | test: install_deps> python -I -m pip install -r requirements.txt 2025-01-27 18:33:22.837396 | ubuntu-noble | test: OK (19.65 seconds) 2025-01-27 18:33:22.904922 | ubuntu-noble | congratulations :) (19.74 seconds) 2025-01-27 18:33:22.978246 | ubuntu-noble | ok: Runtime: 0:00:20.077479 2025-01-27 18:33:22.994692 | 2025-01-27 18:33:22.994844 | TASK [tox : Create a tempfile to save tox showconfig] 2025-01-27 18:33:23.410070 | ubuntu-noble | changed 2025-01-27 18:33:23.418674 | 2025-01-27 18:33:23.418828 | TASK [tox : Get tox envlist config] 2025-01-27 18:33:24.459086 | ubuntu-noble | ok: Runtime: 0:00:00.397596 2025-01-27 18:33:24.473684 | 2025-01-27 18:33:24.473842 | TASK [tox : Install any sibling python packages] 2025-01-27 18:33:25.284264 | ubuntu-noble | ok: No setup.cfg, no action needed 2025-01-27 18:33:25.291240 | 2025-01-27 18:33:25.291343 | TASK [tox : Remove tempfile] 2025-01-27 18:33:25.985962 | ubuntu-noble | changed 2025-01-27 18:33:25.995052 | 2025-01-27 18:33:25.995170 | TASK [tox : Emit tox command] 2025-01-27 18:33:26.078790 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-01-27 18:33:26.085743 | 2025-01-27 18:33:26.085882 | TASK [tox : Run tox] 2025-01-27 18:33:27.075582 | ubuntu-noble | test: commands[0]> python -m unittest discover test/unit 2025-01-27 18:33:28.839034 | ubuntu-noble | ............... 2025-01-27 18:33:29.104783 | ubuntu-noble | ---------------------------------------------------------------------- 2025-01-27 18:33:29.104860 | ubuntu-noble | Ran 15 tests in 0.253s 2025-01-27 18:33:29.104870 | ubuntu-noble | 2025-01-27 18:33:29.104876 | ubuntu-noble | OK 2025-01-27 18:33:29.104891 | ubuntu-noble | test: OK (2.10=setup[0.07]+cmd[2.03] seconds) 2025-01-27 18:33:29.268626 | ubuntu-noble | congratulations :) (2.18 seconds) 2025-01-27 18:33:29.630474 | ubuntu-noble | ok: Runtime: 0:00:02.627680 2025-01-27 18:33:29.639383 | 2025-01-27 18:33:29.639493 | TASK [tox : Look for output] 2025-01-27 18:33:30.306321 | ubuntu-noble | ok 2025-01-27 18:33:30.318057 | 2025-01-27 18:33:30.318280 | TASK [tox : Return file comments to Zuul] 2025-01-27 18:33:30.355110 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:33:30.399994 | 2025-01-27 18:33:30.400251 | PLAY RECAP 2025-01-27 18:33:30.400337 | ubuntu-noble | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-01-27 18:33:30.400370 | 2025-01-27 18:33:30.592658 | RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/run.yaml@master] 2025-01-27 18:33:30.598959 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2025-01-27 18:33:31.349051 | 2025-01-27 18:33:31.349208 | PLAY [all] 2025-01-27 18:33:31.391335 | 2025-01-27 18:33:31.391490 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-01-27 18:33:31.448736 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:33:31.456898 | 2025-01-27 18:33:31.457098 | TASK [fetch-tox-output : Set tox log path for single node] 2025-01-27 18:33:31.504648 | ubuntu-noble | ok 2025-01-27 18:33:31.515042 | 2025-01-27 18:33:31.515165 | TASK [fetch-tox-output : Ensure local tox dir] 2025-01-27 18:33:32.572095 | ubuntu-noble -> localhost | changed 2025-01-27 18:33:32.586741 | 2025-01-27 18:33:32.588092 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-01-27 18:33:32.664662 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:33:32.672142 | 2025-01-27 18:33:32.672265 | TASK [fetch-tox-output : Set envlist fact] 2025-01-27 18:33:32.785505 | ubuntu-noble | ok 2025-01-27 18:33:32.792956 | 2025-01-27 18:33:32.793112 | TASK [fetch-tox-output : Get tox version] 2025-01-27 18:33:33.819985 | ubuntu-noble | ROOT: No tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-01-27 18:33:33.842621 | ubuntu-noble | 4.24.1 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2025-01-27 18:33:34.391883 | ubuntu-noble | ok: Runtime: 0:00:00.443864 2025-01-27 18:33:34.400465 | 2025-01-27 18:33:34.400611 | TASK [fetch-tox-output : Find all default environments] 2025-01-27 18:33:34.474151 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:33:34.482022 | 2025-01-27 18:33:34.482168 | TASK [fetch-tox-output : Set envlist fact] 2025-01-27 18:33:34.515205 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:33:34.528718 | 2025-01-27 18:33:34.528869 | TASK [fetch-tox-output : Find all default environments] 2025-01-27 18:33:34.613319 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:33:34.620696 | 2025-01-27 18:33:34.620817 | TASK [fetch-tox-output : Set envlist fact] 2025-01-27 18:33:34.655812 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:33:34.664056 | 2025-01-27 18:33:34.664183 | LOOP [fetch-tox-output : Copy tox logs] 2025-01-27 18:33:34.776503 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:33:34.790212 | 2025-01-27 18:33:34.790346 | LOOP [fetch-tox-output : Collect tox logs] 2025-01-27 18:33:35.919529 | ubuntu-noble | changed: 2025-01-27 18:33:35.919775 | ubuntu-noble | cd+++++++++ ./ 2025-01-27 18:33:35.919809 | ubuntu-noble | >f+++++++++ 1-commands[0].log 2025-01-27 18:33:35.919842 | 2025-01-27 18:33:35.959378 | 2025-01-27 18:33:35.959477 | PLAY RECAP 2025-01-27 18:33:35.959535 | ubuntu-noble | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-01-27 18:33:35.959562 | 2025-01-27 18:33:36.105500 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2025-01-27 18:33:36.109247 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2025-01-27 18:33:36.898709 | 2025-01-27 18:33:36.898923 | PLAY [all] 2025-01-27 18:33:36.939756 | 2025-01-27 18:33:36.939929 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-01-27 18:33:37.279462 | ubuntu-noble | changed: non-zero return code 2025-01-27 18:33:37.287366 | 2025-01-27 18:33:37.287524 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-01-27 18:33:37.333970 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:33:37.354890 | 2025-01-27 18:33:37.355056 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-01-27 18:33:37.417630 | 2025-01-27 18:33:37.417839 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-01-27 18:33:37.460269 | 2025-01-27 18:33:37.460513 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-01-27 18:33:37.494240 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:33:37.514836 | 2025-01-27 18:33:37.514978 | LOOP [fetch-subunit-output : Generate subunit file] 2025-01-27 18:33:37.547446 | 2025-01-27 18:33:37.547673 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-01-27 18:33:37.572992 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:33:37.580499 | 2025-01-27 18:33:37.580633 | TASK [fetch-subunit-output : Remove the temporary file] 2025-01-27 18:33:37.605297 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:33:37.612720 | 2025-01-27 18:33:37.612849 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-01-27 18:33:37.658105 | ubuntu-noble | skipping: Conditional result was False 2025-01-27 18:33:37.691223 | 2025-01-27 18:33:37.691341 | PLAY RECAP 2025-01-27 18:33:37.691404 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-01-27 18:33:37.691430 | 2025-01-27 18:33:37.822723 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2025-01-27 18:33:37.826606 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-01-27 18:33:38.686342 | 2025-01-27 18:33:38.686522 | PLAY [Base post] 2025-01-27 18:33:38.715313 | 2025-01-27 18:33:38.715485 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-01-27 18:33:39.669873 | ubuntu-noble | changed 2025-01-27 18:33:39.735542 | 2025-01-27 18:33:39.735684 | PLAY RECAP 2025-01-27 18:33:39.735747 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-01-27 18:33:39.735800 | 2025-01-27 18:33:39.897277 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-01-27 18:33:39.904544 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-01-27 18:33:40.743069 | 2025-01-27 18:33:40.743197 | PLAY [Base post-logs] 2025-01-27 18:33:40.757971 | 2025-01-27 18:33:40.758096 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-01-27 18:33:41.277757 | localhost | changed 2025-01-27 18:33:41.281146 | 2025-01-27 18:33:41.281251 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-01-27 18:33:41.337994 | localhost | ok 2025-01-27 18:33:41.343068 | 2025-01-27 18:33:41.343148 | TASK [Set zuul-log-path fact] 2025-01-27 18:33:41.384298 | localhost | ok 2025-01-27 18:33:41.406832 | 2025-01-27 18:33:41.406921 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-27 18:33:41.473708 | localhost | ok 2025-01-27 18:33:41.476317 | 2025-01-27 18:33:41.476420 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-27 18:33:41.510848 | localhost | skipping: Conditional result was False 2025-01-27 18:33:41.514261 | 2025-01-27 18:33:41.514348 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-27 18:33:41.566950 | localhost | skipping: Conditional result was False 2025-01-27 18:33:41.570060 | 2025-01-27 18:33:41.570155 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-27 18:33:41.584289 | localhost | skipping: Conditional result was False 2025-01-27 18:33:41.587330 | 2025-01-27 18:33:41.587413 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-27 18:33:41.611243 | localhost | skipping: Conditional result was False 2025-01-27 18:33:41.614646 | 2025-01-27 18:33:41.614724 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-27 18:33:41.647489 | localhost | skipping: Conditional result was False 2025-01-27 18:33:41.653655 | 2025-01-27 18:33:41.653761 | TASK [upload-logs : Create log directories] 2025-01-27 18:33:42.308278 | localhost | changed 2025-01-27 18:33:42.311828 | 2025-01-27 18:33:42.311911 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-01-27 18:33:42.723841 | localhost -> localhost | ok: Runtime: 0:00:00.011508 2025-01-27 18:33:42.738722 | 2025-01-27 18:33:42.738842 | TASK [upload-logs : Upload logs to log server] 2025-01-27 18:33:43.260256 | localhost | Output suppressed because no_log was given 2025-01-27 18:33:43.263691 | 2025-01-27 18:33:43.263788 | LOOP [upload-logs : Compress console log and json output] 2025-01-27 18:33:43.333063 | localhost | skipping: Conditional result was False 2025-01-27 18:33:43.354736 | localhost | skipping: Conditional result was False 2025-01-27 18:33:43.370864 | 2025-01-27 18:33:43.371112 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-27 18:33:43.441257 | localhost | skipping: Conditional result was False 2025-01-27 18:33:43.441517 | 2025-01-27 18:33:43.466370 | localhost | skipping: Conditional result was False 2025-01-27 18:33:43.480615 | 2025-01-27 18:33:43.480803 | LOOP [upload-logs : Upload console log and json output]