2026-09-07 10:35:49.745323 | Job console starting 2026-09-07 10:35:49.756473 | Updating git repos 2026-09-07 10:35:58.777620 | Cloning repos into workspace 2026-09-07 10:36:15.054201 | Restoring repo states 2026-09-07 10:36:35.459283 | Merging changes 2026-09-07 10:36:36.638083 | Checking out repos 2026-09-07 10:36:38.414921 | Preparing playbooks 2026-09-07 10:36:41.692563 | Running Ansible setup 2026-09-07 10:36:45.516621 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-09-07 10:36:46.152434 | 2026-09-07 10:36:46.152693 | PLAY [localhost] 2026-09-07 10:36:46.159618 | 2026-09-07 10:36:46.159685 | TASK [Gathering Facts] 2026-09-07 10:36:47.140842 | localhost | ok 2026-09-07 10:36:47.153022 | 2026-09-07 10:36:47.153168 | TASK [Setup log path fact] 2026-09-07 10:36:47.175307 | localhost | ok 2026-09-07 10:36:47.195453 | 2026-09-07 10:36:47.195620 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-07 10:36:47.236768 | localhost | ok 2026-09-07 10:36:47.248730 | 2026-09-07 10:36:47.248880 | TASK [emit-job-header : Print job information] 2026-09-07 10:36:47.301851 | # Job Information 2026-09-07 10:36:47.302151 | Ansible Version: 2.16.18 2026-09-07 10:36:47.302214 | Job: atmosphere-molecule-csi-rbd 2026-09-07 10:36:47.302257 | Pipeline: check 2026-09-07 10:36:47.302296 | Executor: 2d72f0692154 2026-09-07 10:36:47.302335 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4090 2026-09-07 10:36:47.302379 | Event ID: 706e6760-aaa7-11f1-948b-5e65aedd5eca 2026-09-07 10:36:47.307800 | 2026-09-07 10:36:47.307945 | LOOP [emit-job-header : Print node information] 2026-09-07 10:36:47.409584 | localhost | ok: 2026-09-07 10:36:47.409845 | localhost | # Node Information 2026-09-07 10:36:47.409901 | localhost | Inventory Hostname: instance 2026-09-07 10:36:47.409944 | localhost | Hostname: np0000192105 2026-09-07 10:36:47.409983 | localhost | Username: zuul 2026-09-07 10:36:47.410027 | localhost | Distro: Ubuntu 22.04 2026-09-07 10:36:47.410066 | localhost | Provider: yul1 2026-09-07 10:36:47.410104 | localhost | Region: ca-ymq-1 2026-09-07 10:36:47.410141 | localhost | Label: ubuntu-jammy 2026-09-07 10:36:47.410177 | localhost | Product Name: OpenStack Nova 2026-09-07 10:36:47.410214 | localhost | Interface IP: 162.253.55.5 2026-09-07 10:36:47.433256 | 2026-09-07 10:36:47.433550 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-07 10:36:47.915607 | localhost -> localhost | changed 2026-09-07 10:36:47.926956 | 2026-09-07 10:36:47.927109 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-07 10:36:48.951921 | localhost -> localhost | changed 2026-09-07 10:36:48.957387 | 2026-09-07 10:36:48.957439 | PLAY [all] 2026-09-07 10:36:48.964910 | 2026-09-07 10:36:48.965424 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-07 10:36:49.241872 | instance -> localhost | ok 2026-09-07 10:36:49.254223 | 2026-09-07 10:36:49.254392 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-07 10:36:49.288930 | instance | ok 2026-09-07 10:36:49.314425 | instance | included: /var/lib/zuul/builds/0d3bfbef84d54de5a1d047a6eb084ad0/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-07 10:36:49.321274 | 2026-09-07 10:36:49.321356 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-07 10:36:50.617771 | instance -> localhost | Generating public/private rsa key pair. 2026-09-07 10:36:50.618041 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/0d3bfbef84d54de5a1d047a6eb084ad0/work/0d3bfbef84d54de5a1d047a6eb084ad0_id_rsa 2026-09-07 10:36:50.618083 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/0d3bfbef84d54de5a1d047a6eb084ad0/work/0d3bfbef84d54de5a1d047a6eb084ad0_id_rsa.pub 2026-09-07 10:36:50.618116 | instance -> localhost | The key fingerprint is: 2026-09-07 10:36:50.618147 | instance -> localhost | SHA256:WSDdtsD/lPGzyuXLTNtupJBkqZ5ryzdic0B0vthY1fw zuul-build-sshkey 2026-09-07 10:36:50.618203 | instance -> localhost | The key's randomart image is: 2026-09-07 10:36:50.618236 | instance -> localhost | +---[RSA 3072]----+ 2026-09-07 10:36:50.618281 | instance -> localhost | | .o.. o | 2026-09-07 10:36:50.618312 | instance -> localhost | | .+.+ o . o| 2026-09-07 10:36:50.618344 | instance -> localhost | | =.+ * .| 2026-09-07 10:36:50.618375 | instance -> localhost | | o+ O o E| 2026-09-07 10:36:50.618404 | instance -> localhost | | S. @ o o | 2026-09-07 10:36:50.618434 | instance -> localhost | | = * o .| 2026-09-07 10:36:50.618462 | instance -> localhost | | . + =.o | 2026-09-07 10:36:50.618489 | instance -> localhost | | .B *+oo.| 2026-09-07 10:36:50.618533 | instance -> localhost | | o+B .=+o| 2026-09-07 10:36:50.618566 | instance -> localhost | +----[SHA256]-----+ 2026-09-07 10:36:50.618639 | instance -> localhost | ok: Runtime: 0:00:00.826035 2026-09-07 10:36:50.627655 | 2026-09-07 10:36:50.627771 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-07 10:36:50.660209 | instance | ok 2026-09-07 10:36:50.671845 | instance | included: /var/lib/zuul/builds/0d3bfbef84d54de5a1d047a6eb084ad0/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-07 10:36:50.682302 | 2026-09-07 10:36:50.682435 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-07 10:36:50.707049 | instance | skipping: Conditional result was False 2026-09-07 10:36:50.714995 | 2026-09-07 10:36:50.715128 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-07 10:36:51.142157 | instance | changed 2026-09-07 10:36:51.150895 | 2026-09-07 10:36:51.151024 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-07 10:36:51.341412 | instance | ok 2026-09-07 10:36:51.352982 | 2026-09-07 10:36:51.353117 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-07 10:36:51.874283 | instance | changed 2026-09-07 10:36:51.883580 | 2026-09-07 10:36:51.883711 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-07 10:36:52.399187 | instance | changed 2026-09-07 10:36:52.406663 | 2026-09-07 10:36:52.406765 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-07 10:36:52.429860 | instance | skipping: Conditional result was False 2026-09-07 10:36:52.436688 | 2026-09-07 10:36:52.436776 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-07 10:36:52.844989 | instance -> localhost | changed 2026-09-07 10:36:52.862347 | 2026-09-07 10:36:52.862467 | TASK [add-build-sshkey : Add back temp key] 2026-09-07 10:36:53.219806 | instance -> localhost | Identity added: /var/lib/zuul/builds/0d3bfbef84d54de5a1d047a6eb084ad0/work/0d3bfbef84d54de5a1d047a6eb084ad0_id_rsa (zuul-build-sshkey) 2026-09-07 10:36:53.220102 | instance -> localhost | ok: Runtime: 0:00:00.015539 2026-09-07 10:36:53.229621 | 2026-09-07 10:36:53.229747 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-07 10:36:53.590029 | instance | ok 2026-09-07 10:36:53.598559 | 2026-09-07 10:36:53.598687 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-07 10:36:53.625977 | instance | skipping: Conditional result was False 2026-09-07 10:36:53.644487 | 2026-09-07 10:36:53.644729 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-09-07 10:36:54.000461 | instance | ok 2026-09-07 10:36:54.012401 | 2026-09-07 10:36:54.012641 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-09-07 10:36:57.551080 | instance | Output suppressed because no_log was given 2026-09-07 10:36:57.563050 | 2026-09-07 10:36:57.563195 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-09-07 10:36:57.791799 | instance | ok: "logs" 2026-09-07 10:36:57.792334 | instance | ok: All items complete 2026-09-07 10:36:57.792426 | 2026-09-07 10:36:57.944610 | instance | ok: "artifacts" 2026-09-07 10:36:58.114348 | instance | ok: "docs" 2026-09-07 10:36:58.131010 | 2026-09-07 10:36:58.131168 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-09-07 10:36:58.334780 | instance | changed: "logs" 2026-09-07 10:36:58.483262 | instance | changed: "artifacts" 2026-09-07 10:36:58.627104 | instance | changed: "docs" 2026-09-07 10:36:58.637542 | 2026-09-07 10:36:58.637666 | PLAY RECAP 2026-09-07 10:36:58.637714 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-09-07 10:36:58.637741 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-07 10:36:58.637764 | 2026-09-07 10:36:58.836613 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-09-07 10:36:58.839184 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-09-07 10:36:59.439810 | 2026-09-07 10:36:59.439952 | PLAY [all] 2026-09-07 10:36:59.450282 | 2026-09-07 10:36:59.450389 | TASK [setup-uv : Extract archive] 2026-09-07 10:37:01.698178 | instance | changed 2026-09-07 10:37:01.709918 | 2026-09-07 10:37:01.710176 | TASK [setup-uv : Print version] 2026-09-07 10:37:02.146173 | instance | uv 0.8.13 2026-09-07 10:37:02.256309 | instance | ok: Runtime: 0:00:00.012667 2026-09-07 10:37:02.274624 | 2026-09-07 10:37:02.274844 | TASK [Install Ansible collection siblings] 2026-09-07 10:37:12.333271 | instance | changed: 2026-09-07 10:37:12.361338 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-09-07 10:37:12.361852 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-09-07 10:37:12.361900 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-09-07 10:37:12.361930 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto 2026-09-07 10:37:12.361967 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general 2026-09-07 10:37:12.362011 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql 2026-09-07 10:37:12.362048 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-09-07 10:37:12.362079 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-09-07 10:37:12.362113 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-09-07 10:37:12.362152 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-09-07 10:37:12.362179 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-09-07 10:37:12.362212 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-09-07 10:37:12.362245 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0 2026-09-07 10:37:12.362283 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0 2026-09-07 10:37:12.362309 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0 2026-09-07 10:37:12.362342 | instance | Resolved community.crypto to 2.2.3 for 2.2.3 2026-09-07 10:37:12.362379 | instance | Resolved community.general to 7.3.0 for 7.3.0 2026-09-07 10:37:12.362404 | instance | Resolved community.mysql to 3.6.0 for 3.6.0 2026-09-07 10:37:12.362436 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0 2026-09-07 10:37:12.362473 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0 2026-09-07 10:37:12.362497 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.1.2 2026-09-07 10:37:12.362558 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0 2026-09-07 10:37:12.362589 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-09-07 10:37:12.362639 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0 2026-09-07 10:37:12.362665 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0 2026-09-07 10:37:12.362697 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-09-07 10:37:12.362735 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-09-07 10:37:12.362760 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-09-07 10:37:12.362794 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0 2026-09-07 10:37:12.362829 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3 2026-09-07 10:37:12.362860 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-09-07 10:37:12.362892 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-09-07 10:37:12.362930 | instance | Checked out ansible.netcommon to 1.2.0 2026-09-07 10:37:12.362956 | 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-07 10:37:12.362996 | instance | Starting galaxy collection install process 2026-09-07 10:37:12.363028 | instance | Process install dependency map 2026-09-07 10:37:12.363060 | instance | Starting collection install process 2026-09-07 10:37:12.363083 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon' 2026-09-07 10:37:12.363106 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon 2026-09-07 10:37:12.363130 | instance | ansible.netcommon:* was installed successfully 2026-09-07 10:37:12.363154 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-09-07 10:37:12.363177 | instance | Creating virtual environment at: .venv 2026-09-07 10:37:12.363202 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-09-07 10:37:12.363225 | instance | Downloading kubernetes (1.9MiB) 2026-09-07 10:37:12.363248 | instance | Downloading netaddr (2.2MiB) 2026-09-07 10:37:12.363280 | instance | Downloading openstacksdk (1.7MiB) 2026-09-07 10:37:12.363305 | instance | Downloading setuptools (1.1MiB) 2026-09-07 10:37:12.363328 | instance | Downloading rjsonnet (1.2MiB) 2026-09-07 10:37:12.363352 | instance | Downloading pygments (1.2MiB) 2026-09-07 10:37:12.363375 | instance | Downloading ansible-core (2.1MiB) 2026-09-07 10:37:12.363398 | instance | Downloading cryptography (4.2MiB) 2026-09-07 10:37:12.363423 | instance | Building pyperclip==1.9.0 2026-09-07 10:37:12.363447 | instance | Downloading rjsonnet 2026-09-07 10:37:12.363480 | instance | Downloading netaddr 2026-09-07 10:37:12.363506 | instance | Downloading pygments 2026-09-07 10:37:12.363531 | instance | Downloading cryptography 2026-09-07 10:37:12.363572 | instance | Downloading setuptools 2026-09-07 10:37:12.363597 | instance | Downloading kubernetes 2026-09-07 10:37:12.363620 | instance | Downloading ansible-core 2026-09-07 10:37:12.363643 | instance | Downloading openstacksdk 2026-09-07 10:37:12.363667 | instance | Built pyperclip==1.9.0 2026-09-07 10:37:12.363692 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-09-07 10:37:12.363716 | instance | Installed 79 packages in 82ms 2026-09-07 10:37:12.363740 | instance | Checked out ansible.posix to 1.6.0 2026-09-07 10:37:12.363764 | 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-07 10:37:12.363788 | instance | Starting galaxy collection install process 2026-09-07 10:37:12.363813 | instance | Process install dependency map 2026-09-07 10:37:12.363837 | instance | Starting collection install process 2026-09-07 10:37:12.363862 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-09-07 10:37:12.363902 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix 2026-09-07 10:37:12.363934 | instance | ansible.posix:1.6.0 was installed successfully 2026-09-07 10:37:12.363971 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-07 10:37:12.363998 | instance | 2.17.12 2026-09-07 10:37:12.364023 | instance | Checked out ansible.utils to v6.1.0 2026-09-07 10:37:12.364048 | 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-07 10:37:12.364072 | instance | Starting galaxy collection install process 2026-09-07 10:37:12.364095 | instance | Process install dependency map 2026-09-07 10:37:12.364118 | instance | Starting collection install process 2026-09-07 10:37:12.364141 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils' 2026-09-07 10:37:12.364165 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils 2026-09-07 10:37:12.364189 | instance | ansible.utils:6.1.0 was installed successfully 2026-09-07 10:37:12.364213 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-07 10:37:12.364237 | instance | 2.17.12 2026-09-07 10:37:12.364262 | instance | Checked out atmosphere.common to v0.7.0 2026-09-07 10:37:12.364287 | 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-07 10:37:12.364312 | instance | Starting galaxy collection install process 2026-09-07 10:37:12.364335 | instance | Process install dependency map 2026-09-07 10:37:12.364359 | instance | Starting collection install process 2026-09-07 10:37:12.364383 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common' 2026-09-07 10:37:12.364407 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common 2026-09-07 10:37:12.364432 | instance | atmosphere.common:0.7.0 was installed successfully 2026-09-07 10:37:12.364457 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-07 10:37:12.364480 | instance | 2.17.12 2026-09-07 10:37:12.364548 | instance | Checked out community.crypto to 2.2.3 2026-09-07 10:37:12.364575 | 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-07 10:37:12.364607 | instance | Starting galaxy collection install process 2026-09-07 10:37:12.364644 | instance | Process install dependency map 2026-09-07 10:37:12.364669 | instance | Starting collection install process 2026-09-07 10:37:12.364703 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-09-07 10:37:12.364726 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto 2026-09-07 10:37:12.364750 | instance | community.crypto:2.2.3 was installed successfully 2026-09-07 10:37:12.364779 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-07 10:37:12.364813 | instance | 2.17.12 2026-09-07 10:37:12.364844 | instance | Checked out community.general to 7.3.0 2026-09-07 10:37:12.364868 | 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-07 10:37:12.364905 | instance | Starting galaxy collection install process 2026-09-07 10:37:12.364945 | instance | Process install dependency map 2026-09-07 10:37:12.364970 | instance | Starting collection install process 2026-09-07 10:37:12.365001 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-09-07 10:37:12.365031 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general 2026-09-07 10:37:12.365061 | instance | community.general:7.3.0 was installed successfully 2026-09-07 10:37:12.365091 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-07 10:37:12.365127 | instance | 2.17.12 2026-09-07 10:37:12.365158 | instance | Checked out community.mysql to 3.6.0 2026-09-07 10:37:12.365183 | 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-07 10:37:12.365214 | instance | Starting galaxy collection install process 2026-09-07 10:37:12.365254 | instance | Process install dependency map 2026-09-07 10:37:12.365282 | instance | Starting collection install process 2026-09-07 10:37:12.365307 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql' 2026-09-07 10:37:12.365332 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql 2026-09-07 10:37:12.365356 | instance | community.mysql:3.6.0 was installed successfully 2026-09-07 10:37:12.365379 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-07 10:37:12.365403 | instance | 2.17.12 2026-09-07 10:37:12.365426 | instance | Checked out kubernetes.core to 2.4.0 2026-09-07 10:37:12.365450 | 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-07 10:37:12.365482 | instance | Starting galaxy collection install process 2026-09-07 10:37:12.365506 | instance | Process install dependency map 2026-09-07 10:37:12.365530 | instance | Starting collection install process 2026-09-07 10:37:12.365568 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core' 2026-09-07 10:37:12.365594 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core 2026-09-07 10:37:12.365619 | instance | kubernetes.core:2.4.0 was installed successfully 2026-09-07 10:37:12.365643 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-07 10:37:12.365667 | instance | 2.17.12 2026-09-07 10:37:12.365690 | instance | Checked out openstack.cloud to 2.6.0 2026-09-07 10:37:12.365714 | 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-07 10:37:12.365740 | instance | Starting galaxy collection install process 2026-09-07 10:37:12.365764 | instance | Process install dependency map 2026-09-07 10:37:12.365791 | instance | Starting collection install process 2026-09-07 10:37:12.365816 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud' 2026-09-07 10:37:12.365839 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud 2026-09-07 10:37:12.365864 | instance | openstack.cloud:2.6.0 was installed successfully 2026-09-07 10:37:12.365888 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-07 10:37:12.365911 | instance | 2.17.12 2026-09-07 10:37:12.365935 | instance | Checked out vexxhost.ceph to v4.2.0 2026-09-07 10:37:12.365958 | 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-07 10:37:12.365992 | instance | Starting galaxy collection install process 2026-09-07 10:37:12.366024 | instance | Process install dependency map 2026-09-07 10:37:12.366063 | instance | Starting collection install process 2026-09-07 10:37:12.366107 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph' 2026-09-07 10:37:12.366147 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph 2026-09-07 10:37:12.366180 | instance | vexxhost.ceph:4.2.0 was installed successfully 2026-09-07 10:37:12.366211 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-07 10:37:12.366235 | instance | 2.17.12 2026-09-07 10:37:12.366266 | instance | Checked out vexxhost.containers to v1.6.8 2026-09-07 10:37:12.366297 | 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-07 10:37:12.366328 | instance | Starting galaxy collection install process 2026-09-07 10:37:12.366359 | instance | Process install dependency map 2026-09-07 10:37:12.366391 | instance | Starting collection install process 2026-09-07 10:37:12.366422 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers' 2026-09-07 10:37:12.366459 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers 2026-09-07 10:37:12.366491 | instance | vexxhost.containers:1.6.8 was installed successfully 2026-09-07 10:37:12.366515 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-07 10:37:12.366571 | instance | 2.17.12 2026-09-07 10:37:12.366603 | instance | Checked out vexxhost.kubernetes to v3.3.0 2026-09-07 10:37:12.366629 | 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-07 10:37:12.366660 | instance | Starting galaxy collection install process 2026-09-07 10:37:12.366685 | instance | Process install dependency map 2026-09-07 10:37:12.366709 | instance | Starting collection install process 2026-09-07 10:37:12.366739 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes' 2026-09-07 10:37:12.366770 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes 2026-09-07 10:37:12.366795 | instance | vexxhost.kubernetes:3.3.0 was installed successfully 2026-09-07 10:37:12.366831 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-07 10:37:12.366854 | instance | 2.17.12 2026-09-07 10:37:12.375514 | 2026-09-07 10:37:12.375711 | PLAY RECAP 2026-09-07 10:37:12.375787 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-07 10:37:12.375817 | 2026-09-07 10:37:12.585992 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-09-07 10:37:12.593865 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-09-07 10:37:13.175430 | 2026-09-07 10:37:13.175660 | PLAY [all] 2026-09-07 10:37:13.191850 | 2026-09-07 10:37:13.192046 | TASK [Install "jq" for log collection] 2026-09-07 10:37:23.379305 | instance | changed 2026-09-07 10:37:23.380899 | 2026-09-07 10:37:23.380955 | PLAY RECAP 2026-09-07 10:37:23.380999 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-07 10:37:23.381044 | 2026-09-07 10:37:23.543165 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-09-07 10:37:23.546447 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-09-07 10:37:24.075220 | 2026-09-07 10:37:24.075329 | PLAY [all] 2026-09-07 10:37:24.085253 | 2026-09-07 10:37:24.085328 | LOOP [Check inventory directories] 2026-09-07 10:37:24.444590 | instance | ok: "src/github.com/vexxhost/atmosphere" 2026-09-07 10:37:24.612074 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory" 2026-09-07 10:37:24.779929 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory" 2026-09-07 10:37:24.803129 | 2026-09-07 10:37:24.803343 | LOOP [Copy inventory file for Zuul] 2026-09-07 10:37:25.609761 | instance | changed: 2026-09-07 10:37:25.609917 | instance | { 2026-09-07 10:37:25.609943 | instance | "ansible_loop_var": "item", 2026-09-07 10:37:25.609963 | instance | "changed": false, 2026-09-07 10:37:25.609983 | instance | "failed": false, 2026-09-07 10:37:25.610003 | instance | "invocation": { 2026-09-07 10:37:25.610018 | instance | "module_args": { 2026-09-07 10:37:25.610034 | instance | "checksum_algorithm": "sha1", 2026-09-07 10:37:25.610051 | instance | "follow": true, 2026-09-07 10:37:25.610068 | instance | "get_attributes": true, 2026-09-07 10:37:25.610085 | instance | "get_checksum": true, 2026-09-07 10:37:25.610101 | instance | "get_mime": true, 2026-09-07 10:37:25.610117 | instance | "path": "src/github.com/vexxhost/atmosphere" 2026-09-07 10:37:25.610133 | instance | } 2026-09-07 10:37:25.610147 | instance | }, 2026-09-07 10:37:25.610162 | instance | "item": "src/github.com/vexxhost/atmosphere", 2026-09-07 10:37:25.610177 | instance | "stat": { 2026-09-07 10:37:25.610192 | instance | "atime": 1788777425.0594745, 2026-09-07 10:37:25.610207 | instance | "attr_flags": "e", 2026-09-07 10:37:25.610222 | instance | "attributes": [ 2026-09-07 10:37:25.610237 | instance | "extents" 2026-09-07 10:37:25.610292 | instance | ], 2026-09-07 10:37:25.610313 | instance | "block_size": 4096, 2026-09-07 10:37:25.610329 | instance | "blocks": 8, 2026-09-07 10:37:25.610370 | instance | "charset": "unknown", 2026-09-07 10:37:25.610388 | instance | "ctime": 1788777423.279431, 2026-09-07 10:37:25.610404 | instance | "dev": 64513, 2026-09-07 10:37:25.610419 | instance | "device_type": 0, 2026-09-07 10:37:25.610435 | instance | "executable": true, 2026-09-07 10:37:25.610450 | instance | "exists": true, 2026-09-07 10:37:25.610465 | instance | "gid": 1000, 2026-09-07 10:37:25.610479 | instance | "gr_name": "zuul", 2026-09-07 10:37:25.610494 | instance | "inode": 1049340, 2026-09-07 10:37:25.610508 | instance | "isblk": false, 2026-09-07 10:37:25.610522 | instance | "ischr": false, 2026-09-07 10:37:25.610537 | instance | "isdir": true, 2026-09-07 10:37:25.610567 | instance | "isfifo": false, 2026-09-07 10:37:25.610582 | instance | "isgid": false, 2026-09-07 10:37:25.610597 | instance | "islnk": false, 2026-09-07 10:37:25.610634 | instance | "isreg": false, 2026-09-07 10:37:25.610653 | instance | "issock": false, 2026-09-07 10:37:25.610668 | instance | "isuid": false, 2026-09-07 10:37:25.610728 | instance | "mimetype": "unknown", 2026-09-07 10:37:25.610745 | instance | "mode": "0755", 2026-09-07 10:37:25.610760 | instance | "mtime": 1788777423.279431, 2026-09-07 10:37:25.610775 | instance | "nlink": 21, 2026-09-07 10:37:25.610789 | instance | "path": "src/github.com/vexxhost/atmosphere", 2026-09-07 10:37:25.610804 | instance | "pw_name": "zuul", 2026-09-07 10:37:25.611023 | instance | "readable": true, 2026-09-07 10:37:25.611046 | instance | "rgrp": true, 2026-09-07 10:37:25.611063 | instance | "roth": true, 2026-09-07 10:37:25.611079 | instance | "rusr": true, 2026-09-07 10:37:25.611093 | instance | "size": 4096, 2026-09-07 10:37:25.611108 | instance | "uid": 1000, 2026-09-07 10:37:25.611129 | instance | "version": "3880674293", 2026-09-07 10:37:25.611145 | instance | "wgrp": false, 2026-09-07 10:37:25.611161 | instance | "woth": false, 2026-09-07 10:37:25.611176 | instance | "writeable": true, 2026-09-07 10:37:25.611190 | instance | "wusr": true, 2026-09-07 10:37:25.611205 | instance | "xgrp": true, 2026-09-07 10:37:25.611219 | instance | "xoth": true, 2026-09-07 10:37:25.611233 | instance | "xusr": true 2026-09-07 10:37:25.611248 | instance | } 2026-09-07 10:37:25.611262 | instance | } 2026-09-07 10:37:25.611320 | instance | ok: All items complete 2026-09-07 10:37:25.611346 | 2026-09-07 10:37:25.617100 | instance | skipping: Conditional result was False 2026-09-07 10:37:25.618945 | instance | skipping: Conditional result was False 2026-09-07 10:37:25.627019 | 2026-09-07 10:37:25.627164 | LOOP [Switch "ansible_host" to private IP] 2026-09-07 10:37:26.095849 | instance | changed: 1 replacements made 2026-09-07 10:37:26.098727 | instance | skipping: Conditional result was False 2026-09-07 10:37:26.104852 | instance | skipping: Conditional result was False 2026-09-07 10:37:26.129742 | 2026-09-07 10:37:26.130181 | TASK [Run Molecule scenario] 2026-09-07 10:37:27.100471 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-09-07 10:37:27.523227 | instance | INFO [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-09-07 10:37:27.523348 | instance | INFO [csi > prerun] Performing prerun with role_name_check=0... 2026-09-07 10:37:38.424199 | instance | INFO [csi > dependency] Executing 2026-09-07 10:37:38.424515 | instance | WARNING [csi > dependency] Missing roles requirements file: requirements.yml 2026-09-07 10:37:38.424914 | instance | WARNING [csi > dependency] Missing collections requirements file: collections.yml 2026-09-07 10:37:38.425143 | instance | WARNING [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-09-07 10:37:38.439660 | instance | INFO [csi > cleanup] Executing 2026-09-07 10:37:38.440354 | instance | WARNING [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-09-07 10:37:38.452768 | instance | INFO [csi > destroy] Executing 2026-09-07 10:37:38.452830 | instance | WARNING [csi > destroy] Skipping, '--destroy=never' requested. 2026-09-07 10:37:38.452941 | instance | INFO [csi > destroy] Executed: Successful 2026-09-07 10:37:38.461856 | instance | INFO [csi > syntax] Executing 2026-09-07 10:37:39.984215 | instance | 2026-09-07 10:37:39.984443 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-09-07 10:37:40.067437 | instance | INFO [csi > syntax] Executed: Successful 2026-09-07 10:37:40.084764 | instance | INFO [csi > create] Executing 2026-09-07 10:37:40.089537 | instance | WARNING [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-09-07 10:37:40.105329 | instance | INFO [csi > prepare] Executing 2026-09-07 10:37:40.867145 | instance | 2026-09-07 10:37:40.867352 | instance | PLAY [Prepare] ***************************************************************** 2026-09-07 10:37:40.867589 | instance | 2026-09-07 10:37:40.867917 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-07 10:37:40.868183 | instance | Monday 07 September 2026 10:37:40 +0000 (0:00:00.033) 0:00:00.033 ****** 2026-09-07 10:37:42.159480 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-09-07 10:37:42.159673 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-09-07 10:37:42.159950 | instance | interpreter could change the meaning of that path. See 2026-09-07 10:37:42.160212 | instance | https://docs.ansible.com/ansible- 2026-09-07 10:37:42.160463 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-09-07 10:37:42.171011 | instance | ok: [instance] 2026-09-07 10:37:42.171258 | instance | 2026-09-07 10:37:42.171528 | instance | TASK [Configure short hostname] ************************************************ 2026-09-07 10:37:42.171779 | instance | Monday 07 September 2026 10:37:42 +0000 (0:00:01.306) 0:00:01.339 ****** 2026-09-07 10:37:42.897071 | instance | changed: [instance] 2026-09-07 10:37:42.897263 | instance | 2026-09-07 10:37:42.897525 | instance | TASK [Ensure hostname inside hosts file] *************************************** 2026-09-07 10:37:42.897806 | instance | Monday 07 September 2026 10:37:42 +0000 (0:00:00.725) 0:00:02.065 ****** 2026-09-07 10:37:43.185469 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created 2026-09-07 10:37:43.185661 | instance | with a mode of 0700, this may cause issues when running as another user. To 2026-09-07 10:37:43.185916 | instance | avoid this, create the remote_tmp dir with the correct permissions manually 2026-09-07 10:37:43.196821 | instance | changed: [instance] 2026-09-07 10:37:43.196970 | instance | 2026-09-07 10:37:43.197215 | instance | TASK [Purge "snapd" package] *************************************************** 2026-09-07 10:37:43.197454 | instance | Monday 07 September 2026 10:37:43 +0000 (0:00:00.299) 0:00:02.364 ****** 2026-09-07 10:37:44.138709 | instance | ok: [instance] 2026-09-07 10:37:44.138913 | instance | 2026-09-07 10:37:44.139150 | instance | PLAY [Create devices for Ceph] ************************************************* 2026-09-07 10:37:44.139408 | instance | 2026-09-07 10:37:44.139646 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-07 10:37:44.139904 | instance | Monday 07 September 2026 10:37:44 +0000 (0:00:00.941) 0:00:03.306 ****** 2026-09-07 10:37:44.945122 | instance | ok: [instance] 2026-09-07 10:37:44.945305 | instance | 2026-09-07 10:37:44.945550 | instance | TASK [Install depedencies] ***************************************************** 2026-09-07 10:37:44.945805 | instance | Monday 07 September 2026 10:37:44 +0000 (0:00:00.806) 0:00:04.113 ****** 2026-09-07 10:38:09.832197 | instance | changed: [instance] 2026-09-07 10:38:09.832279 | instance | 2026-09-07 10:38:09.832291 | instance | TASK [Start up service] ******************************************************** 2026-09-07 10:38:09.832302 | instance | Monday 07 September 2026 10:38:09 +0000 (0:00:24.885) 0:00:28.999 ****** 2026-09-07 10:38:10.434107 | instance | ok: [instance] 2026-09-07 10:38:10.434164 | instance | 2026-09-07 10:38:10.434176 | instance | TASK [Generate lvm.conf] ******************************************************* 2026-09-07 10:38:10.434187 | instance | Monday 07 September 2026 10:38:10 +0000 (0:00:00.601) 0:00:29.601 ****** 2026-09-07 10:38:10.781389 | instance | ok: [instance] 2026-09-07 10:38:10.781447 | instance | 2026-09-07 10:38:10.781460 | instance | TASK [Write /etc/lvm/lvm.conf] ************************************************* 2026-09-07 10:38:10.781471 | instance | Monday 07 September 2026 10:38:10 +0000 (0:00:00.347) 0:00:29.948 ****** 2026-09-07 10:38:11.562746 | instance | changed: [instance] 2026-09-07 10:38:11.563310 | instance | 2026-09-07 10:38:11.563595 | instance | TASK [Get list of all loopback devices] **************************************** 2026-09-07 10:38:11.563619 | instance | Monday 07 September 2026 10:38:11 +0000 (0:00:00.781) 0:00:30.730 ****** 2026-09-07 10:38:11.785615 | instance | ok: [instance] 2026-09-07 10:38:11.785773 | instance | 2026-09-07 10:38:11.786324 | instance | TASK [Fail if there is any existing loopback devices] ************************** 2026-09-07 10:38:11.786410 | instance | Monday 07 September 2026 10:38:11 +0000 (0:00:00.223) 0:00:30.953 ****** 2026-09-07 10:38:11.812157 | instance | skipping: [instance] 2026-09-07 10:38:11.812987 | instance | 2026-09-07 10:38:11.813034 | instance | TASK [Create devices for Ceph] ************************************************* 2026-09-07 10:38:11.813048 | instance | Monday 07 September 2026 10:38:11 +0000 (0:00:00.026) 0:00:30.979 ****** 2026-09-07 10:38:12.357002 | instance | changed: [instance] => (item=osd0) 2026-09-07 10:38:12.357239 | instance | changed: [instance] => (item=osd1) 2026-09-07 10:38:12.357629 | instance | changed: [instance] => (item=osd2) 2026-09-07 10:38:12.357912 | instance | 2026-09-07 10:38:12.358242 | instance | TASK [Set permissions on loopback devices] ************************************* 2026-09-07 10:38:12.358614 | instance | Monday 07 September 2026 10:38:12 +0000 (0:00:00.544) 0:00:31.524 ****** 2026-09-07 10:38:13.061798 | instance | changed: [instance] => (item=osd0) 2026-09-07 10:38:13.063080 | instance | changed: [instance] => (item=osd1) 2026-09-07 10:38:13.063141 | instance | changed: [instance] => (item=osd2) 2026-09-07 10:38:13.063153 | instance | 2026-09-07 10:38:13.063189 | instance | TASK [Start loop devices] ****************************************************** 2026-09-07 10:38:13.063201 | instance | Monday 07 September 2026 10:38:13 +0000 (0:00:00.704) 0:00:32.229 ****** 2026-09-07 10:38:13.790110 | instance | changed: [instance] => (item=osd0) 2026-09-07 10:38:13.791277 | instance | changed: [instance] => (item=osd1) 2026-09-07 10:38:13.791567 | instance | changed: [instance] => (item=osd2) 2026-09-07 10:38:13.791581 | instance | 2026-09-07 10:38:13.791591 | instance | TASK [Create a volume group for each loop device] ****************************** 2026-09-07 10:38:13.791608 | instance | Monday 07 September 2026 10:38:13 +0000 (0:00:00.728) 0:00:32.958 ****** 2026-09-07 10:38:17.247915 | instance | changed: [instance] => (item=osd0) 2026-09-07 10:38:17.248076 | instance | changed: [instance] => (item=osd1) 2026-09-07 10:38:17.248421 | instance | changed: [instance] => (item=osd2) 2026-09-07 10:38:17.248715 | instance | 2026-09-07 10:38:17.249021 | instance | TASK [Create a logical volume for each loop device] **************************** 2026-09-07 10:38:17.249354 | instance | Monday 07 September 2026 10:38:17 +0000 (0:00:03.457) 0:00:36.415 ****** 2026-09-07 10:38:19.267292 | instance | changed: [instance] => (item=ceph-instance-osd0) 2026-09-07 10:38:19.267365 | instance | changed: [instance] => (item=ceph-instance-osd1) 2026-09-07 10:38:19.267392 | instance | changed: [instance] => (item=ceph-instance-osd2) 2026-09-07 10:38:19.267402 | instance | 2026-09-07 10:38:19.267418 | instance | PLAY RECAP ********************************************************************* 2026-09-07 10:38:19.271297 | instance | instance : ok=15 changed=9 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-09-07 10:38:19.271379 | instance | 2026-09-07 10:38:19.271391 | instance | Monday 07 September 2026 10:38:19 +0000 (0:00:02.019) 0:00:38.435 ****** 2026-09-07 10:38:19.271401 | instance | =============================================================================== 2026-09-07 10:38:19.271410 | instance | Install depedencies ---------------------------------------------------- 24.89s 2026-09-07 10:38:19.271419 | instance | Create a volume group for each loop device ------------------------------ 3.46s 2026-09-07 10:38:19.271428 | instance | Create a logical volume for each loop device ---------------------------- 2.02s 2026-09-07 10:38:19.271439 | instance | Gathering Facts --------------------------------------------------------- 1.31s 2026-09-07 10:38:19.271448 | instance | Purge "snapd" package --------------------------------------------------- 0.94s 2026-09-07 10:38:19.271456 | instance | Gathering Facts --------------------------------------------------------- 0.81s 2026-09-07 10:38:19.271465 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.78s 2026-09-07 10:38:19.271474 | instance | Start loop devices ------------------------------------------------------ 0.73s 2026-09-07 10:38:19.271483 | instance | Configure short hostname ------------------------------------------------ 0.73s 2026-09-07 10:38:19.271491 | instance | Set permissions on loopback devices ------------------------------------- 0.70s 2026-09-07 10:38:19.271501 | instance | Start up service -------------------------------------------------------- 0.60s 2026-09-07 10:38:19.271509 | instance | Create devices for Ceph ------------------------------------------------- 0.55s 2026-09-07 10:38:19.271525 | instance | Generate lvm.conf ------------------------------------------------------- 0.35s 2026-09-07 10:38:19.271535 | instance | Ensure hostname inside hosts file --------------------------------------- 0.30s 2026-09-07 10:38:19.271821 | instance | Get list of all loopback devices ---------------------------------------- 0.22s 2026-09-07 10:38:19.272188 | instance | Fail if there is any existing loopback devices -------------------------- 0.03s 2026-09-07 10:38:19.364791 | instance | INFO [csi > prepare] Executed: Successful 2026-09-07 10:38:19.380349 | instance | INFO [csi > converge] Executing 2026-09-07 10:38:20.740047 | instance | 2026-09-07 10:38:20.740502 | instance | PLAY [Debug CSI driver value] ************************************************** 2026-09-07 10:38:20.740831 | instance | 2026-09-07 10:38:20.741237 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-07 10:38:20.741572 | instance | Monday 07 September 2026 10:38:20 +0000 (0:00:00.007) 0:00:00.007 ****** 2026-09-07 10:38:21.827809 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-09-07 10:38:21.828236 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-09-07 10:38:21.828559 | instance | interpreter could change the meaning of that path. See 2026-09-07 10:38:21.828888 | instance | https://docs.ansible.com/ansible- 2026-09-07 10:38:21.829258 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-09-07 10:38:21.841492 | instance | ok: [instance] 2026-09-07 10:38:21.841862 | instance | 2026-09-07 10:38:21.842215 | instance | TASK [Display CSI driver value and environment variable] *********************** 2026-09-07 10:38:21.842527 | instance | Monday 07 September 2026 10:38:21 +0000 (0:00:01.101) 0:00:01.108 ****** 2026-09-07 10:38:21.908480 | instance | ok: [instance] => { 2026-09-07 10:38:21.908839 | instance | "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER=" 2026-09-07 10:38:21.909116 | instance | } 2026-09-07 10:38:21.909413 | instance | 2026-09-07 10:38:21.909709 | instance | PLAY [all] ********************************************************************* 2026-09-07 10:38:21.910004 | instance | 2026-09-07 10:38:21.910301 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-07 10:38:21.910615 | instance | Monday 07 September 2026 10:38:21 +0000 (0:00:00.066) 0:00:01.175 ****** 2026-09-07 10:38:22.857189 | instance | ok: [instance] 2026-09-07 10:38:22.857555 | instance | 2026-09-07 10:38:22.857873 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-09-07 10:38:22.858200 | instance | Monday 07 September 2026 10:38:22 +0000 (0:00:00.948) 0:00:02.123 ****** 2026-09-07 10:38:23.072087 | instance | ok: [instance] 2026-09-07 10:38:23.072359 | instance | 2026-09-07 10:38:23.072550 | instance | PLAY [Deploy Ceph monitors & managers] ***************************************** 2026-09-07 10:38:23.072723 | instance | 2026-09-07 10:38:23.072902 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-07 10:38:23.073089 | instance | Monday 07 September 2026 10:38:23 +0000 (0:00:00.214) 0:00:02.338 ****** 2026-09-07 10:38:24.048068 | instance | ok: [instance] 2026-09-07 10:38:24.048282 | instance | 2026-09-07 10:38:24.048641 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-09-07 10:38:24.048950 | instance | Monday 07 September 2026 10:38:24 +0000 (0:00:00.975) 0:00:03.314 ****** 2026-09-07 10:38:24.382424 | instance | ok: [instance] 2026-09-07 10:38:24.382489 | instance | 2026-09-07 10:38:24.382501 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-09-07 10:38:24.382511 | instance | Monday 07 September 2026 10:38:24 +0000 (0:00:00.334) 0:00:03.648 ****** 2026-09-07 10:38:24.438150 | instance | skipping: [instance] 2026-09-07 10:38:24.438183 | instance | 2026-09-07 10:38:24.438190 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-09-07 10:38:24.438196 | instance | Monday 07 September 2026 10:38:24 +0000 (0:00:00.056) 0:00:03.705 ****** 2026-09-07 10:38:24.836970 | instance | changed: [instance] 2026-09-07 10:38:24.837047 | instance | 2026-09-07 10:38:24.837058 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-09-07 10:38:24.837068 | instance | Monday 07 September 2026 10:38:24 +0000 (0:00:00.397) 0:00:04.103 ****** 2026-09-07 10:38:24.934161 | instance | ok: [instance] => { 2026-09-07 10:38:24.934202 | instance | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-09-07 10:38:24.934214 | instance | } 2026-09-07 10:38:24.934224 | instance | 2026-09-07 10:38:24.934233 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-09-07 10:38:24.934242 | instance | Monday 07 September 2026 10:38:24 +0000 (0:00:00.097) 0:00:04.200 ****** 2026-09-07 10:38:25.604765 | instance | changed: [instance] 2026-09-07 10:38:25.604898 | instance | 2026-09-07 10:38:25.605457 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-09-07 10:38:25.605527 | instance | Monday 07 September 2026 10:38:25 +0000 (0:00:00.671) 0:00:04.871 ****** 2026-09-07 10:38:25.665535 | instance | skipping: [instance] 2026-09-07 10:38:25.665661 | instance | 2026-09-07 10:38:25.666029 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-09-07 10:38:25.666089 | instance | Monday 07 September 2026 10:38:25 +0000 (0:00:00.060) 0:00:04.932 ****** 2026-09-07 10:38:25.735935 | instance | skipping: [instance] 2026-09-07 10:38:25.736031 | instance | 2026-09-07 10:38:25.736156 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-09-07 10:38:25.736306 | instance | Monday 07 September 2026 10:38:25 +0000 (0:00:00.070) 0:00:05.003 ****** 2026-09-07 10:38:25.982253 | instance | ok: [instance] 2026-09-07 10:38:25.982320 | instance | 2026-09-07 10:38:25.982421 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-09-07 10:38:25.982531 | instance | Monday 07 September 2026 10:38:25 +0000 (0:00:00.246) 0:00:05.249 ****** 2026-09-07 10:38:27.381159 | instance | ok: [instance] 2026-09-07 10:38:27.381354 | instance | 2026-09-07 10:38:27.381595 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-09-07 10:38:27.381847 | instance | Monday 07 September 2026 10:38:27 +0000 (0:00:01.398) 0:00:06.648 ****** 2026-09-07 10:38:27.465391 | instance | ok: [instance] => { 2026-09-07 10:38:27.465636 | instance | "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz" 2026-09-07 10:38:27.465863 | instance | } 2026-09-07 10:38:27.466078 | instance | 2026-09-07 10:38:27.466333 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-09-07 10:38:27.466568 | instance | Monday 07 September 2026 10:38:27 +0000 (0:00:00.084) 0:00:06.732 ****** 2026-09-07 10:38:28.131051 | instance | changed: [instance] 2026-09-07 10:38:28.131317 | instance | 2026-09-07 10:38:28.131560 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-09-07 10:38:28.131784 | instance | Monday 07 September 2026 10:38:28 +0000 (0:00:00.665) 0:00:07.398 ****** 2026-09-07 10:38:31.086175 | instance | changed: [instance] 2026-09-07 10:38:31.086251 | instance | 2026-09-07 10:38:31.086262 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-09-07 10:38:31.086273 | instance | Monday 07 September 2026 10:38:31 +0000 (0:00:02.954) 0:00:10.352 ****** 2026-09-07 10:38:31.129361 | instance | skipping: [instance] 2026-09-07 10:38:31.130160 | instance | 2026-09-07 10:38:31.130229 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-09-07 10:38:31.130242 | instance | Monday 07 September 2026 10:38:31 +0000 (0:00:00.043) 0:00:10.396 ****** 2026-09-07 10:38:31.172669 | instance | skipping: [instance] 2026-09-07 10:38:31.173754 | instance | 2026-09-07 10:38:31.173792 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-09-07 10:38:31.173804 | instance | Monday 07 September 2026 10:38:31 +0000 (0:00:00.043) 0:00:10.439 ****** 2026-09-07 10:38:31.216424 | instance | skipping: [instance] 2026-09-07 10:38:31.216772 | instance | 2026-09-07 10:38:31.217241 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-09-07 10:38:31.217607 | instance | Monday 07 September 2026 10:38:31 +0000 (0:00:00.043) 0:00:10.483 ****** 2026-09-07 10:38:37.397821 | instance | changed: [instance] 2026-09-07 10:38:37.398225 | instance | 2026-09-07 10:38:37.398246 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] *** 2026-09-07 10:38:37.398262 | instance | Monday 07 September 2026 10:38:37 +0000 (0:00:06.181) 0:00:16.665 ****** 2026-09-07 10:38:38.036359 | instance | changed: [instance] 2026-09-07 10:38:38.037102 | instance | 2026-09-07 10:38:38.037170 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] ******* 2026-09-07 10:38:38.037182 | instance | Monday 07 September 2026 10:38:38 +0000 (0:00:00.637) 0:00:17.303 ****** 2026-09-07 10:38:39.074029 | instance | changed: [instance] => (item={'path': '/etc/containerd'}) 2026-09-07 10:38:39.075727 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'}) 2026-09-07 10:38:39.075797 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'}) 2026-09-07 10:38:39.075809 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'}) 2026-09-07 10:38:39.075820 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'}) 2026-09-07 10:38:39.075829 | instance | 2026-09-07 10:38:39.075846 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] ********** 2026-09-07 10:38:39.075855 | instance | Monday 07 September 2026 10:38:39 +0000 (0:00:01.037) 0:00:18.341 ****** 2026-09-07 10:38:39.714320 | instance | changed: [instance] 2026-09-07 10:38:39.714387 | instance | 2026-09-07 10:38:39.715181 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ******** 2026-09-07 10:38:39.715249 | instance | Monday 07 September 2026 10:38:39 +0000 (0:00:00.612) 0:00:18.954 ****** 2026-09-07 10:38:39.715256 | instance | 2026-09-07 10:38:39.715262 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-09-07 10:38:39.715268 | instance | Monday 07 September 2026 10:38:39 +0000 (0:00:00.027) 0:00:18.981 ****** 2026-09-07 10:38:40.682292 | instance | ok: [instance] 2026-09-07 10:38:40.683033 | instance | 2026-09-07 10:38:40.683096 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] ********** 2026-09-07 10:38:40.683108 | instance | Monday 07 September 2026 10:38:40 +0000 (0:00:00.967) 0:00:19.949 ****** 2026-09-07 10:38:41.190448 | instance | changed: [instance] 2026-09-07 10:38:41.191220 | instance | 2026-09-07 10:38:41.191300 | instance | TASK [vexxhost.containers.containerd : Enable and start service] *************** 2026-09-07 10:38:41.191312 | instance | Monday 07 September 2026 10:38:41 +0000 (0:00:00.508) 0:00:20.457 ****** 2026-09-07 10:38:41.799288 | instance | changed: [instance] 2026-09-07 10:38:41.799381 | instance | 2026-09-07 10:38:41.799716 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-09-07 10:38:41.799986 | instance | Monday 07 September 2026 10:38:41 +0000 (0:00:00.609) 0:00:21.066 ****** 2026-09-07 10:38:42.044509 | instance | ok: [instance] 2026-09-07 10:38:42.045196 | instance | 2026-09-07 10:38:42.045264 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-09-07 10:38:42.045275 | instance | Monday 07 September 2026 10:38:42 +0000 (0:00:00.244) 0:00:21.311 ****** 2026-09-07 10:38:42.132760 | instance | ok: [instance] => { 2026-09-07 10:38:42.134139 | instance | "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz" 2026-09-07 10:38:42.134215 | instance | } 2026-09-07 10:38:42.134228 | instance | 2026-09-07 10:38:42.134239 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-09-07 10:38:42.134250 | instance | Monday 07 September 2026 10:38:42 +0000 (0:00:00.087) 0:00:21.399 ****** 2026-09-07 10:40:03.368650 | instance | changed: [instance] 2026-09-07 10:40:03.368724 | instance | 2026-09-07 10:40:03.368736 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-09-07 10:40:03.368748 | instance | Monday 07 September 2026 10:40:03 +0000 (0:01:21.234) 0:01:42.634 ****** 2026-09-07 10:40:07.795375 | instance | changed: [instance] 2026-09-07 10:40:07.795523 | instance | 2026-09-07 10:40:07.795906 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ****************** 2026-09-07 10:40:07.795963 | instance | Monday 07 September 2026 10:40:07 +0000 (0:00:04.428) 0:01:47.062 ****** 2026-09-07 10:40:09.173575 | instance | ok: [instance] 2026-09-07 10:40:09.173848 | instance | 2026-09-07 10:40:09.173861 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] *************** 2026-09-07 10:40:09.173991 | instance | Monday 07 September 2026 10:40:09 +0000 (0:00:01.378) 0:01:48.441 ****** 2026-09-07 10:40:09.598115 | instance | changed: [instance] 2026-09-07 10:40:09.598201 | instance | 2026-09-07 10:40:09.598434 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] ***** 2026-09-07 10:40:09.598490 | instance | Monday 07 September 2026 10:40:09 +0000 (0:00:00.424) 0:01:48.865 ****** 2026-09-07 10:40:10.123844 | instance | changed: [instance] 2026-09-07 10:40:10.123896 | instance | 2026-09-07 10:40:10.123903 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] *********** 2026-09-07 10:40:10.123910 | instance | Monday 07 September 2026 10:40:10 +0000 (0:00:00.525) 0:01:49.390 ****** 2026-09-07 10:40:10.783739 | instance | changed: [instance] => (item={'path': '/etc/docker'}) 2026-09-07 10:40:10.783822 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'}) 2026-09-07 10:40:10.784390 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'}) 2026-09-07 10:40:10.784446 | instance | 2026-09-07 10:40:10.784452 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ****** 2026-09-07 10:40:10.784457 | instance | Monday 07 September 2026 10:40:10 +0000 (0:00:00.660) 0:01:50.051 ****** 2026-09-07 10:40:11.308980 | instance | changed: [instance] 2026-09-07 10:40:11.309487 | instance | 2026-09-07 10:40:11.309562 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] *********** 2026-09-07 10:40:11.309717 | instance | Monday 07 September 2026 10:40:11 +0000 (0:00:00.524) 0:01:50.575 ****** 2026-09-07 10:40:11.872710 | instance | changed: [instance] 2026-09-07 10:40:11.872779 | instance | 2026-09-07 10:40:11.872788 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************ 2026-09-07 10:40:11.872794 | instance | Monday 07 September 2026 10:40:11 +0000 (0:00:00.534) 0:01:51.110 ****** 2026-09-07 10:40:11.872800 | instance | 2026-09-07 10:40:11.872805 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-09-07 10:40:11.872810 | instance | Monday 07 September 2026 10:40:11 +0000 (0:00:00.028) 0:01:51.138 ****** 2026-09-07 10:40:12.578476 | instance | ok: [instance] 2026-09-07 10:40:12.579321 | instance | 2026-09-07 10:40:12.579411 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ****************** 2026-09-07 10:40:12.579436 | instance | Monday 07 September 2026 10:40:12 +0000 (0:00:00.706) 0:01:51.845 ****** 2026-09-07 10:40:13.298502 | instance | changed: [instance] 2026-09-07 10:40:13.298611 | instance | 2026-09-07 10:40:13.298996 | instance | TASK [vexxhost.containers.docker : Enable and start service] ******************* 2026-09-07 10:40:13.299064 | instance | Monday 07 September 2026 10:40:13 +0000 (0:00:00.720) 0:01:52.565 ****** 2026-09-07 10:40:13.954153 | instance | changed: [instance] 2026-09-07 10:40:13.954279 | instance | 2026-09-07 10:40:13.954292 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ****** 2026-09-07 10:40:13.954303 | instance | Monday 07 September 2026 10:40:13 +0000 (0:00:00.654) 0:01:53.219 ****** 2026-09-07 10:40:14.024476 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml) 2026-09-07 10:40:14.025241 | instance | 2026-09-07 10:40:14.025324 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ******************************** 2026-09-07 10:40:14.025337 | instance | Monday 07 September 2026 10:40:14 +0000 (0:00:00.071) 0:01:53.291 ****** 2026-09-07 10:40:19.901333 | instance | changed: [instance] 2026-09-07 10:40:19.902042 | instance | 2026-09-07 10:40:19.902109 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] ********************* 2026-09-07 10:40:19.902120 | instance | Monday 07 September 2026 10:40:19 +0000 (0:00:05.876) 0:01:59.168 ****** 2026-09-07 10:40:20.632969 | instance | ok: [instance] => (item=chronyd) 2026-09-07 10:40:20.633891 | instance | ok: [instance] => (item=sshd) 2026-09-07 10:40:20.633924 | instance | 2026-09-07 10:40:20.633935 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ****************************** 2026-09-07 10:40:20.633945 | instance | Monday 07 September 2026 10:40:20 +0000 (0:00:00.731) 0:01:59.899 ****** 2026-09-07 10:40:25.195402 | instance | changed: [instance] 2026-09-07 10:40:25.195591 | instance | 2026-09-07 10:40:25.195825 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ******************** 2026-09-07 10:40:25.196051 | instance | Monday 07 September 2026 10:40:25 +0000 (0:00:04.562) 0:02:04.462 ****** 2026-09-07 10:40:25.416033 | instance | ok: [instance] 2026-09-07 10:40:25.416226 | instance | 2026-09-07 10:40:25.416504 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] **************** 2026-09-07 10:40:25.416748 | instance | Monday 07 September 2026 10:40:25 +0000 (0:00:00.220) 0:02:04.682 ****** 2026-09-07 10:40:25.905160 | instance | changed: [instance] 2026-09-07 10:40:25.905262 | instance | 2026-09-07 10:40:25.905444 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] *** 2026-09-07 10:40:25.905599 | instance | Monday 07 September 2026 10:40:25 +0000 (0:00:00.489) 0:02:05.172 ****** 2026-09-07 10:40:26.279494 | instance | changed: [instance] 2026-09-07 10:40:26.279721 | instance | 2026-09-07 10:40:26.279927 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] ************************* 2026-09-07 10:40:26.280171 | instance | Monday 07 September 2026 10:40:26 +0000 (0:00:00.374) 0:02:05.546 ****** 2026-09-07 10:40:26.422268 | instance | ok: [instance] 2026-09-07 10:40:26.422473 | instance | 2026-09-07 10:40:26.422716 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] ******************* 2026-09-07 10:40:26.422999 | instance | Monday 07 September 2026 10:40:26 +0000 (0:00:00.142) 0:02:05.688 ****** 2026-09-07 10:40:26.683577 | instance | ok: [instance] => (item=instance) 2026-09-07 10:40:26.683733 | instance | 2026-09-07 10:40:26.683984 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ******** 2026-09-07 10:40:26.684235 | instance | Monday 07 September 2026 10:40:26 +0000 (0:00:00.261) 0:02:05.950 ****** 2026-09-07 10:40:26.737203 | instance | ok: [instance] 2026-09-07 10:40:26.737460 | instance | 2026-09-07 10:40:26.737818 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] *********************************** 2026-09-07 10:40:26.738092 | instance | Monday 07 September 2026 10:40:26 +0000 (0:00:00.054) 0:02:06.004 ****** 2026-09-07 10:40:26.808594 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance 2026-09-07 10:40:26.808778 | instance | 2026-09-07 10:40:26.809040 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] ************* 2026-09-07 10:40:26.809277 | instance | Monday 07 September 2026 10:40:26 +0000 (0:00:00.071) 0:02:06.076 ****** 2026-09-07 10:40:27.154746 | instance | changed: [instance] 2026-09-07 10:40:27.154954 | instance | 2026-09-07 10:40:27.155215 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ****************** 2026-09-07 10:40:27.155472 | instance | Monday 07 September 2026 10:40:27 +0000 (0:00:00.345) 0:02:06.421 ****** 2026-09-07 10:40:27.926453 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True}) 2026-09-07 10:40:27.926521 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0}) 2026-09-07 10:40:27.926532 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False}) 2026-09-07 10:40:27.926542 | instance | 2026-09-07 10:40:27.926551 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] ******************************* 2026-09-07 10:40:27.926560 | instance | Monday 07 September 2026 10:40:27 +0000 (0:00:00.770) 0:02:07.192 ****** 2026-09-07 10:42:01.663364 | instance | ok: [instance] 2026-09-07 10:42:01.663451 | instance | 2026-09-07 10:42:01.663478 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] *************** 2026-09-07 10:42:01.663611 | instance | Monday 07 September 2026 10:42:01 +0000 (0:01:33.737) 0:03:40.930 ****** 2026-09-07 10:42:01.951685 | instance | changed: [instance] 2026-09-07 10:42:01.951885 | instance | 2026-09-07 10:42:01.952133 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] ********************************** 2026-09-07 10:42:01.952361 | instance | Monday 07 September 2026 10:42:01 +0000 (0:00:00.288) 0:03:41.218 ****** 2026-09-07 10:42:02.066456 | instance | ok: [instance] 2026-09-07 10:42:02.066506 | instance | 2026-09-07 10:42:02.066777 | instance | TASK [Install Ceph host] ******************************************************* 2026-09-07 10:42:02.066844 | instance | Monday 07 September 2026 10:42:02 +0000 (0:00:00.115) 0:03:41.333 ****** 2026-09-07 10:42:02.155944 | instance | included: vexxhost.ceph.cephadm_host for instance 2026-09-07 10:42:02.156033 | instance | 2026-09-07 10:42:02.156293 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ****** 2026-09-07 10:42:02.156342 | instance | Monday 07 September 2026 10:42:02 +0000 (0:00:00.089) 0:03:41.423 ****** 2026-09-07 10:42:03.902687 | instance | ok: [instance] 2026-09-07 10:42:03.902960 | instance | 2026-09-07 10:42:03.903277 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] *** 2026-09-07 10:42:03.903536 | instance | Monday 07 September 2026 10:42:03 +0000 (0:00:01.745) 0:03:43.169 ****** 2026-09-07 10:42:03.984605 | instance | ok: [instance] => (item=instance) 2026-09-07 10:42:03.984807 | instance | 2026-09-07 10:42:03.985080 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] *********** 2026-09-07 10:42:03.985313 | instance | Monday 07 September 2026 10:42:03 +0000 (0:00:00.082) 0:03:43.251 ****** 2026-09-07 10:42:04.369313 | instance | ok: [instance] 2026-09-07 10:42:04.369387 | instance | 2026-09-07 10:42:04.369554 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] *********************** 2026-09-07 10:42:04.369700 | instance | Monday 07 September 2026 10:42:04 +0000 (0:00:00.385) 0:03:43.636 ****** 2026-09-07 10:42:06.680147 | instance | ok: [instance] 2026-09-07 10:42:06.680627 | instance | 2026-09-07 10:42:06.680677 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ****************** 2026-09-07 10:42:06.680685 | instance | Monday 07 September 2026 10:42:06 +0000 (0:00:02.310) 0:03:45.947 ****** 2026-09-07 10:42:58.574779 | 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-07 10:42:58.575612 | 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_w6gqvtl5/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_w6gqvtl5/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_w6gqvtl5/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_w6gqvtl5/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-07T10:42:58.373+0000 7f121f0c1640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgDPlJ5qoWIIGiAAFDiOAuw19hxzy7q5IjP1gn2iiDKi/bQB3I4zXy2OcYI=: Malformed input [buffer:3]\n2026-09-07T10:42:58.373+0000 7f121f0c1640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-07T10:42:58.377+0000 7f121f0c1640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgDPlJ5qoWIIGiAAFDiOAuw19hxzy7q5IjP1gn2iiDKi/bQB3I4zXy2OcYI=: Malformed input [buffer:3]\n2026-09-07T10:42:58.377+0000 7f121f0c1640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-07T10:42:58.377+0000 7f121f0c1640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgDPlJ5qoWIIGiAAFDiOAuw19hxzy7q5IjP1gn2iiDKi/bQB3I4zXy2OcYI=: Malformed input [buffer:3]\n2026-09-07T10:42:58.377+0000 7f121f0c1640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-07T10:42:58.377+0000 7f121f0c1640 -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-07 10:42:58.578317 | instance | 2026-09-07 10:42:58.579272 | instance | PLAY RECAP ********************************************************************* 2026-09-07 10:42:58.579342 | instance | instance : ok=55 changed=26 unreachable=0 failed=1 skipped=6 rescued=0 ignored=0 2026-09-07 10:42:58.579354 | instance | 2026-09-07 10:42:58.579371 | instance | Monday 07 September 2026 10:42:58 +0000 (0:00:51.899) 0:04:37.846 ****** 2026-09-07 10:42:58.583307 | instance | =============================================================================== 2026-09-07 10:42:58.583378 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 93.74s 2026-09-07 10:42:58.583388 | instance | vexxhost.containers.download_artifact : Download item ------------------ 81.23s 2026-09-07 10:42:58.583397 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 51.90s 2026-09-07 10:42:58.583405 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 6.18s 2026-09-07 10:42:58.583413 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 5.88s 2026-09-07 10:42:58.583421 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 4.56s 2026-09-07 10:42:58.583429 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.43s 2026-09-07 10:42:58.583437 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.95s 2026-09-07 10:42:58.583466 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.31s 2026-09-07 10:42:58.583474 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.75s 2026-09-07 10:42:58.583482 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.67s 2026-09-07 10:42:58.583490 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.40s 2026-09-07 10:42:58.583498 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.38s 2026-09-07 10:42:58.583506 | instance | Gathering Facts --------------------------------------------------------- 1.10s 2026-09-07 10:42:58.583514 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 1.04s 2026-09-07 10:42:58.583522 | instance | Gathering Facts --------------------------------------------------------- 0.98s 2026-09-07 10:42:58.583530 | instance | Gathering Facts --------------------------------------------------------- 0.95s 2026-09-07 10:42:58.583546 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.77s 2026-09-07 10:42:58.583659 | instance | vexxhost.ceph.cephadm : Ensure services are started --------------------- 0.73s 2026-09-07 10:42:58.583982 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 0.72s 2026-09-07 10:42:58.684768 | 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-07 10:42:58.685055 | instance | ERROR [csi > converge] Executed: Failed 2026-09-07 10:42:58.685236 | 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-07 10:42:59.137092 | instance | ERROR 2026-09-07 10:42:59.137256 | instance | { 2026-09-07 10:42:59.137296 | instance | "delta": "0:05:32.267675", 2026-09-07 10:42:59.137314 | instance | "end": "2026-09-07 10:42:58.751584", 2026-09-07 10:42:59.137330 | instance | "msg": "non-zero return code", 2026-09-07 10:42:59.137345 | instance | "rc": 2, 2026-09-07 10:42:59.137360 | instance | "start": "2026-09-07 10:37:26.483909" 2026-09-07 10:42:59.137375 | instance | } failure 2026-09-07 10:42:59.142067 | 2026-09-07 10:42:59.142117 | PLAY RECAP 2026-09-07 10:42:59.142157 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-09-07 10:42:59.142176 | 2026-09-07 10:42:59.258714 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-09-07 10:42:59.264683 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-09-07 10:42:59.850218 | 2026-09-07 10:42:59.850321 | PLAY [all] 2026-09-07 10:42:59.864063 | 2026-09-07 10:42:59.864147 | TASK [gather-host-logs : creating directory for system status] 2026-09-07 10:43:00.214212 | instance | changed 2026-09-07 10:43:00.224343 | 2026-09-07 10:43:00.224549 | TASK [gather-host-logs : Get logs for each host] 2026-09-07 10:43:00.602751 | instance | + systemd-cgls --full --all --no-pager 2026-09-07 10:43:00.621454 | instance | + ip addr 2026-09-07 10:43:00.624047 | instance | + ip route 2026-09-07 10:43:00.626788 | instance | + lsblk 2026-09-07 10:43:00.632108 | instance | + mount 2026-09-07 10:43:00.634559 | instance | + docker images 2026-09-07 10:43:00.659572 | instance | + brctl show 2026-09-07 10:43:00.660177 | instance | /bin/bash: line 8: brctl: command not found 2026-09-07 10:43:00.660522 | instance | + ps aux --sort=-%mem 2026-09-07 10:43:00.681116 | instance | + dpkg -l 2026-09-07 10:43:00.693790 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-09-07 10:43:00.694290 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-09-07 10:43:00.713597 | instance | + '[' '!' -z '' ']' 2026-09-07 10:43:00.774818 | instance | ok: Runtime: 0:00:00.116578 2026-09-07 10:43:00.786241 | 2026-09-07 10:43:00.786386 | TASK [gather-host-logs : Downloads logs to executor] 2026-09-07 10:43:01.462870 | instance | changed: 2026-09-07 10:43:01.463050 | instance | created directory /var/lib/zuul/builds/0d3bfbef84d54de5a1d047a6eb084ad0/work/logs/instance 2026-09-07 10:43:01.463087 | instance | cd+++++++++ system/ 2026-09-07 10:43:01.463114 | instance | >f+++++++++ system/brctl-show.txt 2026-09-07 10:43:01.463140 | instance | >f+++++++++ system/docker-images.txt 2026-09-07 10:43:01.463164 | instance | >f+++++++++ system/ip-addr.txt 2026-09-07 10:43:01.463192 | instance | >f+++++++++ system/ip-route.txt 2026-09-07 10:43:01.463217 | instance | >f+++++++++ system/lsblk.txt 2026-09-07 10:43:01.463241 | instance | >f+++++++++ system/mount.txt 2026-09-07 10:43:01.463264 | instance | >f+++++++++ system/packages.txt 2026-09-07 10:43:01.463287 | instance | >f+++++++++ system/ps.txt 2026-09-07 10:43:01.463312 | instance | >f+++++++++ system/systemd-cgls.txt 2026-09-07 10:43:01.475066 | 2026-09-07 10:43:01.475198 | LOOP [helm-release-status : creating directory for helm release status] 2026-09-07 10:43:01.702614 | instance | changed: "values" 2026-09-07 10:43:01.882030 | instance | changed: "releases" 2026-09-07 10:43:01.901498 | 2026-09-07 10:43:01.901766 | TASK [helm-release-status : Gather get release status for helm charts] 2026-09-07 10:43:02.148604 | instance | /bin/bash: line 3: kubectl: command not found 2026-09-07 10:43:02.443119 | instance | ok: Runtime: 0:00:00.005728 2026-09-07 10:43:02.449424 | 2026-09-07 10:43:02.449542 | TASK [helm-release-status : Downloads logs to executor] 2026-09-07 10:43:02.960165 | instance | changed: 2026-09-07 10:43:02.960468 | instance | cd+++++++++ helm/ 2026-09-07 10:43:02.960637 | instance | cd+++++++++ helm/releases/ 2026-09-07 10:43:02.960693 | instance | cd+++++++++ helm/values/ 2026-09-07 10:43:02.978921 | 2026-09-07 10:43:02.979070 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-09-07 10:43:03.206889 | instance | changed 2026-09-07 10:43:03.219330 | 2026-09-07 10:43:03.219516 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-09-07 10:43:03.539133 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-07 10:43:03.539316 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-07 10:43:03.543489 | instance | environment: line 1: kubectl: command not found 2026-09-07 10:43:03.544923 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-07 10:43:03.547225 | instance | environment: line 1: kubectl: command not found 2026-09-07 10:43:03.548887 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-07 10:43:03.549593 | instance | environment: line 1: kubectl: command not found 2026-09-07 10:43:03.551266 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-07 10:43:03.552482 | instance | environment: line 1: kubectl: command not found 2026-09-07 10:43:03.553901 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-07 10:43:03.554544 | instance | environment: line 1: kubectl: command not found 2026-09-07 10:43:03.556581 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-07 10:43:03.760789 | instance | ok: Runtime: 0:00:00.025248 2026-09-07 10:43:03.769958 | 2026-09-07 10:43:03.770081 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-09-07 10:43:03.966979 | instance | changed 2026-09-07 10:43:03.977087 | 2026-09-07 10:43:03.977262 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-09-07 10:43:04.207519 | instance | environment: line 5: kubectl: command not found 2026-09-07 10:43:04.208123 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-07 10:43:04.208308 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-07 10:43:04.208713 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-07 10:43:04.522917 | instance | ok: Runtime: 0:00:00.007969 2026-09-07 10:43:04.533610 | 2026-09-07 10:43:04.533807 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-09-07 10:43:05.074951 | instance | changed: 2026-09-07 10:43:05.075202 | instance | cd+++++++++ objects/ 2026-09-07 10:43:05.075262 | instance | cd+++++++++ objects/cluster/ 2026-09-07 10:43:05.075311 | instance | cd+++++++++ objects/namespaced/ 2026-09-07 10:43:05.093457 | 2026-09-07 10:43:05.093654 | TASK [gather-pod-logs : creating directory for pod logs] 2026-09-07 10:43:05.271094 | instance | changed 2026-09-07 10:43:05.280360 | 2026-09-07 10:43:05.280486 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-09-07 10:43:05.479775 | instance | changed 2026-09-07 10:43:05.489634 | 2026-09-07 10:43:05.489800 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-09-07 10:43:05.730946 | instance | environment: line 3: kubectl: command not found 2026-09-07 10:43:06.034240 | instance | ok: Runtime: 0:00:00.009115 2026-09-07 10:43:06.038703 | 2026-09-07 10:43:06.038784 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-09-07 10:43:06.568910 | instance | changed: 2026-09-07 10:43:06.569165 | instance | cd+++++++++ pod-logs/ 2026-09-07 10:43:06.569245 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-09-07 10:43:06.587720 | 2026-09-07 10:43:06.587876 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-09-07 10:43:06.806744 | instance | changed 2026-09-07 10:43:06.817288 | 2026-09-07 10:43:06.818057 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-09-07 10:43:07.075667 | instance | /bin/bash: line 2: kubectl: command not found 2026-09-07 10:43:07.370684 | instance | ok: Runtime: 0:00:00.031774 2026-09-07 10:43:07.381318 | 2026-09-07 10:43:07.381477 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-09-07 10:43:07.627425 | instance | /bin/bash: line 2: kubectl: command not found 2026-09-07 10:43:07.656634 | instance | ceph-mgr endpoints: 2026-09-07 10:43:07.934029 | instance | ok: Runtime: 0:00:00.037024 2026-09-07 10:43:07.946134 | 2026-09-07 10:43:07.946335 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-09-07 10:43:08.221626 | instance | /bin/bash: line 4: kubectl: command not found 2026-09-07 10:43:08.493911 | instance | ok: Runtime: 0:00:00.050825 2026-09-07 10:43:08.504155 | 2026-09-07 10:43:08.504290 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-09-07 10:43:09.075506 | instance | changed: cd+++++++++ prometheus/ 2026-09-07 10:43:09.094084 | 2026-09-07 10:43:09.094238 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-09-07 10:43:09.335292 | instance | changed 2026-09-07 10:43:09.345690 | 2026-09-07 10:43:09.345872 | TASK [gather-selenium-data : Get selenium data] 2026-09-07 10:43:09.621422 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-09-07 10:43:09.622911 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-09-07 10:43:09.888860 | instance | ERROR 2026-09-07 10:43:09.889091 | instance | { 2026-09-07 10:43:09.889153 | instance | "delta": "0:00:00.007780", 2026-09-07 10:43:09.889195 | instance | "end": "2026-09-07 10:43:09.623347", 2026-09-07 10:43:09.889236 | instance | "msg": "non-zero return code", 2026-09-07 10:43:09.889273 | instance | "rc": 1, 2026-09-07 10:43:09.889308 | instance | "start": "2026-09-07 10:43:09.615567" 2026-09-07 10:43:09.889343 | instance | } 2026-09-07 10:43:09.889388 | instance | ERROR: Ignoring Errors 2026-09-07 10:43:09.899193 | 2026-09-07 10:43:09.899335 | TASK [gather-selenium-data : Downloads logs to executor] 2026-09-07 10:43:10.408651 | instance | changed: cd+++++++++ selenium/ 2026-09-07 10:43:10.415578 | 2026-09-07 10:43:10.415648 | PLAY RECAP 2026-09-07 10:43:10.415709 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-09-07 10:43:10.415736 | 2026-09-07 10:43:10.636349 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-09-07 10:43:10.639346 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-09-07 10:43:11.286412 | 2026-09-07 10:43:11.286580 | PLAY [all] 2026-09-07 10:43:11.300677 | 2026-09-07 10:43:11.300781 | TASK [fetch-output : Set log path for multiple nodes] 2026-09-07 10:43:11.366135 | instance | skipping: Conditional result was False 2026-09-07 10:43:11.372937 | 2026-09-07 10:43:11.373047 | TASK [fetch-output : Set log path for single node] 2026-09-07 10:43:11.427611 | instance | ok 2026-09-07 10:43:11.437313 | 2026-09-07 10:43:11.437459 | LOOP [fetch-output : Ensure local output dirs] 2026-09-07 10:43:11.883641 | instance -> localhost | ok: "/var/lib/zuul/builds/0d3bfbef84d54de5a1d047a6eb084ad0/work/logs" 2026-09-07 10:43:12.123641 | instance -> localhost | changed: "/var/lib/zuul/builds/0d3bfbef84d54de5a1d047a6eb084ad0/work/artifacts" 2026-09-07 10:43:12.352611 | instance -> localhost | changed: "/var/lib/zuul/builds/0d3bfbef84d54de5a1d047a6eb084ad0/work/docs" 2026-09-07 10:43:12.364788 | 2026-09-07 10:43:12.364971 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-07 10:43:13.084074 | instance | changed: .d..t...... ./ 2026-09-07 10:43:13.084446 | instance | changed: All items complete 2026-09-07 10:43:13.084709 | 2026-09-07 10:43:13.596275 | instance | changed: .d..t...... ./ 2026-09-07 10:43:14.124010 | instance | changed: .d..t...... ./ 2026-09-07 10:43:14.151142 | 2026-09-07 10:43:14.151323 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-07 10:43:14.604003 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.006252 2026-09-07 10:43:14.858274 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.005041 2026-09-07 10:43:14.872678 | 2026-09-07 10:43:14.872815 | PLAY [all] 2026-09-07 10:43:14.880234 | 2026-09-07 10:43:14.880365 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-07 10:43:15.286912 | instance | changed 2026-09-07 10:43:15.297743 | 2026-09-07 10:43:15.297937 | PLAY RECAP 2026-09-07 10:43:15.298027 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-09-07 10:43:15.298072 | 2026-09-07 10:43:15.463362 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-09-07 10:43:15.470221 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-07 10:43:16.128469 | 2026-09-07 10:43:16.128664 | PLAY [localhost] 2026-09-07 10:43:16.137143 | 2026-09-07 10:43:16.137210 | TASK [Generate Zuul manifest] 2026-09-07 10:43:16.152728 | localhost | ok 2026-09-07 10:43:16.171060 | 2026-09-07 10:43:16.171169 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-07 10:43:16.566559 | localhost | changed 2026-09-07 10:43:16.588299 | 2026-09-07 10:43:16.588476 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-07 10:43:16.622353 | localhost | ok 2026-09-07 10:43:16.637579 | 2026-09-07 10:43:16.637724 | TASK [Upload logs] 2026-09-07 10:43:16.672971 | localhost | ok 2026-09-07 10:43:16.744301 | 2026-09-07 10:43:16.744407 | TASK [Set zuul-log-path fact] 2026-09-07 10:43:16.759843 | localhost | ok 2026-09-07 10:43:16.772074 | 2026-09-07 10:43:16.772174 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-07 10:43:16.800116 | localhost | ok 2026-09-07 10:43:16.808075 | 2026-09-07 10:43:16.808176 | TASK [upload-logs : Create log directories] 2026-09-07 10:43:17.259931 | localhost | changed 2026-09-07 10:43:17.265354 | 2026-09-07 10:43:17.265437 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-07 10:43:17.701392 | localhost -> localhost | ok: Runtime: 0:00:00.008913 2026-09-07 10:43:17.707680 | 2026-09-07 10:43:17.707825 | TASK [upload-logs : Upload logs to log server] 2026-09-07 10:43:18.187390 | localhost | Output suppressed because no_log was given 2026-09-07 10:43:18.219023 | 2026-09-07 10:43:18.219122 | LOOP [upload-logs : Compress console log and json output] 2026-09-07 10:43:18.256061 | localhost | skipping: Conditional result was False 2026-09-07 10:43:18.265440 | localhost | skipping: Conditional result was False 2026-09-07 10:43:18.281244 | 2026-09-07 10:43:18.281467 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-07 10:43:18.319854 | localhost | skipping: Conditional result was False 2026-09-07 10:43:18.320029 | 2026-09-07 10:43:18.326093 | localhost | skipping: Conditional result was False 2026-09-07 10:43:18.334964 | 2026-09-07 10:43:18.335144 | LOOP [upload-logs : Upload console log and json output]