2026-02-16 19:19:11.461671 | Job console starting 2026-02-16 19:19:11.473105 | Updating git repos 2026-02-16 19:19:11.519451 | Cloning repos into workspace 2026-02-16 19:19:11.579578 | Restoring repo states 2026-02-16 19:19:11.597977 | Merging changes 2026-02-16 19:19:12.061016 | Checking out repos 2026-02-16 19:19:12.137874 | Preparing playbooks 2026-02-16 19:19:13.278204 | Running Ansible setup 2026-02-16 19:19:18.420801 | PRE-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main] 2026-02-16 19:19:19.041593 | 2026-02-16 19:19:19.041763 | PLAY [localhost] 2026-02-16 19:19:19.051406 | 2026-02-16 19:19:19.051537 | TASK [Gathering Facts] 2026-02-16 19:19:19.959085 | localhost | ok 2026-02-16 19:19:19.969908 | 2026-02-16 19:19:19.970143 | TASK [Setup log path fact] 2026-02-16 19:19:19.992354 | localhost | ok 2026-02-16 19:19:20.004138 | 2026-02-16 19:19:20.004291 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-16 19:19:20.034547 | localhost | ok 2026-02-16 19:19:20.043321 | 2026-02-16 19:19:20.043438 | TASK [emit-job-header : Print job information] 2026-02-16 19:19:20.085643 | # Job Information 2026-02-16 19:19:20.085883 | Ansible Version: 2.16.15 2026-02-16 19:19:20.085928 | Job: magnum-cluster-api-tox-functional 2026-02-16 19:19:20.085959 | Pipeline: check 2026-02-16 19:19:20.085987 | Executor: 3a2793d2bd32 2026-02-16 19:19:20.086014 | Triggered by: https://github.com/vexxhost/magnum-cluster-api/pull/884 2026-02-16 19:19:20.086046 | Event ID: 036266b0-0b6c-11f1-9c94-e50e60db5a7d 2026-02-16 19:19:20.090127 | 2026-02-16 19:19:20.090206 | LOOP [emit-job-header : Print node information] 2026-02-16 19:19:20.209799 | localhost | ok: 2026-02-16 19:19:20.210703 | localhost | # Node Information 2026-02-16 19:19:20.210801 | localhost | Inventory Hostname: ubuntu-noble 2026-02-16 19:19:20.210856 | localhost | Hostname: np0000155680 2026-02-16 19:19:20.210902 | localhost | Username: zuul 2026-02-16 19:19:20.210951 | localhost | Distro: Ubuntu 24.04 2026-02-16 19:19:20.210994 | localhost | Provider: yul1 2026-02-16 19:19:20.211036 | localhost | Region: ca-ymq-1 2026-02-16 19:19:20.211076 | localhost | Label: ubuntu-noble 2026-02-16 19:19:20.211116 | localhost | Product Name: OpenStack Nova 2026-02-16 19:19:20.211203 | localhost | Interface IP: 199.204.45.238 2026-02-16 19:19:20.229402 | 2026-02-16 19:19:20.229497 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-16 19:19:20.640557 | localhost -> localhost | changed 2026-02-16 19:19:20.649983 | 2026-02-16 19:19:20.650261 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-16 19:19:21.582086 | localhost -> localhost | changed 2026-02-16 19:19:21.591408 | 2026-02-16 19:19:21.591552 | PLAY [all] 2026-02-16 19:19:21.604213 | 2026-02-16 19:19:21.604328 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-16 19:19:21.834262 | ubuntu-noble -> localhost | ok 2026-02-16 19:19:21.844369 | 2026-02-16 19:19:21.844488 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-16 19:19:21.866986 | ubuntu-noble | ok 2026-02-16 19:19:21.883205 | ubuntu-noble | included: /var/lib/zuul/builds/52ee9d8aa3a346429929c11393f7cd3c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-16 19:19:21.890080 | 2026-02-16 19:19:21.890188 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-16 19:19:23.316276 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2026-02-16 19:19:23.316547 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/52ee9d8aa3a346429929c11393f7cd3c/work/52ee9d8aa3a346429929c11393f7cd3c_id_rsa 2026-02-16 19:19:23.316605 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/52ee9d8aa3a346429929c11393f7cd3c/work/52ee9d8aa3a346429929c11393f7cd3c_id_rsa.pub 2026-02-16 19:19:23.316642 | ubuntu-noble -> localhost | The key fingerprint is: 2026-02-16 19:19:23.316675 | ubuntu-noble -> localhost | SHA256:qXYjg0+abX+DCtaSH1sw8engCysCCmmzLcONO/fWC24 zuul-build-sshkey 2026-02-16 19:19:23.316730 | ubuntu-noble -> localhost | The key's randomart image is: 2026-02-16 19:19:23.316761 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2026-02-16 19:19:23.316800 | ubuntu-noble -> localhost | | | 2026-02-16 19:19:23.316833 | ubuntu-noble -> localhost | | | 2026-02-16 19:19:23.316908 | ubuntu-noble -> localhost | | . | 2026-02-16 19:19:23.316943 | ubuntu-noble -> localhost | | o o | 2026-02-16 19:19:23.317007 | ubuntu-noble -> localhost | | . + S | 2026-02-16 19:19:23.317038 | ubuntu-noble -> localhost | |+o = * | 2026-02-16 19:19:23.317067 | ubuntu-noble -> localhost | |* * B.@ =. | 2026-02-16 19:19:23.317096 | ubuntu-noble -> localhost | |oB.=.EoX..o | 2026-02-16 19:19:23.317129 | ubuntu-noble -> localhost | | o*.B+B+o. . | 2026-02-16 19:19:23.317158 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2026-02-16 19:19:23.317244 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.957219 2026-02-16 19:19:23.325271 | 2026-02-16 19:19:23.325373 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-16 19:19:23.360478 | ubuntu-noble | ok 2026-02-16 19:19:23.372060 | ubuntu-noble | included: /var/lib/zuul/builds/52ee9d8aa3a346429929c11393f7cd3c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-16 19:19:23.380753 | 2026-02-16 19:19:23.380857 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-16 19:19:23.406384 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:23.417649 | 2026-02-16 19:19:23.417881 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-16 19:19:24.113196 | ubuntu-noble | changed 2026-02-16 19:19:24.118942 | 2026-02-16 19:19:24.119028 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-16 19:19:24.358161 | ubuntu-noble | ok 2026-02-16 19:19:24.363902 | 2026-02-16 19:19:24.364001 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-16 19:19:24.934515 | ubuntu-noble | changed 2026-02-16 19:19:24.941925 | 2026-02-16 19:19:24.942009 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-16 19:19:25.486254 | ubuntu-noble | changed 2026-02-16 19:19:25.493862 | 2026-02-16 19:19:25.493937 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-16 19:19:25.518443 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:25.528776 | 2026-02-16 19:19:25.529030 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-16 19:19:25.932270 | ubuntu-noble -> localhost | changed 2026-02-16 19:19:25.947279 | 2026-02-16 19:19:25.947356 | TASK [add-build-sshkey : Add back temp key] 2026-02-16 19:19:26.226034 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/52ee9d8aa3a346429929c11393f7cd3c/work/52ee9d8aa3a346429929c11393f7cd3c_id_rsa (zuul-build-sshkey) 2026-02-16 19:19:26.226297 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.013347 2026-02-16 19:19:26.236590 | 2026-02-16 19:19:26.236729 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-16 19:19:26.619038 | ubuntu-noble | ok 2026-02-16 19:19:26.625032 | 2026-02-16 19:19:26.625109 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-16 19:19:26.649242 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:26.665038 | 2026-02-16 19:19:26.665188 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-02-16 19:19:27.065864 | ubuntu-noble | ok 2026-02-16 19:19:27.076012 | 2026-02-16 19:19:27.076108 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-02-16 19:19:28.166044 | ubuntu-noble | Output suppressed because no_log was given 2026-02-16 19:19:28.175839 | 2026-02-16 19:19:28.175956 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-02-16 19:19:28.406918 | ubuntu-noble | ok: "logs" 2026-02-16 19:19:28.407237 | ubuntu-noble | ok: All items complete 2026-02-16 19:19:28.407294 | 2026-02-16 19:19:28.647873 | ubuntu-noble | ok: "artifacts" 2026-02-16 19:19:28.798618 | ubuntu-noble | ok: "docs" 2026-02-16 19:19:28.812609 | 2026-02-16 19:19:28.812811 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-02-16 19:19:29.040397 | ubuntu-noble | changed: "logs" 2026-02-16 19:19:29.229525 | ubuntu-noble | changed: "artifacts" 2026-02-16 19:19:29.420946 | ubuntu-noble | changed: "docs" 2026-02-16 19:19:29.443425 | 2026-02-16 19:19:29.443642 | PLAY RECAP 2026-02-16 19:19:29.443747 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-16 19:19:29.443819 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-02-16 19:19:29.443869 | 2026-02-16 19:19:29.634820 | PRE-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main] 2026-02-16 19:19:29.637833 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-16 19:19:30.248918 | 2026-02-16 19:19:30.249121 | PLAY [all] 2026-02-16 19:19:30.263272 | 2026-02-16 19:19:30.263455 | TASK [Install binary dependencies] 2026-02-16 19:19:30.314473 | ubuntu-noble | ok 2026-02-16 19:19:30.334365 | 2026-02-16 19:19:30.334558 | TASK [bindep : Include find tasks] 2026-02-16 19:19:30.368816 | ubuntu-noble | ok 2026-02-16 19:19:30.376757 | ubuntu-noble | included: /var/lib/zuul/builds/52ee9d8aa3a346429929c11393f7cd3c/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-02-16 19:19:30.382992 | 2026-02-16 19:19:30.383062 | TASK [bindep : Look for bindep.txt] 2026-02-16 19:19:30.761977 | ubuntu-noble | ok 2026-02-16 19:19:30.770567 | 2026-02-16 19:19:30.770680 | TASK [bindep : Define bindep_file fact] 2026-02-16 19:19:30.786943 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:30.795889 | 2026-02-16 19:19:30.796091 | TASK [bindep : Look for other-requirements.txt] 2026-02-16 19:19:31.021508 | ubuntu-noble | ok 2026-02-16 19:19:31.026810 | 2026-02-16 19:19:31.026901 | TASK [bindep : Define bindep_file fact] 2026-02-16 19:19:31.060756 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:31.070486 | 2026-02-16 19:19:31.070567 | TASK [bindep : Look for bindep fallback file] 2026-02-16 19:19:31.097343 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:31.110405 | 2026-02-16 19:19:31.110586 | TASK [bindep : Define bindep_file fact] 2026-02-16 19:19:31.146819 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:31.158464 | 2026-02-16 19:19:31.158551 | TASK [bindep : Include bindep tasks] 2026-02-16 19:19:31.185799 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:31.194061 | 2026-02-16 19:19:31.194147 | TASK [bindep : Include install tasks] 2026-02-16 19:19:31.218835 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:31.230664 | 2026-02-16 19:19:31.230735 | LOOP [bindep : Include package tasks] 2026-02-16 19:19:31.290553 | 2026-02-16 19:19:31.290731 | TASK [Run test-setup role] 2026-02-16 19:19:31.315578 | ubuntu-noble | ok 2026-02-16 19:19:31.335231 | 2026-02-16 19:19:31.335306 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-02-16 19:19:31.541304 | ubuntu-noble | ok 2026-02-16 19:19:31.549662 | 2026-02-16 19:19:31.549825 | TASK [test-setup : Run tools/test-setup.sh] 2026-02-16 19:19:32.089993 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:32.103834 | 2026-02-16 19:19:32.103906 | PLAY RECAP 2026-02-16 19:19:32.103964 | ubuntu-noble | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-16 19:19:32.103992 | 2026-02-16 19:19:32.262912 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-16 19:19:32.266128 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2026-02-16 19:19:32.892090 | 2026-02-16 19:19:32.892274 | PLAY [all] 2026-02-16 19:19:32.908827 | 2026-02-16 19:19:32.909105 | TASK [ensure-python : Validate python_version value] 2026-02-16 19:19:32.935251 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:32.946950 | 2026-02-16 19:19:32.947145 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)] 2026-02-16 19:19:32.974277 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:32.985292 | 2026-02-16 19:19:32.985527 | TASK [ensure-python : Pull in venv package] 2026-02-16 19:19:33.011525 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:33.021823 | 2026-02-16 19:19:33.022019 | TASK [ensure-python : Set default RPM package name] 2026-02-16 19:19:33.048252 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:33.059382 | 2026-02-16 19:19:33.059596 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9/10] 2026-02-16 19:19:33.085629 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:33.095372 | 2026-02-16 19:19:33.095486 | TASK [ensure-python : Install RPM package] 2026-02-16 19:19:33.121570 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:33.132433 | 2026-02-16 19:19:33.132519 | TASK [ensure-python : Install python using pyenv] 2026-02-16 19:19:33.158475 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:33.168492 | 2026-02-16 19:19:33.168563 | TASK [ensure-python : Activate python using stow] 2026-02-16 19:19:33.193826 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:33.210995 | 2026-02-16 19:19:33.211171 | TASK [Install pip] 2026-02-16 19:19:33.232327 | ubuntu-noble | ok 2026-02-16 19:19:33.256241 | 2026-02-16 19:19:33.256326 | TASK [ensure-pip : Check if pip is installed] 2026-02-16 19:19:33.811376 | ubuntu-noble | ok: Runtime: 0:00:00.016726 2026-02-16 19:19:33.817992 | 2026-02-16 19:19:33.818089 | LOOP [ensure-pip : Install pip from packages] 2026-02-16 19:19:33.852951 | ubuntu-noble | ok: "/var/lib/zuul/builds/52ee9d8aa3a346429929c11393f7cd3c/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/Debian.yaml" 2026-02-16 19:19:33.867699 | ubuntu-noble | included: /var/lib/zuul/builds/52ee9d8aa3a346429929c11393f7cd3c/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/Debian.yaml 2026-02-16 19:19:33.877653 | 2026-02-16 19:19:33.877718 | TASK [ensure-pip : Update package lists] 2026-02-16 19:19:40.104114 | ubuntu-noble | changed 2026-02-16 19:19:40.112674 | 2026-02-16 19:19:40.112805 | TASK [ensure-pip : Install Python 3 pip] 2026-02-16 19:19:48.325232 | ubuntu-noble | changed 2026-02-16 19:19:48.334908 | 2026-02-16 19:19:48.335034 | TASK [ensure-pip : Install Python 2 pip] 2026-02-16 19:19:48.374982 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:48.382317 | 2026-02-16 19:19:48.382407 | TASK [ensure-pip : Ensure setuptools] 2026-02-16 19:19:48.408145 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:48.420932 | 2026-02-16 19:19:48.421144 | TASK [ensure-pip : Check for ensurepip module] 2026-02-16 19:19:48.607818 | ubuntu-noble | usage: python -m ensurepip [-h] [--version] [-v] [-U] [--user] [--root ROOT] 2026-02-16 19:19:48.607901 | ubuntu-noble | [--altinstall] [--default-pip] 2026-02-16 19:19:48.607915 | ubuntu-noble | 2026-02-16 19:19:48.607926 | ubuntu-noble | options: 2026-02-16 19:19:48.607936 | ubuntu-noble | -h, --help show this help message and exit 2026-02-16 19:19:48.607950 | ubuntu-noble | --version Show the version of pip that is bundled with this Python. 2026-02-16 19:19:48.607962 | ubuntu-noble | -v, --verbose Give more output. Option is additive, and can be used up to 3 2026-02-16 19:19:48.607976 | ubuntu-noble | times. 2026-02-16 19:19:48.607985 | ubuntu-noble | -U, --upgrade Upgrade pip and dependencies, even if already installed. 2026-02-16 19:19:48.608017 | ubuntu-noble | --user Install using the user scheme. 2026-02-16 19:19:48.608042 | ubuntu-noble | --root ROOT Install everything relative to this alternate root directory. 2026-02-16 19:19:48.608051 | ubuntu-noble | --altinstall Make an alternate install, installing only the X.Y versioned 2026-02-16 19:19:48.608060 | ubuntu-noble | scripts (Default: pipX, pipX.Y). 2026-02-16 19:19:48.608068 | ubuntu-noble | --default-pip Make a default pip install, installing the unqualified pip in 2026-02-16 19:19:48.608077 | ubuntu-noble | addition to the versioned scripts. 2026-02-16 19:19:48.955601 | ubuntu-noble | ok: Runtime: 0:00:00.068870 2026-02-16 19:19:48.962851 | 2026-02-16 19:19:48.963028 | TASK [ensure-pip : Ensure python3-venv] 2026-02-16 19:19:48.988668 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:49.000260 | 2026-02-16 19:19:49.000577 | TASK [ensure-pip : Install pip from source] 2026-02-16 19:19:49.027774 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:49.092832 | 2026-02-16 19:19:49.093007 | TASK [ensure-pip : Probe for venv python full path] 2026-02-16 19:19:49.235193 | ubuntu-noble | /usr/bin/python3 2026-02-16 19:19:49.628272 | ubuntu-noble | ok: Runtime: 0:00:00.004815 2026-02-16 19:19:49.635950 | 2026-02-16 19:19:49.636014 | TASK [ensure-pip : Set host default] 2026-02-16 19:19:49.690931 | ubuntu-noble | ok 2026-02-16 19:19:49.697252 | 2026-02-16 19:19:49.697327 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2026-02-16 19:19:49.756208 | ubuntu-noble | ok 2026-02-16 19:19:49.766105 | 2026-02-16 19:19:49.766177 | TASK [ensure-tox : Check if tox is installed] 2026-02-16 19:19:50.306396 | ubuntu-noble | ok: Runtime: 0:00:00.008742 2026-02-16 19:19:50.313196 | 2026-02-16 19:19:50.313280 | TASK [ensure-tox : Export preinstalled tox_exectuable] 2026-02-16 19:19:50.338953 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:50.350609 | 2026-02-16 19:19:50.350710 | TASK [ensure-tox : Create local venv] 2026-02-16 19:19:53.863147 | ubuntu-noble | ok: Runtime: 0:00:03.216587 2026-02-16 19:19:53.869850 | 2026-02-16 19:19:53.869964 | TASK [ensure-tox : Install tox to local venv] 2026-02-16 19:19:54.580747 | ubuntu-noble | Collecting tox 2026-02-16 19:19:54.629840 | ubuntu-noble | Downloading tox-4.36.0-py3-none-any.whl.metadata (3.6 kB) 2026-02-16 19:19:55.046456 | ubuntu-noble | Collecting cachetools>=7.0.1 (from tox) 2026-02-16 19:19:55.051836 | ubuntu-noble | Downloading cachetools-7.0.1-py3-none-any.whl.metadata (5.6 kB) 2026-02-16 19:19:55.089415 | ubuntu-noble | Collecting chardet>=5.2 (from tox) 2026-02-16 19:19:55.094055 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl.metadata (3.4 kB) 2026-02-16 19:19:55.134497 | ubuntu-noble | Collecting colorama>=0.4.6 (from tox) 2026-02-16 19:19:55.138344 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2026-02-16 19:19:55.207414 | ubuntu-noble | Collecting filelock>=3.24 (from tox) 2026-02-16 19:19:55.211313 | ubuntu-noble | Downloading filelock-3.24.2-py3-none-any.whl.metadata (2.0 kB) 2026-02-16 19:19:55.260511 | ubuntu-noble | Collecting packaging>=26 (from tox) 2026-02-16 19:19:55.264122 | ubuntu-noble | Downloading packaging-26.0-py3-none-any.whl.metadata (3.3 kB) 2026-02-16 19:19:55.318333 | ubuntu-noble | Collecting platformdirs>=4.9.1 (from tox) 2026-02-16 19:19:55.322757 | ubuntu-noble | Downloading platformdirs-4.9.2-py3-none-any.whl.metadata (4.7 kB) 2026-02-16 19:19:55.367484 | ubuntu-noble | Collecting pluggy>=1.6 (from tox) 2026-02-16 19:19:55.370984 | ubuntu-noble | Downloading pluggy-1.6.0-py3-none-any.whl.metadata (4.8 kB) 2026-02-16 19:19:55.415038 | ubuntu-noble | Collecting pyproject-api>=1.10 (from tox) 2026-02-16 19:19:55.421436 | ubuntu-noble | Downloading pyproject_api-1.10.0-py3-none-any.whl.metadata (2.7 kB) 2026-02-16 19:19:55.550813 | ubuntu-noble | Collecting virtualenv>=20.36.1 (from tox) 2026-02-16 19:19:55.555860 | ubuntu-noble | Downloading virtualenv-20.37.0-py3-none-any.whl.metadata (5.1 kB) 2026-02-16 19:19:55.682574 | ubuntu-noble | Collecting distlib<1,>=0.3.7 (from virtualenv>=20.36.1->tox) 2026-02-16 19:19:55.686920 | ubuntu-noble | Downloading distlib-0.4.0-py2.py3-none-any.whl.metadata (5.2 kB) 2026-02-16 19:19:55.727458 | ubuntu-noble | Downloading tox-4.36.0-py3-none-any.whl (179 kB) 2026-02-16 19:19:55.755045 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 179.1/179.1 kB 7.7 MB/s eta 0:00:00 2026-02-16 19:19:55.758704 | ubuntu-noble | Downloading cachetools-7.0.1-py3-none-any.whl (13 kB) 2026-02-16 19:19:55.772084 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2026-02-16 19:19:55.790328 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 13.7 MB/s eta 0:00:00 2026-02-16 19:19:55.794895 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-02-16 19:19:55.810748 | ubuntu-noble | Downloading filelock-3.24.2-py3-none-any.whl (24 kB) 2026-02-16 19:19:55.823771 | ubuntu-noble | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-02-16 19:19:55.835135 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 7.3 MB/s eta 0:00:00 2026-02-16 19:19:55.839565 | ubuntu-noble | Downloading platformdirs-4.9.2-py3-none-any.whl (21 kB) 2026-02-16 19:19:55.853569 | ubuntu-noble | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-02-16 19:19:55.870098 | ubuntu-noble | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-02-16 19:19:55.884833 | ubuntu-noble | Downloading virtualenv-20.37.0-py3-none-any.whl (5.8 MB) 2026-02-16 19:19:56.016511 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.8/5.8 MB 46.4 MB/s eta 0:00:00 2026-02-16 19:19:56.026765 | ubuntu-noble | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-02-16 19:19:56.049091 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 25.7 MB/s eta 0:00:00 2026-02-16 19:19:56.122315 | ubuntu-noble | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2026-02-16 19:19:56.972443 | ubuntu-noble | Successfully installed cachetools-7.0.1 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.24.2 packaging-26.0 platformdirs-4.9.2 pluggy-1.6.0 pyproject-api-1.10.0 tox-4.36.0 virtualenv-20.37.0 2026-02-16 19:19:57.396179 | ubuntu-noble | ok: Runtime: 0:00:03.032083 2026-02-16 19:19:57.403844 | 2026-02-16 19:19:57.403915 | TASK [ensure-tox : Export installed tox_executable path] 2026-02-16 19:19:57.440209 | ubuntu-noble | ok 2026-02-16 19:19:57.445620 | 2026-02-16 19:19:57.445695 | TASK [ensure-tox : Output tox version] 2026-02-16 19:19:57.863399 | ubuntu-noble | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2026-02-16 19:19:57.877790 | ubuntu-noble | 4.36.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2026-02-16 19:19:57.985646 | ubuntu-noble | ok: Runtime: 0:00:00.274539 2026-02-16 19:19:57.990957 | 2026-02-16 19:19:57.991031 | TASK [ensure-tox : Make global symlink] 2026-02-16 19:19:58.016134 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:58.026963 | 2026-02-16 19:19:58.027137 | PLAY RECAP 2026-02-16 19:19:58.027219 | ubuntu-noble | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-02-16 19:19:58.027261 | 2026-02-16 19:19:58.205034 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2026-02-16 19:19:58.206838 | PRE-RUN START: [untrusted : github.com/vexxhost/magnum-cluster-api/zuul.d/playbooks/tox/pre.yml@main] 2026-02-16 19:19:58.847149 | 2026-02-16 19:19:58.847350 | PLAY [all] 2026-02-16 19:19:58.871745 | 2026-02-16 19:19:58.872018 | TASK [ensure-rust : Use rustup] 2026-02-16 19:19:58.893436 | ubuntu-noble | ok 2026-02-16 19:19:58.900778 | ubuntu-noble | included: /var/lib/zuul/builds/52ee9d8aa3a346429929c11393f7cd3c/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-rust/tasks/rustup.yaml 2026-02-16 19:19:58.906980 | 2026-02-16 19:19:58.907063 | TASK [ensure-rust : Install Rust] 2026-02-16 19:19:59.295467 | ubuntu-noble | /bin/bash: line 2: curl: command not found 2026-02-16 19:19:59.446010 | ubuntu-noble | ERROR 2026-02-16 19:19:59.446293 | ubuntu-noble | { 2026-02-16 19:19:59.446339 | ubuntu-noble | "delta": "0:00:00.009840", 2026-02-16 19:19:59.446374 | ubuntu-noble | "end": "2026-02-16 19:19:59.297117", 2026-02-16 19:19:59.446404 | ubuntu-noble | "msg": "non-zero return code", 2026-02-16 19:19:59.446433 | ubuntu-noble | "rc": 127, 2026-02-16 19:19:59.446460 | ubuntu-noble | "start": "2026-02-16 19:19:59.287277" 2026-02-16 19:19:59.446492 | ubuntu-noble | } failure 2026-02-16 19:19:59.448690 | 2026-02-16 19:19:59.448769 | PLAY RECAP 2026-02-16 19:19:59.448831 | ubuntu-noble | ok: 1 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-02-16 19:19:59.448863 | 2026-02-16 19:19:59.623515 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/magnum-cluster-api/zuul.d/playbooks/tox/pre.yml@main] 2026-02-16 19:19:59.624999 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2026-02-16 19:20:00.277662 | 2026-02-16 19:20:00.277819 | PLAY [all] 2026-02-16 19:20:00.290236 | 2026-02-16 19:20:00.290323 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-02-16 19:20:00.336161 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:00.346764 | 2026-02-16 19:20:00.346878 | TASK [fetch-tox-output : Set tox log path for single node] 2026-02-16 19:20:00.392517 | ubuntu-noble | ok 2026-02-16 19:20:00.399819 | 2026-02-16 19:20:00.399905 | TASK [fetch-tox-output : Ensure local tox dir] 2026-02-16 19:20:00.799839 | ubuntu-noble -> localhost | changed 2026-02-16 19:20:00.811074 | 2026-02-16 19:20:00.811231 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-02-16 19:20:00.859643 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:00.870100 | 2026-02-16 19:20:00.870212 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 19:20:00.914919 | ubuntu-noble | ok 2026-02-16 19:20:00.922286 | 2026-02-16 19:20:00.922353 | TASK [fetch-tox-output : Get tox version] 2026-02-16 19:20:01.470051 | ubuntu-noble | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2026-02-16 19:20:01.484230 | ubuntu-noble | 4.36.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2026-02-16 19:20:01.961433 | ubuntu-noble | ok: Runtime: 0:00:00.262587 2026-02-16 19:20:01.967100 | 2026-02-16 19:20:01.967178 | TASK [fetch-tox-output : Find all default environments] 2026-02-16 19:20:02.498925 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:02.510041 | 2026-02-16 19:20:02.510209 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 19:20:02.535412 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:02.546184 | 2026-02-16 19:20:02.546353 | TASK [fetch-tox-output : Find all default environments] 2026-02-16 19:20:03.078436 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:03.091420 | 2026-02-16 19:20:03.091632 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 19:20:03.116829 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:03.125702 | 2026-02-16 19:20:03.125787 | LOOP [fetch-tox-output : Copy tox logs] 2026-02-16 19:20:03.163069 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:03.184409 | 2026-02-16 19:20:03.184579 | LOOP [fetch-tox-output : Collect tox logs] 2026-02-16 19:20:03.949402 | ubuntu-noble | ok: 2026-02-16 19:20:03.949602 | ubuntu-noble | rsync: [sender] change_dir "/home/zuul/src/github.com/vexxhost/magnum-cluster-api/.tox/functional/log" failed: No such file or directory (2) 2026-02-16 19:20:03.949650 | ubuntu-noble | rsync error: some files/attrs were not transferred (see previous errors) (code 23) at main.c(1865) [Receiver=3.2.7] 2026-02-16 19:20:03.949676 | ubuntu-noble | rsync: [Receiver] write error: Broken pipe (32) 2026-02-16 19:20:03.949709 | 2026-02-16 19:20:03.970100 | 2026-02-16 19:20:03.970221 | PLAY RECAP 2026-02-16 19:20:03.970271 | ubuntu-noble | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-02-16 19:20:03.970295 | 2026-02-16 19:20:04.127540 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2026-02-16 19:20:04.129188 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-16 19:20:04.734206 | 2026-02-16 19:20:04.734382 | PLAY [all] 2026-02-16 19:20:04.748160 | 2026-02-16 19:20:04.748351 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-02-16 19:20:04.937827 | ubuntu-noble | changed: non-zero return code 2026-02-16 19:20:04.943566 | 2026-02-16 19:20:04.943674 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-02-16 19:20:04.969212 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:04.980468 | 2026-02-16 19:20:04.980631 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-02-16 19:20:05.017346 | 2026-02-16 19:20:05.017647 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-02-16 19:20:05.052720 | 2026-02-16 19:20:05.052983 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-02-16 19:20:05.078482 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:05.090748 | 2026-02-16 19:20:05.090862 | LOOP [fetch-subunit-output : Generate subunit file] 2026-02-16 19:20:05.127133 | 2026-02-16 19:20:05.127344 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-02-16 19:20:05.152819 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:05.165571 | 2026-02-16 19:20:05.165754 | TASK [fetch-subunit-output : Remove the temporary file] 2026-02-16 19:20:05.201049 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:05.211378 | 2026-02-16 19:20:05.211538 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-02-16 19:20:05.236103 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:05.246024 | 2026-02-16 19:20:05.246338 | PLAY RECAP 2026-02-16 19:20:05.246404 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-16 19:20:05.246485 | 2026-02-16 19:20:05.398075 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-16 19:20:05.400772 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main] 2026-02-16 19:20:06.070814 | 2026-02-16 19:20:06.070976 | PLAY [all] 2026-02-16 19:20:06.083038 | 2026-02-16 19:20:06.083154 | TASK [fetch-output : Set log path for multiple nodes] 2026-02-16 19:20:06.129003 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:06.139369 | 2026-02-16 19:20:06.139525 | TASK [fetch-output : Set log path for single node] 2026-02-16 19:20:06.183377 | ubuntu-noble | ok 2026-02-16 19:20:06.192340 | 2026-02-16 19:20:06.192443 | LOOP [fetch-output : Ensure local output dirs] 2026-02-16 19:20:06.673079 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/52ee9d8aa3a346429929c11393f7cd3c/work/logs" 2026-02-16 19:20:06.909109 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/52ee9d8aa3a346429929c11393f7cd3c/work/artifacts" 2026-02-16 19:20:07.138476 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/52ee9d8aa3a346429929c11393f7cd3c/work/docs" 2026-02-16 19:20:07.153980 | 2026-02-16 19:20:07.154143 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-16 19:20:07.822015 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 19:20:07.822271 | ubuntu-noble | changed: All items complete 2026-02-16 19:20:07.822311 | 2026-02-16 19:20:08.310258 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 19:20:08.804580 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 19:20:08.830905 | 2026-02-16 19:20:08.831679 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-02-16 19:20:09.332717 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.024838 2026-02-16 19:20:09.624402 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.008931 2026-02-16 19:20:09.654611 | 2026-02-16 19:20:09.654737 | PLAY [all] 2026-02-16 19:20:09.662966 | 2026-02-16 19:20:09.663065 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-02-16 19:20:10.167340 | ubuntu-noble | changed 2026-02-16 19:20:10.175127 | 2026-02-16 19:20:10.175237 | PLAY RECAP 2026-02-16 19:20:10.175289 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-02-16 19:20:10.175311 | 2026-02-16 19:20:10.353821 | POST-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main] 2026-02-16 19:20:10.356520 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post-logs.yaml@main] 2026-02-16 19:20:11.003474 | 2026-02-16 19:20:11.003740 | PLAY [localhost] 2026-02-16 19:20:11.018521 | 2026-02-16 19:20:11.018678 | TASK [Generate Zuul manifest] 2026-02-16 19:20:11.040851 | localhost | ok 2026-02-16 19:20:11.059395 | 2026-02-16 19:20:11.059567 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-16 19:20:11.419110 | localhost | changed 2026-02-16 19:20:11.435288 | 2026-02-16 19:20:11.435470 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-16 19:20:11.467862 | localhost | ok 2026-02-16 19:20:11.476155 | 2026-02-16 19:20:11.476248 | TASK [Upload logs] 2026-02-16 19:20:11.498356 | localhost | ok 2026-02-16 19:20:11.575458 | 2026-02-16 19:20:11.575625 | TASK [Set zuul-log-path fact] 2026-02-16 19:20:11.598101 | localhost | ok 2026-02-16 19:20:11.614612 | 2026-02-16 19:20:11.614775 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-16 19:20:11.647553 | localhost | ok 2026-02-16 19:20:11.656523 | 2026-02-16 19:20:11.656620 | TASK [upload-logs : Create log directories] 2026-02-16 19:20:12.095843 | localhost | changed 2026-02-16 19:20:12.101476 | 2026-02-16 19:20:12.101551 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-02-16 19:20:12.531158 | localhost -> localhost | ok: Runtime: 0:00:00.007603 2026-02-16 19:20:12.537411 | 2026-02-16 19:20:12.537549 | TASK [upload-logs : Upload logs to log server] 2026-02-16 19:20:13.047699 | localhost | Output suppressed because no_log was given 2026-02-16 19:20:13.053004 | 2026-02-16 19:20:13.053112 | LOOP [upload-logs : Compress console log and json output] 2026-02-16 19:20:13.098534 | localhost | skipping: Conditional result was False 2026-02-16 19:20:13.106493 | localhost | skipping: Conditional result was False 2026-02-16 19:20:13.117522 | 2026-02-16 19:20:13.117731 | LOOP [upload-logs : Upload compressed console log and json output] 2026-02-16 19:20:13.164421 | localhost | skipping: Conditional result was False 2026-02-16 19:20:13.165058 | 2026-02-16 19:20:13.167094 | localhost | skipping: Conditional result was False 2026-02-16 19:20:13.181463 | 2026-02-16 19:20:13.181654 | LOOP [upload-logs : Upload console log and json output]