2026-07-30 20:56:18.617940 | Job console starting 2026-07-30 20:56:18.625896 | Updating git repos 2026-07-30 20:56:21.489017 | Cloning repos into workspace 2026-07-30 20:56:44.695325 | Restoring repo states 2026-07-30 20:56:53.917617 | Merging changes 2026-07-30 20:57:00.285105 | Checking out repos 2026-07-30 20:57:14.073103 | Preparing playbooks 2026-07-30 20:57:23.933542 | Running Ansible setup 2026-07-30 20:57:28.629595 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-07-30 20:57:29.324640 | 2026-07-30 20:57:29.324793 | PLAY [localhost] 2026-07-30 20:57:29.343197 | 2026-07-30 20:57:29.343370 | TASK [Gathering Facts] 2026-07-30 20:57:30.307585 | localhost | ok 2026-07-30 20:57:30.320512 | 2026-07-30 20:57:30.320645 | TASK [Setup log path fact] 2026-07-30 20:57:30.353469 | localhost | ok 2026-07-30 20:57:30.530516 | 2026-07-30 20:57:30.530663 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-30 20:57:30.565781 | localhost | ok 2026-07-30 20:57:30.575634 | 2026-07-30 20:57:30.576151 | TASK [emit-job-header : Print job information] 2026-07-30 20:57:30.634110 | # Job Information 2026-07-30 20:57:30.634270 | Ansible Version: 2.16.18 2026-07-30 20:57:30.634304 | Job: atmosphere-molecule-aio-openvswitch-selective 2026-07-30 20:57:30.634328 | Pipeline: check 2026-07-30 20:57:30.634349 | Executor: 2d72f0692154 2026-07-30 20:57:30.634369 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4231 2026-07-30 20:57:30.634414 | Event ID: c446a930-8c55-11f1-9ad8-8a1b7bf3fa83 2026-07-30 20:57:30.640049 | 2026-07-30 20:57:30.640273 | LOOP [emit-job-header : Print node information] 2026-07-30 20:57:30.762252 | localhost | ok: 2026-07-30 20:57:30.762443 | localhost | # Node Information 2026-07-30 20:57:30.762483 | localhost | Inventory Hostname: instance 2026-07-30 20:57:30.762514 | localhost | Hostname: np0000187673 2026-07-30 20:57:30.762543 | localhost | Username: zuul 2026-07-30 20:57:30.762576 | localhost | Distro: Ubuntu 22.04 2026-07-30 20:57:30.762605 | localhost | Provider: yul1 2026-07-30 20:57:30.762632 | localhost | Region: ca-ymq-1 2026-07-30 20:57:30.762658 | localhost | Label: ubuntu-jammy-16 2026-07-30 20:57:30.762684 | localhost | Product Name: OpenStack Nova 2026-07-30 20:57:30.762710 | localhost | Interface IP: 199.204.45.238 2026-07-30 20:57:30.779762 | 2026-07-30 20:57:30.779909 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-07-30 20:57:31.151040 | localhost -> localhost | changed 2026-07-30 20:57:31.159053 | 2026-07-30 20:57:31.159150 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-07-30 20:57:32.834666 | localhost -> localhost | changed 2026-07-30 20:57:32.844003 | 2026-07-30 20:57:32.844503 | PLAY [all] 2026-07-30 20:57:32.852321 | 2026-07-30 20:57:32.852405 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-07-30 20:57:33.079314 | instance -> localhost | ok 2026-07-30 20:57:33.086130 | 2026-07-30 20:57:33.086210 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-07-30 20:57:33.117071 | instance | ok 2026-07-30 20:57:33.134766 | instance | included: /var/lib/zuul/builds/3eedc45cc79d401187fd3d64411838bd/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-07-30 20:57:33.288811 | 2026-07-30 20:57:33.288933 | TASK [add-build-sshkey : Create Temp SSH key] 2026-07-30 20:57:34.663076 | instance -> localhost | Generating public/private rsa key pair. 2026-07-30 20:57:34.663301 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/3eedc45cc79d401187fd3d64411838bd/work/3eedc45cc79d401187fd3d64411838bd_id_rsa 2026-07-30 20:57:34.663351 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/3eedc45cc79d401187fd3d64411838bd/work/3eedc45cc79d401187fd3d64411838bd_id_rsa.pub 2026-07-30 20:57:34.663385 | instance -> localhost | The key fingerprint is: 2026-07-30 20:57:34.663418 | instance -> localhost | SHA256:sTnlYqeSPaT4MGIfXvceUBQPo3yhRe71UoY3Emf5LNk zuul-build-sshkey 2026-07-30 20:57:34.663460 | instance -> localhost | The key's randomart image is: 2026-07-30 20:57:34.663497 | instance -> localhost | +---[RSA 3072]----+ 2026-07-30 20:57:34.663539 | instance -> localhost | | .O.. o. | 2026-07-30 20:57:34.663578 | instance -> localhost | | . * = =. | 2026-07-30 20:57:34.663616 | instance -> localhost | | = = = == | 2026-07-30 20:57:34.663653 | instance -> localhost | | X . *o.E| 2026-07-30 20:57:34.663688 | instance -> localhost | | S + . .. | 2026-07-30 20:57:34.663720 | instance -> localhost | | . * * . | 2026-07-30 20:57:34.663750 | instance -> localhost | | o = = = . | 2026-07-30 20:57:34.663781 | instance -> localhost | | . + * o o . | 2026-07-30 20:57:34.663813 | instance -> localhost | | o . .o | 2026-07-30 20:57:34.663844 | instance -> localhost | +----[SHA256]-----+ 2026-07-30 20:57:34.667298 | instance -> localhost | ok: Runtime: 0:00:00.799616 2026-07-30 20:57:34.674565 | 2026-07-30 20:57:34.674685 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-07-30 20:57:34.705999 | instance | ok 2026-07-30 20:57:34.731596 | instance | included: /var/lib/zuul/builds/3eedc45cc79d401187fd3d64411838bd/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-07-30 20:57:34.743437 | 2026-07-30 20:57:34.743571 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-07-30 20:57:34.767995 | instance | skipping: Conditional result was False 2026-07-30 20:57:34.780789 | 2026-07-30 20:57:34.780981 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-07-30 20:57:35.665875 | instance | changed 2026-07-30 20:57:35.673191 | 2026-07-30 20:57:35.673290 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-07-30 20:57:35.858630 | instance | ok 2026-07-30 20:57:35.864644 | 2026-07-30 20:57:35.864708 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-07-30 20:57:36.365776 | instance | changed 2026-07-30 20:57:36.375079 | 2026-07-30 20:57:36.375210 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-07-30 20:57:36.877224 | instance | changed 2026-07-30 20:57:36.884558 | 2026-07-30 20:57:36.884644 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-07-30 20:57:36.913311 | instance | skipping: Conditional result was False 2026-07-30 20:57:36.926694 | 2026-07-30 20:57:36.926855 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-07-30 20:57:37.745887 | instance -> localhost | changed 2026-07-30 20:57:37.766934 | 2026-07-30 20:57:37.767101 | TASK [add-build-sshkey : Add back temp key] 2026-07-30 20:57:38.068540 | instance -> localhost | Identity added: /var/lib/zuul/builds/3eedc45cc79d401187fd3d64411838bd/work/3eedc45cc79d401187fd3d64411838bd_id_rsa (zuul-build-sshkey) 2026-07-30 20:57:38.068777 | instance -> localhost | ok: Runtime: 0:00:00.011027 2026-07-30 20:57:38.077794 | 2026-07-30 20:57:38.077880 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-07-30 20:57:38.365017 | instance | ok 2026-07-30 20:57:38.371336 | 2026-07-30 20:57:38.371422 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-07-30 20:57:38.396106 | instance | skipping: Conditional result was False 2026-07-30 20:57:38.411038 | 2026-07-30 20:57:38.411172 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-07-30 20:57:38.697924 | instance | ok 2026-07-30 20:57:38.707338 | 2026-07-30 20:57:38.707432 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-07-30 20:57:47.102254 | instance | Output suppressed because no_log was given 2026-07-30 20:57:47.148989 | 2026-07-30 20:57:47.149126 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-07-30 20:57:47.349322 | instance | ok: "logs" 2026-07-30 20:57:47.349529 | instance | ok: All items complete 2026-07-30 20:57:47.349558 | 2026-07-30 20:57:47.508068 | instance | ok: "artifacts" 2026-07-30 20:57:47.654128 | instance | ok: "docs" 2026-07-30 20:57:47.675750 | 2026-07-30 20:57:47.675939 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-07-30 20:57:47.876923 | instance | changed: "logs" 2026-07-30 20:57:48.017940 | instance | changed: "artifacts" 2026-07-30 20:57:48.169768 | instance | changed: "docs" 2026-07-30 20:57:48.189913 | 2026-07-30 20:57:48.190010 | PLAY RECAP 2026-07-30 20:57:48.190068 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-07-30 20:57:48.190108 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-30 20:57:48.190141 | 2026-07-30 20:57:48.386766 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-07-30 20:57:48.394352 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-07-30 20:57:50.094505 | 2026-07-30 20:57:50.094667 | PLAY [all] 2026-07-30 20:57:50.108468 | 2026-07-30 20:57:50.108609 | TASK [setup-uv : Extract archive] 2026-07-30 20:57:52.744082 | instance | changed 2026-07-30 20:57:52.798487 | 2026-07-30 20:57:52.798678 | TASK [setup-uv : Print version] 2026-07-30 20:57:53.200196 | instance | uv 0.8.13 2026-07-30 20:57:53.337104 | instance | ok: Runtime: 0:00:00.012712 2026-07-30 20:57:53.349617 | 2026-07-30 20:57:53.349685 | TASK [Install Ansible collection siblings] 2026-07-30 20:58:02.942096 | instance | changed: 2026-07-30 20:58:03.049273 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-07-30 20:58:03.049504 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-07-30 20:58:03.049581 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-07-30 20:58:03.049649 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto 2026-07-30 20:58:03.049720 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general 2026-07-30 20:58:03.049805 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql 2026-07-30 20:58:03.049887 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-07-30 20:58:03.049978 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-07-30 20:58:03.050057 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-07-30 20:58:03.050125 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-07-30 20:58:03.050194 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-07-30 20:58:03.050258 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-07-30 20:58:03.050319 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0 2026-07-30 20:58:03.050380 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0 2026-07-30 20:58:03.050449 | instance | Resolved ansible.utils to v6.0.3 for >=2.9.0 2026-07-30 20:58:03.050523 | instance | Resolved community.crypto to 2.2.3 for 2.2.3 2026-07-30 20:58:03.050596 | instance | Resolved community.general to 7.3.0 for 7.3.0 2026-07-30 20:58:03.050670 | instance | Resolved community.mysql to 3.6.0 for 3.6.0 2026-07-30 20:58:03.050743 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0 2026-07-30 20:58:03.050813 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0 2026-07-30 20:58:03.050881 | instance | Resolved vexxhost.ceph to v4.1.0 for >=3.2.0 2026-07-30 20:58:03.050992 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0 2026-07-30 20:58:03.051088 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-07-30 20:58:03.051246 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0 2026-07-30 20:58:03.051316 | instance | Resolved ansible.utils to v6.0.3 for >=2.9.0,>=6.0.0 2026-07-30 20:58:03.051372 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-07-30 20:58:03.051478 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-07-30 20:58:03.051605 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-07-30 20:58:03.051729 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0 2026-07-30 20:58:03.051844 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3 2026-07-30 20:58:03.052025 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-07-30 20:58:03.052106 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-07-30 20:58:03.052176 | instance | Checked out ansible.netcommon to 1.2.0 2026-07-30 20:58:03.052249 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-07-30 20:58:03.052343 | instance | Starting galaxy collection install process 2026-07-30 20:58:03.052412 | instance | Process install dependency map 2026-07-30 20:58:03.052481 | instance | Starting collection install process 2026-07-30 20:58:03.052551 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon' 2026-07-30 20:58:03.052615 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon 2026-07-30 20:58:03.052721 | instance | ansible.netcommon:* was installed successfully 2026-07-30 20:58:03.052779 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-07-30 20:58:03.052831 | instance | Creating virtual environment at: .venv 2026-07-30 20:58:03.052893 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-07-30 20:58:03.052916 | instance | Downloading rjsonnet (1.2MiB) 2026-07-30 20:58:03.052937 | instance | Downloading openstacksdk (1.7MiB) 2026-07-30 20:58:03.052975 | instance | Downloading setuptools (1.1MiB) 2026-07-30 20:58:03.052996 | instance | Downloading pydantic-core (2.0MiB) 2026-07-30 20:58:03.053015 | instance | Downloading netaddr (2.2MiB) 2026-07-30 20:58:03.053037 | instance | Downloading cryptography (4.2MiB) 2026-07-30 20:58:03.053065 | instance | Downloading pygments (1.2MiB) 2026-07-30 20:58:03.053091 | instance | Downloading ansible-core (2.1MiB) 2026-07-30 20:58:03.053118 | instance | Downloading kubernetes (1.9MiB) 2026-07-30 20:58:03.053148 | instance | Building pyperclip==1.9.0 2026-07-30 20:58:03.053180 | instance | Downloading rjsonnet 2026-07-30 20:58:03.053211 | instance | Downloading pydantic-core 2026-07-30 20:58:03.053242 | instance | Downloading netaddr 2026-07-30 20:58:03.053273 | instance | Downloading pygments 2026-07-30 20:58:03.053304 | instance | Downloading cryptography 2026-07-30 20:58:03.053337 | instance | Downloading setuptools 2026-07-30 20:58:03.053369 | instance | Downloading kubernetes 2026-07-30 20:58:03.053402 | instance | Downloading ansible-core 2026-07-30 20:58:03.053434 | instance | Downloading openstacksdk 2026-07-30 20:58:03.053465 | instance | Built pyperclip==1.9.0 2026-07-30 20:58:03.053495 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-07-30 20:58:03.053523 | instance | Installed 87 packages in 48ms 2026-07-30 20:58:03.053549 | instance | Checked out ansible.posix to 1.6.0 2026-07-30 20:58:03.061822 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-07-30 20:58:03.061894 | instance | Starting galaxy collection install process 2026-07-30 20:58:03.061939 | instance | Process install dependency map 2026-07-30 20:58:03.061995 | instance | Starting collection install process 2026-07-30 20:58:03.062041 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-07-30 20:58:03.062087 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix 2026-07-30 20:58:03.062134 | instance | ansible.posix:1.6.0 was installed successfully 2026-07-30 20:58:03.062180 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-30 20:58:03.062222 | instance | 2.17.12 2026-07-30 20:58:03.062268 | instance | Checked out ansible.utils to v6.0.3 2026-07-30 20:58:03.062314 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-07-30 20:58:03.062359 | instance | Starting galaxy collection install process 2026-07-30 20:58:03.062403 | instance | Process install dependency map 2026-07-30 20:58:03.062443 | instance | Starting collection install process 2026-07-30 20:58:03.062482 | instance | Installing 'ansible.utils:6.0.3' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils' 2026-07-30 20:58:03.062522 | instance | Created collection for ansible.utils:6.0.3 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils 2026-07-30 20:58:03.062560 | instance | ansible.utils:6.0.3 was installed successfully 2026-07-30 20:58:03.062598 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-30 20:58:03.062637 | instance | 2.17.12 2026-07-30 20:58:03.062674 | instance | Checked out atmosphere.common to v0.7.0 2026-07-30 20:58:03.062712 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-07-30 20:58:03.062750 | instance | Starting galaxy collection install process 2026-07-30 20:58:03.062787 | instance | Process install dependency map 2026-07-30 20:58:03.062825 | instance | Starting collection install process 2026-07-30 20:58:03.062864 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common' 2026-07-30 20:58:03.062902 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common 2026-07-30 20:58:03.062942 | instance | atmosphere.common:0.7.0 was installed successfully 2026-07-30 20:58:03.062981 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-30 20:58:03.063018 | instance | 2.17.12 2026-07-30 20:58:03.063057 | instance | Checked out community.crypto to 2.2.3 2026-07-30 20:58:03.063096 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.crypto 2026-07-30 20:58:03.063135 | instance | Starting galaxy collection install process 2026-07-30 20:58:03.063174 | instance | Process install dependency map 2026-07-30 20:58:03.063213 | instance | Starting collection install process 2026-07-30 20:58:03.063251 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-07-30 20:58:03.063290 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto 2026-07-30 20:58:03.063330 | instance | community.crypto:2.2.3 was installed successfully 2026-07-30 20:58:03.063369 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-30 20:58:03.063409 | instance | 2.17.12 2026-07-30 20:58:03.063448 | instance | Checked out community.general to 7.3.0 2026-07-30 20:58:03.063487 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.general 2026-07-30 20:58:03.063646 | instance | Starting galaxy collection install process 2026-07-30 20:58:03.077343 | instance | Process install dependency map 2026-07-30 20:58:03.077389 | instance | Starting collection install process 2026-07-30 20:58:03.077418 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-07-30 20:58:03.077445 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general 2026-07-30 20:58:03.077473 | instance | community.general:7.3.0 was installed successfully 2026-07-30 20:58:03.077499 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-30 20:58:03.077526 | instance | 2.17.12 2026-07-30 20:58:03.077553 | instance | Checked out community.mysql to 3.6.0 2026-07-30 20:58:03.077584 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.mysql 2026-07-30 20:58:03.077615 | instance | Starting galaxy collection install process 2026-07-30 20:58:03.077641 | instance | Process install dependency map 2026-07-30 20:58:03.077667 | instance | Starting collection install process 2026-07-30 20:58:03.077693 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql' 2026-07-30 20:58:03.077719 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql 2026-07-30 20:58:03.077745 | instance | community.mysql:3.6.0 was installed successfully 2026-07-30 20:58:03.077771 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-30 20:58:03.077796 | instance | 2.17.12 2026-07-30 20:58:03.077822 | instance | Checked out kubernetes.core to 2.4.0 2026-07-30 20:58:03.077848 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-07-30 20:58:03.077873 | instance | Starting galaxy collection install process 2026-07-30 20:58:03.077898 | instance | Process install dependency map 2026-07-30 20:58:03.077924 | instance | Starting collection install process 2026-07-30 20:58:03.077950 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core' 2026-07-30 20:58:03.077975 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core 2026-07-30 20:58:03.078000 | instance | kubernetes.core:2.4.0 was installed successfully 2026-07-30 20:58:03.078025 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-30 20:58:03.078050 | instance | 2.17.12 2026-07-30 20:58:03.078075 | instance | Checked out openstack.cloud to 2.6.0 2026-07-30 20:58:03.078154 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-07-30 20:58:03.078250 | instance | Starting galaxy collection install process 2026-07-30 20:58:03.078314 | instance | Process install dependency map 2026-07-30 20:58:03.078348 | instance | Starting collection install process 2026-07-30 20:58:03.078375 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud' 2026-07-30 20:58:03.078402 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud 2026-07-30 20:58:03.078428 | instance | openstack.cloud:2.6.0 was installed successfully 2026-07-30 20:58:03.078453 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-30 20:58:03.078479 | instance | 2.17.12 2026-07-30 20:58:03.078517 | instance | Checked out vexxhost.ceph to v4.1.0 2026-07-30 20:58:03.078544 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-07-30 20:58:03.078571 | instance | Starting galaxy collection install process 2026-07-30 20:58:03.078597 | instance | Process install dependency map 2026-07-30 20:58:03.078622 | instance | Starting collection install process 2026-07-30 20:58:03.078647 | instance | Installing 'vexxhost.ceph:4.1.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph' 2026-07-30 20:58:03.078672 | instance | Created collection for vexxhost.ceph:4.1.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph 2026-07-30 20:58:03.078698 | instance | vexxhost.ceph:4.1.0 was installed successfully 2026-07-30 20:58:03.078723 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-30 20:58:03.078748 | instance | 2.17.12 2026-07-30 20:58:03.078773 | instance | Checked out vexxhost.containers to v1.6.8 2026-07-30 20:58:03.078799 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-07-30 20:58:03.078824 | instance | Starting galaxy collection install process 2026-07-30 20:58:03.078850 | instance | Process install dependency map 2026-07-30 20:58:03.078874 | instance | Starting collection install process 2026-07-30 20:58:03.078899 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers' 2026-07-30 20:58:03.078924 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers 2026-07-30 20:58:03.078950 | instance | vexxhost.containers:1.6.8 was installed successfully 2026-07-30 20:58:03.078975 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-30 20:58:03.079001 | instance | 2.17.12 2026-07-30 20:58:03.079027 | instance | Checked out vexxhost.kubernetes to v3.3.0 2026-07-30 20:58:03.079077 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-07-30 20:58:03.079112 | instance | Starting galaxy collection install process 2026-07-30 20:58:03.079146 | instance | Process install dependency map 2026-07-30 20:58:03.079179 | instance | Starting collection install process 2026-07-30 20:58:03.079212 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes' 2026-07-30 20:58:03.079244 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes 2026-07-30 20:58:03.079270 | instance | vexxhost.kubernetes:3.3.0 was installed successfully 2026-07-30 20:58:03.079295 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-07-30 20:58:03.079319 | instance | 2.17.12 2026-07-30 20:58:03.091863 | 2026-07-30 20:58:03.091946 | PLAY RECAP 2026-07-30 20:58:03.091993 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-30 20:58:03.092014 | 2026-07-30 20:58:03.244825 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-07-30 20:58:03.265701 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-07-30 20:58:03.912580 | 2026-07-30 20:58:03.912721 | PLAY [all] 2026-07-30 20:58:03.925532 | 2026-07-30 20:58:03.925653 | TASK [Install "jq" for log collection] 2026-07-30 20:58:15.775678 | instance | changed 2026-07-30 20:58:19.267631 | 2026-07-30 20:58:19.267851 | PLAY RECAP 2026-07-30 20:58:19.268015 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-30 20:58:19.268314 | 2026-07-30 20:58:19.449995 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-07-30 20:58:19.458207 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/prepare.yml@main] 2026-07-30 20:58:20.115222 | 2026-07-30 20:58:20.115366 | PLAY [Prepare selective Molecule plan] 2026-07-30 20:58:20.129241 | 2026-07-30 20:58:20.129469 | TASK [Generate selective Molecule plan] 2026-07-30 20:58:21.168082 | instance | ok: Runtime: 0:00:00.196598 2026-07-30 20:58:21.173193 | 2026-07-30 20:58:21.173271 | TASK [Render selective Molecule plan] 2026-07-30 20:58:21.468590 | instance | Selective Molecule plan: selective 2026-07-30 20:58:21.468710 | instance | Changed files: 2026-07-30 20:58:21.468726 | instance | A roles/multipathd/SELECTIVE_CI_VALIDATION.md 2026-07-30 20:58:21.468741 | instance | Targets: multipathd 2026-07-30 20:58:21.468754 | instance | Job decisions: 2026-07-30 20:58:21.468765 | instance | RUN aio-openvswitch: selected by changed components 2026-07-30 20:58:21.468778 | instance | components: multipathd 2026-07-30 20:58:21.468791 | instance | verification: host-command:systemctl is-active multipathd 2026-07-30 20:58:21.468803 | instance | SKIP aio-ovn: no changed component requires this job 2026-07-30 20:58:21.468813 | instance | SKIP csi-local-path-provisioner: no changed component requires this job 2026-07-30 20:58:21.468823 | instance | SKIP csi-rbd: no changed component requires this job 2026-07-30 20:58:21.468835 | instance | SKIP keycloak: no changed component requires this job 2026-07-30 20:58:22.128240 | instance | ok: Runtime: 0:00:00.113154 2026-07-30 20:58:22.130387 | 2026-07-30 20:58:22.130449 | PLAY RECAP 2026-07-30 20:58:22.130510 | instance | ok: 2 changed: 0 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-30 20:58:22.130549 | 2026-07-30 20:58:22.337354 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/prepare.yml@main] 2026-07-30 20:58:22.354196 | RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/selective-run.yml@main] 2026-07-30 20:58:22.982408 | 2026-07-30 20:58:22.982572 | PLAY [Run selected Molecule scenario] 2026-07-30 20:58:22.995684 | 2026-07-30 20:58:22.995813 | TASK [Read selective Molecule plan] 2026-07-30 20:58:23.343511 | instance | ok 2026-07-30 20:58:23.351986 | 2026-07-30 20:58:23.352163 | TASK [Resolve this job decision] 2026-07-30 20:58:23.416633 | instance | ok 2026-07-30 20:58:23.426108 | 2026-07-30 20:58:23.426175 | TASK [Assert this job exists in the plan] 2026-07-30 20:58:23.468754 | instance | ok: All assertions passed 2026-07-30 20:58:23.475288 | 2026-07-30 20:58:23.475405 | TASK [Resolve selected scenario inputs] 2026-07-30 20:58:23.507516 | instance | ok 2026-07-30 20:58:23.514706 | 2026-07-30 20:58:23.514811 | TASK [Report this job decision] 2026-07-30 20:58:23.581610 | instance | ok: 2026-07-30 20:58:23.581825 | instance | Selective Molecule job: aio-openvswitch 2026-07-30 20:58:23.581866 | instance | Decision: RUN 2026-07-30 20:58:23.581901 | instance | Reason: selected by changed components 2026-07-30 20:58:23.581934 | instance | Scenario: aio 2026-07-30 20:58:23.581963 | instance | Targets: multipathd 2026-07-30 20:58:23.581995 | instance | Components: multipathd 2026-07-30 20:58:23.590694 | 2026-07-30 20:58:23.590883 | LOOP [Check Molecule inventory directories] 2026-07-30 20:58:23.937985 | instance | ok: "src/github.com/vexxhost/atmosphere" 2026-07-30 20:58:24.107870 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/aio/inventory" 2026-07-30 20:58:24.272487 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/aio/inventory" 2026-07-30 20:58:24.295317 | 2026-07-30 20:58:24.295587 | LOOP [Copy Zuul inventory for Molecule] 2026-07-30 20:58:24.975893 | instance | changed: 2026-07-30 20:58:24.976056 | instance | { 2026-07-30 20:58:24.976084 | instance | "ansible_loop_var": "item", 2026-07-30 20:58:24.976105 | instance | "changed": false, 2026-07-30 20:58:24.976126 | instance | "failed": false, 2026-07-30 20:58:24.976144 | instance | "invocation": { 2026-07-30 20:58:24.976162 | instance | "module_args": { 2026-07-30 20:58:24.976179 | instance | "checksum_algorithm": "sha1", 2026-07-30 20:58:24.976197 | instance | "follow": true, 2026-07-30 20:58:24.976214 | instance | "get_attributes": true, 2026-07-30 20:58:24.976232 | instance | "get_checksum": true, 2026-07-30 20:58:24.976249 | instance | "get_mime": true, 2026-07-30 20:58:24.976267 | instance | "path": "src/github.com/vexxhost/atmosphere" 2026-07-30 20:58:24.976285 | instance | } 2026-07-30 20:58:24.976303 | instance | }, 2026-07-30 20:58:24.976320 | instance | "item": "src/github.com/vexxhost/atmosphere", 2026-07-30 20:58:24.976338 | instance | "stat": { 2026-07-30 20:58:24.976355 | instance | "atime": 1785445101.414091, 2026-07-30 20:58:24.976373 | instance | "attr_flags": "e", 2026-07-30 20:58:24.976390 | instance | "attributes": [ 2026-07-30 20:58:24.976408 | instance | "extents" 2026-07-30 20:58:24.976425 | instance | ], 2026-07-30 20:58:24.976442 | instance | "block_size": 4096, 2026-07-30 20:58:24.976459 | instance | "blocks": 8, 2026-07-30 20:58:24.976476 | instance | "charset": "unknown", 2026-07-30 20:58:24.976493 | instance | "ctime": 1785445100.6820784, 2026-07-30 20:58:24.976510 | instance | "dev": 64513, 2026-07-30 20:58:24.976527 | instance | "device_type": 0, 2026-07-30 20:58:24.976544 | instance | "executable": true, 2026-07-30 20:58:24.976561 | instance | "exists": true, 2026-07-30 20:58:24.976578 | instance | "gid": 1000, 2026-07-30 20:58:24.976595 | instance | "gr_name": "zuul", 2026-07-30 20:58:24.976612 | instance | "inode": 1047160, 2026-07-30 20:58:24.976629 | instance | "isblk": false, 2026-07-30 20:58:24.976646 | instance | "ischr": false, 2026-07-30 20:58:24.976665 | instance | "isdir": true, 2026-07-30 20:58:24.976683 | instance | "isfifo": false, 2026-07-30 20:58:24.976700 | instance | "isgid": false, 2026-07-30 20:58:24.976717 | instance | "islnk": false, 2026-07-30 20:58:24.976734 | instance | "isreg": false, 2026-07-30 20:58:24.976751 | instance | "issock": false, 2026-07-30 20:58:24.976768 | instance | "isuid": false, 2026-07-30 20:58:24.976785 | instance | "mimetype": "unknown", 2026-07-30 20:58:24.976802 | instance | "mode": "0755", 2026-07-30 20:58:24.976819 | instance | "mtime": 1785445100.6820784, 2026-07-30 20:58:24.976836 | instance | "nlink": 25, 2026-07-30 20:58:24.976853 | instance | "path": "src/github.com/vexxhost/atmosphere", 2026-07-30 20:58:24.976871 | instance | "pw_name": "zuul", 2026-07-30 20:58:24.976888 | instance | "readable": true, 2026-07-30 20:58:24.976905 | instance | "rgrp": true, 2026-07-30 20:58:24.976921 | instance | "roth": true, 2026-07-30 20:58:24.976938 | instance | "rusr": true, 2026-07-30 20:58:24.976970 | instance | "size": 4096, 2026-07-30 20:58:24.976989 | instance | "uid": 1000, 2026-07-30 20:58:24.977006 | instance | "version": "190681483", 2026-07-30 20:58:24.977022 | instance | "wgrp": false, 2026-07-30 20:58:24.977039 | instance | "woth": false, 2026-07-30 20:58:24.977055 | instance | "writeable": true, 2026-07-30 20:58:24.977071 | instance | "wusr": true, 2026-07-30 20:58:24.977087 | instance | "xgrp": true, 2026-07-30 20:58:24.977104 | instance | "xoth": true, 2026-07-30 20:58:24.977120 | instance | "xusr": true 2026-07-30 20:58:24.977137 | instance | } 2026-07-30 20:58:24.977153 | instance | } 2026-07-30 20:58:24.977185 | instance | ok: All items complete 2026-07-30 20:58:24.977204 | 2026-07-30 20:58:24.978268 | instance | skipping: Conditional result was False 2026-07-30 20:58:24.978907 | instance | skipping: Conditional result was False 2026-07-30 20:58:24.992390 | 2026-07-30 20:58:24.992557 | LOOP [Use private addresses in Molecule inventory] 2026-07-30 20:58:25.358897 | instance | changed: 1 replacements made 2026-07-30 20:58:25.369457 | instance | skipping: Conditional result was False 2026-07-30 20:58:25.369990 | instance | skipping: Conditional result was False 2026-07-30 20:58:25.382507 | 2026-07-30 20:58:25.382587 | TASK [Prepare Molecule command] 2026-07-30 20:58:25.445384 | instance | ok 2026-07-30 20:58:25.460865 | 2026-07-30 20:58:25.460948 | TASK [Run standard Molecule lifecycle with progress output] 2026-07-30 20:58:25.556778 | instance | ok 2026-07-30 20:58:25.603605 | instance | included: /var/lib/zuul/builds/3eedc45cc79d401187fd3d64411838bd/untrusted/project_5/github.com/vexxhost/atmosphere/test-playbooks/molecule/run-command.yml 2026-07-30 20:58:25.609537 | 2026-07-30 20:58:25.609603 | TASK [Create Molecule log directory] 2026-07-30 20:58:25.919770 | instance | changed 2026-07-30 20:58:25.926531 | 2026-07-30 20:58:25.926625 | TASK [Resolve live Molecule log path] 2026-07-30 20:58:25.962388 | instance | ok 2026-07-30 20:58:25.973991 | 2026-07-30 20:58:25.974085 | TASK [Start Molecule aio (aio-openvswitch)] 2026-07-30 20:58:26.594806 | instance | ok: ERROR (ignored) 2026-07-30 20:58:27.556890 | instance | { 2026-07-30 20:58:27.557098 | instance | "ansible_job_id": "j466031631180.1597", 2026-07-30 20:58:27.557153 | instance | "finished": 0, 2026-07-30 20:58:27.557176 | instance | "results_file": "/home/zuul/.ansible_async/j466031631180.1597", 2026-07-30 20:58:27.557195 | instance | "started": 1 2026-07-30 20:58:27.557215 | instance | } 2026-07-30 20:58:27.567188 | 2026-07-30 20:58:27.567435 | TASK [Initialize progress monitor for Molecule aio (aio-openvswitch)] 2026-07-30 20:58:27.630845 | instance | ok 2026-07-30 20:58:27.639614 | 2026-07-30 20:58:27.639993 | TASK [Bound progress monitor recursion for Molecule aio (aio-openvswitch)] 2026-07-30 20:58:27.689127 | instance | ok 2026-07-30 20:58:27.696295 | 2026-07-30 20:58:27.696490 | TASK [Calculate progress monitor chunks for Molecule aio (aio-openvswitch)] 2026-07-30 20:58:27.781824 | instance | ok 2026-07-30 20:58:27.794400 | 2026-07-30 20:58:27.794649 | LOOP [Monitor Molecule aio (aio-openvswitch)] 2026-07-30 20:58:27.850870 | instance | ok: 1 2026-07-30 20:58:28.084338 | instance | changed: All items complete 2026-07-30 20:58:28.084505 | 2026-07-30 20:58:28.097503 | instance | ok: 2 2026-07-30 20:58:28.108515 | instance | ok: 3 2026-07-30 20:58:28.118750 | instance | ok: 4 2026-07-30 20:58:28.123543 | instance | ok: 5 2026-07-30 20:58:28.143487 | instance | included: /var/lib/zuul/builds/3eedc45cc79d401187fd3d64411838bd/untrusted/project_5/github.com/vexxhost/atmosphere/test-playbooks/molecule/poll-chunk.yml 2026-07-30 20:58:28.144627 | instance | included: /var/lib/zuul/builds/3eedc45cc79d401187fd3d64411838bd/untrusted/project_5/github.com/vexxhost/atmosphere/test-playbooks/molecule/poll-chunk.yml 2026-07-30 20:58:28.145589 | instance | included: /var/lib/zuul/builds/3eedc45cc79d401187fd3d64411838bd/untrusted/project_5/github.com/vexxhost/atmosphere/test-playbooks/molecule/poll-chunk.yml 2026-07-30 20:58:28.146507 | instance | included: /var/lib/zuul/builds/3eedc45cc79d401187fd3d64411838bd/untrusted/project_5/github.com/vexxhost/atmosphere/test-playbooks/molecule/poll-chunk.yml 2026-07-30 20:58:28.147744 | instance | included: /var/lib/zuul/builds/3eedc45cc79d401187fd3d64411838bd/untrusted/project_5/github.com/vexxhost/atmosphere/test-playbooks/molecule/poll-chunk.yml 2026-07-30 20:58:28.156079 | 2026-07-30 20:58:28.156162 | TASK [Start progress monitor chunk for Molecule aio (aio-openvswitch)] 2026-07-30 20:58:28.210738 | instance | ok 2026-07-30 20:58:28.224602 | instance | included: /var/lib/zuul/builds/3eedc45cc79d401187fd3d64411838bd/untrusted/project_5/github.com/vexxhost/atmosphere/test-playbooks/molecule/poll-command.yml 2026-07-30 20:58:28.234222 | 2026-07-30 20:58:28.234432 | TASK [Wait before polling Molecule aio (aio-openvswitch)] 2026-07-30 20:58:48.307708 | instance | ok 2026-07-30 20:58:48.354159 | 2026-07-30 20:58:48.354278 | TASK [Count progress poll for Molecule aio (aio-openvswitch)] 2026-07-30 20:58:48.419784 | instance | ok 2026-07-30 20:58:48.530243 | 2026-07-30 20:58:48.530482 | TASK [Poll status for Molecule aio (aio-openvswitch)] 2026-07-30 20:58:48.953904 | instance | ok 2026-07-30 20:58:48.964717 | 2026-07-30 20:58:48.964844 | TASK [Inspect live log for Molecule aio (aio-openvswitch)] 2026-07-30 20:58:49.211127 | instance | ok 2026-07-30 20:58:49.230409 | 2026-07-30 20:58:49.230567 | TASK [Calculate new output for Molecule aio (aio-openvswitch)] 2026-07-30 20:58:49.290395 | instance | ok 2026-07-30 20:58:49.300524 | 2026-07-30 20:58:49.300694 | TASK [Read new output for Molecule aio (aio-openvswitch)] 2026-07-30 20:58:49.526336 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-07-30 20:58:49.526649 | instance | INFO [aio > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-07-30 20:58:49.526674 | instance | INFO [aio > prerun] Performing prerun with role_name_check=0... 2026-07-30 20:58:49.526686 | instance | INFO [aio > dependency] Executing 2026-07-30 20:58:49.526696 | instance | WARNING [aio > dependency] Missing roles requirements file: requirements.yml 2026-07-30 20:58:49.526707 | instance | WARNING [aio > dependency] Missing collections requirements file: collections.yml 2026-07-30 20:58:49.526722 | instance | WARNING [aio > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-07-30 20:58:49.526732 | instance | INFO [aio > cleanup] Executing 2026-07-30 20:58:49.526742 | instance | WARNING [aio > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-07-30 20:58:49.526751 | instance | INFO [aio > destroy] Executing 2026-07-30 20:58:49.526760 | instance | WARNING [aio > destroy] Skipping, '--destroy=never' requested. 2026-07-30 20:58:49.526769 | instance | INFO [aio > destroy] Executed: Successful 2026-07-30 20:58:49.526778 | instance | INFO [aio > syntax] Executing 2026-07-30 20:58:49.526788 | instance | 2026-07-30 20:58:49.526818 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/aio/converge.yml 2026-07-30 20:58:49.526828 | instance | INFO [aio > syntax] Executed: Successful 2026-07-30 20:58:49.526844 | instance | INFO [aio > create] Executing 2026-07-30 20:58:49.526859 | instance | WARNING [aio > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-07-30 20:58:49.526874 | instance | INFO [aio > prepare] Executing 2026-07-30 20:58:49.526890 | instance | 2026-07-30 20:58:49.526905 | instance | PLAY [Prepare] ***************************************************************** 2026-07-30 20:58:49.526920 | instance | 2026-07-30 20:58:49.526935 | instance | TASK [Gathering Facts] ********************************************************* 2026-07-30 20:58:49.526952 | instance | Thursday 30 July 2026 20:58:43 +0000 (0:00:00.030) 0:00:00.030 ********* 2026-07-30 20:58:49.527082 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-07-30 20:58:49.527117 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-07-30 20:58:49.527128 | instance | interpreter could change the meaning of that path. See 2026-07-30 20:58:49.527137 | instance | https://docs.ansible.com/ansible- 2026-07-30 20:58:49.527146 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-07-30 20:58:49.527155 | instance | ok: [instance] 2026-07-30 20:58:49.527164 | instance | 2026-07-30 20:58:49.527173 | instance | TASK [Configure short hostname] ************************************************ 2026-07-30 20:58:49.527182 | instance | Thursday 30 July 2026 20:58:44 +0000 (0:00:01.200) 0:00:01.230 ********* 2026-07-30 20:58:49.527191 | instance | changed: [instance] 2026-07-30 20:58:49.527200 | instance | 2026-07-30 20:58:49.527209 | instance | TASK [Ensure hostname inside hosts file] *************************************** 2026-07-30 20:58:49.527217 | instance | Thursday 30 July 2026 20:58:45 +0000 (0:00:00.744) 0:00:01.974 ********* 2026-07-30 20:58:49.527226 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created 2026-07-30 20:58:49.527235 | instance | with a mode of 0700, this may cause issues when running as another user. To 2026-07-30 20:58:49.527243 | instance | avoid this, create the remote_tmp dir with the correct permissions manually 2026-07-30 20:58:49.527252 | instance | changed: [instance] 2026-07-30 20:58:49.527261 | instance | 2026-07-30 20:58:49.527269 | instance | TASK [Install "dirmngr" for GPG keyserver operations] ************************** 2026-07-30 20:58:49.527278 | instance | Thursday 30 July 2026 20:58:45 +0000 (0:00:00.359) 0:00:02.334 ********* 2026-07-30 20:58:49.527287 | instance | ok: [instance] 2026-07-30 20:58:49.527295 | instance | 2026-07-30 20:58:49.527304 | instance | TASK [Purge "snapd" package] *************************************************** 2026-07-30 20:58:49.527312 | instance | Thursday 30 July 2026 20:58:47 +0000 (0:00:01.348) 0:00:03.683 ********* 2026-07-30 20:58:49.527321 | instance | ok: [instance] 2026-07-30 20:58:49.527342 | instance | 2026-07-30 20:58:49.527351 | instance | PLAY [Generate workspace for Atmosphere] *************************************** 2026-07-30 20:58:49.527359 | instance | 2026-07-30 20:58:49.527368 | instance | TASK [Create folders for workspace] ******************************************** 2026-07-30 20:58:49.527377 | instance | Thursday 30 July 2026 20:58:48 +0000 (0:00:00.894) 0:00:04.578 ********* 2026-07-30 20:58:49.527385 | instance | changed: [localhost] => (item=group_vars) 2026-07-30 20:58:49.527394 | instance | changed: [localhost] => (item=group_vars/all) 2026-07-30 20:58:49.527429 | instance | changed: [localhost] => (item=group_vars/controllers) 2026-07-30 20:58:49.527439 | instance | changed: [localhost] => (item=group_vars/cephs) 2026-07-30 20:58:49.850476 | instance | ok: Runtime: 0:00:00.010139 2026-07-30 20:58:49.858866 | 2026-07-30 20:58:49.858940 | TASK [Track last task for Molecule aio (aio-openvswitch)] 2026-07-30 20:58:49.930932 | instance | ok 2026-07-30 20:58:49.938290 | 2026-07-30 20:58:49.938365 | TASK [Advance live log offset for Molecule aio (aio-openvswitch)] 2026-07-30 20:58:49.992757 | instance | ok 2026-07-30 20:58:49.999821 | 2026-07-30 20:58:49.999916 | TASK [Report progress heartbeat for Molecule aio (aio-openvswitch)] 2026-07-30 20:58:50.054179 | instance | ok: 2026-07-30 20:58:50.054353 | instance | Molecule aio (aio-openvswitch) is still running after 20 seconds. 2026-07-30 20:58:50.054391 | instance | Last task: TASK [Create folders for workspace] 2026-07-30 20:58:50.061614 | 2026-07-30 20:58:50.061684 | TASK [Continue monitoring Molecule aio (aio-openvswitch)] 2026-07-30 20:58:50.119287 | instance | ok 2026-07-30 20:58:50.129137 | instance | included: /var/lib/zuul/builds/3eedc45cc79d401187fd3d64411838bd/untrusted/project_5/github.com/vexxhost/atmosphere/test-playbooks/molecule/poll-command.yml 2026-07-30 20:58:50.139703 | 2026-07-30 20:58:50.139773 | TASK [Wait before polling Molecule aio (aio-openvswitch)] 2026-07-30 20:59:10.196619 | instance | ok 2026-07-30 20:59:10.202655 | 2026-07-30 20:59:10.217504 | TASK [Count progress poll for Molecule aio (aio-openvswitch)] 2026-07-30 20:59:10.275021 | instance | ok 2026-07-30 20:59:10.280950 | 2026-07-30 20:59:10.281049 | TASK [Poll status for Molecule aio (aio-openvswitch)] 2026-07-30 20:59:10.510334 | instance | ok 2026-07-30 20:59:10.701187 | 2026-07-30 20:59:10.701326 | TASK [Inspect live log for Molecule aio (aio-openvswitch)] 2026-07-30 20:59:10.896261 | instance | ok 2026-07-30 20:59:10.906188 | 2026-07-30 20:59:10.906333 | TASK [Calculate new output for Molecule aio (aio-openvswitch)] 2026-07-30 20:59:10.964141 | instance | ok 2026-07-30 20:59:10.970225 | 2026-07-30 20:59:10.970332 | TASK [Read new output for Molecule aio (aio-openvswitch)] 2026-07-30 20:59:11.214383 | instance | changed: [localhost] => (item=group_vars/computes) 2026-07-30 20:59:11.214431 | instance | changed: [localhost] => (item=host_vars) 2026-07-30 20:59:11.214437 | instance | 2026-07-30 20:59:11.214443 | instance | PLAY [Generate Ceph control plane configuration for workspace] ***************** 2026-07-30 20:59:11.214447 | instance | 2026-07-30 20:59:11.214452 | instance | TASK [Ensure the Ceph control plane configuration file exists] ***************** 2026-07-30 20:59:11.214457 | instance | Thursday 30 July 2026 20:58:49 +0000 (0:00:01.420) 0:00:05.998 ********* 2026-07-30 20:59:11.214461 | instance | changed: [localhost] 2026-07-30 20:59:11.214465 | instance | 2026-07-30 20:59:11.214469 | instance | TASK [Load the current Ceph control plane configuration into a variable] ******* 2026-07-30 20:59:11.214474 | instance | Thursday 30 July 2026 20:58:49 +0000 (0:00:00.240) 0:00:06.239 ********* 2026-07-30 20:59:11.214478 | instance | ok: [localhost] 2026-07-30 20:59:11.214482 | instance | 2026-07-30 20:59:11.214486 | instance | TASK [Generate Ceph control plane values for missing variables] **************** 2026-07-30 20:59:11.214489 | instance | Thursday 30 July 2026 20:58:49 +0000 (0:00:00.020) 0:00:06.259 ********* 2026-07-30 20:59:11.214493 | instance | ok: [localhost] => (item={'key': 'ceph_fsid', 'value': 'f4b189b9-82a1-5296-b974-5bbfb7d75efa'}) 2026-07-30 20:59:11.214497 | instance | ok: [localhost] => (item={'key': 'ceph_mon_public_network', 'value': '10.96.240.0/24'}) 2026-07-30 20:59:11.214502 | instance | 2026-07-30 20:59:11.214505 | instance | TASK [Write new Ceph control plane configuration file to disk] ***************** 2026-07-30 20:59:11.214512 | instance | Thursday 30 July 2026 20:58:49 +0000 (0:00:00.042) 0:00:06.302 ********* 2026-07-30 20:59:11.214516 | instance | changed: [localhost] 2026-07-30 20:59:11.214519 | instance | 2026-07-30 20:59:11.214523 | instance | PLAY [Generate Ceph OSD configuration for workspace] *************************** 2026-07-30 20:59:11.214527 | instance | 2026-07-30 20:59:11.214531 | instance | TASK [Ensure the Ceph OSDs configuration file exists] ************************** 2026-07-30 20:59:11.214535 | instance | Thursday 30 July 2026 20:58:50 +0000 (0:00:00.683) 0:00:06.985 ********* 2026-07-30 20:59:11.214539 | instance | changed: [localhost] 2026-07-30 20:59:11.214542 | instance | 2026-07-30 20:59:11.214546 | instance | TASK [Load the current Ceph OSDs configuration into a variable] **************** 2026-07-30 20:59:11.214550 | instance | Thursday 30 July 2026 20:58:50 +0000 (0:00:00.227) 0:00:07.213 ********* 2026-07-30 20:59:11.214554 | instance | ok: [localhost] 2026-07-30 20:59:11.214558 | instance | 2026-07-30 20:59:11.214561 | instance | TASK [Generate Ceph OSDs values for missing variables] ************************* 2026-07-30 20:59:11.214565 | instance | Thursday 30 July 2026 20:58:50 +0000 (0:00:00.026) 0:00:07.239 ********* 2026-07-30 20:59:11.214569 | instance | ok: [localhost] => (item={'key': 'ceph_osd_devices', 'value': ['/dev/vdb', '/dev/vdc', '/dev/vdd']}) 2026-07-30 20:59:11.214573 | instance | 2026-07-30 20:59:11.214577 | instance | TASK [Write new Ceph OSDs configuration file to disk] ************************** 2026-07-30 20:59:11.214580 | instance | Thursday 30 July 2026 20:58:50 +0000 (0:00:00.029) 0:00:07.269 ********* 2026-07-30 20:59:11.214584 | instance | changed: [localhost] 2026-07-30 20:59:11.214588 | instance | 2026-07-30 20:59:11.214592 | instance | PLAY [Generate Kubernetes configuration for workspace] ************************* 2026-07-30 20:59:11.214596 | instance | 2026-07-30 20:59:11.214599 | instance | TASK [Ensure the Kubernetes configuration file exists] ************************* 2026-07-30 20:59:11.214603 | instance | Thursday 30 July 2026 20:58:51 +0000 (0:00:00.524) 0:00:07.793 ********* 2026-07-30 20:59:11.214607 | instance | changed: [localhost] 2026-07-30 20:59:11.214611 | instance | 2026-07-30 20:59:11.214614 | instance | TASK [Load the current Kubernetes configuration into a variable] *************** 2026-07-30 20:59:11.214618 | instance | Thursday 30 July 2026 20:58:51 +0000 (0:00:00.236) 0:00:08.030 ********* 2026-07-30 20:59:11.214622 | instance | ok: [localhost] 2026-07-30 20:59:11.214626 | instance | 2026-07-30 20:59:11.214630 | instance | TASK [Generate Kubernetes values for missing variables] ************************ 2026-07-30 20:59:11.214633 | instance | Thursday 30 July 2026 20:58:51 +0000 (0:00:00.028) 0:00:08.059 ********* 2026-07-30 20:59:11.214637 | instance | ok: [localhost] => (item={'key': 'kubernetes_hostname', 'value': '10.96.240.10'}) 2026-07-30 20:59:11.214645 | instance | ok: [localhost] => (item={'key': 'kubernetes_keepalived_vrid', 'value': 42}) 2026-07-30 20:59:11.214649 | instance | ok: [localhost] => (item={'key': 'kubernetes_keepalived_vip', 'value': '10.96.240.10'}) 2026-07-30 20:59:11.214653 | instance | 2026-07-30 20:59:11.214657 | instance | TASK [Write new Kubernetes configuration file to disk] ************************* 2026-07-30 20:59:11.214660 | instance | Thursday 30 July 2026 20:58:51 +0000 (0:00:00.045) 0:00:08.104 ********* 2026-07-30 20:59:11.214664 | instance | changed: [localhost] 2026-07-30 20:59:11.214668 | instance | 2026-07-30 20:59:11.214672 | instance | PLAY [Generate Keepalived configuration for workspace] ************************* 2026-07-30 20:59:11.214676 | instance | 2026-07-30 20:59:11.214679 | instance | TASK [Ensure the Keeaplived configuration file exists] ************************* 2026-07-30 20:59:11.214683 | instance | Thursday 30 July 2026 20:58:52 +0000 (0:00:00.509) 0:00:08.613 ********* 2026-07-30 20:59:11.214687 | instance | changed: [localhost] 2026-07-30 20:59:11.214691 | instance | 2026-07-30 20:59:11.214694 | instance | TASK [Load the current Keepalived configuration into a variable] *************** 2026-07-30 20:59:11.214698 | instance | Thursday 30 July 2026 20:58:52 +0000 (0:00:00.241) 0:00:08.855 ********* 2026-07-30 20:59:11.214702 | instance | ok: [localhost] 2026-07-30 20:59:11.214706 | instance | 2026-07-30 20:59:11.214710 | instance | TASK [Generate Keepalived values for missing variables] ************************ 2026-07-30 20:59:11.214713 | instance | Thursday 30 July 2026 20:58:52 +0000 (0:00:00.027) 0:00:08.883 ********* 2026-07-30 20:59:11.214717 | instance | ok: [localhost] => (item={'key': 'keepalived_interface', 'value': 'br-ex'}) 2026-07-30 20:59:11.214721 | instance | ok: [localhost] => (item={'key': 'keepalived_vip', 'value': '10.96.250.10'}) 2026-07-30 20:59:11.214725 | instance | 2026-07-30 20:59:11.214729 | instance | TASK [Write new Keepalived configuration file to disk] ************************* 2026-07-30 20:59:11.214732 | instance | Thursday 30 July 2026 20:58:52 +0000 (0:00:00.038) 0:00:08.921 ********* 2026-07-30 20:59:11.214736 | instance | changed: [localhost] 2026-07-30 20:59:11.214740 | instance | 2026-07-30 20:59:11.214744 | instance | PLAY [Generate endpoints for workspace] **************************************** 2026-07-30 20:59:11.214747 | instance | 2026-07-30 20:59:11.214751 | instance | TASK [Gathering Facts] ********************************************************* 2026-07-30 20:59:11.214760 | instance | Thursday 30 July 2026 20:58:52 +0000 (0:00:00.483) 0:00:09.404 ********* 2026-07-30 20:59:11.214764 | instance | ok: [localhost] 2026-07-30 20:59:11.214767 | instance | 2026-07-30 20:59:11.214771 | instance | TASK [Ensure the endpoints file exists] **************************************** 2026-07-30 20:59:11.214775 | instance | Thursday 30 July 2026 20:58:53 +0000 (0:00:00.919) 0:00:10.324 ********* 2026-07-30 20:59:11.214779 | instance | changed: [localhost] 2026-07-30 20:59:11.214783 | instance | 2026-07-30 20:59:11.214787 | instance | TASK [Load the current endpoints into a variable] ****************************** 2026-07-30 20:59:11.214791 | instance | Thursday 30 July 2026 20:58:54 +0000 (0:00:00.246) 0:00:10.571 ********* 2026-07-30 20:59:11.214795 | instance | ok: [localhost] 2026-07-30 20:59:11.214798 | instance | 2026-07-30 20:59:11.214802 | instance | TASK [Generate endpoint skeleton for missing variables] ************************ 2026-07-30 20:59:11.214808 | instance | Thursday 30 July 2026 20:58:54 +0000 (0:00:00.032) 0:00:10.604 ********* 2026-07-30 20:59:11.214812 | instance | ok: [localhost] => (item=keycloak_host) 2026-07-30 20:59:11.214816 | instance | ok: [localhost] => (item=kube_prometheus_stack_grafana_host) 2026-07-30 20:59:11.214820 | instance | ok: [localhost] => (item=kube_prometheus_stack_alertmanager_host) 2026-07-30 20:59:11.214823 | instance | ok: [localhost] => (item=kube_prometheus_stack_prometheus_host) 2026-07-30 20:59:11.214827 | instance | ok: [localhost] => (item=openstack_helm_endpoints_region_name) 2026-07-30 20:59:11.214831 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_api_host) 2026-07-30 20:59:11.214835 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_api_host) 2026-07-30 20:59:11.214839 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_api_host) 2026-07-30 20:59:11.214846 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_api_host) 2026-07-30 20:59:11.214850 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_api_host) 2026-07-30 20:59:11.214854 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_api_host) 2026-07-30 20:59:11.214858 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_api_host) 2026-07-30 20:59:11.214862 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_novnc_host) 2026-07-30 20:59:11.214865 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_api_host) 2026-07-30 20:59:11.214869 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_api_host) 2026-07-30 20:59:11.214873 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_api_host) 2026-07-30 20:59:11.214877 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_api_host) 2026-07-30 20:59:11.214881 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_registry_host) 2026-07-30 20:59:11.214884 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_api_host) 2026-07-30 20:59:11.214888 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_cfn_api_host) 2026-07-30 20:59:11.214892 | instance | ok: [localhost] => (item=openstack_helm_endpoints_horizon_api_host) 2026-07-30 20:59:11.214896 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rgw_host) 2026-07-30 20:59:11.214900 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_api_host) 2026-07-30 20:59:11.214903 | instance | 2026-07-30 20:59:11.214907 | instance | TASK [Write new endpoints file to disk] **************************************** 2026-07-30 20:59:11.214911 | instance | Thursday 30 July 2026 20:58:54 +0000 (0:00:00.792) 0:00:11.397 ********* 2026-07-30 20:59:11.214935 | instance | changed: [localhost] 2026-07-30 20:59:11.214939 | instance | 2026-07-30 20:59:11.214990 | instance | TASK [Ensure the endpoints file exists] **************************************** 2026-07-30 20:59:11.214995 | instance | Thursday 30 July 2026 20:58:55 +0000 (0:00:00.480) 0:00:11.877 ********* 2026-07-30 20:59:11.214999 | instance | changed: [localhost] 2026-07-30 20:59:11.215003 | instance | 2026-07-30 20:59:11.215006 | instance | PLAY [Generate Neutron configuration for workspace] **************************** 2026-07-30 20:59:11.215010 | instance | 2026-07-30 20:59:11.215014 | instance | TASK [Ensure the Neutron configuration file exists] **************************** 2026-07-30 20:59:11.215018 | instance | Thursday 30 July 2026 20:58:55 +0000 (0:00:00.265) 0:00:12.143 ********* 2026-07-30 20:59:11.215022 | instance | changed: [localhost] 2026-07-30 20:59:11.215026 | instance | 2026-07-30 20:59:11.215029 | instance | TASK [Load the current Neutron configuration into a variable] ****************** 2026-07-30 20:59:11.215033 | instance | Thursday 30 July 2026 20:58:55 +0000 (0:00:00.247) 0:00:12.391 ********* 2026-07-30 20:59:11.215037 | instance | ok: [localhost] 2026-07-30 20:59:11.215041 | instance | 2026-07-30 20:59:11.215044 | instance | TASK [Generate Neutron values for missing variables] *************************** 2026-07-30 20:59:11.215048 | instance | Thursday 30 July 2026 20:58:55 +0000 (0:00:00.033) 0:00:12.424 ********* 2026-07-30 20:59:11.215053 | instance | ok: [localhost] => (item={'key': 'neutron_networks', 'value': [{'name': 'public', 'external': True, 'shared': True, 'mtu_size': 1500, 'port_security_enabled': True, 'provider_network_type': 'flat', 'provider_physical_network': 'external', 'subnets': [{'name': 'public-subnet', 'cidr': '10.96.250.0/24', 'gateway_ip': '10.96.250.10', 'allocation_pool_start': '10.96.250.200', 'allocation_pool_end': '10.96.250.220', 'enable_dhcp': True}]}]}) 2026-07-30 20:59:11.215057 | instance | 2026-07-30 20:59:11.215061 | instance | TASK [Write new Neutron configuration file to disk] **************************** 2026-07-30 20:59:11.215064 | instance | Thursday 30 July 2026 20:58:55 +0000 (0:00:00.043) 0:00:12.468 ********* 2026-07-30 20:59:11.215068 | instance | changed: [localhost] 2026-07-30 20:59:11.215072 | instance | 2026-07-30 20:59:11.215076 | instance | PLAY [Generate Nova configuration for workspace] ******************************* 2026-07-30 20:59:11.215080 | instance | 2026-07-30 20:59:11.215083 | instance | TASK [Ensure the Nova configuration file exists] ******************************* 2026-07-30 20:59:11.215087 | instance | Thursday 30 July 2026 20:58:56 +0000 (0:00:00.505) 0:00:12.973 ********* 2026-07-30 20:59:11.215095 | instance | changed: [localhost] 2026-07-30 20:59:11.215099 | instance | 2026-07-30 20:59:11.215103 | instance | TASK [Load the current Nova configuration into a variable] ********************* 2026-07-30 20:59:11.215111 | instance | Thursday 30 July 2026 20:58:56 +0000 (0:00:00.259) 0:00:13.233 ********* 2026-07-30 20:59:11.215115 | instance | ok: [localhost] 2026-07-30 20:59:11.215119 | instance | 2026-07-30 20:59:11.215122 | instance | TASK [Generate Nova values for missing variables] ****************************** 2026-07-30 20:59:11.215126 | instance | Thursday 30 July 2026 20:58:56 +0000 (0:00:00.031) 0:00:13.264 ********* 2026-07-30 20:59:11.215132 | instance | ok: [localhost] => (item={'key': 'nova_flavors', 'value': [{'name': 'm1.tiny', 'ram': 512, 'disk': 1, 'vcpus': 1}, {'name': 'm1.small', 'ram': 2048, 'disk': 20, 'vcpus': 1}, {'name': 'm1.medium', 'ram': 4096, 'disk': 40, 'vcpus': 2}, {'name': 'm1.large', 'ram': 8192, 'disk': 80, 'vcpus': 4}, {'name': 'm1.xlarge', 'ram': 16384, 'disk': 160, 'vcpus': 8}]}) 2026-07-30 20:59:11.215136 | instance | 2026-07-30 20:59:11.215140 | instance | TASK [Write new Nova configuration file to disk] ******************************* 2026-07-30 20:59:11.215144 | instance | Thursday 30 July 2026 20:58:56 +0000 (0:00:00.039) 0:00:13.303 ********* 2026-07-30 20:59:11.215148 | instance | changed: [localhost] 2026-07-30 20:59:11.215152 | instance | 2026-07-30 20:59:11.215155 | instance | PLAY [Generate secrets for workspace] ****************************************** 2026-07-30 20:59:11.215159 | instance | 2026-07-30 20:59:11.215163 | instance | TASK [Ensure the secrets file exists] ****************************************** 2026-07-30 20:59:11.215167 | instance | Thursday 30 July 2026 20:58:57 +0000 (0:00:00.518) 0:00:13.822 ********* 2026-07-30 20:59:11.215171 | instance | changed: [localhost] 2026-07-30 20:59:11.215175 | instance | 2026-07-30 20:59:11.215179 | instance | TASK [Load the current secrets into a variable] ******************************** 2026-07-30 20:59:11.215183 | instance | Thursday 30 July 2026 20:58:57 +0000 (0:00:00.244) 0:00:14.067 ********* 2026-07-30 20:59:11.215187 | instance | ok: [localhost] 2026-07-30 20:59:11.215192 | instance | 2026-07-30 20:59:11.215196 | instance | TASK [Generate secrets for missing variables] ********************************** 2026-07-30 20:59:11.215200 | instance | Thursday 30 July 2026 20:58:57 +0000 (0:00:00.031) 0:00:14.098 ********* 2026-07-30 20:59:11.215205 | instance | ok: [localhost] => (item=heat_auth_encryption_key) 2026-07-30 20:59:11.215210 | instance | ok: [localhost] => (item=keepalived_password) 2026-07-30 20:59:11.215214 | instance | ok: [localhost] => (item=keycloak_admin_password) 2026-07-30 20:59:11.215218 | instance | ok: [localhost] => (item=keycloak_database_password) 2026-07-30 20:59:11.215222 | instance | ok: [localhost] => (item=keystone_keycloak_client_secret) 2026-07-30 20:59:11.215226 | instance | ok: [localhost] => (item=keystone_oidc_crypto_passphrase) 2026-07-30 20:59:11.215229 | instance | ok: [localhost] => (item=kube_prometheus_stack_grafana_admin_password) 2026-07-30 20:59:11.215233 | instance | ok: [localhost] => (item=octavia_heartbeat_key) 2026-07-30 20:59:11.215237 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rabbitmq_admin_password) 2026-07-30 20:59:11.215241 | instance | ok: [localhost] => (item=openstack_helm_endpoints_memcached_secret_key) 2026-07-30 20:59:11.215245 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_admin_password) 2026-07-30 20:59:11.215249 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_mariadb_password) 2026-07-30 20:59:11.215252 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_rabbitmq_password) 2026-07-30 20:59:11.215256 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_keystone_password) 2026-07-30 20:59:11.215260 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_mariadb_password) 2026-07-30 20:59:11.215264 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_rabbitmq_password) 2026-07-30 20:59:11.215268 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_keystone_password) 2026-07-30 20:59:11.215271 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_mariadb_password) 2026-07-30 20:59:11.215275 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_rabbitmq_password) 2026-07-30 20:59:11.215282 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_keystone_password) 2026-07-30 20:59:11.215286 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_mariadb_password) 2026-07-30 20:59:11.215290 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_keystone_password) 2026-07-30 20:59:11.215294 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_mariadb_password) 2026-07-30 20:59:11.215297 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_keystone_password) 2026-07-30 20:59:11.215301 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_mariadb_password) 2026-07-30 20:59:11.215305 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_rabbitmq_password) 2026-07-30 20:59:11.215309 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_metadata_secret) 2026-07-30 20:59:11.215313 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_keystone_password) 2026-07-30 20:59:11.215316 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_mariadb_password) 2026-07-30 20:59:11.215320 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_rabbitmq_password) 2026-07-30 20:59:11.215324 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_keystone_password) 2026-07-30 20:59:11.215328 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_mariadb_password) 2026-07-30 20:59:11.215332 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_rabbitmq_password) 2026-07-30 20:59:11.215335 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_keystone_password) 2026-07-30 20:59:11.215339 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_mariadb_password) 2026-07-30 20:59:11.215343 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_rabbitmq_password) 2026-07-30 20:59:11.215347 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_keystone_password) 2026-07-30 20:59:11.215351 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_mariadb_password) 2026-07-30 20:59:11.215360 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_rabbitmq_password) 2026-07-30 20:59:11.215364 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_keystone_password) 2026-07-30 20:59:11.215368 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_mariadb_password) 2026-07-30 20:59:11.215374 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_rabbitmq_password) 2026-07-30 20:59:11.215378 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_keystone_password) 2026-07-30 20:59:11.215382 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_trustee_keystone_password) 2026-07-30 20:59:11.215385 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_stack_user_keystone_password) 2026-07-30 20:59:11.215407 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_mariadb_password) 2026-07-30 20:59:11.215423 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_rabbitmq_password) 2026-07-30 20:59:11.215429 | instance | ok: [localhost] => (item=openstack_helm_endpoints_horizon_mariadb_password) 2026-07-30 20:59:11.215435 | instance | ok: [localhost] => (item=openstack_helm_endpoints_tempest_keystone_password) 2026-07-30 20:59:11.215440 | instance | ok: [localhost] => (item=openstack_helm_endpoints_openstack_exporter_keystone_password) 2026-07-30 20:59:11.215445 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rgw_keystone_password) 2026-07-30 20:59:11.215450 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_keystone_password) 2026-07-30 20:59:11.215455 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_mariadb_password) 2026-07-30 20:59:11.215460 | instance | ok: [localhost] => (item=openstack_helm_endpoints_staffeln_mariadb_password) 2026-07-30 20:59:11.215465 | instance | 2026-07-30 20:59:11.215468 | instance | TASK [Generate base64 encoded secrets] ***************************************** 2026-07-30 20:59:11.215472 | instance | Thursday 30 July 2026 20:58:57 +0000 (0:00:00.419) 0:00:14.518 ********* 2026-07-30 20:59:11.215476 | instance | ok: [localhost] => (item=barbican_kek) 2026-07-30 20:59:11.215480 | instance | 2026-07-30 20:59:11.215489 | instance | TASK [Generate temporary files for generating keys for missing variables] ****** 2026-07-30 20:59:11.215492 | instance | Thursday 30 July 2026 20:58:58 +0000 (0:00:00.059) 0:00:14.577 ********* 2026-07-30 20:59:11.215496 | instance | changed: [localhost] => (item=manila_ssh_key) 2026-07-30 20:59:11.215500 | instance | changed: [localhost] => (item=nova_ssh_key) 2026-07-30 20:59:11.215504 | instance | 2026-07-30 20:59:11.215507 | instance | TASK [Generate SSH keys for missing variables] ********************************* 2026-07-30 20:59:11.215511 | instance | Thursday 30 July 2026 20:58:58 +0000 (0:00:00.544) 0:00:15.121 ********* 2026-07-30 20:59:11.215515 | instance | changed: [localhost] => (item=manila_ssh_key) 2026-07-30 20:59:11.215519 | instance | changed: [localhost] => (item=nova_ssh_key) 2026-07-30 20:59:11.215523 | instance | 2026-07-30 20:59:11.215526 | instance | TASK [Set values for SSH keys] ************************************************* 2026-07-30 20:59:11.215530 | instance | Thursday 30 July 2026 20:59:01 +0000 (0:00:03.072) 0:00:18.194 ********* 2026-07-30 20:59:11.215534 | instance | ok: [localhost] => (item=manila_ssh_key) 2026-07-30 20:59:11.215538 | instance | ok: [localhost] => (item=nova_ssh_key) 2026-07-30 20:59:11.215541 | instance | 2026-07-30 20:59:11.215545 | instance | TASK [Delete the temporary files generated for SSH keys] *********************** 2026-07-30 20:59:11.215549 | instance | Thursday 30 July 2026 20:59:01 +0000 (0:00:00.057) 0:00:18.252 ********* 2026-07-30 20:59:11.215553 | instance | changed: [localhost] => (item=manila_ssh_key) 2026-07-30 20:59:11.215556 | instance | changed: [localhost] => (item=nova_ssh_key) 2026-07-30 20:59:11.215560 | instance | 2026-07-30 20:59:11.215564 | instance | TASK [Write new secrets file to disk] ****************************************** 2026-07-30 20:59:11.215568 | instance | Thursday 30 July 2026 20:59:02 +0000 (0:00:00.510) 0:00:18.763 ********* 2026-07-30 20:59:11.215571 | instance | changed: [localhost] 2026-07-30 20:59:11.215575 | instance | 2026-07-30 20:59:11.215579 | instance | TASK [Encrypt secrets file with Vault password] ******************************** 2026-07-30 20:59:11.215583 | instance | Thursday 30 July 2026 20:59:02 +0000 (0:00:00.508) 0:00:19.271 ********* 2026-07-30 20:59:11.215586 | instance | skipping: [localhost] 2026-07-30 20:59:11.215590 | instance | 2026-07-30 20:59:11.215594 | instance | PLAY [Setup networking] ******************************************************** 2026-07-30 20:59:11.215597 | instance | 2026-07-30 20:59:11.215602 | instance | TASK [Gathering Facts] ********************************************************* 2026-07-30 20:59:11.215607 | instance | Thursday 30 July 2026 20:59:02 +0000 (0:00:00.041) 0:00:19.312 ********* 2026-07-30 20:59:11.215623 | instance | ok: [instance] 2026-07-30 20:59:11.215629 | instance | 2026-07-30 20:59:11.215634 | instance | TASK [Create bridge for management network] ************************************ 2026-07-30 20:59:11.215639 | instance | Thursday 30 July 2026 20:59:04 +0000 (0:00:01.750) 0:00:21.063 ********* 2026-07-30 20:59:11.215643 | instance | ok: [instance] 2026-07-30 20:59:11.215648 | instance | 2026-07-30 20:59:11.215652 | instance | TASK [Create fake interface for management bridge] ***************************** 2026-07-30 20:59:11.215656 | instance | Thursday 30 July 2026 20:59:04 +0000 (0:00:00.439) 0:00:21.502 ********* 2026-07-30 20:59:11.215660 | instance | ok: [instance] 2026-07-30 20:59:11.215663 | instance | 2026-07-30 20:59:11.215667 | instance | TASK [Assign dummy interface to management bridge] ***************************** 2026-07-30 20:59:11.215671 | instance | Thursday 30 July 2026 20:59:05 +0000 (0:00:00.238) 0:00:21.740 ********* 2026-07-30 20:59:11.215675 | instance | ok: [instance] 2026-07-30 20:59:11.215678 | instance | 2026-07-30 20:59:11.215682 | instance | TASK [Assign IP address for management bridge] ********************************* 2026-07-30 20:59:11.215689 | instance | Thursday 30 July 2026 20:59:05 +0000 (0:00:00.202) 0:00:21.943 ********* 2026-07-30 20:59:11.215693 | instance | ok: [instance] 2026-07-30 20:59:11.215697 | instance | 2026-07-30 20:59:11.215700 | instance | TASK [Bring up interfaces] ***************************************************** 2026-07-30 20:59:11.215704 | instance | Thursday 30 July 2026 20:59:05 +0000 (0:00:00.204) 0:00:22.147 ********* 2026-07-30 20:59:11.215708 | instance | ok: [instance] => (item=br-mgmt) 2026-07-30 20:59:11.215712 | instance | ok: [instance] => (item=dummy0) 2026-07-30 20:59:11.215721 | instance | 2026-07-30 20:59:11.215725 | instance | PLAY [Create devices for Ceph] ************************************************* 2026-07-30 20:59:11.215728 | instance | 2026-07-30 20:59:11.215736 | instance | TASK [Gathering Facts] ********************************************************* 2026-07-30 20:59:11.215740 | instance | Thursday 30 July 2026 20:59:05 +0000 (0:00:00.390) 0:00:22.538 ********* 2026-07-30 20:59:11.215744 | instance | ok: [instance] 2026-07-30 20:59:11.215748 | instance | 2026-07-30 20:59:11.215752 | instance | TASK [Install depedencies] ***************************************************** 2026-07-30 20:59:11.215755 | instance | Thursday 30 July 2026 20:59:06 +0000 (0:00:00.775) 0:00:23.313 ********* 2026-07-30 20:59:11.546041 | instance | ok: Runtime: 0:00:00.009581 2026-07-30 20:59:11.555040 | 2026-07-30 20:59:11.555123 | TASK [Track last task for Molecule aio (aio-openvswitch)] 2026-07-30 20:59:11.615549 | instance | ok 2026-07-30 20:59:11.621925 | 2026-07-30 20:59:11.622056 | TASK [Advance live log offset for Molecule aio (aio-openvswitch)] 2026-07-30 20:59:11.674354 | instance | ok 2026-07-30 20:59:11.682045 | 2026-07-30 20:59:11.682122 | TASK [Report progress heartbeat for Molecule aio (aio-openvswitch)] 2026-07-30 20:59:11.754839 | instance | ok: 2026-07-30 20:59:11.755025 | instance | Molecule aio (aio-openvswitch) is still running after 40 seconds. 2026-07-30 20:59:11.755066 | instance | Last task: TASK [Install depedencies] 2026-07-30 20:59:11.764253 | 2026-07-30 20:59:11.764336 | TASK [Continue monitoring Molecule aio (aio-openvswitch)] 2026-07-30 20:59:11.839556 | instance | ok 2026-07-30 20:59:11.849959 | instance | included: /var/lib/zuul/builds/3eedc45cc79d401187fd3d64411838bd/untrusted/project_5/github.com/vexxhost/atmosphere/test-playbooks/molecule/poll-command.yml 2026-07-30 20:59:11.861925 | 2026-07-30 20:59:11.861999 | TASK [Wait before polling Molecule aio (aio-openvswitch)] 2026-07-30 20:59:31.918886 | instance | ok 2026-07-30 20:59:31.928468 | 2026-07-30 20:59:31.928571 | TASK [Count progress poll for Molecule aio (aio-openvswitch)] 2026-07-30 20:59:31.987587 | instance | ok 2026-07-30 20:59:31.993714 | 2026-07-30 20:59:31.993787 | TASK [Poll status for Molecule aio (aio-openvswitch)] 2026-07-30 20:59:32.220256 | instance | ok 2026-07-30 20:59:32.233858 | 2026-07-30 20:59:32.233942 | TASK [Inspect live log for Molecule aio (aio-openvswitch)] 2026-07-30 20:59:32.432468 | instance | ok 2026-07-30 20:59:32.442795 | 2026-07-30 20:59:32.442900 | TASK [Calculate new output for Molecule aio (aio-openvswitch)] 2026-07-30 20:59:32.513122 | instance | ok 2026-07-30 20:59:32.519371 | 2026-07-30 20:59:32.519449 | TASK [Read new output for Molecule aio (aio-openvswitch)] 2026-07-30 20:59:32.739208 | instance | changed: [instance] 2026-07-30 20:59:32.739475 | instance | 2026-07-30 20:59:32.739487 | instance | TASK [Start up service] ******************************************************** 2026-07-30 20:59:32.739497 | instance | Thursday 30 July 2026 20:59:29 +0000 (0:00:23.143) 0:00:46.457 ********* 2026-07-30 20:59:32.739507 | instance | ok: [instance] 2026-07-30 20:59:32.739513 | instance | 2026-07-30 20:59:32.739520 | instance | TASK [Generate lvm.conf] ******************************************************* 2026-07-30 20:59:32.739527 | instance | Thursday 30 July 2026 20:59:30 +0000 (0:00:00.568) 0:00:47.026 ********* 2026-07-30 20:59:32.739533 | instance | ok: [instance] 2026-07-30 20:59:32.739538 | instance | 2026-07-30 20:59:32.739545 | instance | TASK [Write /etc/lvm/lvm.conf] ************************************************* 2026-07-30 20:59:32.739552 | instance | Thursday 30 July 2026 20:59:30 +0000 (0:00:00.223) 0:00:47.250 ********* 2026-07-30 20:59:32.739558 | instance | changed: [instance] 2026-07-30 20:59:32.739563 | instance | 2026-07-30 20:59:32.739569 | instance | TASK [Get list of all loopback devices] **************************************** 2026-07-30 20:59:32.739574 | instance | Thursday 30 July 2026 20:59:31 +0000 (0:00:00.503) 0:00:47.753 ********* 2026-07-30 20:59:32.739580 | instance | ok: [instance] 2026-07-30 20:59:32.739585 | instance | 2026-07-30 20:59:32.739591 | instance | TASK [Fail if there is any existing loopback devices] ************************** 2026-07-30 20:59:32.739596 | instance | Thursday 30 July 2026 20:59:31 +0000 (0:00:00.218) 0:00:47.972 ********* 2026-07-30 20:59:32.739601 | instance | skipping: [instance] 2026-07-30 20:59:32.739607 | instance | 2026-07-30 20:59:32.739612 | instance | TASK [Create devices for Ceph] ************************************************* 2026-07-30 20:59:32.739621 | instance | Thursday 30 July 2026 20:59:31 +0000 (0:00:00.030) 0:00:48.002 ********* 2026-07-30 20:59:32.739627 | instance | changed: [instance] => (item=osd0) 2026-07-30 20:59:32.739634 | instance | changed: [instance] => (item=osd1) 2026-07-30 20:59:32.739639 | instance | changed: [instance] => (item=osd2) 2026-07-30 20:59:32.739645 | instance | 2026-07-30 20:59:32.739650 | instance | TASK [Set permissions on loopback devices] ************************************* 2026-07-30 20:59:32.739655 | instance | Thursday 30 July 2026 20:59:32 +0000 (0:00:00.560) 0:00:48.562 ********* 2026-07-30 20:59:32.739661 | instance | changed: [instance] => (item=osd0) 2026-07-30 20:59:32.739666 | instance | changed: [instance] => (item=osd1) 2026-07-30 20:59:33.053194 | instance | ok: Runtime: 0:00:00.007903 2026-07-30 20:59:33.059680 | 2026-07-30 20:59:33.059756 | TASK [Track last task for Molecule aio (aio-openvswitch)] 2026-07-30 20:59:33.129424 | instance | ok 2026-07-30 20:59:33.135758 | 2026-07-30 20:59:33.135831 | TASK [Advance live log offset for Molecule aio (aio-openvswitch)] 2026-07-30 20:59:33.195342 | instance | ok 2026-07-30 20:59:33.202629 | 2026-07-30 20:59:33.202705 | TASK [Report progress heartbeat for Molecule aio (aio-openvswitch)] 2026-07-30 20:59:33.253131 | instance | ok: 2026-07-30 20:59:33.253259 | instance | Molecule aio (aio-openvswitch) is still running after 60 seconds. 2026-07-30 20:59:33.253286 | instance | Last task: TASK [Set permissions on loopback devices] 2026-07-30 20:59:33.259647 | 2026-07-30 20:59:33.259724 | TASK [Continue monitoring Molecule aio (aio-openvswitch)] 2026-07-30 20:59:33.309282 | instance | ok 2026-07-30 20:59:33.323453 | instance | included: /var/lib/zuul/builds/3eedc45cc79d401187fd3d64411838bd/untrusted/project_5/github.com/vexxhost/atmosphere/test-playbooks/molecule/poll-command.yml 2026-07-30 20:59:33.337706 | 2026-07-30 20:59:33.337775 | TASK [Wait before polling Molecule aio (aio-openvswitch)] 2026-07-30 20:59:53.395404 | instance | ok 2026-07-30 20:59:53.402165 | 2026-07-30 20:59:53.721374 | TASK [Count progress poll for Molecule aio (aio-openvswitch)] 2026-07-30 20:59:53.787114 | instance | ok 2026-07-30 20:59:53.793475 | 2026-07-30 20:59:53.793601 | TASK [Poll status for Molecule aio (aio-openvswitch)] 2026-07-30 20:59:54.029088 | instance | ok 2026-07-30 20:59:54.035260 | 2026-07-30 20:59:54.035337 | TASK [Inspect live log for Molecule aio (aio-openvswitch)] 2026-07-30 20:59:54.216877 | instance | ok 2026-07-30 20:59:54.229331 | 2026-07-30 20:59:54.280948 | TASK [Calculate new output for Molecule aio (aio-openvswitch)] 2026-07-30 20:59:54.339606 | instance | ok 2026-07-30 20:59:54.347346 | 2026-07-30 20:59:54.347448 | TASK [Read new output for Molecule aio (aio-openvswitch)] 2026-07-30 20:59:54.549745 | instance | changed: [instance] => (item=osd2) 2026-07-30 20:59:54.549885 | instance | 2026-07-30 20:59:54.550076 | instance | TASK [Start loop devices] ****************************************************** 2026-07-30 20:59:54.550096 | instance | Thursday 30 July 2026 20:59:32 +0000 (0:00:00.558) 0:00:49.120 ********* 2026-07-30 20:59:54.550109 | instance | changed: [instance] => (item=osd0) 2026-07-30 20:59:54.550119 | instance | changed: [instance] => (item=osd1) 2026-07-30 20:59:54.550131 | instance | changed: [instance] => (item=osd2) 2026-07-30 20:59:54.550140 | instance | 2026-07-30 20:59:54.550149 | instance | TASK [Create a volume group for each loop device] ****************************** 2026-07-30 20:59:54.550158 | instance | Thursday 30 July 2026 20:59:33 +0000 (0:00:00.808) 0:00:49.928 ********* 2026-07-30 20:59:54.550169 | instance | changed: [instance] => (item=osd0) 2026-07-30 20:59:54.550178 | instance | changed: [instance] => (item=osd1) 2026-07-30 20:59:54.550187 | instance | changed: [instance] => (item=osd2) 2026-07-30 20:59:54.550196 | instance | 2026-07-30 20:59:54.550205 | instance | TASK [Create a logical volume for each loop device] **************************** 2026-07-30 20:59:54.550214 | instance | Thursday 30 July 2026 20:59:36 +0000 (0:00:03.420) 0:00:53.348 ********* 2026-07-30 20:59:54.550223 | instance | changed: [instance] => (item=ceph-instance-osd0) 2026-07-30 20:59:54.550232 | instance | changed: [instance] => (item=ceph-instance-osd1) 2026-07-30 20:59:54.550241 | instance | changed: [instance] => (item=ceph-instance-osd2) 2026-07-30 20:59:54.550249 | instance | 2026-07-30 20:59:54.550263 | instance | PLAY [controllers] ************************************************************* 2026-07-30 20:59:54.550272 | instance | 2026-07-30 20:59:54.550281 | instance | TASK [Gathering Facts] ********************************************************* 2026-07-30 20:59:54.550290 | instance | Thursday 30 July 2026 20:59:38 +0000 (0:00:02.053) 0:00:55.402 ********* 2026-07-30 20:59:54.550298 | instance | ok: [instance] 2026-07-30 20:59:54.550307 | instance | 2026-07-30 20:59:54.550316 | instance | TASK [Set masquerade rule] ***************************************************** 2026-07-30 20:59:54.550325 | instance | Thursday 30 July 2026 20:59:39 +0000 (0:00:00.982) 0:00:56.384 ********* 2026-07-30 20:59:54.550334 | instance | changed: [instance] 2026-07-30 20:59:54.550343 | instance | 2026-07-30 20:59:54.550351 | instance | PLAY RECAP ********************************************************************* 2026-07-30 20:59:54.550360 | instance | instance : ok=24 changed=10 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-07-30 20:59:54.550370 | instance | localhost : ok=40 changed=21 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-07-30 20:59:54.550392 | instance | 2026-07-30 20:59:54.550407 | instance | Thursday 30 July 2026 20:59:40 +0000 (0:00:00.507) 0:00:56.891 ********* 2026-07-30 20:59:54.550422 | instance | =============================================================================== 2026-07-30 20:59:54.550436 | instance | Install depedencies ---------------------------------------------------- 23.14s 2026-07-30 20:59:54.550451 | instance | Create a volume group for each loop device ------------------------------ 3.42s 2026-07-30 20:59:54.550465 | instance | Generate SSH keys for missing variables --------------------------------- 3.07s 2026-07-30 20:59:54.550479 | instance | Create a logical volume for each loop device ---------------------------- 2.05s 2026-07-30 20:59:54.550493 | instance | Gathering Facts --------------------------------------------------------- 1.75s 2026-07-30 20:59:54.550508 | instance | Create folders for workspace -------------------------------------------- 1.42s 2026-07-30 20:59:54.550522 | instance | Install "dirmngr" for GPG keyserver operations -------------------------- 1.35s 2026-07-30 20:59:54.550536 | instance | Gathering Facts --------------------------------------------------------- 1.20s 2026-07-30 20:59:54.550550 | instance | Gathering Facts --------------------------------------------------------- 0.98s 2026-07-30 20:59:54.550565 | instance | Gathering Facts --------------------------------------------------------- 0.92s 2026-07-30 20:59:54.550579 | instance | Purge "snapd" package --------------------------------------------------- 0.90s 2026-07-30 20:59:54.550593 | instance | Start loop devices ------------------------------------------------------ 0.81s 2026-07-30 20:59:54.550668 | instance | Generate endpoint skeleton for missing variables ------------------------ 0.79s 2026-07-30 20:59:54.550682 | instance | Gathering Facts --------------------------------------------------------- 0.78s 2026-07-30 20:59:54.550692 | instance | Configure short hostname ------------------------------------------------ 0.74s 2026-07-30 20:59:54.550701 | instance | Write new Ceph control plane configuration file to disk ----------------- 0.68s 2026-07-30 20:59:54.550709 | instance | Start up service -------------------------------------------------------- 0.57s 2026-07-30 20:59:54.550718 | instance | Create devices for Ceph ------------------------------------------------- 0.56s 2026-07-30 20:59:54.550727 | instance | Set permissions on loopback devices ------------------------------------- 0.56s 2026-07-30 20:59:54.550736 | instance | Generate temporary files for generating keys for missing variables ------ 0.54s 2026-07-30 20:59:54.550745 | instance | INFO [aio > prepare] Executed: Successful 2026-07-30 20:59:54.550753 | instance | INFO [aio > converge] Executing 2026-07-30 20:59:54.550762 | instance | 2026-07-30 20:59:54.550771 | instance | PLAY [all] ********************************************************************* 2026-07-30 20:59:54.550780 | instance | 2026-07-30 20:59:54.550788 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-07-30 20:59:54.550797 | instance | Thursday 30 July 2026 20:59:43 +0000 (0:00:00.023) 0:00:00.023 ********* 2026-07-30 20:59:54.550806 | instance | ok: [instance] 2026-07-30 20:59:54.550815 | instance | 2026-07-30 20:59:54.550823 | instance | PLAY [Deploy Ceph monitors & managers] ***************************************** 2026-07-30 20:59:54.550832 | instance | 2026-07-30 20:59:54.550841 | instance | PLAY [Deploy Ceph OSDs] ******************************************************** 2026-07-30 20:59:54.550849 | instance | 2026-07-30 20:59:54.550858 | instance | PLAY [Deploy Ceph exporters] *************************************************** 2026-07-30 20:59:54.550867 | instance | 2026-07-30 20:59:54.550875 | instance | PLAY [all] ********************************************************************* 2026-07-30 20:59:54.550884 | instance | 2026-07-30 20:59:54.550904 | instance | PLAY [all] ********************************************************************* 2026-07-30 20:59:54.550913 | instance | 2026-07-30 20:59:54.550922 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-07-30 20:59:54.550931 | instance | Thursday 30 July 2026 20:59:44 +0000 (0:00:00.660) 0:00:00.683 ********* 2026-07-30 20:59:54.550939 | instance | ok: [instance] 2026-07-30 20:59:54.550948 | instance | 2026-07-30 20:59:54.550957 | instance | PLAY [Configure Kubernetes VIP] ************************************************ 2026-07-30 20:59:54.550966 | instance | 2026-07-30 20:59:54.550975 | instance | PLAY [Install Kubernetes] ****************************************************** 2026-07-30 20:59:54.550983 | instance | 2026-07-30 20:59:54.550992 | instance | PLAY [Install control-plane components] **************************************** 2026-07-30 20:59:54.551001 | instance | 2026-07-30 20:59:54.551009 | instance | PLAY [all] ********************************************************************* 2026-07-30 20:59:54.551018 | instance | 2026-07-30 20:59:54.551027 | instance | PLAY [all] ********************************************************************* 2026-07-30 20:59:54.551035 | instance | 2026-07-30 20:59:54.551044 | instance | PLAY [controllers] ************************************************************* 2026-07-30 20:59:54.551053 | instance | 2026-07-30 20:59:54.551062 | instance | PLAY [Deploy Infrastructure] *************************************************** 2026-07-30 20:59:54.551070 | instance | 2026-07-30 20:59:54.551084 | instance | TASK [Gathering Facts] ********************************************************* 2026-07-30 20:59:54.551093 | instance | Thursday 30 July 2026 20:59:44 +0000 (0:00:00.350) 0:00:01.033 ********* 2026-07-30 20:59:54.551102 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-07-30 20:59:54.551111 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-07-30 20:59:54.551120 | instance | interpreter could change the meaning of that path. See 2026-07-30 20:59:54.551128 | instance | https://docs.ansible.com/ansible- 2026-07-30 20:59:54.551137 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-07-30 20:59:54.551152 | instance | ok: [instance] 2026-07-30 20:59:54.551202 | instance | 2026-07-30 20:59:54.551212 | instance | PLAY [Deploy Monitoring] ******************************************************* 2026-07-30 20:59:54.551221 | instance | 2026-07-30 20:59:54.551230 | instance | TASK [Gathering Facts] ********************************************************* 2026-07-30 20:59:54.551269 | instance | Thursday 30 July 2026 20:59:45 +0000 (0:00:01.403) 0:00:02.437 ********* 2026-07-30 20:59:54.551278 | instance | ok: [instance] 2026-07-30 20:59:54.551287 | instance | 2026-07-30 20:59:54.551295 | instance | PLAY [Deploy OpenStack] ******************************************************** 2026-07-30 20:59:54.551304 | instance | 2026-07-30 20:59:54.551313 | instance | TASK [Gathering Facts] ********************************************************* 2026-07-30 20:59:54.551325 | instance | Thursday 30 July 2026 20:59:47 +0000 (0:00:01.144) 0:00:03.581 ********* 2026-07-30 20:59:54.551337 | instance | ok: [instance] 2026-07-30 20:59:54.551347 | instance | 2026-07-30 20:59:54.551355 | instance | PLAY [Configure operating system] ********************************************** 2026-07-30 20:59:54.551364 | instance | 2026-07-30 20:59:54.551373 | instance | TASK [Gathering Facts] ********************************************************* 2026-07-30 20:59:54.551381 | instance | Thursday 30 July 2026 20:59:48 +0000 (0:00:01.343) 0:00:04.925 ********* 2026-07-30 20:59:54.551415 | instance | ok: [instance] 2026-07-30 20:59:54.551424 | instance | 2026-07-30 20:59:54.551433 | instance | TASK [vexxhost.atmosphere.multipathd : Add backports PPA] ********************** 2026-07-30 20:59:54.551442 | instance | Thursday 30 July 2026 20:59:49 +0000 (0:00:00.912) 0:00:05.837 ********* 2026-07-30 20:59:54.896814 | instance | ok: Runtime: 0:00:00.009103 2026-07-30 20:59:54.906543 | 2026-07-30 20:59:54.906628 | TASK [Track last task for Molecule aio (aio-openvswitch)] 2026-07-30 20:59:54.974898 | instance | ok 2026-07-30 20:59:54.993189 | 2026-07-30 20:59:54.993422 | TASK [Advance live log offset for Molecule aio (aio-openvswitch)] 2026-07-30 20:59:55.047384 | instance | ok 2026-07-30 20:59:55.056544 | 2026-07-30 20:59:55.056685 | TASK [Report progress heartbeat for Molecule aio (aio-openvswitch)] 2026-07-30 20:59:55.189967 | instance | ok: 2026-07-30 20:59:55.190127 | instance | Molecule aio (aio-openvswitch) is still running after 80 seconds. 2026-07-30 20:59:55.190164 | instance | Last task: TASK [vexxhost.atmosphere.multipathd : Add backports PPA] 2026-07-30 20:59:55.252227 | 2026-07-30 20:59:55.252366 | TASK [Continue monitoring Molecule aio (aio-openvswitch)] 2026-07-30 20:59:55.307660 | instance | ok 2026-07-30 20:59:55.318831 | instance | included: /var/lib/zuul/builds/3eedc45cc79d401187fd3d64411838bd/untrusted/project_5/github.com/vexxhost/atmosphere/test-playbooks/molecule/poll-command.yml 2026-07-30 20:59:55.334137 | 2026-07-30 20:59:55.334278 | TASK [Wait before polling Molecule aio (aio-openvswitch)] 2026-07-30 21:00:15.394061 | instance | ok 2026-07-30 21:00:15.404786 | 2026-07-30 21:00:15.404912 | TASK [Count progress poll for Molecule aio (aio-openvswitch)] 2026-07-30 21:00:15.503442 | instance | ok 2026-07-30 21:00:15.511504 | 2026-07-30 21:00:15.511629 | TASK [Poll status for Molecule aio (aio-openvswitch)] 2026-07-30 21:00:15.779939 | instance | ok 2026-07-30 21:00:15.793601 | 2026-07-30 21:00:15.793785 | TASK [Inspect live log for Molecule aio (aio-openvswitch)] 2026-07-30 21:00:16.113017 | instance | ok 2026-07-30 21:00:16.126103 | 2026-07-30 21:00:16.126236 | TASK [Calculate new output for Molecule aio (aio-openvswitch)] 2026-07-30 21:00:16.192548 | instance | ok 2026-07-30 21:00:16.203943 | 2026-07-30 21:00:16.204063 | TASK [Read new output for Molecule aio (aio-openvswitch)] 2026-07-30 21:00:16.453831 | instance | changed: [instance] 2026-07-30 21:00:16.453927 | instance | 2026-07-30 21:00:16.453940 | instance | TASK [vexxhost.atmosphere.multipathd : Install the multipathd package] ********* 2026-07-30 21:00:16.453952 | instance | Thursday 30 July 2026 20:59:55 +0000 (0:00:05.932) 0:00:11.770 ********* 2026-07-30 21:00:16.751945 | instance | ok: Runtime: 0:00:00.009087 2026-07-30 21:00:16.761439 | 2026-07-30 21:00:16.761573 | TASK [Track last task for Molecule aio (aio-openvswitch)] 2026-07-30 21:00:16.822676 | instance | ok 2026-07-30 21:00:16.829788 | 2026-07-30 21:00:16.829865 | TASK [Advance live log offset for Molecule aio (aio-openvswitch)] 2026-07-30 21:00:16.888624 | instance | ok 2026-07-30 21:00:16.895511 | 2026-07-30 21:00:16.895596 | TASK [Report progress heartbeat for Molecule aio (aio-openvswitch)] 2026-07-30 21:00:16.946840 | instance | ok: 2026-07-30 21:00:16.946979 | instance | Molecule aio (aio-openvswitch) is still running after 100 seconds. 2026-07-30 21:00:16.947006 | instance | Last task: TASK [vexxhost.atmosphere.multipathd : Install the multipathd package] 2026-07-30 21:00:16.953128 | 2026-07-30 21:00:16.953209 | TASK [Continue monitoring Molecule aio (aio-openvswitch)] 2026-07-30 21:00:17.003329 | instance | ok 2026-07-30 21:00:17.015046 | instance | included: /var/lib/zuul/builds/3eedc45cc79d401187fd3d64411838bd/untrusted/project_5/github.com/vexxhost/atmosphere/test-playbooks/molecule/poll-command.yml 2026-07-30 21:00:17.030559 | 2026-07-30 21:00:17.030643 | TASK [Wait before polling Molecule aio (aio-openvswitch)] 2026-07-30 21:00:37.090459 | instance | ok 2026-07-30 21:00:37.096655 | 2026-07-30 21:00:37.096730 | TASK [Count progress poll for Molecule aio (aio-openvswitch)] 2026-07-30 21:00:37.177105 | instance | ok 2026-07-30 21:00:37.184369 | 2026-07-30 21:00:37.184444 | TASK [Poll status for Molecule aio (aio-openvswitch)] 2026-07-30 21:00:37.435519 | instance | ok 2026-07-30 21:00:37.441929 | 2026-07-30 21:00:37.446391 | TASK [Inspect live log for Molecule aio (aio-openvswitch)] 2026-07-30 21:00:37.621020 | instance | ok 2026-07-30 21:00:37.627772 | 2026-07-30 21:00:37.627869 | TASK [Calculate new output for Molecule aio (aio-openvswitch)] 2026-07-30 21:00:37.681814 | instance | ok 2026-07-30 21:00:37.692711 | 2026-07-30 21:00:37.692855 | TASK [Read new output for Molecule aio (aio-openvswitch)] 2026-07-30 21:00:37.895754 | instance | changed: [instance] 2026-07-30 21:00:37.895986 | instance | 2026-07-30 21:00:37.896002 | instance | TASK [vexxhost.atmosphere.multipathd : Install the configuration file] ********* 2026-07-30 21:00:37.896018 | instance | Thursday 30 July 2026 21:00:17 +0000 (0:00:22.371) 0:00:34.141 ********* 2026-07-30 21:00:37.896031 | instance | changed: [instance] 2026-07-30 21:00:37.896040 | instance | 2026-07-30 21:00:37.896051 | instance | RUNNING HANDLER [vexxhost.atmosphere.multipathd : Restart "multipathd"] ******** 2026-07-30 21:00:37.896061 | instance | Thursday 30 July 2026 21:00:18 +0000 (0:00:00.850) 0:00:34.992 ********* 2026-07-30 21:00:37.896071 | instance | changed: [instance] 2026-07-30 21:00:37.896080 | instance | 2026-07-30 21:00:37.896089 | instance | PLAY [Deploy SDN] ************************************************************** 2026-07-30 21:00:37.896098 | instance | 2026-07-30 21:00:37.896107 | instance | PLAY [controllers[0]] ********************************************************** 2026-07-30 21:00:37.896116 | instance | 2026-07-30 21:00:37.896125 | instance | TASK [Gathering Facts] ********************************************************* 2026-07-30 21:00:37.896134 | instance | Thursday 30 July 2026 21:00:19 +0000 (0:00:00.880) 0:00:35.872 ********* 2026-07-30 21:00:37.896143 | instance | ok: [instance] 2026-07-30 21:00:37.896152 | instance | 2026-07-30 21:00:37.896161 | instance | PLAY [controllers] ************************************************************* 2026-07-30 21:00:37.896170 | instance | 2026-07-30 21:00:37.896179 | instance | TASK [Gathering Facts] ********************************************************* 2026-07-30 21:00:37.896188 | instance | Thursday 30 July 2026 21:00:20 +0000 (0:00:01.423) 0:00:37.296 ********* 2026-07-30 21:00:37.896197 | instance | ok: [instance] 2026-07-30 21:00:37.896206 | instance | 2026-07-30 21:00:37.896219 | instance | PLAY [Configure networking] **************************************************** 2026-07-30 21:00:37.896228 | instance | 2026-07-30 21:00:37.896237 | instance | TASK [Gathering Facts] ********************************************************* 2026-07-30 21:00:37.896246 | instance | Thursday 30 July 2026 21:00:21 +0000 (0:00:01.102) 0:00:38.398 ********* 2026-07-30 21:00:37.896255 | instance | ok: [instance] 2026-07-30 21:00:37.896264 | instance | 2026-07-30 21:00:37.896273 | instance | TASK [Add IP address to "br-ex"] *********************************************** 2026-07-30 21:00:37.896282 | instance | Thursday 30 July 2026 21:00:22 +0000 (0:00:01.011) 0:00:39.410 ********* 2026-07-30 21:00:37.896291 | instance | ok: [instance] 2026-07-30 21:00:37.896300 | instance | 2026-07-30 21:00:37.896308 | instance | TASK [Set "br-ex" interface to "up"] ******************************************* 2026-07-30 21:00:37.896317 | instance | Thursday 30 July 2026 21:00:23 +0000 (0:00:00.444) 0:00:39.854 ********* 2026-07-30 21:00:37.896337 | instance | ok: [instance] 2026-07-30 21:00:37.896354 | instance | 2026-07-30 21:00:37.896369 | instance | PLAY RECAP ********************************************************************* 2026-07-30 21:00:37.896384 | instance | instance : ok=15 changed=4 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-07-30 21:00:37.896399 | instance | 2026-07-30 21:00:37.896413 | instance | Thursday 30 July 2026 21:00:23 +0000 (0:00:00.210) 0:00:40.065 ********* 2026-07-30 21:00:37.896428 | instance | =============================================================================== 2026-07-30 21:00:37.896443 | instance | vexxhost.atmosphere.multipathd : Install the multipathd package -------- 22.37s 2026-07-30 21:00:37.896457 | instance | vexxhost.atmosphere.multipathd : Add backports PPA ---------------------- 5.93s 2026-07-30 21:00:37.896471 | instance | Gathering Facts --------------------------------------------------------- 1.42s 2026-07-30 21:00:37.896486 | instance | Gathering Facts --------------------------------------------------------- 1.40s 2026-07-30 21:00:37.896500 | instance | Gathering Facts --------------------------------------------------------- 1.34s 2026-07-30 21:00:37.896515 | instance | Gathering Facts --------------------------------------------------------- 1.14s 2026-07-30 21:00:37.896529 | instance | Gathering Facts --------------------------------------------------------- 1.10s 2026-07-30 21:00:37.896543 | instance | Gathering Facts --------------------------------------------------------- 1.01s 2026-07-30 21:00:37.896557 | instance | Gathering Facts --------------------------------------------------------- 0.91s 2026-07-30 21:00:37.896676 | instance | vexxhost.atmosphere.multipathd : Restart "multipathd" ------------------- 0.88s 2026-07-30 21:00:37.896691 | instance | vexxhost.atmosphere.multipathd : Install the configuration file --------- 0.85s 2026-07-30 21:00:37.896700 | instance | Set a fact with the "atmosphere_images" for other plays ----------------- 0.66s 2026-07-30 21:00:37.896710 | instance | Add IP address to "br-ex" ----------------------------------------------- 0.44s 2026-07-30 21:00:37.896719 | instance | Set a fact with the "atmosphere_images" for other plays ----------------- 0.35s 2026-07-30 21:00:37.896729 | instance | Set "br-ex" interface to "up" ------------------------------------------- 0.21s 2026-07-30 21:00:37.896739 | instance | INFO [aio > converge] Executed: Successful 2026-07-30 21:00:37.896749 | instance | INFO [aio > idempotence] Executing 2026-07-30 21:00:37.896758 | instance | 2026-07-30 21:00:37.896767 | instance | PLAY [all] ********************************************************************* 2026-07-30 21:00:37.896776 | instance | 2026-07-30 21:00:37.896785 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-07-30 21:00:37.896794 | instance | Thursday 30 July 2026 21:00:26 +0000 (0:00:00.018) 0:00:00.018 ********* 2026-07-30 21:00:37.896803 | instance | ok: [instance] 2026-07-30 21:00:37.896812 | instance | 2026-07-30 21:00:37.896821 | instance | PLAY [Deploy Ceph monitors & managers] ***************************************** 2026-07-30 21:00:37.896830 | instance | 2026-07-30 21:00:37.896839 | instance | PLAY [Deploy Ceph OSDs] ******************************************************** 2026-07-30 21:00:37.896848 | instance | 2026-07-30 21:00:37.896857 | instance | PLAY [Deploy Ceph exporters] *************************************************** 2026-07-30 21:00:37.896866 | instance | 2026-07-30 21:00:37.896875 | instance | PLAY [all] ********************************************************************* 2026-07-30 21:00:37.896884 | instance | 2026-07-30 21:00:37.896893 | instance | PLAY [all] ********************************************************************* 2026-07-30 21:00:37.896901 | instance | 2026-07-30 21:00:37.896910 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-07-30 21:00:37.896919 | instance | Thursday 30 July 2026 21:00:27 +0000 (0:00:00.639) 0:00:00.658 ********* 2026-07-30 21:00:37.896928 | instance | ok: [instance] 2026-07-30 21:00:37.896937 | instance | 2026-07-30 21:00:37.896957 | instance | PLAY [Configure Kubernetes VIP] ************************************************ 2026-07-30 21:00:37.896966 | instance | 2026-07-30 21:00:37.896975 | instance | PLAY [Install Kubernetes] ****************************************************** 2026-07-30 21:00:37.896984 | instance | 2026-07-30 21:00:37.896993 | instance | PLAY [Install control-plane components] **************************************** 2026-07-30 21:00:37.897002 | instance | 2026-07-30 21:00:37.897010 | instance | PLAY [all] ********************************************************************* 2026-07-30 21:00:37.897019 | instance | 2026-07-30 21:00:37.897028 | instance | PLAY [all] ********************************************************************* 2026-07-30 21:00:37.897037 | instance | 2026-07-30 21:00:37.897046 | instance | PLAY [controllers] ************************************************************* 2026-07-30 21:00:37.897055 | instance | 2026-07-30 21:00:37.897064 | instance | PLAY [Deploy Infrastructure] *************************************************** 2026-07-30 21:00:37.897073 | instance | 2026-07-30 21:00:37.897082 | instance | TASK [Gathering Facts] ********************************************************* 2026-07-30 21:00:37.897096 | instance | Thursday 30 July 2026 21:00:27 +0000 (0:00:00.334) 0:00:00.992 ********* 2026-07-30 21:00:37.897105 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-07-30 21:00:37.897115 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-07-30 21:00:37.897124 | instance | interpreter could change the meaning of that path. See 2026-07-30 21:00:37.897133 | instance | https://docs.ansible.com/ansible- 2026-07-30 21:00:37.897142 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-07-30 21:00:37.897151 | instance | ok: [instance] 2026-07-30 21:00:37.897160 | instance | 2026-07-30 21:00:37.897169 | instance | PLAY [Deploy Monitoring] ******************************************************* 2026-07-30 21:00:37.897185 | instance | 2026-07-30 21:00:37.897194 | instance | TASK [Gathering Facts] ********************************************************* 2026-07-30 21:00:37.897202 | instance | Thursday 30 July 2026 21:00:29 +0000 (0:00:01.478) 0:00:02.471 ********* 2026-07-30 21:00:37.897211 | instance | ok: [instance] 2026-07-30 21:00:37.897220 | instance | 2026-07-30 21:00:37.897229 | instance | PLAY [Deploy OpenStack] ******************************************************** 2026-07-30 21:00:37.897238 | instance | 2026-07-30 21:00:37.897247 | instance | TASK [Gathering Facts] ********************************************************* 2026-07-30 21:00:37.897256 | instance | Thursday 30 July 2026 21:00:30 +0000 (0:00:01.172) 0:00:03.644 ********* 2026-07-30 21:00:37.897265 | instance | ok: [instance] 2026-07-30 21:00:37.897274 | instance | 2026-07-30 21:00:37.897283 | instance | PLAY [Configure operating system] ********************************************** 2026-07-30 21:00:37.897292 | instance | 2026-07-30 21:00:37.897300 | instance | TASK [Gathering Facts] ********************************************************* 2026-07-30 21:00:37.897309 | instance | Thursday 30 July 2026 21:00:31 +0000 (0:00:01.465) 0:00:05.109 ********* 2026-07-30 21:00:37.897318 | instance | ok: [instance] 2026-07-30 21:00:37.897327 | instance | 2026-07-30 21:00:37.897335 | instance | TASK [vexxhost.atmosphere.multipathd : Add backports PPA] ********************** 2026-07-30 21:00:37.897344 | instance | Thursday 30 July 2026 21:00:32 +0000 (0:00:00.983) 0:00:06.092 ********* 2026-07-30 21:00:37.897353 | instance | ok: [instance] 2026-07-30 21:00:37.897362 | instance | 2026-07-30 21:00:37.897371 | instance | TASK [vexxhost.atmosphere.multipathd : Install the multipathd package] ********* 2026-07-30 21:00:37.897380 | instance | Thursday 30 July 2026 21:00:33 +0000 (0:00:00.450) 0:00:06.542 ********* 2026-07-30 21:00:37.897389 | instance | ok: [instance] 2026-07-30 21:00:37.897398 | instance | 2026-07-30 21:00:37.897407 | instance | TASK [vexxhost.atmosphere.multipathd : Install the configuration file] ********* 2026-07-30 21:00:37.897416 | instance | Thursday 30 July 2026 21:00:34 +0000 (0:00:01.377) 0:00:07.920 ********* 2026-07-30 21:00:37.897424 | instance | ok: [instance] 2026-07-30 21:00:37.897433 | instance | 2026-07-30 21:00:37.897442 | instance | PLAY [Deploy SDN] ************************************************************** 2026-07-30 21:00:37.897451 | instance | 2026-07-30 21:00:37.897460 | instance | PLAY [controllers[0]] ********************************************************** 2026-07-30 21:00:37.897469 | instance | 2026-07-30 21:00:37.897477 | instance | TASK [Gathering Facts] ********************************************************* 2026-07-30 21:00:37.897486 | instance | Thursday 30 July 2026 21:00:35 +0000 (0:00:00.838) 0:00:08.759 ********* 2026-07-30 21:00:37.897495 | instance | ok: [instance] 2026-07-30 21:00:37.897504 | instance | 2026-07-30 21:00:37.897513 | instance | PLAY [controllers] ************************************************************* 2026-07-30 21:00:37.897522 | instance | 2026-07-30 21:00:37.897530 | instance | TASK [Gathering Facts] ********************************************************* 2026-07-30 21:00:37.897539 | instance | Thursday 30 July 2026 21:00:36 +0000 (0:00:01.341) 0:00:10.101 ********* 2026-07-30 21:00:38.233018 | instance | ok: Runtime: 0:00:00.009852 2026-07-30 21:00:38.243236 | 2026-07-30 21:00:38.243367 | TASK [Track last task for Molecule aio (aio-openvswitch)] 2026-07-30 21:00:38.313112 | instance | ok 2026-07-30 21:00:38.319250 | 2026-07-30 21:00:38.319324 | TASK [Advance live log offset for Molecule aio (aio-openvswitch)] 2026-07-30 21:00:38.376889 | instance | ok 2026-07-30 21:00:38.383023 | 2026-07-30 21:00:38.383108 | TASK [Report progress heartbeat for Molecule aio (aio-openvswitch)] 2026-07-30 21:00:38.466433 | instance | ok: 2026-07-30 21:00:38.466641 | instance | Molecule aio (aio-openvswitch) is still running after 120 seconds. 2026-07-30 21:00:38.466683 | instance | Last task: TASK [Gathering Facts] 2026-07-30 21:00:38.478652 | 2026-07-30 21:00:38.478772 | TASK [Continue monitoring Molecule aio (aio-openvswitch)] 2026-07-30 21:00:38.541005 | instance | ok 2026-07-30 21:00:38.555174 | instance | included: /var/lib/zuul/builds/3eedc45cc79d401187fd3d64411838bd/untrusted/project_5/github.com/vexxhost/atmosphere/test-playbooks/molecule/poll-command.yml 2026-07-30 21:00:38.573121 | 2026-07-30 21:00:38.573238 | TASK [Wait before polling Molecule aio (aio-openvswitch)] 2026-07-30 21:00:58.640040 | instance | ok 2026-07-30 21:00:58.650014 | 2026-07-30 21:00:58.650093 | TASK [Count progress poll for Molecule aio (aio-openvswitch)] 2026-07-30 21:00:58.715863 | instance | ok 2026-07-30 21:00:58.724285 | 2026-07-30 21:00:58.724370 | TASK [Poll status for Molecule aio (aio-openvswitch)] 2026-07-30 21:00:58.978314 | instance | ok 2026-07-30 21:00:58.985459 | 2026-07-30 21:00:58.985583 | TASK [Inspect live log for Molecule aio (aio-openvswitch)] 2026-07-30 21:00:59.179625 | instance | ok 2026-07-30 21:00:59.251108 | 2026-07-30 21:00:59.251233 | TASK [Calculate new output for Molecule aio (aio-openvswitch)] 2026-07-30 21:00:59.325072 | instance | ok 2026-07-30 21:00:59.336104 | 2026-07-30 21:00:59.336308 | TASK [Read new output for Molecule aio (aio-openvswitch)] 2026-07-30 21:00:59.555974 | instance | ok: [instance] 2026-07-30 21:00:59.556180 | instance | 2026-07-30 21:00:59.556196 | instance | PLAY [Configure networking] **************************************************** 2026-07-30 21:00:59.556207 | instance | 2026-07-30 21:00:59.556220 | instance | TASK [Gathering Facts] ********************************************************* 2026-07-30 21:00:59.556233 | instance | Thursday 30 July 2026 21:00:37 +0000 (0:00:01.035) 0:00:11.136 ********* 2026-07-30 21:00:59.556248 | instance | ok: [instance] 2026-07-30 21:00:59.556257 | instance | 2026-07-30 21:00:59.556268 | instance | TASK [Add IP address to "br-ex"] *********************************************** 2026-07-30 21:00:59.556278 | instance | Thursday 30 July 2026 21:00:39 +0000 (0:00:01.017) 0:00:12.154 ********* 2026-07-30 21:00:59.556288 | instance | ok: [instance] 2026-07-30 21:00:59.556298 | instance | 2026-07-30 21:00:59.556308 | instance | TASK [Set "br-ex" interface to "up"] ******************************************* 2026-07-30 21:00:59.556318 | instance | Thursday 30 July 2026 21:00:39 +0000 (0:00:00.397) 0:00:12.552 ********* 2026-07-30 21:00:59.556327 | instance | ok: [instance] 2026-07-30 21:00:59.556337 | instance | 2026-07-30 21:00:59.556347 | instance | PLAY RECAP ********************************************************************* 2026-07-30 21:00:59.556357 | instance | instance : ok=14 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-07-30 21:00:59.556367 | instance | 2026-07-30 21:00:59.556377 | instance | Thursday 30 July 2026 21:00:39 +0000 (0:00:00.209) 0:00:12.761 ********* 2026-07-30 21:00:59.556391 | instance | =============================================================================== 2026-07-30 21:00:59.556401 | instance | Gathering Facts --------------------------------------------------------- 1.48s 2026-07-30 21:00:59.556411 | instance | Gathering Facts --------------------------------------------------------- 1.47s 2026-07-30 21:00:59.556421 | instance | vexxhost.atmosphere.multipathd : Install the multipathd package --------- 1.38s 2026-07-30 21:00:59.556430 | instance | Gathering Facts --------------------------------------------------------- 1.34s 2026-07-30 21:00:59.556440 | instance | Gathering Facts --------------------------------------------------------- 1.17s 2026-07-30 21:00:59.556449 | instance | Gathering Facts --------------------------------------------------------- 1.04s 2026-07-30 21:00:59.556459 | instance | Gathering Facts --------------------------------------------------------- 1.02s 2026-07-30 21:00:59.556468 | instance | Gathering Facts --------------------------------------------------------- 0.98s 2026-07-30 21:00:59.556478 | instance | vexxhost.atmosphere.multipathd : Install the configuration file --------- 0.84s 2026-07-30 21:00:59.556488 | instance | Set a fact with the "atmosphere_images" for other plays ----------------- 0.64s 2026-07-30 21:00:59.556497 | instance | vexxhost.atmosphere.multipathd : Add backports PPA ---------------------- 0.45s 2026-07-30 21:00:59.556507 | instance | Add IP address to "br-ex" ----------------------------------------------- 0.40s 2026-07-30 21:00:59.556516 | instance | Set a fact with the "atmosphere_images" for other plays ----------------- 0.33s 2026-07-30 21:00:59.556526 | instance | Set "br-ex" interface to "up" ------------------------------------------- 0.21s 2026-07-30 21:00:59.556536 | instance | INFO [aio > idempotence] Executed: Successful 2026-07-30 21:00:59.556546 | instance | INFO [aio > side_effect] Executing 2026-07-30 21:00:59.556557 | instance | WARNING [aio > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-07-30 21:00:59.556567 | instance | INFO [aio > verify] Executing 2026-07-30 21:00:59.556577 | instance | 2026-07-30 21:00:59.556653 | instance | PLAY [Run tests] *************************************************************** 2026-07-30 21:00:59.556666 | instance | 2026-07-30 21:00:59.556676 | instance | TASK [Run "stestr" tests] ****************************************************** 2026-07-30 21:00:59.556685 | instance | Thursday 30 July 2026 21:00:40 +0000 (0:00:00.027) 0:00:00.027 ********* 2026-07-30 21:00:59.556696 | instance | [WARNING]: conditional statements should not include jinja2 templating 2026-07-30 21:00:59.556706 | instance | delimiters such as {{ }} or {% %}. Found: {{ lookup('env', 2026-07-30 21:00:59.556715 | instance | 'ATMOSPHERE_CI_RUN_STESTR') | default('true', true) | bool }} 2026-07-30 21:00:59.556735 | instance | skipping: [localhost] 2026-07-30 21:00:59.556745 | instance | 2026-07-30 21:00:59.556755 | instance | PLAY [Verify selected OpenStack APIs] ****************************************** 2026-07-30 21:00:59.556765 | instance | 2026-07-30 21:00:59.556774 | instance | PLAY [Run Tempest tests] ******************************************************* 2026-07-30 21:00:59.556784 | instance | 2026-07-30 21:00:59.556793 | instance | TASK [Gathering Facts] ********************************************************* 2026-07-30 21:00:59.556803 | instance | Thursday 30 July 2026 21:00:40 +0000 (0:00:00.048) 0:00:00.076 ********* 2026-07-30 21:00:59.556813 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-07-30 21:00:59.556823 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-07-30 21:00:59.556832 | instance | interpreter could change the meaning of that path. See 2026-07-30 21:00:59.556842 | instance | https://docs.ansible.com/ansible- 2026-07-30 21:00:59.556852 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-07-30 21:00:59.556862 | instance | ok: [instance] 2026-07-30 21:00:59.556871 | instance | 2026-07-30 21:00:59.556881 | instance | TASK [vexxhost.atmosphere.openstacksdk : Install openstacksdk] ***************** 2026-07-30 21:00:59.556890 | instance | Thursday 30 July 2026 21:00:42 +0000 (0:00:01.277) 0:00:01.353 ********* 2026-07-30 21:00:59.556900 | instance | skipping: [instance] 2026-07-30 21:00:59.556910 | instance | 2026-07-30 21:00:59.556919 | instance | TASK [vexxhost.atmosphere.openstacksdk : Create openstack config directory] **** 2026-07-30 21:00:59.556929 | instance | Thursday 30 July 2026 21:00:42 +0000 (0:00:00.039) 0:00:01.393 ********* 2026-07-30 21:00:59.556938 | instance | skipping: [instance] 2026-07-30 21:00:59.556948 | instance | 2026-07-30 21:00:59.556957 | instance | TASK [vexxhost.atmosphere.openstacksdk : Generate cloud config file] *********** 2026-07-30 21:00:59.556967 | instance | Thursday 30 July 2026 21:00:42 +0000 (0:00:00.036) 0:00:01.429 ********* 2026-07-30 21:00:59.556977 | instance | skipping: [instance] 2026-07-30 21:00:59.556986 | instance | 2026-07-30 21:00:59.557005 | instance | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Retrieve list of all the needed endpoints] *** 2026-07-30 21:00:59.557016 | instance | Thursday 30 July 2026 21:00:42 +0000 (0:00:00.050) 0:00:01.479 ********* 2026-07-30 21:00:59.557025 | instance | skipping: [instance] 2026-07-30 21:00:59.557035 | instance | 2026-07-30 21:00:59.557045 | instance | TASK [Create RabbitMQ cluster] ************************************************* 2026-07-30 21:00:59.557054 | instance | Thursday 30 July 2026 21:00:42 +0000 (0:00:00.038) 0:00:01.518 ********* 2026-07-30 21:00:59.557064 | instance | skipping: [instance] 2026-07-30 21:00:59.557073 | instance | 2026-07-30 21:00:59.557083 | instance | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Grab RabbitMQ cluster secret] *** 2026-07-30 21:00:59.557092 | instance | Thursday 30 July 2026 21:00:42 +0000 (0:00:00.046) 0:00:01.564 ********* 2026-07-30 21:00:59.557102 | instance | skipping: [instance] 2026-07-30 21:00:59.557111 | instance | 2026-07-30 21:00:59.557121 | instance | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Cache fact with RabbitMQ cluster credentials] *** 2026-07-30 21:00:59.557131 | instance | Thursday 30 July 2026 21:00:42 +0000 (0:00:00.039) 0:00:01.603 ********* 2026-07-30 21:00:59.557140 | instance | skipping: [instance] 2026-07-30 21:00:59.557153 | instance | 2026-07-30 21:00:59.557167 | instance | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Grab Percona XtraDB cluster secret] *** 2026-07-30 21:00:59.557180 | instance | Thursday 30 July 2026 21:00:42 +0000 (0:00:00.040) 0:00:01.644 ********* 2026-07-30 21:00:59.557193 | instance | skipping: [instance] 2026-07-30 21:00:59.557202 | instance | 2026-07-30 21:00:59.557217 | instance | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Cache fact with Percona XtraDB password] *** 2026-07-30 21:00:59.557227 | instance | Thursday 30 July 2026 21:00:42 +0000 (0:00:00.041) 0:00:01.686 ********* 2026-07-30 21:00:59.557236 | instance | skipping: [instance] 2026-07-30 21:00:59.557247 | instance | 2026-07-30 21:00:59.557260 | instance | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Reset value for OpenStack_Helm endpoints] *** 2026-07-30 21:00:59.557274 | instance | Thursday 30 July 2026 21:00:42 +0000 (0:00:00.048) 0:00:01.734 ********* 2026-07-30 21:00:59.557296 | instance | skipping: [instance] 2026-07-30 21:00:59.557308 | instance | 2026-07-30 21:00:59.557318 | instance | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Generate OpenStack-Helm endpoints] *** 2026-07-30 21:00:59.557328 | instance | Thursday 30 July 2026 21:00:42 +0000 (0:00:00.040) 0:00:01.775 ********* 2026-07-30 21:00:59.557341 | instance | skipping: [instance] 2026-07-30 21:00:59.557354 | instance | 2026-07-30 21:00:59.557367 | instance | TASK [vexxhost.atmosphere.openstack_helm_endpoints : Clean-up facts] *********** 2026-07-30 21:00:59.557380 | instance | Thursday 30 July 2026 21:00:42 +0000 (0:00:00.037) 0:00:01.812 ********* 2026-07-30 21:00:59.557394 | instance | skipping: [instance] 2026-07-30 21:00:59.557406 | instance | 2026-07-30 21:00:59.557418 | instance | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-07-30 21:00:59.557428 | instance | Thursday 30 July 2026 21:00:42 +0000 (0:00:00.045) 0:00:01.858 ********* 2026-07-30 21:00:59.557437 | instance | skipping: [instance] 2026-07-30 21:00:59.557451 | instance | 2026-07-30 21:00:59.557464 | instance | TASK [Generate OpenStack-Helm endpoints] *************************************** 2026-07-30 21:00:59.557473 | instance | Thursday 30 July 2026 21:00:42 +0000 (0:00:00.045) 0:00:01.903 ********* 2026-07-30 21:00:59.557483 | instance | skipping: [instance] 2026-07-30 21:00:59.557492 | instance | 2026-07-30 21:00:59.557502 | instance | TASK [vexxhost.atmosphere.tempest : Read cluster issuer CA secret] ************* 2026-07-30 21:00:59.557511 | instance | Thursday 30 July 2026 21:00:42 +0000 (0:00:00.046) 0:00:01.949 ********* 2026-07-30 21:00:59.557521 | instance | skipping: [instance] 2026-07-30 21:00:59.557534 | instance | 2026-07-30 21:00:59.557546 | instance | TASK [vexxhost.atmosphere.tempest : Copy cluster issuer CA into Tempest namespace] *** 2026-07-30 21:00:59.557556 | instance | Thursday 30 July 2026 21:00:42 +0000 (0:00:00.043) 0:00:01.993 ********* 2026-07-30 21:00:59.557565 | instance | skipping: [instance] 2026-07-30 21:00:59.557575 | instance | 2026-07-30 21:00:59.557584 | instance | TASK [vexxhost.atmosphere.tempest : Get test image object] ********************* 2026-07-30 21:00:59.557594 | instance | Thursday 30 July 2026 21:00:42 +0000 (0:00:00.037) 0:00:02.030 ********* 2026-07-30 21:00:59.557604 | instance | skipping: [instance] 2026-07-30 21:00:59.557617 | instance | 2026-07-30 21:00:59.557629 | instance | TASK [vexxhost.atmosphere.tempest : Configure test image ref] ****************** 2026-07-30 21:00:59.557639 | instance | Thursday 30 July 2026 21:00:42 +0000 (0:00:00.040) 0:00:02.071 ********* 2026-07-30 21:00:59.557648 | instance | skipping: [instance] 2026-07-30 21:00:59.557658 | instance | 2026-07-30 21:00:59.557668 | instance | TASK [vexxhost.atmosphere.tempest : Get test flavor object] ******************** 2026-07-30 21:00:59.557677 | instance | Thursday 30 July 2026 21:00:42 +0000 (0:00:00.036) 0:00:02.108 ********* 2026-07-30 21:00:59.557688 | instance | skipping: [instance] 2026-07-30 21:00:59.557701 | instance | 2026-07-30 21:00:59.557712 | instance | TASK [vexxhost.atmosphere.tempest : Set test flavor ref] *********************** 2026-07-30 21:00:59.557722 | instance | Thursday 30 July 2026 21:00:42 +0000 (0:00:00.040) 0:00:02.148 ********* 2026-07-30 21:00:59.557732 | instance | skipping: [instance] 2026-07-30 21:00:59.557741 | instance | 2026-07-30 21:00:59.557751 | instance | TASK [vexxhost.atmosphere.tempest : Get test network object] ******************* 2026-07-30 21:00:59.557761 | instance | Thursday 30 July 2026 21:00:42 +0000 (0:00:00.029) 0:00:02.178 ********* 2026-07-30 21:00:59.557773 | instance | skipping: [instance] 2026-07-30 21:00:59.557786 | instance | 2026-07-30 21:00:59.557796 | instance | TASK [vexxhost.atmosphere.tempest : Set test network ref] ********************** 2026-07-30 21:00:59.557806 | instance | Thursday 30 July 2026 21:00:42 +0000 (0:00:00.030) 0:00:02.209 ********* 2026-07-30 21:00:59.557815 | instance | skipping: [instance] 2026-07-30 21:00:59.557825 | instance | 2026-07-30 21:00:59.557834 | instance | TASK [vexxhost.atmosphere.tempest : Deploy Helm chart] ************************* 2026-07-30 21:00:59.557844 | instance | Thursday 30 July 2026 21:00:42 +0000 (0:00:00.037) 0:00:02.246 ********* 2026-07-30 21:00:59.557856 | instance | skipping: [instance] 2026-07-30 21:00:59.557869 | instance | 2026-07-30 21:00:59.557879 | instance | TASK [vexxhost.atmosphere.tempest : Get tempest job object] ******************** 2026-07-30 21:00:59.557897 | instance | Thursday 30 July 2026 21:00:42 +0000 (0:00:00.033) 0:00:02.280 ********* 2026-07-30 21:00:59.557906 | instance | skipping: [instance] 2026-07-30 21:00:59.557916 | instance | 2026-07-30 21:00:59.557925 | instance | TASK [vexxhost.atmosphere.tempest : Get tempest log] *************************** 2026-07-30 21:00:59.557937 | instance | Thursday 30 July 2026 21:00:43 +0000 (0:00:00.035) 0:00:02.316 ********* 2026-07-30 21:00:59.557950 | instance | skipping: [instance] 2026-07-30 21:00:59.557960 | instance | 2026-07-30 21:00:59.557977 | instance | TASK [vexxhost.atmosphere.tempest : Print tempest log details] ***************** 2026-07-30 21:00:59.557992 | instance | Thursday 30 July 2026 21:00:43 +0000 (0:00:00.034) 0:00:02.350 ********* 2026-07-30 21:00:59.558002 | instance | skipping: [instance] 2026-07-30 21:00:59.558012 | instance | 2026-07-30 21:00:59.558025 | instance | TASK [vexxhost.atmosphere.tempest : Fail when tempest result is failed] ******** 2026-07-30 21:00:59.558037 | instance | Thursday 30 July 2026 21:00:43 +0000 (0:00:00.032) 0:00:02.382 ********* 2026-07-30 21:00:59.558046 | instance | skipping: [instance] 2026-07-30 21:00:59.558056 | instance | 2026-07-30 21:00:59.558065 | instance | PLAY RECAP ********************************************************************* 2026-07-30 21:00:59.558075 | instance | instance : ok=1 changed=0 unreachable=0 failed=0 skipped=27 rescued=0 ignored=0 2026-07-30 21:00:59.558085 | instance | localhost : ok=0 changed=0 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-07-30 21:00:59.558095 | instance | 2026-07-30 21:00:59.558109 | instance | Thursday 30 July 2026 21:00:43 +0000 (0:00:00.034) 0:00:02.417 ********* 2026-07-30 21:00:59.558119 | instance | =============================================================================== 2026-07-30 21:00:59.558129 | instance | Gathering Facts --------------------------------------------------------- 1.28s 2026-07-30 21:00:59.558138 | instance | vexxhost.atmosphere.openstacksdk : Generate cloud config file ----------- 0.05s 2026-07-30 21:00:59.558148 | instance | Run "stestr" tests ------------------------------------------------------ 0.05s 2026-07-30 21:00:59.558157 | instance | vexxhost.atmosphere.openstack_helm_endpoints : Cache fact with Percona XtraDB password --- 0.05s 2026-07-30 21:00:59.558167 | instance | Generate OpenStack-Helm endpoints --------------------------------------- 0.05s 2026-07-30 21:00:59.558178 | instance | Create RabbitMQ cluster ------------------------------------------------- 0.05s 2026-07-30 21:00:59.558192 | instance | vexxhost.atmosphere.openstack_helm_endpoints : Clean-up facts ----------- 0.05s 2026-07-30 21:00:59.558202 | instance | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s 2026-07-30 21:00:59.558211 | instance | vexxhost.atmosphere.tempest : Read cluster issuer CA secret ------------- 0.04s 2026-07-30 21:00:59.558221 | instance | vexxhost.atmosphere.openstack_helm_endpoints : Grab Percona XtraDB cluster secret --- 0.04s 2026-07-30 21:00:59.558230 | instance | vexxhost.atmosphere.openstack_helm_endpoints : Cache fact with RabbitMQ cluster credentials --- 0.04s 2026-07-30 21:00:59.558240 | instance | vexxhost.atmosphere.tempest : Get test image object --------------------- 0.04s 2026-07-30 21:00:59.558250 | instance | vexxhost.atmosphere.tempest : Get test flavor object -------------------- 0.04s 2026-07-30 21:00:59.558261 | instance | vexxhost.atmosphere.openstack_helm_endpoints : Reset value for OpenStack_Helm endpoints --- 0.04s 2026-07-30 21:00:59.558274 | instance | vexxhost.atmosphere.openstacksdk : Install openstacksdk ----------------- 0.04s 2026-07-30 21:00:59.558284 | instance | vexxhost.atmosphere.openstack_helm_endpoints : Grab RabbitMQ cluster secret --- 0.04s 2026-07-30 21:00:59.558294 | instance | vexxhost.atmosphere.openstack_helm_endpoints : Retrieve list of all the needed endpoints --- 0.04s 2026-07-30 21:00:59.558303 | instance | vexxhost.atmosphere.openstack_helm_endpoints : Generate OpenStack-Helm endpoints --- 0.04s 2026-07-30 21:00:59.558313 | instance | vexxhost.atmosphere.tempest : Copy cluster issuer CA into Tempest namespace --- 0.04s 2026-07-30 21:00:59.558323 | instance | vexxhost.atmosphere.tempest : Set test network ref ---------------------- 0.04s 2026-07-30 21:00:59.558341 | instance | INFO [aio > verify] Executed: Successful 2026-07-30 21:00:59.558356 | instance | INFO [aio > cleanup] Executing 2026-07-30 21:00:59.558366 | instance | WARNING [aio > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-07-30 21:00:59.558375 | instance | INFO [aio > destroy] Executing 2026-07-30 21:00:59.558385 | instance | WARNING [aio > destroy] Skipping, '--destroy=never' requested. 2026-07-30 21:00:59.558395 | instance | INFO [aio > destroy] Executed: Successful 2026-07-30 21:00:59.558404 | instance | WARNING Molecule executed 1 scenario (1 missing files) 2026-07-30 21:00:59.882118 | instance | ok: Runtime: 0:00:00.010523 2026-07-30 21:00:59.892475 | 2026-07-30 21:00:59.892620 | TASK [Track last task for Molecule aio (aio-openvswitch)] 2026-07-30 21:00:59.969017 | instance | ok 2026-07-30 21:00:59.975690 | 2026-07-30 21:00:59.975844 | TASK [Advance live log offset for Molecule aio (aio-openvswitch)] 2026-07-30 21:01:00.029820 | instance | ok 2026-07-30 21:01:00.040603 | 2026-07-30 21:01:00.040737 | TASK [Report progress heartbeat for Molecule aio (aio-openvswitch)] 2026-07-30 21:01:00.086809 | instance | skipping: Conditional result was False 2026-07-30 21:01:00.099590 | 2026-07-30 21:01:00.099715 | TASK [Continue monitoring Molecule aio (aio-openvswitch)] 2026-07-30 21:01:00.146641 | instance | skipping: Conditional result was False 2026-07-30 21:01:00.166946 | 2026-07-30 21:01:00.167331 | TASK [Start progress monitor chunk for Molecule aio (aio-openvswitch)] 2026-07-30 21:01:00.222727 | instance | skipping: Conditional result was False 2026-07-30 21:01:00.232303 | 2026-07-30 21:01:00.232416 | TASK [Start progress monitor chunk for Molecule aio (aio-openvswitch)] 2026-07-30 21:01:00.284763 | instance | skipping: Conditional result was False 2026-07-30 21:01:00.305640 | 2026-07-30 21:01:00.305864 | TASK [Start progress monitor chunk for Molecule aio (aio-openvswitch)] 2026-07-30 21:01:00.351513 | instance | skipping: Conditional result was False 2026-07-30 21:01:00.366402 | 2026-07-30 21:01:00.366593 | TASK [Start progress monitor chunk for Molecule aio (aio-openvswitch)] 2026-07-30 21:01:00.412797 | instance | skipping: Conditional result was False 2026-07-30 21:01:00.426039 | 2026-07-30 21:01:00.426161 | TASK [Clean up async state for Molecule aio (aio-openvswitch)] 2026-07-30 21:01:00.619346 | instance | ok 2026-07-30 21:01:00.625644 | 2026-07-30 21:01:00.625735 | TASK [Assert success for Molecule aio (aio-openvswitch)] 2026-07-30 21:01:00.695955 | instance | ok: All assertions passed 2026-07-30 21:01:00.697793 | 2026-07-30 21:01:00.697857 | PLAY RECAP 2026-07-30 21:01:00.697913 | instance | ok: 92 changed: 4 unreachable: 0 failed: 0 skipped: 6 rescued: 0 ignored: 0 2026-07-30 21:01:00.697941 | 2026-07-30 21:01:00.886496 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/selective-run.yml@main] 2026-07-30 21:01:00.903604 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main] 2026-07-30 21:01:01.653527 | 2026-07-30 21:01:01.653687 | PLAY [Publish selective Molecule plan] 2026-07-30 21:01:01.668200 | 2026-07-30 21:01:01.668329 | TASK [Check for selective Molecule plan] 2026-07-30 21:01:02.040811 | instance | ok 2026-07-30 21:01:02.047873 | 2026-07-30 21:01:02.047960 | TASK [Create log directory] 2026-07-30 21:01:02.463590 | instance | ok 2026-07-30 21:01:02.472224 | 2026-07-30 21:01:02.472306 | TASK [Copy selective Molecule plan to logs] 2026-07-30 21:01:02.930994 | instance | changed 2026-07-30 21:01:02.932876 | 2026-07-30 21:01:02.932928 | PLAY RECAP 2026-07-30 21:01:02.932996 | instance | ok: 3 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-07-30 21:01:02.933043 | 2026-07-30 21:01:03.100733 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main] 2026-07-30 21:01:03.179643 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-07-30 21:01:04.345909 | 2026-07-30 21:01:04.346080 | PLAY [all] 2026-07-30 21:01:04.367144 | 2026-07-30 21:01:04.367339 | TASK [gather-host-logs : creating directory for system status] 2026-07-30 21:01:04.775379 | instance | changed 2026-07-30 21:01:04.783571 | 2026-07-30 21:01:04.783665 | TASK [gather-host-logs : Get logs for each host] 2026-07-30 21:01:05.184711 | instance | + systemd-cgls --full --all --no-pager 2026-07-30 21:01:05.196678 | instance | + ip addr 2026-07-30 21:01:05.199525 | instance | + ip route 2026-07-30 21:01:05.201501 | instance | + lsblk 2026-07-30 21:01:05.206289 | instance | + mount 2026-07-30 21:01:05.210428 | instance | + docker images 2026-07-30 21:01:05.211310 | instance | /bin/bash: line 7: docker: command not found 2026-07-30 21:01:05.211563 | instance | + brctl show 2026-07-30 21:01:05.212015 | instance | /bin/bash: line 8: brctl: command not found 2026-07-30 21:01:05.212248 | instance | + ps aux --sort=-%mem 2026-07-30 21:01:05.228145 | instance | + dpkg -l 2026-07-30 21:01:05.240280 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-07-30 21:01:05.240734 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-07-30 21:01:05.240778 | instance | /bin/bash: line 11: docker: command not found 2026-07-30 21:01:05.241042 | instance | + '[' '!' -z '' ']' 2026-07-30 21:01:05.324648 | instance | ok: Runtime: 0:00:00.062777 2026-07-30 21:01:05.333024 | 2026-07-30 21:01:05.333161 | TASK [gather-host-logs : Downloads logs to executor] 2026-07-30 21:01:06.037394 | instance | changed: 2026-07-30 21:01:06.199496 | instance | created directory /var/lib/zuul/builds/3eedc45cc79d401187fd3d64411838bd/work/logs/instance 2026-07-30 21:01:06.199711 | instance | cd+++++++++ system/ 2026-07-30 21:01:06.199779 | instance | >f+++++++++ system/brctl-show.txt 2026-07-30 21:01:06.199835 | instance | >f+++++++++ system/docker-images.txt 2026-07-30 21:01:06.199885 | instance | >f+++++++++ system/ip-addr.txt 2026-07-30 21:01:06.199942 | instance | >f+++++++++ system/ip-route.txt 2026-07-30 21:01:06.200453 | instance | >f+++++++++ system/lsblk.txt 2026-07-30 21:01:06.200537 | instance | >f+++++++++ system/mount.txt 2026-07-30 21:01:06.200598 | instance | >f+++++++++ system/packages.txt 2026-07-30 21:01:06.200649 | instance | >f+++++++++ system/ps.txt 2026-07-30 21:01:06.200698 | instance | >f+++++++++ system/systemd-cgls.txt 2026-07-30 21:01:06.222133 | 2026-07-30 21:01:06.222272 | LOOP [helm-release-status : creating directory for helm release status] 2026-07-30 21:01:06.453378 | instance | changed: "values" 2026-07-30 21:01:06.619261 | instance | changed: "releases" 2026-07-30 21:01:06.626463 | 2026-07-30 21:01:06.626588 | TASK [helm-release-status : Gather get release status for helm charts] 2026-07-30 21:01:06.914684 | instance | /bin/bash: line 3: kubectl: command not found 2026-07-30 21:01:07.216452 | instance | ok: Runtime: 0:00:00.007478 2026-07-30 21:01:07.223900 | 2026-07-30 21:01:07.224001 | TASK [helm-release-status : Downloads logs to executor] 2026-07-30 21:01:07.746529 | instance | changed: 2026-07-30 21:01:07.746713 | instance | cd+++++++++ helm/ 2026-07-30 21:01:07.746753 | instance | cd+++++++++ helm/releases/ 2026-07-30 21:01:07.746785 | instance | cd+++++++++ helm/values/ 2026-07-30 21:01:07.763099 | 2026-07-30 21:01:07.763367 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-07-30 21:01:07.979565 | instance | changed 2026-07-30 21:01:07.986622 | 2026-07-30 21:01:07.986701 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-07-30 21:01:08.214952 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-07-30 21:01:08.215965 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-07-30 21:01:08.221230 | instance | environment: line 1: kubectl: command not found 2026-07-30 21:01:08.222679 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-07-30 21:01:08.223975 | instance | environment: line 1: kubectl: command not found 2026-07-30 21:01:08.225367 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-07-30 21:01:08.227092 | instance | environment: line 1: kubectl: command not found 2026-07-30 21:01:08.228407 | instance | environment: line 1: kubectl: command not found 2026-07-30 21:01:08.228509 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-07-30 21:01:08.229471 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-07-30 21:01:08.231514 | instance | environment: line 1: kubectl: command not found 2026-07-30 21:01:08.233248 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-07-30 21:01:08.527098 | instance | ok: Runtime: 0:00:00.036401 2026-07-30 21:01:08.532158 | 2026-07-30 21:01:08.532222 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-07-30 21:01:08.748123 | instance | changed 2026-07-30 21:01:08.753819 | 2026-07-30 21:01:08.753893 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-07-30 21:01:09.000863 | instance | environment: line 5: kubectl: command not found 2026-07-30 21:01:09.001202 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-07-30 21:01:09.001581 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-07-30 21:01:09.001718 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-07-30 21:01:09.332942 | instance | ok: Runtime: 0:00:00.010203 2026-07-30 21:01:09.338600 | 2026-07-30 21:01:09.338672 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-07-30 21:01:09.833526 | instance | changed: 2026-07-30 21:01:09.833845 | instance | cd+++++++++ objects/ 2026-07-30 21:01:09.833891 | instance | cd+++++++++ objects/cluster/ 2026-07-30 21:01:09.833923 | instance | cd+++++++++ objects/namespaced/ 2026-07-30 21:01:09.845270 | 2026-07-30 21:01:09.845347 | TASK [gather-pod-logs : creating directory for pod logs] 2026-07-30 21:01:10.046844 | instance | changed 2026-07-30 21:01:10.052318 | 2026-07-30 21:01:10.052390 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-07-30 21:01:10.280502 | instance | changed 2026-07-30 21:01:10.286528 | 2026-07-30 21:01:10.286626 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-07-30 21:01:10.505162 | instance | environment: line 3: kubectl: command not found 2026-07-30 21:01:10.834713 | instance | ok: Runtime: 0:00:00.009728 2026-07-30 21:01:10.840360 | 2026-07-30 21:01:10.840425 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-07-30 21:01:11.341251 | instance | changed: 2026-07-30 21:01:11.341499 | instance | cd+++++++++ pod-logs/ 2026-07-30 21:01:11.341559 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-07-30 21:01:11.351434 | 2026-07-30 21:01:11.351502 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-07-30 21:01:11.564832 | instance | changed 2026-07-30 21:01:11.570688 | 2026-07-30 21:01:11.570756 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-07-30 21:01:11.792913 | instance | /bin/bash: line 2: kubectl: command not found 2026-07-30 21:01:12.110716 | instance | ok: Runtime: 0:00:00.039106 2026-07-30 21:01:12.119354 | 2026-07-30 21:01:12.119434 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-07-30 21:01:12.333032 | instance | /bin/bash: line 2: kubectl: command not found 2026-07-30 21:01:12.358667 | instance | ceph-mgr endpoints: 2026-07-30 21:01:12.653851 | instance | ok: Runtime: 0:00:00.033369 2026-07-30 21:01:12.660356 | 2026-07-30 21:01:12.660436 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-07-30 21:01:12.942464 | instance | /bin/bash: line 4: kubectl: command not found 2026-07-30 21:01:13.264307 | instance | ok: Runtime: 0:00:00.037418 2026-07-30 21:01:13.270000 | 2026-07-30 21:01:13.270069 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-07-30 21:01:13.775875 | instance | changed: cd+++++++++ prometheus/ 2026-07-30 21:01:13.786377 | 2026-07-30 21:01:13.786496 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-07-30 21:01:14.014479 | instance | changed 2026-07-30 21:01:14.021405 | 2026-07-30 21:01:14.021500 | TASK [gather-selenium-data : Get selenium data] 2026-07-30 21:01:14.297949 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-07-30 21:01:14.298996 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-07-30 21:01:14.599922 | instance | ERROR 2026-07-30 21:01:14.600149 | instance | { 2026-07-30 21:01:14.600191 | instance | "delta": "0:00:00.006422", 2026-07-30 21:01:14.600215 | instance | "end": "2026-07-30 21:01:14.299273", 2026-07-30 21:01:14.600234 | instance | "msg": "non-zero return code", 2026-07-30 21:01:14.600253 | instance | "rc": 1, 2026-07-30 21:01:14.600271 | instance | "start": "2026-07-30 21:01:14.292851" 2026-07-30 21:01:14.600289 | instance | } 2026-07-30 21:01:14.600326 | instance | ERROR: Ignoring Errors 2026-07-30 21:01:14.605309 | 2026-07-30 21:01:14.605371 | TASK [gather-selenium-data : Downloads logs to executor] 2026-07-30 21:01:15.120188 | instance | changed: cd+++++++++ selenium/ 2026-07-30 21:01:15.128681 | 2026-07-30 21:01:15.128780 | PLAY RECAP 2026-07-30 21:01:15.128831 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-07-30 21:01:15.128854 | 2026-07-30 21:01:15.298580 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-07-30 21:01:15.313737 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-07-30 21:01:15.999092 | 2026-07-30 21:01:15.999217 | PLAY [all] 2026-07-30 21:01:16.010744 | 2026-07-30 21:01:16.010819 | TASK [fetch-output : Set log path for multiple nodes] 2026-07-30 21:01:16.045602 | instance | skipping: Conditional result was False 2026-07-30 21:01:16.050730 | 2026-07-30 21:01:16.050808 | TASK [fetch-output : Set log path for single node] 2026-07-30 21:01:16.089136 | instance | ok 2026-07-30 21:01:16.093553 | 2026-07-30 21:01:16.093619 | LOOP [fetch-output : Ensure local output dirs] 2026-07-30 21:01:16.485682 | instance -> localhost | ok: "/var/lib/zuul/builds/3eedc45cc79d401187fd3d64411838bd/work/logs" 2026-07-30 21:01:16.724850 | instance -> localhost | changed: "/var/lib/zuul/builds/3eedc45cc79d401187fd3d64411838bd/work/artifacts" 2026-07-30 21:01:16.924269 | instance -> localhost | changed: "/var/lib/zuul/builds/3eedc45cc79d401187fd3d64411838bd/work/docs" 2026-07-30 21:01:16.941111 | 2026-07-30 21:01:16.941238 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-07-30 21:01:17.592488 | instance | changed: .d..t...... ./ 2026-07-30 21:01:17.592743 | instance | changed: All items complete 2026-07-30 21:01:17.592776 | 2026-07-30 21:01:18.082169 | instance | changed: .d..t...... ./ 2026-07-30 21:01:18.699960 | instance | changed: .d..t...... ./ 2026-07-30 21:01:18.717969 | 2026-07-30 21:01:18.718087 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-07-30 21:01:19.881603 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007551 2026-07-30 21:01:20.113429 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007396 2026-07-30 21:01:20.128125 | 2026-07-30 21:01:20.128250 | PLAY [all] 2026-07-30 21:01:20.143737 | 2026-07-30 21:01:20.144172 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-07-30 21:01:20.594434 | instance | changed 2026-07-30 21:01:20.600075 | 2026-07-30 21:01:20.600123 | PLAY RECAP 2026-07-30 21:01:20.600165 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-07-30 21:01:20.600187 | 2026-07-30 21:01:20.730805 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-07-30 21:01:20.749812 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-07-30 21:01:21.438414 | 2026-07-30 21:01:21.438612 | PLAY [localhost] 2026-07-30 21:01:21.454703 | 2026-07-30 21:01:21.454899 | TASK [Generate Zuul manifest] 2026-07-30 21:01:21.478119 | localhost | ok 2026-07-30 21:01:21.500461 | 2026-07-30 21:01:21.500650 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-07-30 21:01:21.914081 | localhost | changed 2026-07-30 21:01:21.924302 | 2026-07-30 21:01:21.924429 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-07-30 21:01:21.952764 | localhost | ok 2026-07-30 21:01:21.961626 | 2026-07-30 21:01:21.961699 | TASK [Upload logs] 2026-07-30 21:01:21.980486 | localhost | ok 2026-07-30 21:01:22.092790 | 2026-07-30 21:01:22.092912 | TASK [Set zuul-log-path fact] 2026-07-30 21:01:22.113942 | localhost | ok 2026-07-30 21:01:22.127862 | 2026-07-30 21:01:22.127954 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-07-30 21:01:22.156239 | localhost | ok 2026-07-30 21:01:22.163316 | 2026-07-30 21:01:22.163385 | TASK [upload-logs : Create log directories] 2026-07-30 21:01:22.538906 | localhost | changed 2026-07-30 21:01:22.545585 | 2026-07-30 21:01:22.545703 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-07-30 21:01:22.917049 | localhost -> localhost | ok: Runtime: 0:00:00.005873 2026-07-30 21:01:22.924760 | 2026-07-30 21:01:22.924832 | TASK [upload-logs : Upload logs to log server] 2026-07-30 21:01:23.381855 | localhost | Output suppressed because no_log was given 2026-07-30 21:01:23.385924 | 2026-07-30 21:01:23.385996 | LOOP [upload-logs : Compress console log and json output] 2026-07-30 21:01:23.433929 | localhost | skipping: Conditional result was False 2026-07-30 21:01:23.441591 | localhost | skipping: Conditional result was False 2026-07-30 21:01:23.453342 | 2026-07-30 21:01:23.453558 | LOOP [upload-logs : Upload compressed console log and json output] 2026-07-30 21:01:23.499455 | localhost | skipping: Conditional result was False 2026-07-30 21:01:23.499826 | 2026-07-30 21:01:23.508620 | localhost | skipping: Conditional result was False 2026-07-30 21:01:23.518800 | 2026-07-30 21:01:23.518984 | LOOP [upload-logs : Upload console log and json output]