2026-02-17 00:18:43.256188 | Job console starting
2026-02-17 00:18:43.268314 | Updating git repos
2026-02-17 00:18:43.305150 | Cloning repos into workspace
2026-02-17 00:18:43.357446 | Restoring repo states
2026-02-17 00:18:43.369852 | Merging changes
2026-02-17 00:18:43.813622 | Checking out repos
2026-02-17 00:18:44.008429 | Preparing playbooks
2026-02-17 00:18:45.148581 | Running Ansible setup
2026-02-17 00:18:49.696715 | PRE-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main]
2026-02-17 00:18:50.302131 | 
2026-02-17 00:18:50.302277 | PLAY [localhost]
2026-02-17 00:18:50.309916 | 
2026-02-17 00:18:50.309988 | TASK [Gathering Facts]
2026-02-17 00:18:51.186298 | localhost | ok
2026-02-17 00:18:51.195563 | 
2026-02-17 00:18:51.195677 | TASK [Setup log path fact]
2026-02-17 00:18:51.219654 | localhost | ok
2026-02-17 00:18:51.244922 | 
2026-02-17 00:18:51.245034 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-02-17 00:18:51.276476 | localhost | ok
2026-02-17 00:18:51.284165 | 
2026-02-17 00:18:51.284254 | TASK [emit-job-header : Print job information]
2026-02-17 00:18:51.343978 | # Job Information
2026-02-17 00:18:51.344143 | Ansible Version: 2.16.15
2026-02-17 00:18:51.344177 | Job: magnum-cluster-api-tox-unit
2026-02-17 00:18:51.344199 | Pipeline: check
2026-02-17 00:18:51.344219 | Executor: 3a2793d2bd32
2026-02-17 00:18:51.344239 | Triggered by: https://github.com/vexxhost/magnum-cluster-api/pull/878
2026-02-17 00:18:51.344260 | Event ID: 0a1e3db0-0b96-11f1-9abc-dc8e8936889f
2026-02-17 00:18:51.347189 | 
2026-02-17 00:18:51.347262 | LOOP [emit-job-header : Print node information]
2026-02-17 00:18:51.447314 | localhost | ok:
2026-02-17 00:18:51.447517 | localhost | # Node Information
2026-02-17 00:18:51.447557 | localhost | Inventory Hostname: ubuntu-noble
2026-02-17 00:18:51.447587 | localhost | Hostname: np0000155856
2026-02-17 00:18:51.447615 | localhost | Username: zuul
2026-02-17 00:18:51.447645 | localhost | Distro: Ubuntu 24.04
2026-02-17 00:18:51.447672 | localhost | Provider: yul1
2026-02-17 00:18:51.447698 | localhost | Region: ca-ymq-1
2026-02-17 00:18:51.447724 | localhost | Label: ubuntu-noble
2026-02-17 00:18:51.447749 | localhost | Product Name: OpenStack Nova
2026-02-17 00:18:51.447774 | localhost | Interface IP: 199.204.45.78
2026-02-17 00:18:51.467503 | 
2026-02-17 00:18:51.467673 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-02-17 00:18:51.928038 | localhost -> localhost | changed
2026-02-17 00:18:51.937634 | 
2026-02-17 00:18:51.937781 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-02-17 00:18:52.792892 | localhost -> localhost | changed
2026-02-17 00:18:52.802769 | 
2026-02-17 00:18:52.802831 | PLAY [all]
2026-02-17 00:18:52.811713 | 
2026-02-17 00:18:52.811784 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-02-17 00:18:53.049115 | ubuntu-noble -> localhost | ok
2026-02-17 00:18:53.080793 | 
2026-02-17 00:18:53.080928 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-02-17 00:18:53.117978 | ubuntu-noble | ok
2026-02-17 00:18:53.153349 | ubuntu-noble | included: /var/lib/zuul/builds/23cecfacf069483d8f0160e07c74f246/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-02-17 00:18:53.162378 | 
2026-02-17 00:18:53.162466 | TASK [add-build-sshkey : Create Temp SSH key]
2026-02-17 00:18:53.825274 | ubuntu-noble -> localhost | Generating public/private rsa key pair.
2026-02-17 00:18:53.825499 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/23cecfacf069483d8f0160e07c74f246/work/23cecfacf069483d8f0160e07c74f246_id_rsa
2026-02-17 00:18:53.825542 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/23cecfacf069483d8f0160e07c74f246/work/23cecfacf069483d8f0160e07c74f246_id_rsa.pub
2026-02-17 00:18:53.825575 | ubuntu-noble -> localhost | The key fingerprint is:
2026-02-17 00:18:53.825606 | ubuntu-noble -> localhost | SHA256:BOTVLDDNAhoOUAMchIofK8Mn1jcauoK7+nLhkjhds8s zuul-build-sshkey
2026-02-17 00:18:53.825652 | ubuntu-noble -> localhost | The key's randomart image is:
2026-02-17 00:18:53.825683 | ubuntu-noble -> localhost | +---[RSA 3072]----+
2026-02-17 00:18:53.825718 | ubuntu-noble -> localhost | |O== .o=+.o       |
2026-02-17 00:18:53.825750 | ubuntu-noble -> localhost | |.+ + ..++ o      |
2026-02-17 00:18:53.825780 | ubuntu-noble -> localhost | |o o   ....       |
2026-02-17 00:18:53.825809 | ubuntu-noble -> localhost | |o .    .         |
2026-02-17 00:18:53.825838 | ubuntu-noble -> localhost | |...o    S        |
2026-02-17 00:18:53.825867 | ubuntu-noble -> localhost | |o+++oo           |
2026-02-17 00:18:53.825896 | ubuntu-noble -> localhost | |+*+o+o.          |
2026-02-17 00:18:53.825924 | ubuntu-noble -> localhost | |O.+o.            |
2026-02-17 00:18:53.825957 | ubuntu-noble -> localhost | |*Xo E.           |
2026-02-17 00:18:53.825987 | ubuntu-noble -> localhost | +----[SHA256]-----+
2026-02-17 00:18:53.826054 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.222513
2026-02-17 00:18:53.833578 | 
2026-02-17 00:18:53.833644 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-02-17 00:18:53.868741 | ubuntu-noble | ok
2026-02-17 00:18:53.878941 | ubuntu-noble | included: /var/lib/zuul/builds/23cecfacf069483d8f0160e07c74f246/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-02-17 00:18:53.886795 | 
2026-02-17 00:18:53.886858 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-02-17 00:18:53.912192 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:18:53.923509 | 
2026-02-17 00:18:53.923609 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-02-17 00:18:54.459435 | ubuntu-noble | changed
2026-02-17 00:18:54.465467 | 
2026-02-17 00:18:54.465843 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-02-17 00:18:54.689950 | ubuntu-noble | ok
2026-02-17 00:18:54.703656 | 
2026-02-17 00:18:54.703721 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-02-17 00:18:55.261210 | ubuntu-noble | changed
2026-02-17 00:18:55.266632 | 
2026-02-17 00:18:55.266693 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-02-17 00:18:55.814759 | ubuntu-noble | changed
2026-02-17 00:18:55.823941 | 
2026-02-17 00:18:55.824032 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-02-17 00:18:55.848607 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:18:55.858042 | 
2026-02-17 00:18:55.858178 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-02-17 00:18:56.237568 | ubuntu-noble -> localhost | changed
2026-02-17 00:18:56.256412 | 
2026-02-17 00:18:56.256549 | TASK [add-build-sshkey : Add back temp key]
2026-02-17 00:18:56.546175 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/23cecfacf069483d8f0160e07c74f246/work/23cecfacf069483d8f0160e07c74f246_id_rsa (zuul-build-sshkey)
2026-02-17 00:18:56.546450 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.016562
2026-02-17 00:18:56.556561 | 
2026-02-17 00:18:56.556638 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-02-17 00:18:56.916995 | ubuntu-noble | ok
2026-02-17 00:18:56.922285 | 
2026-02-17 00:18:56.922351 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-02-17 00:18:56.947494 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:18:56.962191 | 
2026-02-17 00:18:56.962253 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-02-17 00:18:57.358196 | ubuntu-noble | ok
2026-02-17 00:18:57.369763 | 
2026-02-17 00:18:57.369828 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-02-17 00:18:58.525253 | ubuntu-noble | Output suppressed because no_log was given
2026-02-17 00:18:58.538747 | 
2026-02-17 00:18:58.538833 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-02-17 00:18:58.761168 | ubuntu-noble | ok: "logs"
2026-02-17 00:18:58.761501 | ubuntu-noble | ok: All items complete
2026-02-17 00:18:58.761556 | 
2026-02-17 00:18:58.996258 | ubuntu-noble | ok: "artifacts"
2026-02-17 00:18:59.146855 | ubuntu-noble | ok: "docs"
2026-02-17 00:18:59.169687 | 
2026-02-17 00:18:59.169888 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-02-17 00:18:59.414011 | ubuntu-noble | changed: "logs"
2026-02-17 00:18:59.603118 | ubuntu-noble | changed: "artifacts"
2026-02-17 00:18:59.793659 | ubuntu-noble | changed: "docs"
2026-02-17 00:18:59.809996 | 
2026-02-17 00:18:59.810139 | PLAY RECAP
2026-02-17 00:18:59.810188 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-02-17 00:18:59.810238 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-02-17 00:18:59.810268 | 
2026-02-17 00:18:59.990528 | PRE-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main]
2026-02-17 00:18:59.993185 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2026-02-17 00:19:00.586896 | 
2026-02-17 00:19:00.587033 | PLAY [all]
2026-02-17 00:19:00.599128 | 
2026-02-17 00:19:00.599203 | TASK [Install binary dependencies]
2026-02-17 00:19:00.645309 | ubuntu-noble | ok
2026-02-17 00:19:00.667293 | 
2026-02-17 00:19:00.667530 | TASK [bindep : Include find tasks]
2026-02-17 00:19:00.704898 | ubuntu-noble | ok
2026-02-17 00:19:00.714505 | ubuntu-noble | included: /var/lib/zuul/builds/23cecfacf069483d8f0160e07c74f246/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml
2026-02-17 00:19:00.720649 | 
2026-02-17 00:19:00.720713 | TASK [bindep : Look for bindep.txt]
2026-02-17 00:19:01.094301 | ubuntu-noble | ok
2026-02-17 00:19:01.100448 | 
2026-02-17 00:19:01.100513 | TASK [bindep : Define bindep_file fact]
2026-02-17 00:19:01.125723 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:01.136615 | 
2026-02-17 00:19:01.136695 | TASK [bindep : Look for other-requirements.txt]
2026-02-17 00:19:01.364396 | ubuntu-noble | ok
2026-02-17 00:19:01.369655 | 
2026-02-17 00:19:01.369726 | TASK [bindep : Define bindep_file fact]
2026-02-17 00:19:01.394899 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:01.406157 | 
2026-02-17 00:19:01.406250 | TASK [bindep : Look for bindep fallback file]
2026-02-17 00:19:01.431735 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:01.444403 | 
2026-02-17 00:19:01.444504 | TASK [bindep : Define bindep_file fact]
2026-02-17 00:19:01.469858 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:01.480252 | 
2026-02-17 00:19:01.480329 | TASK [bindep : Include bindep tasks]
2026-02-17 00:19:01.506521 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:01.517262 | 
2026-02-17 00:19:01.517348 | TASK [bindep : Include install tasks]
2026-02-17 00:19:01.542396 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:01.552986 | 
2026-02-17 00:19:01.553065 | LOOP [bindep : Include package tasks]
2026-02-17 00:19:01.624775 | 
2026-02-17 00:19:01.624989 | TASK [Run test-setup role]
2026-02-17 00:19:01.650358 | ubuntu-noble | ok
2026-02-17 00:19:01.669931 | 
2026-02-17 00:19:01.670025 | TASK [test-setup : Check if project's tools/test-setup.sh exists]
2026-02-17 00:19:01.897084 | ubuntu-noble | ok
2026-02-17 00:19:01.906695 | 
2026-02-17 00:19:01.906786 | TASK [test-setup : Run tools/test-setup.sh]
2026-02-17 00:19:02.451881 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:02.464238 | 
2026-02-17 00:19:02.464309 | PLAY RECAP
2026-02-17 00:19:02.464359 | ubuntu-noble | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2026-02-17 00:19:02.464380 | 
2026-02-17 00:19:02.627292 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2026-02-17 00:19:02.629996 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master]
2026-02-17 00:19:03.293943 | 
2026-02-17 00:19:03.294114 | PLAY [all]
2026-02-17 00:19:03.309497 | 
2026-02-17 00:19:03.309618 | TASK [ensure-python : Validate python_version value]
2026-02-17 00:19:03.335230 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:03.346661 | 
2026-02-17 00:19:03.346835 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)]
2026-02-17 00:19:03.372265 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:03.384249 | 
2026-02-17 00:19:03.384349 | TASK [ensure-python : Pull in venv package]
2026-02-17 00:19:03.409443 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:03.420022 | 
2026-02-17 00:19:03.420116 | TASK [ensure-python : Set default RPM package name]
2026-02-17 00:19:03.445948 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:03.454166 | 
2026-02-17 00:19:03.454264 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9/10]
2026-02-17 00:19:03.479740 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:03.487377 | 
2026-02-17 00:19:03.487514 | TASK [ensure-python : Install RPM package]
2026-02-17 00:19:03.511897 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:03.520401 | 
2026-02-17 00:19:03.520526 | TASK [ensure-python : Install python using pyenv]
2026-02-17 00:19:03.546184 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:03.558939 | 
2026-02-17 00:19:03.559016 | TASK [ensure-python : Activate python using stow]
2026-02-17 00:19:03.594648 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:03.612455 | 
2026-02-17 00:19:03.612528 | TASK [Install pip]
2026-02-17 00:19:03.637722 | ubuntu-noble | ok
2026-02-17 00:19:03.663777 | 
2026-02-17 00:19:03.663850 | TASK [ensure-pip : Check if pip is installed]
2026-02-17 00:19:04.202677 | ubuntu-noble | ok: Runtime: 0:00:00.009793
2026-02-17 00:19:04.210552 | 
2026-02-17 00:19:04.210672 | LOOP [ensure-pip : Install pip from packages]
2026-02-17 00:19:04.243866 | ubuntu-noble | ok: "/var/lib/zuul/builds/23cecfacf069483d8f0160e07c74f246/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/Debian.yaml"
2026-02-17 00:19:04.258405 | ubuntu-noble | included: /var/lib/zuul/builds/23cecfacf069483d8f0160e07c74f246/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/Debian.yaml
2026-02-17 00:19:04.268576 | 
2026-02-17 00:19:04.268679 | TASK [ensure-pip : Update package lists]
2026-02-17 00:19:10.894134 | ubuntu-noble | changed
2026-02-17 00:19:10.902180 | 
2026-02-17 00:19:10.902248 | TASK [ensure-pip : Install Python 3 pip]
2026-02-17 00:19:17.118044 | ubuntu-noble | changed
2026-02-17 00:19:17.124668 | 
2026-02-17 00:19:17.124749 | TASK [ensure-pip : Install Python 2 pip]
2026-02-17 00:19:17.150125 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:17.163384 | 
2026-02-17 00:19:17.163513 | TASK [ensure-pip : Ensure setuptools]
2026-02-17 00:19:17.189470 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:17.201567 | 
2026-02-17 00:19:17.201680 | TASK [ensure-pip : Check for ensurepip module]
2026-02-17 00:19:17.483430 | ubuntu-noble | usage: python -m ensurepip [-h] [--version] [-v] [-U] [--user] [--root ROOT]
2026-02-17 00:19:17.483572 | ubuntu-noble |                            [--altinstall] [--default-pip]
2026-02-17 00:19:17.483587 | ubuntu-noble |
2026-02-17 00:19:17.483598 | ubuntu-noble | options:
2026-02-17 00:19:17.483609 | ubuntu-noble |   -h, --help     show this help message and exit
2026-02-17 00:19:17.483624 | ubuntu-noble |   --version      Show the version of pip that is bundled with this Python.
2026-02-17 00:19:17.483637 | ubuntu-noble |   -v, --verbose  Give more output. Option is additive, and can be used up to 3
2026-02-17 00:19:17.483652 | ubuntu-noble |                  times.
2026-02-17 00:19:17.483662 | ubuntu-noble |   -U, --upgrade  Upgrade pip and dependencies, even if already installed.
2026-02-17 00:19:17.483671 | ubuntu-noble |   --user         Install using the user scheme.
2026-02-17 00:19:17.483684 | ubuntu-noble |   --root ROOT    Install everything relative to this alternate root directory.
2026-02-17 00:19:17.483692 | ubuntu-noble |   --altinstall   Make an alternate install, installing only the X.Y versioned
2026-02-17 00:19:17.483701 | ubuntu-noble |                  scripts (Default: pipX, pipX.Y).
2026-02-17 00:19:17.483710 | ubuntu-noble |   --default-pip  Make a default pip install, installing the unqualified pip in
2026-02-17 00:19:17.483718 | ubuntu-noble |                  addition to the versioned scripts.
2026-02-17 00:19:17.743068 | ubuntu-noble | ok: Runtime: 0:00:00.062125
2026-02-17 00:19:17.752065 | 
2026-02-17 00:19:17.752221 | TASK [ensure-pip : Ensure python3-venv]
2026-02-17 00:19:17.778018 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:17.789776 | 
2026-02-17 00:19:17.789847 | TASK [ensure-pip : Install pip from source]
2026-02-17 00:19:17.815353 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:17.869705 | 
2026-02-17 00:19:17.869877 | TASK [ensure-pip : Probe for venv python full path]
2026-02-17 00:19:18.114314 | ubuntu-noble | /usr/bin/python3
2026-02-17 00:19:18.411004 | ubuntu-noble | ok: Runtime: 0:00:00.005749
2026-02-17 00:19:18.417436 | 
2026-02-17 00:19:18.417513 | TASK [ensure-pip : Set host default]
2026-02-17 00:19:18.471896 | ubuntu-noble | ok
2026-02-17 00:19:18.479047 | 
2026-02-17 00:19:18.479140 | TASK [ensure-pip : Set ensure_pip_virtualenv_command]
2026-02-17 00:19:18.540656 | ubuntu-noble | ok
2026-02-17 00:19:18.549820 | 
2026-02-17 00:19:18.549885 | TASK [ensure-tox : Check if tox is installed]
2026-02-17 00:19:19.087770 | ubuntu-noble | ok: Runtime: 0:00:00.005176
2026-02-17 00:19:19.095737 | 
2026-02-17 00:19:19.095810 | TASK [ensure-tox : Export preinstalled tox_exectuable]
2026-02-17 00:19:19.120760 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:19.130523 | 
2026-02-17 00:19:19.130619 | TASK [ensure-tox : Create local venv]
2026-02-17 00:19:22.676565 | ubuntu-noble | ok: Runtime: 0:00:03.221241
2026-02-17 00:19:22.683585 | 
2026-02-17 00:19:22.683659 | TASK [ensure-tox : Install tox to local venv]
2026-02-17 00:19:23.487896 | ubuntu-noble | Collecting tox
2026-02-17 00:19:23.546906 | ubuntu-noble |   Downloading tox-4.36.0-py3-none-any.whl.metadata (3.6 kB)
2026-02-17 00:19:23.612861 | ubuntu-noble | Collecting cachetools>=7.0.1 (from tox)
2026-02-17 00:19:23.616351 | ubuntu-noble |   Downloading cachetools-7.0.1-py3-none-any.whl.metadata (5.6 kB)
2026-02-17 00:19:23.653771 | ubuntu-noble | Collecting chardet>=5.2 (from tox)
2026-02-17 00:19:23.661390 | ubuntu-noble |   Downloading chardet-5.2.0-py3-none-any.whl.metadata (3.4 kB)
2026-02-17 00:19:23.701631 | ubuntu-noble | Collecting colorama>=0.4.6 (from tox)
2026-02-17 00:19:23.706022 | ubuntu-noble |   Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB)
2026-02-17 00:19:23.765651 | ubuntu-noble | Collecting filelock>=3.24 (from tox)
2026-02-17 00:19:23.769345 | ubuntu-noble |   Downloading filelock-3.24.2-py3-none-any.whl.metadata (2.0 kB)
2026-02-17 00:19:23.823668 | ubuntu-noble | Collecting packaging>=26 (from tox)
2026-02-17 00:19:23.826838 | ubuntu-noble |   Downloading packaging-26.0-py3-none-any.whl.metadata (3.3 kB)
2026-02-17 00:19:23.879937 | ubuntu-noble | Collecting platformdirs>=4.9.1 (from tox)
2026-02-17 00:19:23.886239 | ubuntu-noble |   Downloading platformdirs-4.9.2-py3-none-any.whl.metadata (4.7 kB)
2026-02-17 00:19:23.933210 | ubuntu-noble | Collecting pluggy>=1.6 (from tox)
2026-02-17 00:19:23.937674 | ubuntu-noble |   Downloading pluggy-1.6.0-py3-none-any.whl.metadata (4.8 kB)
2026-02-17 00:19:23.991565 | ubuntu-noble | Collecting pyproject-api>=1.10 (from tox)
2026-02-17 00:19:24.002871 | ubuntu-noble |   Downloading pyproject_api-1.10.0-py3-none-any.whl.metadata (2.7 kB)
2026-02-17 00:19:24.126105 | ubuntu-noble | Collecting virtualenv>=20.36.1 (from tox)
2026-02-17 00:19:24.129485 | ubuntu-noble |   Downloading virtualenv-20.37.0-py3-none-any.whl.metadata (5.1 kB)
2026-02-17 00:19:24.222246 | ubuntu-noble | Collecting distlib<1,>=0.3.7 (from virtualenv>=20.36.1->tox)
2026-02-17 00:19:24.229425 | ubuntu-noble |   Downloading distlib-0.4.0-py2.py3-none-any.whl.metadata (5.2 kB)
2026-02-17 00:19:24.290272 | ubuntu-noble | Downloading tox-4.36.0-py3-none-any.whl (179 kB)
2026-02-17 00:19:24.309419 | ubuntu-noble |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 179.1/179.1 kB 11.4 MB/s eta 0:00:00
2026-02-17 00:19:24.324442 | ubuntu-noble | Downloading cachetools-7.0.1-py3-none-any.whl (13 kB)
2026-02-17 00:19:24.361686 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl (199 kB)
2026-02-17 00:19:24.377335 | ubuntu-noble |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 15.3 MB/s eta 0:00:00
2026-02-17 00:19:24.397478 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB)
2026-02-17 00:19:24.428152 | ubuntu-noble | Downloading filelock-3.24.2-py3-none-any.whl (24 kB)
2026-02-17 00:19:24.459129 | ubuntu-noble | Downloading packaging-26.0-py3-none-any.whl (74 kB)
2026-02-17 00:19:24.473576 | ubuntu-noble |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 6.0 MB/s eta 0:00:00
2026-02-17 00:19:24.497034 | ubuntu-noble | Downloading platformdirs-4.9.2-py3-none-any.whl (21 kB)
2026-02-17 00:19:24.520610 | ubuntu-noble | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB)
2026-02-17 00:19:24.549536 | ubuntu-noble | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB)
2026-02-17 00:19:24.567601 | ubuntu-noble | Downloading virtualenv-20.37.0-py3-none-any.whl (5.8 MB)
2026-02-17 00:19:24.674304 | ubuntu-noble |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.8/5.8 MB 56.6 MB/s eta 0:00:00
2026-02-17 00:19:24.679644 | ubuntu-noble | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB)
2026-02-17 00:19:24.705471 | ubuntu-noble |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 29.3 MB/s eta 0:00:00
2026-02-17 00:19:24.777676 | ubuntu-noble | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox
2026-02-17 00:19:25.651001 | 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-17 00:19:26.231241 | ubuntu-noble | ok: Runtime: 0:00:02.826624
2026-02-17 00:19:26.238262 | 
2026-02-17 00:19:26.238330 | TASK [ensure-tox : Export installed tox_executable path]
2026-02-17 00:19:26.274422 | ubuntu-noble | ok
2026-02-17 00:19:26.282376 | 
2026-02-17 00:19:26.282565 | TASK [ensure-tox : Output tox version]
2026-02-17 00:19:26.744137 | 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-17 00:19:26.758323 | ubuntu-noble | 4.36.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py
2026-02-17 00:19:26.841631 | ubuntu-noble | ok: Runtime: 0:00:00.270212
2026-02-17 00:19:26.847955 | 
2026-02-17 00:19:26.848038 | TASK [ensure-tox : Make global symlink]
2026-02-17 00:19:26.873939 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:26.885568 | 
2026-02-17 00:19:26.885624 | PLAY RECAP
2026-02-17 00:19:26.885674 | ubuntu-noble | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0
2026-02-17 00:19:26.885697 | 
2026-02-17 00:19:27.033547 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master]
2026-02-17 00:19:27.036016 | PRE-RUN START: [untrusted : github.com/vexxhost/magnum-cluster-api/zuul.d/playbooks/tox/pre.yml@main]
2026-02-17 00:19:27.669300 | 
2026-02-17 00:19:27.669521 | PLAY [all]
2026-02-17 00:19:27.683077 | 
2026-02-17 00:19:27.683176 | TASK [ensure-rust : Use rustup]
2026-02-17 00:19:27.717721 | ubuntu-noble | ok
2026-02-17 00:19:27.727390 | ubuntu-noble | included: /var/lib/zuul/builds/23cecfacf069483d8f0160e07c74f246/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-rust/tasks/rustup.yaml
2026-02-17 00:19:27.735342 | 
2026-02-17 00:19:27.735459 | TASK [ensure-rust : Install Rust]
2026-02-17 00:19:28.123634 | ubuntu-noble | /bin/bash: line 2: curl: command not found
2026-02-17 00:19:28.279388 | ubuntu-noble | ERROR
2026-02-17 00:19:28.279730 | ubuntu-noble | {
2026-02-17 00:19:28.279798 | ubuntu-noble |   "delta": "0:00:00.008943",
2026-02-17 00:19:28.279849 | ubuntu-noble |   "end": "2026-02-17 00:19:28.125307",
2026-02-17 00:19:28.279893 | ubuntu-noble |   "msg": "non-zero return code",
2026-02-17 00:19:28.279933 | ubuntu-noble |   "rc": 127,
2026-02-17 00:19:28.279972 | ubuntu-noble |   "start": "2026-02-17 00:19:28.116364"
2026-02-17 00:19:28.280032 | ubuntu-noble | }
failure
2026-02-17 00:19:28.282507 | 
2026-02-17 00:19:28.282559 | PLAY RECAP
2026-02-17 00:19:28.282611 | ubuntu-noble | ok: 1 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-02-17 00:19:28.282633 | 
2026-02-17 00:19:28.440343 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/magnum-cluster-api/zuul.d/playbooks/tox/pre.yml@main]
2026-02-17 00:19:28.443044 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master]
2026-02-17 00:19:29.029085 | 
2026-02-17 00:19:29.029221 | PLAY [all]
2026-02-17 00:19:29.041570 | 
2026-02-17 00:19:29.041662 | TASK [fetch-tox-output : Set tox log path for multiple nodes]
2026-02-17 00:19:29.087479 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:29.097952 | 
2026-02-17 00:19:29.098149 | TASK [fetch-tox-output : Set tox log path for single node]
2026-02-17 00:19:29.141904 | ubuntu-noble | ok
2026-02-17 00:19:29.150259 | 
2026-02-17 00:19:29.150330 | TASK [fetch-tox-output : Ensure local tox dir]
2026-02-17 00:19:29.540584 | ubuntu-noble -> localhost | changed
2026-02-17 00:19:29.553335 | 
2026-02-17 00:19:29.553440 | TASK [fetch-tox-output : Ensure zuul-output tox dir]
2026-02-17 00:19:29.589499 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:29.600259 | 
2026-02-17 00:19:29.600359 | TASK [fetch-tox-output : Set envlist fact]
2026-02-17 00:19:29.634120 | ubuntu-noble | ok
2026-02-17 00:19:29.639922 | 
2026-02-17 00:19:29.640034 | TASK [fetch-tox-output : Get tox version]
2026-02-17 00:19:30.245757 | 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-17 00:19:30.260399 | ubuntu-noble | 4.36.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py
2026-02-17 00:19:30.679113 | ubuntu-noble | ok: Runtime: 0:00:00.253101
2026-02-17 00:19:30.687784 | 
2026-02-17 00:19:30.687902 | TASK [fetch-tox-output : Find all default environments]
2026-02-17 00:19:31.229185 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:31.239200 | 
2026-02-17 00:19:31.239356 | TASK [fetch-tox-output : Set envlist fact]
2026-02-17 00:19:31.265089 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:31.276541 | 
2026-02-17 00:19:31.276642 | TASK [fetch-tox-output : Find all default environments]
2026-02-17 00:19:31.810207 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:31.823581 | 
2026-02-17 00:19:31.823730 | TASK [fetch-tox-output : Set envlist fact]
2026-02-17 00:19:31.849579 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:31.863119 | 
2026-02-17 00:19:31.863262 | LOOP [fetch-tox-output : Copy tox logs]
2026-02-17 00:19:31.897683 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:31.912208 | 
2026-02-17 00:19:31.912345 | LOOP [fetch-tox-output : Collect tox logs]
2026-02-17 00:19:32.672679 | ubuntu-noble | ok:
2026-02-17 00:19:32.672884 | 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-17 00:19:32.672988 | 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-17 00:19:32.673030 | ubuntu-noble | rsync: [Receiver] write error: Broken pipe (32)
2026-02-17 00:19:32.673060 | 
2026-02-17 00:19:32.689388 | 
2026-02-17 00:19:32.689513 | PLAY RECAP
2026-02-17 00:19:32.689568 | ubuntu-noble | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0
2026-02-17 00:19:32.689590 | 
2026-02-17 00:19:32.825718 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master]
2026-02-17 00:19:32.828108 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2026-02-17 00:19:33.422938 | 
2026-02-17 00:19:33.423094 | PLAY [all]
2026-02-17 00:19:33.435678 | 
2026-02-17 00:19:33.435754 | TASK [fetch-subunit-output : Find stestr or testr executable]
2026-02-17 00:19:33.613617 | ubuntu-noble | changed: non-zero return code
2026-02-17 00:19:33.621067 | 
2026-02-17 00:19:33.621198 | TASK [fetch-subunit-output : Get the list of directories with subunit files]
2026-02-17 00:19:33.647268 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:33.657960 | 
2026-02-17 00:19:33.658059 | LOOP [fetch-subunit-output : Find any inflight partial subunit files]
2026-02-17 00:19:33.694311 | 
2026-02-17 00:19:33.694440 | LOOP [fetch-subunit-output : Copy any inflight subunit files]
2026-02-17 00:19:33.728389 | 
2026-02-17 00:19:33.728558 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream]
2026-02-17 00:19:33.753342 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:33.759241 | 
2026-02-17 00:19:33.759313 | LOOP [fetch-subunit-output : Generate subunit file]
2026-02-17 00:19:33.793999 | 
2026-02-17 00:19:33.794225 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory]
2026-02-17 00:19:33.818974 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:33.831968 | 
2026-02-17 00:19:33.832066 | TASK [fetch-subunit-output : Remove the temporary file]
2026-02-17 00:19:33.856753 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:33.866212 | 
2026-02-17 00:19:33.866299 | TASK [fetch-subunit-output : Process and fetch subunit results]
2026-02-17 00:19:33.890930 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:33.904530 | 
2026-02-17 00:19:33.904666 | PLAY RECAP
2026-02-17 00:19:33.904723 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2026-02-17 00:19:33.904746 | 
2026-02-17 00:19:34.026926 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2026-02-17 00:19:34.029571 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main]
2026-02-17 00:19:34.609161 | 
2026-02-17 00:19:34.609309 | PLAY [all]
2026-02-17 00:19:34.621642 | 
2026-02-17 00:19:34.621719 | TASK [fetch-output : Set log path for multiple nodes]
2026-02-17 00:19:34.667180 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:19:34.676278 | 
2026-02-17 00:19:34.676389 | TASK [fetch-output : Set log path for single node]
2026-02-17 00:19:34.719560 | ubuntu-noble | ok
2026-02-17 00:19:34.727631 | 
2026-02-17 00:19:34.727697 | LOOP [fetch-output : Ensure local output dirs]
2026-02-17 00:19:35.107618 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/23cecfacf069483d8f0160e07c74f246/work/logs"
2026-02-17 00:19:35.312447 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/23cecfacf069483d8f0160e07c74f246/work/artifacts"
2026-02-17 00:19:35.520311 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/23cecfacf069483d8f0160e07c74f246/work/docs"
2026-02-17 00:19:35.536288 | 
2026-02-17 00:19:35.536468 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-02-17 00:19:36.190348 | ubuntu-noble | changed: .d..t...... ./
2026-02-17 00:19:36.190761 | ubuntu-noble | changed: All items complete
2026-02-17 00:19:36.190815 | 
2026-02-17 00:19:36.669665 | ubuntu-noble | changed: .d..t...... ./
2026-02-17 00:19:37.139376 | ubuntu-noble | changed: .d..t...... ./
2026-02-17 00:19:37.160786 | 
2026-02-17 00:19:37.160872 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-02-17 00:19:37.600751 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.007833
2026-02-17 00:19:37.828036 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.008849
2026-02-17 00:19:37.843005 | 
2026-02-17 00:19:37.843141 | PLAY [all]
2026-02-17 00:19:37.851030 | 
2026-02-17 00:19:37.851096 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-02-17 00:19:38.403142 | ubuntu-noble | changed
2026-02-17 00:19:38.409119 | 
2026-02-17 00:19:38.409174 | PLAY RECAP
2026-02-17 00:19:38.409221 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-02-17 00:19:38.409243 | 
2026-02-17 00:19:38.531850 | POST-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main]
2026-02-17 00:19:38.534977 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post-logs.yaml@main]
2026-02-17 00:19:39.108129 | 
2026-02-17 00:19:39.108313 | PLAY [localhost]
2026-02-17 00:19:39.120132 | 
2026-02-17 00:19:39.120279 | TASK [Generate Zuul manifest]
2026-02-17 00:19:39.142335 | localhost | ok
2026-02-17 00:19:39.158719 | 
2026-02-17 00:19:39.158944 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-02-17 00:19:39.506245 | localhost | changed
2026-02-17 00:19:39.521775 | 
2026-02-17 00:19:39.521851 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-02-17 00:19:39.553791 | localhost | ok
2026-02-17 00:19:39.563107 | 
2026-02-17 00:19:39.563196 | TASK [Upload logs]
2026-02-17 00:19:39.584349 | localhost | ok
2026-02-17 00:19:39.658165 | 
2026-02-17 00:19:39.658361 | TASK [Set zuul-log-path fact]
2026-02-17 00:19:39.679776 | localhost | ok
2026-02-17 00:19:39.695647 | 
2026-02-17 00:19:39.695736 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-02-17 00:19:39.728711 | localhost | ok
2026-02-17 00:19:39.739419 | 
2026-02-17 00:19:39.739490 | TASK [upload-logs : Create log directories]
2026-02-17 00:19:40.144540 | localhost | changed
2026-02-17 00:19:40.151068 | 
2026-02-17 00:19:40.151164 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-02-17 00:19:40.560771 | localhost -> localhost | ok: Runtime: 0:00:00.006589
2026-02-17 00:19:40.566248 | 
2026-02-17 00:19:40.566321 | TASK [upload-logs : Upload logs to log server]
2026-02-17 00:19:41.023379 | localhost | Output suppressed because no_log was given
2026-02-17 00:19:41.028333 | 
2026-02-17 00:19:41.028428 | LOOP [upload-logs : Compress console log and json output]
2026-02-17 00:19:41.075957 | localhost | skipping: Conditional result was False
2026-02-17 00:19:41.082109 | localhost | skipping: Conditional result was False
2026-02-17 00:19:41.093479 | 
2026-02-17 00:19:41.093699 | LOOP [upload-logs : Upload compressed console log and json output]
2026-02-17 00:19:41.144311 | localhost | skipping: Conditional result was False
2026-02-17 00:19:41.144576 | 
2026-02-17 00:19:41.149114 | localhost | skipping: Conditional result was False
2026-02-17 00:19:41.159296 | 
2026-02-17 00:19:41.159500 | LOOP [upload-logs : Upload console log and json output]