2026-02-16 19:19:10.374514 | Job console starting 2026-02-16 19:19:10.382760 | Updating git repos 2026-02-16 19:19:10.423118 | Cloning repos into workspace 2026-02-16 19:19:10.474863 | Restoring repo states 2026-02-16 19:19:10.484604 | Merging changes 2026-02-16 19:19:10.913024 | Checking out repos 2026-02-16 19:19:11.065507 | Preparing playbooks 2026-02-16 19:19:12.249498 | Running Ansible setup 2026-02-16 19:19:15.937549 | PRE-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main] 2026-02-16 19:19:16.646099 | 2026-02-16 19:19:16.646272 | PLAY [localhost] 2026-02-16 19:19:16.658263 | 2026-02-16 19:19:16.658460 | TASK [Gathering Facts] 2026-02-16 19:19:17.624077 | localhost | ok 2026-02-16 19:19:17.636386 | 2026-02-16 19:19:17.636573 | TASK [Setup log path fact] 2026-02-16 19:19:17.656422 | localhost | ok 2026-02-16 19:19:17.669035 | 2026-02-16 19:19:17.669255 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-16 19:19:17.702301 | localhost | ok 2026-02-16 19:19:17.716208 | 2026-02-16 19:19:17.716387 | TASK [emit-job-header : Print job information] 2026-02-16 19:19:17.764112 | # Job Information 2026-02-16 19:19:17.764346 | Ansible Version: 2.16.15 2026-02-16 19:19:17.764393 | Job: magnum-cluster-api-tox-unit 2026-02-16 19:19:17.764425 | Pipeline: check 2026-02-16 19:19:17.764453 | Executor: 3a2793d2bd32 2026-02-16 19:19:17.764482 | Triggered by: https://github.com/vexxhost/magnum-cluster-api/pull/884 2026-02-16 19:19:17.764516 | Event ID: 036266b0-0b6c-11f1-9c94-e50e60db5a7d 2026-02-16 19:19:17.768517 | 2026-02-16 19:19:17.768594 | LOOP [emit-job-header : Print node information] 2026-02-16 19:19:17.873561 | localhost | ok: 2026-02-16 19:19:17.873804 | localhost | # Node Information 2026-02-16 19:19:17.873854 | localhost | Inventory Hostname: ubuntu-noble 2026-02-16 19:19:17.873888 | localhost | Hostname: np0000155679 2026-02-16 19:19:17.873917 | localhost | Username: zuul 2026-02-16 19:19:17.873949 | localhost | Distro: Ubuntu 24.04 2026-02-16 19:19:17.873977 | localhost | Provider: yul1 2026-02-16 19:19:17.874005 | localhost | Region: ca-ymq-1 2026-02-16 19:19:17.874031 | localhost | Label: ubuntu-noble 2026-02-16 19:19:17.874058 | localhost | Product Name: OpenStack Nova 2026-02-16 19:19:17.874085 | localhost | Interface IP: 162.253.55.62 2026-02-16 19:19:17.887018 | 2026-02-16 19:19:17.887247 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-16 19:19:18.301365 | localhost -> localhost | changed 2026-02-16 19:19:18.309279 | 2026-02-16 19:19:18.309429 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-16 19:19:19.252421 | localhost -> localhost | changed 2026-02-16 19:19:19.262596 | 2026-02-16 19:19:19.262707 | PLAY [all] 2026-02-16 19:19:19.276900 | 2026-02-16 19:19:19.277228 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-16 19:19:19.561757 | ubuntu-noble -> localhost | ok 2026-02-16 19:19:19.574496 | 2026-02-16 19:19:19.574688 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-16 19:19:19.611120 | ubuntu-noble | ok 2026-02-16 19:19:19.630174 | ubuntu-noble | included: /var/lib/zuul/builds/a2ddc09986be470aa56381e47867a929/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-16 19:19:19.637462 | 2026-02-16 19:19:19.637623 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-16 19:19:20.928807 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2026-02-16 19:19:20.929101 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/a2ddc09986be470aa56381e47867a929/work/a2ddc09986be470aa56381e47867a929_id_rsa 2026-02-16 19:19:20.929135 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/a2ddc09986be470aa56381e47867a929/work/a2ddc09986be470aa56381e47867a929_id_rsa.pub 2026-02-16 19:19:20.929159 | ubuntu-noble -> localhost | The key fingerprint is: 2026-02-16 19:19:20.929181 | ubuntu-noble -> localhost | SHA256:n1tyfYh+c7715WrvQd4bI/0vQf+S0IMeHtWQL2iJu44 zuul-build-sshkey 2026-02-16 19:19:20.929226 | ubuntu-noble -> localhost | The key's randomart image is: 2026-02-16 19:19:20.929257 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2026-02-16 19:19:20.929288 | ubuntu-noble -> localhost | | . | 2026-02-16 19:19:20.929311 | ubuntu-noble -> localhost | | o | 2026-02-16 19:19:20.929331 | ubuntu-noble -> localhost | | . o + | 2026-02-16 19:19:20.929351 | ubuntu-noble -> localhost | | . + + o| 2026-02-16 19:19:20.929370 | ubuntu-noble -> localhost | | S o = + | 2026-02-16 19:19:20.929390 | ubuntu-noble -> localhost | | ...=oB.o| 2026-02-16 19:19:20.929409 | ubuntu-noble -> localhost | | +++=oX*| 2026-02-16 19:19:20.929429 | ubuntu-noble -> localhost | | ..*o Oo%| 2026-02-16 19:19:20.929450 | ubuntu-noble -> localhost | | E.o .o.%@| 2026-02-16 19:19:20.929470 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2026-02-16 19:19:20.929530 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.856886 2026-02-16 19:19:20.939144 | 2026-02-16 19:19:20.939332 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-16 19:19:20.972560 | ubuntu-noble | ok 2026-02-16 19:19:20.987212 | ubuntu-noble | included: /var/lib/zuul/builds/a2ddc09986be470aa56381e47867a929/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-16 19:19:21.000609 | 2026-02-16 19:19:21.000796 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-16 19:19:21.026920 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:21.036265 | 2026-02-16 19:19:21.036442 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-16 19:19:21.625804 | ubuntu-noble | changed 2026-02-16 19:19:21.631567 | 2026-02-16 19:19:21.631648 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-16 19:19:21.859678 | ubuntu-noble | ok 2026-02-16 19:19:21.866045 | 2026-02-16 19:19:21.866119 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-16 19:19:22.433389 | ubuntu-noble | changed 2026-02-16 19:19:22.439311 | 2026-02-16 19:19:22.439421 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-16 19:19:22.965904 | ubuntu-noble | changed 2026-02-16 19:19:22.974055 | 2026-02-16 19:19:22.974259 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-16 19:19:22.999531 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:23.012094 | 2026-02-16 19:19:23.012307 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-16 19:19:23.383490 | ubuntu-noble -> localhost | changed 2026-02-16 19:19:23.400928 | 2026-02-16 19:19:23.401059 | TASK [add-build-sshkey : Add back temp key] 2026-02-16 19:19:23.691169 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/a2ddc09986be470aa56381e47867a929/work/a2ddc09986be470aa56381e47867a929_id_rsa (zuul-build-sshkey) 2026-02-16 19:19:23.691476 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.013978 2026-02-16 19:19:23.702539 | 2026-02-16 19:19:23.702678 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-16 19:19:24.034816 | ubuntu-noble | ok 2026-02-16 19:19:24.042003 | 2026-02-16 19:19:24.042153 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-16 19:19:24.067240 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:24.085789 | 2026-02-16 19:19:24.085969 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-02-16 19:19:24.442919 | ubuntu-noble | ok 2026-02-16 19:19:24.452635 | 2026-02-16 19:19:24.452761 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-02-16 19:19:25.550230 | ubuntu-noble | Output suppressed because no_log was given 2026-02-16 19:19:25.562183 | 2026-02-16 19:19:25.562312 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-02-16 19:19:25.785179 | ubuntu-noble | ok: "logs" 2026-02-16 19:19:25.785499 | ubuntu-noble | ok: All items complete 2026-02-16 19:19:25.785553 | 2026-02-16 19:19:26.032465 | ubuntu-noble | ok: "artifacts" 2026-02-16 19:19:26.171948 | ubuntu-noble | ok: "docs" 2026-02-16 19:19:26.180740 | 2026-02-16 19:19:26.180919 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-02-16 19:19:26.410434 | ubuntu-noble | changed: "logs" 2026-02-16 19:19:26.603415 | ubuntu-noble | changed: "artifacts" 2026-02-16 19:19:26.810690 | ubuntu-noble | changed: "docs" 2026-02-16 19:19:26.825655 | 2026-02-16 19:19:26.825813 | PLAY RECAP 2026-02-16 19:19:26.825874 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-16 19:19:26.825914 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-02-16 19:19:26.825946 | 2026-02-16 19:19:26.970573 | PRE-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main] 2026-02-16 19:19:26.973216 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-16 19:19:27.565205 | 2026-02-16 19:19:27.565383 | PLAY [all] 2026-02-16 19:19:27.578850 | 2026-02-16 19:19:27.578945 | TASK [Install binary dependencies] 2026-02-16 19:19:27.634120 | ubuntu-noble | ok 2026-02-16 19:19:27.652728 | 2026-02-16 19:19:27.652820 | TASK [bindep : Include find tasks] 2026-02-16 19:19:27.685856 | ubuntu-noble | ok 2026-02-16 19:19:27.694759 | ubuntu-noble | included: /var/lib/zuul/builds/a2ddc09986be470aa56381e47867a929/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-02-16 19:19:27.701360 | 2026-02-16 19:19:27.701432 | TASK [bindep : Look for bindep.txt] 2026-02-16 19:19:28.041281 | ubuntu-noble | ok 2026-02-16 19:19:28.048133 | 2026-02-16 19:19:28.048383 | TASK [bindep : Define bindep_file fact] 2026-02-16 19:19:28.073491 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:28.084678 | 2026-02-16 19:19:28.084884 | TASK [bindep : Look for other-requirements.txt] 2026-02-16 19:19:28.291239 | ubuntu-noble | ok 2026-02-16 19:19:28.297469 | 2026-02-16 19:19:28.297543 | TASK [bindep : Define bindep_file fact] 2026-02-16 19:19:28.322705 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:28.332562 | 2026-02-16 19:19:28.332663 | TASK [bindep : Look for bindep fallback file] 2026-02-16 19:19:28.355785 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:28.368337 | 2026-02-16 19:19:28.368468 | TASK [bindep : Define bindep_file fact] 2026-02-16 19:19:28.393423 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:28.405210 | 2026-02-16 19:19:28.405349 | TASK [bindep : Include bindep tasks] 2026-02-16 19:19:28.430392 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:28.440749 | 2026-02-16 19:19:28.440859 | TASK [bindep : Include install tasks] 2026-02-16 19:19:28.465833 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:28.477125 | 2026-02-16 19:19:28.477301 | LOOP [bindep : Include package tasks] 2026-02-16 19:19:28.537362 | 2026-02-16 19:19:28.537608 | TASK [Run test-setup role] 2026-02-16 19:19:28.561671 | ubuntu-noble | ok 2026-02-16 19:19:28.586810 | 2026-02-16 19:19:28.586993 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-02-16 19:19:28.794015 | ubuntu-noble | ok 2026-02-16 19:19:28.801210 | 2026-02-16 19:19:28.801283 | TASK [test-setup : Run tools/test-setup.sh] 2026-02-16 19:19:29.331267 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:29.338855 | 2026-02-16 19:19:29.338974 | PLAY RECAP 2026-02-16 19:19:29.339034 | ubuntu-noble | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-16 19:19:29.339065 | 2026-02-16 19:19:29.455622 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-16 19:19:29.458046 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2026-02-16 19:19:30.105879 | 2026-02-16 19:19:30.106133 | PLAY [all] 2026-02-16 19:19:30.124179 | 2026-02-16 19:19:30.124320 | TASK [ensure-python : Validate python_version value] 2026-02-16 19:19:30.150091 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:30.161083 | 2026-02-16 19:19:30.161182 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)] 2026-02-16 19:19:30.186947 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:30.199070 | 2026-02-16 19:19:30.199210 | TASK [ensure-python : Pull in venv package] 2026-02-16 19:19:30.224765 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:30.236503 | 2026-02-16 19:19:30.236611 | TASK [ensure-python : Set default RPM package name] 2026-02-16 19:19:30.262667 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:30.272692 | 2026-02-16 19:19:30.273061 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9/10] 2026-02-16 19:19:30.299671 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:30.309036 | 2026-02-16 19:19:30.309211 | TASK [ensure-python : Install RPM package] 2026-02-16 19:19:30.335780 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:30.345217 | 2026-02-16 19:19:30.345426 | TASK [ensure-python : Install python using pyenv] 2026-02-16 19:19:30.362453 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:30.372648 | 2026-02-16 19:19:30.372879 | TASK [ensure-python : Activate python using stow] 2026-02-16 19:19:30.401513 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:30.420335 | 2026-02-16 19:19:30.420511 | TASK [Install pip] 2026-02-16 19:19:30.444366 | ubuntu-noble | ok 2026-02-16 19:19:30.478172 | 2026-02-16 19:19:30.478358 | TASK [ensure-pip : Check if pip is installed] 2026-02-16 19:19:31.025194 | ubuntu-noble | ok: Runtime: 0:00:00.005743 2026-02-16 19:19:31.031649 | 2026-02-16 19:19:31.031715 | LOOP [ensure-pip : Install pip from packages] 2026-02-16 19:19:31.066911 | ubuntu-noble | ok: "/var/lib/zuul/builds/a2ddc09986be470aa56381e47867a929/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/Debian.yaml" 2026-02-16 19:19:31.085114 | ubuntu-noble | included: /var/lib/zuul/builds/a2ddc09986be470aa56381e47867a929/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/Debian.yaml 2026-02-16 19:19:31.093992 | 2026-02-16 19:19:31.094062 | TASK [ensure-pip : Update package lists] 2026-02-16 19:19:37.665598 | ubuntu-noble | changed 2026-02-16 19:19:37.671072 | 2026-02-16 19:19:37.671144 | TASK [ensure-pip : Install Python 3 pip] 2026-02-16 19:19:43.902270 | ubuntu-noble | changed 2026-02-16 19:19:43.909348 | 2026-02-16 19:19:43.909464 | TASK [ensure-pip : Install Python 2 pip] 2026-02-16 19:19:43.934873 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:43.946175 | 2026-02-16 19:19:43.946379 | TASK [ensure-pip : Ensure setuptools] 2026-02-16 19:19:43.972657 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:43.983469 | 2026-02-16 19:19:43.983659 | TASK [ensure-pip : Check for ensurepip module] 2026-02-16 19:19:44.284900 | ubuntu-noble | usage: python -m ensurepip [-h] [--version] [-v] [-U] [--user] [--root ROOT] 2026-02-16 19:19:44.285007 | ubuntu-noble | [--altinstall] [--default-pip] 2026-02-16 19:19:44.285022 | ubuntu-noble | 2026-02-16 19:19:44.285032 | ubuntu-noble | options: 2026-02-16 19:19:44.285042 | ubuntu-noble | -h, --help show this help message and exit 2026-02-16 19:19:44.285057 | ubuntu-noble | --version Show the version of pip that is bundled with this Python. 2026-02-16 19:19:44.285069 | ubuntu-noble | -v, --verbose Give more output. Option is additive, and can be used up to 3 2026-02-16 19:19:44.285083 | ubuntu-noble | times. 2026-02-16 19:19:44.285093 | ubuntu-noble | -U, --upgrade Upgrade pip and dependencies, even if already installed. 2026-02-16 19:19:44.285102 | ubuntu-noble | --user Install using the user scheme. 2026-02-16 19:19:44.285111 | ubuntu-noble | --root ROOT Install everything relative to this alternate root directory. 2026-02-16 19:19:44.285120 | ubuntu-noble | --altinstall Make an alternate install, installing only the X.Y versioned 2026-02-16 19:19:44.285128 | ubuntu-noble | scripts (Default: pipX, pipX.Y). 2026-02-16 19:19:44.285137 | ubuntu-noble | --default-pip Make a default pip install, installing the unqualified pip in 2026-02-16 19:19:44.285145 | ubuntu-noble | addition to the versioned scripts. 2026-02-16 19:19:44.537001 | ubuntu-noble | ok: Runtime: 0:00:00.065028 2026-02-16 19:19:44.544530 | 2026-02-16 19:19:44.544620 | TASK [ensure-pip : Ensure python3-venv] 2026-02-16 19:19:44.569334 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:44.580508 | 2026-02-16 19:19:44.580684 | TASK [ensure-pip : Install pip from source] 2026-02-16 19:19:44.607108 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:44.657954 | 2026-02-16 19:19:44.658112 | TASK [ensure-pip : Probe for venv python full path] 2026-02-16 19:19:44.888269 | ubuntu-noble | /usr/bin/python3 2026-02-16 19:19:45.196531 | ubuntu-noble | ok: Runtime: 0:00:00.008428 2026-02-16 19:19:45.202710 | 2026-02-16 19:19:45.202840 | TASK [ensure-pip : Set host default] 2026-02-16 19:19:45.255329 | ubuntu-noble | ok 2026-02-16 19:19:45.261021 | 2026-02-16 19:19:45.261095 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2026-02-16 19:19:45.315299 | ubuntu-noble | ok 2026-02-16 19:19:45.325054 | 2026-02-16 19:19:45.325131 | TASK [ensure-tox : Check if tox is installed] 2026-02-16 19:19:45.866687 | ubuntu-noble | ok: Runtime: 0:00:00.004490 2026-02-16 19:19:45.873029 | 2026-02-16 19:19:45.873165 | TASK [ensure-tox : Export preinstalled tox_exectuable] 2026-02-16 19:19:45.898445 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:45.909671 | 2026-02-16 19:19:45.909861 | TASK [ensure-tox : Create local venv] 2026-02-16 19:19:49.452329 | ubuntu-noble | ok: Runtime: 0:00:03.098303 2026-02-16 19:19:49.457680 | 2026-02-16 19:19:49.457744 | TASK [ensure-tox : Install tox to local venv] 2026-02-16 19:19:50.209882 | ubuntu-noble | Collecting tox 2026-02-16 19:19:50.274475 | ubuntu-noble | Downloading tox-4.36.0-py3-none-any.whl.metadata (3.6 kB) 2026-02-16 19:19:50.338496 | ubuntu-noble | Collecting cachetools>=7.0.1 (from tox) 2026-02-16 19:19:50.351172 | ubuntu-noble | Downloading cachetools-7.0.1-py3-none-any.whl.metadata (5.6 kB) 2026-02-16 19:19:50.392751 | ubuntu-noble | Collecting chardet>=5.2 (from tox) 2026-02-16 19:19:50.410249 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl.metadata (3.4 kB) 2026-02-16 19:19:50.463607 | ubuntu-noble | Collecting colorama>=0.4.6 (from tox) 2026-02-16 19:19:50.472955 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2026-02-16 19:19:50.536085 | ubuntu-noble | Collecting filelock>=3.24 (from tox) 2026-02-16 19:19:50.545942 | ubuntu-noble | Downloading filelock-3.24.2-py3-none-any.whl.metadata (2.0 kB) 2026-02-16 19:19:50.602551 | ubuntu-noble | Collecting packaging>=26 (from tox) 2026-02-16 19:19:50.612594 | ubuntu-noble | Downloading packaging-26.0-py3-none-any.whl.metadata (3.3 kB) 2026-02-16 19:19:50.678239 | ubuntu-noble | Collecting platformdirs>=4.9.1 (from tox) 2026-02-16 19:19:50.688226 | ubuntu-noble | Downloading platformdirs-4.9.2-py3-none-any.whl.metadata (4.7 kB) 2026-02-16 19:19:50.736616 | ubuntu-noble | Collecting pluggy>=1.6 (from tox) 2026-02-16 19:19:50.745365 | ubuntu-noble | Downloading pluggy-1.6.0-py3-none-any.whl.metadata (4.8 kB) 2026-02-16 19:19:50.794456 | ubuntu-noble | Collecting pyproject-api>=1.10 (from tox) 2026-02-16 19:19:50.804750 | ubuntu-noble | Downloading pyproject_api-1.10.0-py3-none-any.whl.metadata (2.7 kB) 2026-02-16 19:19:50.933567 | ubuntu-noble | Collecting virtualenv>=20.36.1 (from tox) 2026-02-16 19:19:50.946962 | ubuntu-noble | Downloading virtualenv-20.37.0-py3-none-any.whl.metadata (5.1 kB) 2026-02-16 19:19:51.048019 | ubuntu-noble | Collecting distlib<1,>=0.3.7 (from virtualenv>=20.36.1->tox) 2026-02-16 19:19:51.056896 | ubuntu-noble | Downloading distlib-0.4.0-py2.py3-none-any.whl.metadata (5.2 kB) 2026-02-16 19:19:51.096861 | ubuntu-noble | Downloading tox-4.36.0-py3-none-any.whl (179 kB) 2026-02-16 19:19:51.129852 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 179.1/179.1 kB 6.5 MB/s eta 0:00:00 2026-02-16 19:19:51.140291 | ubuntu-noble | Downloading cachetools-7.0.1-py3-none-any.whl (13 kB) 2026-02-16 19:19:51.161328 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2026-02-16 19:19:51.179972 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 13.4 MB/s eta 0:00:00 2026-02-16 19:19:51.192411 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-02-16 19:19:51.211055 | ubuntu-noble | Downloading filelock-3.24.2-py3-none-any.whl (24 kB) 2026-02-16 19:19:51.231307 | ubuntu-noble | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-02-16 19:19:51.247352 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 5.5 MB/s eta 0:00:00 2026-02-16 19:19:51.257762 | ubuntu-noble | Downloading platformdirs-4.9.2-py3-none-any.whl (21 kB) 2026-02-16 19:19:51.278594 | ubuntu-noble | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-02-16 19:19:51.300996 | ubuntu-noble | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-02-16 19:19:51.320760 | ubuntu-noble | Downloading virtualenv-20.37.0-py3-none-any.whl (5.8 MB) 2026-02-16 19:19:51.449398 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.8/5.8 MB 46.7 MB/s eta 0:00:00 2026-02-16 19:19:51.460456 | ubuntu-noble | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-02-16 19:19:51.486283 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 21.1 MB/s eta 0:00:00 2026-02-16 19:19:51.556151 | ubuntu-noble | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2026-02-16 19:19:52.421090 | 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:53.001298 | ubuntu-noble | ok: Runtime: 0:00:02.825433 2026-02-16 19:19:53.012343 | 2026-02-16 19:19:53.012564 | TASK [ensure-tox : Export installed tox_executable path] 2026-02-16 19:19:53.049756 | ubuntu-noble | ok 2026-02-16 19:19:53.058936 | 2026-02-16 19:19:53.059161 | TASK [ensure-tox : Output tox version] 2026-02-16 19:19:53.543844 | 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:53.557374 | ubuntu-noble | 4.36.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2026-02-16 19:19:53.634000 | ubuntu-noble | ok: Runtime: 0:00:00.256296 2026-02-16 19:19:53.639932 | 2026-02-16 19:19:53.640061 | TASK [ensure-tox : Make global symlink] 2026-02-16 19:19:53.666728 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:53.677194 | 2026-02-16 19:19:53.677331 | PLAY RECAP 2026-02-16 19:19:53.677381 | ubuntu-noble | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-02-16 19:19:53.677404 | 2026-02-16 19:19:53.838202 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2026-02-16 19:19:53.840541 | PRE-RUN START: [untrusted : github.com/vexxhost/magnum-cluster-api/zuul.d/playbooks/tox/pre.yml@main] 2026-02-16 19:19:54.458529 | 2026-02-16 19:19:54.458697 | PLAY [all] 2026-02-16 19:19:54.478238 | 2026-02-16 19:19:54.478551 | TASK [ensure-rust : Use rustup] 2026-02-16 19:19:54.516476 | ubuntu-noble | ok 2026-02-16 19:19:54.524090 | ubuntu-noble | included: /var/lib/zuul/builds/a2ddc09986be470aa56381e47867a929/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-rust/tasks/rustup.yaml 2026-02-16 19:19:54.531104 | 2026-02-16 19:19:54.531206 | TASK [ensure-rust : Install Rust] 2026-02-16 19:19:54.946920 | ubuntu-noble | /bin/bash: line 2: curl: command not found 2026-02-16 19:19:55.067055 | ubuntu-noble | ERROR 2026-02-16 19:19:55.067242 | ubuntu-noble | { 2026-02-16 19:19:55.067279 | ubuntu-noble | "delta": "0:00:00.007050", 2026-02-16 19:19:55.067307 | ubuntu-noble | "end": "2026-02-16 19:19:54.948322", 2026-02-16 19:19:55.067332 | ubuntu-noble | "msg": "non-zero return code", 2026-02-16 19:19:55.067354 | ubuntu-noble | "rc": 127, 2026-02-16 19:19:55.067376 | ubuntu-noble | "start": "2026-02-16 19:19:54.941272" 2026-02-16 19:19:55.067404 | ubuntu-noble | } failure 2026-02-16 19:19:55.069146 | 2026-02-16 19:19:55.069208 | PLAY RECAP 2026-02-16 19:19:55.069269 | ubuntu-noble | ok: 1 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-02-16 19:19:55.069304 | 2026-02-16 19:19:55.210460 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/magnum-cluster-api/zuul.d/playbooks/tox/pre.yml@main] 2026-02-16 19:19:55.213874 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2026-02-16 19:19:55.850188 | 2026-02-16 19:19:55.850357 | PLAY [all] 2026-02-16 19:19:55.863408 | 2026-02-16 19:19:55.863518 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-02-16 19:19:55.909083 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:55.920432 | 2026-02-16 19:19:55.920525 | TASK [fetch-tox-output : Set tox log path for single node] 2026-02-16 19:19:55.964309 | ubuntu-noble | ok 2026-02-16 19:19:55.973003 | 2026-02-16 19:19:55.973201 | TASK [fetch-tox-output : Ensure local tox dir] 2026-02-16 19:19:56.426599 | ubuntu-noble -> localhost | changed 2026-02-16 19:19:56.438188 | 2026-02-16 19:19:56.438425 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-02-16 19:19:56.484431 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:56.494783 | 2026-02-16 19:19:56.494972 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 19:19:56.541152 | ubuntu-noble | ok 2026-02-16 19:19:56.547496 | 2026-02-16 19:19:56.547612 | TASK [fetch-tox-output : Get tox version] 2026-02-16 19:19:57.136988 | 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.151015 | ubuntu-noble | 4.36.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2026-02-16 19:19:57.590318 | ubuntu-noble | ok: Runtime: 0:00:00.248193 2026-02-16 19:19:57.598975 | 2026-02-16 19:19:57.599184 | TASK [fetch-tox-output : Find all default environments] 2026-02-16 19:19:58.143150 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:58.150488 | 2026-02-16 19:19:58.150691 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 19:19:58.176132 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:58.185539 | 2026-02-16 19:19:58.185770 | TASK [fetch-tox-output : Find all default environments] 2026-02-16 19:19:58.721011 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:58.730183 | 2026-02-16 19:19:58.730283 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 19:19:58.754862 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:58.765960 | 2026-02-16 19:19:58.766044 | LOOP [fetch-tox-output : Copy tox logs] 2026-02-16 19:19:58.804839 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:19:58.823625 | 2026-02-16 19:19:58.823812 | LOOP [fetch-tox-output : Collect tox logs] 2026-02-16 19:19:59.602790 | ubuntu-noble | ok: 2026-02-16 19:19:59.602962 | ubuntu-noble | rsync: [sender] change_dir "/home/zuul/src/github.com/vexxhost/magnum-cluster-api/.tox/unit/log" failed: No such file or directory (2) 2026-02-16 19:19:59.603005 | 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:19:59.603030 | ubuntu-noble | rsync: [Receiver] write error: Broken pipe (32) 2026-02-16 19:19:59.603055 | 2026-02-16 19:19:59.620122 | 2026-02-16 19:19:59.620205 | PLAY RECAP 2026-02-16 19:19:59.620251 | ubuntu-noble | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-02-16 19:19:59.620272 | 2026-02-16 19:19:59.745716 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2026-02-16 19:19:59.746905 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-16 19:20:00.409883 | 2026-02-16 19:20:00.410097 | PLAY [all] 2026-02-16 19:20:00.424508 | 2026-02-16 19:20:00.424722 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-02-16 19:20:00.623413 | ubuntu-noble | changed: non-zero return code 2026-02-16 19:20:00.630200 | 2026-02-16 19:20:00.630283 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-02-16 19:20:00.655642 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:00.666053 | 2026-02-16 19:20:00.666153 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-02-16 19:20:00.693497 | 2026-02-16 19:20:00.693726 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-02-16 19:20:00.731009 | 2026-02-16 19:20:00.731215 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-02-16 19:20:00.756463 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:00.769325 | 2026-02-16 19:20:00.769547 | LOOP [fetch-subunit-output : Generate subunit file] 2026-02-16 19:20:00.806700 | 2026-02-16 19:20:00.807015 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-02-16 19:20:00.824616 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:00.836480 | 2026-02-16 19:20:00.836653 | TASK [fetch-subunit-output : Remove the temporary file] 2026-02-16 19:20:00.862881 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:00.872927 | 2026-02-16 19:20:00.873087 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-02-16 19:20:00.898718 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:00.905799 | 2026-02-16 19:20:00.905863 | PLAY RECAP 2026-02-16 19:20:00.905911 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-16 19:20:00.905932 | 2026-02-16 19:20:01.060256 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-16 19:20:01.062807 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main] 2026-02-16 19:20:01.664048 | 2026-02-16 19:20:01.664194 | PLAY [all] 2026-02-16 19:20:01.675893 | 2026-02-16 19:20:01.676053 | TASK [fetch-output : Set log path for multiple nodes] 2026-02-16 19:20:01.731287 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:01.740262 | 2026-02-16 19:20:01.740400 | TASK [fetch-output : Set log path for single node] 2026-02-16 19:20:01.785158 | ubuntu-noble | ok 2026-02-16 19:20:01.791357 | 2026-02-16 19:20:01.791438 | LOOP [fetch-output : Ensure local output dirs] 2026-02-16 19:20:02.217393 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/a2ddc09986be470aa56381e47867a929/work/logs" 2026-02-16 19:20:02.431497 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/a2ddc09986be470aa56381e47867a929/work/artifacts" 2026-02-16 19:20:02.654519 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/a2ddc09986be470aa56381e47867a929/work/docs" 2026-02-16 19:20:02.669034 | 2026-02-16 19:20:02.669221 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-16 19:20:03.327173 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 19:20:03.327538 | ubuntu-noble | changed: All items complete 2026-02-16 19:20:03.327588 | 2026-02-16 19:20:03.772078 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 19:20:04.249251 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 19:20:04.271803 | 2026-02-16 19:20:04.271894 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-02-16 19:20:04.755108 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.008739 2026-02-16 19:20:04.989438 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.007991 2026-02-16 19:20:05.009435 | 2026-02-16 19:20:05.009560 | PLAY [all] 2026-02-16 19:20:05.016929 | 2026-02-16 19:20:05.017047 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-02-16 19:20:05.509254 | ubuntu-noble | changed 2026-02-16 19:20:05.515639 | 2026-02-16 19:20:05.515696 | PLAY RECAP 2026-02-16 19:20:05.515742 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-02-16 19:20:05.515764 | 2026-02-16 19:20:05.629315 | POST-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main] 2026-02-16 19:20:05.631047 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post-logs.yaml@main] 2026-02-16 19:20:06.224292 | 2026-02-16 19:20:06.224431 | PLAY [localhost] 2026-02-16 19:20:06.235197 | 2026-02-16 19:20:06.235330 | TASK [Generate Zuul manifest] 2026-02-16 19:20:06.257490 | localhost | ok 2026-02-16 19:20:06.272510 | 2026-02-16 19:20:06.272594 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-16 19:20:06.600066 | localhost | changed 2026-02-16 19:20:06.614206 | 2026-02-16 19:20:06.614307 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-16 19:20:06.646915 | localhost | ok 2026-02-16 19:20:06.656781 | 2026-02-16 19:20:06.656934 | TASK [Upload logs] 2026-02-16 19:20:06.680318 | localhost | ok 2026-02-16 19:20:06.742064 | 2026-02-16 19:20:06.742203 | TASK [Set zuul-log-path fact] 2026-02-16 19:20:06.763847 | localhost | ok 2026-02-16 19:20:06.776566 | 2026-02-16 19:20:06.776634 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-16 19:20:06.806720 | localhost | ok 2026-02-16 19:20:06.814662 | 2026-02-16 19:20:06.814742 | TASK [upload-logs : Create log directories] 2026-02-16 19:20:07.233220 | localhost | changed 2026-02-16 19:20:07.240202 | 2026-02-16 19:20:07.240350 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-02-16 19:20:07.742566 | localhost -> localhost | ok: Runtime: 0:00:00.004638 2026-02-16 19:20:07.748307 | 2026-02-16 19:20:07.748414 | TASK [upload-logs : Upload logs to log server] 2026-02-16 19:20:08.259620 | localhost | Output suppressed because no_log was given 2026-02-16 19:20:08.266290 | 2026-02-16 19:20:08.266358 | LOOP [upload-logs : Compress console log and json output] 2026-02-16 19:20:08.313366 | localhost | skipping: Conditional result was False 2026-02-16 19:20:08.320981 | localhost | skipping: Conditional result was False 2026-02-16 19:20:08.339470 | 2026-02-16 19:20:08.339610 | LOOP [upload-logs : Upload compressed console log and json output] 2026-02-16 19:20:08.383442 | localhost | skipping: Conditional result was False 2026-02-16 19:20:08.383891 | 2026-02-16 19:20:08.387174 | localhost | skipping: Conditional result was False 2026-02-16 19:20:08.404637 | 2026-02-16 19:20:08.404907 | LOOP [upload-logs : Upload console log and json output]