2026-08-22 14:27:50.859631 | Job console starting 2026-08-22 14:27:50.875067 | Updating git repos 2026-08-22 14:27:52.578745 | Cloning repos into workspace 2026-08-22 14:28:20.378743 | Restoring repo states 2026-08-22 14:28:31.641807 | Merging changes 2026-08-22 14:28:34.036626 | Checking out repos 2026-08-22 14:28:42.998509 | Preparing playbooks 2026-08-22 14:29:00.638891 | Running Ansible setup 2026-08-22 14:29:04.972613 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-22 14:29:05.618842 | 2026-08-22 14:29:05.619001 | PLAY [localhost] 2026-08-22 14:29:05.626848 | 2026-08-22 14:29:05.626920 | TASK [Gathering Facts] 2026-08-22 14:29:06.510596 | localhost | ok 2026-08-22 14:29:06.519369 | 2026-08-22 14:29:06.519443 | TASK [Setup log path fact] 2026-08-22 14:29:06.542347 | localhost | ok 2026-08-22 14:29:06.553017 | 2026-08-22 14:29:06.553100 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-22 14:29:06.585577 | localhost | ok 2026-08-22 14:29:06.593122 | 2026-08-22 14:29:06.593191 | TASK [emit-job-header : Print job information] 2026-08-22 14:29:06.634446 | # Job Information 2026-08-22 14:29:06.634604 | Ansible Version: 2.16.18 2026-08-22 14:29:06.634647 | Job: atmosphere-molecule-csi-rbd 2026-08-22 14:29:06.634676 | Pipeline: check 2026-08-22 14:29:06.634703 | Executor: 2d72f0692154 2026-08-22 14:29:06.634731 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4092 2026-08-22 14:29:06.634761 | Event ID: e30a5830-9e34-11f1-91b7-8c4b03cee466 2026-08-22 14:29:06.638508 | 2026-08-22 14:29:06.638594 | LOOP [emit-job-header : Print node information] 2026-08-22 14:29:06.734288 | localhost | ok: 2026-08-22 14:29:06.735028 | localhost | # Node Information 2026-08-22 14:29:06.735148 | localhost | Inventory Hostname: instance 2026-08-22 14:29:06.735201 | localhost | Hostname: np0000190632 2026-08-22 14:29:06.735247 | localhost | Username: zuul 2026-08-22 14:29:06.735301 | localhost | Distro: Ubuntu 22.04 2026-08-22 14:29:06.735347 | localhost | Provider: yul1 2026-08-22 14:29:06.735390 | localhost | Region: ca-ymq-1 2026-08-22 14:29:06.735432 | localhost | Label: ubuntu-jammy 2026-08-22 14:29:06.735473 | localhost | Product Name: OpenStack Nova 2026-08-22 14:29:06.735514 | localhost | Interface IP: 199.204.45.113 2026-08-22 14:29:06.752550 | 2026-08-22 14:29:06.752623 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-22 14:29:07.310017 | localhost -> localhost | changed 2026-08-22 14:29:07.321755 | 2026-08-22 14:29:07.321895 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-22 14:29:08.210923 | localhost -> localhost | changed 2026-08-22 14:29:08.224055 | 2026-08-22 14:29:08.224137 | PLAY [all] 2026-08-22 14:29:08.233906 | 2026-08-22 14:29:08.233974 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-22 14:29:08.461907 | instance -> localhost | ok 2026-08-22 14:29:08.472333 | 2026-08-22 14:29:08.472431 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-22 14:29:08.506094 | instance | ok 2026-08-22 14:29:08.520126 | instance | included: /var/lib/zuul/builds/6662058755214bae9354ea66df22c20e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-22 14:29:08.525951 | 2026-08-22 14:29:08.526014 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-22 14:29:09.737624 | instance -> localhost | Generating public/private rsa key pair. 2026-08-22 14:29:09.737892 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/6662058755214bae9354ea66df22c20e/work/6662058755214bae9354ea66df22c20e_id_rsa 2026-08-22 14:29:09.737945 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/6662058755214bae9354ea66df22c20e/work/6662058755214bae9354ea66df22c20e_id_rsa.pub 2026-08-22 14:29:09.737978 | instance -> localhost | The key fingerprint is: 2026-08-22 14:29:09.738008 | instance -> localhost | SHA256:SJLaQXiuPd9GYKgRK6N1naoW5jq4JeBDh1psXJgQEzY zuul-build-sshkey 2026-08-22 14:29:09.738051 | instance -> localhost | The key's randomart image is: 2026-08-22 14:29:09.738083 | instance -> localhost | +---[RSA 3072]----+ 2026-08-22 14:29:09.738118 | instance -> localhost | |=E .. | 2026-08-22 14:29:09.738149 | instance -> localhost | |.o++.. | 2026-08-22 14:29:09.738179 | instance -> localhost | | o==o.. | 2026-08-22 14:29:09.738208 | instance -> localhost | |oo=+++=. | 2026-08-22 14:29:09.738239 | instance -> localhost | |o**B.o..S | 2026-08-22 14:29:09.738275 | instance -> localhost | |*o* + . | 2026-08-22 14:29:09.738310 | instance -> localhost | |+=.o o o | 2026-08-22 14:29:09.738347 | instance -> localhost | |oo= . o | 2026-08-22 14:29:09.738387 | instance -> localhost | |o= . | 2026-08-22 14:29:09.738426 | instance -> localhost | +----[SHA256]-----+ 2026-08-22 14:29:09.738502 | instance -> localhost | ok: Runtime: 0:00:00.734161 2026-08-22 14:29:09.746857 | 2026-08-22 14:29:09.746929 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-22 14:29:09.782209 | instance | ok 2026-08-22 14:29:09.791081 | instance | included: /var/lib/zuul/builds/6662058755214bae9354ea66df22c20e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-22 14:29:09.798852 | 2026-08-22 14:29:09.798939 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-22 14:29:09.824320 | instance | skipping: Conditional result was False 2026-08-22 14:29:09.835662 | 2026-08-22 14:29:09.835775 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-22 14:29:10.312810 | instance | changed 2026-08-22 14:29:12.091453 | 2026-08-22 14:29:12.091599 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-22 14:29:12.289600 | instance | ok 2026-08-22 14:29:12.295847 | 2026-08-22 14:29:12.295915 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-22 14:29:12.776646 | instance | changed 2026-08-22 14:29:12.781907 | 2026-08-22 14:29:12.781975 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-22 14:29:13.245036 | instance | changed 2026-08-22 14:29:13.251551 | 2026-08-22 14:29:13.251623 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-22 14:29:13.277588 | instance | skipping: Conditional result was False 2026-08-22 14:29:13.291030 | 2026-08-22 14:29:13.291122 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-22 14:29:13.776100 | instance -> localhost | changed 2026-08-22 14:29:13.791742 | 2026-08-22 14:29:13.791860 | TASK [add-build-sshkey : Add back temp key] 2026-08-22 14:29:14.186743 | instance -> localhost | Identity added: /var/lib/zuul/builds/6662058755214bae9354ea66df22c20e/work/6662058755214bae9354ea66df22c20e_id_rsa (zuul-build-sshkey) 2026-08-22 14:29:14.187002 | instance -> localhost | ok: Runtime: 0:00:00.016385 2026-08-22 14:29:14.193758 | 2026-08-22 14:29:14.193842 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-22 14:29:14.502552 | instance | ok 2026-08-22 14:29:14.507536 | 2026-08-22 14:29:14.507597 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-22 14:29:14.532773 | instance | skipping: Conditional result was False 2026-08-22 14:29:14.546799 | 2026-08-22 14:29:14.546867 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-08-22 14:29:14.919171 | instance | ok 2026-08-22 14:29:14.929483 | 2026-08-22 14:29:14.930471 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-08-22 14:29:18.517935 | instance | Output suppressed because no_log was given 2026-08-22 14:29:18.528863 | 2026-08-22 14:29:18.528976 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-08-22 14:29:18.719834 | instance | ok: "logs" 2026-08-22 14:29:18.720079 | instance | ok: All items complete 2026-08-22 14:29:18.720109 | 2026-08-22 14:29:18.875031 | instance | ok: "artifacts" 2026-08-22 14:29:19.034662 | instance | ok: "docs" 2026-08-22 14:29:19.050308 | 2026-08-22 14:29:19.050638 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-08-22 14:29:19.237521 | instance | changed: "logs" 2026-08-22 14:29:19.405164 | instance | changed: "artifacts" 2026-08-22 14:29:19.573525 | instance | changed: "docs" 2026-08-22 14:29:19.589035 | 2026-08-22 14:29:19.589209 | PLAY RECAP 2026-08-22 14:29:19.589322 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-08-22 14:29:19.589363 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-22 14:29:19.589394 | 2026-08-22 14:29:19.731884 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-22 14:29:19.734136 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-22 14:29:20.378134 | 2026-08-22 14:29:20.378273 | PLAY [all] 2026-08-22 14:29:20.388736 | 2026-08-22 14:29:20.388818 | TASK [setup-uv : Extract archive] 2026-08-22 14:29:22.680667 | instance | changed 2026-08-22 14:29:22.686406 | 2026-08-22 14:29:22.686483 | TASK [setup-uv : Print version] 2026-08-22 14:29:23.054683 | instance | uv 0.8.13 2026-08-22 14:29:23.221242 | instance | ok: Runtime: 0:00:00.011013 2026-08-22 14:29:23.231694 | 2026-08-22 14:29:23.231773 | TASK [Install Ansible collection siblings] 2026-08-22 14:29:32.625278 | instance | changed: 2026-08-22 14:29:32.625495 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-08-22 14:29:32.625537 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-08-22 14:29:32.625570 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-08-22 14:29:32.625599 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto 2026-08-22 14:29:32.625627 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general 2026-08-22 14:29:32.625661 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql 2026-08-22 14:29:32.625692 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-08-22 14:29:32.625724 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-08-22 14:29:32.625752 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-08-22 14:29:32.625780 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-08-22 14:29:32.625808 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-08-22 14:29:32.625835 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-08-22 14:29:32.625863 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0 2026-08-22 14:29:32.625890 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0 2026-08-22 14:29:32.625917 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0 2026-08-22 14:29:32.625945 | instance | Resolved community.crypto to 2.2.3 for 2.2.3 2026-08-22 14:29:32.625972 | instance | Resolved community.general to 7.3.0 for 7.3.0 2026-08-22 14:29:32.625998 | instance | Resolved community.mysql to 3.6.0 for 3.6.0 2026-08-22 14:29:32.626026 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0 2026-08-22 14:29:32.626053 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0 2026-08-22 14:29:32.626080 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0 2026-08-22 14:29:32.626107 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0 2026-08-22 14:29:32.626136 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-08-22 14:29:32.626182 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0 2026-08-22 14:29:32.626212 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0 2026-08-22 14:29:32.626239 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-08-22 14:29:32.626267 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-08-22 14:29:32.626293 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-08-22 14:29:32.626319 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0 2026-08-22 14:29:32.626352 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3 2026-08-22 14:29:32.626396 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-08-22 14:29:32.626431 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-08-22 14:29:32.626460 | instance | Checked out ansible.netcommon to 1.2.0 2026-08-22 14:29:32.626489 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-08-22 14:29:32.626523 | instance | Starting galaxy collection install process 2026-08-22 14:29:32.626551 | instance | Process install dependency map 2026-08-22 14:29:32.626588 | instance | Starting collection install process 2026-08-22 14:29:32.626618 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon' 2026-08-22 14:29:32.626645 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon 2026-08-22 14:29:32.626672 | instance | ansible.netcommon:* was installed successfully 2026-08-22 14:29:32.626698 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-08-22 14:29:32.626725 | instance | Creating virtual environment at: .venv 2026-08-22 14:29:32.626753 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-08-22 14:29:32.626780 | instance | Downloading openstacksdk (1.7MiB) 2026-08-22 14:29:32.626806 | instance | Downloading kubernetes (1.9MiB) 2026-08-22 14:29:32.626839 | instance | Downloading pygments (1.2MiB) 2026-08-22 14:29:32.626868 | instance | Downloading ansible-core (2.1MiB) 2026-08-22 14:29:32.626894 | instance | Downloading setuptools (1.1MiB) 2026-08-22 14:29:32.626920 | instance | Downloading netaddr (2.2MiB) 2026-08-22 14:29:32.626948 | instance | Downloading rjsonnet (1.2MiB) 2026-08-22 14:29:32.626976 | instance | Downloading cryptography (4.2MiB) 2026-08-22 14:29:32.627002 | instance | Building pyperclip==1.9.0 2026-08-22 14:29:32.627029 | instance | Downloading rjsonnet 2026-08-22 14:29:32.627058 | instance | Downloading netaddr 2026-08-22 14:29:32.627086 | instance | Downloading pygments 2026-08-22 14:29:32.627113 | instance | Downloading cryptography 2026-08-22 14:29:32.627139 | instance | Downloading setuptools 2026-08-22 14:29:32.627166 | instance | Downloading kubernetes 2026-08-22 14:29:32.627192 | instance | Downloading ansible-core 2026-08-22 14:29:32.627219 | instance | Downloading openstacksdk 2026-08-22 14:29:32.627246 | instance | Built pyperclip==1.9.0 2026-08-22 14:29:32.627273 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-08-22 14:29:32.627301 | instance | Installed 79 packages in 49ms 2026-08-22 14:29:32.627328 | instance | Checked out ansible.posix to 1.6.0 2026-08-22 14:29:32.627355 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-08-22 14:29:32.627383 | instance | Starting galaxy collection install process 2026-08-22 14:29:32.627410 | instance | Process install dependency map 2026-08-22 14:29:32.627440 | instance | Starting collection install process 2026-08-22 14:29:32.627480 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-08-22 14:29:32.627526 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix 2026-08-22 14:29:32.627557 | instance | ansible.posix:1.6.0 was installed successfully 2026-08-22 14:29:32.627584 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-22 14:29:32.627612 | instance | 2.17.12 2026-08-22 14:29:32.627639 | instance | Checked out ansible.utils to v6.1.0 2026-08-22 14:29:32.627667 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-08-22 14:29:32.627694 | instance | Starting galaxy collection install process 2026-08-22 14:29:32.627722 | instance | Process install dependency map 2026-08-22 14:29:32.627749 | instance | Starting collection install process 2026-08-22 14:29:32.627775 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils' 2026-08-22 14:29:32.627802 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils 2026-08-22 14:29:32.627830 | instance | ansible.utils:6.1.0 was installed successfully 2026-08-22 14:29:32.627856 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-22 14:29:32.627883 | instance | 2.17.12 2026-08-22 14:29:32.627911 | instance | Checked out atmosphere.common to v0.7.0 2026-08-22 14:29:32.627938 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-08-22 14:29:32.627966 | instance | Starting galaxy collection install process 2026-08-22 14:29:32.627996 | instance | Process install dependency map 2026-08-22 14:29:32.628024 | instance | Starting collection install process 2026-08-22 14:29:32.628052 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common' 2026-08-22 14:29:32.628079 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common 2026-08-22 14:29:32.628106 | instance | atmosphere.common:0.7.0 was installed successfully 2026-08-22 14:29:32.628133 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-22 14:29:32.628160 | instance | 2.17.12 2026-08-22 14:29:32.628186 | instance | Checked out community.crypto to 2.2.3 2026-08-22 14:29:32.628213 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.crypto 2026-08-22 14:29:32.628241 | instance | Starting galaxy collection install process 2026-08-22 14:29:32.628268 | instance | Process install dependency map 2026-08-22 14:29:32.628296 | instance | Starting collection install process 2026-08-22 14:29:32.628322 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-08-22 14:29:32.628349 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto 2026-08-22 14:29:32.628374 | instance | community.crypto:2.2.3 was installed successfully 2026-08-22 14:29:32.628401 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-22 14:29:32.628427 | instance | 2.17.12 2026-08-22 14:29:32.628454 | instance | Checked out community.general to 7.3.0 2026-08-22 14:29:32.628480 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.general 2026-08-22 14:29:32.628507 | instance | Starting galaxy collection install process 2026-08-22 14:29:32.628545 | instance | Process install dependency map 2026-08-22 14:29:32.628588 | instance | Starting collection install process 2026-08-22 14:29:32.628628 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-08-22 14:29:32.628704 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general 2026-08-22 14:29:32.628735 | instance | community.general:7.3.0 was installed successfully 2026-08-22 14:29:32.628763 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-22 14:29:32.628790 | instance | 2.17.12 2026-08-22 14:29:32.628817 | instance | Checked out community.mysql to 3.6.0 2026-08-22 14:29:32.628845 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.mysql 2026-08-22 14:29:32.628873 | instance | Starting galaxy collection install process 2026-08-22 14:29:32.628903 | instance | Process install dependency map 2026-08-22 14:29:32.628931 | instance | Starting collection install process 2026-08-22 14:29:32.628977 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql' 2026-08-22 14:29:32.629010 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql 2026-08-22 14:29:32.629032 | instance | community.mysql:3.6.0 was installed successfully 2026-08-22 14:29:32.629052 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-22 14:29:32.629071 | instance | 2.17.12 2026-08-22 14:29:32.629091 | instance | Checked out kubernetes.core to 2.4.0 2026-08-22 14:29:32.629111 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-08-22 14:29:32.629130 | instance | Starting galaxy collection install process 2026-08-22 14:29:32.629150 | instance | Process install dependency map 2026-08-22 14:29:32.629170 | instance | Starting collection install process 2026-08-22 14:29:32.629188 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core' 2026-08-22 14:29:32.629208 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core 2026-08-22 14:29:32.629227 | instance | kubernetes.core:2.4.0 was installed successfully 2026-08-22 14:29:32.629246 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-22 14:29:32.629265 | instance | 2.17.12 2026-08-22 14:29:32.629285 | instance | Checked out openstack.cloud to 2.6.0 2026-08-22 14:29:32.629305 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-08-22 14:29:32.629325 | instance | Starting galaxy collection install process 2026-08-22 14:29:32.629344 | instance | Process install dependency map 2026-08-22 14:29:32.629364 | instance | Starting collection install process 2026-08-22 14:29:32.629383 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud' 2026-08-22 14:29:32.629401 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud 2026-08-22 14:29:32.629420 | instance | openstack.cloud:2.6.0 was installed successfully 2026-08-22 14:29:32.629440 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-22 14:29:32.629459 | instance | 2.17.12 2026-08-22 14:29:32.629478 | instance | Checked out vexxhost.ceph to v4.2.0 2026-08-22 14:29:32.629498 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-08-22 14:29:32.629523 | instance | Starting galaxy collection install process 2026-08-22 14:29:32.629543 | instance | Process install dependency map 2026-08-22 14:29:32.629563 | instance | Starting collection install process 2026-08-22 14:29:32.629582 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph' 2026-08-22 14:29:32.629601 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph 2026-08-22 14:29:32.629619 | instance | vexxhost.ceph:4.2.0 was installed successfully 2026-08-22 14:29:32.629641 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-22 14:29:32.629670 | instance | 2.17.12 2026-08-22 14:29:32.629699 | instance | Checked out vexxhost.containers to v1.6.8 2026-08-22 14:29:32.629722 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-08-22 14:29:32.629742 | instance | Starting galaxy collection install process 2026-08-22 14:29:32.629763 | instance | Process install dependency map 2026-08-22 14:29:32.629783 | instance | Starting collection install process 2026-08-22 14:29:32.629803 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers' 2026-08-22 14:29:32.629822 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers 2026-08-22 14:29:32.629841 | instance | vexxhost.containers:1.6.8 was installed successfully 2026-08-22 14:29:32.629860 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-22 14:29:32.629879 | instance | 2.17.12 2026-08-22 14:29:32.629898 | instance | Checked out vexxhost.kubernetes to v3.3.0 2026-08-22 14:29:32.629918 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-08-22 14:29:32.629938 | instance | Starting galaxy collection install process 2026-08-22 14:29:32.629958 | instance | Process install dependency map 2026-08-22 14:29:32.629977 | instance | Starting collection install process 2026-08-22 14:29:32.629996 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes' 2026-08-22 14:29:32.630015 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes 2026-08-22 14:29:32.630034 | instance | vexxhost.kubernetes:3.3.0 was installed successfully 2026-08-22 14:29:32.630053 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-22 14:29:32.630072 | instance | 2.17.12 2026-08-22 14:29:32.635711 | 2026-08-22 14:29:32.635754 | PLAY RECAP 2026-08-22 14:29:32.635799 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-22 14:29:32.635820 | 2026-08-22 14:29:32.790908 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-22 14:29:32.793653 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-08-22 14:29:33.453923 | 2026-08-22 14:29:33.454088 | PLAY [all] 2026-08-22 14:29:33.466920 | 2026-08-22 14:29:33.467029 | TASK [Install "jq" for log collection] 2026-08-22 14:29:42.391221 | instance | changed 2026-08-22 14:29:42.393836 | 2026-08-22 14:29:42.393898 | PLAY RECAP 2026-08-22 14:29:42.393950 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-22 14:29:42.394001 | 2026-08-22 14:29:42.539352 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-08-22 14:29:42.541668 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-22 14:29:43.183681 | 2026-08-22 14:29:43.183849 | PLAY [all] 2026-08-22 14:29:43.196565 | 2026-08-22 14:29:43.196690 | LOOP [Check inventory directories] 2026-08-22 14:29:43.596380 | instance | ok: "src/github.com/vexxhost/atmosphere" 2026-08-22 14:29:43.741752 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory" 2026-08-22 14:29:43.917738 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory" 2026-08-22 14:29:43.933172 | 2026-08-22 14:29:43.933419 | LOOP [Copy inventory file for Zuul] 2026-08-22 14:29:45.017901 | instance | changed: 2026-08-22 14:29:45.409524 | instance | { 2026-08-22 14:29:45.409693 | instance | "ansible_loop_var": "item", 2026-08-22 14:29:45.409736 | instance | "changed": false, 2026-08-22 14:29:45.409768 | instance | "failed": false, 2026-08-22 14:29:45.409805 | instance | "invocation": { 2026-08-22 14:29:45.409834 | instance | "module_args": { 2026-08-22 14:29:45.409862 | instance | "checksum_algorithm": "sha1", 2026-08-22 14:29:45.409889 | instance | "follow": true, 2026-08-22 14:29:45.409916 | instance | "get_attributes": true, 2026-08-22 14:29:45.409945 | instance | "get_checksum": true, 2026-08-22 14:29:45.409971 | instance | "get_mime": true, 2026-08-22 14:29:45.409998 | instance | "path": "src/github.com/vexxhost/atmosphere" 2026-08-22 14:29:45.410026 | instance | } 2026-08-22 14:29:45.410051 | instance | }, 2026-08-22 14:29:45.410136 | instance | "item": "src/github.com/vexxhost/atmosphere", 2026-08-22 14:29:45.410175 | instance | "stat": { 2026-08-22 14:29:45.410203 | instance | "atime": 1787408965.0261817, 2026-08-22 14:29:45.410230 | instance | "attr_flags": "e", 2026-08-22 14:29:45.410266 | instance | "attributes": [ 2026-08-22 14:29:45.410294 | instance | "extents" 2026-08-22 14:29:45.410319 | instance | ], 2026-08-22 14:29:45.410345 | instance | "block_size": 4096, 2026-08-22 14:29:45.410371 | instance | "blocks": 8, 2026-08-22 14:29:45.410397 | instance | "charset": "unknown", 2026-08-22 14:29:45.410425 | instance | "ctime": 1787408964.0541756, 2026-08-22 14:29:45.410451 | instance | "dev": 64513, 2026-08-22 14:29:45.410478 | instance | "device_type": 0, 2026-08-22 14:29:45.410503 | instance | "executable": true, 2026-08-22 14:29:45.410529 | instance | "exists": true, 2026-08-22 14:29:45.410555 | instance | "gid": 1000, 2026-08-22 14:29:45.410581 | instance | "gr_name": "zuul", 2026-08-22 14:29:45.410606 | instance | "inode": 1047623, 2026-08-22 14:29:45.410631 | instance | "isblk": false, 2026-08-22 14:29:45.410656 | instance | "ischr": false, 2026-08-22 14:29:45.410682 | instance | "isdir": true, 2026-08-22 14:29:45.410707 | instance | "isfifo": false, 2026-08-22 14:29:45.410733 | instance | "isgid": false, 2026-08-22 14:29:45.410759 | instance | "islnk": false, 2026-08-22 14:29:45.410785 | instance | "isreg": false, 2026-08-22 14:29:45.410810 | instance | "issock": false, 2026-08-22 14:29:45.410836 | instance | "isuid": false, 2026-08-22 14:29:45.410861 | instance | "mimetype": "unknown", 2026-08-22 14:29:45.410885 | instance | "mode": "0755", 2026-08-22 14:29:45.410910 | instance | "mtime": 1787408964.0541756, 2026-08-22 14:29:45.410934 | instance | "nlink": 21, 2026-08-22 14:29:45.410959 | instance | "path": "src/github.com/vexxhost/atmosphere", 2026-08-22 14:29:45.410984 | instance | "pw_name": "zuul", 2026-08-22 14:29:45.411047 | instance | "readable": true, 2026-08-22 14:29:45.411084 | instance | "rgrp": true, 2026-08-22 14:29:45.411113 | instance | "roth": true, 2026-08-22 14:29:45.411139 | instance | "rusr": true, 2026-08-22 14:29:45.411165 | instance | "size": 4096, 2026-08-22 14:29:45.411190 | instance | "uid": 1000, 2026-08-22 14:29:45.411225 | instance | "version": "3493038910", 2026-08-22 14:29:45.411252 | instance | "wgrp": false, 2026-08-22 14:29:45.411279 | instance | "woth": false, 2026-08-22 14:29:45.411314 | instance | "writeable": true, 2026-08-22 14:29:45.411342 | instance | "wusr": true, 2026-08-22 14:29:45.411367 | instance | "xgrp": true, 2026-08-22 14:29:45.411393 | instance | "xoth": true, 2026-08-22 14:29:45.411418 | instance | "xusr": true 2026-08-22 14:29:45.411443 | instance | } 2026-08-22 14:29:45.411469 | instance | } 2026-08-22 14:29:45.411539 | instance | ok: All items complete 2026-08-22 14:29:45.411570 | 2026-08-22 14:29:45.413812 | instance | skipping: Conditional result was False 2026-08-22 14:29:45.414682 | instance | skipping: Conditional result was False 2026-08-22 14:29:45.433044 | 2026-08-22 14:29:45.433217 | LOOP [Switch "ansible_host" to private IP] 2026-08-22 14:29:45.784495 | instance | changed: 1 replacements made 2026-08-22 14:29:45.786921 | instance | skipping: Conditional result was False 2026-08-22 14:29:45.790655 | instance | skipping: Conditional result was False 2026-08-22 14:29:45.804244 | 2026-08-22 14:29:45.804391 | TASK [Run Molecule scenario] 2026-08-22 14:29:46.700073 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-08-22 14:29:47.069961 | instance | INFO [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-08-22 14:29:47.070064 | instance | INFO [csi > prerun] Performing prerun with role_name_check=0... 2026-08-22 14:29:57.635516 | instance | INFO [csi > dependency] Executing 2026-08-22 14:29:57.635605 | instance | WARNING [csi > dependency] Missing roles requirements file: requirements.yml 2026-08-22 14:29:57.635836 | instance | WARNING [csi > dependency] Missing collections requirements file: collections.yml 2026-08-22 14:29:57.635882 | instance | WARNING [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-08-22 14:29:57.643262 | instance | INFO [csi > cleanup] Executing 2026-08-22 14:29:57.643616 | instance | WARNING [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-22 14:29:57.650991 | instance | INFO [csi > destroy] Executing 2026-08-22 14:29:57.651031 | instance | WARNING [csi > destroy] Skipping, '--destroy=never' requested. 2026-08-22 14:29:57.651073 | instance | INFO [csi > destroy] Executed: Successful 2026-08-22 14:29:57.658419 | instance | INFO [csi > syntax] Executing 2026-08-22 14:29:59.220120 | instance | 2026-08-22 14:29:59.220406 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-08-22 14:29:59.276770 | instance | INFO [csi > syntax] Executed: Successful 2026-08-22 14:29:59.290668 | instance | INFO [csi > create] Executing 2026-08-22 14:29:59.292447 | instance | WARNING [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-22 14:29:59.299779 | instance | INFO [csi > prepare] Executing 2026-08-22 14:30:00.053215 | instance | 2026-08-22 14:30:00.053466 | instance | PLAY [Prepare] ***************************************************************** 2026-08-22 14:30:00.053725 | instance | 2026-08-22 14:30:00.053905 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-22 14:30:00.054084 | instance | Saturday 22 August 2026 14:30:00 +0000 (0:00:00.024) 0:00:00.024 ******* 2026-08-22 14:30:01.167706 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-08-22 14:30:01.167984 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-08-22 14:30:01.168258 | instance | interpreter could change the meaning of that path. See 2026-08-22 14:30:01.168525 | instance | https://docs.ansible.com/ansible- 2026-08-22 14:30:01.168802 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-08-22 14:30:01.176731 | instance | ok: [instance] 2026-08-22 14:30:01.176984 | instance | 2026-08-22 14:30:01.177253 | instance | TASK [Configure short hostname] ************************************************ 2026-08-22 14:30:01.177525 | instance | Saturday 22 August 2026 14:30:01 +0000 (0:00:01.127) 0:00:01.152 ******* 2026-08-22 14:30:01.868240 | instance | changed: [instance] 2026-08-22 14:30:01.868481 | instance | 2026-08-22 14:30:01.868759 | instance | TASK [Ensure hostname inside hosts file] *************************************** 2026-08-22 14:30:01.869032 | instance | Saturday 22 August 2026 14:30:01 +0000 (0:00:00.691) 0:00:01.844 ******* 2026-08-22 14:30:02.145992 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created 2026-08-22 14:30:02.146304 | instance | with a mode of 0700, this may cause issues when running as another user. To 2026-08-22 14:30:02.146584 | instance | avoid this, create the remote_tmp dir with the correct permissions manually 2026-08-22 14:30:02.155759 | instance | changed: [instance] 2026-08-22 14:30:02.156010 | instance | 2026-08-22 14:30:02.156280 | instance | TASK [Purge "snapd" package] *************************************************** 2026-08-22 14:30:02.156552 | instance | Saturday 22 August 2026 14:30:02 +0000 (0:00:00.287) 0:00:02.131 ******* 2026-08-22 14:30:02.878977 | instance | ok: [instance] 2026-08-22 14:30:02.879327 | instance | 2026-08-22 14:30:02.879575 | instance | PLAY [Create devices for Ceph] ************************************************* 2026-08-22 14:30:02.879825 | instance | 2026-08-22 14:30:02.880127 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-22 14:30:02.880407 | instance | Saturday 22 August 2026 14:30:02 +0000 (0:00:00.723) 0:00:02.854 ******* 2026-08-22 14:30:03.552639 | instance | ok: [instance] 2026-08-22 14:30:03.552784 | instance | 2026-08-22 14:30:03.552961 | instance | TASK [Install depedencies] ***************************************************** 2026-08-22 14:30:03.553146 | instance | Saturday 22 August 2026 14:30:03 +0000 (0:00:00.673) 0:00:03.528 ******* 2026-08-22 14:30:23.782792 | instance | changed: [instance] 2026-08-22 14:30:23.783039 | instance | 2026-08-22 14:30:23.783335 | instance | TASK [Start up service] ******************************************************** 2026-08-22 14:30:23.783624 | instance | Saturday 22 August 2026 14:30:23 +0000 (0:00:20.229) 0:00:23.758 ******* 2026-08-22 14:30:24.292309 | instance | ok: [instance] 2026-08-22 14:30:24.292486 | instance | 2026-08-22 14:30:24.292681 | instance | TASK [Generate lvm.conf] ******************************************************* 2026-08-22 14:30:24.292868 | instance | Saturday 22 August 2026 14:30:24 +0000 (0:00:00.509) 0:00:24.268 ******* 2026-08-22 14:30:24.575927 | instance | ok: [instance] 2026-08-22 14:30:24.575987 | instance | 2026-08-22 14:30:24.576129 | instance | TASK [Write /etc/lvm/lvm.conf] ************************************************* 2026-08-22 14:30:24.576261 | instance | Saturday 22 August 2026 14:30:24 +0000 (0:00:00.283) 0:00:24.552 ******* 2026-08-22 14:30:25.194462 | instance | changed: [instance] 2026-08-22 14:30:25.194502 | instance | 2026-08-22 14:30:25.194510 | instance | TASK [Get list of all loopback devices] **************************************** 2026-08-22 14:30:25.194517 | instance | Saturday 22 August 2026 14:30:25 +0000 (0:00:00.617) 0:00:25.169 ******* 2026-08-22 14:30:25.376083 | instance | ok: [instance] 2026-08-22 14:30:25.376627 | instance | 2026-08-22 14:30:25.376666 | instance | TASK [Fail if there is any existing loopback devices] ************************** 2026-08-22 14:30:25.376675 | instance | Saturday 22 August 2026 14:30:25 +0000 (0:00:00.182) 0:00:25.351 ******* 2026-08-22 14:30:25.399234 | instance | skipping: [instance] 2026-08-22 14:30:25.399597 | instance | 2026-08-22 14:30:25.399618 | instance | TASK [Create devices for Ceph] ************************************************* 2026-08-22 14:30:25.399623 | instance | Saturday 22 August 2026 14:30:25 +0000 (0:00:00.023) 0:00:25.375 ******* 2026-08-22 14:30:26.953753 | instance | changed: [instance] => (item=osd0) 2026-08-22 14:30:26.953794 | instance | changed: [instance] => (item=osd1) 2026-08-22 14:30:26.953800 | instance | changed: [instance] => (item=osd2) 2026-08-22 14:30:26.953806 | instance | 2026-08-22 14:30:26.953813 | instance | TASK [Set permissions on loopback devices] ************************************* 2026-08-22 14:30:26.953819 | instance | Saturday 22 August 2026 14:30:26 +0000 (0:00:01.553) 0:00:26.928 ******* 2026-08-22 14:30:27.567487 | instance | changed: [instance] => (item=osd0) 2026-08-22 14:30:27.567665 | instance | changed: [instance] => (item=osd1) 2026-08-22 14:30:27.567672 | instance | changed: [instance] => (item=osd2) 2026-08-22 14:30:27.567676 | instance | 2026-08-22 14:30:27.567681 | instance | TASK [Start loop devices] ****************************************************** 2026-08-22 14:30:27.567685 | instance | Saturday 22 August 2026 14:30:27 +0000 (0:00:00.614) 0:00:27.543 ******* 2026-08-22 14:30:28.211094 | instance | changed: [instance] => (item=osd0) 2026-08-22 14:30:28.211148 | instance | changed: [instance] => (item=osd1) 2026-08-22 14:30:28.211155 | instance | changed: [instance] => (item=osd2) 2026-08-22 14:30:28.211167 | instance | 2026-08-22 14:30:28.211229 | instance | TASK [Create a volume group for each loop device] ****************************** 2026-08-22 14:30:28.211238 | instance | Saturday 22 August 2026 14:30:28 +0000 (0:00:00.642) 0:00:28.186 ******* 2026-08-22 14:30:31.414014 | instance | changed: [instance] => (item=osd0) 2026-08-22 14:30:31.414944 | instance | changed: [instance] => (item=osd1) 2026-08-22 14:30:31.414991 | instance | changed: [instance] => (item=osd2) 2026-08-22 14:30:31.414998 | instance | 2026-08-22 14:30:31.415005 | instance | TASK [Create a logical volume for each loop device] **************************** 2026-08-22 14:30:31.415011 | instance | Saturday 22 August 2026 14:30:31 +0000 (0:00:03.203) 0:00:31.389 ******* 2026-08-22 14:30:33.338175 | instance | changed: [instance] => (item=ceph-instance-osd0) 2026-08-22 14:30:33.338234 | instance | changed: [instance] => (item=ceph-instance-osd1) 2026-08-22 14:30:33.338263 | instance | changed: [instance] => (item=ceph-instance-osd2) 2026-08-22 14:30:33.338274 | instance | 2026-08-22 14:30:33.338284 | instance | PLAY RECAP ********************************************************************* 2026-08-22 14:30:33.338294 | instance | instance : ok=15 changed=9 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-08-22 14:30:33.338305 | instance | 2026-08-22 14:30:33.338314 | instance | Saturday 22 August 2026 14:30:33 +0000 (0:00:01.921) 0:00:33.311 ******* 2026-08-22 14:30:33.338324 | instance | =============================================================================== 2026-08-22 14:30:33.338333 | instance | Install depedencies ---------------------------------------------------- 20.23s 2026-08-22 14:30:33.338343 | instance | Create a volume group for each loop device ------------------------------ 3.20s 2026-08-22 14:30:33.338357 | instance | Create a logical volume for each loop device ---------------------------- 1.92s 2026-08-22 14:30:33.341736 | instance | Create devices for Ceph ------------------------------------------------- 1.55s 2026-08-22 14:30:33.341768 | instance | Gathering Facts --------------------------------------------------------- 1.13s 2026-08-22 14:30:33.341773 | instance | Purge "snapd" package --------------------------------------------------- 0.72s 2026-08-22 14:30:33.341777 | instance | Configure short hostname ------------------------------------------------ 0.69s 2026-08-22 14:30:33.341781 | instance | Gathering Facts --------------------------------------------------------- 0.67s 2026-08-22 14:30:33.341785 | instance | Start loop devices ------------------------------------------------------ 0.64s 2026-08-22 14:30:33.341790 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.62s 2026-08-22 14:30:33.341793 | instance | Set permissions on loopback devices ------------------------------------- 0.61s 2026-08-22 14:30:33.341798 | instance | Start up service -------------------------------------------------------- 0.51s 2026-08-22 14:30:33.341802 | instance | Ensure hostname inside hosts file --------------------------------------- 0.29s 2026-08-22 14:30:33.341806 | instance | Generate lvm.conf ------------------------------------------------------- 0.28s 2026-08-22 14:30:33.341810 | instance | Get list of all loopback devices ---------------------------------------- 0.18s 2026-08-22 14:30:33.341813 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s 2026-08-22 14:30:33.399522 | instance | INFO [csi > prepare] Executed: Successful 2026-08-22 14:30:33.417930 | instance | INFO [csi > converge] Executing 2026-08-22 14:30:34.834873 | instance | 2026-08-22 14:30:34.835320 | instance | PLAY [Debug CSI driver value] ************************************************** 2026-08-22 14:30:34.835644 | instance | 2026-08-22 14:30:34.835973 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-22 14:30:34.836297 | instance | Saturday 22 August 2026 14:30:34 +0000 (0:00:00.007) 0:00:00.007 ******* 2026-08-22 14:30:35.824140 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-08-22 14:30:35.824539 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-08-22 14:30:35.824882 | instance | interpreter could change the meaning of that path. See 2026-08-22 14:30:35.825298 | instance | https://docs.ansible.com/ansible- 2026-08-22 14:30:35.825662 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-08-22 14:30:35.835144 | instance | ok: [instance] 2026-08-22 14:30:35.835478 | instance | 2026-08-22 14:30:35.835816 | instance | TASK [Display CSI driver value and environment variable] *********************** 2026-08-22 14:30:35.836150 | instance | Saturday 22 August 2026 14:30:35 +0000 (0:00:01.000) 0:00:01.007 ******* 2026-08-22 14:30:35.876988 | instance | ok: [instance] => { 2026-08-22 14:30:35.877357 | instance | "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER=" 2026-08-22 14:30:35.877722 | instance | } 2026-08-22 14:30:35.878065 | instance | 2026-08-22 14:30:35.878438 | instance | PLAY [all] ********************************************************************* 2026-08-22 14:30:35.878748 | instance | 2026-08-22 14:30:35.879081 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-22 14:30:35.879432 | instance | Saturday 22 August 2026 14:30:35 +0000 (0:00:00.042) 0:00:01.050 ******* 2026-08-22 14:30:36.731941 | instance | ok: [instance] 2026-08-22 14:30:36.732314 | instance | 2026-08-22 14:30:36.732657 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-08-22 14:30:36.733076 | instance | Saturday 22 August 2026 14:30:36 +0000 (0:00:00.854) 0:00:01.904 ******* 2026-08-22 14:30:36.907678 | instance | ok: [instance] 2026-08-22 14:30:36.908028 | instance | 2026-08-22 14:30:36.908392 | instance | PLAY [Deploy Ceph monitors & managers] ***************************************** 2026-08-22 14:30:36.908846 | instance | 2026-08-22 14:30:36.909279 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-22 14:30:36.909693 | instance | Saturday 22 August 2026 14:30:36 +0000 (0:00:00.176) 0:00:02.080 ******* 2026-08-22 14:30:37.818011 | instance | ok: [instance] 2026-08-22 14:30:37.818212 | instance | 2026-08-22 14:30:37.818369 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-22 14:30:37.818552 | instance | Saturday 22 August 2026 14:30:37 +0000 (0:00:00.908) 0:00:02.989 ******* 2026-08-22 14:30:38.098858 | instance | ok: [instance] 2026-08-22 14:30:38.099259 | instance | 2026-08-22 14:30:38.099613 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-22 14:30:38.099956 | instance | Saturday 22 August 2026 14:30:38 +0000 (0:00:00.280) 0:00:03.269 ******* 2026-08-22 14:30:38.141999 | instance | skipping: [instance] 2026-08-22 14:30:38.142199 | instance | 2026-08-22 14:30:38.142357 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-08-22 14:30:38.142549 | instance | Saturday 22 August 2026 14:30:38 +0000 (0:00:00.042) 0:00:03.312 ******* 2026-08-22 14:30:38.459437 | instance | changed: [instance] 2026-08-22 14:30:38.459830 | instance | 2026-08-22 14:30:38.460193 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-22 14:30:38.460537 | instance | Saturday 22 August 2026 14:30:38 +0000 (0:00:00.319) 0:00:03.631 ******* 2026-08-22 14:30:38.540814 | instance | ok: [instance] => { 2026-08-22 14:30:38.541194 | instance | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-08-22 14:30:38.541525 | instance | } 2026-08-22 14:30:38.541840 | instance | 2026-08-22 14:30:38.542296 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-22 14:30:38.542645 | instance | Saturday 22 August 2026 14:30:38 +0000 (0:00:00.081) 0:00:03.713 ******* 2026-08-22 14:30:39.254066 | instance | changed: [instance] 2026-08-22 14:30:39.254551 | instance | 2026-08-22 14:30:39.254914 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-22 14:30:39.255253 | instance | Saturday 22 August 2026 14:30:39 +0000 (0:00:00.712) 0:00:04.426 ******* 2026-08-22 14:30:39.301978 | instance | skipping: [instance] 2026-08-22 14:30:39.302297 | instance | 2026-08-22 14:30:39.302550 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-22 14:30:39.302791 | instance | Saturday 22 August 2026 14:30:39 +0000 (0:00:00.048) 0:00:04.474 ******* 2026-08-22 14:30:39.349860 | instance | skipping: [instance] 2026-08-22 14:30:39.350331 | instance | 2026-08-22 14:30:39.350746 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-22 14:30:39.351161 | instance | Saturday 22 August 2026 14:30:39 +0000 (0:00:00.048) 0:00:04.522 ******* 2026-08-22 14:30:39.564940 | instance | ok: [instance] 2026-08-22 14:30:39.565313 | instance | 2026-08-22 14:30:39.565659 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-22 14:30:39.565993 | instance | Saturday 22 August 2026 14:30:39 +0000 (0:00:00.214) 0:00:04.737 ******* 2026-08-22 14:30:40.720266 | instance | ok: [instance] 2026-08-22 14:30:40.720742 | instance | 2026-08-22 14:30:40.721120 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-22 14:30:40.721459 | instance | Saturday 22 August 2026 14:30:40 +0000 (0:00:01.155) 0:00:05.892 ******* 2026-08-22 14:30:40.780305 | instance | ok: [instance] => { 2026-08-22 14:30:40.780726 | instance | "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz" 2026-08-22 14:30:40.781099 | instance | } 2026-08-22 14:30:40.781423 | instance | 2026-08-22 14:30:40.781823 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-22 14:30:40.782213 | instance | Saturday 22 August 2026 14:30:40 +0000 (0:00:00.060) 0:00:05.953 ******* 2026-08-22 14:30:41.448793 | instance | changed: [instance] 2026-08-22 14:30:41.448845 | instance | 2026-08-22 14:30:41.448856 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-22 14:30:41.448867 | instance | Saturday 22 August 2026 14:30:41 +0000 (0:00:00.667) 0:00:06.620 ******* 2026-08-22 14:30:44.245054 | instance | changed: [instance] 2026-08-22 14:30:44.245104 | instance | 2026-08-22 14:30:44.245110 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-08-22 14:30:44.245115 | instance | Saturday 22 August 2026 14:30:44 +0000 (0:00:02.797) 0:00:09.417 ******* 2026-08-22 14:30:44.274168 | instance | skipping: [instance] 2026-08-22 14:30:44.274219 | instance | 2026-08-22 14:30:44.274230 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-08-22 14:30:44.274416 | instance | Saturday 22 August 2026 14:30:44 +0000 (0:00:00.028) 0:00:09.446 ******* 2026-08-22 14:30:44.302715 | instance | skipping: [instance] 2026-08-22 14:30:44.302963 | instance | 2026-08-22 14:30:44.303497 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-08-22 14:30:44.303780 | instance | Saturday 22 August 2026 14:30:44 +0000 (0:00:00.029) 0:00:09.475 ******* 2026-08-22 14:30:44.330235 | instance | skipping: [instance] 2026-08-22 14:30:44.330479 | instance | 2026-08-22 14:30:44.330747 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-08-22 14:30:44.331017 | instance | Saturday 22 August 2026 14:30:44 +0000 (0:00:00.027) 0:00:09.503 ******* 2026-08-22 14:30:49.409824 | instance | changed: [instance] 2026-08-22 14:30:49.409898 | instance | 2026-08-22 14:30:49.410208 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] *** 2026-08-22 14:30:49.410242 | instance | Saturday 22 August 2026 14:30:49 +0000 (0:00:05.079) 0:00:14.582 ******* 2026-08-22 14:30:49.985768 | instance | changed: [instance] 2026-08-22 14:30:49.985798 | instance | 2026-08-22 14:30:49.985803 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] ******* 2026-08-22 14:30:49.985808 | instance | Saturday 22 August 2026 14:30:49 +0000 (0:00:00.575) 0:00:15.158 ******* 2026-08-22 14:30:50.869359 | instance | changed: [instance] => (item={'path': '/etc/containerd'}) 2026-08-22 14:30:50.869458 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'}) 2026-08-22 14:30:50.870191 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'}) 2026-08-22 14:30:50.870285 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'}) 2026-08-22 14:30:50.870299 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'}) 2026-08-22 14:30:50.870309 | instance | 2026-08-22 14:30:50.870331 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] ********** 2026-08-22 14:30:50.870348 | instance | Saturday 22 August 2026 14:30:50 +0000 (0:00:00.883) 0:00:16.041 ******* 2026-08-22 14:30:51.442285 | instance | changed: [instance] 2026-08-22 14:30:51.442361 | instance | 2026-08-22 14:30:51.443030 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ******** 2026-08-22 14:30:51.443063 | instance | Saturday 22 August 2026 14:30:51 +0000 (0:00:00.555) 0:00:16.597 ******* 2026-08-22 14:30:51.443069 | instance | 2026-08-22 14:30:51.443073 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-08-22 14:30:51.443077 | instance | Saturday 22 August 2026 14:30:51 +0000 (0:00:00.017) 0:00:16.614 ******* 2026-08-22 14:30:52.367739 | instance | ok: [instance] 2026-08-22 14:30:52.368220 | instance | 2026-08-22 14:30:52.368408 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] ********** 2026-08-22 14:30:52.368417 | instance | Saturday 22 August 2026 14:30:52 +0000 (0:00:00.925) 0:00:17.540 ******* 2026-08-22 14:30:52.792821 | instance | changed: [instance] 2026-08-22 14:30:52.792912 | instance | 2026-08-22 14:30:52.793191 | instance | TASK [vexxhost.containers.containerd : Enable and start service] *************** 2026-08-22 14:30:52.793232 | instance | Saturday 22 August 2026 14:30:52 +0000 (0:00:00.424) 0:00:17.965 ******* 2026-08-22 14:30:53.356053 | instance | changed: [instance] 2026-08-22 14:30:53.356128 | instance | 2026-08-22 14:30:53.356396 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-22 14:30:53.356434 | instance | Saturday 22 August 2026 14:30:53 +0000 (0:00:00.563) 0:00:18.528 ******* 2026-08-22 14:30:53.560359 | instance | ok: [instance] 2026-08-22 14:30:53.560424 | instance | 2026-08-22 14:30:53.560714 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-22 14:30:53.560752 | instance | Saturday 22 August 2026 14:30:53 +0000 (0:00:00.204) 0:00:18.733 ******* 2026-08-22 14:30:53.620550 | instance | ok: [instance] => { 2026-08-22 14:30:53.620644 | instance | "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz" 2026-08-22 14:30:53.621162 | instance | } 2026-08-22 14:30:53.621186 | instance | 2026-08-22 14:30:53.621192 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-22 14:30:53.621197 | instance | Saturday 22 August 2026 14:30:53 +0000 (0:00:00.060) 0:00:18.793 ******* 2026-08-22 14:30:54.605897 | instance | changed: [instance] 2026-08-22 14:30:54.606226 | instance | 2026-08-22 14:30:54.606300 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-22 14:30:54.606436 | instance | Saturday 22 August 2026 14:30:54 +0000 (0:00:00.985) 0:00:19.778 ******* 2026-08-22 14:30:58.961338 | instance | changed: [instance] 2026-08-22 14:30:58.961394 | instance | 2026-08-22 14:30:58.961628 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ****************** 2026-08-22 14:30:58.961644 | instance | Saturday 22 August 2026 14:30:58 +0000 (0:00:04.355) 0:00:24.134 ******* 2026-08-22 14:30:59.950019 | instance | ok: [instance] 2026-08-22 14:30:59.950246 | instance | 2026-08-22 14:30:59.950310 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] *************** 2026-08-22 14:30:59.950460 | instance | Saturday 22 August 2026 14:30:59 +0000 (0:00:00.988) 0:00:25.122 ******* 2026-08-22 14:31:00.314589 | instance | changed: [instance] 2026-08-22 14:31:00.314689 | instance | 2026-08-22 14:31:00.315057 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] ***** 2026-08-22 14:31:00.315098 | instance | Saturday 22 August 2026 14:31:00 +0000 (0:00:00.364) 0:00:25.487 ******* 2026-08-22 14:31:00.755174 | instance | changed: [instance] 2026-08-22 14:31:00.755287 | instance | 2026-08-22 14:31:00.755656 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] *********** 2026-08-22 14:31:00.755698 | instance | Saturday 22 August 2026 14:31:00 +0000 (0:00:00.440) 0:00:25.927 ******* 2026-08-22 14:31:01.302567 | instance | changed: [instance] => (item={'path': '/etc/docker'}) 2026-08-22 14:31:01.302639 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'}) 2026-08-22 14:31:01.303171 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'}) 2026-08-22 14:31:01.303209 | instance | 2026-08-22 14:31:01.303215 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ****** 2026-08-22 14:31:01.303220 | instance | Saturday 22 August 2026 14:31:01 +0000 (0:00:00.547) 0:00:26.475 ******* 2026-08-22 14:31:01.747203 | instance | changed: [instance] 2026-08-22 14:31:01.747273 | instance | 2026-08-22 14:31:01.747551 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] *********** 2026-08-22 14:31:01.747586 | instance | Saturday 22 August 2026 14:31:01 +0000 (0:00:00.444) 0:00:26.920 ******* 2026-08-22 14:31:02.208945 | instance | changed: [instance] 2026-08-22 14:31:02.209006 | instance | 2026-08-22 14:31:02.209644 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************ 2026-08-22 14:31:02.209678 | instance | Saturday 22 August 2026 14:31:02 +0000 (0:00:00.445) 0:00:27.365 ******* 2026-08-22 14:31:02.209684 | instance | 2026-08-22 14:31:02.209688 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-08-22 14:31:02.209692 | instance | Saturday 22 August 2026 14:31:02 +0000 (0:00:00.016) 0:00:27.381 ******* 2026-08-22 14:31:02.902223 | instance | ok: [instance] 2026-08-22 14:31:02.902288 | instance | 2026-08-22 14:31:02.902565 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ****************** 2026-08-22 14:31:02.902608 | instance | Saturday 22 August 2026 14:31:02 +0000 (0:00:00.693) 0:00:28.075 ******* 2026-08-22 14:31:04.493946 | instance | changed: [instance] 2026-08-22 14:31:04.494013 | instance | 2026-08-22 14:31:04.494309 | instance | TASK [vexxhost.containers.docker : Enable and start service] ******************* 2026-08-22 14:31:04.494327 | instance | Saturday 22 August 2026 14:31:04 +0000 (0:00:01.591) 0:00:29.666 ******* 2026-08-22 14:31:05.024322 | instance | changed: [instance] 2026-08-22 14:31:05.024404 | instance | 2026-08-22 14:31:05.024681 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ****** 2026-08-22 14:31:05.024712 | instance | Saturday 22 August 2026 14:31:05 +0000 (0:00:00.530) 0:00:30.196 ******* 2026-08-22 14:31:05.067205 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml) 2026-08-22 14:31:05.067596 | instance | 2026-08-22 14:31:05.067638 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ******************************** 2026-08-22 14:31:05.067645 | instance | Saturday 22 August 2026 14:31:05 +0000 (0:00:00.042) 0:00:30.239 ******* 2026-08-22 14:31:10.049082 | instance | changed: [instance] 2026-08-22 14:31:10.049295 | instance | 2026-08-22 14:31:10.049308 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] ********************* 2026-08-22 14:31:10.049413 | instance | Saturday 22 August 2026 14:31:10 +0000 (0:00:04.982) 0:00:35.221 ******* 2026-08-22 14:31:10.697187 | instance | ok: [instance] => (item=chronyd) 2026-08-22 14:31:10.697219 | instance | ok: [instance] => (item=sshd) 2026-08-22 14:31:10.697224 | instance | 2026-08-22 14:31:10.697229 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ****************************** 2026-08-22 14:31:10.697233 | instance | Saturday 22 August 2026 14:31:10 +0000 (0:00:00.647) 0:00:35.869 ******* 2026-08-22 14:31:11.796303 | instance | changed: [instance] 2026-08-22 14:31:11.796507 | instance | 2026-08-22 14:31:11.796520 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ******************** 2026-08-22 14:31:11.796662 | instance | Saturday 22 August 2026 14:31:11 +0000 (0:00:01.099) 0:00:36.969 ******* 2026-08-22 14:31:12.007361 | instance | ok: [instance] 2026-08-22 14:31:12.007470 | instance | 2026-08-22 14:31:12.007731 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] **************** 2026-08-22 14:31:12.007773 | instance | Saturday 22 August 2026 14:31:12 +0000 (0:00:00.210) 0:00:37.180 ******* 2026-08-22 14:31:12.447854 | instance | changed: [instance] 2026-08-22 14:31:12.447986 | instance | 2026-08-22 14:31:12.448257 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] *** 2026-08-22 14:31:12.448460 | instance | Saturday 22 August 2026 14:31:12 +0000 (0:00:00.440) 0:00:37.620 ******* 2026-08-22 14:31:12.815015 | instance | changed: [instance] 2026-08-22 14:31:12.815148 | instance | 2026-08-22 14:31:12.815511 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] ************************* 2026-08-22 14:31:12.815557 | instance | Saturday 22 August 2026 14:31:12 +0000 (0:00:00.367) 0:00:37.987 ******* 2026-08-22 14:31:12.940500 | instance | ok: [instance] 2026-08-22 14:31:12.940642 | instance | 2026-08-22 14:31:12.940655 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] ******************* 2026-08-22 14:31:12.940732 | instance | Saturday 22 August 2026 14:31:12 +0000 (0:00:00.125) 0:00:38.113 ******* 2026-08-22 14:31:13.163181 | instance | ok: [instance] => (item=instance) 2026-08-22 14:31:13.163281 | instance | 2026-08-22 14:31:13.163351 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ******** 2026-08-22 14:31:13.163516 | instance | Saturday 22 August 2026 14:31:13 +0000 (0:00:00.222) 0:00:38.335 ******* 2026-08-22 14:31:13.220862 | instance | ok: [instance] 2026-08-22 14:31:13.221257 | instance | 2026-08-22 14:31:13.221293 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] *********************************** 2026-08-22 14:31:13.221300 | instance | Saturday 22 August 2026 14:31:13 +0000 (0:00:00.057) 0:00:38.393 ******* 2026-08-22 14:31:13.295639 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance 2026-08-22 14:31:13.295708 | instance | 2026-08-22 14:31:13.296009 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] ************* 2026-08-22 14:31:13.296056 | instance | Saturday 22 August 2026 14:31:13 +0000 (0:00:00.075) 0:00:38.468 ******* 2026-08-22 14:31:13.614101 | instance | changed: [instance] 2026-08-22 14:31:13.614564 | instance | 2026-08-22 14:31:13.614631 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ****************** 2026-08-22 14:31:13.614638 | instance | Saturday 22 August 2026 14:31:13 +0000 (0:00:00.318) 0:00:38.786 ******* 2026-08-22 14:31:14.310836 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True}) 2026-08-22 14:31:14.310890 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0}) 2026-08-22 14:31:14.310896 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False}) 2026-08-22 14:31:14.310902 | instance | 2026-08-22 14:31:14.310907 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] ******************************* 2026-08-22 14:31:14.310912 | instance | Saturday 22 August 2026 14:31:14 +0000 (0:00:00.696) 0:00:39.482 ******* 2026-08-22 14:32:50.684225 | instance | ok: [instance] 2026-08-22 14:32:50.684304 | instance | 2026-08-22 14:32:50.684316 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] *************** 2026-08-22 14:32:50.684326 | instance | Saturday 22 August 2026 14:32:50 +0000 (0:01:36.373) 0:02:15.855 ******* 2026-08-22 14:32:50.893612 | instance | changed: [instance] 2026-08-22 14:32:50.893649 | instance | 2026-08-22 14:32:50.893654 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] ********************************** 2026-08-22 14:32:50.893659 | instance | Saturday 22 August 2026 14:32:50 +0000 (0:00:00.210) 0:02:16.066 ******* 2026-08-22 14:32:50.963499 | instance | ok: [instance] 2026-08-22 14:32:50.963552 | instance | 2026-08-22 14:32:50.963561 | instance | TASK [Install Ceph host] ******************************************************* 2026-08-22 14:32:50.963568 | instance | Saturday 22 August 2026 14:32:50 +0000 (0:00:00.069) 0:02:16.135 ******* 2026-08-22 14:32:51.041264 | instance | included: vexxhost.ceph.cephadm_host for instance 2026-08-22 14:32:51.041310 | instance | 2026-08-22 14:32:51.041322 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ****** 2026-08-22 14:32:51.041332 | instance | Saturday 22 August 2026 14:32:51 +0000 (0:00:00.077) 0:02:16.212 ******* 2026-08-22 14:32:53.458034 | instance | ok: [instance] 2026-08-22 14:32:53.458074 | instance | 2026-08-22 14:32:53.458084 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] *** 2026-08-22 14:32:53.458141 | instance | Saturday 22 August 2026 14:32:53 +0000 (0:00:02.417) 0:02:18.630 ******* 2026-08-22 14:32:53.517352 | instance | ok: [instance] => (item=instance) 2026-08-22 14:32:53.517378 | instance | 2026-08-22 14:32:53.517383 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] *********** 2026-08-22 14:32:53.517387 | instance | Saturday 22 August 2026 14:32:53 +0000 (0:00:00.059) 0:02:18.690 ******* 2026-08-22 14:32:53.858208 | instance | ok: [instance] 2026-08-22 14:32:53.858491 | instance | 2026-08-22 14:32:53.858864 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] *********************** 2026-08-22 14:32:53.859234 | instance | Saturday 22 August 2026 14:32:53 +0000 (0:00:00.340) 0:02:19.030 ******* 2026-08-22 14:32:56.143553 | instance | ok: [instance] 2026-08-22 14:32:56.143798 | instance | 2026-08-22 14:32:56.144084 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ****************** 2026-08-22 14:32:56.144361 | instance | Saturday 22 August 2026 14:32:56 +0000 (0:00:02.285) 0:02:21.316 ******* 2026-08-22 14:33:45.979960 | instance | An exception occurred during task execution. To see the full traceback, use -vvv. The error was: [errno 5] RADOS I/O error (error connecting to the cluster) 2026-08-22 14:33:45.980033 | 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_a7p1v5yk/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_a7p1v5yk/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_a7p1v5yk/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_a7p1v5yk/ansible_vexxhost.ceph.orch_apply_payload.zip/ansible_collections/vexxhost/ceph/plugins/modules/orch_apply.py\", line 120, in apply_spec\nRuntimeError: Inferring config /var/lib/ceph/4837cbf8-4f90-4300-b3f6-726c9b9f89b4/mon.instance/config\n2026-08-22T14:33:45.824+0000 7ff9b2d82640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgDjsolquIuWKSAAUtF4AzdE5WSdPmaxb0h+2rYmwwUeYiNGygfA7h9CbIA=: Malformed input [buffer:3]\n2026-08-22T14:33:45.824+0000 7ff9b2d82640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-22T14:33:45.824+0000 7ff9b2d82640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgDjsolquIuWKSAAUtF4AzdE5WSdPmaxb0h+2rYmwwUeYiNGygfA7h9CbIA=: Malformed input [buffer:3]\n2026-08-22T14:33:45.824+0000 7ff9b2d82640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-22T14:33:45.824+0000 7ff9b2d82640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgDjsolquIuWKSAAUtF4AzdE5WSdPmaxb0h+2rYmwwUeYiNGygfA7h9CbIA=: Malformed input [buffer:3]\n2026-08-22T14:33:45.824+0000 7ff9b2d82640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-22T14:33:45.824+0000 7ff9b2d82640 -1 monclient: keyring not found\n[errno 5] RADOS I/O error (error connecting to the cluster)\n\n", "module_stdout": "", "msg": "MODULE FAILURE\nSee stdout/stderr for the exact error", "rc": 1} 2026-08-22 14:33:45.980720 | instance | 2026-08-22 14:33:45.980838 | instance | PLAY RECAP ********************************************************************* 2026-08-22 14:33:45.981022 | instance | instance : ok=55 changed=26 unreachable=0 failed=1 skipped=6 rescued=0 ignored=0 2026-08-22 14:33:45.981195 | instance | 2026-08-22 14:33:45.981408 | instance | Saturday 22 August 2026 14:33:45 +0000 (0:00:49.838) 0:03:11.154 ******* 2026-08-22 14:33:45.981585 | instance | =============================================================================== 2026-08-22 14:33:45.981787 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 96.37s 2026-08-22 14:33:45.982000 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 49.84s 2026-08-22 14:33:45.982326 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 5.08s 2026-08-22 14:33:45.982484 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 4.98s 2026-08-22 14:33:45.982743 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.36s 2026-08-22 14:33:45.983041 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.80s 2026-08-22 14:33:45.983332 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 2.42s 2026-08-22 14:33:45.983604 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.29s 2026-08-22 14:33:45.983873 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.62s 2026-08-22 14:33:45.984138 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 1.59s 2026-08-22 14:33:45.984413 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.16s 2026-08-22 14:33:45.984746 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 1.10s 2026-08-22 14:33:45.985188 | instance | Gathering Facts --------------------------------------------------------- 1.00s 2026-08-22 14:33:45.985481 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 0.99s 2026-08-22 14:33:45.985747 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.99s 2026-08-22 14:33:45.986099 | instance | Gathering Facts --------------------------------------------------------- 0.91s 2026-08-22 14:33:45.986378 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.88s 2026-08-22 14:33:45.986670 | instance | Gathering Facts --------------------------------------------------------- 0.85s 2026-08-22 14:33:45.987028 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.71s 2026-08-22 14:33:45.987403 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.70s 2026-08-22 14:33:46.062110 | instance | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-08-22 14:33:46.062373 | instance | ERROR [csi > converge] Executed: Failed 2026-08-22 14:33:46.062558 | instance | ERROR Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-08-22 14:33:46.223092 | instance | ERROR 2026-08-22 14:33:46.223334 | instance | { 2026-08-22 14:33:46.223395 | instance | "delta": "0:03:59.965926", 2026-08-22 14:33:46.223426 | instance | "end": "2026-08-22 14:33:46.115882", 2026-08-22 14:33:46.223452 | instance | "msg": "non-zero return code", 2026-08-22 14:33:46.223477 | instance | "rc": 2, 2026-08-22 14:33:46.223502 | instance | "start": "2026-08-22 14:29:46.149956" 2026-08-22 14:33:46.223526 | instance | } failure 2026-08-22 14:33:46.229517 | 2026-08-22 14:33:46.229578 | PLAY RECAP 2026-08-22 14:33:46.229639 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-08-22 14:33:46.229670 | 2026-08-22 14:33:46.375172 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-22 14:33:46.379568 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-08-22 14:33:47.023518 | 2026-08-22 14:33:47.023654 | PLAY [all] 2026-08-22 14:33:47.038442 | 2026-08-22 14:33:47.038519 | TASK [gather-host-logs : creating directory for system status] 2026-08-22 14:33:47.391864 | instance | changed 2026-08-22 14:33:47.398044 | 2026-08-22 14:33:47.398129 | TASK [gather-host-logs : Get logs for each host] 2026-08-22 14:33:47.763099 | instance | + systemd-cgls --full --all --no-pager 2026-08-22 14:33:47.777403 | instance | + ip addr 2026-08-22 14:33:47.779750 | instance | + ip route 2026-08-22 14:33:47.781474 | instance | + lsblk 2026-08-22 14:33:47.787487 | instance | + mount 2026-08-22 14:33:47.789440 | instance | + docker images 2026-08-22 14:33:47.809704 | instance | + brctl show 2026-08-22 14:33:47.810571 | instance | /bin/bash: line 8: brctl: command not found 2026-08-22 14:33:47.810921 | instance | + ps aux --sort=-%mem 2026-08-22 14:33:47.834356 | instance | + dpkg -l 2026-08-22 14:33:47.840583 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-08-22 14:33:47.841030 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-08-22 14:33:47.861572 | instance | + '[' '!' -z '' ']' 2026-08-22 14:33:47.934433 | instance | ok: Runtime: 0:00:00.104639 2026-08-22 14:33:47.940905 | 2026-08-22 14:33:47.941000 | TASK [gather-host-logs : Downloads logs to executor] 2026-08-22 14:33:48.573845 | instance | changed: 2026-08-22 14:33:48.574084 | instance | created directory /var/lib/zuul/builds/6662058755214bae9354ea66df22c20e/work/logs/instance 2026-08-22 14:33:48.574128 | instance | cd+++++++++ system/ 2026-08-22 14:33:48.574162 | instance | >f+++++++++ system/brctl-show.txt 2026-08-22 14:33:48.574195 | instance | >f+++++++++ system/docker-images.txt 2026-08-22 14:33:48.574225 | instance | >f+++++++++ system/ip-addr.txt 2026-08-22 14:33:48.574258 | instance | >f+++++++++ system/ip-route.txt 2026-08-22 14:33:48.574289 | instance | >f+++++++++ system/lsblk.txt 2026-08-22 14:33:48.574319 | instance | >f+++++++++ system/mount.txt 2026-08-22 14:33:48.574348 | instance | >f+++++++++ system/packages.txt 2026-08-22 14:33:48.574377 | instance | >f+++++++++ system/ps.txt 2026-08-22 14:33:48.574409 | instance | >f+++++++++ system/systemd-cgls.txt 2026-08-22 14:33:48.589251 | 2026-08-22 14:33:48.589336 | LOOP [helm-release-status : creating directory for helm release status] 2026-08-22 14:33:48.790570 | instance | changed: "values" 2026-08-22 14:33:48.959911 | instance | changed: "releases" 2026-08-22 14:33:48.977864 | 2026-08-22 14:33:48.978013 | TASK [helm-release-status : Gather get release status for helm charts] 2026-08-22 14:33:49.198898 | instance | /bin/bash: line 3: kubectl: command not found 2026-08-22 14:33:49.513862 | instance | ok: Runtime: 0:00:00.005752 2026-08-22 14:33:49.519284 | 2026-08-22 14:33:49.519356 | TASK [helm-release-status : Downloads logs to executor] 2026-08-22 14:33:50.004484 | instance | changed: 2026-08-22 14:33:50.004721 | instance | cd+++++++++ helm/ 2026-08-22 14:33:50.004752 | instance | cd+++++++++ helm/releases/ 2026-08-22 14:33:50.004775 | instance | cd+++++++++ helm/values/ 2026-08-22 14:33:50.013968 | 2026-08-22 14:33:50.014061 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-08-22 14:33:50.210657 | instance | changed 2026-08-22 14:33:50.218648 | 2026-08-22 14:33:50.218720 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-08-22 14:33:50.515700 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-22 14:33:50.515808 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-22 14:33:50.520843 | instance | environment: line 1: kubectl: command not found 2026-08-22 14:33:50.521844 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-22 14:33:50.523518 | instance | environment: line 1: kubectl: command not found 2026-08-22 14:33:50.524312 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-22 14:33:50.525730 | instance | environment: line 1: kubectl: command not found 2026-08-22 14:33:50.526608 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-22 14:33:50.528256 | instance | environment: line 1: kubectl: command not found 2026-08-22 14:33:50.529100 | instance | environment: line 1: kubectl: command not found 2026-08-22 14:33:50.529563 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-22 14:33:50.529847 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-22 14:33:50.757284 | instance | ok: Runtime: 0:00:00.023022 2026-08-22 14:33:50.762327 | 2026-08-22 14:33:50.762392 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-08-22 14:33:50.969919 | instance | changed 2026-08-22 14:33:50.975138 | 2026-08-22 14:33:50.975215 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-08-22 14:33:51.192268 | instance | environment: line 5: kubectl: command not found 2026-08-22 14:33:51.193410 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-22 14:33:51.193609 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-22 14:33:51.193730 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-22 14:33:51.511116 | instance | ok: Runtime: 0:00:00.010283 2026-08-22 14:33:51.519231 | 2026-08-22 14:33:51.519368 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-08-22 14:33:52.021650 | instance | changed: 2026-08-22 14:33:52.021889 | instance | cd+++++++++ objects/ 2026-08-22 14:33:52.021927 | instance | cd+++++++++ objects/cluster/ 2026-08-22 14:33:52.021960 | instance | cd+++++++++ objects/namespaced/ 2026-08-22 14:33:52.034054 | 2026-08-22 14:33:52.034146 | TASK [gather-pod-logs : creating directory for pod logs] 2026-08-22 14:33:52.234158 | instance | changed 2026-08-22 14:33:52.239225 | 2026-08-22 14:33:52.239302 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-08-22 14:33:52.470329 | instance | changed 2026-08-22 14:33:52.477426 | 2026-08-22 14:33:52.477525 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-08-22 14:33:52.681998 | instance | environment: line 3: kubectl: command not found 2026-08-22 14:33:53.017826 | instance | ok: Runtime: 0:00:00.009047 2026-08-22 14:33:53.025248 | 2026-08-22 14:33:53.025372 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-08-22 14:33:53.537182 | instance | changed: 2026-08-22 14:33:53.537494 | instance | cd+++++++++ pod-logs/ 2026-08-22 14:33:53.537567 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-08-22 14:33:53.550051 | 2026-08-22 14:33:53.550122 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-08-22 14:33:53.758067 | instance | changed 2026-08-22 14:33:53.764166 | 2026-08-22 14:33:53.764239 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-08-22 14:33:53.972973 | instance | /bin/bash: line 2: kubectl: command not found 2026-08-22 14:33:54.299861 | instance | ok: Runtime: 0:00:00.032396 2026-08-22 14:33:54.306423 | 2026-08-22 14:33:54.306514 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-08-22 14:33:54.523418 | instance | /bin/bash: line 2: kubectl: command not found 2026-08-22 14:33:54.553378 | instance | ceph-mgr endpoints: 2026-08-22 14:33:54.843441 | instance | ok: Runtime: 0:00:00.035837 2026-08-22 14:33:54.849399 | 2026-08-22 14:33:54.849468 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-08-22 14:33:55.041800 | instance | /bin/bash: line 4: kubectl: command not found 2026-08-22 14:33:55.384017 | instance | ok: Runtime: 0:00:00.035423 2026-08-22 14:33:55.392196 | 2026-08-22 14:33:55.392308 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-08-22 14:33:55.890422 | instance | changed: cd+++++++++ prometheus/ 2026-08-22 14:33:55.903016 | 2026-08-22 14:33:55.903144 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-08-22 14:33:56.096883 | instance | changed 2026-08-22 14:33:56.101786 | 2026-08-22 14:33:56.101856 | TASK [gather-selenium-data : Get selenium data] 2026-08-22 14:33:56.359668 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-08-22 14:33:56.361268 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-08-22 14:33:56.639087 | instance | ERROR 2026-08-22 14:33:56.639684 | instance | { 2026-08-22 14:33:56.639758 | instance | "delta": "0:00:00.006848", 2026-08-22 14:33:56.639807 | instance | "end": "2026-08-22 14:33:56.361583", 2026-08-22 14:33:56.639856 | instance | "msg": "non-zero return code", 2026-08-22 14:33:56.639899 | instance | "rc": 1, 2026-08-22 14:33:56.639941 | instance | "start": "2026-08-22 14:33:56.354735" 2026-08-22 14:33:56.640043 | instance | } 2026-08-22 14:33:56.640101 | instance | ERROR: Ignoring Errors 2026-08-22 14:33:56.646019 | 2026-08-22 14:33:56.646089 | TASK [gather-selenium-data : Downloads logs to executor] 2026-08-22 14:33:57.138755 | instance | changed: cd+++++++++ selenium/ 2026-08-22 14:33:57.147499 | 2026-08-22 14:33:57.147573 | PLAY RECAP 2026-08-22 14:33:57.147639 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-08-22 14:33:57.147666 | 2026-08-22 14:33:57.348894 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-08-22 14:33:57.351002 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-22 14:33:58.001599 | 2026-08-22 14:33:58.001748 | PLAY [all] 2026-08-22 14:33:58.013906 | 2026-08-22 14:33:58.013990 | TASK [fetch-output : Set log path for multiple nodes] 2026-08-22 14:33:58.060129 | instance | skipping: Conditional result was False 2026-08-22 14:33:58.070038 | 2026-08-22 14:33:58.070123 | TASK [fetch-output : Set log path for single node] 2026-08-22 14:33:58.102701 | instance | ok 2026-08-22 14:33:58.111740 | 2026-08-22 14:33:58.111907 | LOOP [fetch-output : Ensure local output dirs] 2026-08-22 14:33:58.566556 | instance -> localhost | ok: "/var/lib/zuul/builds/6662058755214bae9354ea66df22c20e/work/logs" 2026-08-22 14:33:58.780260 | instance -> localhost | changed: "/var/lib/zuul/builds/6662058755214bae9354ea66df22c20e/work/artifacts" 2026-08-22 14:33:58.997344 | instance -> localhost | changed: "/var/lib/zuul/builds/6662058755214bae9354ea66df22c20e/work/docs" 2026-08-22 14:33:59.015878 | 2026-08-22 14:33:59.015980 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-22 14:33:59.691350 | instance | changed: .d..t...... ./ 2026-08-22 14:33:59.691602 | instance | changed: All items complete 2026-08-22 14:33:59.691644 | 2026-08-22 14:34:00.150714 | instance | changed: .d..t...... ./ 2026-08-22 14:34:00.614148 | instance | changed: .d..t...... ./ 2026-08-22 14:34:00.632863 | 2026-08-22 14:34:00.633097 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-22 14:34:01.086121 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.008900 2026-08-22 14:34:01.306154 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.008297 2026-08-22 14:34:01.326881 | 2026-08-22 14:34:01.327249 | PLAY [all] 2026-08-22 14:34:01.333612 | 2026-08-22 14:34:01.333682 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-22 14:34:01.773502 | instance | changed 2026-08-22 14:34:01.779337 | 2026-08-22 14:34:01.779392 | PLAY RECAP 2026-08-22 14:34:01.779441 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-22 14:34:01.779464 | 2026-08-22 14:34:01.944869 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-22 14:34:01.949647 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-22 14:34:02.568780 | 2026-08-22 14:34:02.568930 | PLAY [localhost] 2026-08-22 14:34:02.579219 | 2026-08-22 14:34:02.579318 | TASK [Generate Zuul manifest] 2026-08-22 14:34:02.603892 | localhost | ok 2026-08-22 14:34:02.621741 | 2026-08-22 14:34:02.621954 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-22 14:34:03.032111 | localhost | changed 2026-08-22 14:34:03.045018 | 2026-08-22 14:34:03.045096 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-22 14:34:03.077246 | localhost | ok 2026-08-22 14:34:03.086092 | 2026-08-22 14:34:03.086157 | TASK [Upload logs] 2026-08-22 14:34:03.111043 | localhost | ok 2026-08-22 14:34:03.174396 | 2026-08-22 14:34:03.174509 | TASK [Set zuul-log-path fact] 2026-08-22 14:34:03.197430 | localhost | ok 2026-08-22 14:34:03.210481 | 2026-08-22 14:34:03.210552 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-22 14:34:03.247904 | localhost | ok 2026-08-22 14:34:03.256669 | 2026-08-22 14:34:03.256737 | TASK [upload-logs : Create log directories] 2026-08-22 14:34:03.673924 | localhost | changed 2026-08-22 14:34:03.680675 | 2026-08-22 14:34:03.680769 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-22 14:34:04.137613 | localhost -> localhost | ok: Runtime: 0:00:00.006635 2026-08-22 14:34:04.143316 | 2026-08-22 14:34:04.143388 | TASK [upload-logs : Upload logs to log server] 2026-08-22 14:34:04.652427 | localhost | Output suppressed because no_log was given 2026-08-22 14:34:04.692922 | 2026-08-22 14:34:04.693234 | LOOP [upload-logs : Compress console log and json output] 2026-08-22 14:34:04.744398 | localhost | skipping: Conditional result was False 2026-08-22 14:34:04.751990 | localhost | skipping: Conditional result was False 2026-08-22 14:34:04.766583 | 2026-08-22 14:34:04.766730 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-22 14:34:04.813436 | localhost | skipping: Conditional result was False 2026-08-22 14:34:04.814020 | 2026-08-22 14:34:04.817634 | localhost | skipping: Conditional result was False 2026-08-22 14:34:04.831792 | 2026-08-22 14:34:04.831949 | LOOP [upload-logs : Upload console log and json output]