2026-09-04 00:12:06.771759 | Job console starting 2026-09-04 00:12:06.783529 | Updating git repos 2026-09-04 00:12:12.642305 | Cloning repos into workspace 2026-09-04 00:12:41.431991 | Restoring repo states 2026-09-04 00:12:50.525411 | Merging changes 2026-09-04 00:12:51.996313 | Checking out repos 2026-09-04 00:12:53.521855 | Preparing playbooks 2026-09-04 00:12:55.392944 | Running Ansible setup 2026-09-04 00:12:58.970788 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-09-04 00:12:59.571704 | 2026-09-04 00:12:59.571827 | PLAY [localhost] 2026-09-04 00:12:59.579062 | 2026-09-04 00:12:59.579157 | TASK [Gathering Facts] 2026-09-04 00:13:00.450159 | localhost | ok 2026-09-04 00:13:00.456932 | 2026-09-04 00:13:00.457052 | TASK [Setup log path fact] 2026-09-04 00:13:00.477249 | localhost | ok 2026-09-04 00:13:00.490843 | 2026-09-04 00:13:00.490906 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-04 00:13:00.521236 | localhost | ok 2026-09-04 00:13:00.529853 | 2026-09-04 00:13:00.529925 | TASK [emit-job-header : Print job information] 2026-09-04 00:13:00.570942 | # Job Information 2026-09-04 00:13:00.571139 | Ansible Version: 2.16.18 2026-09-04 00:13:00.571187 | Job: atmosphere-molecule-csi-rbd 2026-09-04 00:13:00.571219 | Pipeline: check 2026-09-04 00:13:00.571249 | Executor: 2d72f0692154 2026-09-04 00:13:00.571278 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3501 2026-09-04 00:13:00.571311 | Event ID: d46ae4b0-a7f4-11f1-9e4a-908fd0c5b31b 2026-09-04 00:13:00.575462 | 2026-09-04 00:13:00.575559 | LOOP [emit-job-header : Print node information] 2026-09-04 00:13:00.672318 | localhost | ok: 2026-09-04 00:13:00.672625 | localhost | # Node Information 2026-09-04 00:13:00.672680 | localhost | Inventory Hostname: instance 2026-09-04 00:13:00.672716 | localhost | Hostname: np0000191913 2026-09-04 00:13:00.672746 | localhost | Username: zuul 2026-09-04 00:13:00.672782 | localhost | Distro: Ubuntu 22.04 2026-09-04 00:13:00.672812 | localhost | Provider: yul1 2026-09-04 00:13:00.672841 | localhost | Region: ca-ymq-1 2026-09-04 00:13:00.672869 | localhost | Label: ubuntu-jammy 2026-09-04 00:13:00.672897 | localhost | Product Name: OpenStack Nova 2026-09-04 00:13:00.672925 | localhost | Interface IP: 162.253.55.129 2026-09-04 00:13:00.692434 | 2026-09-04 00:13:00.692590 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-04 00:13:01.073588 | localhost -> localhost | changed 2026-09-04 00:13:01.083180 | 2026-09-04 00:13:01.083282 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-04 00:13:01.919554 | localhost -> localhost | changed 2026-09-04 00:13:01.929587 | 2026-09-04 00:13:01.929660 | PLAY [all] 2026-09-04 00:13:01.938916 | 2026-09-04 00:13:01.938983 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-04 00:13:02.155902 | instance -> localhost | ok 2026-09-04 00:13:02.167529 | 2026-09-04 00:13:02.167620 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-04 00:13:02.200390 | instance | ok 2026-09-04 00:13:02.215871 | instance | included: /var/lib/zuul/builds/9bdc13a38f63406ebb860b54ce2b8394/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-04 00:13:02.221328 | 2026-09-04 00:13:02.221388 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-04 00:13:03.260394 | instance -> localhost | Generating public/private rsa key pair. 2026-09-04 00:13:03.260725 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/9bdc13a38f63406ebb860b54ce2b8394/work/9bdc13a38f63406ebb860b54ce2b8394_id_rsa 2026-09-04 00:13:03.260773 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/9bdc13a38f63406ebb860b54ce2b8394/work/9bdc13a38f63406ebb860b54ce2b8394_id_rsa.pub 2026-09-04 00:13:03.260805 | instance -> localhost | The key fingerprint is: 2026-09-04 00:13:03.260827 | instance -> localhost | SHA256:Xnl6wD5tuUI6Mh31Ikw+fKCjtZxk0lB8ozvriJGjeBA zuul-build-sshkey 2026-09-04 00:13:03.260874 | instance -> localhost | The key's randomart image is: 2026-09-04 00:13:03.260898 | instance -> localhost | +---[RSA 3072]----+ 2026-09-04 00:13:03.260942 | instance -> localhost | | . | 2026-09-04 00:13:03.260981 | instance -> localhost | | o o | 2026-09-04 00:13:03.261004 | instance -> localhost | | . o . | 2026-09-04 00:13:03.261035 | instance -> localhost | |E . . o... | 2026-09-04 00:13:03.261056 | instance -> localhost | | . o BSo=.. | 2026-09-04 00:13:03.261076 | instance -> localhost | |. .. X.Bo+=.. | 2026-09-04 00:13:03.261107 | instance -> localhost | | .+ B B.B+.= | 2026-09-04 00:13:03.261138 | instance -> localhost | |...+..B + .+ . | 2026-09-04 00:13:03.261162 | instance -> localhost | |o.. ...o . .. | 2026-09-04 00:13:03.261183 | instance -> localhost | +----[SHA256]-----+ 2026-09-04 00:13:03.261251 | instance -> localhost | ok: Runtime: 0:00:00.503542 2026-09-04 00:13:03.268287 | 2026-09-04 00:13:03.268372 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-04 00:13:03.302974 | instance | ok 2026-09-04 00:13:03.314386 | instance | included: /var/lib/zuul/builds/9bdc13a38f63406ebb860b54ce2b8394/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-04 00:13:03.323760 | 2026-09-04 00:13:03.323839 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-04 00:13:03.345406 | instance | skipping: Conditional result was False 2026-09-04 00:13:03.358835 | 2026-09-04 00:13:03.358935 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-04 00:13:03.849963 | instance | changed 2026-09-04 00:13:03.858393 | 2026-09-04 00:13:03.858464 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-04 00:13:04.051296 | instance | ok 2026-09-04 00:13:04.056733 | 2026-09-04 00:13:04.056815 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-04 00:13:04.563253 | instance | changed 2026-09-04 00:13:04.568564 | 2026-09-04 00:13:04.568629 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-04 00:13:05.064417 | instance | changed 2026-09-04 00:13:05.073774 | 2026-09-04 00:13:05.073866 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-04 00:13:05.099704 | instance | skipping: Conditional result was False 2026-09-04 00:13:05.111201 | 2026-09-04 00:13:05.111470 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-04 00:13:05.484746 | instance -> localhost | changed 2026-09-04 00:13:05.502814 | 2026-09-04 00:13:05.502920 | TASK [add-build-sshkey : Add back temp key] 2026-09-04 00:13:05.788620 | instance -> localhost | Identity added: /var/lib/zuul/builds/9bdc13a38f63406ebb860b54ce2b8394/work/9bdc13a38f63406ebb860b54ce2b8394_id_rsa (zuul-build-sshkey) 2026-09-04 00:13:05.788822 | instance -> localhost | ok: Runtime: 0:00:00.014296 2026-09-04 00:13:05.795416 | 2026-09-04 00:13:05.795500 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-04 00:13:06.122766 | instance | ok 2026-09-04 00:13:06.128994 | 2026-09-04 00:13:06.129084 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-04 00:13:06.153721 | instance | skipping: Conditional result was False 2026-09-04 00:13:06.169397 | 2026-09-04 00:13:06.169488 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-09-04 00:13:06.555709 | instance | ok 2026-09-04 00:13:06.562403 | 2026-09-04 00:13:06.562467 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-09-04 00:13:10.745349 | instance | Output suppressed because no_log was given 2026-09-04 00:13:10.756358 | 2026-09-04 00:13:10.756424 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-09-04 00:13:10.966096 | instance | ok: "logs" 2026-09-04 00:13:10.966313 | instance | ok: All items complete 2026-09-04 00:13:10.966342 | 2026-09-04 00:13:11.113484 | instance | ok: "artifacts" 2026-09-04 00:13:11.250685 | instance | ok: "docs" 2026-09-04 00:13:11.276034 | 2026-09-04 00:13:11.276185 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-09-04 00:13:11.471281 | instance | changed: "logs" 2026-09-04 00:13:11.616648 | instance | changed: "artifacts" 2026-09-04 00:13:11.760654 | instance | changed: "docs" 2026-09-04 00:13:11.782654 | 2026-09-04 00:13:11.782717 | PLAY RECAP 2026-09-04 00:13:11.782760 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-09-04 00:13:11.782789 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-04 00:13:11.782812 | 2026-09-04 00:13:11.894249 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-09-04 00:13:11.896497 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-09-04 00:13:12.495905 | 2026-09-04 00:13:12.496022 | PLAY [all] 2026-09-04 00:13:12.507119 | 2026-09-04 00:13:12.507197 | TASK [setup-uv : Extract archive] 2026-09-04 00:13:14.861046 | instance | changed 2026-09-04 00:13:14.866712 | 2026-09-04 00:13:14.866796 | TASK [setup-uv : Print version] 2026-09-04 00:13:15.300126 | instance | uv 0.8.13 2026-09-04 00:13:15.407473 | instance | ok: Runtime: 0:00:00.013917 2026-09-04 00:13:15.419426 | 2026-09-04 00:13:15.419492 | TASK [Install Ansible collection siblings] 2026-09-04 00:13:24.738202 | instance | changed: 2026-09-04 00:13:24.738397 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-09-04 00:13:24.738426 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-09-04 00:13:24.738448 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-09-04 00:13:24.738469 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto 2026-09-04 00:13:24.738491 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general 2026-09-04 00:13:24.738517 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql 2026-09-04 00:13:24.738538 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-09-04 00:13:24.738559 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-09-04 00:13:24.738579 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-09-04 00:13:24.738606 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-09-04 00:13:24.738624 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-09-04 00:13:24.738643 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-09-04 00:13:24.738662 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0 2026-09-04 00:13:24.738680 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0 2026-09-04 00:13:24.738698 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0 2026-09-04 00:13:24.738717 | instance | Resolved community.crypto to 2.2.3 for 2.2.3 2026-09-04 00:13:24.738736 | instance | Resolved community.general to 7.3.0 for 7.3.0 2026-09-04 00:13:24.738754 | instance | Resolved community.mysql to 3.6.0 for 3.6.0 2026-09-04 00:13:24.738773 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0 2026-09-04 00:13:24.738790 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0 2026-09-04 00:13:24.738808 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0 2026-09-04 00:13:24.738826 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0 2026-09-04 00:13:24.738845 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-09-04 00:13:24.738878 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0 2026-09-04 00:13:24.738898 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0 2026-09-04 00:13:24.738917 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-09-04 00:13:24.738935 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-09-04 00:13:24.738952 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-09-04 00:13:24.738970 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0 2026-09-04 00:13:24.738987 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3 2026-09-04 00:13:24.739005 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-09-04 00:13:24.739024 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-09-04 00:13:24.739042 | instance | Checked out ansible.netcommon to 1.2.0 2026-09-04 00:13:24.739060 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-09-04 00:13:24.739085 | instance | Starting galaxy collection install process 2026-09-04 00:13:24.739104 | instance | Process install dependency map 2026-09-04 00:13:24.739122 | instance | Starting collection install process 2026-09-04 00:13:24.739141 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon' 2026-09-04 00:13:24.739159 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon 2026-09-04 00:13:24.739176 | instance | ansible.netcommon:* was installed successfully 2026-09-04 00:13:24.739194 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-09-04 00:13:24.739212 | instance | Creating virtual environment at: .venv 2026-09-04 00:13:24.739229 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-09-04 00:13:24.739247 | instance | Downloading setuptools (1.1MiB) 2026-09-04 00:13:24.739265 | instance | Downloading rjsonnet (1.2MiB) 2026-09-04 00:13:24.739286 | instance | Downloading pydantic-core (2.0MiB) 2026-09-04 00:13:24.739305 | instance | Downloading pygments (1.2MiB) 2026-09-04 00:13:24.739323 | instance | Downloading openstacksdk (1.7MiB) 2026-09-04 00:13:24.739341 | instance | Downloading kubernetes (1.9MiB) 2026-09-04 00:13:24.739359 | instance | Downloading netaddr (2.2MiB) 2026-09-04 00:13:24.739378 | instance | Downloading cryptography (4.2MiB) 2026-09-04 00:13:24.739396 | instance | Downloading ansible-core (2.1MiB) 2026-09-04 00:13:24.739414 | instance | Downloading rjsonnet 2026-09-04 00:13:24.739433 | instance | Building pyperclip==1.9.0 2026-09-04 00:13:24.739452 | instance | Downloading pydantic-core 2026-09-04 00:13:24.739470 | instance | Downloading netaddr 2026-09-04 00:13:24.739488 | instance | Downloading pygments 2026-09-04 00:13:24.739507 | instance | Downloading cryptography 2026-09-04 00:13:24.739525 | instance | Downloading setuptools 2026-09-04 00:13:24.739542 | instance | Downloading kubernetes 2026-09-04 00:13:24.739561 | instance | Downloading ansible-core 2026-09-04 00:13:24.739580 | instance | Downloading openstacksdk 2026-09-04 00:13:24.739598 | instance | Built pyperclip==1.9.0 2026-09-04 00:13:24.739617 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-09-04 00:13:24.739635 | instance | Installed 83 packages in 53ms 2026-09-04 00:13:24.739653 | instance | Checked out ansible.posix to 1.6.0 2026-09-04 00:13:24.739671 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-09-04 00:13:24.739689 | instance | Starting galaxy collection install process 2026-09-04 00:13:24.739707 | instance | Process install dependency map 2026-09-04 00:13:24.739731 | instance | Starting collection install process 2026-09-04 00:13:24.739752 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-09-04 00:13:24.739770 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix 2026-09-04 00:13:24.739789 | instance | ansible.posix:1.6.0 was installed successfully 2026-09-04 00:13:24.739807 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-04 00:13:24.739825 | instance | 2.17.12 2026-09-04 00:13:24.739843 | instance | Checked out ansible.utils to v6.1.0 2026-09-04 00:13:24.739861 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-09-04 00:13:24.739880 | instance | Starting galaxy collection install process 2026-09-04 00:13:24.739898 | instance | Process install dependency map 2026-09-04 00:13:24.739916 | instance | Starting collection install process 2026-09-04 00:13:24.739935 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils' 2026-09-04 00:13:24.739953 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils 2026-09-04 00:13:24.739972 | instance | ansible.utils:6.1.0 was installed successfully 2026-09-04 00:13:24.739990 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-04 00:13:24.740008 | instance | 2.17.12 2026-09-04 00:13:24.740027 | instance | Checked out atmosphere.common to v0.7.0 2026-09-04 00:13:24.740045 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-09-04 00:13:24.740063 | instance | Starting galaxy collection install process 2026-09-04 00:13:24.740081 | instance | Process install dependency map 2026-09-04 00:13:24.740099 | instance | Starting collection install process 2026-09-04 00:13:24.740117 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common' 2026-09-04 00:13:24.740135 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common 2026-09-04 00:13:24.740153 | instance | atmosphere.common:0.7.0 was installed successfully 2026-09-04 00:13:24.740171 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-04 00:13:24.740189 | instance | 2.17.12 2026-09-04 00:13:24.740207 | instance | Checked out community.crypto to 2.2.3 2026-09-04 00:13:24.740225 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.crypto 2026-09-04 00:13:24.740243 | instance | Starting galaxy collection install process 2026-09-04 00:13:24.740261 | instance | Process install dependency map 2026-09-04 00:13:24.740279 | instance | Starting collection install process 2026-09-04 00:13:24.740296 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-09-04 00:13:24.740314 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto 2026-09-04 00:13:24.740333 | instance | community.crypto:2.2.3 was installed successfully 2026-09-04 00:13:24.740350 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-04 00:13:24.740368 | instance | 2.17.12 2026-09-04 00:13:24.740386 | instance | Checked out community.general to 7.3.0 2026-09-04 00:13:24.740404 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.general 2026-09-04 00:13:24.740428 | instance | Starting galaxy collection install process 2026-09-04 00:13:24.740446 | instance | Process install dependency map 2026-09-04 00:13:24.740464 | instance | Starting collection install process 2026-09-04 00:13:24.740482 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-09-04 00:13:24.740500 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general 2026-09-04 00:13:24.740518 | instance | community.general:7.3.0 was installed successfully 2026-09-04 00:13:24.740537 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-04 00:13:24.740555 | instance | 2.17.12 2026-09-04 00:13:24.740573 | instance | Checked out community.mysql to 3.6.0 2026-09-04 00:13:24.740593 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.mysql 2026-09-04 00:13:24.740612 | instance | Starting galaxy collection install process 2026-09-04 00:13:24.740630 | instance | Process install dependency map 2026-09-04 00:13:24.740648 | instance | Starting collection install process 2026-09-04 00:13:24.740665 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql' 2026-09-04 00:13:24.740683 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql 2026-09-04 00:13:24.740701 | instance | community.mysql:3.6.0 was installed successfully 2026-09-04 00:13:24.740719 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-04 00:13:24.740736 | instance | 2.17.12 2026-09-04 00:13:24.740754 | instance | Checked out kubernetes.core to 2.4.0 2026-09-04 00:13:24.740772 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-09-04 00:13:24.740790 | instance | Starting galaxy collection install process 2026-09-04 00:13:24.740808 | instance | Process install dependency map 2026-09-04 00:13:24.740825 | instance | Starting collection install process 2026-09-04 00:13:24.740843 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core' 2026-09-04 00:13:24.740861 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core 2026-09-04 00:13:24.740879 | instance | kubernetes.core:2.4.0 was installed successfully 2026-09-04 00:13:24.740896 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-04 00:13:24.740914 | instance | 2.17.12 2026-09-04 00:13:24.740931 | instance | Checked out openstack.cloud to 2.6.0 2026-09-04 00:13:24.740966 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-09-04 00:13:24.740989 | instance | Starting galaxy collection install process 2026-09-04 00:13:24.741008 | instance | Process install dependency map 2026-09-04 00:13:24.741026 | instance | Starting collection install process 2026-09-04 00:13:24.741044 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud' 2026-09-04 00:13:24.741062 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud 2026-09-04 00:13:24.741080 | instance | openstack.cloud:2.6.0 was installed successfully 2026-09-04 00:13:24.741098 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-04 00:13:24.741116 | instance | 2.17.12 2026-09-04 00:13:24.741139 | instance | Checked out vexxhost.ceph to v4.2.0 2026-09-04 00:13:24.741158 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-09-04 00:13:24.741176 | instance | Starting galaxy collection install process 2026-09-04 00:13:24.741194 | instance | Process install dependency map 2026-09-04 00:13:24.741211 | instance | Starting collection install process 2026-09-04 00:13:24.741229 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph' 2026-09-04 00:13:24.741247 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph 2026-09-04 00:13:24.741265 | instance | vexxhost.ceph:4.2.0 was installed successfully 2026-09-04 00:13:24.741283 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-04 00:13:24.741301 | instance | 2.17.12 2026-09-04 00:13:24.741318 | instance | Checked out vexxhost.containers to v1.6.8 2026-09-04 00:13:24.741369 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-09-04 00:13:24.741398 | instance | Starting galaxy collection install process 2026-09-04 00:13:24.741417 | instance | Process install dependency map 2026-09-04 00:13:24.741435 | instance | Starting collection install process 2026-09-04 00:13:24.741457 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers' 2026-09-04 00:13:24.741475 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers 2026-09-04 00:13:24.741494 | instance | vexxhost.containers:1.6.8 was installed successfully 2026-09-04 00:13:24.741513 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-04 00:13:24.741531 | instance | 2.17.12 2026-09-04 00:13:24.741549 | instance | Checked out vexxhost.kubernetes to v3.3.0 2026-09-04 00:13:24.741567 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-09-04 00:13:24.741585 | instance | Starting galaxy collection install process 2026-09-04 00:13:24.741603 | instance | Process install dependency map 2026-09-04 00:13:24.741621 | instance | Starting collection install process 2026-09-04 00:13:24.741638 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes' 2026-09-04 00:13:24.741656 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes 2026-09-04 00:13:24.741674 | instance | vexxhost.kubernetes:3.3.0 was installed successfully 2026-09-04 00:13:24.741692 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-04 00:13:24.741710 | instance | 2.17.12 2026-09-04 00:13:24.747673 | 2026-09-04 00:13:24.747724 | PLAY RECAP 2026-09-04 00:13:24.747769 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-04 00:13:24.747791 | 2026-09-04 00:13:24.871565 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-09-04 00:13:24.874311 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-09-04 00:13:25.442522 | 2026-09-04 00:13:25.442925 | PLAY [all] 2026-09-04 00:13:25.453572 | 2026-09-04 00:13:25.453640 | TASK [Install "jq" for log collection] 2026-09-04 00:13:35.128772 | instance | changed 2026-09-04 00:13:35.131025 | 2026-09-04 00:13:35.131089 | PLAY RECAP 2026-09-04 00:13:35.131145 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-04 00:13:35.131218 | 2026-09-04 00:13:35.287073 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-09-04 00:13:35.291295 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-09-04 00:13:35.907999 | 2026-09-04 00:13:35.908174 | PLAY [all] 2026-09-04 00:13:35.919677 | 2026-09-04 00:13:35.919772 | LOOP [Check inventory directories] 2026-09-04 00:13:36.267541 | instance | ok: "src/github.com/vexxhost/atmosphere" 2026-09-04 00:13:36.433459 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory" 2026-09-04 00:13:36.605553 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory" 2026-09-04 00:13:36.628088 | 2026-09-04 00:13:36.628318 | LOOP [Copy inventory file for Zuul] 2026-09-04 00:13:37.472236 | instance | changed: 2026-09-04 00:13:37.472544 | instance | { 2026-09-04 00:13:37.472585 | instance | "ansible_loop_var": "item", 2026-09-04 00:13:37.472625 | instance | "changed": false, 2026-09-04 00:13:37.472663 | instance | "failed": false, 2026-09-04 00:13:37.472701 | instance | "invocation": { 2026-09-04 00:13:37.472729 | instance | "module_args": { 2026-09-04 00:13:37.472757 | instance | "checksum_algorithm": "sha1", 2026-09-04 00:13:37.472782 | instance | "follow": true, 2026-09-04 00:13:37.472808 | instance | "get_attributes": true, 2026-09-04 00:13:37.472834 | instance | "get_checksum": true, 2026-09-04 00:13:37.472861 | instance | "get_mime": true, 2026-09-04 00:13:37.472907 | instance | "path": "src/github.com/vexxhost/atmosphere" 2026-09-04 00:13:37.472988 | instance | } 2026-09-04 00:13:37.473027 | instance | }, 2026-09-04 00:13:37.473059 | instance | "item": "src/github.com/vexxhost/atmosphere", 2026-09-04 00:13:37.473085 | instance | "stat": { 2026-09-04 00:13:37.473110 | instance | "atime": 1788480798.0740502, 2026-09-04 00:13:37.473136 | instance | "attr_flags": "e", 2026-09-04 00:13:37.473160 | instance | "attributes": [ 2026-09-04 00:13:37.473184 | instance | "extents" 2026-09-04 00:13:37.473208 | instance | ], 2026-09-04 00:13:37.473231 | instance | "block_size": 4096, 2026-09-04 00:13:37.473254 | instance | "blocks": 8, 2026-09-04 00:13:37.473277 | instance | "charset": "unknown", 2026-09-04 00:13:37.473303 | instance | "ctime": 1788480796.3819973, 2026-09-04 00:13:37.473327 | instance | "dev": 64513, 2026-09-04 00:13:37.473351 | instance | "device_type": 0, 2026-09-04 00:13:37.473374 | instance | "executable": true, 2026-09-04 00:13:37.473398 | instance | "exists": true, 2026-09-04 00:13:37.473421 | instance | "gid": 1000, 2026-09-04 00:13:37.473445 | instance | "gr_name": "zuul", 2026-09-04 00:13:37.473468 | instance | "inode": 1048354, 2026-09-04 00:13:37.473492 | instance | "isblk": false, 2026-09-04 00:13:37.473529 | instance | "ischr": false, 2026-09-04 00:13:37.473554 | instance | "isdir": true, 2026-09-04 00:13:37.473583 | instance | "isfifo": false, 2026-09-04 00:13:37.473607 | instance | "isgid": false, 2026-09-04 00:13:37.473631 | instance | "islnk": false, 2026-09-04 00:13:37.473654 | instance | "isreg": false, 2026-09-04 00:13:37.473677 | instance | "issock": false, 2026-09-04 00:13:37.473701 | instance | "isuid": false, 2026-09-04 00:13:37.473724 | instance | "mimetype": "unknown", 2026-09-04 00:13:37.473747 | instance | "mode": "0755", 2026-09-04 00:13:37.473777 | instance | "mtime": 1788480796.3819973, 2026-09-04 00:13:37.473800 | instance | "nlink": 23, 2026-09-04 00:13:37.473823 | instance | "path": "src/github.com/vexxhost/atmosphere", 2026-09-04 00:13:37.473847 | instance | "pw_name": "zuul", 2026-09-04 00:13:37.473877 | instance | "readable": true, 2026-09-04 00:13:37.473902 | instance | "rgrp": true, 2026-09-04 00:13:37.473933 | instance | "roth": true, 2026-09-04 00:13:37.473978 | instance | "rusr": true, 2026-09-04 00:13:37.474009 | instance | "size": 4096, 2026-09-04 00:13:37.474033 | instance | "uid": 1000, 2026-09-04 00:13:37.474057 | instance | "version": "4076065952", 2026-09-04 00:13:37.474082 | instance | "wgrp": false, 2026-09-04 00:13:37.474107 | instance | "woth": false, 2026-09-04 00:13:37.474131 | instance | "writeable": true, 2026-09-04 00:13:37.474155 | instance | "wusr": true, 2026-09-04 00:13:37.474178 | instance | "xgrp": true, 2026-09-04 00:13:37.474201 | instance | "xoth": true, 2026-09-04 00:13:37.474225 | instance | "xusr": true 2026-09-04 00:13:37.474248 | instance | } 2026-09-04 00:13:37.474280 | instance | } 2026-09-04 00:13:37.474331 | instance | ok: All items complete 2026-09-04 00:13:37.474362 | 2026-09-04 00:13:37.476293 | instance | skipping: Conditional result was False 2026-09-04 00:13:37.477260 | instance | skipping: Conditional result was False 2026-09-04 00:13:37.487026 | 2026-09-04 00:13:37.487233 | LOOP [Switch "ansible_host" to private IP] 2026-09-04 00:13:37.840538 | instance | changed: 1 replacements made 2026-09-04 00:13:37.841876 | instance | skipping: Conditional result was False 2026-09-04 00:13:37.844714 | instance | skipping: Conditional result was False 2026-09-04 00:13:37.865176 | 2026-09-04 00:13:37.865342 | TASK [Run Molecule scenario] 2026-09-04 00:13:38.861233 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-09-04 00:13:39.289117 | instance | INFO [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-09-04 00:13:39.289169 | instance | INFO [csi > prerun] Performing prerun with role_name_check=0... 2026-09-04 00:13:50.171698 | instance | INFO [csi > dependency] Executing 2026-09-04 00:13:50.172195 | instance | WARNING [csi > dependency] Missing roles requirements file: requirements.yml 2026-09-04 00:13:50.172624 | instance | WARNING [csi > dependency] Missing collections requirements file: collections.yml 2026-09-04 00:13:50.172909 | instance | WARNING [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-09-04 00:13:50.187047 | instance | INFO [csi > cleanup] Executing 2026-09-04 00:13:50.187780 | instance | WARNING [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-09-04 00:13:50.201737 | instance | INFO [csi > destroy] Executing 2026-09-04 00:13:50.201924 | instance | WARNING [csi > destroy] Skipping, '--destroy=never' requested. 2026-09-04 00:13:50.202096 | instance | INFO [csi > destroy] Executed: Successful 2026-09-04 00:13:50.211316 | instance | INFO [csi > syntax] Executing 2026-09-04 00:13:51.657691 | instance | 2026-09-04 00:13:51.658012 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-09-04 00:13:51.725406 | instance | INFO [csi > syntax] Executed: Successful 2026-09-04 00:13:51.740503 | instance | INFO [csi > create] Executing 2026-09-04 00:13:51.744298 | instance | WARNING [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-09-04 00:13:51.758186 | instance | INFO [csi > prepare] Executing 2026-09-04 00:13:52.520206 | instance | 2026-09-04 00:13:52.520363 | instance | PLAY [Prepare] ***************************************************************** 2026-09-04 00:13:52.520628 | instance | 2026-09-04 00:13:52.520878 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-04 00:13:52.521109 | instance | Friday 04 September 2026 00:13:52 +0000 (0:00:00.023) 0:00:00.023 ****** 2026-09-04 00:13:53.768028 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-09-04 00:13:53.768259 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-09-04 00:13:53.768502 | instance | interpreter could change the meaning of that path. See 2026-09-04 00:13:53.768752 | instance | https://docs.ansible.com/ansible- 2026-09-04 00:13:53.768991 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-09-04 00:13:53.779364 | instance | ok: [instance] 2026-09-04 00:13:53.779576 | instance | 2026-09-04 00:13:53.779831 | instance | TASK [Configure short hostname] ************************************************ 2026-09-04 00:13:53.780069 | instance | Friday 04 September 2026 00:13:53 +0000 (0:00:01.259) 0:00:01.283 ****** 2026-09-04 00:13:54.523832 | instance | changed: [instance] 2026-09-04 00:13:54.524046 | instance | 2026-09-04 00:13:54.524286 | instance | TASK [Ensure hostname inside hosts file] *************************************** 2026-09-04 00:13:54.524522 | instance | Friday 04 September 2026 00:13:54 +0000 (0:00:00.743) 0:00:02.026 ****** 2026-09-04 00:13:54.836491 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created 2026-09-04 00:13:54.836572 | instance | with a mode of 0700, this may cause issues when running as another user. To 2026-09-04 00:13:54.836769 | instance | avoid this, create the remote_tmp dir with the correct permissions manually 2026-09-04 00:13:54.847579 | instance | changed: [instance] 2026-09-04 00:13:54.847819 | instance | 2026-09-04 00:13:54.848058 | instance | TASK [Purge "snapd" package] *************************************************** 2026-09-04 00:13:54.848289 | instance | Friday 04 September 2026 00:13:54 +0000 (0:00:00.323) 0:00:02.350 ****** 2026-09-04 00:13:55.598978 | instance | ok: [instance] 2026-09-04 00:13:55.599170 | instance | 2026-09-04 00:13:55.599482 | instance | PLAY [Create devices for Ceph] ************************************************* 2026-09-04 00:13:55.599716 | instance | 2026-09-04 00:13:55.599945 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-04 00:13:55.600172 | instance | Friday 04 September 2026 00:13:55 +0000 (0:00:00.751) 0:00:03.102 ****** 2026-09-04 00:13:56.362209 | instance | ok: [instance] 2026-09-04 00:13:56.362393 | instance | 2026-09-04 00:13:56.362630 | instance | TASK [Install depedencies] ***************************************************** 2026-09-04 00:13:56.362892 | instance | Friday 04 September 2026 00:13:56 +0000 (0:00:00.762) 0:00:03.865 ****** 2026-09-04 00:14:19.910995 | instance | changed: [instance] 2026-09-04 00:14:19.911230 | instance | 2026-09-04 00:14:19.911495 | instance | TASK [Start up service] ******************************************************** 2026-09-04 00:14:19.911730 | instance | Friday 04 September 2026 00:14:19 +0000 (0:00:23.549) 0:00:27.414 ****** 2026-09-04 00:14:20.466938 | instance | ok: [instance] 2026-09-04 00:14:20.467137 | instance | 2026-09-04 00:14:20.467432 | instance | TASK [Generate lvm.conf] ******************************************************* 2026-09-04 00:14:20.467670 | instance | Friday 04 September 2026 00:14:20 +0000 (0:00:00.555) 0:00:27.970 ****** 2026-09-04 00:14:20.793171 | instance | ok: [instance] 2026-09-04 00:14:20.793424 | instance | 2026-09-04 00:14:20.793674 | instance | TASK [Write /etc/lvm/lvm.conf] ************************************************* 2026-09-04 00:14:20.793919 | instance | Friday 04 September 2026 00:14:20 +0000 (0:00:00.326) 0:00:28.296 ****** 2026-09-04 00:14:21.487574 | instance | changed: [instance] 2026-09-04 00:14:21.488354 | instance | 2026-09-04 00:14:21.488408 | instance | TASK [Get list of all loopback devices] **************************************** 2026-09-04 00:14:21.488421 | instance | Friday 04 September 2026 00:14:21 +0000 (0:00:00.694) 0:00:28.991 ****** 2026-09-04 00:14:21.684683 | instance | ok: [instance] 2026-09-04 00:14:21.684742 | instance | 2026-09-04 00:14:21.685048 | instance | TASK [Fail if there is any existing loopback devices] ************************** 2026-09-04 00:14:21.685085 | instance | Friday 04 September 2026 00:14:21 +0000 (0:00:00.197) 0:00:29.188 ****** 2026-09-04 00:14:21.708511 | instance | skipping: [instance] 2026-09-04 00:14:21.709297 | instance | 2026-09-04 00:14:21.709334 | instance | TASK [Create devices for Ceph] ************************************************* 2026-09-04 00:14:21.709346 | instance | Friday 04 September 2026 00:14:21 +0000 (0:00:00.023) 0:00:29.212 ****** 2026-09-04 00:14:22.272870 | instance | changed: [instance] => (item=osd0) 2026-09-04 00:14:22.274518 | instance | changed: [instance] => (item=osd1) 2026-09-04 00:14:22.274550 | instance | changed: [instance] => (item=osd2) 2026-09-04 00:14:22.274579 | instance | 2026-09-04 00:14:22.274590 | instance | TASK [Set permissions on loopback devices] ************************************* 2026-09-04 00:14:22.274600 | instance | Friday 04 September 2026 00:14:22 +0000 (0:00:00.563) 0:00:29.775 ****** 2026-09-04 00:14:22.942709 | instance | changed: [instance] => (item=osd0) 2026-09-04 00:14:22.942910 | instance | changed: [instance] => (item=osd1) 2026-09-04 00:14:22.943298 | instance | changed: [instance] => (item=osd2) 2026-09-04 00:14:22.943907 | instance | 2026-09-04 00:14:22.943941 | instance | TASK [Start loop devices] ****************************************************** 2026-09-04 00:14:22.943953 | instance | Friday 04 September 2026 00:14:22 +0000 (0:00:00.670) 0:00:30.446 ****** 2026-09-04 00:14:23.694801 | instance | changed: [instance] => (item=osd0) 2026-09-04 00:14:23.695099 | instance | changed: [instance] => (item=osd1) 2026-09-04 00:14:23.695503 | instance | changed: [instance] => (item=osd2) 2026-09-04 00:14:23.695796 | instance | 2026-09-04 00:14:23.696098 | instance | TASK [Create a volume group for each loop device] ****************************** 2026-09-04 00:14:23.696422 | instance | Friday 04 September 2026 00:14:23 +0000 (0:00:00.752) 0:00:31.198 ****** 2026-09-04 00:14:26.808446 | instance | changed: [instance] => (item=osd0) 2026-09-04 00:14:26.809625 | instance | changed: [instance] => (item=osd1) 2026-09-04 00:14:26.809682 | instance | changed: [instance] => (item=osd2) 2026-09-04 00:14:26.809695 | instance | 2026-09-04 00:14:26.809705 | instance | TASK [Create a logical volume for each loop device] **************************** 2026-09-04 00:14:26.809715 | instance | Friday 04 September 2026 00:14:26 +0000 (0:00:03.113) 0:00:34.311 ****** 2026-09-04 00:14:28.755347 | instance | changed: [instance] => (item=ceph-instance-osd0) 2026-09-04 00:14:28.755426 | instance | changed: [instance] => (item=ceph-instance-osd1) 2026-09-04 00:14:28.755460 | instance | changed: [instance] => (item=ceph-instance-osd2) 2026-09-04 00:14:28.755471 | instance | 2026-09-04 00:14:28.755481 | instance | PLAY RECAP ********************************************************************* 2026-09-04 00:14:28.755492 | instance | instance : ok=15 changed=9 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-09-04 00:14:28.755502 | instance | 2026-09-04 00:14:28.755511 | instance | Friday 04 September 2026 00:14:28 +0000 (0:00:01.945) 0:00:36.257 ****** 2026-09-04 00:14:28.755528 | instance | =============================================================================== 2026-09-04 00:14:28.755540 | instance | Install depedencies ---------------------------------------------------- 23.55s 2026-09-04 00:14:28.759076 | instance | Create a volume group for each loop device ------------------------------ 3.11s 2026-09-04 00:14:28.759154 | instance | Create a logical volume for each loop device ---------------------------- 1.95s 2026-09-04 00:14:28.759168 | instance | Gathering Facts --------------------------------------------------------- 1.26s 2026-09-04 00:14:28.759177 | instance | Gathering Facts --------------------------------------------------------- 0.76s 2026-09-04 00:14:28.759186 | instance | Start loop devices ------------------------------------------------------ 0.75s 2026-09-04 00:14:28.759216 | instance | Purge "snapd" package --------------------------------------------------- 0.75s 2026-09-04 00:14:28.759227 | instance | Configure short hostname ------------------------------------------------ 0.74s 2026-09-04 00:14:28.759236 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.69s 2026-09-04 00:14:28.759245 | instance | Set permissions on loopback devices ------------------------------------- 0.67s 2026-09-04 00:14:28.759254 | instance | Create devices for Ceph ------------------------------------------------- 0.56s 2026-09-04 00:14:28.759263 | instance | Start up service -------------------------------------------------------- 0.56s 2026-09-04 00:14:28.759272 | instance | Generate lvm.conf ------------------------------------------------------- 0.33s 2026-09-04 00:14:28.759281 | instance | Ensure hostname inside hosts file --------------------------------------- 0.32s 2026-09-04 00:14:28.759290 | instance | Get list of all loopback devices ---------------------------------------- 0.20s 2026-09-04 00:14:28.759299 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s 2026-09-04 00:14:28.837007 | instance | INFO [csi > prepare] Executed: Successful 2026-09-04 00:14:28.851155 | instance | INFO [csi > converge] Executing 2026-09-04 00:14:30.327506 | instance | 2026-09-04 00:14:30.327937 | instance | PLAY [Debug CSI driver value] ************************************************** 2026-09-04 00:14:30.328291 | instance | 2026-09-04 00:14:30.328712 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-04 00:14:30.329046 | instance | Friday 04 September 2026 00:14:30 +0000 (0:00:00.008) 0:00:00.008 ****** 2026-09-04 00:14:31.383996 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-09-04 00:14:31.384446 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-09-04 00:14:31.384796 | instance | interpreter could change the meaning of that path. See 2026-09-04 00:14:31.385143 | instance | https://docs.ansible.com/ansible- 2026-09-04 00:14:31.385464 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-09-04 00:14:31.399723 | instance | ok: [instance] 2026-09-04 00:14:31.400061 | instance | 2026-09-04 00:14:31.400422 | instance | TASK [Display CSI driver value and environment variable] *********************** 2026-09-04 00:14:31.400732 | instance | Friday 04 September 2026 00:14:31 +0000 (0:00:01.072) 0:00:01.080 ****** 2026-09-04 00:14:31.476058 | instance | ok: [instance] => { 2026-09-04 00:14:31.476444 | instance | "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER=" 2026-09-04 00:14:31.476754 | instance | } 2026-09-04 00:14:31.477062 | instance | 2026-09-04 00:14:31.477397 | instance | PLAY [all] ********************************************************************* 2026-09-04 00:14:31.477689 | instance | 2026-09-04 00:14:31.478025 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-04 00:14:31.478402 | instance | Friday 04 September 2026 00:14:31 +0000 (0:00:00.076) 0:00:01.156 ****** 2026-09-04 00:14:32.463413 | instance | ok: [instance] 2026-09-04 00:14:32.463795 | instance | 2026-09-04 00:14:32.464159 | instance | TASK [Fail if atmosphere_ceph_enabled is set] ********************************** 2026-09-04 00:14:32.464509 | instance | Friday 04 September 2026 00:14:32 +0000 (0:00:00.986) 0:00:02.143 ****** 2026-09-04 00:14:32.517494 | instance | skipping: [instance] 2026-09-04 00:14:32.517850 | instance | 2026-09-04 00:14:32.518216 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-09-04 00:14:32.518539 | instance | Friday 04 September 2026 00:14:32 +0000 (0:00:00.054) 0:00:02.198 ****** 2026-09-04 00:14:32.738155 | instance | ok: [instance] 2026-09-04 00:14:32.738560 | instance | 2026-09-04 00:14:32.738884 | instance | PLAY [Deploy Ceph monitors & managers] ***************************************** 2026-09-04 00:14:32.739237 | instance | 2026-09-04 00:14:32.739547 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-04 00:14:32.739864 | instance | Friday 04 September 2026 00:14:32 +0000 (0:00:00.220) 0:00:02.418 ****** 2026-09-04 00:14:33.739766 | instance | ok: [instance] 2026-09-04 00:14:33.740157 | instance | 2026-09-04 00:14:33.740468 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-09-04 00:14:33.740790 | instance | Friday 04 September 2026 00:14:33 +0000 (0:00:01.000) 0:00:03.419 ****** 2026-09-04 00:14:34.124091 | instance | ok: [instance] 2026-09-04 00:14:34.124284 | instance | 2026-09-04 00:14:34.124651 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-09-04 00:14:34.124956 | instance | Friday 04 September 2026 00:14:34 +0000 (0:00:00.383) 0:00:03.802 ****** 2026-09-04 00:14:34.196473 | instance | skipping: [instance] 2026-09-04 00:14:34.196984 | instance | 2026-09-04 00:14:34.197469 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-09-04 00:14:34.197943 | instance | Friday 04 September 2026 00:14:34 +0000 (0:00:00.071) 0:00:03.874 ****** 2026-09-04 00:14:34.624383 | instance | changed: [instance] 2026-09-04 00:14:34.624469 | instance | 2026-09-04 00:14:34.624481 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-09-04 00:14:34.624715 | instance | Friday 04 September 2026 00:14:34 +0000 (0:00:00.427) 0:00:04.301 ****** 2026-09-04 00:14:34.720009 | instance | ok: [instance] => { 2026-09-04 00:14:34.720255 | instance | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-09-04 00:14:34.720617 | instance | } 2026-09-04 00:14:34.720908 | instance | 2026-09-04 00:14:34.721303 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-09-04 00:14:34.721610 | instance | Friday 04 September 2026 00:14:34 +0000 (0:00:00.096) 0:00:04.398 ****** 2026-09-04 00:14:35.520132 | instance | changed: [instance] 2026-09-04 00:14:35.520483 | instance | 2026-09-04 00:14:35.520800 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-09-04 00:14:35.521126 | instance | Friday 04 September 2026 00:14:35 +0000 (0:00:00.801) 0:00:05.199 ****** 2026-09-04 00:14:35.567655 | instance | skipping: [instance] 2026-09-04 00:14:35.567834 | instance | 2026-09-04 00:14:35.567994 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-09-04 00:14:35.568171 | instance | Friday 04 September 2026 00:14:35 +0000 (0:00:00.047) 0:00:05.246 ****** 2026-09-04 00:14:35.607413 | instance | skipping: [instance] 2026-09-04 00:14:35.607494 | instance | 2026-09-04 00:14:35.607506 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-09-04 00:14:35.607516 | instance | Friday 04 September 2026 00:14:35 +0000 (0:00:00.041) 0:00:05.288 ****** 2026-09-04 00:14:35.815767 | instance | ok: [instance] 2026-09-04 00:14:35.815845 | instance | 2026-09-04 00:14:35.815909 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-09-04 00:14:35.816045 | instance | Friday 04 September 2026 00:14:35 +0000 (0:00:00.208) 0:00:05.497 ****** 2026-09-04 00:14:37.269721 | instance | ok: [instance] 2026-09-04 00:14:37.269914 | instance | 2026-09-04 00:14:37.270226 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-09-04 00:14:37.270473 | instance | Friday 04 September 2026 00:14:37 +0000 (0:00:01.452) 0:00:06.949 ****** 2026-09-04 00:14:37.360185 | instance | ok: [instance] => { 2026-09-04 00:14:37.360344 | instance | "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz" 2026-09-04 00:14:37.360564 | instance | } 2026-09-04 00:14:37.360778 | instance | 2026-09-04 00:14:37.361028 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-09-04 00:14:37.361262 | instance | Friday 04 September 2026 00:14:37 +0000 (0:00:00.090) 0:00:07.040 ****** 2026-09-04 00:14:38.218897 | instance | changed: [instance] 2026-09-04 00:14:38.219082 | instance | 2026-09-04 00:14:38.219351 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-09-04 00:14:38.219584 | instance | Friday 04 September 2026 00:14:38 +0000 (0:00:00.858) 0:00:07.899 ****** 2026-09-04 00:14:41.135597 | instance | changed: [instance] 2026-09-04 00:14:41.135678 | instance | 2026-09-04 00:14:41.135748 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-09-04 00:14:41.135869 | instance | Friday 04 September 2026 00:14:41 +0000 (0:00:02.917) 0:00:10.816 ****** 2026-09-04 00:14:41.177991 | instance | skipping: [instance] 2026-09-04 00:14:41.179122 | instance | 2026-09-04 00:14:41.179176 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-09-04 00:14:41.179188 | instance | Friday 04 September 2026 00:14:41 +0000 (0:00:00.041) 0:00:10.858 ****** 2026-09-04 00:14:41.220250 | instance | skipping: [instance] 2026-09-04 00:14:41.220304 | instance | 2026-09-04 00:14:41.220316 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-09-04 00:14:41.220326 | instance | Friday 04 September 2026 00:14:41 +0000 (0:00:00.041) 0:00:10.899 ****** 2026-09-04 00:14:41.261353 | instance | skipping: [instance] 2026-09-04 00:14:41.261475 | instance | 2026-09-04 00:14:41.261713 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-09-04 00:14:41.261922 | instance | Friday 04 September 2026 00:14:41 +0000 (0:00:00.042) 0:00:10.942 ****** 2026-09-04 00:14:47.355700 | instance | changed: [instance] 2026-09-04 00:14:47.355924 | instance | 2026-09-04 00:14:47.356522 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] *** 2026-09-04 00:14:47.356577 | instance | Friday 04 September 2026 00:14:47 +0000 (0:00:06.093) 0:00:17.036 ****** 2026-09-04 00:14:48.011212 | instance | changed: [instance] 2026-09-04 00:14:48.012050 | instance | 2026-09-04 00:14:48.012126 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] ******* 2026-09-04 00:14:48.012139 | instance | Friday 04 September 2026 00:14:48 +0000 (0:00:00.655) 0:00:17.691 ****** 2026-09-04 00:14:49.021467 | instance | changed: [instance] => (item={'path': '/etc/containerd'}) 2026-09-04 00:14:49.023301 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'}) 2026-09-04 00:14:49.023366 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'}) 2026-09-04 00:14:49.023382 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'}) 2026-09-04 00:14:49.023391 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'}) 2026-09-04 00:14:49.023397 | instance | 2026-09-04 00:14:49.023405 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] ********** 2026-09-04 00:14:49.023416 | instance | Friday 04 September 2026 00:14:49 +0000 (0:00:01.010) 0:00:18.701 ****** 2026-09-04 00:14:49.659355 | instance | changed: [instance] 2026-09-04 00:14:49.659426 | instance | 2026-09-04 00:14:49.659973 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ******** 2026-09-04 00:14:49.660016 | instance | Friday 04 September 2026 00:14:49 +0000 (0:00:00.620) 0:00:19.322 ****** 2026-09-04 00:14:49.660021 | instance | 2026-09-04 00:14:49.660026 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-09-04 00:14:49.660030 | instance | Friday 04 September 2026 00:14:49 +0000 (0:00:00.017) 0:00:19.340 ****** 2026-09-04 00:14:50.762487 | instance | ok: [instance] 2026-09-04 00:14:50.762557 | instance | 2026-09-04 00:14:50.762687 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] ********** 2026-09-04 00:14:50.762854 | instance | Friday 04 September 2026 00:14:50 +0000 (0:00:01.103) 0:00:20.443 ****** 2026-09-04 00:14:51.252256 | instance | changed: [instance] 2026-09-04 00:14:51.253004 | instance | 2026-09-04 00:14:51.253081 | instance | TASK [vexxhost.containers.containerd : Enable and start service] *************** 2026-09-04 00:14:51.253094 | instance | Friday 04 September 2026 00:14:51 +0000 (0:00:00.488) 0:00:20.932 ****** 2026-09-04 00:14:51.876269 | instance | changed: [instance] 2026-09-04 00:14:51.876330 | instance | 2026-09-04 00:14:51.876342 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-09-04 00:14:51.876352 | instance | Friday 04 September 2026 00:14:51 +0000 (0:00:00.623) 0:00:21.555 ****** 2026-09-04 00:14:52.109523 | instance | ok: [instance] 2026-09-04 00:14:52.109588 | instance | 2026-09-04 00:14:52.109844 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-09-04 00:14:52.109883 | instance | Friday 04 September 2026 00:14:52 +0000 (0:00:00.234) 0:00:21.790 ****** 2026-09-04 00:14:52.180759 | instance | ok: [instance] => { 2026-09-04 00:14:52.181444 | instance | "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz" 2026-09-04 00:14:52.181468 | instance | } 2026-09-04 00:14:52.181476 | instance | 2026-09-04 00:14:52.181484 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-09-04 00:14:52.181490 | instance | Friday 04 September 2026 00:14:52 +0000 (0:00:00.071) 0:00:21.861 ****** 2026-09-04 00:16:13.078977 | instance | changed: [instance] 2026-09-04 00:16:13.079282 | instance | 2026-09-04 00:16:13.079739 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-09-04 00:16:13.079775 | instance | Friday 04 September 2026 00:16:13 +0000 (0:01:20.897) 0:01:42.759 ****** 2026-09-04 00:16:17.520283 | instance | changed: [instance] 2026-09-04 00:16:17.520344 | instance | 2026-09-04 00:16:17.520356 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ****************** 2026-09-04 00:16:17.520368 | instance | Friday 04 September 2026 00:16:17 +0000 (0:00:04.440) 0:01:47.199 ****** 2026-09-04 00:16:18.585444 | instance | ok: [instance] 2026-09-04 00:16:18.586140 | instance | 2026-09-04 00:16:18.586172 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] *************** 2026-09-04 00:16:18.586184 | instance | Friday 04 September 2026 00:16:18 +0000 (0:00:01.066) 0:01:48.266 ****** 2026-09-04 00:16:18.977056 | instance | changed: [instance] 2026-09-04 00:16:18.978029 | instance | 2026-09-04 00:16:18.978085 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] ***** 2026-09-04 00:16:18.978097 | instance | Friday 04 September 2026 00:16:18 +0000 (0:00:00.391) 0:01:48.657 ****** 2026-09-04 00:16:19.450007 | instance | changed: [instance] 2026-09-04 00:16:19.450079 | instance | 2026-09-04 00:16:19.450348 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] *********** 2026-09-04 00:16:19.450593 | instance | Friday 04 September 2026 00:16:19 +0000 (0:00:00.473) 0:01:49.131 ****** 2026-09-04 00:16:20.077259 | instance | changed: [instance] => (item={'path': '/etc/docker'}) 2026-09-04 00:16:20.078503 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'}) 2026-09-04 00:16:20.078587 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'}) 2026-09-04 00:16:20.078600 | instance | 2026-09-04 00:16:20.078611 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ****** 2026-09-04 00:16:20.078621 | instance | Friday 04 September 2026 00:16:20 +0000 (0:00:00.625) 0:01:49.757 ****** 2026-09-04 00:16:20.597504 | instance | changed: [instance] 2026-09-04 00:16:20.598264 | instance | 2026-09-04 00:16:20.598296 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] *********** 2026-09-04 00:16:20.598308 | instance | Friday 04 September 2026 00:16:20 +0000 (0:00:00.520) 0:01:50.277 ****** 2026-09-04 00:16:21.151879 | instance | changed: [instance] 2026-09-04 00:16:21.152852 | instance | 2026-09-04 00:16:21.152874 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************ 2026-09-04 00:16:21.152897 | instance | Friday 04 September 2026 00:16:21 +0000 (0:00:00.526) 0:01:50.804 ****** 2026-09-04 00:16:21.152906 | instance | 2026-09-04 00:16:21.152914 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-09-04 00:16:21.152929 | instance | Friday 04 September 2026 00:16:21 +0000 (0:00:00.028) 0:01:50.832 ****** 2026-09-04 00:16:21.922549 | instance | ok: [instance] 2026-09-04 00:16:21.923317 | instance | 2026-09-04 00:16:21.923402 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ****************** 2026-09-04 00:16:21.923415 | instance | Friday 04 September 2026 00:16:21 +0000 (0:00:00.769) 0:01:51.602 ****** 2026-09-04 00:16:22.900648 | instance | changed: [instance] 2026-09-04 00:16:22.901361 | instance | 2026-09-04 00:16:22.901414 | instance | TASK [vexxhost.containers.docker : Enable and start service] ******************* 2026-09-04 00:16:22.901426 | instance | Friday 04 September 2026 00:16:22 +0000 (0:00:00.978) 0:01:52.581 ****** 2026-09-04 00:16:23.510844 | instance | changed: [instance] 2026-09-04 00:16:23.510937 | instance | 2026-09-04 00:16:23.511305 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ****** 2026-09-04 00:16:23.511367 | instance | Friday 04 September 2026 00:16:23 +0000 (0:00:00.610) 0:01:53.191 ****** 2026-09-04 00:16:23.576238 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml) 2026-09-04 00:16:23.576294 | instance | 2026-09-04 00:16:23.576535 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ******************************** 2026-09-04 00:16:23.576552 | instance | Friday 04 September 2026 00:16:23 +0000 (0:00:00.065) 0:01:53.257 ****** 2026-09-04 00:16:29.415111 | instance | changed: [instance] 2026-09-04 00:16:29.415881 | instance | 2026-09-04 00:16:29.415937 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] ********************* 2026-09-04 00:16:29.415949 | instance | Friday 04 September 2026 00:16:29 +0000 (0:00:05.838) 0:01:59.095 ****** 2026-09-04 00:16:30.174790 | instance | ok: [instance] => (item=chronyd) 2026-09-04 00:16:30.175115 | instance | ok: [instance] => (item=sshd) 2026-09-04 00:16:30.175131 | instance | 2026-09-04 00:16:30.175141 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ****************************** 2026-09-04 00:16:30.175152 | instance | Friday 04 September 2026 00:16:30 +0000 (0:00:00.758) 0:01:59.853 ****** 2026-09-04 00:16:31.275365 | instance | changed: [instance] 2026-09-04 00:16:31.275691 | instance | 2026-09-04 00:16:31.276090 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ******************** 2026-09-04 00:16:31.276186 | instance | Friday 04 September 2026 00:16:31 +0000 (0:00:01.101) 0:02:00.955 ****** 2026-09-04 00:16:31.517980 | instance | ok: [instance] 2026-09-04 00:16:31.518817 | instance | 2026-09-04 00:16:31.518879 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] **************** 2026-09-04 00:16:31.518891 | instance | Friday 04 September 2026 00:16:31 +0000 (0:00:00.242) 0:02:01.198 ****** 2026-09-04 00:16:32.009709 | instance | changed: [instance] 2026-09-04 00:16:32.010311 | instance | 2026-09-04 00:16:32.010336 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] *** 2026-09-04 00:16:32.010346 | instance | Friday 04 September 2026 00:16:32 +0000 (0:00:00.492) 0:02:01.690 ****** 2026-09-04 00:16:32.386826 | instance | changed: [instance] 2026-09-04 00:16:32.386904 | instance | 2026-09-04 00:16:32.387316 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] ************************* 2026-09-04 00:16:32.387391 | instance | Friday 04 September 2026 00:16:32 +0000 (0:00:00.377) 0:02:02.067 ****** 2026-09-04 00:16:32.653915 | instance | ok: [instance] 2026-09-04 00:16:32.653963 | instance | 2026-09-04 00:16:32.653971 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] ******************* 2026-09-04 00:16:32.653976 | instance | Friday 04 September 2026 00:16:32 +0000 (0:00:00.266) 0:02:02.334 ****** 2026-09-04 00:16:32.922295 | instance | ok: [instance] => (item=instance) 2026-09-04 00:16:32.923051 | instance | 2026-09-04 00:16:32.923149 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ******** 2026-09-04 00:16:32.923163 | instance | Friday 04 September 2026 00:16:32 +0000 (0:00:00.268) 0:02:02.602 ****** 2026-09-04 00:16:32.993230 | instance | ok: [instance] 2026-09-04 00:16:32.993583 | instance | 2026-09-04 00:16:32.993631 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] *********************************** 2026-09-04 00:16:32.993638 | instance | Friday 04 September 2026 00:16:32 +0000 (0:00:00.071) 0:02:02.674 ****** 2026-09-04 00:16:33.078036 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance 2026-09-04 00:16:33.078380 | instance | 2026-09-04 00:16:33.078419 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] ************* 2026-09-04 00:16:33.078426 | instance | Friday 04 September 2026 00:16:33 +0000 (0:00:00.085) 0:02:02.759 ****** 2026-09-04 00:16:33.388514 | instance | changed: [instance] 2026-09-04 00:16:33.388599 | instance | 2026-09-04 00:16:33.388614 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ****************** 2026-09-04 00:16:33.388627 | instance | Friday 04 September 2026 00:16:33 +0000 (0:00:00.308) 0:02:03.067 ****** 2026-09-04 00:16:34.105766 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True}) 2026-09-04 00:16:34.106061 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0}) 2026-09-04 00:16:34.106952 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False}) 2026-09-04 00:16:34.107017 | instance | 2026-09-04 00:16:34.107030 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] ******************************* 2026-09-04 00:16:34.107041 | instance | Friday 04 September 2026 00:16:34 +0000 (0:00:00.718) 0:02:03.786 ****** 2026-09-04 00:18:12.164398 | instance | ok: [instance] 2026-09-04 00:18:12.164502 | instance | 2026-09-04 00:18:12.164811 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] *************** 2026-09-04 00:18:12.164832 | instance | Friday 04 September 2026 00:18:12 +0000 (0:01:38.058) 0:03:41.844 ****** 2026-09-04 00:18:12.420119 | instance | changed: [instance] 2026-09-04 00:18:12.420316 | instance | 2026-09-04 00:18:12.420545 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] ********************************** 2026-09-04 00:18:12.420797 | instance | Friday 04 September 2026 00:18:12 +0000 (0:00:00.255) 0:03:42.100 ****** 2026-09-04 00:18:12.463798 | instance | ok: [instance] 2026-09-04 00:18:12.464027 | instance | 2026-09-04 00:18:12.464282 | instance | TASK [Install Ceph host] ******************************************************* 2026-09-04 00:18:12.464528 | instance | Friday 04 September 2026 00:18:12 +0000 (0:00:00.043) 0:03:42.144 ****** 2026-09-04 00:18:12.557343 | instance | included: vexxhost.ceph.cephadm_host for instance 2026-09-04 00:18:12.557457 | instance | 2026-09-04 00:18:12.557469 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ****** 2026-09-04 00:18:12.557598 | instance | Friday 04 September 2026 00:18:12 +0000 (0:00:00.094) 0:03:42.238 ****** 2026-09-04 00:18:14.641700 | instance | ok: [instance] 2026-09-04 00:18:14.641816 | instance | 2026-09-04 00:18:14.641971 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] *** 2026-09-04 00:18:14.642100 | instance | Friday 04 September 2026 00:18:14 +0000 (0:00:02.083) 0:03:44.322 ****** 2026-09-04 00:18:14.719571 | instance | ok: [instance] => (item=instance) 2026-09-04 00:18:14.719823 | instance | 2026-09-04 00:18:14.720068 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] *********** 2026-09-04 00:18:14.720304 | instance | Friday 04 September 2026 00:18:14 +0000 (0:00:00.077) 0:03:44.399 ****** 2026-09-04 00:18:15.119774 | instance | ok: [instance] 2026-09-04 00:18:15.119846 | instance | 2026-09-04 00:18:15.120084 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] *********************** 2026-09-04 00:18:15.120122 | instance | Friday 04 September 2026 00:18:15 +0000 (0:00:00.401) 0:03:44.800 ****** 2026-09-04 00:18:17.814355 | instance | ok: [instance] 2026-09-04 00:18:17.814902 | instance | 2026-09-04 00:18:17.814924 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ****************** 2026-09-04 00:18:17.814932 | instance | Friday 04 September 2026 00:18:17 +0000 (0:00:02.693) 0:03:47.494 ****** 2026-09-04 00:19:13.818486 | instance | An exception occurred during task execution. To see the full traceback, use -vvv. The error was: [errno 5] RADOS I/O error (error connecting to the cluster) 2026-09-04 00:19:13.818595 | 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_txyt__4d/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_txyt__4d/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_txyt__4d/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_txyt__4d/ansible_vexxhost.ceph.orch_apply_payload.zip/ansible_collections/vexxhost/ceph/plugins/modules/orch_apply.py\", line 120, in apply_spec\nRuntimeError: Inferring config /var/lib/ceph/4837cbf8-4f90-4300-b3f6-726c9b9f89b4/mon.instance/config\n2026-09-04T00:19:13.617+0000 7f7398d71640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAYDppqfaWyBSAAilbqloHfqRRJ3LHtR0F6IlbHPSOV4Yg4tkiHvgMj760=: Malformed input [buffer:3]\n2026-09-04T00:19:13.617+0000 7f7398d71640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-04T00:19:13.617+0000 7f7398d71640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAYDppqfaWyBSAAilbqloHfqRRJ3LHtR0F6IlbHPSOV4Yg4tkiHvgMj760=: Malformed input [buffer:3]\n2026-09-04T00:19:13.617+0000 7f7398d71640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-04T00:19:13.617+0000 7f7398d71640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAYDppqfaWyBSAAilbqloHfqRRJ3LHtR0F6IlbHPSOV4Yg4tkiHvgMj760=: Malformed input [buffer:3]\n2026-09-04T00:19:13.617+0000 7f7398d71640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-04T00:19:13.617+0000 7f7398d71640 -1 monclient: keyring not found\n[errno 5] RADOS I/O error (error connecting to the cluster)\n\n", "module_stdout": "", "msg": "MODULE FAILURE\nSee stdout/stderr for the exact error", "rc": 1} 2026-09-04 00:19:13.819580 | instance | 2026-09-04 00:19:13.820017 | instance | PLAY RECAP ********************************************************************* 2026-09-04 00:19:13.820415 | instance | instance : ok=55 changed=26 unreachable=0 failed=1 skipped=7 rescued=0 ignored=0 2026-09-04 00:19:13.820775 | instance | 2026-09-04 00:19:13.821124 | instance | Friday 04 September 2026 00:19:13 +0000 (0:00:56.005) 0:04:43.500 ****** 2026-09-04 00:19:13.821456 | instance | =============================================================================== 2026-09-04 00:19:13.821825 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 98.06s 2026-09-04 00:19:13.822152 | instance | vexxhost.containers.download_artifact : Download item ------------------ 80.90s 2026-09-04 00:19:13.822480 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 56.01s 2026-09-04 00:19:13.822831 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 6.09s 2026-09-04 00:19:13.823159 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 5.84s 2026-09-04 00:19:13.823517 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.44s 2026-09-04 00:19:13.823977 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.92s 2026-09-04 00:19:13.824321 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.69s 2026-09-04 00:19:13.824655 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 2.08s 2026-09-04 00:19:13.825020 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.87s 2026-09-04 00:19:13.825353 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.45s 2026-09-04 00:19:13.825680 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 1.10s 2026-09-04 00:19:13.826039 | instance | Gathering Facts --------------------------------------------------------- 1.07s 2026-09-04 00:19:13.826377 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.07s 2026-09-04 00:19:13.826699 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 1.01s 2026-09-04 00:19:13.827051 | instance | Gathering Facts --------------------------------------------------------- 1.00s 2026-09-04 00:19:13.827497 | instance | Gathering Facts --------------------------------------------------------- 0.99s 2026-09-04 00:19:13.827851 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 0.98s 2026-09-04 00:19:13.828177 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.86s 2026-09-04 00:19:13.828489 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.80s 2026-09-04 00:19:13.981491 | instance | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-09-04 00:19:13.981691 | instance | ERROR [csi > converge] Executed: Failed 2026-09-04 00:19:13.981842 | instance | ERROR Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-09-04 00:19:14.361342 | instance | ERROR 2026-09-04 00:19:14.361521 | instance | { 2026-09-04 00:19:14.361552 | instance | "delta": "0:05:35.787461", 2026-09-04 00:19:14.361573 | instance | "end": "2026-09-04 00:19:14.048799", 2026-09-04 00:19:14.361591 | instance | "msg": "non-zero return code", 2026-09-04 00:19:14.361608 | instance | "rc": 2, 2026-09-04 00:19:14.361625 | instance | "start": "2026-09-04 00:13:38.261338" 2026-09-04 00:19:14.361643 | instance | } failure 2026-09-04 00:19:14.366604 | 2026-09-04 00:19:14.366656 | PLAY RECAP 2026-09-04 00:19:14.366702 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-09-04 00:19:14.366724 | 2026-09-04 00:19:14.620781 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-09-04 00:19:14.625148 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-09-04 00:19:15.230707 | 2026-09-04 00:19:15.230838 | PLAY [all] 2026-09-04 00:19:15.244727 | 2026-09-04 00:19:15.244811 | TASK [gather-host-logs : creating directory for system status] 2026-09-04 00:19:15.625436 | instance | changed 2026-09-04 00:19:15.630829 | 2026-09-04 00:19:15.630906 | TASK [gather-host-logs : Get logs for each host] 2026-09-04 00:19:16.048248 | instance | + systemd-cgls --full --all --no-pager 2026-09-04 00:19:16.065412 | instance | + ip addr 2026-09-04 00:19:16.068564 | instance | + ip route 2026-09-04 00:19:16.071547 | instance | + lsblk 2026-09-04 00:19:16.077484 | instance | + mount 2026-09-04 00:19:16.080581 | instance | + docker images 2026-09-04 00:19:16.106826 | instance | + brctl show 2026-09-04 00:19:16.107462 | instance | /bin/bash: line 8: brctl: command not found 2026-09-04 00:19:16.107820 | instance | + ps aux --sort=-%mem 2026-09-04 00:19:16.127967 | instance | + dpkg -l 2026-09-04 00:19:16.139319 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-09-04 00:19:16.139843 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-09-04 00:19:16.161252 | instance | + '[' '!' -z '' ']' 2026-09-04 00:19:16.172218 | instance | ok: Runtime: 0:00:00.119601 2026-09-04 00:19:16.178585 | 2026-09-04 00:19:16.178655 | TASK [gather-host-logs : Downloads logs to executor] 2026-09-04 00:19:16.809714 | instance | changed: 2026-09-04 00:19:16.809916 | instance | created directory /var/lib/zuul/builds/9bdc13a38f63406ebb860b54ce2b8394/work/logs/instance 2026-09-04 00:19:16.809955 | instance | cd+++++++++ system/ 2026-09-04 00:19:16.809986 | instance | >f+++++++++ system/brctl-show.txt 2026-09-04 00:19:16.810016 | instance | >f+++++++++ system/docker-images.txt 2026-09-04 00:19:16.810043 | instance | >f+++++++++ system/ip-addr.txt 2026-09-04 00:19:16.810076 | instance | >f+++++++++ system/ip-route.txt 2026-09-04 00:19:16.810105 | instance | >f+++++++++ system/lsblk.txt 2026-09-04 00:19:16.810133 | instance | >f+++++++++ system/mount.txt 2026-09-04 00:19:16.810159 | instance | >f+++++++++ system/packages.txt 2026-09-04 00:19:16.810185 | instance | >f+++++++++ system/ps.txt 2026-09-04 00:19:16.810214 | instance | >f+++++++++ system/systemd-cgls.txt 2026-09-04 00:19:16.819668 | 2026-09-04 00:19:16.819732 | LOOP [helm-release-status : creating directory for helm release status] 2026-09-04 00:19:17.029025 | instance | changed: "values" 2026-09-04 00:19:17.218771 | instance | changed: "releases" 2026-09-04 00:19:17.236350 | 2026-09-04 00:19:17.236509 | TASK [helm-release-status : Gather get release status for helm charts] 2026-09-04 00:19:17.505011 | instance | /bin/bash: line 3: kubectl: command not found 2026-09-04 00:19:17.776447 | instance | ok: Runtime: 0:00:00.006731 2026-09-04 00:19:17.781433 | 2026-09-04 00:19:17.781498 | TASK [helm-release-status : Downloads logs to executor] 2026-09-04 00:19:18.288542 | instance | changed: 2026-09-04 00:19:18.288713 | instance | cd+++++++++ helm/ 2026-09-04 00:19:18.288741 | instance | cd+++++++++ helm/releases/ 2026-09-04 00:19:18.288763 | instance | cd+++++++++ helm/values/ 2026-09-04 00:19:18.297351 | 2026-09-04 00:19:18.297422 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-09-04 00:19:18.525105 | instance | changed 2026-09-04 00:19:18.531890 | 2026-09-04 00:19:18.531959 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-09-04 00:19:18.846623 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-04 00:19:18.846740 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-04 00:19:18.852305 | instance | environment: line 1: kubectl: command not found 2026-09-04 00:19:18.853825 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-04 00:19:18.854528 | instance | environment: line 1: kubectl: command not found 2026-09-04 00:19:18.855874 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-04 00:19:18.857489 | instance | environment: line 1: kubectl: command not found 2026-09-04 00:19:18.859009 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-04 00:19:18.861083 | instance | environment: line 1: kubectl: command not found 2026-09-04 00:19:18.862539 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-04 00:19:18.863601 | instance | environment: line 1: kubectl: command not found 2026-09-04 00:19:18.865162 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-04 00:19:19.072035 | instance | ok: Runtime: 0:00:00.026823 2026-09-04 00:19:19.077228 | 2026-09-04 00:19:19.077297 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-09-04 00:19:19.304311 | instance | changed 2026-09-04 00:19:19.309234 | 2026-09-04 00:19:19.309300 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-09-04 00:19:19.594863 | instance | environment: line 5: kubectl: command not found 2026-09-04 00:19:19.595741 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-04 00:19:19.595909 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-04 00:19:19.596483 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-04 00:19:19.847336 | instance | ok: Runtime: 0:00:00.010549 2026-09-04 00:19:19.855276 | 2026-09-04 00:19:19.855362 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-09-04 00:19:20.719765 | instance | changed: 2026-09-04 00:19:20.719972 | instance | cd+++++++++ objects/ 2026-09-04 00:19:20.720011 | instance | cd+++++++++ objects/cluster/ 2026-09-04 00:19:20.720044 | instance | cd+++++++++ objects/namespaced/ 2026-09-04 00:19:20.729500 | 2026-09-04 00:19:20.729562 | TASK [gather-pod-logs : creating directory for pod logs] 2026-09-04 00:19:20.944897 | instance | changed 2026-09-04 00:19:20.949787 | 2026-09-04 00:19:20.949850 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-09-04 00:19:21.178226 | instance | changed 2026-09-04 00:19:21.183777 | 2026-09-04 00:19:21.183851 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-09-04 00:19:21.446435 | instance | environment: line 3: kubectl: command not found 2026-09-04 00:19:21.723595 | instance | ok: Runtime: 0:00:00.007309 2026-09-04 00:19:21.729209 | 2026-09-04 00:19:21.729271 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-09-04 00:19:22.216404 | instance | changed: 2026-09-04 00:19:22.216609 | instance | cd+++++++++ pod-logs/ 2026-09-04 00:19:22.216648 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-09-04 00:19:22.228643 | 2026-09-04 00:19:22.228704 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-09-04 00:19:22.445826 | instance | changed 2026-09-04 00:19:22.450833 | 2026-09-04 00:19:22.450897 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-09-04 00:19:22.723289 | instance | /bin/bash: line 2: kubectl: command not found 2026-09-04 00:19:24.023723 | instance | ok: Runtime: 0:00:00.049765 2026-09-04 00:19:24.029577 | 2026-09-04 00:19:24.029650 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-09-04 00:19:24.289911 | instance | /bin/bash: line 2: kubectl: command not found 2026-09-04 00:19:24.340728 | instance | ceph-mgr endpoints: 2026-09-04 00:19:24.564467 | instance | ok: Runtime: 0:00:00.057115 2026-09-04 00:19:24.571137 | 2026-09-04 00:19:24.571204 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-09-04 00:19:24.838076 | instance | /bin/bash: line 4: kubectl: command not found 2026-09-04 00:19:25.108529 | instance | ok: Runtime: 0:00:00.026221 2026-09-04 00:19:25.115635 | 2026-09-04 00:19:25.115706 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-09-04 00:19:25.617487 | instance | changed: cd+++++++++ prometheus/ 2026-09-04 00:19:25.628387 | 2026-09-04 00:19:25.628455 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-09-04 00:19:25.845707 | instance | changed 2026-09-04 00:19:25.850682 | 2026-09-04 00:19:25.850775 | TASK [gather-selenium-data : Get selenium data] 2026-09-04 00:19:26.180326 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-09-04 00:19:26.181824 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-09-04 00:19:26.390484 | instance | ERROR 2026-09-04 00:19:26.390759 | instance | { 2026-09-04 00:19:26.390811 | instance | "delta": "0:00:00.006533", 2026-09-04 00:19:26.390845 | instance | "end": "2026-09-04 00:19:26.182178", 2026-09-04 00:19:26.390875 | instance | "msg": "non-zero return code", 2026-09-04 00:19:26.390903 | instance | "rc": 1, 2026-09-04 00:19:26.390929 | instance | "start": "2026-09-04 00:19:26.175645" 2026-09-04 00:19:26.390955 | instance | } 2026-09-04 00:19:26.390989 | instance | ERROR: Ignoring Errors 2026-09-04 00:19:26.398911 | 2026-09-04 00:19:26.399017 | TASK [gather-selenium-data : Downloads logs to executor] 2026-09-04 00:19:26.897211 | instance | changed: cd+++++++++ selenium/ 2026-09-04 00:19:26.905441 | 2026-09-04 00:19:26.905515 | PLAY RECAP 2026-09-04 00:19:26.905575 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-09-04 00:19:26.905605 | 2026-09-04 00:19:27.025659 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-09-04 00:19:27.027877 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-09-04 00:19:27.616922 | 2026-09-04 00:19:27.617421 | PLAY [all] 2026-09-04 00:19:27.629221 | 2026-09-04 00:19:27.629297 | TASK [fetch-output : Set log path for multiple nodes] 2026-09-04 00:19:27.664645 | instance | skipping: Conditional result was False 2026-09-04 00:19:27.673566 | 2026-09-04 00:19:27.673670 | TASK [fetch-output : Set log path for single node] 2026-09-04 00:19:27.716843 | instance | ok 2026-09-04 00:19:27.722924 | 2026-09-04 00:19:27.722994 | LOOP [fetch-output : Ensure local output dirs] 2026-09-04 00:19:28.088616 | instance -> localhost | ok: "/var/lib/zuul/builds/9bdc13a38f63406ebb860b54ce2b8394/work/logs" 2026-09-04 00:19:28.296560 | instance -> localhost | changed: "/var/lib/zuul/builds/9bdc13a38f63406ebb860b54ce2b8394/work/artifacts" 2026-09-04 00:19:28.510418 | instance -> localhost | changed: "/var/lib/zuul/builds/9bdc13a38f63406ebb860b54ce2b8394/work/docs" 2026-09-04 00:19:28.524621 | 2026-09-04 00:19:28.524815 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-04 00:19:29.209694 | instance | changed: .d..t...... ./ 2026-09-04 00:19:29.209988 | instance | changed: All items complete 2026-09-04 00:19:29.210018 | 2026-09-04 00:19:30.671485 | instance | changed: .d..t...... ./ 2026-09-04 00:19:31.127005 | instance | changed: .d..t...... ./ 2026-09-04 00:19:31.149826 | 2026-09-04 00:19:31.150035 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-04 00:19:31.608655 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.008703 2026-09-04 00:19:31.826329 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.008805 2026-09-04 00:19:31.850925 | 2026-09-04 00:19:31.851075 | PLAY [all] 2026-09-04 00:19:31.857451 | 2026-09-04 00:19:31.858972 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-04 00:19:32.275525 | instance | changed 2026-09-04 00:19:32.281095 | 2026-09-04 00:19:32.281147 | PLAY RECAP 2026-09-04 00:19:32.281196 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-09-04 00:19:32.281220 | 2026-09-04 00:19:32.496360 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-09-04 00:19:32.501071 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-04 00:19:33.061606 | 2026-09-04 00:19:33.061733 | PLAY [localhost] 2026-09-04 00:19:33.071517 | 2026-09-04 00:19:33.071588 | TASK [Generate Zuul manifest] 2026-09-04 00:19:33.093234 | localhost | ok 2026-09-04 00:19:33.111987 | 2026-09-04 00:19:33.112066 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-04 00:19:33.478062 | localhost | changed 2026-09-04 00:19:33.489012 | 2026-09-04 00:19:33.489089 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-04 00:19:33.520010 | localhost | ok 2026-09-04 00:19:33.529040 | 2026-09-04 00:19:33.529102 | TASK [Upload logs] 2026-09-04 00:19:33.550480 | localhost | ok 2026-09-04 00:19:33.606401 | 2026-09-04 00:19:33.606497 | TASK [Set zuul-log-path fact] 2026-09-04 00:19:33.626413 | localhost | ok 2026-09-04 00:19:33.638677 | 2026-09-04 00:19:33.638756 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-04 00:19:33.669714 | localhost | ok 2026-09-04 00:19:33.677860 | 2026-09-04 00:19:33.677924 | TASK [upload-logs : Create log directories] 2026-09-04 00:19:34.074893 | localhost | changed 2026-09-04 00:19:34.081595 | 2026-09-04 00:19:34.081700 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-04 00:19:34.511141 | localhost -> localhost | ok: Runtime: 0:00:00.005742 2026-09-04 00:19:34.517889 | 2026-09-04 00:19:34.517989 | TASK [upload-logs : Upload logs to log server] 2026-09-04 00:19:34.989109 | localhost | Output suppressed because no_log was given 2026-09-04 00:19:35.034970 | 2026-09-04 00:19:35.035114 | LOOP [upload-logs : Compress console log and json output] 2026-09-04 00:19:35.081871 | localhost | skipping: Conditional result was False 2026-09-04 00:19:35.088816 | localhost | skipping: Conditional result was False 2026-09-04 00:19:35.100605 | 2026-09-04 00:19:35.100800 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-04 00:19:35.147281 | localhost | skipping: Conditional result was False 2026-09-04 00:19:35.147711 | 2026-09-04 00:19:35.151035 | localhost | skipping: Conditional result was False 2026-09-04 00:19:35.167986 | 2026-09-04 00:19:35.168197 | LOOP [upload-logs : Upload console log and json output]