2026-08-24 15:37:08.956663 | Job console starting 2026-08-24 15:37:08.971301 | Updating git repos 2026-08-24 15:37:09.476414 | Cloning repos into workspace 2026-08-24 15:37:25.012626 | Restoring repo states 2026-08-24 15:37:32.470638 | Merging changes 2026-08-24 15:37:33.834757 | Checking out repos 2026-08-24 15:37:36.381865 | Preparing playbooks 2026-08-24 15:37:39.170148 | Running Ansible setup 2026-08-24 15:37:43.041253 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-24 15:37:43.762785 | 2026-08-24 15:37:43.762968 | PLAY [localhost] 2026-08-24 15:37:43.772026 | 2026-08-24 15:37:43.772144 | TASK [Gathering Facts] 2026-08-24 15:37:44.684927 | localhost | ok 2026-08-24 15:37:44.697874 | 2026-08-24 15:37:44.698016 | TASK [Setup log path fact] 2026-08-24 15:37:44.721737 | localhost | ok 2026-08-24 15:37:44.734366 | 2026-08-24 15:37:44.734517 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-24 15:37:44.770030 | localhost | ok 2026-08-24 15:37:44.779344 | 2026-08-24 15:37:44.779446 | TASK [emit-job-header : Print job information] 2026-08-24 15:37:44.824373 | # Job Information 2026-08-24 15:37:44.824661 | Ansible Version: 2.16.18 2026-08-24 15:37:44.824740 | Job: atmosphere-molecule-csi-rbd 2026-08-24 15:37:44.824793 | Pipeline: check 2026-08-24 15:37:44.824840 | Executor: 2d72f0692154 2026-08-24 15:37:44.824887 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4093 2026-08-24 15:37:44.824941 | Event ID: 6d58aa50-9fcf-11f1-8705-660efa594237 2026-08-24 15:37:44.830193 | 2026-08-24 15:37:44.830272 | LOOP [emit-job-header : Print node information] 2026-08-24 15:37:44.925106 | localhost | ok: 2026-08-24 15:37:44.925796 | localhost | # Node Information 2026-08-24 15:37:44.925851 | localhost | Inventory Hostname: instance 2026-08-24 15:37:44.925886 | localhost | Hostname: np0000190924 2026-08-24 15:37:44.925916 | localhost | Username: zuul 2026-08-24 15:37:44.925949 | localhost | Distro: Ubuntu 22.04 2026-08-24 15:37:44.925979 | localhost | Provider: yul1 2026-08-24 15:37:44.926009 | localhost | Region: ca-ymq-1 2026-08-24 15:37:44.926037 | localhost | Label: ubuntu-jammy 2026-08-24 15:37:44.926065 | localhost | Product Name: OpenStack Nova 2026-08-24 15:37:44.926094 | localhost | Interface IP: 199.19.213.27 2026-08-24 15:37:44.940344 | 2026-08-24 15:37:44.940538 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-24 15:37:45.336029 | localhost -> localhost | changed 2026-08-24 15:37:45.342674 | 2026-08-24 15:37:45.342810 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-24 15:37:46.221589 | localhost -> localhost | changed 2026-08-24 15:37:46.229748 | 2026-08-24 15:37:46.230034 | PLAY [all] 2026-08-24 15:37:46.240191 | 2026-08-24 15:37:46.240281 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-24 15:37:46.466901 | instance -> localhost | ok 2026-08-24 15:37:46.475350 | 2026-08-24 15:37:46.475465 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-24 15:37:46.509614 | instance | ok 2026-08-24 15:37:46.524667 | instance | included: /var/lib/zuul/builds/9527653448374108b249b2400ffb5da4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-24 15:37:46.530533 | 2026-08-24 15:37:46.530593 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-24 15:37:47.532938 | instance -> localhost | Generating public/private rsa key pair. 2026-08-24 15:37:47.533142 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/9527653448374108b249b2400ffb5da4/work/9527653448374108b249b2400ffb5da4_id_rsa 2026-08-24 15:37:47.533187 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/9527653448374108b249b2400ffb5da4/work/9527653448374108b249b2400ffb5da4_id_rsa.pub 2026-08-24 15:37:47.533221 | instance -> localhost | The key fingerprint is: 2026-08-24 15:37:47.533252 | instance -> localhost | SHA256:+BeGqvnW3mihllddjQnghaPIx9Qo6k5MaJns8vv5B5U zuul-build-sshkey 2026-08-24 15:37:47.533296 | instance -> localhost | The key's randomart image is: 2026-08-24 15:37:47.533328 | instance -> localhost | +---[RSA 3072]----+ 2026-08-24 15:37:47.533364 | instance -> localhost | | o.o. | 2026-08-24 15:37:47.533396 | instance -> localhost | | . o.+.. | 2026-08-24 15:37:47.533426 | instance -> localhost | | . + o = o.. . + | 2026-08-24 15:37:47.533457 | instance -> localhost | | * o o.E. + .| 2026-08-24 15:37:47.533486 | instance -> localhost | | o + .oS o. . | 2026-08-24 15:37:47.533516 | instance -> localhost | |. . + .o..... | 2026-08-24 15:37:47.533545 | instance -> localhost | | o o .=.o. | 2026-08-24 15:37:47.533575 | instance -> localhost | | . .+= =+ | 2026-08-24 15:37:47.533609 | instance -> localhost | | .o==o=o . | 2026-08-24 15:37:47.533639 | instance -> localhost | +----[SHA256]-----+ 2026-08-24 15:37:47.533702 | instance -> localhost | ok: Runtime: 0:00:00.536140 2026-08-24 15:37:47.542054 | 2026-08-24 15:37:47.542123 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-24 15:37:47.576542 | instance | ok 2026-08-24 15:37:47.586389 | instance | included: /var/lib/zuul/builds/9527653448374108b249b2400ffb5da4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-24 15:37:47.595747 | 2026-08-24 15:37:47.595885 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-24 15:37:47.620555 | instance | skipping: Conditional result was False 2026-08-24 15:37:47.630021 | 2026-08-24 15:37:47.630140 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-24 15:37:48.107410 | instance | changed 2026-08-24 15:37:48.115645 | 2026-08-24 15:37:48.115732 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-24 15:37:48.333047 | instance | ok 2026-08-24 15:37:48.339463 | 2026-08-24 15:37:48.339569 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-24 15:37:48.870640 | instance | changed 2026-08-24 15:37:48.875999 | 2026-08-24 15:37:48.876109 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-24 15:37:49.369037 | instance | changed 2026-08-24 15:37:49.376845 | 2026-08-24 15:37:49.376948 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-24 15:37:49.402753 | instance | skipping: Conditional result was False 2026-08-24 15:37:49.414984 | 2026-08-24 15:37:49.415090 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-24 15:37:49.819390 | instance -> localhost | changed 2026-08-24 15:37:49.836109 | 2026-08-24 15:37:49.836229 | TASK [add-build-sshkey : Add back temp key] 2026-08-24 15:37:50.125322 | instance -> localhost | Identity added: /var/lib/zuul/builds/9527653448374108b249b2400ffb5da4/work/9527653448374108b249b2400ffb5da4_id_rsa (zuul-build-sshkey) 2026-08-24 15:37:50.125572 | instance -> localhost | ok: Runtime: 0:00:00.015577 2026-08-24 15:37:50.133857 | 2026-08-24 15:37:50.134003 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-24 15:37:50.561873 | instance | ok 2026-08-24 15:37:50.568830 | 2026-08-24 15:37:50.569032 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-24 15:37:50.605619 | instance | skipping: Conditional result was False 2026-08-24 15:37:50.622677 | 2026-08-24 15:37:50.622875 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-08-24 15:37:50.984253 | instance | ok 2026-08-24 15:37:50.995490 | 2026-08-24 15:37:50.995613 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-08-24 15:37:55.113180 | instance | Output suppressed because no_log was given 2026-08-24 15:37:55.127150 | 2026-08-24 15:37:55.127310 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-08-24 15:37:55.324316 | instance | ok: "logs" 2026-08-24 15:37:55.324582 | instance | ok: All items complete 2026-08-24 15:37:55.324621 | 2026-08-24 15:37:55.496644 | instance | ok: "artifacts" 2026-08-24 15:37:55.650748 | instance | ok: "docs" 2026-08-24 15:37:55.674488 | 2026-08-24 15:37:55.674702 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-08-24 15:37:55.872573 | instance | changed: "logs" 2026-08-24 15:37:56.042472 | instance | changed: "artifacts" 2026-08-24 15:37:56.242155 | instance | changed: "docs" 2026-08-24 15:37:56.259918 | 2026-08-24 15:37:56.260026 | PLAY RECAP 2026-08-24 15:37:56.260092 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-08-24 15:37:56.260136 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-24 15:37:56.260176 | 2026-08-24 15:37:56.399204 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-24 15:37:56.401799 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-24 15:37:57.226358 | 2026-08-24 15:37:57.226542 | PLAY [all] 2026-08-24 15:37:57.237688 | 2026-08-24 15:37:57.237805 | TASK [setup-uv : Extract archive] 2026-08-24 15:37:59.632719 | instance | changed 2026-08-24 15:37:59.644938 | 2026-08-24 15:37:59.645204 | TASK [setup-uv : Print version] 2026-08-24 15:38:00.008852 | instance | uv 0.8.13 2026-08-24 15:38:00.199873 | instance | ok: Runtime: 0:00:00.011139 2026-08-24 15:38:00.215326 | 2026-08-24 15:38:00.215463 | TASK [Install Ansible collection siblings] 2026-08-24 15:38:10.600796 | instance | changed: 2026-08-24 15:38:10.601174 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-08-24 15:38:10.601593 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-08-24 15:38:10.601678 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-08-24 15:38:10.601741 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto 2026-08-24 15:38:10.601772 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general 2026-08-24 15:38:10.601801 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql 2026-08-24 15:38:10.601851 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-08-24 15:38:10.601881 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-08-24 15:38:10.601941 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-08-24 15:38:10.601966 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-08-24 15:38:10.601989 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-08-24 15:38:10.602010 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-08-24 15:38:10.602071 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0 2026-08-24 15:38:10.602100 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0 2026-08-24 15:38:10.602122 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0 2026-08-24 15:38:10.602144 | instance | Resolved community.crypto to 2.2.3 for 2.2.3 2026-08-24 15:38:10.602165 | instance | Resolved community.general to 7.3.0 for 7.3.0 2026-08-24 15:38:10.602207 | instance | Resolved community.mysql to 3.6.0 for 3.6.0 2026-08-24 15:38:10.602254 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0 2026-08-24 15:38:10.602283 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0 2026-08-24 15:38:10.602334 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0 2026-08-24 15:38:10.602362 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0 2026-08-24 15:38:10.602428 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-08-24 15:38:10.602467 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0 2026-08-24 15:38:10.602489 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0 2026-08-24 15:38:10.602529 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-08-24 15:38:10.602553 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-08-24 15:38:10.602597 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-08-24 15:38:10.602621 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0 2026-08-24 15:38:10.602640 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3 2026-08-24 15:38:10.602659 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-08-24 15:38:10.602680 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-08-24 15:38:10.602699 | instance | Checked out ansible.netcommon to 1.2.0 2026-08-24 15:38:10.602718 | 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-08-24 15:38:10.602744 | instance | Starting galaxy collection install process 2026-08-24 15:38:10.602764 | instance | Process install dependency map 2026-08-24 15:38:10.602782 | instance | Starting collection install process 2026-08-24 15:38:10.602802 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon' 2026-08-24 15:38:10.602838 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon 2026-08-24 15:38:10.602879 | instance | ansible.netcommon:* was installed successfully 2026-08-24 15:38:10.602903 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-08-24 15:38:10.602947 | instance | Creating virtual environment at: .venv 2026-08-24 15:38:10.602971 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-08-24 15:38:10.602991 | instance | Downloading pygments (1.2MiB) 2026-08-24 15:38:10.603010 | instance | Downloading netaddr (2.2MiB) 2026-08-24 15:38:10.603056 | instance | Downloading setuptools (1.1MiB) 2026-08-24 15:38:10.603080 | instance | Downloading kubernetes (1.9MiB) 2026-08-24 15:38:10.603128 | instance | Downloading openstacksdk (1.7MiB) 2026-08-24 15:38:10.603151 | instance | Downloading ansible-core (2.1MiB) 2026-08-24 15:38:10.603200 | instance | Downloading cryptography (4.2MiB) 2026-08-24 15:38:10.603246 | instance | Downloading rjsonnet (1.2MiB) 2026-08-24 15:38:10.603269 | instance | Building pyperclip==1.9.0 2026-08-24 15:38:10.603319 | instance | Downloading rjsonnet 2026-08-24 15:38:10.603344 | instance | Downloading netaddr 2026-08-24 15:38:10.603364 | instance | Downloading pygments 2026-08-24 15:38:10.603384 | instance | Downloading cryptography 2026-08-24 15:38:10.603442 | instance | Downloading setuptools 2026-08-24 15:38:10.603468 | instance | Downloading kubernetes 2026-08-24 15:38:10.603521 | instance | Downloading ansible-core 2026-08-24 15:38:10.603548 | instance | Downloading openstacksdk 2026-08-24 15:38:10.603568 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-08-24 15:38:10.603618 | instance | Built pyperclip==1.9.0 2026-08-24 15:38:10.603640 | instance | Installed 79 packages in 98ms 2026-08-24 15:38:10.603663 | instance | Checked out ansible.posix to 1.6.0 2026-08-24 15:38:10.603682 | 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-08-24 15:38:10.603702 | instance | Starting galaxy collection install process 2026-08-24 15:38:10.603747 | instance | Process install dependency map 2026-08-24 15:38:10.603767 | instance | Starting collection install process 2026-08-24 15:38:10.603822 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-08-24 15:38:10.603881 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix 2026-08-24 15:38:10.603907 | instance | ansible.posix:1.6.0 was installed successfully 2026-08-24 15:38:10.603945 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 15:38:10.603987 | instance | 2.17.12 2026-08-24 15:38:10.604008 | instance | Checked out ansible.utils to v6.1.0 2026-08-24 15:38:10.604055 | 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-08-24 15:38:10.604076 | instance | Starting galaxy collection install process 2026-08-24 15:38:10.604171 | instance | Process install dependency map 2026-08-24 15:38:10.604194 | instance | Starting collection install process 2026-08-24 15:38:10.604242 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils' 2026-08-24 15:38:10.604278 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils 2026-08-24 15:38:10.604324 | instance | ansible.utils:6.1.0 was installed successfully 2026-08-24 15:38:10.604346 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 15:38:10.604404 | instance | 2.17.12 2026-08-24 15:38:10.604429 | instance | Checked out atmosphere.common to v0.7.0 2026-08-24 15:38:10.604467 | 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-08-24 15:38:10.604509 | instance | Starting galaxy collection install process 2026-08-24 15:38:10.604529 | instance | Process install dependency map 2026-08-24 15:38:10.604575 | instance | Starting collection install process 2026-08-24 15:38:10.604595 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common' 2026-08-24 15:38:10.604647 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common 2026-08-24 15:38:10.604673 | instance | atmosphere.common:0.7.0 was installed successfully 2026-08-24 15:38:10.604693 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 15:38:10.604739 | instance | 2.17.12 2026-08-24 15:38:10.604759 | instance | Checked out community.crypto to 2.2.3 2026-08-24 15:38:10.604779 | 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-08-24 15:38:10.604798 | instance | Starting galaxy collection install process 2026-08-24 15:38:10.604817 | instance | Process install dependency map 2026-08-24 15:38:10.604852 | instance | Starting collection install process 2026-08-24 15:38:10.604895 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-08-24 15:38:10.604915 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto 2026-08-24 15:38:10.604986 | instance | community.crypto:2.2.3 was installed successfully 2026-08-24 15:38:10.605009 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 15:38:10.605028 | instance | 2.17.12 2026-08-24 15:38:10.605049 | instance | Checked out community.general to 7.3.0 2026-08-24 15:38:10.605068 | 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-08-24 15:38:10.605109 | instance | Starting galaxy collection install process 2026-08-24 15:38:10.605157 | instance | Process install dependency map 2026-08-24 15:38:10.605200 | instance | Starting collection install process 2026-08-24 15:38:10.605259 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-08-24 15:38:10.605283 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general 2026-08-24 15:38:10.605327 | instance | community.general:7.3.0 was installed successfully 2026-08-24 15:38:10.605353 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 15:38:10.605373 | instance | 2.17.12 2026-08-24 15:38:10.605393 | instance | Checked out community.mysql to 3.6.0 2026-08-24 15:38:10.605414 | 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-08-24 15:38:10.605434 | instance | Starting galaxy collection install process 2026-08-24 15:38:10.605494 | instance | Process install dependency map 2026-08-24 15:38:10.605521 | instance | Starting collection install process 2026-08-24 15:38:10.605562 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql' 2026-08-24 15:38:10.605588 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql 2026-08-24 15:38:10.605607 | instance | community.mysql:3.6.0 was installed successfully 2026-08-24 15:38:10.605644 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 15:38:10.605671 | instance | 2.17.12 2026-08-24 15:38:10.605747 | instance | Checked out kubernetes.core to 2.4.0 2026-08-24 15:38:10.605802 | 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-08-24 15:38:10.605847 | instance | Starting galaxy collection install process 2026-08-24 15:38:10.605891 | instance | Process install dependency map 2026-08-24 15:38:10.605918 | instance | Starting collection install process 2026-08-24 15:38:10.605954 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core' 2026-08-24 15:38:10.605996 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core 2026-08-24 15:38:10.606017 | instance | kubernetes.core:2.4.0 was installed successfully 2026-08-24 15:38:10.606066 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 15:38:10.606088 | instance | 2.17.12 2026-08-24 15:38:10.606142 | instance | Checked out openstack.cloud to 2.6.0 2026-08-24 15:38:10.606167 | 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-08-24 15:38:10.606206 | instance | Starting galaxy collection install process 2026-08-24 15:38:10.606233 | instance | Process install dependency map 2026-08-24 15:38:10.606253 | instance | Starting collection install process 2026-08-24 15:38:10.606309 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud' 2026-08-24 15:38:10.606332 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud 2026-08-24 15:38:10.606373 | instance | openstack.cloud:2.6.0 was installed successfully 2026-08-24 15:38:10.606397 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 15:38:10.606416 | instance | 2.17.12 2026-08-24 15:38:10.606436 | instance | Checked out vexxhost.ceph to v4.2.0 2026-08-24 15:38:10.606455 | 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-08-24 15:38:10.606520 | instance | Starting galaxy collection install process 2026-08-24 15:38:10.606545 | instance | Process install dependency map 2026-08-24 15:38:10.606565 | instance | Starting collection install process 2026-08-24 15:38:10.606621 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph' 2026-08-24 15:38:10.606646 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph 2026-08-24 15:38:10.606689 | instance | vexxhost.ceph:4.2.0 was installed successfully 2026-08-24 15:38:10.606715 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 15:38:10.606734 | instance | 2.17.12 2026-08-24 15:38:10.606754 | instance | Checked out vexxhost.containers to v1.6.8 2026-08-24 15:38:10.606774 | 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-08-24 15:38:10.606809 | instance | Starting galaxy collection install process 2026-08-24 15:38:10.606856 | instance | Process install dependency map 2026-08-24 15:38:10.606879 | instance | Starting collection install process 2026-08-24 15:38:10.606900 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers' 2026-08-24 15:38:10.606920 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers 2026-08-24 15:38:10.606939 | instance | vexxhost.containers:1.6.8 was installed successfully 2026-08-24 15:38:10.606958 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 15:38:10.606998 | instance | 2.17.12 2026-08-24 15:38:10.607040 | instance | Checked out vexxhost.kubernetes to v3.3.0 2026-08-24 15:38:10.607061 | 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-08-24 15:38:10.607109 | instance | Starting galaxy collection install process 2026-08-24 15:38:10.607129 | instance | Process install dependency map 2026-08-24 15:38:10.607148 | instance | Starting collection install process 2026-08-24 15:38:10.607167 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes' 2026-08-24 15:38:10.607202 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes 2026-08-24 15:38:10.607247 | instance | vexxhost.kubernetes:3.3.0 was installed successfully 2026-08-24 15:38:10.607284 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 15:38:10.607326 | instance | 2.17.12 2026-08-24 15:38:10.614552 | 2026-08-24 15:38:10.614605 | PLAY RECAP 2026-08-24 15:38:10.614651 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-24 15:38:10.614674 | 2026-08-24 15:38:10.839946 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-24 15:38:10.844390 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-08-24 15:38:11.505371 | 2026-08-24 15:38:11.680186 | PLAY [all] 2026-08-24 15:38:11.706512 | 2026-08-24 15:38:11.706772 | TASK [Install "jq" for log collection] 2026-08-24 15:38:23.387615 | instance | changed 2026-08-24 15:38:23.389320 | 2026-08-24 15:38:23.389381 | PLAY RECAP 2026-08-24 15:38:23.389430 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-24 15:38:23.389480 | 2026-08-24 15:38:23.511816 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-08-24 15:38:23.588339 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-24 15:38:24.233625 | 2026-08-24 15:38:24.233822 | PLAY [all] 2026-08-24 15:38:24.247573 | 2026-08-24 15:38:24.247719 | LOOP [Check inventory directories] 2026-08-24 15:38:24.595581 | instance | ok: "src/github.com/vexxhost/atmosphere" 2026-08-24 15:38:24.739808 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory" 2026-08-24 15:38:24.910642 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory" 2026-08-24 15:38:24.928794 | 2026-08-24 15:38:24.929115 | LOOP [Copy inventory file for Zuul] 2026-08-24 15:38:25.781987 | instance | changed: 2026-08-24 15:38:25.782344 | instance | { 2026-08-24 15:38:25.782411 | instance | "ansible_loop_var": "item", 2026-08-24 15:38:25.782447 | instance | "changed": false, 2026-08-24 15:38:25.782476 | instance | "failed": false, 2026-08-24 15:38:25.782512 | instance | "invocation": { 2026-08-24 15:38:25.782539 | instance | "module_args": { 2026-08-24 15:38:25.782565 | instance | "checksum_algorithm": "sha1", 2026-08-24 15:38:25.782590 | instance | "follow": true, 2026-08-24 15:38:25.782615 | instance | "get_attributes": true, 2026-08-24 15:38:25.782641 | instance | "get_checksum": true, 2026-08-24 15:38:25.782665 | instance | "get_mime": true, 2026-08-24 15:38:25.782689 | instance | "path": "src/github.com/vexxhost/atmosphere" 2026-08-24 15:38:25.782714 | instance | } 2026-08-24 15:38:25.782737 | instance | }, 2026-08-24 15:38:25.782761 | instance | "item": "src/github.com/vexxhost/atmosphere", 2026-08-24 15:38:25.782785 | instance | "stat": { 2026-08-24 15:38:25.782809 | instance | "atime": 1787585882.1930342, 2026-08-24 15:38:25.782833 | instance | "attr_flags": "e", 2026-08-24 15:38:25.782857 | instance | "attributes": [ 2026-08-24 15:38:25.782882 | instance | "extents" 2026-08-24 15:38:25.782906 | instance | ], 2026-08-24 15:38:25.782930 | instance | "block_size": 4096, 2026-08-24 15:38:25.782954 | instance | "blocks": 8, 2026-08-24 15:38:25.782977 | instance | "charset": "unknown", 2026-08-24 15:38:25.783004 | instance | "ctime": 1787585881.033001, 2026-08-24 15:38:25.783029 | instance | "dev": 64513, 2026-08-24 15:38:25.783053 | instance | "device_type": 0, 2026-08-24 15:38:25.783077 | instance | "executable": true, 2026-08-24 15:38:25.783100 | instance | "exists": true, 2026-08-24 15:38:25.783124 | instance | "gid": 1000, 2026-08-24 15:38:25.783147 | instance | "gr_name": "zuul", 2026-08-24 15:38:25.783170 | instance | "inode": 1047280, 2026-08-24 15:38:25.783194 | instance | "isblk": false, 2026-08-24 15:38:25.783218 | instance | "ischr": false, 2026-08-24 15:38:25.783241 | instance | "isdir": true, 2026-08-24 15:38:25.783265 | instance | "isfifo": false, 2026-08-24 15:38:25.783288 | instance | "isgid": false, 2026-08-24 15:38:25.783311 | instance | "islnk": false, 2026-08-24 15:38:25.783335 | instance | "isreg": false, 2026-08-24 15:38:25.783358 | instance | "issock": false, 2026-08-24 15:38:25.783381 | instance | "isuid": false, 2026-08-24 15:38:25.783404 | instance | "mimetype": "unknown", 2026-08-24 15:38:25.783435 | instance | "mode": "0755", 2026-08-24 15:38:25.783490 | instance | "mtime": 1787585881.033001, 2026-08-24 15:38:25.783525 | instance | "nlink": 22, 2026-08-24 15:38:25.783551 | instance | "path": "src/github.com/vexxhost/atmosphere", 2026-08-24 15:38:25.783575 | instance | "pw_name": "zuul", 2026-08-24 15:38:25.783604 | instance | "readable": true, 2026-08-24 15:38:25.783628 | instance | "rgrp": true, 2026-08-24 15:38:25.783652 | instance | "roth": true, 2026-08-24 15:38:25.783676 | instance | "rusr": true, 2026-08-24 15:38:25.783701 | instance | "size": 4096, 2026-08-24 15:38:25.783725 | instance | "uid": 1000, 2026-08-24 15:38:25.783763 | instance | "version": "84172025", 2026-08-24 15:38:25.783789 | instance | "wgrp": false, 2026-08-24 15:38:25.783815 | instance | "woth": false, 2026-08-24 15:38:25.783840 | instance | "writeable": true, 2026-08-24 15:38:25.783864 | instance | "wusr": true, 2026-08-24 15:38:25.783888 | instance | "xgrp": true, 2026-08-24 15:38:25.783912 | instance | "xoth": true, 2026-08-24 15:38:25.783936 | instance | "xusr": true 2026-08-24 15:38:25.783959 | instance | } 2026-08-24 15:38:25.783984 | instance | } 2026-08-24 15:38:25.784065 | instance | ok: All items complete 2026-08-24 15:38:25.784103 | 2026-08-24 15:38:25.785841 | instance | skipping: Conditional result was False 2026-08-24 15:38:25.786643 | instance | skipping: Conditional result was False 2026-08-24 15:38:25.802190 | 2026-08-24 15:38:25.802377 | LOOP [Switch "ansible_host" to private IP] 2026-08-24 15:38:26.218628 | instance | changed: 1 replacements made 2026-08-24 15:38:26.221055 | instance | skipping: Conditional result was False 2026-08-24 15:38:26.227546 | instance | skipping: Conditional result was False 2026-08-24 15:38:26.244567 | 2026-08-24 15:38:26.244715 | TASK [Run Molecule scenario] 2026-08-24 15:38:27.224503 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-08-24 15:38:27.622872 | instance | INFO [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-08-24 15:38:27.622989 | instance | INFO [csi > prerun] Performing prerun with role_name_check=0... 2026-08-24 15:38:39.207605 | instance | INFO [csi > dependency] Executing 2026-08-24 15:38:39.207792 | instance | WARNING [csi > dependency] Missing roles requirements file: requirements.yml 2026-08-24 15:38:39.208006 | instance | WARNING [csi > dependency] Missing collections requirements file: collections.yml 2026-08-24 15:38:39.208138 | instance | WARNING [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-08-24 15:38:39.215720 | instance | INFO [csi > cleanup] Executing 2026-08-24 15:38:39.216047 | instance | WARNING [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-24 15:38:39.223505 | instance | INFO [csi > destroy] Executing 2026-08-24 15:38:39.223589 | instance | WARNING [csi > destroy] Skipping, '--destroy=never' requested. 2026-08-24 15:38:39.223666 | instance | INFO [csi > destroy] Executed: Successful 2026-08-24 15:38:39.230917 | instance | INFO [csi > syntax] Executing 2026-08-24 15:38:40.910298 | instance | 2026-08-24 15:38:40.910648 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-08-24 15:38:40.974094 | instance | INFO [csi > syntax] Executed: Successful 2026-08-24 15:38:40.987337 | instance | INFO [csi > create] Executing 2026-08-24 15:38:40.990387 | instance | WARNING [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-24 15:38:40.998847 | instance | INFO [csi > prepare] Executing 2026-08-24 15:38:41.852460 | instance | 2026-08-24 15:38:41.852845 | instance | PLAY [Prepare] ***************************************************************** 2026-08-24 15:38:41.853131 | instance | 2026-08-24 15:38:41.853452 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-24 15:38:41.853820 | instance | Monday 24 August 2026 15:38:41 +0000 (0:00:00.026) 0:00:00.026 ********* 2026-08-24 15:38:43.110076 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-08-24 15:38:43.110359 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-08-24 15:38:43.110658 | instance | interpreter could change the meaning of that path. See 2026-08-24 15:38:43.110914 | instance | https://docs.ansible.com/ansible- 2026-08-24 15:38:43.111203 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-08-24 15:38:43.119089 | instance | ok: [instance] 2026-08-24 15:38:43.119414 | instance | 2026-08-24 15:38:43.119622 | instance | TASK [Configure short hostname] ************************************************ 2026-08-24 15:38:43.119902 | instance | Monday 24 August 2026 15:38:43 +0000 (0:00:01.267) 0:00:01.294 ********* 2026-08-24 15:38:44.013046 | instance | changed: [instance] 2026-08-24 15:38:44.013228 | instance | 2026-08-24 15:38:44.013531 | instance | TASK [Ensure hostname inside hosts file] *************************************** 2026-08-24 15:38:44.013822 | instance | Monday 24 August 2026 15:38:44 +0000 (0:00:00.893) 0:00:02.187 ********* 2026-08-24 15:38:44.305402 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created 2026-08-24 15:38:44.305790 | instance | with a mode of 0700, this may cause issues when running as another user. To 2026-08-24 15:38:44.306104 | instance | avoid this, create the remote_tmp dir with the correct permissions manually 2026-08-24 15:38:44.316466 | instance | changed: [instance] 2026-08-24 15:38:44.316789 | instance | 2026-08-24 15:38:44.317128 | instance | TASK [Purge "snapd" package] *************************************************** 2026-08-24 15:38:44.317408 | instance | Monday 24 August 2026 15:38:44 +0000 (0:00:00.303) 0:00:02.491 ********* 2026-08-24 15:38:45.146010 | instance | ok: [instance] 2026-08-24 15:38:45.146297 | instance | 2026-08-24 15:38:45.146637 | instance | PLAY [Create devices for Ceph] ************************************************* 2026-08-24 15:38:45.146907 | instance | 2026-08-24 15:38:45.147189 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-24 15:38:45.147562 | instance | Monday 24 August 2026 15:38:45 +0000 (0:00:00.829) 0:00:03.320 ********* 2026-08-24 15:38:45.844528 | instance | ok: [instance] 2026-08-24 15:38:45.844822 | instance | 2026-08-24 15:38:45.845139 | instance | TASK [Install depedencies] ***************************************************** 2026-08-24 15:38:45.845463 | instance | Monday 24 August 2026 15:38:45 +0000 (0:00:00.698) 0:00:04.019 ********* 2026-08-24 15:39:18.975433 | instance | changed: [instance] 2026-08-24 15:39:18.975722 | instance | 2026-08-24 15:39:18.976095 | instance | TASK [Start up service] ******************************************************** 2026-08-24 15:39:18.976476 | instance | Monday 24 August 2026 15:39:18 +0000 (0:00:33.130) 0:00:37.149 ********* 2026-08-24 15:39:19.569292 | instance | ok: [instance] 2026-08-24 15:39:19.569563 | instance | 2026-08-24 15:39:19.569892 | instance | TASK [Generate lvm.conf] ******************************************************* 2026-08-24 15:39:19.570198 | instance | Monday 24 August 2026 15:39:19 +0000 (0:00:00.594) 0:00:37.743 ********* 2026-08-24 15:39:19.902856 | instance | ok: [instance] 2026-08-24 15:39:19.903079 | instance | 2026-08-24 15:39:19.903370 | instance | TASK [Write /etc/lvm/lvm.conf] ************************************************* 2026-08-24 15:39:19.903661 | instance | Monday 24 August 2026 15:39:19 +0000 (0:00:00.333) 0:00:38.077 ********* 2026-08-24 15:39:20.654044 | instance | changed: [instance] 2026-08-24 15:39:20.654449 | instance | 2026-08-24 15:39:20.654813 | instance | TASK [Get list of all loopback devices] **************************************** 2026-08-24 15:39:20.655165 | instance | Monday 24 August 2026 15:39:20 +0000 (0:00:00.751) 0:00:38.829 ********* 2026-08-24 15:39:20.853349 | instance | ok: [instance] 2026-08-24 15:39:20.853508 | instance | 2026-08-24 15:39:20.853780 | instance | TASK [Fail if there is any existing loopback devices] ************************** 2026-08-24 15:39:20.854010 | instance | Monday 24 August 2026 15:39:20 +0000 (0:00:00.199) 0:00:39.028 ********* 2026-08-24 15:39:20.881068 | instance | skipping: [instance] 2026-08-24 15:39:20.881498 | instance | 2026-08-24 15:39:20.881947 | instance | TASK [Create devices for Ceph] ************************************************* 2026-08-24 15:39:20.882349 | instance | Monday 24 August 2026 15:39:20 +0000 (0:00:00.027) 0:00:39.055 ********* 2026-08-24 15:39:21.445326 | instance | changed: [instance] => (item=osd0) 2026-08-24 15:39:21.445419 | instance | changed: [instance] => (item=osd1) 2026-08-24 15:39:21.445638 | instance | changed: [instance] => (item=osd2) 2026-08-24 15:39:21.445892 | instance | 2026-08-24 15:39:21.446110 | instance | TASK [Set permissions on loopback devices] ************************************* 2026-08-24 15:39:21.446390 | instance | Monday 24 August 2026 15:39:21 +0000 (0:00:00.562) 0:00:39.618 ********* 2026-08-24 15:39:22.096983 | instance | changed: [instance] => (item=osd0) 2026-08-24 15:39:22.097394 | instance | changed: [instance] => (item=osd1) 2026-08-24 15:39:22.097419 | instance | changed: [instance] => (item=osd2) 2026-08-24 15:39:22.097430 | instance | 2026-08-24 15:39:22.097440 | instance | TASK [Start loop devices] ****************************************************** 2026-08-24 15:39:22.097641 | instance | Monday 24 August 2026 15:39:22 +0000 (0:00:00.653) 0:00:40.271 ********* 2026-08-24 15:39:22.848304 | instance | changed: [instance] => (item=osd0) 2026-08-24 15:39:22.848427 | instance | changed: [instance] => (item=osd1) 2026-08-24 15:39:22.848746 | instance | changed: [instance] => (item=osd2) 2026-08-24 15:39:22.848835 | instance | 2026-08-24 15:39:22.848961 | instance | TASK [Create a volume group for each loop device] ****************************** 2026-08-24 15:39:22.849132 | instance | Monday 24 August 2026 15:39:22 +0000 (0:00:00.751) 0:00:41.023 ********* 2026-08-24 15:39:26.157025 | instance | changed: [instance] => (item=osd0) 2026-08-24 15:39:26.157217 | instance | changed: [instance] => (item=osd1) 2026-08-24 15:39:26.157443 | instance | changed: [instance] => (item=osd2) 2026-08-24 15:39:26.157665 | instance | 2026-08-24 15:39:26.157904 | instance | TASK [Create a logical volume for each loop device] **************************** 2026-08-24 15:39:26.158171 | instance | Monday 24 August 2026 15:39:26 +0000 (0:00:03.308) 0:00:44.331 ********* 2026-08-24 15:39:28.060414 | instance | changed: [instance] => (item=ceph-instance-osd0) 2026-08-24 15:39:28.060496 | instance | changed: [instance] => (item=ceph-instance-osd1) 2026-08-24 15:39:28.060530 | instance | changed: [instance] => (item=ceph-instance-osd2) 2026-08-24 15:39:28.060541 | instance | 2026-08-24 15:39:28.060551 | instance | PLAY RECAP ********************************************************************* 2026-08-24 15:39:28.060562 | instance | instance : ok=15 changed=9 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-08-24 15:39:28.060581 | instance | 2026-08-24 15:39:28.060901 | instance | Monday 24 August 2026 15:39:28 +0000 (0:00:01.901) 0:00:46.233 ********* 2026-08-24 15:39:28.061277 | instance | =============================================================================== 2026-08-24 15:39:28.061736 | instance | Install depedencies ---------------------------------------------------- 33.13s 2026-08-24 15:39:28.062110 | instance | Create a volume group for each loop device ------------------------------ 3.31s 2026-08-24 15:39:28.062709 | instance | Create a logical volume for each loop device ---------------------------- 1.90s 2026-08-24 15:39:28.062934 | instance | Gathering Facts --------------------------------------------------------- 1.27s 2026-08-24 15:39:28.063159 | instance | Configure short hostname ------------------------------------------------ 0.89s 2026-08-24 15:39:28.063388 | instance | Purge "snapd" package --------------------------------------------------- 0.83s 2026-08-24 15:39:28.063803 | instance | Start loop devices ------------------------------------------------------ 0.75s 2026-08-24 15:39:28.064038 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.75s 2026-08-24 15:39:28.064278 | instance | Gathering Facts --------------------------------------------------------- 0.70s 2026-08-24 15:39:28.064521 | instance | Set permissions on loopback devices ------------------------------------- 0.65s 2026-08-24 15:39:28.064819 | instance | Start up service -------------------------------------------------------- 0.59s 2026-08-24 15:39:28.065062 | instance | Create devices for Ceph ------------------------------------------------- 0.56s 2026-08-24 15:39:28.065306 | instance | Generate lvm.conf ------------------------------------------------------- 0.33s 2026-08-24 15:39:28.065671 | instance | Ensure hostname inside hosts file --------------------------------------- 0.30s 2026-08-24 15:39:28.065834 | instance | Get list of all loopback devices ---------------------------------------- 0.20s 2026-08-24 15:39:28.066069 | instance | Fail if there is any existing loopback devices -------------------------- 0.03s 2026-08-24 15:39:28.140500 | instance | INFO [csi > prepare] Executed: Successful 2026-08-24 15:39:28.151738 | instance | INFO [csi > converge] Executing 2026-08-24 15:39:29.845288 | instance | 2026-08-24 15:39:29.845464 | instance | PLAY [Debug CSI driver value] ************************************************** 2026-08-24 15:39:29.845734 | instance | 2026-08-24 15:39:29.846012 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-24 15:39:29.846293 | instance | Monday 24 August 2026 15:39:29 +0000 (0:00:00.010) 0:00:00.010 ********* 2026-08-24 15:39:30.842519 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-08-24 15:39:30.842585 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-08-24 15:39:30.842723 | instance | interpreter could change the meaning of that path. See 2026-08-24 15:39:30.843023 | instance | https://docs.ansible.com/ansible- 2026-08-24 15:39:30.843150 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-08-24 15:39:30.854030 | instance | ok: [instance] 2026-08-24 15:39:30.854128 | instance | 2026-08-24 15:39:30.854248 | instance | TASK [Display CSI driver value and environment variable] *********************** 2026-08-24 15:39:30.854370 | instance | Monday 24 August 2026 15:39:30 +0000 (0:00:01.009) 0:00:01.019 ********* 2026-08-24 15:39:30.907858 | instance | ok: [instance] => { 2026-08-24 15:39:30.908070 | instance | "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER=" 2026-08-24 15:39:30.908341 | instance | } 2026-08-24 15:39:30.908593 | instance | 2026-08-24 15:39:30.909008 | instance | PLAY [all] ********************************************************************* 2026-08-24 15:39:30.909234 | instance | 2026-08-24 15:39:30.909506 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-24 15:39:30.909766 | instance | Monday 24 August 2026 15:39:30 +0000 (0:00:00.053) 0:00:01.073 ********* 2026-08-24 15:39:31.830021 | instance | ok: [instance] 2026-08-24 15:39:31.830326 | instance | 2026-08-24 15:39:31.830666 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-08-24 15:39:31.831031 | instance | Monday 24 August 2026 15:39:31 +0000 (0:00:00.921) 0:00:01.994 ********* 2026-08-24 15:39:32.024553 | instance | ok: [instance] 2026-08-24 15:39:32.024680 | instance | 2026-08-24 15:39:32.024833 | instance | PLAY [Deploy Ceph monitors & managers] ***************************************** 2026-08-24 15:39:32.025069 | instance | 2026-08-24 15:39:32.025298 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-24 15:39:32.025490 | instance | Monday 24 August 2026 15:39:32 +0000 (0:00:00.195) 0:00:02.190 ********* 2026-08-24 15:39:32.936499 | instance | ok: [instance] 2026-08-24 15:39:32.936776 | instance | 2026-08-24 15:39:32.937049 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-24 15:39:32.937329 | instance | Monday 24 August 2026 15:39:32 +0000 (0:00:00.911) 0:00:03.101 ********* 2026-08-24 15:39:33.234650 | instance | ok: [instance] 2026-08-24 15:39:33.235099 | instance | 2026-08-24 15:39:33.235445 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-24 15:39:33.235775 | instance | Monday 24 August 2026 15:39:33 +0000 (0:00:00.298) 0:00:03.400 ********* 2026-08-24 15:39:33.285289 | instance | skipping: [instance] 2026-08-24 15:39:33.285382 | instance | 2026-08-24 15:39:33.285420 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-08-24 15:39:33.285574 | instance | Monday 24 August 2026 15:39:33 +0000 (0:00:00.050) 0:00:03.450 ********* 2026-08-24 15:39:33.657311 | instance | changed: [instance] 2026-08-24 15:39:33.657411 | instance | 2026-08-24 15:39:33.657563 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-24 15:39:33.657790 | instance | Monday 24 August 2026 15:39:33 +0000 (0:00:00.371) 0:00:03.821 ********* 2026-08-24 15:39:33.741496 | instance | ok: [instance] => { 2026-08-24 15:39:33.741608 | instance | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-08-24 15:39:33.741759 | instance | } 2026-08-24 15:39:33.741963 | instance | 2026-08-24 15:39:33.742124 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-24 15:39:33.742279 | instance | Monday 24 August 2026 15:39:33 +0000 (0:00:00.081) 0:00:03.903 ********* 2026-08-24 15:39:34.449553 | instance | changed: [instance] 2026-08-24 15:39:34.449824 | instance | 2026-08-24 15:39:34.450084 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-24 15:39:34.450326 | instance | Monday 24 August 2026 15:39:34 +0000 (0:00:00.708) 0:00:04.611 ********* 2026-08-24 15:39:34.505675 | instance | skipping: [instance] 2026-08-24 15:39:34.506110 | instance | 2026-08-24 15:39:34.506546 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-24 15:39:34.506926 | instance | Monday 24 August 2026 15:39:34 +0000 (0:00:00.056) 0:00:04.668 ********* 2026-08-24 15:39:34.557322 | instance | skipping: [instance] 2026-08-24 15:39:34.557428 | instance | 2026-08-24 15:39:34.557581 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-24 15:39:34.557831 | instance | Monday 24 August 2026 15:39:34 +0000 (0:00:00.051) 0:00:04.719 ********* 2026-08-24 15:39:34.785397 | instance | ok: [instance] 2026-08-24 15:39:34.785689 | instance | 2026-08-24 15:39:34.785909 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-24 15:39:34.786118 | instance | Monday 24 August 2026 15:39:34 +0000 (0:00:00.230) 0:00:04.950 ********* 2026-08-24 15:39:36.281342 | instance | ok: [instance] 2026-08-24 15:39:36.281646 | instance | 2026-08-24 15:39:36.281868 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-24 15:39:36.282090 | instance | Monday 24 August 2026 15:39:36 +0000 (0:00:01.492) 0:00:06.443 ********* 2026-08-24 15:39:36.338449 | instance | ok: [instance] => { 2026-08-24 15:39:36.338505 | instance | "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz" 2026-08-24 15:39:36.338524 | instance | } 2026-08-24 15:39:36.338529 | instance | 2026-08-24 15:39:36.338533 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-24 15:39:36.338538 | instance | Monday 24 August 2026 15:39:36 +0000 (0:00:00.060) 0:00:06.503 ********* 2026-08-24 15:39:36.971141 | instance | changed: [instance] 2026-08-24 15:39:36.971280 | instance | 2026-08-24 15:39:36.971688 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-24 15:39:36.971754 | instance | Monday 24 August 2026 15:39:36 +0000 (0:00:00.633) 0:00:07.136 ********* 2026-08-24 15:39:39.951519 | instance | changed: [instance] 2026-08-24 15:39:39.951642 | instance | 2026-08-24 15:39:39.951729 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-08-24 15:39:39.951902 | instance | Monday 24 August 2026 15:39:39 +0000 (0:00:02.980) 0:00:10.116 ********* 2026-08-24 15:39:39.994902 | instance | skipping: [instance] 2026-08-24 15:39:39.995046 | instance | 2026-08-24 15:39:39.995059 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-08-24 15:39:39.995234 | instance | Monday 24 August 2026 15:39:39 +0000 (0:00:00.043) 0:00:10.160 ********* 2026-08-24 15:39:40.035789 | instance | skipping: [instance] 2026-08-24 15:39:40.035862 | instance | 2026-08-24 15:39:40.036426 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-08-24 15:39:40.036485 | instance | Monday 24 August 2026 15:39:40 +0000 (0:00:00.040) 0:00:10.201 ********* 2026-08-24 15:39:40.074289 | instance | skipping: [instance] 2026-08-24 15:39:40.074389 | instance | 2026-08-24 15:39:40.074482 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-08-24 15:39:40.074691 | instance | Monday 24 August 2026 15:39:40 +0000 (0:00:00.038) 0:00:10.239 ********* 2026-08-24 15:39:45.607309 | instance | changed: [instance] 2026-08-24 15:39:45.607435 | instance | 2026-08-24 15:39:45.607538 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] *** 2026-08-24 15:39:45.607746 | instance | Monday 24 August 2026 15:39:45 +0000 (0:00:05.533) 0:00:15.772 ********* 2026-08-24 15:39:46.252608 | instance | changed: [instance] 2026-08-24 15:39:46.252747 | instance | 2026-08-24 15:39:46.252879 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] ******* 2026-08-24 15:39:46.253138 | instance | Monday 24 August 2026 15:39:46 +0000 (0:00:00.645) 0:00:16.418 ********* 2026-08-24 15:39:47.234088 | instance | changed: [instance] => (item={'path': '/etc/containerd'}) 2026-08-24 15:39:47.234136 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'}) 2026-08-24 15:39:47.234142 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'}) 2026-08-24 15:39:47.234146 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'}) 2026-08-24 15:39:47.234152 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'}) 2026-08-24 15:39:47.234157 | instance | 2026-08-24 15:39:47.234166 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] ********** 2026-08-24 15:39:47.234170 | instance | Monday 24 August 2026 15:39:47 +0000 (0:00:00.980) 0:00:17.398 ********* 2026-08-24 15:39:47.921522 | instance | changed: [instance] 2026-08-24 15:39:47.921621 | instance | 2026-08-24 15:39:47.921685 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ******** 2026-08-24 15:39:47.922210 | instance | Monday 24 August 2026 15:39:47 +0000 (0:00:00.670) 0:00:18.068 ********* 2026-08-24 15:39:47.922266 | instance | 2026-08-24 15:39:47.922272 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-08-24 15:39:47.922277 | instance | Monday 24 August 2026 15:39:47 +0000 (0:00:00.018) 0:00:18.087 ********* 2026-08-24 15:39:48.915254 | instance | ok: [instance] 2026-08-24 15:39:48.915301 | instance | 2026-08-24 15:39:48.915308 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] ********** 2026-08-24 15:39:48.915314 | instance | Monday 24 August 2026 15:39:48 +0000 (0:00:00.993) 0:00:19.080 ********* 2026-08-24 15:39:49.446405 | instance | changed: [instance] 2026-08-24 15:39:49.446563 | instance | 2026-08-24 15:39:49.446575 | instance | TASK [vexxhost.containers.containerd : Enable and start service] *************** 2026-08-24 15:39:49.446736 | instance | Monday 24 August 2026 15:39:49 +0000 (0:00:00.531) 0:00:19.612 ********* 2026-08-24 15:39:50.022159 | instance | changed: [instance] 2026-08-24 15:39:50.022227 | instance | 2026-08-24 15:39:50.022529 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-24 15:39:50.022548 | instance | Monday 24 August 2026 15:39:50 +0000 (0:00:00.575) 0:00:20.187 ********* 2026-08-24 15:39:50.255253 | instance | ok: [instance] 2026-08-24 15:39:50.255327 | instance | 2026-08-24 15:39:50.255625 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-24 15:39:50.255680 | instance | Monday 24 August 2026 15:39:50 +0000 (0:00:00.233) 0:00:20.420 ********* 2026-08-24 15:39:50.317457 | instance | ok: [instance] => { 2026-08-24 15:39:50.317533 | instance | "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz" 2026-08-24 15:39:50.318050 | instance | } 2026-08-24 15:39:50.318103 | instance | 2026-08-24 15:39:50.318109 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-24 15:39:50.318115 | instance | Monday 24 August 2026 15:39:50 +0000 (0:00:00.062) 0:00:20.483 ********* 2026-08-24 15:39:51.276291 | instance | changed: [instance] 2026-08-24 15:39:51.276377 | instance | 2026-08-24 15:39:51.276671 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-24 15:39:51.276733 | instance | Monday 24 August 2026 15:39:51 +0000 (0:00:00.958) 0:00:21.441 ********* 2026-08-24 15:39:55.859900 | instance | changed: [instance] 2026-08-24 15:39:55.859987 | instance | 2026-08-24 15:39:55.860232 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ****************** 2026-08-24 15:39:55.860293 | instance | Monday 24 August 2026 15:39:55 +0000 (0:00:04.582) 0:00:26.024 ********* 2026-08-24 15:39:57.237457 | instance | ok: [instance] 2026-08-24 15:39:57.237543 | instance | 2026-08-24 15:39:57.237861 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] *************** 2026-08-24 15:39:57.237917 | instance | Monday 24 August 2026 15:39:57 +0000 (0:00:01.378) 0:00:27.402 ********* 2026-08-24 15:39:57.639679 | instance | changed: [instance] 2026-08-24 15:39:57.640043 | instance | 2026-08-24 15:39:57.640108 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] ***** 2026-08-24 15:39:57.640119 | instance | Monday 24 August 2026 15:39:57 +0000 (0:00:00.401) 0:00:27.804 ********* 2026-08-24 15:39:58.130279 | instance | changed: [instance] 2026-08-24 15:39:58.130370 | instance | 2026-08-24 15:39:58.130673 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] *********** 2026-08-24 15:39:58.130724 | instance | Monday 24 August 2026 15:39:58 +0000 (0:00:00.491) 0:00:28.296 ********* 2026-08-24 15:39:58.730913 | instance | changed: [instance] => (item={'path': '/etc/docker'}) 2026-08-24 15:39:58.731017 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'}) 2026-08-24 15:39:58.731699 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'}) 2026-08-24 15:39:58.731761 | instance | 2026-08-24 15:39:58.731770 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ****** 2026-08-24 15:39:58.731776 | instance | Monday 24 August 2026 15:39:58 +0000 (0:00:00.600) 0:00:28.896 ********* 2026-08-24 15:39:59.218437 | instance | changed: [instance] 2026-08-24 15:39:59.218547 | instance | 2026-08-24 15:39:59.218804 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] *********** 2026-08-24 15:39:59.218821 | instance | Monday 24 August 2026 15:39:59 +0000 (0:00:00.487) 0:00:29.383 ********* 2026-08-24 15:39:59.777048 | instance | changed: [instance] 2026-08-24 15:39:59.777144 | instance | 2026-08-24 15:39:59.777752 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************ 2026-08-24 15:39:59.777807 | instance | Monday 24 August 2026 15:39:59 +0000 (0:00:00.541) 0:00:29.925 ********* 2026-08-24 15:39:59.777814 | instance | 2026-08-24 15:39:59.777819 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-08-24 15:39:59.777823 | instance | Monday 24 August 2026 15:39:59 +0000 (0:00:00.017) 0:00:29.942 ********* 2026-08-24 15:40:00.512454 | instance | ok: [instance] 2026-08-24 15:40:00.512578 | instance | 2026-08-24 15:40:00.512665 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ****************** 2026-08-24 15:40:00.512818 | instance | Monday 24 August 2026 15:40:00 +0000 (0:00:00.735) 0:00:30.678 ********* 2026-08-24 15:40:02.058844 | instance | changed: [instance] 2026-08-24 15:40:02.058943 | instance | 2026-08-24 15:40:02.059209 | instance | TASK [vexxhost.containers.docker : Enable and start service] ******************* 2026-08-24 15:40:02.059272 | instance | Monday 24 August 2026 15:40:02 +0000 (0:00:01.546) 0:00:32.224 ********* 2026-08-24 15:40:02.630139 | instance | changed: [instance] 2026-08-24 15:40:02.630243 | instance | 2026-08-24 15:40:02.630309 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ****** 2026-08-24 15:40:02.630472 | instance | Monday 24 August 2026 15:40:02 +0000 (0:00:00.571) 0:00:32.795 ********* 2026-08-24 15:40:02.698034 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml) 2026-08-24 15:40:02.698154 | instance | 2026-08-24 15:40:02.698172 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ******************************** 2026-08-24 15:40:02.698362 | instance | Monday 24 August 2026 15:40:02 +0000 (0:00:00.067) 0:00:32.863 ********* 2026-08-24 15:40:09.699761 | instance | changed: [instance] 2026-08-24 15:40:09.699864 | instance | 2026-08-24 15:40:09.700118 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] ********************* 2026-08-24 15:40:09.700176 | instance | Monday 24 August 2026 15:40:09 +0000 (0:00:07.002) 0:00:39.865 ********* 2026-08-24 15:40:10.382138 | instance | ok: [instance] => (item=chronyd) 2026-08-24 15:40:10.382233 | instance | ok: [instance] => (item=sshd) 2026-08-24 15:40:10.382608 | instance | 2026-08-24 15:40:10.382670 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ****************************** 2026-08-24 15:40:10.382676 | instance | Monday 24 August 2026 15:40:10 +0000 (0:00:00.682) 0:00:40.547 ********* 2026-08-24 15:40:10.991568 | instance | changed: [instance] 2026-08-24 15:40:10.991670 | instance | 2026-08-24 15:40:10.991935 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ******************** 2026-08-24 15:40:10.992165 | instance | Monday 24 August 2026 15:40:10 +0000 (0:00:00.609) 0:00:41.157 ********* 2026-08-24 15:40:11.205685 | instance | ok: [instance] 2026-08-24 15:40:11.205785 | instance | 2026-08-24 15:40:11.206207 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] **************** 2026-08-24 15:40:11.206281 | instance | Monday 24 August 2026 15:40:11 +0000 (0:00:00.213) 0:00:41.370 ********* 2026-08-24 15:40:11.976389 | instance | changed: [instance] 2026-08-24 15:40:11.976487 | instance | 2026-08-24 15:40:11.976787 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] *** 2026-08-24 15:40:11.976879 | instance | Monday 24 August 2026 15:40:11 +0000 (0:00:00.771) 0:00:42.142 ********* 2026-08-24 15:40:12.358079 | instance | changed: [instance] 2026-08-24 15:40:12.358184 | instance | 2026-08-24 15:40:12.358250 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] ************************* 2026-08-24 15:40:12.358417 | instance | Monday 24 August 2026 15:40:12 +0000 (0:00:00.381) 0:00:42.523 ********* 2026-08-24 15:40:12.486748 | instance | ok: [instance] 2026-08-24 15:40:12.486834 | instance | 2026-08-24 15:40:12.487123 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] ******************* 2026-08-24 15:40:12.487193 | instance | Monday 24 August 2026 15:40:12 +0000 (0:00:00.128) 0:00:42.652 ********* 2026-08-24 15:40:12.734955 | instance | ok: [instance] => (item=instance) 2026-08-24 15:40:12.735069 | instance | 2026-08-24 15:40:12.735086 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ******** 2026-08-24 15:40:12.735273 | instance | Monday 24 August 2026 15:40:12 +0000 (0:00:00.248) 0:00:42.900 ********* 2026-08-24 15:40:12.794378 | instance | ok: [instance] 2026-08-24 15:40:12.794484 | instance | 2026-08-24 15:40:12.794867 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] *********************************** 2026-08-24 15:40:12.794929 | instance | Monday 24 August 2026 15:40:12 +0000 (0:00:00.059) 0:00:42.959 ********* 2026-08-24 15:40:12.872018 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance 2026-08-24 15:40:12.872121 | instance | 2026-08-24 15:40:12.872205 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] ************* 2026-08-24 15:40:12.872386 | instance | Monday 24 August 2026 15:40:12 +0000 (0:00:00.078) 0:00:43.037 ********* 2026-08-24 15:40:13.234316 | instance | changed: [instance] 2026-08-24 15:40:13.234407 | instance | 2026-08-24 15:40:13.234705 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ****************** 2026-08-24 15:40:13.234760 | instance | Monday 24 August 2026 15:40:13 +0000 (0:00:00.362) 0:00:43.399 ********* 2026-08-24 15:40:13.965121 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True}) 2026-08-24 15:40:13.965227 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0}) 2026-08-24 15:40:13.965735 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False}) 2026-08-24 15:40:13.965790 | instance | 2026-08-24 15:40:13.965796 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] ******************************* 2026-08-24 15:40:13.965800 | instance | Monday 24 August 2026 15:40:13 +0000 (0:00:00.730) 0:00:44.130 ********* 2026-08-24 15:44:07.503231 | instance | ok: [instance] 2026-08-24 15:44:07.503303 | instance | 2026-08-24 15:44:07.503317 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] *************** 2026-08-24 15:44:07.503408 | instance | Monday 24 August 2026 15:44:07 +0000 (0:03:53.537) 0:04:37.668 ********* 2026-08-24 15:44:07.756379 | instance | changed: [instance] 2026-08-24 15:44:07.756442 | instance | 2026-08-24 15:44:07.756448 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] ********************************** 2026-08-24 15:44:07.756454 | instance | Monday 24 August 2026 15:44:07 +0000 (0:00:00.252) 0:04:37.921 ********* 2026-08-24 15:44:07.862131 | instance | ok: [instance] 2026-08-24 15:44:07.862186 | instance | 2026-08-24 15:44:07.862192 | instance | TASK [Install Ceph host] ******************************************************* 2026-08-24 15:44:07.862197 | instance | Monday 24 August 2026 15:44:07 +0000 (0:00:00.105) 0:04:38.027 ********* 2026-08-24 15:44:07.948409 | instance | included: vexxhost.ceph.cephadm_host for instance 2026-08-24 15:44:07.948455 | instance | 2026-08-24 15:44:07.948461 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ****** 2026-08-24 15:44:07.948466 | instance | Monday 24 August 2026 15:44:07 +0000 (0:00:00.086) 0:04:38.113 ********* 2026-08-24 15:44:09.612282 | instance | ok: [instance] 2026-08-24 15:44:09.612381 | instance | 2026-08-24 15:44:09.612444 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] *** 2026-08-24 15:44:09.612572 | instance | Monday 24 August 2026 15:44:09 +0000 (0:00:01.664) 0:04:39.777 ********* 2026-08-24 15:44:09.675591 | instance | ok: [instance] => (item=instance) 2026-08-24 15:44:09.675653 | instance | 2026-08-24 15:44:09.675830 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] *********** 2026-08-24 15:44:09.676008 | instance | Monday 24 August 2026 15:44:09 +0000 (0:00:00.063) 0:04:39.841 ********* 2026-08-24 15:44:10.044157 | instance | ok: [instance] 2026-08-24 15:44:10.044204 | instance | 2026-08-24 15:44:10.044210 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] *********************** 2026-08-24 15:44:10.044215 | instance | Monday 24 August 2026 15:44:10 +0000 (0:00:00.368) 0:04:40.209 ********* 2026-08-24 15:44:12.599667 | instance | ok: [instance] 2026-08-24 15:44:12.599725 | instance | 2026-08-24 15:44:12.599731 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ****************** 2026-08-24 15:44:12.599736 | instance | Monday 24 August 2026 15:44:12 +0000 (0:00:02.555) 0:04:42.764 ********* 2026-08-24 15:45:03.527773 | 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-08-24 15:45:03.528876 | 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_nu46gqjr/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_nu46gqjr/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_nu46gqjr/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_nu46gqjr/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-08-24T15:45:03.364+0000 7ffa6c1e3640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCTZoxqLNhlIyAAUCG7uYJehkxk/UcjOtWlMi3c7n+y2rkdCiF9Sm5C5kA=: Malformed input [buffer:3]\n2026-08-24T15:45:03.364+0000 7ffa6c1e3640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T15:45:03.364+0000 7ffa6c1e3640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCTZoxqLNhlIyAAUCG7uYJehkxk/UcjOtWlMi3c7n+y2rkdCiF9Sm5C5kA=: Malformed input [buffer:3]\n2026-08-24T15:45:03.364+0000 7ffa6c1e3640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T15:45:03.364+0000 7ffa6c1e3640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCTZoxqLNhlIyAAUCG7uYJehkxk/UcjOtWlMi3c7n+y2rkdCiF9Sm5C5kA=: Malformed input [buffer:3]\n2026-08-24T15:45:03.364+0000 7ffa6c1e3640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T15:45:03.364+0000 7ffa6c1e3640 -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-08-24 15:45:03.532436 | instance | 2026-08-24 15:45:03.536668 | instance | PLAY RECAP ********************************************************************* 2026-08-24 15:45:03.536699 | instance | instance : ok=55 changed=26 unreachable=0 failed=1 skipped=6 rescued=0 ignored=0 2026-08-24 15:45:03.536707 | instance | 2026-08-24 15:45:03.536714 | instance | Monday 24 August 2026 15:45:03 +0000 (0:00:50.933) 0:05:33.698 ********* 2026-08-24 15:45:03.536721 | instance | =============================================================================== 2026-08-24 15:45:03.536727 | instance | vexxhost.ceph.mon : Run Bootstrap command ----------------------------- 233.54s 2026-08-24 15:45:03.536734 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 50.93s 2026-08-24 15:45:03.536741 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 7.00s 2026-08-24 15:45:03.536747 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 5.53s 2026-08-24 15:45:03.536754 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.58s 2026-08-24 15:45:03.536760 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.98s 2026-08-24 15:45:03.536766 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.56s 2026-08-24 15:45:03.536772 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.73s 2026-08-24 15:45:03.536791 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.66s 2026-08-24 15:45:03.536799 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 1.55s 2026-08-24 15:45:03.536806 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.49s 2026-08-24 15:45:03.536811 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.38s 2026-08-24 15:45:03.536817 | instance | Gathering Facts --------------------------------------------------------- 1.01s 2026-08-24 15:45:03.536822 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.98s 2026-08-24 15:45:03.536828 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.96s 2026-08-24 15:45:03.536833 | instance | Gathering Facts --------------------------------------------------------- 0.92s 2026-08-24 15:45:03.536839 | instance | Gathering Facts --------------------------------------------------------- 0.91s 2026-08-24 15:45:03.536844 | instance | vexxhost.ceph.cephadm : Ensure "cephadm" user is present ---------------- 0.77s 2026-08-24 15:45:03.536850 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.73s 2026-08-24 15:45:03.536855 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.71s 2026-08-24 15:45:03.633215 | 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-08-24 15:45:03.633573 | instance | ERROR [csi > converge] Executed: Failed 2026-08-24 15:45:03.633831 | 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-08-24 15:45:04.081625 | instance | ERROR 2026-08-24 15:45:04.082259 | instance | { 2026-08-24 15:45:04.082323 | instance | "delta": "0:06:37.101388", 2026-08-24 15:45:04.082360 | instance | "end": "2026-08-24 15:45:03.702675", 2026-08-24 15:45:04.082392 | instance | "msg": "non-zero return code", 2026-08-24 15:45:04.082425 | instance | "rc": 2, 2026-08-24 15:45:04.082455 | instance | "start": "2026-08-24 15:38:26.601287" 2026-08-24 15:45:04.082488 | instance | } failure 2026-08-24 15:45:04.088371 | 2026-08-24 15:45:04.088439 | PLAY RECAP 2026-08-24 15:45:04.088481 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-08-24 15:45:04.088503 | 2026-08-24 15:45:04.491189 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-24 15:45:04.646267 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-08-24 15:45:05.828801 | 2026-08-24 15:45:05.828930 | PLAY [all] 2026-08-24 15:45:05.847059 | 2026-08-24 15:45:05.847216 | TASK [gather-host-logs : creating directory for system status] 2026-08-24 15:45:06.206355 | instance | changed 2026-08-24 15:45:06.211690 | 2026-08-24 15:45:06.211772 | TASK [gather-host-logs : Get logs for each host] 2026-08-24 15:45:06.546312 | instance | + systemd-cgls --full --all --no-pager 2026-08-24 15:45:06.559690 | instance | + ip addr 2026-08-24 15:45:06.562030 | instance | + ip route 2026-08-24 15:45:06.563633 | instance | + lsblk 2026-08-24 15:45:06.568095 | instance | + mount 2026-08-24 15:45:06.571064 | instance | + docker images 2026-08-24 15:45:06.591065 | instance | + brctl show 2026-08-24 15:45:06.591496 | instance | /bin/bash: line 8: brctl: command not found 2026-08-24 15:45:06.591723 | instance | + ps aux --sort=-%mem 2026-08-24 15:45:06.608848 | instance | + dpkg -l 2026-08-24 15:45:06.618264 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-08-24 15:45:06.618803 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-08-24 15:45:06.635385 | instance | + '[' '!' -z '' ']' 2026-08-24 15:45:06.747361 | instance | ok: Runtime: 0:00:00.093145 2026-08-24 15:45:06.755622 | 2026-08-24 15:45:06.755739 | TASK [gather-host-logs : Downloads logs to executor] 2026-08-24 15:45:07.389980 | instance | changed: 2026-08-24 15:45:07.390142 | instance | created directory /var/lib/zuul/builds/9527653448374108b249b2400ffb5da4/work/logs/instance 2026-08-24 15:45:07.390179 | instance | cd+++++++++ system/ 2026-08-24 15:45:07.390203 | instance | >f+++++++++ system/brctl-show.txt 2026-08-24 15:45:07.390225 | instance | >f+++++++++ system/docker-images.txt 2026-08-24 15:45:07.390246 | instance | >f+++++++++ system/ip-addr.txt 2026-08-24 15:45:07.390268 | instance | >f+++++++++ system/ip-route.txt 2026-08-24 15:45:07.390288 | instance | >f+++++++++ system/lsblk.txt 2026-08-24 15:45:07.390311 | instance | >f+++++++++ system/mount.txt 2026-08-24 15:45:07.390342 | instance | >f+++++++++ system/packages.txt 2026-08-24 15:45:07.390371 | instance | >f+++++++++ system/ps.txt 2026-08-24 15:45:07.390405 | instance | >f+++++++++ system/systemd-cgls.txt 2026-08-24 15:45:07.401564 | 2026-08-24 15:45:07.401656 | LOOP [helm-release-status : creating directory for helm release status] 2026-08-24 15:45:07.596903 | instance | changed: "values" 2026-08-24 15:45:07.760992 | instance | changed: "releases" 2026-08-24 15:45:07.770656 | 2026-08-24 15:45:07.770801 | TASK [helm-release-status : Gather get release status for helm charts] 2026-08-24 15:45:08.002382 | instance | /bin/bash: line 3: kubectl: command not found 2026-08-24 15:45:08.316133 | instance | ok: Runtime: 0:00:00.006339 2026-08-24 15:45:08.322661 | 2026-08-24 15:45:08.322779 | TASK [helm-release-status : Downloads logs to executor] 2026-08-24 15:45:08.856048 | instance | changed: 2026-08-24 15:45:08.856243 | instance | cd+++++++++ helm/ 2026-08-24 15:45:08.856282 | instance | cd+++++++++ helm/releases/ 2026-08-24 15:45:08.856355 | instance | cd+++++++++ helm/values/ 2026-08-24 15:45:08.869989 | 2026-08-24 15:45:08.870071 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-08-24 15:45:09.088264 | instance | changed 2026-08-24 15:45:09.096532 | 2026-08-24 15:45:09.096634 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-08-24 15:45:09.354216 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-24 15:45:09.354829 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-24 15:45:09.360422 | instance | environment: line 1: kubectl: command not found 2026-08-24 15:45:09.361637 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-24 15:45:09.362313 | instance | environment: line 1: kubectl: command not found 2026-08-24 15:45:09.363346 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-24 15:45:09.365013 | instance | environment: line 1: kubectl: command not found 2026-08-24 15:45:09.365828 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-24 15:45:09.367528 | instance | environment: line 1: kubectl: command not found 2026-08-24 15:45:09.368511 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-24 15:45:09.368794 | instance | environment: line 1: kubectl: command not found 2026-08-24 15:45:09.370303 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-24 15:45:09.654225 | instance | ok: Runtime: 0:00:00.024980 2026-08-24 15:45:09.660367 | 2026-08-24 15:45:09.660483 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-08-24 15:45:09.863218 | instance | changed 2026-08-24 15:45:09.871030 | 2026-08-24 15:45:09.871186 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-08-24 15:45:10.116616 | instance | environment: line 5: kubectl: command not found 2026-08-24 15:45:10.117692 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-24 15:45:10.118103 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-24 15:45:10.118187 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-24 15:45:10.415067 | instance | ok: Runtime: 0:00:00.009186 2026-08-24 15:45:10.423643 | 2026-08-24 15:45:10.423804 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-08-24 15:45:10.938476 | instance | changed: 2026-08-24 15:45:10.938715 | instance | cd+++++++++ objects/ 2026-08-24 15:45:10.938744 | instance | cd+++++++++ objects/cluster/ 2026-08-24 15:45:10.938767 | instance | cd+++++++++ objects/namespaced/ 2026-08-24 15:45:10.949368 | 2026-08-24 15:45:10.949482 | TASK [gather-pod-logs : creating directory for pod logs] 2026-08-24 15:45:11.148354 | instance | changed 2026-08-24 15:45:11.154724 | 2026-08-24 15:45:11.154836 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-08-24 15:45:11.345037 | instance | changed 2026-08-24 15:45:11.350035 | 2026-08-24 15:45:11.350103 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-08-24 15:45:11.569708 | instance | environment: line 3: kubectl: command not found 2026-08-24 15:45:11.893576 | instance | ok: Runtime: 0:00:00.009379 2026-08-24 15:45:11.901103 | 2026-08-24 15:45:11.901199 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-08-24 15:45:12.412249 | instance | changed: 2026-08-24 15:45:12.412880 | instance | cd+++++++++ pod-logs/ 2026-08-24 15:45:12.413051 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-08-24 15:45:12.426061 | 2026-08-24 15:45:12.426168 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-08-24 15:45:12.623748 | instance | changed 2026-08-24 15:45:12.633826 | 2026-08-24 15:45:12.633952 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-08-24 15:45:12.838504 | instance | /bin/bash: line 2: kubectl: command not found 2026-08-24 15:45:13.170105 | instance | ok: Runtime: 0:00:00.038934 2026-08-24 15:45:13.175832 | 2026-08-24 15:45:13.175916 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-08-24 15:45:13.377593 | instance | /bin/bash: line 2: kubectl: command not found 2026-08-24 15:45:13.416916 | instance | ceph-mgr endpoints: 2026-08-24 15:45:13.719366 | instance | ok: Runtime: 0:00:00.046320 2026-08-24 15:45:13.725406 | 2026-08-24 15:45:13.725500 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-08-24 15:45:13.929850 | instance | /bin/bash: line 4: kubectl: command not found 2026-08-24 15:45:14.267969 | instance | ok: Runtime: 0:00:00.043468 2026-08-24 15:45:14.275680 | 2026-08-24 15:45:14.275789 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-08-24 15:45:14.834800 | instance | changed: cd+++++++++ prometheus/ 2026-08-24 15:45:14.847967 | 2026-08-24 15:45:14.848078 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-08-24 15:45:15.056735 | instance | changed 2026-08-24 15:45:15.062547 | 2026-08-24 15:45:15.062616 | TASK [gather-selenium-data : Get selenium data] 2026-08-24 15:45:15.301211 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-08-24 15:45:15.303217 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-08-24 15:45:15.595891 | instance | ERROR 2026-08-24 15:45:15.596077 | instance | { 2026-08-24 15:45:15.596114 | instance | "delta": "0:00:00.007127", 2026-08-24 15:45:15.596138 | instance | "end": "2026-08-24 15:45:15.303664", 2026-08-24 15:45:15.596159 | instance | "msg": "non-zero return code", 2026-08-24 15:45:15.596179 | instance | "rc": 1, 2026-08-24 15:45:15.596227 | instance | "start": "2026-08-24 15:45:15.296537" 2026-08-24 15:45:15.596246 | instance | } 2026-08-24 15:45:15.596270 | instance | ERROR: Ignoring Errors 2026-08-24 15:45:15.601138 | 2026-08-24 15:45:15.601201 | TASK [gather-selenium-data : Downloads logs to executor] 2026-08-24 15:45:16.120982 | instance | changed: cd+++++++++ selenium/ 2026-08-24 15:45:16.126486 | 2026-08-24 15:45:16.126534 | PLAY RECAP 2026-08-24 15:45:16.126577 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-08-24 15:45:16.126600 | 2026-08-24 15:45:16.233992 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-08-24 15:45:16.237393 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-24 15:45:16.884912 | 2026-08-24 15:45:16.885073 | PLAY [all] 2026-08-24 15:45:16.900346 | 2026-08-24 15:45:16.900461 | TASK [fetch-output : Set log path for multiple nodes] 2026-08-24 15:45:16.935441 | instance | skipping: Conditional result was False 2026-08-24 15:45:16.944832 | 2026-08-24 15:45:16.944999 | TASK [fetch-output : Set log path for single node] 2026-08-24 15:45:16.987767 | instance | ok 2026-08-24 15:45:16.993534 | 2026-08-24 15:45:16.993623 | LOOP [fetch-output : Ensure local output dirs] 2026-08-24 15:45:17.404803 | instance -> localhost | ok: "/var/lib/zuul/builds/9527653448374108b249b2400ffb5da4/work/logs" 2026-08-24 15:45:17.665011 | instance -> localhost | changed: "/var/lib/zuul/builds/9527653448374108b249b2400ffb5da4/work/artifacts" 2026-08-24 15:45:17.917503 | instance -> localhost | changed: "/var/lib/zuul/builds/9527653448374108b249b2400ffb5da4/work/docs" 2026-08-24 15:45:17.938055 | 2026-08-24 15:45:17.938198 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-24 15:45:18.663877 | instance | changed: .d..t...... ./ 2026-08-24 15:45:18.664177 | instance | changed: All items complete 2026-08-24 15:45:18.664226 | 2026-08-24 15:45:19.141725 | instance | changed: .d..t...... ./ 2026-08-24 15:45:19.614041 | instance | changed: .d..t...... ./ 2026-08-24 15:45:19.639891 | 2026-08-24 15:45:19.703924 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-24 15:45:20.160255 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007020 2026-08-24 15:45:20.389651 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007246 2026-08-24 15:45:20.407842 | 2026-08-24 15:45:20.407945 | PLAY [all] 2026-08-24 15:45:20.415638 | 2026-08-24 15:45:20.415721 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-24 15:45:20.837529 | instance | changed 2026-08-24 15:45:20.846148 | 2026-08-24 15:45:20.846239 | PLAY RECAP 2026-08-24 15:45:20.846305 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-24 15:45:20.846346 | 2026-08-24 15:45:20.974164 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-24 15:45:20.977595 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-24 15:45:21.658104 | 2026-08-24 15:45:21.658306 | PLAY [localhost] 2026-08-24 15:45:21.669007 | 2026-08-24 15:45:21.669132 | TASK [Generate Zuul manifest] 2026-08-24 15:45:21.690424 | localhost | ok 2026-08-24 15:45:21.718016 | 2026-08-24 15:45:21.718155 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-24 15:45:22.070322 | localhost | changed 2026-08-24 15:45:22.082292 | 2026-08-24 15:45:22.082370 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-24 15:45:22.114081 | localhost | ok 2026-08-24 15:45:22.123030 | 2026-08-24 15:45:22.123100 | TASK [Upload logs] 2026-08-24 15:45:22.144556 | localhost | ok 2026-08-24 15:45:22.208927 | 2026-08-24 15:45:22.209080 | TASK [Set zuul-log-path fact] 2026-08-24 15:45:22.229271 | localhost | ok 2026-08-24 15:45:22.244135 | 2026-08-24 15:45:22.244245 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-24 15:45:22.275775 | localhost | ok 2026-08-24 15:45:22.282761 | 2026-08-24 15:45:22.282848 | TASK [upload-logs : Create log directories] 2026-08-24 15:45:22.715987 | localhost | changed 2026-08-24 15:45:22.723326 | 2026-08-24 15:45:22.723430 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-24 15:45:23.124265 | localhost -> localhost | ok: Runtime: 0:00:00.006738 2026-08-24 15:45:23.131796 | 2026-08-24 15:45:23.131934 | TASK [upload-logs : Upload logs to log server] 2026-08-24 15:45:23.584218 | localhost | Output suppressed because no_log was given 2026-08-24 15:45:23.624013 | 2026-08-24 15:45:23.624140 | LOOP [upload-logs : Compress console log and json output] 2026-08-24 15:45:23.671803 | localhost | skipping: Conditional result was False 2026-08-24 15:45:23.679994 | localhost | skipping: Conditional result was False 2026-08-24 15:45:23.696594 | 2026-08-24 15:45:23.696775 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-24 15:45:23.739337 | localhost | skipping: Conditional result was False 2026-08-24 15:45:23.739881 | 2026-08-24 15:45:23.745746 | localhost | skipping: Conditional result was False 2026-08-24 15:45:23.759268 | 2026-08-24 15:45:23.759435 | LOOP [upload-logs : Upload console log and json output]