2026-08-20 20:21:11.909825 | Job console starting 2026-08-20 20:21:11.978429 | Updating git repos 2026-08-20 20:21:16.881820 | Cloning repos into workspace 2026-08-20 20:21:46.758960 | Restoring repo states 2026-08-20 20:21:54.678352 | Merging changes 2026-08-20 20:21:55.827389 | Checking out repos 2026-08-20 20:21:58.119257 | Preparing playbooks 2026-08-20 20:22:04.793868 | Running Ansible setup 2026-08-20 20:22:08.993221 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-20 20:22:09.683348 | 2026-08-20 20:22:09.683484 | PLAY [localhost] 2026-08-20 20:22:09.693115 | 2026-08-20 20:22:09.693188 | TASK [Gathering Facts] 2026-08-20 20:22:10.617839 | localhost | ok 2026-08-20 20:22:10.630039 | 2026-08-20 20:22:10.630147 | TASK [Setup log path fact] 2026-08-20 20:22:10.652631 | localhost | ok 2026-08-20 20:22:10.666739 | 2026-08-20 20:22:10.666860 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-20 20:22:10.700713 | localhost | ok 2026-08-20 20:22:10.706544 | 2026-08-20 20:22:10.706613 | TASK [emit-job-header : Print job information] 2026-08-20 20:22:10.739366 | # Job Information 2026-08-20 20:22:10.739661 | Ansible Version: 2.16.18 2026-08-20 20:22:10.739761 | Job: atmosphere-molecule-csi-rbd 2026-08-20 20:22:10.739841 | Pipeline: check 2026-08-20 20:22:10.739912 | Executor: 2d72f0692154 2026-08-20 20:22:10.739969 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4305 2026-08-20 20:22:10.740026 | Event ID: a9352160-9cd3-11f1-8bf4-09587e9df4aa 2026-08-20 20:22:10.749526 | 2026-08-20 20:22:10.749605 | LOOP [emit-job-header : Print node information] 2026-08-20 20:22:10.858171 | localhost | ok: 2026-08-20 20:22:10.858412 | localhost | # Node Information 2026-08-20 20:22:10.858475 | localhost | Inventory Hostname: instance 2026-08-20 20:22:10.858524 | localhost | Hostname: np0000190246 2026-08-20 20:22:10.858569 | localhost | Username: zuul 2026-08-20 20:22:10.858619 | localhost | Distro: Ubuntu 22.04 2026-08-20 20:22:10.858664 | localhost | Provider: yul1 2026-08-20 20:22:10.858708 | localhost | Region: ca-ymq-1 2026-08-20 20:22:10.858750 | localhost | Label: ubuntu-jammy 2026-08-20 20:22:10.858791 | localhost | Product Name: OpenStack Nova 2026-08-20 20:22:10.858832 | localhost | Interface IP: 199.19.213.220 2026-08-20 20:22:10.871299 | 2026-08-20 20:22:10.871515 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-20 20:22:11.312824 | localhost -> localhost | changed 2026-08-20 20:22:11.320717 | 2026-08-20 20:22:11.320877 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-20 20:22:12.279255 | localhost -> localhost | changed 2026-08-20 20:22:12.296352 | 2026-08-20 20:22:12.296426 | PLAY [all] 2026-08-20 20:22:12.310005 | 2026-08-20 20:22:12.310122 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-20 20:22:12.558514 | instance -> localhost | ok 2026-08-20 20:22:12.568365 | 2026-08-20 20:22:12.568469 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-20 20:22:12.600675 | instance | ok 2026-08-20 20:22:12.616037 | instance | included: /var/lib/zuul/builds/bdabea34c6a641a29b1e33e33322b49c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-20 20:22:12.621675 | 2026-08-20 20:22:12.621734 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-20 20:22:13.875226 | instance -> localhost | Generating public/private rsa key pair. 2026-08-20 20:22:13.875422 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/bdabea34c6a641a29b1e33e33322b49c/work/bdabea34c6a641a29b1e33e33322b49c_id_rsa 2026-08-20 20:22:13.875484 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/bdabea34c6a641a29b1e33e33322b49c/work/bdabea34c6a641a29b1e33e33322b49c_id_rsa.pub 2026-08-20 20:22:13.875522 | instance -> localhost | The key fingerprint is: 2026-08-20 20:22:13.875553 | instance -> localhost | SHA256:Ogbfw0njm2wVp6N8rSwub8EHxAQ7UuRSYVtVNowm8gw zuul-build-sshkey 2026-08-20 20:22:13.875593 | instance -> localhost | The key's randomart image is: 2026-08-20 20:22:13.875624 | instance -> localhost | +---[RSA 3072]----+ 2026-08-20 20:22:13.875654 | instance -> localhost | | .B=o..++ | 2026-08-20 20:22:13.875683 | instance -> localhost | | =E++ o... | 2026-08-20 20:22:13.875711 | instance -> localhost | | o =* o | 2026-08-20 20:22:13.875739 | instance -> localhost | | o .+ . . | 2026-08-20 20:22:13.875767 | instance -> localhost | | . .S. + | 2026-08-20 20:22:13.875803 | instance -> localhost | | o *oo= | 2026-08-20 20:22:13.875844 | instance -> localhost | | =.*= o | 2026-08-20 20:22:13.875880 | instance -> localhost | | ..o*=. . | 2026-08-20 20:22:13.875919 | instance -> localhost | | **oo. | 2026-08-20 20:22:13.875955 | instance -> localhost | +----[SHA256]-----+ 2026-08-20 20:22:13.876043 | instance -> localhost | ok: Runtime: 0:00:00.787565 2026-08-20 20:22:13.889892 | 2026-08-20 20:22:13.890098 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-20 20:22:13.925892 | instance | ok 2026-08-20 20:22:13.986888 | instance | included: /var/lib/zuul/builds/bdabea34c6a641a29b1e33e33322b49c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-20 20:22:14.001690 | 2026-08-20 20:22:14.083320 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-20 20:22:14.112253 | instance | skipping: Conditional result was False 2026-08-20 20:22:14.124769 | 2026-08-20 20:22:14.124920 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-20 20:22:14.630532 | instance | changed 2026-08-20 20:22:14.639035 | 2026-08-20 20:22:14.639127 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-20 20:22:14.825630 | instance | ok 2026-08-20 20:22:14.833267 | 2026-08-20 20:22:14.833377 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-20 20:22:15.283001 | instance | changed 2026-08-20 20:22:15.290734 | 2026-08-20 20:22:15.290838 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-20 20:22:15.799045 | instance | changed 2026-08-20 20:22:16.105989 | 2026-08-20 20:22:16.106156 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-20 20:22:16.131103 | instance | skipping: Conditional result was False 2026-08-20 20:22:16.138927 | 2026-08-20 20:22:16.139059 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-20 20:22:16.712937 | instance -> localhost | changed 2026-08-20 20:22:16.726206 | 2026-08-20 20:22:16.726322 | TASK [add-build-sshkey : Add back temp key] 2026-08-20 20:22:17.001588 | instance -> localhost | Identity added: /var/lib/zuul/builds/bdabea34c6a641a29b1e33e33322b49c/work/bdabea34c6a641a29b1e33e33322b49c_id_rsa (zuul-build-sshkey) 2026-08-20 20:22:17.001769 | instance -> localhost | ok: Runtime: 0:00:00.013064 2026-08-20 20:22:17.006603 | 2026-08-20 20:22:17.006669 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-20 20:22:17.328201 | instance | ok 2026-08-20 20:22:17.339462 | 2026-08-20 20:22:17.339562 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-20 20:22:17.371982 | instance | skipping: Conditional result was False 2026-08-20 20:22:17.385215 | 2026-08-20 20:22:17.385354 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-08-20 20:22:17.764184 | instance | ok 2026-08-20 20:22:17.774234 | 2026-08-20 20:22:17.774400 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-08-20 20:22:21.996385 | instance | Output suppressed because no_log was given 2026-08-20 20:22:22.152319 | 2026-08-20 20:22:22.152434 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-08-20 20:22:22.357322 | instance | ok: "logs" 2026-08-20 20:22:22.499509 | instance | ok: All items complete 2026-08-20 20:22:22.499692 | 2026-08-20 20:22:22.547147 | instance | ok: "artifacts" 2026-08-20 20:22:22.698187 | instance | ok: "docs" 2026-08-20 20:22:22.791546 | 2026-08-20 20:22:22.791705 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-08-20 20:22:22.979665 | instance | changed: "logs" 2026-08-20 20:22:23.127212 | instance | changed: "artifacts" 2026-08-20 20:22:23.286467 | instance | changed: "docs" 2026-08-20 20:22:23.297408 | 2026-08-20 20:22:23.297706 | PLAY RECAP 2026-08-20 20:22:23.297757 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-08-20 20:22:23.297787 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-20 20:22:23.297810 | 2026-08-20 20:22:23.442792 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-20 20:22:23.445873 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-20 20:22:24.110629 | 2026-08-20 20:22:24.110801 | PLAY [all] 2026-08-20 20:22:24.127652 | 2026-08-20 20:22:24.127812 | TASK [setup-uv : Extract archive] 2026-08-20 20:22:29.447701 | instance | changed 2026-08-20 20:22:29.455487 | 2026-08-20 20:22:29.455674 | TASK [setup-uv : Print version] 2026-08-20 20:22:29.865846 | instance | uv 0.8.13 2026-08-20 20:22:29.994228 | instance | ok: Runtime: 0:00:00.010305 2026-08-20 20:22:30.019670 | 2026-08-20 20:22:30.020178 | TASK [Install Ansible collection siblings] 2026-08-20 20:22:39.046170 | instance | changed: 2026-08-20 20:22:39.046344 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-08-20 20:22:39.046397 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-08-20 20:22:39.046437 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-08-20 20:22:39.046467 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto 2026-08-20 20:22:39.046497 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general 2026-08-20 20:22:39.046529 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql 2026-08-20 20:22:39.046558 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-08-20 20:22:39.046589 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-08-20 20:22:39.046616 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-08-20 20:22:39.046644 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-08-20 20:22:39.046673 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-08-20 20:22:39.046701 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-08-20 20:22:39.046726 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0 2026-08-20 20:22:39.046753 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0 2026-08-20 20:22:39.046777 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0 2026-08-20 20:22:39.046884 | instance | Resolved community.crypto to 2.2.3 for 2.2.3 2026-08-20 20:22:39.046925 | instance | Resolved community.general to 7.3.0 for 7.3.0 2026-08-20 20:22:39.046955 | instance | Resolved community.mysql to 3.6.0 for 3.6.0 2026-08-20 20:22:39.046981 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0 2026-08-20 20:22:39.047009 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0 2026-08-20 20:22:39.047036 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.1.2 2026-08-20 20:22:39.047061 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0 2026-08-20 20:22:39.047089 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-08-20 20:22:39.047125 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0 2026-08-20 20:22:39.047153 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0 2026-08-20 20:22:39.047181 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-08-20 20:22:39.047208 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-08-20 20:22:39.047234 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-08-20 20:22:39.047259 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0 2026-08-20 20:22:39.047286 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3 2026-08-20 20:22:39.047312 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-08-20 20:22:39.047339 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-08-20 20:22:39.047366 | instance | Checked out ansible.netcommon to 1.2.0 2026-08-20 20:22:39.047393 | 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-20 20:22:39.047426 | instance | Starting galaxy collection install process 2026-08-20 20:22:39.047453 | instance | Process install dependency map 2026-08-20 20:22:39.047480 | instance | Starting collection install process 2026-08-20 20:22:39.047505 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon' 2026-08-20 20:22:39.047531 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon 2026-08-20 20:22:39.047557 | instance | ansible.netcommon:* was installed successfully 2026-08-20 20:22:39.047582 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-08-20 20:22:39.047609 | instance | Creating virtual environment at: .venv 2026-08-20 20:22:39.047634 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-08-20 20:22:39.047930 | instance | Downloading cryptography (4.2MiB) 2026-08-20 20:22:39.047967 | instance | Downloading ansible-core (2.1MiB) 2026-08-20 20:22:39.048003 | instance | Downloading openstacksdk (1.7MiB) 2026-08-20 20:22:39.048031 | instance | Downloading rjsonnet (1.2MiB) 2026-08-20 20:22:39.048058 | instance | Downloading pygments (1.2MiB) 2026-08-20 20:22:39.048085 | instance | Downloading netaddr (2.2MiB) 2026-08-20 20:22:39.048111 | instance | Downloading setuptools (1.1MiB) 2026-08-20 20:22:39.048137 | instance | Downloading kubernetes (1.9MiB) 2026-08-20 20:22:39.048164 | instance | Building pyperclip==1.9.0 2026-08-20 20:22:39.048191 | instance | Downloading rjsonnet 2026-08-20 20:22:39.048219 | instance | Downloading netaddr 2026-08-20 20:22:39.048246 | instance | Downloading pygments 2026-08-20 20:22:39.048273 | instance | Downloading cryptography 2026-08-20 20:22:39.048300 | instance | Downloading setuptools 2026-08-20 20:22:39.048326 | instance | Downloading kubernetes 2026-08-20 20:22:39.048353 | instance | Downloading ansible-core 2026-08-20 20:22:39.048378 | instance | Downloading openstacksdk 2026-08-20 20:22:39.048404 | instance | Built pyperclip==1.9.0 2026-08-20 20:22:39.048431 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-08-20 20:22:39.048459 | instance | Installed 79 packages in 35ms 2026-08-20 20:22:39.048696 | instance | Checked out ansible.posix to 1.6.0 2026-08-20 20:22:39.048742 | 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-20 20:22:39.048774 | instance | Starting galaxy collection install process 2026-08-20 20:22:39.048804 | instance | Process install dependency map 2026-08-20 20:22:39.048831 | instance | Starting collection install process 2026-08-20 20:22:39.048859 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-08-20 20:22:39.048894 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix 2026-08-20 20:22:39.048923 | instance | ansible.posix:1.6.0 was installed successfully 2026-08-20 20:22:39.048950 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:22:39.048996 | instance | 2.17.12 2026-08-20 20:22:39.049025 | instance | Checked out ansible.utils to v6.1.0 2026-08-20 20:22:39.049052 | 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-20 20:22:39.049079 | instance | Starting galaxy collection install process 2026-08-20 20:22:39.049107 | instance | Process install dependency map 2026-08-20 20:22:39.049134 | instance | Starting collection install process 2026-08-20 20:22:39.049162 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils' 2026-08-20 20:22:39.049188 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils 2026-08-20 20:22:39.049215 | instance | ansible.utils:6.1.0 was installed successfully 2026-08-20 20:22:39.049242 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:22:39.049268 | instance | 2.17.12 2026-08-20 20:22:39.049294 | instance | Checked out atmosphere.common to v0.7.0 2026-08-20 20:22:39.049319 | 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-20 20:22:39.049346 | instance | Starting galaxy collection install process 2026-08-20 20:22:39.049372 | instance | Process install dependency map 2026-08-20 20:22:39.049398 | instance | Starting collection install process 2026-08-20 20:22:39.049425 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common' 2026-08-20 20:22:39.049451 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common 2026-08-20 20:22:39.049478 | instance | atmosphere.common:0.7.0 was installed successfully 2026-08-20 20:22:39.049505 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:22:39.049531 | instance | 2.17.12 2026-08-20 20:22:39.049557 | instance | Checked out community.crypto to 2.2.3 2026-08-20 20:22:39.049585 | 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-20 20:22:39.049611 | instance | Starting galaxy collection install process 2026-08-20 20:22:39.049637 | instance | Process install dependency map 2026-08-20 20:22:39.049664 | instance | Starting collection install process 2026-08-20 20:22:39.049689 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-08-20 20:22:39.049716 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto 2026-08-20 20:22:39.049743 | instance | community.crypto:2.2.3 was installed successfully 2026-08-20 20:22:39.049769 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:22:39.049796 | instance | 2.17.12 2026-08-20 20:22:39.049823 | instance | Checked out community.general to 7.3.0 2026-08-20 20:22:39.049850 | 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-20 20:22:39.049878 | instance | Starting galaxy collection install process 2026-08-20 20:22:39.049913 | instance | Process install dependency map 2026-08-20 20:22:39.049941 | instance | Starting collection install process 2026-08-20 20:22:39.049988 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-08-20 20:22:39.050018 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general 2026-08-20 20:22:39.050046 | instance | community.general:7.3.0 was installed successfully 2026-08-20 20:22:39.050073 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:22:39.050102 | instance | 2.17.12 2026-08-20 20:22:39.050130 | instance | Checked out community.mysql to 3.6.0 2026-08-20 20:22:39.050158 | 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-20 20:22:39.050187 | instance | Starting galaxy collection install process 2026-08-20 20:22:39.050215 | instance | Process install dependency map 2026-08-20 20:22:39.050240 | instance | Starting collection install process 2026-08-20 20:22:39.050265 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql' 2026-08-20 20:22:39.050289 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql 2026-08-20 20:22:39.050313 | instance | community.mysql:3.6.0 was installed successfully 2026-08-20 20:22:39.050336 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:22:39.050359 | instance | 2.17.12 2026-08-20 20:22:39.050383 | instance | Checked out kubernetes.core to 2.4.0 2026-08-20 20:22:39.050406 | 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-20 20:22:39.050431 | instance | Starting galaxy collection install process 2026-08-20 20:22:39.050456 | instance | Process install dependency map 2026-08-20 20:22:39.050482 | instance | Starting collection install process 2026-08-20 20:22:39.050507 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core' 2026-08-20 20:22:39.050530 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core 2026-08-20 20:22:39.050552 | instance | kubernetes.core:2.4.0 was installed successfully 2026-08-20 20:22:39.050573 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:22:39.050596 | instance | 2.17.12 2026-08-20 20:22:39.050618 | instance | Checked out openstack.cloud to 2.6.0 2026-08-20 20:22:39.050640 | 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-20 20:22:39.050664 | instance | Starting galaxy collection install process 2026-08-20 20:22:39.050686 | instance | Process install dependency map 2026-08-20 20:22:39.050708 | instance | Starting collection install process 2026-08-20 20:22:39.050729 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud' 2026-08-20 20:22:39.050751 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud 2026-08-20 20:22:39.050774 | instance | openstack.cloud:2.6.0 was installed successfully 2026-08-20 20:22:39.050797 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:22:39.050818 | instance | 2.17.12 2026-08-20 20:22:39.050839 | instance | Checked out vexxhost.ceph to v4.2.0 2026-08-20 20:22:39.050861 | 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-20 20:22:39.050891 | instance | Starting galaxy collection install process 2026-08-20 20:22:39.050915 | instance | Process install dependency map 2026-08-20 20:22:39.050938 | instance | Starting collection install process 2026-08-20 20:22:39.050961 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph' 2026-08-20 20:22:39.050984 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph 2026-08-20 20:22:39.051007 | instance | vexxhost.ceph:4.2.0 was installed successfully 2026-08-20 20:22:39.051029 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:22:39.051050 | instance | 2.17.12 2026-08-20 20:22:39.051073 | instance | Checked out vexxhost.containers to v1.6.8 2026-08-20 20:22:39.054232 | 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-20 20:22:39.054284 | instance | Starting galaxy collection install process 2026-08-20 20:22:39.054311 | instance | Process install dependency map 2026-08-20 20:22:39.054333 | instance | Starting collection install process 2026-08-20 20:22:39.054355 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers' 2026-08-20 20:22:39.054376 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers 2026-08-20 20:22:39.054397 | instance | vexxhost.containers:1.6.8 was installed successfully 2026-08-20 20:22:39.054418 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:22:39.054438 | instance | 2.17.12 2026-08-20 20:22:39.054459 | instance | Checked out vexxhost.kubernetes to v3.3.0 2026-08-20 20:22:39.054480 | 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-20 20:22:39.054501 | instance | Starting galaxy collection install process 2026-08-20 20:22:39.054521 | instance | Process install dependency map 2026-08-20 20:22:39.054541 | instance | Starting collection install process 2026-08-20 20:22:39.054561 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes' 2026-08-20 20:22:39.054581 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes 2026-08-20 20:22:39.054601 | instance | vexxhost.kubernetes:3.3.0 was installed successfully 2026-08-20 20:22:39.054621 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:22:39.054640 | instance | 2.17.12 2026-08-20 20:22:39.067428 | 2026-08-20 20:22:39.067550 | PLAY RECAP 2026-08-20 20:22:39.067598 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-20 20:22:39.067621 | 2026-08-20 20:22:39.198909 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-20 20:22:39.205388 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-08-20 20:22:39.894233 | 2026-08-20 20:22:39.894349 | PLAY [all] 2026-08-20 20:22:39.908152 | 2026-08-20 20:22:39.908235 | TASK [Install "jq" for log collection] 2026-08-20 20:23:20.077763 | instance | changed 2026-08-20 20:23:20.081824 | 2026-08-20 20:23:20.081955 | PLAY RECAP 2026-08-20 20:23:20.082024 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-20 20:23:20.082076 | 2026-08-20 20:23:20.214127 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-08-20 20:23:20.219023 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-20 20:23:20.870350 | 2026-08-20 20:23:20.870467 | PLAY [all] 2026-08-20 20:23:20.882146 | 2026-08-20 20:23:20.882430 | LOOP [Check inventory directories] 2026-08-20 20:23:21.259760 | instance | ok: "src/github.com/vexxhost/atmosphere" 2026-08-20 20:23:21.415088 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory" 2026-08-20 20:23:21.567831 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory" 2026-08-20 20:23:21.586306 | 2026-08-20 20:23:21.586480 | LOOP [Copy inventory file for Zuul] 2026-08-20 20:23:22.479770 | instance | changed: 2026-08-20 20:23:22.540602 | instance | { 2026-08-20 20:23:22.540768 | instance | "ansible_loop_var": "item", 2026-08-20 20:23:22.540819 | instance | "changed": false, 2026-08-20 20:23:22.541160 | instance | "failed": false, 2026-08-20 20:23:22.541358 | instance | "invocation": { 2026-08-20 20:23:22.541468 | instance | "module_args": { 2026-08-20 20:23:22.541507 | instance | "checksum_algorithm": "sha1", 2026-08-20 20:23:22.541539 | instance | "follow": true, 2026-08-20 20:23:22.541571 | instance | "get_attributes": true, 2026-08-20 20:23:22.541604 | instance | "get_checksum": true, 2026-08-20 20:23:22.541635 | instance | "get_mime": true, 2026-08-20 20:23:22.541665 | instance | "path": "src/github.com/vexxhost/atmosphere" 2026-08-20 20:23:22.541697 | instance | } 2026-08-20 20:23:22.541726 | instance | }, 2026-08-20 20:23:22.541756 | instance | "item": "src/github.com/vexxhost/atmosphere", 2026-08-20 20:23:22.541785 | instance | "stat": { 2026-08-20 20:23:22.541815 | instance | "atime": 1787257351.8363814, 2026-08-20 20:23:22.541845 | instance | "attr_flags": "e", 2026-08-20 20:23:22.541875 | instance | "attributes": [ 2026-08-20 20:23:22.541905 | instance | "extents" 2026-08-20 20:23:22.541935 | instance | ], 2026-08-20 20:23:22.541968 | instance | "block_size": 4096, 2026-08-20 20:23:22.541993 | instance | "blocks": 8, 2026-08-20 20:23:22.542024 | instance | "charset": "unknown", 2026-08-20 20:23:22.542059 | instance | "ctime": 1787257350.792291, 2026-08-20 20:23:22.542086 | instance | "dev": 64513, 2026-08-20 20:23:22.542111 | instance | "device_type": 0, 2026-08-20 20:23:22.542136 | instance | "executable": true, 2026-08-20 20:23:22.542160 | instance | "exists": true, 2026-08-20 20:23:22.542184 | instance | "gid": 1000, 2026-08-20 20:23:22.542208 | instance | "gr_name": "zuul", 2026-08-20 20:23:22.542231 | instance | "inode": 1047466, 2026-08-20 20:23:22.542255 | instance | "isblk": false, 2026-08-20 20:23:22.542280 | instance | "ischr": false, 2026-08-20 20:23:22.542304 | instance | "isdir": true, 2026-08-20 20:23:22.542328 | instance | "isfifo": false, 2026-08-20 20:23:22.542357 | instance | "isgid": false, 2026-08-20 20:23:22.542392 | instance | "islnk": false, 2026-08-20 20:23:22.542427 | instance | "isreg": false, 2026-08-20 20:23:22.542462 | instance | "issock": false, 2026-08-20 20:23:22.542492 | instance | "isuid": false, 2026-08-20 20:23:22.542520 | instance | "mimetype": "unknown", 2026-08-20 20:23:22.542803 | instance | "mode": "0755", 2026-08-20 20:23:22.542919 | instance | "mtime": 1787257350.792291, 2026-08-20 20:23:22.543075 | instance | "nlink": 21, 2026-08-20 20:23:22.543199 | instance | "path": "src/github.com/vexxhost/atmosphere", 2026-08-20 20:23:22.543312 | instance | "pw_name": "zuul", 2026-08-20 20:23:22.543364 | instance | "readable": true, 2026-08-20 20:23:22.543477 | instance | "rgrp": true, 2026-08-20 20:23:22.543629 | instance | "roth": true, 2026-08-20 20:23:22.543667 | instance | "rusr": true, 2026-08-20 20:23:22.543700 | instance | "size": 4096, 2026-08-20 20:23:22.543732 | instance | "uid": 1000, 2026-08-20 20:23:22.543778 | instance | "version": "3616266252", 2026-08-20 20:23:22.543813 | instance | "wgrp": false, 2026-08-20 20:23:22.543852 | instance | "woth": false, 2026-08-20 20:23:22.543890 | instance | "writeable": true, 2026-08-20 20:23:22.543928 | instance | "wusr": true, 2026-08-20 20:23:22.543962 | instance | "xgrp": true, 2026-08-20 20:23:22.543997 | instance | "xoth": true, 2026-08-20 20:23:22.544033 | instance | "xusr": true 2026-08-20 20:23:22.544068 | instance | } 2026-08-20 20:23:22.544101 | instance | } 2026-08-20 20:23:22.544187 | instance | ok: All items complete 2026-08-20 20:23:22.544226 | 2026-08-20 20:23:22.546861 | instance | skipping: Conditional result was False 2026-08-20 20:23:22.547807 | instance | skipping: Conditional result was False 2026-08-20 20:23:22.564469 | 2026-08-20 20:23:22.564599 | LOOP [Switch "ansible_host" to private IP] 2026-08-20 20:23:22.905089 | instance | changed: 1 replacements made 2026-08-20 20:23:22.907162 | instance | skipping: Conditional result was False 2026-08-20 20:23:22.909009 | instance | skipping: Conditional result was False 2026-08-20 20:23:22.931007 | 2026-08-20 20:23:22.931221 | TASK [Run Molecule scenario] 2026-08-20 20:23:23.913208 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-08-20 20:23:24.333315 | instance | INFO [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-08-20 20:23:24.333397 | instance | INFO [csi > prerun] Performing prerun with role_name_check=0... 2026-08-20 20:23:35.557493 | instance | INFO [csi > dependency] Executing 2026-08-20 20:23:35.557750 | instance | WARNING [csi > dependency] Missing roles requirements file: requirements.yml 2026-08-20 20:23:35.558042 | instance | WARNING [csi > dependency] Missing collections requirements file: collections.yml 2026-08-20 20:23:35.558203 | instance | WARNING [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-08-20 20:23:35.566445 | instance | INFO [csi > cleanup] Executing 2026-08-20 20:23:35.566761 | instance | WARNING [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-20 20:23:35.579546 | instance | INFO [csi > destroy] Executing 2026-08-20 20:23:35.579678 | instance | WARNING [csi > destroy] Skipping, '--destroy=never' requested. 2026-08-20 20:23:35.579854 | instance | INFO [csi > destroy] Executed: Successful 2026-08-20 20:23:35.590919 | instance | INFO [csi > syntax] Executing 2026-08-20 20:23:37.280619 | instance | 2026-08-20 20:23:37.281020 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-08-20 20:23:37.350794 | instance | INFO [csi > syntax] Executed: Successful 2026-08-20 20:23:37.362452 | instance | INFO [csi > create] Executing 2026-08-20 20:23:37.365098 | instance | WARNING [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-20 20:23:37.373675 | instance | INFO [csi > prepare] Executing 2026-08-20 20:23:38.152433 | instance | 2026-08-20 20:23:38.152784 | instance | PLAY [Prepare] ***************************************************************** 2026-08-20 20:23:38.153156 | instance | 2026-08-20 20:23:38.153535 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-20 20:23:38.153912 | instance | Thursday 20 August 2026 20:23:38 +0000 (0:00:00.026) 0:00:00.026 ******* 2026-08-20 20:23:39.309318 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-08-20 20:23:39.309565 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-08-20 20:23:39.309848 | instance | interpreter could change the meaning of that path. See 2026-08-20 20:23:39.310124 | instance | https://docs.ansible.com/ansible- 2026-08-20 20:23:39.310472 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-08-20 20:23:39.317231 | instance | ok: [instance] 2026-08-20 20:23:39.317487 | instance | 2026-08-20 20:23:39.317800 | instance | TASK [Configure short hostname] ************************************************ 2026-08-20 20:23:39.318091 | instance | Thursday 20 August 2026 20:23:39 +0000 (0:00:01.165) 0:00:01.191 ******* 2026-08-20 20:23:40.077030 | instance | changed: [instance] 2026-08-20 20:23:40.077273 | instance | 2026-08-20 20:23:40.077581 | instance | TASK [Ensure hostname inside hosts file] *************************************** 2026-08-20 20:23:40.077865 | instance | Thursday 20 August 2026 20:23:40 +0000 (0:00:00.759) 0:00:01.951 ******* 2026-08-20 20:23:40.326991 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created 2026-08-20 20:23:40.327295 | instance | with a mode of 0700, this may cause issues when running as another user. To 2026-08-20 20:23:40.327579 | instance | avoid this, create the remote_tmp dir with the correct permissions manually 2026-08-20 20:23:40.335850 | instance | changed: [instance] 2026-08-20 20:23:40.335959 | instance | 2026-08-20 20:23:40.336143 | instance | TASK [Purge "snapd" package] *************************************************** 2026-08-20 20:23:40.336332 | instance | Thursday 20 August 2026 20:23:40 +0000 (0:00:00.259) 0:00:02.210 ******* 2026-08-20 20:23:41.099153 | instance | ok: [instance] 2026-08-20 20:23:41.099437 | instance | 2026-08-20 20:23:41.099748 | instance | PLAY [Create devices for Ceph] ************************************************* 2026-08-20 20:23:41.100037 | instance | 2026-08-20 20:23:41.100327 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-20 20:23:41.100691 | instance | Thursday 20 August 2026 20:23:41 +0000 (0:00:00.763) 0:00:02.973 ******* 2026-08-20 20:23:41.805301 | instance | ok: [instance] 2026-08-20 20:23:41.805540 | instance | 2026-08-20 20:23:41.805850 | instance | TASK [Install depedencies] ***************************************************** 2026-08-20 20:23:41.806214 | instance | Thursday 20 August 2026 20:23:41 +0000 (0:00:00.706) 0:00:03.679 ******* 2026-08-20 20:24:02.712898 | instance | changed: [instance] 2026-08-20 20:24:02.712994 | instance | 2026-08-20 20:24:02.713159 | instance | TASK [Start up service] ******************************************************** 2026-08-20 20:24:02.713353 | instance | Thursday 20 August 2026 20:24:02 +0000 (0:00:20.907) 0:00:24.587 ******* 2026-08-20 20:24:03.254341 | instance | ok: [instance] 2026-08-20 20:24:03.254597 | instance | 2026-08-20 20:24:03.254954 | instance | TASK [Generate lvm.conf] ******************************************************* 2026-08-20 20:24:03.255210 | instance | Thursday 20 August 2026 20:24:03 +0000 (0:00:00.540) 0:00:25.128 ******* 2026-08-20 20:24:03.549437 | instance | ok: [instance] 2026-08-20 20:24:03.549692 | instance | 2026-08-20 20:24:03.550074 | instance | TASK [Write /etc/lvm/lvm.conf] ************************************************* 2026-08-20 20:24:03.550419 | instance | Thursday 20 August 2026 20:24:03 +0000 (0:00:00.295) 0:00:25.423 ******* 2026-08-20 20:24:04.182113 | instance | changed: [instance] 2026-08-20 20:24:04.182357 | instance | 2026-08-20 20:24:04.182573 | instance | TASK [Get list of all loopback devices] **************************************** 2026-08-20 20:24:04.182782 | instance | Thursday 20 August 2026 20:24:04 +0000 (0:00:00.632) 0:00:26.056 ******* 2026-08-20 20:24:04.368394 | instance | ok: [instance] 2026-08-20 20:24:04.368574 | instance | 2026-08-20 20:24:04.368865 | instance | TASK [Fail if there is any existing loopback devices] ************************** 2026-08-20 20:24:04.369092 | instance | Thursday 20 August 2026 20:24:04 +0000 (0:00:00.186) 0:00:26.242 ******* 2026-08-20 20:24:04.392638 | instance | skipping: [instance] 2026-08-20 20:24:04.392968 | instance | 2026-08-20 20:24:04.393262 | instance | TASK [Create devices for Ceph] ************************************************* 2026-08-20 20:24:04.393589 | instance | Thursday 20 August 2026 20:24:04 +0000 (0:00:00.024) 0:00:26.267 ******* 2026-08-20 20:24:04.954833 | instance | changed: [instance] => (item=osd0) 2026-08-20 20:24:04.955668 | instance | changed: [instance] => (item=osd1) 2026-08-20 20:24:04.955689 | instance | changed: [instance] => (item=osd2) 2026-08-20 20:24:04.955698 | instance | 2026-08-20 20:24:04.955705 | instance | TASK [Set permissions on loopback devices] ************************************* 2026-08-20 20:24:04.955711 | instance | Thursday 20 August 2026 20:24:04 +0000 (0:00:00.561) 0:00:26.829 ******* 2026-08-20 20:24:05.581955 | instance | changed: [instance] => (item=osd0) 2026-08-20 20:24:05.582774 | instance | changed: [instance] => (item=osd1) 2026-08-20 20:24:05.582796 | instance | changed: [instance] => (item=osd2) 2026-08-20 20:24:05.582803 | instance | 2026-08-20 20:24:05.582809 | instance | TASK [Start loop devices] ****************************************************** 2026-08-20 20:24:05.582815 | instance | Thursday 20 August 2026 20:24:05 +0000 (0:00:00.627) 0:00:27.456 ******* 2026-08-20 20:24:06.276212 | instance | changed: [instance] => (item=osd0) 2026-08-20 20:24:06.276253 | instance | changed: [instance] => (item=osd1) 2026-08-20 20:24:06.276261 | instance | changed: [instance] => (item=osd2) 2026-08-20 20:24:06.276267 | instance | 2026-08-20 20:24:06.276274 | instance | TASK [Create a volume group for each loop device] ****************************** 2026-08-20 20:24:06.276280 | instance | Thursday 20 August 2026 20:24:06 +0000 (0:00:00.693) 0:00:28.149 ******* 2026-08-20 20:24:09.592791 | instance | changed: [instance] => (item=osd0) 2026-08-20 20:24:09.592869 | instance | changed: [instance] => (item=osd1) 2026-08-20 20:24:09.593484 | instance | changed: [instance] => (item=osd2) 2026-08-20 20:24:09.594249 | instance | 2026-08-20 20:24:09.594281 | instance | TASK [Create a logical volume for each loop device] **************************** 2026-08-20 20:24:09.594293 | instance | Thursday 20 August 2026 20:24:09 +0000 (0:00:03.317) 0:00:31.466 ******* 2026-08-20 20:24:11.401106 | instance | changed: [instance] => (item=ceph-instance-osd0) 2026-08-20 20:24:11.401575 | instance | changed: [instance] => (item=ceph-instance-osd1) 2026-08-20 20:24:11.401620 | instance | changed: [instance] => (item=ceph-instance-osd2) 2026-08-20 20:24:11.402423 | instance | 2026-08-20 20:24:11.402449 | instance | PLAY RECAP ********************************************************************* 2026-08-20 20:24:11.402459 | instance | instance : ok=15 changed=9 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-08-20 20:24:11.402468 | instance | 2026-08-20 20:24:11.404667 | instance | Thursday 20 August 2026 20:24:11 +0000 (0:00:01.809) 0:00:33.276 ******* 2026-08-20 20:24:11.404693 | instance | =============================================================================== 2026-08-20 20:24:11.404703 | instance | Install depedencies ---------------------------------------------------- 20.91s 2026-08-20 20:24:11.404711 | instance | Create a volume group for each loop device ------------------------------ 3.32s 2026-08-20 20:24:11.404720 | instance | Create a logical volume for each loop device ---------------------------- 1.81s 2026-08-20 20:24:11.404728 | instance | Gathering Facts --------------------------------------------------------- 1.17s 2026-08-20 20:24:11.404737 | instance | Purge "snapd" package --------------------------------------------------- 0.76s 2026-08-20 20:24:11.404745 | instance | Configure short hostname ------------------------------------------------ 0.76s 2026-08-20 20:24:11.404753 | instance | Gathering Facts --------------------------------------------------------- 0.71s 2026-08-20 20:24:11.404761 | instance | Start loop devices ------------------------------------------------------ 0.69s 2026-08-20 20:24:11.404769 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.63s 2026-08-20 20:24:11.404781 | instance | Set permissions on loopback devices ------------------------------------- 0.63s 2026-08-20 20:24:11.405561 | instance | Create devices for Ceph ------------------------------------------------- 0.56s 2026-08-20 20:24:11.405578 | instance | Start up service -------------------------------------------------------- 0.54s 2026-08-20 20:24:11.405585 | instance | Generate lvm.conf ------------------------------------------------------- 0.30s 2026-08-20 20:24:11.405590 | instance | Ensure hostname inside hosts file --------------------------------------- 0.26s 2026-08-20 20:24:11.405596 | instance | Get list of all loopback devices ---------------------------------------- 0.19s 2026-08-20 20:24:11.405601 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s 2026-08-20 20:24:11.477292 | instance | INFO [csi > prepare] Executed: Successful 2026-08-20 20:24:11.487885 | instance | INFO [csi > converge] Executing 2026-08-20 20:24:13.064847 | instance | 2026-08-20 20:24:13.065292 | instance | PLAY [Debug CSI driver value] ************************************************** 2026-08-20 20:24:13.065642 | instance | 2026-08-20 20:24:13.066025 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-20 20:24:13.066384 | instance | Thursday 20 August 2026 20:24:13 +0000 (0:00:00.007) 0:00:00.007 ******* 2026-08-20 20:24:14.052791 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-08-20 20:24:14.053252 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-08-20 20:24:14.053597 | instance | interpreter could change the meaning of that path. See 2026-08-20 20:24:14.053983 | instance | https://docs.ansible.com/ansible- 2026-08-20 20:24:14.054380 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-08-20 20:24:14.061850 | instance | ok: [instance] 2026-08-20 20:24:14.062101 | instance | 2026-08-20 20:24:14.062342 | instance | TASK [Display CSI driver value and environment variable] *********************** 2026-08-20 20:24:14.062568 | instance | Thursday 20 August 2026 20:24:14 +0000 (0:00:00.997) 0:00:01.005 ******* 2026-08-20 20:24:14.108014 | instance | ok: [instance] => { 2026-08-20 20:24:14.108242 | instance | "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER=" 2026-08-20 20:24:14.108420 | instance | } 2026-08-20 20:24:14.108686 | instance | 2026-08-20 20:24:14.108846 | instance | PLAY [all] ********************************************************************* 2026-08-20 20:24:14.109013 | instance | 2026-08-20 20:24:14.109186 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-20 20:24:14.109366 | instance | Thursday 20 August 2026 20:24:14 +0000 (0:00:00.045) 0:00:01.051 ******* 2026-08-20 20:24:14.977091 | instance | ok: [instance] 2026-08-20 20:24:14.977507 | instance | 2026-08-20 20:24:14.977985 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-08-20 20:24:14.978373 | instance | Thursday 20 August 2026 20:24:14 +0000 (0:00:00.868) 0:00:01.920 ******* 2026-08-20 20:24:15.159425 | instance | ok: [instance] 2026-08-20 20:24:15.159832 | instance | 2026-08-20 20:24:15.160191 | instance | PLAY [Deploy Ceph monitors & managers] ***************************************** 2026-08-20 20:24:15.160555 | instance | 2026-08-20 20:24:15.160935 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-20 20:24:15.161284 | instance | Thursday 20 August 2026 20:24:15 +0000 (0:00:00.182) 0:00:02.103 ******* 2026-08-20 20:24:16.017024 | instance | ok: [instance] 2026-08-20 20:24:16.017219 | instance | 2026-08-20 20:24:16.017384 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-20 20:24:16.017550 | instance | Thursday 20 August 2026 20:24:16 +0000 (0:00:00.854) 0:00:02.957 ******* 2026-08-20 20:24:16.299273 | instance | ok: [instance] 2026-08-20 20:24:16.299553 | instance | 2026-08-20 20:24:16.299795 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-20 20:24:16.300036 | instance | Thursday 20 August 2026 20:24:16 +0000 (0:00:00.284) 0:00:03.242 ******* 2026-08-20 20:24:16.339621 | instance | skipping: [instance] 2026-08-20 20:24:16.339885 | instance | 2026-08-20 20:24:16.340111 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-08-20 20:24:16.340395 | instance | Thursday 20 August 2026 20:24:16 +0000 (0:00:00.040) 0:00:03.283 ******* 2026-08-20 20:24:16.683860 | instance | changed: [instance] 2026-08-20 20:24:16.684336 | instance | 2026-08-20 20:24:16.684816 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-20 20:24:16.685206 | instance | Thursday 20 August 2026 20:24:16 +0000 (0:00:00.343) 0:00:03.627 ******* 2026-08-20 20:24:16.751577 | instance | ok: [instance] => { 2026-08-20 20:24:16.752042 | instance | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-08-20 20:24:16.752515 | instance | } 2026-08-20 20:24:16.752929 | instance | 2026-08-20 20:24:16.753320 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-20 20:24:16.753716 | instance | Thursday 20 August 2026 20:24:16 +0000 (0:00:00.067) 0:00:03.694 ******* 2026-08-20 20:24:17.383759 | instance | changed: [instance] 2026-08-20 20:24:17.384156 | instance | 2026-08-20 20:24:17.384648 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-20 20:24:17.385042 | instance | Thursday 20 August 2026 20:24:17 +0000 (0:00:00.631) 0:00:04.326 ******* 2026-08-20 20:24:17.433131 | instance | skipping: [instance] 2026-08-20 20:24:17.433516 | instance | 2026-08-20 20:24:17.433907 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-20 20:24:17.434372 | instance | Thursday 20 August 2026 20:24:17 +0000 (0:00:00.047) 0:00:04.374 ******* 2026-08-20 20:24:17.481149 | instance | skipping: [instance] 2026-08-20 20:24:17.481270 | instance | 2026-08-20 20:24:17.481511 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-20 20:24:17.481684 | instance | Thursday 20 August 2026 20:24:17 +0000 (0:00:00.047) 0:00:04.422 ******* 2026-08-20 20:24:17.697065 | instance | ok: [instance] 2026-08-20 20:24:17.697144 | instance | 2026-08-20 20:24:17.697251 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-20 20:24:17.697540 | instance | Thursday 20 August 2026 20:24:17 +0000 (0:00:00.216) 0:00:04.639 ******* 2026-08-20 20:24:18.933235 | instance | ok: [instance] 2026-08-20 20:24:18.933464 | instance | 2026-08-20 20:24:18.933821 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-20 20:24:18.934217 | instance | Thursday 20 August 2026 20:24:18 +0000 (0:00:01.236) 0:00:05.875 ******* 2026-08-20 20:24:19.011987 | instance | ok: [instance] => { 2026-08-20 20:24:19.012213 | instance | "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz" 2026-08-20 20:24:19.012381 | instance | } 2026-08-20 20:24:19.012553 | instance | 2026-08-20 20:24:19.012731 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-20 20:24:19.012893 | instance | Thursday 20 August 2026 20:24:19 +0000 (0:00:00.077) 0:00:05.953 ******* 2026-08-20 20:24:19.769264 | instance | changed: [instance] 2026-08-20 20:24:19.769700 | instance | 2026-08-20 20:24:19.770088 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-20 20:24:19.770439 | instance | Thursday 20 August 2026 20:24:19 +0000 (0:00:00.758) 0:00:06.712 ******* 2026-08-20 20:24:22.617778 | instance | changed: [instance] 2026-08-20 20:24:22.618179 | instance | 2026-08-20 20:24:22.618542 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-08-20 20:24:22.618920 | instance | Thursday 20 August 2026 20:24:22 +0000 (0:00:02.848) 0:00:09.561 ******* 2026-08-20 20:24:22.650256 | instance | skipping: [instance] 2026-08-20 20:24:22.650460 | instance | 2026-08-20 20:24:22.650639 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-08-20 20:24:22.650805 | instance | Thursday 20 August 2026 20:24:22 +0000 (0:00:00.032) 0:00:09.593 ******* 2026-08-20 20:24:22.682718 | instance | skipping: [instance] 2026-08-20 20:24:22.683066 | instance | 2026-08-20 20:24:22.683653 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-08-20 20:24:22.684010 | instance | Thursday 20 August 2026 20:24:22 +0000 (0:00:00.032) 0:00:09.626 ******* 2026-08-20 20:24:22.711757 | instance | skipping: [instance] 2026-08-20 20:24:22.712127 | instance | 2026-08-20 20:24:22.712562 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-08-20 20:24:22.712921 | instance | Thursday 20 August 2026 20:24:22 +0000 (0:00:00.028) 0:00:09.655 ******* 2026-08-20 20:24:28.463114 | instance | changed: [instance] 2026-08-20 20:24:28.463207 | instance | 2026-08-20 20:24:28.463219 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] *** 2026-08-20 20:24:28.463230 | instance | Thursday 20 August 2026 20:24:28 +0000 (0:00:05.749) 0:00:15.404 ******* 2026-08-20 20:24:29.052082 | instance | changed: [instance] 2026-08-20 20:24:29.052188 | instance | 2026-08-20 20:24:29.052413 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] ******* 2026-08-20 20:24:29.052449 | instance | Thursday 20 August 2026 20:24:29 +0000 (0:00:00.590) 0:00:15.995 ******* 2026-08-20 20:24:29.941865 | instance | changed: [instance] => (item={'path': '/etc/containerd'}) 2026-08-20 20:24:29.941943 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'}) 2026-08-20 20:24:29.942749 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'}) 2026-08-20 20:24:29.942787 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'}) 2026-08-20 20:24:29.942794 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'}) 2026-08-20 20:24:29.942799 | instance | 2026-08-20 20:24:29.942807 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] ********** 2026-08-20 20:24:29.942812 | instance | Thursday 20 August 2026 20:24:29 +0000 (0:00:00.889) 0:00:16.885 ******* 2026-08-20 20:24:30.510908 | instance | changed: [instance] 2026-08-20 20:24:30.511001 | instance | 2026-08-20 20:24:30.511609 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ******** 2026-08-20 20:24:30.511625 | instance | Thursday 20 August 2026 20:24:30 +0000 (0:00:00.552) 0:00:17.437 ******* 2026-08-20 20:24:30.511630 | instance | 2026-08-20 20:24:30.511634 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-08-20 20:24:30.511638 | instance | Thursday 20 August 2026 20:24:30 +0000 (0:00:00.016) 0:00:17.454 ******* 2026-08-20 20:24:31.426709 | instance | ok: [instance] 2026-08-20 20:24:31.426776 | instance | 2026-08-20 20:24:31.427067 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] ********** 2026-08-20 20:24:31.427103 | instance | Thursday 20 August 2026 20:24:31 +0000 (0:00:00.915) 0:00:18.370 ******* 2026-08-20 20:24:31.874375 | instance | changed: [instance] 2026-08-20 20:24:31.874480 | instance | 2026-08-20 20:24:31.874751 | instance | TASK [vexxhost.containers.containerd : Enable and start service] *************** 2026-08-20 20:24:31.874947 | instance | Thursday 20 August 2026 20:24:31 +0000 (0:00:00.447) 0:00:18.818 ******* 2026-08-20 20:24:32.399419 | instance | changed: [instance] 2026-08-20 20:24:32.399514 | instance | 2026-08-20 20:24:32.399765 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-20 20:24:32.399781 | instance | Thursday 20 August 2026 20:24:32 +0000 (0:00:00.525) 0:00:19.343 ******* 2026-08-20 20:24:32.606582 | instance | ok: [instance] 2026-08-20 20:24:32.606659 | instance | 2026-08-20 20:24:32.606982 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-20 20:24:32.607019 | instance | Thursday 20 August 2026 20:24:32 +0000 (0:00:00.207) 0:00:19.550 ******* 2026-08-20 20:24:32.666979 | instance | ok: [instance] => { 2026-08-20 20:24:32.667049 | instance | "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz" 2026-08-20 20:24:32.667636 | instance | } 2026-08-20 20:24:32.667677 | instance | 2026-08-20 20:24:32.667682 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-20 20:24:32.667687 | instance | Thursday 20 August 2026 20:24:32 +0000 (0:00:00.060) 0:00:19.610 ******* 2026-08-20 20:24:33.422434 | instance | changed: [instance] 2026-08-20 20:24:33.422521 | instance | 2026-08-20 20:24:33.422817 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-20 20:24:33.422950 | instance | Thursday 20 August 2026 20:24:33 +0000 (0:00:00.755) 0:00:20.366 ******* 2026-08-20 20:24:37.867287 | instance | changed: [instance] 2026-08-20 20:24:37.867391 | instance | 2026-08-20 20:24:37.867757 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ****************** 2026-08-20 20:24:37.867822 | instance | Thursday 20 August 2026 20:24:37 +0000 (0:00:04.444) 0:00:24.810 ******* 2026-08-20 20:24:38.986557 | instance | ok: [instance] 2026-08-20 20:24:38.986630 | instance | 2026-08-20 20:24:38.986943 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] *************** 2026-08-20 20:24:38.987011 | instance | Thursday 20 August 2026 20:24:38 +0000 (0:00:01.118) 0:00:25.929 ******* 2026-08-20 20:24:39.370541 | instance | changed: [instance] 2026-08-20 20:24:39.371084 | instance | 2026-08-20 20:24:39.371132 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] ***** 2026-08-20 20:24:39.371141 | instance | Thursday 20 August 2026 20:24:39 +0000 (0:00:00.384) 0:00:26.313 ******* 2026-08-20 20:24:39.832045 | instance | changed: [instance] 2026-08-20 20:24:39.832126 | instance | 2026-08-20 20:24:39.832427 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] *********** 2026-08-20 20:24:39.832465 | instance | Thursday 20 August 2026 20:24:39 +0000 (0:00:00.461) 0:00:26.775 ******* 2026-08-20 20:24:40.388627 | instance | changed: [instance] => (item={'path': '/etc/docker'}) 2026-08-20 20:24:40.388698 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'}) 2026-08-20 20:24:40.388710 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'}) 2026-08-20 20:24:40.388721 | instance | 2026-08-20 20:24:40.388731 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ****** 2026-08-20 20:24:40.388748 | instance | Thursday 20 August 2026 20:24:40 +0000 (0:00:00.555) 0:00:27.331 ******* 2026-08-20 20:24:40.851009 | instance | changed: [instance] 2026-08-20 20:24:40.851073 | instance | 2026-08-20 20:24:40.851355 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] *********** 2026-08-20 20:24:40.851394 | instance | Thursday 20 August 2026 20:24:40 +0000 (0:00:00.462) 0:00:27.794 ******* 2026-08-20 20:24:41.346826 | instance | changed: [instance] 2026-08-20 20:24:41.346908 | instance | 2026-08-20 20:24:41.347574 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************ 2026-08-20 20:24:41.347613 | instance | Thursday 20 August 2026 20:24:41 +0000 (0:00:00.479) 0:00:28.273 ******* 2026-08-20 20:24:41.347619 | instance | 2026-08-20 20:24:41.347624 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-08-20 20:24:41.347628 | instance | Thursday 20 August 2026 20:24:41 +0000 (0:00:00.016) 0:00:28.290 ******* 2026-08-20 20:24:42.065247 | instance | ok: [instance] 2026-08-20 20:24:42.065281 | instance | 2026-08-20 20:24:42.065286 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ****************** 2026-08-20 20:24:42.065296 | instance | Thursday 20 August 2026 20:24:42 +0000 (0:00:00.718) 0:00:29.008 ******* 2026-08-20 20:24:42.975817 | instance | changed: [instance] 2026-08-20 20:24:42.975935 | instance | 2026-08-20 20:24:42.976210 | instance | TASK [vexxhost.containers.docker : Enable and start service] ******************* 2026-08-20 20:24:42.976255 | instance | Thursday 20 August 2026 20:24:42 +0000 (0:00:00.910) 0:00:29.919 ******* 2026-08-20 20:24:43.521106 | instance | changed: [instance] 2026-08-20 20:24:43.521178 | instance | 2026-08-20 20:24:43.521484 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ****** 2026-08-20 20:24:43.521519 | instance | Thursday 20 August 2026 20:24:43 +0000 (0:00:00.545) 0:00:30.464 ******* 2026-08-20 20:24:43.577865 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml) 2026-08-20 20:24:43.577926 | instance | 2026-08-20 20:24:43.578215 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ******************************** 2026-08-20 20:24:43.578250 | instance | Thursday 20 August 2026 20:24:43 +0000 (0:00:00.056) 0:00:30.521 ******* 2026-08-20 20:24:48.654876 | instance | changed: [instance] 2026-08-20 20:24:48.654949 | instance | 2026-08-20 20:24:48.654955 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] ********************* 2026-08-20 20:24:48.654961 | instance | Thursday 20 August 2026 20:24:48 +0000 (0:00:05.075) 0:00:35.596 ******* 2026-08-20 20:24:49.341966 | instance | ok: [instance] => (item=chronyd) 2026-08-20 20:24:49.342041 | instance | ok: [instance] => (item=sshd) 2026-08-20 20:24:49.342431 | instance | 2026-08-20 20:24:49.342472 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ****************************** 2026-08-20 20:24:49.342478 | instance | Thursday 20 August 2026 20:24:49 +0000 (0:00:00.688) 0:00:36.285 ******* 2026-08-20 20:24:51.372367 | instance | changed: [instance] 2026-08-20 20:24:51.372573 | instance | 2026-08-20 20:24:51.372773 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ******************** 2026-08-20 20:24:51.372889 | instance | Thursday 20 August 2026 20:24:51 +0000 (0:00:02.030) 0:00:38.315 ******* 2026-08-20 20:24:51.583081 | instance | ok: [instance] 2026-08-20 20:24:51.583345 | instance | 2026-08-20 20:24:51.583675 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] **************** 2026-08-20 20:24:51.584041 | instance | Thursday 20 August 2026 20:24:51 +0000 (0:00:00.210) 0:00:38.526 ******* 2026-08-20 20:24:52.054416 | instance | changed: [instance] 2026-08-20 20:24:52.054635 | instance | 2026-08-20 20:24:52.054930 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] *** 2026-08-20 20:24:52.055231 | instance | Thursday 20 August 2026 20:24:52 +0000 (0:00:00.471) 0:00:38.997 ******* 2026-08-20 20:24:52.394565 | instance | changed: [instance] 2026-08-20 20:24:52.394772 | instance | 2026-08-20 20:24:52.395060 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] ************************* 2026-08-20 20:24:52.395338 | instance | Thursday 20 August 2026 20:24:52 +0000 (0:00:00.340) 0:00:39.337 ******* 2026-08-20 20:24:52.510202 | instance | ok: [instance] 2026-08-20 20:24:52.510469 | instance | 2026-08-20 20:24:52.510791 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] ******************* 2026-08-20 20:24:52.511146 | instance | Thursday 20 August 2026 20:24:52 +0000 (0:00:00.115) 0:00:39.453 ******* 2026-08-20 20:24:52.752380 | instance | ok: [instance] => (item=instance) 2026-08-20 20:24:52.752669 | instance | 2026-08-20 20:24:52.753055 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ******** 2026-08-20 20:24:52.753338 | instance | Thursday 20 August 2026 20:24:52 +0000 (0:00:00.242) 0:00:39.695 ******* 2026-08-20 20:24:52.802754 | instance | ok: [instance] 2026-08-20 20:24:52.802870 | instance | 2026-08-20 20:24:52.803055 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] *********************************** 2026-08-20 20:24:52.803224 | instance | Thursday 20 August 2026 20:24:52 +0000 (0:00:00.050) 0:00:39.746 ******* 2026-08-20 20:24:52.874327 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance 2026-08-20 20:24:52.874377 | instance | 2026-08-20 20:24:52.874529 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] ************* 2026-08-20 20:24:52.874654 | instance | Thursday 20 August 2026 20:24:52 +0000 (0:00:00.071) 0:00:39.817 ******* 2026-08-20 20:24:53.190816 | instance | changed: [instance] 2026-08-20 20:24:53.190912 | instance | 2026-08-20 20:24:53.191099 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ****************** 2026-08-20 20:24:53.191304 | instance | Thursday 20 August 2026 20:24:53 +0000 (0:00:00.316) 0:00:40.134 ******* 2026-08-20 20:24:53.884680 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True}) 2026-08-20 20:24:53.884771 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0}) 2026-08-20 20:24:53.885985 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False}) 2026-08-20 20:24:53.886016 | instance | 2026-08-20 20:24:53.886028 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] ******************************* 2026-08-20 20:24:53.886037 | instance | Thursday 20 August 2026 20:24:53 +0000 (0:00:00.693) 0:00:40.827 ******* 2026-08-20 20:26:21.329989 | instance | ok: [instance] 2026-08-20 20:26:21.330088 | instance | 2026-08-20 20:26:21.330222 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] *************** 2026-08-20 20:26:21.330349 | instance | Thursday 20 August 2026 20:26:21 +0000 (0:01:27.446) 0:02:08.273 ******* 2026-08-20 20:26:21.547049 | instance | changed: [instance] 2026-08-20 20:26:21.547119 | instance | 2026-08-20 20:26:21.547259 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] ********************************** 2026-08-20 20:26:21.547408 | instance | Thursday 20 August 2026 20:26:21 +0000 (0:00:00.217) 0:02:08.490 ******* 2026-08-20 20:26:21.627355 | instance | ok: [instance] 2026-08-20 20:26:21.627446 | instance | 2026-08-20 20:26:21.627515 | instance | TASK [Install Ceph host] ******************************************************* 2026-08-20 20:26:21.627630 | instance | Thursday 20 August 2026 20:26:21 +0000 (0:00:00.080) 0:02:08.571 ******* 2026-08-20 20:26:21.708675 | instance | included: vexxhost.ceph.cephadm_host for instance 2026-08-20 20:26:21.708783 | instance | 2026-08-20 20:26:21.709063 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ****** 2026-08-20 20:26:21.709106 | instance | Thursday 20 August 2026 20:26:21 +0000 (0:00:00.081) 0:02:08.652 ******* 2026-08-20 20:26:23.473727 | instance | ok: [instance] 2026-08-20 20:26:23.473805 | instance | 2026-08-20 20:26:23.473951 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] *** 2026-08-20 20:26:23.474081 | instance | Thursday 20 August 2026 20:26:23 +0000 (0:00:01.764) 0:02:10.416 ******* 2026-08-20 20:26:23.547089 | instance | ok: [instance] => (item=instance) 2026-08-20 20:26:23.547215 | instance | 2026-08-20 20:26:23.547413 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] *********** 2026-08-20 20:26:23.547645 | instance | Thursday 20 August 2026 20:26:23 +0000 (0:00:00.072) 0:02:10.489 ******* 2026-08-20 20:26:23.890151 | instance | ok: [instance] 2026-08-20 20:26:23.890227 | instance | 2026-08-20 20:26:23.890487 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] *********************** 2026-08-20 20:26:23.890527 | instance | Thursday 20 August 2026 20:26:23 +0000 (0:00:00.343) 0:02:10.833 ******* 2026-08-20 20:26:26.249954 | instance | ok: [instance] 2026-08-20 20:26:26.250034 | instance | 2026-08-20 20:26:26.250311 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ****************** 2026-08-20 20:26:26.250355 | instance | Thursday 20 August 2026 20:26:26 +0000 (0:00:02.359) 0:02:13.193 ******* 2026-08-20 20:27:11.941838 | 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-20 20:27:11.942607 | 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_d8mhulru/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_d8mhulru/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_d8mhulru/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_d8mhulru/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-20T20:27:11.627+0000 7fe79ba50640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgDCYodqX3t0CCAApzsa9Zh8brwJuF+sQOqRIGAgRdb4UHT+RT+wvnOnP/8=: Malformed input [buffer:3]\n2026-08-20T20:27:11.627+0000 7fe79ba50640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-20T20:27:11.631+0000 7fe79ba50640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgDCYodqX3t0CCAApzsa9Zh8brwJuF+sQOqRIGAgRdb4UHT+RT+wvnOnP/8=: Malformed input [buffer:3]\n2026-08-20T20:27:11.631+0000 7fe79ba50640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-20T20:27:11.631+0000 7fe79ba50640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgDCYodqX3t0CCAApzsa9Zh8brwJuF+sQOqRIGAgRdb4UHT+RT+wvnOnP/8=: Malformed input [buffer:3]\n2026-08-20T20:27:11.631+0000 7fe79ba50640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-20T20:27:11.631+0000 7fe79ba50640 -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-20 20:27:11.944586 | instance | 2026-08-20 20:27:11.944779 | instance | PLAY RECAP ********************************************************************* 2026-08-20 20:27:11.948626 | instance | instance : ok=55 changed=26 unreachable=0 failed=1 skipped=6 rescued=0 ignored=0 2026-08-20 20:27:11.948702 | instance | 2026-08-20 20:27:11.948718 | instance | Thursday 20 August 2026 20:27:11 +0000 (0:00:45.695) 0:02:58.888 ******* 2026-08-20 20:27:11.948732 | instance | =============================================================================== 2026-08-20 20:27:11.948744 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 87.45s 2026-08-20 20:27:11.948757 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 45.70s 2026-08-20 20:27:11.948769 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 5.75s 2026-08-20 20:27:11.948781 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 5.08s 2026-08-20 20:27:11.948794 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.44s 2026-08-20 20:27:11.948807 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.85s 2026-08-20 20:27:11.948819 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.36s 2026-08-20 20:27:11.948848 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 2.03s 2026-08-20 20:27:11.948880 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.76s 2026-08-20 20:27:11.948892 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.63s 2026-08-20 20:27:11.948904 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.24s 2026-08-20 20:27:11.948917 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.12s 2026-08-20 20:27:11.948929 | instance | Gathering Facts --------------------------------------------------------- 1.00s 2026-08-20 20:27:11.948941 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 0.91s 2026-08-20 20:27:11.948954 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.89s 2026-08-20 20:27:11.948966 | instance | Gathering Facts --------------------------------------------------------- 0.87s 2026-08-20 20:27:11.948979 | instance | Gathering Facts --------------------------------------------------------- 0.85s 2026-08-20 20:27:11.948991 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.76s 2026-08-20 20:27:11.949012 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.76s 2026-08-20 20:27:11.949025 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.69s 2026-08-20 20:27:12.033046 | 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-20 20:27:12.033174 | instance | ERROR [csi > converge] Executed: Failed 2026-08-20 20:27:12.033364 | 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-20 20:27:12.385292 | instance | ERROR 2026-08-20 20:27:12.385554 | instance | { 2026-08-20 20:27:12.385623 | instance | "delta": "0:03:48.799554", 2026-08-20 20:27:12.385657 | instance | "end": "2026-08-20 20:27:12.088545", 2026-08-20 20:27:12.385684 | instance | "msg": "non-zero return code", 2026-08-20 20:27:12.385709 | instance | "rc": 2, 2026-08-20 20:27:12.385753 | instance | "start": "2026-08-20 20:23:23.288991" 2026-08-20 20:27:12.385797 | instance | } failure 2026-08-20 20:27:12.392782 | 2026-08-20 20:27:12.392856 | PLAY RECAP 2026-08-20 20:27:12.392912 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-08-20 20:27:12.392942 | 2026-08-20 20:27:12.850829 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-20 20:27:12.916277 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-08-20 20:27:13.944161 | 2026-08-20 20:27:14.325767 | PLAY [all] 2026-08-20 20:27:14.659040 | 2026-08-20 20:27:14.659225 | TASK [gather-host-logs : creating directory for system status] 2026-08-20 20:27:15.077435 | instance | changed 2026-08-20 20:27:15.084914 | 2026-08-20 20:27:15.085089 | TASK [gather-host-logs : Get logs for each host] 2026-08-20 20:27:15.495159 | instance | + systemd-cgls --full --all --no-pager 2026-08-20 20:27:15.509084 | instance | + ip addr 2026-08-20 20:27:15.512443 | instance | + ip route 2026-08-20 20:27:15.514343 | instance | + lsblk 2026-08-20 20:27:15.519625 | instance | + mount 2026-08-20 20:27:15.521576 | instance | + docker images 2026-08-20 20:27:15.539242 | instance | + brctl show 2026-08-20 20:27:15.539623 | instance | /bin/bash: line 8: brctl: command not found 2026-08-20 20:27:15.539785 | instance | + ps aux --sort=-%mem 2026-08-20 20:27:15.554409 | instance | + dpkg -l 2026-08-20 20:27:15.566019 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-08-20 20:27:15.566686 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-08-20 20:27:15.586796 | instance | + '[' '!' -z '' ']' 2026-08-20 20:27:15.633223 | instance | ok: Runtime: 0:00:00.096658 2026-08-20 20:27:15.639129 | 2026-08-20 20:27:15.639200 | TASK [gather-host-logs : Downloads logs to executor] 2026-08-20 20:27:16.366188 | instance | changed: 2026-08-20 20:27:16.366368 | instance | created directory /var/lib/zuul/builds/bdabea34c6a641a29b1e33e33322b49c/work/logs/instance 2026-08-20 20:27:16.366399 | instance | cd+++++++++ system/ 2026-08-20 20:27:16.366421 | instance | >f+++++++++ system/brctl-show.txt 2026-08-20 20:27:16.366442 | instance | >f+++++++++ system/docker-images.txt 2026-08-20 20:27:16.366463 | instance | >f+++++++++ system/ip-addr.txt 2026-08-20 20:27:16.366485 | instance | >f+++++++++ system/ip-route.txt 2026-08-20 20:27:16.366506 | instance | >f+++++++++ system/lsblk.txt 2026-08-20 20:27:16.366525 | instance | >f+++++++++ system/mount.txt 2026-08-20 20:27:16.366544 | instance | >f+++++++++ system/packages.txt 2026-08-20 20:27:16.366562 | instance | >f+++++++++ system/ps.txt 2026-08-20 20:27:16.366583 | instance | >f+++++++++ system/systemd-cgls.txt 2026-08-20 20:27:16.383720 | 2026-08-20 20:27:16.383947 | LOOP [helm-release-status : creating directory for helm release status] 2026-08-20 20:27:16.579674 | instance | changed: "values" 2026-08-20 20:27:16.738445 | instance | changed: "releases" 2026-08-20 20:27:16.943722 | 2026-08-20 20:27:16.943883 | TASK [helm-release-status : Gather get release status for helm charts] 2026-08-20 20:27:17.179888 | instance | /bin/bash: line 3: kubectl: command not found 2026-08-20 20:27:18.283208 | instance | ok: Runtime: 0:00:00.004482 2026-08-20 20:27:18.290327 | 2026-08-20 20:27:18.290424 | TASK [helm-release-status : Downloads logs to executor] 2026-08-20 20:27:18.790342 | instance | changed: 2026-08-20 20:27:18.790509 | instance | cd+++++++++ helm/ 2026-08-20 20:27:18.790537 | instance | cd+++++++++ helm/releases/ 2026-08-20 20:27:18.790558 | instance | cd+++++++++ helm/values/ 2026-08-20 20:27:18.800625 | 2026-08-20 20:27:18.800747 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-08-20 20:27:19.017755 | instance | changed 2026-08-20 20:27:19.024089 | 2026-08-20 20:27:19.024172 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-08-20 20:27:19.277409 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-20 20:27:19.277620 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-20 20:27:19.282161 | instance | environment: line 1: kubectl: command not found 2026-08-20 20:27:19.283491 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-20 20:27:19.284896 | instance | environment: line 1: kubectl: command not found 2026-08-20 20:27:19.285895 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-20 20:27:19.286893 | instance | environment: line 1: kubectl: command not found 2026-08-20 20:27:19.288509 | instance | environment: line 1: kubectl: command not found 2026-08-20 20:27:19.288833 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-20 20:27:19.289372 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-20 20:27:19.291964 | instance | environment: line 1: kubectl: command not found 2026-08-20 20:27:19.292887 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-20 20:27:19.559538 | instance | ok: Runtime: 0:00:00.023820 2026-08-20 20:27:19.564778 | 2026-08-20 20:27:19.564845 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-08-20 20:27:19.765614 | instance | changed 2026-08-20 20:27:19.772259 | 2026-08-20 20:27:19.772397 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-08-20 20:27:19.990263 | instance | environment: line 5: kubectl: command not found 2026-08-20 20:27:19.991312 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-20 20:27:19.991461 | instance | xargs: xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args valuewarning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-20 20:27:19.991482 | instance | 2026-08-20 20:27:20.565643 | instance | ok: Runtime: 0:00:00.008288 2026-08-20 20:27:20.584286 | 2026-08-20 20:27:20.584416 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-08-20 20:27:21.078409 | instance | changed: 2026-08-20 20:27:21.078599 | instance | cd+++++++++ objects/ 2026-08-20 20:27:21.078633 | instance | cd+++++++++ objects/cluster/ 2026-08-20 20:27:21.078655 | instance | cd+++++++++ objects/namespaced/ 2026-08-20 20:27:21.094414 | 2026-08-20 20:27:21.094545 | TASK [gather-pod-logs : creating directory for pod logs] 2026-08-20 20:27:21.282419 | instance | changed 2026-08-20 20:27:21.483776 | 2026-08-20 20:27:21.483942 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-08-20 20:27:21.735308 | instance | changed 2026-08-20 20:27:21.742037 | 2026-08-20 20:27:21.976353 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-08-20 20:27:22.206513 | instance | environment: line 3: kubectl: command not found 2026-08-20 20:27:22.664099 | instance | ok: Runtime: 0:00:00.008373 2026-08-20 20:27:22.674495 | 2026-08-20 20:27:22.674630 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-08-20 20:27:23.187904 | instance | changed: 2026-08-20 20:27:23.188073 | instance | cd+++++++++ pod-logs/ 2026-08-20 20:27:23.188128 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-08-20 20:27:23.202355 | 2026-08-20 20:27:23.202452 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-08-20 20:27:23.398899 | instance | changed 2026-08-20 20:27:23.691703 | 2026-08-20 20:27:23.691830 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-08-20 20:27:23.918895 | instance | /bin/bash: line 2: kubectl: command not found 2026-08-20 20:27:24.229552 | instance | ok: Runtime: 0:00:00.034407 2026-08-20 20:27:24.236173 | 2026-08-20 20:27:24.236276 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-08-20 20:27:24.440969 | instance | /bin/bash: line 2: kubectl: command not found 2026-08-20 20:27:24.473562 | instance | ceph-mgr endpoints: 2026-08-20 20:27:24.772032 | instance | ok: Runtime: 0:00:00.038246 2026-08-20 20:27:24.779595 | 2026-08-20 20:27:24.779720 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-08-20 20:27:24.990302 | instance | /bin/bash: line 4: kubectl: command not found 2026-08-20 20:27:25.497305 | instance | ok: Runtime: 0:00:00.035442 2026-08-20 20:27:25.503759 | 2026-08-20 20:27:25.503833 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-08-20 20:27:26.018406 | instance | changed: cd+++++++++ prometheus/ 2026-08-20 20:27:26.029850 | 2026-08-20 20:27:26.029944 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-08-20 20:27:26.252288 | instance | changed 2026-08-20 20:27:26.319428 | 2026-08-20 20:27:26.319535 | TASK [gather-selenium-data : Get selenium data] 2026-08-20 20:27:26.582467 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-08-20 20:27:26.584175 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-08-20 20:27:26.879510 | instance | ERROR 2026-08-20 20:27:26.879712 | instance | { 2026-08-20 20:27:26.879757 | instance | "delta": "0:00:00.006068", 2026-08-20 20:27:26.879787 | instance | "end": "2026-08-20 20:27:26.584564", 2026-08-20 20:27:26.879817 | instance | "msg": "non-zero return code", 2026-08-20 20:27:26.879852 | instance | "rc": 1, 2026-08-20 20:27:26.879879 | instance | "start": "2026-08-20 20:27:26.578496" 2026-08-20 20:27:26.879904 | instance | } 2026-08-20 20:27:26.879938 | instance | ERROR: Ignoring Errors 2026-08-20 20:27:26.889852 | 2026-08-20 20:27:26.889996 | TASK [gather-selenium-data : Downloads logs to executor] 2026-08-20 20:27:27.419370 | instance | changed: cd+++++++++ selenium/ 2026-08-20 20:27:27.432626 | 2026-08-20 20:27:27.432718 | PLAY RECAP 2026-08-20 20:27:27.432764 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-08-20 20:27:27.432788 | 2026-08-20 20:27:27.615709 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-08-20 20:27:27.620481 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-20 20:27:28.757517 | 2026-08-20 20:27:28.757659 | PLAY [all] 2026-08-20 20:27:28.770167 | 2026-08-20 20:27:28.770279 | TASK [fetch-output : Set log path for multiple nodes] 2026-08-20 20:27:28.816106 | instance | skipping: Conditional result was False 2026-08-20 20:27:28.827679 | 2026-08-20 20:27:28.827812 | TASK [fetch-output : Set log path for single node] 2026-08-20 20:27:28.860153 | instance | ok 2026-08-20 20:27:28.865628 | 2026-08-20 20:27:28.865700 | LOOP [fetch-output : Ensure local output dirs] 2026-08-20 20:27:29.281179 | instance -> localhost | ok: "/var/lib/zuul/builds/bdabea34c6a641a29b1e33e33322b49c/work/logs" 2026-08-20 20:27:29.501108 | instance -> localhost | changed: "/var/lib/zuul/builds/bdabea34c6a641a29b1e33e33322b49c/work/artifacts" 2026-08-20 20:27:30.181232 | instance -> localhost | changed: "/var/lib/zuul/builds/bdabea34c6a641a29b1e33e33322b49c/work/docs" 2026-08-20 20:27:30.205761 | 2026-08-20 20:27:30.205928 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-20 20:27:30.920803 | instance | changed: .d..t...... ./ 2026-08-20 20:27:30.921044 | instance | changed: All items complete 2026-08-20 20:27:30.921075 | 2026-08-20 20:27:31.541808 | instance | changed: .d..t...... ./ 2026-08-20 20:27:32.156176 | instance | changed: .d..t...... ./ 2026-08-20 20:27:32.182136 | 2026-08-20 20:27:32.182242 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-20 20:27:32.795587 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.119367 2026-08-20 20:27:33.265627 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.009010 2026-08-20 20:27:33.284145 | 2026-08-20 20:27:33.284282 | PLAY [all] 2026-08-20 20:27:33.291032 | 2026-08-20 20:27:33.291119 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-20 20:27:33.746312 | instance | changed 2026-08-20 20:27:33.752863 | 2026-08-20 20:27:33.752933 | PLAY RECAP 2026-08-20 20:27:33.752997 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-20 20:27:33.753022 | 2026-08-20 20:27:33.920391 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-20 20:27:33.925991 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-20 20:27:34.698207 | 2026-08-20 20:27:35.064163 | PLAY [localhost] 2026-08-20 20:27:35.083484 | 2026-08-20 20:27:35.083648 | TASK [Generate Zuul manifest] 2026-08-20 20:27:35.115085 | localhost | ok 2026-08-20 20:27:35.147646 | 2026-08-20 20:27:35.147764 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-20 20:27:35.604336 | localhost | changed 2026-08-20 20:27:35.616884 | 2026-08-20 20:27:35.617067 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-20 20:27:35.646049 | localhost | ok 2026-08-20 20:27:35.656576 | 2026-08-20 20:27:35.656664 | TASK [Upload logs] 2026-08-20 20:27:35.699933 | localhost | ok 2026-08-20 20:27:35.778820 | 2026-08-20 20:27:35.778978 | TASK [Set zuul-log-path fact] 2026-08-20 20:27:35.799743 | localhost | ok 2026-08-20 20:27:35.973165 | 2026-08-20 20:27:35.973316 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-20 20:27:36.004284 | localhost | ok 2026-08-20 20:27:36.016038 | 2026-08-20 20:27:36.016121 | TASK [upload-logs : Create log directories] 2026-08-20 20:27:36.738143 | localhost | changed 2026-08-20 20:27:36.749108 | 2026-08-20 20:27:36.749353 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-20 20:27:37.333461 | localhost -> localhost | ok: Runtime: 0:00:00.046654 2026-08-20 20:27:37.343439 | 2026-08-20 20:27:37.343568 | TASK [upload-logs : Upload logs to log server] 2026-08-20 20:27:37.972313 | localhost | Output suppressed because no_log was given 2026-08-20 20:27:38.031962 | 2026-08-20 20:27:38.032120 | LOOP [upload-logs : Compress console log and json output] 2026-08-20 20:27:38.082946 | localhost | skipping: Conditional result was False 2026-08-20 20:27:38.090323 | localhost | skipping: Conditional result was False 2026-08-20 20:27:38.105698 | 2026-08-20 20:27:38.105882 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-20 20:27:38.148514 | localhost | skipping: Conditional result was False 2026-08-20 20:27:38.148829 | 2026-08-20 20:27:38.153403 | localhost | skipping: Conditional result was False 2026-08-20 20:27:38.167832 | 2026-08-20 20:27:38.168016 | LOOP [upload-logs : Upload console log and json output]