2026-02-16 18:27:55.248888 | Job console starting 2026-02-16 18:27:55.257641 | Updating git repos 2026-02-16 18:27:55.288702 | Cloning repos into workspace 2026-02-16 18:27:55.336301 | Restoring repo states 2026-02-16 18:27:55.349356 | Merging changes 2026-02-16 18:27:55.732174 | Checking out repos 2026-02-16 18:27:55.892874 | Preparing playbooks 2026-02-16 18:27:57.028704 | Running Ansible setup 2026-02-16 18:28:00.481595 | PRE-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main] 2026-02-16 18:28:01.064840 | 2026-02-16 18:28:01.064991 | PLAY [localhost] 2026-02-16 18:28:01.072797 | 2026-02-16 18:28:01.072867 | TASK [Gathering Facts] 2026-02-16 18:28:01.920484 | localhost | ok 2026-02-16 18:28:01.931348 | 2026-02-16 18:28:01.931428 | TASK [Setup log path fact] 2026-02-16 18:28:01.948381 | localhost | ok 2026-02-16 18:28:01.958428 | 2026-02-16 18:28:01.958496 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-16 18:28:01.989941 | localhost | ok 2026-02-16 18:28:01.998653 | 2026-02-16 18:28:01.998737 | TASK [emit-job-header : Print job information] 2026-02-16 18:28:02.039313 | # Job Information 2026-02-16 18:28:02.039462 | Ansible Version: 2.16.15 2026-02-16 18:28:02.039508 | Job: magnum-cluster-api-tox-unit 2026-02-16 18:28:02.039549 | Pipeline: check 2026-02-16 18:28:02.039590 | Executor: 3a2793d2bd32 2026-02-16 18:28:02.039631 | Triggered by: https://github.com/vexxhost/magnum-cluster-api/pull/884 2026-02-16 18:28:02.039679 | Event ID: e6955ee0-0b64-11f1-9362-3d643ff18065 2026-02-16 18:28:02.043323 | 2026-02-16 18:28:02.043410 | LOOP [emit-job-header : Print node information] 2026-02-16 18:28:02.136770 | localhost | ok: 2026-02-16 18:28:02.137105 | localhost | # Node Information 2026-02-16 18:28:02.137172 | localhost | Inventory Hostname: ubuntu-noble 2026-02-16 18:28:02.137223 | localhost | Hostname: np0000155665 2026-02-16 18:28:02.137270 | localhost | Username: zuul 2026-02-16 18:28:02.137322 | localhost | Distro: Ubuntu 24.04 2026-02-16 18:28:02.137369 | localhost | Provider: yul1 2026-02-16 18:28:02.137413 | localhost | Region: ca-ymq-1 2026-02-16 18:28:02.137458 | localhost | Label: ubuntu-noble 2026-02-16 18:28:02.137501 | localhost | Product Name: OpenStack Nova 2026-02-16 18:28:02.137545 | localhost | Interface IP: 199.204.45.3 2026-02-16 18:28:02.152826 | 2026-02-16 18:28:02.153009 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-16 18:28:02.503876 | localhost -> localhost | changed 2026-02-16 18:28:02.508996 | 2026-02-16 18:28:02.509064 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-16 18:28:03.292555 | localhost -> localhost | changed 2026-02-16 18:28:03.303492 | 2026-02-16 18:28:03.303553 | PLAY [all] 2026-02-16 18:28:03.311769 | 2026-02-16 18:28:03.311832 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-16 18:28:03.548843 | ubuntu-noble -> localhost | ok 2026-02-16 18:28:03.559116 | 2026-02-16 18:28:03.559182 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-16 18:28:03.592109 | ubuntu-noble | ok 2026-02-16 18:28:03.609092 | ubuntu-noble | included: /var/lib/zuul/builds/f61bdc8ee2e64ecd8baf5b7f0d640c3b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-16 18:28:03.615142 | 2026-02-16 18:28:03.615204 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-16 18:28:04.612969 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2026-02-16 18:28:04.613211 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/f61bdc8ee2e64ecd8baf5b7f0d640c3b/work/f61bdc8ee2e64ecd8baf5b7f0d640c3b_id_rsa 2026-02-16 18:28:04.613243 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/f61bdc8ee2e64ecd8baf5b7f0d640c3b/work/f61bdc8ee2e64ecd8baf5b7f0d640c3b_id_rsa.pub 2026-02-16 18:28:04.613266 | ubuntu-noble -> localhost | The key fingerprint is: 2026-02-16 18:28:04.613289 | ubuntu-noble -> localhost | SHA256:YjhHIytz6kCMCGLNEPzsqKOmjAwQ7ufQE2FtPLWFqZw zuul-build-sshkey 2026-02-16 18:28:04.613323 | ubuntu-noble -> localhost | The key's randomart image is: 2026-02-16 18:28:04.613345 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2026-02-16 18:28:04.613369 | ubuntu-noble -> localhost | |.o. .o. | 2026-02-16 18:28:04.613391 | ubuntu-noble -> localhost | | .+ o .oo | 2026-02-16 18:28:04.613412 | ubuntu-noble -> localhost | |+.o=o==. | 2026-02-16 18:28:04.613432 | ubuntu-noble -> localhost | |O..ooE.. | 2026-02-16 18:28:04.613452 | ubuntu-noble -> localhost | |++=.= + S | 2026-02-16 18:28:04.613472 | ubuntu-noble -> localhost | |+..*.+ . | 2026-02-16 18:28:04.613492 | ubuntu-noble -> localhost | |+o.+ | 2026-02-16 18:28:04.613512 | ubuntu-noble -> localhost | |B++ . | 2026-02-16 18:28:04.613534 | ubuntu-noble -> localhost | |B+.. | 2026-02-16 18:28:04.613554 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2026-02-16 18:28:04.613601 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.558345 2026-02-16 18:28:04.619041 | 2026-02-16 18:28:04.619105 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-16 18:28:04.653164 | ubuntu-noble | ok 2026-02-16 18:28:04.665703 | ubuntu-noble | included: /var/lib/zuul/builds/f61bdc8ee2e64ecd8baf5b7f0d640c3b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-16 18:28:04.673236 | 2026-02-16 18:28:04.673293 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-16 18:28:04.697078 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:04.707434 | 2026-02-16 18:28:04.707609 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-16 18:28:05.238002 | ubuntu-noble | changed 2026-02-16 18:28:05.245794 | 2026-02-16 18:28:05.245858 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-16 18:28:05.474266 | ubuntu-noble | ok 2026-02-16 18:28:05.481674 | 2026-02-16 18:28:05.481763 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-16 18:28:06.035066 | ubuntu-noble | changed 2026-02-16 18:28:06.041421 | 2026-02-16 18:28:06.041484 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-16 18:28:06.582092 | ubuntu-noble | changed 2026-02-16 18:28:06.588573 | 2026-02-16 18:28:06.588639 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-16 18:28:06.611291 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:06.621435 | 2026-02-16 18:28:06.621530 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-16 18:28:06.971974 | ubuntu-noble -> localhost | changed 2026-02-16 18:28:06.989348 | 2026-02-16 18:28:06.989441 | TASK [add-build-sshkey : Add back temp key] 2026-02-16 18:28:07.266067 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/f61bdc8ee2e64ecd8baf5b7f0d640c3b/work/f61bdc8ee2e64ecd8baf5b7f0d640c3b_id_rsa (zuul-build-sshkey) 2026-02-16 18:28:07.266309 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.014731 2026-02-16 18:28:07.274813 | 2026-02-16 18:28:07.274894 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-16 18:28:07.604655 | ubuntu-noble | ok 2026-02-16 18:28:07.613188 | 2026-02-16 18:28:07.613277 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-16 18:28:07.637729 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:07.653719 | 2026-02-16 18:28:07.653815 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-02-16 18:28:08.012784 | ubuntu-noble | ok 2026-02-16 18:28:08.022987 | 2026-02-16 18:28:08.023103 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-02-16 18:28:09.028843 | ubuntu-noble | Output suppressed because no_log was given 2026-02-16 18:28:09.041514 | 2026-02-16 18:28:09.041589 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-02-16 18:28:09.257549 | ubuntu-noble | ok: "logs" 2026-02-16 18:28:09.257875 | ubuntu-noble | ok: All items complete 2026-02-16 18:28:09.257931 | 2026-02-16 18:28:09.493958 | ubuntu-noble | ok: "artifacts" 2026-02-16 18:28:09.626689 | ubuntu-noble | ok: "docs" 2026-02-16 18:28:09.640108 | 2026-02-16 18:28:09.640246 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-02-16 18:28:09.863078 | ubuntu-noble | changed: "logs" 2026-02-16 18:28:10.080070 | ubuntu-noble | changed: "artifacts" 2026-02-16 18:28:10.272764 | ubuntu-noble | changed: "docs" 2026-02-16 18:28:10.296626 | 2026-02-16 18:28:10.296743 | PLAY RECAP 2026-02-16 18:28:10.296788 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-16 18:28:10.296819 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-02-16 18:28:10.296839 | 2026-02-16 18:28:10.437295 | PRE-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main] 2026-02-16 18:28:10.438851 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-16 18:28:11.006702 | 2026-02-16 18:28:11.006838 | PLAY [all] 2026-02-16 18:28:11.019282 | 2026-02-16 18:28:11.019369 | TASK [Install binary dependencies] 2026-02-16 18:28:11.073509 | ubuntu-noble | ok 2026-02-16 18:28:11.095774 | 2026-02-16 18:28:11.095887 | TASK [bindep : Include find tasks] 2026-02-16 18:28:11.127018 | ubuntu-noble | ok 2026-02-16 18:28:11.137521 | ubuntu-noble | included: /var/lib/zuul/builds/f61bdc8ee2e64ecd8baf5b7f0d640c3b/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-02-16 18:28:11.144155 | 2026-02-16 18:28:11.144216 | TASK [bindep : Look for bindep.txt] 2026-02-16 18:28:11.501761 | ubuntu-noble | ok 2026-02-16 18:28:11.508964 | 2026-02-16 18:28:11.509040 | TASK [bindep : Define bindep_file fact] 2026-02-16 18:28:11.534598 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:11.545048 | 2026-02-16 18:28:11.545159 | TASK [bindep : Look for other-requirements.txt] 2026-02-16 18:28:11.780631 | ubuntu-noble | ok 2026-02-16 18:28:11.786975 | 2026-02-16 18:28:11.787046 | TASK [bindep : Define bindep_file fact] 2026-02-16 18:28:11.811814 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:11.822729 | 2026-02-16 18:28:11.822817 | TASK [bindep : Look for bindep fallback file] 2026-02-16 18:28:11.847708 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:11.860369 | 2026-02-16 18:28:11.860466 | TASK [bindep : Define bindep_file fact] 2026-02-16 18:28:11.885591 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:11.895712 | 2026-02-16 18:28:11.895816 | TASK [bindep : Include bindep tasks] 2026-02-16 18:28:11.920356 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:11.931200 | 2026-02-16 18:28:11.931289 | TASK [bindep : Include install tasks] 2026-02-16 18:28:11.956144 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:11.966886 | 2026-02-16 18:28:11.966974 | LOOP [bindep : Include package tasks] 2026-02-16 18:28:12.027357 | 2026-02-16 18:28:12.027524 | TASK [Run test-setup role] 2026-02-16 18:28:12.052674 | ubuntu-noble | ok 2026-02-16 18:28:12.071739 | 2026-02-16 18:28:12.071803 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-02-16 18:28:12.308180 | ubuntu-noble | ok 2026-02-16 18:28:12.316098 | 2026-02-16 18:28:12.316183 | TASK [test-setup : Run tools/test-setup.sh] 2026-02-16 18:28:12.844535 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:12.856515 | 2026-02-16 18:28:12.856588 | PLAY RECAP 2026-02-16 18:28:12.856647 | ubuntu-noble | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-16 18:28:12.856675 | 2026-02-16 18:28:12.964543 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-16 18:28:12.967003 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2026-02-16 18:28:13.513880 | 2026-02-16 18:28:13.514011 | PLAY [all] 2026-02-16 18:28:13.527324 | 2026-02-16 18:28:13.527400 | TASK [ensure-python : Validate python_version value] 2026-02-16 18:28:13.562342 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:13.568699 | 2026-02-16 18:28:13.568776 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)] 2026-02-16 18:28:13.592622 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:13.599462 | 2026-02-16 18:28:13.599534 | TASK [ensure-python : Pull in venv package] 2026-02-16 18:28:13.623823 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:13.629716 | 2026-02-16 18:28:13.629786 | TASK [ensure-python : Set default RPM package name] 2026-02-16 18:28:13.654295 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:13.660037 | 2026-02-16 18:28:13.660104 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9/10] 2026-02-16 18:28:13.684584 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:13.690331 | 2026-02-16 18:28:13.690398 | TASK [ensure-python : Install RPM package] 2026-02-16 18:28:13.715002 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:13.720989 | 2026-02-16 18:28:13.721061 | TASK [ensure-python : Install python using pyenv] 2026-02-16 18:28:13.745586 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:13.751367 | 2026-02-16 18:28:13.751435 | TASK [ensure-python : Activate python using stow] 2026-02-16 18:28:13.785932 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:13.798523 | 2026-02-16 18:28:13.798588 | TASK [Install pip] 2026-02-16 18:28:13.817936 | ubuntu-noble | ok 2026-02-16 18:28:13.840183 | 2026-02-16 18:28:13.840247 | TASK [ensure-pip : Check if pip is installed] 2026-02-16 18:28:14.377662 | ubuntu-noble | ok: Runtime: 0:00:00.005632 2026-02-16 18:28:14.387074 | 2026-02-16 18:28:14.387141 | LOOP [ensure-pip : Install pip from packages] 2026-02-16 18:28:14.421641 | ubuntu-noble | ok: "/var/lib/zuul/builds/f61bdc8ee2e64ecd8baf5b7f0d640c3b/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/Debian.yaml" 2026-02-16 18:28:14.442765 | ubuntu-noble | included: /var/lib/zuul/builds/f61bdc8ee2e64ecd8baf5b7f0d640c3b/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/Debian.yaml 2026-02-16 18:28:14.451905 | 2026-02-16 18:28:14.451965 | TASK [ensure-pip : Update package lists] 2026-02-16 18:28:20.907275 | ubuntu-noble | changed 2026-02-16 18:28:20.914788 | 2026-02-16 18:28:20.914879 | TASK [ensure-pip : Install Python 3 pip] 2026-02-16 18:28:27.203017 | ubuntu-noble | changed 2026-02-16 18:28:27.211963 | 2026-02-16 18:28:27.212057 | TASK [ensure-pip : Install Python 2 pip] 2026-02-16 18:28:27.237801 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:27.246975 | 2026-02-16 18:28:27.247068 | TASK [ensure-pip : Ensure setuptools] 2026-02-16 18:28:27.273208 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:27.284517 | 2026-02-16 18:28:27.284625 | TASK [ensure-pip : Check for ensurepip module] 2026-02-16 18:28:27.562807 | ubuntu-noble | usage: python -m ensurepip [-h] [--version] [-v] [-U] [--user] [--root ROOT] 2026-02-16 18:28:27.562889 | ubuntu-noble | [--altinstall] [--default-pip] 2026-02-16 18:28:27.562904 | ubuntu-noble | 2026-02-16 18:28:27.562914 | ubuntu-noble | options: 2026-02-16 18:28:27.562924 | ubuntu-noble | -h, --help show this help message and exit 2026-02-16 18:28:27.562939 | ubuntu-noble | --version Show the version of pip that is bundled with this Python. 2026-02-16 18:28:27.562951 | ubuntu-noble | -v, --verbose Give more output. Option is additive, and can be used up to 3 2026-02-16 18:28:27.562964 | ubuntu-noble | times. 2026-02-16 18:28:27.562974 | ubuntu-noble | -U, --upgrade Upgrade pip and dependencies, even if already installed. 2026-02-16 18:28:27.562983 | ubuntu-noble | --user Install using the user scheme. 2026-02-16 18:28:27.562992 | ubuntu-noble | --root ROOT Install everything relative to this alternate root directory. 2026-02-16 18:28:27.563001 | ubuntu-noble | --altinstall Make an alternate install, installing only the X.Y versioned 2026-02-16 18:28:27.563009 | ubuntu-noble | scripts (Default: pipX, pipX.Y). 2026-02-16 18:28:27.563018 | ubuntu-noble | --default-pip Make a default pip install, installing the unqualified pip in 2026-02-16 18:28:27.563026 | ubuntu-noble | addition to the versioned scripts. 2026-02-16 18:28:27.831947 | ubuntu-noble | ok: Runtime: 0:00:00.058384 2026-02-16 18:28:27.838933 | 2026-02-16 18:28:27.839002 | TASK [ensure-pip : Ensure python3-venv] 2026-02-16 18:28:27.863870 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:27.875442 | 2026-02-16 18:28:27.875536 | TASK [ensure-pip : Install pip from source] 2026-02-16 18:28:27.898907 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:27.953017 | 2026-02-16 18:28:27.953192 | TASK [ensure-pip : Probe for venv python full path] 2026-02-16 18:28:28.175827 | ubuntu-noble | /usr/bin/python3 2026-02-16 18:28:28.492743 | ubuntu-noble | ok: Runtime: 0:00:00.006625 2026-02-16 18:28:28.514355 | 2026-02-16 18:28:28.514467 | TASK [ensure-pip : Set host default] 2026-02-16 18:28:28.571149 | ubuntu-noble | ok 2026-02-16 18:28:28.577539 | 2026-02-16 18:28:28.577602 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2026-02-16 18:28:28.635698 | ubuntu-noble | ok 2026-02-16 18:28:28.645857 | 2026-02-16 18:28:28.645922 | TASK [ensure-tox : Check if tox is installed] 2026-02-16 18:28:29.181497 | ubuntu-noble | ok: Runtime: 0:00:00.006646 2026-02-16 18:28:29.189140 | 2026-02-16 18:28:29.189233 | TASK [ensure-tox : Export preinstalled tox_exectuable] 2026-02-16 18:28:29.214113 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:29.226354 | 2026-02-16 18:28:29.226430 | TASK [ensure-tox : Create local venv] 2026-02-16 18:28:32.770465 | ubuntu-noble | ok: Runtime: 0:00:03.175871 2026-02-16 18:28:32.777202 | 2026-02-16 18:28:32.777266 | TASK [ensure-tox : Install tox to local venv] 2026-02-16 18:28:33.575900 | ubuntu-noble | Collecting tox 2026-02-16 18:28:33.618097 | ubuntu-noble | Downloading tox-4.36.0-py3-none-any.whl.metadata (3.6 kB) 2026-02-16 18:28:33.688138 | ubuntu-noble | Collecting cachetools>=7.0.1 (from tox) 2026-02-16 18:28:33.692236 | ubuntu-noble | Downloading cachetools-7.0.1-py3-none-any.whl.metadata (5.6 kB) 2026-02-16 18:28:33.731375 | ubuntu-noble | Collecting chardet>=5.2 (from tox) 2026-02-16 18:28:33.734427 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl.metadata (3.4 kB) 2026-02-16 18:28:33.782208 | ubuntu-noble | Collecting colorama>=0.4.6 (from tox) 2026-02-16 18:28:33.784972 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2026-02-16 18:28:33.855830 | ubuntu-noble | Collecting filelock>=3.24 (from tox) 2026-02-16 18:28:33.859351 | ubuntu-noble | Downloading filelock-3.24.2-py3-none-any.whl.metadata (2.0 kB) 2026-02-16 18:28:33.912357 | ubuntu-noble | Collecting packaging>=26 (from tox) 2026-02-16 18:28:33.915184 | ubuntu-noble | Downloading packaging-26.0-py3-none-any.whl.metadata (3.3 kB) 2026-02-16 18:28:33.972067 | ubuntu-noble | Collecting platformdirs>=4.9.1 (from tox) 2026-02-16 18:28:33.974965 | ubuntu-noble | Downloading platformdirs-4.9.2-py3-none-any.whl.metadata (4.7 kB) 2026-02-16 18:28:34.021994 | ubuntu-noble | Collecting pluggy>=1.6 (from tox) 2026-02-16 18:28:34.024851 | ubuntu-noble | Downloading pluggy-1.6.0-py3-none-any.whl.metadata (4.8 kB) 2026-02-16 18:28:34.069488 | ubuntu-noble | Collecting pyproject-api>=1.10 (from tox) 2026-02-16 18:28:34.073426 | ubuntu-noble | Downloading pyproject_api-1.10.0-py3-none-any.whl.metadata (2.7 kB) 2026-02-16 18:28:34.200615 | ubuntu-noble | Collecting virtualenv>=20.36.1 (from tox) 2026-02-16 18:28:34.204817 | ubuntu-noble | Downloading virtualenv-20.37.0-py3-none-any.whl.metadata (5.1 kB) 2026-02-16 18:28:34.300115 | ubuntu-noble | Collecting distlib<1,>=0.3.7 (from virtualenv>=20.36.1->tox) 2026-02-16 18:28:34.303375 | ubuntu-noble | Downloading distlib-0.4.0-py2.py3-none-any.whl.metadata (5.2 kB) 2026-02-16 18:28:34.338528 | ubuntu-noble | Downloading tox-4.36.0-py3-none-any.whl (179 kB) 2026-02-16 18:28:34.355899 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 179.1/179.1 kB 12.1 MB/s eta 0:00:00 2026-02-16 18:28:34.359476 | ubuntu-noble | Downloading cachetools-7.0.1-py3-none-any.whl (13 kB) 2026-02-16 18:28:34.370591 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2026-02-16 18:28:34.386067 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 15.9 MB/s eta 0:00:00 2026-02-16 18:28:34.390271 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-02-16 18:28:34.403436 | ubuntu-noble | Downloading filelock-3.24.2-py3-none-any.whl (24 kB) 2026-02-16 18:28:34.416956 | ubuntu-noble | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-02-16 18:28:34.428475 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 7.4 MB/s eta 0:00:00 2026-02-16 18:28:34.431771 | ubuntu-noble | Downloading platformdirs-4.9.2-py3-none-any.whl (21 kB) 2026-02-16 18:28:34.443326 | ubuntu-noble | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-02-16 18:28:34.455915 | ubuntu-noble | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-02-16 18:28:34.470472 | ubuntu-noble | Downloading virtualenv-20.37.0-py3-none-any.whl (5.8 MB) 2026-02-16 18:28:34.558772 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.8/5.8 MB 68.6 MB/s eta 0:00:00 2026-02-16 18:28:34.564606 | ubuntu-noble | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-02-16 18:28:34.604612 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 12.7 MB/s eta 0:00:00 2026-02-16 18:28:34.676540 | ubuntu-noble | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2026-02-16 18:28:35.551508 | ubuntu-noble | Successfully installed cachetools-7.0.1 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.24.2 packaging-26.0 platformdirs-4.9.2 pluggy-1.6.0 pyproject-api-1.10.0 tox-4.36.0 virtualenv-20.37.0 2026-02-16 18:28:35.816072 | ubuntu-noble | ok: Runtime: 0:00:02.618823 2026-02-16 18:28:35.821912 | 2026-02-16 18:28:35.821980 | TASK [ensure-tox : Export installed tox_executable path] 2026-02-16 18:28:35.857800 | ubuntu-noble | ok 2026-02-16 18:28:35.864602 | 2026-02-16 18:28:35.864924 | TASK [ensure-tox : Output tox version] 2026-02-16 18:28:36.335866 | ubuntu-noble | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2026-02-16 18:28:36.348839 | ubuntu-noble | 4.36.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2026-02-16 18:28:36.422408 | ubuntu-noble | ok: Runtime: 0:00:00.271918 2026-02-16 18:28:36.427750 | 2026-02-16 18:28:36.427821 | TASK [ensure-tox : Make global symlink] 2026-02-16 18:28:36.453033 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:36.463831 | 2026-02-16 18:28:36.463895 | PLAY RECAP 2026-02-16 18:28:36.463954 | ubuntu-noble | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-02-16 18:28:36.463983 | 2026-02-16 18:28:36.625752 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2026-02-16 18:28:36.627053 | PRE-RUN START: [untrusted : github.com/vexxhost/magnum-cluster-api/zuul.d/playbooks/tox/pre.yml@main] 2026-02-16 18:28:37.191668 | 2026-02-16 18:28:37.191828 | PLAY [all] 2026-02-16 18:28:37.203558 | 2026-02-16 18:28:37.203640 | TASK [ensure-rust : Use rustup] 2026-02-16 18:28:37.235318 | ubuntu-noble | ok 2026-02-16 18:28:37.242351 | ubuntu-noble | included: /var/lib/zuul/builds/f61bdc8ee2e64ecd8baf5b7f0d640c3b/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-rust/tasks/rustup.yaml 2026-02-16 18:28:37.248409 | 2026-02-16 18:28:37.248485 | TASK [ensure-rust : Install Rust] 2026-02-16 18:28:37.641413 | ubuntu-noble | /bin/bash: line 2: curl: command not found 2026-02-16 18:28:37.785754 | ubuntu-noble | ERROR 2026-02-16 18:28:37.786036 | ubuntu-noble | { 2026-02-16 18:28:37.786079 | ubuntu-noble | "delta": "0:00:00.006886", 2026-02-16 18:28:37.786112 | ubuntu-noble | "end": "2026-02-16 18:28:37.642792", 2026-02-16 18:28:37.786141 | ubuntu-noble | "msg": "non-zero return code", 2026-02-16 18:28:37.786167 | ubuntu-noble | "rc": 127, 2026-02-16 18:28:37.786194 | ubuntu-noble | "start": "2026-02-16 18:28:37.635906" 2026-02-16 18:28:37.786225 | ubuntu-noble | } failure 2026-02-16 18:28:37.788322 | 2026-02-16 18:28:37.788388 | PLAY RECAP 2026-02-16 18:28:37.788451 | ubuntu-noble | ok: 1 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-02-16 18:28:37.788483 | 2026-02-16 18:28:37.901935 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/magnum-cluster-api/zuul.d/playbooks/tox/pre.yml@main] 2026-02-16 18:28:37.903743 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2026-02-16 18:28:38.485644 | 2026-02-16 18:28:38.485781 | PLAY [all] 2026-02-16 18:28:38.498535 | 2026-02-16 18:28:38.498618 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-02-16 18:28:38.545309 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:38.554390 | 2026-02-16 18:28:38.554494 | TASK [fetch-tox-output : Set tox log path for single node] 2026-02-16 18:28:38.598415 | ubuntu-noble | ok 2026-02-16 18:28:38.605819 | 2026-02-16 18:28:38.605888 | TASK [fetch-tox-output : Ensure local tox dir] 2026-02-16 18:28:38.995084 | ubuntu-noble -> localhost | changed 2026-02-16 18:28:39.006321 | 2026-02-16 18:28:39.006501 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-02-16 18:28:39.042779 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:39.048617 | 2026-02-16 18:28:39.048690 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 18:28:39.088625 | ubuntu-noble | ok 2026-02-16 18:28:39.094308 | 2026-02-16 18:28:39.094375 | TASK [fetch-tox-output : Get tox version] 2026-02-16 18:28:39.741623 | ubuntu-noble | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2026-02-16 18:28:39.756534 | ubuntu-noble | 4.36.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2026-02-16 18:28:40.133445 | ubuntu-noble | ok: Runtime: 0:00:00.301466 2026-02-16 18:28:40.139132 | 2026-02-16 18:28:40.139201 | TASK [fetch-tox-output : Find all default environments] 2026-02-16 18:28:40.670174 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:40.679734 | 2026-02-16 18:28:40.679831 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 18:28:40.704912 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:40.715849 | 2026-02-16 18:28:40.715914 | TASK [fetch-tox-output : Find all default environments] 2026-02-16 18:28:41.244615 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:41.255283 | 2026-02-16 18:28:41.255392 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 18:28:41.281473 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:41.288569 | 2026-02-16 18:28:41.288644 | LOOP [fetch-tox-output : Copy tox logs] 2026-02-16 18:28:41.330756 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:41.344494 | 2026-02-16 18:28:41.344601 | LOOP [fetch-tox-output : Collect tox logs] 2026-02-16 18:28:42.117811 | ubuntu-noble | ok: 2026-02-16 18:28:42.118008 | 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 18:28:42.118051 | ubuntu-noble | rsync error: some files/attrs were not transferred (see previous errors) (code 23) at main.c(1865) [Receiver=3.2.7] 2026-02-16 18:28:42.118074 | ubuntu-noble | rsync: [Receiver] write error: Broken pipe (32) 2026-02-16 18:28:42.118101 | 2026-02-16 18:28:42.138068 | 2026-02-16 18:28:42.138191 | PLAY RECAP 2026-02-16 18:28:42.138245 | ubuntu-noble | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-02-16 18:28:42.138267 | 2026-02-16 18:28:42.255928 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2026-02-16 18:28:42.257274 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-16 18:28:42.813773 | 2026-02-16 18:28:42.813918 | PLAY [all] 2026-02-16 18:28:42.826424 | 2026-02-16 18:28:42.826513 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-02-16 18:28:43.005127 | ubuntu-noble | changed: non-zero return code 2026-02-16 18:28:43.012468 | 2026-02-16 18:28:43.012546 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-02-16 18:28:43.037652 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:43.048767 | 2026-02-16 18:28:43.048841 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-02-16 18:28:43.084292 | 2026-02-16 18:28:43.084419 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-02-16 18:28:43.119536 | 2026-02-16 18:28:43.119661 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-02-16 18:28:43.144296 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:43.155853 | 2026-02-16 18:28:43.155927 | LOOP [fetch-subunit-output : Generate subunit file] 2026-02-16 18:28:43.188339 | 2026-02-16 18:28:43.188543 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-02-16 18:28:43.213577 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:43.223184 | 2026-02-16 18:28:43.223256 | TASK [fetch-subunit-output : Remove the temporary file] 2026-02-16 18:28:43.247740 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:43.261021 | 2026-02-16 18:28:43.261179 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-02-16 18:28:43.286155 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:43.300479 | 2026-02-16 18:28:43.300609 | PLAY RECAP 2026-02-16 18:28:43.300664 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-16 18:28:43.300687 | 2026-02-16 18:28:43.424625 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-16 18:28:43.428090 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main] 2026-02-16 18:28:44.049065 | 2026-02-16 18:28:44.049217 | PLAY [all] 2026-02-16 18:28:44.061416 | 2026-02-16 18:28:44.061542 | TASK [fetch-output : Set log path for multiple nodes] 2026-02-16 18:28:44.096611 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 18:28:44.102971 | 2026-02-16 18:28:44.103072 | TASK [fetch-output : Set log path for single node] 2026-02-16 18:28:44.142792 | ubuntu-noble | ok 2026-02-16 18:28:44.148829 | 2026-02-16 18:28:44.148900 | LOOP [fetch-output : Ensure local output dirs] 2026-02-16 18:28:44.545455 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/f61bdc8ee2e64ecd8baf5b7f0d640c3b/work/logs" 2026-02-16 18:28:44.756202 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/f61bdc8ee2e64ecd8baf5b7f0d640c3b/work/artifacts" 2026-02-16 18:28:44.966807 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/f61bdc8ee2e64ecd8baf5b7f0d640c3b/work/docs" 2026-02-16 18:28:45.009169 | 2026-02-16 18:28:45.009398 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-16 18:28:45.663852 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 18:28:45.664074 | ubuntu-noble | changed: All items complete 2026-02-16 18:28:45.664103 | 2026-02-16 18:28:46.128705 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 18:28:46.591454 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 18:28:46.620265 | 2026-02-16 18:28:46.620427 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-02-16 18:28:47.045387 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.009057 2026-02-16 18:28:47.281272 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.008082 2026-02-16 18:28:47.302331 | 2026-02-16 18:28:47.302472 | PLAY [all] 2026-02-16 18:28:47.310379 | 2026-02-16 18:28:47.310445 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-02-16 18:28:47.803155 | ubuntu-noble | changed 2026-02-16 18:28:47.809097 | 2026-02-16 18:28:47.809146 | PLAY RECAP 2026-02-16 18:28:47.809191 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-02-16 18:28:47.809212 | 2026-02-16 18:28:47.931110 | POST-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main] 2026-02-16 18:28:47.932539 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post-logs.yaml@main] 2026-02-16 18:28:48.490408 | 2026-02-16 18:28:48.490571 | PLAY [localhost] 2026-02-16 18:28:48.500817 | 2026-02-16 18:28:48.500885 | TASK [Generate Zuul manifest] 2026-02-16 18:28:48.520654 | localhost | ok 2026-02-16 18:28:48.536123 | 2026-02-16 18:28:48.536197 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-16 18:28:48.860546 | localhost | changed 2026-02-16 18:28:48.873436 | 2026-02-16 18:28:48.873513 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-16 18:28:48.903693 | localhost | ok 2026-02-16 18:28:48.912345 | 2026-02-16 18:28:48.912407 | TASK [Upload logs] 2026-02-16 18:28:48.933415 | localhost | ok 2026-02-16 18:28:48.993088 | 2026-02-16 18:28:48.993230 | TASK [Set zuul-log-path fact] 2026-02-16 18:28:49.012630 | localhost | ok 2026-02-16 18:28:49.025313 | 2026-02-16 18:28:49.025381 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-16 18:28:49.057468 | localhost | ok 2026-02-16 18:28:49.067439 | 2026-02-16 18:28:49.067508 | TASK [upload-logs : Create log directories] 2026-02-16 18:28:49.503200 | localhost | changed 2026-02-16 18:28:49.510014 | 2026-02-16 18:28:49.510100 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-02-16 18:28:49.927184 | localhost -> localhost | ok: Runtime: 0:00:00.005835 2026-02-16 18:28:49.938258 | 2026-02-16 18:28:49.938384 | TASK [upload-logs : Upload logs to log server] 2026-02-16 18:28:50.404221 | localhost | Output suppressed because no_log was given 2026-02-16 18:28:50.409167 | 2026-02-16 18:28:50.409256 | LOOP [upload-logs : Compress console log and json output] 2026-02-16 18:28:50.462983 | localhost | skipping: Conditional result was False 2026-02-16 18:28:50.469656 | localhost | skipping: Conditional result was False 2026-02-16 18:28:50.483280 | 2026-02-16 18:28:50.483413 | LOOP [upload-logs : Upload compressed console log and json output] 2026-02-16 18:28:50.525661 | localhost | skipping: Conditional result was False 2026-02-16 18:28:50.526071 | 2026-02-16 18:28:50.529188 | localhost | skipping: Conditional result was False 2026-02-16 18:28:50.545555 | 2026-02-16 18:28:50.545689 | LOOP [upload-logs : Upload console log and json output]