2026-08-24 15:14:59.222343 | Job console starting 2026-08-24 15:14:59.237212 | Updating git repos 2026-08-24 15:15:03.132877 | Cloning repos into workspace 2026-08-24 15:15:27.227072 | Restoring repo states 2026-08-24 15:15:37.919456 | Merging changes 2026-08-24 15:15:39.880232 | Checking out repos 2026-08-24 15:15:48.765273 | Preparing playbooks 2026-08-24 15:16:02.747610 | Running Ansible setup 2026-08-24 15:16:07.701464 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-24 15:16:08.333921 | 2026-08-24 15:16:08.334449 | PLAY [localhost] 2026-08-24 15:16:08.341879 | 2026-08-24 15:16:08.341950 | TASK [Gathering Facts] 2026-08-24 15:16:09.460488 | localhost | ok 2026-08-24 15:16:09.467695 | 2026-08-24 15:16:09.467779 | TASK [Setup log path fact] 2026-08-24 15:16:09.488398 | localhost | ok 2026-08-24 15:16:09.499150 | 2026-08-24 15:16:09.499224 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-24 15:16:09.527788 | localhost | ok 2026-08-24 15:16:09.535917 | 2026-08-24 15:16:09.536011 | TASK [emit-job-header : Print job information] 2026-08-24 15:16:09.591119 | # Job Information 2026-08-24 15:16:09.591290 | Ansible Version: 2.16.18 2026-08-24 15:16:09.591324 | Job: atmosphere-molecule-csi-rbd 2026-08-24 15:16:09.591346 | Pipeline: check 2026-08-24 15:16:09.591366 | Executor: 2d72f0692154 2026-08-24 15:16:09.591386 | Triggered by: https://github.com/vexxhost/atmosphere/pull/2987 2026-08-24 15:16:09.591465 | Event ID: a1eb6760-9fcc-11f1-8c2b-2db84d4e7066 2026-08-24 15:16:09.594403 | 2026-08-24 15:16:09.594475 | LOOP [emit-job-header : Print node information] 2026-08-24 15:16:09.722013 | localhost | ok: 2026-08-24 15:16:09.722310 | localhost | # Node Information 2026-08-24 15:16:09.722384 | localhost | Inventory Hostname: instance 2026-08-24 15:16:09.722440 | localhost | Hostname: np0000190827 2026-08-24 15:16:09.722491 | localhost | Username: zuul 2026-08-24 15:16:09.722550 | localhost | Distro: Ubuntu 22.04 2026-08-24 15:16:09.722601 | localhost | Provider: yul1 2026-08-24 15:16:09.722650 | localhost | Region: ca-ymq-1 2026-08-24 15:16:09.722698 | localhost | Label: ubuntu-jammy 2026-08-24 15:16:09.722747 | localhost | Product Name: OpenStack Nova 2026-08-24 15:16:09.722794 | localhost | Interface IP: 199.19.213.40 2026-08-24 15:16:09.733083 | 2026-08-24 15:16:09.733313 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-24 15:16:10.163675 | localhost -> localhost | changed 2026-08-24 15:16:10.174049 | 2026-08-24 15:16:10.174243 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-24 15:16:11.038909 | localhost -> localhost | changed 2026-08-24 15:16:11.051259 | 2026-08-24 15:16:11.051382 | PLAY [all] 2026-08-24 15:16:11.061182 | 2026-08-24 15:16:11.061269 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-24 15:16:11.318701 | instance -> localhost | ok 2026-08-24 15:16:11.327756 | 2026-08-24 15:16:11.327859 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-24 15:16:11.367087 | instance | ok 2026-08-24 15:16:11.380236 | instance | included: /var/lib/zuul/builds/58fd97d5ebd741598974b2c2815cfd27/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-24 15:16:11.385801 | 2026-08-24 15:16:11.385865 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-24 15:16:12.390205 | instance -> localhost | Generating public/private rsa key pair. 2026-08-24 15:16:12.390415 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/58fd97d5ebd741598974b2c2815cfd27/work/58fd97d5ebd741598974b2c2815cfd27_id_rsa 2026-08-24 15:16:12.390459 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/58fd97d5ebd741598974b2c2815cfd27/work/58fd97d5ebd741598974b2c2815cfd27_id_rsa.pub 2026-08-24 15:16:12.390493 | instance -> localhost | The key fingerprint is: 2026-08-24 15:16:12.390524 | instance -> localhost | SHA256:xonqobmHeTWe4MUuD/PLzeOjgi8NMStsFa0BBX/zNzw zuul-build-sshkey 2026-08-24 15:16:12.390571 | instance -> localhost | The key's randomart image is: 2026-08-24 15:16:12.390601 | instance -> localhost | +---[RSA 3072]----+ 2026-08-24 15:16:12.390637 | instance -> localhost | | o+.. | 2026-08-24 15:16:12.390669 | instance -> localhost | | .o . | 2026-08-24 15:16:12.390698 | instance -> localhost | | .+o | 2026-08-24 15:16:12.390726 | instance -> localhost | | oo. oo.. | 2026-08-24 15:16:12.390754 | instance -> localhost | |. .+ ...SE | 2026-08-24 15:16:12.390782 | instance -> localhost | |.oo ..=.. o | 2026-08-24 15:16:12.390811 | instance -> localhost | |.. B=* o | 2026-08-24 15:16:12.390839 | instance -> localhost | | =+B*+oo | 2026-08-24 15:16:12.390871 | instance -> localhost | | +*o+*++o | 2026-08-24 15:16:12.390899 | instance -> localhost | +----[SHA256]-----+ 2026-08-24 15:16:12.390966 | instance -> localhost | ok: Runtime: 0:00:00.581787 2026-08-24 15:16:12.398335 | 2026-08-24 15:16:12.398420 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-24 15:16:12.434624 | instance | ok 2026-08-24 15:16:12.443575 | instance | included: /var/lib/zuul/builds/58fd97d5ebd741598974b2c2815cfd27/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-24 15:16:12.451458 | 2026-08-24 15:16:12.451567 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-24 15:16:12.476774 | instance | skipping: Conditional result was False 2026-08-24 15:16:12.486558 | 2026-08-24 15:16:12.486750 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-24 15:16:12.949524 | instance | changed 2026-08-24 15:16:12.960195 | 2026-08-24 15:16:12.961100 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-24 15:16:13.161356 | instance | ok 2026-08-24 15:16:13.169474 | 2026-08-24 15:16:13.169562 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-24 15:16:13.665465 | instance | changed 2026-08-24 15:16:13.672550 | 2026-08-24 15:16:13.672655 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-24 15:16:14.165064 | instance | changed 2026-08-24 15:16:14.171742 | 2026-08-24 15:16:14.171841 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-24 15:16:14.205680 | instance | skipping: Conditional result was False 2026-08-24 15:16:14.215246 | 2026-08-24 15:16:14.215476 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-24 15:16:14.622586 | instance -> localhost | changed 2026-08-24 15:16:14.640195 | 2026-08-24 15:16:14.640375 | TASK [add-build-sshkey : Add back temp key] 2026-08-24 15:16:14.994490 | instance -> localhost | Identity added: /var/lib/zuul/builds/58fd97d5ebd741598974b2c2815cfd27/work/58fd97d5ebd741598974b2c2815cfd27_id_rsa (zuul-build-sshkey) 2026-08-24 15:16:14.994810 | instance -> localhost | ok: Runtime: 0:00:00.018309 2026-08-24 15:16:15.001249 | 2026-08-24 15:16:15.001422 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-24 15:16:15.367021 | instance | ok 2026-08-24 15:16:15.375547 | 2026-08-24 15:16:15.375698 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-24 15:16:15.410434 | instance | skipping: Conditional result was False 2026-08-24 15:16:15.425583 | 2026-08-24 15:16:15.425662 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-08-24 15:16:15.734410 | instance | ok 2026-08-24 15:16:15.741853 | 2026-08-24 15:16:15.741945 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-08-24 15:16:19.231338 | instance | Output suppressed because no_log was given 2026-08-24 15:16:19.240353 | 2026-08-24 15:16:19.240432 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-08-24 15:16:19.457624 | instance | ok: "logs" 2026-08-24 15:16:19.458376 | instance | ok: All items complete 2026-08-24 15:16:19.458418 | 2026-08-24 15:16:19.655916 | instance | ok: "artifacts" 2026-08-24 15:16:19.810612 | instance | ok: "docs" 2026-08-24 15:16:19.822026 | 2026-08-24 15:16:19.822180 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-08-24 15:16:20.020095 | instance | changed: "logs" 2026-08-24 15:16:20.171249 | instance | changed: "artifacts" 2026-08-24 15:16:20.329347 | instance | changed: "docs" 2026-08-24 15:16:20.352167 | 2026-08-24 15:16:20.352326 | PLAY RECAP 2026-08-24 15:16:20.352386 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-08-24 15:16:20.352416 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-24 15:16:20.352438 | 2026-08-24 15:16:20.537547 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-24 15:16:20.548334 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-24 15:16:21.258867 | 2026-08-24 15:16:21.258999 | PLAY [all] 2026-08-24 15:16:21.270165 | 2026-08-24 15:16:21.270248 | TASK [setup-uv : Extract archive] 2026-08-24 15:16:23.536430 | instance | changed 2026-08-24 15:16:23.543989 | 2026-08-24 15:16:23.544170 | TASK [setup-uv : Print version] 2026-08-24 15:16:23.903209 | instance | uv 0.8.13 2026-08-24 15:16:24.085169 | instance | ok: Runtime: 0:00:00.011685 2026-08-24 15:16:24.094572 | 2026-08-24 15:16:24.094672 | TASK [Install Ansible collection siblings] 2026-08-24 15:16:33.011826 | instance | changed: 2026-08-24 15:16:33.012038 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-08-24 15:16:33.012073 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-08-24 15:16:33.012098 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-08-24 15:16:33.012120 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto 2026-08-24 15:16:33.012141 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general 2026-08-24 15:16:33.012166 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql 2026-08-24 15:16:33.012188 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-08-24 15:16:33.012211 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-08-24 15:16:33.012232 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-08-24 15:16:33.012252 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-08-24 15:16:33.012273 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-08-24 15:16:33.012293 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-08-24 15:16:33.012312 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0 2026-08-24 15:16:33.012332 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0 2026-08-24 15:16:33.012352 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0 2026-08-24 15:16:33.012373 | instance | Resolved community.crypto to 2.2.3 for 2.2.3 2026-08-24 15:16:33.012393 | instance | Resolved community.general to 7.3.0 for 7.3.0 2026-08-24 15:16:33.012413 | instance | Resolved community.mysql to 3.6.0 for 3.6.0 2026-08-24 15:16:33.012433 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0 2026-08-24 15:16:33.012451 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0 2026-08-24 15:16:33.012471 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0 2026-08-24 15:16:33.012491 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0 2026-08-24 15:16:33.012512 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-08-24 15:16:33.012543 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0 2026-08-24 15:16:33.012565 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0 2026-08-24 15:16:33.012586 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-08-24 15:16:33.012605 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-08-24 15:16:33.012625 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-08-24 15:16:33.012644 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0 2026-08-24 15:16:33.012664 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3 2026-08-24 15:16:33.012683 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-08-24 15:16:33.012703 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-08-24 15:16:33.012722 | instance | Checked out ansible.netcommon to 1.2.0 2026-08-24 15:16:33.012742 | 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-24 15:16:33.012769 | instance | Starting galaxy collection install process 2026-08-24 15:16:33.012789 | instance | Process install dependency map 2026-08-24 15:16:33.012809 | instance | Starting collection install process 2026-08-24 15:16:33.012828 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon' 2026-08-24 15:16:33.012848 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon 2026-08-24 15:16:33.012867 | instance | ansible.netcommon:* was installed successfully 2026-08-24 15:16:33.012887 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-08-24 15:16:33.012906 | instance | Creating virtual environment at: .venv 2026-08-24 15:16:33.012926 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-08-24 15:16:33.012945 | instance | Downloading netaddr (2.2MiB) 2026-08-24 15:16:33.012988 | instance | Downloading cryptography (4.2MiB) 2026-08-24 15:16:33.013023 | instance | Downloading rjsonnet (1.2MiB) 2026-08-24 15:16:33.013049 | instance | Downloading pydantic-core (2.0MiB) 2026-08-24 15:16:33.013071 | instance | Downloading pygments (1.2MiB) 2026-08-24 15:16:33.013091 | instance | Downloading kubernetes (1.9MiB) 2026-08-24 15:16:33.013112 | instance | Downloading openstacksdk (1.7MiB) 2026-08-24 15:16:33.013133 | instance | Downloading ansible-core (2.1MiB) 2026-08-24 15:16:33.013153 | instance | Downloading setuptools (1.1MiB) 2026-08-24 15:16:33.013173 | instance | Building pyperclip==1.9.0 2026-08-24 15:16:33.013195 | instance | Downloading rjsonnet 2026-08-24 15:16:33.013215 | instance | Downloading pydantic-core 2026-08-24 15:16:33.013235 | instance | Downloading netaddr 2026-08-24 15:16:33.013254 | instance | Downloading pygments 2026-08-24 15:16:33.013275 | instance | Downloading cryptography 2026-08-24 15:16:33.013294 | instance | Downloading setuptools 2026-08-24 15:16:33.013314 | instance | Downloading kubernetes 2026-08-24 15:16:33.013333 | instance | Downloading ansible-core 2026-08-24 15:16:33.013354 | instance | Downloading openstacksdk 2026-08-24 15:16:33.013374 | instance | Built pyperclip==1.9.0 2026-08-24 15:16:33.013394 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-08-24 15:16:33.013414 | instance | Installed 83 packages in 43ms 2026-08-24 15:16:33.013433 | instance | Checked out ansible.posix to 1.6.0 2026-08-24 15:16:33.013453 | 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-24 15:16:33.013472 | instance | Starting galaxy collection install process 2026-08-24 15:16:33.013493 | instance | Process install dependency map 2026-08-24 15:16:33.013518 | instance | Starting collection install process 2026-08-24 15:16:33.013538 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-08-24 15:16:33.013557 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix 2026-08-24 15:16:33.013578 | instance | ansible.posix:1.6.0 was installed successfully 2026-08-24 15:16:33.013597 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 15:16:33.013616 | instance | 2.17.12 2026-08-24 15:16:33.013637 | instance | Checked out ansible.utils to v6.1.0 2026-08-24 15:16:33.013656 | 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-24 15:16:33.013676 | instance | Starting galaxy collection install process 2026-08-24 15:16:33.013695 | instance | Process install dependency map 2026-08-24 15:16:33.013714 | instance | Starting collection install process 2026-08-24 15:16:33.013733 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils' 2026-08-24 15:16:33.013752 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils 2026-08-24 15:16:33.013772 | instance | ansible.utils:6.1.0 was installed successfully 2026-08-24 15:16:33.013791 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 15:16:33.013810 | instance | 2.17.12 2026-08-24 15:16:33.013830 | instance | Checked out atmosphere.common to v0.7.0 2026-08-24 15:16:33.013850 | 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-24 15:16:33.013871 | instance | Starting galaxy collection install process 2026-08-24 15:16:33.013891 | instance | Process install dependency map 2026-08-24 15:16:33.013910 | instance | Starting collection install process 2026-08-24 15:16:33.013929 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common' 2026-08-24 15:16:33.013948 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common 2026-08-24 15:16:33.013966 | instance | atmosphere.common:0.7.0 was installed successfully 2026-08-24 15:16:33.013984 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 15:16:33.014004 | instance | 2.17.12 2026-08-24 15:16:33.014023 | instance | Checked out community.crypto to 2.2.3 2026-08-24 15:16:33.014044 | 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-24 15:16:33.014087 | instance | Starting galaxy collection install process 2026-08-24 15:16:33.014130 | instance | Process install dependency map 2026-08-24 15:16:33.014173 | instance | Starting collection install process 2026-08-24 15:16:33.014213 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-08-24 15:16:33.014255 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto 2026-08-24 15:16:33.014297 | instance | community.crypto:2.2.3 was installed successfully 2026-08-24 15:16:33.014337 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 15:16:33.014380 | instance | 2.17.12 2026-08-24 15:16:33.014422 | instance | Checked out community.general to 7.3.0 2026-08-24 15:16:33.014465 | 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-24 15:16:33.014526 | instance | Starting galaxy collection install process 2026-08-24 15:16:33.014570 | instance | Process install dependency map 2026-08-24 15:16:33.014612 | instance | Starting collection install process 2026-08-24 15:16:33.014655 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-08-24 15:16:33.014698 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general 2026-08-24 15:16:33.014741 | instance | community.general:7.3.0 was installed successfully 2026-08-24 15:16:33.014786 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 15:16:33.014830 | instance | 2.17.12 2026-08-24 15:16:33.014874 | instance | Checked out community.mysql to 3.6.0 2026-08-24 15:16:33.014920 | 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-24 15:16:33.014964 | instance | Starting galaxy collection install process 2026-08-24 15:16:33.015006 | instance | Process install dependency map 2026-08-24 15:16:33.015047 | instance | Starting collection install process 2026-08-24 15:16:33.015090 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql' 2026-08-24 15:16:33.015133 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql 2026-08-24 15:16:33.015175 | instance | community.mysql:3.6.0 was installed successfully 2026-08-24 15:16:33.015218 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 15:16:33.015260 | instance | 2.17.12 2026-08-24 15:16:33.015304 | instance | Checked out kubernetes.core to 2.4.0 2026-08-24 15:16:33.015348 | 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-24 15:16:33.015406 | instance | Starting galaxy collection install process 2026-08-24 15:16:33.015584 | instance | Process install dependency map 2026-08-24 15:16:33.015677 | instance | Starting collection install process 2026-08-24 15:16:33.015812 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core' 2026-08-24 15:16:33.015901 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core 2026-08-24 15:16:33.015975 | instance | kubernetes.core:2.4.0 was installed successfully 2026-08-24 15:16:33.016037 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 15:16:33.016066 | instance | 2.17.12 2026-08-24 15:16:33.016090 | instance | Checked out openstack.cloud to 2.6.0 2026-08-24 15:16:33.016110 | 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-24 15:16:33.016129 | instance | Starting galaxy collection install process 2026-08-24 15:16:33.016148 | instance | Process install dependency map 2026-08-24 15:16:33.016167 | instance | Starting collection install process 2026-08-24 15:16:33.016186 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud' 2026-08-24 15:16:33.016204 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud 2026-08-24 15:16:33.016222 | instance | openstack.cloud:2.6.0 was installed successfully 2026-08-24 15:16:33.016240 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 15:16:33.016259 | instance | 2.17.12 2026-08-24 15:16:33.016284 | instance | Checked out vexxhost.ceph to v4.2.0 2026-08-24 15:16:33.016304 | 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-24 15:16:33.016323 | instance | Starting galaxy collection install process 2026-08-24 15:16:33.016342 | instance | Process install dependency map 2026-08-24 15:16:33.016360 | instance | Starting collection install process 2026-08-24 15:16:33.016378 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph' 2026-08-24 15:16:33.016396 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph 2026-08-24 15:16:33.016415 | instance | vexxhost.ceph:4.2.0 was installed successfully 2026-08-24 15:16:33.016433 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 15:16:33.016451 | instance | 2.17.12 2026-08-24 15:16:33.016470 | instance | Checked out vexxhost.containers to v1.6.8 2026-08-24 15:16:33.016490 | 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-24 15:16:33.016510 | instance | Starting galaxy collection install process 2026-08-24 15:16:33.016530 | instance | Process install dependency map 2026-08-24 15:16:33.016548 | instance | Starting collection install process 2026-08-24 15:16:33.016567 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers' 2026-08-24 15:16:33.016585 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers 2026-08-24 15:16:33.016604 | instance | vexxhost.containers:1.6.8 was installed successfully 2026-08-24 15:16:33.016622 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 15:16:33.016641 | instance | 2.17.12 2026-08-24 15:16:33.016660 | instance | Checked out vexxhost.kubernetes to v3.3.0 2026-08-24 15:16:33.016679 | 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-24 15:16:33.016698 | instance | Starting galaxy collection install process 2026-08-24 15:16:33.016716 | instance | Process install dependency map 2026-08-24 15:16:33.016735 | instance | Starting collection install process 2026-08-24 15:16:33.016753 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes' 2026-08-24 15:16:33.016771 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes 2026-08-24 15:16:33.016790 | instance | vexxhost.kubernetes:3.3.0 was installed successfully 2026-08-24 15:16:33.016808 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 15:16:33.016825 | instance | 2.17.12 2026-08-24 15:16:33.022946 | 2026-08-24 15:16:33.022993 | PLAY RECAP 2026-08-24 15:16:33.023038 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-24 15:16:33.023059 | 2026-08-24 15:16:33.185295 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-24 15:16:33.187407 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-08-24 15:16:33.858769 | 2026-08-24 15:16:34.000537 | PLAY [all] 2026-08-24 15:16:34.023078 | 2026-08-24 15:16:34.023265 | TASK [Install "jq" for log collection] 2026-08-24 15:16:43.129833 | instance | changed 2026-08-24 15:16:43.131818 | 2026-08-24 15:16:43.131878 | PLAY RECAP 2026-08-24 15:16:43.131933 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-24 15:16:43.131996 | 2026-08-24 15:16:43.262108 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-08-24 15:16:43.266154 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-24 15:16:43.958191 | 2026-08-24 15:16:43.958322 | PLAY [all] 2026-08-24 15:16:43.969668 | 2026-08-24 15:16:43.969767 | LOOP [Check inventory directories] 2026-08-24 15:16:44.332949 | instance | ok: "src/github.com/vexxhost/atmosphere" 2026-08-24 15:16:44.480809 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory" 2026-08-24 15:16:44.637014 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory" 2026-08-24 15:16:44.660752 | 2026-08-24 15:16:44.660928 | LOOP [Copy inventory file for Zuul] 2026-08-24 15:16:45.461157 | instance | changed: 2026-08-24 15:16:45.461449 | instance | { 2026-08-24 15:16:45.461480 | instance | "ansible_loop_var": "item", 2026-08-24 15:16:45.461502 | instance | "changed": false, 2026-08-24 15:16:45.461522 | instance | "failed": false, 2026-08-24 15:16:45.461545 | instance | "invocation": { 2026-08-24 15:16:45.461568 | instance | "module_args": { 2026-08-24 15:16:45.461596 | instance | "checksum_algorithm": "sha1", 2026-08-24 15:16:45.461618 | instance | "follow": true, 2026-08-24 15:16:45.461636 | instance | "get_attributes": true, 2026-08-24 15:16:45.461657 | instance | "get_checksum": true, 2026-08-24 15:16:45.461684 | instance | "get_mime": true, 2026-08-24 15:16:45.461705 | instance | "path": "src/github.com/vexxhost/atmosphere" 2026-08-24 15:16:45.461724 | instance | } 2026-08-24 15:16:45.461741 | instance | }, 2026-08-24 15:16:45.461758 | instance | "item": "src/github.com/vexxhost/atmosphere", 2026-08-24 15:16:45.461776 | instance | "stat": { 2026-08-24 15:16:45.461793 | instance | "atime": 1787584585.8985958, 2026-08-24 15:16:45.461848 | instance | "attr_flags": "e", 2026-08-24 15:16:45.461877 | instance | "attributes": [ 2026-08-24 15:16:45.461899 | instance | "extents" 2026-08-24 15:16:45.461924 | instance | ], 2026-08-24 15:16:45.461944 | instance | "block_size": 4096, 2026-08-24 15:16:45.461961 | instance | "blocks": 8, 2026-08-24 15:16:45.461978 | instance | "charset": "unknown", 2026-08-24 15:16:45.461996 | instance | "ctime": 1787584584.9065883, 2026-08-24 15:16:45.462014 | instance | "dev": 64513, 2026-08-24 15:16:45.462031 | instance | "device_type": 0, 2026-08-24 15:16:45.462048 | instance | "executable": true, 2026-08-24 15:16:45.462065 | instance | "exists": true, 2026-08-24 15:16:45.462082 | instance | "gid": 1000, 2026-08-24 15:16:45.462100 | instance | "gr_name": "zuul", 2026-08-24 15:16:45.462117 | instance | "inode": 1047276, 2026-08-24 15:16:45.462133 | instance | "isblk": false, 2026-08-24 15:16:45.462151 | instance | "ischr": false, 2026-08-24 15:16:45.462167 | instance | "isdir": true, 2026-08-24 15:16:45.462184 | instance | "isfifo": false, 2026-08-24 15:16:45.462201 | instance | "isgid": false, 2026-08-24 15:16:45.462217 | instance | "islnk": false, 2026-08-24 15:16:45.462234 | instance | "isreg": false, 2026-08-24 15:16:45.462250 | instance | "issock": false, 2026-08-24 15:16:45.462267 | instance | "isuid": false, 2026-08-24 15:16:45.462283 | instance | "mimetype": "unknown", 2026-08-24 15:16:45.462300 | instance | "mode": "0755", 2026-08-24 15:16:45.462316 | instance | "mtime": 1787584584.9065883, 2026-08-24 15:16:45.462332 | instance | "nlink": 23, 2026-08-24 15:16:45.462348 | instance | "path": "src/github.com/vexxhost/atmosphere", 2026-08-24 15:16:45.462366 | instance | "pw_name": "zuul", 2026-08-24 15:16:45.462386 | instance | "readable": true, 2026-08-24 15:16:45.462404 | instance | "rgrp": true, 2026-08-24 15:16:45.462421 | instance | "roth": true, 2026-08-24 15:16:45.462452 | instance | "rusr": true, 2026-08-24 15:16:45.462470 | instance | "size": 4096, 2026-08-24 15:16:45.462487 | instance | "uid": 1000, 2026-08-24 15:16:45.462504 | instance | "version": "2451173445", 2026-08-24 15:16:45.462522 | instance | "wgrp": false, 2026-08-24 15:16:45.462540 | instance | "woth": false, 2026-08-24 15:16:45.462557 | instance | "writeable": true, 2026-08-24 15:16:45.462574 | instance | "wusr": true, 2026-08-24 15:16:45.462591 | instance | "xgrp": true, 2026-08-24 15:16:45.462607 | instance | "xoth": true, 2026-08-24 15:16:45.462624 | instance | "xusr": true 2026-08-24 15:16:45.462641 | instance | } 2026-08-24 15:16:45.462657 | instance | } 2026-08-24 15:16:45.462692 | instance | ok: All items complete 2026-08-24 15:16:45.462713 | 2026-08-24 15:16:45.463990 | instance | skipping: Conditional result was False 2026-08-24 15:16:45.469834 | instance | skipping: Conditional result was False 2026-08-24 15:16:45.489671 | 2026-08-24 15:16:45.489787 | LOOP [Switch "ansible_host" to private IP] 2026-08-24 15:16:45.864047 | instance | changed: 1 replacements made 2026-08-24 15:16:45.865970 | instance | skipping: Conditional result was False 2026-08-24 15:16:45.868602 | instance | skipping: Conditional result was False 2026-08-24 15:16:45.889359 | 2026-08-24 15:16:45.889544 | TASK [Run Molecule scenario] 2026-08-24 15:16:46.837142 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-08-24 15:16:47.201879 | instance | INFO [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-08-24 15:16:47.201951 | instance | INFO [csi > prerun] Performing prerun with role_name_check=0... 2026-08-24 15:16:58.710722 | instance | INFO [csi > dependency] Executing 2026-08-24 15:16:58.710868 | instance | WARNING [csi > dependency] Missing roles requirements file: requirements.yml 2026-08-24 15:16:58.711084 | instance | WARNING [csi > dependency] Missing collections requirements file: collections.yml 2026-08-24 15:16:58.711198 | instance | WARNING [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-08-24 15:16:58.718900 | instance | INFO [csi > cleanup] Executing 2026-08-24 15:16:58.719444 | instance | WARNING [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-24 15:16:58.727457 | instance | INFO [csi > destroy] Executing 2026-08-24 15:16:58.727502 | instance | WARNING [csi > destroy] Skipping, '--destroy=never' requested. 2026-08-24 15:16:58.727518 | instance | INFO [csi > destroy] Executed: Successful 2026-08-24 15:16:58.734998 | instance | INFO [csi > syntax] Executing 2026-08-24 15:17:00.421211 | instance | 2026-08-24 15:17:00.421373 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-08-24 15:17:00.486973 | instance | INFO [csi > syntax] Executed: Successful 2026-08-24 15:17:00.497861 | instance | INFO [csi > create] Executing 2026-08-24 15:17:00.500213 | instance | WARNING [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-24 15:17:00.510333 | instance | INFO [csi > prepare] Executing 2026-08-24 15:17:01.404911 | instance | 2026-08-24 15:17:01.405373 | instance | PLAY [Prepare] ***************************************************************** 2026-08-24 15:17:01.405724 | instance | 2026-08-24 15:17:01.406052 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-24 15:17:01.406321 | instance | Monday 24 August 2026 15:17:01 +0000 (0:00:00.029) 0:00:00.029 ********* 2026-08-24 15:17:02.572841 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-08-24 15:17:02.573079 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-08-24 15:17:02.573393 | instance | interpreter could change the meaning of that path. See 2026-08-24 15:17:02.573656 | instance | https://docs.ansible.com/ansible- 2026-08-24 15:17:02.573935 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-08-24 15:17:02.582284 | instance | ok: [instance] 2026-08-24 15:17:02.582529 | instance | 2026-08-24 15:17:02.582819 | instance | TASK [Configure short hostname] ************************************************ 2026-08-24 15:17:02.583088 | instance | Monday 24 August 2026 15:17:02 +0000 (0:00:01.178) 0:00:01.208 ********* 2026-08-24 15:17:03.330417 | instance | changed: [instance] 2026-08-24 15:17:03.330656 | instance | 2026-08-24 15:17:03.330970 | instance | TASK [Ensure hostname inside hosts file] *************************************** 2026-08-24 15:17:03.331257 | instance | Monday 24 August 2026 15:17:03 +0000 (0:00:00.747) 0:00:01.956 ********* 2026-08-24 15:17:03.592971 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created 2026-08-24 15:17:03.593251 | instance | with a mode of 0700, this may cause issues when running as another user. To 2026-08-24 15:17:03.593525 | instance | avoid this, create the remote_tmp dir with the correct permissions manually 2026-08-24 15:17:03.598667 | instance | changed: [instance] 2026-08-24 15:17:03.598944 | instance | 2026-08-24 15:17:03.599236 | instance | TASK [Purge "snapd" package] *************************************************** 2026-08-24 15:17:03.599504 | instance | Monday 24 August 2026 15:17:03 +0000 (0:00:00.268) 0:00:02.225 ********* 2026-08-24 15:17:04.399037 | instance | ok: [instance] 2026-08-24 15:17:04.399335 | instance | 2026-08-24 15:17:04.399630 | instance | PLAY [Create devices for Ceph] ************************************************* 2026-08-24 15:17:04.399893 | instance | 2026-08-24 15:17:04.400175 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-24 15:17:04.400456 | instance | Monday 24 August 2026 15:17:04 +0000 (0:00:00.800) 0:00:03.025 ********* 2026-08-24 15:17:05.128818 | instance | ok: [instance] 2026-08-24 15:17:05.128968 | instance | 2026-08-24 15:17:05.129143 | instance | TASK [Install depedencies] ***************************************************** 2026-08-24 15:17:05.129436 | instance | Monday 24 August 2026 15:17:05 +0000 (0:00:00.729) 0:00:03.755 ********* 2026-08-24 15:17:25.084882 | instance | changed: [instance] 2026-08-24 15:17:25.085020 | instance | 2026-08-24 15:17:25.085043 | instance | TASK [Start up service] ******************************************************** 2026-08-24 15:17:25.085263 | instance | Monday 24 August 2026 15:17:25 +0000 (0:00:19.955) 0:00:23.710 ********* 2026-08-24 15:17:25.653925 | instance | ok: [instance] 2026-08-24 15:17:25.654038 | instance | 2026-08-24 15:17:25.654425 | instance | TASK [Generate lvm.conf] ******************************************************* 2026-08-24 15:17:25.654481 | instance | Monday 24 August 2026 15:17:25 +0000 (0:00:00.569) 0:00:24.280 ********* 2026-08-24 15:17:25.953388 | instance | ok: [instance] 2026-08-24 15:17:25.954014 | instance | 2026-08-24 15:17:25.954069 | instance | TASK [Write /etc/lvm/lvm.conf] ************************************************* 2026-08-24 15:17:25.954078 | instance | Monday 24 August 2026 15:17:25 +0000 (0:00:00.299) 0:00:24.579 ********* 2026-08-24 15:17:26.662464 | instance | changed: [instance] 2026-08-24 15:17:26.662564 | instance | 2026-08-24 15:17:26.662974 | instance | TASK [Get list of all loopback devices] **************************************** 2026-08-24 15:17:26.663037 | instance | Monday 24 August 2026 15:17:26 +0000 (0:00:00.709) 0:00:25.288 ********* 2026-08-24 15:17:26.864356 | instance | ok: [instance] 2026-08-24 15:17:26.864466 | instance | 2026-08-24 15:17:26.864711 | instance | TASK [Fail if there is any existing loopback devices] ************************** 2026-08-24 15:17:26.864769 | instance | Monday 24 August 2026 15:17:26 +0000 (0:00:00.202) 0:00:25.490 ********* 2026-08-24 15:17:26.892831 | instance | skipping: [instance] 2026-08-24 15:17:26.893599 | instance | 2026-08-24 15:17:26.893636 | instance | TASK [Create devices for Ceph] ************************************************* 2026-08-24 15:17:26.893644 | instance | Monday 24 August 2026 15:17:26 +0000 (0:00:00.027) 0:00:25.518 ********* 2026-08-24 15:17:27.459035 | instance | changed: [instance] => (item=osd0) 2026-08-24 15:17:27.459114 | instance | changed: [instance] => (item=osd1) 2026-08-24 15:17:27.459682 | instance | changed: [instance] => (item=osd2) 2026-08-24 15:17:27.459753 | instance | 2026-08-24 15:17:27.459759 | instance | TASK [Set permissions on loopback devices] ************************************* 2026-08-24 15:17:27.459765 | instance | Monday 24 August 2026 15:17:27 +0000 (0:00:00.566) 0:00:26.085 ********* 2026-08-24 15:17:28.089425 | instance | changed: [instance] => (item=osd0) 2026-08-24 15:17:28.089526 | instance | changed: [instance] => (item=osd1) 2026-08-24 15:17:28.090033 | instance | changed: [instance] => (item=osd2) 2026-08-24 15:17:28.090083 | instance | 2026-08-24 15:17:28.090089 | instance | TASK [Start loop devices] ****************************************************** 2026-08-24 15:17:28.090095 | instance | Monday 24 August 2026 15:17:28 +0000 (0:00:00.630) 0:00:26.715 ********* 2026-08-24 15:17:28.811015 | instance | changed: [instance] => (item=osd0) 2026-08-24 15:17:28.811872 | instance | changed: [instance] => (item=osd1) 2026-08-24 15:17:28.811924 | instance | changed: [instance] => (item=osd2) 2026-08-24 15:17:28.811932 | instance | 2026-08-24 15:17:28.811940 | instance | TASK [Create a volume group for each loop device] ****************************** 2026-08-24 15:17:28.811947 | instance | Monday 24 August 2026 15:17:28 +0000 (0:00:00.721) 0:00:27.437 ********* 2026-08-24 15:17:32.004043 | instance | changed: [instance] => (item=osd0) 2026-08-24 15:17:32.005086 | instance | changed: [instance] => (item=osd1) 2026-08-24 15:17:32.005139 | instance | changed: [instance] => (item=osd2) 2026-08-24 15:17:32.005148 | instance | 2026-08-24 15:17:32.005155 | instance | TASK [Create a logical volume for each loop device] **************************** 2026-08-24 15:17:32.005162 | instance | Monday 24 August 2026 15:17:32 +0000 (0:00:03.193) 0:00:30.630 ********* 2026-08-24 15:17:34.036577 | instance | changed: [instance] => (item=ceph-instance-osd0) 2026-08-24 15:17:34.037163 | instance | changed: [instance] => (item=ceph-instance-osd1) 2026-08-24 15:17:34.037191 | instance | changed: [instance] => (item=ceph-instance-osd2) 2026-08-24 15:17:34.037196 | instance | 2026-08-24 15:17:34.037723 | instance | PLAY RECAP ********************************************************************* 2026-08-24 15:17:34.037744 | instance | instance : ok=15 changed=9 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-08-24 15:17:34.037752 | instance | 2026-08-24 15:17:34.037762 | instance | Monday 24 August 2026 15:17:34 +0000 (0:00:02.033) 0:00:32.663 ********* 2026-08-24 15:17:34.040757 | instance | =============================================================================== 2026-08-24 15:17:34.040831 | instance | Install depedencies ---------------------------------------------------- 19.96s 2026-08-24 15:17:34.040839 | instance | Create a volume group for each loop device ------------------------------ 3.19s 2026-08-24 15:17:34.040845 | instance | Create a logical volume for each loop device ---------------------------- 2.03s 2026-08-24 15:17:34.040851 | instance | Gathering Facts --------------------------------------------------------- 1.18s 2026-08-24 15:17:34.040857 | instance | Purge "snapd" package --------------------------------------------------- 0.80s 2026-08-24 15:17:34.040863 | instance | Configure short hostname ------------------------------------------------ 0.75s 2026-08-24 15:17:34.040869 | instance | Gathering Facts --------------------------------------------------------- 0.73s 2026-08-24 15:17:34.040875 | instance | Start loop devices ------------------------------------------------------ 0.72s 2026-08-24 15:17:34.040880 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.71s 2026-08-24 15:17:34.040886 | instance | Set permissions on loopback devices ------------------------------------- 0.63s 2026-08-24 15:17:34.040892 | instance | Start up service -------------------------------------------------------- 0.57s 2026-08-24 15:17:34.040897 | instance | Create devices for Ceph ------------------------------------------------- 0.57s 2026-08-24 15:17:34.040903 | instance | Generate lvm.conf ------------------------------------------------------- 0.30s 2026-08-24 15:17:34.040909 | instance | Ensure hostname inside hosts file --------------------------------------- 0.27s 2026-08-24 15:17:34.040914 | instance | Get list of all loopback devices ---------------------------------------- 0.20s 2026-08-24 15:17:34.040920 | instance | Fail if there is any existing loopback devices -------------------------- 0.03s 2026-08-24 15:17:34.126298 | instance | INFO [csi > prepare] Executed: Successful 2026-08-24 15:17:34.139030 | instance | INFO [csi > converge] Executing 2026-08-24 15:17:35.709594 | instance | 2026-08-24 15:17:35.710062 | instance | PLAY [Debug CSI driver value] ************************************************** 2026-08-24 15:17:35.710389 | instance | 2026-08-24 15:17:35.710724 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-24 15:17:35.711074 | instance | Monday 24 August 2026 15:17:35 +0000 (0:00:00.007) 0:00:00.007 ********* 2026-08-24 15:17:36.721344 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-08-24 15:17:36.721976 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-08-24 15:17:36.722323 | instance | interpreter could change the meaning of that path. See 2026-08-24 15:17:36.722665 | instance | https://docs.ansible.com/ansible- 2026-08-24 15:17:36.723010 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-08-24 15:17:36.731950 | instance | ok: [instance] 2026-08-24 15:17:36.732300 | instance | 2026-08-24 15:17:36.732649 | instance | TASK [Display CSI driver value and environment variable] *********************** 2026-08-24 15:17:36.733073 | instance | Monday 24 August 2026 15:17:36 +0000 (0:00:01.022) 0:00:01.030 ********* 2026-08-24 15:17:36.782222 | instance | ok: [instance] => { 2026-08-24 15:17:36.782589 | instance | "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER=" 2026-08-24 15:17:36.782919 | instance | } 2026-08-24 15:17:36.783239 | instance | 2026-08-24 15:17:36.783571 | instance | PLAY [all] ********************************************************************* 2026-08-24 15:17:36.783895 | instance | 2026-08-24 15:17:36.784338 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-24 15:17:36.784786 | instance | Monday 24 August 2026 15:17:36 +0000 (0:00:00.050) 0:00:01.081 ********* 2026-08-24 15:17:37.691308 | instance | ok: [instance] 2026-08-24 15:17:37.691715 | instance | 2026-08-24 15:17:37.692088 | instance | TASK [Fail if atmosphere_ceph_enabled is set] ********************************** 2026-08-24 15:17:37.692455 | instance | Monday 24 August 2026 15:17:37 +0000 (0:00:00.908) 0:00:01.989 ********* 2026-08-24 15:17:37.737626 | instance | skipping: [instance] 2026-08-24 15:17:37.737998 | instance | 2026-08-24 15:17:37.738349 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-08-24 15:17:37.738706 | instance | Monday 24 August 2026 15:17:37 +0000 (0:00:00.046) 0:00:02.036 ********* 2026-08-24 15:17:37.933813 | instance | ok: [instance] 2026-08-24 15:17:37.934218 | instance | 2026-08-24 15:17:37.934594 | instance | PLAY [Deploy Ceph monitors & managers] ***************************************** 2026-08-24 15:17:37.934910 | instance | 2026-08-24 15:17:37.935264 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-24 15:17:37.935709 | instance | Monday 24 August 2026 15:17:37 +0000 (0:00:00.193) 0:00:02.230 ********* 2026-08-24 15:17:38.865611 | instance | ok: [instance] 2026-08-24 15:17:38.866007 | instance | 2026-08-24 15:17:38.866352 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-24 15:17:38.866692 | instance | Monday 24 August 2026 15:17:38 +0000 (0:00:00.931) 0:00:03.161 ********* 2026-08-24 15:17:39.201369 | instance | ok: [instance] 2026-08-24 15:17:39.201453 | instance | 2026-08-24 15:17:39.201653 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-24 15:17:39.201896 | instance | Monday 24 August 2026 15:17:39 +0000 (0:00:00.336) 0:00:03.497 ********* 2026-08-24 15:17:39.253411 | instance | skipping: [instance] 2026-08-24 15:17:39.253477 | instance | 2026-08-24 15:17:39.253650 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-08-24 15:17:39.253865 | instance | Monday 24 August 2026 15:17:39 +0000 (0:00:00.050) 0:00:03.547 ********* 2026-08-24 15:17:39.629427 | instance | changed: [instance] 2026-08-24 15:17:39.629522 | instance | 2026-08-24 15:17:39.629614 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-24 15:17:39.629823 | instance | Monday 24 August 2026 15:17:39 +0000 (0:00:00.377) 0:00:03.925 ********* 2026-08-24 15:17:39.705431 | instance | ok: [instance] => { 2026-08-24 15:17:39.705519 | instance | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-08-24 15:17:39.705617 | instance | } 2026-08-24 15:17:39.705825 | instance | 2026-08-24 15:17:39.705981 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-24 15:17:39.706134 | instance | Monday 24 August 2026 15:17:39 +0000 (0:00:00.075) 0:00:04.000 ********* 2026-08-24 15:17:40.329775 | instance | changed: [instance] 2026-08-24 15:17:40.330229 | instance | 2026-08-24 15:17:40.330604 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-24 15:17:40.330954 | instance | Monday 24 August 2026 15:17:40 +0000 (0:00:00.625) 0:00:04.626 ********* 2026-08-24 15:17:40.385951 | instance | skipping: [instance] 2026-08-24 15:17:40.386391 | instance | 2026-08-24 15:17:40.386758 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-24 15:17:40.387185 | instance | Monday 24 August 2026 15:17:40 +0000 (0:00:00.055) 0:00:04.681 ********* 2026-08-24 15:17:40.441394 | instance | skipping: [instance] 2026-08-24 15:17:40.441616 | instance | 2026-08-24 15:17:40.441786 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-24 15:17:40.441947 | instance | Monday 24 August 2026 15:17:40 +0000 (0:00:00.055) 0:00:04.737 ********* 2026-08-24 15:17:40.673068 | instance | ok: [instance] 2026-08-24 15:17:40.673265 | instance | 2026-08-24 15:17:40.673425 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-24 15:17:40.673598 | instance | Monday 24 August 2026 15:17:40 +0000 (0:00:00.230) 0:00:04.968 ********* 2026-08-24 15:17:42.196236 | instance | ok: [instance] 2026-08-24 15:17:42.196283 | instance | 2026-08-24 15:17:42.196289 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-24 15:17:42.196306 | instance | Monday 24 August 2026 15:17:42 +0000 (0:00:01.526) 0:00:06.494 ********* 2026-08-24 15:17:42.275483 | instance | ok: [instance] => { 2026-08-24 15:17:42.275535 | instance | "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz" 2026-08-24 15:17:42.275547 | instance | } 2026-08-24 15:17:42.275557 | instance | 2026-08-24 15:17:42.275566 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-24 15:17:42.275576 | instance | Monday 24 August 2026 15:17:42 +0000 (0:00:00.078) 0:00:06.572 ********* 2026-08-24 15:17:43.004604 | instance | changed: [instance] 2026-08-24 15:17:43.004648 | instance | 2026-08-24 15:17:43.004654 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-24 15:17:43.004660 | instance | Monday 24 August 2026 15:17:42 +0000 (0:00:00.730) 0:00:07.302 ********* 2026-08-24 15:17:46.008821 | instance | changed: [instance] 2026-08-24 15:17:46.009073 | instance | 2026-08-24 15:17:46.009204 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-08-24 15:17:46.009582 | instance | Monday 24 August 2026 15:17:46 +0000 (0:00:03.003) 0:00:10.306 ********* 2026-08-24 15:17:46.048565 | instance | skipping: [instance] 2026-08-24 15:17:46.048849 | instance | 2026-08-24 15:17:46.049490 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-08-24 15:17:46.049795 | instance | Monday 24 August 2026 15:17:46 +0000 (0:00:00.040) 0:00:10.346 ********* 2026-08-24 15:17:46.084097 | instance | skipping: [instance] 2026-08-24 15:17:46.084404 | instance | 2026-08-24 15:17:46.084732 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-08-24 15:17:46.085100 | instance | Monday 24 August 2026 15:17:46 +0000 (0:00:00.035) 0:00:10.382 ********* 2026-08-24 15:17:46.116124 | instance | skipping: [instance] 2026-08-24 15:17:46.116381 | instance | 2026-08-24 15:17:46.116662 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-08-24 15:17:46.116984 | instance | Monday 24 August 2026 15:17:46 +0000 (0:00:00.031) 0:00:10.414 ********* 2026-08-24 15:17:52.230576 | instance | changed: [instance] 2026-08-24 15:17:52.230834 | instance | 2026-08-24 15:17:52.231176 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] *** 2026-08-24 15:17:52.231520 | instance | Monday 24 August 2026 15:17:52 +0000 (0:00:06.114) 0:00:16.528 ********* 2026-08-24 15:17:52.826900 | instance | changed: [instance] 2026-08-24 15:17:52.827122 | instance | 2026-08-24 15:17:52.827411 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] ******* 2026-08-24 15:17:52.827716 | instance | Monday 24 August 2026 15:17:52 +0000 (0:00:00.597) 0:00:17.125 ********* 2026-08-24 15:17:53.740454 | instance | changed: [instance] => (item={'path': '/etc/containerd'}) 2026-08-24 15:17:53.740522 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'}) 2026-08-24 15:17:53.740535 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'}) 2026-08-24 15:17:53.740560 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'}) 2026-08-24 15:17:53.740571 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'}) 2026-08-24 15:17:53.740581 | instance | 2026-08-24 15:17:53.740591 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] ********** 2026-08-24 15:17:53.740600 | instance | Monday 24 August 2026 15:17:53 +0000 (0:00:00.911) 0:00:18.036 ********* 2026-08-24 15:17:54.327219 | instance | changed: [instance] 2026-08-24 15:17:54.327432 | instance | 2026-08-24 15:17:54.327445 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ******** 2026-08-24 15:17:54.327981 | instance | Monday 24 August 2026 15:17:54 +0000 (0:00:00.572) 0:00:18.608 ********* 2026-08-24 15:17:54.328038 | instance | 2026-08-24 15:17:54.328044 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-08-24 15:17:54.328049 | instance | Monday 24 August 2026 15:17:54 +0000 (0:00:00.016) 0:00:18.625 ********* 2026-08-24 15:17:55.306123 | instance | ok: [instance] 2026-08-24 15:17:55.306258 | instance | 2026-08-24 15:17:55.306328 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] ********** 2026-08-24 15:17:55.306482 | instance | Monday 24 August 2026 15:17:55 +0000 (0:00:00.978) 0:00:19.604 ********* 2026-08-24 15:17:55.749215 | instance | changed: [instance] 2026-08-24 15:17:55.749304 | instance | 2026-08-24 15:17:55.749637 | instance | TASK [vexxhost.containers.containerd : Enable and start service] *************** 2026-08-24 15:17:55.749681 | instance | Monday 24 August 2026 15:17:55 +0000 (0:00:00.443) 0:00:20.047 ********* 2026-08-24 15:17:56.329257 | instance | changed: [instance] 2026-08-24 15:17:56.329352 | instance | 2026-08-24 15:17:56.329638 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-24 15:17:56.329682 | instance | Monday 24 August 2026 15:17:56 +0000 (0:00:00.580) 0:00:20.627 ********* 2026-08-24 15:17:56.549740 | instance | ok: [instance] 2026-08-24 15:17:56.549820 | instance | 2026-08-24 15:17:56.550082 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-24 15:17:56.550130 | instance | Monday 24 August 2026 15:17:56 +0000 (0:00:00.220) 0:00:20.848 ********* 2026-08-24 15:17:56.611988 | instance | ok: [instance] => { 2026-08-24 15:17:56.612635 | instance | "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz" 2026-08-24 15:17:56.612674 | instance | } 2026-08-24 15:17:56.612680 | instance | 2026-08-24 15:17:56.612684 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-24 15:17:56.612690 | instance | Monday 24 August 2026 15:17:56 +0000 (0:00:00.062) 0:00:20.910 ********* 2026-08-24 15:17:57.660183 | instance | changed: [instance] 2026-08-24 15:17:57.660297 | instance | 2026-08-24 15:17:57.660748 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-24 15:17:57.660948 | instance | Monday 24 August 2026 15:17:57 +0000 (0:00:01.047) 0:00:21.958 ********* 2026-08-24 15:18:02.166408 | instance | changed: [instance] 2026-08-24 15:18:02.166485 | instance | 2026-08-24 15:18:02.166754 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ****************** 2026-08-24 15:18:02.166800 | instance | Monday 24 August 2026 15:18:02 +0000 (0:00:04.506) 0:00:26.465 ********* 2026-08-24 15:18:03.640683 | instance | ok: [instance] 2026-08-24 15:18:03.640776 | instance | 2026-08-24 15:18:03.640910 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] *************** 2026-08-24 15:18:03.641036 | instance | Monday 24 August 2026 15:18:03 +0000 (0:00:01.474) 0:00:27.939 ********* 2026-08-24 15:18:04.028499 | instance | changed: [instance] 2026-08-24 15:18:04.028785 | instance | 2026-08-24 15:18:04.029233 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] ***** 2026-08-24 15:18:04.029500 | instance | Monday 24 August 2026 15:18:04 +0000 (0:00:00.387) 0:00:28.326 ********* 2026-08-24 15:18:04.519075 | instance | changed: [instance] 2026-08-24 15:18:04.519231 | instance | 2026-08-24 15:18:04.519425 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] *********** 2026-08-24 15:18:04.519618 | instance | Monday 24 August 2026 15:18:04 +0000 (0:00:00.490) 0:00:28.817 ********* 2026-08-24 15:18:05.147655 | instance | changed: [instance] => (item={'path': '/etc/docker'}) 2026-08-24 15:18:05.148050 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'}) 2026-08-24 15:18:05.148468 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'}) 2026-08-24 15:18:05.148861 | instance | 2026-08-24 15:18:05.149020 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ****** 2026-08-24 15:18:05.149183 | instance | Monday 24 August 2026 15:18:05 +0000 (0:00:00.628) 0:00:29.445 ********* 2026-08-24 15:18:05.623638 | instance | changed: [instance] 2026-08-24 15:18:05.623925 | instance | 2026-08-24 15:18:05.624239 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] *********** 2026-08-24 15:18:05.624799 | instance | Monday 24 August 2026 15:18:05 +0000 (0:00:00.475) 0:00:29.921 ********* 2026-08-24 15:18:06.141111 | instance | changed: [instance] 2026-08-24 15:18:06.141240 | instance | 2026-08-24 15:18:06.141423 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************ 2026-08-24 15:18:06.141610 | instance | Monday 24 August 2026 15:18:06 +0000 (0:00:00.498) 0:00:30.419 ********* 2026-08-24 15:18:06.141769 | instance | 2026-08-24 15:18:06.141944 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-08-24 15:18:06.142118 | instance | Monday 24 August 2026 15:18:06 +0000 (0:00:00.019) 0:00:30.439 ********* 2026-08-24 15:18:06.845941 | instance | ok: [instance] 2026-08-24 15:18:06.846002 | instance | 2026-08-24 15:18:06.846010 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ****************** 2026-08-24 15:18:06.846017 | instance | Monday 24 August 2026 15:18:06 +0000 (0:00:00.704) 0:00:31.143 ********* 2026-08-24 15:18:07.721973 | instance | changed: [instance] 2026-08-24 15:18:07.722489 | instance | 2026-08-24 15:18:07.722509 | instance | TASK [vexxhost.containers.docker : Enable and start service] ******************* 2026-08-24 15:18:07.722517 | instance | Monday 24 August 2026 15:18:07 +0000 (0:00:00.876) 0:00:32.020 ********* 2026-08-24 15:18:08.321272 | instance | changed: [instance] 2026-08-24 15:18:08.321324 | instance | 2026-08-24 15:18:08.321330 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ****** 2026-08-24 15:18:08.321335 | instance | Monday 24 August 2026 15:18:08 +0000 (0:00:00.599) 0:00:32.619 ********* 2026-08-24 15:18:08.384887 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml) 2026-08-24 15:18:08.384976 | instance | 2026-08-24 15:18:08.385252 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ******************************** 2026-08-24 15:18:08.385366 | instance | Monday 24 August 2026 15:18:08 +0000 (0:00:00.063) 0:00:32.683 ********* 2026-08-24 15:18:14.071558 | instance | changed: [instance] 2026-08-24 15:18:14.071677 | instance | 2026-08-24 15:18:14.071722 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] ********************* 2026-08-24 15:18:14.071896 | instance | Monday 24 August 2026 15:18:14 +0000 (0:00:05.686) 0:00:38.370 ********* 2026-08-24 15:18:14.771285 | instance | ok: [instance] => (item=chronyd) 2026-08-24 15:18:14.771400 | instance | ok: [instance] => (item=sshd) 2026-08-24 15:18:14.771915 | instance | 2026-08-24 15:18:14.771986 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ****************************** 2026-08-24 15:18:14.771996 | instance | Monday 24 August 2026 15:18:14 +0000 (0:00:00.699) 0:00:39.069 ********* 2026-08-24 15:18:15.506342 | instance | changed: [instance] 2026-08-24 15:18:15.506452 | instance | 2026-08-24 15:18:15.506509 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ******************** 2026-08-24 15:18:15.506665 | instance | Monday 24 August 2026 15:18:15 +0000 (0:00:00.735) 0:00:39.804 ********* 2026-08-24 15:18:15.728141 | instance | ok: [instance] 2026-08-24 15:18:15.728255 | instance | 2026-08-24 15:18:15.728318 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] **************** 2026-08-24 15:18:15.728503 | instance | Monday 24 August 2026 15:18:15 +0000 (0:00:00.221) 0:00:40.026 ********* 2026-08-24 15:18:16.190793 | instance | changed: [instance] 2026-08-24 15:18:16.190885 | instance | 2026-08-24 15:18:16.191414 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] *** 2026-08-24 15:18:16.191438 | instance | Monday 24 August 2026 15:18:16 +0000 (0:00:00.462) 0:00:40.489 ********* 2026-08-24 15:18:16.547747 | instance | changed: [instance] 2026-08-24 15:18:16.547820 | instance | 2026-08-24 15:18:16.548137 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] ************************* 2026-08-24 15:18:16.548209 | instance | Monday 24 August 2026 15:18:16 +0000 (0:00:00.357) 0:00:40.846 ********* 2026-08-24 15:18:16.798375 | instance | ok: [instance] 2026-08-24 15:18:16.798490 | instance | 2026-08-24 15:18:16.798505 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] ******************* 2026-08-24 15:18:16.798651 | instance | Monday 24 August 2026 15:18:16 +0000 (0:00:00.250) 0:00:41.096 ********* 2026-08-24 15:18:17.035149 | instance | ok: [instance] => (item=instance) 2026-08-24 15:18:17.035259 | instance | 2026-08-24 15:18:17.035332 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ******** 2026-08-24 15:18:17.035521 | instance | Monday 24 August 2026 15:18:17 +0000 (0:00:00.236) 0:00:41.333 ********* 2026-08-24 15:18:17.093418 | instance | ok: [instance] 2026-08-24 15:18:17.093544 | instance | 2026-08-24 15:18:17.093560 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] *********************************** 2026-08-24 15:18:17.093735 | instance | Monday 24 August 2026 15:18:17 +0000 (0:00:00.058) 0:00:41.391 ********* 2026-08-24 15:18:17.172845 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance 2026-08-24 15:18:17.172959 | instance | 2026-08-24 15:18:17.172976 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] ************* 2026-08-24 15:18:17.173179 | instance | Monday 24 August 2026 15:18:17 +0000 (0:00:00.079) 0:00:41.471 ********* 2026-08-24 15:18:17.493632 | instance | changed: [instance] 2026-08-24 15:18:17.493742 | instance | 2026-08-24 15:18:17.494047 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ****************** 2026-08-24 15:18:17.494123 | instance | Monday 24 August 2026 15:18:17 +0000 (0:00:00.320) 0:00:41.791 ********* 2026-08-24 15:18:18.196051 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True}) 2026-08-24 15:18:18.196140 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0}) 2026-08-24 15:18:18.196892 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False}) 2026-08-24 15:18:18.196992 | instance | 2026-08-24 15:18:18.197009 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] ******************************* 2026-08-24 15:18:18.197031 | instance | Monday 24 August 2026 15:18:18 +0000 (0:00:00.702) 0:00:42.494 ********* 2026-08-24 15:19:48.032563 | instance | ok: [instance] 2026-08-24 15:19:48.032614 | instance | 2026-08-24 15:19:48.032620 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] *************** 2026-08-24 15:19:48.032625 | instance | Monday 24 August 2026 15:19:48 +0000 (0:01:29.835) 0:02:12.329 ********* 2026-08-24 15:19:48.241991 | instance | changed: [instance] 2026-08-24 15:19:48.242105 | instance | 2026-08-24 15:19:48.242279 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] ********************************** 2026-08-24 15:19:48.242453 | instance | Monday 24 August 2026 15:19:48 +0000 (0:00:00.211) 0:02:12.540 ********* 2026-08-24 15:19:48.288341 | instance | ok: [instance] 2026-08-24 15:19:48.288421 | instance | 2026-08-24 15:19:48.288474 | instance | TASK [Install Ceph host] ******************************************************* 2026-08-24 15:19:48.288634 | instance | Monday 24 August 2026 15:19:48 +0000 (0:00:00.046) 0:02:12.587 ********* 2026-08-24 15:19:48.376932 | instance | included: vexxhost.ceph.cephadm_host for instance 2026-08-24 15:19:48.377016 | instance | 2026-08-24 15:19:48.377040 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ****** 2026-08-24 15:19:48.377054 | instance | Monday 24 August 2026 15:19:48 +0000 (0:00:00.087) 0:02:12.674 ********* 2026-08-24 15:19:50.034193 | instance | ok: [instance] 2026-08-24 15:19:50.034274 | instance | 2026-08-24 15:19:50.034413 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] *** 2026-08-24 15:19:50.034529 | instance | Monday 24 August 2026 15:19:50 +0000 (0:00:01.658) 0:02:14.333 ********* 2026-08-24 15:19:50.094975 | instance | ok: [instance] => (item=instance) 2026-08-24 15:19:50.095104 | instance | 2026-08-24 15:19:50.095286 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] *********** 2026-08-24 15:19:50.095486 | instance | Monday 24 August 2026 15:19:50 +0000 (0:00:00.060) 0:02:14.393 ********* 2026-08-24 15:19:50.443002 | instance | ok: [instance] 2026-08-24 15:19:50.443390 | instance | 2026-08-24 15:19:50.443466 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] *********************** 2026-08-24 15:19:50.443586 | instance | Monday 24 August 2026 15:19:50 +0000 (0:00:00.348) 0:02:14.741 ********* 2026-08-24 15:19:52.723119 | instance | ok: [instance] 2026-08-24 15:19:52.723258 | instance | 2026-08-24 15:19:52.723272 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ****************** 2026-08-24 15:19:52.723402 | instance | Monday 24 August 2026 15:19:52 +0000 (0:00:02.279) 0:02:17.021 ********* 2026-08-24 15:20:36.263104 | 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-24 15:20:36.263990 | 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_bvq2lvvm/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_bvq2lvvm/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_bvq2lvvm/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_bvq2lvvm/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-24T15:20:36.095+0000 7f2ff038f640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgDqYIxqevA8KSAA/o188kiLI3nPgSB5DFUX5taSmlUk4/Zc7LT+x/rp3NY=: Malformed input [buffer:3]\n2026-08-24T15:20:36.095+0000 7f2ff038f640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T15:20:36.095+0000 7f2ff038f640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgDqYIxqevA8KSAA/o188kiLI3nPgSB5DFUX5taSmlUk4/Zc7LT+x/rp3NY=: Malformed input [buffer:3]\n2026-08-24T15:20:36.095+0000 7f2ff038f640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T15:20:36.095+0000 7f2ff038f640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgDqYIxqevA8KSAA/o188kiLI3nPgSB5DFUX5taSmlUk4/Zc7LT+x/rp3NY=: Malformed input [buffer:3]\n2026-08-24T15:20:36.095+0000 7f2ff038f640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T15:20:36.095+0000 7f2ff038f640 -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-24 15:20:36.267000 | instance | 2026-08-24 15:20:36.267278 | instance | PLAY RECAP ********************************************************************* 2026-08-24 15:20:36.268491 | instance | instance : ok=55 changed=26 unreachable=0 failed=1 skipped=7 rescued=0 ignored=0 2026-08-24 15:20:36.268533 | instance | 2026-08-24 15:20:36.268548 | instance | Monday 24 August 2026 15:20:36 +0000 (0:00:43.544) 0:03:00.565 ********* 2026-08-24 15:20:36.268561 | instance | =============================================================================== 2026-08-24 15:20:36.268854 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 89.84s 2026-08-24 15:20:36.268943 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 43.54s 2026-08-24 15:20:36.270757 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 6.11s 2026-08-24 15:20:36.270842 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 5.69s 2026-08-24 15:20:36.270860 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.51s 2026-08-24 15:20:36.270874 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 3.00s 2026-08-24 15:20:36.270912 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.28s 2026-08-24 15:20:36.270927 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.68s 2026-08-24 15:20:36.270949 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.66s 2026-08-24 15:20:36.271831 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.53s 2026-08-24 15:20:36.271855 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.47s 2026-08-24 15:20:36.271862 | instance | vexxhost.containers.download_artifact : Download item ------------------- 1.05s 2026-08-24 15:20:36.271868 | instance | Gathering Facts --------------------------------------------------------- 1.02s 2026-08-24 15:20:36.271873 | instance | Gathering Facts --------------------------------------------------------- 0.93s 2026-08-24 15:20:36.271882 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.91s 2026-08-24 15:20:36.271973 | instance | Gathering Facts --------------------------------------------------------- 0.91s 2026-08-24 15:20:36.272145 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 0.88s 2026-08-24 15:20:36.272300 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 0.74s 2026-08-24 15:20:36.272468 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.73s 2026-08-24 15:20:36.272625 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.70s 2026-08-24 15:20:36.358105 | 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-24 15:20:36.358476 | instance | ERROR [csi > converge] Executed: Failed 2026-08-24 15:20:36.358673 | 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-24 15:20:36.745093 | instance | ERROR 2026-08-24 15:20:36.745297 | instance | { 2026-08-24 15:20:36.745339 | instance | "delta": "0:03:50.156809", 2026-08-24 15:20:36.745369 | instance | "end": "2026-08-24 15:20:36.418453", 2026-08-24 15:20:36.745396 | instance | "msg": "non-zero return code", 2026-08-24 15:20:36.745421 | instance | "rc": 2, 2026-08-24 15:20:36.745446 | instance | "start": "2026-08-24 15:16:46.261644" 2026-08-24 15:20:36.745471 | instance | } failure 2026-08-24 15:20:36.757032 | 2026-08-24 15:20:36.757108 | PLAY RECAP 2026-08-24 15:20:36.757151 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-08-24 15:20:36.757174 | 2026-08-24 15:20:36.936666 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-24 15:20:36.939574 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-08-24 15:20:38.037888 | 2026-08-24 15:20:38.038035 | PLAY [all] 2026-08-24 15:20:38.055411 | 2026-08-24 15:20:38.055537 | TASK [gather-host-logs : creating directory for system status] 2026-08-24 15:20:38.413999 | instance | changed 2026-08-24 15:20:38.778875 | 2026-08-24 15:20:38.779028 | TASK [gather-host-logs : Get logs for each host] 2026-08-24 15:20:39.164583 | instance | + systemd-cgls --full --all --no-pager 2026-08-24 15:20:39.179786 | instance | + ip addr 2026-08-24 15:20:39.182561 | instance | + ip route 2026-08-24 15:20:39.184498 | instance | + lsblk 2026-08-24 15:20:39.189966 | instance | + mount 2026-08-24 15:20:39.192621 | instance | + docker images 2026-08-24 15:20:39.214215 | instance | + brctl show 2026-08-24 15:20:39.214645 | instance | /bin/bash: line 8: brctl: command not found 2026-08-24 15:20:39.214891 | instance | + ps aux --sort=-%mem 2026-08-24 15:20:39.230417 | instance | + dpkg -l 2026-08-24 15:20:39.239440 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-08-24 15:20:39.239998 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-08-24 15:20:39.260621 | instance | + '[' '!' -z '' ']' 2026-08-24 15:20:39.317859 | instance | ok: Runtime: 0:00:00.100223 2026-08-24 15:20:39.325539 | 2026-08-24 15:20:39.325635 | TASK [gather-host-logs : Downloads logs to executor] 2026-08-24 15:20:39.996587 | instance | changed: 2026-08-24 15:20:39.996775 | instance | created directory /var/lib/zuul/builds/58fd97d5ebd741598974b2c2815cfd27/work/logs/instance 2026-08-24 15:20:39.996816 | instance | cd+++++++++ system/ 2026-08-24 15:20:39.996850 | instance | >f+++++++++ system/brctl-show.txt 2026-08-24 15:20:39.996882 | instance | >f+++++++++ system/docker-images.txt 2026-08-24 15:20:39.996912 | instance | >f+++++++++ system/ip-addr.txt 2026-08-24 15:20:39.996946 | instance | >f+++++++++ system/ip-route.txt 2026-08-24 15:20:39.997020 | instance | >f+++++++++ system/lsblk.txt 2026-08-24 15:20:39.997059 | instance | >f+++++++++ system/mount.txt 2026-08-24 15:20:39.997089 | instance | >f+++++++++ system/packages.txt 2026-08-24 15:20:39.997119 | instance | >f+++++++++ system/ps.txt 2026-08-24 15:20:39.997152 | instance | >f+++++++++ system/systemd-cgls.txt 2026-08-24 15:20:40.009351 | 2026-08-24 15:20:40.009464 | LOOP [helm-release-status : creating directory for helm release status] 2026-08-24 15:20:40.214104 | instance | changed: "values" 2026-08-24 15:20:40.383164 | instance | changed: "releases" 2026-08-24 15:20:40.395675 | 2026-08-24 15:20:40.395830 | TASK [helm-release-status : Gather get release status for helm charts] 2026-08-24 15:20:40.593839 | instance | /bin/bash: line 3: kubectl: command not found 2026-08-24 15:20:40.934846 | instance | ok: Runtime: 0:00:00.004919 2026-08-24 15:20:40.941467 | 2026-08-24 15:20:40.941545 | TASK [helm-release-status : Downloads logs to executor] 2026-08-24 15:20:41.431651 | instance | changed: 2026-08-24 15:20:41.431886 | instance | cd+++++++++ helm/ 2026-08-24 15:20:41.431940 | instance | cd+++++++++ helm/releases/ 2026-08-24 15:20:41.431976 | instance | cd+++++++++ helm/values/ 2026-08-24 15:20:41.445127 | 2026-08-24 15:20:41.445197 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-08-24 15:20:41.653041 | instance | changed 2026-08-24 15:20:41.660643 | 2026-08-24 15:20:41.660725 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-08-24 15:20:41.914228 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-24 15:20:41.914453 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-24 15:20:41.920048 | instance | environment: line 1: kubectl: command not found 2026-08-24 15:20:41.921649 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-24 15:20:41.922820 | instance | environment: line 1: kubectl: command not found 2026-08-24 15:20:41.924231 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-24 15:20:41.925617 | instance | environment: line 1: kubectl: command not found 2026-08-24 15:20:41.926408 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-24 15:20:41.927961 | instance | environment: line 1: kubectl: command not found 2026-08-24 15:20:41.928747 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-24 15:20:41.928784 | instance | environment: line 1: kubectl: command not found 2026-08-24 15:20:41.929813 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-24 15:20:42.198446 | instance | ok: Runtime: 0:00:00.022645 2026-08-24 15:20:42.205013 | 2026-08-24 15:20:42.205100 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-08-24 15:20:42.413386 | instance | changed 2026-08-24 15:20:42.480877 | 2026-08-24 15:20:42.481049 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-08-24 15:20:42.717869 | instance | environment: line 5: kubectl: command not found 2026-08-24 15:20:42.718190 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-24 15:20:42.720101 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-24 15:20:42.720355 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-24 15:20:43.048507 | instance | ok: Runtime: 0:00:00.011073 2026-08-24 15:20:43.059984 | 2026-08-24 15:20:43.060089 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-08-24 15:20:43.836069 | instance | changed: 2026-08-24 15:20:43.836394 | instance | cd+++++++++ objects/ 2026-08-24 15:20:43.836428 | instance | cd+++++++++ objects/cluster/ 2026-08-24 15:20:43.836636 | instance | cd+++++++++ objects/namespaced/ 2026-08-24 15:20:43.856201 | 2026-08-24 15:20:43.856358 | TASK [gather-pod-logs : creating directory for pod logs] 2026-08-24 15:20:44.111856 | instance | changed 2026-08-24 15:20:44.120275 | 2026-08-24 15:20:44.215388 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-08-24 15:20:44.414875 | instance | changed 2026-08-24 15:20:44.421803 | 2026-08-24 15:20:44.421902 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-08-24 15:20:44.651870 | instance | environment: line 3: kubectl: command not found 2026-08-24 15:20:44.962839 | instance | ok: Runtime: 0:00:00.008447 2026-08-24 15:20:44.970859 | 2026-08-24 15:20:44.970970 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-08-24 15:20:45.504474 | instance | changed: 2026-08-24 15:20:45.504645 | instance | cd+++++++++ pod-logs/ 2026-08-24 15:20:45.504682 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-08-24 15:20:45.515096 | 2026-08-24 15:20:45.515169 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-08-24 15:20:45.729965 | instance | changed 2026-08-24 15:20:45.950144 | 2026-08-24 15:20:45.950359 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-08-24 15:20:46.158351 | instance | /bin/bash: line 2: kubectl: command not found 2026-08-24 15:20:46.489174 | instance | ok: Runtime: 0:00:00.039311 2026-08-24 15:20:46.494328 | 2026-08-24 15:20:46.494405 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-08-24 15:20:46.712747 | instance | /bin/bash: line 2: kubectl: command not found 2026-08-24 15:20:46.744555 | instance | ceph-mgr endpoints: 2026-08-24 15:20:47.053058 | instance | ok: Runtime: 0:00:00.036226 2026-08-24 15:20:47.063427 | 2026-08-24 15:20:47.063569 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-08-24 15:20:47.280066 | instance | /bin/bash: line 4: kubectl: command not found 2026-08-24 15:20:47.602282 | instance | ok: Runtime: 0:00:00.039693 2026-08-24 15:20:47.609342 | 2026-08-24 15:20:47.609427 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-08-24 15:20:48.184031 | instance | changed: cd+++++++++ prometheus/ 2026-08-24 15:20:48.197239 | 2026-08-24 15:20:48.197332 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-08-24 15:20:48.435680 | instance | changed 2026-08-24 15:20:48.442985 | 2026-08-24 15:20:48.443093 | TASK [gather-selenium-data : Get selenium data] 2026-08-24 15:20:48.725504 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-08-24 15:20:48.726989 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-08-24 15:20:48.983023 | instance | ERROR 2026-08-24 15:20:48.983209 | instance | { 2026-08-24 15:20:48.983253 | instance | "delta": "0:00:00.005667", 2026-08-24 15:20:48.983285 | instance | "end": "2026-08-24 15:20:48.727322", 2026-08-24 15:20:48.983316 | instance | "msg": "non-zero return code", 2026-08-24 15:20:48.983345 | instance | "rc": 1, 2026-08-24 15:20:48.983373 | instance | "start": "2026-08-24 15:20:48.721655" 2026-08-24 15:20:48.983398 | instance | } 2026-08-24 15:20:48.983431 | instance | ERROR: Ignoring Errors 2026-08-24 15:20:48.990320 | 2026-08-24 15:20:48.990403 | TASK [gather-selenium-data : Downloads logs to executor] 2026-08-24 15:20:49.488728 | instance | changed: cd+++++++++ selenium/ 2026-08-24 15:20:49.577781 | 2026-08-24 15:20:49.578028 | PLAY RECAP 2026-08-24 15:20:49.578246 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-08-24 15:20:49.578432 | 2026-08-24 15:20:49.973900 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-08-24 15:20:49.987071 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-24 15:20:51.016640 | 2026-08-24 15:20:51.016800 | PLAY [all] 2026-08-24 15:20:51.029337 | 2026-08-24 15:20:51.029422 | TASK [fetch-output : Set log path for multiple nodes] 2026-08-24 15:20:51.083807 | instance | skipping: Conditional result was False 2026-08-24 15:20:51.095958 | 2026-08-24 15:20:51.096301 | TASK [fetch-output : Set log path for single node] 2026-08-24 15:20:51.140414 | instance | ok 2026-08-24 15:20:51.147064 | 2026-08-24 15:20:51.147204 | LOOP [fetch-output : Ensure local output dirs] 2026-08-24 15:20:52.051655 | instance -> localhost | ok: "/var/lib/zuul/builds/58fd97d5ebd741598974b2c2815cfd27/work/logs" 2026-08-24 15:20:52.299716 | instance -> localhost | changed: "/var/lib/zuul/builds/58fd97d5ebd741598974b2c2815cfd27/work/artifacts" 2026-08-24 15:20:52.517785 | instance -> localhost | changed: "/var/lib/zuul/builds/58fd97d5ebd741598974b2c2815cfd27/work/docs" 2026-08-24 15:20:52.534872 | 2026-08-24 15:20:52.535054 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-24 15:20:54.003653 | instance | changed: .d..t...... ./ 2026-08-24 15:20:54.003902 | instance | changed: All items complete 2026-08-24 15:20:54.003944 | 2026-08-24 15:20:54.472714 | instance | changed: .d..t...... ./ 2026-08-24 15:20:54.930587 | instance | changed: .d..t...... ./ 2026-08-24 15:20:54.955959 | 2026-08-24 15:20:54.956063 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-24 15:20:55.432408 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007618 2026-08-24 15:20:55.650512 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.009000 2026-08-24 15:20:55.670633 | 2026-08-24 15:20:55.671004 | PLAY [all] 2026-08-24 15:20:55.677840 | 2026-08-24 15:20:55.677902 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-24 15:20:56.163236 | instance | changed 2026-08-24 15:20:56.169516 | 2026-08-24 15:20:56.169568 | PLAY RECAP 2026-08-24 15:20:56.169612 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-24 15:20:56.169635 | 2026-08-24 15:20:56.288552 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-24 15:20:56.683255 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-24 15:20:57.985350 | 2026-08-24 15:20:57.985530 | PLAY [localhost] 2026-08-24 15:20:57.996687 | 2026-08-24 15:20:57.996770 | TASK [Generate Zuul manifest] 2026-08-24 15:20:58.022262 | localhost | ok 2026-08-24 15:20:58.284931 | 2026-08-24 15:20:58.285256 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-24 15:21:01.485754 | localhost | changed 2026-08-24 15:21:01.499487 | 2026-08-24 15:21:01.499574 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-24 15:21:02.747968 | localhost | ok 2026-08-24 15:21:02.758238 | 2026-08-24 15:21:02.758340 | TASK [Upload logs] 2026-08-24 15:21:02.782521 | localhost | ok 2026-08-24 15:21:02.999096 | 2026-08-24 15:21:02.999260 | TASK [Set zuul-log-path fact] 2026-08-24 15:21:03.020516 | localhost | ok 2026-08-24 15:21:03.117004 | 2026-08-24 15:21:03.117131 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-24 15:21:03.149529 | localhost | ok 2026-08-24 15:21:03.165013 | 2026-08-24 15:21:03.165107 | TASK [upload-logs : Create log directories] 2026-08-24 15:21:03.600825 | localhost | changed 2026-08-24 15:21:03.606733 | 2026-08-24 15:21:03.606805 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-24 15:21:05.660735 | localhost -> localhost | ok: Runtime: 0:00:00.006790 2026-08-24 15:21:05.668591 | 2026-08-24 15:21:05.668697 | TASK [upload-logs : Upload logs to log server] 2026-08-24 15:21:07.612937 | localhost | Output suppressed because no_log was given 2026-08-24 15:21:07.653280 | 2026-08-24 15:21:07.653434 | LOOP [upload-logs : Compress console log and json output] 2026-08-24 15:21:07.699110 | localhost | skipping: Conditional result was False 2026-08-24 15:21:07.707609 | localhost | skipping: Conditional result was False 2026-08-24 15:21:07.728200 | 2026-08-24 15:21:07.728350 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-24 15:21:07.773425 | localhost | skipping: Conditional result was False 2026-08-24 15:21:08.527476 | 2026-08-24 15:21:08.528745 | localhost | skipping: Conditional result was False 2026-08-24 15:21:08.539577 | 2026-08-24 15:21:08.539713 | LOOP [upload-logs : Upload console log and json output]