2026-08-20 20:23:48.060425 | Job console starting 2026-08-20 20:23:48.071993 | Updating git repos 2026-08-20 20:23:50.202346 | Cloning repos into workspace 2026-08-20 20:24:10.215644 | Restoring repo states 2026-08-20 20:24:18.208692 | Merging changes 2026-08-20 20:24:19.858500 | Checking out repos 2026-08-20 20:24:22.949253 | Preparing playbooks 2026-08-20 20:24:25.566565 | Running Ansible setup 2026-08-20 20:24:30.081020 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-20 20:24:30.842942 | 2026-08-20 20:24:30.843183 | PLAY [localhost] 2026-08-20 20:24:30.854522 | 2026-08-20 20:24:30.854698 | TASK [Gathering Facts] 2026-08-20 20:24:31.858460 | localhost | ok 2026-08-20 20:24:31.871774 | 2026-08-20 20:24:31.871905 | TASK [Setup log path fact] 2026-08-20 20:24:31.894989 | localhost | ok 2026-08-20 20:24:31.909835 | 2026-08-20 20:24:31.909908 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-20 20:24:31.953284 | localhost | ok 2026-08-20 20:24:31.963417 | 2026-08-20 20:24:31.963584 | TASK [emit-job-header : Print job information] 2026-08-20 20:24:32.005543 | # Job Information 2026-08-20 20:24:32.005757 | Ansible Version: 2.16.18 2026-08-20 20:24:32.005811 | Job: atmosphere-molecule-csi-rbd 2026-08-20 20:24:32.005849 | Pipeline: check 2026-08-20 20:24:32.005877 | Executor: 2d72f0692154 2026-08-20 20:24:32.005905 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4309 2026-08-20 20:24:32.005937 | Event ID: abbbcc40-9cd3-11f1-9f70-8ec6673bc6d6 2026-08-20 20:24:32.010200 | 2026-08-20 20:24:32.010302 | LOOP [emit-job-header : Print node information] 2026-08-20 20:24:32.119216 | localhost | ok: 2026-08-20 20:24:32.119445 | localhost | # Node Information 2026-08-20 20:24:32.119490 | localhost | Inventory Hostname: instance 2026-08-20 20:24:32.119532 | localhost | Hostname: np0000190266 2026-08-20 20:24:32.119621 | localhost | Username: zuul 2026-08-20 20:24:32.119667 | localhost | Distro: Ubuntu 22.04 2026-08-20 20:24:32.119705 | localhost | Provider: yul1 2026-08-20 20:24:32.119947 | localhost | Region: ca-ymq-1 2026-08-20 20:24:32.119996 | localhost | Label: ubuntu-jammy 2026-08-20 20:24:32.120019 | localhost | Product Name: OpenStack Nova 2026-08-20 20:24:32.120042 | localhost | Interface IP: 199.19.213.203 2026-08-20 20:24:32.138956 | 2026-08-20 20:24:32.139120 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-20 20:24:32.579680 | localhost -> localhost | changed 2026-08-20 20:24:32.587913 | 2026-08-20 20:24:32.588037 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-20 20:24:33.518371 | localhost -> localhost | changed 2026-08-20 20:24:33.598614 | 2026-08-20 20:24:33.598692 | PLAY [all] 2026-08-20 20:24:33.607173 | 2026-08-20 20:24:33.607246 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-20 20:24:33.830638 | instance -> localhost | ok 2026-08-20 20:24:33.842038 | 2026-08-20 20:24:33.842177 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-20 20:24:33.876505 | instance | ok 2026-08-20 20:24:33.890027 | instance | included: /var/lib/zuul/builds/599ae0543a9240f8880b92c36d14c380/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-20 20:24:33.965511 | 2026-08-20 20:24:33.965669 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-20 20:24:35.350362 | instance -> localhost | Generating public/private rsa key pair. 2026-08-20 20:24:35.350537 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/599ae0543a9240f8880b92c36d14c380/work/599ae0543a9240f8880b92c36d14c380_id_rsa 2026-08-20 20:24:35.350620 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/599ae0543a9240f8880b92c36d14c380/work/599ae0543a9240f8880b92c36d14c380_id_rsa.pub 2026-08-20 20:24:35.350671 | instance -> localhost | The key fingerprint is: 2026-08-20 20:24:35.350705 | instance -> localhost | SHA256:GaLCdcExR4fPKC49DSYZBdvdy4CKT/8g1LfwW3Z/1Ek zuul-build-sshkey 2026-08-20 20:24:35.350748 | instance -> localhost | The key's randomart image is: 2026-08-20 20:24:35.350778 | instance -> localhost | +---[RSA 3072]----+ 2026-08-20 20:24:35.350813 | instance -> localhost | | .+=oo.. | 2026-08-20 20:24:35.350842 | instance -> localhost | | .o.*.o | 2026-08-20 20:24:35.350870 | instance -> localhost | | oo= ++. | 2026-08-20 20:24:35.350898 | instance -> localhost | | . oo=+..=o. E | 2026-08-20 20:24:35.350925 | instance -> localhost | | + ==o+S o . o| 2026-08-20 20:24:35.350952 | instance -> localhost | | =..++.. .o| 2026-08-20 20:24:35.350978 | instance -> localhost | | o.o.o o . . | 2026-08-20 20:24:35.351005 | instance -> localhost | | . o + . . .| 2026-08-20 20:24:35.351035 | instance -> localhost | | o .. | 2026-08-20 20:24:35.351063 | instance -> localhost | +----[SHA256]-----+ 2026-08-20 20:24:35.351124 | instance -> localhost | ok: Runtime: 0:00:00.939142 2026-08-20 20:24:35.359604 | 2026-08-20 20:24:35.359693 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-20 20:24:35.390960 | instance | ok 2026-08-20 20:24:35.474719 | instance | included: /var/lib/zuul/builds/599ae0543a9240f8880b92c36d14c380/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-20 20:24:35.491472 | 2026-08-20 20:24:35.491622 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-20 20:24:35.516121 | instance | skipping: Conditional result was False 2026-08-20 20:24:35.527280 | 2026-08-20 20:24:35.527365 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-20 20:24:35.950835 | instance | changed 2026-08-20 20:24:35.956778 | 2026-08-20 20:24:35.956844 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-20 20:24:36.133305 | instance | ok 2026-08-20 20:24:36.142018 | 2026-08-20 20:24:36.142100 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-20 20:24:36.593815 | instance | changed 2026-08-20 20:24:36.603118 | 2026-08-20 20:24:36.603250 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-20 20:24:37.088377 | instance | changed 2026-08-20 20:24:37.094261 | 2026-08-20 20:24:37.094330 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-20 20:24:37.119344 | instance | skipping: Conditional result was False 2026-08-20 20:24:37.130223 | 2026-08-20 20:24:37.130296 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-20 20:24:37.529135 | instance -> localhost | changed 2026-08-20 20:24:37.543412 | 2026-08-20 20:24:37.543848 | TASK [add-build-sshkey : Add back temp key] 2026-08-20 20:24:37.837366 | instance -> localhost | Identity added: /var/lib/zuul/builds/599ae0543a9240f8880b92c36d14c380/work/599ae0543a9240f8880b92c36d14c380_id_rsa (zuul-build-sshkey) 2026-08-20 20:24:37.837676 | instance -> localhost | ok: Runtime: 0:00:00.015833 2026-08-20 20:24:37.844818 | 2026-08-20 20:24:37.844904 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-20 20:24:38.166357 | instance | ok 2026-08-20 20:24:38.177276 | 2026-08-20 20:24:38.177467 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-20 20:24:38.204133 | instance | skipping: Conditional result was False 2026-08-20 20:24:38.222106 | 2026-08-20 20:24:38.222281 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-08-20 20:24:38.564555 | instance | ok 2026-08-20 20:24:38.573078 | 2026-08-20 20:24:38.573177 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-08-20 20:24:42.469057 | instance | Output suppressed because no_log was given 2026-08-20 20:24:42.614304 | 2026-08-20 20:24:42.614405 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-08-20 20:24:42.810072 | instance | ok: "logs" 2026-08-20 20:24:42.810293 | instance | ok: All items complete 2026-08-20 20:24:42.810323 | 2026-08-20 20:24:42.960463 | instance | ok: "artifacts" 2026-08-20 20:24:43.310928 | instance | ok: "docs" 2026-08-20 20:24:43.316898 | 2026-08-20 20:24:43.316987 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-08-20 20:24:43.500868 | instance | changed: "logs" 2026-08-20 20:24:43.655347 | instance | changed: "artifacts" 2026-08-20 20:24:43.833288 | instance | changed: "docs" 2026-08-20 20:24:43.935590 | 2026-08-20 20:24:43.935702 | PLAY RECAP 2026-08-20 20:24:43.935765 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-08-20 20:24:43.935808 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-20 20:24:43.935840 | 2026-08-20 20:24:44.104531 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-20 20:24:44.108017 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-20 20:24:44.772187 | 2026-08-20 20:24:44.918774 | PLAY [all] 2026-08-20 20:24:44.936807 | 2026-08-20 20:24:44.936909 | TASK [setup-uv : Extract archive] 2026-08-20 20:24:47.259443 | instance | changed 2026-08-20 20:24:47.316054 | 2026-08-20 20:24:47.316248 | TASK [setup-uv : Print version] 2026-08-20 20:24:47.688278 | instance | uv 0.8.13 2026-08-20 20:24:47.931438 | instance | ok: Runtime: 0:00:00.012334 2026-08-20 20:24:47.945230 | 2026-08-20 20:24:47.957825 | TASK [Install Ansible collection siblings] 2026-08-20 20:24:56.970259 | instance | changed: 2026-08-20 20:24:57.051612 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-08-20 20:24:57.051776 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-08-20 20:24:57.051838 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-08-20 20:24:57.051889 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto 2026-08-20 20:24:57.051939 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general 2026-08-20 20:24:57.052004 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql 2026-08-20 20:24:57.052073 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-08-20 20:24:57.052131 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-08-20 20:24:57.052180 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-08-20 20:24:57.052225 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-08-20 20:24:57.052271 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-08-20 20:24:57.052316 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-08-20 20:24:57.052360 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0 2026-08-20 20:24:57.052404 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0 2026-08-20 20:24:57.052448 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0 2026-08-20 20:24:57.052492 | instance | Resolved community.crypto to 2.2.3 for 2.2.3 2026-08-20 20:24:57.052536 | instance | Resolved community.general to 7.3.0 for 7.3.0 2026-08-20 20:24:57.052580 | instance | Resolved community.mysql to 3.6.0 for 3.6.0 2026-08-20 20:24:57.052622 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0 2026-08-20 20:24:57.052664 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0 2026-08-20 20:24:57.052705 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0 2026-08-20 20:24:57.052749 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0 2026-08-20 20:24:57.052795 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-08-20 20:24:57.052934 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0 2026-08-20 20:24:57.053027 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0 2026-08-20 20:24:57.053073 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-08-20 20:24:57.053116 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-08-20 20:24:57.053158 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-08-20 20:24:57.053203 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0 2026-08-20 20:24:57.053245 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3 2026-08-20 20:24:57.053333 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-08-20 20:24:57.053444 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-08-20 20:24:57.053503 | instance | Checked out ansible.netcommon to 1.2.0 2026-08-20 20:24:57.053550 | 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:24:57.053613 | instance | Starting galaxy collection install process 2026-08-20 20:24:57.053657 | instance | Process install dependency map 2026-08-20 20:24:57.053701 | instance | Starting collection install process 2026-08-20 20:24:57.053743 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon' 2026-08-20 20:24:57.053786 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon 2026-08-20 20:24:57.053829 | instance | ansible.netcommon:* was installed successfully 2026-08-20 20:24:57.053870 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-08-20 20:24:57.053911 | instance | Creating virtual environment at: .venv 2026-08-20 20:24:57.053953 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-08-20 20:24:57.053996 | instance | Downloading netaddr (2.2MiB) 2026-08-20 20:24:57.054038 | instance | Downloading kubernetes (1.9MiB) 2026-08-20 20:24:57.054085 | instance | Downloading rjsonnet (1.2MiB) 2026-08-20 20:24:57.054127 | instance | Downloading pygments (1.2MiB) 2026-08-20 20:24:57.054166 | instance | Downloading cryptography (4.2MiB) 2026-08-20 20:24:57.054208 | instance | Downloading setuptools (1.1MiB) 2026-08-20 20:24:57.054250 | instance | Downloading openstacksdk (1.7MiB) 2026-08-20 20:24:57.054292 | instance | Downloading ansible-core (2.1MiB) 2026-08-20 20:24:57.054335 | instance | Building pyperclip==1.9.0 2026-08-20 20:24:57.054375 | instance | Downloading rjsonnet 2026-08-20 20:24:57.054564 | instance | Downloading netaddr 2026-08-20 20:24:57.054861 | instance | Downloading pygments 2026-08-20 20:24:57.054934 | instance | Downloading cryptography 2026-08-20 20:24:57.054984 | instance | Downloading setuptools 2026-08-20 20:24:57.055036 | instance | Downloading kubernetes 2026-08-20 20:24:57.055083 | instance | Downloading ansible-core 2026-08-20 20:24:57.055127 | instance | Downloading openstacksdk 2026-08-20 20:24:57.055169 | instance | Built pyperclip==1.9.0 2026-08-20 20:24:57.055213 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-08-20 20:24:57.055255 | instance | Installed 79 packages in 38ms 2026-08-20 20:24:57.055299 | instance | Checked out ansible.posix to 1.6.0 2026-08-20 20:24:57.055341 | 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:24:57.055384 | instance | Starting galaxy collection install process 2026-08-20 20:24:57.055427 | instance | Process install dependency map 2026-08-20 20:24:57.055481 | instance | Starting collection install process 2026-08-20 20:24:57.055526 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-08-20 20:24:57.055584 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix 2026-08-20 20:24:57.055629 | instance | ansible.posix:1.6.0 was installed successfully 2026-08-20 20:24:57.055676 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:24:57.055723 | instance | 2.17.12 2026-08-20 20:24:57.055768 | instance | Checked out ansible.utils to v6.1.0 2026-08-20 20:24:57.055813 | 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:24:57.055856 | instance | Starting galaxy collection install process 2026-08-20 20:24:57.055907 | instance | Process install dependency map 2026-08-20 20:24:57.055951 | instance | Starting collection install process 2026-08-20 20:24:57.055997 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils' 2026-08-20 20:24:57.056040 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils 2026-08-20 20:24:57.056085 | instance | ansible.utils:6.1.0 was installed successfully 2026-08-20 20:24:57.056136 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:24:57.056182 | instance | 2.17.12 2026-08-20 20:24:57.056228 | instance | Checked out atmosphere.common to v0.7.0 2026-08-20 20:24:57.056273 | 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:24:57.056317 | instance | Starting galaxy collection install process 2026-08-20 20:24:57.056366 | instance | Process install dependency map 2026-08-20 20:24:57.056410 | instance | Starting collection install process 2026-08-20 20:24:57.056454 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common' 2026-08-20 20:24:57.056495 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common 2026-08-20 20:24:57.056538 | instance | atmosphere.common:0.7.0 was installed successfully 2026-08-20 20:24:57.056587 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:24:57.056630 | instance | 2.17.12 2026-08-20 20:24:57.056673 | instance | Checked out community.crypto to 2.2.3 2026-08-20 20:24:57.056715 | 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:24:57.056758 | instance | Starting galaxy collection install process 2026-08-20 20:24:57.056872 | instance | Process install dependency map 2026-08-20 20:24:57.056924 | instance | Starting collection install process 2026-08-20 20:24:57.057004 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-08-20 20:24:57.057057 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto 2026-08-20 20:24:57.057101 | instance | community.crypto:2.2.3 was installed successfully 2026-08-20 20:24:57.057144 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:24:57.057186 | instance | 2.17.12 2026-08-20 20:24:57.057229 | instance | Checked out community.general to 7.3.0 2026-08-20 20:24:57.057263 | 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:24:57.057291 | instance | Starting galaxy collection install process 2026-08-20 20:24:57.057329 | instance | Process install dependency map 2026-08-20 20:24:57.057357 | instance | Starting collection install process 2026-08-20 20:24:57.057383 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-08-20 20:24:57.057409 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general 2026-08-20 20:24:57.057435 | instance | community.general:7.3.0 was installed successfully 2026-08-20 20:24:57.057462 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:24:57.057489 | instance | 2.17.12 2026-08-20 20:24:57.057515 | instance | Checked out community.mysql to 3.6.0 2026-08-20 20:24:57.057546 | 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:24:57.057574 | instance | Starting galaxy collection install process 2026-08-20 20:24:57.057603 | instance | Process install dependency map 2026-08-20 20:24:57.057630 | instance | Starting collection install process 2026-08-20 20:24:57.057657 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql' 2026-08-20 20:24:57.057683 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql 2026-08-20 20:24:57.057710 | instance | community.mysql:3.6.0 was installed successfully 2026-08-20 20:24:57.057737 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:24:57.057769 | instance | 2.17.12 2026-08-20 20:24:57.057797 | instance | Checked out kubernetes.core to 2.4.0 2026-08-20 20:24:57.057824 | 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:24:57.057886 | instance | Starting galaxy collection install process 2026-08-20 20:24:57.057927 | instance | Process install dependency map 2026-08-20 20:24:57.057957 | instance | Starting collection install process 2026-08-20 20:24:57.058005 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core' 2026-08-20 20:24:57.058069 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core 2026-08-20 20:24:57.058121 | instance | kubernetes.core:2.4.0 was installed successfully 2026-08-20 20:24:57.058151 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:24:57.058179 | instance | 2.17.12 2026-08-20 20:24:57.058208 | instance | Checked out openstack.cloud to 2.6.0 2026-08-20 20:24:57.058267 | 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:24:57.058335 | instance | Starting galaxy collection install process 2026-08-20 20:24:57.058373 | instance | Process install dependency map 2026-08-20 20:24:57.058402 | instance | Starting collection install process 2026-08-20 20:24:57.058430 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud' 2026-08-20 20:24:57.058488 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud 2026-08-20 20:24:57.058554 | instance | openstack.cloud:2.6.0 was installed successfully 2026-08-20 20:24:57.058592 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:24:57.058622 | instance | 2.17.12 2026-08-20 20:24:57.058650 | instance | Checked out vexxhost.ceph to v4.2.0 2026-08-20 20:24:57.058706 | 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:24:57.058789 | instance | Starting galaxy collection install process 2026-08-20 20:24:57.058825 | instance | Process install dependency map 2026-08-20 20:24:57.058854 | instance | Starting collection install process 2026-08-20 20:24:57.058883 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph' 2026-08-20 20:24:57.058916 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph 2026-08-20 20:24:57.058947 | instance | vexxhost.ceph:4.2.0 was installed successfully 2026-08-20 20:24:57.058977 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:24:57.059004 | instance | 2.17.12 2026-08-20 20:24:57.059032 | instance | Checked out vexxhost.containers to v1.6.8 2026-08-20 20:24:57.059063 | 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:24:57.059091 | instance | Starting galaxy collection install process 2026-08-20 20:24:57.059122 | instance | Process install dependency map 2026-08-20 20:24:57.059149 | instance | Starting collection install process 2026-08-20 20:24:57.059176 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers' 2026-08-20 20:24:57.059204 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers 2026-08-20 20:24:57.059235 | instance | vexxhost.containers:1.6.8 was installed successfully 2026-08-20 20:24:57.059270 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:24:57.059298 | instance | 2.17.12 2026-08-20 20:24:57.059325 | instance | Checked out vexxhost.kubernetes to v3.3.0 2026-08-20 20:24:57.059352 | 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:24:57.059379 | instance | Starting galaxy collection install process 2026-08-20 20:24:57.059406 | instance | Process install dependency map 2026-08-20 20:24:57.059435 | instance | Starting collection install process 2026-08-20 20:24:57.059465 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes' 2026-08-20 20:24:57.059495 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes 2026-08-20 20:24:57.059522 | instance | vexxhost.kubernetes:3.3.0 was installed successfully 2026-08-20 20:24:57.059548 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:24:57.059575 | instance | 2.17.12 2026-08-20 20:24:57.067915 | 2026-08-20 20:24:57.067985 | PLAY RECAP 2026-08-20 20:24:57.068046 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-20 20:24:57.068078 | 2026-08-20 20:24:57.251438 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-20 20:24:57.254927 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-08-20 20:24:57.961215 | 2026-08-20 20:24:57.961530 | PLAY [all] 2026-08-20 20:24:57.973739 | 2026-08-20 20:24:57.973879 | TASK [Install "jq" for log collection] 2026-08-20 20:25:07.019419 | instance | changed 2026-08-20 20:25:07.021476 | 2026-08-20 20:25:07.021536 | PLAY RECAP 2026-08-20 20:25:07.021594 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-20 20:25:07.021667 | 2026-08-20 20:25:07.165974 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-08-20 20:25:07.170951 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-20 20:25:07.825430 | 2026-08-20 20:25:07.825762 | PLAY [all] 2026-08-20 20:25:07.842701 | 2026-08-20 20:25:07.842795 | LOOP [Check inventory directories] 2026-08-20 20:25:08.209208 | instance | ok: "src/github.com/vexxhost/atmosphere" 2026-08-20 20:25:08.353536 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory" 2026-08-20 20:25:08.505804 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory" 2026-08-20 20:25:08.519457 | 2026-08-20 20:25:08.519630 | LOOP [Copy inventory file for Zuul] 2026-08-20 20:25:09.305949 | instance | changed: 2026-08-20 20:25:09.306343 | instance | { 2026-08-20 20:25:09.306389 | instance | "ansible_loop_var": "item", 2026-08-20 20:25:09.306424 | instance | "changed": false, 2026-08-20 20:25:09.306454 | instance | "failed": false, 2026-08-20 20:25:09.306486 | instance | "invocation": { 2026-08-20 20:25:09.308838 | instance | "module_args": { 2026-08-20 20:25:09.308882 | instance | "checksum_algorithm": "sha1", 2026-08-20 20:25:09.308904 | instance | "follow": true, 2026-08-20 20:25:09.308923 | instance | "get_attributes": true, 2026-08-20 20:25:09.308943 | instance | "get_checksum": true, 2026-08-20 20:25:09.308983 | instance | "get_mime": true, 2026-08-20 20:25:09.309002 | instance | "path": "src/github.com/vexxhost/atmosphere" 2026-08-20 20:25:09.309020 | instance | } 2026-08-20 20:25:09.309037 | instance | }, 2026-08-20 20:25:09.309054 | instance | "item": "src/github.com/vexxhost/atmosphere", 2026-08-20 20:25:09.309072 | instance | "stat": { 2026-08-20 20:25:09.309088 | instance | "atime": 1787257489.742424, 2026-08-20 20:25:09.309106 | instance | "attr_flags": "e", 2026-08-20 20:25:09.309123 | instance | "attributes": [ 2026-08-20 20:25:09.309140 | instance | "extents" 2026-08-20 20:25:09.309158 | instance | ], 2026-08-20 20:25:09.309175 | instance | "block_size": 4096, 2026-08-20 20:25:09.309192 | instance | "blocks": 8, 2026-08-20 20:25:09.309210 | instance | "charset": "unknown", 2026-08-20 20:25:09.309228 | instance | "ctime": 1787257488.8145766, 2026-08-20 20:25:09.309246 | instance | "dev": 64513, 2026-08-20 20:25:09.309263 | instance | "device_type": 0, 2026-08-20 20:25:09.309280 | instance | "executable": true, 2026-08-20 20:25:09.309298 | instance | "exists": true, 2026-08-20 20:25:09.309315 | instance | "gid": 1000, 2026-08-20 20:25:09.309332 | instance | "gr_name": "zuul", 2026-08-20 20:25:09.309350 | instance | "inode": 1047466, 2026-08-20 20:25:09.309367 | instance | "isblk": false, 2026-08-20 20:25:09.309384 | instance | "ischr": false, 2026-08-20 20:25:09.309402 | instance | "isdir": true, 2026-08-20 20:25:09.309419 | instance | "isfifo": false, 2026-08-20 20:25:09.309436 | instance | "isgid": false, 2026-08-20 20:25:09.309452 | instance | "islnk": false, 2026-08-20 20:25:09.309469 | instance | "isreg": false, 2026-08-20 20:25:09.309485 | instance | "issock": false, 2026-08-20 20:25:09.309502 | instance | "isuid": false, 2026-08-20 20:25:09.309518 | instance | "mimetype": "unknown", 2026-08-20 20:25:09.309535 | instance | "mode": "0755", 2026-08-20 20:25:09.309551 | instance | "mtime": 1787257488.8145766, 2026-08-20 20:25:09.309569 | instance | "nlink": 21, 2026-08-20 20:25:09.309586 | instance | "path": "src/github.com/vexxhost/atmosphere", 2026-08-20 20:25:09.309603 | instance | "pw_name": "zuul", 2026-08-20 20:25:09.309621 | instance | "readable": true, 2026-08-20 20:25:09.309638 | instance | "rgrp": true, 2026-08-20 20:25:09.309656 | instance | "roth": true, 2026-08-20 20:25:09.309685 | instance | "rusr": true, 2026-08-20 20:25:09.309704 | instance | "size": 4096, 2026-08-20 20:25:09.309722 | instance | "uid": 1000, 2026-08-20 20:25:09.309750 | instance | "version": "1350884972", 2026-08-20 20:25:09.309769 | instance | "wgrp": false, 2026-08-20 20:25:09.309789 | instance | "woth": false, 2026-08-20 20:25:09.309808 | instance | "writeable": true, 2026-08-20 20:25:09.309825 | instance | "wusr": true, 2026-08-20 20:25:09.309843 | instance | "xgrp": true, 2026-08-20 20:25:09.309862 | instance | "xoth": true, 2026-08-20 20:25:09.309879 | instance | "xusr": true 2026-08-20 20:25:09.309897 | instance | } 2026-08-20 20:25:09.309915 | instance | } 2026-08-20 20:25:09.309950 | instance | ok: All items complete 2026-08-20 20:25:09.309972 | 2026-08-20 20:25:09.311488 | instance | skipping: Conditional result was False 2026-08-20 20:25:09.312093 | instance | skipping: Conditional result was False 2026-08-20 20:25:09.334009 | 2026-08-20 20:25:09.334245 | LOOP [Switch "ansible_host" to private IP] 2026-08-20 20:25:09.750797 | instance | changed: 1 replacements made 2026-08-20 20:25:09.754326 | instance | skipping: Conditional result was False 2026-08-20 20:25:09.759966 | instance | skipping: Conditional result was False 2026-08-20 20:25:09.775754 | 2026-08-20 20:25:09.775940 | TASK [Run Molecule scenario] 2026-08-20 20:25:10.710069 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-08-20 20:25:11.130172 | instance | INFO [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-08-20 20:25:11.130255 | instance | INFO [csi > prerun] Performing prerun with role_name_check=0... 2026-08-20 20:25:22.532508 | instance | INFO [csi > dependency] Executing 2026-08-20 20:25:22.532748 | instance | WARNING [csi > dependency] Missing roles requirements file: requirements.yml 2026-08-20 20:25:22.533034 | instance | WARNING [csi > dependency] Missing collections requirements file: collections.yml 2026-08-20 20:25:22.533199 | instance | WARNING [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-08-20 20:25:22.542228 | instance | INFO [csi > cleanup] Executing 2026-08-20 20:25:22.542607 | instance | WARNING [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-20 20:25:22.550414 | instance | INFO [csi > destroy] Executing 2026-08-20 20:25:22.550489 | instance | WARNING [csi > destroy] Skipping, '--destroy=never' requested. 2026-08-20 20:25:22.550592 | instance | INFO [csi > destroy] Executed: Successful 2026-08-20 20:25:22.558284 | instance | INFO [csi > syntax] Executing 2026-08-20 20:25:24.231196 | instance | 2026-08-20 20:25:24.231607 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-08-20 20:25:24.315351 | instance | INFO [csi > syntax] Executed: Successful 2026-08-20 20:25:24.328928 | instance | INFO [csi > create] Executing 2026-08-20 20:25:24.330757 | instance | WARNING [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-20 20:25:24.338353 | instance | INFO [csi > prepare] Executing 2026-08-20 20:25:25.206244 | instance | 2026-08-20 20:25:25.206578 | instance | PLAY [Prepare] ***************************************************************** 2026-08-20 20:25:25.206853 | instance | 2026-08-20 20:25:25.207216 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-20 20:25:25.207573 | instance | Thursday 20 August 2026 20:25:25 +0000 (0:00:00.027) 0:00:00.027 ******* 2026-08-20 20:25:26.408795 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-08-20 20:25:26.409074 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-08-20 20:25:26.409356 | instance | interpreter could change the meaning of that path. See 2026-08-20 20:25:26.409696 | instance | https://docs.ansible.com/ansible- 2026-08-20 20:25:26.409981 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-08-20 20:25:26.418352 | instance | ok: [instance] 2026-08-20 20:25:26.418496 | instance | 2026-08-20 20:25:26.418677 | instance | TASK [Configure short hostname] ************************************************ 2026-08-20 20:25:26.418873 | instance | Thursday 20 August 2026 20:25:26 +0000 (0:00:01.212) 0:00:01.240 ******* 2026-08-20 20:25:27.167711 | instance | changed: [instance] 2026-08-20 20:25:27.167919 | instance | 2026-08-20 20:25:27.168175 | instance | TASK [Ensure hostname inside hosts file] *************************************** 2026-08-20 20:25:27.168373 | instance | Thursday 20 August 2026 20:25:27 +0000 (0:00:00.748) 0:00:01.989 ******* 2026-08-20 20:25:27.439656 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created 2026-08-20 20:25:27.439984 | instance | with a mode of 0700, this may cause issues when running as another user. To 2026-08-20 20:25:27.440395 | instance | avoid this, create the remote_tmp dir with the correct permissions manually 2026-08-20 20:25:27.446663 | instance | changed: [instance] 2026-08-20 20:25:27.446962 | instance | 2026-08-20 20:25:27.447322 | instance | TASK [Purge "snapd" package] *************************************************** 2026-08-20 20:25:27.447613 | instance | Thursday 20 August 2026 20:25:27 +0000 (0:00:00.279) 0:00:02.268 ******* 2026-08-20 20:25:28.208857 | instance | ok: [instance] 2026-08-20 20:25:28.208947 | instance | 2026-08-20 20:25:28.209082 | instance | PLAY [Create devices for Ceph] ************************************************* 2026-08-20 20:25:28.209202 | instance | 2026-08-20 20:25:28.209332 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-20 20:25:28.209462 | instance | Thursday 20 August 2026 20:25:28 +0000 (0:00:00.762) 0:00:03.030 ******* 2026-08-20 20:25:28.910270 | instance | ok: [instance] 2026-08-20 20:25:28.910469 | instance | 2026-08-20 20:25:28.910789 | instance | TASK [Install depedencies] ***************************************************** 2026-08-20 20:25:28.911082 | instance | Thursday 20 August 2026 20:25:28 +0000 (0:00:00.700) 0:00:03.731 ******* 2026-08-20 20:25:49.576990 | instance | changed: [instance] 2026-08-20 20:25:49.577087 | instance | 2026-08-20 20:25:49.577100 | instance | TASK [Start up service] ******************************************************** 2026-08-20 20:25:49.577111 | instance | Thursday 20 August 2026 20:25:49 +0000 (0:00:20.666) 0:00:24.397 ******* 2026-08-20 20:25:50.150623 | instance | ok: [instance] 2026-08-20 20:25:50.150891 | instance | 2026-08-20 20:25:50.151295 | instance | TASK [Generate lvm.conf] ******************************************************* 2026-08-20 20:25:50.151576 | instance | Thursday 20 August 2026 20:25:50 +0000 (0:00:00.574) 0:00:24.972 ******* 2026-08-20 20:25:50.440912 | instance | ok: [instance] 2026-08-20 20:25:50.441221 | instance | 2026-08-20 20:25:50.441536 | instance | TASK [Write /etc/lvm/lvm.conf] ************************************************* 2026-08-20 20:25:50.441833 | instance | Thursday 20 August 2026 20:25:50 +0000 (0:00:00.290) 0:00:25.262 ******* 2026-08-20 20:25:51.104230 | instance | changed: [instance] 2026-08-20 20:25:51.104587 | instance | 2026-08-20 20:25:51.104810 | instance | TASK [Get list of all loopback devices] **************************************** 2026-08-20 20:25:51.105049 | instance | Thursday 20 August 2026 20:25:51 +0000 (0:00:00.663) 0:00:25.926 ******* 2026-08-20 20:25:51.296526 | instance | ok: [instance] 2026-08-20 20:25:51.296674 | instance | 2026-08-20 20:25:51.296930 | instance | TASK [Fail if there is any existing loopback devices] ************************** 2026-08-20 20:25:51.297155 | instance | Thursday 20 August 2026 20:25:51 +0000 (0:00:00.192) 0:00:26.118 ******* 2026-08-20 20:25:51.319425 | instance | skipping: [instance] 2026-08-20 20:25:51.319594 | instance | 2026-08-20 20:25:51.319837 | instance | TASK [Create devices for Ceph] ************************************************* 2026-08-20 20:25:51.320055 | instance | Thursday 20 August 2026 20:25:51 +0000 (0:00:00.022) 0:00:26.141 ******* 2026-08-20 20:25:51.860965 | instance | changed: [instance] => (item=osd0) 2026-08-20 20:25:51.862192 | instance | changed: [instance] => (item=osd1) 2026-08-20 20:25:51.862235 | instance | changed: [instance] => (item=osd2) 2026-08-20 20:25:51.862243 | instance | 2026-08-20 20:25:51.862254 | instance | TASK [Set permissions on loopback devices] ************************************* 2026-08-20 20:25:51.862852 | instance | Thursday 20 August 2026 20:25:51 +0000 (0:00:00.540) 0:00:26.681 ******* 2026-08-20 20:25:52.500447 | instance | changed: [instance] => (item=osd0) 2026-08-20 20:25:52.501290 | instance | changed: [instance] => (item=osd1) 2026-08-20 20:25:52.501311 | instance | changed: [instance] => (item=osd2) 2026-08-20 20:25:52.501319 | instance | 2026-08-20 20:25:52.501325 | instance | TASK [Start loop devices] ****************************************************** 2026-08-20 20:25:52.501332 | instance | Thursday 20 August 2026 20:25:52 +0000 (0:00:00.640) 0:00:27.322 ******* 2026-08-20 20:25:53.196004 | instance | changed: [instance] => (item=osd0) 2026-08-20 20:25:53.196890 | instance | changed: [instance] => (item=osd1) 2026-08-20 20:25:53.196931 | instance | changed: [instance] => (item=osd2) 2026-08-20 20:25:53.196939 | instance | 2026-08-20 20:25:53.196946 | instance | TASK [Create a volume group for each loop device] ****************************** 2026-08-20 20:25:53.196953 | instance | Thursday 20 August 2026 20:25:53 +0000 (0:00:00.695) 0:00:28.017 ******* 2026-08-20 20:25:56.539830 | instance | changed: [instance] => (item=osd0) 2026-08-20 20:25:56.540794 | instance | changed: [instance] => (item=osd1) 2026-08-20 20:25:56.540820 | instance | changed: [instance] => (item=osd2) 2026-08-20 20:25:56.540828 | instance | 2026-08-20 20:25:56.540834 | instance | TASK [Create a logical volume for each loop device] **************************** 2026-08-20 20:25:56.540840 | instance | Thursday 20 August 2026 20:25:56 +0000 (0:00:03.343) 0:00:31.361 ******* 2026-08-20 20:25:58.348136 | instance | changed: [instance] => (item=ceph-instance-osd0) 2026-08-20 20:25:58.348624 | instance | changed: [instance] => (item=ceph-instance-osd1) 2026-08-20 20:25:58.348652 | instance | changed: [instance] => (item=ceph-instance-osd2) 2026-08-20 20:25:58.348661 | instance | 2026-08-20 20:25:58.349250 | instance | PLAY RECAP ********************************************************************* 2026-08-20 20:25:58.349307 | instance | instance : ok=15 changed=9 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-08-20 20:25:58.349320 | instance | 2026-08-20 20:25:58.349337 | instance | Thursday 20 August 2026 20:25:58 +0000 (0:00:01.808) 0:00:33.170 ******* 2026-08-20 20:25:58.350201 | instance | =============================================================================== 2026-08-20 20:25:58.350256 | instance | Install depedencies ---------------------------------------------------- 20.67s 2026-08-20 20:25:58.350268 | instance | Create a volume group for each loop device ------------------------------ 3.34s 2026-08-20 20:25:58.350278 | instance | Create a logical volume for each loop device ---------------------------- 1.81s 2026-08-20 20:25:58.350289 | instance | Gathering Facts --------------------------------------------------------- 1.21s 2026-08-20 20:25:58.352271 | instance | Purge "snapd" package --------------------------------------------------- 0.76s 2026-08-20 20:25:58.352320 | instance | Configure short hostname ------------------------------------------------ 0.75s 2026-08-20 20:25:58.352327 | instance | Gathering Facts --------------------------------------------------------- 0.70s 2026-08-20 20:25:58.352333 | instance | Start loop devices ------------------------------------------------------ 0.70s 2026-08-20 20:25:58.352339 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.66s 2026-08-20 20:25:58.352344 | instance | Set permissions on loopback devices ------------------------------------- 0.64s 2026-08-20 20:25:58.352350 | instance | Start up service -------------------------------------------------------- 0.57s 2026-08-20 20:25:58.352356 | instance | Create devices for Ceph ------------------------------------------------- 0.54s 2026-08-20 20:25:58.352361 | instance | Generate lvm.conf ------------------------------------------------------- 0.29s 2026-08-20 20:25:58.352367 | instance | Ensure hostname inside hosts file --------------------------------------- 0.28s 2026-08-20 20:25:58.352373 | instance | Get list of all loopback devices ---------------------------------------- 0.19s 2026-08-20 20:25:58.352379 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s 2026-08-20 20:25:58.419196 | instance | INFO [csi > prepare] Executed: Successful 2026-08-20 20:25:58.432197 | instance | INFO [csi > converge] Executing 2026-08-20 20:25:59.910938 | instance | 2026-08-20 20:25:59.911441 | instance | PLAY [Debug CSI driver value] ************************************************** 2026-08-20 20:25:59.911802 | instance | 2026-08-20 20:25:59.912185 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-20 20:25:59.912598 | instance | Thursday 20 August 2026 20:25:59 +0000 (0:00:00.007) 0:00:00.007 ******* 2026-08-20 20:26:00.866364 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-08-20 20:26:00.866868 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-08-20 20:26:00.867278 | instance | interpreter could change the meaning of that path. See 2026-08-20 20:26:00.867643 | instance | https://docs.ansible.com/ansible- 2026-08-20 20:26:00.868050 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-08-20 20:26:00.875830 | instance | ok: [instance] 2026-08-20 20:26:00.876136 | instance | 2026-08-20 20:26:00.876452 | instance | TASK [Display CSI driver value and environment variable] *********************** 2026-08-20 20:26:00.876775 | instance | Thursday 20 August 2026 20:26:00 +0000 (0:00:00.965) 0:00:00.972 ******* 2026-08-20 20:26:00.921231 | instance | ok: [instance] => { 2026-08-20 20:26:00.921668 | instance | "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER=" 2026-08-20 20:26:00.922155 | instance | } 2026-08-20 20:26:00.922594 | instance | 2026-08-20 20:26:00.922989 | instance | PLAY [all] ********************************************************************* 2026-08-20 20:26:00.923330 | instance | 2026-08-20 20:26:00.923739 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-20 20:26:00.924133 | instance | Thursday 20 August 2026 20:26:00 +0000 (0:00:00.045) 0:00:01.018 ******* 2026-08-20 20:26:01.775721 | instance | ok: [instance] 2026-08-20 20:26:01.776164 | instance | 2026-08-20 20:26:01.776594 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-08-20 20:26:01.776960 | instance | Thursday 20 August 2026 20:26:01 +0000 (0:00:00.854) 0:00:01.872 ******* 2026-08-20 20:26:01.980239 | instance | ok: [instance] 2026-08-20 20:26:01.980722 | instance | 2026-08-20 20:26:01.981124 | instance | PLAY [Deploy Ceph monitors & managers] ***************************************** 2026-08-20 20:26:01.981493 | instance | 2026-08-20 20:26:01.981861 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-20 20:26:01.982279 | instance | Thursday 20 August 2026 20:26:01 +0000 (0:00:00.204) 0:00:02.076 ******* 2026-08-20 20:26:02.868290 | instance | ok: [instance] 2026-08-20 20:26:02.868997 | instance | 2026-08-20 20:26:02.869023 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-20 20:26:02.869041 | instance | Thursday 20 August 2026 20:26:02 +0000 (0:00:00.888) 0:00:02.965 ******* 2026-08-20 20:26:03.159147 | instance | ok: [instance] 2026-08-20 20:26:03.159270 | instance | 2026-08-20 20:26:03.159652 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-20 20:26:03.159757 | instance | Thursday 20 August 2026 20:26:03 +0000 (0:00:00.290) 0:00:03.255 ******* 2026-08-20 20:26:03.203503 | instance | skipping: [instance] 2026-08-20 20:26:03.203907 | instance | 2026-08-20 20:26:03.203946 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-08-20 20:26:03.203952 | instance | Thursday 20 August 2026 20:26:03 +0000 (0:00:00.044) 0:00:03.300 ******* 2026-08-20 20:26:03.533764 | instance | changed: [instance] 2026-08-20 20:26:03.534220 | instance | 2026-08-20 20:26:03.534296 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-20 20:26:03.534316 | instance | Thursday 20 August 2026 20:26:03 +0000 (0:00:00.330) 0:00:03.630 ******* 2026-08-20 20:26:03.602787 | instance | ok: [instance] => { 2026-08-20 20:26:03.602916 | instance | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-08-20 20:26:03.603083 | instance | } 2026-08-20 20:26:03.603244 | instance | 2026-08-20 20:26:03.603420 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-20 20:26:03.603651 | instance | Thursday 20 August 2026 20:26:03 +0000 (0:00:00.068) 0:00:03.699 ******* 2026-08-20 20:26:04.173699 | instance | changed: [instance] 2026-08-20 20:26:04.173968 | instance | 2026-08-20 20:26:04.174442 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-20 20:26:04.174798 | instance | Thursday 20 August 2026 20:26:04 +0000 (0:00:00.570) 0:00:04.270 ******* 2026-08-20 20:26:04.226035 | instance | skipping: [instance] 2026-08-20 20:26:04.226359 | instance | 2026-08-20 20:26:04.226650 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-20 20:26:04.226944 | instance | Thursday 20 August 2026 20:26:04 +0000 (0:00:00.052) 0:00:04.322 ******* 2026-08-20 20:26:04.280482 | instance | skipping: [instance] 2026-08-20 20:26:04.280727 | instance | 2026-08-20 20:26:04.281105 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-20 20:26:04.281544 | instance | Thursday 20 August 2026 20:26:04 +0000 (0:00:00.054) 0:00:04.377 ******* 2026-08-20 20:26:04.496398 | instance | ok: [instance] 2026-08-20 20:26:04.496656 | instance | 2026-08-20 20:26:04.496997 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-20 20:26:04.497293 | instance | Thursday 20 August 2026 20:26:04 +0000 (0:00:00.215) 0:00:04.593 ******* 2026-08-20 20:26:05.694645 | instance | ok: [instance] 2026-08-20 20:26:05.694956 | instance | 2026-08-20 20:26:05.695295 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-20 20:26:05.695617 | instance | Thursday 20 August 2026 20:26:05 +0000 (0:00:01.198) 0:00:05.791 ******* 2026-08-20 20:26:05.768940 | instance | ok: [instance] => { 2026-08-20 20:26:05.769867 | instance | "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz" 2026-08-20 20:26:05.770285 | instance | } 2026-08-20 20:26:05.770580 | instance | 2026-08-20 20:26:05.770903 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-20 20:26:05.771209 | instance | Thursday 20 August 2026 20:26:05 +0000 (0:00:00.073) 0:00:05.865 ******* 2026-08-20 20:26:06.358536 | instance | changed: [instance] 2026-08-20 20:26:06.358801 | instance | 2026-08-20 20:26:06.359095 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-20 20:26:06.359408 | instance | Thursday 20 August 2026 20:26:06 +0000 (0:00:00.590) 0:00:06.455 ******* 2026-08-20 20:26:09.224031 | instance | changed: [instance] 2026-08-20 20:26:09.224101 | instance | 2026-08-20 20:26:09.224114 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-08-20 20:26:09.224287 | instance | Thursday 20 August 2026 20:26:09 +0000 (0:00:02.863) 0:00:09.318 ******* 2026-08-20 20:26:09.250766 | instance | skipping: [instance] 2026-08-20 20:26:09.251014 | instance | 2026-08-20 20:26:09.251294 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-08-20 20:26:09.251587 | instance | Thursday 20 August 2026 20:26:09 +0000 (0:00:00.028) 0:00:09.347 ******* 2026-08-20 20:26:09.286127 | instance | skipping: [instance] 2026-08-20 20:26:09.286385 | instance | 2026-08-20 20:26:09.286958 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-08-20 20:26:09.287247 | instance | Thursday 20 August 2026 20:26:09 +0000 (0:00:00.035) 0:00:09.382 ******* 2026-08-20 20:26:09.319511 | instance | skipping: [instance] 2026-08-20 20:26:09.319774 | instance | 2026-08-20 20:26:09.320109 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-08-20 20:26:09.320314 | instance | Thursday 20 August 2026 20:26:09 +0000 (0:00:00.033) 0:00:09.416 ******* 2026-08-20 20:26:13.938314 | instance | changed: [instance] 2026-08-20 20:26:13.938680 | instance | 2026-08-20 20:26:13.939012 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] *** 2026-08-20 20:26:13.939308 | instance | Thursday 20 August 2026 20:26:13 +0000 (0:00:04.618) 0:00:14.034 ******* 2026-08-20 20:26:14.532409 | instance | changed: [instance] 2026-08-20 20:26:14.532672 | instance | 2026-08-20 20:26:14.532998 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] ******* 2026-08-20 20:26:14.533320 | instance | Thursday 20 August 2026 20:26:14 +0000 (0:00:00.594) 0:00:14.629 ******* 2026-08-20 20:26:15.514310 | instance | changed: [instance] => (item={'path': '/etc/containerd'}) 2026-08-20 20:26:15.514381 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'}) 2026-08-20 20:26:15.514393 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'}) 2026-08-20 20:26:15.514410 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'}) 2026-08-20 20:26:15.514943 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'}) 2026-08-20 20:26:15.515101 | instance | 2026-08-20 20:26:15.515113 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] ********** 2026-08-20 20:26:15.515118 | instance | Thursday 20 August 2026 20:26:15 +0000 (0:00:00.981) 0:00:15.610 ******* 2026-08-20 20:26:16.133238 | instance | changed: [instance] 2026-08-20 20:26:16.133330 | instance | 2026-08-20 20:26:16.133935 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ******** 2026-08-20 20:26:16.133976 | instance | Thursday 20 August 2026 20:26:16 +0000 (0:00:00.603) 0:00:16.213 ******* 2026-08-20 20:26:16.133982 | instance | 2026-08-20 20:26:16.133987 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-08-20 20:26:16.133991 | instance | Thursday 20 August 2026 20:26:16 +0000 (0:00:00.016) 0:00:16.230 ******* 2026-08-20 20:26:17.103512 | instance | ok: [instance] 2026-08-20 20:26:17.103595 | instance | 2026-08-20 20:26:17.103814 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] ********** 2026-08-20 20:26:17.103944 | instance | Thursday 20 August 2026 20:26:17 +0000 (0:00:00.970) 0:00:17.200 ******* 2026-08-20 20:26:17.558809 | instance | changed: [instance] 2026-08-20 20:26:17.558923 | instance | 2026-08-20 20:26:17.559016 | instance | TASK [vexxhost.containers.containerd : Enable and start service] *************** 2026-08-20 20:26:17.559147 | instance | Thursday 20 August 2026 20:26:17 +0000 (0:00:00.455) 0:00:17.655 ******* 2026-08-20 20:26:18.118893 | instance | changed: [instance] 2026-08-20 20:26:18.118930 | instance | 2026-08-20 20:26:18.118936 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-20 20:26:18.118940 | instance | Thursday 20 August 2026 20:26:18 +0000 (0:00:00.559) 0:00:18.215 ******* 2026-08-20 20:26:18.343013 | instance | ok: [instance] 2026-08-20 20:26:18.343053 | instance | 2026-08-20 20:26:18.343060 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-20 20:26:18.343066 | instance | Thursday 20 August 2026 20:26:18 +0000 (0:00:00.224) 0:00:18.439 ******* 2026-08-20 20:26:18.408662 | instance | ok: [instance] => { 2026-08-20 20:26:18.408699 | instance | "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz" 2026-08-20 20:26:18.408705 | instance | } 2026-08-20 20:26:18.408709 | instance | 2026-08-20 20:26:18.408714 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-20 20:26:18.408718 | instance | Thursday 20 August 2026 20:26:18 +0000 (0:00:00.065) 0:00:18.504 ******* 2026-08-20 20:26:19.221746 | instance | changed: [instance] 2026-08-20 20:26:19.222209 | instance | 2026-08-20 20:26:19.222282 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-20 20:26:19.222358 | instance | Thursday 20 August 2026 20:26:19 +0000 (0:00:00.813) 0:00:19.318 ******* 2026-08-20 20:26:23.746289 | instance | changed: [instance] 2026-08-20 20:26:23.746389 | instance | 2026-08-20 20:26:23.746466 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ****************** 2026-08-20 20:26:23.746621 | instance | Thursday 20 August 2026 20:26:23 +0000 (0:00:04.524) 0:00:23.843 ******* 2026-08-20 20:26:24.846640 | instance | ok: [instance] 2026-08-20 20:26:24.846804 | instance | 2026-08-20 20:26:24.847136 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] *************** 2026-08-20 20:26:24.847182 | instance | Thursday 20 August 2026 20:26:24 +0000 (0:00:01.100) 0:00:24.943 ******* 2026-08-20 20:26:25.221867 | instance | changed: [instance] 2026-08-20 20:26:25.221941 | instance | 2026-08-20 20:26:25.222198 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] ***** 2026-08-20 20:26:25.222261 | instance | Thursday 20 August 2026 20:26:25 +0000 (0:00:00.375) 0:00:25.318 ******* 2026-08-20 20:26:25.682857 | instance | changed: [instance] 2026-08-20 20:26:25.682950 | instance | 2026-08-20 20:26:25.683234 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] *********** 2026-08-20 20:26:25.683271 | instance | Thursday 20 August 2026 20:26:25 +0000 (0:00:00.461) 0:00:25.780 ******* 2026-08-20 20:26:26.256622 | instance | changed: [instance] => (item={'path': '/etc/docker'}) 2026-08-20 20:26:26.256698 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'}) 2026-08-20 20:26:26.257241 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'}) 2026-08-20 20:26:26.257283 | instance | 2026-08-20 20:26:26.257289 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ****** 2026-08-20 20:26:26.257293 | instance | Thursday 20 August 2026 20:26:26 +0000 (0:00:00.573) 0:00:26.353 ******* 2026-08-20 20:26:26.734457 | instance | changed: [instance] 2026-08-20 20:26:26.734525 | instance | 2026-08-20 20:26:26.734864 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] *********** 2026-08-20 20:26:26.734904 | instance | Thursday 20 August 2026 20:26:26 +0000 (0:00:00.477) 0:00:26.831 ******* 2026-08-20 20:26:27.211082 | instance | changed: [instance] 2026-08-20 20:26:27.211158 | instance | 2026-08-20 20:26:27.211893 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************ 2026-08-20 20:26:27.211932 | instance | Thursday 20 August 2026 20:26:27 +0000 (0:00:00.458) 0:00:27.289 ******* 2026-08-20 20:26:27.211938 | instance | 2026-08-20 20:26:27.211943 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-08-20 20:26:27.211947 | instance | Thursday 20 August 2026 20:26:27 +0000 (0:00:00.018) 0:00:27.308 ******* 2026-08-20 20:26:27.906342 | instance | ok: [instance] 2026-08-20 20:26:27.906452 | instance | 2026-08-20 20:26:27.906722 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ****************** 2026-08-20 20:26:27.906767 | instance | Thursday 20 August 2026 20:26:27 +0000 (0:00:00.695) 0:00:28.003 ******* 2026-08-20 20:26:28.610207 | instance | changed: [instance] 2026-08-20 20:26:28.610801 | instance | 2026-08-20 20:26:28.610848 | instance | TASK [vexxhost.containers.docker : Enable and start service] ******************* 2026-08-20 20:26:28.610856 | instance | Thursday 20 August 2026 20:26:28 +0000 (0:00:00.703) 0:00:28.706 ******* 2026-08-20 20:26:29.167416 | instance | changed: [instance] 2026-08-20 20:26:29.167900 | instance | 2026-08-20 20:26:29.167920 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ****** 2026-08-20 20:26:29.167928 | instance | Thursday 20 August 2026 20:26:29 +0000 (0:00:00.557) 0:00:29.264 ******* 2026-08-20 20:26:29.220338 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml) 2026-08-20 20:26:29.220753 | instance | 2026-08-20 20:26:29.220796 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ******************************** 2026-08-20 20:26:29.220802 | instance | Thursday 20 August 2026 20:26:29 +0000 (0:00:00.052) 0:00:29.317 ******* 2026-08-20 20:26:34.433651 | instance | changed: [instance] 2026-08-20 20:26:34.433843 | instance | 2026-08-20 20:26:34.433850 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] ********************* 2026-08-20 20:26:34.433855 | instance | Thursday 20 August 2026 20:26:34 +0000 (0:00:05.212) 0:00:34.529 ******* 2026-08-20 20:26:35.136751 | instance | ok: [instance] => (item=chronyd) 2026-08-20 20:26:35.136842 | instance | ok: [instance] => (item=sshd) 2026-08-20 20:26:35.137277 | instance | 2026-08-20 20:26:35.137461 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ****************************** 2026-08-20 20:26:35.137468 | instance | Thursday 20 August 2026 20:26:35 +0000 (0:00:00.703) 0:00:35.233 ******* 2026-08-20 20:26:36.410874 | instance | changed: [instance] 2026-08-20 20:26:36.410937 | instance | 2026-08-20 20:26:36.410942 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ******************** 2026-08-20 20:26:36.410947 | instance | Thursday 20 August 2026 20:26:36 +0000 (0:00:01.273) 0:00:36.507 ******* 2026-08-20 20:26:36.619580 | instance | ok: [instance] 2026-08-20 20:26:36.620400 | instance | 2026-08-20 20:26:36.620550 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] **************** 2026-08-20 20:26:36.620562 | instance | Thursday 20 August 2026 20:26:36 +0000 (0:00:00.209) 0:00:36.716 ******* 2026-08-20 20:26:37.057375 | instance | changed: [instance] 2026-08-20 20:26:37.057452 | instance | 2026-08-20 20:26:37.057757 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] *** 2026-08-20 20:26:37.057802 | instance | Thursday 20 August 2026 20:26:37 +0000 (0:00:00.438) 0:00:37.154 ******* 2026-08-20 20:26:37.386995 | instance | changed: [instance] 2026-08-20 20:26:37.387067 | instance | 2026-08-20 20:26:37.387341 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] ************************* 2026-08-20 20:26:37.387382 | instance | Thursday 20 August 2026 20:26:37 +0000 (0:00:00.329) 0:00:37.483 ******* 2026-08-20 20:26:37.508772 | instance | ok: [instance] 2026-08-20 20:26:37.508844 | instance | 2026-08-20 20:26:37.509170 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] ******************* 2026-08-20 20:26:37.509212 | instance | Thursday 20 August 2026 20:26:37 +0000 (0:00:00.121) 0:00:37.605 ******* 2026-08-20 20:26:37.760088 | instance | ok: [instance] => (item=instance) 2026-08-20 20:26:37.760189 | instance | 2026-08-20 20:26:37.760560 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ******** 2026-08-20 20:26:37.760652 | instance | Thursday 20 August 2026 20:26:37 +0000 (0:00:00.250) 0:00:37.856 ******* 2026-08-20 20:26:37.817379 | instance | ok: [instance] 2026-08-20 20:26:37.817797 | instance | 2026-08-20 20:26:37.817843 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] *********************************** 2026-08-20 20:26:37.817850 | instance | Thursday 20 August 2026 20:26:37 +0000 (0:00:00.057) 0:00:37.913 ******* 2026-08-20 20:26:37.912570 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance 2026-08-20 20:26:37.912664 | instance | 2026-08-20 20:26:37.912964 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] ************* 2026-08-20 20:26:37.913011 | instance | Thursday 20 August 2026 20:26:37 +0000 (0:00:00.095) 0:00:38.008 ******* 2026-08-20 20:26:38.254211 | instance | changed: [instance] 2026-08-20 20:26:38.254440 | instance | 2026-08-20 20:26:38.254458 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ****************** 2026-08-20 20:26:38.254465 | instance | Thursday 20 August 2026 20:26:38 +0000 (0:00:00.341) 0:00:38.350 ******* 2026-08-20 20:26:38.977057 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True}) 2026-08-20 20:26:38.977166 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0}) 2026-08-20 20:26:38.977676 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False}) 2026-08-20 20:26:38.977716 | instance | 2026-08-20 20:26:38.977722 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] ******************************* 2026-08-20 20:26:38.977727 | instance | Thursday 20 August 2026 20:26:38 +0000 (0:00:00.723) 0:00:39.074 ******* 2026-08-20 20:28:07.152552 | instance | ok: [instance] 2026-08-20 20:28:07.152635 | instance | 2026-08-20 20:28:07.152840 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] *************** 2026-08-20 20:28:07.152856 | instance | Thursday 20 August 2026 20:28:07 +0000 (0:01:28.175) 0:02:07.249 ******* 2026-08-20 20:28:07.378299 | instance | changed: [instance] 2026-08-20 20:28:07.378432 | instance | 2026-08-20 20:28:07.378443 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] ********************************** 2026-08-20 20:28:07.378592 | instance | Thursday 20 August 2026 20:28:07 +0000 (0:00:00.225) 0:02:07.475 ******* 2026-08-20 20:28:07.455974 | instance | ok: [instance] 2026-08-20 20:28:07.456078 | instance | 2026-08-20 20:28:07.456329 | instance | TASK [Install Ceph host] ******************************************************* 2026-08-20 20:28:07.456386 | instance | Thursday 20 August 2026 20:28:07 +0000 (0:00:00.077) 0:02:07.552 ******* 2026-08-20 20:28:07.550203 | instance | included: vexxhost.ceph.cephadm_host for instance 2026-08-20 20:28:07.550274 | instance | 2026-08-20 20:28:07.550524 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ****** 2026-08-20 20:28:07.550566 | instance | Thursday 20 August 2026 20:28:07 +0000 (0:00:00.093) 0:02:07.646 ******* 2026-08-20 20:28:09.184587 | instance | ok: [instance] 2026-08-20 20:28:09.184663 | instance | 2026-08-20 20:28:09.184886 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] *** 2026-08-20 20:28:09.185008 | instance | Thursday 20 August 2026 20:28:09 +0000 (0:00:01.634) 0:02:09.281 ******* 2026-08-20 20:28:09.248821 | instance | ok: [instance] => (item=instance) 2026-08-20 20:28:09.248936 | instance | 2026-08-20 20:28:09.249111 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] *********** 2026-08-20 20:28:09.249245 | instance | Thursday 20 August 2026 20:28:09 +0000 (0:00:00.064) 0:02:09.345 ******* 2026-08-20 20:28:09.631119 | instance | ok: [instance] 2026-08-20 20:28:09.632381 | instance | 2026-08-20 20:28:09.632402 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] *********************** 2026-08-20 20:28:09.632411 | instance | Thursday 20 August 2026 20:28:09 +0000 (0:00:00.381) 0:02:09.727 ******* 2026-08-20 20:28:11.955873 | instance | ok: [instance] 2026-08-20 20:28:11.955955 | instance | 2026-08-20 20:28:11.955967 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ****************** 2026-08-20 20:28:11.956107 | instance | Thursday 20 August 2026 20:28:11 +0000 (0:00:02.325) 0:02:12.052 ******* 2026-08-20 20:28:57.581505 | 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:28:57.581997 | 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_dghky4oy/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_dghky4oy/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_dghky4oy/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_dghky4oy/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:28:57.437+0000 7f44bf338640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgArY4dqKd+hHSAAbvD9fWdSeKhqbQR48QAzE3o7ftdxfwwTOtf2xLovenc=: Malformed input [buffer:3]\n2026-08-20T20:28:57.437+0000 7f44bf338640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-20T20:28:57.437+0000 7f44bf338640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgArY4dqKd+hHSAAbvD9fWdSeKhqbQR48QAzE3o7ftdxfwwTOtf2xLovenc=: Malformed input [buffer:3]\n2026-08-20T20:28:57.437+0000 7f44bf338640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-20T20:28:57.437+0000 7f44bf338640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgArY4dqKd+hHSAAbvD9fWdSeKhqbQR48QAzE3o7ftdxfwwTOtf2xLovenc=: Malformed input [buffer:3]\n2026-08-20T20:28:57.437+0000 7f44bf338640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-20T20:28:57.437+0000 7f44bf338640 -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:28:57.582779 | instance | 2026-08-20 20:28:57.582956 | instance | PLAY RECAP ********************************************************************* 2026-08-20 20:28:57.586163 | instance | instance : ok=55 changed=26 unreachable=0 failed=1 skipped=6 rescued=0 ignored=0 2026-08-20 20:28:57.586193 | instance | 2026-08-20 20:28:57.586202 | instance | Thursday 20 August 2026 20:28:57 +0000 (0:00:45.627) 0:02:57.680 ******* 2026-08-20 20:28:57.586210 | instance | =============================================================================== 2026-08-20 20:28:57.586217 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 88.18s 2026-08-20 20:28:57.586223 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 45.63s 2026-08-20 20:28:57.586229 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 5.21s 2026-08-20 20:28:57.586236 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 4.62s 2026-08-20 20:28:57.586242 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.52s 2026-08-20 20:28:57.586249 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.86s 2026-08-20 20:28:57.586255 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.33s 2026-08-20 20:28:57.586262 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.67s 2026-08-20 20:28:57.586282 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.63s 2026-08-20 20:28:57.586289 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 1.27s 2026-08-20 20:28:57.586295 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.20s 2026-08-20 20:28:57.586302 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.10s 2026-08-20 20:28:57.586308 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.98s 2026-08-20 20:28:57.586315 | instance | Gathering Facts --------------------------------------------------------- 0.97s 2026-08-20 20:28:57.586326 | instance | Gathering Facts --------------------------------------------------------- 0.89s 2026-08-20 20:28:57.586471 | instance | Gathering Facts --------------------------------------------------------- 0.85s 2026-08-20 20:28:57.586706 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.81s 2026-08-20 20:28:57.586926 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.72s 2026-08-20 20:28:57.587148 | instance | vexxhost.ceph.cephadm : Ensure services are started --------------------- 0.70s 2026-08-20 20:28:57.587365 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 0.70s 2026-08-20 20:28:57.679414 | 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:28:57.679714 | instance | ERROR [csi > converge] Executed: Failed 2026-08-20 20:28:57.679919 | 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:28:58.122364 | instance | ERROR 2026-08-20 20:28:58.122690 | instance | { 2026-08-20 20:28:58.122821 | instance | "delta": "0:03:47.602701", 2026-08-20 20:28:58.122892 | instance | "end": "2026-08-20 20:28:57.733678", 2026-08-20 20:28:58.122956 | instance | "msg": "non-zero return code", 2026-08-20 20:28:58.123017 | instance | "rc": 2, 2026-08-20 20:28:58.123077 | instance | "start": "2026-08-20 20:25:10.130977" 2026-08-20 20:28:58.123139 | instance | } failure 2026-08-20 20:28:58.129851 | 2026-08-20 20:28:58.129948 | PLAY RECAP 2026-08-20 20:28:58.130010 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-08-20 20:28:58.130044 | 2026-08-20 20:28:58.313852 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-20 20:28:58.325796 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-08-20 20:28:59.718150 | 2026-08-20 20:28:59.965773 | PLAY [all] 2026-08-20 20:28:59.999652 | 2026-08-20 20:28:59.999815 | TASK [gather-host-logs : creating directory for system status] 2026-08-20 20:29:00.407595 | instance | changed 2026-08-20 20:29:00.414324 | 2026-08-20 20:29:00.414446 | TASK [gather-host-logs : Get logs for each host] 2026-08-20 20:29:00.809373 | instance | + systemd-cgls --full --all --no-pager 2026-08-20 20:29:00.821269 | instance | + ip addr 2026-08-20 20:29:00.824078 | instance | + ip route 2026-08-20 20:29:00.826474 | instance | + lsblk 2026-08-20 20:29:00.831535 | instance | + mount 2026-08-20 20:29:00.833649 | instance | + docker images 2026-08-20 20:29:00.852810 | instance | + brctl show 2026-08-20 20:29:00.853381 | instance | /bin/bash: line 8: brctl: command not found 2026-08-20 20:29:00.853642 | instance | + ps aux --sort=-%mem 2026-08-20 20:29:00.867570 | instance | + dpkg -l 2026-08-20 20:29:00.875951 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-08-20 20:29:00.876430 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-08-20 20:29:00.893574 | instance | + '[' '!' -z '' ']' 2026-08-20 20:29:01.362701 | instance | ok: Runtime: 0:00:00.089097 2026-08-20 20:29:01.371148 | 2026-08-20 20:29:01.371299 | TASK [gather-host-logs : Downloads logs to executor] 2026-08-20 20:29:02.208672 | instance | changed: 2026-08-20 20:29:02.208870 | instance | created directory /var/lib/zuul/builds/599ae0543a9240f8880b92c36d14c380/work/logs/instance 2026-08-20 20:29:02.208929 | instance | cd+++++++++ system/ 2026-08-20 20:29:02.208980 | instance | >f+++++++++ system/brctl-show.txt 2026-08-20 20:29:02.209012 | instance | >f+++++++++ system/docker-images.txt 2026-08-20 20:29:02.209042 | instance | >f+++++++++ system/ip-addr.txt 2026-08-20 20:29:02.209074 | instance | >f+++++++++ system/ip-route.txt 2026-08-20 20:29:02.209105 | instance | >f+++++++++ system/lsblk.txt 2026-08-20 20:29:02.209133 | instance | >f+++++++++ system/mount.txt 2026-08-20 20:29:02.209160 | instance | >f+++++++++ system/packages.txt 2026-08-20 20:29:02.209186 | instance | >f+++++++++ system/ps.txt 2026-08-20 20:29:02.209215 | instance | >f+++++++++ system/systemd-cgls.txt 2026-08-20 20:29:02.220588 | 2026-08-20 20:29:02.220675 | LOOP [helm-release-status : creating directory for helm release status] 2026-08-20 20:29:02.412950 | instance | changed: "values" 2026-08-20 20:29:02.594031 | instance | changed: "releases" 2026-08-20 20:29:02.601903 | 2026-08-20 20:29:02.602059 | TASK [helm-release-status : Gather get release status for helm charts] 2026-08-20 20:29:02.818707 | instance | /bin/bash: line 3: kubectl: command not found 2026-08-20 20:29:03.138654 | instance | ok: Runtime: 0:00:00.006313 2026-08-20 20:29:03.146309 | 2026-08-20 20:29:03.146430 | TASK [helm-release-status : Downloads logs to executor] 2026-08-20 20:29:03.890973 | instance | changed: 2026-08-20 20:29:03.891203 | instance | cd+++++++++ helm/ 2026-08-20 20:29:03.891242 | instance | cd+++++++++ helm/releases/ 2026-08-20 20:29:03.891346 | instance | cd+++++++++ helm/values/ 2026-08-20 20:29:03.906188 | 2026-08-20 20:29:03.906273 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-08-20 20:29:04.132749 | instance | changed 2026-08-20 20:29:04.141116 | 2026-08-20 20:29:04.141287 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-08-20 20:29:04.408364 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-20 20:29:04.408898 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-20 20:29:04.413796 | instance | environment: line 1: kubectl: command not found 2026-08-20 20:29:04.415497 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-20 20:29:04.416823 | instance | environment: line 1: kubectl: command not found 2026-08-20 20:29:04.417616 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-20 20:29:04.418614 | instance | environment: line 1: kubectl: command not found 2026-08-20 20:29:04.419467 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-20 20:29:04.421490 | instance | environment: line 1: kubectl: command not found 2026-08-20 20:29:04.422273 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-20 20:29:04.423238 | instance | environment: line 1: kubectl: command not found 2026-08-20 20:29:04.424149 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-20 20:29:04.678201 | instance | ok: Runtime: 0:00:00.022607 2026-08-20 20:29:04.686563 | 2026-08-20 20:29:04.686754 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-08-20 20:29:04.913244 | instance | changed 2026-08-20 20:29:04.919737 | 2026-08-20 20:29:04.919837 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-08-20 20:29:05.136487 | instance | environment: line 5: kubectl: command not found 2026-08-20 20:29:05.137357 | 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:29:05.137376 | instance | 2026-08-20 20:29:05.137704 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-20 20:29:05.466350 | instance | ok: Runtime: 0:00:00.008011 2026-08-20 20:29:05.479220 | 2026-08-20 20:29:05.479371 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-08-20 20:29:06.003077 | instance | changed: 2026-08-20 20:29:06.003429 | instance | cd+++++++++ objects/ 2026-08-20 20:29:06.003469 | instance | cd+++++++++ objects/cluster/ 2026-08-20 20:29:06.003493 | instance | cd+++++++++ objects/namespaced/ 2026-08-20 20:29:06.028633 | 2026-08-20 20:29:06.028799 | TASK [gather-pod-logs : creating directory for pod logs] 2026-08-20 20:29:06.236077 | instance | changed 2026-08-20 20:29:06.251322 | 2026-08-20 20:29:06.251453 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-08-20 20:29:06.475127 | instance | changed 2026-08-20 20:29:06.480568 | 2026-08-20 20:29:06.480639 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-08-20 20:29:06.698623 | instance | environment: line 3: kubectl: command not found 2026-08-20 20:29:07.015715 | instance | ok: Runtime: 0:00:00.009025 2026-08-20 20:29:07.020800 | 2026-08-20 20:29:07.020874 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-08-20 20:29:07.599169 | instance | changed: 2026-08-20 20:29:07.599324 | instance | cd+++++++++ pod-logs/ 2026-08-20 20:29:07.599369 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-08-20 20:29:07.609151 | 2026-08-20 20:29:07.609243 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-08-20 20:29:07.805066 | instance | changed 2026-08-20 20:29:07.812371 | 2026-08-20 20:29:07.812490 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-08-20 20:29:08.018610 | instance | /bin/bash: line 2: kubectl: command not found 2026-08-20 20:29:08.348271 | instance | ok: Runtime: 0:00:00.037812 2026-08-20 20:29:08.356771 | 2026-08-20 20:29:08.356884 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-08-20 20:29:08.560047 | instance | /bin/bash: line 2: kubectl: command not found 2026-08-20 20:29:08.590201 | instance | ceph-mgr endpoints: 2026-08-20 20:29:08.892406 | instance | ok: Runtime: 0:00:00.037566 2026-08-20 20:29:08.899920 | 2026-08-20 20:29:08.900045 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-08-20 20:29:09.138983 | instance | /bin/bash: line 4: kubectl: command not found 2026-08-20 20:29:09.443165 | instance | ok: Runtime: 0:00:00.038017 2026-08-20 20:29:09.450787 | 2026-08-20 20:29:09.450880 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-08-20 20:29:09.989412 | instance | changed: cd+++++++++ prometheus/ 2026-08-20 20:29:10.001081 | 2026-08-20 20:29:10.001216 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-08-20 20:29:10.210052 | instance | changed 2026-08-20 20:29:10.508013 | 2026-08-20 20:29:10.508147 | TASK [gather-selenium-data : Get selenium data] 2026-08-20 20:29:10.813445 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-08-20 20:29:10.814521 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-08-20 20:29:11.049549 | instance | ERROR 2026-08-20 20:29:11.049732 | instance | { 2026-08-20 20:29:11.049798 | instance | "delta": "0:00:00.004599", 2026-08-20 20:29:11.049833 | instance | "end": "2026-08-20 20:29:10.814649", 2026-08-20 20:29:11.049867 | instance | "msg": "non-zero return code", 2026-08-20 20:29:11.049897 | instance | "rc": 1, 2026-08-20 20:29:11.049926 | instance | "start": "2026-08-20 20:29:10.810050" 2026-08-20 20:29:11.049998 | instance | } 2026-08-20 20:29:11.050033 | instance | ERROR: Ignoring Errors 2026-08-20 20:29:11.057910 | 2026-08-20 20:29:11.058020 | TASK [gather-selenium-data : Downloads logs to executor] 2026-08-20 20:29:11.566295 | instance | changed: cd+++++++++ selenium/ 2026-08-20 20:29:11.579535 | 2026-08-20 20:29:11.579650 | PLAY RECAP 2026-08-20 20:29:11.579713 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-08-20 20:29:11.579741 | 2026-08-20 20:29:11.749026 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-08-20 20:29:11.762103 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-20 20:29:12.539585 | 2026-08-20 20:29:12.539950 | PLAY [all] 2026-08-20 20:29:12.554065 | 2026-08-20 20:29:12.554200 | TASK [fetch-output : Set log path for multiple nodes] 2026-08-20 20:29:12.599817 | instance | skipping: Conditional result was False 2026-08-20 20:29:12.610911 | 2026-08-20 20:29:12.611122 | TASK [fetch-output : Set log path for single node] 2026-08-20 20:29:12.652836 | instance | ok 2026-08-20 20:29:12.659544 | 2026-08-20 20:29:12.659689 | LOOP [fetch-output : Ensure local output dirs] 2026-08-20 20:29:13.180572 | instance -> localhost | ok: "/var/lib/zuul/builds/599ae0543a9240f8880b92c36d14c380/work/logs" 2026-08-20 20:29:13.451278 | instance -> localhost | changed: "/var/lib/zuul/builds/599ae0543a9240f8880b92c36d14c380/work/artifacts" 2026-08-20 20:29:13.688173 | instance -> localhost | changed: "/var/lib/zuul/builds/599ae0543a9240f8880b92c36d14c380/work/docs" 2026-08-20 20:29:13.704459 | 2026-08-20 20:29:13.704599 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-20 20:29:14.447362 | instance | changed: .d..t...... ./ 2026-08-20 20:29:14.447564 | instance | changed: All items complete 2026-08-20 20:29:14.447592 | 2026-08-20 20:29:14.925146 | instance | changed: .d..t...... ./ 2026-08-20 20:29:15.599712 | instance | changed: .d..t...... ./ 2026-08-20 20:29:15.618095 | 2026-08-20 20:29:15.618230 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-20 20:29:16.131096 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007523 2026-08-20 20:29:16.435377 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.025022 2026-08-20 20:29:16.446704 | 2026-08-20 20:29:16.446827 | PLAY [all] 2026-08-20 20:29:16.455090 | 2026-08-20 20:29:16.455253 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-20 20:29:16.956091 | instance | changed 2026-08-20 20:29:17.052585 | 2026-08-20 20:29:17.052706 | PLAY RECAP 2026-08-20 20:29:17.053126 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-20 20:29:17.053174 | 2026-08-20 20:29:17.213111 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-20 20:29:17.217798 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-20 20:29:18.006530 | 2026-08-20 20:29:19.065069 | PLAY [localhost] 2026-08-20 20:29:19.078676 | 2026-08-20 20:29:19.078785 | TASK [Generate Zuul manifest] 2026-08-20 20:29:19.098253 | localhost | ok 2026-08-20 20:29:19.299903 | 2026-08-20 20:29:19.300116 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-20 20:29:19.759268 | localhost | changed 2026-08-20 20:29:19.770514 | 2026-08-20 20:29:19.770594 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-20 20:29:19.954297 | localhost | ok 2026-08-20 20:29:19.965814 | 2026-08-20 20:29:19.965940 | TASK [Upload logs] 2026-08-20 20:29:19.988887 | localhost | ok 2026-08-20 20:29:20.433207 | 2026-08-20 20:29:22.645781 | TASK [Set zuul-log-path fact] 2026-08-20 20:29:22.667033 | localhost | ok 2026-08-20 20:29:22.841747 | 2026-08-20 20:29:22.841909 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-20 20:29:22.874846 | localhost | ok 2026-08-20 20:29:22.887774 | 2026-08-20 20:29:22.887870 | TASK [upload-logs : Create log directories] 2026-08-20 20:29:23.336662 | localhost | changed 2026-08-20 20:29:23.342959 | 2026-08-20 20:29:23.343080 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-20 20:29:23.804627 | localhost -> localhost | ok: Runtime: 0:00:00.012337 2026-08-20 20:29:23.815688 | 2026-08-20 20:29:23.815793 | TASK [upload-logs : Upload logs to log server] 2026-08-20 20:29:24.574656 | localhost | Output suppressed because no_log was given 2026-08-20 20:29:24.628187 | 2026-08-20 20:29:24.628368 | LOOP [upload-logs : Compress console log and json output] 2026-08-20 20:29:24.678067 | localhost | skipping: Conditional result was False 2026-08-20 20:29:24.686800 | localhost | skipping: Conditional result was False 2026-08-20 20:29:24.702897 | 2026-08-20 20:29:24.703046 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-20 20:29:24.768344 | localhost | skipping: Conditional result was False 2026-08-20 20:29:24.768682 | 2026-08-20 20:29:24.774248 | localhost | skipping: Conditional result was False 2026-08-20 20:29:24.784012 | 2026-08-20 20:29:24.784155 | LOOP [upload-logs : Upload console log and json output]