2026-02-16 17:40:54.633735 | Job console starting 2026-02-16 17:40:54.677045 | Updating git repos 2026-02-16 17:40:54.714812 | Cloning repos into workspace 2026-02-16 17:40:54.910396 | Restoring repo states 2026-02-16 17:40:54.923762 | Merging changes 2026-02-16 17:40:55.290180 | Checking out repos 2026-02-16 17:40:55.542003 | Preparing playbooks 2026-02-16 17:40:57.358494 | Running Ansible setup 2026-02-16 17:41:00.941752 | PRE-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main] 2026-02-16 17:41:01.547363 | 2026-02-16 17:41:01.547520 | PLAY [localhost] 2026-02-16 17:41:01.555810 | 2026-02-16 17:41:01.555894 | TASK [Gathering Facts] 2026-02-16 17:41:02.458278 | localhost | ok 2026-02-16 17:41:02.468025 | 2026-02-16 17:41:02.468116 | TASK [Setup log path fact] 2026-02-16 17:41:02.486043 | localhost | ok 2026-02-16 17:41:02.496033 | 2026-02-16 17:41:02.496120 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-16 17:41:02.523421 | localhost | ok 2026-02-16 17:41:02.529335 | 2026-02-16 17:41:02.529405 | TASK [emit-job-header : Print job information] 2026-02-16 17:41:02.573856 | # Job Information 2026-02-16 17:41:02.574127 | Ansible Version: 2.16.15 2026-02-16 17:41:02.574199 | Job: magnum-cluster-api-tox-functional 2026-02-16 17:41:02.574249 | Pipeline: check 2026-02-16 17:41:02.574294 | Executor: 3a2793d2bd32 2026-02-16 17:41:02.574338 | Triggered by: https://github.com/vexxhost/magnum-cluster-api/pull/884 2026-02-16 17:41:02.574389 | Event ID: 2685a480-0b5e-11f1-90f6-a235114455cc 2026-02-16 17:41:02.577510 | 2026-02-16 17:41:02.577579 | LOOP [emit-job-header : Print node information] 2026-02-16 17:41:02.678418 | localhost | ok: 2026-02-16 17:41:02.679135 | localhost | # Node Information 2026-02-16 17:41:02.679183 | localhost | Inventory Hostname: ubuntu-noble 2026-02-16 17:41:02.679218 | localhost | Hostname: np0000155618 2026-02-16 17:41:02.679247 | localhost | Username: zuul 2026-02-16 17:41:02.679280 | localhost | Distro: Ubuntu 24.04 2026-02-16 17:41:02.679311 | localhost | Provider: yul1 2026-02-16 17:41:02.679340 | localhost | Region: ca-ymq-1 2026-02-16 17:41:02.679369 | localhost | Label: ubuntu-noble 2026-02-16 17:41:02.679396 | localhost | Product Name: OpenStack Nova 2026-02-16 17:41:02.679423 | localhost | Interface IP: 199.204.45.210 2026-02-16 17:41:02.701233 | 2026-02-16 17:41:02.701397 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-16 17:41:03.153996 | localhost -> localhost | changed 2026-02-16 17:41:03.163368 | 2026-02-16 17:41:03.163465 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-16 17:41:04.020310 | localhost -> localhost | changed 2026-02-16 17:41:04.029023 | 2026-02-16 17:41:04.029104 | PLAY [all] 2026-02-16 17:41:04.037879 | 2026-02-16 17:41:04.037990 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-16 17:41:04.282851 | ubuntu-noble -> localhost | ok 2026-02-16 17:41:04.292752 | 2026-02-16 17:41:04.292823 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-16 17:41:04.326378 | ubuntu-noble | ok 2026-02-16 17:41:04.344352 | ubuntu-noble | included: /var/lib/zuul/builds/969b1923ed0b440885b6f9ffecb9111b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-16 17:41:04.357157 | 2026-02-16 17:41:04.357336 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-16 17:41:05.180311 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2026-02-16 17:41:05.180545 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/969b1923ed0b440885b6f9ffecb9111b/work/969b1923ed0b440885b6f9ffecb9111b_id_rsa 2026-02-16 17:41:05.180590 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/969b1923ed0b440885b6f9ffecb9111b/work/969b1923ed0b440885b6f9ffecb9111b_id_rsa.pub 2026-02-16 17:41:05.180623 | ubuntu-noble -> localhost | The key fingerprint is: 2026-02-16 17:41:05.180654 | ubuntu-noble -> localhost | SHA256:0bmBxMxBL2UnbwFFRgy1h7o4d5n1rLCienHqG2VIaP8 zuul-build-sshkey 2026-02-16 17:41:05.180699 | ubuntu-noble -> localhost | The key's randomart image is: 2026-02-16 17:41:05.180731 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2026-02-16 17:41:05.180765 | ubuntu-noble -> localhost | | =+.*OO | 2026-02-16 17:41:05.180796 | ubuntu-noble -> localhost | | o+* *.+ | 2026-02-16 17:41:05.180830 | ubuntu-noble -> localhost | | o = = = . | 2026-02-16 17:41:05.180864 | ubuntu-noble -> localhost | | . o + = . | 2026-02-16 17:41:05.180901 | ubuntu-noble -> localhost | | S = . | 2026-02-16 17:41:05.180935 | ubuntu-noble -> localhost | | .=.. + o | 2026-02-16 17:41:05.180991 | ubuntu-noble -> localhost | | ++E = o| 2026-02-16 17:41:05.181023 | ubuntu-noble -> localhost | | o+.. o . | 2026-02-16 17:41:05.181054 | ubuntu-noble -> localhost | | .++o .. . | 2026-02-16 17:41:05.181082 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2026-02-16 17:41:05.181139 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.393174 2026-02-16 17:41:05.187905 | 2026-02-16 17:41:05.187971 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-16 17:41:05.217800 | ubuntu-noble | ok 2026-02-16 17:41:05.231715 | ubuntu-noble | included: /var/lib/zuul/builds/969b1923ed0b440885b6f9ffecb9111b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-16 17:41:05.240198 | 2026-02-16 17:41:05.240263 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-16 17:41:05.265513 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:05.273965 | 2026-02-16 17:41:05.274031 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-16 17:41:05.822846 | ubuntu-noble | changed 2026-02-16 17:41:05.829317 | 2026-02-16 17:41:05.829380 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-16 17:41:06.066172 | ubuntu-noble | ok 2026-02-16 17:41:06.071555 | 2026-02-16 17:41:06.071620 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-16 17:41:06.623629 | ubuntu-noble | changed 2026-02-16 17:41:06.635196 | 2026-02-16 17:41:06.635264 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-16 17:41:07.164397 | ubuntu-noble | changed 2026-02-16 17:41:07.173628 | 2026-02-16 17:41:07.173727 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-16 17:41:07.199739 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:07.210184 | 2026-02-16 17:41:07.210252 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-16 17:41:07.596362 | ubuntu-noble -> localhost | changed 2026-02-16 17:41:07.614808 | 2026-02-16 17:41:07.614902 | TASK [add-build-sshkey : Add back temp key] 2026-02-16 17:41:07.922033 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/969b1923ed0b440885b6f9ffecb9111b/work/969b1923ed0b440885b6f9ffecb9111b_id_rsa (zuul-build-sshkey) 2026-02-16 17:41:07.922252 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.014066 2026-02-16 17:41:07.929219 | 2026-02-16 17:41:07.929282 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-16 17:41:08.287151 | ubuntu-noble | ok 2026-02-16 17:41:08.294683 | 2026-02-16 17:41:08.294759 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-16 17:41:08.320131 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:08.336374 | 2026-02-16 17:41:08.336439 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-02-16 17:41:08.752126 | ubuntu-noble | ok 2026-02-16 17:41:08.760122 | 2026-02-16 17:41:08.760201 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-02-16 17:41:09.785922 | ubuntu-noble | Output suppressed because no_log was given 2026-02-16 17:41:09.796654 | 2026-02-16 17:41:09.796778 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-02-16 17:41:10.023814 | ubuntu-noble | ok: "logs" 2026-02-16 17:41:10.024073 | ubuntu-noble | ok: All items complete 2026-02-16 17:41:10.024120 | 2026-02-16 17:41:10.250499 | ubuntu-noble | ok: "artifacts" 2026-02-16 17:41:10.395828 | ubuntu-noble | ok: "docs" 2026-02-16 17:41:10.416110 | 2026-02-16 17:41:10.416281 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-02-16 17:41:10.646751 | ubuntu-noble | changed: "logs" 2026-02-16 17:41:10.836241 | ubuntu-noble | changed: "artifacts" 2026-02-16 17:41:11.023772 | ubuntu-noble | changed: "docs" 2026-02-16 17:41:11.045509 | 2026-02-16 17:41:11.045662 | PLAY RECAP 2026-02-16 17:41:11.045718 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-16 17:41:11.045764 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-02-16 17:41:11.045791 | 2026-02-16 17:41:11.208685 | PRE-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main] 2026-02-16 17:41:11.209982 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-16 17:41:11.806574 | 2026-02-16 17:41:11.806768 | PLAY [all] 2026-02-16 17:41:11.821079 | 2026-02-16 17:41:11.821228 | TASK [Install binary dependencies] 2026-02-16 17:41:11.877542 | ubuntu-noble | ok 2026-02-16 17:41:11.898957 | 2026-02-16 17:41:11.899145 | TASK [bindep : Include find tasks] 2026-02-16 17:41:11.934327 | ubuntu-noble | ok 2026-02-16 17:41:11.942734 | ubuntu-noble | included: /var/lib/zuul/builds/969b1923ed0b440885b6f9ffecb9111b/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-02-16 17:41:11.949123 | 2026-02-16 17:41:11.949199 | TASK [bindep : Look for bindep.txt] 2026-02-16 17:41:12.364808 | ubuntu-noble | ok 2026-02-16 17:41:12.372263 | 2026-02-16 17:41:12.372334 | TASK [bindep : Define bindep_file fact] 2026-02-16 17:41:12.397993 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:12.407657 | 2026-02-16 17:41:12.407750 | TASK [bindep : Look for other-requirements.txt] 2026-02-16 17:41:12.612945 | ubuntu-noble | ok 2026-02-16 17:41:12.619740 | 2026-02-16 17:41:12.619811 | TASK [bindep : Define bindep_file fact] 2026-02-16 17:41:12.642995 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:12.654894 | 2026-02-16 17:41:12.654961 | TASK [bindep : Look for bindep fallback file] 2026-02-16 17:41:12.680915 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:12.694118 | 2026-02-16 17:41:12.694192 | TASK [bindep : Define bindep_file fact] 2026-02-16 17:41:12.719458 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:12.727042 | 2026-02-16 17:41:12.727375 | TASK [bindep : Include bindep tasks] 2026-02-16 17:41:12.753561 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:12.764764 | 2026-02-16 17:41:12.764890 | TASK [bindep : Include install tasks] 2026-02-16 17:41:12.790845 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:12.801662 | 2026-02-16 17:41:12.801778 | LOOP [bindep : Include package tasks] 2026-02-16 17:41:12.872707 | 2026-02-16 17:41:12.872906 | TASK [Run test-setup role] 2026-02-16 17:41:12.905330 | ubuntu-noble | ok 2026-02-16 17:41:12.922808 | 2026-02-16 17:41:12.922884 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-02-16 17:41:13.136356 | ubuntu-noble | ok 2026-02-16 17:41:13.143213 | 2026-02-16 17:41:13.143296 | TASK [test-setup : Run tools/test-setup.sh] 2026-02-16 17:41:13.675995 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:13.688185 | 2026-02-16 17:41:13.688242 | PLAY RECAP 2026-02-16 17:41:13.688290 | ubuntu-noble | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-16 17:41:13.688312 | 2026-02-16 17:41:13.855292 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-16 17:41:13.857535 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2026-02-16 17:41:14.483117 | 2026-02-16 17:41:14.483258 | PLAY [all] 2026-02-16 17:41:14.497219 | 2026-02-16 17:41:14.497305 | TASK [ensure-python : Validate python_version value] 2026-02-16 17:41:14.522716 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:14.533395 | 2026-02-16 17:41:14.533506 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)] 2026-02-16 17:41:14.558968 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:14.570545 | 2026-02-16 17:41:14.570640 | TASK [ensure-python : Pull in venv package] 2026-02-16 17:41:14.596382 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:14.607160 | 2026-02-16 17:41:14.607243 | TASK [ensure-python : Set default RPM package name] 2026-02-16 17:41:14.631848 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:14.644022 | 2026-02-16 17:41:14.644207 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9/10] 2026-02-16 17:41:14.684142 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:14.694387 | 2026-02-16 17:41:14.694488 | TASK [ensure-python : Install RPM package] 2026-02-16 17:41:14.734297 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:14.744896 | 2026-02-16 17:41:14.745015 | TASK [ensure-python : Install python using pyenv] 2026-02-16 17:41:14.770718 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:14.781862 | 2026-02-16 17:41:14.782054 | TASK [ensure-python : Activate python using stow] 2026-02-16 17:41:14.817556 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:14.835785 | 2026-02-16 17:41:14.835847 | TASK [Install pip] 2026-02-16 17:41:14.860392 | ubuntu-noble | ok 2026-02-16 17:41:14.883790 | 2026-02-16 17:41:14.883859 | TASK [ensure-pip : Check if pip is installed] 2026-02-16 17:41:15.418704 | ubuntu-noble | ok: Runtime: 0:00:00.009356 2026-02-16 17:41:15.426783 | 2026-02-16 17:41:15.426851 | LOOP [ensure-pip : Install pip from packages] 2026-02-16 17:41:15.462645 | ubuntu-noble | ok: "/var/lib/zuul/builds/969b1923ed0b440885b6f9ffecb9111b/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/Debian.yaml" 2026-02-16 17:41:15.480791 | ubuntu-noble | included: /var/lib/zuul/builds/969b1923ed0b440885b6f9ffecb9111b/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/Debian.yaml 2026-02-16 17:41:15.490507 | 2026-02-16 17:41:15.490596 | TASK [ensure-pip : Update package lists] 2026-02-16 17:41:21.279038 | ubuntu-noble | changed 2026-02-16 17:41:21.288089 | 2026-02-16 17:41:21.288192 | TASK [ensure-pip : Install Python 3 pip] 2026-02-16 17:41:27.591569 | ubuntu-noble | changed 2026-02-16 17:41:27.599202 | 2026-02-16 17:41:27.599274 | TASK [ensure-pip : Install Python 2 pip] 2026-02-16 17:41:27.624943 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:27.648272 | 2026-02-16 17:41:27.648418 | TASK [ensure-pip : Ensure setuptools] 2026-02-16 17:41:27.678124 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:27.689370 | 2026-02-16 17:41:27.689499 | TASK [ensure-pip : Check for ensurepip module] 2026-02-16 17:41:27.876238 | ubuntu-noble | usage: python -m ensurepip [-h] [--version] [-v] [-U] [--user] [--root ROOT] 2026-02-16 17:41:27.876361 | ubuntu-noble | [--altinstall] [--default-pip] 2026-02-16 17:41:27.876376 | ubuntu-noble | 2026-02-16 17:41:27.876387 | ubuntu-noble | options: 2026-02-16 17:41:27.876397 | ubuntu-noble | -h, --help show this help message and exit 2026-02-16 17:41:27.876412 | ubuntu-noble | --version Show the version of pip that is bundled with this Python. 2026-02-16 17:41:27.876425 | ubuntu-noble | -v, --verbose Give more output. Option is additive, and can be used up to 3 2026-02-16 17:41:27.876439 | ubuntu-noble | times. 2026-02-16 17:41:27.876450 | ubuntu-noble | -U, --upgrade Upgrade pip and dependencies, even if already installed. 2026-02-16 17:41:27.876458 | ubuntu-noble | --user Install using the user scheme. 2026-02-16 17:41:27.876468 | ubuntu-noble | --root ROOT Install everything relative to this alternate root directory. 2026-02-16 17:41:27.876477 | ubuntu-noble | --altinstall Make an alternate install, installing only the X.Y versioned 2026-02-16 17:41:27.876486 | ubuntu-noble | scripts (Default: pipX, pipX.Y). 2026-02-16 17:41:27.876495 | ubuntu-noble | --default-pip Make a default pip install, installing the unqualified pip in 2026-02-16 17:41:27.876503 | ubuntu-noble | addition to the versioned scripts. 2026-02-16 17:41:28.226965 | ubuntu-noble | ok: Runtime: 0:00:00.062703 2026-02-16 17:41:28.235265 | 2026-02-16 17:41:28.235354 | TASK [ensure-pip : Ensure python3-venv] 2026-02-16 17:41:28.260418 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:28.274216 | 2026-02-16 17:41:28.274361 | TASK [ensure-pip : Install pip from source] 2026-02-16 17:41:28.300583 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:28.347462 | 2026-02-16 17:41:28.347618 | TASK [ensure-pip : Probe for venv python full path] 2026-02-16 17:41:28.506722 | ubuntu-noble | /usr/bin/python3 2026-02-16 17:41:28.885767 | ubuntu-noble | ok: Runtime: 0:00:00.007484 2026-02-16 17:41:28.891200 | 2026-02-16 17:41:28.891264 | TASK [ensure-pip : Set host default] 2026-02-16 17:41:28.946034 | ubuntu-noble | ok 2026-02-16 17:41:28.955401 | 2026-02-16 17:41:28.955484 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2026-02-16 17:41:29.014991 | ubuntu-noble | ok 2026-02-16 17:41:29.026157 | 2026-02-16 17:41:29.026248 | TASK [ensure-tox : Check if tox is installed] 2026-02-16 17:41:29.561737 | ubuntu-noble | ok: Runtime: 0:00:00.007663 2026-02-16 17:41:29.571142 | 2026-02-16 17:41:29.571217 | TASK [ensure-tox : Export preinstalled tox_exectuable] 2026-02-16 17:41:29.596597 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:29.607953 | 2026-02-16 17:41:29.608063 | TASK [ensure-tox : Create local venv] 2026-02-16 17:41:33.123458 | ubuntu-noble | ok: Runtime: 0:00:03.218907 2026-02-16 17:41:33.129385 | 2026-02-16 17:41:33.129470 | TASK [ensure-tox : Install tox to local venv] 2026-02-16 17:41:33.799811 | ubuntu-noble | Collecting tox 2026-02-16 17:41:33.841070 | ubuntu-noble | Downloading tox-4.36.0-py3-none-any.whl.metadata (3.6 kB) 2026-02-16 17:41:33.901020 | ubuntu-noble | Collecting cachetools>=7.0.1 (from tox) 2026-02-16 17:41:33.905791 | ubuntu-noble | Downloading cachetools-7.0.1-py3-none-any.whl.metadata (5.6 kB) 2026-02-16 17:41:33.947006 | ubuntu-noble | Collecting chardet>=5.2 (from tox) 2026-02-16 17:41:33.951199 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl.metadata (3.4 kB) 2026-02-16 17:41:34.051086 | ubuntu-noble | Collecting colorama>=0.4.6 (from tox) 2026-02-16 17:41:34.056265 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2026-02-16 17:41:34.115680 | ubuntu-noble | Collecting filelock>=3.24 (from tox) 2026-02-16 17:41:34.122897 | ubuntu-noble | Downloading filelock-3.24.2-py3-none-any.whl.metadata (2.0 kB) 2026-02-16 17:41:34.174658 | ubuntu-noble | Collecting packaging>=26 (from tox) 2026-02-16 17:41:34.178005 | ubuntu-noble | Downloading packaging-26.0-py3-none-any.whl.metadata (3.3 kB) 2026-02-16 17:41:34.233980 | ubuntu-noble | Collecting platformdirs>=4.9.1 (from tox) 2026-02-16 17:41:34.237605 | ubuntu-noble | Downloading platformdirs-4.9.2-py3-none-any.whl.metadata (4.7 kB) 2026-02-16 17:41:34.282021 | ubuntu-noble | Collecting pluggy>=1.6 (from tox) 2026-02-16 17:41:34.285204 | ubuntu-noble | Downloading pluggy-1.6.0-py3-none-any.whl.metadata (4.8 kB) 2026-02-16 17:41:34.320925 | ubuntu-noble | Collecting pyproject-api>=1.10 (from tox) 2026-02-16 17:41:34.325759 | ubuntu-noble | Downloading pyproject_api-1.10.0-py3-none-any.whl.metadata (2.7 kB) 2026-02-16 17:41:34.451694 | ubuntu-noble | Collecting virtualenv>=20.36.1 (from tox) 2026-02-16 17:41:34.454967 | ubuntu-noble | Downloading virtualenv-20.37.0-py3-none-any.whl.metadata (5.1 kB) 2026-02-16 17:41:34.544249 | ubuntu-noble | Collecting distlib<1,>=0.3.7 (from virtualenv>=20.36.1->tox) 2026-02-16 17:41:34.547185 | ubuntu-noble | Downloading distlib-0.4.0-py2.py3-none-any.whl.metadata (5.2 kB) 2026-02-16 17:41:34.580187 | ubuntu-noble | Downloading tox-4.36.0-py3-none-any.whl (179 kB) 2026-02-16 17:41:34.598434 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 179.1/179.1 kB 11.4 MB/s eta 0:00:00 2026-02-16 17:41:34.603717 | ubuntu-noble | Downloading cachetools-7.0.1-py3-none-any.whl (13 kB) 2026-02-16 17:41:34.616627 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2026-02-16 17:41:34.631796 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 15.2 MB/s eta 0:00:00 2026-02-16 17:41:34.635456 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-02-16 17:41:34.649227 | ubuntu-noble | Downloading filelock-3.24.2-py3-none-any.whl (24 kB) 2026-02-16 17:41:34.662927 | ubuntu-noble | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-02-16 17:41:34.675343 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 6.8 MB/s eta 0:00:00 2026-02-16 17:41:34.678699 | ubuntu-noble | Downloading platformdirs-4.9.2-py3-none-any.whl (21 kB) 2026-02-16 17:41:34.690824 | ubuntu-noble | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-02-16 17:41:34.705542 | ubuntu-noble | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-02-16 17:41:34.719608 | ubuntu-noble | Downloading virtualenv-20.37.0-py3-none-any.whl (5.8 MB) 2026-02-16 17:41:34.795097 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.8/5.8 MB 80.3 MB/s eta 0:00:00 2026-02-16 17:41:34.798971 | ubuntu-noble | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-02-16 17:41:34.821128 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 23.4 MB/s eta 0:00:00 2026-02-16 17:41:34.891397 | ubuntu-noble | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2026-02-16 17:41:35.727054 | 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 17:41:36.158724 | ubuntu-noble | ok: Runtime: 0:00:02.506240 2026-02-16 17:41:36.166966 | 2026-02-16 17:41:36.167056 | TASK [ensure-tox : Export installed tox_executable path] 2026-02-16 17:41:36.205041 | ubuntu-noble | ok 2026-02-16 17:41:36.211810 | 2026-02-16 17:41:36.211897 | TASK [ensure-tox : Output tox version] 2026-02-16 17:41:36.639458 | 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 17:41:36.653795 | ubuntu-noble | 4.36.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2026-02-16 17:41:36.754800 | ubuntu-noble | ok: Runtime: 0:00:00.269972 2026-02-16 17:41:36.759993 | 2026-02-16 17:41:36.760059 | TASK [ensure-tox : Make global symlink] 2026-02-16 17:41:36.784570 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:36.795903 | 2026-02-16 17:41:36.795955 | PLAY RECAP 2026-02-16 17:41:36.796002 | ubuntu-noble | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-02-16 17:41:36.796025 | 2026-02-16 17:41:36.939148 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2026-02-16 17:41:36.941171 | PRE-RUN START: [untrusted : github.com/vexxhost/magnum-cluster-api/zuul.d/playbooks/tox/pre.yml@main] 2026-02-16 17:41:37.540170 | 2026-02-16 17:41:37.540318 | PLAY [all] 2026-02-16 17:41:37.552329 | 2026-02-16 17:41:37.552412 | TASK [ensure-rust : Use rustup] 2026-02-16 17:41:37.587685 | ubuntu-noble | ok 2026-02-16 17:41:37.595080 | ubuntu-noble | included: /var/lib/zuul/builds/969b1923ed0b440885b6f9ffecb9111b/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-rust/tasks/rustup.yaml 2026-02-16 17:41:37.600981 | 2026-02-16 17:41:37.601058 | TASK [ensure-rust : Install Rust] 2026-02-16 17:41:37.994671 | ubuntu-noble | /bin/bash: line 2: curl: command not found 2026-02-16 17:41:38.136782 | ubuntu-noble | ERROR 2026-02-16 17:41:38.137034 | ubuntu-noble | { 2026-02-16 17:41:38.137067 | ubuntu-noble | "delta": "0:00:00.010389", 2026-02-16 17:41:38.137091 | ubuntu-noble | "end": "2026-02-16 17:41:37.995432", 2026-02-16 17:41:38.137111 | ubuntu-noble | "msg": "non-zero return code", 2026-02-16 17:41:38.137129 | ubuntu-noble | "rc": 127, 2026-02-16 17:41:38.137147 | ubuntu-noble | "start": "2026-02-16 17:41:37.985043" 2026-02-16 17:41:38.137167 | ubuntu-noble | } failure 2026-02-16 17:41:38.138872 | 2026-02-16 17:41:38.138920 | PLAY RECAP 2026-02-16 17:41:38.138996 | ubuntu-noble | ok: 1 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-02-16 17:41:38.139025 | 2026-02-16 17:41:38.257739 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/magnum-cluster-api/zuul.d/playbooks/tox/pre.yml@main] 2026-02-16 17:41:38.260264 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2026-02-16 17:41:38.850081 | 2026-02-16 17:41:38.850709 | PLAY [all] 2026-02-16 17:41:38.863312 | 2026-02-16 17:41:38.863396 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-02-16 17:41:38.919551 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:38.931279 | 2026-02-16 17:41:38.931360 | TASK [fetch-tox-output : Set tox log path for single node] 2026-02-16 17:41:38.975725 | ubuntu-noble | ok 2026-02-16 17:41:38.981943 | 2026-02-16 17:41:38.982011 | TASK [fetch-tox-output : Ensure local tox dir] 2026-02-16 17:41:39.413318 | ubuntu-noble -> localhost | changed 2026-02-16 17:41:39.420531 | 2026-02-16 17:41:39.426084 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-02-16 17:41:39.471826 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:39.482988 | 2026-02-16 17:41:39.483096 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 17:41:39.527359 | ubuntu-noble | ok 2026-02-16 17:41:39.535450 | 2026-02-16 17:41:39.535527 | TASK [fetch-tox-output : Get tox version] 2026-02-16 17:41:40.112729 | 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 17:41:40.127182 | ubuntu-noble | 4.36.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2026-02-16 17:41:40.577480 | ubuntu-noble | ok: Runtime: 0:00:00.246442 2026-02-16 17:41:40.583293 | 2026-02-16 17:41:40.583365 | TASK [fetch-tox-output : Find all default environments] 2026-02-16 17:41:41.111441 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:41.121836 | 2026-02-16 17:41:41.121936 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 17:41:41.146900 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:41.158329 | 2026-02-16 17:41:41.158394 | TASK [fetch-tox-output : Find all default environments] 2026-02-16 17:41:41.686358 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:41.698209 | 2026-02-16 17:41:41.698298 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 17:41:41.724038 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:41.734323 | 2026-02-16 17:41:41.734411 | LOOP [fetch-tox-output : Copy tox logs] 2026-02-16 17:41:41.775788 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:41.790860 | 2026-02-16 17:41:41.790984 | LOOP [fetch-tox-output : Collect tox logs] 2026-02-16 17:41:42.544983 | ubuntu-noble | ok: 2026-02-16 17:41:42.545247 | 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 17:41:42.545325 | 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 17:41:42.545374 | ubuntu-noble | rsync: [Receiver] write error: Broken pipe (32) 2026-02-16 17:41:42.545427 | 2026-02-16 17:41:42.562753 | 2026-02-16 17:41:42.562855 | PLAY RECAP 2026-02-16 17:41:42.562904 | ubuntu-noble | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-02-16 17:41:42.562927 | 2026-02-16 17:41:42.681894 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2026-02-16 17:41:42.683487 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-16 17:41:43.236640 | 2026-02-16 17:41:43.236782 | PLAY [all] 2026-02-16 17:41:43.249058 | 2026-02-16 17:41:43.249135 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-02-16 17:41:43.447961 | ubuntu-noble | changed: non-zero return code 2026-02-16 17:41:43.453880 | 2026-02-16 17:41:43.453960 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-02-16 17:41:43.478969 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:43.489966 | 2026-02-16 17:41:43.490042 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-02-16 17:41:43.525534 | 2026-02-16 17:41:43.525661 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-02-16 17:41:43.560838 | 2026-02-16 17:41:43.560971 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-02-16 17:41:43.585481 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:43.597155 | 2026-02-16 17:41:43.597225 | LOOP [fetch-subunit-output : Generate subunit file] 2026-02-16 17:41:43.633090 | 2026-02-16 17:41:43.633323 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-02-16 17:41:43.658739 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:43.676266 | 2026-02-16 17:41:43.676365 | TASK [fetch-subunit-output : Remove the temporary file] 2026-02-16 17:41:43.701136 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:43.712822 | 2026-02-16 17:41:43.712994 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-02-16 17:41:43.738723 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:43.749027 | 2026-02-16 17:41:43.749094 | PLAY RECAP 2026-02-16 17:41:43.749155 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-16 17:41:43.749187 | 2026-02-16 17:41:43.879310 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-16 17:41:43.881757 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main] 2026-02-16 17:41:44.458382 | 2026-02-16 17:41:44.458518 | PLAY [all] 2026-02-16 17:41:44.470209 | 2026-02-16 17:41:44.470284 | TASK [fetch-output : Set log path for multiple nodes] 2026-02-16 17:41:44.515352 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:41:44.527292 | 2026-02-16 17:41:44.527459 | TASK [fetch-output : Set log path for single node] 2026-02-16 17:41:44.573839 | ubuntu-noble | ok 2026-02-16 17:41:44.582647 | 2026-02-16 17:41:44.582716 | LOOP [fetch-output : Ensure local output dirs] 2026-02-16 17:41:44.969807 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/969b1923ed0b440885b6f9ffecb9111b/work/logs" 2026-02-16 17:41:45.171967 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/969b1923ed0b440885b6f9ffecb9111b/work/artifacts" 2026-02-16 17:41:45.374597 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/969b1923ed0b440885b6f9ffecb9111b/work/docs" 2026-02-16 17:41:45.385750 | 2026-02-16 17:41:45.386336 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-16 17:41:46.014543 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 17:41:46.014767 | ubuntu-noble | changed: All items complete 2026-02-16 17:41:46.014795 | 2026-02-16 17:41:46.496859 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 17:41:46.979125 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 17:41:46.997127 | 2026-02-16 17:41:46.997359 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-02-16 17:41:47.465906 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.008097 2026-02-16 17:41:47.683275 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.006655 2026-02-16 17:41:47.705129 | 2026-02-16 17:41:47.705210 | PLAY [all] 2026-02-16 17:41:47.713591 | 2026-02-16 17:41:47.713653 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-02-16 17:41:48.179362 | ubuntu-noble | changed 2026-02-16 17:41:48.185343 | 2026-02-16 17:41:48.185394 | PLAY RECAP 2026-02-16 17:41:48.185444 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-02-16 17:41:48.185465 | 2026-02-16 17:41:48.310318 | POST-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main] 2026-02-16 17:41:48.311550 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post-logs.yaml@main] 2026-02-16 17:41:48.859824 | 2026-02-16 17:41:48.860569 | PLAY [localhost] 2026-02-16 17:41:48.870988 | 2026-02-16 17:41:48.871067 | TASK [Generate Zuul manifest] 2026-02-16 17:41:48.891937 | localhost | ok 2026-02-16 17:41:48.908648 | 2026-02-16 17:41:48.908727 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-16 17:41:49.244724 | localhost | changed 2026-02-16 17:41:49.258954 | 2026-02-16 17:41:49.259034 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-16 17:41:49.292196 | localhost | ok 2026-02-16 17:41:49.301378 | 2026-02-16 17:41:49.301448 | TASK [Upload logs] 2026-02-16 17:41:49.321311 | localhost | ok 2026-02-16 17:41:49.384289 | 2026-02-16 17:41:49.384421 | TASK [Set zuul-log-path fact] 2026-02-16 17:41:49.411505 | localhost | ok 2026-02-16 17:41:49.424997 | 2026-02-16 17:41:49.425079 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-16 17:41:49.456622 | localhost | ok 2026-02-16 17:41:49.464565 | 2026-02-16 17:41:49.464634 | TASK [upload-logs : Create log directories] 2026-02-16 17:41:49.872003 | localhost | changed 2026-02-16 17:41:49.879264 | 2026-02-16 17:41:49.879336 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-02-16 17:41:50.284133 | localhost -> localhost | ok: Runtime: 0:00:00.005201 2026-02-16 17:41:50.289403 | 2026-02-16 17:41:50.289473 | TASK [upload-logs : Upload logs to log server] 2026-02-16 17:41:50.766333 | localhost | Output suppressed because no_log was given 2026-02-16 17:41:50.771792 | 2026-02-16 17:41:50.771878 | LOOP [upload-logs : Compress console log and json output] 2026-02-16 17:41:50.821455 | localhost | skipping: Conditional result was False 2026-02-16 17:41:50.827548 | localhost | skipping: Conditional result was False 2026-02-16 17:41:50.835980 | 2026-02-16 17:41:50.836109 | LOOP [upload-logs : Upload compressed console log and json output] 2026-02-16 17:41:50.877421 | localhost | skipping: Conditional result was False 2026-02-16 17:41:50.877815 | 2026-02-16 17:41:50.880543 | localhost | skipping: Conditional result was False 2026-02-16 17:41:50.890477 | 2026-02-16 17:41:50.890638 | LOOP [upload-logs : Upload console log and json output]