2025-04-10 13:28:41.820731 | Job console starting... 2025-04-10 13:28:41.875782 | Updating repositories 2025-04-10 13:28:41.956137 | Preparing job workspace 2025-04-10 13:28:44.191633 | Running Ansible setup... 2025-04-10 13:28:51.423179 | PRE-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/pre.yaml@main] 2025-04-10 13:28:52.168014 | 2025-04-10 13:28:52.168167 | PLAY [Base pre] 2025-04-10 13:28:52.191458 | 2025-04-10 13:28:52.191568 | TASK [Setup log path fact] 2025-04-10 13:28:52.210039 | ubuntu-noble | ok 2025-04-10 13:28:52.225796 | 2025-04-10 13:28:52.225896 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-04-10 13:28:52.284978 | ubuntu-noble | ok 2025-04-10 13:28:52.295545 | 2025-04-10 13:28:52.295633 | TASK [emit-job-header : Print job information] 2025-04-10 13:28:52.335631 | # Job Information 2025-04-10 13:28:52.335835 | Ansible Version: 2.15.3 2025-04-10 13:28:52.335867 | Job: tox 2025-04-10 13:28:52.335896 | Pipeline: check 2025-04-10 13:28:52.335918 | Executor: 7d211f194f6a 2025-04-10 13:28:52.335934 | Triggered by: https://github.com/osism/openstack-image-manager/pull/908 2025-04-10 13:28:52.335949 | Event ID: b3044f50-160f-11f0-94f3-709a07b03fb1 2025-04-10 13:28:52.341368 | 2025-04-10 13:28:52.341460 | LOOP [emit-job-header : Print node information] 2025-04-10 13:28:52.545195 | ubuntu-noble | ok: 2025-04-10 13:28:52.545347 | ubuntu-noble | # Node Information 2025-04-10 13:28:52.545380 | ubuntu-noble | Inventory Hostname: ubuntu-noble 2025-04-10 13:28:52.545405 | ubuntu-noble | Hostname: ubuntu 2025-04-10 13:28:52.545427 | ubuntu-noble | Username: zuul 2025-04-10 13:28:52.545447 | ubuntu-noble | Distro: Ubuntu 24.04 2025-04-10 13:28:52.545471 | ubuntu-noble | Provider: regiocloud-a 2025-04-10 13:28:52.545492 | ubuntu-noble | Label: ubuntu-noble 2025-04-10 13:28:52.545513 | ubuntu-noble | Product Name: OpenStack Nova 2025-04-10 13:28:52.545532 | ubuntu-noble | Interface IP: 81.163.193.182 2025-04-10 13:28:52.574158 | 2025-04-10 13:28:52.574277 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-04-10 13:28:53.191153 | ubuntu-noble -> localhost | changed 2025-04-10 13:28:53.201524 | 2025-04-10 13:28:53.201631 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-04-10 13:28:54.522544 | ubuntu-noble -> localhost | changed 2025-04-10 13:28:54.534264 | 2025-04-10 13:28:54.534350 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-04-10 13:28:54.937244 | ubuntu-noble -> localhost | ok 2025-04-10 13:28:54.943802 | 2025-04-10 13:28:54.943921 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-04-10 13:28:54.977600 | ubuntu-noble | ok 2025-04-10 13:28:54.997522 | ubuntu-noble | included: /var/lib/zuul/builds/b736767897214ad9b4447a0e6746cd3d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-04-10 13:28:55.003786 | 2025-04-10 13:28:55.003861 | TASK [add-build-sshkey : Create Temp SSH key] 2025-04-10 13:28:55.762001 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2025-04-10 13:28:55.762164 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/b736767897214ad9b4447a0e6746cd3d/work/b736767897214ad9b4447a0e6746cd3d_id_rsa 2025-04-10 13:28:55.762195 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/b736767897214ad9b4447a0e6746cd3d/work/b736767897214ad9b4447a0e6746cd3d_id_rsa.pub 2025-04-10 13:28:55.762218 | ubuntu-noble -> localhost | The key fingerprint is: 2025-04-10 13:28:55.762238 | ubuntu-noble -> localhost | SHA256:CZ1zgjury0A/9P61CAuwXl8huf5lGAMcdujEU+C3UNA zuul-build-sshkey 2025-04-10 13:28:55.762256 | ubuntu-noble -> localhost | The key's randomart image is: 2025-04-10 13:28:55.762273 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2025-04-10 13:28:55.762290 | ubuntu-noble -> localhost | | .=*+ | 2025-04-10 13:28:55.762306 | ubuntu-noble -> localhost | | +=*E. | 2025-04-10 13:28:55.762323 | ubuntu-noble -> localhost | | oB.* . | 2025-04-10 13:28:55.762349 | ubuntu-noble -> localhost | | .B * | 2025-04-10 13:28:55.762366 | ubuntu-noble -> localhost | | o . = S | 2025-04-10 13:28:55.762383 | ubuntu-noble -> localhost | | . = . = = | 2025-04-10 13:28:55.762403 | ubuntu-noble -> localhost | | o = = o + | 2025-04-10 13:28:55.762420 | ubuntu-noble -> localhost | | . + B + = . | 2025-04-10 13:28:55.762436 | ubuntu-noble -> localhost | | . +.=o+ . | 2025-04-10 13:28:55.762453 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2025-04-10 13:28:55.762495 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.283658 2025-04-10 13:28:55.768930 | 2025-04-10 13:28:55.769021 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-04-10 13:28:55.797186 | ubuntu-noble | ok 2025-04-10 13:28:55.806648 | ubuntu-noble | included: /var/lib/zuul/builds/b736767897214ad9b4447a0e6746cd3d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-04-10 13:28:55.820597 | 2025-04-10 13:28:55.820688 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-04-10 13:28:55.845003 | ubuntu-noble | skipping: Conditional result was False 2025-04-10 13:28:55.851917 | 2025-04-10 13:28:55.852006 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-04-10 13:28:56.514425 | ubuntu-noble | changed 2025-04-10 13:28:56.522936 | 2025-04-10 13:28:56.523037 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-04-10 13:28:56.817263 | ubuntu-noble | ok 2025-04-10 13:28:56.825896 | 2025-04-10 13:28:56.826001 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-04-10 13:28:57.534458 | ubuntu-noble | changed 2025-04-10 13:28:57.542368 | 2025-04-10 13:28:57.542625 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-04-10 13:28:58.206743 | ubuntu-noble | changed 2025-04-10 13:28:58.221702 | 2025-04-10 13:28:58.221806 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-04-10 13:28:58.265829 | ubuntu-noble | skipping: Conditional result was False 2025-04-10 13:28:58.273351 | 2025-04-10 13:28:58.273454 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-04-10 13:28:58.733764 | ubuntu-noble -> localhost | changed 2025-04-10 13:28:58.747774 | 2025-04-10 13:28:58.747873 | TASK [add-build-sshkey : Add back temp key] 2025-04-10 13:28:59.112447 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/b736767897214ad9b4447a0e6746cd3d/work/b736767897214ad9b4447a0e6746cd3d_id_rsa (zuul-build-sshkey) 2025-04-10 13:28:59.112646 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.029566 2025-04-10 13:28:59.119819 | 2025-04-10 13:28:59.119906 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-04-10 13:28:59.541272 | ubuntu-noble | ok 2025-04-10 13:28:59.553036 | 2025-04-10 13:28:59.553161 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-04-10 13:28:59.611234 | ubuntu-noble | skipping: Conditional result was False 2025-04-10 13:28:59.658025 | 2025-04-10 13:28:59.658148 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-04-10 13:29:00.060646 | ubuntu-noble | ok 2025-04-10 13:29:00.075149 | 2025-04-10 13:29:00.075276 | TASK [validate-host : Define zuul_info_dir fact] 2025-04-10 13:29:00.106340 | ubuntu-noble | ok 2025-04-10 13:29:00.112805 | 2025-04-10 13:29:00.112889 | TASK [validate-host : Ensure Zuul Ansible directory exists] 2025-04-10 13:29:00.352360 | ubuntu-noble -> localhost | ok 2025-04-10 13:29:00.365468 | 2025-04-10 13:29:00.365596 | TASK [validate-host : Collect information about the host] 2025-04-10 13:29:01.477271 | ubuntu-noble | ok 2025-04-10 13:29:01.489161 | 2025-04-10 13:29:01.489257 | TASK [validate-host : Sanitize hostname] 2025-04-10 13:29:01.589862 | ubuntu-noble | ok 2025-04-10 13:29:01.596229 | 2025-04-10 13:29:01.596322 | TASK [validate-host : Write out all ansible variables/facts known for each host] 2025-04-10 13:29:02.275253 | ubuntu-noble -> localhost | changed 2025-04-10 13:29:02.281772 | 2025-04-10 13:29:02.281873 | TASK [validate-host : Collect information about zuul worker] 2025-04-10 13:29:02.718464 | ubuntu-noble | ok 2025-04-10 13:29:02.728640 | 2025-04-10 13:29:02.728746 | TASK [validate-host : Write out all zuul information for each host] 2025-04-10 13:29:03.283277 | ubuntu-noble -> localhost | changed 2025-04-10 13:29:03.298019 | 2025-04-10 13:29:03.298148 | TASK [prepare-workspace-log : Start zuul_console daemon.] 2025-04-10 13:29:03.579111 | ubuntu-noble | ok 2025-04-10 13:29:03.585668 | 2025-04-10 13:29:03.585774 | TASK [prepare-workspace-log : Synchronize src repos to workspace directory.] 2025-04-10 13:29:04.720474 | ubuntu-noble | changed: 2025-04-10 13:29:04.720633 | ubuntu-noble | cd+++++++++ src/ 2025-04-10 13:29:04.720667 | ubuntu-noble | cd+++++++++ src/github.com/ 2025-04-10 13:29:04.720691 | ubuntu-noble | cd+++++++++ src/github.com/osism/ 2025-04-10 13:29:04.720712 | ubuntu-noble | cd+++++++++ src/github.com/osism/openstack-image-manager/ 2025-04-10 13:29:04.720732 | ubuntu-noble | =5.5.1 (from tox) 2025-04-10 13:29:31.638429 | ubuntu-noble | Downloading cachetools-5.5.2-py3-none-any.whl.metadata (5.4 kB) 2025-04-10 13:29:31.687389 | ubuntu-noble | Collecting chardet>=5.2 (from tox) 2025-04-10 13:29:31.702564 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl.metadata (3.4 kB) 2025-04-10 13:29:31.769460 | ubuntu-noble | Collecting colorama>=0.4.6 (from tox) 2025-04-10 13:29:31.785024 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2025-04-10 13:29:31.878797 | ubuntu-noble | Collecting filelock>=3.16.1 (from tox) 2025-04-10 13:29:31.893442 | ubuntu-noble | Downloading filelock-3.18.0-py3-none-any.whl.metadata (2.9 kB) 2025-04-10 13:29:31.972298 | ubuntu-noble | Collecting packaging>=24.2 (from tox) 2025-04-10 13:29:31.988575 | ubuntu-noble | Downloading packaging-24.2-py3-none-any.whl.metadata (3.2 kB) 2025-04-10 13:29:32.070009 | ubuntu-noble | Collecting platformdirs>=4.3.6 (from tox) 2025-04-10 13:29:32.084752 | ubuntu-noble | Downloading platformdirs-4.3.7-py3-none-any.whl.metadata (11 kB) 2025-04-10 13:29:32.213617 | ubuntu-noble | Collecting pluggy>=1.5 (from tox) 2025-04-10 13:29:32.228602 | ubuntu-noble | Downloading pluggy-1.5.0-py3-none-any.whl.metadata (4.8 kB) 2025-04-10 13:29:32.290149 | ubuntu-noble | Collecting pyproject-api>=1.8 (from tox) 2025-04-10 13:29:32.307387 | ubuntu-noble | Downloading pyproject_api-1.9.0-py3-none-any.whl.metadata (2.7 kB) 2025-04-10 13:29:32.457273 | ubuntu-noble | Collecting virtualenv>=20.29.1 (from tox) 2025-04-10 13:29:32.470695 | ubuntu-noble | Downloading virtualenv-20.30.0-py3-none-any.whl.metadata (4.5 kB) 2025-04-10 13:29:32.696653 | ubuntu-noble | Collecting distlib<1,>=0.3.7 (from virtualenv>=20.29.1->tox) 2025-04-10 13:29:32.711600 | ubuntu-noble | Downloading distlib-0.3.9-py2.py3-none-any.whl.metadata (5.2 kB) 2025-04-10 13:29:32.768404 | ubuntu-noble | Downloading tox-4.25.0-py3-none-any.whl (172 kB) 2025-04-10 13:29:32.801166 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 172.4/172.4 kB 6.0 MB/s eta 0:00:00 2025-04-10 13:29:32.815770 | ubuntu-noble | Downloading cachetools-5.5.2-py3-none-any.whl (10 kB) 2025-04-10 13:29:32.837842 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2025-04-10 13:29:32.850889 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 18.8 MB/s eta 0:00:00 2025-04-10 13:29:32.867218 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2025-04-10 13:29:32.887022 | ubuntu-noble | Downloading filelock-3.18.0-py3-none-any.whl (16 kB) 2025-04-10 13:29:32.906732 | ubuntu-noble | Downloading packaging-24.2-py3-none-any.whl (65 kB) 2025-04-10 13:29:32.915501 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 65.5/65.5 kB 8.9 MB/s eta 0:00:00 2025-04-10 13:29:32.930796 | ubuntu-noble | Downloading platformdirs-4.3.7-py3-none-any.whl (18 kB) 2025-04-10 13:29:32.950570 | ubuntu-noble | Downloading pluggy-1.5.0-py3-none-any.whl (20 kB) 2025-04-10 13:29:32.972460 | ubuntu-noble | Downloading pyproject_api-1.9.0-py3-none-any.whl (13 kB) 2025-04-10 13:29:32.993491 | ubuntu-noble | Downloading virtualenv-20.30.0-py3-none-any.whl (4.3 MB) 2025-04-10 13:29:33.167747 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.3/4.3 MB 25.7 MB/s eta 0:00:00 2025-04-10 13:29:33.183046 | ubuntu-noble | Downloading distlib-0.3.9-py2.py3-none-any.whl (468 kB) 2025-04-10 13:29:33.211141 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 20.2 MB/s eta 0:00:00 2025-04-10 13:29:33.317876 | ubuntu-noble | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2025-04-10 13:29:34.190374 | 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-10 13:29:34.769707 | ubuntu-noble | ok: Runtime: 0:00:03.673457 2025-04-10 13:29:34.781081 | 2025-04-10 13:29:34.781239 | TASK [ensure-tox : Export installed tox_executable path] 2025-04-10 13:29:34.825653 | ubuntu-noble | ok 2025-04-10 13:29:34.839763 | 2025-04-10 13:29:34.839853 | TASK [ensure-tox : Output tox version] 2025-04-10 13:29:35.732542 | 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-10 13:29:35.765037 | ubuntu-noble | 4.25.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2025-04-10 13:29:35.894544 | ubuntu-noble | ok: Runtime: 0:00:00.608661 2025-04-10 13:29:35.901522 | 2025-04-10 13:29:35.901643 | TASK [ensure-tox : Make global symlink] 2025-04-10 13:29:35.936459 | ubuntu-noble | skipping: Conditional result was False 2025-04-10 13:29:35.973351 | 2025-04-10 13:29:35.973470 | PLAY RECAP 2025-04-10 13:29:35.973525 | ubuntu-noble | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-04-10 13:29:35.973550 | 2025-04-10 13:29:36.118772 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2025-04-10 13:29:36.122592 | RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/run.yaml@master] 2025-04-10 13:29:37.018324 | 2025-04-10 13:29:37.018472 | PLAY [all] 2025-04-10 13:29:37.047262 | 2025-04-10 13:29:37.047424 | TASK [revoke-sudo : Check if zuul is sudoer] 2025-04-10 13:29:38.101781 | ubuntu-noble | ok: Runtime: 0:00:00.023145 2025-04-10 13:29:38.109559 | 2025-04-10 13:29:38.109713 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2025-04-10 13:29:38.645931 | ubuntu-noble | ok: Runtime: 0:00:00.006299 2025-04-10 13:29:38.664796 | 2025-04-10 13:29:38.664941 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2025-04-10 13:29:38.964444 | ubuntu-noble | sudo: a password is required 2025-04-10 13:29:39.205203 | ubuntu-noble | ok: Runtime: 0:00:00.013261 2025-04-10 13:29:39.230714 | 2025-04-10 13:29:39.230849 | TASK [tox : Check to see if the constraints file exists] 2025-04-10 13:29:39.278146 | ubuntu-noble | skipping: Conditional result was False 2025-04-10 13:29:39.293687 | 2025-04-10 13:29:39.293837 | TASK [tox : Fail if constraints file is missing] 2025-04-10 13:29:39.340927 | ubuntu-noble | skipping: Conditional result was False 2025-04-10 13:29:39.357351 | 2025-04-10 13:29:39.357492 | TASK [tox : Record file location] 2025-04-10 13:29:39.393561 | ubuntu-noble | skipping: Conditional result was False 2025-04-10 13:29:39.406363 | 2025-04-10 13:29:39.406515 | TASK [tox : Install tox siblings] 2025-04-10 13:29:39.446723 | ubuntu-noble | ok 2025-04-10 13:29:39.461384 | ubuntu-noble | included: /var/lib/zuul/builds/b736767897214ad9b4447a0e6746cd3d/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/tox/tasks/siblings.yaml 2025-04-10 13:29:39.469420 | 2025-04-10 13:29:39.469528 | TASK [tox : Run tox without tests] 2025-04-10 13:29:40.495857 | ubuntu-noble | test: install_deps> python -I -m pip install -r requirements.txt 2025-04-10 13:29:55.547567 | ubuntu-noble | test: OK (15.37 seconds) 2025-04-10 13:29:55.595281 | ubuntu-noble | congratulations :) (15.46 seconds) 2025-04-10 13:29:56.034664 | ubuntu-noble | ok: Runtime: 0:00:15.731676 2025-04-10 13:29:56.049380 | 2025-04-10 13:29:56.049533 | TASK [tox : Create a tempfile to save tox showconfig] 2025-04-10 13:29:56.417099 | ubuntu-noble | changed 2025-04-10 13:29:56.425662 | 2025-04-10 13:29:56.425783 | TASK [tox : Get tox envlist config] 2025-04-10 13:29:57.462686 | ubuntu-noble | ok: Runtime: 0:00:00.324112 2025-04-10 13:29:57.477834 | 2025-04-10 13:29:57.477988 | TASK [tox : Install any sibling python packages] 2025-04-10 13:29:57.986048 | ubuntu-noble | ok: No setup.cfg, no action needed 2025-04-10 13:29:57.995772 | 2025-04-10 13:29:57.995886 | TASK [tox : Remove tempfile] 2025-04-10 13:29:58.442441 | ubuntu-noble | changed 2025-04-10 13:29:58.449877 | 2025-04-10 13:29:58.449965 | TASK [tox : Emit tox command] 2025-04-10 13:29:58.499780 | /home/zuul/.local/tox/bin/tox -etest -- test/unit 2025-04-10 13:29:58.505879 | 2025-04-10 13:29:58.505968 | TASK [tox : Run tox] 2025-04-10 13:29:59.317949 | ubuntu-noble | test: commands[0]> python -m unittest discover test/unit 2025-04-10 13:30:00.730608 | ubuntu-noble | ............... 2025-04-10 13:30:00.887469 | ubuntu-noble | ---------------------------------------------------------------------- 2025-04-10 13:30:00.887500 | ubuntu-noble | Ran 15 tests in 0.302s 2025-04-10 13:30:00.887506 | ubuntu-noble | 2025-04-10 13:30:00.887511 | ubuntu-noble | OK 2025-04-10 13:30:00.887520 | ubuntu-noble | test: OK (1.65=setup[0.08]+cmd[1.57] seconds) 2025-04-10 13:30:00.960673 | ubuntu-noble | congratulations :) (1.76 seconds) 2025-04-10 13:30:01.043576 | ubuntu-noble | ok: Runtime: 0:00:02.089464 2025-04-10 13:30:01.053125 | 2025-04-10 13:30:01.053266 | TASK [tox : Look for output] 2025-04-10 13:30:01.639528 | ubuntu-noble | ok 2025-04-10 13:30:01.648932 | 2025-04-10 13:30:01.649091 | TASK [tox : Return file comments to Zuul] 2025-04-10 13:30:01.695482 | ubuntu-noble | skipping: Conditional result was False 2025-04-10 13:30:01.726825 | 2025-04-10 13:30:01.726919 | PLAY RECAP 2025-04-10 13:30:01.726975 | ubuntu-noble | ok: 12 changed: 8 unreachable: 0 failed: 0 skipped: 4 rescued: 0 ignored: 0 2025-04-10 13:30:01.727000 | 2025-04-10 13:30:01.845319 | RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/run.yaml@master] 2025-04-10 13:30:01.858783 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2025-04-10 13:30:02.575282 | 2025-04-10 13:30:02.575447 | PLAY [all] 2025-04-10 13:30:02.603538 | 2025-04-10 13:30:02.603693 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2025-04-10 13:30:02.680303 | ubuntu-noble | skipping: Conditional result was False 2025-04-10 13:30:02.687790 | 2025-04-10 13:30:02.687935 | TASK [fetch-tox-output : Set tox log path for single node] 2025-04-10 13:30:02.728764 | ubuntu-noble | ok 2025-04-10 13:30:02.744802 | 2025-04-10 13:30:02.744929 | TASK [fetch-tox-output : Ensure local tox dir] 2025-04-10 13:30:03.270267 | ubuntu-noble -> localhost | changed 2025-04-10 13:30:03.283667 | 2025-04-10 13:30:03.283828 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2025-04-10 13:30:03.340357 | ubuntu-noble | skipping: Conditional result was False 2025-04-10 13:30:03.355019 | 2025-04-10 13:30:03.355249 | TASK [fetch-tox-output : Set envlist fact] 2025-04-10 13:30:03.415939 | ubuntu-noble | ok 2025-04-10 13:30:03.424913 | 2025-04-10 13:30:03.425020 | TASK [fetch-tox-output : Get tox version] 2025-04-10 13:30:04.424200 | 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-10 13:30:04.455746 | ubuntu-noble | 4.25.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2025-04-10 13:30:04.965328 | ubuntu-noble | ok: Runtime: 0:00:00.513856 2025-04-10 13:30:04.973371 | 2025-04-10 13:30:04.973541 | TASK [fetch-tox-output : Find all default environments] 2025-04-10 13:30:05.058353 | ubuntu-noble | skipping: Conditional result was False 2025-04-10 13:30:05.068177 | 2025-04-10 13:30:05.068284 | TASK [fetch-tox-output : Set envlist fact] 2025-04-10 13:30:05.103104 | ubuntu-noble | skipping: Conditional result was False 2025-04-10 13:30:05.112403 | 2025-04-10 13:30:05.112509 | TASK [fetch-tox-output : Find all default environments] 2025-04-10 13:30:05.231767 | ubuntu-noble | skipping: Conditional result was False 2025-04-10 13:30:05.240745 | 2025-04-10 13:30:05.240841 | TASK [fetch-tox-output : Set envlist fact] 2025-04-10 13:30:05.288301 | ubuntu-noble | skipping: Conditional result was False 2025-04-10 13:30:05.295858 | 2025-04-10 13:30:05.295962 | LOOP [fetch-tox-output : Copy tox logs] 2025-04-10 13:30:05.347048 | ubuntu-noble | skipping: Conditional result was False 2025-04-10 13:30:05.358521 | 2025-04-10 13:30:05.358652 | LOOP [fetch-tox-output : Collect tox logs] 2025-04-10 13:30:06.217039 | ubuntu-noble | changed: 2025-04-10 13:30:06.217351 | ubuntu-noble | cd+++++++++ ./ 2025-04-10 13:30:06.217406 | ubuntu-noble | >f+++++++++ 1-commands[0].log 2025-04-10 13:30:06.217454 | 2025-04-10 13:30:06.251475 | 2025-04-10 13:30:06.251600 | PLAY RECAP 2025-04-10 13:30:06.251663 | ubuntu-noble | ok: 5 changed: 3 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2025-04-10 13:30:06.251694 | 2025-04-10 13:30:06.388359 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2025-04-10 13:30:06.395948 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2025-04-10 13:30:07.130706 | 2025-04-10 13:30:07.130880 | PLAY [all] 2025-04-10 13:30:07.161646 | 2025-04-10 13:30:07.161835 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-04-10 13:30:07.326434 | ubuntu-noble | changed: non-zero return code 2025-04-10 13:30:07.333620 | 2025-04-10 13:30:07.333761 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2025-04-10 13:30:07.358667 | ubuntu-noble | skipping: Conditional result was False 2025-04-10 13:30:07.367205 | 2025-04-10 13:30:07.367328 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2025-04-10 13:30:07.399704 | 2025-04-10 13:30:07.399898 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2025-04-10 13:30:07.448276 | 2025-04-10 13:30:07.448499 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2025-04-10 13:30:07.473103 | ubuntu-noble | skipping: Conditional result was False 2025-04-10 13:30:07.480860 | 2025-04-10 13:30:07.480997 | LOOP [fetch-subunit-output : Generate subunit file] 2025-04-10 13:30:07.513296 | 2025-04-10 13:30:07.513512 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2025-04-10 13:30:07.538293 | ubuntu-noble | skipping: Conditional result was False 2025-04-10 13:30:07.545870 | 2025-04-10 13:30:07.545988 | TASK [fetch-subunit-output : Remove the temporary file] 2025-04-10 13:30:07.570532 | ubuntu-noble | skipping: Conditional result was False 2025-04-10 13:30:07.577730 | 2025-04-10 13:30:07.577846 | TASK [fetch-subunit-output : Process and fetch subunit results] 2025-04-10 13:30:07.602169 | ubuntu-noble | skipping: Conditional result was False 2025-04-10 13:30:07.637194 | 2025-04-10 13:30:07.637304 | PLAY RECAP 2025-04-10 13:30:07.637359 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-04-10 13:30:07.637386 | 2025-04-10 13:30:07.760626 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2025-04-10 13:30:07.764347 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-04-10 13:30:08.504272 | 2025-04-10 13:30:08.504486 | PLAY [Base post] 2025-04-10 13:30:08.530549 | 2025-04-10 13:30:08.530671 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2025-04-10 13:30:09.095459 | ubuntu-noble | changed 2025-04-10 13:30:09.126654 | 2025-04-10 13:30:09.126783 | PLAY RECAP 2025-04-10 13:30:09.126851 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-04-10 13:30:09.126912 | 2025-04-10 13:30:09.249090 | POST-RUN END RESULT_NORMAL: [trusted : github.com/osism/zuul-config/playbooks/base/post.yaml@main] 2025-04-10 13:30:09.255775 | POST-RUN START: [trusted : github.com/osism/zuul-config/playbooks/base/post-logs.yaml@main] 2025-04-10 13:30:10.040120 | 2025-04-10 13:30:10.040302 | PLAY [Base post-logs] 2025-04-10 13:30:10.057337 | 2025-04-10 13:30:10.057476 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-04-10 13:30:10.525502 | localhost | changed 2025-04-10 13:30:10.529555 | 2025-04-10 13:30:10.529699 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-04-10 13:30:10.564016 | localhost | ok 2025-04-10 13:30:10.570179 | 2025-04-10 13:30:10.570287 | TASK [Set zuul-log-path fact] 2025-04-10 13:30:10.587768 | localhost | ok 2025-04-10 13:30:10.599191 | 2025-04-10 13:30:10.599355 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-04-10 13:30:10.626816 | localhost | ok 2025-04-10 13:30:10.632873 | 2025-04-10 13:30:10.633020 | TASK [upload-logs : Create log directories] 2025-04-10 13:30:11.127252 | localhost | changed 2025-04-10 13:30:11.131648 | 2025-04-10 13:30:11.131761 | TASK [upload-logs : Ensure logs are readable before uploading] 2025-04-10 13:30:11.636729 | localhost -> localhost | ok: Runtime: 0:00:00.006285 2025-04-10 13:30:11.642624 | 2025-04-10 13:30:11.642746 | TASK [upload-logs : Upload logs to log server] 2025-04-10 13:30:12.225174 | localhost | Output suppressed because no_log was given 2025-04-10 13:30:12.230165 | 2025-04-10 13:30:12.230336 | LOOP [upload-logs : Compress console log and json output] 2025-04-10 13:30:12.309679 | localhost | skipping: Conditional result was False 2025-04-10 13:30:12.326975 | localhost | skipping: Conditional result was False 2025-04-10 13:30:12.340017 | 2025-04-10 13:30:12.340309 | LOOP [upload-logs : Upload compressed console log and json output] 2025-04-10 13:30:12.419918 | localhost | skipping: Conditional result was False 2025-04-10 13:30:12.420285 | 2025-04-10 13:30:12.435200 | localhost | skipping: Conditional result was False 2025-04-10 13:30:12.446662 | 2025-04-10 13:30:12.446775 | LOOP [upload-logs : Upload console log and json output]