2025-01-08 11:35:35.214442 | Job console starting... 2025-01-08 11:35:35.263484 | Updating repositories 2025-01-08 11:35:35.361374 | Preparing job workspace 2025-01-08 11:35:38.884432 | Running Ansible setup... 2025-01-08 11:35:46.471973 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-08 11:35:47.915636 | 2025-01-08 11:35:47.915768 | PLAY [Base pre] 2025-01-08 11:35:47.943484 | 2025-01-08 11:35:47.943598 | TASK [Setup log path fact] 2025-01-08 11:35:47.983373 | ubuntu-noble | ok 2025-01-08 11:35:48.014084 | 2025-01-08 11:35:48.014218 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-08 11:35:48.139329 | ubuntu-noble | ok 2025-01-08 11:35:48.145296 | 2025-01-08 11:35:48.145381 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-08 11:35:48.194878 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:35:48.200817 | 2025-01-08 11:35:48.200909 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-08 11:35:48.244524 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:35:48.250748 | 2025-01-08 11:35:48.250842 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-08 11:35:48.314795 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:35:48.321062 | 2025-01-08 11:35:48.321166 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-08 11:35:48.364671 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:35:48.371874 | 2025-01-08 11:35:48.371968 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-08 11:35:48.406448 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:35:48.417565 | 2025-01-08 11:35:48.417662 | TASK [emit-job-header : Print job information] 2025-01-08 11:35:48.510029 | # Job Information 2025-01-08 11:35:48.510189 | Ansible Version: 2.15.3 2025-01-08 11:35:48.510218 | Job: tox 2025-01-08 11:35:48.510243 | Pipeline: check 2025-01-08 11:35:48.510260 | Executor: 7d211f194f6a 2025-01-08 11:35:48.510275 | Triggered by: https://github.com/osism/openstack-image-manager/pull/866 2025-01-08 11:35:48.510290 | Event ID: a7f148f0-cdb4-11ef-89ab-43a46f2cf011 2025-01-08 11:35:48.517243 | 2025-01-08 11:35:48.517328 | LOOP [emit-job-header : Print node information] 2025-01-08 11:35:48.731435 | ubuntu-noble | ok: 2025-01-08 11:35:48.731577 | ubuntu-noble | # Node Information 2025-01-08 11:35:48.731605 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-08 11:35:48.731625 | ubuntu-noble | Hostname: ubuntu 2025-01-08 11:35:48.731642 | ubuntu-noble | Username: zuul 2025-01-08 11:35:48.731658 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-08 11:35:48.731674 | ubuntu-noble | Provider: regiocloud-a 2025-01-08 11:35:48.731690 | ubuntu-noble | Label: ubuntu-noble 2025-01-08 11:35:48.731705 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-08 11:35:48.731721 | ubuntu-noble | Interface IP: 81.163.192.128 2025-01-08 11:35:48.752096 | 2025-01-08 11:35:48.752209 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-08 11:35:49.561675 | ubuntu-noble -> localhost | changed 2025-01-08 11:35:49.568839 | 2025-01-08 11:35:49.568930 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-08 11:35:51.347889 | ubuntu-noble -> localhost | changed 2025-01-08 11:35:51.360601 | 2025-01-08 11:35:51.360693 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-08 11:35:51.769976 | ubuntu-noble -> localhost | ok 2025-01-08 11:35:51.776410 | 2025-01-08 11:35:51.776505 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-08 11:35:51.795609 | ubuntu-noble | ok 2025-01-08 11:35:51.820492 | ubuntu-noble | included: /var/lib/zuul/builds/302855264c3e47a5aa55d18f6375eb1e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-08 11:35:51.837411 | 2025-01-08 11:35:51.837520 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-08 11:35:52.706454 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-08 11:35:52.706610 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/302855264c3e47a5aa55d18f6375eb1e/work/302855264c3e47a5aa55d18f6375eb1e_id_rsa 2025-01-08 11:35:52.706640 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/302855264c3e47a5aa55d18f6375eb1e/work/302855264c3e47a5aa55d18f6375eb1e_id_rsa.pub 2025-01-08 11:35:52.706660 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-08 11:35:52.706677 | ubuntu-noble -> localhost | SHA256:CHZQIZwuxn0obR2CDENX02kteE7bhkH3CRxf18mgzMY zuul-build-sshkey 2025-01-08 11:35:52.706695 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-08 11:35:52.706714 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-08 11:35:52.706731 | ubuntu-noble -> localhost | |++ ++=*o++. oo.o| 2025-01-08 11:35:52.706747 | ubuntu-noble -> localhost | | .+ ++oO.oB + .o.| 2025-01-08 11:35:52.706763 | ubuntu-noble -> localhost | | . +o+*.* E | 2025-01-08 11:35:52.706778 | ubuntu-noble -> localhost | | =.*oo= o. | 2025-01-08 11:35:52.706793 | ubuntu-noble -> localhost | | . + .. S | 2025-01-08 11:35:52.706809 | ubuntu-noble -> localhost | | | 2025-01-08 11:35:52.706824 | ubuntu-noble -> localhost | | | 2025-01-08 11:35:52.706840 | ubuntu-noble -> localhost | | | 2025-01-08 11:35:52.706855 | ubuntu-noble -> localhost | | | 2025-01-08 11:35:52.706870 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-08 11:35:52.706910 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.367098 2025-01-08 11:35:52.713171 | 2025-01-08 11:35:52.713263 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-08 11:35:52.750988 | ubuntu-noble | ok 2025-01-08 11:35:52.760126 | ubuntu-noble | included: /var/lib/zuul/builds/302855264c3e47a5aa55d18f6375eb1e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-08 11:35:52.770073 | 2025-01-08 11:35:52.770149 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-08 11:35:52.790756 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:35:52.796831 | 2025-01-08 11:35:52.796912 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-08 11:35:53.545223 | ubuntu-noble | changed 2025-01-08 11:35:53.553325 | 2025-01-08 11:35:53.553418 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-08 11:35:53.862770 | ubuntu-noble | ok 2025-01-08 11:35:53.871406 | 2025-01-08 11:35:53.871512 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-08 11:35:54.639904 | ubuntu-noble | changed 2025-01-08 11:35:54.654318 | 2025-01-08 11:35:54.654431 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-08 11:35:55.352531 | ubuntu-noble | changed 2025-01-08 11:35:55.359638 | 2025-01-08 11:35:55.359736 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-08 11:35:55.395706 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:35:55.404411 | 2025-01-08 11:35:55.404527 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-08 11:35:56.151410 | ubuntu-noble -> localhost | changed 2025-01-08 11:35:56.204788 | 2025-01-08 11:35:56.204897 | TASK [add-build-sshkey : Add back temp key] 2025-01-08 11:35:56.732569 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/302855264c3e47a5aa55d18f6375eb1e/work/302855264c3e47a5aa55d18f6375eb1e_id_rsa (zuul-build-sshkey) 2025-01-08 11:35:56.732749 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.019850 2025-01-08 11:35:56.739101 | 2025-01-08 11:35:56.739198 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-08 11:35:57.260255 | ubuntu-noble | ok 2025-01-08 11:35:57.270210 | 2025-01-08 11:35:57.270312 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-08 11:35:57.303798 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:35:57.321362 | 2025-01-08 11:35:57.321463 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-08 11:35:57.756862 | ubuntu-noble | ok 2025-01-08 11:35:57.769814 | 2025-01-08 11:35:57.769941 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-08 11:35:57.799673 | ubuntu-noble | ok 2025-01-08 11:35:57.805964 | 2025-01-08 11:35:57.806062 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-08 11:35:58.110239 | ubuntu-noble -> localhost | ok 2025-01-08 11:35:58.118282 | 2025-01-08 11:35:58.118370 | TASK [validate-host : Collect information about the host] 2025-01-08 11:35:59.435966 | ubuntu-noble | ok 2025-01-08 11:35:59.452441 | 2025-01-08 11:35:59.452555 | TASK [validate-host : Sanitize hostname] 2025-01-08 11:35:59.573747 | ubuntu-noble | ok 2025-01-08 11:35:59.579635 | 2025-01-08 11:35:59.579732 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-08 11:36:00.164801 | ubuntu-noble -> localhost | changed 2025-01-08 11:36:00.175084 | 2025-01-08 11:36:00.175220 | TASK [validate-host : Collect information about zuul worker] 2025-01-08 11:36:00.791173 | ubuntu-noble | ok 2025-01-08 11:36:00.816803 | 2025-01-08 11:36:00.816915 | TASK [validate-host : Write out all zuul information for each host] 2025-01-08 11:36:01.637076 | ubuntu-noble -> localhost | changed 2025-01-08 11:36:01.649320 | 2025-01-08 11:36:01.649420 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-08 11:36:02.008078 | ubuntu-noble | ok 2025-01-08 11:36:02.015752 | 2025-01-08 11:36:02.015855 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-08 11:36:03.257814 | ubuntu-noble | changed: 2025-01-08 11:36:03.257998 | ubuntu-noble | cd+++++++++ src/ 2025-01-08 11:36:03.258032 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-08 11:36:03.258055 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-08 11:36:03.258076 | ubuntu-noble | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-01-08 11:36:03.258096 | ubuntu-noble | =5.5 (from tox) 2025-01-08 11:36:36.229358 | ubuntu-noble | Downloading cachetools-5.5.0-py3-none-any.whl.metadata (5.3 kB) 2025-01-08 11:36:36.291944 | ubuntu-noble | Collecting chardet>=5.2 (from tox) 2025-01-08 11:36:36.308022 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl.metadata (3.4 kB) 2025-01-08 11:36:36.381704 | ubuntu-noble | Collecting colorama>=0.4.6 (from tox) 2025-01-08 11:36:36.397453 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2025-01-08 11:36:36.469377 | ubuntu-noble | Collecting filelock>=3.16.1 (from tox) 2025-01-08 11:36:36.488311 | ubuntu-noble | Downloading filelock-3.16.1-py3-none-any.whl.metadata (2.9 kB) 2025-01-08 11:36:36.548161 | ubuntu-noble | Collecting packaging>=24.1 (from tox) 2025-01-08 11:36:36.562840 | ubuntu-noble | Downloading packaging-24.2-py3-none-any.whl.metadata (3.2 kB) 2025-01-08 11:36:36.638108 | ubuntu-noble | Collecting platformdirs>=4.3.6 (from tox) 2025-01-08 11:36:36.652969 | ubuntu-noble | Downloading platformdirs-4.3.6-py3-none-any.whl.metadata (11 kB) 2025-01-08 11:36:36.782303 | ubuntu-noble | Collecting pluggy>=1.5 (from tox) 2025-01-08 11:36:36.798323 | ubuntu-noble | Downloading pluggy-1.5.0-py3-none-any.whl.metadata (4.8 kB) 2025-01-08 11:36:36.865352 | ubuntu-noble | Collecting pyproject-api>=1.8 (from tox) 2025-01-08 11:36:36.881742 | ubuntu-noble | Downloading pyproject_api-1.8.0-py3-none-any.whl.metadata (2.7 kB) 2025-01-08 11:36:37.017980 | ubuntu-noble | Collecting virtualenv>=20.26.6 (from tox) 2025-01-08 11:36:37.033311 | ubuntu-noble | Downloading virtualenv-20.28.1-py3-none-any.whl.metadata (4.5 kB) 2025-01-08 11:36:37.181353 | ubuntu-noble | Collecting distlib<1,>=0.3.7 (from virtualenv>=20.26.6->tox) 2025-01-08 11:36:37.197516 | ubuntu-noble | Downloading distlib-0.3.9-py2.py3-none-any.whl.metadata (5.2 kB) 2025-01-08 11:36:37.246001 | ubuntu-noble | Downloading tox-4.23.2-py3-none-any.whl (166 kB) 2025-01-08 11:36:37.285873 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 166.8/166.8 kB 4.5 MB/s eta 0:00:00 2025-01-08 11:36:37.303327 | ubuntu-noble | Downloading cachetools-5.5.0-py3-none-any.whl (9.5 kB) 2025-01-08 11:36:37.328302 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-01-08 11:36:37.356253 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 9.3 MB/s eta 0:00:00 2025-01-08 11:36:37.371804 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-01-08 11:36:37.398429 | ubuntu-noble | Downloading filelock-3.16.1-py3-none-any.whl (16 kB) 2025-01-08 11:36:37.440263 | ubuntu-noble | Downloading packaging-24.2-py3-none-any.whl (65 kB) 2025-01-08 11:36:37.458046 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 65.5/65.5 kB 4.9 MB/s eta 0:00:00 2025-01-08 11:36:37.477309 | ubuntu-noble | Downloading platformdirs-4.3.6-py3-none-any.whl (18 kB) 2025-01-08 11:36:37.519437 | ubuntu-noble | Downloading pluggy-1.5.0-py3-none-any.whl (20 kB) 2025-01-08 11:36:37.555008 | ubuntu-noble | Downloading pyproject_api-1.8.0-py3-none-any.whl (13 kB) 2025-01-08 11:36:37.588900 | ubuntu-noble | Downloading virtualenv-20.28.1-py3-none-any.whl (4.3 MB) 2025-01-08 11:36:37.785449 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.3/4.3 MB 22.8 MB/s eta 0:00:00 2025-01-08 11:36:37.802006 | ubuntu-noble | Downloading distlib-0.3.9-py2.py3-none-any.whl (468 kB) 2025-01-08 11:36:37.837354 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 17.0 MB/s eta 0:00:00 2025-01-08 11:36:37.947353 | ubuntu-noble | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-01-08 11:36:39.066728 | ubuntu-noble | Successfully installed cachetools-5.5.0 chardet-5.2.0 colorama-0.4.6 distlib-0.3.9 filelock-3.16.1 packaging-24.2 platformdirs-4.3.6 pluggy-1.5.0 pyproject-api-1.8.0 tox-4.23.2 virtualenv-20.28.1 2025-01-08 11:36:39.679317 | ubuntu-noble | ok: Runtime: 0:00:04.124133 2025-01-08 11:36:39.703927 | 2025-01-08 11:36:39.704041 | TASK [ensure-tox : Export installed tox_executable path] 2025-01-08 11:36:39.807175 | ubuntu-noble | ok 2025-01-08 11:36:39.826189 | 2025-01-08 11:36:39.826309 | TASK [ensure-tox : Output tox version] 2025-01-08 11:36:41.417411 | 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-08 11:36:41.448177 | ubuntu-noble | 4.23.2 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2025-01-08 11:36:41.899833 | ubuntu-noble | ok: Runtime: 0:00:00.801732 2025-01-08 11:36:41.906745 | 2025-01-08 11:36:41.906928 | TASK [ensure-tox : Make global symlink] 2025-01-08 11:36:41.941452 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:36:41.973102 | 2025-01-08 11:36:41.973177 | PLAY RECAP 2025-01-08 11:36:41.973249 | ubuntu-noble | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-01-08 11:36:41.973273 | 2025-01-08 11:36:42.083694 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2025-01-08 11:36:42.086627 | RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/run.yaml@master] 2025-01-08 11:36:43.491237 | 2025-01-08 11:36:43.491375 | PLAY [all] 2025-01-08 11:36:43.545590 | 2025-01-08 11:36:43.545714 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-01-08 11:36:44.644461 | ubuntu-noble | ok: Runtime: 0:00:00.035303 2025-01-08 11:36:44.651443 | 2025-01-08 11:36:44.651550 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-01-08 11:36:45.704603 | ubuntu-noble | ok: Runtime: 0:00:00.006022 2025-01-08 11:36:45.719116 | 2025-01-08 11:36:45.719226 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-01-08 11:36:46.299312 | ubuntu-noble | sudo: a password is required 2025-01-08 11:36:46.350327 | ubuntu-noble | ok: Runtime: 0:00:00.018222 2025-01-08 11:36:46.377134 | 2025-01-08 11:36:46.377262 | TASK [tox : Check to see if the constraints file exists] 2025-01-08 11:36:46.442272 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:36:46.452224 | 2025-01-08 11:36:46.452337 | TASK [tox : Fail if constraints file is missing] 2025-01-08 11:36:46.549695 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:36:46.559319 | 2025-01-08 11:36:46.559454 | TASK [tox : Record file location] 2025-01-08 11:36:46.608484 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:36:46.616027 | 2025-01-08 11:36:46.616115 | TASK [tox : Install tox siblings] 2025-01-08 11:36:46.655879 | ubuntu-noble | ok 2025-01-08 11:36:46.671134 | ubuntu-noble | included: /var/lib/zuul/builds/302855264c3e47a5aa55d18f6375eb1e/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/tox/tasks/siblings.yaml 2025-01-08 11:36:46.700644 | 2025-01-08 11:36:46.700754 | TASK [tox : Run tox without tests] 2025-01-08 11:36:48.149051 | ubuntu-noble | test: install_deps> python -I -m pip install -r requirements.txt 2025-01-08 11:37:08.334413 | ubuntu-noble | test: OK (20.55 seconds) 2025-01-08 11:37:08.375055 | ubuntu-noble | congratulations :) (20.66 seconds) 2025-01-08 11:37:08.406942 | ubuntu-noble | ok: Runtime: 0:00:20.981529 2025-01-08 11:37:08.426953 | 2025-01-08 11:37:08.427060 | TASK [tox : Create a tempfile to save tox showconfig] 2025-01-08 11:37:08.784201 | ubuntu-noble | changed 2025-01-08 11:37:08.790668 | 2025-01-08 11:37:08.790763 | TASK [tox : Get tox envlist config] 2025-01-08 11:37:09.825020 | ubuntu-noble | ok: Runtime: 0:00:00.333675 2025-01-08 11:37:09.831823 | 2025-01-08 11:37:09.831913 | TASK [tox : Install any sibling python packages] 2025-01-08 11:37:10.437519 | ubuntu-noble | ok: No setup.cfg, no action needed 2025-01-08 11:37:10.444052 | 2025-01-08 11:37:10.444135 | TASK [tox : Remove tempfile] 2025-01-08 11:37:10.977018 | ubuntu-noble | changed 2025-01-08 11:37:10.984340 | 2025-01-08 11:37:10.984431 | TASK [tox : Emit tox command] 2025-01-08 11:37:11.024853 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-01-08 11:37:11.031451 | 2025-01-08 11:37:11.031544 | TASK [tox : Run tox] 2025-01-08 11:37:12.223064 | ubuntu-noble | test: commands[0]> python -m unittest discover test/unit 2025-01-08 11:37:13.751336 | ubuntu-noble | ............... 2025-01-08 11:37:13.900637 | ubuntu-noble | ---------------------------------------------------------------------- 2025-01-08 11:37:13.900703 | ubuntu-noble | Ran 15 tests in 0.319s 2025-01-08 11:37:13.900712 | ubuntu-noble | 2025-01-08 11:37:13.900718 | ubuntu-noble | OK 2025-01-08 11:37:13.900734 | ubuntu-noble | test: OK (1.78=setup[0.11]+cmd[1.68] seconds) 2025-01-08 11:37:14.050765 | ubuntu-noble | congratulations :) (1.91 seconds) 2025-01-08 11:37:14.143533 | ubuntu-noble | ok: Runtime: 0:00:02.490012 2025-01-08 11:37:14.154614 | 2025-01-08 11:37:14.154746 | TASK [tox : Look for output] 2025-01-08 11:37:14.915977 | ubuntu-noble | ok 2025-01-08 11:37:14.923820 | 2025-01-08 11:37:14.923925 | TASK [tox : Return file comments to Zuul] 2025-01-08 11:37:14.984394 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:37:15.024008 | 2025-01-08 11:37:15.024128 | PLAY RECAP 2025-01-08 11:37:15.024196 | ubuntu-noble | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-01-08 11:37:15.024244 | 2025-01-08 11:37:15.152851 | RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/run.yaml@master] 2025-01-08 11:37:15.161553 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2025-01-08 11:37:15.918314 | 2025-01-08 11:37:15.918484 | PLAY [all] 2025-01-08 11:37:15.948416 | 2025-01-08 11:37:15.948576 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-01-08 11:37:16.047348 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:37:16.056157 | 2025-01-08 11:37:16.056335 | TASK [fetch-tox-output : Set tox log path for single node] 2025-01-08 11:37:16.110935 | ubuntu-noble | ok 2025-01-08 11:37:16.119302 | 2025-01-08 11:37:16.119421 | TASK [fetch-tox-output : Ensure local tox dir] 2025-01-08 11:37:16.592113 | ubuntu-noble -> localhost | changed 2025-01-08 11:37:16.600561 | 2025-01-08 11:37:16.600678 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-01-08 11:37:16.666198 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:37:16.673620 | 2025-01-08 11:37:16.673739 | TASK [fetch-tox-output : Set envlist fact] 2025-01-08 11:37:16.730298 | ubuntu-noble | ok 2025-01-08 11:37:16.740819 | 2025-01-08 11:37:16.740936 | TASK [fetch-tox-output : Get tox version] 2025-01-08 11:37:18.036668 | 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-08 11:37:18.070347 | ubuntu-noble | 4.23.2 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2025-01-08 11:37:18.321317 | ubuntu-noble | ok: Runtime: 0:00:00.799523 2025-01-08 11:37:18.332516 | 2025-01-08 11:37:18.332655 | TASK [fetch-tox-output : Find all default environments] 2025-01-08 11:37:18.408009 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:37:18.417040 | 2025-01-08 11:37:18.417163 | TASK [fetch-tox-output : Set envlist fact] 2025-01-08 11:37:18.452092 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:37:18.468781 | 2025-01-08 11:37:18.468955 | TASK [fetch-tox-output : Find all default environments] 2025-01-08 11:37:18.543580 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:37:18.559124 | 2025-01-08 11:37:18.559358 | TASK [fetch-tox-output : Set envlist fact] 2025-01-08 11:37:18.605499 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:37:18.621597 | 2025-01-08 11:37:18.621763 | LOOP [fetch-tox-output : Copy tox logs] 2025-01-08 11:37:18.676062 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:37:18.693648 | 2025-01-08 11:37:18.693793 | LOOP [fetch-tox-output : Collect tox logs] 2025-01-08 11:37:19.554945 | ubuntu-noble | changed: 2025-01-08 11:37:19.555325 | ubuntu-noble | cd+++++++++ ./ 2025-01-08 11:37:19.555410 | ubuntu-noble | >f+++++++++ 1-commands[0].log 2025-01-08 11:37:19.555486 | 2025-01-08 11:37:19.600587 | 2025-01-08 11:37:19.600701 | PLAY RECAP 2025-01-08 11:37:19.600761 | ubuntu-noble | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-01-08 11:37:19.600786 | 2025-01-08 11:37:19.725750 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2025-01-08 11:37:19.734955 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2025-01-08 11:37:20.420582 | 2025-01-08 11:37:20.420740 | PLAY [all] 2025-01-08 11:37:20.447872 | 2025-01-08 11:37:20.448007 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-01-08 11:37:20.693430 | ubuntu-noble | changed: non-zero return code 2025-01-08 11:37:20.704039 | 2025-01-08 11:37:20.704214 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-01-08 11:37:20.731164 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:37:20.743995 | 2025-01-08 11:37:20.744117 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-01-08 11:37:20.777583 | 2025-01-08 11:37:20.777775 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-01-08 11:37:20.811867 | 2025-01-08 11:37:20.812073 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-01-08 11:37:20.837018 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:37:20.844936 | 2025-01-08 11:37:20.845059 | LOOP [fetch-subunit-output : Generate subunit file] 2025-01-08 11:37:20.883954 | 2025-01-08 11:37:20.884378 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-01-08 11:37:20.909868 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:37:20.923367 | 2025-01-08 11:37:20.923527 | TASK [fetch-subunit-output : Remove the temporary file] 2025-01-08 11:37:20.948645 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:37:20.960982 | 2025-01-08 11:37:20.961130 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-01-08 11:37:20.996616 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:37:21.036517 | 2025-01-08 11:37:21.036617 | PLAY RECAP 2025-01-08 11:37:21.036673 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-01-08 11:37:21.036698 | 2025-01-08 11:37:21.159577 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2025-01-08 11:37:21.167314 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-01-08 11:37:21.880352 | 2025-01-08 11:37:21.880503 | PLAY [Base post] 2025-01-08 11:37:21.906553 | 2025-01-08 11:37:21.906679 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-01-08 11:37:22.929450 | ubuntu-noble | changed 2025-01-08 11:37:22.962193 | 2025-01-08 11:37:22.962348 | PLAY RECAP 2025-01-08 11:37:22.962416 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-01-08 11:37:22.962478 | 2025-01-08 11:37:23.082169 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-01-08 11:37:23.091428 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-01-08 11:37:23.877138 | 2025-01-08 11:37:23.877404 | PLAY [Base post-logs] 2025-01-08 11:37:23.894482 | 2025-01-08 11:37:23.894611 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-01-08 11:37:24.372896 | localhost | changed 2025-01-08 11:37:24.377151 | 2025-01-08 11:37:24.377315 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-01-08 11:37:24.416639 | localhost | ok 2025-01-08 11:37:24.424356 | 2025-01-08 11:37:24.424472 | TASK [Set zuul-log-path fact] 2025-01-08 11:37:24.443954 | localhost | ok 2025-01-08 11:37:24.458815 | 2025-01-08 11:37:24.458944 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-08 11:37:24.517749 | localhost | ok 2025-01-08 11:37:24.525547 | 2025-01-08 11:37:24.525726 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-08 11:37:24.563804 | localhost | skipping: Conditional result was False 2025-01-08 11:37:24.574401 | 2025-01-08 11:37:24.574648 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-08 11:37:24.622633 | localhost | skipping: Conditional result was False 2025-01-08 11:37:24.631544 | 2025-01-08 11:37:24.631740 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-08 11:37:24.658690 | localhost | skipping: Conditional result was False 2025-01-08 11:37:24.668468 | 2025-01-08 11:37:24.668658 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-08 11:37:24.686967 | localhost | skipping: Conditional result was False 2025-01-08 11:37:24.693367 | 2025-01-08 11:37:24.693512 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-08 11:37:24.718974 | localhost | skipping: Conditional result was False 2025-01-08 11:37:24.731853 | 2025-01-08 11:37:24.732008 | TASK [upload-logs : Create log directories] 2025-01-08 11:37:25.263150 | localhost | changed 2025-01-08 11:37:25.267575 | 2025-01-08 11:37:25.267684 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-01-08 11:37:25.821427 | localhost -> localhost | ok: Runtime: 0:00:00.013747 2025-01-08 11:37:25.827033 | 2025-01-08 11:37:25.827164 | TASK [upload-logs : Upload logs to log server] 2025-01-08 11:37:26.440800 | localhost | Output suppressed because no_log was given 2025-01-08 11:37:26.443982 | 2025-01-08 11:37:26.444088 | LOOP [upload-logs : Compress console log and json output] 2025-01-08 11:37:26.511137 | localhost | skipping: Conditional result was False 2025-01-08 11:37:26.528120 | localhost | skipping: Conditional result was False 2025-01-08 11:37:26.545209 | 2025-01-08 11:37:26.545439 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-08 11:37:26.630604 | localhost | skipping: Conditional result was False 2025-01-08 11:37:26.630935 | 2025-01-08 11:37:26.650192 | localhost | skipping: Conditional result was False 2025-01-08 11:37:26.657127 | 2025-01-08 11:37:26.657261 | LOOP [upload-logs : Upload console log and json output]