2026-02-17 00:17:34.036236 | Job console starting
2026-02-17 00:17:34.049481 | Updating git repos
2026-02-17 00:17:34.096617 | Cloning repos into workspace
2026-02-17 00:17:34.145267 | Restoring repo states
2026-02-17 00:17:34.159742 | Merging changes
2026-02-17 00:17:34.560381 | Checking out repos
2026-02-17 00:17:34.727032 | Preparing playbooks
2026-02-17 00:17:36.028397 | Running Ansible setup
2026-02-17 00:17:39.509048 | PRE-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main]
2026-02-17 00:17:40.103982 | 
2026-02-17 00:17:40.104207 | PLAY [localhost]
2026-02-17 00:17:40.113645 | 
2026-02-17 00:17:40.113722 | TASK [Gathering Facts]
2026-02-17 00:17:40.994541 | localhost | ok
2026-02-17 00:17:41.005156 | 
2026-02-17 00:17:41.005285 | TASK [Setup log path fact]
2026-02-17 00:17:41.025841 | localhost | ok
2026-02-17 00:17:41.044315 | 
2026-02-17 00:17:41.044506 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-02-17 00:17:41.077020 | localhost | ok
2026-02-17 00:17:41.086679 | 
2026-02-17 00:17:41.086800 | TASK [emit-job-header : Print job information]
2026-02-17 00:17:41.133720 | # Job Information
2026-02-17 00:17:41.133937 | Ansible Version: 2.16.15
2026-02-17 00:17:41.133970 | Job: magnum-cluster-api-tox-functional
2026-02-17 00:17:41.133993 | Pipeline: check
2026-02-17 00:17:41.134013 | Executor: 3a2793d2bd32
2026-02-17 00:17:41.134032 | Triggered by: https://github.com/vexxhost/magnum-cluster-api/pull/878
2026-02-17 00:17:41.134054 | Event ID: 0a1e3db0-0b96-11f1-9abc-dc8e8936889f
2026-02-17 00:17:41.136946 | 
2026-02-17 00:17:41.137042 | LOOP [emit-job-header : Print node information]
2026-02-17 00:17:41.236689 | localhost | ok:
2026-02-17 00:17:41.236947 | localhost | # Node Information
2026-02-17 00:17:41.237009 | localhost | Inventory Hostname: ubuntu-noble
2026-02-17 00:17:41.237040 | localhost | Hostname: np0000155759
2026-02-17 00:17:41.237067 | localhost | Username: zuul
2026-02-17 00:17:41.237097 | localhost | Distro: Ubuntu 24.04
2026-02-17 00:17:41.237124 | localhost | Provider: yul1
2026-02-17 00:17:41.237150 | localhost | Region: ca-ymq-1
2026-02-17 00:17:41.237175 | localhost | Label: ubuntu-noble
2026-02-17 00:17:41.237200 | localhost | Product Name: OpenStack Nova
2026-02-17 00:17:41.237224 | localhost | Interface IP: 199.204.45.141
2026-02-17 00:17:41.256318 | 
2026-02-17 00:17:41.256515 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-02-17 00:17:41.665760 | localhost -> localhost | changed
2026-02-17 00:17:41.674327 | 
2026-02-17 00:17:41.674447 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-02-17 00:17:42.533424 | localhost -> localhost | changed
2026-02-17 00:17:42.544001 | 
2026-02-17 00:17:42.544063 | PLAY [all]
2026-02-17 00:17:42.552221 | 
2026-02-17 00:17:42.552284 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-02-17 00:17:42.778354 | ubuntu-noble -> localhost | ok
2026-02-17 00:17:42.788826 | 
2026-02-17 00:17:42.788925 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-02-17 00:17:42.823283 | ubuntu-noble | ok
2026-02-17 00:17:42.840725 | ubuntu-noble | included: /var/lib/zuul/builds/0d15a7513bbd4fa2bb364a5655e37fc1/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-02-17 00:17:42.846863 | 
2026-02-17 00:17:42.846923 | TASK [add-build-sshkey : Create Temp SSH key]
2026-02-17 00:17:44.560548 | ubuntu-noble -> localhost | Generating public/private rsa key pair.
2026-02-17 00:17:44.560787 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/0d15a7513bbd4fa2bb364a5655e37fc1/work/0d15a7513bbd4fa2bb364a5655e37fc1_id_rsa
2026-02-17 00:17:44.560829 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/0d15a7513bbd4fa2bb364a5655e37fc1/work/0d15a7513bbd4fa2bb364a5655e37fc1_id_rsa.pub
2026-02-17 00:17:44.560861 | ubuntu-noble -> localhost | The key fingerprint is:
2026-02-17 00:17:44.560890 | ubuntu-noble -> localhost | SHA256:QgQy6/toxsgPFG5XFHuYQfRpvzxvhjvcpNyzjyEFNTE zuul-build-sshkey
2026-02-17 00:17:44.560936 | ubuntu-noble -> localhost | The key's randomart image is:
2026-02-17 00:17:44.560991 | ubuntu-noble -> localhost | +---[RSA 3072]----+
2026-02-17 00:17:44.561030 | ubuntu-noble -> localhost | |  o +Bo    E.    |
2026-02-17 00:17:44.561060 | ubuntu-noble -> localhost | |   +..* . . o    |
2026-02-17 00:17:44.561088 | ubuntu-noble -> localhost | | ..  =.= .       |
2026-02-17 00:17:44.561116 | ubuntu-noble -> localhost | |... ..o . .      |
2026-02-17 00:17:44.561143 | ubuntu-noble -> localhost | | +..  . S. .     |
2026-02-17 00:17:44.561169 | ubuntu-noble -> localhost | |o ..   .. o.     |
2026-02-17 00:17:44.561195 | ubuntu-noble -> localhost | |.+.     o=*.     |
2026-02-17 00:17:44.561222 | ubuntu-noble -> localhost | |..=o     *+*o    |
2026-02-17 00:17:44.561251 | ubuntu-noble -> localhost | | oo..    .=++.   |
2026-02-17 00:17:44.561279 | ubuntu-noble -> localhost | +----[SHA256]-----+
2026-02-17 00:17:44.561346 | ubuntu-noble -> localhost | ok: Runtime: 0:00:01.304672
2026-02-17 00:17:44.567414 | 
2026-02-17 00:17:44.567481 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-02-17 00:17:44.603748 | ubuntu-noble | ok
2026-02-17 00:17:44.614317 | ubuntu-noble | included: /var/lib/zuul/builds/0d15a7513bbd4fa2bb364a5655e37fc1/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-02-17 00:17:44.622382 | 
2026-02-17 00:17:44.622450 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-02-17 00:17:44.639084 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:17:44.651887 | 
2026-02-17 00:17:44.651956 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-02-17 00:17:45.146394 | ubuntu-noble | changed
2026-02-17 00:17:45.153623 | 
2026-02-17 00:17:45.153694 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-02-17 00:17:45.375988 | ubuntu-noble | ok
2026-02-17 00:17:45.383038 | 
2026-02-17 00:17:45.383108 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-02-17 00:17:45.905836 | ubuntu-noble | changed
2026-02-17 00:17:45.913239 | 
2026-02-17 00:17:45.913308 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-02-17 00:17:46.429107 | ubuntu-noble | changed
2026-02-17 00:17:46.436988 | 
2026-02-17 00:17:46.437074 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-02-17 00:17:46.463475 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:17:46.473179 | 
2026-02-17 00:17:46.473290 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-02-17 00:17:46.826905 | ubuntu-noble -> localhost | changed
2026-02-17 00:17:46.843808 | 
2026-02-17 00:17:46.843877 | TASK [add-build-sshkey : Add back temp key]
2026-02-17 00:17:47.125909 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/0d15a7513bbd4fa2bb364a5655e37fc1/work/0d15a7513bbd4fa2bb364a5655e37fc1_id_rsa (zuul-build-sshkey)
2026-02-17 00:17:47.126125 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.016104
2026-02-17 00:17:47.133419 | 
2026-02-17 00:17:47.133479 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-02-17 00:17:47.498789 | ubuntu-noble | ok
2026-02-17 00:17:47.504135 | 
2026-02-17 00:17:47.504201 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-02-17 00:17:47.529918 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:17:47.544925 | 
2026-02-17 00:17:47.545000 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-02-17 00:17:47.905422 | ubuntu-noble | ok
2026-02-17 00:17:47.915824 | 
2026-02-17 00:17:47.915893 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-02-17 00:17:48.947880 | ubuntu-noble | Output suppressed because no_log was given
2026-02-17 00:17:48.957696 | 
2026-02-17 00:17:48.957763 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-02-17 00:17:49.174915 | ubuntu-noble | ok: "logs"
2026-02-17 00:17:49.175280 | ubuntu-noble | ok: All items complete
2026-02-17 00:17:49.175331 | 
2026-02-17 00:17:49.401936 | ubuntu-noble | ok: "artifacts"
2026-02-17 00:17:49.545549 | ubuntu-noble | ok: "docs"
2026-02-17 00:17:49.563821 | 
2026-02-17 00:17:49.563989 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-02-17 00:17:49.779112 | ubuntu-noble | changed: "logs"
2026-02-17 00:17:49.971867 | ubuntu-noble | changed: "artifacts"
2026-02-17 00:17:50.157411 | ubuntu-noble | changed: "docs"
2026-02-17 00:17:50.178080 | 
2026-02-17 00:17:50.178254 | PLAY RECAP
2026-02-17 00:17:50.178322 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-02-17 00:17:50.178366 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-02-17 00:17:50.178404 | 
2026-02-17 00:17:50.349437 | PRE-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main]
2026-02-17 00:17:50.351919 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2026-02-17 00:17:50.966308 | 
2026-02-17 00:17:50.966474 | PLAY [all]
2026-02-17 00:17:50.979751 | 
2026-02-17 00:17:50.979831 | TASK [Install binary dependencies]
2026-02-17 00:17:51.035138 | ubuntu-noble | ok
2026-02-17 00:17:51.054709 | 
2026-02-17 00:17:51.054825 | TASK [bindep : Include find tasks]
2026-02-17 00:17:51.088881 | ubuntu-noble | ok
2026-02-17 00:17:51.098377 | ubuntu-noble | included: /var/lib/zuul/builds/0d15a7513bbd4fa2bb364a5655e37fc1/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml
2026-02-17 00:17:51.104434 | 
2026-02-17 00:17:51.104495 | TASK [bindep : Look for bindep.txt]
2026-02-17 00:17:51.453885 | ubuntu-noble | ok
2026-02-17 00:17:51.460305 | 
2026-02-17 00:17:51.460379 | TASK [bindep : Define bindep_file fact]
2026-02-17 00:17:51.485800 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:17:51.497812 | 
2026-02-17 00:17:51.497914 | TASK [bindep : Look for other-requirements.txt]
2026-02-17 00:17:51.704034 | ubuntu-noble | ok
2026-02-17 00:17:51.710320 | 
2026-02-17 00:17:51.710412 | TASK [bindep : Define bindep_file fact]
2026-02-17 00:17:51.736077 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:17:51.744913 | 
2026-02-17 00:17:51.745023 | TASK [bindep : Look for bindep fallback file]
2026-02-17 00:17:51.769946 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:17:51.782298 | 
2026-02-17 00:17:51.782375 | TASK [bindep : Define bindep_file fact]
2026-02-17 00:17:51.808911 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:17:51.819730 | 
2026-02-17 00:17:51.819826 | TASK [bindep : Include bindep tasks]
2026-02-17 00:17:51.844854 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:17:51.853689 | 
2026-02-17 00:17:51.853779 | TASK [bindep : Include install tasks]
2026-02-17 00:17:51.878726 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:17:51.889610 | 
2026-02-17 00:17:51.889678 | LOOP [bindep : Include package tasks]
2026-02-17 00:17:51.950166 | 
2026-02-17 00:17:51.950343 | TASK [Run test-setup role]
2026-02-17 00:17:51.978240 | ubuntu-noble | ok
2026-02-17 00:17:51.995289 | 
2026-02-17 00:17:51.995355 | TASK [test-setup : Check if project's tools/test-setup.sh exists]
2026-02-17 00:17:52.213847 | ubuntu-noble | ok
2026-02-17 00:17:52.223514 | 
2026-02-17 00:17:52.223582 | TASK [test-setup : Run tools/test-setup.sh]
2026-02-17 00:17:52.756384 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:17:52.770317 | 
2026-02-17 00:17:52.770546 | PLAY RECAP
2026-02-17 00:17:52.770657 | ubuntu-noble | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2026-02-17 00:17:52.770705 | 
2026-02-17 00:17:52.905893 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2026-02-17 00:17:52.908739 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master]
2026-02-17 00:17:53.499165 | 
2026-02-17 00:17:53.499362 | PLAY [all]
2026-02-17 00:17:53.514456 | 
2026-02-17 00:17:53.514557 | TASK [ensure-python : Validate python_version value]
2026-02-17 00:17:53.540207 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:17:53.550292 | 
2026-02-17 00:17:53.550418 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)]
2026-02-17 00:17:53.576152 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:17:53.586958 | 
2026-02-17 00:17:53.587029 | TASK [ensure-python : Pull in venv package]
2026-02-17 00:17:53.611789 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:17:53.621225 | 
2026-02-17 00:17:53.621320 | TASK [ensure-python : Set default RPM package name]
2026-02-17 00:17:53.646452 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:17:53.656658 | 
2026-02-17 00:17:53.656761 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9/10]
2026-02-17 00:17:53.682279 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:17:53.693381 | 
2026-02-17 00:17:53.693454 | TASK [ensure-python : Install RPM package]
2026-02-17 00:17:53.718114 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:17:53.728374 | 
2026-02-17 00:17:53.728463 | TASK [ensure-python : Install python using pyenv]
2026-02-17 00:17:53.745074 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:17:53.753968 | 
2026-02-17 00:17:53.754073 | TASK [ensure-python : Activate python using stow]
2026-02-17 00:17:53.779637 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:17:53.796516 | 
2026-02-17 00:17:53.796582 | TASK [Install pip]
2026-02-17 00:17:53.819756 | ubuntu-noble | ok
2026-02-17 00:17:53.844106 | 
2026-02-17 00:17:53.844170 | TASK [ensure-pip : Check if pip is installed]
2026-02-17 00:17:54.377260 | ubuntu-noble | ok: Runtime: 0:00:00.007780
2026-02-17 00:17:54.383628 | 
2026-02-17 00:17:54.383695 | LOOP [ensure-pip : Install pip from packages]
2026-02-17 00:17:54.420419 | ubuntu-noble | ok: "/var/lib/zuul/builds/0d15a7513bbd4fa2bb364a5655e37fc1/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/Debian.yaml"
2026-02-17 00:17:54.432190 | ubuntu-noble | included: /var/lib/zuul/builds/0d15a7513bbd4fa2bb364a5655e37fc1/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/Debian.yaml
2026-02-17 00:17:54.441042 | 
2026-02-17 00:17:54.441112 | TASK [ensure-pip : Update package lists]
2026-02-17 00:18:00.976418 | ubuntu-noble | changed
2026-02-17 00:18:00.982041 | 
2026-02-17 00:18:00.982108 | TASK [ensure-pip : Install Python 3 pip]
2026-02-17 00:18:06.935251 | ubuntu-noble | changed
2026-02-17 00:18:06.941290 | 
2026-02-17 00:18:06.941354 | TASK [ensure-pip : Install Python 2 pip]
2026-02-17 00:18:06.966411 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:18:06.977450 | 
2026-02-17 00:18:06.977566 | TASK [ensure-pip : Ensure setuptools]
2026-02-17 00:18:07.003003 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:18:07.015407 | 
2026-02-17 00:18:07.015475 | TASK [ensure-pip : Check for ensurepip module]
2026-02-17 00:18:07.297655 | ubuntu-noble | usage: python -m ensurepip [-h] [--version] [-v] [-U] [--user] [--root ROOT]
2026-02-17 00:18:07.297743 | ubuntu-noble |                            [--altinstall] [--default-pip]
2026-02-17 00:18:07.297758 | ubuntu-noble |
2026-02-17 00:18:07.297768 | ubuntu-noble | options:
2026-02-17 00:18:07.297779 | ubuntu-noble |   -h, --help     show this help message and exit
2026-02-17 00:18:07.297795 | ubuntu-noble |   --version      Show the version of pip that is bundled with this Python.
2026-02-17 00:18:07.297808 | ubuntu-noble |   -v, --verbose  Give more output. Option is additive, and can be used up to 3
2026-02-17 00:18:07.297823 | ubuntu-noble |                  times.
2026-02-17 00:18:07.297833 | ubuntu-noble |   -U, --upgrade  Upgrade pip and dependencies, even if already installed.
2026-02-17 00:18:07.297841 | ubuntu-noble |   --user         Install using the user scheme.
2026-02-17 00:18:07.297850 | ubuntu-noble |   --root ROOT    Install everything relative to this alternate root directory.
2026-02-17 00:18:07.297859 | ubuntu-noble |   --altinstall   Make an alternate install, installing only the X.Y versioned
2026-02-17 00:18:07.297867 | ubuntu-noble |                  scripts (Default: pipX, pipX.Y).
2026-02-17 00:18:07.297876 | ubuntu-noble |   --default-pip  Make a default pip install, installing the unqualified pip in
2026-02-17 00:18:07.297884 | ubuntu-noble |                  addition to the versioned scripts.
2026-02-17 00:18:07.556001 | ubuntu-noble | ok: Runtime: 0:00:00.067276
2026-02-17 00:18:07.563183 | 
2026-02-17 00:18:07.563251 | TASK [ensure-pip : Ensure python3-venv]
2026-02-17 00:18:07.588568 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:18:07.599613 | 
2026-02-17 00:18:07.599685 | TASK [ensure-pip : Install pip from source]
2026-02-17 00:18:07.622412 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:18:07.671213 | 
2026-02-17 00:18:07.671368 | TASK [ensure-pip : Probe for venv python full path]
2026-02-17 00:18:07.899379 | ubuntu-noble | /usr/bin/python3
2026-02-17 00:18:08.210167 | ubuntu-noble | ok: Runtime: 0:00:00.007925
2026-02-17 00:18:08.216006 | 
2026-02-17 00:18:08.216070 | TASK [ensure-pip : Set host default]
2026-02-17 00:18:08.271630 | ubuntu-noble | ok
2026-02-17 00:18:08.276662 | 
2026-02-17 00:18:08.276724 | TASK [ensure-pip : Set ensure_pip_virtualenv_command]
2026-02-17 00:18:08.334054 | ubuntu-noble | ok
2026-02-17 00:18:08.343257 | 
2026-02-17 00:18:08.343320 | TASK [ensure-tox : Check if tox is installed]
2026-02-17 00:18:08.883320 | ubuntu-noble | ok: Runtime: 0:00:00.007602
2026-02-17 00:18:08.890324 | 
2026-02-17 00:18:08.890459 | TASK [ensure-tox : Export preinstalled tox_exectuable]
2026-02-17 00:18:08.915592 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:18:08.925555 | 
2026-02-17 00:18:08.925648 | TASK [ensure-tox : Create local venv]
2026-02-17 00:18:12.465791 | ubuntu-noble | ok: Runtime: 0:00:03.119462
2026-02-17 00:18:12.472690 | 
2026-02-17 00:18:12.472754 | TASK [ensure-tox : Install tox to local venv]
2026-02-17 00:18:13.213189 | ubuntu-noble | Collecting tox
2026-02-17 00:18:13.277387 | ubuntu-noble |   Downloading tox-4.36.0-py3-none-any.whl.metadata (3.6 kB)
2026-02-17 00:18:13.343732 | ubuntu-noble | Collecting cachetools>=7.0.1 (from tox)
2026-02-17 00:18:13.348310 | ubuntu-noble |   Downloading cachetools-7.0.1-py3-none-any.whl.metadata (5.6 kB)
2026-02-17 00:18:13.389583 | ubuntu-noble | Collecting chardet>=5.2 (from tox)
2026-02-17 00:18:13.398739 | ubuntu-noble |   Downloading chardet-5.2.0-py3-none-any.whl.metadata (3.4 kB)
2026-02-17 00:18:13.443752 | ubuntu-noble | Collecting colorama>=0.4.6 (from tox)
2026-02-17 00:18:13.453933 | ubuntu-noble |   Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB)
2026-02-17 00:18:13.515880 | ubuntu-noble | Collecting filelock>=3.24 (from tox)
2026-02-17 00:18:13.519196 | ubuntu-noble |   Downloading filelock-3.24.2-py3-none-any.whl.metadata (2.0 kB)
2026-02-17 00:18:13.574258 | ubuntu-noble | Collecting packaging>=26 (from tox)
2026-02-17 00:18:13.580396 | ubuntu-noble |   Downloading packaging-26.0-py3-none-any.whl.metadata (3.3 kB)
2026-02-17 00:18:13.637270 | ubuntu-noble | Collecting platformdirs>=4.9.1 (from tox)
2026-02-17 00:18:13.649683 | ubuntu-noble |   Downloading platformdirs-4.9.2-py3-none-any.whl.metadata (4.7 kB)
2026-02-17 00:18:13.695524 | ubuntu-noble | Collecting pluggy>=1.6 (from tox)
2026-02-17 00:18:13.698398 | ubuntu-noble |   Downloading pluggy-1.6.0-py3-none-any.whl.metadata (4.8 kB)
2026-02-17 00:18:13.743309 | ubuntu-noble | Collecting pyproject-api>=1.10 (from tox)
2026-02-17 00:18:13.791812 | ubuntu-noble |   Downloading pyproject_api-1.10.0-py3-none-any.whl.metadata (2.7 kB)
2026-02-17 00:18:14.141617 | ubuntu-noble | Collecting virtualenv>=20.36.1 (from tox)
2026-02-17 00:18:14.146974 | ubuntu-noble |   Downloading virtualenv-20.37.0-py3-none-any.whl.metadata (5.1 kB)
2026-02-17 00:18:14.243514 | ubuntu-noble | Collecting distlib<1,>=0.3.7 (from virtualenv>=20.36.1->tox)
2026-02-17 00:18:14.248529 | ubuntu-noble |   Downloading distlib-0.4.0-py2.py3-none-any.whl.metadata (5.2 kB)
2026-02-17 00:18:14.288357 | ubuntu-noble | Downloading tox-4.36.0-py3-none-any.whl (179 kB)
2026-02-17 00:18:14.306643 | ubuntu-noble |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 179.1/179.1 kB 12.1 MB/s eta 0:00:00
2026-02-17 00:18:14.316474 | ubuntu-noble | Downloading cachetools-7.0.1-py3-none-any.whl (13 kB)
2026-02-17 00:18:14.330439 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl (199 kB)
2026-02-17 00:18:14.347108 | ubuntu-noble |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 14.5 MB/s eta 0:00:00
2026-02-17 00:18:14.353103 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB)
2026-02-17 00:18:14.369520 | ubuntu-noble | Downloading filelock-3.24.2-py3-none-any.whl (24 kB)
2026-02-17 00:18:14.384446 | ubuntu-noble | Downloading packaging-26.0-py3-none-any.whl (74 kB)
2026-02-17 00:18:14.397064 | ubuntu-noble |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 6.5 MB/s eta 0:00:00
2026-02-17 00:18:14.404076 | ubuntu-noble | Downloading platformdirs-4.9.2-py3-none-any.whl (21 kB)
2026-02-17 00:18:14.420457 | ubuntu-noble | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB)
2026-02-17 00:18:14.439041 | ubuntu-noble | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB)
2026-02-17 00:18:14.456767 | ubuntu-noble | Downloading virtualenv-20.37.0-py3-none-any.whl (5.8 MB)
2026-02-17 00:18:14.533860 | ubuntu-noble |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.8/5.8 MB 80.0 MB/s eta 0:00:00
2026-02-17 00:18:14.540213 | ubuntu-noble | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB)
2026-02-17 00:18:14.559833 | ubuntu-noble |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 28.4 MB/s eta 0:00:00
2026-02-17 00:18:14.630662 | ubuntu-noble | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox
2026-02-17 00:18:15.491629 | 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:18:16.011449 | ubuntu-noble | ok: Runtime: 0:00:02.878485
2026-02-17 00:18:16.020802 | 
2026-02-17 00:18:16.021038 | TASK [ensure-tox : Export installed tox_executable path]
2026-02-17 00:18:16.057052 | ubuntu-noble | ok
2026-02-17 00:18:16.062542 | 
2026-02-17 00:18:16.062609 | TASK [ensure-tox : Output tox version]
2026-02-17 00:18:16.508065 | 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:18:16.521435 | ubuntu-noble | 4.36.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py
2026-02-17 00:18:16.595767 | ubuntu-noble | ok: Runtime: 0:00:00.268298
2026-02-17 00:18:16.603290 | 
2026-02-17 00:18:16.603358 | TASK [ensure-tox : Make global symlink]
2026-02-17 00:18:16.627760 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:18:16.638551 | 
2026-02-17 00:18:16.638607 | PLAY RECAP
2026-02-17 00:18:16.638660 | ubuntu-noble | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0
2026-02-17 00:18:16.638682 | 
2026-02-17 00:18:16.786757 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master]
2026-02-17 00:18:16.789234 | PRE-RUN START: [untrusted : github.com/vexxhost/magnum-cluster-api/zuul.d/playbooks/tox/pre.yml@main]
2026-02-17 00:18:17.369597 | 
2026-02-17 00:18:17.369735 | PLAY [all]
2026-02-17 00:18:17.381527 | 
2026-02-17 00:18:17.381609 | TASK [ensure-rust : Use rustup]
2026-02-17 00:18:17.416686 | ubuntu-noble | ok
2026-02-17 00:18:17.423762 | ubuntu-noble | included: /var/lib/zuul/builds/0d15a7513bbd4fa2bb364a5655e37fc1/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-rust/tasks/rustup.yaml
2026-02-17 00:18:17.429736 | 
2026-02-17 00:18:17.429811 | TASK [ensure-rust : Install Rust]
2026-02-17 00:18:17.820929 | ubuntu-noble | /bin/bash: line 2: curl: command not found
2026-02-17 00:18:17.974295 | ubuntu-noble | ERROR
2026-02-17 00:18:17.974547 | ubuntu-noble | {
2026-02-17 00:18:17.974587 | ubuntu-noble |   "delta": "0:00:00.005778",
2026-02-17 00:18:17.974619 | ubuntu-noble |   "end": "2026-02-17 00:18:17.821498",
2026-02-17 00:18:17.974647 | ubuntu-noble |   "msg": "non-zero return code",
2026-02-17 00:18:17.974672 | ubuntu-noble |   "rc": 127,
2026-02-17 00:18:17.974698 | ubuntu-noble |   "start": "2026-02-17 00:18:17.815720"
2026-02-17 00:18:17.974726 | ubuntu-noble | }
failure
2026-02-17 00:18:17.976428 | 
2026-02-17 00:18:17.976470 | PLAY RECAP
2026-02-17 00:18:17.976517 | ubuntu-noble | ok: 1 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-02-17 00:18:17.976538 | 
2026-02-17 00:18:18.091026 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/magnum-cluster-api/zuul.d/playbooks/tox/pre.yml@main]
2026-02-17 00:18:18.094035 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master]
2026-02-17 00:18:18.680832 | 
2026-02-17 00:18:18.680977 | PLAY [all]
2026-02-17 00:18:18.693769 | 
2026-02-17 00:18:18.693857 | TASK [fetch-tox-output : Set tox log path for multiple nodes]
2026-02-17 00:18:18.730024 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:18:18.741580 | 
2026-02-17 00:18:18.741671 | TASK [fetch-tox-output : Set tox log path for single node]
2026-02-17 00:18:18.784903 | ubuntu-noble | ok
2026-02-17 00:18:18.792056 | 
2026-02-17 00:18:18.792123 | TASK [fetch-tox-output : Ensure local tox dir]
2026-02-17 00:18:19.173562 | ubuntu-noble -> localhost | changed
2026-02-17 00:18:19.185135 | 
2026-02-17 00:18:19.185230 | TASK [fetch-tox-output : Ensure zuul-output tox dir]
2026-02-17 00:18:19.230694 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:18:19.240318 | 
2026-02-17 00:18:19.240415 | TASK [fetch-tox-output : Set envlist fact]
2026-02-17 00:18:19.286880 | ubuntu-noble | ok
2026-02-17 00:18:19.294607 | 
2026-02-17 00:18:19.294674 | TASK [fetch-tox-output : Get tox version]
2026-02-17 00:18:19.857503 | 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:18:19.871574 | ubuntu-noble | 4.36.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py
2026-02-17 00:18:20.334558 | ubuntu-noble | ok: Runtime: 0:00:00.244666
2026-02-17 00:18:20.341062 | 
2026-02-17 00:18:20.341131 | TASK [fetch-tox-output : Find all default environments]
2026-02-17 00:18:20.883111 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:18:20.898803 | 
2026-02-17 00:18:20.899086 | TASK [fetch-tox-output : Set envlist fact]
2026-02-17 00:18:20.925545 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:18:20.936826 | 
2026-02-17 00:18:20.936896 | TASK [fetch-tox-output : Find all default environments]
2026-02-17 00:18:21.467355 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:18:21.477047 | 
2026-02-17 00:18:21.477138 | TASK [fetch-tox-output : Set envlist fact]
2026-02-17 00:18:21.501202 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:18:21.512721 | 
2026-02-17 00:18:21.512783 | LOOP [fetch-tox-output : Copy tox logs]
2026-02-17 00:18:21.552202 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:18:21.571303 | 
2026-02-17 00:18:21.571476 | LOOP [fetch-tox-output : Collect tox logs]
2026-02-17 00:18:22.312014 | ubuntu-noble | ok:
2026-02-17 00:18:22.312329 | ubuntu-noble | rsync: [sender] change_dir "/home/zuul/src/github.com/vexxhost/magnum-cluster-api/.tox/functional/log" failed: No such file or directory (2)
2026-02-17 00:18:22.312404 | 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:18:22.312436 | ubuntu-noble | rsync: [Receiver] write error: Broken pipe (32)
2026-02-17 00:18:22.312473 | 
2026-02-17 00:18:22.334236 | 
2026-02-17 00:18:22.334386 | PLAY RECAP
2026-02-17 00:18:22.334458 | ubuntu-noble | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0
2026-02-17 00:18:22.334488 | 
2026-02-17 00:18:22.488264 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master]
2026-02-17 00:18:22.490998 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2026-02-17 00:18:23.069239 | 
2026-02-17 00:18:23.069379 | PLAY [all]
2026-02-17 00:18:23.081791 | 
2026-02-17 00:18:23.081869 | TASK [fetch-subunit-output : Find stestr or testr executable]
2026-02-17 00:18:23.260143 | ubuntu-noble | changed: non-zero return code
2026-02-17 00:18:23.266635 | 
2026-02-17 00:18:23.266727 | TASK [fetch-subunit-output : Get the list of directories with subunit files]
2026-02-17 00:18:23.291931 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:18:23.303792 | 
2026-02-17 00:18:23.303874 | LOOP [fetch-subunit-output : Find any inflight partial subunit files]
2026-02-17 00:18:23.339951 | 
2026-02-17 00:18:23.340179 | LOOP [fetch-subunit-output : Copy any inflight subunit files]
2026-02-17 00:18:23.379871 | 
2026-02-17 00:18:23.380034 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream]
2026-02-17 00:18:23.404847 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:18:23.416588 | 
2026-02-17 00:18:23.416730 | LOOP [fetch-subunit-output : Generate subunit file]
2026-02-17 00:18:23.453026 | 
2026-02-17 00:18:23.453169 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory]
2026-02-17 00:18:23.477838 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:18:23.491746 | 
2026-02-17 00:18:23.491821 | TASK [fetch-subunit-output : Remove the temporary file]
2026-02-17 00:18:23.516306 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:18:23.526689 | 
2026-02-17 00:18:23.526763 | TASK [fetch-subunit-output : Process and fetch subunit results]
2026-02-17 00:18:23.551080 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:18:23.562274 | 
2026-02-17 00:18:23.562361 | PLAY RECAP
2026-02-17 00:18:23.562432 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2026-02-17 00:18:23.562464 | 
2026-02-17 00:18:23.732991 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2026-02-17 00:18:23.735746 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main]
2026-02-17 00:18:24.314561 | 
2026-02-17 00:18:24.314765 | PLAY [all]
2026-02-17 00:18:24.326935 | 
2026-02-17 00:18:24.327016 | TASK [fetch-output : Set log path for multiple nodes]
2026-02-17 00:18:24.372091 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:18:24.382165 | 
2026-02-17 00:18:24.382245 | TASK [fetch-output : Set log path for single node]
2026-02-17 00:18:24.424769 | ubuntu-noble | ok
2026-02-17 00:18:24.431775 | 
2026-02-17 00:18:24.431841 | LOOP [fetch-output : Ensure local output dirs]
2026-02-17 00:18:24.820367 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/0d15a7513bbd4fa2bb364a5655e37fc1/work/logs"
2026-02-17 00:18:25.048104 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/0d15a7513bbd4fa2bb364a5655e37fc1/work/artifacts"
2026-02-17 00:18:25.256523 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/0d15a7513bbd4fa2bb364a5655e37fc1/work/docs"
2026-02-17 00:18:25.283523 | 
2026-02-17 00:18:25.283837 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-02-17 00:18:25.911764 | ubuntu-noble | changed: .d..t...... ./
2026-02-17 00:18:25.912070 | ubuntu-noble | changed: All items complete
2026-02-17 00:18:25.912291 | 
2026-02-17 00:18:26.374135 | ubuntu-noble | changed: .d..t...... ./
2026-02-17 00:18:26.830662 | ubuntu-noble | changed: .d..t...... ./
2026-02-17 00:18:26.855332 | 
2026-02-17 00:18:26.855456 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-02-17 00:18:27.267951 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.008185
2026-02-17 00:18:27.512837 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.007425
2026-02-17 00:18:27.533898 | 
2026-02-17 00:18:27.534033 | PLAY [all]
2026-02-17 00:18:27.541728 | 
2026-02-17 00:18:27.541795 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-02-17 00:18:28.013322 | ubuntu-noble | changed
2026-02-17 00:18:28.021484 | 
2026-02-17 00:18:28.021543 | PLAY RECAP
2026-02-17 00:18:28.021601 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-02-17 00:18:28.021629 | 
2026-02-17 00:18:28.139145 | POST-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main]
2026-02-17 00:18:28.141706 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post-logs.yaml@main]
2026-02-17 00:18:28.728148 | 
2026-02-17 00:18:28.728345 | PLAY [localhost]
2026-02-17 00:18:28.743036 | 
2026-02-17 00:18:28.743154 | TASK [Generate Zuul manifest]
2026-02-17 00:18:28.763835 | localhost | ok
2026-02-17 00:18:28.783006 | 
2026-02-17 00:18:28.783133 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-02-17 00:18:29.090855 | localhost | changed
2026-02-17 00:18:29.104543 | 
2026-02-17 00:18:29.104618 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-02-17 00:18:29.136911 | localhost | ok
2026-02-17 00:18:29.144065 | 
2026-02-17 00:18:29.144128 | TASK [Upload logs]
2026-02-17 00:18:29.165107 | localhost | ok
2026-02-17 00:18:29.225909 | 
2026-02-17 00:18:29.226053 | TASK [Set zuul-log-path fact]
2026-02-17 00:18:29.247242 | localhost | ok
2026-02-17 00:18:29.262432 | 
2026-02-17 00:18:29.262549 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-02-17 00:18:29.292765 | localhost | ok
2026-02-17 00:18:29.300540 | 
2026-02-17 00:18:29.300607 | TASK [upload-logs : Create log directories]
2026-02-17 00:18:29.707723 | localhost | changed
2026-02-17 00:18:29.712742 | 
2026-02-17 00:18:29.712818 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-02-17 00:18:30.105684 | localhost -> localhost | ok: Runtime: 0:00:00.005348
2026-02-17 00:18:30.112229 | 
2026-02-17 00:18:30.112300 | TASK [upload-logs : Upload logs to log server]
2026-02-17 00:18:30.572333 | localhost | Output suppressed because no_log was given
2026-02-17 00:18:30.577284 | 
2026-02-17 00:18:30.577352 | LOOP [upload-logs : Compress console log and json output]
2026-02-17 00:18:30.623611 | localhost | skipping: Conditional result was False
2026-02-17 00:18:30.629593 | localhost | skipping: Conditional result was False
2026-02-17 00:18:30.641664 | 
2026-02-17 00:18:30.641801 | LOOP [upload-logs : Upload compressed console log and json output]
2026-02-17 00:18:30.684168 | localhost | skipping: Conditional result was False
2026-02-17 00:18:30.684604 | 
2026-02-17 00:18:30.688626 | localhost | skipping: Conditional result was False
2026-02-17 00:18:30.704327 | 
2026-02-17 00:18:30.704498 | LOOP [upload-logs : Upload console log and json output]