2026-02-16 17:39:28.499165 | Job console starting 2026-02-16 17:39:28.652465 | Updating git repos 2026-02-16 17:39:28.687515 | Cloning repos into workspace 2026-02-16 17:39:28.978572 | Restoring repo states 2026-02-16 17:39:28.990764 | Merging changes 2026-02-16 17:39:29.496769 | Checking out repos 2026-02-16 17:39:29.817969 | Preparing playbooks 2026-02-16 17:39:32.762062 | Running Ansible setup 2026-02-16 17:39:36.349336 | PRE-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main] 2026-02-16 17:39:36.920196 | 2026-02-16 17:39:36.920401 | PLAY [localhost] 2026-02-16 17:39:36.928122 | 2026-02-16 17:39:36.928201 | TASK [Gathering Facts] 2026-02-16 17:39:37.806363 | localhost | ok 2026-02-16 17:39:37.813353 | 2026-02-16 17:39:37.813429 | TASK [Setup log path fact] 2026-02-16 17:39:37.831803 | localhost | ok 2026-02-16 17:39:37.844186 | 2026-02-16 17:39:37.844253 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-16 17:39:37.875059 | localhost | ok 2026-02-16 17:39:37.885810 | 2026-02-16 17:39:37.885877 | TASK [emit-job-header : Print job information] 2026-02-16 17:39:37.930237 | # Job Information 2026-02-16 17:39:37.930507 | Ansible Version: 2.16.15 2026-02-16 17:39:37.930576 | Job: magnum-cluster-api-tox-unit 2026-02-16 17:39:37.930623 | Pipeline: check 2026-02-16 17:39:37.930674 | Executor: 3a2793d2bd32 2026-02-16 17:39:37.930727 | Triggered by: https://github.com/vexxhost/magnum-cluster-api/pull/884 2026-02-16 17:39:37.930775 | Event ID: 2685a480-0b5e-11f1-90f6-a235114455cc 2026-02-16 17:39:37.934217 | 2026-02-16 17:39:37.934284 | LOOP [emit-job-header : Print node information] 2026-02-16 17:39:38.039997 | localhost | ok: 2026-02-16 17:39:38.040346 | localhost | # Node Information 2026-02-16 17:39:38.040388 | localhost | Inventory Hostname: ubuntu-noble 2026-02-16 17:39:38.040420 | localhost | Hostname: np0000155617 2026-02-16 17:39:38.040448 | localhost | Username: zuul 2026-02-16 17:39:38.040482 | localhost | Distro: Ubuntu 24.04 2026-02-16 17:39:38.040510 | localhost | Provider: yul1 2026-02-16 17:39:38.040537 | localhost | Region: ca-ymq-1 2026-02-16 17:39:38.040563 | localhost | Label: ubuntu-noble 2026-02-16 17:39:38.040589 | localhost | Product Name: OpenStack Nova 2026-02-16 17:39:38.040615 | localhost | Interface IP: 199.204.45.244 2026-02-16 17:39:38.052973 | 2026-02-16 17:39:38.053108 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-16 17:39:38.434964 | localhost -> localhost | changed 2026-02-16 17:39:38.445524 | 2026-02-16 17:39:38.445610 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-16 17:39:39.267469 | localhost -> localhost | changed 2026-02-16 17:39:39.278728 | 2026-02-16 17:39:39.278812 | PLAY [all] 2026-02-16 17:39:39.292171 | 2026-02-16 17:39:39.292245 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-16 17:39:39.529678 | ubuntu-noble -> localhost | ok 2026-02-16 17:39:39.543045 | 2026-02-16 17:39:39.543139 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-16 17:39:39.579826 | ubuntu-noble | ok 2026-02-16 17:39:39.596676 | ubuntu-noble | included: /var/lib/zuul/builds/0e15bef3a3584444bb62fab2a8b1f121/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-16 17:39:39.602923 | 2026-02-16 17:39:39.602986 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-16 17:39:40.306327 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2026-02-16 17:39:40.306509 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/0e15bef3a3584444bb62fab2a8b1f121/work/0e15bef3a3584444bb62fab2a8b1f121_id_rsa 2026-02-16 17:39:40.306539 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/0e15bef3a3584444bb62fab2a8b1f121/work/0e15bef3a3584444bb62fab2a8b1f121_id_rsa.pub 2026-02-16 17:39:40.306561 | ubuntu-noble -> localhost | The key fingerprint is: 2026-02-16 17:39:40.306583 | ubuntu-noble -> localhost | SHA256:SnBb9EFjG99DC0YtlxmSGoDeL4GSfJUWubb2jCsBw5Y zuul-build-sshkey 2026-02-16 17:39:40.306615 | ubuntu-noble -> localhost | The key's randomart image is: 2026-02-16 17:39:40.306636 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2026-02-16 17:39:40.306661 | ubuntu-noble -> localhost | | .+**.=oo+ | 2026-02-16 17:39:40.306683 | ubuntu-noble -> localhost | | ..=o.Bo==. | 2026-02-16 17:39:40.306702 | ubuntu-noble -> localhost | | o.+.=..oo.o+ | 2026-02-16 17:39:40.306721 | ubuntu-noble -> localhost | | Eo+o= . . | 2026-02-16 17:39:40.306740 | ubuntu-noble -> localhost | | . =o.S+ | 2026-02-16 17:39:40.306760 | ubuntu-noble -> localhost | | ...+ . | 2026-02-16 17:39:40.306778 | ubuntu-noble -> localhost | | .o = | 2026-02-16 17:39:40.306796 | ubuntu-noble -> localhost | | . . o | 2026-02-16 17:39:40.306817 | ubuntu-noble -> localhost | | ... | 2026-02-16 17:39:40.306837 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2026-02-16 17:39:40.306882 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.295759 2026-02-16 17:39:40.312400 | 2026-02-16 17:39:40.312463 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-16 17:39:40.342093 | ubuntu-noble | ok 2026-02-16 17:39:40.355845 | ubuntu-noble | included: /var/lib/zuul/builds/0e15bef3a3584444bb62fab2a8b1f121/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-16 17:39:40.363789 | 2026-02-16 17:39:40.363848 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-16 17:39:40.387986 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:39:40.396162 | 2026-02-16 17:39:40.396260 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-16 17:39:40.994952 | ubuntu-noble | changed 2026-02-16 17:39:41.000605 | 2026-02-16 17:39:41.000671 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-16 17:39:41.259676 | ubuntu-noble | ok 2026-02-16 17:39:41.267075 | 2026-02-16 17:39:41.267147 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-16 17:39:41.848067 | ubuntu-noble | changed 2026-02-16 17:39:41.854347 | 2026-02-16 17:39:41.854412 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-16 17:39:42.438246 | ubuntu-noble | changed 2026-02-16 17:39:42.444665 | 2026-02-16 17:39:42.444733 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-16 17:39:42.460060 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:39:42.467077 | 2026-02-16 17:39:42.467142 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-16 17:39:42.804506 | ubuntu-noble -> localhost | changed 2026-02-16 17:39:42.820025 | 2026-02-16 17:39:42.820097 | TASK [add-build-sshkey : Add back temp key] 2026-02-16 17:39:43.097864 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/0e15bef3a3584444bb62fab2a8b1f121/work/0e15bef3a3584444bb62fab2a8b1f121_id_rsa (zuul-build-sshkey) 2026-02-16 17:39:43.098117 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.014498 2026-02-16 17:39:43.106312 | 2026-02-16 17:39:43.106378 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-16 17:39:43.456113 | ubuntu-noble | ok 2026-02-16 17:39:43.461102 | 2026-02-16 17:39:43.461165 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-16 17:39:43.484365 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:39:43.500579 | 2026-02-16 17:39:43.500640 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-02-16 17:39:43.876870 | ubuntu-noble | ok 2026-02-16 17:39:43.884244 | 2026-02-16 17:39:43.884308 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-02-16 17:39:44.899950 | ubuntu-noble | Output suppressed because no_log was given 2026-02-16 17:39:44.909663 | 2026-02-16 17:39:44.909732 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-02-16 17:39:45.128325 | ubuntu-noble | ok: "logs" 2026-02-16 17:39:45.128617 | ubuntu-noble | ok: All items complete 2026-02-16 17:39:45.128661 | 2026-02-16 17:39:45.361037 | ubuntu-noble | ok: "artifacts" 2026-02-16 17:39:45.504553 | ubuntu-noble | ok: "docs" 2026-02-16 17:39:45.522429 | 2026-02-16 17:39:45.522623 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-02-16 17:39:45.757777 | ubuntu-noble | changed: "logs" 2026-02-16 17:39:45.945751 | ubuntu-noble | changed: "artifacts" 2026-02-16 17:39:46.132886 | ubuntu-noble | changed: "docs" 2026-02-16 17:39:46.154513 | 2026-02-16 17:39:46.154654 | PLAY RECAP 2026-02-16 17:39:46.154704 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-16 17:39:46.154734 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-02-16 17:39:46.154757 | 2026-02-16 17:39:46.289714 | PRE-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main] 2026-02-16 17:39:46.290925 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-16 17:39:46.845821 | 2026-02-16 17:39:46.845957 | PLAY [all] 2026-02-16 17:39:46.858047 | 2026-02-16 17:39:46.858124 | TASK [Install binary dependencies] 2026-02-16 17:39:46.903488 | ubuntu-noble | ok 2026-02-16 17:39:46.924203 | 2026-02-16 17:39:46.924318 | TASK [bindep : Include find tasks] 2026-02-16 17:39:46.959335 | ubuntu-noble | ok 2026-02-16 17:39:46.967288 | ubuntu-noble | included: /var/lib/zuul/builds/0e15bef3a3584444bb62fab2a8b1f121/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-02-16 17:39:46.973469 | 2026-02-16 17:39:46.973529 | TASK [bindep : Look for bindep.txt] 2026-02-16 17:39:47.321827 | ubuntu-noble | ok 2026-02-16 17:39:47.328989 | 2026-02-16 17:39:47.329055 | TASK [bindep : Define bindep_file fact] 2026-02-16 17:39:47.352517 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:39:47.362544 | 2026-02-16 17:39:47.362656 | TASK [bindep : Look for other-requirements.txt] 2026-02-16 17:39:47.580359 | ubuntu-noble | ok 2026-02-16 17:39:47.585648 | 2026-02-16 17:39:47.585716 | TASK [bindep : Define bindep_file fact] 2026-02-16 17:39:47.610942 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:39:47.621588 | 2026-02-16 17:39:47.621681 | TASK [bindep : Look for bindep fallback file] 2026-02-16 17:39:47.648773 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:39:47.660068 | 2026-02-16 17:39:47.660160 | TASK [bindep : Define bindep_file fact] 2026-02-16 17:39:47.685096 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:39:47.694674 | 2026-02-16 17:39:47.694770 | TASK [bindep : Include bindep tasks] 2026-02-16 17:39:47.719810 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:39:47.730066 | 2026-02-16 17:39:47.730152 | TASK [bindep : Include install tasks] 2026-02-16 17:39:47.755317 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:39:47.765540 | 2026-02-16 17:39:47.765630 | LOOP [bindep : Include package tasks] 2026-02-16 17:39:47.833394 | 2026-02-16 17:39:47.833706 | TASK [Run test-setup role] 2026-02-16 17:39:47.861363 | ubuntu-noble | ok 2026-02-16 17:39:47.882279 | 2026-02-16 17:39:47.882349 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-02-16 17:39:48.100252 | ubuntu-noble | ok 2026-02-16 17:39:48.107222 | 2026-02-16 17:39:48.107293 | TASK [test-setup : Run tools/test-setup.sh] 2026-02-16 17:39:48.638882 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:39:48.650345 | 2026-02-16 17:39:48.650399 | PLAY RECAP 2026-02-16 17:39:48.650450 | ubuntu-noble | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-16 17:39:48.650472 | 2026-02-16 17:39:48.763451 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-16 17:39:48.765829 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2026-02-16 17:39:50.247473 | 2026-02-16 17:39:50.247610 | PLAY [all] 2026-02-16 17:39:50.262743 | 2026-02-16 17:39:50.262841 | TASK [ensure-python : Validate python_version value] 2026-02-16 17:39:50.287976 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:39:50.298010 | 2026-02-16 17:39:50.298093 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)] 2026-02-16 17:39:50.320719 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:39:50.331809 | 2026-02-16 17:39:50.331904 | TASK [ensure-python : Pull in venv package] 2026-02-16 17:39:50.356785 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:39:50.368440 | 2026-02-16 17:39:50.368509 | TASK [ensure-python : Set default RPM package name] 2026-02-16 17:39:50.393161 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:39:50.400799 | 2026-02-16 17:39:50.400899 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9/10] 2026-02-16 17:39:50.425880 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:39:50.436750 | 2026-02-16 17:39:50.436833 | TASK [ensure-python : Install RPM package] 2026-02-16 17:39:50.461604 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:39:50.467770 | 2026-02-16 17:39:50.467847 | TASK [ensure-python : Install python using pyenv] 2026-02-16 17:39:50.492689 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:39:50.498485 | 2026-02-16 17:39:50.498557 | TASK [ensure-python : Activate python using stow] 2026-02-16 17:39:50.523198 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:39:50.539100 | 2026-02-16 17:39:50.539164 | TASK [Install pip] 2026-02-16 17:39:50.562661 | ubuntu-noble | ok 2026-02-16 17:39:50.586814 | 2026-02-16 17:39:50.586890 | TASK [ensure-pip : Check if pip is installed] 2026-02-16 17:39:51.120356 | ubuntu-noble | ok: Runtime: 0:00:00.007244 2026-02-16 17:39:51.125904 | 2026-02-16 17:39:51.125970 | LOOP [ensure-pip : Install pip from packages] 2026-02-16 17:39:51.160823 | ubuntu-noble | ok: "/var/lib/zuul/builds/0e15bef3a3584444bb62fab2a8b1f121/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/Debian.yaml" 2026-02-16 17:39:51.174256 | ubuntu-noble | included: /var/lib/zuul/builds/0e15bef3a3584444bb62fab2a8b1f121/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/Debian.yaml 2026-02-16 17:39:51.183555 | 2026-02-16 17:39:51.183621 | TASK [ensure-pip : Update package lists] 2026-02-16 17:39:57.503049 | ubuntu-noble | changed 2026-02-16 17:39:57.508564 | 2026-02-16 17:39:57.508631 | TASK [ensure-pip : Install Python 3 pip] 2026-02-16 17:40:03.270349 | ubuntu-noble | changed 2026-02-16 17:40:03.277763 | 2026-02-16 17:40:03.277867 | TASK [ensure-pip : Install Python 2 pip] 2026-02-16 17:40:03.305890 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:40:03.317186 | 2026-02-16 17:40:03.317262 | TASK [ensure-pip : Ensure setuptools] 2026-02-16 17:40:03.331610 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:40:03.344058 | 2026-02-16 17:40:03.344129 | TASK [ensure-pip : Check for ensurepip module] 2026-02-16 17:40:03.620461 | ubuntu-noble | usage: python -m ensurepip [-h] [--version] [-v] [-U] [--user] [--root ROOT] 2026-02-16 17:40:03.620615 | ubuntu-noble | [--altinstall] [--default-pip] 2026-02-16 17:40:03.620630 | ubuntu-noble | 2026-02-16 17:40:03.620641 | ubuntu-noble | options: 2026-02-16 17:40:03.620651 | ubuntu-noble | -h, --help show this help message and exit 2026-02-16 17:40:03.620666 | ubuntu-noble | --version Show the version of pip that is bundled with this Python. 2026-02-16 17:40:03.620679 | ubuntu-noble | -v, --verbose Give more output. Option is additive, and can be used up to 3 2026-02-16 17:40:03.620693 | ubuntu-noble | times. 2026-02-16 17:40:03.620704 | ubuntu-noble | -U, --upgrade Upgrade pip and dependencies, even if already installed. 2026-02-16 17:40:03.620713 | ubuntu-noble | --user Install using the user scheme. 2026-02-16 17:40:03.620726 | ubuntu-noble | --root ROOT Install everything relative to this alternate root directory. 2026-02-16 17:40:03.620735 | ubuntu-noble | --altinstall Make an alternate install, installing only the X.Y versioned 2026-02-16 17:40:03.620744 | ubuntu-noble | scripts (Default: pipX, pipX.Y). 2026-02-16 17:40:03.620752 | ubuntu-noble | --default-pip Make a default pip install, installing the unqualified pip in 2026-02-16 17:40:03.620761 | ubuntu-noble | addition to the versioned scripts. 2026-02-16 17:40:03.882836 | ubuntu-noble | ok: Runtime: 0:00:00.060303 2026-02-16 17:40:03.890379 | 2026-02-16 17:40:03.890446 | TASK [ensure-pip : Ensure python3-venv] 2026-02-16 17:40:03.915546 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:40:03.926626 | 2026-02-16 17:40:03.926759 | TASK [ensure-pip : Install pip from source] 2026-02-16 17:40:03.952645 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:40:04.006426 | 2026-02-16 17:40:04.006584 | TASK [ensure-pip : Probe for venv python full path] 2026-02-16 17:40:04.255673 | ubuntu-noble | /usr/bin/python3 2026-02-16 17:40:04.589971 | ubuntu-noble | ok: Runtime: 0:00:00.005264 2026-02-16 17:40:04.597653 | 2026-02-16 17:40:04.597778 | TASK [ensure-pip : Set host default] 2026-02-16 17:40:04.653424 | ubuntu-noble | ok 2026-02-16 17:40:04.660910 | 2026-02-16 17:40:04.660998 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2026-02-16 17:40:04.769281 | ubuntu-noble | ok 2026-02-16 17:40:04.779429 | 2026-02-16 17:40:04.779494 | TASK [ensure-tox : Check if tox is installed] 2026-02-16 17:40:05.320609 | ubuntu-noble | ok: Runtime: 0:00:00.005198 2026-02-16 17:40:05.327924 | 2026-02-16 17:40:05.327992 | TASK [ensure-tox : Export preinstalled tox_exectuable] 2026-02-16 17:40:05.352438 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:40:05.363450 | 2026-02-16 17:40:05.363542 | TASK [ensure-tox : Create local venv] 2026-02-16 17:40:08.907475 | ubuntu-noble | ok: Runtime: 0:00:03.189957 2026-02-16 17:40:08.913634 | 2026-02-16 17:40:08.913741 | TASK [ensure-tox : Install tox to local venv] 2026-02-16 17:40:09.673404 | ubuntu-noble | Collecting tox 2026-02-16 17:40:09.718734 | ubuntu-noble | Downloading tox-4.36.0-py3-none-any.whl.metadata (3.6 kB) 2026-02-16 17:40:09.776076 | ubuntu-noble | Collecting cachetools>=7.0.1 (from tox) 2026-02-16 17:40:09.779915 | ubuntu-noble | Downloading cachetools-7.0.1-py3-none-any.whl.metadata (5.6 kB) 2026-02-16 17:40:09.828264 | ubuntu-noble | Collecting chardet>=5.2 (from tox) 2026-02-16 17:40:09.831490 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl.metadata (3.4 kB) 2026-02-16 17:40:09.876730 | ubuntu-noble | Collecting colorama>=0.4.6 (from tox) 2026-02-16 17:40:09.879753 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2026-02-16 17:40:09.938419 | ubuntu-noble | Collecting filelock>=3.24 (from tox) 2026-02-16 17:40:09.941403 | ubuntu-noble | Downloading filelock-3.24.2-py3-none-any.whl.metadata (2.0 kB) 2026-02-16 17:40:09.991270 | ubuntu-noble | Collecting packaging>=26 (from tox) 2026-02-16 17:40:09.994251 | ubuntu-noble | Downloading packaging-26.0-py3-none-any.whl.metadata (3.3 kB) 2026-02-16 17:40:10.044492 | ubuntu-noble | Collecting platformdirs>=4.9.1 (from tox) 2026-02-16 17:40:10.047873 | ubuntu-noble | Downloading platformdirs-4.9.2-py3-none-any.whl.metadata (4.7 kB) 2026-02-16 17:40:10.095453 | ubuntu-noble | Collecting pluggy>=1.6 (from tox) 2026-02-16 17:40:10.098218 | ubuntu-noble | Downloading pluggy-1.6.0-py3-none-any.whl.metadata (4.8 kB) 2026-02-16 17:40:10.138758 | ubuntu-noble | Collecting pyproject-api>=1.10 (from tox) 2026-02-16 17:40:10.142513 | ubuntu-noble | Downloading pyproject_api-1.10.0-py3-none-any.whl.metadata (2.7 kB) 2026-02-16 17:40:10.267981 | ubuntu-noble | Collecting virtualenv>=20.36.1 (from tox) 2026-02-16 17:40:10.274193 | ubuntu-noble | Downloading virtualenv-20.37.0-py3-none-any.whl.metadata (5.1 kB) 2026-02-16 17:40:10.365609 | ubuntu-noble | Collecting distlib<1,>=0.3.7 (from virtualenv>=20.36.1->tox) 2026-02-16 17:40:10.369171 | ubuntu-noble | Downloading distlib-0.4.0-py2.py3-none-any.whl.metadata (5.2 kB) 2026-02-16 17:40:10.403837 | ubuntu-noble | Downloading tox-4.36.0-py3-none-any.whl (179 kB) 2026-02-16 17:40:10.421549 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 179.1/179.1 kB 11.9 MB/s eta 0:00:00 2026-02-16 17:40:10.425008 | ubuntu-noble | Downloading cachetools-7.0.1-py3-none-any.whl (13 kB) 2026-02-16 17:40:10.436242 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2026-02-16 17:40:10.449671 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 17.8 MB/s eta 0:00:00 2026-02-16 17:40:10.453025 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-02-16 17:40:10.464705 | ubuntu-noble | Downloading filelock-3.24.2-py3-none-any.whl (24 kB) 2026-02-16 17:40:10.476833 | ubuntu-noble | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-02-16 17:40:10.490442 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 6.4 MB/s eta 0:00:00 2026-02-16 17:40:10.493273 | ubuntu-noble | Downloading platformdirs-4.9.2-py3-none-any.whl (21 kB) 2026-02-16 17:40:10.503303 | ubuntu-noble | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-02-16 17:40:10.513570 | ubuntu-noble | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-02-16 17:40:10.526179 | ubuntu-noble | Downloading virtualenv-20.37.0-py3-none-any.whl (5.8 MB) 2026-02-16 17:40:10.605203 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.8/5.8 MB 77.8 MB/s eta 0:00:00 2026-02-16 17:40:10.609717 | ubuntu-noble | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-02-16 17:40:10.629319 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 28.4 MB/s eta 0:00:00 2026-02-16 17:40:10.697775 | ubuntu-noble | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2026-02-16 17:40:11.558061 | ubuntu-noble | Successfully installed cachetools-7.0.1 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.24.2 packaging-26.0 platformdirs-4.9.2 pluggy-1.6.0 pyproject-api-1.10.0 tox-4.36.0 virtualenv-20.37.0 2026-02-16 17:40:11.959600 | ubuntu-noble | ok: Runtime: 0:00:02.507788 2026-02-16 17:40:11.968221 | 2026-02-16 17:40:11.968326 | TASK [ensure-tox : Export installed tox_executable path] 2026-02-16 17:40:12.005843 | ubuntu-noble | ok 2026-02-16 17:40:12.011038 | 2026-02-16 17:40:12.011103 | TASK [ensure-tox : Output tox version] 2026-02-16 17:40:12.461259 | ubuntu-noble | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2026-02-16 17:40:12.475754 | ubuntu-noble | 4.36.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2026-02-16 17:40:12.558554 | ubuntu-noble | ok: Runtime: 0:00:00.265421 2026-02-16 17:40:12.564385 | 2026-02-16 17:40:12.564450 | TASK [ensure-tox : Make global symlink] 2026-02-16 17:40:12.588870 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:40:12.600307 | 2026-02-16 17:40:12.600382 | PLAY RECAP 2026-02-16 17:40:12.600447 | ubuntu-noble | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-02-16 17:40:12.600477 | 2026-02-16 17:40:12.752517 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2026-02-16 17:40:12.754228 | PRE-RUN START: [untrusted : github.com/vexxhost/magnum-cluster-api/zuul.d/playbooks/tox/pre.yml@main] 2026-02-16 17:40:13.348360 | 2026-02-16 17:40:13.348580 | PLAY [all] 2026-02-16 17:40:13.362246 | 2026-02-16 17:40:13.362421 | TASK [ensure-rust : Use rustup] 2026-02-16 17:40:13.396513 | ubuntu-noble | ok 2026-02-16 17:40:13.406218 | ubuntu-noble | included: /var/lib/zuul/builds/0e15bef3a3584444bb62fab2a8b1f121/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-rust/tasks/rustup.yaml 2026-02-16 17:40:13.412665 | 2026-02-16 17:40:13.412746 | TASK [ensure-rust : Install Rust] 2026-02-16 17:40:13.804527 | ubuntu-noble | /bin/bash: line 2: curl: command not found 2026-02-16 17:40:13.954683 | ubuntu-noble | ERROR 2026-02-16 17:40:13.955003 | ubuntu-noble | { 2026-02-16 17:40:13.955070 | ubuntu-noble | "delta": "0:00:00.006132", 2026-02-16 17:40:13.955121 | ubuntu-noble | "end": "2026-02-16 17:40:13.805646", 2026-02-16 17:40:13.955166 | ubuntu-noble | "msg": "non-zero return code", 2026-02-16 17:40:13.955208 | ubuntu-noble | "rc": 127, 2026-02-16 17:40:13.955249 | ubuntu-noble | "start": "2026-02-16 17:40:13.799514" 2026-02-16 17:40:13.955294 | ubuntu-noble | } failure 2026-02-16 17:40:13.957841 | 2026-02-16 17:40:13.957892 | PLAY RECAP 2026-02-16 17:40:13.957939 | ubuntu-noble | ok: 1 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-02-16 17:40:13.957960 | 2026-02-16 17:40:14.063902 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/magnum-cluster-api/zuul.d/playbooks/tox/pre.yml@main] 2026-02-16 17:40:14.066331 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2026-02-16 17:40:14.640885 | 2026-02-16 17:40:14.641106 | PLAY [all] 2026-02-16 17:40:14.653551 | 2026-02-16 17:40:14.653638 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-02-16 17:40:14.690569 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:40:14.702882 | 2026-02-16 17:40:14.702990 | TASK [fetch-tox-output : Set tox log path for single node] 2026-02-16 17:40:14.748978 | ubuntu-noble | ok 2026-02-16 17:40:14.755887 | 2026-02-16 17:40:14.755963 | TASK [fetch-tox-output : Ensure local tox dir] 2026-02-16 17:40:15.158950 | ubuntu-noble -> localhost | changed 2026-02-16 17:40:15.171615 | 2026-02-16 17:40:15.171725 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-02-16 17:40:15.217559 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:40:15.223609 | 2026-02-16 17:40:15.223682 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 17:40:15.267894 | ubuntu-noble | ok 2026-02-16 17:40:15.276143 | 2026-02-16 17:40:15.276236 | TASK [fetch-tox-output : Get tox version] 2026-02-16 17:40:15.879336 | ubuntu-noble | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2026-02-16 17:40:15.893268 | ubuntu-noble | 4.36.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2026-02-16 17:40:16.314661 | ubuntu-noble | ok: Runtime: 0:00:00.243832 2026-02-16 17:40:16.320539 | 2026-02-16 17:40:16.320608 | TASK [fetch-tox-output : Find all default environments] 2026-02-16 17:40:16.849331 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:40:16.859293 | 2026-02-16 17:40:16.859372 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 17:40:16.884670 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:40:16.894789 | 2026-02-16 17:40:16.894857 | TASK [fetch-tox-output : Find all default environments] 2026-02-16 17:40:17.423325 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:40:17.435001 | 2026-02-16 17:40:17.435077 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 17:40:17.460515 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:40:17.470283 | 2026-02-16 17:40:17.470361 | LOOP [fetch-tox-output : Copy tox logs] 2026-02-16 17:40:17.509524 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:40:17.524581 | 2026-02-16 17:40:17.524756 | LOOP [fetch-tox-output : Collect tox logs] 2026-02-16 17:40:18.269852 | ubuntu-noble | ok: 2026-02-16 17:40:18.270064 | 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 17:40:18.270117 | ubuntu-noble | rsync error: some files/attrs were not transferred (see previous errors) (code 23) at main.c(1865) [Receiver=3.2.7] 2026-02-16 17:40:18.270150 | ubuntu-noble | rsync: [Receiver] write error: Broken pipe (32) 2026-02-16 17:40:18.270187 | 2026-02-16 17:40:18.290788 | 2026-02-16 17:40:18.290949 | PLAY RECAP 2026-02-16 17:40:18.290998 | ubuntu-noble | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-02-16 17:40:18.291020 | 2026-02-16 17:40:18.427808 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2026-02-16 17:40:18.430286 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-16 17:40:19.056403 | 2026-02-16 17:40:19.056579 | PLAY [all] 2026-02-16 17:40:19.070796 | 2026-02-16 17:40:19.070878 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-02-16 17:40:19.242904 | ubuntu-noble | changed: non-zero return code 2026-02-16 17:40:19.250678 | 2026-02-16 17:40:19.250791 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-02-16 17:40:19.278063 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:40:19.288564 | 2026-02-16 17:40:19.288720 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-02-16 17:40:19.329413 | 2026-02-16 17:40:19.329709 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-02-16 17:40:19.367641 | 2026-02-16 17:40:19.367914 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-02-16 17:40:19.395322 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:40:19.405511 | 2026-02-16 17:40:19.405653 | LOOP [fetch-subunit-output : Generate subunit file] 2026-02-16 17:40:19.441480 | 2026-02-16 17:40:19.441713 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-02-16 17:40:19.467915 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:40:19.478801 | 2026-02-16 17:40:19.478907 | TASK [fetch-subunit-output : Remove the temporary file] 2026-02-16 17:40:19.505775 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:40:19.514444 | 2026-02-16 17:40:19.514548 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-02-16 17:40:19.541265 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:40:19.551205 | 2026-02-16 17:40:19.551279 | PLAY RECAP 2026-02-16 17:40:19.551350 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-16 17:40:19.551383 | 2026-02-16 17:40:19.709795 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-16 17:40:19.712291 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main] 2026-02-16 17:40:20.312475 | 2026-02-16 17:40:20.312608 | PLAY [all] 2026-02-16 17:40:20.324395 | 2026-02-16 17:40:20.324474 | TASK [fetch-output : Set log path for multiple nodes] 2026-02-16 17:40:20.369528 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:40:20.381703 | 2026-02-16 17:40:20.382032 | TASK [fetch-output : Set log path for single node] 2026-02-16 17:40:20.418846 | ubuntu-noble | ok 2026-02-16 17:40:20.425616 | 2026-02-16 17:40:20.425695 | LOOP [fetch-output : Ensure local output dirs] 2026-02-16 17:40:20.847700 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/0e15bef3a3584444bb62fab2a8b1f121/work/logs" 2026-02-16 17:40:21.071372 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/0e15bef3a3584444bb62fab2a8b1f121/work/artifacts" 2026-02-16 17:40:21.283887 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/0e15bef3a3584444bb62fab2a8b1f121/work/docs" 2026-02-16 17:40:21.309470 | 2026-02-16 17:40:21.309600 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-16 17:40:21.936475 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 17:40:21.936762 | ubuntu-noble | changed: All items complete 2026-02-16 17:40:21.936801 | 2026-02-16 17:40:22.416832 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 17:40:22.877579 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 17:40:22.906807 | 2026-02-16 17:40:22.906955 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-02-16 17:40:23.393008 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.008356 2026-02-16 17:40:23.619887 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.007937 2026-02-16 17:40:23.643318 | 2026-02-16 17:40:23.643454 | PLAY [all] 2026-02-16 17:40:23.651794 | 2026-02-16 17:40:23.651862 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-02-16 17:40:24.163495 | ubuntu-noble | changed 2026-02-16 17:40:24.171128 | 2026-02-16 17:40:24.171181 | PLAY RECAP 2026-02-16 17:40:24.171227 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-02-16 17:40:24.171249 | 2026-02-16 17:40:24.292571 | POST-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main] 2026-02-16 17:40:24.295336 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post-logs.yaml@main] 2026-02-16 17:40:24.855481 | 2026-02-16 17:40:24.855619 | PLAY [localhost] 2026-02-16 17:40:24.866360 | 2026-02-16 17:40:24.866439 | TASK [Generate Zuul manifest] 2026-02-16 17:40:24.889130 | localhost | ok 2026-02-16 17:40:24.903921 | 2026-02-16 17:40:24.904004 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-16 17:40:25.218986 | localhost | changed 2026-02-16 17:40:25.234612 | 2026-02-16 17:40:25.234687 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-16 17:40:25.276685 | localhost | ok 2026-02-16 17:40:25.286244 | 2026-02-16 17:40:25.286336 | TASK [Upload logs] 2026-02-16 17:40:25.310770 | localhost | ok 2026-02-16 17:40:25.374091 | 2026-02-16 17:40:25.374238 | TASK [Set zuul-log-path fact] 2026-02-16 17:40:25.397076 | localhost | ok 2026-02-16 17:40:25.410207 | 2026-02-16 17:40:25.410279 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-16 17:40:25.442953 | localhost | ok 2026-02-16 17:40:25.458437 | 2026-02-16 17:40:25.458633 | TASK [upload-logs : Create log directories] 2026-02-16 17:40:25.888207 | localhost | changed 2026-02-16 17:40:25.894206 | 2026-02-16 17:40:25.894279 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-02-16 17:40:26.320977 | localhost -> localhost | ok: Runtime: 0:00:00.005548 2026-02-16 17:40:26.325818 | 2026-02-16 17:40:26.325884 | TASK [upload-logs : Upload logs to log server] 2026-02-16 17:40:26.805465 | localhost | Output suppressed because no_log was given 2026-02-16 17:40:26.820219 | 2026-02-16 17:40:26.820334 | LOOP [upload-logs : Compress console log and json output] 2026-02-16 17:40:26.867580 | localhost | skipping: Conditional result was False 2026-02-16 17:40:26.873692 | localhost | skipping: Conditional result was False 2026-02-16 17:40:26.886289 | 2026-02-16 17:40:26.886451 | LOOP [upload-logs : Upload compressed console log and json output] 2026-02-16 17:40:26.927339 | localhost | skipping: Conditional result was False 2026-02-16 17:40:26.927779 | 2026-02-16 17:40:26.930395 | localhost | skipping: Conditional result was False 2026-02-16 17:40:26.954231 | 2026-02-16 17:40:26.954406 | LOOP [upload-logs : Upload console log and json output]