2026-02-16 17:38:01.862996 | Job console starting 2026-02-16 17:38:01.874543 | Updating git repos 2026-02-16 17:38:01.909226 | Cloning repos into workspace 2026-02-16 17:38:01.957468 | Restoring repo states 2026-02-16 17:38:01.969310 | Merging changes 2026-02-16 17:38:02.343487 | Checking out repos 2026-02-16 17:38:02.495209 | Preparing playbooks 2026-02-16 17:38:05.868683 | Running Ansible setup 2026-02-16 17:38:09.563326 | PRE-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main] 2026-02-16 17:38:10.182311 | 2026-02-16 17:38:10.182459 | PLAY [localhost] 2026-02-16 17:38:10.191021 | 2026-02-16 17:38:10.191097 | TASK [Gathering Facts] 2026-02-16 17:38:11.070905 | localhost | ok 2026-02-16 17:38:11.079843 | 2026-02-16 17:38:11.079927 | TASK [Setup log path fact] 2026-02-16 17:38:11.101308 | localhost | ok 2026-02-16 17:38:11.118266 | 2026-02-16 17:38:11.118366 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-16 17:38:11.149156 | localhost | ok 2026-02-16 17:38:11.161438 | 2026-02-16 17:38:11.161528 | TASK [emit-job-header : Print job information] 2026-02-16 17:38:11.207404 | # Job Information 2026-02-16 17:38:11.230025 | Ansible Version: 2.16.15 2026-02-16 17:38:11.230132 | Job: magnum-cluster-api-tox-unit 2026-02-16 17:38:11.230170 | Pipeline: check 2026-02-16 17:38:11.230199 | Executor: 3a2793d2bd32 2026-02-16 17:38:11.230226 | Triggered by: https://github.com/vexxhost/magnum-cluster-api/pull/884 2026-02-16 17:38:11.230276 | Event ID: 2685a480-0b5e-11f1-90f6-a235114455cc 2026-02-16 17:38:11.235545 | 2026-02-16 17:38:11.235690 | LOOP [emit-job-header : Print node information] 2026-02-16 17:38:11.406678 | localhost | ok: 2026-02-16 17:38:11.407109 | localhost | # Node Information 2026-02-16 17:38:11.407241 | localhost | Inventory Hostname: ubuntu-noble 2026-02-16 17:38:11.407292 | localhost | Hostname: np0000155608 2026-02-16 17:38:11.407336 | localhost | Username: zuul 2026-02-16 17:38:11.407384 | localhost | Distro: Ubuntu 24.04 2026-02-16 17:38:11.407426 | localhost | Provider: yul1 2026-02-16 17:38:11.407467 | localhost | Region: ca-ymq-1 2026-02-16 17:38:11.407507 | localhost | Label: ubuntu-noble 2026-02-16 17:38:11.407545 | localhost | Product Name: OpenStack Nova 2026-02-16 17:38:11.407585 | localhost | Interface IP: 199.204.45.33 2026-02-16 17:38:11.429283 | 2026-02-16 17:38:11.429435 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-16 17:38:11.879783 | localhost -> localhost | changed 2026-02-16 17:38:11.889655 | 2026-02-16 17:38:11.889803 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-16 17:38:12.746274 | localhost -> localhost | changed 2026-02-16 17:38:12.753746 | 2026-02-16 17:38:12.753922 | PLAY [all] 2026-02-16 17:38:12.764901 | 2026-02-16 17:38:12.765088 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-16 17:38:12.993328 | ubuntu-noble -> localhost | ok 2026-02-16 17:38:12.999865 | 2026-02-16 17:38:12.999934 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-16 17:38:13.033114 | ubuntu-noble | ok 2026-02-16 17:38:13.047799 | ubuntu-noble | included: /var/lib/zuul/builds/980a3a8c846048bcbd379fa529b930ac/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-16 17:38:13.053724 | 2026-02-16 17:38:13.053782 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-16 17:38:14.318888 | ubuntu-noble -> localhost | Generating public/private rsa key pair. 2026-02-16 17:38:14.319084 | ubuntu-noble -> localhost | Your identification has been saved in /var/lib/zuul/builds/980a3a8c846048bcbd379fa529b930ac/work/980a3a8c846048bcbd379fa529b930ac_id_rsa 2026-02-16 17:38:14.319114 | ubuntu-noble -> localhost | Your public key has been saved in /var/lib/zuul/builds/980a3a8c846048bcbd379fa529b930ac/work/980a3a8c846048bcbd379fa529b930ac_id_rsa.pub 2026-02-16 17:38:14.319137 | ubuntu-noble -> localhost | The key fingerprint is: 2026-02-16 17:38:14.319158 | ubuntu-noble -> localhost | SHA256:ArFOAFvWjQE1Z50t+xvj2VoQLvvxDT605YxnbicuxV8 zuul-build-sshkey 2026-02-16 17:38:14.319189 | ubuntu-noble -> localhost | The key's randomart image is: 2026-02-16 17:38:14.319210 | ubuntu-noble -> localhost | +---[RSA 3072]----+ 2026-02-16 17:38:14.319237 | ubuntu-noble -> localhost | |..=+=+o. o | 2026-02-16 17:38:14.319297 | ubuntu-noble -> localhost | | + .o*. + . | 2026-02-16 17:38:14.319329 | ubuntu-noble -> localhost | |. + o. | 2026-02-16 17:38:14.319350 | ubuntu-noble -> localhost | | o . .. . | 2026-02-16 17:38:14.319370 | ubuntu-noble -> localhost | | . . S.o . | 2026-02-16 17:38:14.319390 | ubuntu-noble -> localhost | | . o+.. + E| 2026-02-16 17:38:14.319409 | ubuntu-noble -> localhost | | ...BoB ..| 2026-02-16 17:38:14.319428 | ubuntu-noble -> localhost | | .+=*oB o| 2026-02-16 17:38:14.319450 | ubuntu-noble -> localhost | | o.oO+o | 2026-02-16 17:38:14.319470 | ubuntu-noble -> localhost | +----[SHA256]-----+ 2026-02-16 17:38:14.319520 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.854452 2026-02-16 17:38:14.325430 | 2026-02-16 17:38:14.325493 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-16 17:38:14.360673 | ubuntu-noble | ok 2026-02-16 17:38:14.370660 | ubuntu-noble | included: /var/lib/zuul/builds/980a3a8c846048bcbd379fa529b930ac/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-16 17:38:14.378934 | 2026-02-16 17:38:14.378999 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-16 17:38:14.403773 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:14.414340 | 2026-02-16 17:38:14.414432 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-16 17:38:14.984575 | ubuntu-noble | changed 2026-02-16 17:38:14.990195 | 2026-02-16 17:38:14.990263 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-16 17:38:15.237691 | ubuntu-noble | ok 2026-02-16 17:38:15.243926 | 2026-02-16 17:38:15.243987 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-16 17:38:15.803917 | ubuntu-noble | changed 2026-02-16 17:38:15.809603 | 2026-02-16 17:38:15.809671 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-16 17:38:16.321466 | ubuntu-noble | changed 2026-02-16 17:38:16.327852 | 2026-02-16 17:38:16.327922 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-16 17:38:16.352933 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:16.359080 | 2026-02-16 17:38:16.359142 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-16 17:38:16.749316 | ubuntu-noble -> localhost | changed 2026-02-16 17:38:16.764259 | 2026-02-16 17:38:16.764327 | TASK [add-build-sshkey : Add back temp key] 2026-02-16 17:38:17.081970 | ubuntu-noble -> localhost | Identity added: /var/lib/zuul/builds/980a3a8c846048bcbd379fa529b930ac/work/980a3a8c846048bcbd379fa529b930ac_id_rsa (zuul-build-sshkey) 2026-02-16 17:38:17.082742 | ubuntu-noble -> localhost | ok: Runtime: 0:00:00.014696 2026-02-16 17:38:17.091541 | 2026-02-16 17:38:17.091606 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-16 17:38:17.440362 | ubuntu-noble | ok 2026-02-16 17:38:17.446366 | 2026-02-16 17:38:17.446436 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-16 17:38:17.472758 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:17.488577 | 2026-02-16 17:38:17.488641 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-02-16 17:38:17.857890 | ubuntu-noble | ok 2026-02-16 17:38:17.867527 | 2026-02-16 17:38:17.867596 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-02-16 17:38:18.983308 | ubuntu-noble | Output suppressed because no_log was given 2026-02-16 17:38:18.992850 | 2026-02-16 17:38:18.992916 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-02-16 17:38:19.222397 | ubuntu-noble | ok: "logs" 2026-02-16 17:38:19.223168 | ubuntu-noble | ok: All items complete 2026-02-16 17:38:19.223221 | 2026-02-16 17:38:19.471697 | ubuntu-noble | ok: "artifacts" 2026-02-16 17:38:19.629814 | ubuntu-noble | ok: "docs" 2026-02-16 17:38:19.648855 | 2026-02-16 17:38:19.649000 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-02-16 17:38:19.887246 | ubuntu-noble | changed: "logs" 2026-02-16 17:38:20.077176 | ubuntu-noble | changed: "artifacts" 2026-02-16 17:38:20.261782 | ubuntu-noble | changed: "docs" 2026-02-16 17:38:20.279015 | 2026-02-16 17:38:20.279072 | PLAY RECAP 2026-02-16 17:38:20.279117 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-16 17:38:20.279145 | ubuntu-noble | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-02-16 17:38:20.279169 | 2026-02-16 17:38:20.402156 | PRE-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main] 2026-02-16 17:38:20.405531 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-16 17:38:21.038258 | 2026-02-16 17:38:21.147211 | PLAY [all] 2026-02-16 17:38:21.164715 | 2026-02-16 17:38:21.164800 | TASK [Install binary dependencies] 2026-02-16 17:38:21.218780 | ubuntu-noble | ok 2026-02-16 17:38:21.293405 | 2026-02-16 17:38:21.293490 | TASK [bindep : Include find tasks] 2026-02-16 17:38:21.327722 | ubuntu-noble | ok 2026-02-16 17:38:21.336230 | ubuntu-noble | included: /var/lib/zuul/builds/980a3a8c846048bcbd379fa529b930ac/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-02-16 17:38:21.342576 | 2026-02-16 17:38:21.342640 | TASK [bindep : Look for bindep.txt] 2026-02-16 17:38:21.731837 | ubuntu-noble | ok 2026-02-16 17:38:21.739054 | 2026-02-16 17:38:21.739146 | TASK [bindep : Define bindep_file fact] 2026-02-16 17:38:21.764541 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:21.773237 | 2026-02-16 17:38:21.773327 | TASK [bindep : Look for other-requirements.txt] 2026-02-16 17:38:21.989964 | ubuntu-noble | ok 2026-02-16 17:38:21.996016 | 2026-02-16 17:38:21.996086 | TASK [bindep : Define bindep_file fact] 2026-02-16 17:38:22.021360 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:22.058174 | 2026-02-16 17:38:22.058247 | TASK [bindep : Look for bindep fallback file] 2026-02-16 17:38:22.083894 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:22.097029 | 2026-02-16 17:38:22.097126 | TASK [bindep : Define bindep_file fact] 2026-02-16 17:38:22.122739 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:22.132698 | 2026-02-16 17:38:22.132792 | TASK [bindep : Include bindep tasks] 2026-02-16 17:38:22.158467 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:22.190714 | 2026-02-16 17:38:22.190784 | TASK [bindep : Include install tasks] 2026-02-16 17:38:22.215643 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:22.225621 | 2026-02-16 17:38:22.225708 | LOOP [bindep : Include package tasks] 2026-02-16 17:38:22.287486 | 2026-02-16 17:38:22.287647 | TASK [Run test-setup role] 2026-02-16 17:38:22.313334 | ubuntu-noble | ok 2026-02-16 17:38:22.331671 | 2026-02-16 17:38:22.331739 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-02-16 17:38:22.550132 | ubuntu-noble | ok 2026-02-16 17:38:22.557973 | 2026-02-16 17:38:22.558082 | TASK [test-setup : Run tools/test-setup.sh] 2026-02-16 17:38:23.090549 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:23.101129 | 2026-02-16 17:38:23.262203 | PLAY RECAP 2026-02-16 17:38:23.262488 | ubuntu-noble | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-16 17:38:23.262548 | 2026-02-16 17:38:23.425338 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-16 17:38:23.428284 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2026-02-16 17:38:24.051369 | 2026-02-16 17:38:24.051767 | PLAY [all] 2026-02-16 17:38:24.065668 | 2026-02-16 17:38:24.065772 | TASK [ensure-python : Validate python_version value] 2026-02-16 17:38:24.090965 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:24.100693 | 2026-02-16 17:38:24.101012 | TASK [ensure-python : Install specified version of python interpreter and development files (DEB)] 2026-02-16 17:38:24.125925 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:24.138659 | 2026-02-16 17:38:24.138755 | TASK [ensure-python : Pull in venv package] 2026-02-16 17:38:24.163776 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:24.176120 | 2026-02-16 17:38:24.230578 | TASK [ensure-python : Set default RPM package name] 2026-02-16 17:38:24.259395 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:24.266287 | 2026-02-16 17:38:24.266367 | TASK [ensure-python : Set RPM package name for CentOS/RHEL 9/10] 2026-02-16 17:38:24.302264 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:24.326531 | 2026-02-16 17:38:24.326619 | TASK [ensure-python : Install RPM package] 2026-02-16 17:38:24.359311 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:24.366510 | 2026-02-16 17:38:24.366624 | TASK [ensure-python : Install python using pyenv] 2026-02-16 17:38:24.390087 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:24.396299 | 2026-02-16 17:38:24.396395 | TASK [ensure-python : Activate python using stow] 2026-02-16 17:38:24.421203 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:24.438540 | 2026-02-16 17:38:24.438609 | TASK [Install pip] 2026-02-16 17:38:24.471783 | ubuntu-noble | ok 2026-02-16 17:38:24.494778 | 2026-02-16 17:38:24.494847 | TASK [ensure-pip : Check if pip is installed] 2026-02-16 17:38:25.061765 | ubuntu-noble | ok: Runtime: 0:00:00.007706 2026-02-16 17:38:25.069178 | 2026-02-16 17:38:25.069247 | LOOP [ensure-pip : Install pip from packages] 2026-02-16 17:38:25.105673 | ubuntu-noble | ok: "/var/lib/zuul/builds/980a3a8c846048bcbd379fa529b930ac/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/Debian.yaml" 2026-02-16 17:38:25.130006 | ubuntu-noble | included: /var/lib/zuul/builds/980a3a8c846048bcbd379fa529b930ac/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/Debian.yaml 2026-02-16 17:38:25.139637 | 2026-02-16 17:38:25.139708 | TASK [ensure-pip : Update package lists] 2026-02-16 17:38:31.263956 | ubuntu-noble | changed 2026-02-16 17:38:31.269309 | 2026-02-16 17:38:31.269376 | TASK [ensure-pip : Install Python 3 pip] 2026-02-16 17:38:36.329110 | ubuntu-noble | changed 2026-02-16 17:38:36.338065 | 2026-02-16 17:38:36.338147 | TASK [ensure-pip : Install Python 2 pip] 2026-02-16 17:38:36.351502 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:36.418006 | 2026-02-16 17:38:36.418081 | TASK [ensure-pip : Ensure setuptools] 2026-02-16 17:38:36.444096 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:36.456861 | 2026-02-16 17:38:36.457015 | TASK [ensure-pip : Check for ensurepip module] 2026-02-16 17:38:36.595060 | ubuntu-noble | usage: python -m ensurepip [-h] [--version] [-v] [-U] [--user] [--root ROOT] 2026-02-16 17:38:36.595206 | ubuntu-noble | [--altinstall] [--default-pip] 2026-02-16 17:38:36.595227 | ubuntu-noble | 2026-02-16 17:38:36.595238 | ubuntu-noble | options: 2026-02-16 17:38:36.595249 | ubuntu-noble | -h, --help show this help message and exit 2026-02-16 17:38:36.595264 | ubuntu-noble | --version Show the version of pip that is bundled with this Python. 2026-02-16 17:38:36.595277 | ubuntu-noble | -v, --verbose Give more output. Option is additive, and can be used up to 3 2026-02-16 17:38:36.595291 | ubuntu-noble | times. 2026-02-16 17:38:36.595301 | ubuntu-noble | -U, --upgrade Upgrade pip and dependencies, even if already installed. 2026-02-16 17:38:36.595309 | ubuntu-noble | --user Install using the user scheme. 2026-02-16 17:38:36.595318 | ubuntu-noble | --root ROOT Install everything relative to this alternate root directory. 2026-02-16 17:38:36.595327 | ubuntu-noble | --altinstall Make an alternate install, installing only the X.Y versioned 2026-02-16 17:38:36.595336 | ubuntu-noble | scripts (Default: pipX, pipX.Y). 2026-02-16 17:38:36.595344 | ubuntu-noble | --default-pip Make a default pip install, installing the unqualified pip in 2026-02-16 17:38:36.595353 | ubuntu-noble | addition to the versioned scripts. 2026-02-16 17:38:36.991021 | ubuntu-noble | ok: Runtime: 0:00:00.061876 2026-02-16 17:38:36.999237 | 2026-02-16 17:38:36.999307 | TASK [ensure-pip : Ensure python3-venv] 2026-02-16 17:38:37.023543 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:37.033473 | 2026-02-16 17:38:37.105266 | TASK [ensure-pip : Install pip from source] 2026-02-16 17:38:37.131700 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:37.179079 | 2026-02-16 17:38:37.179228 | TASK [ensure-pip : Probe for venv python full path] 2026-02-16 17:38:37.291360 | ubuntu-noble | /usr/bin/python3 2026-02-16 17:38:37.706224 | ubuntu-noble | ok: Runtime: 0:00:00.004720 2026-02-16 17:38:37.711812 | 2026-02-16 17:38:37.711883 | TASK [ensure-pip : Set host default] 2026-02-16 17:38:37.762457 | ubuntu-noble | ok 2026-02-16 17:38:37.767734 | 2026-02-16 17:38:37.767843 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2026-02-16 17:38:37.839425 | ubuntu-noble | ok 2026-02-16 17:38:37.849345 | 2026-02-16 17:38:37.849417 | TASK [ensure-tox : Check if tox is installed] 2026-02-16 17:38:38.381588 | ubuntu-noble | ok: Runtime: 0:00:00.004698 2026-02-16 17:38:38.389530 | 2026-02-16 17:38:38.389644 | TASK [ensure-tox : Export preinstalled tox_exectuable] 2026-02-16 17:38:38.414330 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:38.425683 | 2026-02-16 17:38:38.425796 | TASK [ensure-tox : Create local venv] 2026-02-16 17:38:41.927814 | ubuntu-noble | ok: Runtime: 0:00:03.144557 2026-02-16 17:38:41.933400 | 2026-02-16 17:38:41.933469 | TASK [ensure-tox : Install tox to local venv] 2026-02-16 17:38:42.614852 | ubuntu-noble | Collecting tox 2026-02-16 17:38:42.682384 | ubuntu-noble | Downloading tox-4.36.0-py3-none-any.whl.metadata (3.6 kB) 2026-02-16 17:38:42.754632 | ubuntu-noble | Collecting cachetools>=7.0.1 (from tox) 2026-02-16 17:38:42.763899 | ubuntu-noble | Downloading cachetools-7.0.1-py3-none-any.whl.metadata (5.6 kB) 2026-02-16 17:38:42.807848 | ubuntu-noble | Collecting chardet>=5.2 (from tox) 2026-02-16 17:38:42.816915 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl.metadata (3.4 kB) 2026-02-16 17:38:42.873010 | ubuntu-noble | Collecting colorama>=0.4.6 (from tox) 2026-02-16 17:38:42.882411 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl.metadata (17 kB) 2026-02-16 17:38:43.208123 | ubuntu-noble | Collecting filelock>=3.24 (from tox) 2026-02-16 17:38:43.218577 | ubuntu-noble | Downloading filelock-3.24.2-py3-none-any.whl.metadata (2.0 kB) 2026-02-16 17:38:43.455432 | ubuntu-noble | Collecting packaging>=26 (from tox) 2026-02-16 17:38:43.465409 | ubuntu-noble | Downloading packaging-26.0-py3-none-any.whl.metadata (3.3 kB) 2026-02-16 17:38:43.536584 | ubuntu-noble | Collecting platformdirs>=4.9.1 (from tox) 2026-02-16 17:38:43.546612 | ubuntu-noble | Downloading platformdirs-4.9.2-py3-none-any.whl.metadata (4.7 kB) 2026-02-16 17:38:43.594683 | ubuntu-noble | Collecting pluggy>=1.6 (from tox) 2026-02-16 17:38:43.604470 | ubuntu-noble | Downloading pluggy-1.6.0-py3-none-any.whl.metadata (4.8 kB) 2026-02-16 17:38:43.730094 | ubuntu-noble | Collecting pyproject-api>=1.10 (from tox) 2026-02-16 17:38:43.742731 | ubuntu-noble | Downloading pyproject_api-1.10.0-py3-none-any.whl.metadata (2.7 kB) 2026-02-16 17:38:43.874125 | ubuntu-noble | Collecting virtualenv>=20.36.1 (from tox) 2026-02-16 17:38:43.883763 | ubuntu-noble | Downloading virtualenv-20.37.0-py3-none-any.whl.metadata (5.1 kB) 2026-02-16 17:38:43.992284 | ubuntu-noble | Collecting distlib<1,>=0.3.7 (from virtualenv>=20.36.1->tox) 2026-02-16 17:38:44.002997 | ubuntu-noble | Downloading distlib-0.4.0-py2.py3-none-any.whl.metadata (5.2 kB) 2026-02-16 17:38:44.042612 | ubuntu-noble | Downloading tox-4.36.0-py3-none-any.whl (179 kB) 2026-02-16 17:38:44.073718 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 179.1/179.1 kB 6.4 MB/s eta 0:00:00 2026-02-16 17:38:44.085547 | ubuntu-noble | Downloading cachetools-7.0.1-py3-none-any.whl (13 kB) 2026-02-16 17:38:44.106957 | ubuntu-noble | Downloading chardet-5.2.0-py3-none-any.whl (199 kB) 2026-02-16 17:38:44.125336 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 199.4/199.4 kB 14.1 MB/s eta 0:00:00 2026-02-16 17:38:44.135817 | ubuntu-noble | Downloading colorama-0.4.6-py2.py3-none-any.whl (25 kB) 2026-02-16 17:38:44.156269 | ubuntu-noble | Downloading filelock-3.24.2-py3-none-any.whl (24 kB) 2026-02-16 17:38:44.175107 | ubuntu-noble | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-02-16 17:38:44.188903 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 6.0 MB/s eta 0:00:00 2026-02-16 17:38:44.198779 | ubuntu-noble | Downloading platformdirs-4.9.2-py3-none-any.whl (21 kB) 2026-02-16 17:38:44.218472 | ubuntu-noble | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-02-16 17:38:44.236542 | ubuntu-noble | Downloading pyproject_api-1.10.0-py3-none-any.whl (13 kB) 2026-02-16 17:38:44.258075 | ubuntu-noble | Downloading virtualenv-20.37.0-py3-none-any.whl (5.8 MB) 2026-02-16 17:38:44.355545 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 5.8/5.8 MB 62.2 MB/s eta 0:00:00 2026-02-16 17:38:44.365788 | ubuntu-noble | Downloading distlib-0.4.0-py2.py3-none-any.whl (469 kB) 2026-02-16 17:38:44.389385 | ubuntu-noble | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 469.0/469.0 kB 25.6 MB/s eta 0:00:00 2026-02-16 17:38:44.463490 | ubuntu-noble | Installing collected packages: distlib, pluggy, platformdirs, packaging, filelock, colorama, chardet, cachetools, virtualenv, pyproject-api, tox 2026-02-16 17:38:45.384885 | 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:38:45.954784 | ubuntu-noble | ok: Runtime: 0:00:03.380927 2026-02-16 17:38:45.960931 | 2026-02-16 17:38:45.961017 | TASK [ensure-tox : Export installed tox_executable path] 2026-02-16 17:38:45.997377 | ubuntu-noble | ok 2026-02-16 17:38:46.004053 | 2026-02-16 17:38:46.004144 | TASK [ensure-tox : Output tox version] 2026-02-16 17:38:46.452924 | 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:38:46.468916 | ubuntu-noble | 4.36.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2026-02-16 17:38:46.576372 | ubuntu-noble | ok: Runtime: 0:00:00.270009 2026-02-16 17:38:46.582354 | 2026-02-16 17:38:46.582420 | TASK [ensure-tox : Make global symlink] 2026-02-16 17:38:46.606656 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:46.622759 | 2026-02-16 17:38:46.622812 | PLAY RECAP 2026-02-16 17:38:46.622859 | ubuntu-noble | ok: 13 changed: 9 unreachable: 0 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-02-16 17:38:46.622882 | 2026-02-16 17:38:46.862204 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/pre.yaml@master] 2026-02-16 17:38:46.863892 | PRE-RUN START: [untrusted : github.com/vexxhost/magnum-cluster-api/zuul.d/playbooks/tox/pre.yml@main] 2026-02-16 17:38:47.460519 | 2026-02-16 17:38:47.460691 | PLAY [all] 2026-02-16 17:38:47.473033 | 2026-02-16 17:38:47.473141 | TASK [ensure-rust : Use rustup] 2026-02-16 17:38:47.508987 | ubuntu-noble | ok 2026-02-16 17:38:47.515979 | ubuntu-noble | included: /var/lib/zuul/builds/980a3a8c846048bcbd379fa529b930ac/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-rust/tasks/rustup.yaml 2026-02-16 17:38:47.522144 | 2026-02-16 17:38:47.522224 | TASK [ensure-rust : Install Rust] 2026-02-16 17:38:47.912999 | ubuntu-noble | /bin/bash: line 2: curl: command not found 2026-02-16 17:38:48.069338 | ubuntu-noble | ERROR 2026-02-16 17:38:48.069572 | ubuntu-noble | { 2026-02-16 17:38:48.069603 | ubuntu-noble | "delta": "0:00:00.006275", 2026-02-16 17:38:48.069627 | ubuntu-noble | "end": "2026-02-16 17:38:47.913985", 2026-02-16 17:38:48.069647 | ubuntu-noble | "msg": "non-zero return code", 2026-02-16 17:38:48.069666 | ubuntu-noble | "rc": 127, 2026-02-16 17:38:48.069685 | ubuntu-noble | "start": "2026-02-16 17:38:47.907710" 2026-02-16 17:38:48.069710 | ubuntu-noble | } failure 2026-02-16 17:38:48.074266 | 2026-02-16 17:38:48.074334 | PLAY RECAP 2026-02-16 17:38:48.074397 | ubuntu-noble | ok: 1 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-02-16 17:38:48.074442 | 2026-02-16 17:38:48.208089 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/magnum-cluster-api/zuul.d/playbooks/tox/pre.yml@main] 2026-02-16 17:38:48.209975 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2026-02-16 17:38:48.821308 | 2026-02-16 17:38:48.821442 | PLAY [all] 2026-02-16 17:38:48.834401 | 2026-02-16 17:38:48.834484 | TASK [fetch-tox-output : Set tox log path for multiple nodes] 2026-02-16 17:38:48.880437 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:48.891354 | 2026-02-16 17:38:48.891463 | TASK [fetch-tox-output : Set tox log path for single node] 2026-02-16 17:38:48.944947 | ubuntu-noble | ok 2026-02-16 17:38:48.951655 | 2026-02-16 17:38:48.951723 | TASK [fetch-tox-output : Ensure local tox dir] 2026-02-16 17:38:49.382278 | ubuntu-noble -> localhost | changed 2026-02-16 17:38:49.392322 | 2026-02-16 17:38:49.392422 | TASK [fetch-tox-output : Ensure zuul-output tox dir] 2026-02-16 17:38:49.439400 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:49.447971 | 2026-02-16 17:38:49.448067 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 17:38:49.489567 | ubuntu-noble | ok 2026-02-16 17:38:49.496740 | 2026-02-16 17:38:49.496826 | TASK [fetch-tox-output : Get tox version] 2026-02-16 17:38:50.047500 | 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:38:50.061945 | ubuntu-noble | 4.36.0 from /home/zuul/.local/tox/lib/python3.12/site-packages/tox/__init__.py 2026-02-16 17:38:50.542398 | ubuntu-noble | ok: Runtime: 0:00:00.253256 2026-02-16 17:38:50.547605 | 2026-02-16 17:38:50.547669 | TASK [fetch-tox-output : Find all default environments] 2026-02-16 17:38:51.074579 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:51.082989 | 2026-02-16 17:38:51.083069 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 17:38:51.108124 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:51.117461 | 2026-02-16 17:38:51.117663 | TASK [fetch-tox-output : Find all default environments] 2026-02-16 17:38:51.668568 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:51.675776 | 2026-02-16 17:38:51.675861 | TASK [fetch-tox-output : Set envlist fact] 2026-02-16 17:38:51.700579 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:51.711065 | 2026-02-16 17:38:51.711197 | LOOP [fetch-tox-output : Copy tox logs] 2026-02-16 17:38:51.752630 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:51.769066 | 2026-02-16 17:38:51.769256 | LOOP [fetch-tox-output : Collect tox logs] 2026-02-16 17:38:52.550822 | ubuntu-noble | ok: 2026-02-16 17:38:52.551110 | 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 17:38:52.551195 | 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:38:52.551223 | ubuntu-noble | rsync: [Receiver] write error: Broken pipe (32) 2026-02-16 17:38:52.551283 | 2026-02-16 17:38:52.564974 | 2026-02-16 17:38:52.565144 | PLAY RECAP 2026-02-16 17:38:52.565204 | ubuntu-noble | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 7 rescued: 0 ignored: 0 2026-02-16 17:38:52.565228 | 2026-02-16 17:38:52.749637 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/tox/post.yaml@master] 2026-02-16 17:38:52.751193 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-16 17:38:53.379115 | 2026-02-16 17:38:53.379253 | PLAY [all] 2026-02-16 17:38:53.392796 | 2026-02-16 17:38:53.392886 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-02-16 17:38:53.566262 | ubuntu-noble | changed: non-zero return code 2026-02-16 17:38:53.572078 | 2026-02-16 17:38:53.572159 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-02-16 17:38:53.597562 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:53.607796 | 2026-02-16 17:38:53.607936 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-02-16 17:38:53.642444 | 2026-02-16 17:38:53.642631 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-02-16 17:38:53.673952 | 2026-02-16 17:38:53.674176 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-02-16 17:38:53.699329 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:53.710798 | 2026-02-16 17:38:53.710868 | LOOP [fetch-subunit-output : Generate subunit file] 2026-02-16 17:38:53.746690 | 2026-02-16 17:38:53.746858 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-02-16 17:38:53.772482 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:53.785396 | 2026-02-16 17:38:53.785518 | TASK [fetch-subunit-output : Remove the temporary file] 2026-02-16 17:38:53.811104 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:53.823050 | 2026-02-16 17:38:53.823156 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-02-16 17:38:53.848842 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:53.861944 | 2026-02-16 17:38:53.861997 | PLAY RECAP 2026-02-16 17:38:53.862044 | ubuntu-noble | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-16 17:38:53.862066 | 2026-02-16 17:38:53.998252 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-16 17:38:53.999626 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main] 2026-02-16 17:38:54.569892 | 2026-02-16 17:38:54.570033 | PLAY [all] 2026-02-16 17:38:54.582272 | 2026-02-16 17:38:54.582348 | TASK [fetch-output : Set log path for multiple nodes] 2026-02-16 17:38:54.627714 | ubuntu-noble | skipping: Conditional result was False 2026-02-16 17:38:54.637510 | 2026-02-16 17:38:54.637616 | TASK [fetch-output : Set log path for single node] 2026-02-16 17:38:54.682902 | ubuntu-noble | ok 2026-02-16 17:38:54.691349 | 2026-02-16 17:38:54.691443 | LOOP [fetch-output : Ensure local output dirs] 2026-02-16 17:38:55.104078 | ubuntu-noble -> localhost | ok: "/var/lib/zuul/builds/980a3a8c846048bcbd379fa529b930ac/work/logs" 2026-02-16 17:38:55.311253 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/980a3a8c846048bcbd379fa529b930ac/work/artifacts" 2026-02-16 17:38:55.622200 | ubuntu-noble -> localhost | changed: "/var/lib/zuul/builds/980a3a8c846048bcbd379fa529b930ac/work/docs" 2026-02-16 17:38:55.639465 | 2026-02-16 17:38:55.639702 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-16 17:38:56.401655 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 17:38:56.401899 | ubuntu-noble | changed: All items complete 2026-02-16 17:38:56.401929 | 2026-02-16 17:38:56.941560 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 17:38:57.447833 | ubuntu-noble | changed: .d..t...... ./ 2026-02-16 17:38:57.490414 | 2026-02-16 17:38:57.491145 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-02-16 17:38:57.994238 | ubuntu-noble -> localhost | ok: Item: artifacts Runtime: 0:00:00.008970 2026-02-16 17:38:58.235168 | ubuntu-noble -> localhost | ok: Item: docs Runtime: 0:00:00.009947 2026-02-16 17:38:58.255141 | 2026-02-16 17:38:58.255289 | PLAY [all] 2026-02-16 17:38:58.263074 | 2026-02-16 17:38:58.263169 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-02-16 17:38:58.785624 | ubuntu-noble | changed 2026-02-16 17:38:58.795577 | 2026-02-16 17:38:58.795633 | PLAY RECAP 2026-02-16 17:38:58.795679 | ubuntu-noble | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-02-16 17:38:58.795701 | 2026-02-16 17:38:58.963091 | POST-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main] 2026-02-16 17:38:58.964426 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post-logs.yaml@main] 2026-02-16 17:38:59.572340 | 2026-02-16 17:38:59.572468 | PLAY [localhost] 2026-02-16 17:38:59.582882 | 2026-02-16 17:38:59.582954 | TASK [Generate Zuul manifest] 2026-02-16 17:38:59.616484 | localhost | ok 2026-02-16 17:38:59.634748 | 2026-02-16 17:38:59.634827 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-16 17:38:59.979148 | localhost | changed 2026-02-16 17:38:59.995780 | 2026-02-16 17:38:59.995890 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-16 17:39:00.031840 | localhost | ok 2026-02-16 17:39:00.045354 | 2026-02-16 17:39:00.045429 | TASK [Upload logs] 2026-02-16 17:39:00.074344 | localhost | ok 2026-02-16 17:39:00.187849 | 2026-02-16 17:39:00.188046 | TASK [Set zuul-log-path fact] 2026-02-16 17:39:00.210645 | localhost | ok 2026-02-16 17:39:00.226401 | 2026-02-16 17:39:00.226596 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-16 17:39:00.263202 | localhost | ok 2026-02-16 17:39:00.271797 | 2026-02-16 17:39:00.271942 | TASK [upload-logs : Create log directories] 2026-02-16 17:39:00.733205 | localhost | changed 2026-02-16 17:39:00.738944 | 2026-02-16 17:39:00.739024 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-02-16 17:39:01.315844 | localhost -> localhost | ok: Runtime: 0:00:00.010419 2026-02-16 17:39:01.321391 | 2026-02-16 17:39:01.321458 | TASK [upload-logs : Upload logs to log server] 2026-02-16 17:39:01.917949 | localhost | Output suppressed because no_log was given 2026-02-16 17:39:01.922365 | 2026-02-16 17:39:01.922434 | LOOP [upload-logs : Compress console log and json output] 2026-02-16 17:39:01.983729 | localhost | skipping: Conditional result was False 2026-02-16 17:39:01.989899 | localhost | skipping: Conditional result was False 2026-02-16 17:39:02.005958 | 2026-02-16 17:39:02.006164 | LOOP [upload-logs : Upload compressed console log and json output] 2026-02-16 17:39:02.048436 | localhost | skipping: Conditional result was False 2026-02-16 17:39:02.048784 | 2026-02-16 17:39:02.051865 | localhost | skipping: Conditional result was False 2026-02-16 17:39:02.064404 | 2026-02-16 17:39:02.064627 | LOOP [upload-logs : Upload console log and json output]