2026-02-16 19:20:40.651209 | Job console starting 2026-02-16 19:20:40.676669 | Updating git repos 2026-02-16 19:20:40.724238 | Cloning repos into workspace 2026-02-16 19:20:40.769870 | Restoring repo states 2026-02-16 19:20:40.783039 | Merging changes 2026-02-16 19:20:41.213925 | Checking out repos 2026-02-16 19:20:41.257589 | Preparing playbooks 2026-02-16 19:20:42.350369 | Running Ansible setup 2026-02-16 19:20:46.067133 | PRE-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main] 2026-02-16 19:20:46.901410 | 2026-02-16 19:20:46.901583 | PLAY [localhost] 2026-02-16 19:20:46.910260 | 2026-02-16 19:20:46.910356 | TASK [Gathering Facts] 2026-02-16 19:20:47.833895 | localhost | ok 2026-02-16 19:20:47.844690 | 2026-02-16 19:20:47.844809 | TASK [Setup log path fact] 2026-02-16 19:20:47.866394 | localhost | ok 2026-02-16 19:20:47.878633 | 2026-02-16 19:20:47.878731 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-16 19:20:47.910378 | localhost | ok 2026-02-16 19:20:47.919042 | 2026-02-16 19:20:47.919151 | TASK [emit-job-header : Print job information] 2026-02-16 19:20:47.960289 | # Job Information 2026-02-16 19:20:47.960500 | Ansible Version: 2.16.15 2026-02-16 19:20:47.960547 | Job: magnum-cluster-api-tox-functional 2026-02-16 19:20:47.960581 | Pipeline: check 2026-02-16 19:20:47.960608 | Executor: 3a2793d2bd32 2026-02-16 19:20:47.960635 | Triggered by: https://github.com/vexxhost/magnum-cluster-api/pull/884 2026-02-16 19:20:47.960666 | Event ID: 036266b0-0b6c-11f1-9c94-e50e60db5a7d 2026-02-16 19:20:47.964913 | 2026-02-16 19:20:47.965027 | LOOP [emit-job-header : Print node information] 2026-02-16 19:20:48.071647 | localhost | ok: 2026-02-16 19:20:48.071890 | localhost | # Node Information 2026-02-16 19:20:48.071931 | localhost | Inventory Hostname: ubuntu-noble 2026-02-16 19:20:48.071963 | localhost | Hostname: np0000155682 2026-02-16 19:20:48.071992 | localhost | Username: zuul 2026-02-16 19:20:48.072025 | localhost | Distro: Ubuntu 24.04 2026-02-16 19:20:48.072054 | localhost | Provider: yul1 2026-02-16 19:20:48.072082 | localhost | Region: ca-ymq-1 2026-02-16 19:20:48.072110 | localhost | Label: ubuntu-noble 2026-02-16 19:20:48.072138 | localhost | Product Name: OpenStack Nova 2026-02-16 19:20:48.072165 | localhost | Interface IP: 162.253.55.227 2026-02-16 19:20:48.084123 | 2026-02-16 19:20:48.084783 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-16 19:20:48.521473 | localhost -> localhost | changed 2026-02-16 19:20:48.526936 | 2026-02-16 19:20:48.527095 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-16 19:20:49.447892 | localhost -> localhost | changed 2026-02-16 19:20:49.457138 | 2026-02-16 19:20:49.457256 | PLAY [all] 2026-02-16 19:20:49.473693 | 2026-02-16 19:20:49.474489 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-16 19:20:49.704873 | ubuntu-noble -> localhost | ok 2026-02-16 19:20:49.715107 | 2026-02-16 19:20:49.715272 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-16 19:20:49.749393 | ubuntu-noble | ok 2026-02-16 19:20:49.768194 | ubuntu-noble | included: /var/lib/zuul/builds/688bf1f4dbf7421baa126972a33c3584/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-16 19:20:49.774948 | 2026-02-16 19:20:49.775078 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-16 19:20:51.017164 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2026-02-16 19:20:51.017384 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/688bf1f4dbf7421baa126972a33c3584/work/688bf1f4dbf7421baa126972a33c3584_id_rsa 2026-02-16 19:20:51.017417 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/688bf1f4dbf7421baa126972a33c3584/work/688bf1f4dbf7421baa126972a33c3584_id_rsa.pub 2026-02-16 19:20:51.017441 | ubuntu-noble -> localhost | The key fingerprint is: 2026-02-16 19:20:51.017463 | ubuntu-noble -> localhost | SHA256:7Xkolz+TWB6LstowPj7+6YeX9dBUosAXI/xfr4Y+N/I zuul-build-sshkey 2026-02-16 19:20:51.017523 | ubuntu-noble -> localhost | The key's randomart image is: 2026-02-16 19:20:51.017565 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2026-02-16 19:20:51.017600 | ubuntu-noble -> localhost | | o. o. | 2026-02-16 19:20:51.017631 | ubuntu-noble -> localhost | | +.... .| 2026-02-16 19:20:51.017660 | ubuntu-noble -> localhost | | + . o | 2026-02-16 19:20:51.017688 | ubuntu-noble -> localhost | | . o . .| 2026-02-16 19:20:51.017715 | ubuntu-noble -> localhost | | S . + ..| 2026-02-16 19:20:51.017741 | ubuntu-noble -> localhost | | . += o .| 2026-02-16 19:20:51.017767 | ubuntu-noble -> localhost | | o ..*B.B . | 2026-02-16 19:20:51.017794 | ubuntu-noble -> localhost | | .o+o+*oX * | 2026-02-16 19:20:51.017823 | ubuntu-noble -> localhost | | o=**= .oOE. | 2026-02-16 19:20:51.017850 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2026-02-16 19:20:51.017914 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.789169 2026-02-16 19:20:51.027314 | 2026-02-16 19:20:51.027472 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-16 19:20:51.062065 | ubuntu-noble | ok 2026-02-16 19:20:51.073617 | ubuntu-noble | included: /var/lib/zuul/builds/688bf1f4dbf7421baa126972a33c3584/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-16 19:20:51.082555 | 2026-02-16 19:20:51.082639 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-16 19:20:51.117577 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:51.129168 | 2026-02-16 19:20:51.129245 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-16 19:20:51.791618 | ubuntu-noble | changed 2026-02-16 19:20:51.799884 | 2026-02-16 19:20:51.800105 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-16 19:20:52.031534 | ubuntu-noble | ok 2026-02-16 19:20:52.037110 | 2026-02-16 19:20:52.037187 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-16 19:20:52.620844 | ubuntu-noble | changed 2026-02-16 19:20:52.629877 | 2026-02-16 19:20:52.630076 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-16 19:20:53.183780 | ubuntu-noble | changed 2026-02-16 19:20:53.193427 | 2026-02-16 19:20:53.193571 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-16 19:20:53.219591 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:53.229857 | 2026-02-16 19:20:53.230013 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-16 19:20:53.672379 | ubuntu-noble -> localhost | changed 2026-02-16 19:20:53.688528 | 2026-02-16 19:20:53.688699 | TASK [add-build-sshkey : Add back temp key] 2026-02-16 19:20:53.990974 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/688bf1f4dbf7421baa126972a33c3584/work/688bf1f4dbf7421baa126972a33c3584_id_rsa (zuul-build-sshkey) 2026-02-16 19:20:53.991215 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.013176 2026-02-16 19:20:54.001238 | 2026-02-16 19:20:54.001385 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-16 19:20:54.415527 | ubuntu-noble | ok 2026-02-16 19:20:54.424432 | 2026-02-16 19:20:54.424628 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-16 19:20:54.450696 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:54.469788 | 2026-02-16 19:20:54.469999 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-02-16 19:20:54.881923 | ubuntu-noble | ok 2026-02-16 19:20:54.891748 | 2026-02-16 19:20:54.891889 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-02-16 19:20:55.991972 | ubuntu-noble | Output suppressed because no_log was given 2026-02-16 19:20:56.002871 | 2026-02-16 19:20:56.003009 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-02-16 19:20:56.225986 | ubuntu-noble | ok: "logs" 2026-02-16 19:20:56.226338 | ubuntu-noble | ok: All items complete 2026-02-16 19:20:56.226387 | 2026-02-16 19:20:56.463433 | ubuntu-noble | ok: "artifacts" 2026-02-16 19:20:56.611677 | ubuntu-noble | ok: "docs" 2026-02-16 19:20:56.628005 | 2026-02-16 19:20:56.628263 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-02-16 19:20:56.874829 | ubuntu-noble | changed: "logs" 2026-02-16 19:20:57.073631 | ubuntu-noble | changed: "artifacts" 2026-02-16 19:20:57.268881 | ubuntu-noble | changed: "docs" 2026-02-16 19:20:57.289703 | 2026-02-16 19:20:57.289841 | PLAY RECAP 2026-02-16 19:20:57.289890 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-16 19:20:57.289922 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-02-16 19:20:57.289946 | 2026-02-16 19:20:57.472515 | PRE-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main] 2026-02-16 19:20:57.475135 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-16 19:20:58.148343 | 2026-02-16 19:20:58.148527 | PLAY [all] 2026-02-16 19:20:58.164711 | 2026-02-16 19:20:58.164906 | TASK [Install binary dependencies] 2026-02-16 19:20:58.219418 | ubuntu-noble | ok 2026-02-16 19:20:58.245836 | 2026-02-16 19:20:58.246266 | TASK [bindep : Include find tasks] 2026-02-16 19:20:58.280012 | ubuntu-noble | ok 2026-02-16 19:20:58.290064 | ubuntu-noble | included: /var/lib/zuul/builds/688bf1f4dbf7421baa126972a33c3584/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-02-16 19:20:58.297228 | 2026-02-16 19:20:58.297305 | TASK [bindep : Look for bindep.txt] 2026-02-16 19:20:58.658335 | ubuntu-noble | ok 2026-02-16 19:20:58.666068 | 2026-02-16 19:20:58.666134 | TASK [bindep : Define bindep_file fact] 2026-02-16 19:20:58.689608 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:58.700798 | 2026-02-16 19:20:58.701066 | TASK [bindep : Look for other-requirements.txt] 2026-02-16 19:20:58.917596 | ubuntu-noble | ok 2026-02-16 19:20:58.925477 | 2026-02-16 19:20:58.925579 | TASK [bindep : Define bindep_file fact] 2026-02-16 19:20:58.950724 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:58.962726 | 2026-02-16 19:20:58.962825 | TASK [bindep : Look for bindep fallback file] 2026-02-16 19:20:58.988924 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:59.000792 | 2026-02-16 19:20:59.000936 | TASK [bindep : Define bindep_file fact] 2026-02-16 19:20:59.036743 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:59.047051 | 2026-02-16 19:20:59.047237 | TASK [bindep : Include bindep tasks] 2026-02-16 19:20:59.073251 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:59.083558 | 2026-02-16 19:20:59.083831 | TASK [bindep : Include install tasks] 2026-02-16 19:20:59.109234 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:59.120587 | 2026-02-16 19:20:59.120758 | LOOP [bindep : Include package tasks] 2026-02-16 19:20:59.180852 | 2026-02-16 19:20:59.181174 | TASK [Run test-setup role] 2026-02-16 19:20:59.208821 | ubuntu-noble | ok 2026-02-16 19:20:59.232820 | 2026-02-16 19:20:59.233030 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-02-16 19:20:59.453186 | ubuntu-noble | ok 2026-02-16 19:20:59.462084 | 2026-02-16 19:20:59.462499 | TASK [test-setup : Run tools/test-setup.sh] 2026-02-16 19:20:59.994659 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:00.004555 | 2026-02-16 19:21:00.004636 | PLAY RECAP 2026-02-16 19:21:00.004699 | ubuntu-noble | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-16 19:21:00.004734 | 2026-02-16 19:21:00.144407 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-16 19:21:00.146954 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2026-02-16 19:21:00.786372 | 2026-02-16 19:21:00.786559 | PLAY [all] 2026-02-16 19:21:00.806215 | 2026-02-16 19:21:00.806386 | TASK [ensure-python : Validate python_version value] 2026-02-16 19:21:00.831707 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:00.843556 | 2026-02-16 19:21:00.843775 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)] 2026-02-16 19:21:00.870130 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:00.884248 | 2026-02-16 19:21:00.884412 | TASK [ensure-python : Pull in venv package] 2026-02-16 19:21:00.909459 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:00.922521 | 2026-02-16 19:21:00.922735 | TASK [ensure-python : Set default RPM package name] 2026-02-16 19:21:00.959360 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:00.971030 | 2026-02-16 19:21:00.971271 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9/10] 2026-02-16 19:21:00.997026 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:01.006887 | 2026-02-16 19:21:01.007075 | TASK [ensure-python : Install RPM package] 2026-02-16 19:21:01.032559 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:01.044363 | 2026-02-16 19:21:01.044461 | TASK [ensure-python : Install python using pyenv] 2026-02-16 19:21:01.069065 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:01.079143 | 2026-02-16 19:21:01.079247 | TASK [ensure-python : Activate python using stow] 2026-02-16 19:21:01.114105 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:01.131019 | 2026-02-16 19:21:01.131098 | TASK [Install pip] 2026-02-16 19:21:01.154673 | ubuntu-noble | ok 2026-02-16 19:21:01.179011 | 2026-02-16 19:21:01.179091 | TASK [ensure-pip : Check if pip is installed] 2026-02-16 19:21:01.718843 | ubuntu-noble | ok: Runtime: 0:00:00.012484 2026-02-16 19:21:01.727811 | 2026-02-16 19:21:01.727913 | LOOP [ensure-pip : Install pip from packages] 2026-02-16 19:21:01.757360 | ubuntu-noble | ok: "/var/lib/zuul/builds/688bf1f4dbf7421baa126972a33c3584/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/Debian.yaml" 2026-02-16 19:21:01.779417 | ubuntu-noble | included: /var/lib/zuul/builds/688bf1f4dbf7421baa126972a33c3584/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/Debian.yaml 2026-02-16 19:21:01.788669 | 2026-02-16 19:21:01.788803 | TASK [ensure-pip : Update package lists] 2026-02-16 19:21:08.870273 | ubuntu-noble | changed 2026-02-16 19:21:08.878214 | 2026-02-16 19:21:08.878303 | TASK [ensure-pip : Install Python 3 pip] 2026-02-16 19:21:19.907205 | ubuntu-noble | changed 2026-02-16 19:21:19.913418 | 2026-02-16 19:21:19.913532 | TASK [ensure-pip : Install Python 2 pip] 2026-02-16 19:21:19.938443 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:19.949973 | 2026-02-16 19:21:19.950182 | TASK [ensure-pip : Ensure setuptools] 2026-02-16 19:21:19.975985 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:19.986885 | 2026-02-16 19:21:19.987065 | TASK [ensure-pip : Check for ensurepip module] 2026-02-16 19:21:20.287670 | ubuntu-noble | usage: python -m ensurepip [-h] [--version] [-v] [-U] [--user] [--root ROOT] 2026-02-16 19:21:20.287752 | ubuntu-noble | [--altinstall] [--default-pip] 2026-02-16 19:21:20.287766 | ubuntu-noble | 2026-02-16 19:21:20.287776 | ubuntu-noble | options: 2026-02-16 19:21:20.287786 | ubuntu-noble | -h, --help show this help message and exit 2026-02-16 19:21:20.287800 | ubuntu-noble | --version Show the version of pip that is bundled with this Python. 2026-02-16 19:21:20.287812 | ubuntu-noble | -v, --verbose Give more output. Option is additive, and can be used up to 3 2026-02-16 19:21:20.287826 | ubuntu-noble | times. 2026-02-16 19:21:20.287835 | ubuntu-noble | -U, --upgrade Upgrade pip and dependencies, even if already installed. 2026-02-16 19:21:20.287843 | ubuntu-noble | --user Install using the user scheme. 2026-02-16 19:21:20.287852 | ubuntu-noble | --root ROOT Install everything relative to this alternate root directory. 2026-02-16 19:21:20.287861 | ubuntu-noble | --altinstall Make an alternate install, installing only the X.Y versioned 2026-02-16 19:21:20.287870 | ubuntu-noble | scripts (Default: pipX, pipX.Y). 2026-02-16 19:21:20.287878 | ubuntu-noble | --default-pip Make a default pip install, installing the unqualified pip in 2026-02-16 19:21:20.287887 | ubuntu-noble | addition to the versioned scripts. 2026-02-16 19:21:20.544205 | ubuntu-noble | ok: Runtime: 0:00:00.069074 2026-02-16 19:21:20.551302 | 2026-02-16 19:21:20.551421 | TASK [ensure-pip : Ensure python3-venv] 2026-02-16 19:21:20.576191 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:20.584878 | 2026-02-16 19:21:20.585034 | TASK [ensure-pip : Install pip from source] 2026-02-16 19:21:20.609809 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:20.668745 | 2026-02-16 19:21:20.668918 | TASK [ensure-pip : Probe for venv python full path] 2026-02-16 19:21:20.896535 | ubuntu-noble | /usr/bin/python3 2026-02-16 19:21:21.211978 | ubuntu-noble | ok: Runtime: 0:00:00.008421 2026-02-16 19:21:21.218414 | 2026-02-16 19:21:21.218516 | TASK [ensure-pip : Set host default] 2026-02-16 19:21:21.269441 | ubuntu-noble | ok 2026-02-16 19:21:21.275074 | 2026-02-16 19:21:21.275178 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2026-02-16 19:21:21.355726 | ubuntu-noble | ok 2026-02-16 19:21:21.369091 | 2026-02-16 19:21:21.369180 | TASK [ensure-tox : Check if tox is installed] 2026-02-16 19:21:21.906923 | ubuntu-noble | ok: Runtime: 0:00:00.006618 2026-02-16 19:21:21.913666 | 2026-02-16 19:21:21.913736 | TASK [ensure-tox : Export preinstalled tox_exectuable] 2026-02-16 19:21:21.938360 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:21.949296 | 2026-02-16 19:21:21.949394 | TASK [ensure-tox : Create local venv] 2026-02-16 19:21:25.489208 | ubuntu-noble | ok: Runtime: 0:00:03.227343 2026-02-16 19:21:25.496036 | 2026-02-16 19:21:25.496193 | TASK [ensure-tox : Install tox to local venv] 2026-02-16 19:21:26.374824 | ubuntu-noble | Collecting tox 2026-02-16 19:21:26.418941 | ubuntu-noble | Downloading tox-4.36.0-py3-none-any.whl.metadata (3.6 kB) 2026-02-16 19:21:26.580764 | ubuntu-noble | Collecting cachetools>=7.0.1 (from tox) 2026-02-16 19:21:26.584112 | ubuntu-noble | Downloading cachetools-7.0.1-py3-none-any.whl.metadata (5.6 kB) 2026-02-16 19:21:26.712429 | ubuntu-noble | Collecting chardet>=5.2 (from tox) 2026-02-16 19:21:26.715674 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl.metadata (3.4 kB) 2026-02-16 19:21:26.882210 | ubuntu-noble | Collecting colorama>=0.4.6 (from tox) 2026-02-16 19:21:26.885769 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2026-02-16 19:21:27.063004 | ubuntu-noble | Collecting filelock>=3.24 (from tox) 2026-02-16 19:21:27.069313 | ubuntu-noble | Downloading filelock-3.24.2-py3-none-any.whl.metadata (2.0 kB) 2026-02-16 19:21:27.217222 | ubuntu-noble | Collecting packaging>=26 (from tox) 2026-02-16 19:21:27.221644 | ubuntu-noble | Downloading packaging-26.0-py3-none-any.whl.metadata (3.3 kB) 2026-02-16 19:21:27.380013 | ubuntu-noble | Collecting platformdirs>=4.9.1 (from tox) 2026-02-16 19:21:27.383438 | ubuntu-noble | Downloading platformdirs-4.9.2-py3-none-any.whl.metadata (4.7 kB) 2026-02-16 19:21:27.572703 | ubuntu-noble | Collecting pluggy>=1.6 (from tox) 2026-02-16 19:21:27.576267 | ubuntu-noble | Downloading pluggy-1.6.0-py3-none-any.whl.metadata (4.8 kB) 2026-02-16 19:21:27.706190 | ubuntu-noble | Collecting pyproject-api>=1.10 (from tox) 2026-02-16 19:21:27.710472 | ubuntu-noble | Downloading pyproject_api-1.10.0-py3-none-any.whl.metadata (2.7 kB) 2026-02-16 19:21:27.899237 | ubuntu-noble | Collecting virtualenv>=20.36.1 (from tox) 2026-02-16 19:21:27.903488 | ubuntu-noble | Downloading virtualenv-20.37.0-py3-none-any.whl.metadata (5.1 kB) 2026-02-16 19:21:28.197713 | ubuntu-noble | Collecting distlib<1,>=0.3.7 (from virtualenv>=20.36.1->tox) 2026-02-16 19:21:28.200740 | ubuntu-noble | Downloading distlib-0.4.0-py2.py3-none-any.whl.metadata (5.2 kB) 2026-02-16 19:21:28.312615 | ubuntu-noble | Downloading tox-4.36.0-py3-none-any.whl (179 kB) 2026-02-16 19:21:28.425332 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 179.1/179.1 kB 1.6 MB/s eta 0:00:00 2026-02-16 19:21:28.429428 | ubuntu-noble | Downloading cachetools-7.0.1-py3-none-any.whl (13 kB) 2026-02-16 19:21:28.495631 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2026-02-16 19:21:28.596272 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 2.0 MB/s eta 0:00:00 2026-02-16 19:21:28.600341 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-02-16 19:21:28.620878 | ubuntu-noble | Downloading filelock-3.24.2-py3-none-any.whl (24 kB) 2026-02-16 19:21:28.646147 | ubuntu-noble | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-02-16 19:21:28.679682 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 2.3 MB/s eta 0:00:00 2026-02-16 19:21:28.686638 | ubuntu-noble | Downloading platformdirs-4.9.2-py3-none-any.whl (21 kB) 2026-02-16 19:21:28.743472 | ubuntu-noble | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-02-16 19:21:28.780286 | ubuntu-noble | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-02-16 19:21:28.837377 | ubuntu-noble | Downloading virtualenv-20.37.0-py3-none-any.whl (5.8 MB) 2026-02-16 19:21:28.988781 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.8/5.8 MB 39.7 MB/s eta 0:00:00 2026-02-16 19:21:29.013789 | ubuntu-noble | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-02-16 19:21:29.119327 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 5.0 MB/s eta 0:00:00 2026-02-16 19:21:29.187993 | ubuntu-noble | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2026-02-16 19:21:30.567086 | 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:21:31.047986 | ubuntu-noble | ok: Runtime: 0:00:04.979550 2026-02-16 19:21:31.057683 | 2026-02-16 19:21:31.057888 | TASK [ensure-tox : Export installed tox_executable path] 2026-02-16 19:21:31.095160 | ubuntu-noble | ok 2026-02-16 19:21:31.103208 | 2026-02-16 19:21:31.103352 | TASK [ensure-tox : Output tox version] 2026-02-16 19:21:31.591989 | 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:21:31.606600 | ubuntu-noble | 4.36.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2026-02-16 19:21:32.146082 | ubuntu-noble | ok: Runtime: 0:00:00.309529 2026-02-16 19:21:32.155091 | 2026-02-16 19:21:32.155236 | TASK [ensure-tox : Make global symlink] 2026-02-16 19:21:32.180286 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:32.193097 | 2026-02-16 19:21:32.193221 | PLAY RECAP 2026-02-16 19:21:32.193278 | ubuntu-noble | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-02-16 19:21:32.193308 | 2026-02-16 19:21:32.342944 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2026-02-16 19:21:32.344421 | PRE-RUN START: [untrusted : github.com/vexxhost/magnum-cluster-api/zuul.d/playbooks/tox/pre.yml@main] 2026-02-16 19:21:33.021364 | 2026-02-16 19:21:33.021538 | PLAY [all] 2026-02-16 19:21:33.033740 | 2026-02-16 19:21:33.033851 | TASK [ensure-rust : Use rustup] 2026-02-16 19:21:33.063313 | ubuntu-noble | ok 2026-02-16 19:21:33.070186 | ubuntu-noble | included: /var/lib/zuul/builds/688bf1f4dbf7421baa126972a33c3584/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-rust/tasks/rustup.yaml 2026-02-16 19:21:33.076195 | 2026-02-16 19:21:33.076276 | TASK [ensure-rust : Install Rust] 2026-02-16 19:21:33.476735 | ubuntu-noble | /bin/bash: line 2: curl: command not found 2026-02-16 19:21:33.615893 | ubuntu-noble | ERROR 2026-02-16 19:21:33.616175 | ubuntu-noble | { 2026-02-16 19:21:33.616216 | ubuntu-noble | "delta": "0:00:00.010768", 2026-02-16 19:21:33.616249 | ubuntu-noble | "end": "2026-02-16 19:21:33.478699", 2026-02-16 19:21:33.616277 | ubuntu-noble | "msg": "non-zero return code", 2026-02-16 19:21:33.616303 | ubuntu-noble | "rc": 127, 2026-02-16 19:21:33.616329 | ubuntu-noble | "start": "2026-02-16 19:21:33.467931" 2026-02-16 19:21:33.616358 | ubuntu-noble | } failure 2026-02-16 19:21:33.618578 | 2026-02-16 19:21:33.618645 | PLAY RECAP 2026-02-16 19:21:33.618708 | ubuntu-noble | ok: 1 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-02-16 19:21:33.618738 | 2026-02-16 19:21:33.755095 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/magnum-cluster-api/zuul.d/playbooks/tox/pre.yml@main] 2026-02-16 19:21:33.758210 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2026-02-16 19:21:34.421532 | 2026-02-16 19:21:34.421730 | PLAY [all] 2026-02-16 19:21:34.434815 | 2026-02-16 19:21:34.434978 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-02-16 19:21:34.480678 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:34.494447 | 2026-02-16 19:21:34.494643 | TASK [fetch-tox-output : Set tox log path for single node] 2026-02-16 19:21:34.538482 | ubuntu-noble | ok 2026-02-16 19:21:34.546279 | 2026-02-16 19:21:34.546371 | TASK [fetch-tox-output : Ensure local tox dir] 2026-02-16 19:21:34.958796 | ubuntu-noble -> localhost | changed 2026-02-16 19:21:34.972631 | 2026-02-16 19:21:34.972814 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-02-16 19:21:35.018646 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:35.028147 | 2026-02-16 19:21:35.028342 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 19:21:35.075295 | ubuntu-noble | ok 2026-02-16 19:21:35.081269 | 2026-02-16 19:21:35.081372 | TASK [fetch-tox-output : Get tox version] 2026-02-16 19:21:35.715524 | 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:21:35.730253 | ubuntu-noble | 4.36.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2026-02-16 19:21:36.124153 | ubuntu-noble | ok: Runtime: 0:00:00.311853 2026-02-16 19:21:36.129617 | 2026-02-16 19:21:36.129687 | TASK [fetch-tox-output : Find all default environments] 2026-02-16 19:21:36.658438 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:36.668066 | 2026-02-16 19:21:36.668203 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 19:21:36.693726 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:36.704664 | 2026-02-16 19:21:36.704780 | TASK [fetch-tox-output : Find all default environments] 2026-02-16 19:21:37.236673 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:37.247431 | 2026-02-16 19:21:37.247530 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 19:21:37.282656 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:37.293521 | 2026-02-16 19:21:37.293596 | LOOP [fetch-tox-output : Copy tox logs] 2026-02-16 19:21:37.340687 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:37.366985 | 2026-02-16 19:21:37.367175 | LOOP [fetch-tox-output : Collect tox logs] 2026-02-16 19:21:38.145575 | ubuntu-noble | ok: 2026-02-16 19:21:38.145869 | ubuntu-noble | rsync: [sender] change_dir "/home/zuul/src/github.com/vexxhost/magnum-cluster-api/.tox/functional/log" failed: No such file or directory (2) 2026-02-16 19:21:38.146059 | 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:21:38.146124 | ubuntu-noble | rsync: [Receiver] write error: Broken pipe (32) 2026-02-16 19:21:38.146178 | 2026-02-16 19:21:38.167376 | 2026-02-16 19:21:38.167521 | PLAY RECAP 2026-02-16 19:21:38.167587 | ubuntu-noble | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-02-16 19:21:38.167617 | 2026-02-16 19:21:38.349277 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2026-02-16 19:21:38.351677 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-16 19:21:38.936236 | 2026-02-16 19:21:38.936416 | PLAY [all] 2026-02-16 19:21:38.949037 | 2026-02-16 19:21:38.949139 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-02-16 19:21:39.125584 | ubuntu-noble | changed: non-zero return code 2026-02-16 19:21:39.132557 | 2026-02-16 19:21:39.132661 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-02-16 19:21:39.158663 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:39.170355 | 2026-02-16 19:21:39.170660 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-02-16 19:21:39.208665 | 2026-02-16 19:21:39.208839 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-02-16 19:21:39.244007 | 2026-02-16 19:21:39.244342 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-02-16 19:21:39.268786 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:39.278945 | 2026-02-16 19:21:39.279058 | LOOP [fetch-subunit-output : Generate subunit file] 2026-02-16 19:21:39.312714 | 2026-02-16 19:21:39.312916 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-02-16 19:21:39.337668 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:39.348701 | 2026-02-16 19:21:39.348902 | TASK [fetch-subunit-output : Remove the temporary file] 2026-02-16 19:21:39.375026 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:39.385526 | 2026-02-16 19:21:39.385635 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-02-16 19:21:39.411546 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:39.422074 | 2026-02-16 19:21:39.422154 | PLAY RECAP 2026-02-16 19:21:39.422215 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-16 19:21:39.422244 | 2026-02-16 19:21:39.544628 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-16 19:21:39.547174 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main] 2026-02-16 19:21:40.222286 | 2026-02-16 19:21:40.222683 | PLAY [all] 2026-02-16 19:21:40.235226 | 2026-02-16 19:21:40.235345 | TASK [fetch-output : Set log path for multiple nodes] 2026-02-16 19:21:40.281725 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:40.292119 | 2026-02-16 19:21:40.292232 | TASK [fetch-output : Set log path for single node] 2026-02-16 19:21:40.336770 | ubuntu-noble | ok 2026-02-16 19:21:40.344527 | 2026-02-16 19:21:40.344658 | LOOP [fetch-output : Ensure local output dirs] 2026-02-16 19:21:40.764483 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/688bf1f4dbf7421baa126972a33c3584/work/logs" 2026-02-16 19:21:40.994263 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/688bf1f4dbf7421baa126972a33c3584/work/artifacts" 2026-02-16 19:21:41.206651 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/688bf1f4dbf7421baa126972a33c3584/work/docs" 2026-02-16 19:21:41.222818 | 2026-02-16 19:21:41.223009 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-16 19:21:41.874467 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 19:21:41.874759 | ubuntu-noble | changed: All items complete 2026-02-16 19:21:41.874801 | 2026-02-16 19:21:42.328859 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 19:21:42.791742 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 19:21:42.820413 | 2026-02-16 19:21:42.820603 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-02-16 19:21:43.267998 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.008491 2026-02-16 19:21:43.506188 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.009378 2026-02-16 19:21:43.528676 | 2026-02-16 19:21:43.528844 | PLAY [all] 2026-02-16 19:21:43.537794 | 2026-02-16 19:21:43.537959 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-02-16 19:21:44.002948 | ubuntu-noble | changed 2026-02-16 19:21:44.009369 | 2026-02-16 19:21:44.009451 | PLAY RECAP 2026-02-16 19:21:44.009502 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-02-16 19:21:44.009525 | 2026-02-16 19:21:44.134865 | POST-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main] 2026-02-16 19:21:44.137372 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post-logs.yaml@main] 2026-02-16 19:21:44.724470 | 2026-02-16 19:21:44.724651 | PLAY [localhost] 2026-02-16 19:21:44.737481 | 2026-02-16 19:21:44.737639 | TASK [Generate Zuul manifest] 2026-02-16 19:21:44.761389 | localhost | ok 2026-02-16 19:21:44.777111 | 2026-02-16 19:21:44.777258 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-16 19:21:45.174407 | localhost | changed 2026-02-16 19:21:45.190802 | 2026-02-16 19:21:45.191021 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-16 19:21:45.221185 | localhost | ok 2026-02-16 19:21:45.229780 | 2026-02-16 19:21:45.229876 | TASK [Upload logs] 2026-02-16 19:21:45.251961 | localhost | ok 2026-02-16 19:21:45.334344 | 2026-02-16 19:21:45.334583 | TASK [Set zuul-log-path fact] 2026-02-16 19:21:45.357261 | localhost | ok 2026-02-16 19:21:45.373278 | 2026-02-16 19:21:45.373471 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-16 19:21:45.409672 | localhost | ok 2026-02-16 19:21:45.423309 | 2026-02-16 19:21:45.423488 | TASK [upload-logs : Create log directories] 2026-02-16 19:21:45.863941 | localhost | changed 2026-02-16 19:21:45.869384 | 2026-02-16 19:21:45.869487 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-02-16 19:21:46.317360 | localhost -> localhost | ok: Runtime: 0:00:00.006533 2026-02-16 19:21:46.323085 | 2026-02-16 19:21:46.323159 | TASK [upload-logs : Upload logs to log server] 2026-02-16 19:21:46.843813 | localhost | Output suppressed because no_log was given 2026-02-16 19:21:46.849303 | 2026-02-16 19:21:46.849445 | LOOP [upload-logs : Compress console log and json output] 2026-02-16 19:21:46.893866 | localhost | skipping: Conditional result was False 2026-02-16 19:21:46.900349 | localhost | skipping: Conditional result was False 2026-02-16 19:21:46.914443 | 2026-02-16 19:21:46.914610 | LOOP [upload-logs : Upload compressed console log and json output] 2026-02-16 19:21:46.958928 | localhost | skipping: Conditional result was False 2026-02-16 19:21:46.959444 | 2026-02-16 19:21:46.962389 | localhost | skipping: Conditional result was False 2026-02-16 19:21:46.978063 | 2026-02-16 19:21:46.978259 | LOOP [upload-logs : Upload console log and json output]