2025-04-06 19:53:58.269238 | Job console starting... 2025-04-06 19:53:58.290307 | Updating repositories 2025-04-06 19:53:58.319575 | Preparing job workspace 2025-04-06 19:54:00.840444 | Running Ansible setup... 2025-04-06 19:54:08.200453 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-04-06 19:54:09.298649 | 2025-04-06 19:54:09.298870 | PLAY [Base pre] 2025-04-06 19:54:09.355277 | 2025-04-06 19:54:09.355408 | TASK [Setup log path fact] 2025-04-06 19:54:09.449288 | ubuntu-noble | ok 2025-04-06 19:54:09.489186 | 2025-04-06 19:54:09.489321 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-04-06 19:54:09.553141 | ubuntu-noble | ok 2025-04-06 19:54:09.582868 | 2025-04-06 19:54:09.582977 | TASK [emit-job-header : Print job information] 2025-04-06 19:54:09.727572 | # Job Information 2025-04-06 19:54:09.727700 | Ansible Version: 2.15.3 2025-04-06 19:54:09.727727 | Job: tox 2025-04-06 19:54:09.727753 | Pipeline: check 2025-04-06 19:54:09.727770 | Executor: 7d211f194f6a 2025-04-06 19:54:09.727785 | Triggered by: https://github.com/osism/openstack-image-manager/pull/895 2025-04-06 19:54:09.727800 | Event ID: dbf9d570-1320-11f0-8c4e-4a48dd52416a 2025-04-06 19:54:09.745360 | 2025-04-06 19:54:09.745460 | LOOP [emit-job-header : Print node information] 2025-04-06 19:54:09.951799 | ubuntu-noble | ok: 2025-04-06 19:54:09.951936 | ubuntu-noble | # Node Information 2025-04-06 19:54:09.951962 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-04-06 19:54:09.951982 | ubuntu-noble | Hostname: ubuntu 2025-04-06 19:54:09.951999 | ubuntu-noble | Username: zuul 2025-04-06 19:54:09.952016 | ubuntu-noble | Distro: Ubuntu 24.04 2025-04-06 19:54:09.952035 | ubuntu-noble | Provider: regiocloud-a 2025-04-06 19:54:09.952051 | ubuntu-noble | Label: ubuntu-noble 2025-04-06 19:54:09.952068 | ubuntu-noble | Product Name: OpenStack Nova 2025-04-06 19:54:09.952084 | ubuntu-noble | Interface IP: 81.163.192.241 2025-04-06 19:54:09.970312 | 2025-04-06 19:54:09.970406 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-04-06 19:54:10.727032 | ubuntu-noble -> localhost | changed 2025-04-06 19:54:10.733691 | 2025-04-06 19:54:10.733779 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-04-06 19:54:13.117003 | ubuntu-noble -> localhost | changed 2025-04-06 19:54:13.127949 | 2025-04-06 19:54:13.128040 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-04-06 19:54:13.574383 | ubuntu-noble -> localhost | ok 2025-04-06 19:54:13.580378 | 2025-04-06 19:54:13.580490 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-04-06 19:54:13.640826 | ubuntu-noble | ok 2025-04-06 19:54:13.667412 | ubuntu-noble | included: /var/lib/zuul/builds/4cdc183623db40a184db6ca72da995f7/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-04-06 19:54:13.681811 | 2025-04-06 19:54:13.681899 | TASK [add-build-sshkey : Create Temp SSH key] 2025-04-06 19:54:14.327558 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-04-06 19:54:14.327805 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/4cdc183623db40a184db6ca72da995f7/work/4cdc183623db40a184db6ca72da995f7_id_rsa 2025-04-06 19:54:14.327856 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/4cdc183623db40a184db6ca72da995f7/work/4cdc183623db40a184db6ca72da995f7_id_rsa.pub 2025-04-06 19:54:14.327883 | ubuntu-noble -> localhost | The key fingerprint is: 2025-04-06 19:54:14.327909 | ubuntu-noble -> localhost | SHA256:66kaH7Yl5boVkEddZcCXYo9FevKaDyI8IicWIJz1swg zuul-build-sshkey 2025-04-06 19:54:14.327932 | ubuntu-noble -> localhost | The key's randomart image is: 2025-04-06 19:54:14.328026 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-04-06 19:54:14.328056 | ubuntu-noble -> localhost | | . .. oo++. | 2025-04-06 19:54:14.328078 | ubuntu-noble -> localhost | |. o . o . +o+ | 2025-04-06 19:54:14.328099 | ubuntu-noble -> localhost | |.E. oo . .o*. | 2025-04-06 19:54:14.328129 | ubuntu-noble -> localhost | | .... oo .+. | 2025-04-06 19:54:14.328150 | ubuntu-noble -> localhost | | ... S . | 2025-04-06 19:54:14.328206 | ubuntu-noble -> localhost | | . + o o | 2025-04-06 19:54:14.328277 | ubuntu-noble -> localhost | | = * O . + | 2025-04-06 19:54:14.328301 | ubuntu-noble -> localhost | | . B X + . o | 2025-04-06 19:54:14.328322 | ubuntu-noble -> localhost | | ..*oo . | 2025-04-06 19:54:14.328343 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-04-06 19:54:14.328453 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.192895 2025-04-06 19:54:14.340131 | 2025-04-06 19:54:14.340302 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-04-06 19:54:14.373335 | ubuntu-noble | ok 2025-04-06 19:54:14.400670 | ubuntu-noble | included: /var/lib/zuul/builds/4cdc183623db40a184db6ca72da995f7/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-04-06 19:54:14.417881 | 2025-04-06 19:54:14.418076 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-04-06 19:54:14.478114 | ubuntu-noble | skipping: Conditional result was False 2025-04-06 19:54:14.490993 | 2025-04-06 19:54:14.491095 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-04-06 19:54:15.332243 | ubuntu-noble | changed 2025-04-06 19:54:15.368250 | 2025-04-06 19:54:15.368454 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-04-06 19:54:15.715569 | ubuntu-noble | ok 2025-04-06 19:54:15.741561 | 2025-04-06 19:54:15.741666 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-04-06 19:54:16.593604 | ubuntu-noble | changed 2025-04-06 19:54:16.599285 | 2025-04-06 19:54:16.599366 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-04-06 19:54:17.378231 | ubuntu-noble | changed 2025-04-06 19:54:17.397852 | 2025-04-06 19:54:17.398599 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-04-06 19:54:17.463161 | ubuntu-noble | skipping: Conditional result was False 2025-04-06 19:54:17.471646 | 2025-04-06 19:54:17.471751 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-04-06 19:54:18.163914 | ubuntu-noble -> localhost | changed 2025-04-06 19:54:18.175145 | 2025-04-06 19:54:18.175232 | TASK [add-build-sshkey : Add back temp key] 2025-04-06 19:54:18.594118 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/4cdc183623db40a184db6ca72da995f7/work/4cdc183623db40a184db6ca72da995f7_id_rsa (zuul-build-sshkey) 2025-04-06 19:54:18.594352 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.011729 2025-04-06 19:54:18.603824 | 2025-04-06 19:54:18.603912 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-04-06 19:54:19.171648 | ubuntu-noble | ok 2025-04-06 19:54:19.188702 | 2025-04-06 19:54:19.188791 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-04-06 19:54:19.256535 | ubuntu-noble | skipping: Conditional result was False 2025-04-06 19:54:19.281900 | 2025-04-06 19:54:19.281991 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-04-06 19:54:19.785029 | ubuntu-noble | ok 2025-04-06 19:54:19.802625 | 2025-04-06 19:54:19.802719 | TASK [validate-host : Define zuul_info_dir fact] 2025-04-06 19:54:19.861542 | ubuntu-noble | ok 2025-04-06 19:54:19.869336 | 2025-04-06 19:54:19.869419 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-04-06 19:54:20.319632 | ubuntu-noble -> localhost | ok 2025-04-06 19:54:20.325929 | 2025-04-06 19:54:20.326009 | TASK [validate-host : Collect information about the host] 2025-04-06 19:54:21.452425 | ubuntu-noble | ok 2025-04-06 19:54:21.462102 | 2025-04-06 19:54:21.462179 | TASK [validate-host : Sanitize hostname] 2025-04-06 19:54:21.547758 | ubuntu-noble | ok 2025-04-06 19:54:21.552783 | 2025-04-06 19:54:21.552865 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-04-06 19:54:22.456309 | ubuntu-noble -> localhost | changed 2025-04-06 19:54:22.461834 | 2025-04-06 19:54:22.461921 | TASK [validate-host : Collect information about zuul worker] 2025-04-06 19:54:22.897370 | ubuntu-noble | ok 2025-04-06 19:54:22.905153 | 2025-04-06 19:54:22.905240 | TASK [validate-host : Write out all zuul information for each host] 2025-04-06 19:54:23.718091 | ubuntu-noble -> localhost | changed 2025-04-06 19:54:23.728213 | 2025-04-06 19:54:23.728308 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-04-06 19:54:24.047167 | ubuntu-noble | ok 2025-04-06 19:54:24.052746 | 2025-04-06 19:54:24.052838 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-04-06 19:54:25.048193 | ubuntu-noble | changed: 2025-04-06 19:54:25.048344 | ubuntu-noble | cd+++++++++ src/ 2025-04-06 19:54:25.048377 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-04-06 19:54:25.048584 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-04-06 19:54:25.048613 | ubuntu-noble | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-04-06 19:54:25.048634 | ubuntu-noble | =5.5.1 (from tox) 2025-04-06 19:54:51.360429 | ubuntu-noble | Downloading cachetools-5.5.2-py3-none-any.whl.metadata (5.4 kB) 2025-04-06 19:54:51.425571 | ubuntu-noble | Collecting chardet>=5.2 (from tox) 2025-04-06 19:54:51.441466 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl.metadata (3.4 kB) 2025-04-06 19:54:51.511492 | ubuntu-noble | Collecting colorama>=0.4.6 (from tox) 2025-04-06 19:54:51.528566 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2025-04-06 19:54:51.623492 | ubuntu-noble | Collecting filelock>=3.16.1 (from tox) 2025-04-06 19:54:51.642220 | ubuntu-noble | Downloading filelock-3.18.0-py3-none-any.whl.metadata (2.9 kB) 2025-04-06 19:54:51.734773 | ubuntu-noble | Collecting packaging>=24.2 (from tox) 2025-04-06 19:54:51.757136 | ubuntu-noble | Downloading packaging-24.2-py3-none-any.whl.metadata (3.2 kB) 2025-04-06 19:54:51.842776 | ubuntu-noble | Collecting platformdirs>=4.3.6 (from tox) 2025-04-06 19:54:51.858657 | ubuntu-noble | Downloading platformdirs-4.3.7-py3-none-any.whl.metadata (11 kB) 2025-04-06 19:54:51.921852 | ubuntu-noble | Collecting pluggy>=1.5 (from tox) 2025-04-06 19:54:51.937530 | ubuntu-noble | Downloading pluggy-1.5.0-py3-none-any.whl.metadata (4.8 kB) 2025-04-06 19:54:52.002575 | ubuntu-noble | Collecting pyproject-api>=1.8 (from tox) 2025-04-06 19:54:52.021226 | ubuntu-noble | Downloading pyproject_api-1.9.0-py3-none-any.whl.metadata (2.7 kB) 2025-04-06 19:54:52.230449 | ubuntu-noble | Collecting virtualenv>=20.29.1 (from tox) 2025-04-06 19:54:52.245225 | ubuntu-noble | Downloading virtualenv-20.30.0-py3-none-any.whl.metadata (4.5 kB) 2025-04-06 19:54:52.398160 | ubuntu-noble | Collecting distlib<1,>=0.3.7 (from virtualenv>=20.29.1->tox) 2025-04-06 19:54:52.413320 | ubuntu-noble | Downloading distlib-0.3.9-py2.py3-none-any.whl.metadata (5.2 kB) 2025-04-06 19:54:52.465783 | ubuntu-noble | Downloading tox-4.25.0-py3-none-any.whl (172 kB) 2025-04-06 19:54:52.500120 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 172.4/172.4 kB 5.7 MB/s eta 0:00:00 2025-04-06 19:54:52.517701 | ubuntu-noble | Downloading cachetools-5.5.2-py3-none-any.whl (10 kB) 2025-04-06 19:54:52.548234 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-04-06 19:54:52.562858 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 19.9 MB/s eta 0:00:00 2025-04-06 19:54:52.577242 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-04-06 19:54:52.604171 | ubuntu-noble | Downloading filelock-3.18.0-py3-none-any.whl (16 kB) 2025-04-06 19:54:52.679064 | ubuntu-noble | Downloading packaging-24.2-py3-none-any.whl (65 kB) 2025-04-06 19:54:52.695463 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 65.5/65.5 kB 4.5 MB/s eta 0:00:00 2025-04-06 19:54:52.714229 | ubuntu-noble | Downloading platformdirs-4.3.7-py3-none-any.whl (18 kB) 2025-04-06 19:54:52.743234 | ubuntu-noble | Downloading pluggy-1.5.0-py3-none-any.whl (20 kB) 2025-04-06 19:54:52.769768 | ubuntu-noble | Downloading pyproject_api-1.9.0-py3-none-any.whl (13 kB) 2025-04-06 19:54:52.796984 | ubuntu-noble | Downloading virtualenv-20.30.0-py3-none-any.whl (4.3 MB) 2025-04-06 19:54:52.972236 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.3/4.3 MB 25.8 MB/s eta 0:00:00 2025-04-06 19:54:52.990367 | ubuntu-noble | Downloading distlib-0.3.9-py2.py3-none-any.whl (468 kB) 2025-04-06 19:54:53.019311 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 20.3 MB/s eta 0:00:00 2025-04-06 19:54:53.150337 | ubuntu-noble | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-04-06 19:54:54.056946 | ubuntu-noble | Successfully installed cachetools-5.5.2 chardet-5.2.0 colorama-0.4.6 distlib-0.3.9 filelock-3.18.0 packaging-24.2 platformdirs-4.3.7 pluggy-1.5.0 pyproject-api-1.9.0 tox-4.25.0 virtualenv-20.30.0 2025-04-06 19:54:54.362876 | ubuntu-noble | ok: Runtime: 0:00:03.913676 2025-04-06 19:54:54.374558 | 2025-04-06 19:54:54.374687 | TASK [ensure-tox : Export installed tox_executable path] 2025-04-06 19:54:54.471491 | ubuntu-noble | ok 2025-04-06 19:54:54.484953 | 2025-04-06 19:54:54.485082 | TASK [ensure-tox : Output tox version] 2025-04-06 19:54:55.409180 | ubuntu-noble | ROOT: No tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-04-06 19:54:55.446525 | ubuntu-noble | 4.25.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2025-04-06 19:54:55.575959 | ubuntu-noble | ok: Runtime: 0:00:00.398842 2025-04-06 19:54:55.583709 | 2025-04-06 19:54:55.583790 | TASK [ensure-tox : Make global symlink] 2025-04-06 19:54:55.607472 | ubuntu-noble | skipping: Conditional result was False 2025-04-06 19:54:55.668832 | 2025-04-06 19:54:55.668917 | PLAY RECAP 2025-04-06 19:54:55.668961 | ubuntu-noble | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-04-06 19:54:55.668982 | 2025-04-06 19:54:55.849737 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2025-04-06 19:54:55.853490 | RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/run.yaml@master] 2025-04-06 19:54:56.856216 | 2025-04-06 19:54:56.856324 | PLAY [all] 2025-04-06 19:54:56.911763 | 2025-04-06 19:54:56.911910 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-04-06 19:54:57.994107 | ubuntu-noble | ok: Runtime: 0:00:00.020307 2025-04-06 19:54:57.999863 | 2025-04-06 19:54:57.999962 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-04-06 19:54:58.555418 | ubuntu-noble | ok: Runtime: 0:00:00.004576 2025-04-06 19:54:58.566494 | 2025-04-06 19:54:58.566613 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-04-06 19:54:59.167179 | ubuntu-noble | sudo: a password is required 2025-04-06 19:54:59.225421 | ubuntu-noble | ok: Runtime: 0:00:00.014748 2025-04-06 19:54:59.237954 | 2025-04-06 19:54:59.238051 | TASK [tox : Check to see if the constraints file exists] 2025-04-06 19:54:59.317673 | ubuntu-noble | skipping: Conditional result was False 2025-04-06 19:54:59.325728 | 2025-04-06 19:54:59.325836 | TASK [tox : Fail if constraints file is missing] 2025-04-06 19:54:59.360085 | ubuntu-noble | skipping: Conditional result was False 2025-04-06 19:54:59.367374 | 2025-04-06 19:54:59.367472 | TASK [tox : Record file location] 2025-04-06 19:54:59.418503 | ubuntu-noble | skipping: Conditional result was False 2025-04-06 19:54:59.444535 | 2025-04-06 19:54:59.444706 | TASK [tox : Install tox siblings] 2025-04-06 19:54:59.478444 | ubuntu-noble | ok 2025-04-06 19:54:59.491000 | ubuntu-noble | included: /var/lib/zuul/builds/4cdc183623db40a184db6ca72da995f7/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/tox/tasks/siblings.yaml 2025-04-06 19:54:59.508010 | 2025-04-06 19:54:59.508116 | TASK [tox : Run tox without tests] 2025-04-06 19:55:00.599544 | ubuntu-noble | test: install_deps> python -I -m pip install -r requirements.txt 2025-04-06 19:55:16.920609 | ubuntu-noble | test: OK (16.66 seconds) 2025-04-06 19:55:16.954306 | ubuntu-noble | congratulations :) (16.76 seconds) 2025-04-06 19:55:17.109224 | ubuntu-noble | ok: Runtime: 0:00:17.015344 2025-04-06 19:55:17.116107 | 2025-04-06 19:55:17.116196 | TASK [tox : Create a tempfile to save tox showconfig] 2025-04-06 19:55:17.476993 | ubuntu-noble | changed 2025-04-06 19:55:17.483761 | 2025-04-06 19:55:17.483857 | TASK [tox : Get tox envlist config] 2025-04-06 19:55:18.531921 | ubuntu-noble | ok: Runtime: 0:00:00.312003 2025-04-06 19:55:18.550176 | 2025-04-06 19:55:18.550348 | TASK [tox : Install any sibling python packages] 2025-04-06 19:55:19.128807 | ubuntu-noble | ok: No setup.cfg, no action needed 2025-04-06 19:55:19.140914 | 2025-04-06 19:55:19.141034 | TASK [tox : Remove tempfile] 2025-04-06 19:55:19.775751 | ubuntu-noble | changed 2025-04-06 19:55:19.784266 | 2025-04-06 19:55:19.784400 | TASK [tox : Emit tox command] 2025-04-06 19:55:19.840484 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-04-06 19:55:19.850728 | 2025-04-06 19:55:19.850853 | TASK [tox : Run tox] 2025-04-06 19:55:20.971435 | ubuntu-noble | test: commands[0]> python -m unittest discover test/unit 2025-04-06 19:55:22.140506 | ubuntu-noble | ............... 2025-04-06 19:55:22.140615 | ubuntu-noble | ---------------------------------------------------------------------- 2025-04-06 19:55:22.212022 | ubuntu-noble | Ran 15 tests in 0.175s 2025-04-06 19:55:22.212056 | ubuntu-noble | 2025-04-06 19:55:22.212066 | ubuntu-noble | OK 2025-04-06 19:55:22.212076 | ubuntu-noble | test: OK (1.33=setup[0.09]+cmd[1.24] seconds) 2025-04-06 19:55:22.284172 | ubuntu-noble | congratulations :) (1.43 seconds) 2025-04-06 19:55:22.412993 | ubuntu-noble | ok: Runtime: 0:00:01.878490 2025-04-06 19:55:22.430424 | 2025-04-06 19:55:22.430592 | TASK [tox : Look for output] 2025-04-06 19:55:23.016119 | ubuntu-noble | ok 2025-04-06 19:55:23.033231 | 2025-04-06 19:55:23.033412 | TASK [tox : Return file comments to Zuul] 2025-04-06 19:55:23.080838 | ubuntu-noble | skipping: Conditional result was False 2025-04-06 19:55:23.113711 | 2025-04-06 19:55:23.113802 | PLAY RECAP 2025-04-06 19:55:23.113859 | ubuntu-noble | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-04-06 19:55:23.113895 | 2025-04-06 19:55:23.235169 | RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/run.yaml@master] 2025-04-06 19:55:23.240333 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2025-04-06 19:55:23.913971 | 2025-04-06 19:55:23.914192 | PLAY [all] 2025-04-06 19:55:23.942733 | 2025-04-06 19:55:23.942876 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-04-06 19:55:24.011709 | ubuntu-noble | skipping: Conditional result was False 2025-04-06 19:55:24.019687 | 2025-04-06 19:55:24.019842 | TASK [fetch-tox-output : Set tox log path for single node] 2025-04-06 19:55:24.062571 | ubuntu-noble | ok 2025-04-06 19:55:24.070301 | 2025-04-06 19:55:24.070407 | TASK [fetch-tox-output : Ensure local tox dir] 2025-04-06 19:55:24.607028 | ubuntu-noble -> localhost | changed 2025-04-06 19:55:24.621817 | 2025-04-06 19:55:24.621936 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-04-06 19:55:24.676446 | ubuntu-noble | skipping: Conditional result was False 2025-04-06 19:55:24.683296 | 2025-04-06 19:55:24.683394 | TASK [fetch-tox-output : Set envlist fact] 2025-04-06 19:55:24.722835 | ubuntu-noble | ok 2025-04-06 19:55:24.729581 | 2025-04-06 19:55:24.729668 | TASK [fetch-tox-output : Get tox version] 2025-04-06 19:55:25.523451 | ubuntu-noble | ROOT: No tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2025-04-06 19:55:25.539587 | ubuntu-noble | 4.25.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2025-04-06 19:55:25.771280 | ubuntu-noble | ok: Runtime: 0:00:00.317329 2025-04-06 19:55:25.779984 | 2025-04-06 19:55:25.780108 | TASK [fetch-tox-output : Find all default environments] 2025-04-06 19:55:25.854617 | ubuntu-noble | skipping: Conditional result was False 2025-04-06 19:55:25.861914 | 2025-04-06 19:55:25.862036 | TASK [fetch-tox-output : Set envlist fact] 2025-04-06 19:55:25.897580 | ubuntu-noble | skipping: Conditional result was False 2025-04-06 19:55:25.905168 | 2025-04-06 19:55:25.905278 | TASK [fetch-tox-output : Find all default environments] 2025-04-06 19:55:25.987131 | ubuntu-noble | skipping: Conditional result was False 2025-04-06 19:55:26.002236 | 2025-04-06 19:55:26.002385 | TASK [fetch-tox-output : Set envlist fact] 2025-04-06 19:55:26.028232 | ubuntu-noble | skipping: Conditional result was False 2025-04-06 19:55:26.044932 | 2025-04-06 19:55:26.045086 | LOOP [fetch-tox-output : Copy tox logs] 2025-04-06 19:55:26.110245 | ubuntu-noble | skipping: Conditional result was False 2025-04-06 19:55:26.130346 | 2025-04-06 19:55:26.130461 | LOOP [fetch-tox-output : Collect tox logs] 2025-04-06 19:55:26.904857 | ubuntu-noble | changed: 2025-04-06 19:55:26.905113 | ubuntu-noble | cd+++++++++ ./ 2025-04-06 19:55:26.905168 | ubuntu-noble | >f+++++++++ 1-commands[0].log 2025-04-06 19:55:26.905352 | 2025-04-06 19:55:26.958935 | 2025-04-06 19:55:26.959043 | PLAY RECAP 2025-04-06 19:55:26.959100 | ubuntu-noble | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-04-06 19:55:26.959129 | 2025-04-06 19:55:27.103165 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2025-04-06 19:55:27.107008 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2025-04-06 19:55:27.838725 | 2025-04-06 19:55:27.838891 | PLAY [all] 2025-04-06 19:55:27.883514 | 2025-04-06 19:55:27.883742 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-04-06 19:55:28.047196 | ubuntu-noble | changed: non-zero return code 2025-04-06 19:55:28.055444 | 2025-04-06 19:55:28.055639 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-04-06 19:55:28.090879 | ubuntu-noble | skipping: Conditional result was False 2025-04-06 19:55:28.106929 | 2025-04-06 19:55:28.107083 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-04-06 19:55:28.145596 | 2025-04-06 19:55:28.145833 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-04-06 19:55:28.178314 | 2025-04-06 19:55:28.178497 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-04-06 19:55:28.202791 | ubuntu-noble | skipping: Conditional result was False 2025-04-06 19:55:28.210115 | 2025-04-06 19:55:28.210224 | LOOP [fetch-subunit-output : Generate subunit file] 2025-04-06 19:55:28.242787 | 2025-04-06 19:55:28.242967 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-04-06 19:55:28.277300 | ubuntu-noble | skipping: Conditional result was False 2025-04-06 19:55:28.286812 | 2025-04-06 19:55:28.286953 | TASK [fetch-subunit-output : Remove the temporary file] 2025-04-06 19:55:28.311764 | ubuntu-noble | skipping: Conditional result was False 2025-04-06 19:55:28.321789 | 2025-04-06 19:55:28.321915 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-04-06 19:55:28.349966 | ubuntu-noble | skipping: Conditional result was False 2025-04-06 19:55:28.385172 | 2025-04-06 19:55:28.385272 | PLAY RECAP 2025-04-06 19:55:28.385328 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-04-06 19:55:28.385353 | 2025-04-06 19:55:28.501898 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2025-04-06 19:55:28.505731 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-04-06 19:55:29.250834 | 2025-04-06 19:55:29.250992 | PLAY [Base post] 2025-04-06 19:55:29.278118 | 2025-04-06 19:55:29.278256 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-04-06 19:55:30.023857 | ubuntu-noble | changed 2025-04-06 19:55:30.060347 | 2025-04-06 19:55:30.060506 | PLAY RECAP 2025-04-06 19:55:30.060597 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-04-06 19:55:30.060659 | 2025-04-06 19:55:30.182448 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-04-06 19:55:30.191286 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-04-06 19:55:30.978512 | 2025-04-06 19:55:30.978681 | PLAY [Base post-logs] 2025-04-06 19:55:30.994967 | 2025-04-06 19:55:30.995095 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-04-06 19:55:31.473482 | localhost | changed 2025-04-06 19:55:31.477654 | 2025-04-06 19:55:31.477794 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-04-06 19:55:31.505285 | localhost | ok 2025-04-06 19:55:31.531293 | 2025-04-06 19:55:31.531421 | TASK [Set zuul-log-path fact] 2025-04-06 19:55:31.550169 | localhost | ok 2025-04-06 19:55:31.562112 | 2025-04-06 19:55:31.562251 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-04-06 19:55:31.590335 | localhost | ok 2025-04-06 19:55:31.596365 | 2025-04-06 19:55:31.596501 | TASK [upload-logs : Create log directories] 2025-04-06 19:55:32.110406 | localhost | changed 2025-04-06 19:55:32.115510 | 2025-04-06 19:55:32.115646 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-04-06 19:55:32.626042 | localhost -> localhost | ok: Runtime: 0:00:00.008250 2025-04-06 19:55:32.651637 | 2025-04-06 19:55:32.651768 | TASK [upload-logs : Upload logs to log server] 2025-04-06 19:55:33.244771 | localhost | Output suppressed because no_log was given 2025-04-06 19:55:33.251304 | 2025-04-06 19:55:33.251477 | LOOP [upload-logs : Compress console log and json output] 2025-04-06 19:55:33.319513 | localhost | skipping: Conditional result was False 2025-04-06 19:55:33.336828 | localhost | skipping: Conditional result was False 2025-04-06 19:55:33.350252 | 2025-04-06 19:55:33.350437 | LOOP [upload-logs : Upload compressed console log and json output] 2025-04-06 19:55:33.413045 | localhost | skipping: Conditional result was False 2025-04-06 19:55:33.413473 | 2025-04-06 19:55:33.426719 | localhost | skipping: Conditional result was False 2025-04-06 19:55:33.437655 | 2025-04-06 19:55:33.437901 | LOOP [upload-logs : Upload console log and json output]