2026-02-16 17:52:49.198895 | Job console starting 2026-02-16 17:52:49.208400 | Updating git repos 2026-02-16 17:52:49.249984 | Cloning repos into workspace 2026-02-16 17:52:49.305463 | Restoring repo states 2026-02-16 17:52:49.319667 | Merging changes 2026-02-16 17:52:49.746684 | Checking out repos 2026-02-16 17:52:49.908283 | Preparing playbooks 2026-02-16 17:52:50.924001 | Running Ansible setup 2026-02-16 17:52:54.432940 | PRE-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main] 2026-02-16 17:52:55.046089 | 2026-02-16 17:52:55.046221 | PLAY [localhost] 2026-02-16 17:52:55.053930 | 2026-02-16 17:52:55.054001 | TASK [Gathering Facts] 2026-02-16 17:52:55.930950 | localhost | ok 2026-02-16 17:52:55.940238 | 2026-02-16 17:52:55.940318 | TASK [Setup log path fact] 2026-02-16 17:52:55.958541 | localhost | ok 2026-02-16 17:52:55.969887 | 2026-02-16 17:52:55.969984 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-16 17:52:55.997799 | localhost | ok 2026-02-16 17:52:56.005660 | 2026-02-16 17:52:56.005752 | TASK [emit-job-header : Print job information] 2026-02-16 17:52:56.046673 | # Job Information 2026-02-16 17:52:56.046813 | Ansible Version: 2.16.15 2026-02-16 17:52:56.046876 | Job: magnum-cluster-api-tox-unit 2026-02-16 17:52:56.046909 | Pipeline: check 2026-02-16 17:52:56.046938 | Executor: 3a2793d2bd32 2026-02-16 17:52:56.046968 | Triggered by: https://github.com/vexxhost/magnum-cluster-api/pull/884 2026-02-16 17:52:56.046999 | Event ID: ed3be480-0b5f-11f1-9b41-a55389b20acd 2026-02-16 17:52:56.050741 | 2026-02-16 17:52:56.050828 | LOOP [emit-job-header : Print node information] 2026-02-16 17:52:56.160007 | localhost | ok: 2026-02-16 17:52:56.160240 | localhost | # Node Information 2026-02-16 17:52:56.160278 | localhost | Inventory Hostname: ubuntu-noble 2026-02-16 17:52:56.160316 | localhost | Hostname: np0000155652 2026-02-16 17:52:56.160345 | localhost | Username: zuul 2026-02-16 17:52:56.160372 | localhost | Distro: Ubuntu 24.04 2026-02-16 17:52:56.160398 | localhost | Provider: yul1 2026-02-16 17:52:56.160423 | localhost | Region: ca-ymq-1 2026-02-16 17:52:56.160449 | localhost | Label: ubuntu-noble 2026-02-16 17:52:56.160474 | localhost | Product Name: OpenStack Nova 2026-02-16 17:52:56.160499 | localhost | Interface IP: 162.253.55.49 2026-02-16 17:52:56.172569 | 2026-02-16 17:52:56.172699 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-16 17:52:56.552767 | localhost -> localhost | changed 2026-02-16 17:52:56.561258 | 2026-02-16 17:52:56.561331 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-16 17:52:57.386690 | localhost -> localhost | changed 2026-02-16 17:52:57.397741 | 2026-02-16 17:52:57.397802 | PLAY [all] 2026-02-16 17:52:57.407413 | 2026-02-16 17:52:57.407489 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-16 17:52:57.645832 | ubuntu-noble -> localhost | ok 2026-02-16 17:52:57.656710 | 2026-02-16 17:52:57.656803 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-16 17:52:57.692480 | ubuntu-noble | ok 2026-02-16 17:52:57.710316 | ubuntu-noble | included: /var/lib/zuul/builds/ea6735b0d6a44aa8a83eaed241d2448c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-16 17:52:57.716529 | 2026-02-16 17:52:57.716588 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-16 17:52:59.915474 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2026-02-16 17:52:59.915711 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/ea6735b0d6a44aa8a83eaed241d2448c/work/ea6735b0d6a44aa8a83eaed241d2448c_id_rsa 2026-02-16 17:52:59.915766 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/ea6735b0d6a44aa8a83eaed241d2448c/work/ea6735b0d6a44aa8a83eaed241d2448c_id_rsa.pub 2026-02-16 17:52:59.915807 | ubuntu-noble -> localhost | The key fingerprint is: 2026-02-16 17:52:59.915843 | ubuntu-noble -> localhost | SHA256:qX0SOSDIVIk0ZiAWjEbFrHYLxgqINebs2ZLuUrrI5Oc zuul-build-sshkey 2026-02-16 17:52:59.915900 | ubuntu-noble -> localhost | The key's randomart image is: 2026-02-16 17:52:59.915937 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2026-02-16 17:52:59.915978 | ubuntu-noble -> localhost | |**@+.. | 2026-02-16 17:52:59.916009 | ubuntu-noble -> localhost | |+B==. | 2026-02-16 17:52:59.916037 | ubuntu-noble -> localhost | |==+.. . | 2026-02-16 17:52:59.916066 | ubuntu-noble -> localhost | |+*o. . . o | 2026-02-16 17:52:59.916093 | ubuntu-noble -> localhost | |=.o+. S | 2026-02-16 17:52:59.916120 | ubuntu-noble -> localhost | |. *.. o o | 2026-02-16 17:52:59.916146 | ubuntu-noble -> localhost | | = . . o . | 2026-02-16 17:52:59.916174 | ubuntu-noble -> localhost | |B .. o | 2026-02-16 17:52:59.916206 | ubuntu-noble -> localhost | |o*+E | 2026-02-16 17:52:59.916235 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2026-02-16 17:52:59.916299 | ubuntu-noble -> localhost | ok: Runtime: 0:00:01.808558 2026-02-16 17:52:59.923095 | 2026-02-16 17:52:59.923156 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-16 17:52:59.958076 | ubuntu-noble | ok 2026-02-16 17:52:59.971071 | ubuntu-noble | included: /var/lib/zuul/builds/ea6735b0d6a44aa8a83eaed241d2448c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-16 17:52:59.979214 | 2026-02-16 17:52:59.979283 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-16 17:53:00.004051 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:00.014881 | 2026-02-16 17:53:00.014968 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-16 17:53:00.537757 | ubuntu-noble | changed 2026-02-16 17:53:00.543188 | 2026-02-16 17:53:00.543259 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-16 17:53:00.762213 | ubuntu-noble | ok 2026-02-16 17:53:00.767527 | 2026-02-16 17:53:00.767587 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-16 17:53:01.339700 | ubuntu-noble | changed 2026-02-16 17:53:01.347751 | 2026-02-16 17:53:01.347859 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-16 17:53:01.920338 | ubuntu-noble | changed 2026-02-16 17:53:01.926731 | 2026-02-16 17:53:01.926798 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-16 17:53:01.952012 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:01.963264 | 2026-02-16 17:53:01.963347 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-16 17:53:02.319431 | ubuntu-noble -> localhost | changed 2026-02-16 17:53:02.335050 | 2026-02-16 17:53:02.335115 | TASK [add-build-sshkey : Add back temp key] 2026-02-16 17:53:02.604354 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/ea6735b0d6a44aa8a83eaed241d2448c/work/ea6735b0d6a44aa8a83eaed241d2448c_id_rsa (zuul-build-sshkey) 2026-02-16 17:53:02.604600 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.013584 2026-02-16 17:53:02.611888 | 2026-02-16 17:53:02.611965 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-16 17:53:02.971029 | ubuntu-noble | ok 2026-02-16 17:53:02.978785 | 2026-02-16 17:53:02.979089 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-16 17:53:03.004477 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:03.021528 | 2026-02-16 17:53:03.021595 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-02-16 17:53:03.420905 | ubuntu-noble | ok 2026-02-16 17:53:03.431358 | 2026-02-16 17:53:03.431432 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-02-16 17:53:04.454943 | ubuntu-noble | Output suppressed because no_log was given 2026-02-16 17:53:04.465158 | 2026-02-16 17:53:04.465227 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-02-16 17:53:04.686998 | ubuntu-noble | ok: "logs" 2026-02-16 17:53:04.687297 | ubuntu-noble | ok: All items complete 2026-02-16 17:53:04.687339 | 2026-02-16 17:53:04.963567 | ubuntu-noble | ok: "artifacts" 2026-02-16 17:53:05.100130 | ubuntu-noble | ok: "docs" 2026-02-16 17:53:05.114740 | 2026-02-16 17:53:05.114928 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-02-16 17:53:05.395578 | ubuntu-noble | changed: "logs" 2026-02-16 17:53:05.585240 | ubuntu-noble | changed: "artifacts" 2026-02-16 17:53:05.790319 | ubuntu-noble | changed: "docs" 2026-02-16 17:53:05.813435 | 2026-02-16 17:53:05.813574 | PLAY RECAP 2026-02-16 17:53:05.813623 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-16 17:53:05.813653 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-02-16 17:53:05.813677 | 2026-02-16 17:53:05.955502 | PRE-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main] 2026-02-16 17:53:05.957961 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-16 17:53:06.510001 | 2026-02-16 17:53:06.510129 | PLAY [all] 2026-02-16 17:53:06.522595 | 2026-02-16 17:53:06.522673 | TASK [Install binary dependencies] 2026-02-16 17:53:06.578022 | ubuntu-noble | ok 2026-02-16 17:53:06.597003 | 2026-02-16 17:53:06.597083 | TASK [bindep : Include find tasks] 2026-02-16 17:53:06.632547 | ubuntu-noble | ok 2026-02-16 17:53:06.643272 | ubuntu-noble | included: /var/lib/zuul/builds/ea6735b0d6a44aa8a83eaed241d2448c/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-02-16 17:53:06.652916 | 2026-02-16 17:53:06.653006 | TASK [bindep : Look for bindep.txt] 2026-02-16 17:53:07.003926 | ubuntu-noble | ok 2026-02-16 17:53:07.011722 | 2026-02-16 17:53:07.011790 | TASK [bindep : Define bindep_file fact] 2026-02-16 17:53:07.036291 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:07.047084 | 2026-02-16 17:53:07.047154 | TASK [bindep : Look for other-requirements.txt] 2026-02-16 17:53:07.274743 | ubuntu-noble | ok 2026-02-16 17:53:07.279950 | 2026-02-16 17:53:07.280020 | TASK [bindep : Define bindep_file fact] 2026-02-16 17:53:07.305753 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:07.315679 | 2026-02-16 17:53:07.315746 | TASK [bindep : Look for bindep fallback file] 2026-02-16 17:53:07.339950 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:07.354247 | 2026-02-16 17:53:07.354321 | TASK [bindep : Define bindep_file fact] 2026-02-16 17:53:07.379383 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:07.390590 | 2026-02-16 17:53:07.390657 | TASK [bindep : Include bindep tasks] 2026-02-16 17:53:07.414806 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:07.423523 | 2026-02-16 17:53:07.423611 | TASK [bindep : Include install tasks] 2026-02-16 17:53:07.448657 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:07.458432 | 2026-02-16 17:53:07.458521 | LOOP [bindep : Include package tasks] 2026-02-16 17:53:07.520259 | 2026-02-16 17:53:07.520427 | TASK [Run test-setup role] 2026-02-16 17:53:07.545023 | ubuntu-noble | ok 2026-02-16 17:53:07.562027 | 2026-02-16 17:53:07.562093 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-02-16 17:53:07.759574 | ubuntu-noble | ok 2026-02-16 17:53:07.765742 | 2026-02-16 17:53:07.765810 | TASK [test-setup : Run tools/test-setup.sh] 2026-02-16 17:53:08.295750 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:08.303518 | 2026-02-16 17:53:08.303601 | PLAY RECAP 2026-02-16 17:53:08.303654 | ubuntu-noble | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-16 17:53:08.303675 | 2026-02-16 17:53:08.428125 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-16 17:53:08.430923 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2026-02-16 17:53:08.991587 | 2026-02-16 17:53:08.991726 | PLAY [all] 2026-02-16 17:53:09.005980 | 2026-02-16 17:53:09.006060 | TASK [ensure-python : Validate python_version value] 2026-02-16 17:53:09.031375 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:09.042393 | 2026-02-16 17:53:09.042474 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)] 2026-02-16 17:53:09.067568 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:09.078668 | 2026-02-16 17:53:09.078766 | TASK [ensure-python : Pull in venv package] 2026-02-16 17:53:09.103830 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:09.115268 | 2026-02-16 17:53:09.115338 | TASK [ensure-python : Set default RPM package name] 2026-02-16 17:53:09.150448 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:09.160591 | 2026-02-16 17:53:09.160658 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9/10] 2026-02-16 17:53:09.185734 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:09.195225 | 2026-02-16 17:53:09.195320 | TASK [ensure-python : Install RPM package] 2026-02-16 17:53:09.220876 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:09.232818 | 2026-02-16 17:53:09.232891 | TASK [ensure-python : Install python using pyenv] 2026-02-16 17:53:09.258377 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:09.268076 | 2026-02-16 17:53:09.268170 | TASK [ensure-python : Activate python using stow] 2026-02-16 17:53:09.294498 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:09.312102 | 2026-02-16 17:53:09.312171 | TASK [Install pip] 2026-02-16 17:53:09.337914 | ubuntu-noble | ok 2026-02-16 17:53:09.360894 | 2026-02-16 17:53:09.360962 | TASK [ensure-pip : Check if pip is installed] 2026-02-16 17:53:09.898691 | ubuntu-noble | ok: Runtime: 0:00:00.010867 2026-02-16 17:53:09.905306 | 2026-02-16 17:53:09.905380 | LOOP [ensure-pip : Install pip from packages] 2026-02-16 17:53:09.939294 | ubuntu-noble | ok: "/var/lib/zuul/builds/ea6735b0d6a44aa8a83eaed241d2448c/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/Debian.yaml" 2026-02-16 17:53:09.953466 | ubuntu-noble | included: /var/lib/zuul/builds/ea6735b0d6a44aa8a83eaed241d2448c/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/Debian.yaml 2026-02-16 17:53:09.963176 | 2026-02-16 17:53:09.963238 | TASK [ensure-pip : Update package lists] 2026-02-16 17:53:16.964375 | ubuntu-noble | changed 2026-02-16 17:53:16.970816 | 2026-02-16 17:53:16.970883 | TASK [ensure-pip : Install Python 3 pip] 2026-02-16 17:53:24.162848 | ubuntu-noble | changed 2026-02-16 17:53:24.169399 | 2026-02-16 17:53:24.169518 | TASK [ensure-pip : Install Python 2 pip] 2026-02-16 17:53:24.205844 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:24.215469 | 2026-02-16 17:53:24.215548 | TASK [ensure-pip : Ensure setuptools] 2026-02-16 17:53:24.249830 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:24.257615 | 2026-02-16 17:53:24.257685 | TASK [ensure-pip : Check for ensurepip module] 2026-02-16 17:53:24.540892 | ubuntu-noble | usage: python -m ensurepip [-h] [--version] [-v] [-U] [--user] [--root ROOT] 2026-02-16 17:53:24.540992 | ubuntu-noble | [--altinstall] [--default-pip] 2026-02-16 17:53:24.541011 | ubuntu-noble | 2026-02-16 17:53:24.541022 | ubuntu-noble | options: 2026-02-16 17:53:24.541033 | ubuntu-noble | -h, --help show this help message and exit 2026-02-16 17:53:24.541050 | ubuntu-noble | --version Show the version of pip that is bundled with this Python. 2026-02-16 17:53:24.541063 | ubuntu-noble | -v, --verbose Give more output. Option is additive, and can be used up to 3 2026-02-16 17:53:24.541078 | ubuntu-noble | times. 2026-02-16 17:53:24.541087 | ubuntu-noble | -U, --upgrade Upgrade pip and dependencies, even if already installed. 2026-02-16 17:53:24.541096 | ubuntu-noble | --user Install using the user scheme. 2026-02-16 17:53:24.541109 | ubuntu-noble | --root ROOT Install everything relative to this alternate root directory. 2026-02-16 17:53:24.541118 | ubuntu-noble | --altinstall Make an alternate install, installing only the X.Y versioned 2026-02-16 17:53:24.541126 | ubuntu-noble | scripts (Default: pipX, pipX.Y). 2026-02-16 17:53:24.541135 | ubuntu-noble | --default-pip Make a default pip install, installing the unqualified pip in 2026-02-16 17:53:24.541143 | ubuntu-noble | addition to the versioned scripts. 2026-02-16 17:53:24.817232 | ubuntu-noble | ok: Runtime: 0:00:00.058979 2026-02-16 17:53:24.824154 | 2026-02-16 17:53:24.824223 | TASK [ensure-pip : Ensure python3-venv] 2026-02-16 17:53:24.850328 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:24.862512 | 2026-02-16 17:53:24.862626 | TASK [ensure-pip : Install pip from source] 2026-02-16 17:53:24.888904 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:24.944013 | 2026-02-16 17:53:24.944201 | TASK [ensure-pip : Probe for venv python full path] 2026-02-16 17:53:25.158142 | ubuntu-noble | /usr/bin/python3 2026-02-16 17:53:25.483000 | ubuntu-noble | ok: Runtime: 0:00:00.004609 2026-02-16 17:53:25.489384 | 2026-02-16 17:53:25.489449 | TASK [ensure-pip : Set host default] 2026-02-16 17:53:25.542787 | ubuntu-noble | ok 2026-02-16 17:53:25.549100 | 2026-02-16 17:53:25.549162 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2026-02-16 17:53:25.607013 | ubuntu-noble | ok 2026-02-16 17:53:25.617285 | 2026-02-16 17:53:25.617367 | TASK [ensure-tox : Check if tox is installed] 2026-02-16 17:53:26.158004 | ubuntu-noble | ok: Runtime: 0:00:00.004810 2026-02-16 17:53:26.163608 | 2026-02-16 17:53:26.163682 | TASK [ensure-tox : Export preinstalled tox_exectuable] 2026-02-16 17:53:26.188864 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:26.200143 | 2026-02-16 17:53:26.200236 | TASK [ensure-tox : Create local venv] 2026-02-16 17:53:29.736633 | ubuntu-noble | ok: Runtime: 0:00:03.124074 2026-02-16 17:53:29.743433 | 2026-02-16 17:53:29.743500 | TASK [ensure-tox : Install tox to local venv] 2026-02-16 17:53:30.505701 | ubuntu-noble | Collecting tox 2026-02-16 17:53:30.568849 | ubuntu-noble | Downloading tox-4.36.0-py3-none-any.whl.metadata (3.6 kB) 2026-02-16 17:53:30.625880 | ubuntu-noble | Collecting cachetools>=7.0.1 (from tox) 2026-02-16 17:53:30.634897 | ubuntu-noble | Downloading cachetools-7.0.1-py3-none-any.whl.metadata (5.6 kB) 2026-02-16 17:53:30.668269 | ubuntu-noble | Collecting chardet>=5.2 (from tox) 2026-02-16 17:53:30.678808 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl.metadata (3.4 kB) 2026-02-16 17:53:30.732716 | ubuntu-noble | Collecting colorama>=0.4.6 (from tox) 2026-02-16 17:53:30.741928 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2026-02-16 17:53:30.814440 | ubuntu-noble | Collecting filelock>=3.24 (from tox) 2026-02-16 17:53:30.824355 | ubuntu-noble | Downloading filelock-3.24.2-py3-none-any.whl.metadata (2.0 kB) 2026-02-16 17:53:30.885880 | ubuntu-noble | Collecting packaging>=26 (from tox) 2026-02-16 17:53:30.895870 | ubuntu-noble | Downloading packaging-26.0-py3-none-any.whl.metadata (3.3 kB) 2026-02-16 17:53:30.959629 | ubuntu-noble | Collecting platformdirs>=4.9.1 (from tox) 2026-02-16 17:53:30.968834 | ubuntu-noble | Downloading platformdirs-4.9.2-py3-none-any.whl.metadata (4.7 kB) 2026-02-16 17:53:31.018114 | ubuntu-noble | Collecting pluggy>=1.6 (from tox) 2026-02-16 17:53:31.027762 | ubuntu-noble | Downloading pluggy-1.6.0-py3-none-any.whl.metadata (4.8 kB) 2026-02-16 17:53:31.091023 | ubuntu-noble | Collecting pyproject-api>=1.10 (from tox) 2026-02-16 17:53:31.103514 | ubuntu-noble | Downloading pyproject_api-1.10.0-py3-none-any.whl.metadata (2.7 kB) 2026-02-16 17:53:31.228231 | ubuntu-noble | Collecting virtualenv>=20.36.1 (from tox) 2026-02-16 17:53:31.238095 | ubuntu-noble | Downloading virtualenv-20.37.0-py3-none-any.whl.metadata (5.1 kB) 2026-02-16 17:53:31.339847 | ubuntu-noble | Collecting distlib<1,>=0.3.7 (from virtualenv>=20.36.1->tox) 2026-02-16 17:53:31.349631 | ubuntu-noble | Downloading distlib-0.4.0-py2.py3-none-any.whl.metadata (5.2 kB) 2026-02-16 17:53:31.387803 | ubuntu-noble | Downloading tox-4.36.0-py3-none-any.whl (179 kB) 2026-02-16 17:53:31.418424 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 179.1/179.1 kB 6.5 MB/s eta 0:00:00 2026-02-16 17:53:31.429814 | ubuntu-noble | Downloading cachetools-7.0.1-py3-none-any.whl (13 kB) 2026-02-16 17:53:31.449622 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2026-02-16 17:53:31.468370 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 12.8 MB/s eta 0:00:00 2026-02-16 17:53:31.478077 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-02-16 17:53:31.496210 | ubuntu-noble | Downloading filelock-3.24.2-py3-none-any.whl (24 kB) 2026-02-16 17:53:31.515712 | ubuntu-noble | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-02-16 17:53:31.530265 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 5.6 MB/s eta 0:00:00 2026-02-16 17:53:31.539870 | ubuntu-noble | Downloading platformdirs-4.9.2-py3-none-any.whl (21 kB) 2026-02-16 17:53:31.560675 | ubuntu-noble | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-02-16 17:53:31.590012 | ubuntu-noble | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-02-16 17:53:31.615846 | ubuntu-noble | Downloading virtualenv-20.37.0-py3-none-any.whl (5.8 MB) 2026-02-16 17:53:31.696408 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.8/5.8 MB 75.7 MB/s eta 0:00:00 2026-02-16 17:53:31.705991 | ubuntu-noble | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-02-16 17:53:31.726982 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 26.9 MB/s eta 0:00:00 2026-02-16 17:53:31.799616 | ubuntu-noble | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2026-02-16 17:53:32.642442 | 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:53:32.780464 | ubuntu-noble | ok: Runtime: 0:00:02.755611 2026-02-16 17:53:32.788697 | 2026-02-16 17:53:32.788794 | TASK [ensure-tox : Export installed tox_executable path] 2026-02-16 17:53:32.824881 | ubuntu-noble | ok 2026-02-16 17:53:32.829947 | 2026-02-16 17:53:32.830019 | TASK [ensure-tox : Output tox version] 2026-02-16 17:53:33.274417 | 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:53:33.287469 | ubuntu-noble | 4.36.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2026-02-16 17:53:33.368628 | ubuntu-noble | ok: Runtime: 0:00:00.266562 2026-02-16 17:53:33.374062 | 2026-02-16 17:53:33.374126 | TASK [ensure-tox : Make global symlink] 2026-02-16 17:53:33.398452 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:33.405220 | 2026-02-16 17:53:33.405268 | PLAY RECAP 2026-02-16 17:53:33.405314 | ubuntu-noble | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-02-16 17:53:33.405335 | 2026-02-16 17:53:33.557453 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2026-02-16 17:53:33.559892 | PRE-RUN START: [untrusted : github.com/vexxhost/magnum-cluster-api/zuul.d/playbooks/tox/pre.yml@main] 2026-02-16 17:53:34.147462 | 2026-02-16 17:53:34.147648 | PLAY [all] 2026-02-16 17:53:34.160117 | 2026-02-16 17:53:34.160213 | TASK [ensure-rust : Use rustup] 2026-02-16 17:53:34.195380 | ubuntu-noble | ok 2026-02-16 17:53:34.204056 | ubuntu-noble | included: /var/lib/zuul/builds/ea6735b0d6a44aa8a83eaed241d2448c/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-rust/tasks/rustup.yaml 2026-02-16 17:53:34.210185 | 2026-02-16 17:53:34.210260 | TASK [ensure-rust : Install Rust] 2026-02-16 17:53:34.590070 | ubuntu-noble | /bin/bash: line 2: curl: command not found 2026-02-16 17:53:34.744017 | ubuntu-noble | ERROR 2026-02-16 17:53:34.744256 | ubuntu-noble | { 2026-02-16 17:53:34.744287 | ubuntu-noble | "delta": "0:00:00.006914", 2026-02-16 17:53:34.744311 | ubuntu-noble | "end": "2026-02-16 17:53:34.591058", 2026-02-16 17:53:34.744331 | ubuntu-noble | "msg": "non-zero return code", 2026-02-16 17:53:34.744349 | ubuntu-noble | "rc": 127, 2026-02-16 17:53:34.744367 | ubuntu-noble | "start": "2026-02-16 17:53:34.584144" 2026-02-16 17:53:34.744389 | ubuntu-noble | } failure 2026-02-16 17:53:34.746105 | 2026-02-16 17:53:34.746156 | PLAY RECAP 2026-02-16 17:53:34.746204 | ubuntu-noble | ok: 1 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-02-16 17:53:34.746225 | 2026-02-16 17:53:34.907462 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/magnum-cluster-api/zuul.d/playbooks/tox/pre.yml@main] 2026-02-16 17:53:34.909089 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2026-02-16 17:53:35.603771 | 2026-02-16 17:53:35.603926 | PLAY [all] 2026-02-16 17:53:35.616723 | 2026-02-16 17:53:35.616801 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-02-16 17:53:35.662245 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:35.673233 | 2026-02-16 17:53:35.673344 | TASK [fetch-tox-output : Set tox log path for single node] 2026-02-16 17:53:35.708913 | ubuntu-noble | ok 2026-02-16 17:53:35.716265 | 2026-02-16 17:53:35.716338 | TASK [fetch-tox-output : Ensure local tox dir] 2026-02-16 17:53:36.116192 | ubuntu-noble -> localhost | changed 2026-02-16 17:53:36.128260 | 2026-02-16 17:53:36.128338 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-02-16 17:53:36.173169 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:36.183999 | 2026-02-16 17:53:36.184069 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 17:53:36.228924 | ubuntu-noble | ok 2026-02-16 17:53:36.236539 | 2026-02-16 17:53:36.236624 | TASK [fetch-tox-output : Get tox version] 2026-02-16 17:53:36.851217 | 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:53:36.865590 | ubuntu-noble | 4.36.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2026-02-16 17:53:37.280621 | ubuntu-noble | ok: Runtime: 0:00:00.260692 2026-02-16 17:53:37.286053 | 2026-02-16 17:53:37.286122 | TASK [fetch-tox-output : Find all default environments] 2026-02-16 17:53:37.814274 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:37.820855 | 2026-02-16 17:53:37.820928 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 17:53:37.846085 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:37.855841 | 2026-02-16 17:53:37.855936 | TASK [fetch-tox-output : Find all default environments] 2026-02-16 17:53:38.386089 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:38.396929 | 2026-02-16 17:53:38.397044 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 17:53:38.432375 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:38.446050 | 2026-02-16 17:53:38.446133 | LOOP [fetch-tox-output : Copy tox logs] 2026-02-16 17:53:38.488283 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:38.505220 | 2026-02-16 17:53:38.505393 | LOOP [fetch-tox-output : Collect tox logs] 2026-02-16 17:53:39.277846 | ubuntu-noble | ok: 2026-02-16 17:53:39.278068 | 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:53:39.278125 | 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:53:39.278157 | ubuntu-noble | rsync: [Receiver] write error: Broken pipe (32) 2026-02-16 17:53:39.278191 | 2026-02-16 17:53:39.300327 | 2026-02-16 17:53:39.300481 | PLAY RECAP 2026-02-16 17:53:39.300532 | ubuntu-noble | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-02-16 17:53:39.300555 | 2026-02-16 17:53:39.426957 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2026-02-16 17:53:39.429661 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-16 17:53:40.017491 | 2026-02-16 17:53:40.017638 | PLAY [all] 2026-02-16 17:53:40.029840 | 2026-02-16 17:53:40.029915 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-02-16 17:53:40.208670 | ubuntu-noble | changed: non-zero return code 2026-02-16 17:53:40.214049 | 2026-02-16 17:53:40.214128 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-02-16 17:53:40.238918 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:40.250972 | 2026-02-16 17:53:40.251049 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-02-16 17:53:40.286321 | 2026-02-16 17:53:40.286491 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-02-16 17:53:40.321885 | 2026-02-16 17:53:40.322094 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-02-16 17:53:40.348389 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:40.360431 | 2026-02-16 17:53:40.360510 | LOOP [fetch-subunit-output : Generate subunit file] 2026-02-16 17:53:40.397731 | 2026-02-16 17:53:40.397870 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-02-16 17:53:40.423591 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:40.435952 | 2026-02-16 17:53:40.436046 | TASK [fetch-subunit-output : Remove the temporary file] 2026-02-16 17:53:40.461593 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:40.473533 | 2026-02-16 17:53:40.473600 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-02-16 17:53:40.498866 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:40.510139 | 2026-02-16 17:53:40.510206 | PLAY RECAP 2026-02-16 17:53:40.510272 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-16 17:53:40.510301 | 2026-02-16 17:53:40.646825 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-16 17:53:40.649411 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main] 2026-02-16 17:53:41.336210 | 2026-02-16 17:53:41.336401 | PLAY [all] 2026-02-16 17:53:41.349092 | 2026-02-16 17:53:41.349251 | TASK [fetch-output : Set log path for multiple nodes] 2026-02-16 17:53:41.394951 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:53:41.404059 | 2026-02-16 17:53:41.404170 | TASK [fetch-output : Set log path for single node] 2026-02-16 17:53:41.449711 | ubuntu-noble | ok 2026-02-16 17:53:41.456093 | 2026-02-16 17:53:41.456163 | LOOP [fetch-output : Ensure local output dirs] 2026-02-16 17:53:41.845411 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/ea6735b0d6a44aa8a83eaed241d2448c/work/logs" 2026-02-16 17:53:42.074645 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/ea6735b0d6a44aa8a83eaed241d2448c/work/artifacts" 2026-02-16 17:53:42.289079 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/ea6735b0d6a44aa8a83eaed241d2448c/work/docs" 2026-02-16 17:53:42.308521 | 2026-02-16 17:53:42.308663 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-16 17:53:42.928303 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 17:53:42.928664 | ubuntu-noble | changed: All items complete 2026-02-16 17:53:42.928705 | 2026-02-16 17:53:43.385197 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 17:53:43.847726 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 17:53:43.871210 | 2026-02-16 17:53:43.871377 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-02-16 17:53:44.292346 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.007975 2026-02-16 17:53:44.540531 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.008928 2026-02-16 17:53:44.562553 | 2026-02-16 17:53:44.562700 | PLAY [all] 2026-02-16 17:53:44.570742 | 2026-02-16 17:53:44.570807 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-02-16 17:53:45.074960 | ubuntu-noble | changed 2026-02-16 17:53:45.080673 | 2026-02-16 17:53:45.080719 | PLAY RECAP 2026-02-16 17:53:45.080763 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-02-16 17:53:45.080784 | 2026-02-16 17:53:45.194202 | POST-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main] 2026-02-16 17:53:45.196592 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post-logs.yaml@main] 2026-02-16 17:53:45.738566 | 2026-02-16 17:53:45.738703 | PLAY [localhost] 2026-02-16 17:53:45.748940 | 2026-02-16 17:53:45.749026 | TASK [Generate Zuul manifest] 2026-02-16 17:53:45.783927 | localhost | ok 2026-02-16 17:53:45.798826 | 2026-02-16 17:53:45.798910 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-16 17:53:46.129722 | localhost | changed 2026-02-16 17:53:46.142592 | 2026-02-16 17:53:46.142671 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-16 17:53:46.174907 | localhost | ok 2026-02-16 17:53:46.182382 | 2026-02-16 17:53:46.182444 | TASK [Upload logs] 2026-02-16 17:53:46.203286 | localhost | ok 2026-02-16 17:53:46.261107 | 2026-02-16 17:53:46.261222 | TASK [Set zuul-log-path fact] 2026-02-16 17:53:46.285080 | localhost | ok 2026-02-16 17:53:46.298721 | 2026-02-16 17:53:46.298797 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-16 17:53:46.330206 | localhost | ok 2026-02-16 17:53:46.338470 | 2026-02-16 17:53:46.338542 | TASK [upload-logs : Create log directories] 2026-02-16 17:53:46.762204 | localhost | changed 2026-02-16 17:53:46.769430 | 2026-02-16 17:53:46.769532 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-02-16 17:53:47.186005 | localhost -> localhost | ok: Runtime: 0:00:00.006304 2026-02-16 17:53:47.191353 | 2026-02-16 17:53:47.191421 | TASK [upload-logs : Upload logs to log server] 2026-02-16 17:53:47.635987 | localhost | Output suppressed because no_log was given 2026-02-16 17:53:47.639941 | 2026-02-16 17:53:47.640009 | LOOP [upload-logs : Compress console log and json output] 2026-02-16 17:53:47.681486 | localhost | skipping: Conditional result was False 2026-02-16 17:53:47.687839 | localhost | skipping: Conditional result was False 2026-02-16 17:53:47.704546 | 2026-02-16 17:53:47.704685 | LOOP [upload-logs : Upload compressed console log and json output] 2026-02-16 17:53:47.742807 | localhost | skipping: Conditional result was False 2026-02-16 17:53:47.743021 | 2026-02-16 17:53:47.746237 | localhost | skipping: Conditional result was False 2026-02-16 17:53:47.758357 | 2026-02-16 17:53:47.758489 | LOOP [upload-logs : Upload console log and json output]