2025-01-08 11:22:58.408334 | Job console starting... 2025-01-08 11:22:58.416733 | Updating repositories 2025-01-08 11:22:58.432702 | Preparing job workspace 2025-01-08 11:23:00.558810 | Running Ansible setup... 2025-01-08 11:23:06.419349 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-01-08 11:23:07.147148 | 2025-01-08 11:23:07.147288 | PLAY [Base pre] 2025-01-08 11:23:07.169540 | 2025-01-08 11:23:07.169746 | TASK [Setup log path fact] 2025-01-08 11:23:07.199172 | ubuntu-noble | ok 2025-01-08 11:23:07.217258 | 2025-01-08 11:23:07.217374 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-08 11:23:07.262446 | ubuntu-noble | ok 2025-01-08 11:23:07.271132 | 2025-01-08 11:23:07.271255 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-08 11:23:07.316412 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:23:07.333232 | 2025-01-08 11:23:07.333417 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-08 11:23:07.390586 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:23:07.407750 | 2025-01-08 11:23:07.407943 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-08 11:23:07.444282 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:23:07.456699 | 2025-01-08 11:23:07.456848 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-08 11:23:07.481718 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:23:07.490587 | 2025-01-08 11:23:07.490702 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-08 11:23:07.514584 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:23:07.527987 | 2025-01-08 11:23:07.528105 | TASK [emit-job-header : Print job information] 2025-01-08 11:23:07.578888 | # Job Information 2025-01-08 11:23:07.579041 | Ansible Version: 2.15.3 2025-01-08 11:23:07.579072 | Job: tox 2025-01-08 11:23:07.579102 | Pipeline: check 2025-01-08 11:23:07.579123 | Executor: 7d211f194f6a 2025-01-08 11:23:07.579142 | Triggered by: https://github.com/osism/openstack-image-manager/pull/868 2025-01-08 11:23:07.579160 | Event ID: d81dd040-cdb2-11ef-95bf-d6ca19da912d 2025-01-08 11:23:07.585573 | 2025-01-08 11:23:07.585662 | LOOP [emit-job-header : Print node information] 2025-01-08 11:23:07.730579 | ubuntu-noble | ok: 2025-01-08 11:23:07.730744 | ubuntu-noble | # Node Information 2025-01-08 11:23:07.730776 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-01-08 11:23:07.730799 | ubuntu-noble | Hostname: ubuntu 2025-01-08 11:23:07.730820 | ubuntu-noble | Username: zuul 2025-01-08 11:23:07.730840 | ubuntu-noble | Distro: Ubuntu 24.04 2025-01-08 11:23:07.730859 | ubuntu-noble | Provider: regiocloud-a 2025-01-08 11:23:07.730879 | ubuntu-noble | Label: ubuntu-noble 2025-01-08 11:23:07.730897 | ubuntu-noble | Product Name: OpenStack Nova 2025-01-08 11:23:07.730918 | ubuntu-noble | Interface IP: 81.163.193.153 2025-01-08 11:23:07.755338 | 2025-01-08 11:23:07.755471 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-01-08 11:23:08.212492 | ubuntu-noble -> localhost | changed 2025-01-08 11:23:08.221805 | 2025-01-08 11:23:08.221930 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-01-08 11:23:09.446669 | ubuntu-noble -> localhost | changed 2025-01-08 11:23:09.485004 | 2025-01-08 11:23:09.485151 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-01-08 11:23:09.959731 | ubuntu-noble -> localhost | ok 2025-01-08 11:23:09.967629 | 2025-01-08 11:23:09.967728 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-01-08 11:23:10.025359 | ubuntu-noble | ok 2025-01-08 11:23:10.063736 | ubuntu-noble | included: /var/lib/zuul/builds/d5920af165e54815ac03c45523a79a8e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-01-08 11:23:10.084662 | 2025-01-08 11:23:10.084772 | TASK [add-build-sshkey : Create Temp SSH key] 2025-01-08 11:23:11.334688 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-01-08 11:23:11.334907 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/d5920af165e54815ac03c45523a79a8e/work/d5920af165e54815ac03c45523a79a8e_id_rsa 2025-01-08 11:23:11.334946 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/d5920af165e54815ac03c45523a79a8e/work/d5920af165e54815ac03c45523a79a8e_id_rsa.pub 2025-01-08 11:23:11.334972 | ubuntu-noble -> localhost | The key fingerprint is: 2025-01-08 11:23:11.334995 | ubuntu-noble -> localhost | SHA256:8QoiO+ypevHSPqi1l+Xineg1chRXXb8MAr+Ojho9cvc zuul-build-sshkey 2025-01-08 11:23:11.335017 | ubuntu-noble -> localhost | The key's randomart image is: 2025-01-08 11:23:11.335044 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-01-08 11:23:11.335065 | ubuntu-noble -> localhost | | ... .. | 2025-01-08 11:23:11.335085 | ubuntu-noble -> localhost | | .o . . | 2025-01-08 11:23:11.335104 | ubuntu-noble -> localhost | | . o o . .| 2025-01-08 11:23:11.335124 | ubuntu-noble -> localhost | | o o o o .| 2025-01-08 11:23:11.335143 | ubuntu-noble -> localhost | | . . o S .. o | 2025-01-08 11:23:11.335162 | ubuntu-noble -> localhost | | ..o oo. .o | 2025-01-08 11:23:11.335181 | ubuntu-noble -> localhost | | ==.*++.o . | 2025-01-08 11:23:11.335201 | ubuntu-noble -> localhost | | o++B*=o= . | 2025-01-08 11:23:11.335221 | ubuntu-noble -> localhost | |=++*=++. . E | 2025-01-08 11:23:11.335240 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-01-08 11:23:11.335286 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.578637 2025-01-08 11:23:11.343582 | 2025-01-08 11:23:11.343679 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-01-08 11:23:11.374004 | ubuntu-noble | ok 2025-01-08 11:23:11.395169 | ubuntu-noble | included: /var/lib/zuul/builds/d5920af165e54815ac03c45523a79a8e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-01-08 11:23:11.415406 | 2025-01-08 11:23:11.415518 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-01-08 11:23:11.461342 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:23:11.470289 | 2025-01-08 11:23:11.470394 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-01-08 11:23:12.211882 | ubuntu-noble | changed 2025-01-08 11:23:12.221057 | 2025-01-08 11:23:12.221151 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-01-08 11:23:12.538869 | ubuntu-noble | ok 2025-01-08 11:23:12.558774 | 2025-01-08 11:23:12.559224 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-01-08 11:23:13.543734 | ubuntu-noble | changed 2025-01-08 11:23:13.557475 | 2025-01-08 11:23:13.557607 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-01-08 11:23:14.338017 | ubuntu-noble | changed 2025-01-08 11:23:14.358743 | 2025-01-08 11:23:14.358918 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-01-08 11:23:14.395847 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:23:14.405690 | 2025-01-08 11:23:14.405849 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-01-08 11:23:15.726635 | ubuntu-noble -> localhost | changed 2025-01-08 11:23:15.969087 | 2025-01-08 11:23:15.970018 | TASK [add-build-sshkey : Add back temp key] 2025-01-08 11:23:16.861150 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/d5920af165e54815ac03c45523a79a8e/work/d5920af165e54815ac03c45523a79a8e_id_rsa (zuul-build-sshkey) 2025-01-08 11:23:16.861421 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.030818 2025-01-08 11:23:16.868912 | 2025-01-08 11:23:16.868999 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-01-08 11:23:17.376987 | ubuntu-noble | ok 2025-01-08 11:23:17.383551 | 2025-01-08 11:23:17.383657 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-01-08 11:23:17.469192 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:23:17.484547 | 2025-01-08 11:23:17.494017 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-01-08 11:23:17.933654 | ubuntu-noble | ok 2025-01-08 11:23:17.960894 | 2025-01-08 11:23:17.961003 | TASK [validate-host : Define zuul_info_dir fact] 2025-01-08 11:23:18.037713 | ubuntu-noble | ok 2025-01-08 11:23:18.045549 | 2025-01-08 11:23:18.045657 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-01-08 11:23:18.790820 | ubuntu-noble -> localhost | ok 2025-01-08 11:23:18.798679 | 2025-01-08 11:23:18.798788 | TASK [validate-host : Collect information about the host] 2025-01-08 11:23:20.401725 | ubuntu-noble | ok 2025-01-08 11:23:20.440787 | 2025-01-08 11:23:20.440902 | TASK [validate-host : Sanitize hostname] 2025-01-08 11:23:20.552217 | ubuntu-noble | ok 2025-01-08 11:23:20.558297 | 2025-01-08 11:23:20.558377 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-01-08 11:23:21.947085 | ubuntu-noble -> localhost | changed 2025-01-08 11:23:21.957133 | 2025-01-08 11:23:21.957237 | TASK [validate-host : Collect information about zuul worker] 2025-01-08 11:23:22.532969 | ubuntu-noble | ok 2025-01-08 11:23:22.547524 | 2025-01-08 11:23:22.547635 | TASK [validate-host : Write out all zuul information for each host] 2025-01-08 11:23:23.440935 | ubuntu-noble -> localhost | changed 2025-01-08 11:23:23.452700 | 2025-01-08 11:23:23.452795 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-01-08 11:23:23.781254 | ubuntu-noble | ok 2025-01-08 11:23:23.787161 | 2025-01-08 11:23:23.787249 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-01-08 11:23:25.026489 | ubuntu-noble | changed: 2025-01-08 11:23:25.026641 | ubuntu-noble | cd+++++++++ src/ 2025-01-08 11:23:25.026668 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-01-08 11:23:25.026688 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-01-08 11:23:25.026705 | ubuntu-noble | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-01-08 11:23:25.026722 | ubuntu-noble | =5.5 (from tox) 2025-01-08 11:23:55.174014 | ubuntu-noble | Downloading cachetools-5.5.0-py3-none-any.whl.metadata (5.3 kB) 2025-01-08 11:23:55.216556 | ubuntu-noble | Collecting chardet>=5.2 (from tox) 2025-01-08 11:23:55.231542 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl.metadata (3.4 kB) 2025-01-08 11:23:55.284079 | ubuntu-noble | Collecting colorama>=0.4.6 (from tox) 2025-01-08 11:23:55.297668 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2025-01-08 11:23:55.394355 | ubuntu-noble | Collecting filelock>=3.16.1 (from tox) 2025-01-08 11:23:55.408558 | ubuntu-noble | Downloading filelock-3.16.1-py3-none-any.whl.metadata (2.9 kB) 2025-01-08 11:23:55.484698 | ubuntu-noble | Collecting packaging>=24.1 (from tox) 2025-01-08 11:23:55.498661 | ubuntu-noble | Downloading packaging-24.2-py3-none-any.whl.metadata (3.2 kB) 2025-01-08 11:23:55.584353 | ubuntu-noble | Collecting platformdirs>=4.3.6 (from tox) 2025-01-08 11:23:55.600387 | ubuntu-noble | Downloading platformdirs-4.3.6-py3-none-any.whl.metadata (11 kB) 2025-01-08 11:23:55.667277 | ubuntu-noble | Collecting pluggy>=1.5 (from tox) 2025-01-08 11:23:55.680480 | ubuntu-noble | Downloading pluggy-1.5.0-py3-none-any.whl.metadata (4.8 kB) 2025-01-08 11:23:55.738249 | ubuntu-noble | Collecting pyproject-api>=1.8 (from tox) 2025-01-08 11:23:55.754277 | ubuntu-noble | Downloading pyproject_api-1.8.0-py3-none-any.whl.metadata (2.7 kB) 2025-01-08 11:23:55.905877 | ubuntu-noble | Collecting virtualenv>=20.26.6 (from tox) 2025-01-08 11:23:55.919452 | ubuntu-noble | Downloading virtualenv-20.28.1-py3-none-any.whl.metadata (4.5 kB) 2025-01-08 11:23:56.033337 | ubuntu-noble | Collecting distlib<1,>=0.3.7 (from virtualenv>=20.26.6->tox) 2025-01-08 11:23:56.047876 | ubuntu-noble | Downloading distlib-0.3.9-py2.py3-none-any.whl.metadata (5.2 kB) 2025-01-08 11:23:56.102540 | ubuntu-noble | Downloading tox-4.23.2-py3-none-any.whl (166 kB) 2025-01-08 11:23:56.153352 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 166.8/166.8 kB 3.6 MB/s eta 0:00:00 2025-01-08 11:23:56.171552 | ubuntu-noble | Downloading cachetools-5.5.0-py3-none-any.whl (9.5 kB) 2025-01-08 11:23:56.197863 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-01-08 11:23:56.219983 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 13.2 MB/s eta 0:00:00 2025-01-08 11:23:56.235160 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-01-08 11:23:56.260961 | ubuntu-noble | Downloading filelock-3.16.1-py3-none-any.whl (16 kB) 2025-01-08 11:23:56.294090 | ubuntu-noble | Downloading packaging-24.2-py3-none-any.whl (65 kB) 2025-01-08 11:23:56.392726 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 65.5/65.5 kB 1.2 MB/s eta 0:00:00 2025-01-08 11:23:56.410795 | ubuntu-noble | Downloading platformdirs-4.3.6-py3-none-any.whl (18 kB) 2025-01-08 11:23:56.438127 | ubuntu-noble | Downloading pluggy-1.5.0-py3-none-any.whl (20 kB) 2025-01-08 11:23:56.516229 | ubuntu-noble | Downloading pyproject_api-1.8.0-py3-none-any.whl (13 kB) 2025-01-08 11:23:56.546544 | ubuntu-noble | Downloading virtualenv-20.28.1-py3-none-any.whl (4.3 MB) 2025-01-08 11:23:56.759420 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.3/4.3 MB 21.0 MB/s eta 0:00:00 2025-01-08 11:23:56.777268 | ubuntu-noble | Downloading distlib-0.3.9-py2.py3-none-any.whl (468 kB) 2025-01-08 11:23:56.812116 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 16.4 MB/s eta 0:00:00 2025-01-08 11:23:56.918256 | ubuntu-noble | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-01-08 11:23:57.946462 | 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:23:58.097277 | ubuntu-noble | ok: Runtime: 0:00:04.045581 2025-01-08 11:23:58.108057 | 2025-01-08 11:23:58.127636 | TASK [ensure-tox : Export installed tox_executable path] 2025-01-08 11:23:58.184199 | ubuntu-noble | ok 2025-01-08 11:23:58.190229 | 2025-01-08 11:23:58.190306 | TASK [ensure-tox : Output tox version] 2025-01-08 11:23:59.088907 | 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:23:59.125204 | ubuntu-noble | 4.23.2 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2025-01-08 11:23:59.263163 | ubuntu-noble | ok: Runtime: 0:00:00.480385 2025-01-08 11:23:59.273450 | 2025-01-08 11:23:59.273534 | TASK [ensure-tox : Make global symlink] 2025-01-08 11:23:59.332344 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:23:59.490392 | 2025-01-08 11:23:59.490486 | PLAY RECAP 2025-01-08 11:23:59.490529 | ubuntu-noble | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-01-08 11:23:59.490550 | 2025-01-08 11:23:59.644235 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2025-01-08 11:23:59.647152 | RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/run.yaml@master] 2025-01-08 11:24:00.721246 | 2025-01-08 11:24:00.721356 | PLAY [all] 2025-01-08 11:24:00.743687 | 2025-01-08 11:24:00.743788 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-01-08 11:24:01.774628 | ubuntu-noble | ok: Runtime: 0:00:00.019020 2025-01-08 11:24:01.781735 | 2025-01-08 11:24:01.781898 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-01-08 11:24:02.321486 | ubuntu-noble | ok: Runtime: 0:00:00.004601 2025-01-08 11:24:02.330042 | 2025-01-08 11:24:02.330142 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-01-08 11:24:02.898282 | ubuntu-noble | sudo: a password is required 2025-01-08 11:24:02.962721 | ubuntu-noble | ok: Runtime: 0:00:00.021165 2025-01-08 11:24:02.974716 | 2025-01-08 11:24:02.974817 | TASK [tox : Check to see if the constraints file exists] 2025-01-08 11:24:02.998657 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:24:03.005968 | 2025-01-08 11:24:03.006069 | TASK [tox : Fail if constraints file is missing] 2025-01-08 11:24:03.031247 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:24:03.037875 | 2025-01-08 11:24:03.037976 | TASK [tox : Record file location] 2025-01-08 11:24:03.062048 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:24:03.067861 | 2025-01-08 11:24:03.067942 | TASK [tox : Install tox siblings] 2025-01-08 11:24:03.100532 | ubuntu-noble | ok 2025-01-08 11:24:03.109126 | ubuntu-noble | included: /var/lib/zuul/builds/d5920af165e54815ac03c45523a79a8e/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/tox/tasks/siblings.yaml 2025-01-08 11:24:03.130240 | 2025-01-08 11:24:03.130333 | TASK [tox : Run tox without tests] 2025-01-08 11:24:04.335528 | ubuntu-noble | test: install_deps> python -I -m pip install -r requirements.txt 2025-01-08 11:24:24.419707 | ubuntu-noble | test: OK (20.45 seconds) 2025-01-08 11:24:24.483134 | ubuntu-noble | congratulations :) (20.56 seconds) 2025-01-08 11:24:24.713586 | ubuntu-noble | ok: Runtime: 0:00:20.900628 2025-01-08 11:24:24.720284 | 2025-01-08 11:24:24.720366 | TASK [tox : Create a tempfile to save tox showconfig] 2025-01-08 11:24:25.171456 | ubuntu-noble | changed 2025-01-08 11:24:25.184129 | 2025-01-08 11:24:25.184267 | TASK [tox : Get tox envlist config] 2025-01-08 11:24:26.228614 | ubuntu-noble | ok: Runtime: 0:00:00.387418 2025-01-08 11:24:26.235483 | 2025-01-08 11:24:26.235570 | TASK [tox : Install any sibling python packages] 2025-01-08 11:24:26.996002 | ubuntu-noble | ok: No setup.cfg, no action needed 2025-01-08 11:24:27.003628 | 2025-01-08 11:24:27.003769 | TASK [tox : Remove tempfile] 2025-01-08 11:24:27.758968 | ubuntu-noble | changed 2025-01-08 11:24:27.767595 | 2025-01-08 11:24:27.767683 | TASK [tox : Emit tox command] 2025-01-08 11:24:27.811490 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-01-08 11:24:27.819808 | 2025-01-08 11:24:27.819906 | TASK [tox : Run tox] 2025-01-08 11:24:28.901996 | ubuntu-noble | test: commands[0]> python -m unittest discover test/unit 2025-01-08 11:24:30.818592 | ubuntu-noble | ............... 2025-01-08 11:24:31.080685 | ubuntu-noble | ---------------------------------------------------------------------- 2025-01-08 11:24:31.080733 | ubuntu-noble | Ran 15 tests in 0.397s 2025-01-08 11:24:31.080742 | ubuntu-noble | 2025-01-08 11:24:31.080748 | ubuntu-noble | OK 2025-01-08 11:24:31.080762 | ubuntu-noble | test: OK (2.28=setup[0.10]+cmd[2.18] seconds) 2025-01-08 11:24:31.204473 | ubuntu-noble | congratulations :) (2.40 seconds) 2025-01-08 11:24:31.374618 | ubuntu-noble | ok: Runtime: 0:00:02.830817 2025-01-08 11:24:31.393675 | 2025-01-08 11:24:31.394151 | TASK [tox : Look for output] 2025-01-08 11:24:32.085118 | ubuntu-noble | ok 2025-01-08 11:24:32.102960 | 2025-01-08 11:24:32.103198 | TASK [tox : Return file comments to Zuul] 2025-01-08 11:24:32.141745 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:24:32.194026 | 2025-01-08 11:24:32.194141 | PLAY RECAP 2025-01-08 11:24:32.194199 | ubuntu-noble | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-01-08 11:24:32.194226 | 2025-01-08 11:24:32.345180 | RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/run.yaml@master] 2025-01-08 11:24:32.349168 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2025-01-08 11:24:33.204193 | 2025-01-08 11:24:33.204365 | PLAY [all] 2025-01-08 11:24:33.232129 | 2025-01-08 11:24:33.232294 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-01-08 11:24:33.310559 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:24:33.321046 | 2025-01-08 11:24:33.321207 | TASK [fetch-tox-output : Set tox log path for single node] 2025-01-08 11:24:33.379135 | ubuntu-noble | ok 2025-01-08 11:24:33.388488 | 2025-01-08 11:24:33.388608 | TASK [fetch-tox-output : Ensure local tox dir] 2025-01-08 11:24:33.873112 | ubuntu-noble -> localhost | changed 2025-01-08 11:24:33.881883 | 2025-01-08 11:24:33.882034 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-01-08 11:24:33.939964 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:24:33.947546 | 2025-01-08 11:24:33.947689 | TASK [fetch-tox-output : Set envlist fact] 2025-01-08 11:24:33.999231 | ubuntu-noble | ok 2025-01-08 11:24:34.025084 | 2025-01-08 11:24:34.025236 | TASK [fetch-tox-output : Get tox version] 2025-01-08 11:24:35.205819 | 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:24:35.239272 | ubuntu-noble | 4.23.2 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2025-01-08 11:24:35.570655 | ubuntu-noble | ok: Runtime: 0:00:00.525950 2025-01-08 11:24:35.578118 | 2025-01-08 11:24:35.578250 | TASK [fetch-tox-output : Find all default environments] 2025-01-08 11:24:35.680933 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:24:35.691282 | 2025-01-08 11:24:35.691440 | TASK [fetch-tox-output : Set envlist fact] 2025-01-08 11:24:35.727962 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:24:35.739000 | 2025-01-08 11:24:35.739152 | TASK [fetch-tox-output : Find all default environments] 2025-01-08 11:24:35.815350 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:24:35.823549 | 2025-01-08 11:24:35.823672 | TASK [fetch-tox-output : Set envlist fact] 2025-01-08 11:24:35.860324 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:24:35.870920 | 2025-01-08 11:24:35.871085 | LOOP [fetch-tox-output : Copy tox logs] 2025-01-08 11:24:35.942807 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:24:35.959888 | 2025-01-08 11:24:35.960047 | LOOP [fetch-tox-output : Collect tox logs] 2025-01-08 11:24:36.774524 | ubuntu-noble | changed: 2025-01-08 11:24:36.774751 | ubuntu-noble | cd+++++++++ ./ 2025-01-08 11:24:36.774786 | ubuntu-noble | >f+++++++++ 1-commands[0].log 2025-01-08 11:24:36.774828 | 2025-01-08 11:24:36.825379 | 2025-01-08 11:24:36.825509 | PLAY RECAP 2025-01-08 11:24:36.825577 | ubuntu-noble | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-01-08 11:24:36.825611 | 2025-01-08 11:24:36.970273 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2025-01-08 11:24:36.973886 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2025-01-08 11:24:37.748640 | 2025-01-08 11:24:37.748846 | PLAY [all] 2025-01-08 11:24:37.777758 | 2025-01-08 11:24:37.777945 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-01-08 11:24:37.973512 | ubuntu-noble | changed: non-zero return code 2025-01-08 11:24:37.984458 | 2025-01-08 11:24:37.984768 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-01-08 11:24:38.014647 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:24:38.032912 | 2025-01-08 11:24:38.033075 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-01-08 11:24:38.069556 | 2025-01-08 11:24:38.069815 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-01-08 11:24:38.121629 | 2025-01-08 11:24:38.121981 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-01-08 11:24:38.158817 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:24:38.174967 | 2025-01-08 11:24:38.175142 | LOOP [fetch-subunit-output : Generate subunit file] 2025-01-08 11:24:38.225718 | 2025-01-08 11:24:38.226085 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-01-08 11:24:38.259954 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:24:38.270330 | 2025-01-08 11:24:38.270471 | TASK [fetch-subunit-output : Remove the temporary file] 2025-01-08 11:24:38.295635 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:24:38.303355 | 2025-01-08 11:24:38.303474 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-01-08 11:24:38.338098 | ubuntu-noble | skipping: Conditional result was False 2025-01-08 11:24:38.372446 | 2025-01-08 11:24:38.372579 | PLAY RECAP 2025-01-08 11:24:38.372863 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-01-08 11:24:38.372907 | 2025-01-08 11:24:38.539917 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2025-01-08 11:24:38.543612 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-01-08 11:24:39.274192 | 2025-01-08 11:24:39.274362 | PLAY [Base post] 2025-01-08 11:24:39.301967 | 2025-01-08 11:24:39.302139 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-01-08 11:24:40.399050 | ubuntu-noble | changed 2025-01-08 11:24:40.433634 | 2025-01-08 11:24:40.433835 | PLAY RECAP 2025-01-08 11:24:40.433948 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-01-08 11:24:40.434015 | 2025-01-08 11:24:40.703541 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-01-08 11:24:40.710523 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-01-08 11:24:41.502782 | 2025-01-08 11:24:41.502957 | PLAY [Base post-logs] 2025-01-08 11:24:41.522674 | 2025-01-08 11:24:41.522984 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-01-08 11:24:42.015290 | localhost | changed 2025-01-08 11:24:42.019975 | 2025-01-08 11:24:42.020124 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-01-08 11:24:42.054536 | localhost | ok 2025-01-08 11:24:42.061842 | 2025-01-08 11:24:42.062002 | TASK [Set zuul-log-path fact] 2025-01-08 11:24:42.082141 | localhost | ok 2025-01-08 11:24:42.097778 | 2025-01-08 11:24:42.097964 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-08 11:24:42.180927 | localhost | ok 2025-01-08 11:24:42.187330 | 2025-01-08 11:24:42.187557 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-08 11:24:42.235478 | localhost | skipping: Conditional result was False 2025-01-08 11:24:42.245599 | 2025-01-08 11:24:42.245864 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-08 11:24:42.295342 | localhost | skipping: Conditional result was False 2025-01-08 11:24:42.300755 | 2025-01-08 11:24:42.300880 | TASK [set-zuul-log-path-fact : Set log path for a change] 2025-01-08 11:24:42.325863 | localhost | skipping: Conditional result was False 2025-01-08 11:24:42.329611 | 2025-01-08 11:24:42.329726 | TASK [set-zuul-log-path-fact : Set log path for a ref update] 2025-01-08 11:24:42.354216 | localhost | skipping: Conditional result was False 2025-01-08 11:24:42.358317 | 2025-01-08 11:24:42.358429 | TASK [set-zuul-log-path-fact : Set log path for a periodic job] 2025-01-08 11:24:42.382768 | localhost | skipping: Conditional result was False 2025-01-08 11:24:42.389111 | 2025-01-08 11:24:42.389241 | TASK [upload-logs : Create log directories] 2025-01-08 11:24:42.907281 | localhost | changed 2025-01-08 11:24:42.912277 | 2025-01-08 11:24:42.912387 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-01-08 11:24:43.463857 | localhost -> localhost | ok: Runtime: 0:00:00.004598 2025-01-08 11:24:43.470677 | 2025-01-08 11:24:43.470872 | TASK [upload-logs : Upload logs to log server] 2025-01-08 11:24:44.076050 | localhost | Output suppressed because no_log was given 2025-01-08 11:24:44.079640 | 2025-01-08 11:24:44.079811 | LOOP [upload-logs : Compress console log and json output] 2025-01-08 11:24:44.147015 | localhost | skipping: Conditional result was False 2025-01-08 11:24:44.166568 | localhost | skipping: Conditional result was False 2025-01-08 11:24:44.177758 | 2025-01-08 11:24:44.178200 | LOOP [upload-logs : Upload compressed console log and json output] 2025-01-08 11:24:44.246828 | localhost | skipping: Conditional result was False 2025-01-08 11:24:44.247428 | 2025-01-08 11:24:44.260735 | localhost | skipping: Conditional result was False 2025-01-08 11:24:44.278228 | 2025-01-08 11:24:44.278424 | LOOP [upload-logs : Upload console log and json output]