2026-02-16 18:27:55.028102 | Job console starting 2026-02-16 18:27:55.038266 | Updating git repos 2026-02-16 18:27:55.077727 | Cloning repos into workspace 2026-02-16 18:27:55.128637 | Restoring repo states 2026-02-16 18:27:55.140177 | Merging changes 2026-02-16 18:27:55.623273 | Checking out repos 2026-02-16 18:27:55.798274 | Preparing playbooks 2026-02-16 18:27:56.921551 | Running Ansible setup 2026-02-16 18:28:00.329819 | PRE-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main] 2026-02-16 18:28:00.898005 | 2026-02-16 18:28:00.898150 | PLAY [localhost] 2026-02-16 18:28:00.905754 | 2026-02-16 18:28:00.905835 | TASK [Gathering Facts] 2026-02-16 18:28:01.752583 | localhost | ok 2026-02-16 18:28:01.764645 | 2026-02-16 18:28:01.764726 | TASK [Setup log path fact] 2026-02-16 18:28:01.783666 | localhost | ok 2026-02-16 18:28:01.799207 | 2026-02-16 18:28:01.799274 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-16 18:28:01.828344 | localhost | ok 2026-02-16 18:28:01.838014 | 2026-02-16 18:28:01.838103 | TASK [emit-job-header : Print job information] 2026-02-16 18:28:01.881152 | # Job Information 2026-02-16 18:28:01.881415 | Ansible Version: 2.16.15 2026-02-16 18:28:01.881497 | Job: magnum-cluster-api-tox-functional 2026-02-16 18:28:01.881549 | Pipeline: check 2026-02-16 18:28:01.881596 | Executor: 3a2793d2bd32 2026-02-16 18:28:01.881641 | Triggered by: https://github.com/vexxhost/magnum-cluster-api/pull/884 2026-02-16 18:28:01.881699 | Event ID: e6955ee0-0b64-11f1-9362-3d643ff18065 2026-02-16 18:28:01.888687 | 2026-02-16 18:28:01.888765 | LOOP [emit-job-header : Print node information] 2026-02-16 18:28:01.984659 | localhost | ok: 2026-02-16 18:28:01.984903 | localhost | # Node Information 2026-02-16 18:28:01.985010 | localhost | Inventory Hostname: ubuntu-noble 2026-02-16 18:28:01.985057 | localhost | Hostname: np0000155666 2026-02-16 18:28:01.985092 | localhost | Username: zuul 2026-02-16 18:28:01.985129 | localhost | Distro: Ubuntu 24.04 2026-02-16 18:28:01.985165 | localhost | Provider: yul1 2026-02-16 18:28:01.985197 | localhost | Region: ca-ymq-1 2026-02-16 18:28:01.985228 | localhost | Label: ubuntu-noble 2026-02-16 18:28:01.985259 | localhost | Product Name: OpenStack Nova 2026-02-16 18:28:01.985290 | localhost | Interface IP: 199.204.45.44 2026-02-16 18:28:02.006164 | 2026-02-16 18:28:02.006333 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-16 18:28:02.404798 | localhost -> localhost | changed 2026-02-16 18:28:02.411349 | 2026-02-16 18:28:02.411415 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-16 18:28:03.206158 | localhost -> localhost | changed 2026-02-16 18:28:03.216703 | 2026-02-16 18:28:03.216779 | PLAY [all] 2026-02-16 18:28:03.226489 | 2026-02-16 18:28:03.226555 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-16 18:28:03.461147 | ubuntu-noble -> localhost | ok 2026-02-16 18:28:03.471836 | 2026-02-16 18:28:03.471904 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-16 18:28:03.504561 | ubuntu-noble | ok 2026-02-16 18:28:03.522708 | ubuntu-noble | included: /var/lib/zuul/builds/993f7ba3fa89414fb7fff88132f16848/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-16 18:28:03.528709 | 2026-02-16 18:28:03.528768 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-16 18:28:04.189549 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2026-02-16 18:28:04.189764 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/993f7ba3fa89414fb7fff88132f16848/work/993f7ba3fa89414fb7fff88132f16848_id_rsa 2026-02-16 18:28:04.189806 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/993f7ba3fa89414fb7fff88132f16848/work/993f7ba3fa89414fb7fff88132f16848_id_rsa.pub 2026-02-16 18:28:04.189839 | ubuntu-noble -> localhost | The key fingerprint is: 2026-02-16 18:28:04.189869 | ubuntu-noble -> localhost | SHA256:TLgiUOq/DRa3mW0cDixWcx9dPoN4xcPi9MYSpqgLoXQ zuul-build-sshkey 2026-02-16 18:28:04.189913 | ubuntu-noble -> localhost | The key's randomart image is: 2026-02-16 18:28:04.189944 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2026-02-16 18:28:04.189982 | ubuntu-noble -> localhost | | . oo | 2026-02-16 18:28:04.190013 | ubuntu-noble -> localhost | | o . o==+ | 2026-02-16 18:28:04.190042 | ubuntu-noble -> localhost | |o o..oo=+=+. | 2026-02-16 18:28:04.190069 | ubuntu-noble -> localhost | |.o Eo o=..oo +o | 2026-02-16 18:28:04.190096 | ubuntu-noble -> localhost | |..++o+o.S. o | 2026-02-16 18:28:04.190123 | ubuntu-noble -> localhost | | .oo+oO . | 2026-02-16 18:28:04.190149 | ubuntu-noble -> localhost | | +.+.= | 2026-02-16 18:28:04.190176 | ubuntu-noble -> localhost | | . +.. | 2026-02-16 18:28:04.190206 | ubuntu-noble -> localhost | | . . | 2026-02-16 18:28:04.190235 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2026-02-16 18:28:04.190297 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.259153 2026-02-16 18:28:04.198324 | 2026-02-16 18:28:04.198430 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-16 18:28:04.232164 | ubuntu-noble | ok 2026-02-16 18:28:04.243924 | ubuntu-noble | included: /var/lib/zuul/builds/993f7ba3fa89414fb7fff88132f16848/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-16 18:28:04.251558 | 2026-02-16 18:28:04.251624 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-16 18:28:04.275280 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:04.280917 | 2026-02-16 18:28:04.281002 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-16 18:28:04.786853 | ubuntu-noble | changed 2026-02-16 18:28:04.792300 | 2026-02-16 18:28:04.792379 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-16 18:28:05.000862 | ubuntu-noble | ok 2026-02-16 18:28:05.006222 | 2026-02-16 18:28:05.006298 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-16 18:28:05.517689 | ubuntu-noble | changed 2026-02-16 18:28:05.529278 | 2026-02-16 18:28:05.529352 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-16 18:28:06.040064 | ubuntu-noble | changed 2026-02-16 18:28:06.049009 | 2026-02-16 18:28:06.049115 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-16 18:28:06.073642 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:06.083585 | 2026-02-16 18:28:06.083682 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-16 18:28:06.434410 | ubuntu-noble -> localhost | changed 2026-02-16 18:28:06.453822 | 2026-02-16 18:28:06.453956 | TASK [add-build-sshkey : Add back temp key] 2026-02-16 18:28:06.732208 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/993f7ba3fa89414fb7fff88132f16848/work/993f7ba3fa89414fb7fff88132f16848_id_rsa (zuul-build-sshkey) 2026-02-16 18:28:06.732572 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.013973 2026-02-16 18:28:06.740064 | 2026-02-16 18:28:06.740128 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-16 18:28:07.092683 | ubuntu-noble | ok 2026-02-16 18:28:07.097820 | 2026-02-16 18:28:07.097889 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-16 18:28:07.122731 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:07.136841 | 2026-02-16 18:28:07.136935 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-02-16 18:28:07.505893 | ubuntu-noble | ok 2026-02-16 18:28:07.514301 | 2026-02-16 18:28:07.514372 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-02-16 18:28:08.568287 | ubuntu-noble | Output suppressed because no_log was given 2026-02-16 18:28:08.577989 | 2026-02-16 18:28:08.578059 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-02-16 18:28:08.810205 | ubuntu-noble | ok: "logs" 2026-02-16 18:28:08.810704 | ubuntu-noble | ok: All items complete 2026-02-16 18:28:08.810753 | 2026-02-16 18:28:09.045094 | ubuntu-noble | ok: "artifacts" 2026-02-16 18:28:09.181139 | ubuntu-noble | ok: "docs" 2026-02-16 18:28:09.202423 | 2026-02-16 18:28:09.202653 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-02-16 18:28:09.421676 | ubuntu-noble | changed: "logs" 2026-02-16 18:28:09.605362 | ubuntu-noble | changed: "artifacts" 2026-02-16 18:28:09.794113 | ubuntu-noble | changed: "docs" 2026-02-16 18:28:09.807101 | 2026-02-16 18:28:09.807311 | PLAY RECAP 2026-02-16 18:28:09.807377 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-16 18:28:09.807420 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-02-16 18:28:09.807449 | 2026-02-16 18:28:09.966558 | PRE-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main] 2026-02-16 18:28:09.969056 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-16 18:28:10.557148 | 2026-02-16 18:28:10.557317 | PLAY [all] 2026-02-16 18:28:10.569926 | 2026-02-16 18:28:10.570033 | TASK [Install binary dependencies] 2026-02-16 18:28:10.625050 | ubuntu-noble | ok 2026-02-16 18:28:10.648485 | 2026-02-16 18:28:10.648659 | TASK [bindep : Include find tasks] 2026-02-16 18:28:10.684107 | ubuntu-noble | ok 2026-02-16 18:28:10.699495 | ubuntu-noble | included: /var/lib/zuul/builds/993f7ba3fa89414fb7fff88132f16848/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-02-16 18:28:10.706044 | 2026-02-16 18:28:10.706112 | TASK [bindep : Look for bindep.txt] 2026-02-16 18:28:11.044187 | ubuntu-noble | ok 2026-02-16 18:28:11.052924 | 2026-02-16 18:28:11.053046 | TASK [bindep : Define bindep_file fact] 2026-02-16 18:28:11.079045 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:11.088841 | 2026-02-16 18:28:11.088944 | TASK [bindep : Look for other-requirements.txt] 2026-02-16 18:28:11.296769 | ubuntu-noble | ok 2026-02-16 18:28:11.303971 | 2026-02-16 18:28:11.304064 | TASK [bindep : Define bindep_file fact] 2026-02-16 18:28:11.330094 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:11.339940 | 2026-02-16 18:28:11.340035 | TASK [bindep : Look for bindep fallback file] 2026-02-16 18:28:11.365935 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:11.378664 | 2026-02-16 18:28:11.378756 | TASK [bindep : Define bindep_file fact] 2026-02-16 18:28:11.404375 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:11.414679 | 2026-02-16 18:28:11.414766 | TASK [bindep : Include bindep tasks] 2026-02-16 18:28:11.440466 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:11.450830 | 2026-02-16 18:28:11.450918 | TASK [bindep : Include install tasks] 2026-02-16 18:28:11.476485 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:11.486585 | 2026-02-16 18:28:11.486674 | LOOP [bindep : Include package tasks] 2026-02-16 18:28:11.548845 | 2026-02-16 18:28:11.549059 | TASK [Run test-setup role] 2026-02-16 18:28:11.576561 | ubuntu-noble | ok 2026-02-16 18:28:11.597019 | 2026-02-16 18:28:11.597092 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-02-16 18:28:11.815342 | ubuntu-noble | ok 2026-02-16 18:28:11.823570 | 2026-02-16 18:28:11.823660 | TASK [test-setup : Run tools/test-setup.sh] 2026-02-16 18:28:12.357177 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:12.368400 | 2026-02-16 18:28:12.368466 | PLAY RECAP 2026-02-16 18:28:12.368528 | ubuntu-noble | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-16 18:28:12.368557 | 2026-02-16 18:28:12.485343 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-16 18:28:12.487719 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2026-02-16 18:28:13.048532 | 2026-02-16 18:28:13.048665 | PLAY [all] 2026-02-16 18:28:13.061926 | 2026-02-16 18:28:13.062012 | TASK [ensure-python : Validate python_version value] 2026-02-16 18:28:13.087620 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:13.097753 | 2026-02-16 18:28:13.097861 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)] 2026-02-16 18:28:13.123439 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:13.135263 | 2026-02-16 18:28:13.135355 | TASK [ensure-python : Pull in venv package] 2026-02-16 18:28:13.161080 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:13.171595 | 2026-02-16 18:28:13.171691 | TASK [ensure-python : Set default RPM package name] 2026-02-16 18:28:13.196871 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:13.207030 | 2026-02-16 18:28:13.207123 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9/10] 2026-02-16 18:28:13.230162 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:13.240762 | 2026-02-16 18:28:13.240832 | TASK [ensure-python : Install RPM package] 2026-02-16 18:28:13.263262 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:13.272459 | 2026-02-16 18:28:13.272550 | TASK [ensure-python : Install python using pyenv] 2026-02-16 18:28:13.286148 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:13.296903 | 2026-02-16 18:28:13.296994 | TASK [ensure-python : Activate python using stow] 2026-02-16 18:28:13.319370 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:13.337861 | 2026-02-16 18:28:13.337967 | TASK [Install pip] 2026-02-16 18:28:13.357505 | ubuntu-noble | ok 2026-02-16 18:28:13.382017 | 2026-02-16 18:28:13.382106 | TASK [ensure-pip : Check if pip is installed] 2026-02-16 18:28:13.919152 | ubuntu-noble | ok: Runtime: 0:00:00.009789 2026-02-16 18:28:13.926659 | 2026-02-16 18:28:13.926743 | LOOP [ensure-pip : Install pip from packages] 2026-02-16 18:28:13.958210 | ubuntu-noble | ok: "/var/lib/zuul/builds/993f7ba3fa89414fb7fff88132f16848/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/Debian.yaml" 2026-02-16 18:28:13.973119 | ubuntu-noble | included: /var/lib/zuul/builds/993f7ba3fa89414fb7fff88132f16848/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/Debian.yaml 2026-02-16 18:28:13.985643 | 2026-02-16 18:28:13.985726 | TASK [ensure-pip : Update package lists] 2026-02-16 18:28:19.962734 | ubuntu-noble | changed 2026-02-16 18:28:19.968572 | 2026-02-16 18:28:19.968665 | TASK [ensure-pip : Install Python 3 pip] 2026-02-16 18:28:25.233549 | ubuntu-noble | changed 2026-02-16 18:28:25.239563 | 2026-02-16 18:28:25.239628 | TASK [ensure-pip : Install Python 2 pip] 2026-02-16 18:28:25.264539 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:25.275544 | 2026-02-16 18:28:25.275636 | TASK [ensure-pip : Ensure setuptools] 2026-02-16 18:28:25.301852 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:25.312336 | 2026-02-16 18:28:25.312402 | TASK [ensure-pip : Check for ensurepip module] 2026-02-16 18:28:25.400805 | ubuntu-noble | usage: python -m ensurepip [-h] [--version] [-v] [-U] [--user] [--root ROOT] 2026-02-16 18:28:25.400865 | ubuntu-noble | [--altinstall] [--default-pip] 2026-02-16 18:28:25.400872 | ubuntu-noble | 2026-02-16 18:28:25.400877 | ubuntu-noble | options: 2026-02-16 18:28:25.400882 | ubuntu-noble | -h, --help show this help message and exit 2026-02-16 18:28:25.400890 | ubuntu-noble | --version Show the version of pip that is bundled with this Python. 2026-02-16 18:28:25.400896 | ubuntu-noble | -v, --verbose Give more output. Option is additive, and can be used up to 3 2026-02-16 18:28:25.400903 | ubuntu-noble | times. 2026-02-16 18:28:25.400908 | ubuntu-noble | -U, --upgrade Upgrade pip and dependencies, even if already installed. 2026-02-16 18:28:25.400912 | ubuntu-noble | --user Install using the user scheme. 2026-02-16 18:28:25.400916 | ubuntu-noble | --root ROOT Install everything relative to this alternate root directory. 2026-02-16 18:28:25.400920 | ubuntu-noble | --altinstall Make an alternate install, installing only the X.Y versioned 2026-02-16 18:28:25.400924 | ubuntu-noble | scripts (Default: pipX, pipX.Y). 2026-02-16 18:28:25.400928 | ubuntu-noble | --default-pip Make a default pip install, installing the unqualified pip in 2026-02-16 18:28:25.400932 | ubuntu-noble | addition to the versioned scripts. 2026-02-16 18:28:25.839906 | ubuntu-noble | ok: Runtime: 0:00:00.066106 2026-02-16 18:28:25.847805 | 2026-02-16 18:28:25.847884 | TASK [ensure-pip : Ensure python3-venv] 2026-02-16 18:28:25.873648 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:25.886065 | 2026-02-16 18:28:25.886151 | TASK [ensure-pip : Install pip from source] 2026-02-16 18:28:25.911565 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:25.965456 | 2026-02-16 18:28:25.965624 | TASK [ensure-pip : Probe for venv python full path] 2026-02-16 18:28:26.033633 | ubuntu-noble | /usr/bin/python3 2026-02-16 18:28:26.489803 | ubuntu-noble | ok: Runtime: 0:00:00.008614 2026-02-16 18:28:26.497341 | 2026-02-16 18:28:26.497432 | TASK [ensure-pip : Set host default] 2026-02-16 18:28:26.553614 | ubuntu-noble | ok 2026-02-16 18:28:26.560639 | 2026-02-16 18:28:26.560726 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2026-02-16 18:28:26.617904 | ubuntu-noble | ok 2026-02-16 18:28:26.627202 | 2026-02-16 18:28:26.627266 | TASK [ensure-tox : Check if tox is installed] 2026-02-16 18:28:27.166581 | ubuntu-noble | ok: Runtime: 0:00:00.004861 2026-02-16 18:28:27.174207 | 2026-02-16 18:28:27.174298 | TASK [ensure-tox : Export preinstalled tox_exectuable] 2026-02-16 18:28:27.199754 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:27.210141 | 2026-02-16 18:28:27.210232 | TASK [ensure-tox : Create local venv] 2026-02-16 18:28:30.693565 | ubuntu-noble | ok: Runtime: 0:00:03.177722 2026-02-16 18:28:30.701560 | 2026-02-16 18:28:30.701750 | TASK [ensure-tox : Install tox to local venv] 2026-02-16 18:28:31.345515 | ubuntu-noble | Collecting tox 2026-02-16 18:28:31.383872 | ubuntu-noble | Downloading tox-4.36.0-py3-none-any.whl.metadata (3.6 kB) 2026-02-16 18:28:31.434123 | ubuntu-noble | Collecting cachetools>=7.0.1 (from tox) 2026-02-16 18:28:31.438127 | ubuntu-noble | Downloading cachetools-7.0.1-py3-none-any.whl.metadata (5.6 kB) 2026-02-16 18:28:31.467286 | ubuntu-noble | Collecting chardet>=5.2 (from tox) 2026-02-16 18:28:31.470867 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl.metadata (3.4 kB) 2026-02-16 18:28:31.513192 | ubuntu-noble | Collecting colorama>=0.4.6 (from tox) 2026-02-16 18:28:31.516412 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2026-02-16 18:28:31.569665 | ubuntu-noble | Collecting filelock>=3.24 (from tox) 2026-02-16 18:28:31.572889 | ubuntu-noble | Downloading filelock-3.24.2-py3-none-any.whl.metadata (2.0 kB) 2026-02-16 18:28:31.616892 | ubuntu-noble | Collecting packaging>=26 (from tox) 2026-02-16 18:28:31.619704 | ubuntu-noble | Downloading packaging-26.0-py3-none-any.whl.metadata (3.3 kB) 2026-02-16 18:28:31.677681 | ubuntu-noble | Collecting platformdirs>=4.9.1 (from tox) 2026-02-16 18:28:31.681692 | ubuntu-noble | Downloading platformdirs-4.9.2-py3-none-any.whl.metadata (4.7 kB) 2026-02-16 18:28:31.720739 | ubuntu-noble | Collecting pluggy>=1.6 (from tox) 2026-02-16 18:28:31.723653 | ubuntu-noble | Downloading pluggy-1.6.0-py3-none-any.whl.metadata (4.8 kB) 2026-02-16 18:28:31.762294 | ubuntu-noble | Collecting pyproject-api>=1.10 (from tox) 2026-02-16 18:28:31.788846 | ubuntu-noble | Downloading pyproject_api-1.10.0-py3-none-any.whl.metadata (2.7 kB) 2026-02-16 18:28:31.907104 | ubuntu-noble | Collecting virtualenv>=20.36.1 (from tox) 2026-02-16 18:28:31.910537 | ubuntu-noble | Downloading virtualenv-20.37.0-py3-none-any.whl.metadata (5.1 kB) 2026-02-16 18:28:31.998153 | ubuntu-noble | Collecting distlib<1,>=0.3.7 (from virtualenv>=20.36.1->tox) 2026-02-16 18:28:32.001255 | ubuntu-noble | Downloading distlib-0.4.0-py2.py3-none-any.whl.metadata (5.2 kB) 2026-02-16 18:28:32.033054 | ubuntu-noble | Downloading tox-4.36.0-py3-none-any.whl (179 kB) 2026-02-16 18:28:32.048972 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 179.1/179.1 kB 14.6 MB/s eta 0:00:00 2026-02-16 18:28:32.053460 | ubuntu-noble | Downloading cachetools-7.0.1-py3-none-any.whl (13 kB) 2026-02-16 18:28:32.066147 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2026-02-16 18:28:32.078392 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 20.0 MB/s eta 0:00:00 2026-02-16 18:28:32.082863 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-02-16 18:28:32.095700 | ubuntu-noble | Downloading filelock-3.24.2-py3-none-any.whl (24 kB) 2026-02-16 18:28:32.108142 | ubuntu-noble | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-02-16 18:28:32.121065 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 6.4 MB/s eta 0:00:00 2026-02-16 18:28:32.124803 | ubuntu-noble | Downloading platformdirs-4.9.2-py3-none-any.whl (21 kB) 2026-02-16 18:28:32.135112 | ubuntu-noble | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-02-16 18:28:32.147577 | ubuntu-noble | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-02-16 18:28:32.160331 | ubuntu-noble | Downloading virtualenv-20.37.0-py3-none-any.whl (5.8 MB) 2026-02-16 18:28:32.228110 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.8/5.8 MB 89.8 MB/s eta 0:00:00 2026-02-16 18:28:32.231893 | ubuntu-noble | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-02-16 18:28:32.248467 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 32.9 MB/s eta 0:00:00 2026-02-16 18:28:32.317222 | ubuntu-noble | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2026-02-16 18:28:33.154328 | 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 18:28:33.720683 | ubuntu-noble | ok: Runtime: 0:00:02.405750 2026-02-16 18:28:33.728140 | 2026-02-16 18:28:33.728215 | TASK [ensure-tox : Export installed tox_executable path] 2026-02-16 18:28:33.763373 | ubuntu-noble | ok 2026-02-16 18:28:33.769128 | 2026-02-16 18:28:33.769189 | TASK [ensure-tox : Output tox version] 2026-02-16 18:28:34.183037 | 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 18:28:34.202108 | ubuntu-noble | 4.36.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2026-02-16 18:28:34.797581 | ubuntu-noble | ok: Runtime: 0:00:00.289615 2026-02-16 18:28:34.803972 | 2026-02-16 18:28:34.804055 | TASK [ensure-tox : Make global symlink] 2026-02-16 18:28:34.819359 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:34.830834 | 2026-02-16 18:28:34.830905 | PLAY RECAP 2026-02-16 18:28:34.830965 | ubuntu-noble | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-02-16 18:28:34.830995 | 2026-02-16 18:28:34.961891 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2026-02-16 18:28:34.963196 | PRE-RUN START: [untrusted : github.com/vexxhost/magnum-cluster-api/zuul.d/playbooks/tox/pre.yml@main] 2026-02-16 18:28:35.539171 | 2026-02-16 18:28:35.539309 | PLAY [all] 2026-02-16 18:28:35.551219 | 2026-02-16 18:28:35.551303 | TASK [ensure-rust : Use rustup] 2026-02-16 18:28:35.587346 | ubuntu-noble | ok 2026-02-16 18:28:35.594668 | ubuntu-noble | included: /var/lib/zuul/builds/993f7ba3fa89414fb7fff88132f16848/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-rust/tasks/rustup.yaml 2026-02-16 18:28:35.601343 | 2026-02-16 18:28:35.601420 | TASK [ensure-rust : Install Rust] 2026-02-16 18:28:35.951676 | ubuntu-noble | /bin/bash: line 2: curl: command not found 2026-02-16 18:28:36.135631 | ubuntu-noble | ERROR 2026-02-16 18:28:36.135891 | ubuntu-noble | { 2026-02-16 18:28:36.135935 | ubuntu-noble | "delta": "0:00:00.006016", 2026-02-16 18:28:36.135991 | ubuntu-noble | "end": "2026-02-16 18:28:35.952296", 2026-02-16 18:28:36.136022 | ubuntu-noble | "msg": "non-zero return code", 2026-02-16 18:28:36.136304 | ubuntu-noble | "rc": 127, 2026-02-16 18:28:36.136353 | ubuntu-noble | "start": "2026-02-16 18:28:35.946280" 2026-02-16 18:28:36.136387 | ubuntu-noble | } failure 2026-02-16 18:28:36.138373 | 2026-02-16 18:28:36.138439 | PLAY RECAP 2026-02-16 18:28:36.138506 | ubuntu-noble | ok: 1 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-02-16 18:28:36.138538 | 2026-02-16 18:28:36.261346 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/magnum-cluster-api/zuul.d/playbooks/tox/pre.yml@main] 2026-02-16 18:28:36.263996 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2026-02-16 18:28:36.869454 | 2026-02-16 18:28:36.869632 | PLAY [all] 2026-02-16 18:28:36.885490 | 2026-02-16 18:28:36.885916 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-02-16 18:28:36.934105 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:36.944377 | 2026-02-16 18:28:36.944460 | TASK [fetch-tox-output : Set tox log path for single node] 2026-02-16 18:28:36.986939 | ubuntu-noble | ok 2026-02-16 18:28:36.994267 | 2026-02-16 18:28:36.994332 | TASK [fetch-tox-output : Ensure local tox dir] 2026-02-16 18:28:37.376697 | ubuntu-noble -> localhost | changed 2026-02-16 18:28:37.387072 | 2026-02-16 18:28:37.387150 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-02-16 18:28:37.427072 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:37.433987 | 2026-02-16 18:28:37.434060 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 18:28:37.475604 | ubuntu-noble | ok 2026-02-16 18:28:37.483165 | 2026-02-16 18:28:37.483229 | TASK [fetch-tox-output : Get tox version] 2026-02-16 18:28:38.039600 | 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 18:28:38.053563 | ubuntu-noble | 4.36.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2026-02-16 18:28:38.522827 | ubuntu-noble | ok: Runtime: 0:00:00.268204 2026-02-16 18:28:38.528078 | 2026-02-16 18:28:38.528145 | TASK [fetch-tox-output : Find all default environments] 2026-02-16 18:28:39.055087 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:39.067519 | 2026-02-16 18:28:39.067674 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 18:28:39.092894 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:39.104275 | 2026-02-16 18:28:39.104341 | TASK [fetch-tox-output : Find all default environments] 2026-02-16 18:28:39.630872 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:39.641197 | 2026-02-16 18:28:39.641290 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 18:28:39.666570 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:39.676412 | 2026-02-16 18:28:39.676509 | LOOP [fetch-tox-output : Copy tox logs] 2026-02-16 18:28:39.715453 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:39.733428 | 2026-02-16 18:28:39.733608 | LOOP [fetch-tox-output : Collect tox logs] 2026-02-16 18:28:40.483195 | ubuntu-noble | ok: 2026-02-16 18:28:40.483530 | 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 18:28:40.483612 | 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 18:28:40.483648 | ubuntu-noble | rsync: [Receiver] write error: Broken pipe (32) 2026-02-16 18:28:40.483687 | 2026-02-16 18:28:40.503036 | 2026-02-16 18:28:40.503105 | PLAY RECAP 2026-02-16 18:28:40.503165 | ubuntu-noble | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-02-16 18:28:40.503194 | 2026-02-16 18:28:40.616265 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2026-02-16 18:28:40.618996 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-16 18:28:41.231987 | 2026-02-16 18:28:41.232126 | PLAY [all] 2026-02-16 18:28:41.244895 | 2026-02-16 18:28:41.244992 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-02-16 18:28:41.421102 | ubuntu-noble | changed: non-zero return code 2026-02-16 18:28:41.428123 | 2026-02-16 18:28:41.428207 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-02-16 18:28:41.453859 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:41.464841 | 2026-02-16 18:28:41.464925 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-02-16 18:28:41.511837 | 2026-02-16 18:28:41.512013 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-02-16 18:28:41.547697 | 2026-02-16 18:28:41.547954 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-02-16 18:28:41.573219 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:41.583839 | 2026-02-16 18:28:41.583986 | LOOP [fetch-subunit-output : Generate subunit file] 2026-02-16 18:28:41.620204 | 2026-02-16 18:28:41.620509 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-02-16 18:28:41.647226 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:41.659615 | 2026-02-16 18:28:41.660083 | TASK [fetch-subunit-output : Remove the temporary file] 2026-02-16 18:28:41.686891 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:41.701982 | 2026-02-16 18:28:41.702118 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-02-16 18:28:41.728651 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:41.741413 | 2026-02-16 18:28:41.741557 | PLAY RECAP 2026-02-16 18:28:41.741617 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-16 18:28:41.741641 | 2026-02-16 18:28:41.893758 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-16 18:28:41.896874 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main] 2026-02-16 18:28:42.489166 | 2026-02-16 18:28:42.489341 | PLAY [all] 2026-02-16 18:28:42.502419 | 2026-02-16 18:28:42.502594 | TASK [fetch-output : Set log path for multiple nodes] 2026-02-16 18:28:42.548615 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:42.558562 | 2026-02-16 18:28:42.558693 | TASK [fetch-output : Set log path for single node] 2026-02-16 18:28:42.602530 | ubuntu-noble | ok 2026-02-16 18:28:42.609533 | 2026-02-16 18:28:42.609601 | LOOP [fetch-output : Ensure local output dirs] 2026-02-16 18:28:43.001873 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/993f7ba3fa89414fb7fff88132f16848/work/logs" 2026-02-16 18:28:43.208688 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/993f7ba3fa89414fb7fff88132f16848/work/artifacts" 2026-02-16 18:28:43.415001 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/993f7ba3fa89414fb7fff88132f16848/work/docs" 2026-02-16 18:28:43.438691 | 2026-02-16 18:28:43.438872 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-16 18:28:44.136150 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 18:28:44.136419 | ubuntu-noble | changed: All items complete 2026-02-16 18:28:44.136465 | 2026-02-16 18:28:44.582235 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 18:28:45.032477 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 18:28:45.055055 | 2026-02-16 18:28:45.055892 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-02-16 18:28:45.472988 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.008849 2026-02-16 18:28:45.700313 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.007815 2026-02-16 18:28:45.719944 | 2026-02-16 18:28:45.720091 | PLAY [all] 2026-02-16 18:28:45.727933 | 2026-02-16 18:28:45.728003 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-02-16 18:28:46.197795 | ubuntu-noble | changed 2026-02-16 18:28:46.203877 | 2026-02-16 18:28:46.203929 | PLAY RECAP 2026-02-16 18:28:46.203982 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-02-16 18:28:46.204003 | 2026-02-16 18:28:46.329835 | POST-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main] 2026-02-16 18:28:46.332458 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post-logs.yaml@main] 2026-02-16 18:28:46.920590 | 2026-02-16 18:28:46.920723 | PLAY [localhost] 2026-02-16 18:28:46.932112 | 2026-02-16 18:28:46.932221 | TASK [Generate Zuul manifest] 2026-02-16 18:28:46.953739 | localhost | ok 2026-02-16 18:28:46.969733 | 2026-02-16 18:28:46.969810 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-16 18:28:47.304512 | localhost | changed 2026-02-16 18:28:47.318515 | 2026-02-16 18:28:47.318600 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-16 18:28:47.351202 | localhost | ok 2026-02-16 18:28:47.359731 | 2026-02-16 18:28:47.359793 | TASK [Upload logs] 2026-02-16 18:28:47.381384 | localhost | ok 2026-02-16 18:28:47.440022 | 2026-02-16 18:28:47.440119 | TASK [Set zuul-log-path fact] 2026-02-16 18:28:47.463019 | localhost | ok 2026-02-16 18:28:47.475481 | 2026-02-16 18:28:47.475549 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-16 18:28:47.517528 | localhost | ok 2026-02-16 18:28:47.524135 | 2026-02-16 18:28:47.524199 | TASK [upload-logs : Create log directories] 2026-02-16 18:28:47.926175 | localhost | changed 2026-02-16 18:28:47.931314 | 2026-02-16 18:28:47.931386 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-02-16 18:28:48.331548 | localhost -> localhost | ok: Runtime: 0:00:00.006057 2026-02-16 18:28:48.336379 | 2026-02-16 18:28:48.336450 | TASK [upload-logs : Upload logs to log server] 2026-02-16 18:28:48.795694 | localhost | Output suppressed because no_log was given 2026-02-16 18:28:48.799586 | 2026-02-16 18:28:48.799658 | LOOP [upload-logs : Compress console log and json output] 2026-02-16 18:28:48.841727 | localhost | skipping: Conditional result was False 2026-02-16 18:28:48.849360 | localhost | skipping: Conditional result was False 2026-02-16 18:28:48.862473 | 2026-02-16 18:28:48.862603 | LOOP [upload-logs : Upload compressed console log and json output] 2026-02-16 18:28:48.903203 | localhost | skipping: Conditional result was False 2026-02-16 18:28:48.903448 | 2026-02-16 18:28:48.907086 | localhost | skipping: Conditional result was False 2026-02-16 18:28:48.916490 | 2026-02-16 18:28:48.916598 | LOOP [upload-logs : Upload console log and json output]