2026-02-16 17:53:52.401161 | Job console starting 2026-02-16 17:53:52.410071 | Updating git repos 2026-02-16 17:53:52.444292 | Cloning repos into workspace 2026-02-16 17:53:52.492545 | Restoring repo states 2026-02-16 17:53:52.506494 | Merging changes 2026-02-16 17:53:52.932451 | Checking out repos 2026-02-16 17:53:53.055537 | Preparing playbooks 2026-02-16 17:53:54.072214 | Running Ansible setup 2026-02-16 17:53:57.599067 | PRE-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main] 2026-02-16 17:53:58.230551 | 2026-02-16 17:53:58.230696 | PLAY [localhost] 2026-02-16 17:53:58.238649 | 2026-02-16 17:53:58.238732 | TASK [Gathering Facts] 2026-02-16 17:53:59.115683 | localhost | ok 2026-02-16 17:53:59.123260 | 2026-02-16 17:53:59.123337 | TASK [Setup log path fact] 2026-02-16 17:53:59.144225 | localhost | ok 2026-02-16 17:53:59.156866 | 2026-02-16 17:53:59.156932 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-16 17:53:59.188493 | localhost | ok 2026-02-16 17:53:59.196470 | 2026-02-16 17:53:59.196562 | TASK [emit-job-header : Print job information] 2026-02-16 17:53:59.239690 | # Job Information 2026-02-16 17:53:59.239845 | Ansible Version: 2.16.15 2026-02-16 17:53:59.239890 | Job: magnum-cluster-api-tox-functional 2026-02-16 17:53:59.239943 | Pipeline: check 2026-02-16 17:53:59.239981 | Executor: 3a2793d2bd32 2026-02-16 17:53:59.240010 | Triggered by: https://github.com/vexxhost/magnum-cluster-api/pull/884 2026-02-16 17:53:59.240040 | Event ID: ed3be480-0b5f-11f1-9b41-a55389b20acd 2026-02-16 17:53:59.243749 | 2026-02-16 17:53:59.243839 | LOOP [emit-job-header : Print node information] 2026-02-16 17:53:59.341330 | localhost | ok: 2026-02-16 17:53:59.341693 | localhost | # Node Information 2026-02-16 17:53:59.341776 | localhost | Inventory Hostname: ubuntu-noble 2026-02-16 17:53:59.341837 | localhost | Hostname: np0000155653 2026-02-16 17:53:59.341892 | localhost | Username: zuul 2026-02-16 17:53:59.341953 | localhost | Distro: Ubuntu 24.04 2026-02-16 17:53:59.342007 | localhost | Provider: yul1 2026-02-16 17:53:59.342059 | localhost | Region: ca-ymq-1 2026-02-16 17:53:59.342111 | localhost | Label: ubuntu-noble 2026-02-16 17:53:59.342161 | localhost | Product Name: OpenStack Nova 2026-02-16 17:53:59.342210 | localhost | Interface IP: 162.253.55.195 2026-02-16 17:53:59.353448 | 2026-02-16 17:53:59.353597 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-16 17:53:59.754909 | localhost -> localhost | changed 2026-02-16 17:53:59.763996 | 2026-02-16 17:53:59.764069 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-16 17:54:00.606470 | localhost -> localhost | changed 2026-02-16 17:54:00.617350 | 2026-02-16 17:54:00.617412 | PLAY [all] 2026-02-16 17:54:00.626251 | 2026-02-16 17:54:00.626318 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-16 17:54:00.852777 | ubuntu-noble -> localhost | ok 2026-02-16 17:54:00.859486 | 2026-02-16 17:54:00.859552 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-16 17:54:00.890745 | ubuntu-noble | ok 2026-02-16 17:54:00.906470 | ubuntu-noble | included: /var/lib/zuul/builds/4ea781caf91f4b77a6c8059339e395da/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-16 17:54:00.912438 | 2026-02-16 17:54:00.912497 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-16 17:54:02.272486 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2026-02-16 17:54:02.272730 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/4ea781caf91f4b77a6c8059339e395da/work/4ea781caf91f4b77a6c8059339e395da_id_rsa 2026-02-16 17:54:02.272784 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/4ea781caf91f4b77a6c8059339e395da/work/4ea781caf91f4b77a6c8059339e395da_id_rsa.pub 2026-02-16 17:54:02.272817 | ubuntu-noble -> localhost | The key fingerprint is: 2026-02-16 17:54:02.272847 | ubuntu-noble -> localhost | SHA256:kwtOe2l2jcxu4WWQqBaVOr0r0+jGXdbX4xtiegdOLLY zuul-build-sshkey 2026-02-16 17:54:02.272893 | ubuntu-noble -> localhost | The key's randomart image is: 2026-02-16 17:54:02.272922 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2026-02-16 17:54:02.272981 | ubuntu-noble -> localhost | | . | 2026-02-16 17:54:02.273016 | ubuntu-noble -> localhost | | o | 2026-02-16 17:54:02.273044 | ubuntu-noble -> localhost | | + . . | 2026-02-16 17:54:02.273071 | ubuntu-noble -> localhost | | + o.o | 2026-02-16 17:54:02.273098 | ubuntu-noble -> localhost | | o+S. o. . | 2026-02-16 17:54:02.273123 | ubuntu-noble -> localhost | | ooo.*+=++...| 2026-02-16 17:54:02.273149 | ubuntu-noble -> localhost | | oo+*=*+*+o..| 2026-02-16 17:54:02.273174 | ubuntu-noble -> localhost | | *++ooEoo.o.| 2026-02-16 17:54:02.273203 | ubuntu-noble -> localhost | | o.o .... ...| 2026-02-16 17:54:02.273230 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2026-02-16 17:54:02.273291 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.943110 2026-02-16 17:54:02.279780 | 2026-02-16 17:54:02.279851 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-16 17:54:02.314978 | ubuntu-noble | ok 2026-02-16 17:54:02.326873 | ubuntu-noble | included: /var/lib/zuul/builds/4ea781caf91f4b77a6c8059339e395da/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-16 17:54:02.335408 | 2026-02-16 17:54:02.335473 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-16 17:54:02.360943 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:02.371290 | 2026-02-16 17:54:02.371360 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-16 17:54:02.926750 | ubuntu-noble | changed 2026-02-16 17:54:02.934307 | 2026-02-16 17:54:02.934373 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-16 17:54:03.164187 | ubuntu-noble | ok 2026-02-16 17:54:03.169634 | 2026-02-16 17:54:03.169699 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-16 17:54:03.730093 | ubuntu-noble | changed 2026-02-16 17:54:03.735617 | 2026-02-16 17:54:03.735686 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-16 17:54:04.295829 | ubuntu-noble | changed 2026-02-16 17:54:04.302779 | 2026-02-16 17:54:04.302856 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-16 17:54:04.326106 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:04.345522 | 2026-02-16 17:54:04.345593 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-16 17:54:04.705591 | ubuntu-noble -> localhost | changed 2026-02-16 17:54:04.724427 | 2026-02-16 17:54:04.724509 | TASK [add-build-sshkey : Add back temp key] 2026-02-16 17:54:05.008696 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/4ea781caf91f4b77a6c8059339e395da/work/4ea781caf91f4b77a6c8059339e395da_id_rsa (zuul-build-sshkey) 2026-02-16 17:54:05.008900 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.016099 2026-02-16 17:54:05.016115 | 2026-02-16 17:54:05.016180 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-16 17:54:05.373392 | ubuntu-noble | ok 2026-02-16 17:54:05.379412 | 2026-02-16 17:54:05.379477 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-16 17:54:05.404251 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:05.419316 | 2026-02-16 17:54:05.419381 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-02-16 17:54:05.799984 | ubuntu-noble | ok 2026-02-16 17:54:05.807710 | 2026-02-16 17:54:05.807773 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-02-16 17:54:06.836659 | ubuntu-noble | Output suppressed because no_log was given 2026-02-16 17:54:06.846567 | 2026-02-16 17:54:06.846642 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-02-16 17:54:07.068866 | ubuntu-noble | ok: "logs" 2026-02-16 17:54:07.069224 | ubuntu-noble | ok: All items complete 2026-02-16 17:54:07.069279 | 2026-02-16 17:54:07.326649 | ubuntu-noble | ok: "artifacts" 2026-02-16 17:54:07.484865 | ubuntu-noble | ok: "docs" 2026-02-16 17:54:07.504001 | 2026-02-16 17:54:07.504164 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-02-16 17:54:07.763765 | ubuntu-noble | changed: "logs" 2026-02-16 17:54:07.954432 | ubuntu-noble | changed: "artifacts" 2026-02-16 17:54:08.140705 | ubuntu-noble | changed: "docs" 2026-02-16 17:54:08.162097 | 2026-02-16 17:54:08.162235 | PLAY RECAP 2026-02-16 17:54:08.162287 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-16 17:54:08.162316 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-02-16 17:54:08.162336 | 2026-02-16 17:54:08.307764 | PRE-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main] 2026-02-16 17:54:08.310464 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-16 17:54:08.891888 | 2026-02-16 17:54:08.892018 | PLAY [all] 2026-02-16 17:54:08.904417 | 2026-02-16 17:54:08.904516 | TASK [Install binary dependencies] 2026-02-16 17:54:08.955457 | ubuntu-noble | ok 2026-02-16 17:54:08.974826 | 2026-02-16 17:54:08.974938 | TASK [bindep : Include find tasks] 2026-02-16 17:54:09.006085 | ubuntu-noble | ok 2026-02-16 17:54:09.013887 | ubuntu-noble | included: /var/lib/zuul/builds/4ea781caf91f4b77a6c8059339e395da/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-02-16 17:54:09.020154 | 2026-02-16 17:54:09.020219 | TASK [bindep : Look for bindep.txt] 2026-02-16 17:54:09.394676 | ubuntu-noble | ok 2026-02-16 17:54:09.401313 | 2026-02-16 17:54:09.401385 | TASK [bindep : Define bindep_file fact] 2026-02-16 17:54:09.426001 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:09.432009 | 2026-02-16 17:54:09.432077 | TASK [bindep : Look for other-requirements.txt] 2026-02-16 17:54:09.640652 | ubuntu-noble | ok 2026-02-16 17:54:09.646152 | 2026-02-16 17:54:09.646222 | TASK [bindep : Define bindep_file fact] 2026-02-16 17:54:09.672374 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:09.682033 | 2026-02-16 17:54:09.682127 | TASK [bindep : Look for bindep fallback file] 2026-02-16 17:54:09.707991 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:09.720114 | 2026-02-16 17:54:09.720192 | TASK [bindep : Define bindep_file fact] 2026-02-16 17:54:09.745920 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:09.757820 | 2026-02-16 17:54:09.757885 | TASK [bindep : Include bindep tasks] 2026-02-16 17:54:09.783179 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:09.789045 | 2026-02-16 17:54:09.789110 | TASK [bindep : Include install tasks] 2026-02-16 17:54:09.824493 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:09.834957 | 2026-02-16 17:54:09.835029 | LOOP [bindep : Include package tasks] 2026-02-16 17:54:09.894876 | 2026-02-16 17:54:09.895009 | TASK [Run test-setup role] 2026-02-16 17:54:09.921853 | ubuntu-noble | ok 2026-02-16 17:54:09.939929 | 2026-02-16 17:54:09.940000 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-02-16 17:54:10.158857 | ubuntu-noble | ok 2026-02-16 17:54:10.165205 | 2026-02-16 17:54:10.165278 | TASK [test-setup : Run tools/test-setup.sh] 2026-02-16 17:54:10.696950 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:10.709086 | 2026-02-16 17:54:10.709158 | PLAY RECAP 2026-02-16 17:54:10.709226 | ubuntu-noble | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-16 17:54:10.709255 | 2026-02-16 17:54:10.823527 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-16 17:54:10.824780 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2026-02-16 17:54:11.382692 | 2026-02-16 17:54:11.382832 | PLAY [all] 2026-02-16 17:54:11.396290 | 2026-02-16 17:54:11.396372 | TASK [ensure-python : Validate python_version value] 2026-02-16 17:54:11.421852 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:11.431920 | 2026-02-16 17:54:11.432033 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)] 2026-02-16 17:54:11.457708 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:11.467017 | 2026-02-16 17:54:11.467102 | TASK [ensure-python : Pull in venv package] 2026-02-16 17:54:11.492454 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:11.500702 | 2026-02-16 17:54:11.500799 | TASK [ensure-python : Set default RPM package name] 2026-02-16 17:54:11.526633 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:11.534901 | 2026-02-16 17:54:11.535001 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9/10] 2026-02-16 17:54:11.580947 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:11.591947 | 2026-02-16 17:54:11.592019 | TASK [ensure-python : Install RPM package] 2026-02-16 17:54:11.617682 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:11.627401 | 2026-02-16 17:54:11.627498 | TASK [ensure-python : Install python using pyenv] 2026-02-16 17:54:11.653359 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:11.664153 | 2026-02-16 17:54:11.664223 | TASK [ensure-python : Activate python using stow] 2026-02-16 17:54:11.699527 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:11.717886 | 2026-02-16 17:54:11.717953 | TASK [Install pip] 2026-02-16 17:54:11.742952 | ubuntu-noble | ok 2026-02-16 17:54:11.767311 | 2026-02-16 17:54:11.767385 | TASK [ensure-pip : Check if pip is installed] 2026-02-16 17:54:12.302500 | ubuntu-noble | ok: Runtime: 0:00:00.007545 2026-02-16 17:54:12.309070 | 2026-02-16 17:54:12.309137 | LOOP [ensure-pip : Install pip from packages] 2026-02-16 17:54:12.339169 | ubuntu-noble | ok: "/var/lib/zuul/builds/4ea781caf91f4b77a6c8059339e395da/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/Debian.yaml" 2026-02-16 17:54:12.358147 | ubuntu-noble | included: /var/lib/zuul/builds/4ea781caf91f4b77a6c8059339e395da/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/Debian.yaml 2026-02-16 17:54:12.367917 | 2026-02-16 17:54:12.367980 | TASK [ensure-pip : Update package lists] 2026-02-16 17:54:18.317620 | ubuntu-noble | changed 2026-02-16 17:54:18.323073 | 2026-02-16 17:54:18.323137 | TASK [ensure-pip : Install Python 3 pip] 2026-02-16 17:54:24.278129 | ubuntu-noble | changed 2026-02-16 17:54:24.284221 | 2026-02-16 17:54:24.284289 | TASK [ensure-pip : Install Python 2 pip] 2026-02-16 17:54:24.309708 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:24.321852 | 2026-02-16 17:54:24.321918 | TASK [ensure-pip : Ensure setuptools] 2026-02-16 17:54:24.346271 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:24.358327 | 2026-02-16 17:54:24.358393 | TASK [ensure-pip : Check for ensurepip module] 2026-02-16 17:54:24.627149 | ubuntu-noble | usage: python -m ensurepip [-h] [--version] [-v] [-U] [--user] [--root ROOT] 2026-02-16 17:54:24.627311 | ubuntu-noble | [--altinstall] [--default-pip] 2026-02-16 17:54:24.627326 | ubuntu-noble | 2026-02-16 17:54:24.627337 | ubuntu-noble | options: 2026-02-16 17:54:24.627349 | ubuntu-noble | -h, --help show this help message and exit 2026-02-16 17:54:24.627365 | ubuntu-noble | --version Show the version of pip that is bundled with this Python. 2026-02-16 17:54:24.627378 | ubuntu-noble | -v, --verbose Give more output. Option is additive, and can be used up to 3 2026-02-16 17:54:24.627393 | ubuntu-noble | times. 2026-02-16 17:54:24.627404 | ubuntu-noble | -U, --upgrade Upgrade pip and dependencies, even if already installed. 2026-02-16 17:54:24.627413 | ubuntu-noble | --user Install using the user scheme. 2026-02-16 17:54:24.627422 | ubuntu-noble | --root ROOT Install everything relative to this alternate root directory. 2026-02-16 17:54:24.627431 | ubuntu-noble | --altinstall Make an alternate install, installing only the X.Y versioned 2026-02-16 17:54:24.627440 | ubuntu-noble | scripts (Default: pipX, pipX.Y). 2026-02-16 17:54:24.627448 | ubuntu-noble | --default-pip Make a default pip install, installing the unqualified pip in 2026-02-16 17:54:24.627457 | ubuntu-noble | addition to the versioned scripts. 2026-02-16 17:54:24.900258 | ubuntu-noble | ok: Runtime: 0:00:00.058912 2026-02-16 17:54:24.906099 | 2026-02-16 17:54:24.906167 | TASK [ensure-pip : Ensure python3-venv] 2026-02-16 17:54:24.931798 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:24.942365 | 2026-02-16 17:54:24.942484 | TASK [ensure-pip : Install pip from source] 2026-02-16 17:54:24.968086 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:25.019920 | 2026-02-16 17:54:25.020052 | TASK [ensure-pip : Probe for venv python full path] 2026-02-16 17:54:25.251108 | ubuntu-noble | /usr/bin/python3 2026-02-16 17:54:25.558940 | ubuntu-noble | ok: Runtime: 0:00:00.005281 2026-02-16 17:54:25.566878 | 2026-02-16 17:54:25.566971 | TASK [ensure-pip : Set host default] 2026-02-16 17:54:25.623077 | ubuntu-noble | ok 2026-02-16 17:54:25.630028 | 2026-02-16 17:54:25.630117 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2026-02-16 17:54:25.682286 | ubuntu-noble | ok 2026-02-16 17:54:25.691752 | 2026-02-16 17:54:25.691839 | TASK [ensure-tox : Check if tox is installed] 2026-02-16 17:54:26.230499 | ubuntu-noble | ok: Runtime: 0:00:00.008807 2026-02-16 17:54:26.239266 | 2026-02-16 17:54:26.239361 | TASK [ensure-tox : Export preinstalled tox_exectuable] 2026-02-16 17:54:26.265709 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:26.277757 | 2026-02-16 17:54:26.277824 | TASK [ensure-tox : Create local venv] 2026-02-16 17:54:29.821963 | ubuntu-noble | ok: Runtime: 0:00:03.180660 2026-02-16 17:54:29.828017 | 2026-02-16 17:54:29.828083 | TASK [ensure-tox : Install tox to local venv] 2026-02-16 17:54:30.586764 | ubuntu-noble | Collecting tox 2026-02-16 17:54:30.633991 | ubuntu-noble | Downloading tox-4.36.0-py3-none-any.whl.metadata (3.6 kB) 2026-02-16 17:54:30.707662 | ubuntu-noble | Collecting cachetools>=7.0.1 (from tox) 2026-02-16 17:54:30.710924 | ubuntu-noble | Downloading cachetools-7.0.1-py3-none-any.whl.metadata (5.6 kB) 2026-02-16 17:54:30.755994 | ubuntu-noble | Collecting chardet>=5.2 (from tox) 2026-02-16 17:54:30.759144 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl.metadata (3.4 kB) 2026-02-16 17:54:30.812766 | ubuntu-noble | Collecting colorama>=0.4.6 (from tox) 2026-02-16 17:54:30.815982 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2026-02-16 17:54:30.886739 | ubuntu-noble | Collecting filelock>=3.24 (from tox) 2026-02-16 17:54:30.891249 | ubuntu-noble | Downloading filelock-3.24.2-py3-none-any.whl.metadata (2.0 kB) 2026-02-16 17:54:30.953283 | ubuntu-noble | Collecting packaging>=26 (from tox) 2026-02-16 17:54:30.956438 | ubuntu-noble | Downloading packaging-26.0-py3-none-any.whl.metadata (3.3 kB) 2026-02-16 17:54:31.023211 | ubuntu-noble | Collecting platformdirs>=4.9.1 (from tox) 2026-02-16 17:54:31.025987 | ubuntu-noble | Downloading platformdirs-4.9.2-py3-none-any.whl.metadata (4.7 kB) 2026-02-16 17:54:31.074482 | ubuntu-noble | Collecting pluggy>=1.6 (from tox) 2026-02-16 17:54:31.077355 | ubuntu-noble | Downloading pluggy-1.6.0-py3-none-any.whl.metadata (4.8 kB) 2026-02-16 17:54:31.129985 | ubuntu-noble | Collecting pyproject-api>=1.10 (from tox) 2026-02-16 17:54:31.134648 | ubuntu-noble | Downloading pyproject_api-1.10.0-py3-none-any.whl.metadata (2.7 kB) 2026-02-16 17:54:31.263739 | ubuntu-noble | Collecting virtualenv>=20.36.1 (from tox) 2026-02-16 17:54:31.266735 | ubuntu-noble | Downloading virtualenv-20.37.0-py3-none-any.whl.metadata (5.1 kB) 2026-02-16 17:54:31.367847 | ubuntu-noble | Collecting distlib<1,>=0.3.7 (from virtualenv>=20.36.1->tox) 2026-02-16 17:54:31.373651 | ubuntu-noble | Downloading distlib-0.4.0-py2.py3-none-any.whl.metadata (5.2 kB) 2026-02-16 17:54:31.411284 | ubuntu-noble | Downloading tox-4.36.0-py3-none-any.whl (179 kB) 2026-02-16 17:54:31.431738 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 179.1/179.1 kB 11.0 MB/s eta 0:00:00 2026-02-16 17:54:31.436591 | ubuntu-noble | Downloading cachetools-7.0.1-py3-none-any.whl (13 kB) 2026-02-16 17:54:31.451146 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2026-02-16 17:54:31.469355 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 12.4 MB/s eta 0:00:00 2026-02-16 17:54:31.473745 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-02-16 17:54:31.486599 | ubuntu-noble | Downloading filelock-3.24.2-py3-none-any.whl (24 kB) 2026-02-16 17:54:31.500000 | ubuntu-noble | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-02-16 17:54:31.512849 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 6.6 MB/s eta 0:00:00 2026-02-16 17:54:31.517672 | ubuntu-noble | Downloading platformdirs-4.9.2-py3-none-any.whl (21 kB) 2026-02-16 17:54:31.533388 | ubuntu-noble | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-02-16 17:54:31.547348 | ubuntu-noble | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-02-16 17:54:31.604632 | ubuntu-noble | Downloading virtualenv-20.37.0-py3-none-any.whl (5.8 MB) 2026-02-16 17:54:31.699131 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.8/5.8 MB 65.0 MB/s eta 0:00:00 2026-02-16 17:54:31.705372 | ubuntu-noble | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-02-16 17:54:31.725928 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 27.6 MB/s eta 0:00:00 2026-02-16 17:54:31.809653 | ubuntu-noble | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2026-02-16 17:54:32.687382 | ubuntu-noble | Successfully installed cachetools-7.0.1 chardet-5.2.0 colorama-0.4.6 distlib-0.4.0 filelock-3.24.2 packaging-26.0 platformdirs-4.9.2 pluggy-1.6.0 pyproject-api-1.10.0 tox-4.36.0 virtualenv-20.37.0 2026-02-16 17:54:32.867374 | ubuntu-noble | ok: Runtime: 0:00:02.718139 2026-02-16 17:54:32.876091 | 2026-02-16 17:54:32.876158 | TASK [ensure-tox : Export installed tox_executable path] 2026-02-16 17:54:32.912997 | ubuntu-noble | ok 2026-02-16 17:54:32.919599 | 2026-02-16 17:54:32.919685 | TASK [ensure-tox : Output tox version] 2026-02-16 17:54:33.371539 | ubuntu-noble | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2026-02-16 17:54:33.386078 | ubuntu-noble | 4.36.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2026-02-16 17:54:33.468637 | ubuntu-noble | ok: Runtime: 0:00:00.266562 2026-02-16 17:54:33.474079 | 2026-02-16 17:54:33.474144 | TASK [ensure-tox : Make global symlink] 2026-02-16 17:54:33.499452 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:33.509303 | 2026-02-16 17:54:33.509364 | PLAY RECAP 2026-02-16 17:54:33.509425 | ubuntu-noble | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-02-16 17:54:33.509457 | 2026-02-16 17:54:33.646113 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2026-02-16 17:54:33.649023 | PRE-RUN START: [untrusted : github.com/vexxhost/magnum-cluster-api/zuul.d/playbooks/tox/pre.yml@main] 2026-02-16 17:54:34.263930 | 2026-02-16 17:54:34.264083 | PLAY [all] 2026-02-16 17:54:34.276822 | 2026-02-16 17:54:34.276905 | TASK [ensure-rust : Use rustup] 2026-02-16 17:54:34.310601 | ubuntu-noble | ok 2026-02-16 17:54:34.320126 | ubuntu-noble | included: /var/lib/zuul/builds/4ea781caf91f4b77a6c8059339e395da/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-rust/tasks/rustup.yaml 2026-02-16 17:54:34.326940 | 2026-02-16 17:54:34.327015 | TASK [ensure-rust : Install Rust] 2026-02-16 17:54:34.723862 | ubuntu-noble | /bin/bash: line 2: curl: command not found 2026-02-16 17:54:34.865001 | ubuntu-noble | ERROR 2026-02-16 17:54:34.865328 | ubuntu-noble | { 2026-02-16 17:54:34.865392 | ubuntu-noble | "delta": "0:00:00.007882", 2026-02-16 17:54:34.865442 | ubuntu-noble | "end": "2026-02-16 17:54:34.725410", 2026-02-16 17:54:34.865486 | ubuntu-noble | "msg": "non-zero return code", 2026-02-16 17:54:34.865525 | ubuntu-noble | "rc": 127, 2026-02-16 17:54:34.865564 | ubuntu-noble | "start": "2026-02-16 17:54:34.717528" 2026-02-16 17:54:34.865607 | ubuntu-noble | } failure 2026-02-16 17:54:34.867872 | 2026-02-16 17:54:34.867922 | PLAY RECAP 2026-02-16 17:54:34.867975 | ubuntu-noble | ok: 1 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-02-16 17:54:34.867995 | 2026-02-16 17:54:35.004757 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/magnum-cluster-api/zuul.d/playbooks/tox/pre.yml@main] 2026-02-16 17:54:35.006144 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2026-02-16 17:54:35.567553 | 2026-02-16 17:54:35.567709 | PLAY [all] 2026-02-16 17:54:35.580363 | 2026-02-16 17:54:35.580441 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-02-16 17:54:35.625779 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:35.633118 | 2026-02-16 17:54:35.633234 | TASK [fetch-tox-output : Set tox log path for single node] 2026-02-16 17:54:35.674345 | ubuntu-noble | ok 2026-02-16 17:54:35.681432 | 2026-02-16 17:54:35.681505 | TASK [fetch-tox-output : Ensure local tox dir] 2026-02-16 17:54:36.041506 | ubuntu-noble -> localhost | changed 2026-02-16 17:54:36.053086 | 2026-02-16 17:54:36.053188 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-02-16 17:54:36.099193 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:36.110977 | 2026-02-16 17:54:36.111050 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 17:54:36.156022 | ubuntu-noble | ok 2026-02-16 17:54:36.166025 | 2026-02-16 17:54:36.166094 | TASK [fetch-tox-output : Get tox version] 2026-02-16 17:54:36.755554 | ubuntu-noble | ROOT: No loadable tox.ini or setup.cfg or pyproject.toml or tox.toml found, assuming empty tox.ini at /home/zuul 2026-02-16 17:54:36.769679 | ubuntu-noble | 4.36.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2026-02-16 17:54:37.209262 | ubuntu-noble | ok: Runtime: 0:00:00.258642 2026-02-16 17:54:37.214494 | 2026-02-16 17:54:37.214561 | TASK [fetch-tox-output : Find all default environments] 2026-02-16 17:54:37.742929 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:37.755325 | 2026-02-16 17:54:37.755480 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 17:54:37.780511 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:37.793051 | 2026-02-16 17:54:37.793204 | TASK [fetch-tox-output : Find all default environments] 2026-02-16 17:54:38.323464 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:38.333522 | 2026-02-16 17:54:38.333616 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 17:54:38.358721 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:38.370122 | 2026-02-16 17:54:38.370211 | LOOP [fetch-tox-output : Copy tox logs] 2026-02-16 17:54:38.409844 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:38.428720 | 2026-02-16 17:54:38.428917 | LOOP [fetch-tox-output : Collect tox logs] 2026-02-16 17:54:39.156704 | ubuntu-noble | ok: 2026-02-16 17:54:39.156946 | 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-16 17:54:39.157026 | ubuntu-noble | rsync error: some files/attrs were not transferred (see previous errors) (code 23) at main.c(1865) [Receiver=3.2.7] 2026-02-16 17:54:39.157060 | ubuntu-noble | rsync: [Receiver] write error: Broken pipe (32) 2026-02-16 17:54:39.157097 | 2026-02-16 17:54:39.174825 | 2026-02-16 17:54:39.174975 | PLAY RECAP 2026-02-16 17:54:39.175056 | ubuntu-noble | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-02-16 17:54:39.175146 | 2026-02-16 17:54:39.342959 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2026-02-16 17:54:39.344637 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-16 17:54:39.900634 | 2026-02-16 17:54:39.900775 | PLAY [all] 2026-02-16 17:54:39.913184 | 2026-02-16 17:54:39.913266 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-02-16 17:54:40.091151 | ubuntu-noble | changed: non-zero return code 2026-02-16 17:54:40.096703 | 2026-02-16 17:54:40.096781 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-02-16 17:54:40.122595 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:40.133553 | 2026-02-16 17:54:40.133623 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-02-16 17:54:40.169367 | 2026-02-16 17:54:40.169507 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-02-16 17:54:40.204518 | 2026-02-16 17:54:40.204656 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-02-16 17:54:40.229677 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:40.240699 | 2026-02-16 17:54:40.240772 | LOOP [fetch-subunit-output : Generate subunit file] 2026-02-16 17:54:40.276164 | 2026-02-16 17:54:40.276295 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-02-16 17:54:40.301183 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:40.315550 | 2026-02-16 17:54:40.315623 | TASK [fetch-subunit-output : Remove the temporary file] 2026-02-16 17:54:40.340753 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:40.352540 | 2026-02-16 17:54:40.352680 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-02-16 17:54:40.378835 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:40.388894 | 2026-02-16 17:54:40.389062 | PLAY RECAP 2026-02-16 17:54:40.389134 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-16 17:54:40.389165 | 2026-02-16 17:54:40.528632 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-16 17:54:40.531280 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main] 2026-02-16 17:54:41.096343 | 2026-02-16 17:54:41.096494 | PLAY [all] 2026-02-16 17:54:41.108789 | 2026-02-16 17:54:41.108870 | TASK [fetch-output : Set log path for multiple nodes] 2026-02-16 17:54:41.155129 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:54:41.166772 | 2026-02-16 17:54:41.166868 | TASK [fetch-output : Set log path for single node] 2026-02-16 17:54:41.211298 | ubuntu-noble | ok 2026-02-16 17:54:41.217421 | 2026-02-16 17:54:41.217491 | LOOP [fetch-output : Ensure local output dirs] 2026-02-16 17:54:41.605215 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/4ea781caf91f4b77a6c8059339e395da/work/logs" 2026-02-16 17:54:41.828295 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/4ea781caf91f4b77a6c8059339e395da/work/artifacts" 2026-02-16 17:54:42.036490 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/4ea781caf91f4b77a6c8059339e395da/work/docs" 2026-02-16 17:54:42.061205 | 2026-02-16 17:54:42.061393 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-16 17:54:42.711942 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 17:54:42.712211 | ubuntu-noble | changed: All items complete 2026-02-16 17:54:42.712239 | 2026-02-16 17:54:43.193067 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 17:54:43.669439 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 17:54:43.690587 | 2026-02-16 17:54:43.690726 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-02-16 17:54:44.101884 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.008078 2026-02-16 17:54:44.327697 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.006677 2026-02-16 17:54:44.344768 | 2026-02-16 17:54:44.344887 | PLAY [all] 2026-02-16 17:54:44.353942 | 2026-02-16 17:54:44.354029 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-02-16 17:54:44.856567 | ubuntu-noble | changed 2026-02-16 17:54:44.864004 | 2026-02-16 17:54:44.864068 | PLAY RECAP 2026-02-16 17:54:44.864120 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-02-16 17:54:44.864142 | 2026-02-16 17:54:45.007896 | POST-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main] 2026-02-16 17:54:45.010590 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post-logs.yaml@main] 2026-02-16 17:54:45.605437 | 2026-02-16 17:54:45.605603 | PLAY [localhost] 2026-02-16 17:54:45.616653 | 2026-02-16 17:54:45.616725 | TASK [Generate Zuul manifest] 2026-02-16 17:54:45.639445 | localhost | ok 2026-02-16 17:54:45.657168 | 2026-02-16 17:54:45.657299 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-16 17:54:45.972070 | localhost | changed 2026-02-16 17:54:45.985300 | 2026-02-16 17:54:45.985377 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-16 17:54:46.016210 | localhost | ok 2026-02-16 17:54:46.026627 | 2026-02-16 17:54:46.026695 | TASK [Upload logs] 2026-02-16 17:54:46.045850 | localhost | ok 2026-02-16 17:54:46.105377 | 2026-02-16 17:54:46.105476 | TASK [Set zuul-log-path fact] 2026-02-16 17:54:46.126208 | localhost | ok 2026-02-16 17:54:46.137394 | 2026-02-16 17:54:46.137460 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-16 17:54:46.167297 | localhost | ok 2026-02-16 17:54:46.176110 | 2026-02-16 17:54:46.176181 | TASK [upload-logs : Create log directories] 2026-02-16 17:54:46.607601 | localhost | changed 2026-02-16 17:54:46.613727 | 2026-02-16 17:54:46.613856 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-02-16 17:54:47.027929 | localhost -> localhost | ok: Runtime: 0:00:00.005865 2026-02-16 17:54:47.033208 | 2026-02-16 17:54:47.033275 | TASK [upload-logs : Upload logs to log server] 2026-02-16 17:54:47.502229 | localhost | Output suppressed because no_log was given 2026-02-16 17:54:47.507468 | 2026-02-16 17:54:47.507559 | LOOP [upload-logs : Compress console log and json output] 2026-02-16 17:54:47.555945 | localhost | skipping: Conditional result was False 2026-02-16 17:54:47.565365 | localhost | skipping: Conditional result was False 2026-02-16 17:54:47.581694 | 2026-02-16 17:54:47.581855 | LOOP [upload-logs : Upload compressed console log and json output] 2026-02-16 17:54:47.625149 | localhost | skipping: Conditional result was False 2026-02-16 17:54:47.625586 | 2026-02-16 17:54:47.628230 | localhost | skipping: Conditional result was False 2026-02-16 17:54:47.644994 | 2026-02-16 17:54:47.645143 | LOOP [upload-logs : Upload console log and json output]