2026-09-10 10:57:19.574005 | Job console starting 2026-09-10 10:57:19.584079 | Updating git repos 2026-09-10 10:57:24.120742 | Cloning repos into workspace 2026-09-10 10:57:42.316552 | Restoring repo states 2026-09-10 10:57:53.711653 | Merging changes 2026-09-10 10:57:54.473367 | Checking out repos 2026-09-10 10:57:57.184627 | Preparing playbooks 2026-09-10 10:58:11.795948 | Running Ansible setup 2026-09-10 10:58:15.982257 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-09-10 10:58:16.689292 | 2026-09-10 10:58:16.689428 | PLAY [localhost] 2026-09-10 10:58:16.698546 | 2026-09-10 10:58:16.698655 | TASK [Gathering Facts] 2026-09-10 10:58:17.940153 | localhost | ok 2026-09-10 10:58:17.955866 | 2026-09-10 10:58:17.956078 | TASK [Setup log path fact] 2026-09-10 10:58:17.987239 | localhost | ok 2026-09-10 10:58:18.007414 | 2026-09-10 10:58:18.007563 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-10 10:58:18.046921 | localhost | ok 2026-09-10 10:58:18.057256 | 2026-09-10 10:58:18.057386 | TASK [emit-job-header : Print job information] 2026-09-10 10:58:18.089090 | # Job Information 2026-09-10 10:58:18.089251 | Ansible Version: 2.16.18 2026-09-10 10:58:18.089292 | Job: atmosphere-molecule-csi-rbd 2026-09-10 10:58:18.089402 | Pipeline: check 2026-09-10 10:58:18.089462 | Executor: 2d72f0692154 2026-09-10 10:58:18.089490 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4092 2026-09-10 10:58:18.089522 | Event ID: cae84f20-ad05-11f1-8055-df0de5173bf8 2026-09-10 10:58:18.093825 | 2026-09-10 10:58:18.093912 | LOOP [emit-job-header : Print node information] 2026-09-10 10:58:18.194165 | localhost | ok: 2026-09-10 10:58:18.194347 | localhost | # Node Information 2026-09-10 10:58:18.194383 | localhost | Inventory Hostname: instance 2026-09-10 10:58:18.194409 | localhost | Hostname: np0000192501 2026-09-10 10:58:18.194432 | localhost | Username: zuul 2026-09-10 10:58:18.194459 | localhost | Distro: Ubuntu 22.04 2026-09-10 10:58:18.194482 | localhost | Provider: yul1 2026-09-10 10:58:18.194505 | localhost | Region: ca-ymq-1 2026-09-10 10:58:18.194527 | localhost | Label: ubuntu-jammy 2026-09-10 10:58:18.194549 | localhost | Product Name: OpenStack Nova 2026-09-10 10:58:18.194570 | localhost | Interface IP: 162.253.55.45 2026-09-10 10:58:18.202309 | 2026-09-10 10:58:18.202439 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-10 10:58:18.624775 | localhost -> localhost | changed 2026-09-10 10:58:18.634496 | 2026-09-10 10:58:18.634662 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-10 10:58:19.532010 | localhost -> localhost | changed 2026-09-10 10:58:19.540139 | 2026-09-10 10:58:19.540236 | PLAY [all] 2026-09-10 10:58:19.555914 | 2026-09-10 10:58:19.556039 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-10 10:58:19.813690 | instance -> localhost | ok 2026-09-10 10:58:19.821485 | 2026-09-10 10:58:19.821572 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-10 10:58:19.841538 | instance | ok 2026-09-10 10:58:19.859538 | instance | included: /var/lib/zuul/builds/017f51773e4a47678bf84ea56ac4c1ba/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-10 10:58:19.867771 | 2026-09-10 10:58:19.867867 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-10 10:58:22.566225 | instance -> localhost | Generating public/private rsa key pair. 2026-09-10 10:58:22.566434 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/017f51773e4a47678bf84ea56ac4c1ba/work/017f51773e4a47678bf84ea56ac4c1ba_id_rsa 2026-09-10 10:58:22.566462 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/017f51773e4a47678bf84ea56ac4c1ba/work/017f51773e4a47678bf84ea56ac4c1ba_id_rsa.pub 2026-09-10 10:58:22.566482 | instance -> localhost | The key fingerprint is: 2026-09-10 10:58:22.566508 | instance -> localhost | SHA256:FYJF80A2oOwPWtvFqt9tR2hfMEyAXsWRUOJzfrB53Ww zuul-build-sshkey 2026-09-10 10:58:22.566555 | instance -> localhost | The key's randomart image is: 2026-09-10 10:58:22.566575 | instance -> localhost | +---[RSA 3072]----+ 2026-09-10 10:58:22.566601 | instance -> localhost | | .*X.=*+o | 2026-09-10 10:58:22.566621 | instance -> localhost | | . ....B.o+ | 2026-09-10 10:58:22.566639 | instance -> localhost | | o . .=oo | 2026-09-10 10:58:22.566657 | instance -> localhost | | . ... +++ o.| 2026-09-10 10:58:22.566674 | instance -> localhost | | + S .+oo E| 2026-09-10 10:58:22.566691 | instance -> localhost | | o = o o .o.. | 2026-09-10 10:58:22.566709 | instance -> localhost | | . . + . o . | 2026-09-10 10:58:22.566726 | instance -> localhost | | . . .. o | 2026-09-10 10:58:22.566745 | instance -> localhost | | ... .... | 2026-09-10 10:58:22.566782 | instance -> localhost | +----[SHA256]-----+ 2026-09-10 10:58:22.566832 | instance -> localhost | ok: Runtime: 0:00:02.252414 2026-09-10 10:58:22.573284 | 2026-09-10 10:58:22.573353 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-10 10:58:22.605968 | instance | ok 2026-09-10 10:58:22.620091 | instance | included: /var/lib/zuul/builds/017f51773e4a47678bf84ea56ac4c1ba/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-10 10:58:22.632142 | 2026-09-10 10:58:22.632291 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-10 10:58:22.656143 | instance | skipping: Conditional result was False 2026-09-10 10:58:22.661549 | 2026-09-10 10:58:22.661629 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-10 10:58:23.099735 | instance | changed 2026-09-10 10:58:23.107619 | 2026-09-10 10:58:23.107728 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-10 10:58:23.304138 | instance | ok 2026-09-10 10:58:23.314569 | 2026-09-10 10:58:23.314714 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-10 10:58:23.819191 | instance | changed 2026-09-10 10:58:23.831303 | 2026-09-10 10:58:23.831526 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-10 10:58:24.324092 | instance | changed 2026-09-10 10:58:24.336528 | 2026-09-10 10:58:24.336700 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-10 10:58:24.362577 | instance | skipping: Conditional result was False 2026-09-10 10:58:24.373646 | 2026-09-10 10:58:24.373794 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-10 10:58:24.734185 | instance -> localhost | changed 2026-09-10 10:58:24.757829 | 2026-09-10 10:58:24.758010 | TASK [add-build-sshkey : Add back temp key] 2026-09-10 10:58:25.185572 | instance -> localhost | Identity added: /var/lib/zuul/builds/017f51773e4a47678bf84ea56ac4c1ba/work/017f51773e4a47678bf84ea56ac4c1ba_id_rsa (zuul-build-sshkey) 2026-09-10 10:58:25.185795 | instance -> localhost | ok: Runtime: 0:00:00.020539 2026-09-10 10:58:25.190694 | 2026-09-10 10:58:25.190814 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-10 10:58:25.530148 | instance | ok 2026-09-10 10:58:25.537431 | 2026-09-10 10:58:25.537530 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-10 10:58:25.571395 | instance | skipping: Conditional result was False 2026-09-10 10:58:25.584174 | 2026-09-10 10:58:25.584293 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-09-10 10:58:25.948288 | instance | ok 2026-09-10 10:58:25.954566 | 2026-09-10 10:58:25.954677 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-09-10 10:58:30.891578 | instance | Output suppressed because no_log was given 2026-09-10 10:58:30.899466 | 2026-09-10 10:58:30.899555 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-09-10 10:58:31.102757 | instance | ok: "logs" 2026-09-10 10:58:31.103118 | instance | ok: All items complete 2026-09-10 10:58:31.103184 | 2026-09-10 10:58:31.256340 | instance | ok: "artifacts" 2026-09-10 10:58:31.402415 | instance | ok: "docs" 2026-09-10 10:58:31.419593 | 2026-09-10 10:58:31.419731 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-09-10 10:58:31.608124 | instance | changed: "logs" 2026-09-10 10:58:31.786071 | instance | changed: "artifacts" 2026-09-10 10:58:31.958811 | instance | changed: "docs" 2026-09-10 10:58:31.971600 | 2026-09-10 10:58:31.971792 | PLAY RECAP 2026-09-10 10:58:31.971931 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-09-10 10:58:31.972005 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-10 10:58:31.972053 | 2026-09-10 10:58:32.119170 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-09-10 10:58:32.123209 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-09-10 10:58:32.792950 | 2026-09-10 10:58:32.793115 | PLAY [all] 2026-09-10 10:58:32.803909 | 2026-09-10 10:58:32.804028 | TASK [setup-uv : Extract archive] 2026-09-10 10:58:35.102333 | instance | changed 2026-09-10 10:58:35.107673 | 2026-09-10 10:58:35.107792 | TASK [setup-uv : Print version] 2026-09-10 10:58:35.494961 | instance | uv 0.8.13 2026-09-10 10:58:35.645945 | instance | ok: Runtime: 0:00:00.013695 2026-09-10 10:58:35.664290 | 2026-09-10 10:58:35.664465 | TASK [Install Ansible collection siblings] 2026-09-10 10:58:45.482885 | instance | changed: 2026-09-10 10:58:45.483108 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-09-10 10:58:45.483179 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-09-10 10:58:45.483224 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-09-10 10:58:45.483262 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto 2026-09-10 10:58:45.483302 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general 2026-09-10 10:58:45.483339 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql 2026-09-10 10:58:45.483366 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-09-10 10:58:45.483395 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-09-10 10:58:45.483420 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-09-10 10:58:45.483445 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-09-10 10:58:45.483470 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-09-10 10:58:45.483494 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-09-10 10:58:45.483517 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0 2026-09-10 10:58:45.483539 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0 2026-09-10 10:58:45.483562 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0 2026-09-10 10:58:45.483586 | instance | Resolved community.crypto to 2.2.3 for 2.2.3 2026-09-10 10:58:45.483609 | instance | Resolved community.general to 7.3.0 for 7.3.0 2026-09-10 10:58:45.483632 | instance | Resolved community.mysql to 3.6.0 for 3.6.0 2026-09-10 10:58:45.483655 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0 2026-09-10 10:58:45.483678 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0 2026-09-10 10:58:45.483701 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0 2026-09-10 10:58:45.483724 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0 2026-09-10 10:58:45.483749 | instance | Resolved vexxhost.kubernetes to v3.4.0 for >=3.3.0,>=2.5.0 2026-09-10 10:58:45.483786 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0 2026-09-10 10:58:45.483827 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0 2026-09-10 10:58:45.483851 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-09-10 10:58:45.483873 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-09-10 10:58:45.483896 | instance | Resolved vexxhost.kubernetes to v3.4.0 for >=3.3.0,>=2.5.0 2026-09-10 10:58:45.483918 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0 2026-09-10 10:58:45.483950 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3 2026-09-10 10:58:45.483983 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-09-10 10:58:45.484018 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-09-10 10:58:45.484052 | instance | Checked out ansible.netcommon to 1.2.0 2026-09-10 10:58:45.484087 | 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-09-10 10:58:45.484131 | instance | Starting galaxy collection install process 2026-09-10 10:58:45.484165 | instance | Process install dependency map 2026-09-10 10:58:45.484200 | instance | Starting collection install process 2026-09-10 10:58:45.484234 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon' 2026-09-10 10:58:45.484267 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon 2026-09-10 10:58:45.484300 | instance | ansible.netcommon:* was installed successfully 2026-09-10 10:58:45.484334 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-09-10 10:58:45.484367 | instance | Creating virtual environment at: .venv 2026-09-10 10:58:45.484401 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-09-10 10:58:45.484436 | instance | Downloading ansible-core (2.1MiB) 2026-09-10 10:58:45.484470 | instance | Downloading openstacksdk (1.7MiB) 2026-09-10 10:58:45.484555 | instance | Downloading pygments (1.2MiB) 2026-09-10 10:58:45.484594 | instance | Downloading rjsonnet (1.2MiB) 2026-09-10 10:58:45.484629 | instance | Downloading netaddr (2.2MiB) 2026-09-10 10:58:45.484664 | instance | Downloading cryptography (4.2MiB) 2026-09-10 10:58:45.484699 | instance | Downloading setuptools (1.1MiB) 2026-09-10 10:58:45.484734 | instance | Downloading kubernetes (1.9MiB) 2026-09-10 10:58:45.484768 | instance | Building pyperclip==1.9.0 2026-09-10 10:58:45.484822 | instance | Downloading rjsonnet 2026-09-10 10:58:45.484862 | instance | Downloading netaddr 2026-09-10 10:58:45.484897 | instance | Downloading pygments 2026-09-10 10:58:45.484931 | instance | Downloading cryptography 2026-09-10 10:58:45.484967 | instance | Downloading setuptools 2026-09-10 10:58:45.485000 | instance | Downloading kubernetes 2026-09-10 10:58:45.485032 | instance | Downloading ansible-core 2026-09-10 10:58:45.485064 | instance | Downloading openstacksdk 2026-09-10 10:58:45.485097 | instance | Built pyperclip==1.9.0 2026-09-10 10:58:45.485130 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-09-10 10:58:45.485166 | instance | Installed 79 packages in 79ms 2026-09-10 10:58:45.485200 | instance | Checked out ansible.posix to 1.6.0 2026-09-10 10:58:45.485233 | 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-09-10 10:58:45.485267 | instance | Starting galaxy collection install process 2026-09-10 10:58:45.485300 | instance | Process install dependency map 2026-09-10 10:58:45.485333 | instance | Starting collection install process 2026-09-10 10:58:45.485367 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-09-10 10:58:45.485408 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix 2026-09-10 10:58:45.485442 | instance | ansible.posix:1.6.0 was installed successfully 2026-09-10 10:58:45.485476 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-10 10:58:45.485510 | instance | 2.17.12 2026-09-10 10:58:45.485544 | instance | Checked out ansible.utils to v6.1.0 2026-09-10 10:58:45.485577 | 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-09-10 10:58:45.485610 | instance | Starting galaxy collection install process 2026-09-10 10:58:45.485643 | instance | Process install dependency map 2026-09-10 10:58:45.485675 | instance | Starting collection install process 2026-09-10 10:58:45.485708 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils' 2026-09-10 10:58:45.485740 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils 2026-09-10 10:58:45.485774 | instance | ansible.utils:6.1.0 was installed successfully 2026-09-10 10:58:45.485826 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-10 10:58:45.485861 | instance | 2.17.12 2026-09-10 10:58:45.485895 | instance | Checked out atmosphere.common to v0.7.0 2026-09-10 10:58:45.485929 | 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-09-10 10:58:45.485963 | instance | Starting galaxy collection install process 2026-09-10 10:58:45.485995 | instance | Process install dependency map 2026-09-10 10:58:45.486028 | instance | Starting collection install process 2026-09-10 10:58:45.486061 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common' 2026-09-10 10:58:45.486094 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common 2026-09-10 10:58:45.486140 | instance | atmosphere.common:0.7.0 was installed successfully 2026-09-10 10:58:45.486194 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-10 10:58:45.486238 | instance | 2.17.12 2026-09-10 10:58:45.486697 | instance | Checked out community.crypto to 2.2.3 2026-09-10 10:58:45.486741 | 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-09-10 10:58:45.486780 | instance | Starting galaxy collection install process 2026-09-10 10:58:45.486839 | instance | Process install dependency map 2026-09-10 10:58:45.486875 | instance | Starting collection install process 2026-09-10 10:58:45.486908 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-09-10 10:58:45.486941 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto 2026-09-10 10:58:45.486974 | instance | community.crypto:2.2.3 was installed successfully 2026-09-10 10:58:45.487007 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-10 10:58:45.487039 | instance | 2.17.12 2026-09-10 10:58:45.487072 | instance | Checked out community.general to 7.3.0 2026-09-10 10:58:45.487104 | 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-09-10 10:58:45.487138 | instance | Starting galaxy collection install process 2026-09-10 10:58:45.487182 | instance | Process install dependency map 2026-09-10 10:58:45.487216 | instance | Starting collection install process 2026-09-10 10:58:45.487249 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-09-10 10:58:45.487282 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general 2026-09-10 10:58:45.487315 | instance | community.general:7.3.0 was installed successfully 2026-09-10 10:58:45.487347 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-10 10:58:45.487379 | instance | 2.17.12 2026-09-10 10:58:45.487412 | instance | Checked out community.mysql to 3.6.0 2026-09-10 10:58:45.487445 | 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-09-10 10:58:45.487479 | instance | Starting galaxy collection install process 2026-09-10 10:58:45.487518 | instance | Process install dependency map 2026-09-10 10:58:45.487553 | instance | Starting collection install process 2026-09-10 10:58:45.487587 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql' 2026-09-10 10:58:45.487621 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql 2026-09-10 10:58:45.487655 | instance | community.mysql:3.6.0 was installed successfully 2026-09-10 10:58:45.487688 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-10 10:58:45.487721 | instance | 2.17.12 2026-09-10 10:58:45.487753 | instance | Checked out kubernetes.core to 2.4.0 2026-09-10 10:58:45.487786 | 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-09-10 10:58:45.487847 | instance | Starting galaxy collection install process 2026-09-10 10:58:45.487883 | instance | Process install dependency map 2026-09-10 10:58:45.487916 | instance | Starting collection install process 2026-09-10 10:58:45.487951 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core' 2026-09-10 10:58:45.487986 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core 2026-09-10 10:58:45.488020 | instance | kubernetes.core:2.4.0 was installed successfully 2026-09-10 10:58:45.488255 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-10 10:58:45.488318 | instance | 2.17.12 2026-09-10 10:58:45.488357 | instance | Checked out openstack.cloud to 2.6.0 2026-09-10 10:58:45.488393 | 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-09-10 10:58:45.488429 | instance | Starting galaxy collection install process 2026-09-10 10:58:45.488464 | instance | Process install dependency map 2026-09-10 10:58:45.488522 | instance | Starting collection install process 2026-09-10 10:58:45.488561 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud' 2026-09-10 10:58:45.488595 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud 2026-09-10 10:58:45.488630 | instance | openstack.cloud:2.6.0 was installed successfully 2026-09-10 10:58:45.488664 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-10 10:58:45.488697 | instance | 2.17.12 2026-09-10 10:58:45.488731 | instance | Checked out vexxhost.ceph to v4.2.0 2026-09-10 10:58:45.488766 | 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-09-10 10:58:45.488832 | instance | Starting galaxy collection install process 2026-09-10 10:58:45.488870 | instance | Process install dependency map 2026-09-10 10:58:45.488905 | instance | Starting collection install process 2026-09-10 10:58:45.488940 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph' 2026-09-10 10:58:45.488974 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph 2026-09-10 10:58:45.489008 | instance | vexxhost.ceph:4.2.0 was installed successfully 2026-09-10 10:58:45.489042 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-10 10:58:45.489075 | instance | 2.17.12 2026-09-10 10:58:45.489109 | instance | Checked out vexxhost.containers to v1.6.8 2026-09-10 10:58:45.489142 | 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-09-10 10:58:45.489177 | instance | Starting galaxy collection install process 2026-09-10 10:58:45.489210 | instance | Process install dependency map 2026-09-10 10:58:45.489244 | instance | Starting collection install process 2026-09-10 10:58:45.489278 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers' 2026-09-10 10:58:45.489313 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers 2026-09-10 10:58:45.489348 | instance | vexxhost.containers:1.6.8 was installed successfully 2026-09-10 10:58:45.489381 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-10 10:58:45.489415 | instance | 2.17.12 2026-09-10 10:58:45.489449 | instance | Checked out vexxhost.kubernetes to v3.4.0 2026-09-10 10:58:45.489484 | 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-09-10 10:58:45.489518 | instance | Starting galaxy collection install process 2026-09-10 10:58:45.489552 | instance | Process install dependency map 2026-09-10 10:58:45.489586 | instance | Starting collection install process 2026-09-10 10:58:45.489619 | instance | Installing 'vexxhost.kubernetes:3.4.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes' 2026-09-10 10:58:45.489653 | instance | Created collection for vexxhost.kubernetes:3.4.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes 2026-09-10 10:58:45.489687 | instance | vexxhost.kubernetes:3.4.0 was installed successfully 2026-09-10 10:58:45.489720 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-10 10:58:45.489753 | instance | 2.17.12 2026-09-10 10:58:45.502053 | 2026-09-10 10:58:45.502370 | PLAY RECAP 2026-09-10 10:58:45.502449 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-10 10:58:45.502481 | 2026-09-10 10:58:45.695913 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-09-10 10:58:45.697745 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-09-10 10:58:46.256899 | 2026-09-10 10:58:46.257235 | PLAY [all] 2026-09-10 10:58:46.267000 | 2026-09-10 10:58:46.267073 | TASK [Install "jq" for log collection] 2026-09-10 10:58:57.235298 | instance | changed 2026-09-10 10:58:57.240084 | 2026-09-10 10:58:57.240250 | PLAY RECAP 2026-09-10 10:58:57.240393 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-10 10:58:57.240580 | 2026-09-10 10:58:57.426582 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-09-10 10:58:57.429771 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-09-10 10:58:58.079722 | 2026-09-10 10:58:58.079888 | PLAY [all] 2026-09-10 10:58:58.091747 | 2026-09-10 10:58:58.091917 | LOOP [Check inventory directories] 2026-09-10 10:58:58.451788 | instance | ok: "src/github.com/vexxhost/atmosphere" 2026-09-10 10:58:58.623789 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory" 2026-09-10 10:58:58.797742 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory" 2026-09-10 10:58:58.815958 | 2026-09-10 10:58:58.816242 | LOOP [Copy inventory file for Zuul] 2026-09-10 10:58:59.683906 | instance | changed: 2026-09-10 10:58:59.684213 | instance | { 2026-09-10 10:58:59.684271 | instance | "ansible_loop_var": "item", 2026-09-10 10:58:59.684315 | instance | "changed": false, 2026-09-10 10:58:59.684352 | instance | "failed": false, 2026-09-10 10:58:59.684397 | instance | "invocation": { 2026-09-10 10:58:59.684435 | instance | "module_args": { 2026-09-10 10:58:59.684471 | instance | "checksum_algorithm": "sha1", 2026-09-10 10:58:59.684541 | instance | "follow": true, 2026-09-10 10:58:59.684580 | instance | "get_attributes": true, 2026-09-10 10:58:59.684617 | instance | "get_checksum": true, 2026-09-10 10:58:59.684651 | instance | "get_mime": true, 2026-09-10 10:58:59.684684 | instance | "path": "src/github.com/vexxhost/atmosphere" 2026-09-10 10:58:59.684717 | instance | } 2026-09-10 10:58:59.684752 | instance | }, 2026-09-10 10:58:59.684801 | instance | "item": "src/github.com/vexxhost/atmosphere", 2026-09-10 10:58:59.684875 | instance | "stat": { 2026-09-10 10:58:59.684911 | instance | "atime": 1789037917.8801124, 2026-09-10 10:58:59.684947 | instance | "attr_flags": "e", 2026-09-10 10:58:59.684981 | instance | "attributes": [ 2026-09-10 10:58:59.685014 | instance | "extents" 2026-09-10 10:58:59.685047 | instance | ], 2026-09-10 10:58:59.685080 | instance | "block_size": 4096, 2026-09-10 10:58:59.685112 | instance | "blocks": 8, 2026-09-10 10:58:59.685145 | instance | "charset": "unknown", 2026-09-10 10:58:59.685182 | instance | "ctime": 1789037916.624053, 2026-09-10 10:58:59.685215 | instance | "dev": 64513, 2026-09-10 10:58:59.685248 | instance | "device_type": 0, 2026-09-10 10:58:59.685281 | instance | "executable": true, 2026-09-10 10:58:59.685314 | instance | "exists": true, 2026-09-10 10:58:59.685346 | instance | "gid": 1000, 2026-09-10 10:58:59.685378 | instance | "gr_name": "zuul", 2026-09-10 10:58:59.685410 | instance | "inode": 1049225, 2026-09-10 10:58:59.685442 | instance | "isblk": false, 2026-09-10 10:58:59.685475 | instance | "ischr": false, 2026-09-10 10:58:59.685507 | instance | "isdir": true, 2026-09-10 10:58:59.685539 | instance | "isfifo": false, 2026-09-10 10:58:59.685570 | instance | "isgid": false, 2026-09-10 10:58:59.685601 | instance | "islnk": false, 2026-09-10 10:58:59.685633 | instance | "isreg": false, 2026-09-10 10:58:59.685664 | instance | "issock": false, 2026-09-10 10:58:59.685696 | instance | "isuid": false, 2026-09-10 10:58:59.685727 | instance | "mimetype": "unknown", 2026-09-10 10:58:59.685765 | instance | "mode": "0755", 2026-09-10 10:58:59.685838 | instance | "mtime": 1789037916.624053, 2026-09-10 10:58:59.685886 | instance | "nlink": 21, 2026-09-10 10:58:59.685920 | instance | "path": "src/github.com/vexxhost/atmosphere", 2026-09-10 10:58:59.685953 | instance | "pw_name": "zuul", 2026-09-10 10:58:59.685990 | instance | "readable": true, 2026-09-10 10:58:59.686023 | instance | "rgrp": true, 2026-09-10 10:58:59.686055 | instance | "roth": true, 2026-09-10 10:58:59.686088 | instance | "rusr": true, 2026-09-10 10:58:59.686121 | instance | "size": 4096, 2026-09-10 10:58:59.686153 | instance | "uid": 1000, 2026-09-10 10:58:59.686203 | instance | "version": "3784308558", 2026-09-10 10:58:59.686238 | instance | "wgrp": false, 2026-09-10 10:58:59.686274 | instance | "woth": false, 2026-09-10 10:58:59.686307 | instance | "writeable": true, 2026-09-10 10:58:59.686340 | instance | "wusr": true, 2026-09-10 10:58:59.686373 | instance | "xgrp": true, 2026-09-10 10:58:59.686404 | instance | "xoth": true, 2026-09-10 10:58:59.686439 | instance | "xusr": true 2026-09-10 10:58:59.686471 | instance | } 2026-09-10 10:58:59.686504 | instance | } 2026-09-10 10:58:59.686580 | instance | ok: All items complete 2026-09-10 10:58:59.686623 | 2026-09-10 10:58:59.689376 | instance | skipping: Conditional result was False 2026-09-10 10:58:59.695452 | instance | skipping: Conditional result was False 2026-09-10 10:58:59.721743 | 2026-09-10 10:58:59.722000 | LOOP [Switch "ansible_host" to private IP] 2026-09-10 10:59:00.094194 | instance | changed: 1 replacements made 2026-09-10 10:59:00.096898 | instance | skipping: Conditional result was False 2026-09-10 10:59:00.099484 | instance | skipping: Conditional result was False 2026-09-10 10:59:00.118449 | 2026-09-10 10:59:00.118634 | TASK [Run Molecule scenario] 2026-09-10 10:59:01.088670 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-09-10 10:59:01.494639 | instance | INFO [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-09-10 10:59:01.494759 | instance | INFO [csi > prerun] Performing prerun with role_name_check=0... 2026-09-10 10:59:12.767664 | instance | INFO [csi > dependency] Executing 2026-09-10 10:59:12.768055 | instance | WARNING [csi > dependency] Missing roles requirements file: requirements.yml 2026-09-10 10:59:12.768548 | instance | WARNING [csi > dependency] Missing collections requirements file: collections.yml 2026-09-10 10:59:12.768817 | instance | WARNING [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-09-10 10:59:12.784021 | instance | INFO [csi > cleanup] Executing 2026-09-10 10:59:12.784740 | instance | WARNING [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-09-10 10:59:12.798553 | instance | INFO [csi > destroy] Executing 2026-09-10 10:59:12.798650 | instance | WARNING [csi > destroy] Skipping, '--destroy=never' requested. 2026-09-10 10:59:12.798663 | instance | INFO [csi > destroy] Executed: Successful 2026-09-10 10:59:12.807566 | instance | INFO [csi > syntax] Executing 2026-09-10 10:59:14.358672 | instance | 2026-09-10 10:59:14.359066 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-09-10 10:59:14.423426 | instance | INFO [csi > syntax] Executed: Successful 2026-09-10 10:59:14.439293 | instance | INFO [csi > create] Executing 2026-09-10 10:59:14.442968 | instance | WARNING [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-09-10 10:59:14.459979 | instance | INFO [csi > prepare] Executing 2026-09-10 10:59:15.264072 | instance | 2026-09-10 10:59:15.264212 | instance | PLAY [Prepare] ***************************************************************** 2026-09-10 10:59:15.264572 | instance | 2026-09-10 10:59:15.264870 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-10 10:59:15.265151 | instance | Thursday 10 September 2026 10:59:15 +0000 (0:00:00.023) 0:00:00.023 **** 2026-09-10 10:59:16.581939 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-09-10 10:59:16.582052 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-09-10 10:59:16.582212 | instance | interpreter could change the meaning of that path. See 2026-09-10 10:59:16.582367 | instance | https://docs.ansible.com/ansible- 2026-09-10 10:59:16.582509 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-09-10 10:59:16.595996 | instance | ok: [instance] 2026-09-10 10:59:16.596127 | instance | 2026-09-10 10:59:16.596277 | instance | TASK [Configure short hostname] ************************************************ 2026-09-10 10:59:16.596460 | instance | Thursday 10 September 2026 10:59:16 +0000 (0:00:01.332) 0:00:01.355 **** 2026-09-10 10:59:17.347436 | instance | changed: [instance] 2026-09-10 10:59:17.347588 | instance | 2026-09-10 10:59:17.347866 | instance | TASK [Ensure hostname inside hosts file] *************************************** 2026-09-10 10:59:17.348113 | instance | Thursday 10 September 2026 10:59:17 +0000 (0:00:00.750) 0:00:02.106 **** 2026-09-10 10:59:17.635181 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created 2026-09-10 10:59:17.635517 | instance | with a mode of 0700, this may cause issues when running as another user. To 2026-09-10 10:59:17.635867 | instance | avoid this, create the remote_tmp dir with the correct permissions manually 2026-09-10 10:59:17.641948 | instance | changed: [instance] 2026-09-10 10:59:17.642222 | instance | 2026-09-10 10:59:17.642487 | instance | TASK [Purge "snapd" package] *************************************************** 2026-09-10 10:59:17.642746 | instance | Thursday 10 September 2026 10:59:17 +0000 (0:00:00.295) 0:00:02.401 **** 2026-09-10 10:59:18.504011 | instance | ok: [instance] 2026-09-10 10:59:18.504208 | instance | 2026-09-10 10:59:18.504456 | instance | PLAY [Create devices for Ceph] ************************************************* 2026-09-10 10:59:18.504679 | instance | 2026-09-10 10:59:18.504943 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-10 10:59:18.505183 | instance | Thursday 10 September 2026 10:59:18 +0000 (0:00:00.861) 0:00:03.263 **** 2026-09-10 10:59:19.292727 | instance | ok: [instance] 2026-09-10 10:59:19.292962 | instance | 2026-09-10 10:59:19.293231 | instance | TASK [Install depedencies] ***************************************************** 2026-09-10 10:59:19.293478 | instance | Thursday 10 September 2026 10:59:19 +0000 (0:00:00.788) 0:00:04.052 **** 2026-09-10 10:59:46.127343 | instance | changed: [instance] 2026-09-10 10:59:46.127426 | instance | 2026-09-10 10:59:46.127434 | instance | TASK [Start up service] ******************************************************** 2026-09-10 10:59:46.127441 | instance | Thursday 10 September 2026 10:59:46 +0000 (0:00:26.833) 0:00:30.885 **** 2026-09-10 10:59:46.683938 | instance | ok: [instance] 2026-09-10 10:59:46.684034 | instance | 2026-09-10 10:59:46.684270 | instance | TASK [Generate lvm.conf] ******************************************************* 2026-09-10 10:59:46.684352 | instance | Thursday 10 September 2026 10:59:46 +0000 (0:00:00.558) 0:00:31.443 **** 2026-09-10 10:59:47.006003 | instance | ok: [instance] 2026-09-10 10:59:47.006164 | instance | 2026-09-10 10:59:47.006760 | instance | TASK [Write /etc/lvm/lvm.conf] ************************************************* 2026-09-10 10:59:47.006822 | instance | Thursday 10 September 2026 10:59:46 +0000 (0:00:00.321) 0:00:31.765 **** 2026-09-10 10:59:47.776457 | instance | changed: [instance] 2026-09-10 10:59:47.776745 | instance | 2026-09-10 10:59:47.777409 | instance | TASK [Get list of all loopback devices] **************************************** 2026-09-10 10:59:47.777484 | instance | Thursday 10 September 2026 10:59:47 +0000 (0:00:00.770) 0:00:32.535 **** 2026-09-10 10:59:47.997651 | instance | ok: [instance] 2026-09-10 10:59:47.998399 | instance | 2026-09-10 10:59:47.998431 | instance | TASK [Fail if there is any existing loopback devices] ************************** 2026-09-10 10:59:47.998443 | instance | Thursday 10 September 2026 10:59:47 +0000 (0:00:00.221) 0:00:32.756 **** 2026-09-10 10:59:48.028498 | instance | skipping: [instance] 2026-09-10 10:59:48.029309 | instance | 2026-09-10 10:59:48.029341 | instance | TASK [Create devices for Ceph] ************************************************* 2026-09-10 10:59:48.029352 | instance | Thursday 10 September 2026 10:59:48 +0000 (0:00:00.031) 0:00:32.788 **** 2026-09-10 10:59:48.642809 | instance | changed: [instance] => (item=osd0) 2026-09-10 10:59:48.642903 | instance | changed: [instance] => (item=osd1) 2026-09-10 10:59:48.642988 | instance | changed: [instance] => (item=osd2) 2026-09-10 10:59:48.643131 | instance | 2026-09-10 10:59:48.643272 | instance | TASK [Set permissions on loopback devices] ************************************* 2026-09-10 10:59:48.643411 | instance | Thursday 10 September 2026 10:59:48 +0000 (0:00:00.614) 0:00:33.403 **** 2026-09-10 10:59:49.355286 | instance | changed: [instance] => (item=osd0) 2026-09-10 10:59:49.355613 | instance | changed: [instance] => (item=osd1) 2026-09-10 10:59:49.356077 | instance | changed: [instance] => (item=osd2) 2026-09-10 10:59:49.356493 | instance | 2026-09-10 10:59:49.356960 | instance | TASK [Start loop devices] ****************************************************** 2026-09-10 10:59:49.357362 | instance | Thursday 10 September 2026 10:59:49 +0000 (0:00:00.711) 0:00:34.114 **** 2026-09-10 10:59:50.181969 | instance | changed: [instance] => (item=osd0) 2026-09-10 10:59:50.182042 | instance | changed: [instance] => (item=osd1) 2026-09-10 10:59:50.182052 | instance | changed: [instance] => (item=osd2) 2026-09-10 10:59:50.182062 | instance | 2026-09-10 10:59:50.182071 | instance | TASK [Create a volume group for each loop device] ****************************** 2026-09-10 10:59:50.182081 | instance | Thursday 10 September 2026 10:59:50 +0000 (0:00:00.824) 0:00:34.939 **** 2026-09-10 10:59:53.514894 | instance | changed: [instance] => (item=osd0) 2026-09-10 10:59:53.514987 | instance | changed: [instance] => (item=osd1) 2026-09-10 10:59:53.515464 | instance | changed: [instance] => (item=osd2) 2026-09-10 10:59:53.515729 | instance | 2026-09-10 10:59:53.515738 | instance | TASK [Create a logical volume for each loop device] **************************** 2026-09-10 10:59:53.515745 | instance | Thursday 10 September 2026 10:59:53 +0000 (0:00:03.335) 0:00:38.274 **** 2026-09-10 10:59:55.571354 | instance | changed: [instance] => (item=ceph-instance-osd0) 2026-09-10 10:59:55.571567 | instance | changed: [instance] => (item=ceph-instance-osd1) 2026-09-10 10:59:55.571826 | instance | changed: [instance] => (item=ceph-instance-osd2) 2026-09-10 10:59:55.572055 | instance | 2026-09-10 10:59:55.572428 | instance | PLAY RECAP ********************************************************************* 2026-09-10 10:59:55.576440 | instance | instance : ok=15 changed=9 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-09-10 10:59:55.576540 | instance | 2026-09-10 10:59:55.576552 | instance | Thursday 10 September 2026 10:59:55 +0000 (0:00:02.056) 0:00:40.331 **** 2026-09-10 10:59:55.576562 | instance | =============================================================================== 2026-09-10 10:59:55.576571 | instance | Install depedencies ---------------------------------------------------- 26.83s 2026-09-10 10:59:55.576580 | instance | Create a volume group for each loop device ------------------------------ 3.34s 2026-09-10 10:59:55.576588 | instance | Create a logical volume for each loop device ---------------------------- 2.06s 2026-09-10 10:59:55.576599 | instance | Gathering Facts --------------------------------------------------------- 1.33s 2026-09-10 10:59:55.576608 | instance | Purge "snapd" package --------------------------------------------------- 0.86s 2026-09-10 10:59:55.576617 | instance | Start loop devices ------------------------------------------------------ 0.83s 2026-09-10 10:59:55.576625 | instance | Gathering Facts --------------------------------------------------------- 0.79s 2026-09-10 10:59:55.576634 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.77s 2026-09-10 10:59:55.576642 | instance | Configure short hostname ------------------------------------------------ 0.75s 2026-09-10 10:59:55.576651 | instance | Set permissions on loopback devices ------------------------------------- 0.71s 2026-09-10 10:59:55.576660 | instance | Create devices for Ceph ------------------------------------------------- 0.61s 2026-09-10 10:59:55.576668 | instance | Start up service -------------------------------------------------------- 0.56s 2026-09-10 10:59:55.576689 | instance | Generate lvm.conf ------------------------------------------------------- 0.32s 2026-09-10 10:59:55.576698 | instance | Ensure hostname inside hosts file --------------------------------------- 0.30s 2026-09-10 10:59:55.576941 | instance | Get list of all loopback devices ---------------------------------------- 0.22s 2026-09-10 10:59:55.577264 | instance | Fail if there is any existing loopback devices -------------------------- 0.03s 2026-09-10 10:59:55.659535 | instance | INFO [csi > prepare] Executed: Successful 2026-09-10 10:59:55.675008 | instance | INFO [csi > converge] Executing 2026-09-10 10:59:57.128259 | instance | 2026-09-10 10:59:57.128765 | instance | PLAY [Debug CSI driver value] ************************************************** 2026-09-10 10:59:57.129147 | instance | 2026-09-10 10:59:57.129468 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-10 10:59:57.129832 | instance | Thursday 10 September 2026 10:59:57 +0000 (0:00:00.007) 0:00:00.007 **** 2026-09-10 10:59:59.252511 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-09-10 10:59:59.253004 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-09-10 10:59:59.253425 | instance | interpreter could change the meaning of that path. See 2026-09-10 10:59:59.253816 | instance | https://docs.ansible.com/ansible- 2026-09-10 10:59:59.254239 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-09-10 10:59:59.269316 | instance | ok: [instance] 2026-09-10 10:59:59.269536 | instance | 2026-09-10 10:59:59.269937 | instance | TASK [Display CSI driver value and environment variable] *********************** 2026-09-10 10:59:59.270257 | instance | Thursday 10 September 2026 10:59:59 +0000 (0:00:02.139) 0:00:02.147 **** 2026-09-10 10:59:59.345350 | instance | ok: [instance] => { 2026-09-10 10:59:59.345771 | instance | "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER=" 2026-09-10 10:59:59.346110 | instance | } 2026-09-10 10:59:59.346408 | instance | 2026-09-10 10:59:59.346719 | instance | PLAY [all] ********************************************************************* 2026-09-10 10:59:59.347041 | instance | 2026-09-10 10:59:59.347351 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-10 10:59:59.347684 | instance | Thursday 10 September 2026 10:59:59 +0000 (0:00:00.075) 0:00:02.222 **** 2026-09-10 11:00:00.373091 | instance | ok: [instance] 2026-09-10 11:00:00.373207 | instance | 2026-09-10 11:00:00.373357 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-09-10 11:00:00.373609 | instance | Thursday 10 September 2026 11:00:00 +0000 (0:00:01.027) 0:00:03.250 **** 2026-09-10 11:00:00.573294 | instance | ok: [instance] 2026-09-10 11:00:00.573671 | instance | 2026-09-10 11:00:00.574011 | instance | PLAY [Deploy Ceph monitors & managers] ***************************************** 2026-09-10 11:00:00.574296 | instance | 2026-09-10 11:00:00.574590 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-10 11:00:00.576250 | instance | Thursday 10 September 2026 11:00:00 +0000 (0:00:00.200) 0:00:03.451 **** 2026-09-10 11:00:01.565410 | instance | ok: [instance] 2026-09-10 11:00:01.565791 | instance | 2026-09-10 11:00:01.566250 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-09-10 11:00:01.566720 | instance | Thursday 10 September 2026 11:00:01 +0000 (0:00:00.989) 0:00:04.440 **** 2026-09-10 11:00:01.904918 | instance | ok: [instance] 2026-09-10 11:00:01.905028 | instance | 2026-09-10 11:00:01.905421 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-09-10 11:00:01.905628 | instance | Thursday 10 September 2026 11:00:01 +0000 (0:00:00.341) 0:00:04.782 **** 2026-09-10 11:00:01.961116 | instance | skipping: [instance] 2026-09-10 11:00:01.961280 | instance | 2026-09-10 11:00:01.961520 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-09-10 11:00:01.961727 | instance | Thursday 10 September 2026 11:00:01 +0000 (0:00:00.055) 0:00:04.837 **** 2026-09-10 11:00:02.316141 | instance | changed: [instance] 2026-09-10 11:00:02.316557 | instance | 2026-09-10 11:00:02.316901 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-09-10 11:00:02.317217 | instance | Thursday 10 September 2026 11:00:02 +0000 (0:00:00.354) 0:00:05.192 **** 2026-09-10 11:00:02.416494 | instance | ok: [instance] => { 2026-09-10 11:00:02.416594 | instance | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-09-10 11:00:02.416615 | instance | } 2026-09-10 11:00:02.416812 | instance | 2026-09-10 11:00:02.417100 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-09-10 11:00:02.417345 | instance | Thursday 10 September 2026 11:00:02 +0000 (0:00:00.102) 0:00:05.294 **** 2026-09-10 11:00:03.138992 | instance | changed: [instance] 2026-09-10 11:00:03.139161 | instance | 2026-09-10 11:00:03.139408 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-09-10 11:00:03.139618 | instance | Thursday 10 September 2026 11:00:03 +0000 (0:00:00.723) 0:00:06.017 **** 2026-09-10 11:00:03.183858 | instance | skipping: [instance] 2026-09-10 11:00:03.184030 | instance | 2026-09-10 11:00:03.184205 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-09-10 11:00:03.184365 | instance | Thursday 10 September 2026 11:00:03 +0000 (0:00:00.045) 0:00:06.063 **** 2026-09-10 11:00:03.227646 | instance | skipping: [instance] 2026-09-10 11:00:03.227718 | instance | 2026-09-10 11:00:03.227825 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-09-10 11:00:03.228003 | instance | Thursday 10 September 2026 11:00:03 +0000 (0:00:00.043) 0:00:06.106 **** 2026-09-10 11:00:03.478501 | instance | ok: [instance] 2026-09-10 11:00:03.478612 | instance | 2026-09-10 11:00:03.478705 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-09-10 11:00:03.478830 | instance | Thursday 10 September 2026 11:00:03 +0000 (0:00:00.250) 0:00:06.357 **** 2026-09-10 11:00:05.162085 | instance | ok: [instance] 2026-09-10 11:00:05.162170 | instance | 2026-09-10 11:00:05.162182 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-09-10 11:00:05.162192 | instance | Thursday 10 September 2026 11:00:05 +0000 (0:00:01.681) 0:00:08.039 **** 2026-09-10 11:00:05.238398 | instance | ok: [instance] => { 2026-09-10 11:00:05.239669 | instance | "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz" 2026-09-10 11:00:05.239760 | instance | } 2026-09-10 11:00:05.239772 | instance | 2026-09-10 11:00:05.239782 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-09-10 11:00:05.239792 | instance | Thursday 10 September 2026 11:00:05 +0000 (0:00:00.077) 0:00:08.117 **** 2026-09-10 11:00:05.943391 | instance | changed: [instance] 2026-09-10 11:00:05.943457 | instance | 2026-09-10 11:00:05.943463 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-09-10 11:00:05.943469 | instance | Thursday 10 September 2026 11:00:05 +0000 (0:00:00.705) 0:00:08.822 **** 2026-09-10 11:00:08.928822 | instance | changed: [instance] 2026-09-10 11:00:08.928947 | instance | 2026-09-10 11:00:08.929327 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-09-10 11:00:08.929392 | instance | Thursday 10 September 2026 11:00:08 +0000 (0:00:02.985) 0:00:11.808 **** 2026-09-10 11:00:08.970084 | instance | skipping: [instance] 2026-09-10 11:00:08.970177 | instance | 2026-09-10 11:00:08.970561 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-09-10 11:00:08.970622 | instance | Thursday 10 September 2026 11:00:08 +0000 (0:00:00.040) 0:00:11.848 **** 2026-09-10 11:00:09.013701 | instance | skipping: [instance] 2026-09-10 11:00:09.013764 | instance | 2026-09-10 11:00:09.013775 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-09-10 11:00:09.013785 | instance | Thursday 10 September 2026 11:00:09 +0000 (0:00:00.042) 0:00:11.891 **** 2026-09-10 11:00:09.056560 | instance | skipping: [instance] 2026-09-10 11:00:09.056841 | instance | 2026-09-10 11:00:09.057095 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-09-10 11:00:09.057315 | instance | Thursday 10 September 2026 11:00:09 +0000 (0:00:00.043) 0:00:11.935 **** 2026-09-10 11:00:16.482757 | instance | changed: [instance] 2026-09-10 11:00:16.483020 | instance | 2026-09-10 11:00:16.483037 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] *** 2026-09-10 11:00:16.483221 | instance | Thursday 10 September 2026 11:00:16 +0000 (0:00:07.426) 0:00:19.362 **** 2026-09-10 11:00:17.195497 | instance | changed: [instance] 2026-09-10 11:00:17.196428 | instance | 2026-09-10 11:00:17.196515 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] ******* 2026-09-10 11:00:17.196536 | instance | Thursday 10 September 2026 11:00:17 +0000 (0:00:00.711) 0:00:20.074 **** 2026-09-10 11:00:18.272998 | instance | changed: [instance] => (item={'path': '/etc/containerd'}) 2026-09-10 11:00:18.274878 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'}) 2026-09-10 11:00:18.274942 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'}) 2026-09-10 11:00:18.274955 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'}) 2026-09-10 11:00:18.274965 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'}) 2026-09-10 11:00:18.274975 | instance | 2026-09-10 11:00:18.274993 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] ********** 2026-09-10 11:00:18.275026 | instance | Thursday 10 September 2026 11:00:18 +0000 (0:00:01.077) 0:00:21.151 **** 2026-09-10 11:00:18.924455 | instance | changed: [instance] 2026-09-10 11:00:18.924547 | instance | 2026-09-10 11:00:18.925341 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ******** 2026-09-10 11:00:18.925396 | instance | Thursday 10 September 2026 11:00:18 +0000 (0:00:00.625) 0:00:21.777 **** 2026-09-10 11:00:18.925404 | instance | 2026-09-10 11:00:18.925411 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-09-10 11:00:18.925417 | instance | Thursday 10 September 2026 11:00:18 +0000 (0:00:00.025) 0:00:21.803 **** 2026-09-10 11:00:19.923852 | instance | ok: [instance] 2026-09-10 11:00:19.923924 | instance | 2026-09-10 11:00:19.924176 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] ********** 2026-09-10 11:00:19.924215 | instance | Thursday 10 September 2026 11:00:19 +0000 (0:00:00.999) 0:00:22.803 **** 2026-09-10 11:00:20.457807 | instance | changed: [instance] 2026-09-10 11:00:20.457904 | instance | 2026-09-10 11:00:20.457916 | instance | TASK [vexxhost.containers.containerd : Enable and start service] *************** 2026-09-10 11:00:20.457926 | instance | Thursday 10 September 2026 11:00:20 +0000 (0:00:00.532) 0:00:23.335 **** 2026-09-10 11:00:21.082775 | instance | changed: [instance] 2026-09-10 11:00:21.082849 | instance | 2026-09-10 11:00:21.082867 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-09-10 11:00:21.082882 | instance | Thursday 10 September 2026 11:00:21 +0000 (0:00:00.624) 0:00:23.960 **** 2026-09-10 11:00:21.331667 | instance | ok: [instance] 2026-09-10 11:00:21.331760 | instance | 2026-09-10 11:00:21.332193 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-09-10 11:00:21.332251 | instance | Thursday 10 September 2026 11:00:21 +0000 (0:00:00.250) 0:00:24.210 **** 2026-09-10 11:00:21.412436 | instance | ok: [instance] => { 2026-09-10 11:00:21.412486 | instance | "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz" 2026-09-10 11:00:21.412496 | instance | } 2026-09-10 11:00:21.413181 | instance | 2026-09-10 11:00:21.413248 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-09-10 11:00:21.413261 | instance | Thursday 10 September 2026 11:00:21 +0000 (0:00:00.079) 0:00:24.290 **** 2026-09-10 11:00:22.355308 | instance | changed: [instance] 2026-09-10 11:00:22.356060 | instance | 2026-09-10 11:00:22.356335 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-09-10 11:00:22.356353 | instance | Thursday 10 September 2026 11:00:22 +0000 (0:00:00.943) 0:00:25.234 **** 2026-09-10 11:00:26.847602 | instance | changed: [instance] 2026-09-10 11:00:26.847667 | instance | 2026-09-10 11:00:26.847675 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ****************** 2026-09-10 11:00:26.847682 | instance | Thursday 10 September 2026 11:00:26 +0000 (0:00:04.491) 0:00:29.725 **** 2026-09-10 11:00:28.119107 | instance | ok: [instance] 2026-09-10 11:00:28.119230 | instance | 2026-09-10 11:00:28.119793 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] *************** 2026-09-10 11:00:28.120039 | instance | Thursday 10 September 2026 11:00:28 +0000 (0:00:01.271) 0:00:30.997 **** 2026-09-10 11:00:28.512205 | instance | changed: [instance] 2026-09-10 11:00:28.512354 | instance | 2026-09-10 11:00:28.512595 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] ***** 2026-09-10 11:00:28.512653 | instance | Thursday 10 September 2026 11:00:28 +0000 (0:00:00.393) 0:00:31.391 **** 2026-09-10 11:00:29.016097 | instance | changed: [instance] 2026-09-10 11:00:29.016170 | instance | 2026-09-10 11:00:29.016181 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] *********** 2026-09-10 11:00:29.016191 | instance | Thursday 10 September 2026 11:00:29 +0000 (0:00:00.502) 0:00:31.894 **** 2026-09-10 11:00:29.674966 | instance | changed: [instance] => (item={'path': '/etc/docker'}) 2026-09-10 11:00:29.675103 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'}) 2026-09-10 11:00:29.675614 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'}) 2026-09-10 11:00:29.675672 | instance | 2026-09-10 11:00:29.675678 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ****** 2026-09-10 11:00:29.675682 | instance | Thursday 10 September 2026 11:00:29 +0000 (0:00:00.659) 0:00:32.554 **** 2026-09-10 11:00:30.206462 | instance | changed: [instance] 2026-09-10 11:00:30.207406 | instance | 2026-09-10 11:00:30.207478 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] *********** 2026-09-10 11:00:30.207490 | instance | Thursday 10 September 2026 11:00:30 +0000 (0:00:00.530) 0:00:33.084 **** 2026-09-10 11:00:30.744834 | instance | changed: [instance] 2026-09-10 11:00:30.744966 | instance | 2026-09-10 11:00:30.745731 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************ 2026-09-10 11:00:30.745795 | instance | Thursday 10 September 2026 11:00:30 +0000 (0:00:00.520) 0:00:33.604 **** 2026-09-10 11:00:30.745801 | instance | 2026-09-10 11:00:30.745806 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-09-10 11:00:30.745810 | instance | Thursday 10 September 2026 11:00:30 +0000 (0:00:00.018) 0:00:33.623 **** 2026-09-10 11:00:31.541643 | instance | ok: [instance] 2026-09-10 11:00:31.541829 | instance | 2026-09-10 11:00:31.542425 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ****************** 2026-09-10 11:00:31.542502 | instance | Thursday 10 September 2026 11:00:31 +0000 (0:00:00.796) 0:00:34.420 **** 2026-09-10 11:00:32.519361 | instance | changed: [instance] 2026-09-10 11:00:32.519544 | instance | 2026-09-10 11:00:32.520077 | instance | TASK [vexxhost.containers.docker : Enable and start service] ******************* 2026-09-10 11:00:32.520179 | instance | Thursday 10 September 2026 11:00:32 +0000 (0:00:00.977) 0:00:35.398 **** 2026-09-10 11:00:33.229259 | instance | changed: [instance] 2026-09-10 11:00:33.229687 | instance | 2026-09-10 11:00:33.229709 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ****** 2026-09-10 11:00:33.229716 | instance | Thursday 10 September 2026 11:00:33 +0000 (0:00:00.710) 0:00:36.108 **** 2026-09-10 11:00:33.301807 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml) 2026-09-10 11:00:33.301891 | instance | 2026-09-10 11:00:33.302139 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ******************************** 2026-09-10 11:00:33.302201 | instance | Thursday 10 September 2026 11:00:33 +0000 (0:00:00.072) 0:00:36.181 **** 2026-09-10 11:00:38.908847 | instance | changed: [instance] 2026-09-10 11:00:38.909859 | instance | 2026-09-10 11:00:38.909896 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] ********************* 2026-09-10 11:00:38.909911 | instance | Thursday 10 September 2026 11:00:38 +0000 (0:00:05.606) 0:00:41.787 **** 2026-09-10 11:00:39.615474 | instance | ok: [instance] => (item=chronyd) 2026-09-10 11:00:39.615575 | instance | ok: [instance] => (item=sshd) 2026-09-10 11:00:39.616061 | instance | 2026-09-10 11:00:39.616155 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ****************************** 2026-09-10 11:00:39.616165 | instance | Thursday 10 September 2026 11:00:39 +0000 (0:00:00.706) 0:00:42.494 **** 2026-09-10 11:00:57.977930 | instance | changed: [instance] 2026-09-10 11:00:57.978050 | instance | 2026-09-10 11:00:57.978062 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ******************** 2026-09-10 11:00:57.978212 | instance | Thursday 10 September 2026 11:00:57 +0000 (0:00:18.362) 0:01:00.857 **** 2026-09-10 11:00:58.212814 | instance | ok: [instance] 2026-09-10 11:00:58.212876 | instance | 2026-09-10 11:00:58.212882 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] **************** 2026-09-10 11:00:58.212887 | instance | Thursday 10 September 2026 11:00:58 +0000 (0:00:00.234) 0:01:01.091 **** 2026-09-10 11:00:58.684947 | instance | changed: [instance] 2026-09-10 11:00:58.685041 | instance | 2026-09-10 11:00:58.685415 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] *** 2026-09-10 11:00:58.685483 | instance | Thursday 10 September 2026 11:00:58 +0000 (0:00:00.472) 0:01:01.563 **** 2026-09-10 11:00:59.083446 | instance | changed: [instance] 2026-09-10 11:00:59.083550 | instance | 2026-09-10 11:00:59.083876 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] ************************* 2026-09-10 11:00:59.083941 | instance | Thursday 10 September 2026 11:00:59 +0000 (0:00:00.398) 0:01:01.962 **** 2026-09-10 11:00:59.235861 | instance | ok: [instance] 2026-09-10 11:00:59.236368 | instance | 2026-09-10 11:00:59.236462 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] ******************* 2026-09-10 11:00:59.236783 | instance | Thursday 10 September 2026 11:00:59 +0000 (0:00:00.151) 0:01:02.114 **** 2026-09-10 11:00:59.531919 | instance | ok: [instance] => (item=instance) 2026-09-10 11:00:59.532000 | instance | 2026-09-10 11:00:59.532375 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ******** 2026-09-10 11:00:59.532614 | instance | Thursday 10 September 2026 11:00:59 +0000 (0:00:00.296) 0:01:02.411 **** 2026-09-10 11:00:59.611495 | instance | ok: [instance] 2026-09-10 11:00:59.612445 | instance | 2026-09-10 11:00:59.612555 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] *********************************** 2026-09-10 11:00:59.612568 | instance | Thursday 10 September 2026 11:00:59 +0000 (0:00:00.078) 0:01:02.489 **** 2026-09-10 11:00:59.705719 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance 2026-09-10 11:00:59.706206 | instance | 2026-09-10 11:00:59.706228 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] ************* 2026-09-10 11:00:59.706236 | instance | Thursday 10 September 2026 11:00:59 +0000 (0:00:00.094) 0:01:02.584 **** 2026-09-10 11:01:00.081560 | instance | changed: [instance] 2026-09-10 11:01:00.081643 | instance | 2026-09-10 11:01:00.081915 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ****************** 2026-09-10 11:01:00.081976 | instance | Thursday 10 September 2026 11:01:00 +0000 (0:00:00.376) 0:01:02.960 **** 2026-09-10 11:01:00.861368 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True}) 2026-09-10 11:01:00.861456 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0}) 2026-09-10 11:01:00.861900 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False}) 2026-09-10 11:01:00.861962 | instance | 2026-09-10 11:01:00.861969 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] ******************************* 2026-09-10 11:01:00.861975 | instance | Thursday 10 September 2026 11:01:00 +0000 (0:00:00.779) 0:01:03.740 **** 2026-09-10 11:02:34.648409 | instance | ok: [instance] 2026-09-10 11:02:34.648493 | instance | 2026-09-10 11:02:34.648506 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] *************** 2026-09-10 11:02:34.648516 | instance | Thursday 10 September 2026 11:02:34 +0000 (0:01:33.783) 0:02:37.523 **** 2026-09-10 11:02:34.907400 | instance | changed: [instance] 2026-09-10 11:02:34.907612 | instance | 2026-09-10 11:02:34.907905 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] ********************************** 2026-09-10 11:02:34.908164 | instance | Thursday 10 September 2026 11:02:34 +0000 (0:00:00.262) 0:02:37.786 **** 2026-09-10 11:02:34.956573 | instance | ok: [instance] 2026-09-10 11:02:34.956799 | instance | 2026-09-10 11:02:34.957044 | instance | TASK [Install Ceph host] ******************************************************* 2026-09-10 11:02:34.957293 | instance | Thursday 10 September 2026 11:02:34 +0000 (0:00:00.049) 0:02:37.835 **** 2026-09-10 11:02:35.038480 | instance | included: vexxhost.ceph.cephadm_host for instance 2026-09-10 11:02:35.038555 | instance | 2026-09-10 11:02:35.038622 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ****** 2026-09-10 11:02:35.038725 | instance | Thursday 10 September 2026 11:02:35 +0000 (0:00:00.082) 0:02:37.918 **** 2026-09-10 11:02:36.792454 | instance | ok: [instance] 2026-09-10 11:02:36.792581 | instance | 2026-09-10 11:02:36.792793 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] *** 2026-09-10 11:02:36.792974 | instance | Thursday 10 September 2026 11:02:36 +0000 (0:00:01.753) 0:02:39.672 **** 2026-09-10 11:02:36.863455 | instance | ok: [instance] => (item=instance) 2026-09-10 11:02:36.863743 | instance | 2026-09-10 11:02:36.864011 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] *********** 2026-09-10 11:02:36.864263 | instance | Thursday 10 September 2026 11:02:36 +0000 (0:00:00.070) 0:02:39.742 **** 2026-09-10 11:02:37.246475 | instance | ok: [instance] 2026-09-10 11:02:37.246807 | instance | 2026-09-10 11:02:37.247164 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] *********************** 2026-09-10 11:02:37.247483 | instance | Thursday 10 September 2026 11:02:37 +0000 (0:00:00.382) 0:02:40.125 **** 2026-09-10 11:02:39.892466 | instance | ok: [instance] 2026-09-10 11:02:39.892526 | instance | 2026-09-10 11:02:39.892538 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ****************** 2026-09-10 11:02:39.892678 | instance | Thursday 10 September 2026 11:02:39 +0000 (0:00:02.645) 0:02:42.771 **** 2026-09-10 11:03:38.977636 | instance | An exception occurred during task execution. To see the full traceback, use -vvv. The error was: [errno 5] RADOS I/O error (error connecting to the cluster) 2026-09-10 11:03:38.978516 | instance | fatal: [instance]: FAILED! => {"changed": false, "module_stderr": "Traceback (most recent call last):\n File \"\", line 107, in \n File \"\", line 99, in _ansiballz_main\n File \"\", line 47, in invoke_module\n File \"/usr/lib/python3.10/runpy.py\", line 224, in run_module\n return _run_module_code(code, init_globals, run_name, mod_spec)\n File \"/usr/lib/python3.10/runpy.py\", line 96, in _run_module_code\n _run_code(code, mod_globals, init_globals,\n File \"/usr/lib/python3.10/runpy.py\", line 86, in _run_code\n exec(code, run_globals)\n File \"/tmp/ansible_vexxhost.ceph.orch_apply_payload_iere_n65/ansible_vexxhost.ceph.orch_apply_payload.zip/ansible_collections/vexxhost/ceph/plugins/modules/orch_apply.py\", line 202, in \n File \"/tmp/ansible_vexxhost.ceph.orch_apply_payload_iere_n65/ansible_vexxhost.ceph.orch_apply_payload.zip/ansible_collections/vexxhost/ceph/plugins/modules/orch_apply.py\", line 198, in main\n File \"/tmp/ansible_vexxhost.ceph.orch_apply_payload_iere_n65/ansible_vexxhost.ceph.orch_apply_payload.zip/ansible_collections/vexxhost/ceph/plugins/modules/orch_apply.py\", line 177, in run_module\n File \"/tmp/ansible_vexxhost.ceph.orch_apply_payload_iere_n65/ansible_vexxhost.ceph.orch_apply_payload.zip/ansible_collections/vexxhost/ceph/plugins/modules/orch_apply.py\", line 120, in apply_spec\nRuntimeError: Inferring config /var/lib/ceph/4837cbf8-4f90-4300-b3f6-726c9b9f89b4/mon.instance/config\n2026-09-10T11:03:38.788+0000 7faa9e04a640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAejqJqNaFzAyAAWRjqP/p68emUyie4cflNS2fRzk2ndbxpGQJ2FoPVs1I=: Malformed input [buffer:3]\n2026-09-10T11:03:38.788+0000 7faa9e04a640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-10T11:03:38.788+0000 7faa9e04a640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAejqJqNaFzAyAAWRjqP/p68emUyie4cflNS2fRzk2ndbxpGQJ2FoPVs1I=: Malformed input [buffer:3]\n2026-09-10T11:03:38.788+0000 7faa9e04a640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-10T11:03:38.788+0000 7faa9e04a640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAejqJqNaFzAyAAWRjqP/p68emUyie4cflNS2fRzk2ndbxpGQJ2FoPVs1I=: Malformed input [buffer:3]\n2026-09-10T11:03:38.788+0000 7faa9e04a640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-10T11:03:38.788+0000 7faa9e04a640 -1 monclient: keyring not found\n[errno 5] RADOS I/O error (error connecting to the cluster)\n\n", "module_stdout": "", "msg": "MODULE FAILURE\nSee stdout/stderr for the exact error", "rc": 1} 2026-09-10 11:03:38.981599 | instance | 2026-09-10 11:03:38.981915 | instance | PLAY RECAP ********************************************************************* 2026-09-10 11:03:38.984442 | instance | instance : ok=55 changed=26 unreachable=0 failed=1 skipped=6 rescued=0 ignored=0 2026-09-10 11:03:38.984542 | instance | 2026-09-10 11:03:38.984549 | instance | Thursday 10 September 2026 11:03:38 +0000 (0:00:59.090) 0:03:41.861 **** 2026-09-10 11:03:38.984556 | instance | =============================================================================== 2026-09-10 11:03:38.984561 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 93.78s 2026-09-10 11:03:38.984566 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 59.09s 2026-09-10 11:03:38.984570 | instance | vexxhost.ceph.cephadm : Download "cephadm" ----------------------------- 18.36s 2026-09-10 11:03:38.984575 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 7.43s 2026-09-10 11:03:38.984580 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 5.61s 2026-09-10 11:03:38.984594 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.49s 2026-09-10 11:03:38.988239 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.99s 2026-09-10 11:03:38.988386 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.65s 2026-09-10 11:03:38.988422 | instance | Gathering Facts --------------------------------------------------------- 2.14s 2026-09-10 11:03:38.988431 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.80s 2026-09-10 11:03:38.988441 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.75s 2026-09-10 11:03:38.988449 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.68s 2026-09-10 11:03:38.988458 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.27s 2026-09-10 11:03:38.988467 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 1.08s 2026-09-10 11:03:38.988475 | instance | Gathering Facts --------------------------------------------------------- 1.03s 2026-09-10 11:03:38.988484 | instance | Gathering Facts --------------------------------------------------------- 0.99s 2026-09-10 11:03:38.988494 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 0.98s 2026-09-10 11:03:38.988503 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.94s 2026-09-10 11:03:38.988514 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.78s 2026-09-10 11:03:38.988531 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.72s 2026-09-10 11:03:39.109218 | instance | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-09-10 11:03:39.109398 | instance | ERROR [csi > converge] Executed: Failed 2026-09-10 11:03:39.109497 | instance | ERROR Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-09-10 11:03:39.559593 | instance | ERROR 2026-09-10 11:03:39.559851 | instance | { 2026-09-10 11:03:39.559925 | instance | "delta": "0:04:38.667723", 2026-09-10 11:03:39.559965 | instance | "end": "2026-09-10 11:03:39.176067", 2026-09-10 11:03:39.560000 | instance | "msg": "non-zero return code", 2026-09-10 11:03:39.560034 | instance | "rc": 2, 2026-09-10 11:03:39.560067 | instance | "start": "2026-09-10 10:59:00.508344" 2026-09-10 11:03:39.560099 | instance | } failure 2026-09-10 11:03:39.570010 | 2026-09-10 11:03:39.570134 | PLAY RECAP 2026-09-10 11:03:39.570241 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-09-10 11:03:39.570286 | 2026-09-10 11:03:39.724652 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-09-10 11:03:39.730830 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-09-10 11:03:40.303940 | 2026-09-10 11:03:40.304079 | PLAY [all] 2026-09-10 11:03:40.319212 | 2026-09-10 11:03:40.319340 | TASK [gather-host-logs : creating directory for system status] 2026-09-10 11:03:40.715815 | instance | changed 2026-09-10 11:03:40.722138 | 2026-09-10 11:03:40.722272 | TASK [gather-host-logs : Get logs for each host] 2026-09-10 11:03:41.126063 | instance | + systemd-cgls --full --all --no-pager 2026-09-10 11:03:41.136087 | instance | + ip addr 2026-09-10 11:03:41.138777 | instance | + ip route 2026-09-10 11:03:41.141318 | instance | + lsblk 2026-09-10 11:03:41.145975 | instance | + mount 2026-09-10 11:03:41.148231 | instance | + docker images 2026-09-10 11:03:41.170659 | instance | + brctl show 2026-09-10 11:03:41.171368 | instance | /bin/bash: line 8: brctl: command not found 2026-09-10 11:03:41.171867 | instance | + ps aux --sort=-%mem 2026-09-10 11:03:41.195583 | instance | + dpkg -l 2026-09-10 11:03:41.204341 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-09-10 11:03:41.205158 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-09-10 11:03:41.231425 | instance | + '[' '!' -z '' ']' 2026-09-10 11:03:41.272074 | instance | ok: Runtime: 0:00:00.109642 2026-09-10 11:03:41.281633 | 2026-09-10 11:03:41.281749 | TASK [gather-host-logs : Downloads logs to executor] 2026-09-10 11:03:41.978756 | instance | changed: 2026-09-10 11:03:41.978999 | instance | created directory /var/lib/zuul/builds/017f51773e4a47678bf84ea56ac4c1ba/work/logs/instance 2026-09-10 11:03:41.979056 | instance | cd+++++++++ system/ 2026-09-10 11:03:41.979099 | instance | >f+++++++++ system/brctl-show.txt 2026-09-10 11:03:41.979139 | instance | >f+++++++++ system/docker-images.txt 2026-09-10 11:03:41.979176 | instance | >f+++++++++ system/ip-addr.txt 2026-09-10 11:03:41.979245 | instance | >f+++++++++ system/ip-route.txt 2026-09-10 11:03:41.979287 | instance | >f+++++++++ system/lsblk.txt 2026-09-10 11:03:41.979324 | instance | >f+++++++++ system/mount.txt 2026-09-10 11:03:41.979361 | instance | >f+++++++++ system/packages.txt 2026-09-10 11:03:41.979397 | instance | >f+++++++++ system/ps.txt 2026-09-10 11:03:41.979437 | instance | >f+++++++++ system/systemd-cgls.txt 2026-09-10 11:03:41.996669 | 2026-09-10 11:03:41.996798 | LOOP [helm-release-status : creating directory for helm release status] 2026-09-10 11:03:42.235055 | instance | changed: "values" 2026-09-10 11:03:42.430795 | instance | changed: "releases" 2026-09-10 11:03:42.443559 | 2026-09-10 11:03:42.443749 | TASK [helm-release-status : Gather get release status for helm charts] 2026-09-10 11:03:42.706896 | instance | /bin/bash: line 3: kubectl: command not found 2026-09-10 11:03:42.998287 | instance | ok: Runtime: 0:00:00.006588 2026-09-10 11:03:43.008669 | 2026-09-10 11:03:43.008845 | TASK [helm-release-status : Downloads logs to executor] 2026-09-10 11:03:43.538664 | instance | changed: 2026-09-10 11:03:43.538828 | instance | cd+++++++++ helm/ 2026-09-10 11:03:43.538867 | instance | cd+++++++++ helm/releases/ 2026-09-10 11:03:43.538896 | instance | cd+++++++++ helm/values/ 2026-09-10 11:03:43.550944 | 2026-09-10 11:03:43.551070 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-09-10 11:03:43.775941 | instance | changed 2026-09-10 11:03:43.788185 | 2026-09-10 11:03:43.788348 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-09-10 11:03:44.092471 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-10 11:03:44.093358 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-10 11:03:44.099889 | instance | environment: line 1: kubectl: command not found 2026-09-10 11:03:44.101128 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-10 11:03:44.103041 | instance | environment: line 1: kubectl: command not found 2026-09-10 11:03:44.104247 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-10 11:03:44.104850 | instance | environment: line 1: kubectl: command not found 2026-09-10 11:03:44.105961 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-10 11:03:44.109157 | instance | environment: line 1: kubectl: command not found 2026-09-10 11:03:44.109942 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-10 11:03:44.110961 | instance | environment: line 1: kubectl: command not found 2026-09-10 11:03:44.111499 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-10 11:03:44.331939 | instance | ok: Runtime: 0:00:00.028118 2026-09-10 11:03:44.339777 | 2026-09-10 11:03:44.339880 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-09-10 11:03:44.576135 | instance | changed 2026-09-10 11:03:44.584375 | 2026-09-10 11:03:44.584477 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-09-10 11:03:44.860452 | instance | environment: line 5: kubectl: command not found 2026-09-10 11:03:44.861963 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-10 11:03:44.862194 | instance | xargs: xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args valuewarning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-10 11:03:44.862210 | instance | 2026-09-10 11:03:45.131710 | instance | ok: Runtime: 0:00:00.010935 2026-09-10 11:03:45.136851 | 2026-09-10 11:03:45.136918 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-09-10 11:03:45.677913 | instance | changed: 2026-09-10 11:03:45.678155 | instance | cd+++++++++ objects/ 2026-09-10 11:03:45.678241 | instance | cd+++++++++ objects/cluster/ 2026-09-10 11:03:45.678528 | instance | cd+++++++++ objects/namespaced/ 2026-09-10 11:03:45.696568 | 2026-09-10 11:03:45.696737 | TASK [gather-pod-logs : creating directory for pod logs] 2026-09-10 11:03:45.913017 | instance | changed 2026-09-10 11:03:45.922974 | 2026-09-10 11:03:45.923100 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-09-10 11:03:46.148170 | instance | changed 2026-09-10 11:03:46.152713 | 2026-09-10 11:03:46.152791 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-09-10 11:03:46.393010 | instance | environment: line 3: kubectl: command not found 2026-09-10 11:03:46.687833 | instance | ok: Runtime: 0:00:00.010419 2026-09-10 11:03:46.697881 | 2026-09-10 11:03:46.698026 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-09-10 11:03:47.239956 | instance | changed: 2026-09-10 11:03:47.240226 | instance | cd+++++++++ pod-logs/ 2026-09-10 11:03:47.240378 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-09-10 11:03:47.254457 | 2026-09-10 11:03:47.254622 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-09-10 11:03:47.491726 | instance | changed 2026-09-10 11:03:47.497678 | 2026-09-10 11:03:47.497904 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-09-10 11:03:47.763180 | instance | /bin/bash: line 2: kubectl: command not found 2026-09-10 11:03:48.040240 | instance | ok: Runtime: 0:00:00.053476 2026-09-10 11:03:48.050085 | 2026-09-10 11:03:48.050302 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-09-10 11:03:48.307827 | instance | /bin/bash: line 2: kubectl: command not found 2026-09-10 11:03:48.355904 | instance | ceph-mgr endpoints: 2026-09-10 11:03:48.593796 | instance | ok: Runtime: 0:00:00.053499 2026-09-10 11:03:48.609938 | 2026-09-10 11:03:48.610189 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-09-10 11:03:48.888629 | instance | /bin/bash: line 4: kubectl: command not found 2026-09-10 11:03:49.167052 | instance | ok: Runtime: 0:00:00.056062 2026-09-10 11:03:49.181318 | 2026-09-10 11:03:49.181574 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-09-10 11:03:49.778105 | instance | changed: cd+++++++++ prometheus/ 2026-09-10 11:03:49.795683 | 2026-09-10 11:03:49.795866 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-09-10 11:03:50.043847 | instance | changed 2026-09-10 11:03:50.050577 | 2026-09-10 11:03:50.051169 | TASK [gather-selenium-data : Get selenium data] 2026-09-10 11:03:50.368469 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-09-10 11:03:50.369913 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-09-10 11:03:50.591700 | instance | ERROR 2026-09-10 11:03:50.592024 | instance | { 2026-09-10 11:03:50.592087 | instance | "delta": "0:00:00.007278", 2026-09-10 11:03:50.592131 | instance | "end": "2026-09-10 11:03:50.370296", 2026-09-10 11:03:50.592192 | instance | "msg": "non-zero return code", 2026-09-10 11:03:50.592264 | instance | "rc": 1, 2026-09-10 11:03:50.592301 | instance | "start": "2026-09-10 11:03:50.363018" 2026-09-10 11:03:50.592335 | instance | } 2026-09-10 11:03:50.592380 | instance | ERROR: Ignoring Errors 2026-09-10 11:03:50.602587 | 2026-09-10 11:03:50.602727 | TASK [gather-selenium-data : Downloads logs to executor] 2026-09-10 11:03:51.152433 | instance | changed: cd+++++++++ selenium/ 2026-09-10 11:03:51.163864 | 2026-09-10 11:03:51.164000 | PLAY RECAP 2026-09-10 11:03:51.164096 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-09-10 11:03:51.164145 | 2026-09-10 11:03:51.308424 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-09-10 11:03:51.314458 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-09-10 11:03:51.882108 | 2026-09-10 11:03:51.882337 | PLAY [all] 2026-09-10 11:03:51.900604 | 2026-09-10 11:03:51.900797 | TASK [fetch-output : Set log path for multiple nodes] 2026-09-10 11:03:51.966752 | instance | skipping: Conditional result was False 2026-09-10 11:03:51.974304 | 2026-09-10 11:03:51.974510 | TASK [fetch-output : Set log path for single node] 2026-09-10 11:03:52.025869 | instance | ok 2026-09-10 11:03:52.030498 | 2026-09-10 11:03:52.030630 | LOOP [fetch-output : Ensure local output dirs] 2026-09-10 11:03:52.487972 | instance -> localhost | ok: "/var/lib/zuul/builds/017f51773e4a47678bf84ea56ac4c1ba/work/logs" 2026-09-10 11:03:52.771826 | instance -> localhost | changed: "/var/lib/zuul/builds/017f51773e4a47678bf84ea56ac4c1ba/work/artifacts" 2026-09-10 11:03:52.998682 | instance -> localhost | changed: "/var/lib/zuul/builds/017f51773e4a47678bf84ea56ac4c1ba/work/docs" 2026-09-10 11:03:53.011298 | 2026-09-10 11:03:53.011503 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-10 11:03:53.763161 | instance | changed: .d..t...... ./ 2026-09-10 11:03:53.763528 | instance | changed: All items complete 2026-09-10 11:03:53.763590 | 2026-09-10 11:03:54.202124 | instance | changed: .d..t...... ./ 2026-09-10 11:03:54.704640 | instance | changed: .d..t...... ./ 2026-09-10 11:03:54.741142 | 2026-09-10 11:03:54.741334 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-10 11:03:55.289458 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.006849 2026-09-10 11:03:55.556545 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007071 2026-09-10 11:03:55.576992 | 2026-09-10 11:03:55.577158 | PLAY [all] 2026-09-10 11:03:55.589978 | 2026-09-10 11:03:55.590617 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-10 11:03:56.030480 | instance | changed 2026-09-10 11:03:56.039165 | 2026-09-10 11:03:56.039273 | PLAY RECAP 2026-09-10 11:03:56.039354 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-09-10 11:03:56.039401 | 2026-09-10 11:03:56.191503 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-09-10 11:03:56.195427 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-10 11:03:56.828356 | 2026-09-10 11:03:56.828491 | PLAY [localhost] 2026-09-10 11:03:56.838222 | 2026-09-10 11:03:56.838309 | TASK [Generate Zuul manifest] 2026-09-10 11:03:56.854748 | localhost | ok 2026-09-10 11:03:56.896397 | 2026-09-10 11:03:56.896605 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-10 11:03:57.303853 | localhost | changed 2026-09-10 11:03:57.325385 | 2026-09-10 11:03:57.325624 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-10 11:03:57.368952 | localhost | ok 2026-09-10 11:03:57.383403 | 2026-09-10 11:03:57.383586 | TASK [Upload logs] 2026-09-10 11:03:57.407648 | localhost | ok 2026-09-10 11:03:57.498198 | 2026-09-10 11:03:57.498351 | TASK [Set zuul-log-path fact] 2026-09-10 11:03:57.515911 | localhost | ok 2026-09-10 11:03:57.540608 | 2026-09-10 11:03:57.540723 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-10 11:03:57.569513 | localhost | ok 2026-09-10 11:03:57.579420 | 2026-09-10 11:03:57.580017 | TASK [upload-logs : Create log directories] 2026-09-10 11:03:58.023571 | localhost | changed 2026-09-10 11:03:58.027937 | 2026-09-10 11:03:58.028005 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-10 11:03:58.466948 | localhost -> localhost | ok: Runtime: 0:00:00.006609 2026-09-10 11:03:58.481712 | 2026-09-10 11:03:58.481950 | TASK [upload-logs : Upload logs to log server] 2026-09-10 11:03:58.989820 | localhost | Output suppressed because no_log was given 2026-09-10 11:03:59.037517 | 2026-09-10 11:03:59.037678 | LOOP [upload-logs : Compress console log and json output] 2026-09-10 11:03:59.077513 | localhost | skipping: Conditional result was False 2026-09-10 11:03:59.085642 | localhost | skipping: Conditional result was False 2026-09-10 11:03:59.097310 | 2026-09-10 11:03:59.097458 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-10 11:03:59.144362 | localhost | skipping: Conditional result was False 2026-09-10 11:03:59.144702 | 2026-09-10 11:03:59.148300 | localhost | skipping: Conditional result was False 2026-09-10 11:03:59.159973 | 2026-09-10 11:03:59.160152 | LOOP [upload-logs : Upload console log and json output]