2026-02-16 17:51:10.968196 | Job console starting 2026-02-16 17:51:10.980748 | Updating git repos 2026-02-16 17:51:11.082569 | Cloning repos into workspace 2026-02-16 17:51:11.505914 | Restoring repo states 2026-02-16 17:51:11.534188 | Merging changes 2026-02-16 17:51:12.364510 | Checking out repos 2026-02-16 17:51:12.463075 | Preparing playbooks 2026-02-16 17:51:14.744824 | Running Ansible setup 2026-02-16 17:51:18.612019 | PRE-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main] 2026-02-16 17:51:19.227573 | 2026-02-16 17:51:19.227720 | PLAY [localhost] 2026-02-16 17:51:19.235663 | 2026-02-16 17:51:19.235734 | TASK [Gathering Facts] 2026-02-16 17:51:20.154065 | localhost | ok 2026-02-16 17:51:20.162604 | 2026-02-16 17:51:20.162684 | TASK [Setup log path fact] 2026-02-16 17:51:20.182727 | localhost | ok 2026-02-16 17:51:20.196135 | 2026-02-16 17:51:20.196229 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-16 17:51:20.227049 | localhost | ok 2026-02-16 17:51:20.236202 | 2026-02-16 17:51:20.236354 | TASK [emit-job-header : Print job information] 2026-02-16 17:51:20.281673 | # Job Information 2026-02-16 17:51:20.281984 | Ansible Version: 2.16.15 2026-02-16 17:51:20.282056 | Job: magnum-cluster-api-tox-functional 2026-02-16 17:51:20.282105 | Pipeline: check 2026-02-16 17:51:20.282151 | Executor: 3a2793d2bd32 2026-02-16 17:51:20.282194 | Triggered by: https://github.com/vexxhost/magnum-cluster-api/pull/884 2026-02-16 17:51:20.282249 | Event ID: ed3be480-0b5f-11f1-9b41-a55389b20acd 2026-02-16 17:51:20.287503 | 2026-02-16 17:51:20.287602 | LOOP [emit-job-header : Print node information] 2026-02-16 17:51:20.387555 | localhost | ok: 2026-02-16 17:51:20.387862 | localhost | # Node Information 2026-02-16 17:51:20.387925 | localhost | Inventory Hostname: ubuntu-noble 2026-02-16 17:51:20.387976 | localhost | Hostname: np0000155644 2026-02-16 17:51:20.388021 | localhost | Username: zuul 2026-02-16 17:51:20.388071 | localhost | Distro: Ubuntu 24.04 2026-02-16 17:51:20.388115 | localhost | Provider: yul1 2026-02-16 17:51:20.388159 | localhost | Region: ca-ymq-1 2026-02-16 17:51:20.388200 | localhost | Label: ubuntu-noble 2026-02-16 17:51:20.388243 | localhost | Product Name: OpenStack Nova 2026-02-16 17:51:20.388284 | localhost | Interface IP: 162.253.55.195 2026-02-16 17:51:20.401653 | 2026-02-16 17:51:20.401817 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-16 17:51:20.791330 | localhost -> localhost | changed 2026-02-16 17:51:20.797138 | 2026-02-16 17:51:20.797226 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-16 17:51:21.876243 | localhost -> localhost | changed 2026-02-16 17:51:21.882865 | 2026-02-16 17:51:21.882925 | PLAY [all] 2026-02-16 17:51:21.905737 | 2026-02-16 17:51:22.097072 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-16 17:51:22.365675 | ubuntu-noble -> localhost | ok 2026-02-16 17:51:22.373459 | 2026-02-16 17:51:22.373530 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-16 17:51:22.405886 | ubuntu-noble | ok 2026-02-16 17:51:22.423078 | ubuntu-noble | included: /var/lib/zuul/builds/ee2bf92ae7a346649f7464e3595959d4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-16 17:51:22.430075 | 2026-02-16 17:51:22.430146 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-16 17:51:23.443479 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2026-02-16 17:51:23.443752 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/ee2bf92ae7a346649f7464e3595959d4/work/ee2bf92ae7a346649f7464e3595959d4_id_rsa 2026-02-16 17:51:23.443799 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/ee2bf92ae7a346649f7464e3595959d4/work/ee2bf92ae7a346649f7464e3595959d4_id_rsa.pub 2026-02-16 17:51:23.443832 | ubuntu-noble -> localhost | The key fingerprint is: 2026-02-16 17:51:23.443862 | ubuntu-noble -> localhost | SHA256:iLvjtNaJowgEQ/LXJ4NQ61B+KzwuLNe4jl68oTHmBfA zuul-build-sshkey 2026-02-16 17:51:23.443914 | ubuntu-noble -> localhost | The key's randomart image is: 2026-02-16 17:51:23.443944 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2026-02-16 17:51:23.443984 | ubuntu-noble -> localhost | |....o | 2026-02-16 17:51:23.444015 | ubuntu-noble -> localhost | |o. + + | 2026-02-16 17:51:23.444043 | ubuntu-noble -> localhost | |+ o = = . | 2026-02-16 17:51:23.444070 | ubuntu-noble -> localhost | |oo = o * | 2026-02-16 17:51:23.444097 | ubuntu-noble -> localhost | | oE * o S | 2026-02-16 17:51:23.444124 | ubuntu-noble -> localhost | |..o+ + | 2026-02-16 17:51:23.444151 | ubuntu-noble -> localhost | |o+===o . | 2026-02-16 17:51:23.444178 | ubuntu-noble -> localhost | |+=*+Boo | 2026-02-16 17:51:23.444208 | ubuntu-noble -> localhost | |+=+=+o | 2026-02-16 17:51:23.444236 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2026-02-16 17:51:23.444296 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.576550 2026-02-16 17:51:23.450332 | 2026-02-16 17:51:23.450400 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-16 17:51:23.484665 | ubuntu-noble | ok 2026-02-16 17:51:23.498090 | ubuntu-noble | included: /var/lib/zuul/builds/ee2bf92ae7a346649f7464e3595959d4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-16 17:51:23.507260 | 2026-02-16 17:51:23.507344 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-16 17:51:23.532698 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:51:23.544578 | 2026-02-16 17:51:23.544649 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-16 17:51:24.070144 | ubuntu-noble | changed 2026-02-16 17:51:24.078761 | 2026-02-16 17:51:24.078927 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-16 17:51:24.298435 | ubuntu-noble | ok 2026-02-16 17:51:24.307181 | 2026-02-16 17:51:24.307319 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-16 17:51:24.852367 | ubuntu-noble | changed 2026-02-16 17:51:24.857988 | 2026-02-16 17:51:24.858053 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-16 17:51:25.412152 | ubuntu-noble | changed 2026-02-16 17:51:25.418225 | 2026-02-16 17:51:25.418292 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-16 17:51:25.442633 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:51:25.454175 | 2026-02-16 17:51:25.454246 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-16 17:51:26.025553 | ubuntu-noble -> localhost | changed 2026-02-16 17:51:26.036602 | 2026-02-16 17:51:26.036686 | TASK [add-build-sshkey : Add back temp key] 2026-02-16 17:51:26.350088 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/ee2bf92ae7a346649f7464e3595959d4/work/ee2bf92ae7a346649f7464e3595959d4_id_rsa (zuul-build-sshkey) 2026-02-16 17:51:26.350290 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.011761 2026-02-16 17:51:26.359051 | 2026-02-16 17:51:26.359153 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-16 17:51:26.701838 | ubuntu-noble | ok 2026-02-16 17:51:26.737385 | 2026-02-16 17:51:26.737459 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-16 17:51:26.775435 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:51:26.787116 | 2026-02-16 17:51:26.787190 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-02-16 17:51:27.149549 | ubuntu-noble | ok 2026-02-16 17:51:27.157810 | 2026-02-16 17:51:27.157882 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-02-16 17:51:28.253462 | ubuntu-noble | Output suppressed because no_log was given 2026-02-16 17:51:28.263827 | 2026-02-16 17:51:28.263897 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-02-16 17:51:28.503953 | ubuntu-noble | ok: "logs" 2026-02-16 17:51:28.602901 | ubuntu-noble | ok: All items complete 2026-02-16 17:51:28.603074 | 2026-02-16 17:51:28.749915 | ubuntu-noble | ok: "artifacts" 2026-02-16 17:51:28.916549 | ubuntu-noble | ok: "docs" 2026-02-16 17:51:28.927847 | 2026-02-16 17:51:28.928034 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-02-16 17:51:29.150926 | ubuntu-noble | changed: "logs" 2026-02-16 17:51:29.359750 | ubuntu-noble | changed: "artifacts" 2026-02-16 17:51:29.551714 | ubuntu-noble | changed: "docs" 2026-02-16 17:51:29.567855 | 2026-02-16 17:51:29.567980 | PLAY RECAP 2026-02-16 17:51:29.568026 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-16 17:51:29.568058 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-02-16 17:51:29.568188 | 2026-02-16 17:51:29.712922 | PRE-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main] 2026-02-16 17:51:29.715055 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-16 17:51:30.359228 | 2026-02-16 17:51:30.431836 | PLAY [all] 2026-02-16 17:51:30.450886 | 2026-02-16 17:51:30.451049 | TASK [Install binary dependencies] 2026-02-16 17:51:30.506916 | ubuntu-noble | ok 2026-02-16 17:51:30.529658 | 2026-02-16 17:51:30.529752 | TASK [bindep : Include find tasks] 2026-02-16 17:51:30.568438 | ubuntu-noble | ok 2026-02-16 17:51:30.578477 | ubuntu-noble | included: /var/lib/zuul/builds/ee2bf92ae7a346649f7464e3595959d4/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-02-16 17:51:30.585264 | 2026-02-16 17:51:30.585337 | TASK [bindep : Look for bindep.txt] 2026-02-16 17:51:30.920966 | ubuntu-noble | ok 2026-02-16 17:51:30.927951 | 2026-02-16 17:51:30.928026 | TASK [bindep : Define bindep_file fact] 2026-02-16 17:51:30.953158 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:51:30.964589 | 2026-02-16 17:51:30.964711 | TASK [bindep : Look for other-requirements.txt] 2026-02-16 17:51:31.176853 | ubuntu-noble | ok 2026-02-16 17:51:31.182768 | 2026-02-16 17:51:31.182842 | TASK [bindep : Define bindep_file fact] 2026-02-16 17:51:31.212477 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:51:31.225078 | 2026-02-16 17:51:31.225187 | TASK [bindep : Look for bindep fallback file] 2026-02-16 17:51:31.250471 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:51:31.262082 | 2026-02-16 17:51:31.262221 | TASK [bindep : Define bindep_file fact] 2026-02-16 17:51:31.298426 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:51:31.311416 | 2026-02-16 17:51:31.311521 | TASK [bindep : Include bindep tasks] 2026-02-16 17:51:31.348491 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:51:31.478070 | 2026-02-16 17:51:31.478214 | TASK [bindep : Include install tasks] 2026-02-16 17:51:31.507191 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:51:31.522175 | 2026-02-16 17:51:31.522284 | LOOP [bindep : Include package tasks] 2026-02-16 17:51:31.589494 | 2026-02-16 17:51:31.589817 | TASK [Run test-setup role] 2026-02-16 17:51:31.618670 | ubuntu-noble | ok 2026-02-16 17:51:31.643211 | 2026-02-16 17:51:31.643347 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-02-16 17:51:31.867899 | ubuntu-noble | ok 2026-02-16 17:51:31.874054 | 2026-02-16 17:51:31.874133 | TASK [test-setup : Run tools/test-setup.sh] 2026-02-16 17:51:32.406622 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:51:32.416561 | 2026-02-16 17:51:32.416647 | PLAY RECAP 2026-02-16 17:51:32.416712 | ubuntu-noble | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-16 17:51:32.416745 | 2026-02-16 17:51:32.540090 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-16 17:51:32.541926 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2026-02-16 17:51:33.184811 | 2026-02-16 17:51:33.185290 | PLAY [all] 2026-02-16 17:51:33.198567 | 2026-02-16 17:51:33.198647 | TASK [ensure-python : Validate python_version value] 2026-02-16 17:51:33.224713 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:51:33.235574 | 2026-02-16 17:51:33.235683 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)] 2026-02-16 17:51:33.261175 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:51:33.272535 | 2026-02-16 17:51:33.272633 | TASK [ensure-python : Pull in venv package] 2026-02-16 17:51:33.299747 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:51:33.311204 | 2026-02-16 17:51:33.311308 | TASK [ensure-python : Set default RPM package name] 2026-02-16 17:51:33.336626 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:51:33.345523 | 2026-02-16 17:51:33.345614 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9/10] 2026-02-16 17:51:33.370288 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:51:33.381346 | 2026-02-16 17:51:33.381419 | TASK [ensure-python : Install RPM package] 2026-02-16 17:51:33.408255 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:51:33.512363 | 2026-02-16 17:51:33.512587 | TASK [ensure-python : Install python using pyenv] 2026-02-16 17:51:33.539192 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:51:33.549456 | 2026-02-16 17:51:33.549606 | TASK [ensure-python : Activate python using stow] 2026-02-16 17:51:33.575926 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:51:33.594921 | 2026-02-16 17:51:33.595064 | TASK [Install pip] 2026-02-16 17:51:33.620730 | ubuntu-noble | ok 2026-02-16 17:51:33.645495 | 2026-02-16 17:51:33.645648 | TASK [ensure-pip : Check if pip is installed] 2026-02-16 17:51:34.183388 | ubuntu-noble | ok: Runtime: 0:00:00.009361 2026-02-16 17:51:34.189418 | 2026-02-16 17:51:34.189486 | LOOP [ensure-pip : Install pip from packages] 2026-02-16 17:51:34.238701 | ubuntu-noble | ok: "/var/lib/zuul/builds/ee2bf92ae7a346649f7464e3595959d4/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/Debian.yaml" 2026-02-16 17:51:34.258570 | ubuntu-noble | included: /var/lib/zuul/builds/ee2bf92ae7a346649f7464e3595959d4/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/Debian.yaml 2026-02-16 17:51:34.268853 | 2026-02-16 17:51:34.268921 | TASK [ensure-pip : Update package lists] 2026-02-16 17:51:40.711425 | ubuntu-noble | changed 2026-02-16 17:51:40.729529 | 2026-02-16 17:51:40.729630 | TASK [ensure-pip : Install Python 3 pip] 2026-02-16 17:51:46.985378 | ubuntu-noble | changed 2026-02-16 17:51:46.991398 | 2026-02-16 17:51:46.991478 | TASK [ensure-pip : Install Python 2 pip] 2026-02-16 17:51:47.019504 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:51:47.029942 | 2026-02-16 17:51:47.030067 | TASK [ensure-pip : Ensure setuptools] 2026-02-16 17:51:47.045027 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:51:47.053789 | 2026-02-16 17:51:47.053866 | TASK [ensure-pip : Check for ensurepip module] 2026-02-16 17:51:47.360758 | ubuntu-noble | usage: python -m ensurepip [-h] [--version] [-v] [-U] [--user] [--root ROOT] 2026-02-16 17:51:47.360880 | ubuntu-noble | [--altinstall] [--default-pip] 2026-02-16 17:51:47.360897 | ubuntu-noble | 2026-02-16 17:51:47.360911 | ubuntu-noble | options: 2026-02-16 17:51:47.360924 | ubuntu-noble | -h, --help show this help message and exit 2026-02-16 17:51:47.360943 | ubuntu-noble | --version Show the version of pip that is bundled with this Python. 2026-02-16 17:51:47.360958 | ubuntu-noble | -v, --verbose Give more output. Option is additive, and can be used up to 3 2026-02-16 17:51:47.360976 | ubuntu-noble | times. 2026-02-16 17:51:47.360989 | ubuntu-noble | -U, --upgrade Upgrade pip and dependencies, even if already installed. 2026-02-16 17:51:47.361001 | ubuntu-noble | --user Install using the user scheme. 2026-02-16 17:51:47.361013 | ubuntu-noble | --root ROOT Install everything relative to this alternate root directory. 2026-02-16 17:51:47.361024 | ubuntu-noble | --altinstall Make an alternate install, installing only the X.Y versioned 2026-02-16 17:51:47.361033 | ubuntu-noble | scripts (Default: pipX, pipX.Y). 2026-02-16 17:51:47.361042 | ubuntu-noble | --default-pip Make a default pip install, installing the unqualified pip in 2026-02-16 17:51:47.361050 | ubuntu-noble | addition to the versioned scripts. 2026-02-16 17:51:47.596163 | ubuntu-noble | ok: Runtime: 0:00:00.058129 2026-02-16 17:51:47.603765 | 2026-02-16 17:51:47.603852 | TASK [ensure-pip : Ensure python3-venv] 2026-02-16 17:51:47.628615 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:51:47.639426 | 2026-02-16 17:51:47.639555 | TASK [ensure-pip : Install pip from source] 2026-02-16 17:51:47.665355 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:51:47.718649 | 2026-02-16 17:51:47.718799 | TASK [ensure-pip : Probe for venv python full path] 2026-02-16 17:51:47.947079 | ubuntu-noble | /usr/bin/python3 2026-02-16 17:51:48.254926 | ubuntu-noble | ok: Runtime: 0:00:00.004629 2026-02-16 17:51:48.262546 | 2026-02-16 17:51:48.262632 | TASK [ensure-pip : Set host default] 2026-02-16 17:51:48.326748 | ubuntu-noble | ok 2026-02-16 17:51:48.334952 | 2026-02-16 17:51:48.335097 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2026-02-16 17:51:48.392872 | ubuntu-noble | ok 2026-02-16 17:51:48.403718 | 2026-02-16 17:51:48.403782 | TASK [ensure-tox : Check if tox is installed] 2026-02-16 17:51:48.936978 | ubuntu-noble | ok: Runtime: 0:00:00.004535 2026-02-16 17:51:48.942453 | 2026-02-16 17:51:48.942519 | TASK [ensure-tox : Export preinstalled tox_exectuable] 2026-02-16 17:51:48.967601 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:51:48.979205 | 2026-02-16 17:51:48.979329 | TASK [ensure-tox : Create local venv] 2026-02-16 17:51:52.523977 | ubuntu-noble | ok: Runtime: 0:00:03.140215 2026-02-16 17:51:52.529493 | 2026-02-16 17:51:52.529562 | TASK [ensure-tox : Install tox to local venv] 2026-02-16 17:51:53.304333 | ubuntu-noble | Collecting tox 2026-02-16 17:51:53.371654 | ubuntu-noble | Downloading tox-4.36.0-py3-none-any.whl.metadata (3.6 kB) 2026-02-16 17:51:53.443720 | ubuntu-noble | Collecting cachetools>=7.0.1 (from tox) 2026-02-16 17:51:53.453786 | ubuntu-noble | Downloading cachetools-7.0.1-py3-none-any.whl.metadata (5.6 kB) 2026-02-16 17:51:53.500797 | ubuntu-noble | Collecting chardet>=5.2 (from tox) 2026-02-16 17:51:53.511595 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl.metadata (3.4 kB) 2026-02-16 17:51:53.567438 | ubuntu-noble | Collecting colorama>=0.4.6 (from tox) 2026-02-16 17:51:53.577798 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2026-02-16 17:51:53.649826 | ubuntu-noble | Collecting filelock>=3.24 (from tox) 2026-02-16 17:51:53.660218 | ubuntu-noble | Downloading filelock-3.24.2-py3-none-any.whl.metadata (2.0 kB) 2026-02-16 17:51:53.721039 | ubuntu-noble | Collecting packaging>=26 (from tox) 2026-02-16 17:51:53.730487 | ubuntu-noble | Downloading packaging-26.0-py3-none-any.whl.metadata (3.3 kB) 2026-02-16 17:51:53.801414 | ubuntu-noble | Collecting platformdirs>=4.9.1 (from tox) 2026-02-16 17:51:53.818442 | ubuntu-noble | Downloading platformdirs-4.9.2-py3-none-any.whl.metadata (4.7 kB) 2026-02-16 17:51:53.876454 | ubuntu-noble | Collecting pluggy>=1.6 (from tox) 2026-02-16 17:51:53.886375 | ubuntu-noble | Downloading pluggy-1.6.0-py3-none-any.whl.metadata (4.8 kB) 2026-02-16 17:51:53.968961 | ubuntu-noble | Collecting pyproject-api>=1.10 (from tox) 2026-02-16 17:51:53.979417 | ubuntu-noble | Downloading pyproject_api-1.10.0-py3-none-any.whl.metadata (2.7 kB) 2026-02-16 17:51:54.135740 | ubuntu-noble | Collecting virtualenv>=20.36.1 (from tox) 2026-02-16 17:51:54.145492 | ubuntu-noble | Downloading virtualenv-20.37.0-py3-none-any.whl.metadata (5.1 kB) 2026-02-16 17:51:54.241888 | ubuntu-noble | Collecting distlib<1,>=0.3.7 (from virtualenv>=20.36.1->tox) 2026-02-16 17:51:54.252617 | ubuntu-noble | Downloading distlib-0.4.0-py2.py3-none-any.whl.metadata (5.2 kB) 2026-02-16 17:51:54.294516 | ubuntu-noble | Downloading tox-4.36.0-py3-none-any.whl (179 kB) 2026-02-16 17:51:54.327352 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 179.1/179.1 kB 6.1 MB/s eta 0:00:00 2026-02-16 17:51:54.337569 | ubuntu-noble | Downloading cachetools-7.0.1-py3-none-any.whl (13 kB) 2026-02-16 17:51:54.355079 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2026-02-16 17:51:54.370242 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 15.8 MB/s eta 0:00:00 2026-02-16 17:51:54.380521 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-02-16 17:51:54.398669 | ubuntu-noble | Downloading filelock-3.24.2-py3-none-any.whl (24 kB) 2026-02-16 17:51:54.422200 | ubuntu-noble | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-02-16 17:51:54.437581 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 5.3 MB/s eta 0:00:00 2026-02-16 17:51:54.447964 | ubuntu-noble | Downloading platformdirs-4.9.2-py3-none-any.whl (21 kB) 2026-02-16 17:51:54.467900 | ubuntu-noble | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-02-16 17:51:54.497305 | ubuntu-noble | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-02-16 17:51:54.518535 | ubuntu-noble | Downloading virtualenv-20.37.0-py3-none-any.whl (5.8 MB) 2026-02-16 17:51:54.635053 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.8/5.8 MB 52.2 MB/s eta 0:00:00 2026-02-16 17:51:54.650042 | ubuntu-noble | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-02-16 17:51:54.668621 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 29.7 MB/s eta 0:00:00 2026-02-16 17:51:54.736612 | ubuntu-noble | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2026-02-16 17:51:55.602142 | 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:51:56.068637 | ubuntu-noble | ok: Runtime: 0:00:02.914596 2026-02-16 17:51:56.074601 | 2026-02-16 17:51:56.074666 | TASK [ensure-tox : Export installed tox_executable path] 2026-02-16 17:51:56.126233 | ubuntu-noble | ok 2026-02-16 17:51:56.133037 | 2026-02-16 17:51:56.133122 | TASK [ensure-tox : Output tox version] 2026-02-16 17:51:56.597136 | 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:51:56.611420 | ubuntu-noble | 4.36.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2026-02-16 17:51:56.701717 | ubuntu-noble | ok: Runtime: 0:00:00.280785 2026-02-16 17:51:56.707398 | 2026-02-16 17:51:56.707468 | TASK [ensure-tox : Make global symlink] 2026-02-16 17:51:56.732783 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:51:56.742456 | 2026-02-16 17:51:56.742544 | PLAY RECAP 2026-02-16 17:51:56.742615 | ubuntu-noble | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-02-16 17:51:56.742649 | 2026-02-16 17:51:56.907973 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2026-02-16 17:51:56.911001 | PRE-RUN START: [untrusted : github.com/vexxhost/magnum-cluster-api/zuul.d/playbooks/tox/pre.yml@main] 2026-02-16 17:51:57.494384 | 2026-02-16 17:51:57.495182 | PLAY [all] 2026-02-16 17:51:57.510776 | 2026-02-16 17:51:57.510860 | TASK [ensure-rust : Use rustup] 2026-02-16 17:51:57.534750 | ubuntu-noble | ok 2026-02-16 17:51:57.543606 | ubuntu-noble | included: /var/lib/zuul/builds/ee2bf92ae7a346649f7464e3595959d4/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-rust/tasks/rustup.yaml 2026-02-16 17:51:57.549457 | 2026-02-16 17:51:57.549528 | TASK [ensure-rust : Install Rust] 2026-02-16 17:51:57.981174 | ubuntu-noble | /bin/bash: line 2: curl: command not found 2026-02-16 17:51:58.087945 | ubuntu-noble | ERROR 2026-02-16 17:51:58.088287 | ubuntu-noble | { 2026-02-16 17:51:58.088378 | ubuntu-noble | "delta": "0:00:00.006812", 2026-02-16 17:51:58.088438 | ubuntu-noble | "end": "2026-02-16 17:51:57.982551", 2026-02-16 17:51:58.088470 | ubuntu-noble | "msg": "non-zero return code", 2026-02-16 17:51:58.088499 | ubuntu-noble | "rc": 127, 2026-02-16 17:51:58.088545 | ubuntu-noble | "start": "2026-02-16 17:51:57.975739" 2026-02-16 17:51:58.088578 | ubuntu-noble | } failure 2026-02-16 17:51:58.091032 | 2026-02-16 17:51:58.091151 | PLAY RECAP 2026-02-16 17:51:58.091238 | ubuntu-noble | ok: 1 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-02-16 17:51:58.091315 | 2026-02-16 17:51:58.230065 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/magnum-cluster-api/zuul.d/playbooks/tox/pre.yml@main] 2026-02-16 17:51:58.231741 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2026-02-16 17:51:58.814195 | 2026-02-16 17:51:58.814366 | PLAY [all] 2026-02-16 17:51:58.827054 | 2026-02-16 17:51:58.827144 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-02-16 17:51:58.872257 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:51:58.878465 | 2026-02-16 17:51:58.878553 | TASK [fetch-tox-output : Set tox log path for single node] 2026-02-16 17:51:58.919349 | ubuntu-noble | ok 2026-02-16 17:51:58.926515 | 2026-02-16 17:51:58.926613 | TASK [fetch-tox-output : Ensure local tox dir] 2026-02-16 17:51:59.579162 | ubuntu-noble -> localhost | changed 2026-02-16 17:51:59.586750 | 2026-02-16 17:51:59.586842 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-02-16 17:51:59.632538 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:51:59.642903 | 2026-02-16 17:51:59.642987 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 17:51:59.689862 | ubuntu-noble | ok 2026-02-16 17:51:59.697366 | 2026-02-16 17:51:59.697445 | TASK [fetch-tox-output : Get tox version] 2026-02-16 17:52:00.282032 | 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:52:00.296412 | ubuntu-noble | 4.36.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2026-02-16 17:52:00.749020 | ubuntu-noble | ok: Runtime: 0:00:00.247553 2026-02-16 17:52:00.754247 | 2026-02-16 17:52:00.754313 | TASK [fetch-tox-output : Find all default environments] 2026-02-16 17:52:01.282659 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:52:01.416220 | 2026-02-16 17:52:01.416349 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 17:52:01.441778 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:52:01.454343 | 2026-02-16 17:52:01.454453 | TASK [fetch-tox-output : Find all default environments] 2026-02-16 17:52:01.986795 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:52:01.996224 | 2026-02-16 17:52:01.996326 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 17:52:02.032939 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:52:02.041951 | 2026-02-16 17:52:02.042025 | LOOP [fetch-tox-output : Copy tox logs] 2026-02-16 17:52:02.085303 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:52:02.100301 | 2026-02-16 17:52:02.100432 | LOOP [fetch-tox-output : Collect tox logs] 2026-02-16 17:52:02.904402 | ubuntu-noble | ok: 2026-02-16 17:52:02.904603 | 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:52:02.904694 | 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:52:02.904729 | ubuntu-noble | rsync: [Receiver] write error: Broken pipe (32) 2026-02-16 17:52:02.904760 | 2026-02-16 17:52:02.923865 | 2026-02-16 17:52:02.924349 | PLAY RECAP 2026-02-16 17:52:02.924414 | ubuntu-noble | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-02-16 17:52:02.924437 | 2026-02-16 17:52:03.113827 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2026-02-16 17:52:03.115506 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-16 17:52:03.801552 | 2026-02-16 17:52:03.801730 | PLAY [all] 2026-02-16 17:52:03.815881 | 2026-02-16 17:52:03.815983 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-02-16 17:52:03.995212 | ubuntu-noble | changed: non-zero return code 2026-02-16 17:52:04.001502 | 2026-02-16 17:52:04.001596 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-02-16 17:52:04.027460 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:52:04.038978 | 2026-02-16 17:52:04.039109 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-02-16 17:52:04.076436 | 2026-02-16 17:52:04.076650 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-02-16 17:52:04.112042 | 2026-02-16 17:52:04.112239 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-02-16 17:52:04.138482 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:52:04.151059 | 2026-02-16 17:52:04.151232 | LOOP [fetch-subunit-output : Generate subunit file] 2026-02-16 17:52:04.189288 | 2026-02-16 17:52:04.189578 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-02-16 17:52:04.216161 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:52:04.227192 | 2026-02-16 17:52:04.227334 | TASK [fetch-subunit-output : Remove the temporary file] 2026-02-16 17:52:04.253375 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:52:04.264481 | 2026-02-16 17:52:04.264602 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-02-16 17:52:04.291883 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:52:04.303637 | 2026-02-16 17:52:04.303724 | PLAY RECAP 2026-02-16 17:52:04.303840 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-16 17:52:04.303892 | 2026-02-16 17:52:04.477741 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-16 17:52:04.480701 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main] 2026-02-16 17:52:05.128861 | 2026-02-16 17:52:05.129044 | PLAY [all] 2026-02-16 17:52:05.142070 | 2026-02-16 17:52:05.142175 | TASK [fetch-output : Set log path for multiple nodes] 2026-02-16 17:52:05.188148 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:52:05.199010 | 2026-02-16 17:52:05.199211 | TASK [fetch-output : Set log path for single node] 2026-02-16 17:52:05.247576 | ubuntu-noble | ok 2026-02-16 17:52:05.256586 | 2026-02-16 17:52:05.256738 | LOOP [fetch-output : Ensure local output dirs] 2026-02-16 17:52:05.660767 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/ee2bf92ae7a346649f7464e3595959d4/work/logs" 2026-02-16 17:52:05.872431 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/ee2bf92ae7a346649f7464e3595959d4/work/artifacts" 2026-02-16 17:52:06.092245 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/ee2bf92ae7a346649f7464e3595959d4/work/docs" 2026-02-16 17:52:06.114272 | 2026-02-16 17:52:06.114452 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-16 17:52:06.735680 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 17:52:06.735977 | ubuntu-noble | changed: All items complete 2026-02-16 17:52:06.736033 | 2026-02-16 17:52:07.226697 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 17:52:07.710655 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 17:52:07.737189 | 2026-02-16 17:52:07.737343 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-02-16 17:52:08.154065 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.008037 2026-02-16 17:52:08.381212 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.008806 2026-02-16 17:52:08.396304 | 2026-02-16 17:52:08.396448 | PLAY [all] 2026-02-16 17:52:08.404684 | 2026-02-16 17:52:08.404750 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-02-16 17:52:08.887265 | ubuntu-noble | changed 2026-02-16 17:52:08.893607 | 2026-02-16 17:52:08.893658 | PLAY RECAP 2026-02-16 17:52:08.893705 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-02-16 17:52:08.893727 | 2026-02-16 17:52:09.015251 | POST-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main] 2026-02-16 17:52:09.016891 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post-logs.yaml@main] 2026-02-16 17:52:09.601376 | 2026-02-16 17:52:09.601531 | PLAY [localhost] 2026-02-16 17:52:09.612719 | 2026-02-16 17:52:09.612795 | TASK [Generate Zuul manifest] 2026-02-16 17:52:09.631895 | localhost | ok 2026-02-16 17:52:09.647875 | 2026-02-16 17:52:09.647956 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-16 17:52:09.999814 | localhost | changed 2026-02-16 17:52:10.013355 | 2026-02-16 17:52:10.013427 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-16 17:52:10.045197 | localhost | ok 2026-02-16 17:52:10.054256 | 2026-02-16 17:52:10.054344 | TASK [Upload logs] 2026-02-16 17:52:10.074761 | localhost | ok 2026-02-16 17:52:10.136092 | 2026-02-16 17:52:10.136209 | TASK [Set zuul-log-path fact] 2026-02-16 17:52:10.158932 | localhost | ok 2026-02-16 17:52:10.173967 | 2026-02-16 17:52:10.174057 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-16 17:52:10.207012 | localhost | ok 2026-02-16 17:52:10.216603 | 2026-02-16 17:52:10.216692 | TASK [upload-logs : Create log directories] 2026-02-16 17:52:10.706912 | localhost | changed 2026-02-16 17:52:10.713444 | 2026-02-16 17:52:10.713547 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-02-16 17:52:11.153468 | localhost -> localhost | ok: Runtime: 0:00:00.005245 2026-02-16 17:52:11.161465 | 2026-02-16 17:52:11.161540 | TASK [upload-logs : Upload logs to log server] 2026-02-16 17:52:11.669267 | localhost | Output suppressed because no_log was given 2026-02-16 17:52:11.673003 | 2026-02-16 17:52:11.673072 | LOOP [upload-logs : Compress console log and json output] 2026-02-16 17:52:11.720480 | localhost | skipping: Conditional result was False 2026-02-16 17:52:11.726468 | localhost | skipping: Conditional result was False 2026-02-16 17:52:11.735693 | 2026-02-16 17:52:11.735830 | LOOP [upload-logs : Upload compressed console log and json output] 2026-02-16 17:52:11.777575 | localhost | skipping: Conditional result was False 2026-02-16 17:52:11.777979 | 2026-02-16 17:52:11.780873 | localhost | skipping: Conditional result was False 2026-02-16 17:52:11.796065 | 2026-02-16 17:52:11.796211 | LOOP [upload-logs : Upload console log and json output]