2026-02-17 00:21:25.999952 | Job console starting
2026-02-17 00:21:26.008941 | Updating git repos
2026-02-17 00:21:26.042195 | Cloning repos into workspace
2026-02-17 00:21:26.094745 | Restoring repo states
2026-02-17 00:21:26.107896 | Merging changes
2026-02-17 00:21:26.528481 | Checking out repos
2026-02-17 00:21:26.688629 | Preparing playbooks
2026-02-17 00:21:27.719031 | Running Ansible setup
2026-02-17 00:21:31.266974 | PRE-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main]
2026-02-17 00:21:31.832885 | 
2026-02-17 00:21:31.833021 | PLAY [localhost]
2026-02-17 00:21:31.840314 | 
2026-02-17 00:21:31.840401 | TASK [Gathering Facts]
2026-02-17 00:21:32.700457 | localhost | ok
2026-02-17 00:21:32.712225 | 
2026-02-17 00:21:32.712309 | TASK [Setup log path fact]
2026-02-17 00:21:32.731329 | localhost | ok
2026-02-17 00:21:32.746649 | 
2026-02-17 00:21:32.746749 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-02-17 00:21:32.775752 | localhost | ok
2026-02-17 00:21:32.783682 | 
2026-02-17 00:21:32.783778 | TASK [emit-job-header : Print job information]
2026-02-17 00:21:32.824722 | # Job Information
2026-02-17 00:21:32.824869 | Ansible Version: 2.16.15
2026-02-17 00:21:32.824914 | Job: magnum-cluster-api-tox-unit
2026-02-17 00:21:32.824944 | Pipeline: check
2026-02-17 00:21:32.824993 | Executor: 3a2793d2bd32
2026-02-17 00:21:32.825021 | Triggered by: https://github.com/vexxhost/magnum-cluster-api/pull/878
2026-02-17 00:21:32.825053 | Event ID: 0a1e3db0-0b96-11f1-9abc-dc8e8936889f
2026-02-17 00:21:32.828637 | 
2026-02-17 00:21:32.828722 | LOOP [emit-job-header : Print node information]
2026-02-17 00:21:32.928221 | localhost | ok:
2026-02-17 00:21:32.928564 | localhost | # Node Information
2026-02-17 00:21:32.928627 | localhost | Inventory Hostname: ubuntu-noble
2026-02-17 00:21:32.928675 | localhost | Hostname: np0000155860
2026-02-17 00:21:32.928719 | localhost | Username: zuul
2026-02-17 00:21:32.928768 | localhost | Distro: Ubuntu 24.04
2026-02-17 00:21:32.928812 | localhost | Provider: yul1
2026-02-17 00:21:32.928854 | localhost | Region: ca-ymq-1
2026-02-17 00:21:32.928896 | localhost | Label: ubuntu-noble
2026-02-17 00:21:32.928936 | localhost | Product Name: OpenStack Nova
2026-02-17 00:21:32.929023 | localhost | Interface IP: 162.253.55.70
2026-02-17 00:21:32.943634 | 
2026-02-17 00:21:32.943776 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-02-17 00:21:33.324262 | localhost -> localhost | changed
2026-02-17 00:21:33.334922 | 
2026-02-17 00:21:33.335083 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-02-17 00:21:34.160652 | localhost -> localhost | changed
2026-02-17 00:21:34.171660 | 
2026-02-17 00:21:34.171753 | PLAY [all]
2026-02-17 00:21:34.181357 | 
2026-02-17 00:21:34.181422 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-02-17 00:21:34.407979 | ubuntu-noble -> localhost | ok
2026-02-17 00:21:34.416856 | 
2026-02-17 00:21:34.416939 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-02-17 00:21:34.448935 | ubuntu-noble | ok
2026-02-17 00:21:34.468666 | ubuntu-noble | included: /var/lib/zuul/builds/8d1d6698eb934fee86091843aefd163b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-02-17 00:21:34.475480 | 
2026-02-17 00:21:34.475544 | TASK [add-build-sshkey : Create Temp SSH key]
2026-02-17 00:21:35.597249 | ubuntu-noble -> localhost | Generating public/private rsa key pair.
2026-02-17 00:21:35.597470 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/8d1d6698eb934fee86091843aefd163b/work/8d1d6698eb934fee86091843aefd163b_id_rsa
2026-02-17 00:21:35.597511 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/8d1d6698eb934fee86091843aefd163b/work/8d1d6698eb934fee86091843aefd163b_id_rsa.pub
2026-02-17 00:21:35.597542 | ubuntu-noble -> localhost | The key fingerprint is:
2026-02-17 00:21:35.597571 | ubuntu-noble -> localhost | SHA256:+K6BpgrT4ywgaE22N62o4MbMXekgEncu93fi0JaqTCk zuul-build-sshkey
2026-02-17 00:21:35.597610 | ubuntu-noble -> localhost | The key's randomart image is:
2026-02-17 00:21:35.597640 | ubuntu-noble -> localhost | +---[RSA 3072]----+
2026-02-17 00:21:35.597684 | ubuntu-noble -> localhost | |                 |
2026-02-17 00:21:35.597728 | ubuntu-noble -> localhost | |                 |
2026-02-17 00:21:35.597759 | ubuntu-noble -> localhost | |                 |
2026-02-17 00:21:35.597794 | ubuntu-noble -> localhost | |. .o.  .         |
2026-02-17 00:21:35.597827 | ubuntu-noble -> localhost | |.o+o. + S        |
2026-02-17 00:21:35.597854 | ubuntu-noble -> localhost | |=+.+oB + .       |
2026-02-17 00:21:35.597880 | ubuntu-noble -> localhost | |% Eo@.= =        |
2026-02-17 00:21:35.597906 | ubuntu-noble -> localhost | |=O X o.*o .      |
2026-02-17 00:21:35.597936 | ubuntu-noble -> localhost | |o== o.o+oo       |
2026-02-17 00:21:35.597963 | ubuntu-noble -> localhost | +----[SHA256]-----+
2026-02-17 00:21:35.598025 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.707582
2026-02-17 00:21:35.605789 | 
2026-02-17 00:21:35.605876 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-02-17 00:21:35.639363 | ubuntu-noble | ok
2026-02-17 00:21:35.651214 | ubuntu-noble | included: /var/lib/zuul/builds/8d1d6698eb934fee86091843aefd163b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-02-17 00:21:35.658909 | 
2026-02-17 00:21:35.658969 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-02-17 00:21:35.681527 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:21:35.693156 | 
2026-02-17 00:21:35.693245 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-02-17 00:21:36.214400 | ubuntu-noble | changed
2026-02-17 00:21:36.221988 | 
2026-02-17 00:21:36.222079 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-02-17 00:21:36.460652 | ubuntu-noble | ok
2026-02-17 00:21:36.468159 | 
2026-02-17 00:21:36.468228 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-02-17 00:21:37.023136 | ubuntu-noble | changed
2026-02-17 00:21:37.030703 | 
2026-02-17 00:21:37.030785 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-02-17 00:21:37.560157 | ubuntu-noble | changed
2026-02-17 00:21:37.566462 | 
2026-02-17 00:21:37.566526 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-02-17 00:21:37.591784 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:21:37.602240 | 
2026-02-17 00:21:37.602329 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-02-17 00:21:37.950631 | ubuntu-noble -> localhost | changed
2026-02-17 00:21:37.968784 | 
2026-02-17 00:21:37.968875 | TASK [add-build-sshkey : Add back temp key]
2026-02-17 00:21:38.258081 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/8d1d6698eb934fee86091843aefd163b/work/8d1d6698eb934fee86091843aefd163b_id_rsa (zuul-build-sshkey)
2026-02-17 00:21:38.258346 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.015889
2026-02-17 00:21:38.267190 | 
2026-02-17 00:21:38.267260 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-02-17 00:21:38.626316 | ubuntu-noble | ok
2026-02-17 00:21:38.632655 | 
2026-02-17 00:21:38.632719 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-02-17 00:21:38.657967 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:21:38.673989 | 
2026-02-17 00:21:38.674067 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-02-17 00:21:39.042883 | ubuntu-noble | ok
2026-02-17 00:21:39.050547 | 
2026-02-17 00:21:39.050618 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-02-17 00:21:40.118716 | ubuntu-noble | Output suppressed because no_log was given
2026-02-17 00:21:40.131535 | 
2026-02-17 00:21:40.131604 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-02-17 00:21:40.361453 | ubuntu-noble | ok: "logs"
2026-02-17 00:21:40.362885 | ubuntu-noble | ok: All items complete
2026-02-17 00:21:40.362996 | 
2026-02-17 00:21:40.593247 | ubuntu-noble | ok: "artifacts"
2026-02-17 00:21:40.738050 | ubuntu-noble | ok: "docs"
2026-02-17 00:21:40.755028 | 
2026-02-17 00:21:40.755277 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-02-17 00:21:40.988005 | ubuntu-noble | changed: "logs"
2026-02-17 00:21:41.184147 | ubuntu-noble | changed: "artifacts"
2026-02-17 00:21:41.388770 | ubuntu-noble | changed: "docs"
2026-02-17 00:21:41.411847 | 
2026-02-17 00:21:41.411975 | PLAY RECAP
2026-02-17 00:21:41.412025 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-02-17 00:21:41.412056 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-02-17 00:21:41.412080 | 
2026-02-17 00:21:41.569908 | PRE-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main]
2026-02-17 00:21:41.572280 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2026-02-17 00:21:42.113959 | 
2026-02-17 00:21:42.114110 | PLAY [all]
2026-02-17 00:21:42.126857 | 
2026-02-17 00:21:42.126975 | TASK [Install binary dependencies]
2026-02-17 00:21:42.182012 | ubuntu-noble | ok
2026-02-17 00:21:42.203588 | 
2026-02-17 00:21:42.203676 | TASK [bindep : Include find tasks]
2026-02-17 00:21:42.239097 | ubuntu-noble | ok
2026-02-17 00:21:42.249417 | ubuntu-noble | included: /var/lib/zuul/builds/8d1d6698eb934fee86091843aefd163b/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml
2026-02-17 00:21:42.255724 | 
2026-02-17 00:21:42.255786 | TASK [bindep : Look for bindep.txt]
2026-02-17 00:21:42.608545 | ubuntu-noble | ok
2026-02-17 00:21:42.615359 | 
2026-02-17 00:21:42.615432 | TASK [bindep : Define bindep_file fact]
2026-02-17 00:21:42.640727 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:21:42.649566 | 
2026-02-17 00:21:42.649657 | TASK [bindep : Look for other-requirements.txt]
2026-02-17 00:21:42.873755 | ubuntu-noble | ok
2026-02-17 00:21:42.881492 | 
2026-02-17 00:21:42.881596 | TASK [bindep : Define bindep_file fact]
2026-02-17 00:21:42.906705 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:21:42.917272 | 
2026-02-17 00:21:42.917338 | TASK [bindep : Look for bindep fallback file]
2026-02-17 00:21:42.942204 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:21:42.954387 | 
2026-02-17 00:21:42.954456 | TASK [bindep : Define bindep_file fact]
2026-02-17 00:21:42.979000 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:21:42.988553 | 
2026-02-17 00:21:42.988639 | TASK [bindep : Include bindep tasks]
2026-02-17 00:21:43.013629 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:21:43.025270 | 
2026-02-17 00:21:43.025376 | TASK [bindep : Include install tasks]
2026-02-17 00:21:43.060626 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:21:43.071373 | 
2026-02-17 00:21:43.071461 | LOOP [bindep : Include package tasks]
2026-02-17 00:21:43.132645 | 
2026-02-17 00:21:43.132774 | TASK [Run test-setup role]
2026-02-17 00:21:43.160415 | ubuntu-noble | ok
2026-02-17 00:21:43.177473 | 
2026-02-17 00:21:43.177538 | TASK [test-setup : Check if project's tools/test-setup.sh exists]
2026-02-17 00:21:43.394171 | ubuntu-noble | ok
2026-02-17 00:21:43.400871 | 
2026-02-17 00:21:43.400935 | TASK [test-setup : Run tools/test-setup.sh]
2026-02-17 00:21:43.932553 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:21:43.945498 | 
2026-02-17 00:21:43.945555 | PLAY RECAP
2026-02-17 00:21:43.945605 | ubuntu-noble | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2026-02-17 00:21:43.945627 | 
2026-02-17 00:21:44.068122 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2026-02-17 00:21:44.070662 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master]
2026-02-17 00:21:44.635006 | 
2026-02-17 00:21:44.635137 | PLAY [all]
2026-02-17 00:21:44.648478 | 
2026-02-17 00:21:44.648558 | TASK [ensure-python : Validate python_version value]
2026-02-17 00:21:44.673980 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:21:44.683870 | 
2026-02-17 00:21:44.683982 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)]
2026-02-17 00:21:44.710781 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:21:44.721553 | 
2026-02-17 00:21:44.721648 | TASK [ensure-python : Pull in venv package]
2026-02-17 00:21:44.747286 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:21:44.758379 | 
2026-02-17 00:21:44.758477 | TASK [ensure-python : Set default RPM package name]
2026-02-17 00:21:44.784684 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:21:44.794596 | 
2026-02-17 00:21:44.794688 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9/10]
2026-02-17 00:21:44.820439 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:21:44.831950 | 
2026-02-17 00:21:44.832041 | TASK [ensure-python : Install RPM package]
2026-02-17 00:21:44.858390 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:21:44.867901 | 
2026-02-17 00:21:44.867993 | TASK [ensure-python : Install python using pyenv]
2026-02-17 00:21:44.894107 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:21:44.904641 | 
2026-02-17 00:21:44.904705 | TASK [ensure-python : Activate python using stow]
2026-02-17 00:21:44.940240 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:21:44.959259 | 
2026-02-17 00:21:44.959360 | TASK [Install pip]
2026-02-17 00:21:44.986957 | ubuntu-noble | ok
2026-02-17 00:21:45.010115 | 
2026-02-17 00:21:45.010187 | TASK [ensure-pip : Check if pip is installed]
2026-02-17 00:21:45.549314 | ubuntu-noble | ok: Runtime: 0:00:00.005923
2026-02-17 00:21:45.556050 | 
2026-02-17 00:21:45.556119 | LOOP [ensure-pip : Install pip from packages]
2026-02-17 00:21:45.585764 | ubuntu-noble | ok: "/var/lib/zuul/builds/8d1d6698eb934fee86091843aefd163b/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/Debian.yaml"
2026-02-17 00:21:45.606537 | ubuntu-noble | included: /var/lib/zuul/builds/8d1d6698eb934fee86091843aefd163b/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/Debian.yaml
2026-02-17 00:21:45.618398 | 
2026-02-17 00:21:45.618465 | TASK [ensure-pip : Update package lists]
2026-02-17 00:21:51.228596 | ubuntu-noble | changed
2026-02-17 00:21:51.236137 | 
2026-02-17 00:21:51.236233 | TASK [ensure-pip : Install Python 3 pip]
2026-02-17 00:21:57.393428 | ubuntu-noble | changed
2026-02-17 00:21:57.399528 | 
2026-02-17 00:21:57.399591 | TASK [ensure-pip : Install Python 2 pip]
2026-02-17 00:21:57.424202 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:21:57.435461 | 
2026-02-17 00:21:57.435534 | TASK [ensure-pip : Ensure setuptools]
2026-02-17 00:21:57.460766 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:21:57.472611 | 
2026-02-17 00:21:57.472701 | TASK [ensure-pip : Check for ensurepip module]
2026-02-17 00:21:57.754264 | ubuntu-noble | usage: python -m ensurepip [-h] [--version] [-v] [-U] [--user] [--root ROOT]
2026-02-17 00:21:57.754388 | ubuntu-noble |                            [--altinstall] [--default-pip]
2026-02-17 00:21:57.754404 | ubuntu-noble |
2026-02-17 00:21:57.754414 | ubuntu-noble | options:
2026-02-17 00:21:57.754424 | ubuntu-noble |   -h, --help     show this help message and exit
2026-02-17 00:21:57.754439 | ubuntu-noble |   --version      Show the version of pip that is bundled with this Python.
2026-02-17 00:21:57.754451 | ubuntu-noble |   -v, --verbose  Give more output. Option is additive, and can be used up to 3
2026-02-17 00:21:57.754465 | ubuntu-noble |                  times.
2026-02-17 00:21:57.754475 | ubuntu-noble |   -U, --upgrade  Upgrade pip and dependencies, even if already installed.
2026-02-17 00:21:57.754483 | ubuntu-noble |   --user         Install using the user scheme.
2026-02-17 00:21:57.754492 | ubuntu-noble |   --root ROOT    Install everything relative to this alternate root directory.
2026-02-17 00:21:57.754501 | ubuntu-noble |   --altinstall   Make an alternate install, installing only the X.Y versioned
2026-02-17 00:21:57.754510 | ubuntu-noble |                  scripts (Default: pipX, pipX.Y).
2026-02-17 00:21:57.754518 | ubuntu-noble |   --default-pip  Make a default pip install, installing the unqualified pip in
2026-02-17 00:21:57.754526 | ubuntu-noble |                  addition to the versioned scripts.
2026-02-17 00:21:58.018048 | ubuntu-noble | ok: Runtime: 0:00:00.060360
2026-02-17 00:21:58.024101 | 
2026-02-17 00:21:58.024182 | TASK [ensure-pip : Ensure python3-venv]
2026-02-17 00:21:58.050243 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:21:58.062382 | 
2026-02-17 00:21:58.062479 | TASK [ensure-pip : Install pip from source]
2026-02-17 00:21:58.088316 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:21:58.145577 | 
2026-02-17 00:21:58.145746 | TASK [ensure-pip : Probe for venv python full path]
2026-02-17 00:21:58.368496 | ubuntu-noble | /usr/bin/python3
2026-02-17 00:21:58.685469 | ubuntu-noble | ok: Runtime: 0:00:00.005236
2026-02-17 00:21:58.691364 | 
2026-02-17 00:21:58.691436 | TASK [ensure-pip : Set host default]
2026-02-17 00:21:58.748282 | ubuntu-noble | ok
2026-02-17 00:21:58.755839 | 
2026-02-17 00:21:58.755904 | TASK [ensure-pip : Set ensure_pip_virtualenv_command]
2026-02-17 00:21:58.814373 | ubuntu-noble | ok
2026-02-17 00:21:58.825767 | 
2026-02-17 00:21:58.825833 | TASK [ensure-tox : Check if tox is installed]
2026-02-17 00:21:59.364297 | ubuntu-noble | ok: Runtime: 0:00:00.004375
2026-02-17 00:21:59.371987 | 
2026-02-17 00:21:59.372081 | TASK [ensure-tox : Export preinstalled tox_exectuable]
2026-02-17 00:21:59.397596 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:21:59.408325 | 
2026-02-17 00:21:59.408416 | TASK [ensure-tox : Create local venv]
2026-02-17 00:22:02.947395 | ubuntu-noble | ok: Runtime: 0:00:03.063964
2026-02-17 00:22:02.955414 | 
2026-02-17 00:22:02.955507 | TASK [ensure-tox : Install tox to local venv]
2026-02-17 00:22:03.759326 | ubuntu-noble | Collecting tox
2026-02-17 00:22:03.821430 | ubuntu-noble |   Downloading tox-4.36.0-py3-none-any.whl.metadata (3.6 kB)
2026-02-17 00:22:03.889239 | ubuntu-noble | Collecting cachetools>=7.0.1 (from tox)
2026-02-17 00:22:03.901287 | ubuntu-noble |   Downloading cachetools-7.0.1-py3-none-any.whl.metadata (5.6 kB)
2026-02-17 00:22:03.942879 | ubuntu-noble | Collecting chardet>=5.2 (from tox)
2026-02-17 00:22:03.951672 | ubuntu-noble |   Downloading chardet-5.2.0-py3-none-any.whl.metadata (3.4 kB)
2026-02-17 00:22:03.994675 | ubuntu-noble | Collecting colorama>=0.4.6 (from tox)
2026-02-17 00:22:04.006235 | ubuntu-noble |   Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB)
2026-02-17 00:22:04.068890 | ubuntu-noble | Collecting filelock>=3.24 (from tox)
2026-02-17 00:22:04.078460 | ubuntu-noble |   Downloading filelock-3.24.2-py3-none-any.whl.metadata (2.0 kB)
2026-02-17 00:22:04.134586 | ubuntu-noble | Collecting packaging>=26 (from tox)
2026-02-17 00:22:04.143659 | ubuntu-noble |   Downloading packaging-26.0-py3-none-any.whl.metadata (3.3 kB)
2026-02-17 00:22:04.201750 | ubuntu-noble | Collecting platformdirs>=4.9.1 (from tox)
2026-02-17 00:22:04.211078 | ubuntu-noble |   Downloading platformdirs-4.9.2-py3-none-any.whl.metadata (4.7 kB)
2026-02-17 00:22:04.254091 | ubuntu-noble | Collecting pluggy>=1.6 (from tox)
2026-02-17 00:22:04.263021 | ubuntu-noble |   Downloading pluggy-1.6.0-py3-none-any.whl.metadata (4.8 kB)
2026-02-17 00:22:04.305921 | ubuntu-noble | Collecting pyproject-api>=1.10 (from tox)
2026-02-17 00:22:04.317650 | ubuntu-noble |   Downloading pyproject_api-1.10.0-py3-none-any.whl.metadata (2.7 kB)
2026-02-17 00:22:04.441112 | ubuntu-noble | Collecting virtualenv>=20.36.1 (from tox)
2026-02-17 00:22:04.450423 | ubuntu-noble |   Downloading virtualenv-20.37.0-py3-none-any.whl.metadata (5.1 kB)
2026-02-17 00:22:04.545370 | ubuntu-noble | Collecting distlib<1,>=0.3.7 (from virtualenv>=20.36.1->tox)
2026-02-17 00:22:04.554564 | ubuntu-noble |   Downloading distlib-0.4.0-py2.py3-none-any.whl.metadata (5.2 kB)
2026-02-17 00:22:04.595142 | ubuntu-noble | Downloading tox-4.36.0-py3-none-any.whl (179 kB)
2026-02-17 00:22:04.651784 | ubuntu-noble |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 179.1/179.1 kB 3.5 MB/s eta 0:00:00
2026-02-17 00:22:04.663353 | ubuntu-noble | Downloading cachetools-7.0.1-py3-none-any.whl (13 kB)
2026-02-17 00:22:04.684690 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl (199 kB)
2026-02-17 00:22:04.744505 | ubuntu-noble |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 3.4 MB/s eta 0:00:00
2026-02-17 00:22:04.754323 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB)
2026-02-17 00:22:04.776374 | ubuntu-noble | Downloading filelock-3.24.2-py3-none-any.whl (24 kB)
2026-02-17 00:22:04.797004 | ubuntu-noble | Downloading packaging-26.0-py3-none-any.whl (74 kB)
2026-02-17 00:22:04.826176 | ubuntu-noble |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 2.5 MB/s eta 0:00:00
2026-02-17 00:22:04.836397 | ubuntu-noble | Downloading platformdirs-4.9.2-py3-none-any.whl (21 kB)
2026-02-17 00:22:04.858561 | ubuntu-noble | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB)
2026-02-17 00:22:04.877708 | ubuntu-noble | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB)
2026-02-17 00:22:04.895347 | ubuntu-noble | Downloading virtualenv-20.37.0-py3-none-any.whl (5.8 MB)
2026-02-17 00:22:05.871489 | ubuntu-noble |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.8/5.8 MB 6.0 MB/s eta 0:00:00
2026-02-17 00:22:05.882594 | ubuntu-noble | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB)
2026-02-17 00:22:05.941201 | ubuntu-noble |    ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 8.4 MB/s eta 0:00:00
2026-02-17 00:22:06.010566 | ubuntu-noble | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox
2026-02-17 00:22:06.836183 | 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:22:07.006530 | ubuntu-noble | ok: Runtime: 0:00:03.748258
2026-02-17 00:22:07.013720 | 
2026-02-17 00:22:07.013790 | TASK [ensure-tox : Export installed tox_executable path]
2026-02-17 00:22:07.050998 | ubuntu-noble | ok
2026-02-17 00:22:07.057921 | 
2026-02-17 00:22:07.058009 | TASK [ensure-tox : Output tox version]
2026-02-17 00:22:07.497328 | 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:22:07.511810 | ubuntu-noble | 4.36.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py
2026-02-17 00:22:07.596556 | ubuntu-noble | ok: Runtime: 0:00:00.268006
2026-02-17 00:22:07.604058 | 
2026-02-17 00:22:07.604145 | TASK [ensure-tox : Make global symlink]
2026-02-17 00:22:07.629941 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:22:07.639947 | 
2026-02-17 00:22:07.640016 | PLAY RECAP
2026-02-17 00:22:07.640082 | ubuntu-noble | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0
2026-02-17 00:22:07.640111 | 
2026-02-17 00:22:07.791925 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master]
2026-02-17 00:22:07.794624 | PRE-RUN START: [untrusted : github.com/vexxhost/magnum-cluster-api/zuul.d/playbooks/tox/pre.yml@main]
2026-02-17 00:22:08.355058 | 
2026-02-17 00:22:08.355205 | PLAY [all]
2026-02-17 00:22:08.366922 | 
2026-02-17 00:22:08.367003 | TASK [ensure-rust : Use rustup]
2026-02-17 00:22:08.401141 | ubuntu-noble | ok
2026-02-17 00:22:08.412019 | ubuntu-noble | included: /var/lib/zuul/builds/8d1d6698eb934fee86091843aefd163b/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-rust/tasks/rustup.yaml
2026-02-17 00:22:08.419869 | 
2026-02-17 00:22:08.419964 | TASK [ensure-rust : Install Rust]
2026-02-17 00:22:08.791361 | ubuntu-noble | /bin/bash: line 2: curl: command not found
2026-02-17 00:22:08.958882 | ubuntu-noble | ERROR
2026-02-17 00:22:08.959221 | ubuntu-noble | {
2026-02-17 00:22:08.959288 | ubuntu-noble |   "delta": "0:00:00.005836",
2026-02-17 00:22:08.959339 | ubuntu-noble |   "end": "2026-02-17 00:22:08.792224",
2026-02-17 00:22:08.959383 | ubuntu-noble |   "msg": "non-zero return code",
2026-02-17 00:22:08.959424 | ubuntu-noble |   "rc": 127,
2026-02-17 00:22:08.959464 | ubuntu-noble |   "start": "2026-02-17 00:22:08.786388"
2026-02-17 00:22:08.959514 | ubuntu-noble | }
failure
2026-02-17 00:22:08.961172 | 
2026-02-17 00:22:08.961217 | PLAY RECAP
2026-02-17 00:22:08.961263 | ubuntu-noble | ok: 1 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-02-17 00:22:08.961284 | 
2026-02-17 00:22:09.073187 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/magnum-cluster-api/zuul.d/playbooks/tox/pre.yml@main]
2026-02-17 00:22:09.075673 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master]
2026-02-17 00:22:09.647043 | 
2026-02-17 00:22:09.647208 | PLAY [all]
2026-02-17 00:22:09.659921 | 
2026-02-17 00:22:09.660018 | TASK [fetch-tox-output : Set tox log path for multiple nodes]
2026-02-17 00:22:09.705545 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:22:09.717674 | 
2026-02-17 00:22:09.717776 | TASK [fetch-tox-output : Set tox log path for single node]
2026-02-17 00:22:09.761035 | ubuntu-noble | ok
2026-02-17 00:22:09.769915 | 
2026-02-17 00:22:09.770010 | TASK [fetch-tox-output : Ensure local tox dir]
2026-02-17 00:22:10.149793 | ubuntu-noble -> localhost | changed
2026-02-17 00:22:10.161472 | 
2026-02-17 00:22:10.161550 | TASK [fetch-tox-output : Ensure zuul-output tox dir]
2026-02-17 00:22:10.206487 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:22:10.215506 | 
2026-02-17 00:22:10.215604 | TASK [fetch-tox-output : Set envlist fact]
2026-02-17 00:22:10.259778 | ubuntu-noble | ok
2026-02-17 00:22:10.267334 | 
2026-02-17 00:22:10.267424 | TASK [fetch-tox-output : Get tox version]
2026-02-17 00:22:10.881725 | 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:22:10.902051 | ubuntu-noble | 4.36.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py
2026-02-17 00:22:11.303901 | ubuntu-noble | ok: Runtime: 0:00:00.300290
2026-02-17 00:22:11.309577 | 
2026-02-17 00:22:11.309655 | TASK [fetch-tox-output : Find all default environments]
2026-02-17 00:22:11.839794 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:22:11.849992 | 
2026-02-17 00:22:11.850099 | TASK [fetch-tox-output : Set envlist fact]
2026-02-17 00:22:11.875535 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:22:11.885942 | 
2026-02-17 00:22:11.886036 | TASK [fetch-tox-output : Find all default environments]
2026-02-17 00:22:12.419123 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:22:12.431751 | 
2026-02-17 00:22:12.431897 | TASK [fetch-tox-output : Set envlist fact]
2026-02-17 00:22:12.458727 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:22:12.468760 | 
2026-02-17 00:22:12.468968 | LOOP [fetch-tox-output : Copy tox logs]
2026-02-17 00:22:12.510746 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:22:12.527407 | 
2026-02-17 00:22:12.527539 | LOOP [fetch-tox-output : Collect tox logs]
2026-02-17 00:22:13.315736 | ubuntu-noble | ok:
2026-02-17 00:22:13.315931 | 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:22:13.315970 | 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:22:13.315992 | ubuntu-noble | rsync: [Receiver] write error: Broken pipe (32)
2026-02-17 00:22:13.316021 | 
2026-02-17 00:22:13.336437 | 
2026-02-17 00:22:13.336569 | PLAY RECAP
2026-02-17 00:22:13.336622 | ubuntu-noble | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0
2026-02-17 00:22:13.336643 | 
2026-02-17 00:22:13.470198 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master]
2026-02-17 00:22:13.472794 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2026-02-17 00:22:14.034104 | 
2026-02-17 00:22:14.034246 | PLAY [all]
2026-02-17 00:22:14.046703 | 
2026-02-17 00:22:14.046785 | TASK [fetch-subunit-output : Find stestr or testr executable]
2026-02-17 00:22:14.243876 | ubuntu-noble | changed: non-zero return code
2026-02-17 00:22:14.249538 | 
2026-02-17 00:22:14.249623 | TASK [fetch-subunit-output : Get the list of directories with subunit files]
2026-02-17 00:22:14.275431 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:22:14.286598 | 
2026-02-17 00:22:14.286695 | LOOP [fetch-subunit-output : Find any inflight partial subunit files]
2026-02-17 00:22:14.322756 | 
2026-02-17 00:22:14.322966 | LOOP [fetch-subunit-output : Copy any inflight subunit files]
2026-02-17 00:22:14.358199 | 
2026-02-17 00:22:14.358375 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream]
2026-02-17 00:22:14.384195 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:22:14.395284 | 
2026-02-17 00:22:14.395358 | LOOP [fetch-subunit-output : Generate subunit file]
2026-02-17 00:22:14.430466 | 
2026-02-17 00:22:14.430635 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory]
2026-02-17 00:22:14.455662 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:22:14.470018 | 
2026-02-17 00:22:14.470091 | TASK [fetch-subunit-output : Remove the temporary file]
2026-02-17 00:22:14.494782 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:22:14.506448 | 
2026-02-17 00:22:14.506537 | TASK [fetch-subunit-output : Process and fetch subunit results]
2026-02-17 00:22:14.531418 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:22:14.543469 | 
2026-02-17 00:22:14.543536 | PLAY RECAP
2026-02-17 00:22:14.543599 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2026-02-17 00:22:14.543628 | 
2026-02-17 00:22:14.684304 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2026-02-17 00:22:14.686843 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main]
2026-02-17 00:22:15.240809 | 
2026-02-17 00:22:15.240967 | PLAY [all]
2026-02-17 00:22:15.252780 | 
2026-02-17 00:22:15.252851 | TASK [fetch-output : Set log path for multiple nodes]
2026-02-17 00:22:15.298706 | ubuntu-noble | skipping: Conditional result was False
2026-02-17 00:22:15.308831 | 
2026-02-17 00:22:15.308914 | TASK [fetch-output : Set log path for single node]
2026-02-17 00:22:15.354983 | ubuntu-noble | ok
2026-02-17 00:22:15.361442 | 
2026-02-17 00:22:15.361511 | LOOP [fetch-output : Ensure local output dirs]
2026-02-17 00:22:15.779014 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/8d1d6698eb934fee86091843aefd163b/work/logs"
2026-02-17 00:22:16.004623 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/8d1d6698eb934fee86091843aefd163b/work/artifacts"
2026-02-17 00:22:16.215544 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/8d1d6698eb934fee86091843aefd163b/work/docs"
2026-02-17 00:22:16.239377 | 
2026-02-17 00:22:16.239537 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-02-17 00:22:16.887814 | ubuntu-noble | changed: .d..t...... ./
2026-02-17 00:22:16.888038 | ubuntu-noble | changed: All items complete
2026-02-17 00:22:16.888066 | 
2026-02-17 00:22:17.349307 | ubuntu-noble | changed: .d..t...... ./
2026-02-17 00:22:17.826275 | ubuntu-noble | changed: .d..t...... ./
2026-02-17 00:22:17.852245 | 
2026-02-17 00:22:17.852395 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-02-17 00:22:18.305944 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.008463
2026-02-17 00:22:18.535175 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.008889
2026-02-17 00:22:18.555944 | 
2026-02-17 00:22:18.556097 | PLAY [all]
2026-02-17 00:22:18.564137 | 
2026-02-17 00:22:18.564206 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-02-17 00:22:19.035861 | ubuntu-noble | changed
2026-02-17 00:22:19.041988 | 
2026-02-17 00:22:19.042038 | PLAY RECAP
2026-02-17 00:22:19.042084 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-02-17 00:22:19.042106 | 
2026-02-17 00:22:19.161424 | POST-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main]
2026-02-17 00:22:19.164050 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post-logs.yaml@main]
2026-02-17 00:22:19.741768 | 
2026-02-17 00:22:19.741914 | PLAY [localhost]
2026-02-17 00:22:19.752426 | 
2026-02-17 00:22:19.752497 | TASK [Generate Zuul manifest]
2026-02-17 00:22:19.775528 | localhost | ok
2026-02-17 00:22:19.793243 | 
2026-02-17 00:22:19.793320 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-02-17 00:22:20.124409 | localhost | changed
2026-02-17 00:22:20.136398 | 
2026-02-17 00:22:20.136471 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-02-17 00:22:20.168217 | localhost | ok
2026-02-17 00:22:20.176717 | 
2026-02-17 00:22:20.176799 | TASK [Upload logs]
2026-02-17 00:22:20.198224 | localhost | ok
2026-02-17 00:22:20.256874 | 
2026-02-17 00:22:20.257020 | TASK [Set zuul-log-path fact]
2026-02-17 00:22:20.276533 | localhost | ok
2026-02-17 00:22:20.290700 | 
2026-02-17 00:22:20.290767 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-02-17 00:22:20.322346 | localhost | ok
2026-02-17 00:22:20.332828 | 
2026-02-17 00:22:20.332893 | TASK [upload-logs : Create log directories]
2026-02-17 00:22:20.746613 | localhost | changed
2026-02-17 00:22:20.753021 | 
2026-02-17 00:22:20.753110 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-02-17 00:22:21.171510 | localhost -> localhost | ok: Runtime: 0:00:00.006044
2026-02-17 00:22:21.178306 | 
2026-02-17 00:22:21.178396 | TASK [upload-logs : Upload logs to log server]
2026-02-17 00:22:21.667499 | localhost | Output suppressed because no_log was given
2026-02-17 00:22:21.673025 | 
2026-02-17 00:22:21.673133 | LOOP [upload-logs : Compress console log and json output]
2026-02-17 00:22:21.720512 | localhost | skipping: Conditional result was False
2026-02-17 00:22:21.726748 | localhost | skipping: Conditional result was False
2026-02-17 00:22:21.740735 | 
2026-02-17 00:22:21.740921 | LOOP [upload-logs : Upload compressed console log and json output]
2026-02-17 00:22:21.786314 | localhost | skipping: Conditional result was False
2026-02-17 00:22:21.786692 | 
2026-02-17 00:22:21.789857 | localhost | skipping: Conditional result was False
2026-02-17 00:22:21.806772 | 
2026-02-17 00:22:21.806954 | LOOP [upload-logs : Upload console log and json output]