2026-08-26 03:50:57.101963 | Job console starting 2026-08-26 03:50:57.111179 | Updating git repos 2026-08-26 03:50:59.858792 | Cloning repos into workspace 2026-08-26 03:51:22.541278 | Restoring repo states 2026-08-26 03:51:28.531250 | Merging changes 2026-08-26 03:51:30.526647 | Checking out repos 2026-08-26 03:51:32.674678 | Preparing playbooks 2026-08-26 03:51:36.360211 | Running Ansible setup 2026-08-26 03:51:40.133983 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-26 03:51:40.765447 | 2026-08-26 03:51:40.765930 | PLAY [localhost] 2026-08-26 03:51:40.773771 | 2026-08-26 03:51:40.773864 | TASK [Gathering Facts] 2026-08-26 03:51:41.694045 | localhost | ok 2026-08-26 03:51:41.703786 | 2026-08-26 03:51:41.703887 | TASK [Setup log path fact] 2026-08-26 03:51:41.727001 | localhost | ok 2026-08-26 03:51:41.740465 | 2026-08-26 03:51:41.740535 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-26 03:51:41.790447 | localhost | ok 2026-08-26 03:51:41.796399 | 2026-08-26 03:51:41.796475 | TASK [emit-job-header : Print job information] 2026-08-26 03:51:41.837797 | # Job Information 2026-08-26 03:51:41.838055 | Ansible Version: 2.16.18 2026-08-26 03:51:41.838128 | Job: atmosphere-molecule-csi-rbd 2026-08-26 03:51:41.838176 | Pipeline: check 2026-08-26 03:51:41.838220 | Executor: 2d72f0692154 2026-08-26 03:51:41.838264 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4093 2026-08-26 03:51:41.838314 | Event ID: dc304960-a100-11f1-89ac-bd7af41798b4 2026-08-26 03:51:41.844461 | 2026-08-26 03:51:41.844607 | LOOP [emit-job-header : Print node information] 2026-08-26 03:51:41.973088 | localhost | ok: 2026-08-26 03:51:42.009274 | localhost | # Node Information 2026-08-26 03:51:42.009373 | localhost | Inventory Hostname: instance 2026-08-26 03:51:42.009429 | localhost | Hostname: np0000191119 2026-08-26 03:51:42.009475 | localhost | Username: zuul 2026-08-26 03:51:42.009525 | localhost | Distro: Ubuntu 22.04 2026-08-26 03:51:42.009569 | localhost | Provider: yul1 2026-08-26 03:51:42.009612 | localhost | Region: ca-ymq-1 2026-08-26 03:51:42.009653 | localhost | Label: ubuntu-jammy 2026-08-26 03:51:42.009694 | localhost | Product Name: OpenStack Nova 2026-08-26 03:51:42.009736 | localhost | Interface IP: 162.253.55.173 2026-08-26 03:51:42.019909 | 2026-08-26 03:51:42.020036 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-26 03:51:42.507836 | localhost -> localhost | changed 2026-08-26 03:51:42.512771 | 2026-08-26 03:51:42.512838 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-26 03:51:43.531737 | localhost -> localhost | changed 2026-08-26 03:51:43.540874 | 2026-08-26 03:51:43.540945 | PLAY [all] 2026-08-26 03:51:43.552148 | 2026-08-26 03:51:43.552223 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-26 03:51:43.806546 | instance -> localhost | ok 2026-08-26 03:51:43.818893 | 2026-08-26 03:51:43.819035 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-26 03:51:43.865331 | instance | ok 2026-08-26 03:51:43.895093 | instance | included: /var/lib/zuul/builds/8490e7a5b57a4bb39a13429710a6e519/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-26 03:51:43.911286 | 2026-08-26 03:51:43.911574 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-26 03:51:44.857849 | instance -> localhost | Generating public/private rsa key pair. 2026-08-26 03:51:44.858061 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/8490e7a5b57a4bb39a13429710a6e519/work/8490e7a5b57a4bb39a13429710a6e519_id_rsa 2026-08-26 03:51:44.858109 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/8490e7a5b57a4bb39a13429710a6e519/work/8490e7a5b57a4bb39a13429710a6e519_id_rsa.pub 2026-08-26 03:51:44.858143 | instance -> localhost | The key fingerprint is: 2026-08-26 03:51:44.858175 | instance -> localhost | SHA256:aeoPwkF9daut6c1vHHK1xvk9GfbGxzISUnFUh2RUxzw zuul-build-sshkey 2026-08-26 03:51:44.858219 | instance -> localhost | The key's randomart image is: 2026-08-26 03:51:44.858251 | instance -> localhost | +---[RSA 3072]----+ 2026-08-26 03:51:44.858287 | instance -> localhost | | . .+=*=| 2026-08-26 03:51:44.858319 | instance -> localhost | | . . ..ooE=| 2026-08-26 03:51:44.858349 | instance -> localhost | | . . . .o .| 2026-08-26 03:51:44.858379 | instance -> localhost | | . . . o. .| 2026-08-26 03:51:44.858408 | instance -> localhost | | . S ... ..o| 2026-08-26 03:51:44.858437 | instance -> localhost | | . . o .oo oB | 2026-08-26 03:51:44.858466 | instance -> localhost | | o o o. =o+*| 2026-08-26 03:51:44.858495 | instance -> localhost | | o . . o. =oO| 2026-08-26 03:51:44.858528 | instance -> localhost | | ... . o+.+o| 2026-08-26 03:51:44.858557 | instance -> localhost | +----[SHA256]-----+ 2026-08-26 03:51:44.858623 | instance -> localhost | ok: Runtime: 0:00:00.503444 2026-08-26 03:51:44.865145 | 2026-08-26 03:51:44.865208 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-26 03:51:44.898540 | instance | ok 2026-08-26 03:51:44.907536 | instance | included: /var/lib/zuul/builds/8490e7a5b57a4bb39a13429710a6e519/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-26 03:51:44.914945 | 2026-08-26 03:51:44.915006 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-26 03:51:44.940666 | instance | skipping: Conditional result was False 2026-08-26 03:51:44.945999 | 2026-08-26 03:51:44.946067 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-26 03:51:45.476307 | instance | changed 2026-08-26 03:51:45.499744 | 2026-08-26 03:51:45.499854 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-26 03:51:45.685748 | instance | ok 2026-08-26 03:51:45.691866 | 2026-08-26 03:51:45.691936 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-26 03:51:46.194940 | instance | changed 2026-08-26 03:51:46.395905 | 2026-08-26 03:51:46.396002 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-26 03:51:46.886620 | instance | changed 2026-08-26 03:51:46.892346 | 2026-08-26 03:51:46.892407 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-26 03:51:46.907552 | instance | skipping: Conditional result was False 2026-08-26 03:51:46.917543 | 2026-08-26 03:51:46.917654 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-26 03:51:47.286810 | instance -> localhost | changed 2026-08-26 03:51:47.300339 | 2026-08-26 03:51:47.300428 | TASK [add-build-sshkey : Add back temp key] 2026-08-26 03:51:47.616428 | instance -> localhost | Identity added: /var/lib/zuul/builds/8490e7a5b57a4bb39a13429710a6e519/work/8490e7a5b57a4bb39a13429710a6e519_id_rsa (zuul-build-sshkey) 2026-08-26 03:51:47.616644 | instance -> localhost | ok: Runtime: 0:00:00.015892 2026-08-26 03:51:47.623294 | 2026-08-26 03:51:47.623373 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-26 03:51:47.929705 | instance | ok 2026-08-26 03:51:47.936141 | 2026-08-26 03:51:47.936268 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-26 03:51:47.981263 | instance | skipping: Conditional result was False 2026-08-26 03:51:47.995070 | 2026-08-26 03:51:47.995134 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-08-26 03:51:48.343908 | instance | ok 2026-08-26 03:51:48.351769 | 2026-08-26 03:51:48.351860 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-08-26 03:51:51.960314 | instance | Output suppressed because no_log was given 2026-08-26 03:51:51.969099 | 2026-08-26 03:51:51.969169 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-08-26 03:51:52.166764 | instance | ok: "logs" 2026-08-26 03:51:52.167050 | instance | ok: All items complete 2026-08-26 03:51:52.167092 | 2026-08-26 03:51:52.326633 | instance | ok: "artifacts" 2026-08-26 03:51:52.477598 | instance | ok: "docs" 2026-08-26 03:51:52.495669 | 2026-08-26 03:51:52.495814 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-08-26 03:51:52.676479 | instance | changed: "logs" 2026-08-26 03:51:52.827455 | instance | changed: "artifacts" 2026-08-26 03:51:52.982179 | instance | changed: "docs" 2026-08-26 03:51:53.005587 | 2026-08-26 03:51:53.005754 | PLAY RECAP 2026-08-26 03:51:53.005821 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-08-26 03:51:53.005870 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-26 03:51:53.005907 | 2026-08-26 03:51:53.170638 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-26 03:51:53.175023 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-26 03:51:53.782745 | 2026-08-26 03:51:53.782882 | PLAY [all] 2026-08-26 03:51:53.793398 | 2026-08-26 03:51:53.793486 | TASK [setup-uv : Extract archive] 2026-08-26 03:51:56.301740 | instance | changed 2026-08-26 03:51:56.307298 | 2026-08-26 03:51:56.307371 | TASK [setup-uv : Print version] 2026-08-26 03:51:56.682704 | instance | uv 0.8.13 2026-08-26 03:51:56.841860 | instance | ok: Runtime: 0:00:00.018061 2026-08-26 03:51:56.852324 | 2026-08-26 03:51:56.852419 | TASK [Install Ansible collection siblings] 2026-08-26 03:52:10.666071 | instance | changed: 2026-08-26 03:52:10.666226 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-08-26 03:52:10.666256 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-08-26 03:52:10.666277 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-08-26 03:52:10.666297 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto 2026-08-26 03:52:10.666316 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general 2026-08-26 03:52:10.666340 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql 2026-08-26 03:52:10.666361 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-08-26 03:52:10.666383 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-08-26 03:52:10.666403 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-08-26 03:52:10.666422 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-08-26 03:52:10.666441 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-08-26 03:52:10.666459 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-08-26 03:52:10.666477 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0 2026-08-26 03:52:10.666495 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0 2026-08-26 03:52:10.666514 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0 2026-08-26 03:52:10.666533 | instance | Resolved community.crypto to 2.2.3 for 2.2.3 2026-08-26 03:52:10.666551 | instance | Resolved community.general to 7.3.0 for 7.3.0 2026-08-26 03:52:10.666570 | instance | Resolved community.mysql to 3.6.0 for 3.6.0 2026-08-26 03:52:10.666588 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0 2026-08-26 03:52:10.666605 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0 2026-08-26 03:52:10.666624 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0 2026-08-26 03:52:10.666642 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0 2026-08-26 03:52:10.666661 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-08-26 03:52:10.666691 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0 2026-08-26 03:52:10.666711 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0 2026-08-26 03:52:10.666729 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-08-26 03:52:10.666747 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-08-26 03:52:10.666764 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-08-26 03:52:10.666782 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0 2026-08-26 03:52:10.666799 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3 2026-08-26 03:52:10.666817 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-08-26 03:52:10.666835 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-08-26 03:52:10.666853 | instance | Checked out ansible.netcommon to 1.2.0 2026-08-26 03:52:10.666871 | 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-26 03:52:10.666895 | instance | Starting galaxy collection install process 2026-08-26 03:52:10.666913 | instance | Process install dependency map 2026-08-26 03:52:10.666930 | instance | Starting collection install process 2026-08-26 03:52:10.666948 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon' 2026-08-26 03:52:10.666966 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon 2026-08-26 03:52:10.666983 | instance | ansible.netcommon:* was installed successfully 2026-08-26 03:52:10.667000 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-08-26 03:52:10.667018 | instance | Creating virtual environment at: .venv 2026-08-26 03:52:10.667035 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-08-26 03:52:10.667052 | instance | Downloading kubernetes (1.9MiB) 2026-08-26 03:52:10.667070 | instance | Downloading cryptography (4.2MiB) 2026-08-26 03:52:10.667091 | instance | Downloading pygments (1.2MiB) 2026-08-26 03:52:10.667109 | instance | Downloading ansible-core (2.1MiB) 2026-08-26 03:52:10.667126 | instance | Downloading openstacksdk (1.7MiB) 2026-08-26 03:52:10.667144 | instance | Downloading setuptools (1.1MiB) 2026-08-26 03:52:10.667162 | instance | Downloading netaddr (2.2MiB) 2026-08-26 03:52:10.667180 | instance | Downloading rjsonnet (1.2MiB) 2026-08-26 03:52:10.667199 | instance | Downloading rjsonnet 2026-08-26 03:52:10.667217 | instance | Downloading pygments 2026-08-26 03:52:10.667237 | instance | Downloading netaddr 2026-08-26 03:52:10.667257 | instance | Downloading cryptography 2026-08-26 03:52:10.667276 | instance | Downloading setuptools 2026-08-26 03:52:10.667294 | instance | Downloading kubernetes 2026-08-26 03:52:10.667312 | instance | Downloading ansible-core 2026-08-26 03:52:10.667330 | instance | Downloading openstacksdk 2026-08-26 03:52:10.667348 | instance | Building pyperclip==1.9.0 2026-08-26 03:52:10.667366 | instance | Built pyperclip==1.9.0 2026-08-26 03:52:10.667384 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-08-26 03:52:10.667402 | instance | Installed 79 packages in 1.05s 2026-08-26 03:52:10.667420 | instance | Checked out ansible.posix to 1.6.0 2026-08-26 03:52:10.667438 | 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-26 03:52:10.667456 | instance | Starting galaxy collection install process 2026-08-26 03:52:10.667474 | instance | Process install dependency map 2026-08-26 03:52:10.667492 | instance | Starting collection install process 2026-08-26 03:52:10.667510 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-08-26 03:52:10.667533 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix 2026-08-26 03:52:10.667551 | instance | ansible.posix:1.6.0 was installed successfully 2026-08-26 03:52:10.667570 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 03:52:10.667587 | instance | 2.17.12 2026-08-26 03:52:10.667606 | instance | Checked out ansible.utils to v6.1.0 2026-08-26 03:52:10.667624 | 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-26 03:52:10.667642 | instance | Starting galaxy collection install process 2026-08-26 03:52:10.667659 | instance | Process install dependency map 2026-08-26 03:52:10.667677 | instance | Starting collection install process 2026-08-26 03:52:10.667695 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils' 2026-08-26 03:52:10.667714 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils 2026-08-26 03:52:10.667732 | instance | ansible.utils:6.1.0 was installed successfully 2026-08-26 03:52:10.667750 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 03:52:10.667768 | instance | 2.17.12 2026-08-26 03:52:10.667787 | instance | Checked out atmosphere.common to v0.7.0 2026-08-26 03:52:10.667805 | 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-26 03:52:10.667822 | instance | Starting galaxy collection install process 2026-08-26 03:52:10.667840 | instance | Process install dependency map 2026-08-26 03:52:10.667857 | instance | Starting collection install process 2026-08-26 03:52:10.667875 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common' 2026-08-26 03:52:10.667893 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common 2026-08-26 03:52:10.667910 | instance | atmosphere.common:0.7.0 was installed successfully 2026-08-26 03:52:10.667928 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 03:52:10.667946 | instance | 2.17.12 2026-08-26 03:52:10.667964 | instance | Checked out community.crypto to 2.2.3 2026-08-26 03:52:10.667982 | 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-26 03:52:10.668000 | instance | Starting galaxy collection install process 2026-08-26 03:52:10.668017 | instance | Process install dependency map 2026-08-26 03:52:10.668035 | instance | Starting collection install process 2026-08-26 03:52:10.668053 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-08-26 03:52:10.668071 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto 2026-08-26 03:52:10.668088 | instance | community.crypto:2.2.3 was installed successfully 2026-08-26 03:52:10.668106 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 03:52:10.668124 | instance | 2.17.12 2026-08-26 03:52:10.668142 | instance | Checked out community.general to 7.3.0 2026-08-26 03:52:10.668160 | 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-26 03:52:10.668178 | instance | Starting galaxy collection install process 2026-08-26 03:52:10.668200 | instance | Process install dependency map 2026-08-26 03:52:10.668218 | instance | Starting collection install process 2026-08-26 03:52:10.668236 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-08-26 03:52:10.668253 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general 2026-08-26 03:52:10.668271 | instance | community.general:7.3.0 was installed successfully 2026-08-26 03:52:10.668288 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 03:52:10.668306 | instance | 2.17.12 2026-08-26 03:52:10.668324 | instance | Checked out community.mysql to 3.6.0 2026-08-26 03:52:10.668342 | 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-26 03:52:10.668361 | instance | Starting galaxy collection install process 2026-08-26 03:52:10.668381 | instance | Process install dependency map 2026-08-26 03:52:10.668400 | instance | Starting collection install process 2026-08-26 03:52:10.668418 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql' 2026-08-26 03:52:10.668436 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql 2026-08-26 03:52:10.668454 | instance | community.mysql:3.6.0 was installed successfully 2026-08-26 03:52:10.668472 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 03:52:10.668490 | instance | 2.17.12 2026-08-26 03:52:10.668508 | instance | Checked out kubernetes.core to 2.4.0 2026-08-26 03:52:10.668526 | 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-26 03:52:10.668543 | instance | Starting galaxy collection install process 2026-08-26 03:52:10.668562 | instance | Process install dependency map 2026-08-26 03:52:10.668579 | instance | Starting collection install process 2026-08-26 03:52:10.668597 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core' 2026-08-26 03:52:10.668615 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core 2026-08-26 03:52:10.668633 | instance | kubernetes.core:2.4.0 was installed successfully 2026-08-26 03:52:10.668651 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 03:52:10.668668 | instance | 2.17.12 2026-08-26 03:52:10.668686 | instance | Checked out openstack.cloud to 2.6.0 2026-08-26 03:52:10.668704 | 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-26 03:52:10.668722 | instance | Starting galaxy collection install process 2026-08-26 03:52:10.668740 | instance | Process install dependency map 2026-08-26 03:52:10.668758 | instance | Starting collection install process 2026-08-26 03:52:10.668775 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud' 2026-08-26 03:52:10.668793 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud 2026-08-26 03:52:10.668811 | instance | openstack.cloud:2.6.0 was installed successfully 2026-08-26 03:52:10.668828 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 03:52:10.668846 | instance | 2.17.12 2026-08-26 03:52:10.668863 | instance | Checked out vexxhost.ceph to v4.2.0 2026-08-26 03:52:10.668897 | 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-26 03:52:10.668921 | instance | Starting galaxy collection install process 2026-08-26 03:52:10.668940 | instance | Process install dependency map 2026-08-26 03:52:10.668979 | instance | Starting collection install process 2026-08-26 03:52:10.668998 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph' 2026-08-26 03:52:10.669017 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph 2026-08-26 03:52:10.669034 | instance | vexxhost.ceph:4.2.0 was installed successfully 2026-08-26 03:52:10.669052 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 03:52:10.669069 | instance | 2.17.12 2026-08-26 03:52:10.669087 | instance | Checked out vexxhost.containers to v1.6.8 2026-08-26 03:52:10.669105 | 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-26 03:52:10.669123 | instance | Starting galaxy collection install process 2026-08-26 03:52:10.669140 | instance | Process install dependency map 2026-08-26 03:52:10.669157 | instance | Starting collection install process 2026-08-26 03:52:10.669175 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers' 2026-08-26 03:52:10.669193 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers 2026-08-26 03:52:10.669211 | instance | vexxhost.containers:1.6.8 was installed successfully 2026-08-26 03:52:10.669229 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 03:52:10.669246 | instance | 2.17.12 2026-08-26 03:52:10.669263 | instance | Checked out vexxhost.kubernetes to v3.3.0 2026-08-26 03:52:10.669281 | 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-26 03:52:10.669299 | instance | Starting galaxy collection install process 2026-08-26 03:52:10.669317 | instance | Process install dependency map 2026-08-26 03:52:10.669335 | instance | Starting collection install process 2026-08-26 03:52:10.669353 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes' 2026-08-26 03:52:10.669371 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes 2026-08-26 03:52:10.669389 | instance | vexxhost.kubernetes:3.3.0 was installed successfully 2026-08-26 03:52:10.669407 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 03:52:10.669425 | instance | 2.17.12 2026-08-26 03:52:10.685132 | 2026-08-26 03:52:10.685569 | PLAY RECAP 2026-08-26 03:52:10.685624 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-26 03:52:10.685648 | 2026-08-26 03:52:10.794144 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-26 03:52:10.796631 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-08-26 03:52:11.427715 | 2026-08-26 03:52:11.427833 | PLAY [all] 2026-08-26 03:52:11.439186 | 2026-08-26 03:52:11.439277 | TASK [Install "jq" for log collection] 2026-08-26 03:52:22.508642 | instance | changed 2026-08-26 03:52:22.511244 | 2026-08-26 03:52:22.511327 | PLAY RECAP 2026-08-26 03:52:22.511397 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-26 03:52:22.511463 | 2026-08-26 03:52:22.749847 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-08-26 03:52:22.754254 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-26 03:52:23.360038 | 2026-08-26 03:52:23.360192 | PLAY [all] 2026-08-26 03:52:23.371592 | 2026-08-26 03:52:23.371697 | LOOP [Check inventory directories] 2026-08-26 03:52:23.688832 | instance | ok: "src/github.com/vexxhost/atmosphere" 2026-08-26 03:52:23.844526 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory" 2026-08-26 03:52:24.007749 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory" 2026-08-26 03:52:24.026834 | 2026-08-26 03:52:24.027054 | LOOP [Copy inventory file for Zuul] 2026-08-26 03:52:24.849698 | instance | changed: 2026-08-26 03:52:24.849944 | instance | { 2026-08-26 03:52:24.849985 | instance | "ansible_loop_var": "item", 2026-08-26 03:52:24.850016 | instance | "changed": false, 2026-08-26 03:52:24.850044 | instance | "failed": false, 2026-08-26 03:52:24.850079 | instance | "invocation": { 2026-08-26 03:52:24.850107 | instance | "module_args": { 2026-08-26 03:52:24.850132 | instance | "checksum_algorithm": "sha1", 2026-08-26 03:52:24.850157 | instance | "follow": true, 2026-08-26 03:52:24.850183 | instance | "get_attributes": true, 2026-08-26 03:52:24.850209 | instance | "get_checksum": true, 2026-08-26 03:52:24.850234 | instance | "get_mime": true, 2026-08-26 03:52:24.850259 | instance | "path": "src/github.com/vexxhost/atmosphere" 2026-08-26 03:52:24.850284 | instance | } 2026-08-26 03:52:24.850309 | instance | }, 2026-08-26 03:52:24.850333 | instance | "item": "src/github.com/vexxhost/atmosphere", 2026-08-26 03:52:24.850358 | instance | "stat": { 2026-08-26 03:52:24.850382 | instance | "atime": 1787716319.857002, 2026-08-26 03:52:24.850407 | instance | "attr_flags": "e", 2026-08-26 03:52:24.850432 | instance | "attributes": [ 2026-08-26 03:52:24.850457 | instance | "extents" 2026-08-26 03:52:24.850481 | instance | ], 2026-08-26 03:52:24.850505 | instance | "block_size": 4096, 2026-08-26 03:52:24.850530 | instance | "blocks": 8, 2026-08-26 03:52:24.850555 | instance | "charset": "unknown", 2026-08-26 03:52:24.850581 | instance | "ctime": 1787716317.6409993, 2026-08-26 03:52:24.850607 | instance | "dev": 64513, 2026-08-26 03:52:24.850631 | instance | "device_type": 0, 2026-08-26 03:52:24.850656 | instance | "executable": true, 2026-08-26 03:52:24.850681 | instance | "exists": true, 2026-08-26 03:52:24.850705 | instance | "gid": 1000, 2026-08-26 03:52:24.850729 | instance | "gr_name": "zuul", 2026-08-26 03:52:24.850753 | instance | "inode": 1049443, 2026-08-26 03:52:24.850777 | instance | "isblk": false, 2026-08-26 03:52:24.850802 | instance | "ischr": false, 2026-08-26 03:52:24.850825 | instance | "isdir": true, 2026-08-26 03:52:24.850849 | instance | "isfifo": false, 2026-08-26 03:52:24.850872 | instance | "isgid": false, 2026-08-26 03:52:24.850896 | instance | "islnk": false, 2026-08-26 03:52:24.850920 | instance | "isreg": false, 2026-08-26 03:52:24.850943 | instance | "issock": false, 2026-08-26 03:52:24.850967 | instance | "isuid": false, 2026-08-26 03:52:24.850991 | instance | "mimetype": "unknown", 2026-08-26 03:52:24.851015 | instance | "mode": "0755", 2026-08-26 03:52:24.851039 | instance | "mtime": 1787716317.6409993, 2026-08-26 03:52:24.851063 | instance | "nlink": 22, 2026-08-26 03:52:24.851087 | instance | "path": "src/github.com/vexxhost/atmosphere", 2026-08-26 03:52:24.851110 | instance | "pw_name": "zuul", 2026-08-26 03:52:24.851138 | instance | "readable": true, 2026-08-26 03:52:24.851163 | instance | "rgrp": true, 2026-08-26 03:52:24.851188 | instance | "roth": true, 2026-08-26 03:52:24.851212 | instance | "rusr": true, 2026-08-26 03:52:24.851237 | instance | "size": 4096, 2026-08-26 03:52:24.851261 | instance | "uid": 1000, 2026-08-26 03:52:24.851299 | instance | "version": "2391620299", 2026-08-26 03:52:24.851325 | instance | "wgrp": false, 2026-08-26 03:52:24.851351 | instance | "woth": false, 2026-08-26 03:52:24.851376 | instance | "writeable": true, 2026-08-26 03:52:24.851400 | instance | "wusr": true, 2026-08-26 03:52:24.851424 | instance | "xgrp": true, 2026-08-26 03:52:24.851448 | instance | "xoth": true, 2026-08-26 03:52:24.851471 | instance | "xusr": true 2026-08-26 03:52:24.851495 | instance | } 2026-08-26 03:52:24.851519 | instance | } 2026-08-26 03:52:24.851562 | instance | ok: All items complete 2026-08-26 03:52:24.851591 | 2026-08-26 03:52:24.853230 | instance | skipping: Conditional result was False 2026-08-26 03:52:24.854036 | instance | skipping: Conditional result was False 2026-08-26 03:52:24.864815 | 2026-08-26 03:52:24.864946 | LOOP [Switch "ansible_host" to private IP] 2026-08-26 03:52:25.205943 | instance | changed: 1 replacements made 2026-08-26 03:52:25.210006 | instance | skipping: Conditional result was False 2026-08-26 03:52:25.211652 | instance | skipping: Conditional result was False 2026-08-26 03:52:25.231227 | 2026-08-26 03:52:25.231392 | TASK [Run Molecule scenario] 2026-08-26 03:52:26.161184 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-08-26 03:52:26.525927 | instance | INFO [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-08-26 03:52:26.525991 | instance | INFO [csi > prerun] Performing prerun with role_name_check=0... 2026-08-26 03:52:37.162273 | instance | INFO [csi > dependency] Executing 2026-08-26 03:52:37.162480 | instance | WARNING [csi > dependency] Missing roles requirements file: requirements.yml 2026-08-26 03:52:37.162776 | instance | WARNING [csi > dependency] Missing collections requirements file: collections.yml 2026-08-26 03:52:37.162950 | instance | WARNING [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-08-26 03:52:37.171260 | instance | INFO [csi > cleanup] Executing 2026-08-26 03:52:37.171592 | instance | WARNING [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-26 03:52:37.179155 | instance | INFO [csi > destroy] Executing 2026-08-26 03:52:37.179194 | instance | WARNING [csi > destroy] Skipping, '--destroy=never' requested. 2026-08-26 03:52:37.179326 | instance | INFO [csi > destroy] Executed: Successful 2026-08-26 03:52:37.186637 | instance | INFO [csi > syntax] Executing 2026-08-26 03:52:38.853228 | instance | 2026-08-26 03:52:38.853579 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-08-26 03:52:38.919075 | instance | INFO [csi > syntax] Executed: Successful 2026-08-26 03:52:38.930324 | instance | INFO [csi > create] Executing 2026-08-26 03:52:38.932091 | instance | WARNING [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-26 03:52:38.939576 | instance | INFO [csi > prepare] Executing 2026-08-26 03:52:39.712232 | instance | 2026-08-26 03:52:39.712434 | instance | PLAY [Prepare] ***************************************************************** 2026-08-26 03:52:39.712698 | instance | 2026-08-26 03:52:39.712976 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-26 03:52:39.713257 | instance | Wednesday 26 August 2026 03:52:39 +0000 (0:00:00.036) 0:00:00.036 ****** 2026-08-26 03:52:40.877544 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-08-26 03:52:40.877828 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-08-26 03:52:40.878152 | instance | interpreter could change the meaning of that path. See 2026-08-26 03:52:40.878453 | instance | https://docs.ansible.com/ansible- 2026-08-26 03:52:40.878734 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-08-26 03:52:40.884806 | instance | ok: [instance] 2026-08-26 03:52:40.884936 | instance | 2026-08-26 03:52:40.885104 | instance | TASK [Configure short hostname] ************************************************ 2026-08-26 03:52:40.885273 | instance | Wednesday 26 August 2026 03:52:40 +0000 (0:00:01.173) 0:00:01.210 ****** 2026-08-26 03:52:41.558379 | instance | changed: [instance] 2026-08-26 03:52:41.558636 | instance | 2026-08-26 03:52:41.558920 | instance | TASK [Ensure hostname inside hosts file] *************************************** 2026-08-26 03:52:41.559200 | instance | Wednesday 26 August 2026 03:52:41 +0000 (0:00:00.673) 0:00:01.883 ****** 2026-08-26 03:52:41.803972 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created 2026-08-26 03:52:41.804034 | instance | with a mode of 0700, this may cause issues when running as another user. To 2026-08-26 03:52:41.804294 | instance | avoid this, create the remote_tmp dir with the correct permissions manually 2026-08-26 03:52:41.813803 | instance | changed: [instance] 2026-08-26 03:52:41.814068 | instance | 2026-08-26 03:52:41.814341 | instance | TASK [Purge "snapd" package] *************************************************** 2026-08-26 03:52:41.814615 | instance | Wednesday 26 August 2026 03:52:41 +0000 (0:00:00.255) 0:00:02.138 ****** 2026-08-26 03:52:42.666700 | instance | ok: [instance] 2026-08-26 03:52:42.666819 | instance | 2026-08-26 03:52:42.666996 | instance | PLAY [Create devices for Ceph] ************************************************* 2026-08-26 03:52:42.667152 | instance | 2026-08-26 03:52:42.667324 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-26 03:52:42.667497 | instance | Wednesday 26 August 2026 03:52:42 +0000 (0:00:00.853) 0:00:02.991 ****** 2026-08-26 03:52:43.369933 | instance | ok: [instance] 2026-08-26 03:52:43.370179 | instance | 2026-08-26 03:52:43.370458 | instance | TASK [Install depedencies] ***************************************************** 2026-08-26 03:52:43.370737 | instance | Wednesday 26 August 2026 03:52:43 +0000 (0:00:00.703) 0:00:03.694 ****** 2026-08-26 03:53:12.881791 | instance | changed: [instance] 2026-08-26 03:53:12.882131 | instance | 2026-08-26 03:53:12.882391 | instance | TASK [Start up service] ******************************************************** 2026-08-26 03:53:12.882716 | instance | Wednesday 26 August 2026 03:53:12 +0000 (0:00:29.510) 0:00:33.205 ****** 2026-08-26 03:53:13.441373 | instance | ok: [instance] 2026-08-26 03:53:13.441724 | instance | 2026-08-26 03:53:13.442089 | instance | TASK [Generate lvm.conf] ******************************************************* 2026-08-26 03:53:13.442422 | instance | Wednesday 26 August 2026 03:53:13 +0000 (0:00:00.560) 0:00:33.766 ****** 2026-08-26 03:53:13.747950 | instance | ok: [instance] 2026-08-26 03:53:13.748210 | instance | 2026-08-26 03:53:13.748532 | instance | TASK [Write /etc/lvm/lvm.conf] ************************************************* 2026-08-26 03:53:13.748813 | instance | Wednesday 26 August 2026 03:53:13 +0000 (0:00:00.306) 0:00:34.072 ****** 2026-08-26 03:53:14.401492 | instance | changed: [instance] 2026-08-26 03:53:14.401581 | instance | 2026-08-26 03:53:14.401714 | instance | TASK [Get list of all loopback devices] **************************************** 2026-08-26 03:53:14.401847 | instance | Wednesday 26 August 2026 03:53:14 +0000 (0:00:00.653) 0:00:34.726 ****** 2026-08-26 03:53:14.596859 | instance | ok: [instance] 2026-08-26 03:53:14.597235 | instance | 2026-08-26 03:53:14.597658 | instance | TASK [Fail if there is any existing loopback devices] ************************** 2026-08-26 03:53:14.598083 | instance | Wednesday 26 August 2026 03:53:14 +0000 (0:00:00.195) 0:00:34.921 ****** 2026-08-26 03:53:14.621198 | instance | skipping: [instance] 2026-08-26 03:53:14.621494 | instance | 2026-08-26 03:53:14.621773 | instance | TASK [Create devices for Ceph] ************************************************* 2026-08-26 03:53:14.622052 | instance | Wednesday 26 August 2026 03:53:14 +0000 (0:00:00.024) 0:00:34.946 ****** 2026-08-26 03:53:15.162747 | instance | changed: [instance] => (item=osd0) 2026-08-26 03:53:15.162984 | instance | changed: [instance] => (item=osd1) 2026-08-26 03:53:15.163267 | instance | changed: [instance] => (item=osd2) 2026-08-26 03:53:15.163517 | instance | 2026-08-26 03:53:15.163787 | instance | TASK [Set permissions on loopback devices] ************************************* 2026-08-26 03:53:15.164080 | instance | Wednesday 26 August 2026 03:53:15 +0000 (0:00:00.540) 0:00:35.487 ****** 2026-08-26 03:53:15.777515 | instance | changed: [instance] => (item=osd0) 2026-08-26 03:53:15.777572 | instance | changed: [instance] => (item=osd1) 2026-08-26 03:53:15.777588 | instance | changed: [instance] => (item=osd2) 2026-08-26 03:53:15.778472 | instance | 2026-08-26 03:53:15.778518 | instance | TASK [Start loop devices] ****************************************************** 2026-08-26 03:53:15.778526 | instance | Wednesday 26 August 2026 03:53:15 +0000 (0:00:00.614) 0:00:36.101 ****** 2026-08-26 03:53:16.472657 | instance | changed: [instance] => (item=osd0) 2026-08-26 03:53:16.472781 | instance | changed: [instance] => (item=osd1) 2026-08-26 03:53:16.472966 | instance | changed: [instance] => (item=osd2) 2026-08-26 03:53:16.473113 | instance | 2026-08-26 03:53:16.473265 | instance | TASK [Create a volume group for each loop device] ****************************** 2026-08-26 03:53:16.473416 | instance | Wednesday 26 August 2026 03:53:16 +0000 (0:00:00.696) 0:00:36.797 ****** 2026-08-26 03:53:19.723267 | instance | changed: [instance] => (item=osd0) 2026-08-26 03:53:19.724119 | instance | changed: [instance] => (item=osd1) 2026-08-26 03:53:19.724178 | instance | changed: [instance] => (item=osd2) 2026-08-26 03:53:19.724186 | instance | 2026-08-26 03:53:19.724193 | instance | TASK [Create a logical volume for each loop device] **************************** 2026-08-26 03:53:19.724200 | instance | Wednesday 26 August 2026 03:53:19 +0000 (0:00:03.250) 0:00:40.047 ****** 2026-08-26 03:53:21.683570 | instance | changed: [instance] => (item=ceph-instance-osd0) 2026-08-26 03:53:21.684359 | instance | changed: [instance] => (item=ceph-instance-osd1) 2026-08-26 03:53:21.684399 | instance | changed: [instance] => (item=ceph-instance-osd2) 2026-08-26 03:53:21.684410 | instance | 2026-08-26 03:53:21.685529 | instance | PLAY RECAP ********************************************************************* 2026-08-26 03:53:21.685616 | instance | instance : ok=15 changed=9 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-08-26 03:53:21.685624 | instance | 2026-08-26 03:53:21.685631 | instance | Wednesday 26 August 2026 03:53:21 +0000 (0:00:01.960) 0:00:42.008 ****** 2026-08-26 03:53:21.685642 | instance | =============================================================================== 2026-08-26 03:53:21.686385 | instance | Install depedencies ---------------------------------------------------- 29.51s 2026-08-26 03:53:21.686449 | instance | Create a volume group for each loop device ------------------------------ 3.25s 2026-08-26 03:53:21.686466 | instance | Create a logical volume for each loop device ---------------------------- 1.96s 2026-08-26 03:53:21.689496 | instance | Gathering Facts --------------------------------------------------------- 1.17s 2026-08-26 03:53:21.689520 | instance | Purge "snapd" package --------------------------------------------------- 0.85s 2026-08-26 03:53:21.689529 | instance | Gathering Facts --------------------------------------------------------- 0.70s 2026-08-26 03:53:21.689537 | instance | Start loop devices ------------------------------------------------------ 0.70s 2026-08-26 03:53:21.689544 | instance | Configure short hostname ------------------------------------------------ 0.67s 2026-08-26 03:53:21.689552 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.65s 2026-08-26 03:53:21.689559 | instance | Set permissions on loopback devices ------------------------------------- 0.61s 2026-08-26 03:53:21.689566 | instance | Start up service -------------------------------------------------------- 0.56s 2026-08-26 03:53:21.689573 | instance | Create devices for Ceph ------------------------------------------------- 0.54s 2026-08-26 03:53:21.689581 | instance | Generate lvm.conf ------------------------------------------------------- 0.31s 2026-08-26 03:53:21.689588 | instance | Ensure hostname inside hosts file --------------------------------------- 0.26s 2026-08-26 03:53:21.689595 | instance | Get list of all loopback devices ---------------------------------------- 0.20s 2026-08-26 03:53:21.689708 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s 2026-08-26 03:53:21.765381 | instance | INFO [csi > prepare] Executed: Successful 2026-08-26 03:53:21.778994 | instance | INFO [csi > converge] Executing 2026-08-26 03:53:23.280941 | instance | 2026-08-26 03:53:23.281389 | instance | PLAY [Debug CSI driver value] ************************************************** 2026-08-26 03:53:23.281768 | instance | 2026-08-26 03:53:23.282107 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-26 03:53:23.282442 | instance | Wednesday 26 August 2026 03:53:23 +0000 (0:00:00.007) 0:00:00.007 ****** 2026-08-26 03:53:24.253861 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-08-26 03:53:24.254310 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-08-26 03:53:24.254661 | instance | interpreter could change the meaning of that path. See 2026-08-26 03:53:24.255001 | instance | https://docs.ansible.com/ansible- 2026-08-26 03:53:24.255338 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-08-26 03:53:24.264126 | instance | ok: [instance] 2026-08-26 03:53:24.264474 | instance | 2026-08-26 03:53:24.264808 | instance | TASK [Display CSI driver value and environment variable] *********************** 2026-08-26 03:53:24.265139 | instance | Wednesday 26 August 2026 03:53:24 +0000 (0:00:00.983) 0:00:00.990 ****** 2026-08-26 03:53:24.310801 | instance | ok: [instance] => { 2026-08-26 03:53:24.311195 | instance | "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER=" 2026-08-26 03:53:24.311518 | instance | } 2026-08-26 03:53:24.311828 | instance | 2026-08-26 03:53:24.312149 | instance | PLAY [all] ********************************************************************* 2026-08-26 03:53:24.312454 | instance | 2026-08-26 03:53:24.312837 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-26 03:53:24.313263 | instance | Wednesday 26 August 2026 03:53:24 +0000 (0:00:00.046) 0:00:01.037 ****** 2026-08-26 03:53:25.214766 | instance | ok: [instance] 2026-08-26 03:53:25.215154 | instance | 2026-08-26 03:53:25.215513 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-08-26 03:53:25.215931 | instance | Wednesday 26 August 2026 03:53:25 +0000 (0:00:00.903) 0:00:01.941 ****** 2026-08-26 03:53:25.392551 | instance | ok: [instance] 2026-08-26 03:53:25.392992 | instance | 2026-08-26 03:53:25.393427 | instance | PLAY [Deploy Ceph monitors & managers] ***************************************** 2026-08-26 03:53:25.393907 | instance | 2026-08-26 03:53:25.394322 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-26 03:53:25.394766 | instance | Wednesday 26 August 2026 03:53:25 +0000 (0:00:00.177) 0:00:02.119 ****** 2026-08-26 03:53:26.280100 | instance | ok: [instance] 2026-08-26 03:53:26.280137 | instance | 2026-08-26 03:53:26.280143 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-26 03:53:26.280152 | instance | Wednesday 26 August 2026 03:53:26 +0000 (0:00:00.887) 0:00:03.006 ****** 2026-08-26 03:53:26.559075 | instance | ok: [instance] 2026-08-26 03:53:26.559278 | instance | 2026-08-26 03:53:26.559288 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-26 03:53:26.559294 | instance | Wednesday 26 August 2026 03:53:26 +0000 (0:00:00.278) 0:00:03.285 ****** 2026-08-26 03:53:26.610478 | instance | skipping: [instance] 2026-08-26 03:53:26.610518 | instance | 2026-08-26 03:53:26.610524 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-08-26 03:53:26.610529 | instance | Wednesday 26 August 2026 03:53:26 +0000 (0:00:00.051) 0:00:03.336 ****** 2026-08-26 03:53:26.992280 | instance | changed: [instance] 2026-08-26 03:53:26.992311 | instance | 2026-08-26 03:53:26.992317 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-26 03:53:26.992322 | instance | Wednesday 26 August 2026 03:53:26 +0000 (0:00:00.382) 0:00:03.718 ****** 2026-08-26 03:53:27.065084 | instance | ok: [instance] => { 2026-08-26 03:53:27.065115 | instance | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-08-26 03:53:27.065123 | instance | } 2026-08-26 03:53:27.065129 | instance | 2026-08-26 03:53:27.065135 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-26 03:53:27.065141 | instance | Wednesday 26 August 2026 03:53:27 +0000 (0:00:00.072) 0:00:03.790 ****** 2026-08-26 03:53:27.670188 | instance | changed: [instance] 2026-08-26 03:53:27.670806 | instance | 2026-08-26 03:53:27.670847 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-26 03:53:27.670855 | instance | Wednesday 26 August 2026 03:53:27 +0000 (0:00:00.605) 0:00:04.396 ****** 2026-08-26 03:53:27.712874 | instance | skipping: [instance] 2026-08-26 03:53:27.712983 | instance | 2026-08-26 03:53:27.713241 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-26 03:53:27.713264 | instance | Wednesday 26 August 2026 03:53:27 +0000 (0:00:00.043) 0:00:04.439 ****** 2026-08-26 03:53:27.764714 | instance | skipping: [instance] 2026-08-26 03:53:27.765108 | instance | 2026-08-26 03:53:27.765149 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-26 03:53:27.765155 | instance | Wednesday 26 August 2026 03:53:27 +0000 (0:00:00.051) 0:00:04.491 ****** 2026-08-26 03:53:27.974037 | instance | ok: [instance] 2026-08-26 03:53:27.974107 | instance | 2026-08-26 03:53:27.974396 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-26 03:53:27.974465 | instance | Wednesday 26 August 2026 03:53:27 +0000 (0:00:00.208) 0:00:04.700 ****** 2026-08-26 03:53:29.136518 | instance | ok: [instance] 2026-08-26 03:53:29.136668 | instance | 2026-08-26 03:53:29.136872 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-26 03:53:29.137139 | instance | Wednesday 26 August 2026 03:53:29 +0000 (0:00:01.162) 0:00:05.862 ****** 2026-08-26 03:53:29.200262 | instance | ok: [instance] => { 2026-08-26 03:53:29.200424 | instance | "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz" 2026-08-26 03:53:29.200758 | instance | } 2026-08-26 03:53:29.200949 | instance | 2026-08-26 03:53:29.201137 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-26 03:53:29.201295 | instance | Wednesday 26 August 2026 03:53:29 +0000 (0:00:00.064) 0:00:05.926 ****** 2026-08-26 03:53:29.796800 | instance | changed: [instance] 2026-08-26 03:53:29.796879 | instance | 2026-08-26 03:53:29.796954 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-26 03:53:29.797134 | instance | Wednesday 26 August 2026 03:53:29 +0000 (0:00:00.596) 0:00:06.523 ****** 2026-08-26 03:53:32.619250 | instance | changed: [instance] 2026-08-26 03:53:32.619317 | instance | 2026-08-26 03:53:32.619454 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-08-26 03:53:32.619721 | instance | Wednesday 26 August 2026 03:53:32 +0000 (0:00:02.822) 0:00:09.346 ****** 2026-08-26 03:53:32.655383 | instance | skipping: [instance] 2026-08-26 03:53:32.655537 | instance | 2026-08-26 03:53:32.655769 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-08-26 03:53:32.655981 | instance | Wednesday 26 August 2026 03:53:32 +0000 (0:00:00.035) 0:00:09.382 ****** 2026-08-26 03:53:32.684774 | instance | skipping: [instance] 2026-08-26 03:53:32.685036 | instance | 2026-08-26 03:53:32.685236 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-08-26 03:53:32.685456 | instance | Wednesday 26 August 2026 03:53:32 +0000 (0:00:00.028) 0:00:09.411 ****** 2026-08-26 03:53:32.717893 | instance | skipping: [instance] 2026-08-26 03:53:32.718046 | instance | 2026-08-26 03:53:32.718224 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-08-26 03:53:32.718401 | instance | Wednesday 26 August 2026 03:53:32 +0000 (0:00:00.033) 0:00:09.444 ****** 2026-08-26 03:53:38.713359 | instance | changed: [instance] 2026-08-26 03:53:38.713446 | instance | 2026-08-26 03:53:38.713640 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] *** 2026-08-26 03:53:38.713865 | instance | Wednesday 26 August 2026 03:53:38 +0000 (0:00:05.995) 0:00:15.440 ****** 2026-08-26 03:53:39.281928 | instance | changed: [instance] 2026-08-26 03:53:39.281991 | instance | 2026-08-26 03:53:39.282150 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] ******* 2026-08-26 03:53:39.282337 | instance | Wednesday 26 August 2026 03:53:39 +0000 (0:00:00.567) 0:00:16.007 ****** 2026-08-26 03:53:40.159836 | instance | changed: [instance] => (item={'path': '/etc/containerd'}) 2026-08-26 03:53:40.160807 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'}) 2026-08-26 03:53:40.160824 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'}) 2026-08-26 03:53:40.160829 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'}) 2026-08-26 03:53:40.160834 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'}) 2026-08-26 03:53:40.160839 | instance | 2026-08-26 03:53:40.160848 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] ********** 2026-08-26 03:53:40.160852 | instance | Wednesday 26 August 2026 03:53:40 +0000 (0:00:00.878) 0:00:16.886 ****** 2026-08-26 03:53:40.728197 | instance | changed: [instance] 2026-08-26 03:53:40.728279 | instance | 2026-08-26 03:53:40.728932 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ******** 2026-08-26 03:53:40.728971 | instance | Wednesday 26 August 2026 03:53:40 +0000 (0:00:00.551) 0:00:17.437 ****** 2026-08-26 03:53:40.728977 | instance | 2026-08-26 03:53:40.728981 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-08-26 03:53:40.728985 | instance | Wednesday 26 August 2026 03:53:40 +0000 (0:00:00.017) 0:00:17.455 ****** 2026-08-26 03:53:41.662574 | instance | ok: [instance] 2026-08-26 03:53:41.662643 | instance | 2026-08-26 03:53:41.662921 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] ********** 2026-08-26 03:53:41.662957 | instance | Wednesday 26 August 2026 03:53:41 +0000 (0:00:00.934) 0:00:18.389 ****** 2026-08-26 03:53:42.097788 | instance | changed: [instance] 2026-08-26 03:53:42.097887 | instance | 2026-08-26 03:53:42.098151 | instance | TASK [vexxhost.containers.containerd : Enable and start service] *************** 2026-08-26 03:53:42.098192 | instance | Wednesday 26 August 2026 03:53:42 +0000 (0:00:00.435) 0:00:18.824 ****** 2026-08-26 03:53:42.604226 | instance | changed: [instance] 2026-08-26 03:53:42.604306 | instance | 2026-08-26 03:53:42.604563 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-26 03:53:42.604599 | instance | Wednesday 26 August 2026 03:53:42 +0000 (0:00:00.506) 0:00:19.331 ****** 2026-08-26 03:53:42.806837 | instance | ok: [instance] 2026-08-26 03:53:42.807210 | instance | 2026-08-26 03:53:42.807241 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-26 03:53:42.807247 | instance | Wednesday 26 August 2026 03:53:42 +0000 (0:00:00.202) 0:00:19.533 ****** 2026-08-26 03:53:42.862804 | instance | ok: [instance] => { 2026-08-26 03:53:42.863417 | instance | "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz" 2026-08-26 03:53:42.863452 | instance | } 2026-08-26 03:53:42.863458 | instance | 2026-08-26 03:53:42.863462 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-26 03:53:42.863467 | instance | Wednesday 26 August 2026 03:53:42 +0000 (0:00:00.055) 0:00:19.589 ****** 2026-08-26 03:53:43.856748 | instance | changed: [instance] 2026-08-26 03:53:43.856787 | instance | 2026-08-26 03:53:43.856793 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-26 03:53:43.856798 | instance | Wednesday 26 August 2026 03:53:43 +0000 (0:00:00.993) 0:00:20.582 ****** 2026-08-26 03:53:48.150651 | instance | changed: [instance] 2026-08-26 03:53:48.150722 | instance | 2026-08-26 03:53:48.151008 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ****************** 2026-08-26 03:53:48.151045 | instance | Wednesday 26 August 2026 03:53:48 +0000 (0:00:04.294) 0:00:24.877 ****** 2026-08-26 03:53:49.186400 | instance | ok: [instance] 2026-08-26 03:53:49.186492 | instance | 2026-08-26 03:53:49.186770 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] *************** 2026-08-26 03:53:49.186900 | instance | Wednesday 26 August 2026 03:53:49 +0000 (0:00:01.035) 0:00:25.913 ****** 2026-08-26 03:53:49.550573 | instance | changed: [instance] 2026-08-26 03:53:49.551127 | instance | 2026-08-26 03:53:49.551168 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] ***** 2026-08-26 03:53:49.551176 | instance | Wednesday 26 August 2026 03:53:49 +0000 (0:00:00.363) 0:00:26.277 ****** 2026-08-26 03:53:50.023297 | instance | changed: [instance] 2026-08-26 03:53:50.023755 | instance | 2026-08-26 03:53:50.023794 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] *********** 2026-08-26 03:53:50.023800 | instance | Wednesday 26 August 2026 03:53:50 +0000 (0:00:00.472) 0:00:26.749 ****** 2026-08-26 03:53:50.614791 | instance | changed: [instance] => (item={'path': '/etc/docker'}) 2026-08-26 03:53:50.614866 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'}) 2026-08-26 03:53:50.615395 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'}) 2026-08-26 03:53:50.615436 | instance | 2026-08-26 03:53:50.615442 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ****** 2026-08-26 03:53:50.615447 | instance | Wednesday 26 August 2026 03:53:50 +0000 (0:00:00.591) 0:00:27.341 ****** 2026-08-26 03:53:51.054990 | instance | changed: [instance] 2026-08-26 03:53:51.055034 | instance | 2026-08-26 03:53:51.055041 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] *********** 2026-08-26 03:53:51.055047 | instance | Wednesday 26 August 2026 03:53:51 +0000 (0:00:00.439) 0:00:27.780 ****** 2026-08-26 03:53:51.520390 | instance | changed: [instance] 2026-08-26 03:53:51.520436 | instance | 2026-08-26 03:53:51.520443 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************ 2026-08-26 03:53:51.520450 | instance | Wednesday 26 August 2026 03:53:51 +0000 (0:00:00.443) 0:00:28.224 ****** 2026-08-26 03:53:51.520455 | instance | 2026-08-26 03:53:51.520461 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-08-26 03:53:51.520467 | instance | Wednesday 26 August 2026 03:53:51 +0000 (0:00:00.021) 0:00:28.245 ****** 2026-08-26 03:53:52.197533 | instance | ok: [instance] 2026-08-26 03:53:52.197950 | instance | 2026-08-26 03:53:52.197990 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ****************** 2026-08-26 03:53:52.198002 | instance | Wednesday 26 August 2026 03:53:52 +0000 (0:00:00.678) 0:00:28.924 ****** 2026-08-26 03:53:56.467709 | instance | changed: [instance] 2026-08-26 03:53:56.467793 | instance | 2026-08-26 03:53:56.468076 | instance | TASK [vexxhost.containers.docker : Enable and start service] ******************* 2026-08-26 03:53:56.468116 | instance | Wednesday 26 August 2026 03:53:56 +0000 (0:00:04.270) 0:00:33.194 ****** 2026-08-26 03:53:57.000467 | instance | changed: [instance] 2026-08-26 03:53:57.000500 | instance | 2026-08-26 03:53:57.000505 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ****** 2026-08-26 03:53:57.000510 | instance | Wednesday 26 August 2026 03:53:56 +0000 (0:00:00.532) 0:00:33.726 ****** 2026-08-26 03:53:57.057688 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml) 2026-08-26 03:53:57.057756 | instance | 2026-08-26 03:53:57.057773 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ******************************** 2026-08-26 03:53:57.057786 | instance | Wednesday 26 August 2026 03:53:57 +0000 (0:00:00.057) 0:00:33.784 ****** 2026-08-26 03:54:02.309433 | instance | changed: [instance] 2026-08-26 03:54:02.309495 | instance | 2026-08-26 03:54:02.309502 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] ********************* 2026-08-26 03:54:02.309507 | instance | Wednesday 26 August 2026 03:54:02 +0000 (0:00:05.251) 0:00:39.036 ****** 2026-08-26 03:54:02.945536 | instance | ok: [instance] => (item=chronyd) 2026-08-26 03:54:02.945649 | instance | ok: [instance] => (item=sshd) 2026-08-26 03:54:02.946048 | instance | 2026-08-26 03:54:02.946086 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ****************************** 2026-08-26 03:54:02.946092 | instance | Wednesday 26 August 2026 03:54:02 +0000 (0:00:00.636) 0:00:39.672 ****** 2026-08-26 03:54:03.884326 | instance | changed: [instance] 2026-08-26 03:54:03.884532 | instance | 2026-08-26 03:54:03.884545 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ******************** 2026-08-26 03:54:03.884697 | instance | Wednesday 26 August 2026 03:54:03 +0000 (0:00:00.938) 0:00:40.611 ****** 2026-08-26 03:54:04.099541 | instance | ok: [instance] 2026-08-26 03:54:04.099604 | instance | 2026-08-26 03:54:04.099880 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] **************** 2026-08-26 03:54:04.099919 | instance | Wednesday 26 August 2026 03:54:04 +0000 (0:00:00.215) 0:00:40.826 ****** 2026-08-26 03:54:04.608467 | instance | changed: [instance] 2026-08-26 03:54:04.608584 | instance | 2026-08-26 03:54:04.608929 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] *** 2026-08-26 03:54:04.608968 | instance | Wednesday 26 August 2026 03:54:04 +0000 (0:00:00.509) 0:00:41.335 ****** 2026-08-26 03:54:04.932717 | instance | changed: [instance] 2026-08-26 03:54:04.932774 | instance | 2026-08-26 03:54:04.933035 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] ************************* 2026-08-26 03:54:04.933052 | instance | Wednesday 26 August 2026 03:54:04 +0000 (0:00:00.324) 0:00:41.659 ****** 2026-08-26 03:54:05.042687 | instance | ok: [instance] 2026-08-26 03:54:05.042799 | instance | 2026-08-26 03:54:05.043059 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] ******************* 2026-08-26 03:54:05.043074 | instance | Wednesday 26 August 2026 03:54:05 +0000 (0:00:00.110) 0:00:41.769 ****** 2026-08-26 03:54:05.250910 | instance | ok: [instance] => (item=instance) 2026-08-26 03:54:05.251297 | instance | 2026-08-26 03:54:05.251337 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ******** 2026-08-26 03:54:05.251343 | instance | Wednesday 26 August 2026 03:54:05 +0000 (0:00:00.208) 0:00:41.977 ****** 2026-08-26 03:54:05.292669 | instance | ok: [instance] 2026-08-26 03:54:05.292798 | instance | 2026-08-26 03:54:05.293074 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] *********************************** 2026-08-26 03:54:05.293103 | instance | Wednesday 26 August 2026 03:54:05 +0000 (0:00:00.041) 0:00:42.019 ****** 2026-08-26 03:54:05.358634 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance 2026-08-26 03:54:05.359011 | instance | 2026-08-26 03:54:05.359049 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] ************* 2026-08-26 03:54:05.359055 | instance | Wednesday 26 August 2026 03:54:05 +0000 (0:00:00.065) 0:00:42.085 ****** 2026-08-26 03:54:05.729185 | instance | changed: [instance] 2026-08-26 03:54:05.729270 | instance | 2026-08-26 03:54:05.729633 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ****************** 2026-08-26 03:54:05.729715 | instance | Wednesday 26 August 2026 03:54:05 +0000 (0:00:00.370) 0:00:42.455 ****** 2026-08-26 03:54:06.408544 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True}) 2026-08-26 03:54:06.408581 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0}) 2026-08-26 03:54:06.408586 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False}) 2026-08-26 03:54:06.408591 | instance | 2026-08-26 03:54:06.408596 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] ******************************* 2026-08-26 03:54:06.408600 | instance | Wednesday 26 August 2026 03:54:06 +0000 (0:00:00.679) 0:00:43.134 ****** 2026-08-26 03:56:00.054440 | instance | ok: [instance] 2026-08-26 03:56:00.054559 | instance | 2026-08-26 03:56:00.054852 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] *************** 2026-08-26 03:56:00.054890 | instance | Wednesday 26 August 2026 03:56:00 +0000 (0:01:53.645) 0:02:36.780 ****** 2026-08-26 03:56:00.293461 | instance | changed: [instance] 2026-08-26 03:56:00.293553 | instance | 2026-08-26 03:56:00.293562 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] ********************************** 2026-08-26 03:56:00.293567 | instance | Wednesday 26 August 2026 03:56:00 +0000 (0:00:00.238) 0:02:37.019 ****** 2026-08-26 03:56:00.390768 | instance | ok: [instance] 2026-08-26 03:56:00.390819 | instance | 2026-08-26 03:56:00.390827 | instance | TASK [Install Ceph host] ******************************************************* 2026-08-26 03:56:00.390834 | instance | Wednesday 26 August 2026 03:56:00 +0000 (0:00:00.097) 0:02:37.116 ****** 2026-08-26 03:56:00.479980 | instance | included: vexxhost.ceph.cephadm_host for instance 2026-08-26 03:56:00.480031 | instance | 2026-08-26 03:56:00.480043 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ****** 2026-08-26 03:56:00.480053 | instance | Wednesday 26 August 2026 03:56:00 +0000 (0:00:00.088) 0:02:37.205 ****** 2026-08-26 03:56:02.258902 | instance | ok: [instance] 2026-08-26 03:56:02.258963 | instance | 2026-08-26 03:56:02.258975 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] *** 2026-08-26 03:56:02.258986 | instance | Wednesday 26 August 2026 03:56:02 +0000 (0:00:01.778) 0:02:38.984 ****** 2026-08-26 03:56:02.319464 | instance | ok: [instance] => (item=instance) 2026-08-26 03:56:02.319497 | instance | 2026-08-26 03:56:02.319508 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] *********** 2026-08-26 03:56:02.319517 | instance | Wednesday 26 August 2026 03:56:02 +0000 (0:00:00.061) 0:02:39.045 ****** 2026-08-26 03:56:02.657543 | instance | ok: [instance] 2026-08-26 03:56:02.657591 | instance | 2026-08-26 03:56:02.657865 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] *********************** 2026-08-26 03:56:02.658129 | instance | Wednesday 26 August 2026 03:56:02 +0000 (0:00:00.338) 0:02:39.383 ****** 2026-08-26 03:56:11.355720 | instance | ok: [instance] 2026-08-26 03:56:11.355788 | instance | 2026-08-26 03:56:11.355801 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ****************** 2026-08-26 03:56:11.355812 | instance | Wednesday 26 August 2026 03:56:11 +0000 (0:00:08.697) 0:02:48.081 ****** 2026-08-26 03:57:19.024725 | 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-26 03:57:19.025312 | 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_wu1yfdg1/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_wu1yfdg1/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_wu1yfdg1/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_wu1yfdg1/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-26T03:57:18.709+0000 7f89cc089640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCVY45qdQZFKSAADtqLpS4DGM9g7caKDkp3lRTDqgj9mE8sJiJ+5UFILIo=: Malformed input [buffer:3]\n2026-08-26T03:57:18.709+0000 7f89cc089640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-26T03:57:18.709+0000 7f89cc089640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCVY45qdQZFKSAADtqLpS4DGM9g7caKDkp3lRTDqgj9mE8sJiJ+5UFILIo=: Malformed input [buffer:3]\n2026-08-26T03:57:18.709+0000 7f89cc089640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-26T03:57:18.709+0000 7f89cc089640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCVY45qdQZFKSAADtqLpS4DGM9g7caKDkp3lRTDqgj9mE8sJiJ+5UFILIo=: Malformed input [buffer:3]\n2026-08-26T03:57:18.709+0000 7f89cc089640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-26T03:57:18.709+0000 7f89cc089640 -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-26 03:57:19.027606 | instance | 2026-08-26 03:57:19.027806 | instance | PLAY RECAP ********************************************************************* 2026-08-26 03:57:19.028143 | instance | instance : ok=55 changed=26 unreachable=0 failed=1 skipped=6 rescued=0 ignored=0 2026-08-26 03:57:19.028189 | instance | 2026-08-26 03:57:19.029490 | instance | Wednesday 26 August 2026 03:57:19 +0000 (0:01:07.673) 0:03:55.754 ****** 2026-08-26 03:57:19.029502 | instance | =============================================================================== 2026-08-26 03:57:19.029507 | instance | vexxhost.ceph.mon : Run Bootstrap command ----------------------------- 113.65s 2026-08-26 03:57:19.029511 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 67.67s 2026-08-26 03:57:19.029515 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 8.70s 2026-08-26 03:57:19.029520 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 6.00s 2026-08-26 03:57:19.029524 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 5.25s 2026-08-26 03:57:19.029528 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.29s 2026-08-26 03:57:19.032007 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 4.27s 2026-08-26 03:57:19.032030 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.82s 2026-08-26 03:57:19.032045 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.78s 2026-08-26 03:57:19.032051 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.61s 2026-08-26 03:57:19.032056 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.16s 2026-08-26 03:57:19.032062 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.04s 2026-08-26 03:57:19.032067 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.99s 2026-08-26 03:57:19.032073 | instance | Gathering Facts --------------------------------------------------------- 0.98s 2026-08-26 03:57:19.032078 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 0.94s 2026-08-26 03:57:19.032084 | instance | Gathering Facts --------------------------------------------------------- 0.90s 2026-08-26 03:57:19.032089 | instance | Gathering Facts --------------------------------------------------------- 0.89s 2026-08-26 03:57:19.032095 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.88s 2026-08-26 03:57:19.032100 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.68s 2026-08-26 03:57:19.032106 | instance | vexxhost.ceph.cephadm : Ensure services are started --------------------- 0.64s 2026-08-26 03:57:19.114300 | 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-26 03:57:19.114636 | instance | ERROR [csi > converge] Executed: Failed 2026-08-26 03:57:19.114828 | 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-26 03:57:19.210234 | instance | ERROR 2026-08-26 03:57:19.210447 | instance | { 2026-08-26 03:57:19.210500 | instance | "delta": "0:04:53.547746", 2026-08-26 03:57:19.210530 | instance | "end": "2026-08-26 03:57:19.161012", 2026-08-26 03:57:19.210556 | instance | "msg": "non-zero return code", 2026-08-26 03:57:19.210581 | instance | "rc": 2, 2026-08-26 03:57:19.210605 | instance | "start": "2026-08-26 03:52:25.613266" 2026-08-26 03:57:19.210630 | instance | } failure 2026-08-26 03:57:19.216705 | 2026-08-26 03:57:19.216761 | PLAY RECAP 2026-08-26 03:57:19.216805 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-08-26 03:57:19.216827 | 2026-08-26 03:57:19.418579 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-26 03:57:19.441928 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-08-26 03:57:20.394161 | 2026-08-26 03:57:20.394281 | PLAY [all] 2026-08-26 03:57:20.410005 | 2026-08-26 03:57:20.410116 | TASK [gather-host-logs : creating directory for system status] 2026-08-26 03:57:20.739878 | instance | changed 2026-08-26 03:57:20.747050 | 2026-08-26 03:57:20.747130 | TASK [gather-host-logs : Get logs for each host] 2026-08-26 03:57:21.090128 | instance | + systemd-cgls --full --all --no-pager 2026-08-26 03:57:21.119111 | instance | + ip addr 2026-08-26 03:57:21.122926 | instance | + ip route 2026-08-26 03:57:21.124789 | instance | + lsblk 2026-08-26 03:57:21.130965 | instance | + mount 2026-08-26 03:57:21.132985 | instance | + docker images 2026-08-26 03:57:21.155090 | instance | + brctl show 2026-08-26 03:57:21.155945 | instance | /bin/bash: line 8: brctl: command not found 2026-08-26 03:57:21.156356 | instance | + ps aux --sort=-%mem 2026-08-26 03:57:21.207512 | instance | + dpkg -l 2026-08-26 03:57:21.219270 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-08-26 03:57:21.219852 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-08-26 03:57:21.235126 | instance | + '[' '!' -z '' ']' 2026-08-26 03:57:21.361945 | instance | ok: Runtime: 0:00:00.151495 2026-08-26 03:57:21.368726 | 2026-08-26 03:57:21.368799 | TASK [gather-host-logs : Downloads logs to executor] 2026-08-26 03:57:22.001275 | instance | changed: 2026-08-26 03:57:22.001468 | instance | created directory /var/lib/zuul/builds/8490e7a5b57a4bb39a13429710a6e519/work/logs/instance 2026-08-26 03:57:22.001508 | instance | cd+++++++++ system/ 2026-08-26 03:57:22.001541 | instance | >f+++++++++ system/brctl-show.txt 2026-08-26 03:57:22.001572 | instance | >f+++++++++ system/docker-images.txt 2026-08-26 03:57:22.001602 | instance | >f+++++++++ system/ip-addr.txt 2026-08-26 03:57:22.001633 | instance | >f+++++++++ system/ip-route.txt 2026-08-26 03:57:22.001663 | instance | >f+++++++++ system/lsblk.txt 2026-08-26 03:57:22.001692 | instance | >f+++++++++ system/mount.txt 2026-08-26 03:57:22.001720 | instance | >f+++++++++ system/packages.txt 2026-08-26 03:57:22.001748 | instance | >f+++++++++ system/ps.txt 2026-08-26 03:57:22.001778 | instance | >f+++++++++ system/systemd-cgls.txt 2026-08-26 03:57:22.011514 | 2026-08-26 03:57:22.011583 | LOOP [helm-release-status : creating directory for helm release status] 2026-08-26 03:57:22.222663 | instance | changed: "values" 2026-08-26 03:57:22.395887 | instance | changed: "releases" 2026-08-26 03:57:22.414096 | 2026-08-26 03:57:22.414253 | TASK [helm-release-status : Gather get release status for helm charts] 2026-08-26 03:57:22.628709 | instance | /bin/bash: line 3: kubectl: command not found 2026-08-26 03:57:22.950348 | instance | ok: Runtime: 0:00:00.004960 2026-08-26 03:57:22.955196 | 2026-08-26 03:57:22.955271 | TASK [helm-release-status : Downloads logs to executor] 2026-08-26 03:57:23.434093 | instance | changed: 2026-08-26 03:57:23.434280 | instance | cd+++++++++ helm/ 2026-08-26 03:57:23.434318 | instance | cd+++++++++ helm/releases/ 2026-08-26 03:57:23.434348 | instance | cd+++++++++ helm/values/ 2026-08-26 03:57:23.444512 | 2026-08-26 03:57:23.445091 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-08-26 03:57:23.631098 | instance | changed 2026-08-26 03:57:23.638065 | 2026-08-26 03:57:23.638138 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-08-26 03:57:23.889349 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-26 03:57:23.889665 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-26 03:57:23.895939 | instance | environment: line 1: kubectl: command not found 2026-08-26 03:57:23.897268 | instance | environment: line 1: kubectl: command not found 2026-08-26 03:57:23.897356 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-26 03:57:23.899506 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-26 03:57:23.900932 | instance | environment: line 1: kubectl: command not found 2026-08-26 03:57:23.902028 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-26 03:57:23.903389 | instance | environment: line 1: kubectl: command not found 2026-08-26 03:57:23.904519 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-26 03:57:23.904556 | instance | environment: line 1: kubectl: command not found 2026-08-26 03:57:23.905637 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-26 03:57:24.173067 | instance | ok: Runtime: 0:00:00.025808 2026-08-26 03:57:24.178932 | 2026-08-26 03:57:24.178994 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-08-26 03:57:24.393853 | instance | changed 2026-08-26 03:57:24.400125 | 2026-08-26 03:57:24.400196 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-08-26 03:57:24.619159 | instance | environment: line 5: kubectl: command not found 2026-08-26 03:57:24.620511 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-26 03:57:24.620903 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-26 03:57:24.621158 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-26 03:57:24.933151 | instance | ok: Runtime: 0:00:00.010815 2026-08-26 03:57:24.940144 | 2026-08-26 03:57:24.940231 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-08-26 03:57:25.419746 | instance | changed: 2026-08-26 03:57:25.419948 | instance | cd+++++++++ objects/ 2026-08-26 03:57:25.419987 | instance | cd+++++++++ objects/cluster/ 2026-08-26 03:57:25.420018 | instance | cd+++++++++ objects/namespaced/ 2026-08-26 03:57:25.430107 | 2026-08-26 03:57:25.430177 | TASK [gather-pod-logs : creating directory for pod logs] 2026-08-26 03:57:25.622239 | instance | changed 2026-08-26 03:57:25.629413 | 2026-08-26 03:57:25.629506 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-08-26 03:57:25.837382 | instance | changed 2026-08-26 03:57:25.843161 | 2026-08-26 03:57:25.843227 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-08-26 03:57:26.056337 | instance | environment: line 3: kubectl: command not found 2026-08-26 03:57:26.377510 | instance | ok: Runtime: 0:00:00.009781 2026-08-26 03:57:26.382822 | 2026-08-26 03:57:26.382885 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-08-26 03:57:26.869316 | instance | changed: 2026-08-26 03:57:26.869483 | instance | cd+++++++++ pod-logs/ 2026-08-26 03:57:26.869522 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-08-26 03:57:26.878631 | 2026-08-26 03:57:26.878697 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-08-26 03:57:27.085085 | instance | changed 2026-08-26 03:57:27.089931 | 2026-08-26 03:57:27.089993 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-08-26 03:57:27.301010 | instance | /bin/bash: line 2: kubectl: command not found 2026-08-26 03:57:27.624306 | instance | ok: Runtime: 0:00:00.034349 2026-08-26 03:57:27.630968 | 2026-08-26 03:57:27.631048 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-08-26 03:57:27.824645 | instance | /bin/bash: line 2: kubectl: command not found 2026-08-26 03:57:27.855233 | instance | ceph-mgr endpoints: 2026-08-26 03:57:28.166149 | instance | ok: Runtime: 0:00:00.035546 2026-08-26 03:57:28.172832 | 2026-08-26 03:57:28.172899 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-08-26 03:57:28.368460 | instance | /bin/bash: line 4: kubectl: command not found 2026-08-26 03:57:28.706480 | instance | ok: Runtime: 0:00:00.036923 2026-08-26 03:57:28.713105 | 2026-08-26 03:57:28.713188 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-08-26 03:57:29.181780 | instance | changed: cd+++++++++ prometheus/ 2026-08-26 03:57:29.192567 | 2026-08-26 03:57:29.192648 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-08-26 03:57:29.399249 | instance | changed 2026-08-26 03:57:29.405629 | 2026-08-26 03:57:29.405711 | TASK [gather-selenium-data : Get selenium data] 2026-08-26 03:57:29.656602 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-08-26 03:57:29.658205 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-08-26 03:57:29.939931 | instance | ERROR 2026-08-26 03:57:29.940208 | instance | { 2026-08-26 03:57:29.940275 | instance | "delta": "0:00:00.007150", 2026-08-26 03:57:29.940321 | instance | "end": "2026-08-26 03:57:29.658752", 2026-08-26 03:57:29.940367 | instance | "msg": "non-zero return code", 2026-08-26 03:57:29.940409 | instance | "rc": 1, 2026-08-26 03:57:29.940450 | instance | "start": "2026-08-26 03:57:29.651602" 2026-08-26 03:57:29.940490 | instance | } 2026-08-26 03:57:29.940540 | instance | ERROR: Ignoring Errors 2026-08-26 03:57:29.946602 | 2026-08-26 03:57:29.946662 | TASK [gather-selenium-data : Downloads logs to executor] 2026-08-26 03:57:30.416440 | instance | changed: cd+++++++++ selenium/ 2026-08-26 03:57:30.422092 | 2026-08-26 03:57:30.422142 | PLAY RECAP 2026-08-26 03:57:30.422186 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-08-26 03:57:30.422208 | 2026-08-26 03:57:30.530411 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-08-26 03:57:30.535224 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-26 03:57:31.121098 | 2026-08-26 03:57:31.121199 | PLAY [all] 2026-08-26 03:57:31.132620 | 2026-08-26 03:57:31.132691 | TASK [fetch-output : Set log path for multiple nodes] 2026-08-26 03:57:31.177753 | instance | skipping: Conditional result was False 2026-08-26 03:57:31.187426 | 2026-08-26 03:57:31.187527 | TASK [fetch-output : Set log path for single node] 2026-08-26 03:57:31.231623 | instance | ok 2026-08-26 03:57:31.237766 | 2026-08-26 03:57:31.237854 | LOOP [fetch-output : Ensure local output dirs] 2026-08-26 03:57:31.599947 | instance -> localhost | ok: "/var/lib/zuul/builds/8490e7a5b57a4bb39a13429710a6e519/work/logs" 2026-08-26 03:57:31.804530 | instance -> localhost | changed: "/var/lib/zuul/builds/8490e7a5b57a4bb39a13429710a6e519/work/artifacts" 2026-08-26 03:57:32.007301 | instance -> localhost | changed: "/var/lib/zuul/builds/8490e7a5b57a4bb39a13429710a6e519/work/docs" 2026-08-26 03:57:32.022999 | 2026-08-26 03:57:32.023216 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-26 03:57:32.667074 | instance | changed: .d..t...... ./ 2026-08-26 03:57:32.667317 | instance | changed: All items complete 2026-08-26 03:57:32.667356 | 2026-08-26 03:57:33.116181 | instance | changed: .d..t...... ./ 2026-08-26 03:57:33.559096 | instance | changed: .d..t...... ./ 2026-08-26 03:57:33.573094 | 2026-08-26 03:57:33.573218 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-26 03:57:33.959003 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007170 2026-08-26 03:57:34.183126 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007289 2026-08-26 03:57:34.201508 | 2026-08-26 03:57:34.201615 | PLAY [all] 2026-08-26 03:57:34.207972 | 2026-08-26 03:57:34.208038 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-26 03:57:34.605824 | instance | changed 2026-08-26 03:57:34.612569 | 2026-08-26 03:57:34.612618 | PLAY RECAP 2026-08-26 03:57:34.612661 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-26 03:57:34.612684 | 2026-08-26 03:57:34.735172 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-26 03:57:34.739744 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-26 03:57:35.345673 | 2026-08-26 03:57:35.345834 | PLAY [localhost] 2026-08-26 03:57:35.357215 | 2026-08-26 03:57:35.357301 | TASK [Generate Zuul manifest] 2026-08-26 03:57:35.380573 | localhost | ok 2026-08-26 03:57:35.399784 | 2026-08-26 03:57:35.399876 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-26 03:57:35.755351 | localhost | changed 2026-08-26 03:57:35.770575 | 2026-08-26 03:57:35.770729 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-26 03:57:35.803535 | localhost | ok 2026-08-26 03:57:35.811279 | 2026-08-26 03:57:35.811346 | TASK [Upload logs] 2026-08-26 03:57:35.832589 | localhost | ok 2026-08-26 03:57:35.895852 | 2026-08-26 03:57:35.895970 | TASK [Set zuul-log-path fact] 2026-08-26 03:57:35.916260 | localhost | ok 2026-08-26 03:57:35.967389 | 2026-08-26 03:57:35.967467 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-26 03:57:36.003315 | localhost | ok 2026-08-26 03:57:36.011168 | 2026-08-26 03:57:36.011235 | TASK [upload-logs : Create log directories] 2026-08-26 03:57:36.389496 | localhost | changed 2026-08-26 03:57:36.395521 | 2026-08-26 03:57:36.395595 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-26 03:57:36.791960 | localhost -> localhost | ok: Runtime: 0:00:00.005292 2026-08-26 03:57:36.799491 | 2026-08-26 03:57:36.799571 | TASK [upload-logs : Upload logs to log server] 2026-08-26 03:57:37.298477 | localhost | Output suppressed because no_log was given 2026-08-26 03:57:37.334896 | 2026-08-26 03:57:37.335020 | LOOP [upload-logs : Compress console log and json output] 2026-08-26 03:57:37.378176 | localhost | skipping: Conditional result was False 2026-08-26 03:57:37.385825 | localhost | skipping: Conditional result was False 2026-08-26 03:57:37.398021 | 2026-08-26 03:57:37.411781 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-26 03:57:37.454147 | localhost | skipping: Conditional result was False 2026-08-26 03:57:37.454668 | 2026-08-26 03:57:37.458253 | localhost | skipping: Conditional result was False 2026-08-26 03:57:37.478165 | 2026-08-26 03:57:37.478327 | LOOP [upload-logs : Upload console log and json output]