2026-05-26 05:48:13.987284 | Job console starting
2026-05-26 05:48:14.005522 | Updating git repos
2026-05-26 05:48:16.141383 | Cloning repos into workspace
2026-05-26 05:49:12.071874 | Restoring repo states
2026-05-26 05:49:19.695229 | Merging changes
2026-05-26 05:49:22.546265 | Checking out repos
2026-05-26 05:49:28.367711 | Preparing playbooks
2026-05-26 05:49:38.008802 | Running Ansible setup
2026-05-26 05:49:43.069844 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-05-26 05:49:43.768037 | 
2026-05-26 05:49:43.768237 | PLAY [localhost]
2026-05-26 05:49:43.777220 | 
2026-05-26 05:49:43.777299 | TASK [Gathering Facts]
2026-05-26 05:49:44.738545 | localhost | ok
2026-05-26 05:49:44.749775 | 
2026-05-26 05:49:44.749868 | TASK [Setup log path fact]
2026-05-26 05:49:44.772834 | localhost | ok
2026-05-26 05:49:44.789388 | 
2026-05-26 05:49:44.789472 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-05-26 05:49:44.822226 | localhost | ok
2026-05-26 05:49:44.830090 | 
2026-05-26 05:49:44.830162 | TASK [emit-job-header : Print job information]
2026-05-26 05:49:44.868232 | # Job Information
2026-05-26 05:49:45.173943 | Ansible Version: 2.16.18
2026-05-26 05:49:45.174338 | Job: atmosphere-molecule-aio-openvswitch
2026-05-26 05:49:45.174775 | Pipeline: check
2026-05-26 05:49:45.174890 | Executor: 2d72f0692154
2026-05-26 05:49:45.174994 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3818
2026-05-26 05:49:45.175129 | Event ID: 598826e0-58c6-11f1-820a-d4f611e7ae97
2026-05-26 05:49:45.182824 | 
2026-05-26 05:49:45.182902 | LOOP [emit-job-header : Print node information]
2026-05-26 05:49:45.284146 | localhost | ok:
2026-05-26 05:49:45.284424 | localhost | # Node Information
2026-05-26 05:49:45.284477 | localhost | Inventory Hostname: instance
2026-05-26 05:49:45.284518 | localhost | Hostname: np0000176454
2026-05-26 05:49:45.284554 | localhost | Username: zuul
2026-05-26 05:49:45.284592 | localhost | Distro: Ubuntu 22.04
2026-05-26 05:49:45.284628 | localhost | Provider: yul1
2026-05-26 05:49:45.284662 | localhost | Region: ca-ymq-1
2026-05-26 05:49:45.284695 | localhost | Label: ubuntu-jammy-16
2026-05-26 05:49:45.284729 | localhost | Product Name: OpenStack Nova
2026-05-26 05:49:45.284762 | localhost | Interface IP: 199.204.45.65
2026-05-26 05:49:45.305697 | 
2026-05-26 05:49:45.305871 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-05-26 05:49:45.697752 | localhost -> localhost | changed
2026-05-26 05:49:45.707263 | 
2026-05-26 05:49:45.707352 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-05-26 05:49:46.675585 | localhost -> localhost | changed
2026-05-26 05:49:46.686337 | 
2026-05-26 05:49:46.686433 | PLAY [all]
2026-05-26 05:49:46.695498 | 
2026-05-26 05:49:46.695562 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-05-26 05:49:46.962337 | instance -> localhost | ok
2026-05-26 05:49:46.975308 | 
2026-05-26 05:49:46.975418 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-05-26 05:49:47.007031 | instance | ok
2026-05-26 05:49:47.023161 | instance | included: /var/lib/zuul/builds/946e305c1d79426492d7166ee90ac734/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-05-26 05:49:47.029011 | 
2026-05-26 05:49:47.029074 | TASK [add-build-sshkey : Create Temp SSH key]
2026-05-26 05:49:48.249303 | instance -> localhost | Generating public/private rsa key pair.
2026-05-26 05:49:48.249761 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/946e305c1d79426492d7166ee90ac734/work/946e305c1d79426492d7166ee90ac734_id_rsa
2026-05-26 05:49:48.249817 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/946e305c1d79426492d7166ee90ac734/work/946e305c1d79426492d7166ee90ac734_id_rsa.pub
2026-05-26 05:49:48.249850 | instance -> localhost | The key fingerprint is:
2026-05-26 05:49:48.249880 | instance -> localhost | SHA256:uoVDIzsgGkyyr0cF4t9kBSh97N5SpfR+JA9X99nfPoc zuul-build-sshkey
2026-05-26 05:49:48.249923 | instance -> localhost | The key's randomart image is:
2026-05-26 05:49:48.249953 | instance -> localhost | +---[RSA 3072]----+
2026-05-26 05:49:48.249990 | instance -> localhost | |  . o..          |
2026-05-26 05:49:48.250020 | instance -> localhost | |...o o o .   . . |
2026-05-26 05:49:48.250048 | instance -> localhost | |oo..o o +   . . +|
2026-05-26 05:49:48.250076 | instance -> localhost | |+o  .+ o + o   .o|
2026-05-26 05:49:48.250104 | instance -> localhost | |+.o.* = S *     o|
2026-05-26 05:49:48.250130 | instance -> localhost | |.+.o B = . o    o|
2026-05-26 05:49:48.250157 | instance -> localhost | |... o = . .    o |
2026-05-26 05:49:48.250184 | instance -> localhost | | ..  . +      E.o|
2026-05-26 05:49:48.250215 | instance -> localhost | |..    .         o|
2026-05-26 05:49:48.250244 | instance -> localhost | +----[SHA256]-----+
2026-05-26 05:49:48.250312 | instance -> localhost | ok: Runtime: 0:00:00.713362
2026-05-26 05:49:48.257436 | 
2026-05-26 05:49:48.257507 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-05-26 05:49:48.294639 | instance | ok
2026-05-26 05:49:48.305246 | instance | included: /var/lib/zuul/builds/946e305c1d79426492d7166ee90ac734/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-05-26 05:49:48.314230 | 
2026-05-26 05:49:48.314291 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-05-26 05:49:48.339140 | instance | skipping: Conditional result was False
2026-05-26 05:49:48.349101 | 
2026-05-26 05:49:48.349166 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-05-26 05:49:48.796154 | instance | changed
2026-05-26 05:49:48.801631 | 
2026-05-26 05:49:48.801699 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-05-26 05:49:49.033993 | instance | ok
2026-05-26 05:49:49.039750 | 
2026-05-26 05:49:49.039837 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-05-26 05:49:49.492426 | instance | changed
2026-05-26 05:49:49.644772 | 
2026-05-26 05:49:49.644935 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-05-26 05:49:50.113478 | instance | changed
2026-05-26 05:49:50.119592 | 
2026-05-26 05:49:50.119656 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-05-26 05:49:50.143600 | instance | skipping: Conditional result was False
2026-05-26 05:49:50.156147 | 
2026-05-26 05:49:50.156236 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-05-26 05:49:50.466787 | instance -> localhost | changed
2026-05-26 05:49:50.482059 | 
2026-05-26 05:49:50.482124 | TASK [add-build-sshkey : Add back temp key]
2026-05-26 05:49:50.780865 | instance -> localhost | Identity added: /var/lib/zuul/builds/946e305c1d79426492d7166ee90ac734/work/946e305c1d79426492d7166ee90ac734_id_rsa (zuul-build-sshkey)
2026-05-26 05:49:50.781086 | instance -> localhost | ok: Runtime: 0:00:00.013921
2026-05-26 05:49:50.786042 | 
2026-05-26 05:49:50.786101 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-05-26 05:49:51.073980 | instance | ok
2026-05-26 05:49:51.086018 | 
2026-05-26 05:49:51.086186 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-05-26 05:49:51.112194 | instance | skipping: Conditional result was False
2026-05-26 05:49:51.127926 | 
2026-05-26 05:49:51.128025 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-05-26 05:49:51.417212 | instance | ok
2026-05-26 05:49:51.424032 | 
2026-05-26 05:49:51.424093 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-05-26 05:49:57.062070 | instance | Output suppressed because no_log was given
2026-05-26 05:49:57.071844 | 
2026-05-26 05:49:57.071915 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-05-26 05:49:57.269350 | instance | ok: "logs"
2026-05-26 05:49:57.269635 | instance | ok: All items complete
2026-05-26 05:49:57.269664 | 
2026-05-26 05:49:57.451643 | instance | ok: "artifacts"
2026-05-26 05:49:57.614640 | instance | ok: "docs"
2026-05-26 05:49:57.636456 | 
2026-05-26 05:49:57.636654 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-05-26 05:49:57.824043 | instance | changed: "logs"
2026-05-26 05:49:57.989939 | instance | changed: "artifacts"
2026-05-26 05:49:58.167521 | instance | changed: "docs"
2026-05-26 05:49:58.181978 | 
2026-05-26 05:49:58.182120 | PLAY RECAP
2026-05-26 05:49:58.182181 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-05-26 05:49:58.182221 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-26 05:49:58.182252 | 
2026-05-26 05:49:58.359674 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-05-26 05:49:58.372508 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-05-26 05:49:59.019816 | 
2026-05-26 05:49:59.019936 | PLAY [all]
2026-05-26 05:49:59.030844 | 
2026-05-26 05:49:59.030919 | TASK [setup-uv : Extract archive]
2026-05-26 05:50:01.329513 | instance | changed
2026-05-26 05:50:01.335608 | 
2026-05-26 05:50:01.335699 | TASK [setup-uv : Print version]
2026-05-26 05:50:01.752647 | instance | uv 0.8.13
2026-05-26 05:50:01.876279 | instance | ok: Runtime: 0:00:00.012155
2026-05-26 05:50:01.889548 | 
2026-05-26 05:50:01.889641 | TASK [Install Ansible collection siblings]
2026-05-26 05:50:11.572978 | instance | changed:
2026-05-26 05:50:11.573179 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-05-26 05:50:11.573222 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-05-26 05:50:11.573253 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-05-26 05:50:11.573284 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-05-26 05:50:11.573311 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-05-26 05:50:11.573341 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-05-26 05:50:11.573370 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-05-26 05:50:11.573399 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-05-26 05:50:11.573425 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-05-26 05:50:11.573452 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-05-26 05:50:11.573478 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-05-26 05:50:11.573505 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-05-26 05:50:11.573530 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-05-26 05:50:11.573556 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-05-26 05:50:11.573582 | instance | Resolved ansible.utils to v6.0.2 for >=2.9.0
2026-05-26 05:50:11.573607 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-05-26 05:50:11.573633 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-05-26 05:50:11.573659 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-05-26 05:50:11.573684 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-05-26 05:50:11.573709 | instance | Resolved openstack.cloud to 2.5.0 for >=2.0.0
2026-05-26 05:50:11.573734 | instance | Resolved vexxhost.ceph to v4.0.0 for >=3.2.0
2026-05-26 05:50:11.573759 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-05-26 05:50:11.573840 | instance | Resolved vexxhost.kubernetes to v3.1.0 for >=2.5.0
2026-05-26 05:50:11.573894 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-05-26 05:50:11.573929 | instance | Resolved ansible.utils to v6.0.2 for >=2.9.0,>=6.0.0
2026-05-26 05:50:11.573962 | instance | Resolved vexxhost.containers to v1.6.6 for >=1.1.1,>=1.6.0
2026-05-26 05:50:11.573994 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-05-26 05:50:11.574025 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-05-26 05:50:11.574057 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-05-26 05:50:11.574083 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-05-26 05:50:11.574108 | instance | Resolved vexxhost.containers to v1.6.6 for >=1.1.1,>=1.6.0
2026-05-26 05:50:11.574133 | instance | Checked out ansible.netcommon to 1.2.0
2026-05-26 05:50:11.574159 | 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-05-26 05:50:11.574193 | instance | Starting galaxy collection install process
2026-05-26 05:50:11.574219 | instance | Process install dependency map
2026-05-26 05:50:11.574245 | instance | Starting collection install process
2026-05-26 05:50:11.574270 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-05-26 05:50:11.574295 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-05-26 05:50:11.574320 | instance | ansible.netcommon:* was installed successfully
2026-05-26 05:50:11.574345 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-05-26 05:50:11.574370 | instance | Creating virtual environment at: .venv
2026-05-26 05:50:11.574395 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-05-26 05:50:11.574420 | instance | Downloading cryptography (4.2MiB)
2026-05-26 05:50:11.574444 | instance | Downloading netaddr (2.2MiB)
2026-05-26 05:50:11.574469 | instance | Downloading rjsonnet (1.2MiB)
2026-05-26 05:50:11.574499 | instance | Downloading pydantic-core (2.0MiB)
2026-05-26 05:50:11.574524 | instance | Downloading openstacksdk (1.7MiB)
2026-05-26 05:50:11.574549 | instance | Downloading kubernetes (1.9MiB)
2026-05-26 05:50:11.574574 | instance | Downloading ansible-core (2.1MiB)
2026-05-26 05:50:11.574599 | instance | Downloading pygments (1.2MiB)
2026-05-26 05:50:11.574624 | instance | Downloading setuptools (1.1MiB)
2026-05-26 05:50:11.574649 | instance |  Downloading rjsonnet
2026-05-26 05:50:11.574673 | instance |    Building pyperclip==1.9.0
2026-05-26 05:50:11.574700 | instance |  Downloading pydantic-core
2026-05-26 05:50:11.574726 | instance |  Downloading netaddr
2026-05-26 05:50:11.574751 | instance |  Downloading pygments
2026-05-26 05:50:11.574776 | instance |  Downloading cryptography
2026-05-26 05:50:11.574800 | instance |  Downloading setuptools
2026-05-26 05:50:11.574825 | instance |  Downloading kubernetes
2026-05-26 05:50:11.574850 | instance |  Downloading openstacksdk
2026-05-26 05:50:11.574875 | instance |  Downloading ansible-core
2026-05-26 05:50:11.574900 | instance |       Built pyperclip==1.9.0
2026-05-26 05:50:11.574924 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-05-26 05:50:11.574949 | instance | Installed 83 packages in 55ms
2026-05-26 05:50:11.574974 | instance | Checked out ansible.posix to 1.6.0
2026-05-26 05:50:11.574999 | 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-05-26 05:50:11.575025 | instance | Starting galaxy collection install process
2026-05-26 05:50:11.575050 | instance | Process install dependency map
2026-05-26 05:50:11.575075 | instance | Starting collection install process
2026-05-26 05:50:11.575100 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-05-26 05:50:11.575131 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-05-26 05:50:11.575157 | instance | ansible.posix:1.6.0 was installed successfully
2026-05-26 05:50:11.575183 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-05-26 05:50:11.575208 | instance | 2.17.12
2026-05-26 05:50:11.575234 | instance | Checked out ansible.utils to v6.0.2
2026-05-26 05:50:11.575261 | 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-05-26 05:50:11.575289 | instance | Starting galaxy collection install process
2026-05-26 05:50:11.575313 | instance | Process install dependency map
2026-05-26 05:50:11.575338 | instance | Starting collection install process
2026-05-26 05:50:11.575363 | instance | Installing 'ansible.utils:6.0.2' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-05-26 05:50:11.575388 | instance | Created collection for ansible.utils:6.0.2 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-05-26 05:50:11.575413 | instance | ansible.utils:6.0.2 was installed successfully
2026-05-26 05:50:11.575438 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-05-26 05:50:11.575464 | instance | 2.17.12
2026-05-26 05:50:11.575489 | instance | Checked out atmosphere.common to v0.7.0
2026-05-26 05:50:11.575514 | 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-05-26 05:50:11.575540 | instance | Starting galaxy collection install process
2026-05-26 05:50:11.575565 | instance | Process install dependency map
2026-05-26 05:50:11.575590 | instance | Starting collection install process
2026-05-26 05:50:11.575623 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-05-26 05:50:11.575692 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-05-26 05:50:11.575745 | instance | atmosphere.common:0.7.0 was installed successfully
2026-05-26 05:50:11.575779 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-05-26 05:50:11.575806 | instance | 2.17.12
2026-05-26 05:50:11.575832 | instance | Checked out community.crypto to 2.2.3
2026-05-26 05:50:11.575857 | 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-05-26 05:50:11.575882 | instance | Starting galaxy collection install process
2026-05-26 05:50:11.575907 | instance | Process install dependency map
2026-05-26 05:50:11.575931 | instance | Starting collection install process
2026-05-26 05:50:11.575956 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-05-26 05:50:11.575981 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-05-26 05:50:11.576006 | instance | community.crypto:2.2.3 was installed successfully
2026-05-26 05:50:11.576030 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-05-26 05:50:11.576054 | instance | 2.17.12
2026-05-26 05:50:11.576079 | instance | Checked out community.general to 7.3.0
2026-05-26 05:50:11.576104 | 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-05-26 05:50:11.576128 | instance | Starting galaxy collection install process
2026-05-26 05:50:11.576160 | instance | Process install dependency map
2026-05-26 05:50:11.576185 | instance | Starting collection install process
2026-05-26 05:50:11.576210 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-05-26 05:50:11.576235 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-05-26 05:50:11.576260 | instance | community.general:7.3.0 was installed successfully
2026-05-26 05:50:11.576285 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-05-26 05:50:11.576309 | instance | 2.17.12
2026-05-26 05:50:11.576334 | instance | Checked out community.mysql to 3.6.0
2026-05-26 05:50:11.576359 | 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-05-26 05:50:11.576387 | instance | Starting galaxy collection install process
2026-05-26 05:50:11.576412 | instance | Process install dependency map
2026-05-26 05:50:11.576437 | instance | Starting collection install process
2026-05-26 05:50:11.576462 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-05-26 05:50:11.576487 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-05-26 05:50:11.576511 | instance | community.mysql:3.6.0 was installed successfully
2026-05-26 05:50:11.576535 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-05-26 05:50:11.576559 | instance | 2.17.12
2026-05-26 05:50:11.576583 | instance | Checked out kubernetes.core to 2.4.0
2026-05-26 05:50:11.576608 | 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-05-26 05:50:11.576633 | instance | Starting galaxy collection install process
2026-05-26 05:50:11.576658 | instance | Process install dependency map
2026-05-26 05:50:11.576683 | instance | Starting collection install process
2026-05-26 05:50:11.576708 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-05-26 05:50:11.576733 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-05-26 05:50:11.576758 | instance | kubernetes.core:2.4.0 was installed successfully
2026-05-26 05:50:11.576783 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-05-26 05:50:11.576807 | instance | 2.17.12
2026-05-26 05:50:11.576831 | instance | Checked out openstack.cloud to 2.5.0
2026-05-26 05:50:11.576855 | 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-05-26 05:50:11.576880 | instance | Starting galaxy collection install process
2026-05-26 05:50:11.576905 | instance | Process install dependency map
2026-05-26 05:50:11.576929 | instance | Starting collection install process
2026-05-26 05:50:11.576974 | instance | Installing 'openstack.cloud:2.5.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-05-26 05:50:11.577004 | instance | Created collection for openstack.cloud:2.5.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-05-26 05:50:11.577028 | instance | openstack.cloud:2.5.0 was installed successfully
2026-05-26 05:50:11.577052 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-05-26 05:50:11.577076 | instance | 2.17.12
2026-05-26 05:50:11.577100 | instance | Checked out vexxhost.ceph to v4.0.0
2026-05-26 05:50:11.577130 | 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-05-26 05:50:11.577156 | instance | Starting galaxy collection install process
2026-05-26 05:50:11.577180 | instance | Process install dependency map
2026-05-26 05:50:11.577204 | instance | Starting collection install process
2026-05-26 05:50:11.577229 | instance | Installing 'vexxhost.ceph:4.0.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-05-26 05:50:11.577255 | instance | Created collection for vexxhost.ceph:4.0.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-05-26 05:50:11.577283 | instance | vexxhost.ceph:4.0.0 was installed successfully
2026-05-26 05:50:11.577307 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-05-26 05:50:11.577332 | instance | 2.17.12
2026-05-26 05:50:11.577356 | instance | Checked out vexxhost.containers to v1.6.6
2026-05-26 05:50:11.577380 | 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-05-26 05:50:11.577404 | instance | Starting galaxy collection install process
2026-05-26 05:50:11.577428 | instance | Process install dependency map
2026-05-26 05:50:11.577452 | instance | Starting collection install process
2026-05-26 05:50:11.577477 | instance | Installing 'vexxhost.containers:1.6.6' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-05-26 05:50:11.577501 | instance | Created collection for vexxhost.containers:1.6.6 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-05-26 05:50:11.577526 | instance | vexxhost.containers:1.6.6 was installed successfully
2026-05-26 05:50:11.577550 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-05-26 05:50:11.577574 | instance | 2.17.12
2026-05-26 05:50:11.577599 | instance | Checked out vexxhost.kubernetes to v3.1.0
2026-05-26 05:50:11.577624 | 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-05-26 05:50:11.577648 | instance | Starting galaxy collection install process
2026-05-26 05:50:11.577673 | instance | Process install dependency map
2026-05-26 05:50:11.577697 | instance | Starting collection install process
2026-05-26 05:50:11.577721 | instance | Installing 'vexxhost.kubernetes:3.1.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-05-26 05:50:11.577745 | instance | Created collection for vexxhost.kubernetes:3.1.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-05-26 05:50:11.577770 | instance | vexxhost.kubernetes:3.1.0 was installed successfully
2026-05-26 05:50:11.577817 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-05-26 05:50:11.577850 | instance | 2.17.12
2026-05-26 05:50:11.584824 | 
2026-05-26 05:50:11.584873 | PLAY RECAP
2026-05-26 05:50:11.584922 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-26 05:50:11.584943 | 
2026-05-26 05:50:11.707148 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-05-26 05:50:11.720740 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main]
2026-05-26 05:50:12.337837 | 
2026-05-26 05:50:12.337962 | PLAY [all]
2026-05-26 05:50:12.348822 | 
2026-05-26 05:50:12.348900 | TASK [Install "jq" for log collection]
2026-05-26 05:50:22.413671 | instance | changed
2026-05-26 05:50:22.421050 | 
2026-05-26 05:50:22.421129 | TASK [Install pip3 for Python package management]
2026-05-26 05:50:27.269146 | instance | changed
2026-05-26 05:50:27.275850 | 
2026-05-26 05:50:27.275920 | TASK [Install Python "kubernetes" library for kubernetes.core modules]
2026-05-26 05:50:37.225296 | instance | changed
2026-05-26 05:50:37.231527 | 
2026-05-26 05:50:37.231583 | PLAY [all]
2026-05-26 05:50:37.239840 | 
2026-05-26 05:50:37.239905 | TASK [ensure-go : Check installed go version]
2026-05-26 05:50:37.775687 | instance | ok: ERROR (ignored)
2026-05-26 05:50:37.776050 | instance | {
2026-05-26 05:50:37.776119 | instance |   "failed_when_result": false,
2026-05-26 05:50:37.776167 | instance |   "msg": "[Errno 2] No such file or directory: b'go'",
2026-05-26 05:50:37.776213 | instance |   "rc": 2
2026-05-26 05:50:37.776263 | instance | }
2026-05-26 05:50:37.781659 | 
2026-05-26 05:50:37.781730 | TASK [ensure-go : Skip if correct version of go is installed]
2026-05-26 05:50:37.837700 | instance | ok
2026-05-26 05:50:37.845318 | instance | included: /var/lib/zuul/builds/946e305c1d79426492d7166ee90ac734/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-go/tasks/install-go.yaml
2026-05-26 05:50:37.850010 | 
2026-05-26 05:50:37.850076 | TASK [ensure-go : Create temp directory]
2026-05-26 05:50:38.146368 | instance | changed
2026-05-26 05:50:38.153390 | 
2026-05-26 05:50:38.153482 | TASK [ensure-go : Get archive checksum]
2026-05-26 05:50:38.778800 | instance | ok: OK (64 bytes)
2026-05-26 05:50:38.785303 | 
2026-05-26 05:50:38.785380 | TASK [ensure-go : Download go archive]
2026-05-26 05:50:40.646946 | instance | changed: OK (78559214 bytes)
2026-05-26 05:50:40.653298 | 
2026-05-26 05:50:40.653363 | TASK [ensure-go : Install go]
2026-05-26 05:50:47.595576 | instance | changed
2026-05-26 05:50:47.602424 | 
2026-05-26 05:50:47.602477 | PLAY [all]
2026-05-26 05:50:47.608124 | 
2026-05-26 05:50:47.608183 | TASK [Copy inventory file for Zuul]
2026-05-26 05:50:48.302255 | instance | changed
2026-05-26 05:50:48.308212 | 
2026-05-26 05:50:48.308289 | TASK [Switch "ansible_host" to private IP]
2026-05-26 05:50:48.581884 | instance | changed: 1 replacements made
2026-05-26 05:50:48.591307 | 
2026-05-26 05:50:48.591380 | TASK [Run molecule prepare]
2026-05-26 05:50:49.310833 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-05-26 05:50:49.882296 | instance | INFO     [aio > discovery] scenario test matrix: prepare
2026-05-26 05:50:49.882357 | instance | INFO     [aio > prerun] Performing prerun with role_name_check=0...
2026-05-26 05:51:01.234445 | instance | INFO     [aio > prepare] Executing
2026-05-26 05:51:02.209031 | instance |
2026-05-26 05:51:02.209672 | instance | PLAY [Prepare] *****************************************************************
2026-05-26 05:51:02.209937 | instance |
2026-05-26 05:51:02.210211 | instance | TASK [Gathering Facts] *********************************************************
2026-05-26 05:51:02.210533 | instance | Tuesday 26 May 2026  05:51:02 +0000 (0:00:00.025)       0:00:00.025 ***********
2026-05-26 05:51:03.391200 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-05-26 05:51:03.391454 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-05-26 05:51:03.391746 | instance | interpreter could change the meaning of that path. See
2026-05-26 05:51:03.392031 | instance | https://docs.ansible.com/ansible-
2026-05-26 05:51:03.392389 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-05-26 05:51:03.400382 | instance | ok: [instance]
2026-05-26 05:51:03.400648 | instance |
2026-05-26 05:51:03.400938 | instance | TASK [Configure short hostname] ************************************************
2026-05-26 05:51:03.401239 | instance | Tuesday 26 May 2026  05:51:03 +0000 (0:00:01.192)       0:00:01.217 ***********
2026-05-26 05:51:04.101380 | instance | changed: [instance]
2026-05-26 05:51:04.101629 | instance |
2026-05-26 05:51:04.101916 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-05-26 05:51:04.102178 | instance | Tuesday 26 May 2026  05:51:04 +0000 (0:00:00.700)       0:00:01.917 ***********
2026-05-26 05:51:04.383812 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-05-26 05:51:04.384038 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-05-26 05:51:04.384325 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-05-26 05:51:04.395313 | instance | changed: [instance]
2026-05-26 05:51:04.395390 | instance |
2026-05-26 05:51:04.395403 | instance | TASK [Install "dirmngr" for GPG keyserver operations] **************************
2026-05-26 05:51:04.395414 | instance | Tuesday 26 May 2026  05:51:04 +0000 (0:00:00.293)       0:00:02.211 ***********
2026-05-26 05:51:05.686811 | instance | ok: [instance]
2026-05-26 05:51:05.687091 | instance |
2026-05-26 05:51:05.687272 | instance | TASK [Purge "snapd" package] ***************************************************
2026-05-26 05:51:05.687446 | instance | Tuesday 26 May 2026  05:51:05 +0000 (0:00:01.282)       0:00:03.494 ***********
2026-05-26 05:51:06.425524 | instance | ok: [instance]
2026-05-26 05:51:06.425973 | instance |
2026-05-26 05:51:06.426206 | instance | PLAY [Generate workspace for Atmosphere] ***************************************
2026-05-26 05:51:06.426419 | instance |
2026-05-26 05:51:06.426639 | instance | TASK [Create folders for workspace] ********************************************
2026-05-26 05:51:06.426862 | instance | Tuesday 26 May 2026  05:51:06 +0000 (0:00:00.745)       0:00:04.240 ***********
2026-05-26 05:51:07.413494 | instance | changed: [localhost] => (item=group_vars)
2026-05-26 05:51:07.413560 | instance | changed: [localhost] => (item=group_vars/all)
2026-05-26 05:51:07.413572 | instance | changed: [localhost] => (item=group_vars/controllers)
2026-05-26 05:51:07.413582 | instance | changed: [localhost] => (item=group_vars/cephs)
2026-05-26 05:51:07.413591 | instance | changed: [localhost] => (item=group_vars/computes)
2026-05-26 05:51:07.413603 | instance | changed: [localhost] => (item=host_vars)
2026-05-26 05:51:07.413613 | instance |
2026-05-26 05:51:07.413732 | instance | PLAY [Generate Ceph control plane configuration for workspace] *****************
2026-05-26 05:51:07.414052 | instance |
2026-05-26 05:51:07.414318 | instance | TASK [Ensure the Ceph control plane configuration file exists] *****************
2026-05-26 05:51:07.414585 | instance | Tuesday 26 May 2026  05:51:07 +0000 (0:00:00.988)       0:00:05.228 ***********
2026-05-26 05:51:07.597485 | instance | changed: [localhost]
2026-05-26 05:51:07.597727 | instance |
2026-05-26 05:51:07.598035 | instance | TASK [Load the current Ceph control plane configuration into a variable] *******
2026-05-26 05:51:07.598300 | instance | Tuesday 26 May 2026  05:51:07 +0000 (0:00:00.185)       0:00:05.414 ***********
2026-05-26 05:51:07.624013 | instance | ok: [localhost]
2026-05-26 05:51:07.624260 | instance |
2026-05-26 05:51:07.624533 | instance | TASK [Generate Ceph control plane values for missing variables] ****************
2026-05-26 05:51:07.624797 | instance | Tuesday 26 May 2026  05:51:07 +0000 (0:00:00.026)       0:00:05.440 ***********
2026-05-26 05:51:07.677280 | instance | ok: [localhost] => (item={'key': 'ceph_fsid', 'value': 'bca52dca-8773-5c2a-a324-6d52aafa7b90'})
2026-05-26 05:51:07.677543 | instance | ok: [localhost] => (item={'key': 'ceph_mon_public_network', 'value': '10.96.240.0/24'})
2026-05-26 05:51:07.677794 | instance |
2026-05-26 05:51:07.678095 | instance | TASK [Write new Ceph control plane configuration file to disk] *****************
2026-05-26 05:51:07.678357 | instance | Tuesday 26 May 2026  05:51:07 +0000 (0:00:00.053)       0:00:05.494 ***********
2026-05-26 05:51:08.251905 | instance | changed: [localhost]
2026-05-26 05:51:08.252114 | instance |
2026-05-26 05:51:08.252407 | instance | PLAY [Generate Ceph OSD configuration for workspace] ***************************
2026-05-26 05:51:08.252668 | instance |
2026-05-26 05:51:08.252967 | instance | TASK [Ensure the Ceph OSDs configuration file exists] **************************
2026-05-26 05:51:08.253363 | instance | Tuesday 26 May 2026  05:51:08 +0000 (0:00:00.574)       0:00:06.068 ***********
2026-05-26 05:51:08.452722 | instance | changed: [localhost]
2026-05-26 05:51:08.452793 | instance |
2026-05-26 05:51:08.452805 | instance | TASK [Load the current Ceph OSDs configuration into a variable] ****************
2026-05-26 05:51:08.452816 | instance | Tuesday 26 May 2026  05:51:08 +0000 (0:00:00.199)       0:00:06.268 ***********
2026-05-26 05:51:08.479991 | instance | ok: [localhost]
2026-05-26 05:51:08.480532 | instance |
2026-05-26 05:51:08.480590 | instance | TASK [Generate Ceph OSDs values for missing variables] *************************
2026-05-26 05:51:08.480601 | instance | Tuesday 26 May 2026  05:51:08 +0000 (0:00:00.028)       0:00:06.296 ***********
2026-05-26 05:51:08.513937 | instance | ok: [localhost] => (item={'key': 'ceph_osd_devices', 'value': ['/dev/vdb', '/dev/vdc', '/dev/vdd']})
2026-05-26 05:51:08.514167 | instance |
2026-05-26 05:51:08.514483 | instance | TASK [Write new Ceph OSDs configuration file to disk] **************************
2026-05-26 05:51:08.514751 | instance | Tuesday 26 May 2026  05:51:08 +0000 (0:00:00.033)       0:00:06.330 ***********
2026-05-26 05:51:08.865234 | instance | changed: [localhost]
2026-05-26 05:51:08.865511 | instance |
2026-05-26 05:51:08.865795 | instance | PLAY [Generate Kubernetes configuration for workspace] *************************
2026-05-26 05:51:08.866057 | instance |
2026-05-26 05:51:08.866326 | instance | TASK [Ensure the Kubernetes configuration file exists] *************************
2026-05-26 05:51:08.866616 | instance | Tuesday 26 May 2026  05:51:08 +0000 (0:00:00.351)       0:00:06.682 ***********
2026-05-26 05:51:09.049612 | instance | changed: [localhost]
2026-05-26 05:51:09.049831 | instance |
2026-05-26 05:51:09.050102 | instance | TASK [Load the current Kubernetes configuration into a variable] ***************
2026-05-26 05:51:09.050367 | instance | Tuesday 26 May 2026  05:51:09 +0000 (0:00:00.183)       0:00:06.866 ***********
2026-05-26 05:51:09.075552 | instance | ok: [localhost]
2026-05-26 05:51:09.075785 | instance |
2026-05-26 05:51:09.076057 | instance | TASK [Generate Kubernetes values for missing variables] ************************
2026-05-26 05:51:09.076324 | instance | Tuesday 26 May 2026  05:51:09 +0000 (0:00:00.025)       0:00:06.892 ***********
2026-05-26 05:51:09.119354 | instance | ok: [localhost] => (item={'key': 'kubernetes_hostname', 'value': '10.96.240.10'})
2026-05-26 05:51:09.119626 | instance | ok: [localhost] => (item={'key': 'kubernetes_keepalived_vrid', 'value': 42})
2026-05-26 05:51:09.119913 | instance | ok: [localhost] => (item={'key': 'kubernetes_keepalived_vip', 'value': '10.96.240.10'})
2026-05-26 05:51:09.120155 | instance |
2026-05-26 05:51:09.120421 | instance | TASK [Write new Kubernetes configuration file to disk] *************************
2026-05-26 05:51:09.120689 | instance | Tuesday 26 May 2026  05:51:09 +0000 (0:00:00.043)       0:00:06.936 ***********
2026-05-26 05:51:09.469677 | instance | changed: [localhost]
2026-05-26 05:51:09.469903 | instance |
2026-05-26 05:51:09.470169 | instance | PLAY [Generate Keepalived configuration for workspace] *************************
2026-05-26 05:51:09.470412 | instance |
2026-05-26 05:51:09.470679 | instance | TASK [Ensure the Keeaplived configuration file exists] *************************
2026-05-26 05:51:09.471004 | instance | Tuesday 26 May 2026  05:51:09 +0000 (0:00:00.350)       0:00:07.286 ***********
2026-05-26 05:51:09.647092 | instance | changed: [localhost]
2026-05-26 05:51:09.647379 | instance |
2026-05-26 05:51:09.647578 | instance | TASK [Load the current Keepalived configuration into a variable] ***************
2026-05-26 05:51:09.647840 | instance | Tuesday 26 May 2026  05:51:09 +0000 (0:00:00.177)       0:00:07.464 ***********
2026-05-26 05:51:09.673541 | instance | ok: [localhost]
2026-05-26 05:51:09.673783 | instance |
2026-05-26 05:51:09.674055 | instance | TASK [Generate Keepalived values for missing variables] ************************
2026-05-26 05:51:09.674321 | instance | Tuesday 26 May 2026  05:51:09 +0000 (0:00:00.026)       0:00:07.490 ***********
2026-05-26 05:51:09.713223 | instance | ok: [localhost] => (item={'key': 'keepalived_interface', 'value': 'br-ex'})
2026-05-26 05:51:09.713507 | instance | ok: [localhost] => (item={'key': 'keepalived_vip', 'value': '10.96.250.10'})
2026-05-26 05:51:09.713749 | instance |
2026-05-26 05:51:09.714014 | instance | TASK [Write new Keepalived configuration file to disk] *************************
2026-05-26 05:51:09.714279 | instance | Tuesday 26 May 2026  05:51:09 +0000 (0:00:00.039)       0:00:07.530 ***********
2026-05-26 05:51:10.054827 | instance | changed: [localhost]
2026-05-26 05:51:10.055037 | instance |
2026-05-26 05:51:10.055332 | instance | PLAY [Generate endpoints for workspace] ****************************************
2026-05-26 05:51:10.055577 | instance |
2026-05-26 05:51:10.055837 | instance | TASK [Gathering Facts] *********************************************************
2026-05-26 05:51:10.056094 | instance | Tuesday 26 May 2026  05:51:10 +0000 (0:00:00.342)       0:00:07.872 ***********
2026-05-26 05:51:10.779882 | instance | ok: [localhost]
2026-05-26 05:51:10.780170 | instance |
2026-05-26 05:51:10.780192 | instance | TASK [Ensure the endpoints file exists] ****************************************
2026-05-26 05:51:10.780206 | instance | Tuesday 26 May 2026  05:51:10 +0000 (0:00:00.724)       0:00:08.596 ***********
2026-05-26 05:51:10.962333 | instance | changed: [localhost]
2026-05-26 05:51:10.962887 | instance |
2026-05-26 05:51:10.962948 | instance | TASK [Load the current endpoints into a variable] ******************************
2026-05-26 05:51:10.962957 | instance | Tuesday 26 May 2026  05:51:10 +0000 (0:00:00.182)       0:00:08.779 ***********
2026-05-26 05:51:10.997154 | instance | ok: [localhost]
2026-05-26 05:51:10.997215 | instance |
2026-05-26 05:51:10.997709 | instance | TASK [Generate endpoint skeleton for missing variables] ************************
2026-05-26 05:51:10.997737 | instance | Tuesday 26 May 2026  05:51:10 +0000 (0:00:00.034)       0:00:08.814 ***********
2026-05-26 05:51:11.789403 | instance | ok: [localhost] => (item=keycloak_host)
2026-05-26 05:51:11.789491 | instance | ok: [localhost] => (item=kube_prometheus_stack_grafana_host)
2026-05-26 05:51:11.789625 | instance | ok: [localhost] => (item=kube_prometheus_stack_alertmanager_host)
2026-05-26 05:51:11.789853 | instance | ok: [localhost] => (item=kube_prometheus_stack_prometheus_host)
2026-05-26 05:51:11.790016 | instance | ok: [localhost] => (item=openstack_helm_endpoints_region_name)
2026-05-26 05:51:11.790205 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_api_host)
2026-05-26 05:51:11.790399 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_api_host)
2026-05-26 05:51:11.790584 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_api_host)
2026-05-26 05:51:11.790771 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_api_host)
2026-05-26 05:51:11.790956 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_api_host)
2026-05-26 05:51:11.791139 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_api_host)
2026-05-26 05:51:11.791325 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_api_host)
2026-05-26 05:51:11.791508 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_novnc_host)
2026-05-26 05:51:11.791692 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_api_host)
2026-05-26 05:51:11.791865 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_api_host)
2026-05-26 05:51:11.792073 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_api_host)
2026-05-26 05:51:11.792225 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_api_host)
2026-05-26 05:51:11.792375 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_registry_host)
2026-05-26 05:51:11.792524 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_api_host)
2026-05-26 05:51:11.792673 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_cfn_api_host)
2026-05-26 05:51:11.792834 | instance | ok: [localhost] => (item=openstack_helm_endpoints_horizon_api_host)
2026-05-26 05:51:11.792983 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rgw_host)
2026-05-26 05:51:11.793135 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_api_host)
2026-05-26 05:51:11.793279 | instance |
2026-05-26 05:51:11.793450 | instance | TASK [Write new endpoints file to disk] ****************************************
2026-05-26 05:51:11.793602 | instance | Tuesday 26 May 2026  05:51:11 +0000 (0:00:00.792)       0:00:09.606 ***********
2026-05-26 05:51:12.136825 | instance | changed: [localhost]
2026-05-26 05:51:12.137481 | instance |
2026-05-26 05:51:12.137577 | instance | TASK [Ensure the endpoints file exists] ****************************************
2026-05-26 05:51:12.137710 | instance | Tuesday 26 May 2026  05:51:12 +0000 (0:00:00.347)       0:00:09.953 ***********
2026-05-26 05:51:12.323486 | instance | changed: [localhost]
2026-05-26 05:51:12.323574 | instance |
2026-05-26 05:51:12.324101 | instance | PLAY [Generate Neutron configuration for workspace] ****************************
2026-05-26 05:51:12.324155 | instance |
2026-05-26 05:51:12.324161 | instance | TASK [Ensure the Neutron configuration file exists] ****************************
2026-05-26 05:51:12.324181 | instance | Tuesday 26 May 2026  05:51:12 +0000 (0:00:00.187)       0:00:10.140 ***********
2026-05-26 05:51:12.503607 | instance | changed: [localhost]
2026-05-26 05:51:12.503689 | instance |
2026-05-26 05:51:12.504035 | instance | TASK [Load the current Neutron configuration into a variable] ******************
2026-05-26 05:51:12.504064 | instance | Tuesday 26 May 2026  05:51:12 +0000 (0:00:00.180)       0:00:10.321 ***********
2026-05-26 05:51:12.539717 | instance | ok: [localhost]
2026-05-26 05:51:12.540114 | instance |
2026-05-26 05:51:12.540152 | instance | TASK [Generate Neutron values for missing variables] ***************************
2026-05-26 05:51:12.540161 | instance | Tuesday 26 May 2026  05:51:12 +0000 (0:00:00.035)       0:00:10.357 ***********
2026-05-26 05:51:12.580789 | 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-05-26 05:51:12.580971 | instance |
2026-05-26 05:51:12.581236 | instance | TASK [Write new Neutron configuration file to disk] ****************************
2026-05-26 05:51:12.581480 | instance | Tuesday 26 May 2026  05:51:12 +0000 (0:00:00.041)       0:00:10.398 ***********
2026-05-26 05:51:12.946772 | instance | changed: [localhost]
2026-05-26 05:51:12.947134 | instance |
2026-05-26 05:51:12.947476 | instance | PLAY [Generate Nova configuration for workspace] *******************************
2026-05-26 05:51:12.947789 | instance |
2026-05-26 05:51:12.948124 | instance | TASK [Ensure the Nova configuration file exists] *******************************
2026-05-26 05:51:12.948456 | instance | Tuesday 26 May 2026  05:51:12 +0000 (0:00:00.365)       0:00:10.763 ***********
2026-05-26 05:51:13.138386 | instance | changed: [localhost]
2026-05-26 05:51:13.138734 | instance |
2026-05-26 05:51:13.139073 | instance | TASK [Load the current Nova configuration into a variable] *********************
2026-05-26 05:51:13.139406 | instance | Tuesday 26 May 2026  05:51:13 +0000 (0:00:00.191)       0:00:10.955 ***********
2026-05-26 05:51:13.171680 | instance | ok: [localhost]
2026-05-26 05:51:13.172026 | instance |
2026-05-26 05:51:13.172366 | instance | TASK [Generate Nova values for missing variables] ******************************
2026-05-26 05:51:13.172763 | instance | Tuesday 26 May 2026  05:51:13 +0000 (0:00:00.033)       0:00:10.989 ***********
2026-05-26 05:51:13.214414 | 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-05-26 05:51:13.214765 | instance |
2026-05-26 05:51:13.215105 | instance | TASK [Write new Nova configuration file to disk] *******************************
2026-05-26 05:51:13.215438 | instance | Tuesday 26 May 2026  05:51:13 +0000 (0:00:00.042)       0:00:11.031 ***********
2026-05-26 05:51:13.566303 | instance | changed: [localhost]
2026-05-26 05:51:13.566651 | instance |
2026-05-26 05:51:13.567004 | instance | PLAY [Generate secrets for workspace] ******************************************
2026-05-26 05:51:13.567318 | instance |
2026-05-26 05:51:13.567649 | instance | TASK [Ensure the secrets file exists] ******************************************
2026-05-26 05:51:13.567979 | instance | Tuesday 26 May 2026  05:51:13 +0000 (0:00:00.351)       0:00:11.383 ***********
2026-05-26 05:51:13.741806 | instance | changed: [localhost]
2026-05-26 05:51:13.742173 | instance |
2026-05-26 05:51:13.742525 | instance | TASK [Load the current secrets into a variable] ********************************
2026-05-26 05:51:13.742859 | instance | Tuesday 26 May 2026  05:51:13 +0000 (0:00:00.174)       0:00:11.558 ***********
2026-05-26 05:51:13.774531 | instance | ok: [localhost]
2026-05-26 05:51:13.774877 | instance |
2026-05-26 05:51:13.775219 | instance | TASK [Generate secrets for missing variables] **********************************
2026-05-26 05:51:13.775552 | instance | Tuesday 26 May 2026  05:51:13 +0000 (0:00:00.033)       0:00:11.592 ***********
2026-05-26 05:51:14.201515 | instance | ok: [localhost] => (item=heat_auth_encryption_key)
2026-05-26 05:51:14.201941 | instance | ok: [localhost] => (item=keepalived_password)
2026-05-26 05:51:14.202282 | instance | ok: [localhost] => (item=keycloak_admin_password)
2026-05-26 05:51:14.202624 | instance | ok: [localhost] => (item=keycloak_database_password)
2026-05-26 05:51:14.202955 | instance | ok: [localhost] => (item=keystone_keycloak_client_secret)
2026-05-26 05:51:14.203283 | instance | ok: [localhost] => (item=keystone_oidc_crypto_passphrase)
2026-05-26 05:51:14.203623 | instance | ok: [localhost] => (item=kube_prometheus_stack_grafana_admin_password)
2026-05-26 05:51:14.203977 | instance | ok: [localhost] => (item=octavia_heartbeat_key)
2026-05-26 05:51:14.204311 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rabbitmq_admin_password)
2026-05-26 05:51:14.204636 | instance | ok: [localhost] => (item=openstack_helm_endpoints_memcached_secret_key)
2026-05-26 05:51:14.204971 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_admin_password)
2026-05-26 05:51:14.205360 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_mariadb_password)
2026-05-26 05:51:14.205697 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_rabbitmq_password)
2026-05-26 05:51:14.206037 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_keystone_password)
2026-05-26 05:51:14.206365 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_mariadb_password)
2026-05-26 05:51:14.206690 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_rabbitmq_password)
2026-05-26 05:51:14.207011 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_keystone_password)
2026-05-26 05:51:14.207427 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_mariadb_password)
2026-05-26 05:51:14.207788 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_rabbitmq_password)
2026-05-26 05:51:14.208217 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_keystone_password)
2026-05-26 05:51:14.208561 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_mariadb_password)
2026-05-26 05:51:14.208883 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_keystone_password)
2026-05-26 05:51:14.209281 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_mariadb_password)
2026-05-26 05:51:14.209665 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_keystone_password)
2026-05-26 05:51:14.209992 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_mariadb_password)
2026-05-26 05:51:14.210255 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_rabbitmq_password)
2026-05-26 05:51:14.210456 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_metadata_secret)
2026-05-26 05:51:14.210660 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_keystone_password)
2026-05-26 05:51:14.210861 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_mariadb_password)
2026-05-26 05:51:14.211063 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_rabbitmq_password)
2026-05-26 05:51:14.211269 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_keystone_password)
2026-05-26 05:51:14.211471 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_mariadb_password)
2026-05-26 05:51:14.211672 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_rabbitmq_password)
2026-05-26 05:51:14.211873 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_keystone_password)
2026-05-26 05:51:14.212074 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_mariadb_password)
2026-05-26 05:51:14.212274 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_rabbitmq_password)
2026-05-26 05:51:14.212475 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_keystone_password)
2026-05-26 05:51:14.212675 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_mariadb_password)
2026-05-26 05:51:14.212877 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_rabbitmq_password)
2026-05-26 05:51:14.213098 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_keystone_password)
2026-05-26 05:51:14.213318 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_mariadb_password)
2026-05-26 05:51:14.213524 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_rabbitmq_password)
2026-05-26 05:51:14.213725 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_keystone_password)
2026-05-26 05:51:14.213939 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_trustee_keystone_password)
2026-05-26 05:51:14.214150 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_stack_user_keystone_password)
2026-05-26 05:51:14.214350 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_mariadb_password)
2026-05-26 05:51:14.214551 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_rabbitmq_password)
2026-05-26 05:51:14.214752 | instance | ok: [localhost] => (item=openstack_helm_endpoints_horizon_mariadb_password)
2026-05-26 05:51:14.214952 | instance | ok: [localhost] => (item=openstack_helm_endpoints_tempest_keystone_password)
2026-05-26 05:51:14.215158 | instance | ok: [localhost] => (item=openstack_helm_endpoints_openstack_exporter_keystone_password)
2026-05-26 05:51:14.215359 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rgw_keystone_password)
2026-05-26 05:51:14.215559 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_keystone_password)
2026-05-26 05:51:14.215759 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_mariadb_password)
2026-05-26 05:51:14.215962 | instance | ok: [localhost] => (item=openstack_helm_endpoints_staffeln_mariadb_password)
2026-05-26 05:51:14.216152 | instance |
2026-05-26 05:51:14.216353 | instance | TASK [Generate base64 encoded secrets] *****************************************
2026-05-26 05:51:14.216556 | instance | Tuesday 26 May 2026  05:51:14 +0000 (0:00:00.426)       0:00:12.018 ***********
2026-05-26 05:51:14.265535 | instance | ok: [localhost] => (item=barbican_kek)
2026-05-26 05:51:14.265819 | instance |
2026-05-26 05:51:14.266046 | instance | TASK [Generate temporary files for generating keys for missing variables] ******
2026-05-26 05:51:14.266262 | instance | Tuesday 26 May 2026  05:51:14 +0000 (0:00:00.061)       0:00:12.079 ***********
2026-05-26 05:51:14.696679 | instance | changed: [localhost] => (item=manila_ssh_key)
2026-05-26 05:51:14.696734 | instance | changed: [localhost] => (item=nova_ssh_key)
2026-05-26 05:51:14.696742 | instance |
2026-05-26 05:51:14.696749 | instance | TASK [Generate SSH keys for missing variables] *********************************
2026-05-26 05:51:14.696756 | instance | Tuesday 26 May 2026  05:51:14 +0000 (0:00:00.433)       0:00:12.513 ***********
2026-05-26 05:51:17.483759 | instance | changed: [localhost] => (item=manila_ssh_key)
2026-05-26 05:51:17.484397 | instance | changed: [localhost] => (item=nova_ssh_key)
2026-05-26 05:51:17.484413 | instance |
2026-05-26 05:51:17.484420 | instance | TASK [Set values for SSH keys] *************************************************
2026-05-26 05:51:17.484426 | instance | Tuesday 26 May 2026  05:51:17 +0000 (0:00:02.785)       0:00:15.298 ***********
2026-05-26 05:51:17.543328 | instance | ok: [localhost] => (item=manila_ssh_key)
2026-05-26 05:51:17.543394 | instance | ok: [localhost] => (item=nova_ssh_key)
2026-05-26 05:51:17.543403 | instance |
2026-05-26 05:51:17.543417 | instance | TASK [Delete the temporary files generated for SSH keys] ***********************
2026-05-26 05:51:17.543543 | instance | Tuesday 26 May 2026  05:51:17 +0000 (0:00:00.060)       0:00:15.359 ***********
2026-05-26 05:51:17.902997 | instance | changed: [localhost] => (item=manila_ssh_key)
2026-05-26 05:51:17.904017 | instance | changed: [localhost] => (item=nova_ssh_key)
2026-05-26 05:51:17.904194 | instance |
2026-05-26 05:51:17.904401 | instance | TASK [Write new secrets file to disk] ******************************************
2026-05-26 05:51:17.904576 | instance | Tuesday 26 May 2026  05:51:17 +0000 (0:00:00.360)       0:00:15.719 ***********
2026-05-26 05:51:18.280102 | instance | changed: [localhost]
2026-05-26 05:51:18.280353 | instance |
2026-05-26 05:51:18.280588 | instance | TASK [Encrypt secrets file with Vault password] ********************************
2026-05-26 05:51:18.280845 | instance | Tuesday 26 May 2026  05:51:18 +0000 (0:00:00.376)       0:00:16.096 ***********
2026-05-26 05:51:18.317133 | instance | skipping: [localhost]
2026-05-26 05:51:18.317460 | instance |
2026-05-26 05:51:18.317784 | instance | PLAY [Setup networking] ********************************************************
2026-05-26 05:51:18.318174 | instance |
2026-05-26 05:51:18.318526 | instance | TASK [Gathering Facts] *********************************************************
2026-05-26 05:51:18.318858 | instance | Tuesday 26 May 2026  05:51:18 +0000 (0:00:00.037)       0:00:16.134 ***********
2026-05-26 05:51:19.070385 | instance | ok: [instance]
2026-05-26 05:51:19.070585 | instance |
2026-05-26 05:51:19.070887 | instance | TASK [Create bridge for management network] ************************************
2026-05-26 05:51:19.071177 | instance | Tuesday 26 May 2026  05:51:19 +0000 (0:00:00.752)       0:00:16.886 ***********
2026-05-26 05:51:19.430853 | instance | ok: [instance]
2026-05-26 05:51:19.431120 | instance |
2026-05-26 05:51:19.431416 | instance | TASK [Create fake interface for management bridge] *****************************
2026-05-26 05:51:19.431770 | instance | Tuesday 26 May 2026  05:51:19 +0000 (0:00:00.360)       0:00:17.247 ***********
2026-05-26 05:51:19.640650 | instance | ok: [instance]
2026-05-26 05:51:19.641101 | instance |
2026-05-26 05:51:19.641473 | instance | TASK [Assign dummy interface to management bridge] *****************************
2026-05-26 05:51:19.641761 | instance | Tuesday 26 May 2026  05:51:19 +0000 (0:00:00.209)       0:00:17.457 ***********
2026-05-26 05:51:19.842579 | instance | ok: [instance]
2026-05-26 05:51:19.842778 | instance |
2026-05-26 05:51:19.843044 | instance | TASK [Assign IP address for management bridge] *********************************
2026-05-26 05:51:19.843307 | instance | Tuesday 26 May 2026  05:51:19 +0000 (0:00:00.201)       0:00:17.659 ***********
2026-05-26 05:51:20.045153 | instance | ok: [instance]
2026-05-26 05:51:20.045472 | instance |
2026-05-26 05:51:20.045797 | instance | TASK [Bring up interfaces] *****************************************************
2026-05-26 05:51:20.046092 | instance | Tuesday 26 May 2026  05:51:20 +0000 (0:00:00.202)       0:00:17.861 ***********
2026-05-26 05:51:20.420458 | instance | ok: [instance] => (item=br-mgmt)
2026-05-26 05:51:20.420736 | instance | ok: [instance] => (item=dummy0)
2026-05-26 05:51:20.421027 | instance |
2026-05-26 05:51:20.421314 | instance | PLAY [Create devices for Ceph] *************************************************
2026-05-26 05:51:20.421639 | instance |
2026-05-26 05:51:20.421915 | instance | TASK [Gathering Facts] *********************************************************
2026-05-26 05:51:20.422203 | instance | Tuesday 26 May 2026  05:51:20 +0000 (0:00:00.375)       0:00:18.237 ***********
2026-05-26 05:51:21.158673 | instance | ok: [instance]
2026-05-26 05:51:21.158862 | instance |
2026-05-26 05:51:21.159130 | instance | TASK [Install depedencies] *****************************************************
2026-05-26 05:51:21.159401 | instance | Tuesday 26 May 2026  05:51:21 +0000 (0:00:00.738)       0:00:18.975 ***********
2026-05-26 05:51:41.850123 | instance | changed: [instance]
2026-05-26 05:51:41.850503 | instance |
2026-05-26 05:51:41.850742 | instance | TASK [Start up service] ********************************************************
2026-05-26 05:51:41.851044 | instance | Tuesday 26 May 2026  05:51:41 +0000 (0:00:20.688)       0:00:39.664 ***********
2026-05-26 05:51:42.424164 | instance | ok: [instance]
2026-05-26 05:51:42.424254 | instance |
2026-05-26 05:51:42.424472 | instance | TASK [Generate lvm.conf] *******************************************************
2026-05-26 05:51:42.424926 | instance | Tuesday 26 May 2026  05:51:42 +0000 (0:00:00.576)       0:00:40.241 ***********
2026-05-26 05:51:42.641876 | instance | ok: [instance]
2026-05-26 05:51:42.641963 | instance |
2026-05-26 05:51:42.642078 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-05-26 05:51:42.642286 | instance | Tuesday 26 May 2026  05:51:42 +0000 (0:00:00.217)       0:00:40.459 ***********
2026-05-26 05:51:43.109891 | instance | changed: [instance]
2026-05-26 05:51:43.109972 | instance |
2026-05-26 05:51:43.110099 | instance | TASK [Get list of all loopback devices] ****************************************
2026-05-26 05:51:43.110300 | instance | Tuesday 26 May 2026  05:51:43 +0000 (0:00:00.467)       0:00:40.926 ***********
2026-05-26 05:51:43.338026 | instance | ok: [instance]
2026-05-26 05:51:43.338098 | instance |
2026-05-26 05:51:43.338237 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-05-26 05:51:43.338439 | instance | Tuesday 26 May 2026  05:51:43 +0000 (0:00:00.226)       0:00:41.152 ***********
2026-05-26 05:51:43.360663 | instance | skipping: [instance]
2026-05-26 05:51:43.360867 | instance |
2026-05-26 05:51:43.361025 | instance | TASK [Create devices for Ceph] *************************************************
2026-05-26 05:51:43.361194 | instance | Tuesday 26 May 2026  05:51:43 +0000 (0:00:00.023)       0:00:41.176 ***********
2026-05-26 05:51:43.919337 | instance | changed: [instance] => (item=osd0)
2026-05-26 05:51:43.919391 | instance | changed: [instance] => (item=osd1)
2026-05-26 05:51:43.919396 | instance | changed: [instance] => (item=osd2)
2026-05-26 05:51:43.919401 | instance |
2026-05-26 05:51:43.919406 | instance | TASK [Set permissions on loopback devices] *************************************
2026-05-26 05:51:43.919412 | instance | Tuesday 26 May 2026  05:51:43 +0000 (0:00:00.559)       0:00:41.736 ***********
2026-05-26 05:51:44.463941 | instance | changed: [instance] => (item=osd0)
2026-05-26 05:51:44.463997 | instance | changed: [instance] => (item=osd1)
2026-05-26 05:51:44.464005 | instance | changed: [instance] => (item=osd2)
2026-05-26 05:51:44.464011 | instance |
2026-05-26 05:51:44.464018 | instance | TASK [Start loop devices] ******************************************************
2026-05-26 05:51:44.464025 | instance | Tuesday 26 May 2026  05:51:44 +0000 (0:00:00.544)       0:00:42.280 ***********
2026-05-26 05:51:45.251423 | instance | changed: [instance] => (item=osd0)
2026-05-26 05:51:45.251499 | instance | changed: [instance] => (item=osd1)
2026-05-26 05:51:45.251510 | instance | changed: [instance] => (item=osd2)
2026-05-26 05:51:45.251521 | instance |
2026-05-26 05:51:45.251531 | instance | TASK [Create a volume group for each loop device] ******************************
2026-05-26 05:51:45.251542 | instance | Tuesday 26 May 2026  05:51:45 +0000 (0:00:00.786)       0:00:43.067 ***********
2026-05-26 05:51:48.377360 | instance | changed: [instance] => (item=osd0)
2026-05-26 05:51:48.377443 | instance | changed: [instance] => (item=osd1)
2026-05-26 05:51:48.377451 | instance | changed: [instance] => (item=osd2)
2026-05-26 05:51:48.377458 | instance |
2026-05-26 05:51:48.377465 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-05-26 05:51:48.377473 | instance | Tuesday 26 May 2026  05:51:48 +0000 (0:00:03.126)       0:00:46.193 ***********
2026-05-26 05:51:50.293199 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-05-26 05:51:50.293263 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-05-26 05:51:50.293269 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-05-26 05:51:50.293274 | instance |
2026-05-26 05:51:50.293279 | instance | PLAY [controllers] *************************************************************
2026-05-26 05:51:50.293284 | instance |
2026-05-26 05:51:50.293318 | instance | TASK [Gathering Facts] *********************************************************
2026-05-26 05:51:50.293343 | instance | Tuesday 26 May 2026  05:51:50 +0000 (0:00:01.916)       0:00:48.109 ***********
2026-05-26 05:51:51.191711 | instance | ok: [instance]
2026-05-26 05:51:51.191847 | instance |
2026-05-26 05:51:51.192199 | instance | TASK [Set masquerade rule] *****************************************************
2026-05-26 05:51:51.192278 | instance | Tuesday 26 May 2026  05:51:51 +0000 (0:00:00.898)       0:00:49.008 ***********
2026-05-26 05:51:51.662099 | instance | changed: [instance]
2026-05-26 05:51:51.665435 | instance |
2026-05-26 05:51:51.665520 | instance | PLAY RECAP *********************************************************************
2026-05-26 05:51:51.665531 | instance | instance                   : ok=24   changed=10   unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-05-26 05:51:51.665539 | instance | localhost                  : ok=40   changed=21   unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-05-26 05:51:51.665545 | instance |
2026-05-26 05:51:51.665551 | instance | Tuesday 26 May 2026  05:51:51 +0000 (0:00:00.470)       0:00:49.479 ***********
2026-05-26 05:51:51.665558 | instance | ===============================================================================
2026-05-26 05:51:51.665564 | instance | Install depedencies ---------------------------------------------------- 20.69s
2026-05-26 05:51:51.665570 | instance | Create a volume group for each loop device ------------------------------ 3.13s
2026-05-26 05:51:51.665576 | instance | Generate SSH keys for missing variables --------------------------------- 2.79s
2026-05-26 05:51:51.665582 | instance | Create a logical volume for each loop device ---------------------------- 1.92s
2026-05-26 05:51:51.665588 | instance | Install "dirmngr" for GPG keyserver operations -------------------------- 1.28s
2026-05-26 05:51:51.665594 | instance | Gathering Facts --------------------------------------------------------- 1.19s
2026-05-26 05:51:51.665608 | instance | Create folders for workspace -------------------------------------------- 0.99s
2026-05-26 05:51:51.665614 | instance | Gathering Facts --------------------------------------------------------- 0.90s
2026-05-26 05:51:51.665811 | instance | Generate endpoint skeleton for missing variables ------------------------ 0.79s
2026-05-26 05:51:51.666086 | instance | Start loop devices ------------------------------------------------------ 0.79s
2026-05-26 05:51:51.666359 | instance | Gathering Facts --------------------------------------------------------- 0.75s
2026-05-26 05:51:51.666610 | instance | Purge "snapd" package --------------------------------------------------- 0.75s
2026-05-26 05:51:51.666845 | instance | Gathering Facts --------------------------------------------------------- 0.74s
2026-05-26 05:51:51.667073 | instance | Gathering Facts --------------------------------------------------------- 0.72s
2026-05-26 05:51:51.667293 | instance | Configure short hostname ------------------------------------------------ 0.70s
2026-05-26 05:51:51.667508 | instance | Start up service -------------------------------------------------------- 0.58s
2026-05-26 05:51:51.667725 | instance | Write new Ceph control plane configuration file to disk ----------------- 0.57s
2026-05-26 05:51:51.667943 | instance | Create devices for Ceph ------------------------------------------------- 0.56s
2026-05-26 05:51:51.668186 | instance | Set permissions on loopback devices ------------------------------------- 0.54s
2026-05-26 05:51:51.668406 | instance | Set masquerade rule ----------------------------------------------------- 0.47s
2026-05-26 05:51:51.752882 | instance | INFO     [aio > prepare] Executed: Successful
2026-05-26 05:51:51.753575 | instance | INFO     Molecule executed 1 scenario (1 successful)
2026-05-26 05:51:52.234931 | instance | ok: Runtime: 0:01:03.031909
2026-05-26 05:51:52.240034 | 
2026-05-26 05:51:52.240086 | PLAY RECAP
2026-05-26 05:51:52.240145 | instance | ok: 12 changed: 9 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-05-26 05:51:52.240181 | 
2026-05-26 05:51:52.401341 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main]
2026-05-26 05:51:52.408483 | RUN START: [untrusted : github.com/vexxhost/atmosphere/molecule/aio/converge.yml@main]
2026-05-26 05:51:53.056854 | 
2026-05-26 05:51:53.365345 | PLAY [all]
2026-05-26 05:51:53.383539 | 
2026-05-26 05:51:53.383678 | TASK [Build atmosphere binary]
2026-05-26 05:51:53.777047 | instance | go: downloading github.com/spf13/cobra v1.9.1
2026-05-26 05:51:53.779987 | instance | go: downloading golang.org/x/sync v0.18.0
2026-05-26 05:51:54.097874 | instance | go: downloading github.com/spf13/pflag v1.0.7
2026-05-26 05:52:00.932486 | instance | ok: Runtime: 0:00:06.759420
2026-05-26 05:52:00.942046 | 
2026-05-26 05:52:00.942268 | TASK [Deploy with parallel orchestrator]
2026-05-26 05:52:01.148999 | instance | ==> Running preflight checks
2026-05-26 05:52:01.658981 | instance | [preflight]
2026-05-26 05:52:01.659078 | instance | [preflight] PLAY [Preflight checks] ********************************************************
2026-05-26 05:52:01.659086 | instance | [preflight]
2026-05-26 05:52:01.659097 | instance | [preflight] TASK [Fail if atmosphere_ceph_enabled is set] **********************************
2026-05-26 05:52:01.681455 | instance | [preflight] skipping: [instance]
2026-05-26 05:52:01.681533 | instance | [preflight]
2026-05-26 05:52:01.681545 | instance | [preflight] PLAY RECAP *********************************************************************
2026-05-26 05:52:01.681558 | instance | [preflight] instance                   : ok=0    changed=0    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-05-26 05:52:01.681567 | instance | [preflight]
2026-05-26 05:52:01.793433 | instance | ==> Preflight checks passed
2026-05-26 05:52:01.793596 | instance | ==> Starting parallel deployment
2026-05-26 05:52:01.793891 | instance | ==> [lpfc] Starting deployment
2026-05-26 05:52:01.793905 | instance | ==> [multipathd] Starting deployment
2026-05-26 05:52:01.793935 | instance | ==> [iscsi] Starting deployment
2026-05-26 05:52:01.794092 | instance | ==> [kubernetes] Starting deployment
2026-05-26 05:52:01.794213 | instance | ==> [udev] Starting deployment
2026-05-26 05:52:01.794225 | instance | ==> [ceph] Starting deployment
2026-05-26 05:52:02.307725 | instance | [multipathd/multipathd]
2026-05-26 05:52:02.307811 | instance | [multipathd/multipathd] PLAY [controllers:computes] ****************************************************
2026-05-26 05:52:02.307824 | instance | [multipathd/multipathd]
2026-05-26 05:52:02.307846 | instance | [multipathd/multipathd] TASK [Gathering Facts] *********************************************************
2026-05-26 05:52:02.310155 | instance | [lpfc/lpfc]
2026-05-26 05:52:02.310186 | instance | [lpfc/lpfc] PLAY [controllers:computes] ****************************************************
2026-05-26 05:52:02.310198 | instance | [lpfc/lpfc]
2026-05-26 05:52:02.310207 | instance | [lpfc/lpfc] TASK [Gathering Facts] *********************************************************
2026-05-26 05:52:02.353956 | instance | [udev/udev]
2026-05-26 05:52:02.353994 | instance | [udev/udev] PLAY [controllers:computes] ****************************************************
2026-05-26 05:52:02.354006 | instance | [udev/udev]
2026-05-26 05:52:02.354016 | instance | [udev/udev] TASK [Gathering Facts] *********************************************************
2026-05-26 05:52:02.692999 | instance | [ceph/ceph]
2026-05-26 05:52:02.693077 | instance | [ceph/ceph] PLAY [all] *********************************************************************
2026-05-26 05:52:02.693089 | instance | [ceph/ceph]
2026-05-26 05:52:02.693100 | instance | [ceph/ceph] TASK [Gathering Facts] *********************************************************
2026-05-26 05:52:03.833155 | instance | [lpfc/lpfc] [WARNING]: Platform linux on host instance is using the discovered Python
2026-05-26 05:52:03.833222 | instance | [lpfc/lpfc] interpreter at /usr/bin/python3.10, but future installation of another Python
2026-05-26 05:52:03.833235 | instance | [lpfc/lpfc] interpreter could change the meaning of that path. See
2026-05-26 05:52:03.833253 | instance | [lpfc/lpfc] https://docs.ansible.com/ansible-
2026-05-26 05:52:03.833298 | instance | [lpfc/lpfc] core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-05-26 05:52:03.841248 | instance | [multipathd/multipathd] [WARNING]: Platform linux on host instance is using the discovered Python
2026-05-26 05:52:03.841315 | instance | [multipathd/multipathd] interpreter at /usr/bin/python3.10, but future installation of another Python
2026-05-26 05:52:03.841327 | instance | [multipathd/multipathd] interpreter could change the meaning of that path. See
2026-05-26 05:52:03.841337 | instance | [multipathd/multipathd] https://docs.ansible.com/ansible-
2026-05-26 05:52:03.841346 | instance | [multipathd/multipathd] core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-05-26 05:52:03.844951 | instance | [lpfc/lpfc] ok: [instance]
2026-05-26 05:52:03.844965 | instance | [lpfc/lpfc]
2026-05-26 05:52:03.844974 | instance | [lpfc/lpfc] TASK [vexxhost.atmosphere.lpfc : Detect if the "lpfc" module is loaded] ********
2026-05-26 05:52:03.851376 | instance | [multipathd/multipathd] ok: [instance]
2026-05-26 05:52:03.851399 | instance | [multipathd/multipathd]
2026-05-26 05:52:03.851429 | instance | [multipathd/multipathd] TASK [vexxhost.atmosphere.multipathd : Add backports PPA] **********************
2026-05-26 05:52:03.965603 | instance | [udev/udev] [WARNING]: Platform linux on host instance is using the discovered Python
2026-05-26 05:52:03.965662 | instance | [udev/udev] interpreter at /usr/bin/python3.10, but future installation of another Python
2026-05-26 05:52:03.965671 | instance | [udev/udev] interpreter could change the meaning of that path. See
2026-05-26 05:52:03.965677 | instance | [udev/udev] https://docs.ansible.com/ansible-
2026-05-26 05:52:03.965684 | instance | [udev/udev] core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-05-26 05:52:03.975392 | instance | [udev/udev] ok: [instance]
2026-05-26 05:52:03.975426 | instance | [udev/udev]
2026-05-26 05:52:03.975437 | instance | [udev/udev] TASK [vexxhost.atmosphere.udev : Add udev rules for Pure Storage FlashArray] ***
2026-05-26 05:52:04.052283 | instance | [ceph/ceph] [WARNING]: Platform linux on host instance is using the discovered Python
2026-05-26 05:52:04.052312 | instance | [ceph/ceph] interpreter at /usr/bin/python3.10, but future installation of another Python
2026-05-26 05:52:04.052319 | instance | [ceph/ceph] interpreter could change the meaning of that path. See
2026-05-26 05:52:04.052326 | instance | [ceph/ceph] https://docs.ansible.com/ansible-
2026-05-26 05:52:04.052332 | instance | [ceph/ceph] core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-05-26 05:52:04.062131 | instance | [ceph/ceph] ok: [instance]
2026-05-26 05:52:04.062166 | instance | [ceph/ceph]
2026-05-26 05:52:04.062177 | instance | [ceph/ceph] TASK [Fail if atmosphere_ceph_enabled is set] **********************************
2026-05-26 05:52:04.103217 | instance | [ceph/ceph] skipping: [instance]
2026-05-26 05:52:04.103275 | instance | [ceph/ceph]
2026-05-26 05:52:04.103288 | instance | [ceph/ceph] TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-05-26 05:52:04.281412 | instance | [ceph/ceph] ok: [instance]
2026-05-26 05:52:04.281458 | instance | [ceph/ceph]
2026-05-26 05:52:04.281464 | instance | [ceph/ceph] PLAY [Deploy Ceph monitors & managers] *****************************************
2026-05-26 05:52:04.281469 | instance | [ceph/ceph]
2026-05-26 05:52:04.281474 | instance | [ceph/ceph] TASK [Gathering Facts] *********************************************************
2026-05-26 05:52:04.285385 | instance | [lpfc/lpfc] ok: [instance]
2026-05-26 05:52:04.285399 | instance | [lpfc/lpfc]
2026-05-26 05:52:04.285404 | instance | [lpfc/lpfc] TASK [vexxhost.atmosphere.lpfc : Install the configuration file] ***************
2026-05-26 05:52:04.309778 | instance | [lpfc/lpfc] skipping: [instance]
2026-05-26 05:52:04.309811 | instance | [lpfc/lpfc]
2026-05-26 05:52:04.309838 | instance | [lpfc/lpfc] TASK [vexxhost.atmosphere.lpfc : Get the values for the module parameters] *****
2026-05-26 05:52:04.347251 | instance | [lpfc/lpfc] skipping: [instance] => (item=lpfc_lun_queue_depth)
2026-05-26 05:52:04.347287 | instance | [lpfc/lpfc] skipping: [instance] => (item=lpfc_sg_seg_cnt)
2026-05-26 05:52:04.347314 | instance | [lpfc/lpfc] skipping: [instance] => (item=lpfc_max_luns)
2026-05-26 05:52:04.347324 | instance | [lpfc/lpfc] skipping: [instance] => (item=lpfc_enable_fc4_type)
2026-05-26 05:52:04.347333 | instance | [lpfc/lpfc] skipping: [instance]
2026-05-26 05:52:04.347342 | instance | [lpfc/lpfc]
2026-05-26 05:52:04.347352 | instance | [lpfc/lpfc] TASK [vexxhost.atmosphere.lpfc : Detect if the run-time module parameters are set correctly] ***
2026-05-26 05:52:04.389488 | instance | [lpfc/lpfc] skipping: [instance] => (item=lpfc_lun_queue_depth)
2026-05-26 05:52:04.389538 | instance | [lpfc/lpfc] skipping: [instance] => (item=lpfc_sg_seg_cnt)
2026-05-26 05:52:04.389550 | instance | [lpfc/lpfc] skipping: [instance] => (item=lpfc_max_luns)
2026-05-26 05:52:04.389559 | instance | [lpfc/lpfc] skipping: [instance] => (item=lpfc_enable_fc4_type)
2026-05-26 05:52:04.389568 | instance | [lpfc/lpfc] skipping: [instance]
2026-05-26 05:52:04.389577 | instance | [lpfc/lpfc]
2026-05-26 05:52:04.389586 | instance | [lpfc/lpfc] TASK [vexxhost.atmosphere.lpfc : Update "initramfs" if the configuration file has changed] ***
2026-05-26 05:52:04.416899 | instance | [lpfc/lpfc] skipping: [instance]
2026-05-26 05:52:04.416918 | instance | [lpfc/lpfc]
2026-05-26 05:52:04.416923 | instance | [lpfc/lpfc] TASK [Reboot the system if the configuration file has changed] *****************
2026-05-26 05:52:04.447974 | instance | [lpfc/lpfc] skipping: [instance]
2026-05-26 05:52:04.447997 | instance | [lpfc/lpfc]
2026-05-26 05:52:04.448004 | instance | [lpfc/lpfc] PLAY RECAP *********************************************************************
2026-05-26 05:52:04.448012 | instance | [lpfc/lpfc] instance                   : ok=2    changed=0    unreachable=0    failed=0    skipped=5    rescued=0    ignored=0
2026-05-26 05:52:04.448018 | instance | [lpfc/lpfc]
2026-05-26 05:52:04.582717 | instance | ==> [lpfc] Deployment complete
2026-05-26 05:52:04.766887 | instance | [udev/udev] changed: [instance]
2026-05-26 05:52:04.766959 | instance | [udev/udev]
2026-05-26 05:52:04.766965 | instance | [udev/udev] TASK [vexxhost.atmosphere.udev : Add udev rules for SCSI Unit Attention] *******
2026-05-26 05:52:05.342606 | instance | [udev/udev] changed: [instance]
2026-05-26 05:52:05.342687 | instance | [udev/udev]
2026-05-26 05:52:05.342696 | instance | [udev/udev] RUNNING HANDLER [vexxhost.atmosphere.udev : Reload udev] ***********************
2026-05-26 05:52:05.350217 | instance | [ceph/ceph] ok: [instance]
2026-05-26 05:52:05.350271 | instance | [ceph/ceph]
2026-05-26 05:52:05.350278 | instance | [ceph/ceph] TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-05-26 05:52:05.752451 | instance | [udev/udev] ok: [instance]
2026-05-26 05:52:05.752524 | instance | [udev/udev]
2026-05-26 05:52:05.752536 | instance | [udev/udev] PLAY RECAP *********************************************************************
2026-05-26 05:52:05.752548 | instance | [udev/udev] instance                   : ok=4    changed=2    unreachable=0    failed=0    skipped=0    rescued=0    ignored=0
2026-05-26 05:52:05.752558 | instance | [udev/udev]
2026-05-26 05:52:05.832265 | instance | [ceph/ceph] ok: [instance]
2026-05-26 05:52:05.832356 | instance | [ceph/ceph]
2026-05-26 05:52:05.832368 | instance | [ceph/ceph] TASK [vexxhost.containers.package : Update state for tar] **********************
2026-05-26 05:52:05.841351 | instance | ==> [udev] Deployment complete
2026-05-26 05:52:05.875447 | instance | [ceph/ceph] skipping: [instance]
2026-05-26 05:52:05.875499 | instance | [ceph/ceph]
2026-05-26 05:52:05.875510 | instance | [ceph/ceph] TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-05-26 05:52:06.353818 | instance | [ceph/ceph] changed: [instance]
2026-05-26 05:52:06.353901 | instance | [ceph/ceph]
2026-05-26 05:52:06.353913 | instance | [ceph/ceph] TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-05-26 05:52:06.429910 | instance | [ceph/ceph] ok: [instance] => {
2026-05-26 05:52:06.430041 | instance | [ceph/ceph]     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-05-26 05:52:06.430060 | instance | [ceph/ceph] }
2026-05-26 05:52:06.430074 | instance | [ceph/ceph]
2026-05-26 05:52:06.430088 | instance | [ceph/ceph] TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-05-26 05:52:07.239060 | instance | [ceph/ceph] changed: [instance]
2026-05-26 05:52:07.239138 | instance | [ceph/ceph]
2026-05-26 05:52:07.239151 | instance | [ceph/ceph] TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-05-26 05:52:07.292654 | instance | [ceph/ceph] skipping: [instance]
2026-05-26 05:52:07.292699 | instance | [ceph/ceph]
2026-05-26 05:52:07.292706 | instance | [ceph/ceph] TASK [vexxhost.containers.package : Update state for tar] **********************
2026-05-26 05:52:07.344407 | instance | [ceph/ceph] skipping: [instance]
2026-05-26 05:52:07.344462 | instance | [ceph/ceph]
2026-05-26 05:52:07.344474 | instance | [ceph/ceph] TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-05-26 05:52:07.669030 | instance | [ceph/ceph] ok: [instance]
2026-05-26 05:52:07.669088 | instance | [ceph/ceph]
2026-05-26 05:52:07.669100 | instance | [ceph/ceph] TASK [vexxhost.containers.package : Update state for tar] **********************
2026-05-26 05:52:09.108856 | instance | [ceph/ceph] ok: [instance]
2026-05-26 05:52:09.108951 | instance | [ceph/ceph]
2026-05-26 05:52:09.108977 | instance | [ceph/ceph] TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-05-26 05:52:09.178845 | instance | [ceph/ceph] ok: [instance] => {
2026-05-26 05:52:09.178884 | instance | [ceph/ceph]     "msg": "https://github.com/containerd/containerd/releases/download/v2.2.3/containerd-2.2.3-linux-amd64.tar.gz"
2026-05-26 05:52:09.178889 | instance | [ceph/ceph] }
2026-05-26 05:52:09.178913 | instance | [ceph/ceph]
2026-05-26 05:52:09.178917 | instance | [ceph/ceph] TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-05-26 05:52:10.063300 | instance | [ceph/ceph] changed: [instance]
2026-05-26 05:52:10.063384 | instance | [ceph/ceph]
2026-05-26 05:52:10.063398 | instance | [ceph/ceph] TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-05-26 05:52:13.182808 | instance | [ceph/ceph] changed: [instance]
2026-05-26 05:52:13.182885 | instance | [ceph/ceph]
2026-05-26 05:52:13.182897 | instance | [ceph/ceph] TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-05-26 05:52:13.219037 | instance | [ceph/ceph] skipping: [instance]
2026-05-26 05:52:13.219070 | instance | [ceph/ceph]
2026-05-26 05:52:13.219080 | instance | [ceph/ceph] TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-05-26 05:52:13.255467 | instance | [ceph/ceph] skipping: [instance]
2026-05-26 05:52:13.255503 | instance | [ceph/ceph]
2026-05-26 05:52:13.255516 | instance | [ceph/ceph] TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-05-26 05:52:13.293103 | instance | [ceph/ceph] skipping: [instance]
2026-05-26 05:52:13.293144 | instance | [ceph/ceph]
2026-05-26 05:52:13.293158 | instance | [ceph/ceph] TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-05-26 05:52:13.550370 | instance | [multipathd/multipathd] changed: [instance]
2026-05-26 05:52:13.550443 | instance | [multipathd/multipathd]
2026-05-26 05:52:13.550453 | instance | [multipathd/multipathd] TASK [vexxhost.atmosphere.multipathd : Install the multipathd package] *********
2026-05-26 05:52:16.206081 | instance | [multipathd/multipathd] fatal: [instance]: FAILED! => {"cache_update_time": 1779774733, "cache_updated": false, "changed": false, "msg": "'/usr/bin/apt-get -y -o \"Dpkg::Options::=--force-confdef\" -o \"Dpkg::Options::=--force-confold\"       install 'multipath-tools=0.9.4-5ubuntu8~bpo22.04.1~ppa1'' failed: E: Could not get lock /var/lib/dpkg/lock-frontend. It is held by process 12252 (apt-get)\nE: Unable to acquire the dpkg frontend lock (/var/lib/dpkg/lock-frontend), is another process using it?\n", "rc": 100, "stderr": "E: Could not get lock /var/lib/dpkg/lock-frontend. It is held by process 12252 (apt-get)\nE: Unable to acquire the dpkg frontend lock (/var/lib/dpkg/lock-frontend), is another process using it?\n", "stderr_lines": ["E: Could not get lock /var/lib/dpkg/lock-frontend. It is held by process 12252 (apt-get)", "E: Unable to acquire the dpkg frontend lock (/var/lib/dpkg/lock-frontend), is another process using it?"], "stdout": "", "stdout_lines": []}
2026-05-26 05:52:16.206166 | instance | [multipathd/multipathd]
2026-05-26 05:52:16.206179 | instance | [multipathd/multipathd] PLAY RECAP *********************************************************************
2026-05-26 05:52:16.206190 | instance | [multipathd/multipathd] instance                   : ok=2    changed=1    unreachable=0    failed=1    skipped=0    rescued=0    ignored=0
2026-05-26 05:52:16.206200 | instance | [multipathd/multipathd]
2026-05-26 05:52:16.302412 | instance | Error: component multipathd failed: ansible-playbook failed for multipathd/multipathd: exit status 2
2026-05-26 05:52:16.302504 | instance | Usage:
2026-05-26 05:52:16.302521 | instance |   atmosphere deploy [flags]
2026-05-26 05:52:16.302535 | instance |
2026-05-26 05:52:16.302546 | instance | Flags:
2026-05-26 05:52:16.302559 | instance |       --concurrency int    Max concurrent deployments per wave (0 = unlimited)
2026-05-26 05:52:16.302572 | instance |   -h, --help               help for deploy
2026-05-26 05:52:16.302584 | instance |   -i, --inventory string   Path to Ansible inventory file (required)
2026-05-26 05:52:16.302607 | instance |   -t, --tags string        Comma-separated list of component tags to deploy
2026-05-26 05:52:16.302615 | instance |
2026-05-26 05:52:16.302624 | instance | component multipathd failed: ansible-playbook failed for multipathd/multipathd: exit status 2
2026-05-26 05:52:16.506608 | instance | ERROR
2026-05-26 05:52:16.507015 | instance | {
2026-05-26 05:52:16.507075 | instance |   "delta": "0:00:15.168357",
2026-05-26 05:52:16.507108 | instance |   "end": "2026-05-26 05:52:16.304419",
2026-05-26 05:52:16.507135 | instance |   "msg": "non-zero return code",
2026-05-26 05:52:16.507161 | instance |   "rc": 1,
2026-05-26 05:52:16.507187 | instance |   "start": "2026-05-26 05:52:01.136062"
2026-05-26 05:52:16.507215 | instance | }
failure
2026-05-26 05:52:16.511566 | 
2026-05-26 05:52:16.511616 | PLAY RECAP
2026-05-26 05:52:16.511662 | instance | ok: 1 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-05-26 05:52:16.511684 | 
2026-05-26 05:52:16.678642 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/molecule/aio/converge.yml@main]
2026-05-26 05:52:16.688675 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main]
2026-05-26 05:52:17.329367 | 
2026-05-26 05:52:17.329487 | PLAY [all]
2026-05-26 05:52:17.343886 | 
2026-05-26 05:52:17.343967 | TASK [gather-host-logs : creating directory for system status]
2026-05-26 05:52:17.691663 | instance | changed
2026-05-26 05:52:17.697135 | 
2026-05-26 05:52:17.697215 | TASK [gather-host-logs : Get logs for each host]
2026-05-26 05:52:18.047975 | instance | + systemd-cgls --full --all --no-pager
2026-05-26 05:52:18.061879 | instance | + ip addr
2026-05-26 05:52:18.063898 | instance | + ip route
2026-05-26 05:52:18.065536 | instance | + lsblk
2026-05-26 05:52:18.068481 | instance | + mount
2026-05-26 05:52:18.069994 | instance | + docker images
2026-05-26 05:52:18.070494 | instance | /bin/bash: line 7: docker: command not found
2026-05-26 05:52:18.070705 | instance | + brctl show
2026-05-26 05:52:18.071048 | instance | /bin/bash: line 8: brctl: command not found
2026-05-26 05:52:18.071236 | instance | + ps aux --sort=-%mem
2026-05-26 05:52:18.083793 | instance | + dpkg -l
2026-05-26 05:52:18.096637 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-05-26 05:52:18.097276 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-05-26 05:52:18.097394 | instance | /bin/bash: line 11: docker: command not found
2026-05-26 05:52:18.097805 | instance | + '[' '!' -z '' ']'
2026-05-26 05:52:18.233620 | instance | ok: Runtime: 0:00:00.056077
2026-05-26 05:52:18.241276 | 
2026-05-26 05:52:18.241347 | TASK [gather-host-logs : Downloads logs to executor]
2026-05-26 05:52:18.876216 | instance | changed:
2026-05-26 05:52:18.876520 | instance | created directory /var/lib/zuul/builds/946e305c1d79426492d7166ee90ac734/work/logs/instance
2026-05-26 05:52:18.876585 | instance | cd+++++++++ system/
2026-05-26 05:52:18.876634 | instance | >f+++++++++ system/brctl-show.txt
2026-05-26 05:52:18.876681 | instance | >f+++++++++ system/docker-images.txt
2026-05-26 05:52:18.876723 | instance | >f+++++++++ system/ip-addr.txt
2026-05-26 05:52:18.876769 | instance | >f+++++++++ system/ip-route.txt
2026-05-26 05:52:18.876819 | instance | >f+++++++++ system/lsblk.txt
2026-05-26 05:52:18.876862 | instance | >f+++++++++ system/mount.txt
2026-05-26 05:52:18.876908 | instance | >f+++++++++ system/packages.txt
2026-05-26 05:52:18.876949 | instance | >f+++++++++ system/ps.txt
2026-05-26 05:52:18.877058 | instance | >f+++++++++ system/systemd-cgls.txt
2026-05-26 05:52:18.887738 | 
2026-05-26 05:52:18.887810 | LOOP [helm-release-status : creating directory for helm release status]
2026-05-26 05:52:19.088812 | instance | changed: "values"
2026-05-26 05:52:19.266942 | instance | changed: "releases"
2026-05-26 05:52:19.286588 | 
2026-05-26 05:52:19.286786 | TASK [helm-release-status : Gather get release status for helm charts]
2026-05-26 05:52:19.581601 | instance | /bin/bash: line 3: kubectl: command not found
2026-05-26 05:52:19.876037 | instance | ok: Runtime: 0:00:00.006373
2026-05-26 05:52:19.881046 | 
2026-05-26 05:52:19.881110 | TASK [helm-release-status : Downloads logs to executor]
2026-05-26 05:52:20.374816 | instance | changed:
2026-05-26 05:52:20.375045 | instance | cd+++++++++ helm/
2026-05-26 05:52:20.375084 | instance | cd+++++++++ helm/releases/
2026-05-26 05:52:20.375116 | instance | cd+++++++++ helm/values/
2026-05-26 05:52:20.386186 | 
2026-05-26 05:52:20.386297 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-05-26 05:52:20.584702 | instance | changed
2026-05-26 05:52:20.591870 | 
2026-05-26 05:52:20.591959 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-05-26 05:52:20.801993 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-05-26 05:52:20.802845 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-05-26 05:52:20.809148 | instance | environment: line 1: kubectl: command not found
2026-05-26 05:52:20.810753 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-05-26 05:52:20.811677 | instance | environment: line 1: kubectl: command not found
2026-05-26 05:52:20.813451 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-05-26 05:52:20.814715 | instance | environment: line 1: kubectl: command not found
2026-05-26 05:52:20.816394 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-05-26 05:52:20.816814 | instance | environment: line 1: kubectl: command not found
2026-05-26 05:52:20.817886 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-05-26 05:52:20.819363 | instance | environment: line 1: kubectl: command not found
2026-05-26 05:52:20.820705 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-05-26 05:52:21.138209 | instance | ok: Runtime: 0:00:00.027449
2026-05-26 05:52:21.143742 | 
2026-05-26 05:52:21.143807 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-05-26 05:52:21.348751 | instance | changed
2026-05-26 05:52:21.357092 | 
2026-05-26 05:52:21.357175 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-05-26 05:52:21.565733 | instance | environment: line 5: kubectl: command not found
2026-05-26 05:52:21.566437 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-05-26 05:52:21.566506 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-05-26 05:52:21.566947 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-05-26 05:52:21.903346 | instance | ok: Runtime: 0:00:00.009537
2026-05-26 05:52:21.912300 | 
2026-05-26 05:52:21.912408 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-05-26 05:52:22.400947 | instance | changed:
2026-05-26 05:52:22.401215 | instance | cd+++++++++ objects/
2026-05-26 05:52:22.401279 | instance | cd+++++++++ objects/cluster/
2026-05-26 05:52:22.401310 | instance | cd+++++++++ objects/namespaced/
2026-05-26 05:52:22.411583 | 
2026-05-26 05:52:22.411649 | TASK [gather-pod-logs : creating directory for pod logs]
2026-05-26 05:52:22.607864 | instance | changed
2026-05-26 05:52:22.614975 | 
2026-05-26 05:52:22.615065 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-05-26 05:52:22.825455 | instance | changed
2026-05-26 05:52:22.831180 | 
2026-05-26 05:52:22.831272 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-05-26 05:52:23.069772 | instance | environment: line 3: kubectl: command not found
2026-05-26 05:52:23.373539 | instance | ok: Runtime: 0:00:00.009606
2026-05-26 05:52:23.381155 | 
2026-05-26 05:52:23.381245 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-05-26 05:52:23.862421 | instance | changed:
2026-05-26 05:52:23.862702 | instance | cd+++++++++ pod-logs/
2026-05-26 05:52:23.862754 | instance | cd+++++++++ pod-logs/failed-pods/
2026-05-26 05:52:23.874753 | 
2026-05-26 05:52:23.874816 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-05-26 05:52:24.081960 | instance | changed
2026-05-26 05:52:24.088702 | 
2026-05-26 05:52:24.088789 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-05-26 05:52:24.302265 | instance | /bin/bash: line 2: kubectl: command not found
2026-05-26 05:52:25.243499 | instance | ok: Runtime: 0:00:00.036117
2026-05-26 05:52:25.251757 | 
2026-05-26 05:52:25.251821 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-05-26 05:52:25.453850 | instance | /bin/bash: line 2: kubectl: command not found
2026-05-26 05:52:25.480570 | instance | ceph-mgr endpoints:
2026-05-26 05:52:25.785205 | instance | ok: Runtime: 0:00:00.033232
2026-05-26 05:52:25.792398 | 
2026-05-26 05:52:25.792488 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-05-26 05:52:26.039539 | instance | /bin/bash: line 4: kubectl: command not found
2026-05-26 05:52:26.327296 | instance | ok: Runtime: 0:00:00.035306
2026-05-26 05:52:26.333421 | 
2026-05-26 05:52:26.333484 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-05-26 05:52:26.804102 | instance | changed: cd+++++++++ prometheus/
2026-05-26 05:52:26.814343 | 
2026-05-26 05:52:26.814404 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-05-26 05:52:27.016006 | instance | changed
2026-05-26 05:52:27.020944 | 
2026-05-26 05:52:27.021032 | TASK [gather-selenium-data : Get selenium data]
2026-05-26 05:52:27.243865 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-05-26 05:52:27.245005 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-05-26 05:52:27.556486 | instance | ERROR
2026-05-26 05:52:27.556661 | instance | {
2026-05-26 05:52:27.556707 | instance |   "delta": "0:00:00.007492",
2026-05-26 05:52:27.556739 | instance |   "end": "2026-05-26 05:52:27.245338",
2026-05-26 05:52:27.556766 | instance |   "msg": "non-zero return code",
2026-05-26 05:52:27.556792 | instance |   "rc": 1,
2026-05-26 05:52:27.556818 | instance |   "start": "2026-05-26 05:52:27.237846"
2026-05-26 05:52:27.556843 | instance | }
2026-05-26 05:52:27.556875 | instance | ERROR: Ignoring Errors
2026-05-26 05:52:27.563820 | 
2026-05-26 05:52:27.563906 | TASK [gather-selenium-data : Downloads logs to executor]
2026-05-26 05:52:28.071413 | instance | changed: cd+++++++++ selenium/
2026-05-26 05:52:28.079650 | 
2026-05-26 05:52:28.079706 | PLAY RECAP
2026-05-26 05:52:28.079751 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-05-26 05:52:28.079773 | 
2026-05-26 05:52:28.214600 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main]
2026-05-26 05:52:28.226537 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-05-26 05:52:28.889440 | 
2026-05-26 05:52:28.889574 | PLAY [all]
2026-05-26 05:52:28.901304 | 
2026-05-26 05:52:28.901387 | TASK [fetch-output : Set log path for multiple nodes]
2026-05-26 05:52:28.946792 | instance | skipping: Conditional result was False
2026-05-26 05:52:28.956319 | 
2026-05-26 05:52:28.956425 | TASK [fetch-output : Set log path for single node]
2026-05-26 05:52:28.998654 | instance | ok
2026-05-26 05:52:29.005082 | 
2026-05-26 05:52:29.005174 | LOOP [fetch-output : Ensure local output dirs]
2026-05-26 05:52:29.459018 | instance -> localhost | ok: "/var/lib/zuul/builds/946e305c1d79426492d7166ee90ac734/work/logs"
2026-05-26 05:52:29.708278 | instance -> localhost | changed: "/var/lib/zuul/builds/946e305c1d79426492d7166ee90ac734/work/artifacts"
2026-05-26 05:52:29.930184 | instance -> localhost | changed: "/var/lib/zuul/builds/946e305c1d79426492d7166ee90ac734/work/docs"
2026-05-26 05:52:29.949701 | 
2026-05-26 05:52:29.949855 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-05-26 05:52:30.596143 | instance | changed: .d..t...... ./
2026-05-26 05:52:30.596451 | instance | changed: All items complete
2026-05-26 05:52:30.596491 | 
2026-05-26 05:52:31.056335 | instance | changed: .d..t...... ./
2026-05-26 05:52:31.544223 | instance | changed: .d..t...... ./
2026-05-26 05:52:31.569463 | 
2026-05-26 05:52:31.569605 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-05-26 05:52:31.996841 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007020
2026-05-26 05:52:32.217544 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.008826
2026-05-26 05:52:32.242365 | 
2026-05-26 05:52:32.242522 | PLAY [all]
2026-05-26 05:52:32.250267 | 
2026-05-26 05:52:32.250340 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-05-26 05:52:32.680161 | instance | changed
2026-05-26 05:52:32.685645 | 
2026-05-26 05:52:32.685693 | PLAY RECAP
2026-05-26 05:52:32.685743 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-05-26 05:52:32.685778 | 
2026-05-26 05:52:32.812730 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-05-26 05:52:32.826306 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-05-26 05:52:33.488501 | 
2026-05-26 05:52:33.488645 | PLAY [localhost]
2026-05-26 05:52:33.498628 | 
2026-05-26 05:52:33.498704 | TASK [Generate Zuul manifest]
2026-05-26 05:52:33.517709 | localhost | ok
2026-05-26 05:52:33.534050 | 
2026-05-26 05:52:33.534449 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-05-26 05:52:33.909488 | localhost | changed
2026-05-26 05:52:33.920414 | 
2026-05-26 05:52:33.920575 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-05-26 05:52:33.963439 | localhost | ok
2026-05-26 05:52:33.973472 | 
2026-05-26 05:52:33.973578 | TASK [Upload logs]
2026-05-26 05:52:33.996307 | localhost | ok
2026-05-26 05:52:34.113548 | 
2026-05-26 05:52:34.113715 | TASK [Set zuul-log-path fact]
2026-05-26 05:52:34.137505 | localhost | ok
2026-05-26 05:52:34.153350 | 
2026-05-26 05:52:34.153419 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-05-26 05:52:34.186047 | localhost | ok
2026-05-26 05:52:34.195098 | 
2026-05-26 05:52:34.195165 | TASK [upload-logs : Create log directories]
2026-05-26 05:52:34.565560 | localhost | changed
2026-05-26 05:52:34.572411 | 
2026-05-26 05:52:34.572518 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-05-26 05:52:34.931033 | localhost -> localhost | ok: Runtime: 0:00:00.004303
2026-05-26 05:52:34.937934 | 
2026-05-26 05:52:34.938139 | TASK [upload-logs : Upload logs to log server]
2026-05-26 05:52:35.351136 | localhost | Output suppressed because no_log was given
2026-05-26 05:52:35.355702 | 
2026-05-26 05:52:35.355769 | LOOP [upload-logs : Compress console log and json output]
2026-05-26 05:52:35.405557 | localhost | skipping: Conditional result was False
2026-05-26 05:52:35.411072 | localhost | skipping: Conditional result was False
2026-05-26 05:52:35.422390 | 
2026-05-26 05:52:35.422676 | LOOP [upload-logs : Upload compressed console log and json output]
2026-05-26 05:52:35.469405 | localhost | skipping: Conditional result was False
2026-05-26 05:52:35.469848 | 
2026-05-26 05:52:35.473185 | localhost | skipping: Conditional result was False
2026-05-26 05:52:35.485275 | 
2026-05-26 05:52:35.485450 | LOOP [upload-logs : Upload console log and json output]