2026-09-17 20:13:08.192190 | Job console starting 2026-09-17 20:13:08.205491 | Updating git repos 2026-09-17 20:13:10.815070 | Cloning repos into workspace 2026-09-17 20:13:28.131419 | Restoring repo states 2026-09-17 20:13:36.287202 | Merging changes 2026-09-17 20:13:37.433533 | Checking out repos 2026-09-17 20:13:39.264668 | Preparing playbooks 2026-09-17 20:13:41.950344 | Running Ansible setup 2026-09-17 20:13:45.567984 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-09-17 20:13:46.144059 | 2026-09-17 20:13:46.144192 | PLAY [localhost] 2026-09-17 20:13:46.151461 | 2026-09-17 20:13:46.151560 | TASK [Gathering Facts] 2026-09-17 20:13:46.989573 | localhost | ok 2026-09-17 20:13:46.999182 | 2026-09-17 20:13:46.999318 | TASK [Setup log path fact] 2026-09-17 20:13:47.018962 | localhost | ok 2026-09-17 20:13:47.037873 | 2026-09-17 20:13:47.038032 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-17 20:13:47.066892 | localhost | ok 2026-09-17 20:13:47.075252 | 2026-09-17 20:13:47.075378 | TASK [emit-job-header : Print job information] 2026-09-17 20:13:47.115036 | # Job Information 2026-09-17 20:13:47.115259 | Ansible Version: 2.16.18 2026-09-17 20:13:47.115311 | Job: atmosphere-molecule-csi-rbd 2026-09-17 20:13:47.115367 | Pipeline: check 2026-09-17 20:13:47.115406 | Executor: 2d72f0692154 2026-09-17 20:13:47.115440 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4381 2026-09-17 20:13:47.115480 | Event ID: 8f2caf70-b2d3-11f1-97e6-5ff7e2deb355 2026-09-17 20:13:47.119988 | 2026-09-17 20:13:47.120145 | LOOP [emit-job-header : Print node information] 2026-09-17 20:13:47.223952 | localhost | ok: 2026-09-17 20:13:47.224464 | localhost | # Node Information 2026-09-17 20:13:47.224537 | localhost | Inventory Hostname: instance 2026-09-17 20:13:47.224570 | localhost | Hostname: np0000193106 2026-09-17 20:13:47.224598 | localhost | Username: zuul 2026-09-17 20:13:47.224629 | localhost | Distro: Ubuntu 22.04 2026-09-17 20:13:47.224657 | localhost | Provider: yul1 2026-09-17 20:13:47.224683 | localhost | Region: ca-ymq-1 2026-09-17 20:13:47.224708 | localhost | Label: ubuntu-jammy 2026-09-17 20:13:47.224735 | localhost | Product Name: OpenStack Nova 2026-09-17 20:13:47.224761 | localhost | Interface IP: 162.253.55.91 2026-09-17 20:13:47.233295 | 2026-09-17 20:13:47.233437 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-17 20:13:47.662148 | localhost -> localhost | changed 2026-09-17 20:13:47.666413 | 2026-09-17 20:13:47.666507 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-17 20:13:48.533119 | localhost -> localhost | changed 2026-09-17 20:13:48.540028 | 2026-09-17 20:13:48.540120 | PLAY [all] 2026-09-17 20:13:48.550483 | 2026-09-17 20:13:48.550634 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-17 20:13:48.809644 | instance -> localhost | ok 2026-09-17 20:13:48.822374 | 2026-09-17 20:13:48.822514 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-17 20:13:48.848856 | instance | ok 2026-09-17 20:13:48.866099 | instance | included: /var/lib/zuul/builds/106f7ff5ff334e869d82d38102a54cb0/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-17 20:13:48.874665 | 2026-09-17 20:13:48.874910 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-17 20:13:49.964468 | instance -> localhost | Generating public/private rsa key pair. 2026-09-17 20:13:49.964782 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/106f7ff5ff334e869d82d38102a54cb0/work/106f7ff5ff334e869d82d38102a54cb0_id_rsa 2026-09-17 20:13:49.964843 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/106f7ff5ff334e869d82d38102a54cb0/work/106f7ff5ff334e869d82d38102a54cb0_id_rsa.pub 2026-09-17 20:13:49.964888 | instance -> localhost | The key fingerprint is: 2026-09-17 20:13:49.964929 | instance -> localhost | SHA256:dGFZ+McYMxhN5yp8dvE9G1sc0nS5KGrnPv8HeLlybi0 zuul-build-sshkey 2026-09-17 20:13:49.965012 | instance -> localhost | The key's randomart image is: 2026-09-17 20:13:49.965069 | instance -> localhost | +---[RSA 3072]----+ 2026-09-17 20:13:49.965115 | instance -> localhost | | +Oo ..o| 2026-09-17 20:13:49.965156 | instance -> localhost | | .+.=oo..| 2026-09-17 20:13:49.965194 | instance -> localhost | | . .. B+o.| 2026-09-17 20:13:49.965233 | instance -> localhost | | . o .oo+=o| 2026-09-17 20:13:49.965271 | instance -> localhost | | S + =o.+=| 2026-09-17 20:13:49.965308 | instance -> localhost | | o =..+ *| 2026-09-17 20:13:49.965371 | instance -> localhost | | . o . * | 2026-09-17 20:13:49.965413 | instance -> localhost | | o. E o| 2026-09-17 20:13:49.965458 | instance -> localhost | | ..o*oo.| 2026-09-17 20:13:49.965498 | instance -> localhost | +----[SHA256]-----+ 2026-09-17 20:13:49.965587 | instance -> localhost | ok: Runtime: 0:00:00.635512 2026-09-17 20:13:49.979307 | 2026-09-17 20:13:49.979486 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-17 20:13:50.014919 | instance | ok 2026-09-17 20:13:50.032024 | instance | included: /var/lib/zuul/builds/106f7ff5ff334e869d82d38102a54cb0/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-17 20:13:50.044626 | 2026-09-17 20:13:50.044738 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-17 20:13:50.070085 | instance | skipping: Conditional result was False 2026-09-17 20:13:50.080774 | 2026-09-17 20:13:50.080910 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-17 20:13:50.562683 | instance | changed 2026-09-17 20:13:50.578162 | 2026-09-17 20:13:50.578426 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-17 20:13:50.773802 | instance | ok 2026-09-17 20:13:50.780801 | 2026-09-17 20:13:50.780940 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-17 20:13:51.280064 | instance | changed 2026-09-17 20:13:51.288636 | 2026-09-17 20:13:51.288755 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-17 20:13:51.805103 | instance | changed 2026-09-17 20:13:51.810694 | 2026-09-17 20:13:51.810776 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-17 20:13:51.833757 | instance | skipping: Conditional result was False 2026-09-17 20:13:51.840333 | 2026-09-17 20:13:51.840462 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-17 20:13:52.200822 | instance -> localhost | changed 2026-09-17 20:13:52.219601 | 2026-09-17 20:13:52.219749 | TASK [add-build-sshkey : Add back temp key] 2026-09-17 20:13:52.491982 | instance -> localhost | Identity added: /var/lib/zuul/builds/106f7ff5ff334e869d82d38102a54cb0/work/106f7ff5ff334e869d82d38102a54cb0_id_rsa (zuul-build-sshkey) 2026-09-17 20:13:52.492147 | instance -> localhost | ok: Runtime: 0:00:00.011415 2026-09-17 20:13:52.496720 | 2026-09-17 20:13:52.496778 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-17 20:13:52.825532 | instance | ok 2026-09-17 20:13:52.834111 | 2026-09-17 20:13:52.834248 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-17 20:13:52.858625 | instance | skipping: Conditional result was False 2026-09-17 20:13:52.876858 | 2026-09-17 20:13:52.877036 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-09-17 20:13:53.293762 | instance | ok 2026-09-17 20:13:53.301137 | 2026-09-17 20:13:53.301249 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-09-17 20:13:56.985121 | instance | Output suppressed because no_log was given 2026-09-17 20:13:56.992878 | 2026-09-17 20:13:56.992942 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-09-17 20:13:57.205276 | instance | ok: "logs" 2026-09-17 20:13:57.206061 | instance | ok: All items complete 2026-09-17 20:13:57.206093 | 2026-09-17 20:13:57.351205 | instance | ok: "artifacts" 2026-09-17 20:13:57.497279 | instance | ok: "docs" 2026-09-17 20:13:57.519684 | 2026-09-17 20:13:57.519933 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-09-17 20:13:57.723146 | instance | changed: "logs" 2026-09-17 20:13:57.874510 | instance | changed: "artifacts" 2026-09-17 20:13:58.046401 | instance | changed: "docs" 2026-09-17 20:13:58.070809 | 2026-09-17 20:13:58.070984 | PLAY RECAP 2026-09-17 20:13:58.071079 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-09-17 20:13:58.071134 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-17 20:13:58.071176 | 2026-09-17 20:13:58.204616 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-09-17 20:13:58.208145 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-09-17 20:13:58.759965 | 2026-09-17 20:13:58.760070 | PLAY [all] 2026-09-17 20:13:58.771920 | 2026-09-17 20:13:58.772047 | TASK [setup-uv : Extract archive] 2026-09-17 20:14:01.100737 | instance | changed 2026-09-17 20:14:01.112597 | 2026-09-17 20:14:01.112938 | TASK [setup-uv : Print version] 2026-09-17 20:14:01.477800 | instance | uv 0.8.13 2026-09-17 20:14:01.658860 | instance | ok: Runtime: 0:00:00.010392 2026-09-17 20:14:01.670675 | 2026-09-17 20:14:01.670851 | TASK [Install Ansible collection siblings] 2026-09-17 20:14:11.075090 | instance | changed: 2026-09-17 20:14:11.075315 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-09-17 20:14:11.075392 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-09-17 20:14:11.075435 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-09-17 20:14:11.075473 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto 2026-09-17 20:14:11.075511 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general 2026-09-17 20:14:11.075555 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql 2026-09-17 20:14:11.075678 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-09-17 20:14:11.075732 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-09-17 20:14:11.075771 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-09-17 20:14:11.075807 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-09-17 20:14:11.075844 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-09-17 20:14:11.075880 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-09-17 20:14:11.075915 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0 2026-09-17 20:14:11.075949 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0 2026-09-17 20:14:11.075984 | instance | Resolved ansible.utils to v6.1.1 for >=2.9.0 2026-09-17 20:14:11.076019 | instance | Resolved community.crypto to 2.2.3 for 2.2.3 2026-09-17 20:14:11.076054 | instance | Resolved community.general to 7.3.0 for 7.3.0 2026-09-17 20:14:11.076089 | instance | Resolved community.mysql to 3.6.0 for 3.6.0 2026-09-17 20:14:11.076125 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0 2026-09-17 20:14:11.076160 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0 2026-09-17 20:14:11.076194 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0 2026-09-17 20:14:11.076228 | instance | Resolved atmosphere.common to v0.7.1 for >=0.7.0 2026-09-17 20:14:11.076266 | instance | Resolved vexxhost.kubernetes to v3.4.0 for >=3.3.0,>=2.5.0 2026-09-17 20:14:11.076551 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0 2026-09-17 20:14:11.076612 | instance | Resolved ansible.utils to v6.1.1 for >=2.9.0,>=6.0.0 2026-09-17 20:14:11.076663 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-09-17 20:14:11.076759 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-09-17 20:14:11.076831 | instance | Resolved vexxhost.kubernetes to v3.4.0 for >=3.3.0,>=2.5.0 2026-09-17 20:14:11.076894 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0 2026-09-17 20:14:11.076954 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3 2026-09-17 20:14:11.076994 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-09-17 20:14:11.077031 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-09-17 20:14:11.077066 | instance | Checked out ansible.netcommon to 1.2.0 2026-09-17 20:14:11.077101 | 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-17 20:14:11.077148 | instance | Starting galaxy collection install process 2026-09-17 20:14:11.077182 | instance | Process install dependency map 2026-09-17 20:14:11.077217 | instance | Starting collection install process 2026-09-17 20:14:11.077250 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon' 2026-09-17 20:14:11.077284 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon 2026-09-17 20:14:11.077341 | instance | ansible.netcommon:* was installed successfully 2026-09-17 20:14:11.077558 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-09-17 20:14:11.077591 | instance | Creating virtual environment at: .venv 2026-09-17 20:14:11.077624 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-09-17 20:14:11.077657 | instance | Downloading ansible-core (2.1MiB) 2026-09-17 20:14:11.077690 | instance | Downloading rjsonnet (1.2MiB) 2026-09-17 20:14:11.077728 | instance | Downloading pydantic-core (2.0MiB) 2026-09-17 20:14:11.077762 | instance | Downloading netaddr (2.2MiB) 2026-09-17 20:14:11.077796 | instance | Downloading openstacksdk (1.7MiB) 2026-09-17 20:14:11.077829 | instance | Downloading pygments (1.2MiB) 2026-09-17 20:14:11.077863 | instance | Downloading kubernetes (1.9MiB) 2026-09-17 20:14:11.077898 | instance | Downloading cryptography (4.2MiB) 2026-09-17 20:14:11.077932 | instance | Downloading setuptools (1.1MiB) 2026-09-17 20:14:11.077965 | instance | Building pyperclip==1.9.0 2026-09-17 20:14:11.078004 | instance | Downloading rjsonnet 2026-09-17 20:14:11.078040 | instance | Downloading pydantic-core 2026-09-17 20:14:11.078074 | instance | Downloading netaddr 2026-09-17 20:14:11.078108 | instance | Downloading pygments 2026-09-17 20:14:11.078141 | instance | Downloading cryptography 2026-09-17 20:14:11.078174 | instance | Downloading setuptools 2026-09-17 20:14:11.078206 | instance | Downloading kubernetes 2026-09-17 20:14:11.078239 | instance | Downloading ansible-core 2026-09-17 20:14:11.078273 | instance | Downloading openstacksdk 2026-09-17 20:14:11.078305 | instance | Built pyperclip==1.9.0 2026-09-17 20:14:11.078359 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-09-17 20:14:11.078393 | instance | Installed 83 packages in 55ms 2026-09-17 20:14:11.078426 | instance | Checked out ansible.posix to 1.6.0 2026-09-17 20:14:11.078459 | 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-17 20:14:11.078492 | instance | Starting galaxy collection install process 2026-09-17 20:14:11.078525 | instance | Process install dependency map 2026-09-17 20:14:11.078568 | instance | Starting collection install process 2026-09-17 20:14:11.078603 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-09-17 20:14:11.078637 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix 2026-09-17 20:14:11.078671 | instance | ansible.posix:1.6.0 was installed successfully 2026-09-17 20:14:11.078705 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-17 20:14:11.078738 | instance | 2.17.12 2026-09-17 20:14:11.078771 | instance | Checked out ansible.utils to v6.1.1 2026-09-17 20:14:11.078804 | 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-17 20:14:11.078837 | instance | Starting galaxy collection install process 2026-09-17 20:14:11.078870 | instance | Process install dependency map 2026-09-17 20:14:11.078902 | instance | Starting collection install process 2026-09-17 20:14:11.078936 | instance | Installing 'ansible.utils:6.1.1' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils' 2026-09-17 20:14:11.078970 | instance | Created collection for ansible.utils:6.1.1 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils 2026-09-17 20:14:11.079004 | instance | ansible.utils:6.1.1 was installed successfully 2026-09-17 20:14:11.079038 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-17 20:14:11.079072 | instance | 2.17.12 2026-09-17 20:14:11.079104 | instance | Checked out atmosphere.common to v0.7.1 2026-09-17 20:14:11.079137 | 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-17 20:14:11.079171 | instance | Starting galaxy collection install process 2026-09-17 20:14:11.079204 | instance | Process install dependency map 2026-09-17 20:14:11.079237 | instance | Starting collection install process 2026-09-17 20:14:11.079270 | instance | Installing 'atmosphere.common:0.7.1' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common' 2026-09-17 20:14:11.079303 | instance | Created collection for atmosphere.common:0.7.1 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common 2026-09-17 20:14:11.079353 | instance | atmosphere.common:0.7.1 was installed successfully 2026-09-17 20:14:11.079386 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-17 20:14:11.079418 | instance | 2.17.12 2026-09-17 20:14:11.079450 | instance | Checked out community.crypto to 2.2.3 2026-09-17 20:14:11.079483 | 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-17 20:14:11.079516 | instance | Starting galaxy collection install process 2026-09-17 20:14:11.079549 | instance | Process install dependency map 2026-09-17 20:14:11.079582 | instance | Starting collection install process 2026-09-17 20:14:11.079615 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-09-17 20:14:11.079647 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto 2026-09-17 20:14:11.079680 | instance | community.crypto:2.2.3 was installed successfully 2026-09-17 20:14:11.079713 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-17 20:14:11.079746 | instance | 2.17.12 2026-09-17 20:14:11.079779 | instance | Checked out community.general to 7.3.0 2026-09-17 20:14:11.079812 | 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-17 20:14:11.079853 | instance | Starting galaxy collection install process 2026-09-17 20:14:11.079886 | instance | Process install dependency map 2026-09-17 20:14:11.079919 | instance | Starting collection install process 2026-09-17 20:14:11.079951 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-09-17 20:14:11.079984 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general 2026-09-17 20:14:11.080016 | instance | community.general:7.3.0 was installed successfully 2026-09-17 20:14:11.080049 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-17 20:14:11.080083 | instance | 2.17.12 2026-09-17 20:14:11.080116 | instance | Checked out community.mysql to 3.6.0 2026-09-17 20:14:11.080154 | 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-17 20:14:11.080190 | instance | Starting galaxy collection install process 2026-09-17 20:14:11.080224 | instance | Process install dependency map 2026-09-17 20:14:11.080258 | instance | Starting collection install process 2026-09-17 20:14:11.080291 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql' 2026-09-17 20:14:11.080343 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql 2026-09-17 20:14:11.080378 | instance | community.mysql:3.6.0 was installed successfully 2026-09-17 20:14:11.080411 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-17 20:14:11.080445 | instance | 2.17.12 2026-09-17 20:14:11.080478 | instance | Checked out kubernetes.core to 2.4.0 2026-09-17 20:14:11.080540 | 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-17 20:14:11.080576 | instance | Starting galaxy collection install process 2026-09-17 20:14:11.080610 | instance | Process install dependency map 2026-09-17 20:14:11.080644 | instance | Starting collection install process 2026-09-17 20:14:11.080676 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core' 2026-09-17 20:14:11.080709 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core 2026-09-17 20:14:11.080742 | instance | kubernetes.core:2.4.0 was installed successfully 2026-09-17 20:14:11.080775 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-17 20:14:11.080807 | instance | 2.17.12 2026-09-17 20:14:11.080840 | instance | Checked out openstack.cloud to 2.6.0 2026-09-17 20:14:11.080874 | 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-17 20:14:11.080908 | instance | Starting galaxy collection install process 2026-09-17 20:14:11.080941 | instance | Process install dependency map 2026-09-17 20:14:11.080974 | instance | Starting collection install process 2026-09-17 20:14:11.081006 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud' 2026-09-17 20:14:11.081039 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud 2026-09-17 20:14:11.081071 | instance | openstack.cloud:2.6.0 was installed successfully 2026-09-17 20:14:11.081104 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-17 20:14:11.081146 | instance | 2.17.12 2026-09-17 20:14:11.081260 | instance | Checked out vexxhost.ceph to v4.2.0 2026-09-17 20:14:11.081350 | 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-17 20:14:11.081393 | instance | Starting galaxy collection install process 2026-09-17 20:14:11.081430 | instance | Process install dependency map 2026-09-17 20:14:11.081465 | instance | Starting collection install process 2026-09-17 20:14:11.081499 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph' 2026-09-17 20:14:11.081533 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph 2026-09-17 20:14:11.081567 | instance | vexxhost.ceph:4.2.0 was installed successfully 2026-09-17 20:14:11.081600 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-17 20:14:11.081634 | instance | 2.17.12 2026-09-17 20:14:11.081667 | instance | Checked out vexxhost.containers to v1.6.8 2026-09-17 20:14:11.081700 | 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-17 20:14:11.081734 | instance | Starting galaxy collection install process 2026-09-17 20:14:11.081767 | instance | Process install dependency map 2026-09-17 20:14:11.081800 | instance | Starting collection install process 2026-09-17 20:14:11.081833 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers' 2026-09-17 20:14:11.081866 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers 2026-09-17 20:14:11.081898 | instance | vexxhost.containers:1.6.8 was installed successfully 2026-09-17 20:14:11.081931 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-17 20:14:11.081966 | instance | 2.17.12 2026-09-17 20:14:11.082000 | instance | Checked out vexxhost.kubernetes to v3.4.0 2026-09-17 20:14:11.082033 | 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-17 20:14:11.082067 | instance | Starting galaxy collection install process 2026-09-17 20:14:11.082100 | instance | Process install dependency map 2026-09-17 20:14:11.082134 | instance | Starting collection install process 2026-09-17 20:14:11.082166 | instance | Installing 'vexxhost.kubernetes:3.4.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes' 2026-09-17 20:14:11.082199 | instance | Created collection for vexxhost.kubernetes:3.4.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes 2026-09-17 20:14:11.082232 | instance | vexxhost.kubernetes:3.4.0 was installed successfully 2026-09-17 20:14:11.082264 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-17 20:14:11.082297 | instance | 2.17.12 2026-09-17 20:14:11.092944 | 2026-09-17 20:14:11.093064 | PLAY RECAP 2026-09-17 20:14:11.093141 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-17 20:14:11.093181 | 2026-09-17 20:14:11.211892 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-09-17 20:14:11.215368 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-09-17 20:14:11.737532 | 2026-09-17 20:14:11.737637 | PLAY [all] 2026-09-17 20:14:11.746904 | 2026-09-17 20:14:11.746985 | TASK [Install "jq" for log collection] 2026-09-17 20:14:21.774953 | instance | changed 2026-09-17 20:14:21.777429 | 2026-09-17 20:14:21.777504 | PLAY RECAP 2026-09-17 20:14:21.777572 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-17 20:14:21.777646 | 2026-09-17 20:14:21.907056 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-09-17 20:14:21.912084 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-09-17 20:14:22.504106 | 2026-09-17 20:14:22.504208 | PLAY [all] 2026-09-17 20:14:22.513846 | 2026-09-17 20:14:22.513914 | LOOP [Check inventory directories] 2026-09-17 20:14:22.845719 | instance | ok: "src/github.com/vexxhost/atmosphere" 2026-09-17 20:14:23.021186 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory" 2026-09-17 20:14:23.181962 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory" 2026-09-17 20:14:23.196865 | 2026-09-17 20:14:23.197098 | LOOP [Copy inventory file for Zuul] 2026-09-17 20:14:24.008343 | instance | changed: 2026-09-17 20:14:24.008618 | instance | { 2026-09-17 20:14:24.008681 | instance | "ansible_loop_var": "item", 2026-09-17 20:14:24.008726 | instance | "changed": false, 2026-09-17 20:14:24.008767 | instance | "failed": false, 2026-09-17 20:14:24.008817 | instance | "invocation": { 2026-09-17 20:14:24.008861 | instance | "module_args": { 2026-09-17 20:14:24.008909 | instance | "checksum_algorithm": "sha1", 2026-09-17 20:14:24.008958 | instance | "follow": true, 2026-09-17 20:14:24.009007 | instance | "get_attributes": true, 2026-09-17 20:14:24.009055 | instance | "get_checksum": true, 2026-09-17 20:14:24.009094 | instance | "get_mime": true, 2026-09-17 20:14:24.009137 | instance | "path": "src/github.com/vexxhost/atmosphere" 2026-09-17 20:14:24.009185 | instance | } 2026-09-17 20:14:24.009234 | instance | }, 2026-09-17 20:14:24.009283 | instance | "item": "src/github.com/vexxhost/atmosphere", 2026-09-17 20:14:24.009360 | instance | "stat": { 2026-09-17 20:14:24.009413 | instance | "atime": 1789676043.5876613, 2026-09-17 20:14:24.009463 | instance | "attr_flags": "e", 2026-09-17 20:14:24.009521 | instance | "attributes": [ 2026-09-17 20:14:24.009571 | instance | "extents" 2026-09-17 20:14:24.009621 | instance | ], 2026-09-17 20:14:24.009669 | instance | "block_size": 4096, 2026-09-17 20:14:24.009713 | instance | "blocks": 8, 2026-09-17 20:14:24.009760 | instance | "charset": "unknown", 2026-09-17 20:14:24.009806 | instance | "ctime": 1789676042.5435884, 2026-09-17 20:14:24.009852 | instance | "dev": 64513, 2026-09-17 20:14:24.009896 | instance | "device_type": 0, 2026-09-17 20:14:24.009947 | instance | "executable": true, 2026-09-17 20:14:24.010000 | instance | "exists": true, 2026-09-17 20:14:24.010056 | instance | "gid": 1000, 2026-09-17 20:14:24.010112 | instance | "gr_name": "zuul", 2026-09-17 20:14:24.010166 | instance | "inode": 1048528, 2026-09-17 20:14:24.010216 | instance | "isblk": false, 2026-09-17 20:14:24.010271 | instance | "ischr": false, 2026-09-17 20:14:24.010342 | instance | "isdir": true, 2026-09-17 20:14:24.010394 | instance | "isfifo": false, 2026-09-17 20:14:24.010446 | instance | "isgid": false, 2026-09-17 20:14:24.010498 | instance | "islnk": false, 2026-09-17 20:14:24.010549 | instance | "isreg": false, 2026-09-17 20:14:24.010597 | instance | "issock": false, 2026-09-17 20:14:24.010645 | instance | "isuid": false, 2026-09-17 20:14:24.010690 | instance | "mimetype": "unknown", 2026-09-17 20:14:24.010732 | instance | "mode": "0755", 2026-09-17 20:14:24.010774 | instance | "mtime": 1789676042.5435884, 2026-09-17 20:14:24.010815 | instance | "nlink": 23, 2026-09-17 20:14:24.010856 | instance | "path": "src/github.com/vexxhost/atmosphere", 2026-09-17 20:14:24.010895 | instance | "pw_name": "zuul", 2026-09-17 20:14:24.010943 | instance | "readable": true, 2026-09-17 20:14:24.010987 | instance | "rgrp": true, 2026-09-17 20:14:24.011030 | instance | "roth": true, 2026-09-17 20:14:24.011184 | instance | "rusr": true, 2026-09-17 20:14:24.011250 | instance | "size": 4096, 2026-09-17 20:14:24.011296 | instance | "uid": 1000, 2026-09-17 20:14:24.011378 | instance | "version": "368228599", 2026-09-17 20:14:24.011423 | instance | "wgrp": false, 2026-09-17 20:14:24.011469 | instance | "woth": false, 2026-09-17 20:14:24.011511 | instance | "writeable": true, 2026-09-17 20:14:24.011551 | instance | "wusr": true, 2026-09-17 20:14:24.011589 | instance | "xgrp": true, 2026-09-17 20:14:24.011626 | instance | "xoth": true, 2026-09-17 20:14:24.011662 | instance | "xusr": true 2026-09-17 20:14:24.011706 | instance | } 2026-09-17 20:14:24.011751 | instance | } 2026-09-17 20:14:24.011825 | instance | ok: All items complete 2026-09-17 20:14:24.011875 | 2026-09-17 20:14:24.014270 | instance | skipping: Conditional result was False 2026-09-17 20:14:24.015340 | instance | skipping: Conditional result was False 2026-09-17 20:14:24.027523 | 2026-09-17 20:14:24.027632 | LOOP [Switch "ansible_host" to private IP] 2026-09-17 20:14:24.388481 | instance | changed: 1 replacements made 2026-09-17 20:14:24.390118 | instance | skipping: Conditional result was False 2026-09-17 20:14:24.390947 | instance | skipping: Conditional result was False 2026-09-17 20:14:24.402582 | 2026-09-17 20:14:24.402692 | TASK [Run Molecule scenario] 2026-09-17 20:14:25.359528 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-09-17 20:14:25.802295 | instance | INFO [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-09-17 20:14:25.802406 | instance | INFO [csi > prerun] Performing prerun with role_name_check=0... 2026-09-17 20:14:36.793142 | instance | INFO [csi > dependency] Executing 2026-09-17 20:14:36.793263 | instance | WARNING [csi > dependency] Missing roles requirements file: requirements.yml 2026-09-17 20:14:36.793551 | instance | WARNING [csi > dependency] Missing collections requirements file: collections.yml 2026-09-17 20:14:36.793692 | instance | WARNING [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-09-17 20:14:36.804182 | instance | INFO [csi > cleanup] Executing 2026-09-17 20:14:36.804281 | instance | WARNING [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-09-17 20:14:36.814844 | instance | INFO [csi > destroy] Executing 2026-09-17 20:14:36.814898 | instance | WARNING [csi > destroy] Skipping, '--destroy=never' requested. 2026-09-17 20:14:36.814909 | instance | INFO [csi > destroy] Executed: Successful 2026-09-17 20:14:36.824116 | instance | INFO [csi > syntax] Executing 2026-09-17 20:14:38.288987 | instance | 2026-09-17 20:14:38.289099 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-09-17 20:14:38.348584 | instance | INFO [csi > syntax] Executed: Successful 2026-09-17 20:14:38.365463 | instance | INFO [csi > create] Executing 2026-09-17 20:14:38.369217 | instance | WARNING [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-09-17 20:14:38.383389 | instance | INFO [csi > prepare] Executing 2026-09-17 20:14:39.156714 | instance | 2026-09-17 20:14:39.156995 | instance | PLAY [Prepare] ***************************************************************** 2026-09-17 20:14:39.157280 | instance | 2026-09-17 20:14:39.157528 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-17 20:14:39.157775 | instance | Thursday 17 September 2026 20:14:39 +0000 (0:00:00.025) 0:00:00.025 **** 2026-09-17 20:14:40.445546 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-09-17 20:14:40.445782 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-09-17 20:14:40.446043 | instance | interpreter could change the meaning of that path. See 2026-09-17 20:14:40.446333 | instance | https://docs.ansible.com/ansible- 2026-09-17 20:14:40.446593 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-09-17 20:14:40.456706 | instance | ok: [instance] 2026-09-17 20:14:40.456920 | instance | 2026-09-17 20:14:40.457176 | instance | TASK [Configure short hostname] ************************************************ 2026-09-17 20:14:40.457418 | instance | Thursday 17 September 2026 20:14:40 +0000 (0:00:01.300) 0:00:01.325 **** 2026-09-17 20:14:41.339260 | instance | changed: [instance] 2026-09-17 20:14:41.339361 | instance | 2026-09-17 20:14:41.339494 | instance | TASK [Ensure hostname inside hosts file] *************************************** 2026-09-17 20:14:41.339685 | instance | Thursday 17 September 2026 20:14:41 +0000 (0:00:00.883) 0:00:02.208 **** 2026-09-17 20:14:41.603003 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created 2026-09-17 20:14:41.603251 | instance | with a mode of 0700, this may cause issues when running as another user. To 2026-09-17 20:14:41.603530 | instance | avoid this, create the remote_tmp dir with the correct permissions manually 2026-09-17 20:14:41.613782 | instance | changed: [instance] 2026-09-17 20:14:41.614020 | instance | 2026-09-17 20:14:41.614319 | instance | TASK [Purge "snapd" package] *************************************************** 2026-09-17 20:14:41.614569 | instance | Thursday 17 September 2026 20:14:41 +0000 (0:00:00.273) 0:00:02.482 **** 2026-09-17 20:14:42.516228 | instance | ok: [instance] 2026-09-17 20:14:42.516355 | instance | 2026-09-17 20:14:42.516536 | instance | PLAY [Create devices for Ceph] ************************************************* 2026-09-17 20:14:42.516699 | instance | 2026-09-17 20:14:42.516879 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-17 20:14:42.517047 | instance | Thursday 17 September 2026 20:14:42 +0000 (0:00:00.902) 0:00:03.385 **** 2026-09-17 20:14:43.221967 | instance | ok: [instance] 2026-09-17 20:14:43.222051 | instance | 2026-09-17 20:14:43.222233 | instance | TASK [Install depedencies] ***************************************************** 2026-09-17 20:14:43.222377 | instance | Thursday 17 September 2026 20:14:43 +0000 (0:00:00.705) 0:00:04.090 **** 2026-09-17 20:15:07.996214 | instance | changed: [instance] 2026-09-17 20:15:07.996433 | instance | 2026-09-17 20:15:07.996446 | instance | TASK [Start up service] ******************************************************** 2026-09-17 20:15:07.996463 | instance | Thursday 17 September 2026 20:15:07 +0000 (0:00:24.773) 0:00:28.864 **** 2026-09-17 20:15:08.575412 | instance | ok: [instance] 2026-09-17 20:15:08.575833 | instance | 2026-09-17 20:15:08.575863 | instance | TASK [Generate lvm.conf] ******************************************************* 2026-09-17 20:15:08.575871 | instance | Thursday 17 September 2026 20:15:08 +0000 (0:00:00.580) 0:00:29.445 **** 2026-09-17 20:15:08.877347 | instance | ok: [instance] 2026-09-17 20:15:08.877378 | instance | 2026-09-17 20:15:08.877383 | instance | TASK [Write /etc/lvm/lvm.conf] ************************************************* 2026-09-17 20:15:08.877388 | instance | Thursday 17 September 2026 20:15:08 +0000 (0:00:00.301) 0:00:29.746 **** 2026-09-17 20:15:09.609887 | instance | changed: [instance] 2026-09-17 20:15:09.610814 | instance | 2026-09-17 20:15:09.610884 | instance | TASK [Get list of all loopback devices] **************************************** 2026-09-17 20:15:09.610896 | instance | Thursday 17 September 2026 20:15:09 +0000 (0:00:00.732) 0:00:30.478 **** 2026-09-17 20:15:09.844706 | instance | ok: [instance] 2026-09-17 20:15:09.844763 | instance | 2026-09-17 20:15:09.845054 | instance | TASK [Fail if there is any existing loopback devices] ************************** 2026-09-17 20:15:09.845111 | instance | Thursday 17 September 2026 20:15:09 +0000 (0:00:00.235) 0:00:30.713 **** 2026-09-17 20:15:09.872036 | instance | skipping: [instance] 2026-09-17 20:15:09.872920 | instance | 2026-09-17 20:15:09.872984 | instance | TASK [Create devices for Ceph] ************************************************* 2026-09-17 20:15:09.872996 | instance | Thursday 17 September 2026 20:15:09 +0000 (0:00:00.026) 0:00:30.740 **** 2026-09-17 20:15:10.484232 | instance | changed: [instance] => (item=osd0) 2026-09-17 20:15:10.484305 | instance | changed: [instance] => (item=osd1) 2026-09-17 20:15:10.484323 | instance | changed: [instance] => (item=osd2) 2026-09-17 20:15:10.484337 | instance | 2026-09-17 20:15:10.484351 | instance | TASK [Set permissions on loopback devices] ************************************* 2026-09-17 20:15:10.484518 | instance | Thursday 17 September 2026 20:15:10 +0000 (0:00:00.611) 0:00:31.352 **** 2026-09-17 20:15:11.137692 | instance | changed: [instance] => (item=osd0) 2026-09-17 20:15:11.137766 | instance | changed: [instance] => (item=osd1) 2026-09-17 20:15:11.137777 | instance | changed: [instance] => (item=osd2) 2026-09-17 20:15:11.137786 | instance | 2026-09-17 20:15:11.137796 | instance | TASK [Start loop devices] ****************************************************** 2026-09-17 20:15:11.137806 | instance | Thursday 17 September 2026 20:15:11 +0000 (0:00:00.652) 0:00:32.005 **** 2026-09-17 20:15:11.911278 | instance | changed: [instance] => (item=osd0) 2026-09-17 20:15:11.911442 | instance | changed: [instance] => (item=osd1) 2026-09-17 20:15:11.912200 | instance | changed: [instance] => (item=osd2) 2026-09-17 20:15:11.912265 | instance | 2026-09-17 20:15:11.912284 | instance | TASK [Create a volume group for each loop device] ****************************** 2026-09-17 20:15:11.912497 | instance | Thursday 17 September 2026 20:15:11 +0000 (0:00:00.774) 0:00:32.779 **** 2026-09-17 20:15:15.399953 | instance | changed: [instance] => (item=osd0) 2026-09-17 20:15:15.400029 | instance | changed: [instance] => (item=osd1) 2026-09-17 20:15:15.400695 | instance | changed: [instance] => (item=osd2) 2026-09-17 20:15:15.400714 | instance | 2026-09-17 20:15:15.400721 | instance | TASK [Create a logical volume for each loop device] **************************** 2026-09-17 20:15:15.400727 | instance | Thursday 17 September 2026 20:15:15 +0000 (0:00:03.487) 0:00:36.267 **** 2026-09-17 20:15:17.454091 | instance | changed: [instance] => (item=ceph-instance-osd0) 2026-09-17 20:15:17.454148 | instance | changed: [instance] => (item=ceph-instance-osd1) 2026-09-17 20:15:17.454178 | instance | changed: [instance] => (item=ceph-instance-osd2) 2026-09-17 20:15:17.454188 | instance | 2026-09-17 20:15:17.454197 | instance | PLAY RECAP ********************************************************************* 2026-09-17 20:15:17.454206 | instance | instance : ok=15 changed=9 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-09-17 20:15:17.454233 | instance | 2026-09-17 20:15:17.454242 | instance | Thursday 17 September 2026 20:15:17 +0000 (0:00:02.050) 0:00:38.318 **** 2026-09-17 20:15:17.454251 | instance | =============================================================================== 2026-09-17 20:15:17.454259 | instance | Install depedencies ---------------------------------------------------- 24.77s 2026-09-17 20:15:17.454267 | instance | Create a volume group for each loop device ------------------------------ 3.49s 2026-09-17 20:15:17.454275 | instance | Create a logical volume for each loop device ---------------------------- 2.05s 2026-09-17 20:15:17.454284 | instance | Gathering Facts --------------------------------------------------------- 1.30s 2026-09-17 20:15:17.454292 | instance | Purge "snapd" package --------------------------------------------------- 0.90s 2026-09-17 20:15:17.454301 | instance | Configure short hostname ------------------------------------------------ 0.88s 2026-09-17 20:15:17.454309 | instance | Start loop devices ------------------------------------------------------ 0.77s 2026-09-17 20:15:17.454317 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.73s 2026-09-17 20:15:17.454325 | instance | Gathering Facts --------------------------------------------------------- 0.71s 2026-09-17 20:15:17.454334 | instance | Set permissions on loopback devices ------------------------------------- 0.65s 2026-09-17 20:15:17.454342 | instance | Create devices for Ceph ------------------------------------------------- 0.61s 2026-09-17 20:15:17.454351 | instance | Start up service -------------------------------------------------------- 0.58s 2026-09-17 20:15:17.454359 | instance | Generate lvm.conf ------------------------------------------------------- 0.30s 2026-09-17 20:15:17.454367 | instance | Ensure hostname inside hosts file --------------------------------------- 0.27s 2026-09-17 20:15:17.454375 | instance | Get list of all loopback devices ---------------------------------------- 0.24s 2026-09-17 20:15:17.454384 | instance | Fail if there is any existing loopback devices -------------------------- 0.03s 2026-09-17 20:15:17.562868 | instance | INFO [csi > prepare] Executed: Successful 2026-09-17 20:15:17.578512 | instance | INFO [csi > converge] Executing 2026-09-17 20:15:18.992498 | instance | 2026-09-17 20:15:18.992838 | instance | PLAY [Debug CSI driver value] ************************************************** 2026-09-17 20:15:18.993132 | instance | 2026-09-17 20:15:18.993450 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-17 20:15:18.993711 | instance | Thursday 17 September 2026 20:15:18 +0000 (0:00:00.007) 0:00:00.007 **** 2026-09-17 20:15:20.050517 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-09-17 20:15:20.050914 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-09-17 20:15:20.051220 | instance | interpreter could change the meaning of that path. See 2026-09-17 20:15:20.051555 | instance | https://docs.ansible.com/ansible- 2026-09-17 20:15:20.051898 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-09-17 20:15:20.069070 | instance | ok: [instance] 2026-09-17 20:15:20.069462 | instance | 2026-09-17 20:15:20.069793 | instance | TASK [Display CSI driver value and environment variable] *********************** 2026-09-17 20:15:20.070121 | instance | Thursday 17 September 2026 20:15:20 +0000 (0:00:01.073) 0:00:01.080 **** 2026-09-17 20:15:20.124656 | instance | ok: [instance] => { 2026-09-17 20:15:20.125000 | instance | "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER=" 2026-09-17 20:15:20.125339 | instance | } 2026-09-17 20:15:20.125626 | instance | 2026-09-17 20:15:20.125922 | instance | PLAY [all] ********************************************************************* 2026-09-17 20:15:20.126198 | instance | 2026-09-17 20:15:20.126519 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-17 20:15:20.126840 | instance | Thursday 17 September 2026 20:15:20 +0000 (0:00:00.056) 0:00:01.136 **** 2026-09-17 20:15:21.125048 | instance | ok: [instance] 2026-09-17 20:15:21.125319 | instance | 2026-09-17 20:15:21.125757 | instance | TASK [Fail if atmosphere_ceph_enabled is set] ********************************** 2026-09-17 20:15:21.126174 | instance | Thursday 17 September 2026 20:15:21 +0000 (0:00:01.001) 0:00:02.138 **** 2026-09-17 20:15:21.184891 | instance | skipping: [instance] 2026-09-17 20:15:21.185052 | instance | 2026-09-17 20:15:21.185417 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-09-17 20:15:21.185717 | instance | Thursday 17 September 2026 20:15:21 +0000 (0:00:00.058) 0:00:02.197 **** 2026-09-17 20:15:21.401049 | instance | ok: [instance] 2026-09-17 20:15:21.401628 | instance | 2026-09-17 20:15:21.402019 | instance | PLAY [Deploy Ceph monitors & managers] ***************************************** 2026-09-17 20:15:21.402445 | instance | 2026-09-17 20:15:21.402835 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-17 20:15:21.403243 | instance | Thursday 17 September 2026 20:15:21 +0000 (0:00:00.216) 0:00:02.413 **** 2026-09-17 20:15:22.440933 | instance | ok: [instance] 2026-09-17 20:15:22.441003 | instance | 2026-09-17 20:15:22.441250 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-09-17 20:15:22.441328 | instance | Thursday 17 September 2026 20:15:22 +0000 (0:00:01.041) 0:00:03.455 **** 2026-09-17 20:15:22.728694 | instance | ok: [instance] 2026-09-17 20:15:22.728805 | instance | 2026-09-17 20:15:22.728817 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-09-17 20:15:22.728967 | instance | Thursday 17 September 2026 20:15:22 +0000 (0:00:00.288) 0:00:03.743 **** 2026-09-17 20:15:22.782717 | instance | skipping: [instance] 2026-09-17 20:15:22.783249 | instance | 2026-09-17 20:15:22.783347 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-09-17 20:15:22.783368 | instance | Thursday 17 September 2026 20:15:22 +0000 (0:00:00.053) 0:00:03.796 **** 2026-09-17 20:15:23.124410 | instance | changed: [instance] 2026-09-17 20:15:23.124504 | instance | 2026-09-17 20:15:23.124751 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-09-17 20:15:23.124806 | instance | Thursday 17 September 2026 20:15:23 +0000 (0:00:00.342) 0:00:04.139 **** 2026-09-17 20:15:23.218235 | instance | ok: [instance] => { 2026-09-17 20:15:23.219487 | instance | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-09-17 20:15:23.219559 | instance | } 2026-09-17 20:15:23.219571 | instance | 2026-09-17 20:15:23.219580 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-09-17 20:15:23.219591 | instance | Thursday 17 September 2026 20:15:23 +0000 (0:00:00.092) 0:00:04.232 **** 2026-09-17 20:15:23.878594 | instance | changed: [instance] 2026-09-17 20:15:23.878722 | instance | 2026-09-17 20:15:23.878740 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-09-17 20:15:23.878930 | instance | Thursday 17 September 2026 20:15:23 +0000 (0:00:00.661) 0:00:04.893 **** 2026-09-17 20:15:23.951288 | instance | skipping: [instance] 2026-09-17 20:15:23.951386 | instance | 2026-09-17 20:15:23.951619 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-09-17 20:15:23.951895 | instance | Thursday 17 September 2026 20:15:23 +0000 (0:00:00.072) 0:00:04.965 **** 2026-09-17 20:15:24.018376 | instance | skipping: [instance] 2026-09-17 20:15:24.018608 | instance | 2026-09-17 20:15:24.018823 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-09-17 20:15:24.019020 | instance | Thursday 17 September 2026 20:15:24 +0000 (0:00:00.066) 0:00:05.031 **** 2026-09-17 20:15:24.267659 | instance | ok: [instance] 2026-09-17 20:15:24.268005 | instance | 2026-09-17 20:15:24.268419 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-09-17 20:15:24.268740 | instance | Thursday 17 September 2026 20:15:24 +0000 (0:00:00.250) 0:00:05.282 **** 2026-09-17 20:15:25.544826 | instance | ok: [instance] 2026-09-17 20:15:25.545237 | instance | 2026-09-17 20:15:25.545641 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-09-17 20:15:25.545989 | instance | Thursday 17 September 2026 20:15:25 +0000 (0:00:01.276) 0:00:06.558 **** 2026-09-17 20:15:25.649812 | instance | ok: [instance] => { 2026-09-17 20:15:25.650195 | instance | "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz" 2026-09-17 20:15:25.650557 | instance | } 2026-09-17 20:15:25.650884 | instance | 2026-09-17 20:15:25.651229 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-09-17 20:15:25.651553 | instance | Thursday 17 September 2026 20:15:25 +0000 (0:00:00.105) 0:00:06.663 **** 2026-09-17 20:15:26.586133 | instance | changed: [instance] 2026-09-17 20:15:26.586386 | instance | 2026-09-17 20:15:26.586594 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-09-17 20:15:26.586788 | instance | Thursday 17 September 2026 20:15:26 +0000 (0:00:00.936) 0:00:07.600 **** 2026-09-17 20:15:29.615902 | instance | changed: [instance] 2026-09-17 20:15:29.615982 | instance | 2026-09-17 20:15:29.616121 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-09-17 20:15:29.616547 | instance | Thursday 17 September 2026 20:15:29 +0000 (0:00:03.030) 0:00:10.630 **** 2026-09-17 20:15:29.660152 | instance | skipping: [instance] 2026-09-17 20:15:29.660441 | instance | 2026-09-17 20:15:29.661136 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-09-17 20:15:29.661358 | instance | Thursday 17 September 2026 20:15:29 +0000 (0:00:00.043) 0:00:10.673 **** 2026-09-17 20:15:29.698440 | instance | skipping: [instance] 2026-09-17 20:15:29.698633 | instance | 2026-09-17 20:15:29.698898 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-09-17 20:15:29.699119 | instance | Thursday 17 September 2026 20:15:29 +0000 (0:00:00.038) 0:00:10.712 **** 2026-09-17 20:15:29.744133 | instance | skipping: [instance] 2026-09-17 20:15:29.744252 | instance | 2026-09-17 20:15:29.744563 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-09-17 20:15:29.744852 | instance | Thursday 17 September 2026 20:15:29 +0000 (0:00:00.045) 0:00:10.757 **** 2026-09-17 20:15:36.399617 | instance | changed: [instance] 2026-09-17 20:15:36.399928 | instance | 2026-09-17 20:15:36.400284 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] *** 2026-09-17 20:15:36.400585 | instance | Thursday 17 September 2026 20:15:36 +0000 (0:00:06.655) 0:00:17.413 **** 2026-09-17 20:15:37.049699 | instance | changed: [instance] 2026-09-17 20:15:37.050012 | instance | 2026-09-17 20:15:37.050362 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] ******* 2026-09-17 20:15:37.050788 | instance | Thursday 17 September 2026 20:15:37 +0000 (0:00:00.649) 0:00:18.063 **** 2026-09-17 20:15:38.098352 | instance | changed: [instance] => (item={'path': '/etc/containerd'}) 2026-09-17 20:15:38.098400 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'}) 2026-09-17 20:15:38.098406 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'}) 2026-09-17 20:15:38.098415 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'}) 2026-09-17 20:15:38.098420 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'}) 2026-09-17 20:15:38.098425 | instance | 2026-09-17 20:15:38.098429 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] ********** 2026-09-17 20:15:38.098577 | instance | Thursday 17 September 2026 20:15:38 +0000 (0:00:01.047) 0:00:19.111 **** 2026-09-17 20:15:38.763975 | instance | changed: [instance] 2026-09-17 20:15:38.764057 | instance | 2026-09-17 20:15:38.764851 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ******** 2026-09-17 20:15:38.764895 | instance | Thursday 17 September 2026 20:15:38 +0000 (0:00:00.639) 0:00:19.750 **** 2026-09-17 20:15:38.764903 | instance | 2026-09-17 20:15:38.764909 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-09-17 20:15:38.764915 | instance | Thursday 17 September 2026 20:15:38 +0000 (0:00:00.027) 0:00:19.778 **** 2026-09-17 20:15:39.691874 | instance | ok: [instance] 2026-09-17 20:15:39.692022 | instance | 2026-09-17 20:15:39.692833 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] ********** 2026-09-17 20:15:39.692937 | instance | Thursday 17 September 2026 20:15:39 +0000 (0:00:00.926) 0:00:20.705 **** 2026-09-17 20:15:40.210745 | instance | changed: [instance] 2026-09-17 20:15:40.211456 | instance | 2026-09-17 20:15:40.211504 | instance | TASK [vexxhost.containers.containerd : Enable and start service] *************** 2026-09-17 20:15:40.211516 | instance | Thursday 17 September 2026 20:15:40 +0000 (0:00:00.519) 0:00:21.225 **** 2026-09-17 20:15:40.793040 | instance | changed: [instance] 2026-09-17 20:15:40.793462 | instance | 2026-09-17 20:15:40.793482 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-09-17 20:15:40.793490 | instance | Thursday 17 September 2026 20:15:40 +0000 (0:00:00.582) 0:00:21.807 **** 2026-09-17 20:15:41.061332 | instance | ok: [instance] 2026-09-17 20:15:41.061375 | instance | 2026-09-17 20:15:41.061382 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-09-17 20:15:41.061388 | instance | Thursday 17 September 2026 20:15:41 +0000 (0:00:00.266) 0:00:22.074 **** 2026-09-17 20:15:41.139480 | instance | ok: [instance] => { 2026-09-17 20:15:41.140205 | instance | "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz" 2026-09-17 20:15:41.140262 | instance | } 2026-09-17 20:15:41.140840 | instance | 2026-09-17 20:15:41.140873 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-09-17 20:15:41.140886 | instance | Thursday 17 September 2026 20:15:41 +0000 (0:00:00.079) 0:00:22.154 **** 2026-09-17 20:15:42.006913 | instance | changed: [instance] 2026-09-17 20:15:42.007885 | instance | 2026-09-17 20:15:42.007920 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-09-17 20:15:42.007933 | instance | Thursday 17 September 2026 20:15:42 +0000 (0:00:00.866) 0:00:23.021 **** 2026-09-17 20:15:47.384244 | instance | changed: [instance] 2026-09-17 20:15:47.384517 | instance | 2026-09-17 20:15:47.384529 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ****************** 2026-09-17 20:15:47.384652 | instance | Thursday 17 September 2026 20:15:47 +0000 (0:00:05.377) 0:00:28.398 **** 2026-09-17 20:15:48.506997 | instance | ok: [instance] 2026-09-17 20:15:48.507057 | instance | 2026-09-17 20:15:48.507069 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] *************** 2026-09-17 20:15:48.507079 | instance | Thursday 17 September 2026 20:15:48 +0000 (0:00:01.121) 0:00:29.520 **** 2026-09-17 20:15:48.890748 | instance | changed: [instance] 2026-09-17 20:15:48.891578 | instance | 2026-09-17 20:15:48.891638 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] ***** 2026-09-17 20:15:48.891650 | instance | Thursday 17 September 2026 20:15:48 +0000 (0:00:00.384) 0:00:29.904 **** 2026-09-17 20:15:49.413914 | instance | changed: [instance] 2026-09-17 20:15:49.414633 | instance | 2026-09-17 20:15:49.414664 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] *********** 2026-09-17 20:15:49.414675 | instance | Thursday 17 September 2026 20:15:49 +0000 (0:00:00.523) 0:00:30.428 **** 2026-09-17 20:15:50.048159 | instance | changed: [instance] => (item={'path': '/etc/docker'}) 2026-09-17 20:15:50.048216 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'}) 2026-09-17 20:15:50.048226 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'}) 2026-09-17 20:15:50.048238 | instance | 2026-09-17 20:15:50.048746 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ****** 2026-09-17 20:15:50.048796 | instance | Thursday 17 September 2026 20:15:50 +0000 (0:00:00.633) 0:00:31.061 **** 2026-09-17 20:15:50.499912 | instance | changed: [instance] 2026-09-17 20:15:50.500006 | instance | 2026-09-17 20:15:50.500201 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] *********** 2026-09-17 20:15:50.500360 | instance | Thursday 17 September 2026 20:15:50 +0000 (0:00:00.452) 0:00:31.514 **** 2026-09-17 20:15:51.010949 | instance | changed: [instance] 2026-09-17 20:15:51.011033 | instance | 2026-09-17 20:15:51.011217 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************ 2026-09-17 20:15:51.011386 | instance | Thursday 17 September 2026 20:15:50 +0000 (0:00:00.494) 0:00:32.009 **** 2026-09-17 20:15:51.011535 | instance | 2026-09-17 20:15:51.011711 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-09-17 20:15:51.011883 | instance | Thursday 17 September 2026 20:15:51 +0000 (0:00:00.016) 0:00:32.025 **** 2026-09-17 20:15:51.830448 | instance | ok: [instance] 2026-09-17 20:15:51.830509 | instance | 2026-09-17 20:15:51.830638 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ****************** 2026-09-17 20:15:51.830746 | instance | Thursday 17 September 2026 20:15:51 +0000 (0:00:00.819) 0:00:32.845 **** 2026-09-17 20:15:52.942972 | instance | changed: [instance] 2026-09-17 20:15:52.943057 | instance | 2026-09-17 20:15:52.943067 | instance | TASK [vexxhost.containers.docker : Enable and start service] ******************* 2026-09-17 20:15:52.943076 | instance | Thursday 17 September 2026 20:15:52 +0000 (0:00:01.110) 0:00:33.956 **** 2026-09-17 20:15:53.564032 | instance | changed: [instance] 2026-09-17 20:15:53.564166 | instance | 2026-09-17 20:15:53.564504 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ****** 2026-09-17 20:15:53.564554 | instance | Thursday 17 September 2026 20:15:53 +0000 (0:00:00.622) 0:00:34.578 **** 2026-09-17 20:15:53.634065 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml) 2026-09-17 20:15:53.634162 | instance | 2026-09-17 20:15:53.634456 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ******************************** 2026-09-17 20:15:53.634498 | instance | Thursday 17 September 2026 20:15:53 +0000 (0:00:00.069) 0:00:34.648 **** 2026-09-17 20:15:59.023932 | instance | changed: [instance] 2026-09-17 20:15:59.024108 | instance | 2026-09-17 20:15:59.024716 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] ********************* 2026-09-17 20:15:59.024808 | instance | Thursday 17 September 2026 20:15:59 +0000 (0:00:05.388) 0:00:40.037 **** 2026-09-17 20:15:59.729460 | instance | ok: [instance] => (item=chronyd) 2026-09-17 20:15:59.729619 | instance | ok: [instance] => (item=sshd) 2026-09-17 20:15:59.730300 | instance | 2026-09-17 20:15:59.730520 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ****************************** 2026-09-17 20:15:59.730533 | instance | Thursday 17 September 2026 20:15:59 +0000 (0:00:00.706) 0:00:40.743 **** 2026-09-17 20:16:00.701387 | instance | changed: [instance] 2026-09-17 20:16:00.701569 | instance | 2026-09-17 20:16:00.702182 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ******************** 2026-09-17 20:16:00.702241 | instance | Thursday 17 September 2026 20:16:00 +0000 (0:00:00.971) 0:00:41.715 **** 2026-09-17 20:16:00.939989 | instance | ok: [instance] 2026-09-17 20:16:00.940969 | instance | 2026-09-17 20:16:00.941050 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] **************** 2026-09-17 20:16:00.941062 | instance | Thursday 17 September 2026 20:16:00 +0000 (0:00:00.238) 0:00:41.953 **** 2026-09-17 20:16:01.443543 | instance | changed: [instance] 2026-09-17 20:16:01.443678 | instance | 2026-09-17 20:16:01.444025 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] *** 2026-09-17 20:16:01.444113 | instance | Thursday 17 September 2026 20:16:01 +0000 (0:00:00.504) 0:00:42.458 **** 2026-09-17 20:16:01.889403 | instance | changed: [instance] 2026-09-17 20:16:01.889485 | instance | 2026-09-17 20:16:01.889831 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] ************************* 2026-09-17 20:16:01.889900 | instance | Thursday 17 September 2026 20:16:01 +0000 (0:00:00.445) 0:00:42.903 **** 2026-09-17 20:16:02.027927 | instance | ok: [instance] 2026-09-17 20:16:02.028110 | instance | 2026-09-17 20:16:02.028665 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] ******************* 2026-09-17 20:16:02.028735 | instance | Thursday 17 September 2026 20:16:02 +0000 (0:00:00.138) 0:00:43.042 **** 2026-09-17 20:16:02.302296 | instance | ok: [instance] => (item=instance) 2026-09-17 20:16:02.303131 | instance | 2026-09-17 20:16:02.303340 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ******** 2026-09-17 20:16:02.303354 | instance | Thursday 17 September 2026 20:16:02 +0000 (0:00:00.273) 0:00:43.315 **** 2026-09-17 20:16:02.376060 | instance | ok: [instance] 2026-09-17 20:16:02.376607 | instance | 2026-09-17 20:16:02.376680 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] *********************************** 2026-09-17 20:16:02.376688 | instance | Thursday 17 September 2026 20:16:02 +0000 (0:00:00.074) 0:00:43.390 **** 2026-09-17 20:16:02.465809 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance 2026-09-17 20:16:02.465901 | instance | 2026-09-17 20:16:02.465917 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] ************* 2026-09-17 20:16:02.466088 | instance | Thursday 17 September 2026 20:16:02 +0000 (0:00:00.090) 0:00:43.480 **** 2026-09-17 20:16:02.815847 | instance | changed: [instance] 2026-09-17 20:16:02.815955 | instance | 2026-09-17 20:16:02.816235 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ****************** 2026-09-17 20:16:02.816324 | instance | Thursday 17 September 2026 20:16:02 +0000 (0:00:00.349) 0:00:43.830 **** 2026-09-17 20:16:03.567815 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True}) 2026-09-17 20:16:03.567885 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0}) 2026-09-17 20:16:03.568180 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False}) 2026-09-17 20:16:03.568222 | instance | 2026-09-17 20:16:03.568472 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] ******************************* 2026-09-17 20:16:03.568514 | instance | Thursday 17 September 2026 20:16:03 +0000 (0:00:00.752) 0:00:44.582 **** 2026-09-17 20:17:33.535428 | instance | ok: [instance] 2026-09-17 20:17:33.535548 | instance | 2026-09-17 20:17:33.535839 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] *************** 2026-09-17 20:17:33.535882 | instance | Thursday 17 September 2026 20:17:33 +0000 (0:01:29.967) 0:02:14.550 **** 2026-09-17 20:17:33.765544 | instance | changed: [instance] 2026-09-17 20:17:33.765596 | instance | 2026-09-17 20:17:33.765608 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] ********************************** 2026-09-17 20:17:33.765617 | instance | Thursday 17 September 2026 20:17:33 +0000 (0:00:00.229) 0:02:14.779 **** 2026-09-17 20:17:33.816157 | instance | ok: [instance] 2026-09-17 20:17:33.816206 | instance | 2026-09-17 20:17:33.816218 | instance | TASK [Install Ceph host] ******************************************************* 2026-09-17 20:17:33.816228 | instance | Thursday 17 September 2026 20:17:33 +0000 (0:00:00.050) 0:02:14.829 **** 2026-09-17 20:17:33.935885 | instance | included: vexxhost.ceph.cephadm_host for instance 2026-09-17 20:17:33.935920 | instance | 2026-09-17 20:17:33.935925 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ****** 2026-09-17 20:17:33.935930 | instance | Thursday 17 September 2026 20:17:33 +0000 (0:00:00.120) 0:02:14.950 **** 2026-09-17 20:17:35.554702 | instance | ok: [instance] 2026-09-17 20:17:35.554924 | instance | 2026-09-17 20:17:35.555220 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] *** 2026-09-17 20:17:35.555458 | instance | Thursday 17 September 2026 20:17:35 +0000 (0:00:01.618) 0:02:16.569 **** 2026-09-17 20:17:35.634596 | instance | ok: [instance] => (item=instance) 2026-09-17 20:17:35.634804 | instance | 2026-09-17 20:17:35.635082 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] *********** 2026-09-17 20:17:35.635339 | instance | Thursday 17 September 2026 20:17:35 +0000 (0:00:00.079) 0:02:16.648 **** 2026-09-17 20:17:35.991357 | instance | ok: [instance] 2026-09-17 20:17:35.991470 | instance | 2026-09-17 20:17:35.991809 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] *********************** 2026-09-17 20:17:35.991845 | instance | Thursday 17 September 2026 20:17:35 +0000 (0:00:00.357) 0:02:17.006 **** 2026-09-17 20:17:38.540358 | instance | ok: [instance] 2026-09-17 20:17:38.540466 | instance | 2026-09-17 20:17:38.540802 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ****************** 2026-09-17 20:17:38.540845 | instance | Thursday 17 September 2026 20:17:38 +0000 (0:00:02.548) 0:02:19.555 **** 2026-09-17 20:18:18.974983 | 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-17 20:18:18.975785 | 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_d4cmmad0/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_d4cmmad0/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_d4cmmad0/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_d4cmmad0/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-17T20:18:18.800+0000 7fd7be7f3640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgC2SqxqPDV9ASAA9MWulpd0T6D6iR80Xp/F7KbTswmxNdZCvcoNIbwBraw=: Malformed input [buffer:3]\n2026-09-17T20:18:18.800+0000 7fd7be7f3640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-17T20:18:18.800+0000 7fd7be7f3640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgC2SqxqPDV9ASAA9MWulpd0T6D6iR80Xp/F7KbTswmxNdZCvcoNIbwBraw=: Malformed input [buffer:3]\n2026-09-17T20:18:18.800+0000 7fd7be7f3640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-17T20:18:18.800+0000 7fd7be7f3640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgC2SqxqPDV9ASAA9MWulpd0T6D6iR80Xp/F7KbTswmxNdZCvcoNIbwBraw=: Malformed input [buffer:3]\n2026-09-17T20:18:18.800+0000 7fd7be7f3640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-17T20:18:18.800+0000 7fd7be7f3640 -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-17 20:18:18.980183 | instance | 2026-09-17 20:18:18.980245 | instance | PLAY RECAP ********************************************************************* 2026-09-17 20:18:18.980257 | instance | instance : ok=55 changed=26 unreachable=0 failed=1 skipped=7 rescued=0 ignored=0 2026-09-17 20:18:18.980267 | instance | 2026-09-17 20:18:18.980275 | instance | Thursday 17 September 2026 20:18:18 +0000 (0:00:40.438) 0:02:59.993 **** 2026-09-17 20:18:18.980284 | instance | =============================================================================== 2026-09-17 20:18:18.980293 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 89.97s 2026-09-17 20:18:18.980301 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 40.44s 2026-09-17 20:18:18.980310 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 6.66s 2026-09-17 20:18:18.980319 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 5.39s 2026-09-17 20:18:18.980327 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 5.38s 2026-09-17 20:18:18.980336 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 3.03s 2026-09-17 20:18:18.980362 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.55s 2026-09-17 20:18:18.980371 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.75s 2026-09-17 20:18:18.980380 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.62s 2026-09-17 20:18:18.980388 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.28s 2026-09-17 20:18:18.980397 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.12s 2026-09-17 20:18:18.980405 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 1.11s 2026-09-17 20:18:18.980414 | instance | Gathering Facts --------------------------------------------------------- 1.07s 2026-09-17 20:18:18.980422 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 1.05s 2026-09-17 20:18:18.980431 | instance | Gathering Facts --------------------------------------------------------- 1.04s 2026-09-17 20:18:18.980446 | instance | Gathering Facts --------------------------------------------------------- 1.00s 2026-09-17 20:18:18.980455 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 0.97s 2026-09-17 20:18:18.980464 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.94s 2026-09-17 20:18:18.980663 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.87s 2026-09-17 20:18:18.980686 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.75s 2026-09-17 20:18:19.072155 | 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-17 20:18:19.072206 | instance | ERROR [csi > converge] Executed: Failed 2026-09-17 20:18:19.072212 | 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-17 20:18:19.296084 | instance | ERROR 2026-09-17 20:18:19.296383 | instance | { 2026-09-17 20:18:19.296441 | instance | "delta": "0:03:54.363887", 2026-09-17 20:18:19.296481 | instance | "end": "2026-09-17 20:18:19.125437", 2026-09-17 20:18:19.296548 | instance | "msg": "non-zero return code", 2026-09-17 20:18:19.296584 | instance | "rc": 2, 2026-09-17 20:18:19.296617 | instance | "start": "2026-09-17 20:14:24.761550" 2026-09-17 20:18:19.296652 | instance | } failure 2026-09-17 20:18:19.306013 | 2026-09-17 20:18:19.306218 | PLAY RECAP 2026-09-17 20:18:19.306435 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-09-17 20:18:19.306536 | 2026-09-17 20:18:19.437571 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-09-17 20:18:19.439368 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-09-17 20:18:20.130389 | 2026-09-17 20:18:20.130560 | PLAY [all] 2026-09-17 20:18:20.145083 | 2026-09-17 20:18:20.145193 | TASK [gather-host-logs : creating directory for system status] 2026-09-17 20:18:20.560478 | instance | changed 2026-09-17 20:18:20.567006 | 2026-09-17 20:18:20.567199 | TASK [gather-host-logs : Get logs for each host] 2026-09-17 20:18:20.915052 | instance | + systemd-cgls --full --all --no-pager 2026-09-17 20:18:20.935266 | instance | + ip addr 2026-09-17 20:18:20.938693 | instance | + ip route 2026-09-17 20:18:20.941798 | instance | + lsblk 2026-09-17 20:18:20.947596 | instance | + mount 2026-09-17 20:18:20.950820 | instance | + docker images 2026-09-17 20:18:20.975646 | instance | + brctl show 2026-09-17 20:18:20.976357 | instance | /bin/bash: line 8: brctl: command not found 2026-09-17 20:18:20.976771 | instance | + ip neigh 2026-09-17 20:18:20.979530 | instance | + bridge fdb show 2026-09-17 20:18:20.982968 | instance | + ps aux --sort=-%mem 2026-09-17 20:18:21.002564 | instance | + dpkg -l 2026-09-17 20:18:21.011442 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-09-17 20:18:21.012033 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-09-17 20:18:21.040217 | instance | + '[' '!' -z '' ']' 2026-09-17 20:18:21.104281 | instance | ok: Runtime: 0:00:00.132504 2026-09-17 20:18:21.112158 | 2026-09-17 20:18:21.112280 | TASK [gather-host-logs : Downloads logs to executor] 2026-09-17 20:18:21.836423 | instance | changed: 2026-09-17 20:18:21.836650 | instance | created directory /var/lib/zuul/builds/106f7ff5ff334e869d82d38102a54cb0/work/logs/instance 2026-09-17 20:18:21.836701 | instance | cd+++++++++ system/ 2026-09-17 20:18:21.836905 | instance | >f+++++++++ system/brctl-show.txt 2026-09-17 20:18:21.836958 | instance | >f+++++++++ system/bridge-fdb.txt 2026-09-17 20:18:21.836995 | instance | >f+++++++++ system/docker-images.txt 2026-09-17 20:18:21.837035 | instance | >f+++++++++ system/ip-addr.txt 2026-09-17 20:18:21.837072 | instance | >f+++++++++ system/ip-neigh.txt 2026-09-17 20:18:21.837129 | instance | >f+++++++++ system/ip-route.txt 2026-09-17 20:18:21.837169 | instance | >f+++++++++ system/lsblk.txt 2026-09-17 20:18:21.837204 | instance | >f+++++++++ system/mount.txt 2026-09-17 20:18:21.837238 | instance | >f+++++++++ system/packages.txt 2026-09-17 20:18:21.837270 | instance | >f+++++++++ system/ps.txt 2026-09-17 20:18:21.837304 | instance | >f+++++++++ system/systemd-cgls.txt 2026-09-17 20:18:21.857439 | 2026-09-17 20:18:21.857586 | LOOP [helm-release-status : creating directory for helm release status] 2026-09-17 20:18:22.090849 | instance | changed: "values" 2026-09-17 20:18:22.248545 | instance | changed: "releases" 2026-09-17 20:18:22.264988 | 2026-09-17 20:18:22.265229 | TASK [helm-release-status : Gather get release status for helm charts] 2026-09-17 20:18:22.516283 | instance | /bin/bash: line 3: kubectl: command not found 2026-09-17 20:18:22.818541 | instance | ok: Runtime: 0:00:00.007288 2026-09-17 20:18:22.828433 | 2026-09-17 20:18:22.828601 | TASK [helm-release-status : Downloads logs to executor] 2026-09-17 20:18:23.364864 | instance | changed: 2026-09-17 20:18:23.365125 | instance | cd+++++++++ helm/ 2026-09-17 20:18:23.365184 | instance | cd+++++++++ helm/releases/ 2026-09-17 20:18:23.365226 | instance | cd+++++++++ helm/values/ 2026-09-17 20:18:23.385946 | 2026-09-17 20:18:23.386037 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-09-17 20:18:23.614157 | instance | changed 2026-09-17 20:18:23.626412 | 2026-09-17 20:18:23.626527 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-09-17 20:18:23.919634 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-17 20:18:23.919717 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-17 20:18:23.925423 | instance | environment: line 1: kubectl: command not found 2026-09-17 20:18:23.926335 | instance | environment: line 1: kubectl: command not found 2026-09-17 20:18:23.926498 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-17 20:18:23.928462 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-17 20:18:23.930051 | instance | environment: line 1: kubectl: command not found 2026-09-17 20:18:23.931244 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-17 20:18:23.931953 | instance | environment: line 1: kubectl: command not found 2026-09-17 20:18:23.933607 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-17 20:18:23.935161 | instance | environment: line 1: kubectl: command not found 2026-09-17 20:18:23.936747 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-17 20:18:24.162468 | instance | ok: Runtime: 0:00:00.025374 2026-09-17 20:18:24.169336 | 2026-09-17 20:18:24.169685 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-09-17 20:18:24.394191 | instance | changed 2026-09-17 20:18:24.399830 | 2026-09-17 20:18:24.399911 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-09-17 20:18:24.657978 | instance | environment: line 5: kubectl: command not found 2026-09-17 20:18:24.658225 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-17 20:18:24.658509 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-17 20:18:24.658772 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-17 20:18:24.934638 | instance | ok: Runtime: 0:00:00.008425 2026-09-17 20:18:24.943676 | 2026-09-17 20:18:24.943777 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-09-17 20:18:25.441903 | instance | changed: 2026-09-17 20:18:25.442126 | instance | cd+++++++++ objects/ 2026-09-17 20:18:25.442175 | instance | cd+++++++++ objects/cluster/ 2026-09-17 20:18:25.442210 | instance | cd+++++++++ objects/namespaced/ 2026-09-17 20:18:25.458774 | 2026-09-17 20:18:25.458844 | TASK [gather-pod-logs : creating directory for pod logs] 2026-09-17 20:18:25.674686 | instance | changed 2026-09-17 20:18:25.686052 | 2026-09-17 20:18:25.686227 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-09-17 20:18:25.944626 | instance | changed 2026-09-17 20:18:25.950811 | 2026-09-17 20:18:25.950975 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-09-17 20:18:26.194414 | instance | environment: line 3: kubectl: command not found 2026-09-17 20:18:26.497190 | instance | ok: Runtime: 0:00:00.008312 2026-09-17 20:18:26.508800 | 2026-09-17 20:18:26.508974 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-09-17 20:18:27.050395 | instance | changed: 2026-09-17 20:18:27.050577 | instance | cd+++++++++ pod-logs/ 2026-09-17 20:18:27.050603 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-09-17 20:18:27.067949 | 2026-09-17 20:18:27.068148 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-09-17 20:18:27.286621 | instance | changed 2026-09-17 20:18:27.300363 | 2026-09-17 20:18:27.300696 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-09-17 20:18:27.565261 | instance | /bin/bash: line 2: kubectl: command not found 2026-09-17 20:18:27.847027 | instance | ok: Runtime: 0:00:00.053740 2026-09-17 20:18:27.855394 | 2026-09-17 20:18:27.855578 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-09-17 20:18:28.102993 | instance | /bin/bash: line 2: kubectl: command not found 2026-09-17 20:18:28.149924 | instance | ceph-mgr endpoints: 2026-09-17 20:18:28.387564 | instance | ok: Runtime: 0:00:00.053994 2026-09-17 20:18:28.392603 | 2026-09-17 20:18:28.392702 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-09-17 20:18:28.628001 | instance | /bin/bash: line 4: kubectl: command not found 2026-09-17 20:18:28.925297 | instance | ok: Runtime: 0:00:00.053061 2026-09-17 20:18:28.933126 | 2026-09-17 20:18:28.933252 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-09-17 20:18:29.441624 | instance | changed: cd+++++++++ prometheus/ 2026-09-17 20:18:29.457110 | 2026-09-17 20:18:29.457241 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-09-17 20:18:29.684719 | instance | changed 2026-09-17 20:18:29.696939 | 2026-09-17 20:18:29.697149 | TASK [gather-selenium-data : Get selenium data] 2026-09-17 20:18:29.976652 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-09-17 20:18:29.978868 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-09-17 20:18:30.237286 | instance | ERROR 2026-09-17 20:18:30.237524 | instance | { 2026-09-17 20:18:30.237554 | instance | "delta": "0:00:00.005641", 2026-09-17 20:18:30.237575 | instance | "end": "2026-09-17 20:18:29.979202", 2026-09-17 20:18:30.237592 | instance | "msg": "non-zero return code", 2026-09-17 20:18:30.237608 | instance | "rc": 1, 2026-09-17 20:18:30.237624 | instance | "start": "2026-09-17 20:18:29.973561" 2026-09-17 20:18:30.237641 | instance | } 2026-09-17 20:18:30.237663 | instance | ERROR: Ignoring Errors 2026-09-17 20:18:30.242974 | 2026-09-17 20:18:30.243046 | TASK [gather-selenium-data : Downloads logs to executor] 2026-09-17 20:18:30.731839 | instance | changed: cd+++++++++ selenium/ 2026-09-17 20:18:30.738932 | 2026-09-17 20:18:30.739023 | PLAY RECAP 2026-09-17 20:18:30.739118 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-09-17 20:18:30.739152 | 2026-09-17 20:18:30.968705 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-09-17 20:18:30.971604 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-09-17 20:18:31.663374 | 2026-09-17 20:18:31.663602 | PLAY [all] 2026-09-17 20:18:31.676140 | 2026-09-17 20:18:31.676272 | TASK [fetch-output : Set log path for multiple nodes] 2026-09-17 20:18:31.721518 | instance | skipping: Conditional result was False 2026-09-17 20:18:31.727324 | 2026-09-17 20:18:31.727456 | TASK [fetch-output : Set log path for single node] 2026-09-17 20:18:31.768900 | instance | ok 2026-09-17 20:18:31.775863 | 2026-09-17 20:18:31.776032 | LOOP [fetch-output : Ensure local output dirs] 2026-09-17 20:18:32.234721 | instance -> localhost | ok: "/var/lib/zuul/builds/106f7ff5ff334e869d82d38102a54cb0/work/logs" 2026-09-17 20:18:32.484818 | instance -> localhost | changed: "/var/lib/zuul/builds/106f7ff5ff334e869d82d38102a54cb0/work/artifacts" 2026-09-17 20:18:32.780222 | instance -> localhost | changed: "/var/lib/zuul/builds/106f7ff5ff334e869d82d38102a54cb0/work/docs" 2026-09-17 20:18:32.800449 | 2026-09-17 20:18:32.800675 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-17 20:18:33.498849 | instance | changed: .d..t...... ./ 2026-09-17 20:18:33.499202 | instance | changed: All items complete 2026-09-17 20:18:33.499247 | 2026-09-17 20:18:33.983776 | instance | changed: .d..t...... ./ 2026-09-17 20:18:34.488104 | instance | changed: .d..t...... ./ 2026-09-17 20:18:34.518350 | 2026-09-17 20:18:34.518598 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-17 20:18:35.054520 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007685 2026-09-17 20:18:35.354315 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007216 2026-09-17 20:18:35.373397 | 2026-09-17 20:18:35.373831 | PLAY [all] 2026-09-17 20:18:35.381053 | 2026-09-17 20:18:35.381246 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-17 20:18:35.821112 | instance | changed 2026-09-17 20:18:35.832418 | 2026-09-17 20:18:35.832605 | PLAY RECAP 2026-09-17 20:18:35.833101 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-09-17 20:18:35.833162 | 2026-09-17 20:18:36.004807 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-09-17 20:18:36.007377 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-17 20:18:36.599363 | 2026-09-17 20:18:36.599558 | PLAY [localhost] 2026-09-17 20:18:36.611042 | 2026-09-17 20:18:36.611163 | TASK [Generate Zuul manifest] 2026-09-17 20:18:36.628266 | localhost | ok 2026-09-17 20:18:36.644611 | 2026-09-17 20:18:36.644733 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-17 20:18:37.037404 | localhost | changed 2026-09-17 20:18:37.058482 | 2026-09-17 20:18:37.058686 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-17 20:18:37.100629 | localhost | ok 2026-09-17 20:18:37.113823 | 2026-09-17 20:18:37.113950 | TASK [Upload logs] 2026-09-17 20:18:37.139474 | localhost | ok 2026-09-17 20:18:37.210610 | 2026-09-17 20:18:37.210803 | TASK [Set zuul-log-path fact] 2026-09-17 20:18:37.238610 | localhost | ok 2026-09-17 20:18:37.252295 | 2026-09-17 20:18:37.252381 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-17 20:18:37.292658 | localhost | ok 2026-09-17 20:18:37.303525 | 2026-09-17 20:18:37.303611 | TASK [upload-logs : Create log directories] 2026-09-17 20:18:37.799614 | localhost | changed 2026-09-17 20:18:37.813560 | 2026-09-17 20:18:37.813738 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-17 20:18:38.335974 | localhost -> localhost | ok: Runtime: 0:00:00.006239 2026-09-17 20:18:38.344666 | 2026-09-17 20:18:38.344771 | TASK [upload-logs : Upload logs to log server] 2026-09-17 20:18:38.894334 | localhost | Output suppressed because no_log was given 2026-09-17 20:18:38.982550 | 2026-09-17 20:18:38.982758 | LOOP [upload-logs : Compress console log and json output] 2026-09-17 20:18:39.043656 | localhost | skipping: Conditional result was False 2026-09-17 20:18:39.051943 | localhost | skipping: Conditional result was False 2026-09-17 20:18:39.063367 | 2026-09-17 20:18:39.063541 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-17 20:18:39.127748 | localhost | skipping: Conditional result was False 2026-09-17 20:18:39.128687 | 2026-09-17 20:18:39.137667 | localhost | skipping: Conditional result was False 2026-09-17 20:18:39.146220 | 2026-09-17 20:18:39.146405 | LOOP [upload-logs : Upload console log and json output]