2026-02-16 19:20:30.591643 | Job console starting 2026-02-16 19:20:30.599641 | Updating git repos 2026-02-16 19:20:30.631190 | Cloning repos into workspace 2026-02-16 19:20:30.692416 | Restoring repo states 2026-02-16 19:20:30.726048 | Merging changes 2026-02-16 19:20:31.165402 | Checking out repos 2026-02-16 19:20:31.215317 | Preparing playbooks 2026-02-16 19:20:32.305998 | Running Ansible setup 2026-02-16 19:20:35.893752 | PRE-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main] 2026-02-16 19:20:36.568205 | 2026-02-16 19:20:36.568370 | PLAY [localhost] 2026-02-16 19:20:36.577425 | 2026-02-16 19:20:36.577564 | TASK [Gathering Facts] 2026-02-16 19:20:37.465141 | localhost | ok 2026-02-16 19:20:37.475225 | 2026-02-16 19:20:37.475401 | TASK [Setup log path fact] 2026-02-16 19:20:37.495400 | localhost | ok 2026-02-16 19:20:37.508361 | 2026-02-16 19:20:37.508493 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-16 19:20:37.538893 | localhost | ok 2026-02-16 19:20:37.547058 | 2026-02-16 19:20:37.547143 | TASK [emit-job-header : Print job information] 2026-02-16 19:20:37.591992 | # Job Information 2026-02-16 19:20:37.592217 | Ansible Version: 2.16.15 2026-02-16 19:20:37.592265 | Job: magnum-cluster-api-tox-unit 2026-02-16 19:20:37.592297 | Pipeline: check 2026-02-16 19:20:37.592325 | Executor: 3a2793d2bd32 2026-02-16 19:20:37.592353 | Triggered by: https://github.com/vexxhost/magnum-cluster-api/pull/884 2026-02-16 19:20:37.592385 | Event ID: 036266b0-0b6c-11f1-9c94-e50e60db5a7d 2026-02-16 19:20:37.596390 | 2026-02-16 19:20:37.596481 | LOOP [emit-job-header : Print node information] 2026-02-16 19:20:37.704661 | localhost | ok: 2026-02-16 19:20:37.704944 | localhost | # Node Information 2026-02-16 19:20:37.705046 | localhost | Inventory Hostname: ubuntu-noble 2026-02-16 19:20:37.705106 | localhost | Hostname: np0000155681 2026-02-16 19:20:37.705161 | localhost | Username: zuul 2026-02-16 19:20:37.705239 | localhost | Distro: Ubuntu 24.04 2026-02-16 19:20:37.705302 | localhost | Provider: yul1 2026-02-16 19:20:37.705356 | localhost | Region: ca-ymq-1 2026-02-16 19:20:37.705407 | localhost | Label: ubuntu-noble 2026-02-16 19:20:37.705463 | localhost | Product Name: OpenStack Nova 2026-02-16 19:20:37.705514 | localhost | Interface IP: 162.253.55.49 2026-02-16 19:20:37.728321 | 2026-02-16 19:20:37.728475 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-16 19:20:38.170893 | localhost -> localhost | changed 2026-02-16 19:20:38.178673 | 2026-02-16 19:20:38.178838 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-16 19:20:39.112472 | localhost -> localhost | changed 2026-02-16 19:20:39.124271 | 2026-02-16 19:20:39.124450 | PLAY [all] 2026-02-16 19:20:39.136635 | 2026-02-16 19:20:39.136745 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-16 19:20:39.395677 | ubuntu-noble -> localhost | ok 2026-02-16 19:20:39.407496 | 2026-02-16 19:20:39.407619 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-16 19:20:39.440837 | ubuntu-noble | ok 2026-02-16 19:20:39.456544 | ubuntu-noble | included: /var/lib/zuul/builds/f5e26ad279d54446a12e44b58c26f095/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-16 19:20:39.463346 | 2026-02-16 19:20:39.463414 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-16 19:20:40.227663 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2026-02-16 19:20:40.227903 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/f5e26ad279d54446a12e44b58c26f095/work/f5e26ad279d54446a12e44b58c26f095_id_rsa 2026-02-16 19:20:40.227957 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/f5e26ad279d54446a12e44b58c26f095/work/f5e26ad279d54446a12e44b58c26f095_id_rsa.pub 2026-02-16 19:20:40.227986 | ubuntu-noble -> localhost | The key fingerprint is: 2026-02-16 19:20:40.228040 | ubuntu-noble -> localhost | SHA256:UvocgFkxkz4CvZpL0tAXD/6/+KYU/dBqOHPgZ4DJD2w zuul-build-sshkey 2026-02-16 19:20:40.228113 | ubuntu-noble -> localhost | The key's randomart image is: 2026-02-16 19:20:40.228147 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2026-02-16 19:20:40.228198 | ubuntu-noble -> localhost | | . =o | 2026-02-16 19:20:40.228225 | ubuntu-noble -> localhost | | . ++.o | 2026-02-16 19:20:40.228246 | ubuntu-noble -> localhost | | . oo*. . | 2026-02-16 19:20:40.228290 | ubuntu-noble -> localhost | |. .o=o+= . | 2026-02-16 19:20:40.228310 | ubuntu-noble -> localhost | | o +Eo*.S . | 2026-02-16 19:20:40.228346 | ubuntu-noble -> localhost | |. =. +.O = | 2026-02-16 19:20:40.228372 | ubuntu-noble -> localhost | | o . B.O . | 2026-02-16 19:20:40.228392 | ubuntu-noble -> localhost | | . . Oo | 2026-02-16 19:20:40.228472 | ubuntu-noble -> localhost | | o+o. | 2026-02-16 19:20:40.228536 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2026-02-16 19:20:40.228595 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.277764 2026-02-16 19:20:40.237572 | 2026-02-16 19:20:40.237658 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-16 19:20:40.273208 | ubuntu-noble | ok 2026-02-16 19:20:40.284150 | ubuntu-noble | included: /var/lib/zuul/builds/f5e26ad279d54446a12e44b58c26f095/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-16 19:20:40.292199 | 2026-02-16 19:20:40.292260 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-16 19:20:40.316719 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:40.327354 | 2026-02-16 19:20:40.327459 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-16 19:20:40.871142 | ubuntu-noble | changed 2026-02-16 19:20:40.878599 | 2026-02-16 19:20:40.878677 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-16 19:20:41.097821 | ubuntu-noble | ok 2026-02-16 19:20:41.103973 | 2026-02-16 19:20:41.104083 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-16 19:20:41.667005 | ubuntu-noble | changed 2026-02-16 19:20:41.674451 | 2026-02-16 19:20:41.674567 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-16 19:20:42.309554 | ubuntu-noble | changed 2026-02-16 19:20:42.352593 | 2026-02-16 19:20:42.352720 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-16 19:20:42.377746 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:42.388226 | 2026-02-16 19:20:42.388332 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-16 19:20:42.803450 | ubuntu-noble -> localhost | changed 2026-02-16 19:20:42.820522 | 2026-02-16 19:20:42.820666 | TASK [add-build-sshkey : Add back temp key] 2026-02-16 19:20:43.156544 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/f5e26ad279d54446a12e44b58c26f095/work/f5e26ad279d54446a12e44b58c26f095_id_rsa (zuul-build-sshkey) 2026-02-16 19:20:43.156764 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.013526 2026-02-16 19:20:43.166166 | 2026-02-16 19:20:43.166287 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-16 19:20:43.518607 | ubuntu-noble | ok 2026-02-16 19:20:43.526313 | 2026-02-16 19:20:43.526468 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-16 19:20:43.551857 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:43.568202 | 2026-02-16 19:20:43.568344 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-02-16 19:20:43.980079 | ubuntu-noble | ok 2026-02-16 19:20:43.989774 | 2026-02-16 19:20:43.989913 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-02-16 19:20:45.160936 | ubuntu-noble | Output suppressed because no_log was given 2026-02-16 19:20:45.172088 | 2026-02-16 19:20:45.172204 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-02-16 19:20:45.385873 | ubuntu-noble | ok: "logs" 2026-02-16 19:20:45.386626 | ubuntu-noble | ok: All items complete 2026-02-16 19:20:45.386904 | 2026-02-16 19:20:45.611690 | ubuntu-noble | ok: "artifacts" 2026-02-16 19:20:45.763248 | ubuntu-noble | ok: "docs" 2026-02-16 19:20:45.784013 | 2026-02-16 19:20:45.784214 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-02-16 19:20:46.010424 | ubuntu-noble | changed: "logs" 2026-02-16 19:20:46.192086 | ubuntu-noble | changed: "artifacts" 2026-02-16 19:20:46.382330 | ubuntu-noble | changed: "docs" 2026-02-16 19:20:46.403428 | 2026-02-16 19:20:46.403571 | PLAY RECAP 2026-02-16 19:20:46.403621 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-16 19:20:46.403652 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-02-16 19:20:46.403675 | 2026-02-16 19:20:46.587196 | PRE-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main] 2026-02-16 19:20:46.589753 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-16 19:20:47.224655 | 2026-02-16 19:20:47.224823 | PLAY [all] 2026-02-16 19:20:47.238582 | 2026-02-16 19:20:47.238805 | TASK [Install binary dependencies] 2026-02-16 19:20:47.294363 | ubuntu-noble | ok 2026-02-16 19:20:47.321301 | 2026-02-16 19:20:47.321504 | TASK [bindep : Include find tasks] 2026-02-16 19:20:47.355556 | ubuntu-noble | ok 2026-02-16 19:20:47.364873 | ubuntu-noble | included: /var/lib/zuul/builds/f5e26ad279d54446a12e44b58c26f095/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-02-16 19:20:47.371375 | 2026-02-16 19:20:47.371459 | TASK [bindep : Look for bindep.txt] 2026-02-16 19:20:47.750470 | ubuntu-noble | ok 2026-02-16 19:20:47.758539 | 2026-02-16 19:20:47.758676 | TASK [bindep : Define bindep_file fact] 2026-02-16 19:20:47.783560 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:47.793394 | 2026-02-16 19:20:47.793562 | TASK [bindep : Look for other-requirements.txt] 2026-02-16 19:20:48.001834 | ubuntu-noble | ok 2026-02-16 19:20:48.008553 | 2026-02-16 19:20:48.008675 | TASK [bindep : Define bindep_file fact] 2026-02-16 19:20:48.033274 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:48.043010 | 2026-02-16 19:20:48.043148 | TASK [bindep : Look for bindep fallback file] 2026-02-16 19:20:48.068335 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:48.078888 | 2026-02-16 19:20:48.079050 | TASK [bindep : Define bindep_file fact] 2026-02-16 19:20:48.104581 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:48.113469 | 2026-02-16 19:20:48.113646 | TASK [bindep : Include bindep tasks] 2026-02-16 19:20:48.139351 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:48.148009 | 2026-02-16 19:20:48.148187 | TASK [bindep : Include install tasks] 2026-02-16 19:20:48.173979 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:48.182610 | 2026-02-16 19:20:48.182791 | LOOP [bindep : Include package tasks] 2026-02-16 19:20:48.243784 | 2026-02-16 19:20:48.244024 | TASK [Run test-setup role] 2026-02-16 19:20:48.269276 | ubuntu-noble | ok 2026-02-16 19:20:48.286727 | 2026-02-16 19:20:48.286800 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-02-16 19:20:48.494897 | ubuntu-noble | ok 2026-02-16 19:20:48.501418 | 2026-02-16 19:20:48.501599 | TASK [test-setup : Run tools/test-setup.sh] 2026-02-16 19:20:49.033590 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:49.046081 | 2026-02-16 19:20:49.046221 | PLAY RECAP 2026-02-16 19:20:49.046282 | ubuntu-noble | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-16 19:20:49.046314 | 2026-02-16 19:20:49.197185 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-16 19:20:49.199899 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2026-02-16 19:20:49.848990 | 2026-02-16 19:20:49.849164 | PLAY [all] 2026-02-16 19:20:49.864013 | 2026-02-16 19:20:49.864136 | TASK [ensure-python : Validate python_version value] 2026-02-16 19:20:49.889296 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:49.900110 | 2026-02-16 19:20:49.900198 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)] 2026-02-16 19:20:49.925143 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:49.937253 | 2026-02-16 19:20:49.937356 | TASK [ensure-python : Pull in venv package] 2026-02-16 19:20:49.962719 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:49.975381 | 2026-02-16 19:20:49.975537 | TASK [ensure-python : Set default RPM package name] 2026-02-16 19:20:50.000812 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:50.009798 | 2026-02-16 19:20:50.009904 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9/10] 2026-02-16 19:20:50.035150 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:50.041717 | 2026-02-16 19:20:50.041799 | TASK [ensure-python : Install RPM package] 2026-02-16 19:20:50.066934 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:50.078915 | 2026-02-16 19:20:50.079016 | TASK [ensure-python : Install python using pyenv] 2026-02-16 19:20:50.104598 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:50.115832 | 2026-02-16 19:20:50.115935 | TASK [ensure-python : Activate python using stow] 2026-02-16 19:20:50.151811 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:20:50.168668 | 2026-02-16 19:20:50.168740 | TASK [Install pip] 2026-02-16 19:20:50.200534 | ubuntu-noble | ok 2026-02-16 19:20:50.224580 | 2026-02-16 19:20:50.224691 | TASK [ensure-pip : Check if pip is installed] 2026-02-16 19:20:50.759250 | ubuntu-noble | ok: Runtime: 0:00:00.006392 2026-02-16 19:20:50.766002 | 2026-02-16 19:20:50.766074 | LOOP [ensure-pip : Install pip from packages] 2026-02-16 19:20:50.797434 | ubuntu-noble | ok: "/var/lib/zuul/builds/f5e26ad279d54446a12e44b58c26f095/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/Debian.yaml" 2026-02-16 19:20:50.814563 | ubuntu-noble | included: /var/lib/zuul/builds/f5e26ad279d54446a12e44b58c26f095/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/Debian.yaml 2026-02-16 19:20:50.826093 | 2026-02-16 19:20:50.826179 | TASK [ensure-pip : Update package lists] 2026-02-16 19:20:57.041411 | ubuntu-noble | changed 2026-02-16 19:20:57.048029 | 2026-02-16 19:20:57.048097 | TASK [ensure-pip : Install Python 3 pip] 2026-02-16 19:21:02.405999 | ubuntu-noble | changed 2026-02-16 19:21:02.413261 | 2026-02-16 19:21:02.413402 | TASK [ensure-pip : Install Python 2 pip] 2026-02-16 19:21:02.438289 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:02.453730 | 2026-02-16 19:21:02.453899 | TASK [ensure-pip : Ensure setuptools] 2026-02-16 19:21:02.478824 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:02.494019 | 2026-02-16 19:21:02.494173 | TASK [ensure-pip : Check for ensurepip module] 2026-02-16 19:21:02.782604 | ubuntu-noble | usage: python -m ensurepip [-h] [--version] [-v] [-U] [--user] [--root ROOT] 2026-02-16 19:21:02.782781 | ubuntu-noble | [--altinstall] [--default-pip] 2026-02-16 19:21:02.782797 | ubuntu-noble | 2026-02-16 19:21:02.782808 | ubuntu-noble | options: 2026-02-16 19:21:02.782819 | ubuntu-noble | -h, --help show this help message and exit 2026-02-16 19:21:02.782836 | ubuntu-noble | --version Show the version of pip that is bundled with this Python. 2026-02-16 19:21:02.782849 | ubuntu-noble | -v, --verbose Give more output. Option is additive, and can be used up to 3 2026-02-16 19:21:02.782864 | ubuntu-noble | times. 2026-02-16 19:21:02.782873 | ubuntu-noble | -U, --upgrade Upgrade pip and dependencies, even if already installed. 2026-02-16 19:21:02.782882 | ubuntu-noble | --user Install using the user scheme. 2026-02-16 19:21:02.782892 | ubuntu-noble | --root ROOT Install everything relative to this alternate root directory. 2026-02-16 19:21:02.782901 | ubuntu-noble | --altinstall Make an alternate install, installing only the X.Y versioned 2026-02-16 19:21:02.782910 | ubuntu-noble | scripts (Default: pipX, pipX.Y). 2026-02-16 19:21:02.782919 | ubuntu-noble | --default-pip Make a default pip install, installing the unqualified pip in 2026-02-16 19:21:02.782927 | ubuntu-noble | addition to the versioned scripts. 2026-02-16 19:21:03.052608 | ubuntu-noble | ok: Runtime: 0:00:00.064495 2026-02-16 19:21:03.059337 | 2026-02-16 19:21:03.059511 | TASK [ensure-pip : Ensure python3-venv] 2026-02-16 19:21:03.085683 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:03.095210 | 2026-02-16 19:21:03.095463 | TASK [ensure-pip : Install pip from source] 2026-02-16 19:21:03.121764 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:03.182880 | 2026-02-16 19:21:03.183039 | TASK [ensure-pip : Probe for venv python full path] 2026-02-16 19:21:03.409820 | ubuntu-noble | /usr/bin/python3 2026-02-16 19:21:03.725769 | ubuntu-noble | ok: Runtime: 0:00:00.006999 2026-02-16 19:21:03.731921 | 2026-02-16 19:21:03.732035 | TASK [ensure-pip : Set host default] 2026-02-16 19:21:03.787041 | ubuntu-noble | ok 2026-02-16 19:21:03.794557 | 2026-02-16 19:21:03.794661 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2026-02-16 19:21:03.864487 | ubuntu-noble | ok 2026-02-16 19:21:03.874276 | 2026-02-16 19:21:03.874388 | TASK [ensure-tox : Check if tox is installed] 2026-02-16 19:21:04.412335 | ubuntu-noble | ok: Runtime: 0:00:00.004672 2026-02-16 19:21:04.419006 | 2026-02-16 19:21:04.419154 | TASK [ensure-tox : Export preinstalled tox_exectuable] 2026-02-16 19:21:04.444743 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:04.455780 | 2026-02-16 19:21:04.455951 | TASK [ensure-tox : Create local venv] 2026-02-16 19:21:07.997760 | ubuntu-noble | ok: Runtime: 0:00:03.115676 2026-02-16 19:21:08.004809 | 2026-02-16 19:21:08.004885 | TASK [ensure-tox : Install tox to local venv] 2026-02-16 19:21:08.816205 | ubuntu-noble | Collecting tox 2026-02-16 19:21:08.868128 | ubuntu-noble | Downloading tox-4.36.0-py3-none-any.whl.metadata (3.6 kB) 2026-02-16 19:21:08.933262 | ubuntu-noble | Collecting cachetools>=7.0.1 (from tox) 2026-02-16 19:21:08.936909 | ubuntu-noble | Downloading cachetools-7.0.1-py3-none-any.whl.metadata (5.6 kB) 2026-02-16 19:21:08.980385 | ubuntu-noble | Collecting chardet>=5.2 (from tox) 2026-02-16 19:21:08.984116 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl.metadata (3.4 kB) 2026-02-16 19:21:09.041867 | ubuntu-noble | Collecting colorama>=0.4.6 (from tox) 2026-02-16 19:21:09.046116 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2026-02-16 19:21:09.104710 | ubuntu-noble | Collecting filelock>=3.24 (from tox) 2026-02-16 19:21:09.107878 | ubuntu-noble | Downloading filelock-3.24.2-py3-none-any.whl.metadata (2.0 kB) 2026-02-16 19:21:09.160043 | ubuntu-noble | Collecting packaging>=26 (from tox) 2026-02-16 19:21:09.163553 | ubuntu-noble | Downloading packaging-26.0-py3-none-any.whl.metadata (3.3 kB) 2026-02-16 19:21:09.220886 | ubuntu-noble | Collecting platformdirs>=4.9.1 (from tox) 2026-02-16 19:21:09.224273 | ubuntu-noble | Downloading platformdirs-4.9.2-py3-none-any.whl.metadata (4.7 kB) 2026-02-16 19:21:09.270336 | ubuntu-noble | Collecting pluggy>=1.6 (from tox) 2026-02-16 19:21:09.275708 | ubuntu-noble | Downloading pluggy-1.6.0-py3-none-any.whl.metadata (4.8 kB) 2026-02-16 19:21:09.321300 | ubuntu-noble | Collecting pyproject-api>=1.10 (from tox) 2026-02-16 19:21:09.326038 | ubuntu-noble | Downloading pyproject_api-1.10.0-py3-none-any.whl.metadata (2.7 kB) 2026-02-16 19:21:09.444728 | ubuntu-noble | Collecting virtualenv>=20.36.1 (from tox) 2026-02-16 19:21:09.447881 | ubuntu-noble | Downloading virtualenv-20.37.0-py3-none-any.whl.metadata (5.1 kB) 2026-02-16 19:21:09.535614 | ubuntu-noble | Collecting distlib<1,>=0.3.7 (from virtualenv>=20.36.1->tox) 2026-02-16 19:21:09.539225 | ubuntu-noble | Downloading distlib-0.4.0-py2.py3-none-any.whl.metadata (5.2 kB) 2026-02-16 19:21:09.575542 | ubuntu-noble | Downloading tox-4.36.0-py3-none-any.whl (179 kB) 2026-02-16 19:21:09.596680 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 179.1/179.1 kB 10.2 MB/s eta 0:00:00 2026-02-16 19:21:09.600150 | ubuntu-noble | Downloading cachetools-7.0.1-py3-none-any.whl (13 kB) 2026-02-16 19:21:09.615577 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2026-02-16 19:21:09.631869 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 15.3 MB/s eta 0:00:00 2026-02-16 19:21:09.636590 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-02-16 19:21:09.648414 | ubuntu-noble | Downloading filelock-3.24.2-py3-none-any.whl (24 kB) 2026-02-16 19:21:09.662657 | ubuntu-noble | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-02-16 19:21:09.676587 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 5.7 MB/s eta 0:00:00 2026-02-16 19:21:09.679987 | ubuntu-noble | Downloading platformdirs-4.9.2-py3-none-any.whl (21 kB) 2026-02-16 19:21:09.694395 | ubuntu-noble | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-02-16 19:21:09.705725 | ubuntu-noble | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-02-16 19:21:09.720471 | ubuntu-noble | Downloading virtualenv-20.37.0-py3-none-any.whl (5.8 MB) 2026-02-16 19:21:09.803873 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.8/5.8 MB 72.7 MB/s eta 0:00:00 2026-02-16 19:21:09.808642 | ubuntu-noble | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-02-16 19:21:09.832235 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 24.9 MB/s eta 0:00:00 2026-02-16 19:21:09.910489 | ubuntu-noble | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2026-02-16 19:21:10.777767 | 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 19:21:11.048330 | ubuntu-noble | ok: Runtime: 0:00:02.634250 2026-02-16 19:21:11.057489 | 2026-02-16 19:21:11.057562 | TASK [ensure-tox : Export installed tox_executable path] 2026-02-16 19:21:11.092811 | ubuntu-noble | ok 2026-02-16 19:21:11.099523 | 2026-02-16 19:21:11.099597 | TASK [ensure-tox : Output tox version] 2026-02-16 19:21:11.580221 | 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 19:21:11.594034 | ubuntu-noble | 4.36.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2026-02-16 19:21:11.674218 | ubuntu-noble | ok: Runtime: 0:00:00.290393 2026-02-16 19:21:11.681887 | 2026-02-16 19:21:11.682116 | TASK [ensure-tox : Make global symlink] 2026-02-16 19:21:11.707889 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:11.719839 | 2026-02-16 19:21:11.719976 | PLAY RECAP 2026-02-16 19:21:11.720060 | ubuntu-noble | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-02-16 19:21:11.720113 | 2026-02-16 19:21:11.904681 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2026-02-16 19:21:11.906615 | PRE-RUN START: [untrusted : github.com/vexxhost/magnum-cluster-api/zuul.d/playbooks/tox/pre.yml@main] 2026-02-16 19:21:12.608324 | 2026-02-16 19:21:12.608487 | PLAY [all] 2026-02-16 19:21:12.624503 | 2026-02-16 19:21:12.624736 | TASK [ensure-rust : Use rustup] 2026-02-16 19:21:12.651436 | ubuntu-noble | ok 2026-02-16 19:21:12.659036 | ubuntu-noble | included: /var/lib/zuul/builds/f5e26ad279d54446a12e44b58c26f095/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-rust/tasks/rustup.yaml 2026-02-16 19:21:12.666242 | 2026-02-16 19:21:12.666410 | TASK [ensure-rust : Install Rust] 2026-02-16 19:21:13.069360 | ubuntu-noble | /bin/bash: line 2: curl: command not found 2026-02-16 19:21:13.209193 | ubuntu-noble | ERROR 2026-02-16 19:21:13.209458 | ubuntu-noble | { 2026-02-16 19:21:13.209489 | ubuntu-noble | "delta": "0:00:00.007637", 2026-02-16 19:21:13.209514 | ubuntu-noble | "end": "2026-02-16 19:21:13.070555", 2026-02-16 19:21:13.209534 | ubuntu-noble | "msg": "non-zero return code", 2026-02-16 19:21:13.209553 | ubuntu-noble | "rc": 127, 2026-02-16 19:21:13.209572 | ubuntu-noble | "start": "2026-02-16 19:21:13.062918" 2026-02-16 19:21:13.209596 | ubuntu-noble | } failure 2026-02-16 19:21:13.211242 | 2026-02-16 19:21:13.211302 | PLAY RECAP 2026-02-16 19:21:13.211356 | ubuntu-noble | ok: 1 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-02-16 19:21:13.211382 | 2026-02-16 19:21:13.372750 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/magnum-cluster-api/zuul.d/playbooks/tox/pre.yml@main] 2026-02-16 19:21:13.375460 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2026-02-16 19:21:14.059093 | 2026-02-16 19:21:14.059305 | PLAY [all] 2026-02-16 19:21:14.073852 | 2026-02-16 19:21:14.074050 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-02-16 19:21:14.120297 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:14.129894 | 2026-02-16 19:21:14.130088 | TASK [fetch-tox-output : Set tox log path for single node] 2026-02-16 19:21:14.173388 | ubuntu-noble | ok 2026-02-16 19:21:14.182492 | 2026-02-16 19:21:14.182647 | TASK [fetch-tox-output : Ensure local tox dir] 2026-02-16 19:21:14.607088 | ubuntu-noble -> localhost | changed 2026-02-16 19:21:14.618115 | 2026-02-16 19:21:14.618211 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-02-16 19:21:14.663243 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:14.673008 | 2026-02-16 19:21:14.673167 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 19:21:14.717252 | ubuntu-noble | ok 2026-02-16 19:21:14.724294 | 2026-02-16 19:21:14.724391 | TASK [fetch-tox-output : Get tox version] 2026-02-16 19:21:15.309435 | 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 19:21:15.323677 | ubuntu-noble | 4.36.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2026-02-16 19:21:15.765129 | ubuntu-noble | ok: Runtime: 0:00:00.258698 2026-02-16 19:21:15.772597 | 2026-02-16 19:21:15.772819 | TASK [fetch-tox-output : Find all default environments] 2026-02-16 19:21:16.307556 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:16.317419 | 2026-02-16 19:21:16.317570 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 19:21:16.342695 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:16.352851 | 2026-02-16 19:21:16.353059 | TASK [fetch-tox-output : Find all default environments] 2026-02-16 19:21:16.884875 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:16.896871 | 2026-02-16 19:21:16.897028 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 19:21:16.922245 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:16.932605 | 2026-02-16 19:21:16.932719 | LOOP [fetch-tox-output : Copy tox logs] 2026-02-16 19:21:16.976678 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:16.993417 | 2026-02-16 19:21:16.993606 | LOOP [fetch-tox-output : Collect tox logs] 2026-02-16 19:21:17.766752 | ubuntu-noble | ok: 2026-02-16 19:21:17.767101 | ubuntu-noble | rsync: [sender] change_dir "/home/zuul/src/github.com/vexxhost/magnum-cluster-api/.tox/unit/log" failed: No such file or directory (2) 2026-02-16 19:21:17.767280 | 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 19:21:17.767314 | ubuntu-noble | rsync: [Receiver] write error: Broken pipe (32) 2026-02-16 19:21:17.767345 | 2026-02-16 19:21:17.788692 | 2026-02-16 19:21:17.788869 | PLAY RECAP 2026-02-16 19:21:17.788940 | ubuntu-noble | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-02-16 19:21:17.789000 | 2026-02-16 19:21:17.948345 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2026-02-16 19:21:17.951108 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-16 19:21:18.551853 | 2026-02-16 19:21:18.552033 | PLAY [all] 2026-02-16 19:21:18.568291 | 2026-02-16 19:21:18.568463 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-02-16 19:21:18.757417 | ubuntu-noble | changed: non-zero return code 2026-02-16 19:21:18.764018 | 2026-02-16 19:21:18.764190 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-02-16 19:21:18.789428 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:18.802488 | 2026-02-16 19:21:18.802640 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-02-16 19:21:18.838943 | 2026-02-16 19:21:18.839324 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-02-16 19:21:18.875074 | 2026-02-16 19:21:18.875380 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-02-16 19:21:18.900630 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:18.909916 | 2026-02-16 19:21:18.910049 | LOOP [fetch-subunit-output : Generate subunit file] 2026-02-16 19:21:18.946574 | 2026-02-16 19:21:18.946893 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-02-16 19:21:18.973471 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:18.987343 | 2026-02-16 19:21:18.987526 | TASK [fetch-subunit-output : Remove the temporary file] 2026-02-16 19:21:19.012402 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:19.024621 | 2026-02-16 19:21:19.024773 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-02-16 19:21:19.049440 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:19.061727 | 2026-02-16 19:21:19.061783 | PLAY RECAP 2026-02-16 19:21:19.061837 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-16 19:21:19.061860 | 2026-02-16 19:21:19.211584 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-16 19:21:19.215031 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main] 2026-02-16 19:21:19.871152 | 2026-02-16 19:21:19.871353 | PLAY [all] 2026-02-16 19:21:19.890228 | 2026-02-16 19:21:19.890455 | TASK [fetch-output : Set log path for multiple nodes] 2026-02-16 19:21:19.928627 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 19:21:19.939770 | 2026-02-16 19:21:19.940092 | TASK [fetch-output : Set log path for single node] 2026-02-16 19:21:19.985882 | ubuntu-noble | ok 2026-02-16 19:21:19.992694 | 2026-02-16 19:21:19.992829 | LOOP [fetch-output : Ensure local output dirs] 2026-02-16 19:21:20.405885 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/f5e26ad279d54446a12e44b58c26f095/work/logs" 2026-02-16 19:21:20.646170 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/f5e26ad279d54446a12e44b58c26f095/work/artifacts" 2026-02-16 19:21:20.884845 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/f5e26ad279d54446a12e44b58c26f095/work/docs" 2026-02-16 19:21:20.904861 | 2026-02-16 19:21:20.905021 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-16 19:21:21.599482 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 19:21:21.599731 | ubuntu-noble | changed: All items complete 2026-02-16 19:21:21.599760 | 2026-02-16 19:21:22.088408 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 19:21:22.570825 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 19:21:22.596306 | 2026-02-16 19:21:22.596396 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-02-16 19:21:23.069828 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.007098 2026-02-16 19:21:23.327550 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.010482 2026-02-16 19:21:23.346816 | 2026-02-16 19:21:23.347019 | PLAY [all] 2026-02-16 19:21:23.357472 | 2026-02-16 19:21:23.357623 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-02-16 19:21:23.859917 | ubuntu-noble | changed 2026-02-16 19:21:23.870138 | 2026-02-16 19:21:23.870257 | PLAY RECAP 2026-02-16 19:21:23.870305 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-02-16 19:21:23.870328 | 2026-02-16 19:21:24.022431 | POST-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main] 2026-02-16 19:21:24.025239 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post-logs.yaml@main] 2026-02-16 19:21:24.664638 | 2026-02-16 19:21:24.664782 | PLAY [localhost] 2026-02-16 19:21:24.675627 | 2026-02-16 19:21:24.675722 | TASK [Generate Zuul manifest] 2026-02-16 19:21:24.695960 | localhost | ok 2026-02-16 19:21:24.712621 | 2026-02-16 19:21:24.712806 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-16 19:21:25.075947 | localhost | changed 2026-02-16 19:21:25.089564 | 2026-02-16 19:21:25.089731 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-16 19:21:25.121657 | localhost | ok 2026-02-16 19:21:25.130250 | 2026-02-16 19:21:25.130318 | TASK [Upload logs] 2026-02-16 19:21:25.152462 | localhost | ok 2026-02-16 19:21:25.211931 | 2026-02-16 19:21:25.212055 | TASK [Set zuul-log-path fact] 2026-02-16 19:21:25.229986 | localhost | ok 2026-02-16 19:21:25.240748 | 2026-02-16 19:21:25.240814 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-16 19:21:25.281836 | localhost | ok 2026-02-16 19:21:25.290403 | 2026-02-16 19:21:25.290539 | TASK [upload-logs : Create log directories] 2026-02-16 19:21:25.744034 | localhost | changed 2026-02-16 19:21:25.750752 | 2026-02-16 19:21:25.750899 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-02-16 19:21:26.214327 | localhost -> localhost | ok: Runtime: 0:00:00.005821 2026-02-16 19:21:26.219161 | 2026-02-16 19:21:26.219240 | TASK [upload-logs : Upload logs to log server] 2026-02-16 19:21:26.728641 | localhost | Output suppressed because no_log was given 2026-02-16 19:21:26.732660 | 2026-02-16 19:21:26.732759 | LOOP [upload-logs : Compress console log and json output] 2026-02-16 19:21:26.784991 | localhost | skipping: Conditional result was False 2026-02-16 19:21:26.791874 | localhost | skipping: Conditional result was False 2026-02-16 19:21:26.807699 | 2026-02-16 19:21:26.807891 | LOOP [upload-logs : Upload compressed console log and json output] 2026-02-16 19:21:26.856170 | localhost | skipping: Conditional result was False 2026-02-16 19:21:26.856658 | 2026-02-16 19:21:26.859685 | localhost | skipping: Conditional result was False 2026-02-16 19:21:26.876770 | 2026-02-16 19:21:26.877221 | LOOP [upload-logs : Upload console log and json output]