2026-08-26 00:12:06.705734 | Job console starting 2026-08-26 00:12:06.721205 | Updating git repos 2026-08-26 00:12:10.670822 | Cloning repos into workspace 2026-08-26 00:12:25.944199 | Restoring repo states 2026-08-26 00:12:31.157502 | Merging changes 2026-08-26 00:12:32.497356 | Checking out repos 2026-08-26 00:12:34.294486 | Preparing playbooks 2026-08-26 00:12:36.336083 | Running Ansible setup 2026-08-26 00:12:39.607316 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-26 00:12:40.183516 | 2026-08-26 00:12:40.495598 | PLAY [localhost] 2026-08-26 00:12:40.509530 | 2026-08-26 00:12:40.509606 | TASK [Gathering Facts] 2026-08-26 00:12:41.372603 | localhost | ok 2026-08-26 00:12:41.381824 | 2026-08-26 00:12:41.381926 | TASK [Setup log path fact] 2026-08-26 00:12:41.407269 | localhost | ok 2026-08-26 00:12:41.418929 | 2026-08-26 00:12:41.418995 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-26 00:12:41.451547 | localhost | ok 2026-08-26 00:12:41.458071 | 2026-08-26 00:12:41.458144 | TASK [emit-job-header : Print job information] 2026-08-26 00:12:41.503162 | # Job Information 2026-08-26 00:12:41.503356 | Ansible Version: 2.16.18 2026-08-26 00:12:41.503400 | Job: atmosphere-molecule-csi-rbd 2026-08-26 00:12:41.503431 | Pipeline: check 2026-08-26 00:12:41.503459 | Executor: 2d72f0692154 2026-08-26 00:12:41.503487 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4090 2026-08-26 00:12:41.503519 | Event ID: fd396980-a0e1-11f1-82a1-cfc9473e2d76 2026-08-26 00:12:41.507543 | 2026-08-26 00:12:41.507632 | LOOP [emit-job-header : Print node information] 2026-08-26 00:12:41.603969 | localhost | ok: 2026-08-26 00:12:41.604234 | localhost | # Node Information 2026-08-26 00:12:41.604287 | localhost | Inventory Hostname: instance 2026-08-26 00:12:41.604325 | localhost | Hostname: np0000191085 2026-08-26 00:12:41.604358 | localhost | Username: zuul 2026-08-26 00:12:41.604394 | localhost | Distro: Ubuntu 22.04 2026-08-26 00:12:41.604428 | localhost | Provider: yul1 2026-08-26 00:12:41.604459 | localhost | Region: ca-ymq-1 2026-08-26 00:12:41.604491 | localhost | Label: ubuntu-jammy 2026-08-26 00:12:41.604523 | localhost | Product Name: OpenStack Nova 2026-08-26 00:12:41.604553 | localhost | Interface IP: 162.253.55.34 2026-08-26 00:12:41.617753 | 2026-08-26 00:12:41.617900 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-26 00:12:41.988868 | localhost -> localhost | changed 2026-08-26 00:12:41.998407 | 2026-08-26 00:12:41.998492 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-26 00:12:42.840559 | localhost -> localhost | changed 2026-08-26 00:12:42.849215 | 2026-08-26 00:12:42.849292 | PLAY [all] 2026-08-26 00:12:42.859376 | 2026-08-26 00:12:42.859442 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-26 00:12:43.076575 | instance -> localhost | ok 2026-08-26 00:12:43.085020 | 2026-08-26 00:12:43.085119 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-26 00:12:43.117598 | instance | ok 2026-08-26 00:12:43.143086 | instance | included: /var/lib/zuul/builds/6ef40afce5ec4349a33a6d86b2e8c75d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-26 00:12:43.149441 | 2026-08-26 00:12:43.149518 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-26 00:12:44.565475 | instance -> localhost | Generating public/private rsa key pair. 2026-08-26 00:12:44.565716 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/6ef40afce5ec4349a33a6d86b2e8c75d/work/6ef40afce5ec4349a33a6d86b2e8c75d_id_rsa 2026-08-26 00:12:44.565758 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/6ef40afce5ec4349a33a6d86b2e8c75d/work/6ef40afce5ec4349a33a6d86b2e8c75d_id_rsa.pub 2026-08-26 00:12:44.565791 | instance -> localhost | The key fingerprint is: 2026-08-26 00:12:44.565822 | instance -> localhost | SHA256:D3w2y3I9CPUHqQslsRvdBU67qopo1qj80toUMlyQVps zuul-build-sshkey 2026-08-26 00:12:44.565873 | instance -> localhost | The key's randomart image is: 2026-08-26 00:12:44.565904 | instance -> localhost | +---[RSA 3072]----+ 2026-08-26 00:12:44.565938 | instance -> localhost | | .o. . o.. | 2026-08-26 00:12:44.565969 | instance -> localhost | | o. o + + + | 2026-08-26 00:12:44.565999 | instance -> localhost | |. E + + * | 2026-08-26 00:12:44.566029 | instance -> localhost | |. . . * o o | 2026-08-26 00:12:44.566057 | instance -> localhost | | + . S = o . | 2026-08-26 00:12:44.566086 | instance -> localhost | | o . O B . | 2026-08-26 00:12:44.566115 | instance -> localhost | | .+ . O o | 2026-08-26 00:12:44.566143 | instance -> localhost | |..*o.. + . | 2026-08-26 00:12:44.566175 | instance -> localhost | |.*=o. ... | 2026-08-26 00:12:44.566204 | instance -> localhost | +----[SHA256]-----+ 2026-08-26 00:12:44.566268 | instance -> localhost | ok: Runtime: 0:00:01.011230 2026-08-26 00:12:44.573312 | 2026-08-26 00:12:44.573399 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-26 00:12:44.608549 | instance | ok 2026-08-26 00:12:44.620403 | instance | included: /var/lib/zuul/builds/6ef40afce5ec4349a33a6d86b2e8c75d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-26 00:12:44.627745 | 2026-08-26 00:12:44.627810 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-26 00:12:44.653655 | instance | skipping: Conditional result was False 2026-08-26 00:12:44.662962 | 2026-08-26 00:12:44.663049 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-26 00:12:45.112654 | instance | changed 2026-08-26 00:12:45.119093 | 2026-08-26 00:12:45.119160 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-26 00:12:45.303194 | instance | ok 2026-08-26 00:12:45.309915 | 2026-08-26 00:12:45.310005 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-26 00:12:45.786838 | instance | changed 2026-08-26 00:12:45.793683 | 2026-08-26 00:12:45.793776 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-26 00:12:46.242994 | instance | changed 2026-08-26 00:12:46.253032 | 2026-08-26 00:12:46.253114 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-26 00:12:46.278079 | instance | skipping: Conditional result was False 2026-08-26 00:12:46.286071 | 2026-08-26 00:12:46.286215 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-26 00:12:46.666410 | instance -> localhost | changed 2026-08-26 00:12:46.683360 | 2026-08-26 00:12:46.683492 | TASK [add-build-sshkey : Add back temp key] 2026-08-26 00:12:47.003245 | instance -> localhost | Identity added: /var/lib/zuul/builds/6ef40afce5ec4349a33a6d86b2e8c75d/work/6ef40afce5ec4349a33a6d86b2e8c75d_id_rsa (zuul-build-sshkey) 2026-08-26 00:12:47.003556 | instance -> localhost | ok: Runtime: 0:00:00.013425 2026-08-26 00:12:47.010383 | 2026-08-26 00:12:47.010444 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-26 00:12:47.331487 | instance | ok 2026-08-26 00:12:47.336208 | 2026-08-26 00:12:47.336280 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-26 00:12:47.361386 | instance | skipping: Conditional result was False 2026-08-26 00:12:47.377514 | 2026-08-26 00:12:47.377658 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-08-26 00:12:47.727101 | instance | ok 2026-08-26 00:12:47.735539 | 2026-08-26 00:12:47.735663 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-08-26 00:12:51.094587 | instance | Output suppressed because no_log was given 2026-08-26 00:12:51.106544 | 2026-08-26 00:12:51.106613 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-08-26 00:12:51.308590 | instance | ok: "logs" 2026-08-26 00:12:51.308903 | instance | ok: All items complete 2026-08-26 00:12:51.308978 | 2026-08-26 00:12:51.467608 | instance | ok: "artifacts" 2026-08-26 00:12:51.615764 | instance | ok: "docs" 2026-08-26 00:12:51.634194 | 2026-08-26 00:12:51.634322 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-08-26 00:12:51.826703 | instance | changed: "logs" 2026-08-26 00:12:51.988031 | instance | changed: "artifacts" 2026-08-26 00:12:52.173415 | instance | changed: "docs" 2026-08-26 00:12:52.195750 | 2026-08-26 00:12:52.195864 | PLAY RECAP 2026-08-26 00:12:52.195911 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-08-26 00:12:52.195939 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-26 00:12:52.195961 | 2026-08-26 00:12:52.340079 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-26 00:12:52.342202 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-26 00:12:52.932493 | 2026-08-26 00:12:52.932614 | PLAY [all] 2026-08-26 00:12:52.944744 | 2026-08-26 00:12:52.944850 | TASK [setup-uv : Extract archive] 2026-08-26 00:12:55.482972 | instance | changed 2026-08-26 00:12:55.488708 | 2026-08-26 00:12:55.488791 | TASK [setup-uv : Print version] 2026-08-26 00:12:55.878636 | instance | uv 0.8.13 2026-08-26 00:12:56.026981 | instance | ok: Runtime: 0:00:00.015750 2026-08-26 00:12:56.037301 | 2026-08-26 00:12:56.037370 | TASK [Install Ansible collection siblings] 2026-08-26 00:13:05.215588 | instance | changed: 2026-08-26 00:13:05.215775 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-08-26 00:13:05.215805 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-08-26 00:13:05.215828 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-08-26 00:13:05.215848 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto 2026-08-26 00:13:05.215868 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general 2026-08-26 00:13:05.215891 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql 2026-08-26 00:13:05.215912 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-08-26 00:13:05.215933 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-08-26 00:13:05.215954 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-08-26 00:13:05.215974 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-08-26 00:13:05.215993 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-08-26 00:13:05.216012 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-08-26 00:13:05.216031 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0 2026-08-26 00:13:05.216050 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0 2026-08-26 00:13:05.216068 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0 2026-08-26 00:13:05.216087 | instance | Resolved community.crypto to 2.2.3 for 2.2.3 2026-08-26 00:13:05.216106 | instance | Resolved community.general to 7.3.0 for 7.3.0 2026-08-26 00:13:05.216125 | instance | Resolved community.mysql to 3.6.0 for 3.6.0 2026-08-26 00:13:05.216143 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0 2026-08-26 00:13:05.216161 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0 2026-08-26 00:13:05.216179 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.1.2 2026-08-26 00:13:05.216197 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0 2026-08-26 00:13:05.216216 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-08-26 00:13:05.216247 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0 2026-08-26 00:13:05.216267 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0 2026-08-26 00:13:05.216286 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-08-26 00:13:05.216304 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-08-26 00:13:05.216323 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-08-26 00:13:05.216340 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0 2026-08-26 00:13:05.216358 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3 2026-08-26 00:13:05.216377 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-08-26 00:13:05.216395 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-08-26 00:13:05.216414 | instance | Checked out ansible.netcommon to 1.2.0 2026-08-26 00:13:05.216432 | 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-26 00:13:05.216456 | instance | Starting galaxy collection install process 2026-08-26 00:13:05.216474 | instance | Process install dependency map 2026-08-26 00:13:05.216493 | instance | Starting collection install process 2026-08-26 00:13:05.216511 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon' 2026-08-26 00:13:05.216529 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon 2026-08-26 00:13:05.216547 | instance | ansible.netcommon:* was installed successfully 2026-08-26 00:13:05.216565 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-08-26 00:13:05.216582 | instance | Creating virtual environment at: .venv 2026-08-26 00:13:05.216600 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-08-26 00:13:05.216618 | instance | Downloading cryptography (4.2MiB) 2026-08-26 00:13:05.216636 | instance | Downloading pygments (1.2MiB) 2026-08-26 00:13:05.216655 | instance | Downloading setuptools (1.1MiB) 2026-08-26 00:13:05.216673 | instance | Downloading kubernetes (1.9MiB) 2026-08-26 00:13:05.216692 | instance | Downloading netaddr (2.2MiB) 2026-08-26 00:13:05.216710 | instance | Downloading ansible-core (2.1MiB) 2026-08-26 00:13:05.216729 | instance | Downloading rjsonnet (1.2MiB) 2026-08-26 00:13:05.216747 | instance | Downloading openstacksdk (1.7MiB) 2026-08-26 00:13:05.216766 | instance | Building pyperclip==1.9.0 2026-08-26 00:13:05.216783 | instance | Downloading setuptools 2026-08-26 00:13:05.216803 | instance | Downloading pygments 2026-08-26 00:13:05.216821 | instance | Downloading rjsonnet 2026-08-26 00:13:05.216840 | instance | Downloading netaddr 2026-08-26 00:13:05.216858 | instance | Downloading kubernetes 2026-08-26 00:13:05.216875 | instance | Downloading cryptography 2026-08-26 00:13:05.216893 | instance | Downloading ansible-core 2026-08-26 00:13:05.216911 | instance | Downloading openstacksdk 2026-08-26 00:13:05.216929 | instance | Built pyperclip==1.9.0 2026-08-26 00:13:05.216947 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-08-26 00:13:05.216987 | instance | Installed 79 packages in 34ms 2026-08-26 00:13:05.217007 | instance | Checked out ansible.posix to 1.6.0 2026-08-26 00:13:05.217025 | 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-26 00:13:05.217043 | instance | Starting galaxy collection install process 2026-08-26 00:13:05.217061 | instance | Process install dependency map 2026-08-26 00:13:05.217079 | instance | Starting collection install process 2026-08-26 00:13:05.217097 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-08-26 00:13:05.217120 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix 2026-08-26 00:13:05.217139 | instance | ansible.posix:1.6.0 was installed successfully 2026-08-26 00:13:05.217158 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 00:13:05.217176 | instance | 2.17.12 2026-08-26 00:13:05.217194 | instance | Checked out ansible.utils to v6.1.0 2026-08-26 00:13:05.217212 | 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-26 00:13:05.217231 | instance | Starting galaxy collection install process 2026-08-26 00:13:05.217250 | instance | Process install dependency map 2026-08-26 00:13:05.217268 | instance | Starting collection install process 2026-08-26 00:13:05.217286 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils' 2026-08-26 00:13:05.217305 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils 2026-08-26 00:13:05.217323 | instance | ansible.utils:6.1.0 was installed successfully 2026-08-26 00:13:05.217342 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 00:13:05.217360 | instance | 2.17.12 2026-08-26 00:13:05.217378 | instance | Checked out atmosphere.common to v0.7.0 2026-08-26 00:13:05.217396 | 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-26 00:13:05.217415 | instance | Starting galaxy collection install process 2026-08-26 00:13:05.217433 | instance | Process install dependency map 2026-08-26 00:13:05.217451 | instance | Starting collection install process 2026-08-26 00:13:05.217470 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common' 2026-08-26 00:13:05.217488 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common 2026-08-26 00:13:05.217507 | instance | atmosphere.common:0.7.0 was installed successfully 2026-08-26 00:13:05.217525 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 00:13:05.217543 | instance | 2.17.12 2026-08-26 00:13:05.217561 | instance | Checked out community.crypto to 2.2.3 2026-08-26 00:13:05.217591 | 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-26 00:13:05.217612 | instance | Starting galaxy collection install process 2026-08-26 00:13:05.217630 | instance | Process install dependency map 2026-08-26 00:13:05.217648 | instance | Starting collection install process 2026-08-26 00:13:05.217666 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-08-26 00:13:05.217685 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto 2026-08-26 00:13:05.217703 | instance | community.crypto:2.2.3 was installed successfully 2026-08-26 00:13:05.217722 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 00:13:05.217739 | instance | 2.17.12 2026-08-26 00:13:05.217757 | instance | Checked out community.general to 7.3.0 2026-08-26 00:13:05.217775 | 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-26 00:13:05.217793 | instance | Starting galaxy collection install process 2026-08-26 00:13:05.217815 | instance | Process install dependency map 2026-08-26 00:13:05.217834 | instance | Starting collection install process 2026-08-26 00:13:05.217852 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-08-26 00:13:05.217870 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general 2026-08-26 00:13:05.217889 | instance | community.general:7.3.0 was installed successfully 2026-08-26 00:13:05.217907 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 00:13:05.217926 | instance | 2.17.12 2026-08-26 00:13:05.217945 | instance | Checked out community.mysql to 3.6.0 2026-08-26 00:13:05.217963 | 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-26 00:13:05.217982 | instance | Starting galaxy collection install process 2026-08-26 00:13:05.218001 | instance | Process install dependency map 2026-08-26 00:13:05.218020 | instance | Starting collection install process 2026-08-26 00:13:05.218039 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql' 2026-08-26 00:13:05.218057 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql 2026-08-26 00:13:05.218074 | instance | community.mysql:3.6.0 was installed successfully 2026-08-26 00:13:05.218092 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 00:13:05.218110 | instance | 2.17.12 2026-08-26 00:13:05.218128 | instance | Checked out kubernetes.core to 2.4.0 2026-08-26 00:13:05.218146 | 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-26 00:13:05.218164 | instance | Starting galaxy collection install process 2026-08-26 00:13:05.218183 | instance | Process install dependency map 2026-08-26 00:13:05.218200 | instance | Starting collection install process 2026-08-26 00:13:05.218218 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core' 2026-08-26 00:13:05.218237 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core 2026-08-26 00:13:05.218255 | instance | kubernetes.core:2.4.0 was installed successfully 2026-08-26 00:13:05.218273 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 00:13:05.218291 | instance | 2.17.12 2026-08-26 00:13:05.218310 | instance | Checked out openstack.cloud to 2.6.0 2026-08-26 00:13:05.218328 | 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-26 00:13:05.218346 | instance | Starting galaxy collection install process 2026-08-26 00:13:05.218364 | instance | Process install dependency map 2026-08-26 00:13:05.218382 | instance | Starting collection install process 2026-08-26 00:13:05.218400 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud' 2026-08-26 00:13:05.218418 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud 2026-08-26 00:13:05.218435 | instance | openstack.cloud:2.6.0 was installed successfully 2026-08-26 00:13:05.218453 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 00:13:05.218470 | instance | 2.17.12 2026-08-26 00:13:05.218488 | instance | Checked out vexxhost.ceph to v4.2.0 2026-08-26 00:13:05.218506 | 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-26 00:13:05.218528 | instance | Starting galaxy collection install process 2026-08-26 00:13:05.218547 | instance | Process install dependency map 2026-08-26 00:13:05.218565 | instance | Starting collection install process 2026-08-26 00:13:05.218583 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph' 2026-08-26 00:13:05.218601 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph 2026-08-26 00:13:05.218619 | instance | vexxhost.ceph:4.2.0 was installed successfully 2026-08-26 00:13:05.218637 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 00:13:05.218655 | instance | 2.17.12 2026-08-26 00:13:05.218672 | instance | Checked out vexxhost.containers to v1.6.8 2026-08-26 00:13:05.218690 | 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-26 00:13:05.218708 | instance | Starting galaxy collection install process 2026-08-26 00:13:05.218726 | instance | Process install dependency map 2026-08-26 00:13:05.218744 | instance | Starting collection install process 2026-08-26 00:13:05.218762 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers' 2026-08-26 00:13:05.218780 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers 2026-08-26 00:13:05.218798 | instance | vexxhost.containers:1.6.8 was installed successfully 2026-08-26 00:13:05.218816 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 00:13:05.218834 | instance | 2.17.12 2026-08-26 00:13:05.218851 | instance | Checked out vexxhost.kubernetes to v3.3.0 2026-08-26 00:13:05.218870 | 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-26 00:13:05.218888 | instance | Starting galaxy collection install process 2026-08-26 00:13:05.218906 | instance | Process install dependency map 2026-08-26 00:13:05.218924 | instance | Starting collection install process 2026-08-26 00:13:05.218942 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes' 2026-08-26 00:13:05.218960 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes 2026-08-26 00:13:05.218979 | instance | vexxhost.kubernetes:3.3.0 was installed successfully 2026-08-26 00:13:05.218996 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 00:13:05.219014 | instance | 2.17.12 2026-08-26 00:13:05.224785 | 2026-08-26 00:13:05.224833 | PLAY RECAP 2026-08-26 00:13:05.224880 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-26 00:13:05.224900 | 2026-08-26 00:13:05.353705 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-26 00:13:05.358342 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-08-26 00:13:06.060408 | 2026-08-26 00:13:06.060578 | PLAY [all] 2026-08-26 00:13:06.071825 | 2026-08-26 00:13:06.071899 | TASK [Install "jq" for log collection] 2026-08-26 00:13:15.633408 | instance | changed 2026-08-26 00:13:15.635896 | 2026-08-26 00:13:15.635976 | PLAY RECAP 2026-08-26 00:13:15.636048 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-26 00:13:15.636117 | 2026-08-26 00:13:15.768205 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-08-26 00:13:15.773025 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-26 00:13:16.354569 | 2026-08-26 00:13:16.354698 | PLAY [all] 2026-08-26 00:13:16.365573 | 2026-08-26 00:13:16.365671 | LOOP [Check inventory directories] 2026-08-26 00:13:16.771719 | instance | ok: "src/github.com/vexxhost/atmosphere" 2026-08-26 00:13:16.945081 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory" 2026-08-26 00:13:17.106083 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory" 2026-08-26 00:13:17.119090 | 2026-08-26 00:13:17.119536 | LOOP [Copy inventory file for Zuul] 2026-08-26 00:13:17.955065 | instance | changed: 2026-08-26 00:13:17.955508 | instance | { 2026-08-26 00:13:17.955543 | instance | "ansible_loop_var": "item", 2026-08-26 00:13:17.955570 | instance | "changed": false, 2026-08-26 00:13:17.955594 | instance | "failed": false, 2026-08-26 00:13:17.955621 | instance | "invocation": { 2026-08-26 00:13:17.955644 | instance | "module_args": { 2026-08-26 00:13:17.955666 | instance | "checksum_algorithm": "sha1", 2026-08-26 00:13:17.955689 | instance | "follow": true, 2026-08-26 00:13:17.955711 | instance | "get_attributes": true, 2026-08-26 00:13:17.955735 | instance | "get_checksum": true, 2026-08-26 00:13:17.955757 | instance | "get_mime": true, 2026-08-26 00:13:17.955779 | instance | "path": "src/github.com/vexxhost/atmosphere" 2026-08-26 00:13:17.955801 | instance | } 2026-08-26 00:13:17.955823 | instance | }, 2026-08-26 00:13:17.955843 | instance | "item": "src/github.com/vexxhost/atmosphere", 2026-08-26 00:13:17.955864 | instance | "stat": { 2026-08-26 00:13:17.955884 | instance | "atime": 1787703177.8602986, 2026-08-26 00:13:17.955906 | instance | "attr_flags": "e", 2026-08-26 00:13:17.955927 | instance | "attributes": [ 2026-08-26 00:13:17.956133 | instance | "extents" 2026-08-26 00:13:17.956251 | instance | ], 2026-08-26 00:13:17.957032 | instance | "block_size": 4096, 2026-08-26 00:13:17.957579 | instance | "blocks": 8, 2026-08-26 00:13:17.957749 | instance | "charset": "unknown", 2026-08-26 00:13:17.958088 | instance | "ctime": 1787703176.8562875, 2026-08-26 00:13:17.958292 | instance | "dev": 64513, 2026-08-26 00:13:17.958408 | instance | "device_type": 0, 2026-08-26 00:13:17.958657 | instance | "executable": true, 2026-08-26 00:13:17.958790 | instance | "exists": true, 2026-08-26 00:13:17.958945 | instance | "gid": 1000, 2026-08-26 00:13:17.959106 | instance | "gr_name": "zuul", 2026-08-26 00:13:17.959314 | instance | "inode": 1048403, 2026-08-26 00:13:17.959519 | instance | "isblk": false, 2026-08-26 00:13:17.959717 | instance | "ischr": false, 2026-08-26 00:13:17.959914 | instance | "isdir": true, 2026-08-26 00:13:17.960113 | instance | "isfifo": false, 2026-08-26 00:13:17.960489 | instance | "isgid": false, 2026-08-26 00:13:17.961063 | instance | "islnk": false, 2026-08-26 00:13:17.961248 | instance | "isreg": false, 2026-08-26 00:13:17.961355 | instance | "issock": false, 2026-08-26 00:13:17.961493 | instance | "isuid": false, 2026-08-26 00:13:17.961597 | instance | "mimetype": "unknown", 2026-08-26 00:13:17.961737 | instance | "mode": "0755", 2026-08-26 00:13:17.961843 | instance | "mtime": 1787703176.8562875, 2026-08-26 00:13:17.961945 | instance | "nlink": 21, 2026-08-26 00:13:17.961975 | instance | "path": "src/github.com/vexxhost/atmosphere", 2026-08-26 00:13:17.961995 | instance | "pw_name": "zuul", 2026-08-26 00:13:17.962697 | instance | "readable": true, 2026-08-26 00:13:17.962869 | instance | "rgrp": true, 2026-08-26 00:13:17.962911 | instance | "roth": true, 2026-08-26 00:13:17.962980 | instance | "rusr": true, 2026-08-26 00:13:17.963196 | instance | "size": 4096, 2026-08-26 00:13:17.963233 | instance | "uid": 1000, 2026-08-26 00:13:17.963463 | instance | "version": "1825427397", 2026-08-26 00:13:17.963782 | instance | "wgrp": false, 2026-08-26 00:13:17.964250 | instance | "woth": false, 2026-08-26 00:13:17.964344 | instance | "writeable": true, 2026-08-26 00:13:17.964557 | instance | "wusr": true, 2026-08-26 00:13:17.964629 | instance | "xgrp": true, 2026-08-26 00:13:17.964820 | instance | "xoth": true, 2026-08-26 00:13:17.964867 | instance | "xusr": true 2026-08-26 00:13:17.964890 | instance | } 2026-08-26 00:13:17.964985 | instance | } 2026-08-26 00:13:17.965218 | instance | ok: All items complete 2026-08-26 00:13:17.965256 | 2026-08-26 00:13:17.968345 | instance | skipping: Conditional result was False 2026-08-26 00:13:17.969659 | instance | skipping: Conditional result was False 2026-08-26 00:13:17.980795 | 2026-08-26 00:13:17.980987 | LOOP [Switch "ansible_host" to private IP] 2026-08-26 00:13:18.325455 | instance | changed: 1 replacements made 2026-08-26 00:13:18.328031 | instance | skipping: Conditional result was False 2026-08-26 00:13:18.332020 | instance | skipping: Conditional result was False 2026-08-26 00:13:18.341133 | 2026-08-26 00:13:18.530716 | TASK [Run Molecule scenario] 2026-08-26 00:13:19.449003 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-08-26 00:13:19.830342 | instance | INFO [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-08-26 00:13:19.830405 | instance | INFO [csi > prerun] Performing prerun with role_name_check=0... 2026-08-26 00:13:30.491188 | instance | INFO [csi > dependency] Executing 2026-08-26 00:13:30.491265 | instance | WARNING [csi > dependency] Missing roles requirements file: requirements.yml 2026-08-26 00:13:30.491476 | instance | WARNING [csi > dependency] Missing collections requirements file: collections.yml 2026-08-26 00:13:30.491585 | instance | WARNING [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-08-26 00:13:30.499220 | instance | INFO [csi > cleanup] Executing 2026-08-26 00:13:30.499702 | instance | WARNING [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-26 00:13:30.508950 | instance | INFO [csi > destroy] Executing 2026-08-26 00:13:30.508992 | instance | WARNING [csi > destroy] Skipping, '--destroy=never' requested. 2026-08-26 00:13:30.509052 | instance | INFO [csi > destroy] Executed: Successful 2026-08-26 00:13:30.519034 | instance | INFO [csi > syntax] Executing 2026-08-26 00:13:32.151346 | instance | 2026-08-26 00:13:32.151589 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-08-26 00:13:32.209424 | instance | INFO [csi > syntax] Executed: Successful 2026-08-26 00:13:32.225614 | instance | INFO [csi > create] Executing 2026-08-26 00:13:32.228458 | instance | WARNING [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-26 00:13:32.239899 | instance | INFO [csi > prepare] Executing 2026-08-26 00:13:33.005489 | instance | 2026-08-26 00:13:33.005704 | instance | PLAY [Prepare] ***************************************************************** 2026-08-26 00:13:33.005958 | instance | 2026-08-26 00:13:33.006235 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-26 00:13:33.006509 | instance | Wednesday 26 August 2026 00:13:32 +0000 (0:00:00.027) 0:00:00.027 ****** 2026-08-26 00:13:34.147843 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-08-26 00:13:34.148075 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-08-26 00:13:34.148347 | instance | interpreter could change the meaning of that path. See 2026-08-26 00:13:34.148689 | instance | https://docs.ansible.com/ansible- 2026-08-26 00:13:34.148988 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-08-26 00:13:34.160147 | instance | ok: [instance] 2026-08-26 00:13:34.160436 | instance | 2026-08-26 00:13:34.160711 | instance | TASK [Configure short hostname] ************************************************ 2026-08-26 00:13:34.160978 | instance | Wednesday 26 August 2026 00:13:34 +0000 (0:00:01.155) 0:00:01.182 ****** 2026-08-26 00:13:34.789841 | instance | changed: [instance] 2026-08-26 00:13:34.790083 | instance | 2026-08-26 00:13:34.790362 | instance | TASK [Ensure hostname inside hosts file] *************************************** 2026-08-26 00:13:34.790633 | instance | Wednesday 26 August 2026 00:13:34 +0000 (0:00:00.629) 0:00:01.811 ****** 2026-08-26 00:13:35.035273 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created 2026-08-26 00:13:35.035496 | instance | with a mode of 0700, this may cause issues when running as another user. To 2026-08-26 00:13:35.035760 | instance | avoid this, create the remote_tmp dir with the correct permissions manually 2026-08-26 00:13:35.045567 | instance | changed: [instance] 2026-08-26 00:13:35.045816 | instance | 2026-08-26 00:13:35.046087 | instance | TASK [Purge "snapd" package] *************************************************** 2026-08-26 00:13:35.046373 | instance | Wednesday 26 August 2026 00:13:35 +0000 (0:00:00.255) 0:00:02.067 ****** 2026-08-26 00:13:35.786406 | instance | ok: [instance] 2026-08-26 00:13:35.786692 | instance | 2026-08-26 00:13:35.787066 | instance | PLAY [Create devices for Ceph] ************************************************* 2026-08-26 00:13:35.787418 | instance | 2026-08-26 00:13:35.787827 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-26 00:13:35.788216 | instance | Wednesday 26 August 2026 00:13:35 +0000 (0:00:00.741) 0:00:02.808 ****** 2026-08-26 00:13:36.442478 | instance | ok: [instance] 2026-08-26 00:13:36.442792 | instance | 2026-08-26 00:13:36.443144 | instance | TASK [Install depedencies] ***************************************************** 2026-08-26 00:13:36.443456 | instance | Wednesday 26 August 2026 00:13:36 +0000 (0:00:00.655) 0:00:03.464 ****** 2026-08-26 00:13:56.146051 | instance | changed: [instance] 2026-08-26 00:13:56.146318 | instance | 2026-08-26 00:13:56.146599 | instance | TASK [Start up service] ******************************************************** 2026-08-26 00:13:56.146872 | instance | Wednesday 26 August 2026 00:13:56 +0000 (0:00:19.703) 0:00:23.168 ****** 2026-08-26 00:13:56.703478 | instance | ok: [instance] 2026-08-26 00:13:56.703858 | instance | 2026-08-26 00:13:56.704253 | instance | TASK [Generate lvm.conf] ******************************************************* 2026-08-26 00:13:56.704679 | instance | Wednesday 26 August 2026 00:13:56 +0000 (0:00:00.557) 0:00:23.725 ****** 2026-08-26 00:13:56.995174 | instance | ok: [instance] 2026-08-26 00:13:56.995456 | instance | 2026-08-26 00:13:56.995759 | instance | TASK [Write /etc/lvm/lvm.conf] ************************************************* 2026-08-26 00:13:56.996084 | instance | Wednesday 26 August 2026 00:13:56 +0000 (0:00:00.291) 0:00:24.017 ****** 2026-08-26 00:13:57.645289 | instance | changed: [instance] 2026-08-26 00:13:57.645529 | instance | 2026-08-26 00:13:57.645796 | instance | TASK [Get list of all loopback devices] **************************************** 2026-08-26 00:13:57.646064 | instance | Wednesday 26 August 2026 00:13:57 +0000 (0:00:00.650) 0:00:24.667 ****** 2026-08-26 00:13:57.838783 | instance | ok: [instance] 2026-08-26 00:13:57.838993 | instance | 2026-08-26 00:13:57.839278 | instance | TASK [Fail if there is any existing loopback devices] ************************** 2026-08-26 00:13:57.839562 | instance | Wednesday 26 August 2026 00:13:57 +0000 (0:00:00.193) 0:00:24.860 ****** 2026-08-26 00:13:57.862124 | instance | skipping: [instance] 2026-08-26 00:13:57.862362 | instance | 2026-08-26 00:13:57.862616 | instance | TASK [Create devices for Ceph] ************************************************* 2026-08-26 00:13:57.862906 | instance | Wednesday 26 August 2026 00:13:57 +0000 (0:00:00.023) 0:00:24.884 ****** 2026-08-26 00:13:58.410677 | instance | changed: [instance] => (item=osd0) 2026-08-26 00:13:58.410950 | instance | changed: [instance] => (item=osd1) 2026-08-26 00:13:58.411234 | instance | changed: [instance] => (item=osd2) 2026-08-26 00:13:58.411506 | instance | 2026-08-26 00:13:58.411791 | instance | TASK [Set permissions on loopback devices] ************************************* 2026-08-26 00:13:58.412092 | instance | Wednesday 26 August 2026 00:13:58 +0000 (0:00:00.548) 0:00:25.432 ****** 2026-08-26 00:13:59.026953 | instance | changed: [instance] => (item=osd0) 2026-08-26 00:13:59.027001 | instance | changed: [instance] => (item=osd1) 2026-08-26 00:13:59.027013 | instance | changed: [instance] => (item=osd2) 2026-08-26 00:13:59.027023 | instance | 2026-08-26 00:13:59.027033 | instance | TASK [Start loop devices] ****************************************************** 2026-08-26 00:13:59.027042 | instance | Wednesday 26 August 2026 00:13:59 +0000 (0:00:00.614) 0:00:26.047 ****** 2026-08-26 00:13:59.740639 | instance | changed: [instance] => (item=osd0) 2026-08-26 00:13:59.741512 | instance | changed: [instance] => (item=osd1) 2026-08-26 00:13:59.741560 | instance | changed: [instance] => (item=osd2) 2026-08-26 00:13:59.741568 | instance | 2026-08-26 00:13:59.741575 | instance | TASK [Create a volume group for each loop device] ****************************** 2026-08-26 00:13:59.741582 | instance | Wednesday 26 August 2026 00:13:59 +0000 (0:00:00.715) 0:00:26.762 ****** 2026-08-26 00:14:03.091945 | instance | changed: [instance] => (item=osd0) 2026-08-26 00:14:03.092035 | instance | changed: [instance] => (item=osd1) 2026-08-26 00:14:03.092536 | instance | changed: [instance] => (item=osd2) 2026-08-26 00:14:03.092639 | instance | 2026-08-26 00:14:03.092652 | instance | TASK [Create a logical volume for each loop device] **************************** 2026-08-26 00:14:03.092672 | instance | Wednesday 26 August 2026 00:14:03 +0000 (0:00:03.351) 0:00:30.114 ****** 2026-08-26 00:14:05.004590 | instance | changed: [instance] => (item=ceph-instance-osd0) 2026-08-26 00:14:05.004686 | instance | changed: [instance] => (item=ceph-instance-osd1) 2026-08-26 00:14:05.004731 | instance | changed: [instance] => (item=ceph-instance-osd2) 2026-08-26 00:14:05.005293 | instance | 2026-08-26 00:14:05.005359 | instance | PLAY RECAP ********************************************************************* 2026-08-26 00:14:05.005372 | instance | instance : ok=15 changed=9 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-08-26 00:14:05.005389 | instance | 2026-08-26 00:14:05.007897 | instance | Wednesday 26 August 2026 00:14:04 +0000 (0:00:01.912) 0:00:32.026 ****** 2026-08-26 00:14:05.007964 | instance | =============================================================================== 2026-08-26 00:14:05.007976 | instance | Install depedencies ---------------------------------------------------- 19.70s 2026-08-26 00:14:05.007987 | instance | Create a volume group for each loop device ------------------------------ 3.35s 2026-08-26 00:14:05.007997 | instance | Create a logical volume for each loop device ---------------------------- 1.91s 2026-08-26 00:14:05.008007 | instance | Gathering Facts --------------------------------------------------------- 1.16s 2026-08-26 00:14:05.008017 | instance | Purge "snapd" package --------------------------------------------------- 0.74s 2026-08-26 00:14:05.008027 | instance | Start loop devices ------------------------------------------------------ 0.72s 2026-08-26 00:14:05.008037 | instance | Gathering Facts --------------------------------------------------------- 0.66s 2026-08-26 00:14:05.008047 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.65s 2026-08-26 00:14:05.008057 | instance | Configure short hostname ------------------------------------------------ 0.63s 2026-08-26 00:14:05.008066 | instance | Set permissions on loopback devices ------------------------------------- 0.61s 2026-08-26 00:14:05.008076 | instance | Start up service -------------------------------------------------------- 0.56s 2026-08-26 00:14:05.008086 | instance | Create devices for Ceph ------------------------------------------------- 0.55s 2026-08-26 00:14:05.008103 | instance | Generate lvm.conf ------------------------------------------------------- 0.29s 2026-08-26 00:14:05.008116 | instance | Ensure hostname inside hosts file --------------------------------------- 0.26s 2026-08-26 00:14:05.008344 | instance | Get list of all loopback devices ---------------------------------------- 0.19s 2026-08-26 00:14:05.008680 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s 2026-08-26 00:14:05.085361 | instance | INFO [csi > prepare] Executed: Successful 2026-08-26 00:14:05.102370 | instance | INFO [csi > converge] Executing 2026-08-26 00:14:06.572739 | instance | 2026-08-26 00:14:06.573150 | instance | PLAY [Debug CSI driver value] ************************************************** 2026-08-26 00:14:06.573465 | instance | 2026-08-26 00:14:06.573789 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-26 00:14:06.574159 | instance | Wednesday 26 August 2026 00:14:06 +0000 (0:00:00.007) 0:00:00.007 ****** 2026-08-26 00:14:07.572483 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-08-26 00:14:07.572683 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-08-26 00:14:07.572703 | instance | interpreter could change the meaning of that path. See 2026-08-26 00:14:07.572743 | instance | https://docs.ansible.com/ansible- 2026-08-26 00:14:07.573016 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-08-26 00:14:07.583830 | instance | ok: [instance] 2026-08-26 00:14:07.583987 | instance | 2026-08-26 00:14:07.584167 | instance | TASK [Display CSI driver value and environment variable] *********************** 2026-08-26 00:14:07.584352 | instance | Wednesday 26 August 2026 00:14:07 +0000 (0:00:01.011) 0:00:01.019 ****** 2026-08-26 00:14:07.631825 | instance | ok: [instance] => { 2026-08-26 00:14:07.632161 | instance | "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER=" 2026-08-26 00:14:07.632536 | instance | } 2026-08-26 00:14:07.632797 | instance | 2026-08-26 00:14:07.633082 | instance | PLAY [all] ********************************************************************* 2026-08-26 00:14:07.633438 | instance | 2026-08-26 00:14:07.633814 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-26 00:14:07.634171 | instance | Wednesday 26 August 2026 00:14:07 +0000 (0:00:00.047) 0:00:01.066 ****** 2026-08-26 00:14:08.517479 | instance | ok: [instance] 2026-08-26 00:14:08.517706 | instance | 2026-08-26 00:14:08.517987 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-08-26 00:14:08.518262 | instance | Wednesday 26 August 2026 00:14:08 +0000 (0:00:00.885) 0:00:01.952 ****** 2026-08-26 00:14:08.700091 | instance | ok: [instance] 2026-08-26 00:14:08.700549 | instance | 2026-08-26 00:14:08.700903 | instance | PLAY [Deploy Ceph monitors & managers] ***************************************** 2026-08-26 00:14:08.701212 | instance | 2026-08-26 00:14:08.701537 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-26 00:14:08.701968 | instance | Wednesday 26 August 2026 00:14:08 +0000 (0:00:00.182) 0:00:02.135 ****** 2026-08-26 00:14:09.565109 | instance | ok: [instance] 2026-08-26 00:14:09.565180 | instance | 2026-08-26 00:14:09.565327 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-26 00:14:09.565547 | instance | Wednesday 26 August 2026 00:14:09 +0000 (0:00:00.862) 0:00:02.997 ****** 2026-08-26 00:14:09.852947 | instance | ok: [instance] 2026-08-26 00:14:09.853028 | instance | 2026-08-26 00:14:09.853153 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-26 00:14:09.853345 | instance | Wednesday 26 August 2026 00:14:09 +0000 (0:00:00.290) 0:00:03.288 ****** 2026-08-26 00:14:09.899881 | instance | skipping: [instance] 2026-08-26 00:14:09.900083 | instance | 2026-08-26 00:14:09.901919 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-08-26 00:14:09.901933 | instance | Wednesday 26 August 2026 00:14:09 +0000 (0:00:00.044) 0:00:03.332 ****** 2026-08-26 00:14:10.230751 | instance | changed: [instance] 2026-08-26 00:14:10.231176 | instance | 2026-08-26 00:14:10.231699 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-26 00:14:10.232070 | instance | Wednesday 26 August 2026 00:14:10 +0000 (0:00:00.333) 0:00:03.665 ****** 2026-08-26 00:14:10.297902 | instance | ok: [instance] => { 2026-08-26 00:14:10.298300 | instance | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-08-26 00:14:10.298622 | instance | } 2026-08-26 00:14:10.298933 | instance | 2026-08-26 00:14:10.299286 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-26 00:14:10.299655 | instance | Wednesday 26 August 2026 00:14:10 +0000 (0:00:00.067) 0:00:03.733 ****** 2026-08-26 00:14:10.990840 | instance | changed: [instance] 2026-08-26 00:14:10.991345 | instance | 2026-08-26 00:14:10.991797 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-26 00:14:10.992200 | instance | Wednesday 26 August 2026 00:14:10 +0000 (0:00:00.692) 0:00:04.426 ****** 2026-08-26 00:14:11.037206 | instance | skipping: [instance] 2026-08-26 00:14:11.037593 | instance | 2026-08-26 00:14:11.037975 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-26 00:14:11.038329 | instance | Wednesday 26 August 2026 00:14:11 +0000 (0:00:00.046) 0:00:04.472 ****** 2026-08-26 00:14:11.082079 | instance | skipping: [instance] 2026-08-26 00:14:11.082494 | instance | 2026-08-26 00:14:11.082852 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-26 00:14:11.083347 | instance | Wednesday 26 August 2026 00:14:11 +0000 (0:00:00.044) 0:00:04.516 ****** 2026-08-26 00:14:11.307354 | instance | ok: [instance] 2026-08-26 00:14:11.307743 | instance | 2026-08-26 00:14:11.308088 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-26 00:14:11.308436 | instance | Wednesday 26 August 2026 00:14:11 +0000 (0:00:00.225) 0:00:04.742 ****** 2026-08-26 00:14:12.612009 | instance | ok: [instance] 2026-08-26 00:14:12.612533 | instance | 2026-08-26 00:14:12.612911 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-26 00:14:12.613249 | instance | Wednesday 26 August 2026 00:14:12 +0000 (0:00:01.304) 0:00:06.046 ****** 2026-08-26 00:14:12.679969 | instance | ok: [instance] => { 2026-08-26 00:14:12.680258 | instance | "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz" 2026-08-26 00:14:12.680425 | instance | } 2026-08-26 00:14:12.680641 | instance | 2026-08-26 00:14:12.680795 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-26 00:14:12.680941 | instance | Wednesday 26 August 2026 00:14:12 +0000 (0:00:00.066) 0:00:06.113 ****** 2026-08-26 00:14:13.876331 | instance | changed: [instance] 2026-08-26 00:14:13.876773 | instance | 2026-08-26 00:14:13.877152 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-26 00:14:13.877565 | instance | Wednesday 26 August 2026 00:14:13 +0000 (0:00:01.198) 0:00:07.311 ****** 2026-08-26 00:14:16.705758 | instance | changed: [instance] 2026-08-26 00:14:16.706159 | instance | 2026-08-26 00:14:16.706513 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-08-26 00:14:16.706852 | instance | Wednesday 26 August 2026 00:14:16 +0000 (0:00:02.829) 0:00:10.140 ****** 2026-08-26 00:14:16.736931 | instance | skipping: [instance] 2026-08-26 00:14:16.737043 | instance | 2026-08-26 00:14:16.737235 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-08-26 00:14:16.737407 | instance | Wednesday 26 August 2026 00:14:16 +0000 (0:00:00.031) 0:00:10.171 ****** 2026-08-26 00:14:16.764935 | instance | skipping: [instance] 2026-08-26 00:14:16.765339 | instance | 2026-08-26 00:14:16.765508 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-08-26 00:14:16.765700 | instance | Wednesday 26 August 2026 00:14:16 +0000 (0:00:00.026) 0:00:10.198 ****** 2026-08-26 00:14:16.796303 | instance | skipping: [instance] 2026-08-26 00:14:16.796524 | instance | 2026-08-26 00:14:16.796688 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-08-26 00:14:16.796856 | instance | Wednesday 26 August 2026 00:14:16 +0000 (0:00:00.030) 0:00:10.229 ****** 2026-08-26 00:14:22.357082 | instance | changed: [instance] 2026-08-26 00:14:22.357517 | instance | 2026-08-26 00:14:22.357863 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] *** 2026-08-26 00:14:22.358189 | instance | Wednesday 26 August 2026 00:14:22 +0000 (0:00:05.562) 0:00:15.792 ****** 2026-08-26 00:14:22.948807 | instance | changed: [instance] 2026-08-26 00:14:22.949182 | instance | 2026-08-26 00:14:22.949538 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] ******* 2026-08-26 00:14:22.949861 | instance | Wednesday 26 August 2026 00:14:22 +0000 (0:00:00.591) 0:00:16.384 ****** 2026-08-26 00:14:23.895482 | instance | changed: [instance] => (item={'path': '/etc/containerd'}) 2026-08-26 00:14:23.895552 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'}) 2026-08-26 00:14:23.895565 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'}) 2026-08-26 00:14:23.895574 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'}) 2026-08-26 00:14:23.895585 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'}) 2026-08-26 00:14:23.895594 | instance | 2026-08-26 00:14:23.895610 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] ********** 2026-08-26 00:14:23.895620 | instance | Wednesday 26 August 2026 00:14:23 +0000 (0:00:00.944) 0:00:17.328 ****** 2026-08-26 00:14:24.550483 | instance | changed: [instance] 2026-08-26 00:14:24.552313 | instance | 2026-08-26 00:14:24.552370 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ******** 2026-08-26 00:14:24.552379 | instance | Wednesday 26 August 2026 00:14:24 +0000 (0:00:00.631) 0:00:17.960 ****** 2026-08-26 00:14:24.552385 | instance | 2026-08-26 00:14:24.552391 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-08-26 00:14:24.552422 | instance | Wednesday 26 August 2026 00:14:24 +0000 (0:00:00.024) 0:00:17.984 ****** 2026-08-26 00:14:25.538969 | instance | ok: [instance] 2026-08-26 00:14:25.539070 | instance | 2026-08-26 00:14:25.539184 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] ********** 2026-08-26 00:14:25.539343 | instance | Wednesday 26 August 2026 00:14:25 +0000 (0:00:00.989) 0:00:18.974 ****** 2026-08-26 00:14:25.978654 | instance | changed: [instance] 2026-08-26 00:14:25.978787 | instance | 2026-08-26 00:14:25.978853 | instance | TASK [vexxhost.containers.containerd : Enable and start service] *************** 2026-08-26 00:14:25.978991 | instance | Wednesday 26 August 2026 00:14:25 +0000 (0:00:00.439) 0:00:19.414 ****** 2026-08-26 00:14:26.549487 | instance | changed: [instance] 2026-08-26 00:14:26.549591 | instance | 2026-08-26 00:14:26.549877 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-26 00:14:26.549944 | instance | Wednesday 26 August 2026 00:14:26 +0000 (0:00:00.570) 0:00:19.984 ****** 2026-08-26 00:14:26.759207 | instance | ok: [instance] 2026-08-26 00:14:26.759277 | instance | 2026-08-26 00:14:26.759541 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-26 00:14:26.759588 | instance | Wednesday 26 August 2026 00:14:26 +0000 (0:00:00.209) 0:00:20.194 ****** 2026-08-26 00:14:26.826503 | instance | ok: [instance] => { 2026-08-26 00:14:26.827266 | instance | "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz" 2026-08-26 00:14:26.827336 | instance | } 2026-08-26 00:14:26.827343 | instance | 2026-08-26 00:14:26.827348 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-26 00:14:26.827353 | instance | Wednesday 26 August 2026 00:14:26 +0000 (0:00:00.066) 0:00:20.261 ****** 2026-08-26 00:14:27.756417 | instance | changed: [instance] 2026-08-26 00:14:27.756500 | instance | 2026-08-26 00:14:27.756811 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-26 00:14:27.756870 | instance | Wednesday 26 August 2026 00:14:27 +0000 (0:00:00.930) 0:00:21.191 ****** 2026-08-26 00:14:32.085405 | instance | changed: [instance] 2026-08-26 00:14:32.085882 | instance | 2026-08-26 00:14:32.085903 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ****************** 2026-08-26 00:14:32.085911 | instance | Wednesday 26 August 2026 00:14:32 +0000 (0:00:04.329) 0:00:25.520 ****** 2026-08-26 00:14:33.234546 | instance | ok: [instance] 2026-08-26 00:14:33.234634 | instance | 2026-08-26 00:14:33.234870 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] *************** 2026-08-26 00:14:33.235038 | instance | Wednesday 26 August 2026 00:14:33 +0000 (0:00:01.148) 0:00:26.669 ****** 2026-08-26 00:14:33.593362 | instance | changed: [instance] 2026-08-26 00:14:33.593449 | instance | 2026-08-26 00:14:33.593720 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] ***** 2026-08-26 00:14:33.593769 | instance | Wednesday 26 August 2026 00:14:33 +0000 (0:00:00.359) 0:00:27.028 ****** 2026-08-26 00:14:34.058180 | instance | changed: [instance] 2026-08-26 00:14:34.058253 | instance | 2026-08-26 00:14:34.058528 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] *********** 2026-08-26 00:14:34.058574 | instance | Wednesday 26 August 2026 00:14:34 +0000 (0:00:00.465) 0:00:27.493 ****** 2026-08-26 00:14:34.615406 | instance | changed: [instance] => (item={'path': '/etc/docker'}) 2026-08-26 00:14:34.615491 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'}) 2026-08-26 00:14:34.616014 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'}) 2026-08-26 00:14:34.616057 | instance | 2026-08-26 00:14:34.616063 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ****** 2026-08-26 00:14:34.616068 | instance | Wednesday 26 August 2026 00:14:34 +0000 (0:00:00.557) 0:00:28.050 ****** 2026-08-26 00:14:35.062456 | instance | changed: [instance] 2026-08-26 00:14:35.062584 | instance | 2026-08-26 00:14:35.062835 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] *********** 2026-08-26 00:14:35.062851 | instance | Wednesday 26 August 2026 00:14:35 +0000 (0:00:00.447) 0:00:28.498 ****** 2026-08-26 00:14:35.503728 | instance | changed: [instance] 2026-08-26 00:14:35.503800 | instance | 2026-08-26 00:14:35.504427 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************ 2026-08-26 00:14:35.504469 | instance | Wednesday 26 August 2026 00:14:35 +0000 (0:00:00.424) 0:00:28.922 ****** 2026-08-26 00:14:35.504475 | instance | 2026-08-26 00:14:35.504480 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-08-26 00:14:35.504484 | instance | Wednesday 26 August 2026 00:14:35 +0000 (0:00:00.016) 0:00:28.939 ****** 2026-08-26 00:14:36.186307 | instance | ok: [instance] 2026-08-26 00:14:36.186717 | instance | 2026-08-26 00:14:36.186732 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ****************** 2026-08-26 00:14:36.186744 | instance | Wednesday 26 August 2026 00:14:36 +0000 (0:00:00.682) 0:00:29.621 ****** 2026-08-26 00:14:36.994787 | instance | changed: [instance] 2026-08-26 00:14:36.994882 | instance | 2026-08-26 00:14:36.995113 | instance | TASK [vexxhost.containers.docker : Enable and start service] ******************* 2026-08-26 00:14:36.995161 | instance | Wednesday 26 August 2026 00:14:36 +0000 (0:00:00.808) 0:00:30.430 ****** 2026-08-26 00:14:37.560433 | instance | changed: [instance] 2026-08-26 00:14:37.560518 | instance | 2026-08-26 00:14:37.560803 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ****** 2026-08-26 00:14:37.560841 | instance | Wednesday 26 August 2026 00:14:37 +0000 (0:00:00.565) 0:00:30.995 ****** 2026-08-26 00:14:37.613082 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml) 2026-08-26 00:14:37.613712 | instance | 2026-08-26 00:14:37.613768 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ******************************** 2026-08-26 00:14:37.613777 | instance | Wednesday 26 August 2026 00:14:37 +0000 (0:00:00.052) 0:00:31.048 ****** 2026-08-26 00:14:42.114717 | instance | changed: [instance] 2026-08-26 00:14:42.114782 | instance | 2026-08-26 00:14:42.115089 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] ********************* 2026-08-26 00:14:42.115137 | instance | Wednesday 26 August 2026 00:14:42 +0000 (0:00:04.502) 0:00:35.550 ****** 2026-08-26 00:14:42.752221 | instance | ok: [instance] => (item=chronyd) 2026-08-26 00:14:42.752301 | instance | ok: [instance] => (item=sshd) 2026-08-26 00:14:42.752617 | instance | 2026-08-26 00:14:42.752739 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ****************************** 2026-08-26 00:14:42.752752 | instance | Wednesday 26 August 2026 00:14:42 +0000 (0:00:00.637) 0:00:36.187 ****** 2026-08-26 00:14:43.053406 | instance | changed: [instance] 2026-08-26 00:14:43.053508 | instance | 2026-08-26 00:14:43.053736 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ******************** 2026-08-26 00:14:43.053786 | instance | Wednesday 26 August 2026 00:14:43 +0000 (0:00:00.301) 0:00:36.488 ****** 2026-08-26 00:14:43.260479 | instance | ok: [instance] 2026-08-26 00:14:43.260992 | instance | 2026-08-26 00:14:43.261016 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] **************** 2026-08-26 00:14:43.261024 | instance | Wednesday 26 August 2026 00:14:43 +0000 (0:00:00.207) 0:00:36.695 ****** 2026-08-26 00:14:43.717139 | instance | changed: [instance] 2026-08-26 00:14:43.717258 | instance | 2026-08-26 00:14:43.717528 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] *** 2026-08-26 00:14:43.717576 | instance | Wednesday 26 August 2026 00:14:43 +0000 (0:00:00.456) 0:00:37.152 ****** 2026-08-26 00:14:44.047381 | instance | changed: [instance] 2026-08-26 00:14:44.047456 | instance | 2026-08-26 00:14:44.047735 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] ************************* 2026-08-26 00:14:44.047787 | instance | Wednesday 26 August 2026 00:14:44 +0000 (0:00:00.330) 0:00:37.482 ****** 2026-08-26 00:14:44.157658 | instance | ok: [instance] 2026-08-26 00:14:44.157742 | instance | 2026-08-26 00:14:44.157949 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] ******************* 2026-08-26 00:14:44.157994 | instance | Wednesday 26 August 2026 00:14:44 +0000 (0:00:00.110) 0:00:37.593 ****** 2026-08-26 00:14:44.377898 | instance | ok: [instance] => (item=instance) 2026-08-26 00:14:44.378000 | instance | 2026-08-26 00:14:44.378069 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ******** 2026-08-26 00:14:44.378222 | instance | Wednesday 26 August 2026 00:14:44 +0000 (0:00:00.220) 0:00:37.813 ****** 2026-08-26 00:14:44.430518 | instance | ok: [instance] 2026-08-26 00:14:44.430617 | instance | 2026-08-26 00:14:44.430883 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] *********************************** 2026-08-26 00:14:44.430931 | instance | Wednesday 26 August 2026 00:14:44 +0000 (0:00:00.052) 0:00:37.865 ****** 2026-08-26 00:14:44.507796 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance 2026-08-26 00:14:44.507898 | instance | 2026-08-26 00:14:44.508164 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] ************* 2026-08-26 00:14:44.508194 | instance | Wednesday 26 August 2026 00:14:44 +0000 (0:00:00.077) 0:00:37.943 ****** 2026-08-26 00:14:44.865644 | instance | changed: [instance] 2026-08-26 00:14:44.865768 | instance | 2026-08-26 00:14:44.865790 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ****************** 2026-08-26 00:14:44.865936 | instance | Wednesday 26 August 2026 00:14:44 +0000 (0:00:00.357) 0:00:38.301 ****** 2026-08-26 00:14:45.553055 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True}) 2026-08-26 00:14:45.553091 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0}) 2026-08-26 00:14:45.553097 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False}) 2026-08-26 00:14:45.553102 | instance | 2026-08-26 00:14:45.553107 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] ******************************* 2026-08-26 00:14:45.553111 | instance | Wednesday 26 August 2026 00:14:45 +0000 (0:00:00.686) 0:00:38.987 ****** 2026-08-26 00:16:15.038908 | instance | ok: [instance] 2026-08-26 00:16:15.038994 | instance | 2026-08-26 00:16:15.039244 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] *************** 2026-08-26 00:16:15.039260 | instance | Wednesday 26 August 2026 00:16:15 +0000 (0:01:29.486) 0:02:08.474 ****** 2026-08-26 00:16:15.254622 | instance | changed: [instance] 2026-08-26 00:16:15.254700 | instance | 2026-08-26 00:16:15.254916 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] ********************************** 2026-08-26 00:16:15.263072 | instance | Wednesday 26 August 2026 00:16:15 +0000 (0:00:00.215) 0:02:08.690 ****** 2026-08-26 00:16:15.336494 | instance | ok: [instance] 2026-08-26 00:16:15.336561 | instance | 2026-08-26 00:16:15.336711 | instance | TASK [Install Ceph host] ******************************************************* 2026-08-26 00:16:15.336840 | instance | Wednesday 26 August 2026 00:16:15 +0000 (0:00:00.081) 0:02:08.771 ****** 2026-08-26 00:16:15.419756 | instance | included: vexxhost.ceph.cephadm_host for instance 2026-08-26 00:16:15.420055 | instance | 2026-08-26 00:16:15.420369 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ****** 2026-08-26 00:16:15.420696 | instance | Wednesday 26 August 2026 00:16:15 +0000 (0:00:00.083) 0:02:08.854 ****** 2026-08-26 00:16:17.003513 | instance | ok: [instance] 2026-08-26 00:16:17.003744 | instance | 2026-08-26 00:16:17.004036 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] *** 2026-08-26 00:16:17.004305 | instance | Wednesday 26 August 2026 00:16:17 +0000 (0:00:01.582) 0:02:10.437 ****** 2026-08-26 00:16:17.069195 | instance | ok: [instance] => (item=instance) 2026-08-26 00:16:17.069422 | instance | 2026-08-26 00:16:17.070049 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] *********** 2026-08-26 00:16:17.070115 | instance | Wednesday 26 August 2026 00:16:17 +0000 (0:00:00.066) 0:02:10.504 ****** 2026-08-26 00:16:17.431888 | instance | ok: [instance] 2026-08-26 00:16:17.431955 | instance | 2026-08-26 00:16:17.431968 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] *********************** 2026-08-26 00:16:17.431980 | instance | Wednesday 26 August 2026 00:16:17 +0000 (0:00:00.361) 0:02:10.865 ****** 2026-08-26 00:16:19.844131 | instance | ok: [instance] 2026-08-26 00:16:19.844456 | instance | 2026-08-26 00:16:19.844473 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ****************** 2026-08-26 00:16:19.844483 | instance | Wednesday 26 August 2026 00:16:19 +0000 (0:00:02.412) 0:02:13.278 ****** 2026-08-26 00:17:21.596728 | 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-26 00:17:21.597063 | 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_5p89ondd/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_5p89ondd/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_5p89ondd/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_5p89ondd/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-26T00:17:21.333+0000 7f11726e8640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAkMI5qgI3gISAAEWg3moydCsQpHHAW9YCQNyZ1QVPE/nsEBDzmK2VTwyU=: Malformed input [buffer:3]\n2026-08-26T00:17:21.333+0000 7f11726e8640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-26T00:17:21.333+0000 7f11726e8640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAkMI5qgI3gISAAEWg3moydCsQpHHAW9YCQNyZ1QVPE/nsEBDzmK2VTwyU=: Malformed input [buffer:3]\n2026-08-26T00:17:21.333+0000 7f11726e8640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-26T00:17:21.333+0000 7f11726e8640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAkMI5qgI3gISAAEWg3moydCsQpHHAW9YCQNyZ1QVPE/nsEBDzmK2VTwyU=: Malformed input [buffer:3]\n2026-08-26T00:17:21.333+0000 7f11726e8640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-26T00:17:21.333+0000 7f11726e8640 -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-26 00:17:21.600123 | instance | 2026-08-26 00:17:21.600510 | instance | PLAY RECAP ********************************************************************* 2026-08-26 00:17:21.604528 | instance | instance : ok=55 changed=26 unreachable=0 failed=1 skipped=6 rescued=0 ignored=0 2026-08-26 00:17:21.604622 | instance | 2026-08-26 00:17:21.604631 | instance | Wednesday 26 August 2026 00:17:21 +0000 (0:01:01.757) 0:03:15.035 ****** 2026-08-26 00:17:21.604638 | instance | =============================================================================== 2026-08-26 00:17:21.604644 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 89.49s 2026-08-26 00:17:21.604651 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 61.76s 2026-08-26 00:17:21.604657 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 5.56s 2026-08-26 00:17:21.604663 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 4.50s 2026-08-26 00:17:21.604669 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.33s 2026-08-26 00:17:21.604675 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.83s 2026-08-26 00:17:21.604681 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.41s 2026-08-26 00:17:21.604687 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.67s 2026-08-26 00:17:21.604719 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.58s 2026-08-26 00:17:21.604725 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.30s 2026-08-26 00:17:21.604731 | instance | vexxhost.containers.download_artifact : Download item ------------------- 1.20s 2026-08-26 00:17:21.604736 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.15s 2026-08-26 00:17:21.604742 | instance | Gathering Facts --------------------------------------------------------- 1.01s 2026-08-26 00:17:21.604758 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.94s 2026-08-26 00:17:21.604764 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.93s 2026-08-26 00:17:21.605595 | instance | Gathering Facts --------------------------------------------------------- 0.89s 2026-08-26 00:17:21.605627 | instance | Gathering Facts --------------------------------------------------------- 0.86s 2026-08-26 00:17:21.605635 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 0.81s 2026-08-26 00:17:21.605642 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.69s 2026-08-26 00:17:21.605648 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.69s 2026-08-26 00:17:21.687793 | 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-26 00:17:21.688106 | instance | ERROR [csi > converge] Executed: Failed 2026-08-26 00:17:21.688303 | 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-26 00:17:23.695233 | instance | ERROR 2026-08-26 00:17:23.695494 | instance | { 2026-08-26 00:17:23.695551 | instance | "delta": "0:04:02.862962", 2026-08-26 00:17:23.695666 | instance | "end": "2026-08-26 00:17:21.742537", 2026-08-26 00:17:23.695709 | instance | "msg": "non-zero return code", 2026-08-26 00:17:23.695736 | instance | "rc": 2, 2026-08-26 00:17:23.695761 | instance | "start": "2026-08-26 00:13:18.879575" 2026-08-26 00:17:23.695785 | instance | } failure 2026-08-26 00:17:23.702308 | 2026-08-26 00:17:23.702389 | PLAY RECAP 2026-08-26 00:17:23.702448 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-08-26 00:17:23.702483 | 2026-08-26 00:17:24.469541 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-26 00:17:24.473819 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-08-26 00:17:26.200574 | 2026-08-26 00:17:26.200732 | PLAY [all] 2026-08-26 00:17:26.787911 | 2026-08-26 00:17:27.800556 | TASK [gather-host-logs : creating directory for system status] 2026-08-26 00:17:28.235042 | instance | changed 2026-08-26 00:17:28.241592 | 2026-08-26 00:17:28.241674 | TASK [gather-host-logs : Get logs for each host] 2026-08-26 00:17:28.587075 | instance | + systemd-cgls --full --all --no-pager 2026-08-26 00:17:47.301630 | instance | + ip addr 2026-08-26 00:17:47.303631 | instance | + ip route 2026-08-26 00:17:47.305194 | instance | + lsblk 2026-08-26 00:17:47.310590 | instance | + mount 2026-08-26 00:17:47.312368 | instance | + docker images 2026-08-26 00:17:47.330178 | instance | + brctl show 2026-08-26 00:17:47.330843 | instance | /bin/bash: line 8: brctl: command not found 2026-08-26 00:17:47.331149 | instance | + ps aux --sort=-%mem 2026-08-26 00:17:47.362949 | instance | + dpkg -l 2026-08-26 00:17:47.378272 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-08-26 00:17:47.378829 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-08-26 00:17:47.397043 | instance | + '[' '!' -z '' ']' 2026-08-26 00:17:47.800461 | instance | ok: Runtime: 0:00:18.815787 2026-08-26 00:17:47.809678 | 2026-08-26 00:17:47.809769 | TASK [gather-host-logs : Downloads logs to executor] 2026-08-26 00:17:48.433035 | instance | changed: 2026-08-26 00:17:48.433230 | instance | created directory /var/lib/zuul/builds/6ef40afce5ec4349a33a6d86b2e8c75d/work/logs/instance 2026-08-26 00:17:48.433272 | instance | cd+++++++++ system/ 2026-08-26 00:17:48.433304 | instance | >f+++++++++ system/brctl-show.txt 2026-08-26 00:17:48.433334 | instance | >f+++++++++ system/docker-images.txt 2026-08-26 00:17:48.433363 | instance | >f+++++++++ system/ip-addr.txt 2026-08-26 00:17:48.433394 | instance | >f+++++++++ system/ip-route.txt 2026-08-26 00:17:48.433424 | instance | >f+++++++++ system/lsblk.txt 2026-08-26 00:17:48.433452 | instance | >f+++++++++ system/mount.txt 2026-08-26 00:17:48.433480 | instance | >f+++++++++ system/packages.txt 2026-08-26 00:17:48.433507 | instance | >f+++++++++ system/ps.txt 2026-08-26 00:17:48.433538 | instance | >f+++++++++ system/systemd-cgls.txt 2026-08-26 00:17:48.446386 | 2026-08-26 00:17:48.446473 | LOOP [helm-release-status : creating directory for helm release status] 2026-08-26 00:17:48.639801 | instance | changed: "values" 2026-08-26 00:17:48.803918 | instance | changed: "releases" 2026-08-26 00:17:48.817319 | 2026-08-26 00:17:48.817495 | TASK [helm-release-status : Gather get release status for helm charts] 2026-08-26 00:17:49.029795 | instance | /bin/bash: line 3: kubectl: command not found 2026-08-26 00:17:49.359346 | instance | ok: Runtime: 0:00:00.004957 2026-08-26 00:17:49.366957 | 2026-08-26 00:17:49.367052 | TASK [helm-release-status : Downloads logs to executor] 2026-08-26 00:17:49.861889 | instance | changed: 2026-08-26 00:17:49.862117 | instance | cd+++++++++ helm/ 2026-08-26 00:17:49.862169 | instance | cd+++++++++ helm/releases/ 2026-08-26 00:17:49.862208 | instance | cd+++++++++ helm/values/ 2026-08-26 00:17:49.878329 | 2026-08-26 00:17:49.878486 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-08-26 00:17:50.085608 | instance | changed 2026-08-26 00:17:50.093722 | 2026-08-26 00:17:50.093827 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-08-26 00:17:50.353248 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-26 00:17:50.353300 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-26 00:17:50.357648 | instance | environment: line 1: kubectl: command not found 2026-08-26 00:17:50.359701 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-26 00:17:50.361164 | instance | environment: line 1: kubectl: command not found 2026-08-26 00:17:50.362603 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-26 00:17:50.362721 | instance | environment: line 1: kubectl: command not found 2026-08-26 00:17:50.363629 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-26 00:17:50.365886 | instance | environment: line 1: kubectl: command not found 2026-08-26 00:17:50.366196 | instance | environment: line 1: kubectl: command not found 2026-08-26 00:17:50.367017 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-26 00:17:50.367098 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-26 00:17:50.626917 | instance | ok: Runtime: 0:00:00.022953 2026-08-26 00:17:50.633653 | 2026-08-26 00:17:50.633732 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-08-26 00:17:50.840203 | instance | changed 2026-08-26 00:17:50.845684 | 2026-08-26 00:17:50.845760 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-08-26 00:17:51.060002 | instance | environment: line 5: kubectl: command not found 2026-08-26 00:17:51.061006 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-26 00:17:51.061639 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-26 00:17:51.061989 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-26 00:17:51.386088 | instance | ok: Runtime: 0:00:00.009706 2026-08-26 00:17:51.391673 | 2026-08-26 00:17:51.391738 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-08-26 00:17:51.891900 | instance | changed: 2026-08-26 00:17:51.966737 | instance | cd+++++++++ objects/ 2026-08-26 00:17:51.966919 | instance | cd+++++++++ objects/cluster/ 2026-08-26 00:17:51.967002 | instance | cd+++++++++ objects/namespaced/ 2026-08-26 00:17:51.981427 | 2026-08-26 00:17:51.981501 | TASK [gather-pod-logs : creating directory for pod logs] 2026-08-26 00:17:52.177693 | instance | changed 2026-08-26 00:17:52.184553 | 2026-08-26 00:17:52.184620 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-08-26 00:17:52.395627 | instance | changed 2026-08-26 00:17:52.400887 | 2026-08-26 00:17:52.400987 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-08-26 00:17:52.621881 | instance | environment: line 3: kubectl: command not found 2026-08-26 00:17:52.935612 | instance | ok: Runtime: 0:00:00.009359 2026-08-26 00:17:52.942441 | 2026-08-26 00:17:52.942544 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-08-26 00:17:53.408905 | instance | changed: 2026-08-26 00:17:53.409083 | instance | cd+++++++++ pod-logs/ 2026-08-26 00:17:53.409120 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-08-26 00:17:53.419163 | 2026-08-26 00:17:53.419237 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-08-26 00:17:53.659652 | instance | changed 2026-08-26 00:17:53.664769 | 2026-08-26 00:17:53.664838 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-08-26 00:17:53.876997 | instance | /bin/bash: line 2: kubectl: command not found 2026-08-26 00:17:54.314217 | instance | ok: Runtime: 0:00:00.036091 2026-08-26 00:17:54.321860 | 2026-08-26 00:17:54.321991 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-08-26 00:17:54.539769 | instance | /bin/bash: line 2: kubectl: command not found 2026-08-26 00:17:54.571068 | instance | ceph-mgr endpoints: 2026-08-26 00:17:54.860100 | instance | ok: Runtime: 0:00:00.038537 2026-08-26 00:17:54.867063 | 2026-08-26 00:17:54.867150 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-08-26 00:17:55.089216 | instance | /bin/bash: line 4: kubectl: command not found 2026-08-26 00:17:55.407951 | instance | ok: Runtime: 0:00:00.037625 2026-08-26 00:17:55.413912 | 2026-08-26 00:17:55.413978 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-08-26 00:17:55.912569 | instance | changed: cd+++++++++ prometheus/ 2026-08-26 00:17:55.931321 | 2026-08-26 00:17:55.931467 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-08-26 00:17:56.148065 | instance | changed 2026-08-26 00:17:56.157227 | 2026-08-26 00:17:56.157576 | TASK [gather-selenium-data : Get selenium data] 2026-08-26 00:17:56.428211 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-08-26 00:17:56.429266 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-08-26 00:17:56.696771 | instance | ERROR 2026-08-26 00:17:56.697140 | instance | { 2026-08-26 00:17:56.697188 | instance | "delta": "0:00:00.006929", 2026-08-26 00:17:56.697220 | instance | "end": "2026-08-26 00:17:56.429656", 2026-08-26 00:17:56.697262 | instance | "msg": "non-zero return code", 2026-08-26 00:17:56.697303 | instance | "rc": 1, 2026-08-26 00:17:56.697337 | instance | "start": "2026-08-26 00:17:56.422727" 2026-08-26 00:17:56.697364 | instance | } 2026-08-26 00:17:56.697399 | instance | ERROR: Ignoring Errors 2026-08-26 00:17:56.703897 | 2026-08-26 00:17:56.703985 | TASK [gather-selenium-data : Downloads logs to executor] 2026-08-26 00:17:57.257090 | instance | changed: cd+++++++++ selenium/ 2026-08-26 00:17:57.265021 | 2026-08-26 00:17:57.265076 | PLAY RECAP 2026-08-26 00:17:57.265142 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-08-26 00:17:57.265168 | 2026-08-26 00:17:57.448452 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-08-26 00:17:57.450644 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-26 00:17:59.045309 | 2026-08-26 00:17:59.045440 | PLAY [all] 2026-08-26 00:17:59.057477 | 2026-08-26 00:17:59.057570 | TASK [fetch-output : Set log path for multiple nodes] 2026-08-26 00:17:59.102944 | instance | skipping: Conditional result was False 2026-08-26 00:17:59.172697 | 2026-08-26 00:17:59.172821 | TASK [fetch-output : Set log path for single node] 2026-08-26 00:17:59.214932 | instance | ok 2026-08-26 00:17:59.221673 | 2026-08-26 00:17:59.221808 | LOOP [fetch-output : Ensure local output dirs] 2026-08-26 00:17:59.652301 | instance -> localhost | ok: "/var/lib/zuul/builds/6ef40afce5ec4349a33a6d86b2e8c75d/work/logs" 2026-08-26 00:17:59.879825 | instance -> localhost | changed: "/var/lib/zuul/builds/6ef40afce5ec4349a33a6d86b2e8c75d/work/artifacts" 2026-08-26 00:18:00.116556 | instance -> localhost | changed: "/var/lib/zuul/builds/6ef40afce5ec4349a33a6d86b2e8c75d/work/docs" 2026-08-26 00:18:00.137703 | 2026-08-26 00:18:00.137863 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-26 00:18:00.934731 | instance | changed: .d..t...... ./ 2026-08-26 00:18:00.934962 | instance | changed: All items complete 2026-08-26 00:18:00.934993 | 2026-08-26 00:18:01.388490 | instance | changed: .d..t...... ./ 2026-08-26 00:18:01.948376 | instance | changed: .d..t...... ./ 2026-08-26 00:18:01.967685 | 2026-08-26 00:18:01.967820 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-26 00:18:02.423947 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.026038 2026-08-26 00:18:02.662769 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.006909 2026-08-26 00:18:02.683722 | 2026-08-26 00:18:02.685513 | PLAY [all] 2026-08-26 00:18:02.691574 | 2026-08-26 00:18:02.691642 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-26 00:18:03.161572 | instance | changed 2026-08-26 00:18:03.168605 | 2026-08-26 00:18:03.168657 | PLAY RECAP 2026-08-26 00:18:03.168702 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-26 00:18:03.168724 | 2026-08-26 00:18:03.301461 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-26 00:18:03.344856 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-26 00:18:03.957091 | 2026-08-26 00:18:03.957214 | PLAY [localhost] 2026-08-26 00:18:03.967326 | 2026-08-26 00:18:03.967402 | TASK [Generate Zuul manifest] 2026-08-26 00:18:03.989954 | localhost | ok 2026-08-26 00:18:04.077738 | 2026-08-26 00:18:04.077930 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-26 00:18:04.578958 | localhost | changed 2026-08-26 00:18:05.185836 | 2026-08-26 00:18:05.186027 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-26 00:18:05.227494 | localhost | ok 2026-08-26 00:18:05.252528 | 2026-08-26 00:18:05.252797 | TASK [Upload logs] 2026-08-26 00:18:05.278971 | localhost | ok 2026-08-26 00:18:06.504005 | 2026-08-26 00:18:06.504149 | TASK [Set zuul-log-path fact] 2026-08-26 00:18:06.525697 | localhost | ok 2026-08-26 00:18:06.684996 | 2026-08-26 00:18:06.685155 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-26 00:18:06.717570 | localhost | ok 2026-08-26 00:18:06.724248 | 2026-08-26 00:18:06.724313 | TASK [upload-logs : Create log directories] 2026-08-26 00:18:07.147403 | localhost | changed 2026-08-26 00:18:07.152546 | 2026-08-26 00:18:07.152614 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-26 00:18:07.609429 | localhost -> localhost | ok: Runtime: 0:00:00.005491 2026-08-26 00:18:07.616741 | 2026-08-26 00:18:07.616863 | TASK [upload-logs : Upload logs to log server] 2026-08-26 00:18:08.391472 | localhost | Output suppressed because no_log was given 2026-08-26 00:18:08.431955 | 2026-08-26 00:18:08.432091 | LOOP [upload-logs : Compress console log and json output] 2026-08-26 00:18:08.485694 | localhost | skipping: Conditional result was False 2026-08-26 00:18:08.499635 | localhost | skipping: Conditional result was False 2026-08-26 00:18:08.515304 | 2026-08-26 00:18:08.542332 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-26 00:18:08.584491 | localhost | skipping: Conditional result was False 2026-08-26 00:18:08.584869 | 2026-08-26 00:18:08.588329 | localhost | skipping: Conditional result was False 2026-08-26 00:18:08.598939 | 2026-08-26 00:18:08.599105 | LOOP [upload-logs : Upload console log and json output]