2026-09-03 05:07:33.547456 | Job console starting 2026-09-03 05:07:33.560114 | Updating git repos 2026-09-03 05:07:36.685346 | Cloning repos into workspace 2026-09-03 05:08:06.367648 | Restoring repo states 2026-09-03 05:08:14.682528 | Merging changes 2026-09-03 05:08:15.403623 | Checking out repos 2026-09-03 05:08:16.726180 | Preparing playbooks 2026-09-03 05:08:18.963263 | Running Ansible setup 2026-09-03 05:08:22.850825 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-09-03 05:08:23.485950 | 2026-09-03 05:08:23.486080 | PLAY [localhost] 2026-09-03 05:08:23.493687 | 2026-09-03 05:08:23.493770 | TASK [Gathering Facts] 2026-09-03 05:08:24.696174 | localhost | ok 2026-09-03 05:08:24.707371 | 2026-09-03 05:08:24.707488 | TASK [Setup log path fact] 2026-09-03 05:08:24.729630 | localhost | ok 2026-09-03 05:08:24.745381 | 2026-09-03 05:08:24.745493 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-03 05:08:24.776499 | localhost | ok 2026-09-03 05:08:24.784847 | 2026-09-03 05:08:24.784926 | TASK [emit-job-header : Print job information] 2026-09-03 05:08:24.826615 | # Job Information 2026-09-03 05:08:24.826821 | Ansible Version: 2.16.18 2026-09-03 05:08:24.826892 | Job: atmosphere-molecule-csi-rbd 2026-09-03 05:08:24.826940 | Pipeline: check 2026-09-03 05:08:24.826985 | Executor: 2d72f0692154 2026-09-03 05:08:24.827028 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3501 2026-09-03 05:08:24.827078 | Event ID: e5d26b60-a754-11f1-9b6d-8bd402b1df4d 2026-09-03 05:08:24.831598 | 2026-09-03 05:08:24.831688 | LOOP [emit-job-header : Print node information] 2026-09-03 05:08:24.922273 | localhost | ok: 2026-09-03 05:08:24.922518 | localhost | # Node Information 2026-09-03 05:08:24.922560 | localhost | Inventory Hostname: instance 2026-09-03 05:08:24.922592 | localhost | Hostname: np0000191885 2026-09-03 05:08:24.922622 | localhost | Username: zuul 2026-09-03 05:08:24.922656 | localhost | Distro: Ubuntu 22.04 2026-09-03 05:08:24.922685 | localhost | Provider: yul1 2026-09-03 05:08:24.922714 | localhost | Region: ca-ymq-1 2026-09-03 05:08:24.922742 | localhost | Label: ubuntu-jammy 2026-09-03 05:08:24.922769 | localhost | Product Name: OpenStack Nova 2026-09-03 05:08:24.922797 | localhost | Interface IP: 162.253.55.66 2026-09-03 05:08:24.941313 | 2026-09-03 05:08:24.941483 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-03 05:08:25.371803 | localhost -> localhost | changed 2026-09-03 05:08:25.377317 | 2026-09-03 05:08:25.377391 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-03 05:08:26.202107 | localhost -> localhost | changed 2026-09-03 05:08:26.213669 | 2026-09-03 05:08:26.213751 | PLAY [all] 2026-09-03 05:08:26.223128 | 2026-09-03 05:08:26.223199 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-03 05:08:26.439160 | instance -> localhost | ok 2026-09-03 05:08:26.450721 | 2026-09-03 05:08:26.450862 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-03 05:08:26.485331 | instance | ok 2026-09-03 05:08:26.501388 | instance | included: /var/lib/zuul/builds/193aac422fc54c54b3c793ff8a4f6b05/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-03 05:08:26.506993 | 2026-09-03 05:08:26.507053 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-03 05:08:27.346852 | instance -> localhost | Generating public/private rsa key pair. 2026-09-03 05:08:27.347050 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/193aac422fc54c54b3c793ff8a4f6b05/work/193aac422fc54c54b3c793ff8a4f6b05_id_rsa 2026-09-03 05:08:27.347079 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/193aac422fc54c54b3c793ff8a4f6b05/work/193aac422fc54c54b3c793ff8a4f6b05_id_rsa.pub 2026-09-03 05:08:27.347101 | instance -> localhost | The key fingerprint is: 2026-09-03 05:08:27.347122 | instance -> localhost | SHA256:n3NSU7f/zvK2KDqv+X/XHp7cxN/CUWVfJsxqwh6TcKU zuul-build-sshkey 2026-09-03 05:08:27.347161 | instance -> localhost | The key's randomart image is: 2026-09-03 05:08:27.347182 | instance -> localhost | +---[RSA 3072]----+ 2026-09-03 05:08:27.347212 | instance -> localhost | | ..o | 2026-09-03 05:08:27.347234 | instance -> localhost | | . .. + =| 2026-09-03 05:08:27.347254 | instance -> localhost | | +E. ..+=| 2026-09-03 05:08:27.347275 | instance -> localhost | | * o. .+| 2026-09-03 05:08:27.347294 | instance -> localhost | | S. =o o | 2026-09-03 05:08:27.347314 | instance -> localhost | | ..o ....| 2026-09-03 05:08:27.347333 | instance -> localhost | | = .. o=| 2026-09-03 05:08:27.347352 | instance -> localhost | | ..= B+@| 2026-09-03 05:08:27.347374 | instance -> localhost | | +*ooo.%%| 2026-09-03 05:08:27.347394 | instance -> localhost | +----[SHA256]-----+ 2026-09-03 05:08:27.347442 | instance -> localhost | ok: Runtime: 0:00:00.397285 2026-09-03 05:08:27.353979 | 2026-09-03 05:08:27.354045 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-03 05:08:27.383063 | instance | ok 2026-09-03 05:08:27.391143 | instance | included: /var/lib/zuul/builds/193aac422fc54c54b3c793ff8a4f6b05/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-03 05:08:27.398181 | 2026-09-03 05:08:27.398243 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-03 05:08:27.422446 | instance | skipping: Conditional result was False 2026-09-03 05:08:27.427697 | 2026-09-03 05:08:27.427765 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-03 05:08:27.871815 | instance | changed 2026-09-03 05:08:27.880993 | 2026-09-03 05:08:27.881088 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-03 05:08:28.088117 | instance | ok 2026-09-03 05:08:28.093901 | 2026-09-03 05:08:28.093967 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-03 05:08:28.648233 | instance | changed 2026-09-03 05:08:28.657216 | 2026-09-03 05:08:28.657311 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-03 05:08:29.178615 | instance | changed 2026-09-03 05:08:29.218388 | 2026-09-03 05:08:29.218462 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-03 05:08:29.244140 | instance | skipping: Conditional result was False 2026-09-03 05:08:29.257796 | 2026-09-03 05:08:29.257868 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-03 05:08:29.607936 | instance -> localhost | changed 2026-09-03 05:08:29.625369 | 2026-09-03 05:08:29.625463 | TASK [add-build-sshkey : Add back temp key] 2026-09-03 05:08:29.902521 | instance -> localhost | Identity added: /var/lib/zuul/builds/193aac422fc54c54b3c793ff8a4f6b05/work/193aac422fc54c54b3c793ff8a4f6b05_id_rsa (zuul-build-sshkey) 2026-09-03 05:08:29.902727 | instance -> localhost | ok: Runtime: 0:00:00.012455 2026-09-03 05:08:29.909441 | 2026-09-03 05:08:29.909528 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-03 05:08:30.226095 | instance | ok 2026-09-03 05:08:30.230765 | 2026-09-03 05:08:30.230833 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-03 05:08:30.256927 | instance | skipping: Conditional result was False 2026-09-03 05:08:30.272557 | 2026-09-03 05:08:30.272645 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-09-03 05:08:30.630723 | instance | ok 2026-09-03 05:08:30.638325 | 2026-09-03 05:08:30.638412 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-09-03 05:08:34.129865 | instance | Output suppressed because no_log was given 2026-09-03 05:08:34.138650 | 2026-09-03 05:08:34.138730 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-09-03 05:08:34.337652 | instance | ok: "logs" 2026-09-03 05:08:34.337967 | instance | ok: All items complete 2026-09-03 05:08:34.338007 | 2026-09-03 05:08:34.476208 | instance | ok: "artifacts" 2026-09-03 05:08:34.610700 | instance | ok: "docs" 2026-09-03 05:08:34.628863 | 2026-09-03 05:08:34.629057 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-09-03 05:08:34.811041 | instance | changed: "logs" 2026-09-03 05:08:34.946328 | instance | changed: "artifacts" 2026-09-03 05:08:35.079983 | instance | changed: "docs" 2026-09-03 05:08:35.102582 | 2026-09-03 05:08:35.102629 | PLAY RECAP 2026-09-03 05:08:35.102672 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-09-03 05:08:35.102700 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-03 05:08:35.102721 | 2026-09-03 05:08:35.237320 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-09-03 05:08:35.239599 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-09-03 05:08:35.848150 | 2026-09-03 05:08:35.848507 | PLAY [all] 2026-09-03 05:08:35.859290 | 2026-09-03 05:08:35.859365 | TASK [setup-uv : Extract archive] 2026-09-03 05:08:38.411273 | instance | changed 2026-09-03 05:08:38.417838 | 2026-09-03 05:08:38.417917 | TASK [setup-uv : Print version] 2026-09-03 05:08:38.809532 | instance | uv 0.8.13 2026-09-03 05:08:41.996532 | instance | ok: Runtime: 0:00:00.012720 2026-09-03 05:08:42.005250 | 2026-09-03 05:08:42.005317 | TASK [Install Ansible collection siblings] 2026-09-03 05:08:51.165633 | instance | changed: 2026-09-03 05:08:51.165946 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-09-03 05:08:51.166011 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-09-03 05:08:51.166058 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-09-03 05:08:51.166102 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto 2026-09-03 05:08:51.166145 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general 2026-09-03 05:08:51.166195 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql 2026-09-03 05:08:51.166241 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-09-03 05:08:51.166289 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-09-03 05:08:51.166332 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-09-03 05:08:51.166375 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-09-03 05:08:51.166417 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-09-03 05:08:51.166458 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-09-03 05:08:51.166498 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0 2026-09-03 05:08:51.166539 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0 2026-09-03 05:08:51.166580 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0 2026-09-03 05:08:51.166639 | instance | Resolved community.crypto to 2.2.3 for 2.2.3 2026-09-03 05:08:51.166694 | instance | Resolved community.general to 7.3.0 for 7.3.0 2026-09-03 05:08:51.166735 | instance | Resolved community.mysql to 3.6.0 for 3.6.0 2026-09-03 05:08:51.166788 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0 2026-09-03 05:08:51.166972 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0 2026-09-03 05:08:51.167037 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0 2026-09-03 05:08:51.167081 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0 2026-09-03 05:08:51.167201 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-09-03 05:08:51.167275 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0 2026-09-03 05:08:51.167320 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0 2026-09-03 05:08:51.167361 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-09-03 05:08:51.167402 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-09-03 05:08:51.167442 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-09-03 05:08:51.167482 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0 2026-09-03 05:08:51.167521 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3 2026-09-03 05:08:51.167560 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-09-03 05:08:51.167601 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-09-03 05:08:51.167641 | instance | Checked out ansible.netcommon to 1.2.0 2026-09-03 05:08:51.167682 | 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-03 05:08:51.167737 | instance | Starting galaxy collection install process 2026-09-03 05:08:51.167783 | instance | Process install dependency map 2026-09-03 05:08:51.167830 | instance | Starting collection install process 2026-09-03 05:08:51.167877 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon' 2026-09-03 05:08:51.167924 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon 2026-09-03 05:08:51.167951 | instance | ansible.netcommon:* was installed successfully 2026-09-03 05:08:51.167973 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-09-03 05:08:51.167992 | instance | Creating virtual environment at: .venv 2026-09-03 05:08:51.168009 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-09-03 05:08:51.168027 | instance | Downloading netaddr (2.2MiB) 2026-09-03 05:08:51.168045 | instance | Downloading kubernetes (1.9MiB) 2026-09-03 05:08:51.168064 | instance | Downloading setuptools (1.1MiB) 2026-09-03 05:08:51.168082 | instance | Downloading ansible-core (2.1MiB) 2026-09-03 05:08:51.168100 | instance | Downloading cryptography (4.2MiB) 2026-09-03 05:08:51.168117 | instance | Downloading pygments (1.2MiB) 2026-09-03 05:08:51.168135 | instance | Downloading openstacksdk (1.7MiB) 2026-09-03 05:08:51.168153 | instance | Downloading rjsonnet (1.2MiB) 2026-09-03 05:08:51.168170 | instance | Downloading pydantic-core (2.0MiB) 2026-09-03 05:08:51.168188 | instance | Building pyperclip==1.9.0 2026-09-03 05:08:51.168208 | instance | Downloading rjsonnet 2026-09-03 05:08:51.168227 | instance | Downloading pydantic-core 2026-09-03 05:08:51.168245 | instance | Downloading netaddr 2026-09-03 05:08:51.168264 | instance | Downloading pygments 2026-09-03 05:08:51.168282 | instance | Downloading cryptography 2026-09-03 05:08:51.168299 | instance | Downloading setuptools 2026-09-03 05:08:51.168317 | instance | Downloading kubernetes 2026-09-03 05:08:51.168335 | instance | Downloading ansible-core 2026-09-03 05:08:51.168352 | instance | Downloading openstacksdk 2026-09-03 05:08:51.168370 | instance | Built pyperclip==1.9.0 2026-09-03 05:08:51.168389 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-09-03 05:08:51.168406 | instance | Installed 83 packages in 64ms 2026-09-03 05:08:51.168437 | instance | Checked out ansible.posix to 1.6.0 2026-09-03 05:08:51.168463 | 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-03 05:08:51.168482 | instance | Starting galaxy collection install process 2026-09-03 05:08:51.168499 | instance | Process install dependency map 2026-09-03 05:08:51.168522 | instance | Starting collection install process 2026-09-03 05:08:51.168540 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-09-03 05:08:51.168557 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix 2026-09-03 05:08:51.168575 | instance | ansible.posix:1.6.0 was installed successfully 2026-09-03 05:08:51.168593 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-03 05:08:51.168611 | instance | 2.17.12 2026-09-03 05:08:51.168628 | instance | Checked out ansible.utils to v6.1.0 2026-09-03 05:08:51.168647 | 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-03 05:08:51.168665 | instance | Starting galaxy collection install process 2026-09-03 05:08:51.168683 | instance | Process install dependency map 2026-09-03 05:08:51.168700 | instance | Starting collection install process 2026-09-03 05:08:51.168719 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils' 2026-09-03 05:08:51.168737 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils 2026-09-03 05:08:51.168766 | instance | ansible.utils:6.1.0 was installed successfully 2026-09-03 05:08:51.168786 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-03 05:08:51.168805 | instance | 2.17.12 2026-09-03 05:08:51.168823 | instance | Checked out atmosphere.common to v0.7.0 2026-09-03 05:08:51.168841 | 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-03 05:08:51.168860 | instance | Starting galaxy collection install process 2026-09-03 05:08:51.168877 | instance | Process install dependency map 2026-09-03 05:08:51.168895 | instance | Starting collection install process 2026-09-03 05:08:51.168913 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common' 2026-09-03 05:08:51.168931 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common 2026-09-03 05:08:51.168949 | instance | atmosphere.common:0.7.0 was installed successfully 2026-09-03 05:08:51.168983 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-03 05:08:51.169002 | instance | 2.17.12 2026-09-03 05:08:51.169020 | instance | Checked out community.crypto to 2.2.3 2026-09-03 05:08:51.169038 | 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-03 05:08:51.169057 | instance | Starting galaxy collection install process 2026-09-03 05:08:51.169075 | instance | Process install dependency map 2026-09-03 05:08:51.169107 | instance | Starting collection install process 2026-09-03 05:08:51.169131 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-09-03 05:08:51.169150 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto 2026-09-03 05:08:51.169167 | instance | community.crypto:2.2.3 was installed successfully 2026-09-03 05:08:51.169184 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-03 05:08:51.169202 | instance | 2.17.12 2026-09-03 05:08:51.169220 | instance | Checked out community.general to 7.3.0 2026-09-03 05:08:51.169238 | 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-03 05:08:51.169262 | instance | Starting galaxy collection install process 2026-09-03 05:08:51.169281 | instance | Process install dependency map 2026-09-03 05:08:51.169299 | instance | Starting collection install process 2026-09-03 05:08:51.169317 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-09-03 05:08:51.169334 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general 2026-09-03 05:08:51.169361 | instance | community.general:7.3.0 was installed successfully 2026-09-03 05:08:51.169386 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-03 05:08:51.169404 | instance | 2.17.12 2026-09-03 05:08:51.169423 | instance | Checked out community.mysql to 3.6.0 2026-09-03 05:08:51.169443 | 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-03 05:08:51.169462 | instance | Starting galaxy collection install process 2026-09-03 05:08:51.169481 | instance | Process install dependency map 2026-09-03 05:08:51.169499 | instance | Starting collection install process 2026-09-03 05:08:51.169516 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql' 2026-09-03 05:08:51.169534 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql 2026-09-03 05:08:51.169552 | instance | community.mysql:3.6.0 was installed successfully 2026-09-03 05:08:51.169569 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-03 05:08:51.169587 | instance | 2.17.12 2026-09-03 05:08:51.169605 | instance | Checked out kubernetes.core to 2.4.0 2026-09-03 05:08:51.169623 | 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-03 05:08:51.169641 | instance | Starting galaxy collection install process 2026-09-03 05:08:51.169659 | instance | Process install dependency map 2026-09-03 05:08:51.169676 | instance | Starting collection install process 2026-09-03 05:08:51.169694 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core' 2026-09-03 05:08:51.169712 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core 2026-09-03 05:08:51.169730 | instance | kubernetes.core:2.4.0 was installed successfully 2026-09-03 05:08:51.169748 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-03 05:08:51.169765 | instance | 2.17.12 2026-09-03 05:08:51.169783 | instance | Checked out openstack.cloud to 2.6.0 2026-09-03 05:08:51.169800 | 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-03 05:08:51.169819 | instance | Starting galaxy collection install process 2026-09-03 05:08:51.169836 | instance | Process install dependency map 2026-09-03 05:08:51.169854 | instance | Starting collection install process 2026-09-03 05:08:51.169872 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud' 2026-09-03 05:08:51.169890 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud 2026-09-03 05:08:51.169907 | instance | openstack.cloud:2.6.0 was installed successfully 2026-09-03 05:08:51.169925 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-03 05:08:51.169942 | instance | 2.17.12 2026-09-03 05:08:51.169965 | instance | Checked out vexxhost.ceph to v4.2.0 2026-09-03 05:08:51.169983 | 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-03 05:08:51.170001 | instance | Starting galaxy collection install process 2026-09-03 05:08:51.170019 | instance | Process install dependency map 2026-09-03 05:08:51.170037 | instance | Starting collection install process 2026-09-03 05:08:51.170054 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph' 2026-09-03 05:08:51.170073 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph 2026-09-03 05:08:51.170090 | instance | vexxhost.ceph:4.2.0 was installed successfully 2026-09-03 05:08:51.170107 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-03 05:08:51.170125 | instance | 2.17.12 2026-09-03 05:08:51.170143 | instance | Checked out vexxhost.containers to v1.6.8 2026-09-03 05:08:51.170161 | 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-03 05:08:51.170178 | instance | Starting galaxy collection install process 2026-09-03 05:08:51.170196 | instance | Process install dependency map 2026-09-03 05:08:51.170214 | instance | Starting collection install process 2026-09-03 05:08:51.170232 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers' 2026-09-03 05:08:51.170250 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers 2026-09-03 05:08:51.170274 | instance | vexxhost.containers:1.6.8 was installed successfully 2026-09-03 05:08:51.170292 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-03 05:08:51.170310 | instance | 2.17.12 2026-09-03 05:08:51.170328 | instance | Checked out vexxhost.kubernetes to v3.3.0 2026-09-03 05:08:51.170346 | 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-03 05:08:51.170364 | instance | Starting galaxy collection install process 2026-09-03 05:08:51.170381 | instance | Process install dependency map 2026-09-03 05:08:51.170399 | instance | Starting collection install process 2026-09-03 05:08:51.170417 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes' 2026-09-03 05:08:51.170434 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes 2026-09-03 05:08:51.170452 | instance | vexxhost.kubernetes:3.3.0 was installed successfully 2026-09-03 05:08:51.170469 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-03 05:08:51.170487 | instance | 2.17.12 2026-09-03 05:08:51.176202 | 2026-09-03 05:08:51.176250 | PLAY RECAP 2026-09-03 05:08:51.176294 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-03 05:08:51.176315 | 2026-09-03 05:08:51.323641 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-09-03 05:08:51.328269 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-09-03 05:08:51.933048 | 2026-09-03 05:08:51.933183 | PLAY [all] 2026-09-03 05:08:51.944476 | 2026-09-03 05:08:51.944553 | TASK [Install "jq" for log collection] 2026-09-03 05:09:01.653118 | instance | changed 2026-09-03 05:09:01.655183 | 2026-09-03 05:09:01.655246 | PLAY RECAP 2026-09-03 05:09:01.655300 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-03 05:09:01.655368 | 2026-09-03 05:09:01.779626 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-09-03 05:09:01.781857 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-09-03 05:09:02.348407 | 2026-09-03 05:09:02.348545 | PLAY [all] 2026-09-03 05:09:02.359480 | 2026-09-03 05:09:02.359553 | LOOP [Check inventory directories] 2026-09-03 05:09:02.707247 | instance | ok: "src/github.com/vexxhost/atmosphere" 2026-09-03 05:09:02.883843 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory" 2026-09-03 05:09:03.060847 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory" 2026-09-03 05:09:03.080836 | 2026-09-03 05:09:03.081119 | LOOP [Copy inventory file for Zuul] 2026-09-03 05:09:03.911407 | instance | changed: 2026-09-03 05:09:03.911652 | instance | { 2026-09-03 05:09:03.911691 | instance | "ansible_loop_var": "item", 2026-09-03 05:09:03.911723 | instance | "changed": false, 2026-09-03 05:09:03.911752 | instance | "failed": false, 2026-09-03 05:09:03.911785 | instance | "invocation": { 2026-09-03 05:09:03.911813 | instance | "module_args": { 2026-09-03 05:09:03.911840 | instance | "checksum_algorithm": "sha1", 2026-09-03 05:09:03.911866 | instance | "follow": true, 2026-09-03 05:09:03.911892 | instance | "get_attributes": true, 2026-09-03 05:09:03.911920 | instance | "get_checksum": true, 2026-09-03 05:09:03.911947 | instance | "get_mime": true, 2026-09-03 05:09:03.911973 | instance | "path": "src/github.com/vexxhost/atmosphere" 2026-09-03 05:09:03.912027 | instance | } 2026-09-03 05:09:03.912059 | instance | }, 2026-09-03 05:09:03.912086 | instance | "item": "src/github.com/vexxhost/atmosphere", 2026-09-03 05:09:03.912112 | instance | "stat": { 2026-09-03 05:09:03.912137 | instance | "atime": 1788412124.0703242, 2026-09-03 05:09:03.912163 | instance | "attr_flags": "e", 2026-09-03 05:09:03.912189 | instance | "attributes": [ 2026-09-03 05:09:03.912214 | instance | "extents" 2026-09-03 05:09:03.912239 | instance | ], 2026-09-03 05:09:03.912264 | instance | "block_size": 4096, 2026-09-03 05:09:03.912289 | instance | "blocks": 8, 2026-09-03 05:09:03.912314 | instance | "charset": "unknown", 2026-09-03 05:09:03.912341 | instance | "ctime": 1788412122.878304, 2026-09-03 05:09:03.912366 | instance | "dev": 64513, 2026-09-03 05:09:03.912391 | instance | "device_type": 0, 2026-09-03 05:09:03.912416 | instance | "executable": true, 2026-09-03 05:09:03.912446 | instance | "exists": true, 2026-09-03 05:09:03.912480 | instance | "gid": 1000, 2026-09-03 05:09:03.912506 | instance | "gr_name": "zuul", 2026-09-03 05:09:03.912531 | instance | "inode": 1047896, 2026-09-03 05:09:03.912557 | instance | "isblk": false, 2026-09-03 05:09:03.912583 | instance | "ischr": false, 2026-09-03 05:09:03.912608 | instance | "isdir": true, 2026-09-03 05:09:03.912633 | instance | "isfifo": false, 2026-09-03 05:09:03.912658 | instance | "isgid": false, 2026-09-03 05:09:03.912682 | instance | "islnk": false, 2026-09-03 05:09:03.912707 | instance | "isreg": false, 2026-09-03 05:09:03.912731 | instance | "issock": false, 2026-09-03 05:09:03.912755 | instance | "isuid": false, 2026-09-03 05:09:03.912780 | instance | "mimetype": "unknown", 2026-09-03 05:09:03.912804 | instance | "mode": "0755", 2026-09-03 05:09:03.912829 | instance | "mtime": 1788412122.878304, 2026-09-03 05:09:03.912853 | instance | "nlink": 23, 2026-09-03 05:09:03.912878 | instance | "path": "src/github.com/vexxhost/atmosphere", 2026-09-03 05:09:03.912903 | instance | "pw_name": "zuul", 2026-09-03 05:09:03.912931 | instance | "readable": true, 2026-09-03 05:09:03.912980 | instance | "rgrp": true, 2026-09-03 05:09:03.913009 | instance | "roth": true, 2026-09-03 05:09:03.913060 | instance | "rusr": true, 2026-09-03 05:09:03.913087 | instance | "size": 4096, 2026-09-03 05:09:03.913112 | instance | "uid": 1000, 2026-09-03 05:09:03.913138 | instance | "version": "2888282981", 2026-09-03 05:09:03.913163 | instance | "wgrp": false, 2026-09-03 05:09:03.913190 | instance | "woth": false, 2026-09-03 05:09:03.913223 | instance | "writeable": true, 2026-09-03 05:09:03.913257 | instance | "wusr": true, 2026-09-03 05:09:03.913283 | instance | "xgrp": true, 2026-09-03 05:09:03.913308 | instance | "xoth": true, 2026-09-03 05:09:03.913338 | instance | "xusr": true 2026-09-03 05:09:03.913363 | instance | } 2026-09-03 05:09:03.913388 | instance | } 2026-09-03 05:09:03.913438 | instance | ok: All items complete 2026-09-03 05:09:03.913469 | 2026-09-03 05:09:03.915192 | instance | skipping: Conditional result was False 2026-09-03 05:09:03.916095 | instance | skipping: Conditional result was False 2026-09-03 05:09:03.927631 | 2026-09-03 05:09:03.927848 | LOOP [Switch "ansible_host" to private IP] 2026-09-03 05:09:04.314984 | instance | changed: 1 replacements made 2026-09-03 05:09:04.316789 | instance | skipping: Conditional result was False 2026-09-03 05:09:04.320312 | instance | skipping: Conditional result was False 2026-09-03 05:09:04.344292 | 2026-09-03 05:09:04.344568 | TASK [Run Molecule scenario] 2026-09-03 05:09:05.265192 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-09-03 05:09:05.682793 | instance | INFO [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-09-03 05:09:05.682894 | instance | INFO [csi > prerun] Performing prerun with role_name_check=0... 2026-09-03 05:09:16.278670 | instance | INFO [csi > dependency] Executing 2026-09-03 05:09:16.279080 | instance | WARNING [csi > dependency] Missing roles requirements file: requirements.yml 2026-09-03 05:09:16.279449 | instance | WARNING [csi > dependency] Missing collections requirements file: collections.yml 2026-09-03 05:09:16.279619 | instance | WARNING [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-09-03 05:09:16.293728 | instance | INFO [csi > cleanup] Executing 2026-09-03 05:09:16.294251 | instance | WARNING [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-09-03 05:09:16.308318 | instance | INFO [csi > destroy] Executing 2026-09-03 05:09:16.308402 | instance | WARNING [csi > destroy] Skipping, '--destroy=never' requested. 2026-09-03 05:09:16.308594 | instance | INFO [csi > destroy] Executed: Successful 2026-09-03 05:09:16.318002 | instance | INFO [csi > syntax] Executing 2026-09-03 05:09:17.930410 | instance | 2026-09-03 05:09:17.930633 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-09-03 05:09:18.053672 | instance | INFO [csi > syntax] Executed: Successful 2026-09-03 05:09:18.068492 | instance | INFO [csi > create] Executing 2026-09-03 05:09:18.071899 | instance | WARNING [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-09-03 05:09:18.087805 | instance | INFO [csi > prepare] Executing 2026-09-03 05:09:18.803291 | instance | 2026-09-03 05:09:18.803521 | instance | PLAY [Prepare] ***************************************************************** 2026-09-03 05:09:18.803748 | instance | 2026-09-03 05:09:18.803995 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-03 05:09:18.804180 | instance | Thursday 03 September 2026 05:09:18 +0000 (0:00:00.023) 0:00:00.023 **** 2026-09-03 05:09:20.162561 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-09-03 05:09:20.162671 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-09-03 05:09:20.162957 | instance | interpreter could change the meaning of that path. See 2026-09-03 05:09:20.163175 | instance | https://docs.ansible.com/ansible- 2026-09-03 05:09:20.163403 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-09-03 05:09:20.176009 | instance | ok: [instance] 2026-09-03 05:09:20.176211 | instance | 2026-09-03 05:09:20.176434 | instance | TASK [Configure short hostname] ************************************************ 2026-09-03 05:09:20.176651 | instance | Thursday 03 September 2026 05:09:20 +0000 (0:00:01.372) 0:00:01.396 **** 2026-09-03 05:09:20.957631 | instance | changed: [instance] 2026-09-03 05:09:20.957845 | instance | 2026-09-03 05:09:20.958077 | instance | TASK [Ensure hostname inside hosts file] *************************************** 2026-09-03 05:09:20.958310 | instance | Thursday 03 September 2026 05:09:20 +0000 (0:00:00.781) 0:00:02.177 **** 2026-09-03 05:09:21.249828 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created 2026-09-03 05:09:21.250042 | instance | with a mode of 0700, this may cause issues when running as another user. To 2026-09-03 05:09:21.250266 | instance | avoid this, create the remote_tmp dir with the correct permissions manually 2026-09-03 05:09:21.259794 | instance | changed: [instance] 2026-09-03 05:09:21.259997 | instance | 2026-09-03 05:09:21.260223 | instance | TASK [Purge "snapd" package] *************************************************** 2026-09-03 05:09:21.260446 | instance | Thursday 03 September 2026 05:09:21 +0000 (0:00:00.302) 0:00:02.479 **** 2026-09-03 05:09:22.023737 | instance | ok: [instance] 2026-09-03 05:09:22.023934 | instance | 2026-09-03 05:09:22.024164 | instance | PLAY [Create devices for Ceph] ************************************************* 2026-09-03 05:09:22.024370 | instance | 2026-09-03 05:09:22.024589 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-03 05:09:22.024833 | instance | Thursday 03 September 2026 05:09:22 +0000 (0:00:00.763) 0:00:03.243 **** 2026-09-03 05:09:22.806966 | instance | ok: [instance] 2026-09-03 05:09:22.807132 | instance | 2026-09-03 05:09:22.807409 | instance | TASK [Install depedencies] ***************************************************** 2026-09-03 05:09:22.807638 | instance | Thursday 03 September 2026 05:09:22 +0000 (0:00:00.782) 0:00:04.026 **** 2026-09-03 05:09:47.049133 | instance | changed: [instance] 2026-09-03 05:09:47.049335 | instance | 2026-09-03 05:09:47.049584 | instance | TASK [Start up service] ******************************************************** 2026-09-03 05:09:47.049861 | instance | Thursday 03 September 2026 05:09:47 +0000 (0:00:24.242) 0:00:28.269 **** 2026-09-03 05:09:47.608082 | instance | ok: [instance] 2026-09-03 05:09:47.608383 | instance | 2026-09-03 05:09:47.608654 | instance | TASK [Generate lvm.conf] ******************************************************* 2026-09-03 05:09:47.608920 | instance | Thursday 03 September 2026 05:09:47 +0000 (0:00:00.558) 0:00:28.827 **** 2026-09-03 05:09:47.939104 | instance | ok: [instance] 2026-09-03 05:09:47.939318 | instance | 2026-09-03 05:09:47.939582 | instance | TASK [Write /etc/lvm/lvm.conf] ************************************************* 2026-09-03 05:09:47.939857 | instance | Thursday 03 September 2026 05:09:47 +0000 (0:00:00.331) 0:00:29.159 **** 2026-09-03 05:09:48.622252 | instance | changed: [instance] 2026-09-03 05:09:48.622305 | instance | 2026-09-03 05:09:48.622318 | instance | TASK [Get list of all loopback devices] **************************************** 2026-09-03 05:09:48.622329 | instance | Thursday 03 September 2026 05:09:48 +0000 (0:00:00.682) 0:00:29.841 **** 2026-09-03 05:09:48.834404 | instance | ok: [instance] 2026-09-03 05:09:48.834825 | instance | 2026-09-03 05:09:48.835367 | instance | TASK [Fail if there is any existing loopback devices] ************************** 2026-09-03 05:09:48.835410 | instance | Thursday 03 September 2026 05:09:48 +0000 (0:00:00.212) 0:00:30.054 **** 2026-09-03 05:09:48.856829 | instance | skipping: [instance] 2026-09-03 05:09:48.857535 | instance | 2026-09-03 05:09:48.857566 | instance | TASK [Create devices for Ceph] ************************************************* 2026-09-03 05:09:48.857577 | instance | Thursday 03 September 2026 05:09:48 +0000 (0:00:00.022) 0:00:30.076 **** 2026-09-03 05:09:49.425855 | instance | changed: [instance] => (item=osd0) 2026-09-03 05:09:49.426071 | instance | changed: [instance] => (item=osd1) 2026-09-03 05:09:49.426394 | instance | changed: [instance] => (item=osd2) 2026-09-03 05:09:49.426668 | instance | 2026-09-03 05:09:49.427030 | instance | TASK [Set permissions on loopback devices] ************************************* 2026-09-03 05:09:49.427323 | instance | Thursday 03 September 2026 05:09:49 +0000 (0:00:00.568) 0:00:30.645 **** 2026-09-03 05:09:50.079325 | instance | changed: [instance] => (item=osd0) 2026-09-03 05:09:50.079447 | instance | changed: [instance] => (item=osd1) 2026-09-03 05:09:50.079634 | instance | changed: [instance] => (item=osd2) 2026-09-03 05:09:50.079824 | instance | 2026-09-03 05:09:50.080001 | instance | TASK [Start loop devices] ****************************************************** 2026-09-03 05:09:50.080180 | instance | Thursday 03 September 2026 05:09:50 +0000 (0:00:00.654) 0:00:31.299 **** 2026-09-03 05:09:50.790308 | instance | changed: [instance] => (item=osd0) 2026-09-03 05:09:50.790415 | instance | changed: [instance] => (item=osd1) 2026-09-03 05:09:50.790557 | instance | changed: [instance] => (item=osd2) 2026-09-03 05:09:50.790991 | instance | 2026-09-03 05:09:50.791167 | instance | TASK [Create a volume group for each loop device] ****************************** 2026-09-03 05:09:50.791339 | instance | Thursday 03 September 2026 05:09:50 +0000 (0:00:00.710) 0:00:32.010 **** 2026-09-03 05:09:53.844103 | instance | changed: [instance] => (item=osd0) 2026-09-03 05:09:53.845295 | instance | changed: [instance] => (item=osd1) 2026-09-03 05:09:53.845341 | instance | changed: [instance] => (item=osd2) 2026-09-03 05:09:53.845353 | instance | 2026-09-03 05:09:53.845363 | instance | TASK [Create a logical volume for each loop device] **************************** 2026-09-03 05:09:53.845372 | instance | Thursday 03 September 2026 05:09:53 +0000 (0:00:03.053) 0:00:35.064 **** 2026-09-03 05:09:55.701384 | instance | changed: [instance] => (item=ceph-instance-osd0) 2026-09-03 05:09:55.701777 | instance | changed: [instance] => (item=ceph-instance-osd1) 2026-09-03 05:09:55.702771 | instance | changed: [instance] => (item=ceph-instance-osd2) 2026-09-03 05:09:55.702787 | instance | 2026-09-03 05:09:55.702794 | instance | PLAY RECAP ********************************************************************* 2026-09-03 05:09:55.702801 | instance | instance : ok=15 changed=9 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-09-03 05:09:55.706784 | instance | 2026-09-03 05:09:55.706799 | instance | Thursday 03 September 2026 05:09:55 +0000 (0:00:01.857) 0:00:36.921 **** 2026-09-03 05:09:55.706806 | instance | =============================================================================== 2026-09-03 05:09:55.706812 | instance | Install depedencies ---------------------------------------------------- 24.24s 2026-09-03 05:09:55.706818 | instance | Create a volume group for each loop device ------------------------------ 3.05s 2026-09-03 05:09:55.706823 | instance | Create a logical volume for each loop device ---------------------------- 1.86s 2026-09-03 05:09:55.706830 | instance | Gathering Facts --------------------------------------------------------- 1.37s 2026-09-03 05:09:55.706835 | instance | Gathering Facts --------------------------------------------------------- 0.78s 2026-09-03 05:09:55.706841 | instance | Configure short hostname ------------------------------------------------ 0.78s 2026-09-03 05:09:55.706847 | instance | Purge "snapd" package --------------------------------------------------- 0.76s 2026-09-03 05:09:55.706853 | instance | Start loop devices ------------------------------------------------------ 0.71s 2026-09-03 05:09:55.706858 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.68s 2026-09-03 05:09:55.706864 | instance | Set permissions on loopback devices ------------------------------------- 0.65s 2026-09-03 05:09:55.706870 | instance | Create devices for Ceph ------------------------------------------------- 0.57s 2026-09-03 05:09:55.706875 | instance | Start up service -------------------------------------------------------- 0.56s 2026-09-03 05:09:55.706881 | instance | Generate lvm.conf ------------------------------------------------------- 0.33s 2026-09-03 05:09:55.706890 | instance | Ensure hostname inside hosts file --------------------------------------- 0.30s 2026-09-03 05:09:55.707125 | instance | Get list of all loopback devices ---------------------------------------- 0.21s 2026-09-03 05:09:55.707535 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s 2026-09-03 05:09:55.790997 | instance | INFO [csi > prepare] Executed: Successful 2026-09-03 05:09:55.806018 | instance | INFO [csi > converge] Executing 2026-09-03 05:09:57.154927 | instance | 2026-09-03 05:09:57.155284 | instance | PLAY [Debug CSI driver value] ************************************************** 2026-09-03 05:09:57.155558 | instance | 2026-09-03 05:09:57.155866 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-03 05:09:57.156173 | instance | Thursday 03 September 2026 05:09:57 +0000 (0:00:00.007) 0:00:00.007 **** 2026-09-03 05:09:58.141234 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-09-03 05:09:58.141634 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-09-03 05:09:58.141977 | instance | interpreter could change the meaning of that path. See 2026-09-03 05:09:58.142281 | instance | https://docs.ansible.com/ansible- 2026-09-03 05:09:58.142674 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-09-03 05:09:58.153962 | instance | ok: [instance] 2026-09-03 05:09:58.154257 | instance | 2026-09-03 05:09:58.154554 | instance | TASK [Display CSI driver value and environment variable] *********************** 2026-09-03 05:09:58.154918 | instance | Thursday 03 September 2026 05:09:58 +0000 (0:00:00.999) 0:00:01.006 **** 2026-09-03 05:09:58.213124 | instance | ok: [instance] => { 2026-09-03 05:09:58.213437 | instance | "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER=" 2026-09-03 05:09:58.213718 | instance | } 2026-09-03 05:09:58.214042 | instance | 2026-09-03 05:09:58.214352 | instance | PLAY [all] ********************************************************************* 2026-09-03 05:09:58.214704 | instance | 2026-09-03 05:09:58.215085 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-03 05:09:58.215404 | instance | Thursday 03 September 2026 05:09:58 +0000 (0:00:00.059) 0:00:01.065 **** 2026-09-03 05:09:59.122971 | instance | ok: [instance] 2026-09-03 05:09:59.123439 | instance | 2026-09-03 05:09:59.123795 | instance | TASK [Fail if atmosphere_ceph_enabled is set] ********************************** 2026-09-03 05:09:59.124128 | instance | Thursday 03 September 2026 05:09:59 +0000 (0:00:00.908) 0:00:01.974 **** 2026-09-03 05:09:59.170894 | instance | skipping: [instance] 2026-09-03 05:09:59.171204 | instance | 2026-09-03 05:09:59.171521 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-09-03 05:09:59.171884 | instance | Thursday 03 September 2026 05:09:59 +0000 (0:00:00.048) 0:00:02.023 **** 2026-09-03 05:09:59.372774 | instance | ok: [instance] 2026-09-03 05:09:59.372925 | instance | 2026-09-03 05:09:59.373065 | instance | PLAY [Deploy Ceph monitors & managers] ***************************************** 2026-09-03 05:09:59.373192 | instance | 2026-09-03 05:09:59.373325 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-03 05:09:59.373478 | instance | Thursday 03 September 2026 05:09:59 +0000 (0:00:00.202) 0:00:02.225 **** 2026-09-03 05:10:00.352798 | instance | ok: [instance] 2026-09-03 05:10:00.353047 | instance | 2026-09-03 05:10:00.353234 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-09-03 05:10:00.353415 | instance | Thursday 03 September 2026 05:10:00 +0000 (0:00:00.978) 0:00:03.204 **** 2026-09-03 05:10:00.727604 | instance | ok: [instance] 2026-09-03 05:10:00.728016 | instance | 2026-09-03 05:10:00.728346 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-09-03 05:10:00.728746 | instance | Thursday 03 September 2026 05:10:00 +0000 (0:00:00.374) 0:00:03.578 **** 2026-09-03 05:10:00.778004 | instance | skipping: [instance] 2026-09-03 05:10:00.778354 | instance | 2026-09-03 05:10:00.778660 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-09-03 05:10:00.779007 | instance | Thursday 03 September 2026 05:10:00 +0000 (0:00:00.051) 0:00:03.630 **** 2026-09-03 05:10:01.136754 | instance | changed: [instance] 2026-09-03 05:10:01.137120 | instance | 2026-09-03 05:10:01.137443 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-09-03 05:10:01.137859 | instance | Thursday 03 September 2026 05:10:01 +0000 (0:00:00.357) 0:00:03.988 **** 2026-09-03 05:10:01.216546 | instance | ok: [instance] => { 2026-09-03 05:10:01.216917 | instance | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-09-03 05:10:01.217230 | instance | } 2026-09-03 05:10:01.217510 | instance | 2026-09-03 05:10:01.217837 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-09-03 05:10:01.218131 | instance | Thursday 03 September 2026 05:10:01 +0000 (0:00:00.080) 0:00:04.068 **** 2026-09-03 05:10:02.296037 | instance | changed: [instance] 2026-09-03 05:10:02.296483 | instance | 2026-09-03 05:10:02.296946 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-09-03 05:10:02.297341 | instance | Thursday 03 September 2026 05:10:02 +0000 (0:00:01.078) 0:00:05.147 **** 2026-09-03 05:10:02.353039 | instance | skipping: [instance] 2026-09-03 05:10:02.353306 | instance | 2026-09-03 05:10:02.353510 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-09-03 05:10:02.353706 | instance | Thursday 03 September 2026 05:10:02 +0000 (0:00:00.056) 0:00:05.203 **** 2026-09-03 05:10:02.401302 | instance | skipping: [instance] 2026-09-03 05:10:02.401350 | instance | 2026-09-03 05:10:02.401357 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-09-03 05:10:02.401364 | instance | Thursday 03 September 2026 05:10:02 +0000 (0:00:00.049) 0:00:05.253 **** 2026-09-03 05:10:02.626858 | instance | ok: [instance] 2026-09-03 05:10:02.626935 | instance | 2026-09-03 05:10:02.627038 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-09-03 05:10:02.627354 | instance | Thursday 03 September 2026 05:10:02 +0000 (0:00:00.225) 0:00:05.478 **** 2026-09-03 05:10:03.799821 | instance | ok: [instance] 2026-09-03 05:10:03.799971 | instance | 2026-09-03 05:10:03.800249 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-09-03 05:10:03.800474 | instance | Thursday 03 September 2026 05:10:03 +0000 (0:00:01.172) 0:00:06.651 **** 2026-09-03 05:10:03.893280 | instance | ok: [instance] => { 2026-09-03 05:10:03.893540 | instance | "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz" 2026-09-03 05:10:03.893719 | instance | } 2026-09-03 05:10:03.893963 | instance | 2026-09-03 05:10:03.894196 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-09-03 05:10:03.894424 | instance | Thursday 03 September 2026 05:10:03 +0000 (0:00:00.093) 0:00:06.745 **** 2026-09-03 05:10:04.689608 | instance | changed: [instance] 2026-09-03 05:10:04.689675 | instance | 2026-09-03 05:10:04.689797 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-09-03 05:10:04.689905 | instance | Thursday 03 September 2026 05:10:04 +0000 (0:00:00.796) 0:00:07.541 **** 2026-09-03 05:10:07.541607 | instance | changed: [instance] 2026-09-03 05:10:07.542002 | instance | 2026-09-03 05:10:07.542324 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-09-03 05:10:07.542667 | instance | Thursday 03 September 2026 05:10:07 +0000 (0:00:02.851) 0:00:10.393 **** 2026-09-03 05:10:07.581634 | instance | skipping: [instance] 2026-09-03 05:10:07.581733 | instance | 2026-09-03 05:10:07.582167 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-09-03 05:10:07.582544 | instance | Thursday 03 September 2026 05:10:07 +0000 (0:00:00.040) 0:00:10.433 **** 2026-09-03 05:10:07.627314 | instance | skipping: [instance] 2026-09-03 05:10:07.627589 | instance | 2026-09-03 05:10:07.627808 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-09-03 05:10:07.628002 | instance | Thursday 03 September 2026 05:10:07 +0000 (0:00:00.042) 0:00:10.476 **** 2026-09-03 05:10:07.668091 | instance | skipping: [instance] 2026-09-03 05:10:07.668131 | instance | 2026-09-03 05:10:07.668145 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-09-03 05:10:07.668159 | instance | Thursday 03 September 2026 05:10:07 +0000 (0:00:00.043) 0:00:10.519 **** 2026-09-03 05:10:13.280664 | instance | changed: [instance] 2026-09-03 05:10:13.280868 | instance | 2026-09-03 05:10:13.281034 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] *** 2026-09-03 05:10:13.281174 | instance | Thursday 03 September 2026 05:10:13 +0000 (0:00:05.613) 0:00:16.132 **** 2026-09-03 05:10:13.968344 | instance | changed: [instance] 2026-09-03 05:10:13.968388 | instance | 2026-09-03 05:10:13.968395 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] ******* 2026-09-03 05:10:13.968401 | instance | Thursday 03 September 2026 05:10:13 +0000 (0:00:00.686) 0:00:16.819 **** 2026-09-03 05:10:14.970594 | instance | changed: [instance] => (item={'path': '/etc/containerd'}) 2026-09-03 05:10:14.970658 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'}) 2026-09-03 05:10:14.970670 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'}) 2026-09-03 05:10:14.970693 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'}) 2026-09-03 05:10:14.970703 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'}) 2026-09-03 05:10:14.970712 | instance | 2026-09-03 05:10:14.970722 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] ********** 2026-09-03 05:10:14.970760 | instance | Thursday 03 September 2026 05:10:14 +0000 (0:00:01.000) 0:00:17.820 **** 2026-09-03 05:10:15.609973 | instance | changed: [instance] 2026-09-03 05:10:15.610084 | instance | 2026-09-03 05:10:15.610929 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ******** 2026-09-03 05:10:15.611036 | instance | Thursday 03 September 2026 05:10:15 +0000 (0:00:00.615) 0:00:18.435 **** 2026-09-03 05:10:15.611047 | instance | 2026-09-03 05:10:15.611057 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-09-03 05:10:15.611078 | instance | Thursday 03 September 2026 05:10:15 +0000 (0:00:00.026) 0:00:18.462 **** 2026-09-03 05:10:16.570291 | instance | ok: [instance] 2026-09-03 05:10:16.570429 | instance | 2026-09-03 05:10:16.570441 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] ********** 2026-09-03 05:10:16.570584 | instance | Thursday 03 September 2026 05:10:16 +0000 (0:00:00.960) 0:00:19.422 **** 2026-09-03 05:10:17.071212 | instance | changed: [instance] 2026-09-03 05:10:17.071970 | instance | 2026-09-03 05:10:17.072021 | instance | TASK [vexxhost.containers.containerd : Enable and start service] *************** 2026-09-03 05:10:17.072033 | instance | Thursday 03 September 2026 05:10:17 +0000 (0:00:00.500) 0:00:19.922 **** 2026-09-03 05:10:17.663381 | instance | changed: [instance] 2026-09-03 05:10:17.664089 | instance | 2026-09-03 05:10:17.664141 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-09-03 05:10:17.664153 | instance | Thursday 03 September 2026 05:10:17 +0000 (0:00:00.592) 0:00:20.515 **** 2026-09-03 05:10:17.899967 | instance | ok: [instance] 2026-09-03 05:10:17.900931 | instance | 2026-09-03 05:10:17.900967 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-09-03 05:10:17.900981 | instance | Thursday 03 September 2026 05:10:17 +0000 (0:00:00.236) 0:00:20.752 **** 2026-09-03 05:10:17.972976 | instance | ok: [instance] => { 2026-09-03 05:10:17.974532 | instance | "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz" 2026-09-03 05:10:17.974568 | instance | } 2026-09-03 05:10:17.974582 | instance | 2026-09-03 05:10:17.974594 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-09-03 05:10:17.974608 | instance | Thursday 03 September 2026 05:10:17 +0000 (0:00:00.072) 0:00:20.824 **** 2026-09-03 05:10:28.728803 | instance | changed: [instance] 2026-09-03 05:10:28.728873 | instance | 2026-09-03 05:10:28.729124 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-09-03 05:10:28.729287 | instance | Thursday 03 September 2026 05:10:28 +0000 (0:00:10.756) 0:00:31.581 **** 2026-09-03 05:10:34.041521 | instance | changed: [instance] 2026-09-03 05:10:34.041642 | instance | 2026-09-03 05:10:34.042032 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ****************** 2026-09-03 05:10:34.042098 | instance | Thursday 03 September 2026 05:10:34 +0000 (0:00:05.311) 0:00:36.893 **** 2026-09-03 05:10:35.099458 | instance | ok: [instance] 2026-09-03 05:10:35.099572 | instance | 2026-09-03 05:10:35.100144 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] *************** 2026-09-03 05:10:35.100212 | instance | Thursday 03 September 2026 05:10:35 +0000 (0:00:01.057) 0:00:37.951 **** 2026-09-03 05:10:35.428923 | instance | changed: [instance] 2026-09-03 05:10:35.428997 | instance | 2026-09-03 05:10:35.429227 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] ***** 2026-09-03 05:10:35.429260 | instance | Thursday 03 September 2026 05:10:35 +0000 (0:00:00.330) 0:00:38.281 **** 2026-09-03 05:10:35.951653 | instance | changed: [instance] 2026-09-03 05:10:35.952391 | instance | 2026-09-03 05:10:35.952447 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] *********** 2026-09-03 05:10:35.952459 | instance | Thursday 03 September 2026 05:10:35 +0000 (0:00:00.522) 0:00:38.803 **** 2026-09-03 05:10:36.556943 | instance | changed: [instance] => (item={'path': '/etc/docker'}) 2026-09-03 05:10:36.558078 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'}) 2026-09-03 05:10:36.558110 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'}) 2026-09-03 05:10:36.558122 | instance | 2026-09-03 05:10:36.558131 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ****** 2026-09-03 05:10:36.558140 | instance | Thursday 03 September 2026 05:10:36 +0000 (0:00:00.605) 0:00:39.408 **** 2026-09-03 05:10:36.996884 | instance | changed: [instance] 2026-09-03 05:10:36.996938 | instance | 2026-09-03 05:10:36.997167 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] *********** 2026-09-03 05:10:36.997183 | instance | Thursday 03 September 2026 05:10:36 +0000 (0:00:00.440) 0:00:39.849 **** 2026-09-03 05:10:37.467309 | instance | changed: [instance] 2026-09-03 05:10:37.467363 | instance | 2026-09-03 05:10:37.467871 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************ 2026-09-03 05:10:37.467896 | instance | Thursday 03 September 2026 05:10:37 +0000 (0:00:00.453) 0:00:40.303 **** 2026-09-03 05:10:37.467901 | instance | 2026-09-03 05:10:37.467905 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-09-03 05:10:37.467913 | instance | Thursday 03 September 2026 05:10:37 +0000 (0:00:00.016) 0:00:40.319 **** 2026-09-03 05:10:38.236277 | instance | ok: [instance] 2026-09-03 05:10:38.237093 | instance | 2026-09-03 05:10:38.237127 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ****************** 2026-09-03 05:10:38.237139 | instance | Thursday 03 September 2026 05:10:38 +0000 (0:00:00.768) 0:00:41.088 **** 2026-09-03 05:10:39.098852 | instance | changed: [instance] 2026-09-03 05:10:39.099586 | instance | 2026-09-03 05:10:39.099644 | instance | TASK [vexxhost.containers.docker : Enable and start service] ******************* 2026-09-03 05:10:39.099655 | instance | Thursday 03 September 2026 05:10:39 +0000 (0:00:00.862) 0:00:41.950 **** 2026-09-03 05:10:39.707080 | instance | changed: [instance] 2026-09-03 05:10:39.707197 | instance | 2026-09-03 05:10:39.707341 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ****** 2026-09-03 05:10:39.707495 | instance | Thursday 03 September 2026 05:10:39 +0000 (0:00:00.608) 0:00:42.559 **** 2026-09-03 05:10:39.777869 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml) 2026-09-03 05:10:39.778126 | instance | 2026-09-03 05:10:39.778354 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ******************************** 2026-09-03 05:10:39.778581 | instance | Thursday 03 September 2026 05:10:39 +0000 (0:00:00.070) 0:00:42.630 **** 2026-09-03 05:10:45.042616 | instance | changed: [instance] 2026-09-03 05:10:45.042891 | instance | 2026-09-03 05:10:45.042921 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] ********************* 2026-09-03 05:10:45.043104 | instance | Thursday 03 September 2026 05:10:45 +0000 (0:00:05.264) 0:00:47.894 **** 2026-09-03 05:10:45.682044 | instance | ok: [instance] => (item=chronyd) 2026-09-03 05:10:45.682217 | instance | ok: [instance] => (item=sshd) 2026-09-03 05:10:45.682453 | instance | 2026-09-03 05:10:45.682683 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ****************************** 2026-09-03 05:10:45.683027 | instance | Thursday 03 September 2026 05:10:45 +0000 (0:00:00.638) 0:00:48.533 **** 2026-09-03 05:10:47.769626 | instance | changed: [instance] 2026-09-03 05:10:47.769787 | instance | 2026-09-03 05:10:47.770048 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ******************** 2026-09-03 05:10:47.770281 | instance | Thursday 03 September 2026 05:10:47 +0000 (0:00:02.087) 0:00:50.621 **** 2026-09-03 05:10:47.990439 | instance | ok: [instance] 2026-09-03 05:10:47.990547 | instance | 2026-09-03 05:10:47.990691 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] **************** 2026-09-03 05:10:47.990894 | instance | Thursday 03 September 2026 05:10:47 +0000 (0:00:00.220) 0:00:50.842 **** 2026-09-03 05:10:48.529342 | instance | changed: [instance] 2026-09-03 05:10:48.529551 | instance | 2026-09-03 05:10:48.529867 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] *** 2026-09-03 05:10:48.530128 | instance | Thursday 03 September 2026 05:10:48 +0000 (0:00:00.538) 0:00:51.380 **** 2026-09-03 05:10:48.858085 | instance | changed: [instance] 2026-09-03 05:10:48.858295 | instance | 2026-09-03 05:10:48.858567 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] ************************* 2026-09-03 05:10:48.858873 | instance | Thursday 03 September 2026 05:10:48 +0000 (0:00:00.329) 0:00:51.710 **** 2026-09-03 05:10:49.045676 | instance | ok: [instance] 2026-09-03 05:10:49.045918 | instance | 2026-09-03 05:10:49.046171 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] ******************* 2026-09-03 05:10:49.046426 | instance | Thursday 03 September 2026 05:10:49 +0000 (0:00:00.187) 0:00:51.897 **** 2026-09-03 05:10:49.299107 | instance | ok: [instance] => (item=instance) 2026-09-03 05:10:49.299300 | instance | 2026-09-03 05:10:49.299532 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ******** 2026-09-03 05:10:49.299761 | instance | Thursday 03 September 2026 05:10:49 +0000 (0:00:00.252) 0:00:52.150 **** 2026-09-03 05:10:49.370531 | instance | ok: [instance] 2026-09-03 05:10:49.370763 | instance | 2026-09-03 05:10:49.371043 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] *********************************** 2026-09-03 05:10:49.371277 | instance | Thursday 03 September 2026 05:10:49 +0000 (0:00:00.071) 0:00:52.222 **** 2026-09-03 05:10:49.461838 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance 2026-09-03 05:10:49.462067 | instance | 2026-09-03 05:10:49.462294 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] ************* 2026-09-03 05:10:49.462519 | instance | Thursday 03 September 2026 05:10:49 +0000 (0:00:00.091) 0:00:52.314 **** 2026-09-03 05:10:49.758634 | instance | changed: [instance] 2026-09-03 05:10:49.758873 | instance | 2026-09-03 05:10:49.759038 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ****************** 2026-09-03 05:10:49.759193 | instance | Thursday 03 September 2026 05:10:49 +0000 (0:00:00.296) 0:00:52.610 **** 2026-09-03 05:10:50.440118 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True}) 2026-09-03 05:10:50.440373 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0}) 2026-09-03 05:10:50.440626 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False}) 2026-09-03 05:10:50.440848 | instance | 2026-09-03 05:10:50.441104 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] ******************************* 2026-09-03 05:10:50.441340 | instance | Thursday 03 September 2026 05:10:50 +0000 (0:00:00.681) 0:00:53.292 **** 2026-09-03 05:12:27.755341 | instance | ok: [instance] 2026-09-03 05:12:27.755482 | instance | 2026-09-03 05:12:27.755722 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] *************** 2026-09-03 05:12:27.755982 | instance | Thursday 03 September 2026 05:12:27 +0000 (0:01:37.314) 0:02:30.606 **** 2026-09-03 05:12:27.971778 | instance | changed: [instance] 2026-09-03 05:12:27.971834 | instance | 2026-09-03 05:12:27.971846 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] ********************************** 2026-09-03 05:12:27.971856 | instance | Thursday 03 September 2026 05:12:27 +0000 (0:00:00.216) 0:02:30.822 **** 2026-09-03 05:12:28.015847 | instance | ok: [instance] 2026-09-03 05:12:28.015897 | instance | 2026-09-03 05:12:28.015908 | instance | TASK [Install Ceph host] ******************************************************* 2026-09-03 05:12:28.015918 | instance | Thursday 03 September 2026 05:12:28 +0000 (0:00:00.044) 0:02:30.867 **** 2026-09-03 05:12:28.105575 | instance | included: vexxhost.ceph.cephadm_host for instance 2026-09-03 05:12:28.105611 | instance | 2026-09-03 05:12:28.105616 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ****** 2026-09-03 05:12:28.105620 | instance | Thursday 03 September 2026 05:12:28 +0000 (0:00:00.090) 0:02:30.957 **** 2026-09-03 05:12:29.703274 | instance | ok: [instance] 2026-09-03 05:12:29.704004 | instance | 2026-09-03 05:12:29.704060 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] *** 2026-09-03 05:12:29.704074 | instance | Thursday 03 September 2026 05:12:29 +0000 (0:00:01.597) 0:02:32.555 **** 2026-09-03 05:12:29.773796 | instance | ok: [instance] => (item=instance) 2026-09-03 05:12:29.774025 | instance | 2026-09-03 05:12:29.774271 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] *********** 2026-09-03 05:12:29.774506 | instance | Thursday 03 September 2026 05:12:29 +0000 (0:00:00.070) 0:02:32.625 **** 2026-09-03 05:12:30.129554 | instance | ok: [instance] 2026-09-03 05:12:30.129603 | instance | 2026-09-03 05:12:30.129614 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] *********************** 2026-09-03 05:12:30.129625 | instance | Thursday 03 September 2026 05:12:30 +0000 (0:00:00.355) 0:02:32.980 **** 2026-09-03 05:12:32.415342 | instance | ok: [instance] 2026-09-03 05:12:32.415452 | instance | 2026-09-03 05:12:32.415799 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ****************** 2026-09-03 05:12:32.415840 | instance | Thursday 03 September 2026 05:12:32 +0000 (0:00:02.286) 0:02:35.267 **** 2026-09-03 05:13:23.244429 | 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-03 05:13:23.245363 | 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_ui2li5ms/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_ui2li5ms/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_ui2li5ms/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_ui2li5ms/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-03T05:13:23.068+0000 7f6894d50640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCRAZlqg1/nJSAAe9zpLLWXObczyDMyNyoGOiuZOoiqraB9CFk38kbaGCk=: Malformed input [buffer:3]\n2026-09-03T05:13:23.068+0000 7f6894d50640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-03T05:13:23.068+0000 7f6894d50640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCRAZlqg1/nJSAAe9zpLLWXObczyDMyNyoGOiuZOoiqraB9CFk38kbaGCk=: Malformed input [buffer:3]\n2026-09-03T05:13:23.068+0000 7f6894d50640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-03T05:13:23.068+0000 7f6894d50640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCRAZlqg1/nJSAAe9zpLLWXObczyDMyNyoGOiuZOoiqraB9CFk38kbaGCk=: Malformed input [buffer:3]\n2026-09-03T05:13:23.068+0000 7f6894d50640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-03T05:13:23.068+0000 7f6894d50640 -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-03 05:13:23.250845 | instance | 2026-09-03 05:13:23.250902 | instance | PLAY RECAP ********************************************************************* 2026-09-03 05:13:23.250914 | instance | instance : ok=55 changed=26 unreachable=0 failed=1 skipped=7 rescued=0 ignored=0 2026-09-03 05:13:23.250923 | instance | 2026-09-03 05:13:23.250933 | instance | Thursday 03 September 2026 05:13:23 +0000 (0:00:50.833) 0:03:26.100 **** 2026-09-03 05:13:23.250942 | instance | =============================================================================== 2026-09-03 05:13:23.250950 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 97.31s 2026-09-03 05:13:23.250959 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 50.83s 2026-09-03 05:13:23.250968 | instance | vexxhost.containers.download_artifact : Download item ------------------ 10.76s 2026-09-03 05:13:23.250977 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 5.61s 2026-09-03 05:13:23.250986 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 5.31s 2026-09-03 05:13:23.250994 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 5.26s 2026-09-03 05:13:23.251027 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.85s 2026-09-03 05:13:23.251036 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.29s 2026-09-03 05:13:23.253706 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 2.09s 2026-09-03 05:13:23.253740 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.73s 2026-09-03 05:13:23.253751 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.60s 2026-09-03 05:13:23.253760 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.17s 2026-09-03 05:13:23.253768 | instance | vexxhost.containers.download_artifact : Download item ------------------- 1.08s 2026-09-03 05:13:23.253777 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.06s 2026-09-03 05:13:23.253785 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 1.00s 2026-09-03 05:13:23.253794 | instance | Gathering Facts --------------------------------------------------------- 1.00s 2026-09-03 05:13:23.253802 | instance | Gathering Facts --------------------------------------------------------- 0.98s 2026-09-03 05:13:23.253811 | instance | Gathering Facts --------------------------------------------------------- 0.91s 2026-09-03 05:13:23.253819 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 0.86s 2026-09-03 05:13:23.253828 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.80s 2026-09-03 05:13:23.350639 | 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-03 05:13:23.350972 | instance | ERROR [csi > converge] Executed: Failed 2026-09-03 05:13:23.351166 | 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-03 05:13:24.349166 | instance | ERROR 2026-09-03 05:13:24.349736 | instance | { 2026-09-03 05:13:24.349807 | instance | "delta": "0:04:18.702577", 2026-09-03 05:13:24.349856 | instance | "end": "2026-09-03 05:13:23.418145", 2026-09-03 05:13:24.349900 | instance | "msg": "non-zero return code", 2026-09-03 05:13:24.349942 | instance | "rc": 2, 2026-09-03 05:13:24.349983 | instance | "start": "2026-09-03 05:09:04.715568" 2026-09-03 05:13:24.350025 | instance | } failure 2026-09-03 05:13:24.355223 | 2026-09-03 05:13:24.355275 | PLAY RECAP 2026-09-03 05:13:24.355322 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-09-03 05:13:24.355345 | 2026-09-03 05:13:24.484607 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-09-03 05:13:24.488149 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-09-03 05:13:25.162873 | 2026-09-03 05:13:25.163028 | PLAY [all] 2026-09-03 05:13:25.177602 | 2026-09-03 05:13:25.177681 | TASK [gather-host-logs : creating directory for system status] 2026-09-03 05:13:25.556844 | instance | changed 2026-09-03 05:13:25.565305 | 2026-09-03 05:13:25.565386 | TASK [gather-host-logs : Get logs for each host] 2026-09-03 05:13:25.938398 | instance | + systemd-cgls --full --all --no-pager 2026-09-03 05:13:25.953264 | instance | + ip addr 2026-09-03 05:13:25.954881 | instance | + ip route 2026-09-03 05:13:25.956994 | instance | + lsblk 2026-09-03 05:13:25.960188 | instance | + mount 2026-09-03 05:13:25.962842 | instance | + docker images 2026-09-03 05:13:25.983495 | instance | + brctl show 2026-09-03 05:13:25.984027 | instance | /bin/bash: line 8: brctl: command not found 2026-09-03 05:13:25.984285 | instance | + ps aux --sort=-%mem 2026-09-03 05:13:26.003825 | instance | + dpkg -l 2026-09-03 05:13:26.014551 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-09-03 05:13:26.015145 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-09-03 05:13:26.035309 | instance | + '[' '!' -z '' ']' 2026-09-03 05:13:26.106292 | instance | ok: Runtime: 0:00:00.101243 2026-09-03 05:13:26.112613 | 2026-09-03 05:13:26.112680 | TASK [gather-host-logs : Downloads logs to executor] 2026-09-03 05:13:26.751712 | instance | changed: 2026-09-03 05:13:26.751886 | instance | created directory /var/lib/zuul/builds/193aac422fc54c54b3c793ff8a4f6b05/work/logs/instance 2026-09-03 05:13:26.751916 | instance | cd+++++++++ system/ 2026-09-03 05:13:26.751984 | instance | >f+++++++++ system/brctl-show.txt 2026-09-03 05:13:26.752093 | instance | >f+++++++++ system/docker-images.txt 2026-09-03 05:13:26.752125 | instance | >f+++++++++ system/ip-addr.txt 2026-09-03 05:13:26.752149 | instance | >f+++++++++ system/ip-route.txt 2026-09-03 05:13:26.752172 | instance | >f+++++++++ system/lsblk.txt 2026-09-03 05:13:26.752193 | instance | >f+++++++++ system/mount.txt 2026-09-03 05:13:26.752215 | instance | >f+++++++++ system/packages.txt 2026-09-03 05:13:26.752234 | instance | >f+++++++++ system/ps.txt 2026-09-03 05:13:26.752256 | instance | >f+++++++++ system/systemd-cgls.txt 2026-09-03 05:13:26.761881 | 2026-09-03 05:13:26.761952 | LOOP [helm-release-status : creating directory for helm release status] 2026-09-03 05:13:26.971711 | instance | changed: "values" 2026-09-03 05:13:27.148621 | instance | changed: "releases" 2026-09-03 05:13:27.168200 | 2026-09-03 05:13:27.168393 | TASK [helm-release-status : Gather get release status for helm charts] 2026-09-03 05:13:27.383619 | instance | /bin/bash: line 3: kubectl: command not found 2026-09-03 05:13:27.707647 | instance | ok: Runtime: 0:00:00.004439 2026-09-03 05:13:27.714478 | 2026-09-03 05:13:27.714549 | TASK [helm-release-status : Downloads logs to executor] 2026-09-03 05:13:28.205962 | instance | changed: 2026-09-03 05:13:28.206200 | instance | cd+++++++++ helm/ 2026-09-03 05:13:28.206383 | instance | cd+++++++++ helm/releases/ 2026-09-03 05:13:28.206599 | instance | cd+++++++++ helm/values/ 2026-09-03 05:13:28.218826 | 2026-09-03 05:13:28.218895 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-09-03 05:13:28.434858 | instance | changed 2026-09-03 05:13:28.440789 | 2026-09-03 05:13:28.440864 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-09-03 05:13:28.717133 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-03 05:13:28.717443 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-03 05:13:28.722395 | instance | environment: line 1: kubectl: command not found 2026-09-03 05:13:28.723712 | instance | environment: line 1: kubectl: command not found 2026-09-03 05:13:28.724041 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-03 05:13:28.724449 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-03 05:13:28.727040 | instance | environment: line 1: kubectl: command not found 2026-09-03 05:13:28.728332 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-03 05:13:28.728978 | instance | environment: line 1: kubectl: command not found 2026-09-03 05:13:28.729762 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-03 05:13:28.731710 | instance | environment: line 1: kubectl: command not found 2026-09-03 05:13:28.732485 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-03 05:13:30.996228 | instance | ok: Runtime: 0:00:00.023538 2026-09-03 05:13:31.001278 | 2026-09-03 05:13:31.001343 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-09-03 05:13:31.224217 | instance | changed 2026-09-03 05:13:31.229562 | 2026-09-03 05:13:31.229643 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-09-03 05:13:31.445992 | instance | environment: line 5: kubectl: command not found 2026-09-03 05:13:31.446338 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-03 05:13:31.446591 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-03 05:13:31.446877 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-03 05:13:31.763909 | instance | ok: Runtime: 0:00:00.009350 2026-09-03 05:13:31.771307 | 2026-09-03 05:13:31.771393 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-09-03 05:13:32.273126 | instance | changed: 2026-09-03 05:13:32.273350 | instance | cd+++++++++ objects/ 2026-09-03 05:13:32.273389 | instance | cd+++++++++ objects/cluster/ 2026-09-03 05:13:32.273421 | instance | cd+++++++++ objects/namespaced/ 2026-09-03 05:13:32.286630 | 2026-09-03 05:13:32.286695 | TASK [gather-pod-logs : creating directory for pod logs] 2026-09-03 05:13:32.511637 | instance | changed 2026-09-03 05:13:32.517042 | 2026-09-03 05:13:32.517108 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-09-03 05:13:32.717215 | instance | changed 2026-09-03 05:13:32.724106 | 2026-09-03 05:13:32.724192 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-09-03 05:13:32.951313 | instance | environment: line 3: kubectl: command not found 2026-09-03 05:13:33.263297 | instance | ok: Runtime: 0:00:00.008576 2026-09-03 05:13:33.270300 | 2026-09-03 05:13:33.270403 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-09-03 05:13:33.770149 | instance | changed: 2026-09-03 05:13:33.770396 | instance | cd+++++++++ pod-logs/ 2026-09-03 05:13:33.770437 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-09-03 05:13:33.783132 | 2026-09-03 05:13:33.783196 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-09-03 05:13:33.993944 | instance | changed 2026-09-03 05:13:33.999087 | 2026-09-03 05:13:33.999162 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-09-03 05:13:34.221159 | instance | /bin/bash: line 2: kubectl: command not found 2026-09-03 05:13:34.538835 | instance | ok: Runtime: 0:00:00.048662 2026-09-03 05:13:34.543950 | 2026-09-03 05:13:34.544020 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-09-03 05:13:34.762574 | instance | /bin/bash: line 2: kubectl: command not found 2026-09-03 05:13:34.808138 | instance | ceph-mgr endpoints: 2026-09-03 05:13:35.081227 | instance | ok: Runtime: 0:00:00.051268 2026-09-03 05:13:35.088664 | 2026-09-03 05:13:35.088766 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-09-03 05:13:35.318117 | instance | /bin/bash: line 4: kubectl: command not found 2026-09-03 05:13:35.627990 | instance | ok: Runtime: 0:00:00.050839 2026-09-03 05:13:35.635250 | 2026-09-03 05:13:35.635339 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-09-03 05:13:36.128387 | instance | changed: cd+++++++++ prometheus/ 2026-09-03 05:13:36.139654 | 2026-09-03 05:13:36.139720 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-09-03 05:13:36.346248 | instance | changed 2026-09-03 05:13:36.351193 | 2026-09-03 05:13:36.351261 | TASK [gather-selenium-data : Get selenium data] 2026-09-03 05:13:36.618791 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-09-03 05:13:36.620301 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-09-03 05:13:36.889748 | instance | ERROR 2026-09-03 05:13:36.890104 | instance | { 2026-09-03 05:13:36.890169 | instance | "delta": "0:00:00.006515", 2026-09-03 05:13:36.890214 | instance | "end": "2026-09-03 05:13:36.620742", 2026-09-03 05:13:36.890261 | instance | "msg": "non-zero return code", 2026-09-03 05:13:36.890302 | instance | "rc": 1, 2026-09-03 05:13:36.890341 | instance | "start": "2026-09-03 05:13:36.614227" 2026-09-03 05:13:36.890380 | instance | } 2026-09-03 05:13:36.890430 | instance | ERROR: Ignoring Errors 2026-09-03 05:13:36.899059 | 2026-09-03 05:13:36.899150 | TASK [gather-selenium-data : Downloads logs to executor] 2026-09-03 05:13:37.419323 | instance | changed: cd+++++++++ selenium/ 2026-09-03 05:13:37.425043 | 2026-09-03 05:13:37.425092 | PLAY RECAP 2026-09-03 05:13:37.425139 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-09-03 05:13:37.425160 | 2026-09-03 05:13:37.555322 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-09-03 05:13:37.559550 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-09-03 05:13:38.176170 | 2026-09-03 05:13:38.176306 | PLAY [all] 2026-09-03 05:13:38.188899 | 2026-09-03 05:13:38.188999 | TASK [fetch-output : Set log path for multiple nodes] 2026-09-03 05:13:38.235597 | instance | skipping: Conditional result was False 2026-09-03 05:13:38.241541 | 2026-09-03 05:13:38.241717 | TASK [fetch-output : Set log path for single node] 2026-09-03 05:13:38.285895 | instance | ok 2026-09-03 05:13:38.293545 | 2026-09-03 05:13:38.293615 | LOOP [fetch-output : Ensure local output dirs] 2026-09-03 05:13:38.672699 | instance -> localhost | ok: "/var/lib/zuul/builds/193aac422fc54c54b3c793ff8a4f6b05/work/logs" 2026-09-03 05:13:38.888247 | instance -> localhost | changed: "/var/lib/zuul/builds/193aac422fc54c54b3c793ff8a4f6b05/work/artifacts" 2026-09-03 05:13:39.094825 | instance -> localhost | changed: "/var/lib/zuul/builds/193aac422fc54c54b3c793ff8a4f6b05/work/docs" 2026-09-03 05:13:39.111371 | 2026-09-03 05:13:39.111547 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-03 05:13:40.546645 | instance | changed: .d..t...... ./ 2026-09-03 05:13:40.546915 | instance | changed: All items complete 2026-09-03 05:13:40.546954 | 2026-09-03 05:13:41.007824 | instance | changed: .d..t...... ./ 2026-09-03 05:13:41.472144 | instance | changed: .d..t...... ./ 2026-09-03 05:13:41.497794 | 2026-09-03 05:13:41.497960 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-03 05:13:41.911072 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007393 2026-09-03 05:13:42.137597 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.008324 2026-09-03 05:13:42.152991 | 2026-09-03 05:13:42.153217 | PLAY [all] 2026-09-03 05:13:42.160342 | 2026-09-03 05:13:42.160513 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-03 05:13:42.624168 | instance | changed 2026-09-03 05:13:42.645163 | 2026-09-03 05:13:42.645218 | PLAY RECAP 2026-09-03 05:13:42.645267 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-09-03 05:13:42.645289 | 2026-09-03 05:13:42.792670 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-09-03 05:13:42.795817 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-03 05:13:43.394108 | 2026-09-03 05:13:43.394259 | PLAY [localhost] 2026-09-03 05:13:43.404249 | 2026-09-03 05:13:43.404325 | TASK [Generate Zuul manifest] 2026-09-03 05:13:43.426006 | localhost | ok 2026-09-03 05:13:43.444250 | 2026-09-03 05:13:43.444326 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-03 05:13:43.820949 | localhost | changed 2026-09-03 05:13:43.831844 | 2026-09-03 05:13:43.831923 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-03 05:13:43.863920 | localhost | ok 2026-09-03 05:13:43.873652 | 2026-09-03 05:13:43.873742 | TASK [Upload logs] 2026-09-03 05:13:43.896913 | localhost | ok 2026-09-03 05:13:43.965591 | 2026-09-03 05:13:43.965759 | TASK [Set zuul-log-path fact] 2026-09-03 05:13:43.984767 | localhost | ok 2026-09-03 05:13:43.996174 | 2026-09-03 05:13:43.996242 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-03 05:13:44.024494 | localhost | ok 2026-09-03 05:13:44.031431 | 2026-09-03 05:13:44.031504 | TASK [upload-logs : Create log directories] 2026-09-03 05:13:44.428703 | localhost | changed 2026-09-03 05:13:44.434866 | 2026-09-03 05:13:44.434932 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-03 05:13:44.833589 | localhost -> localhost | ok: Runtime: 0:00:00.005437 2026-09-03 05:13:44.840580 | 2026-09-03 05:13:44.840646 | TASK [upload-logs : Upload logs to log server] 2026-09-03 05:13:45.326048 | localhost | Output suppressed because no_log was given 2026-09-03 05:13:45.366072 | 2026-09-03 05:13:45.366216 | LOOP [upload-logs : Compress console log and json output] 2026-09-03 05:13:45.412801 | localhost | skipping: Conditional result was False 2026-09-03 05:13:45.419829 | localhost | skipping: Conditional result was False 2026-09-03 05:13:45.430562 | 2026-09-03 05:13:45.430746 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-03 05:13:45.476121 | localhost | skipping: Conditional result was False 2026-09-03 05:13:45.476365 | 2026-09-03 05:13:45.480604 | localhost | skipping: Conditional result was False 2026-09-03 05:13:45.496788 | 2026-09-03 05:13:45.496995 | LOOP [upload-logs : Upload console log and json output]