2026-08-24 19:32:29.026221 | Job console starting 2026-08-24 19:32:29.037877 | Updating git repos 2026-08-24 19:32:36.470306 | Cloning repos into workspace 2026-08-24 19:32:54.444195 | Restoring repo states 2026-08-24 19:33:03.380542 | Merging changes 2026-08-24 19:33:05.119086 | Checking out repos 2026-08-24 19:33:08.757441 | Preparing playbooks 2026-08-24 19:33:13.187787 | Running Ansible setup 2026-08-24 19:33:16.826210 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-24 19:33:17.446898 | 2026-08-24 19:33:17.447024 | PLAY [localhost] 2026-08-24 19:33:17.454483 | 2026-08-24 19:33:17.454553 | TASK [Gathering Facts] 2026-08-24 19:33:18.466770 | localhost | ok 2026-08-24 19:33:18.481718 | 2026-08-24 19:33:18.481888 | TASK [Setup log path fact] 2026-08-24 19:33:18.506830 | localhost | ok 2026-08-24 19:33:18.517395 | 2026-08-24 19:33:18.517463 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-24 19:33:18.546859 | localhost | ok 2026-08-24 19:33:18.553871 | 2026-08-24 19:33:18.553938 | TASK [emit-job-header : Print job information] 2026-08-24 19:33:18.593994 | # Job Information 2026-08-24 19:33:18.594140 | Ansible Version: 2.16.18 2026-08-24 19:33:18.594183 | Job: atmosphere-molecule-csi-rbd 2026-08-24 19:33:18.594213 | Pipeline: check 2026-08-24 19:33:18.594240 | Executor: 2d72f0692154 2026-08-24 19:33:18.594267 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4341 2026-08-24 19:33:18.594298 | Event ID: a7cd67e0-9ff0-11f1-84df-9ecc53398d84 2026-08-24 19:33:18.598071 | 2026-08-24 19:33:18.598158 | LOOP [emit-job-header : Print node information] 2026-08-24 19:33:18.694017 | localhost | ok: 2026-08-24 19:33:18.694232 | localhost | # Node Information 2026-08-24 19:33:18.694273 | localhost | Inventory Hostname: instance 2026-08-24 19:33:18.694325 | localhost | Hostname: np0000190979 2026-08-24 19:33:18.694439 | localhost | Username: zuul 2026-08-24 19:33:18.694491 | localhost | Distro: Ubuntu 22.04 2026-08-24 19:33:18.694523 | localhost | Provider: yul1 2026-08-24 19:33:18.694562 | localhost | Region: ca-ymq-1 2026-08-24 19:33:18.694614 | localhost | Label: ubuntu-jammy 2026-08-24 19:33:18.694651 | localhost | Product Name: OpenStack Nova 2026-08-24 19:33:18.694684 | localhost | Interface IP: 199.19.213.10 2026-08-24 19:33:18.716166 | 2026-08-24 19:33:18.716283 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-24 19:33:19.147521 | localhost -> localhost | changed 2026-08-24 19:33:19.158122 | 2026-08-24 19:33:19.158208 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-24 19:33:20.075382 | localhost -> localhost | changed 2026-08-24 19:33:20.091135 | 2026-08-24 19:33:20.091231 | PLAY [all] 2026-08-24 19:33:20.103549 | 2026-08-24 19:33:20.103628 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-24 19:33:20.460890 | instance -> localhost | ok 2026-08-24 19:33:20.469610 | 2026-08-24 19:33:20.469705 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-24 19:33:20.499374 | instance | ok 2026-08-24 19:33:20.531507 | instance | included: /var/lib/zuul/builds/3adeae4facf54914b27c4baed8a45348/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-24 19:33:20.542271 | 2026-08-24 19:33:20.542340 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-24 19:33:21.994530 | instance -> localhost | Generating public/private rsa key pair. 2026-08-24 19:33:21.994735 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/3adeae4facf54914b27c4baed8a45348/work/3adeae4facf54914b27c4baed8a45348_id_rsa 2026-08-24 19:33:21.994780 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/3adeae4facf54914b27c4baed8a45348/work/3adeae4facf54914b27c4baed8a45348_id_rsa.pub 2026-08-24 19:33:21.994816 | instance -> localhost | The key fingerprint is: 2026-08-24 19:33:21.994849 | instance -> localhost | SHA256:mOMQP39r3NmseAv6w8tF1kDzFSWimemnYuMW1KHEQtM zuul-build-sshkey 2026-08-24 19:33:21.994899 | instance -> localhost | The key's randomart image is: 2026-08-24 19:33:21.994932 | instance -> localhost | +---[RSA 3072]----+ 2026-08-24 19:33:21.994970 | instance -> localhost | | .oo + ..=| 2026-08-24 19:33:21.995003 | instance -> localhost | | ..E .* + o | 2026-08-24 19:33:21.995035 | instance -> localhost | | . o o=.. . | 2026-08-24 19:33:21.995067 | instance -> localhost | | o oo.. o | 2026-08-24 19:33:21.995097 | instance -> localhost | | . *.S . + . | 2026-08-24 19:33:21.995128 | instance -> localhost | | o +. = | 2026-08-24 19:33:21.995158 | instance -> localhost | | . =++..+ | 2026-08-24 19:33:21.995188 | instance -> localhost | | o.*==+ o | 2026-08-24 19:33:21.995222 | instance -> localhost | | .oo*+oo | 2026-08-24 19:33:21.995253 | instance -> localhost | +----[SHA256]-----+ 2026-08-24 19:33:21.995323 | instance -> localhost | ok: Runtime: 0:00:01.006394 2026-08-24 19:33:22.006077 | 2026-08-24 19:33:22.006217 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-24 19:33:22.040447 | instance | ok 2026-08-24 19:33:22.050270 | instance | included: /var/lib/zuul/builds/3adeae4facf54914b27c4baed8a45348/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-24 19:33:22.059595 | 2026-08-24 19:33:22.059717 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-24 19:33:22.086100 | instance | skipping: Conditional result was False 2026-08-24 19:33:22.096835 | 2026-08-24 19:33:22.096949 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-24 19:33:22.569933 | instance | changed 2026-08-24 19:33:22.575745 | 2026-08-24 19:33:22.575806 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-24 19:33:22.746408 | instance | ok 2026-08-24 19:33:22.751568 | 2026-08-24 19:33:22.751635 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-24 19:33:23.192135 | instance | changed 2026-08-24 19:33:23.197385 | 2026-08-24 19:33:23.197454 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-24 19:33:23.620601 | instance | changed 2026-08-24 19:33:23.626752 | 2026-08-24 19:33:23.626815 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-24 19:33:23.652026 | instance | skipping: Conditional result was False 2026-08-24 19:33:23.663464 | 2026-08-24 19:33:23.663596 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-24 19:33:24.067974 | instance -> localhost | changed 2026-08-24 19:33:24.115183 | 2026-08-24 19:33:24.115321 | TASK [add-build-sshkey : Add back temp key] 2026-08-24 19:33:24.479763 | instance -> localhost | Identity added: /var/lib/zuul/builds/3adeae4facf54914b27c4baed8a45348/work/3adeae4facf54914b27c4baed8a45348_id_rsa (zuul-build-sshkey) 2026-08-24 19:33:24.480362 | instance -> localhost | ok: Runtime: 0:00:00.010591 2026-08-24 19:33:24.486469 | 2026-08-24 19:33:24.486531 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-24 19:33:24.792352 | instance | ok 2026-08-24 19:33:24.796930 | 2026-08-24 19:33:24.797014 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-24 19:33:24.821001 | instance | skipping: Conditional result was False 2026-08-24 19:33:24.835345 | 2026-08-24 19:33:24.835413 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-08-24 19:33:25.172923 | instance | ok 2026-08-24 19:33:25.178466 | 2026-08-24 19:33:25.178532 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-08-24 19:33:28.725402 | instance | Output suppressed because no_log was given 2026-08-24 19:33:28.741460 | 2026-08-24 19:33:28.741647 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-08-24 19:33:28.937602 | instance | ok: "logs" 2026-08-24 19:33:28.937853 | instance | ok: All items complete 2026-08-24 19:33:28.937884 | 2026-08-24 19:33:29.089880 | instance | ok: "artifacts" 2026-08-24 19:33:29.242692 | instance | ok: "docs" 2026-08-24 19:33:29.266030 | 2026-08-24 19:33:29.266206 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-08-24 19:33:29.454747 | instance | changed: "logs" 2026-08-24 19:33:29.607257 | instance | changed: "artifacts" 2026-08-24 19:33:29.792171 | instance | changed: "docs" 2026-08-24 19:33:29.805868 | 2026-08-24 19:33:29.806004 | PLAY RECAP 2026-08-24 19:33:29.806074 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-08-24 19:33:29.806157 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-24 19:33:29.806195 | 2026-08-24 19:33:29.991904 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-24 19:33:29.995863 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-24 19:33:30.655113 | 2026-08-24 19:33:30.655268 | PLAY [all] 2026-08-24 19:33:30.670710 | 2026-08-24 19:33:30.670850 | TASK [setup-uv : Extract archive] 2026-08-24 19:33:32.863539 | instance | changed 2026-08-24 19:33:32.870672 | 2026-08-24 19:33:32.870749 | TASK [setup-uv : Print version] 2026-08-24 19:33:33.235513 | instance | uv 0.8.13 2026-08-24 19:33:33.409400 | instance | ok: Runtime: 0:00:00.011801 2026-08-24 19:33:33.420857 | 2026-08-24 19:33:33.420932 | TASK [Install Ansible collection siblings] 2026-08-24 19:33:42.047875 | instance | changed: 2026-08-24 19:33:42.048412 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-08-24 19:33:42.048454 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-08-24 19:33:42.048478 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-08-24 19:33:42.048498 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto 2026-08-24 19:33:42.048519 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general 2026-08-24 19:33:42.048543 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql 2026-08-24 19:33:42.048565 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-08-24 19:33:42.048588 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-08-24 19:33:42.048609 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-08-24 19:33:42.048635 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-08-24 19:33:42.048656 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-08-24 19:33:42.048787 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-08-24 19:33:42.048819 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0 2026-08-24 19:33:42.048840 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0 2026-08-24 19:33:42.048865 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0 2026-08-24 19:33:42.048887 | instance | Resolved community.crypto to 2.2.3 for 2.2.3 2026-08-24 19:33:42.048911 | instance | Resolved community.general to 7.3.0 for 7.3.0 2026-08-24 19:33:42.048935 | instance | Resolved community.mysql to 3.6.0 for 3.6.0 2026-08-24 19:33:42.048964 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0 2026-08-24 19:33:42.048988 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0 2026-08-24 19:33:42.049007 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0 2026-08-24 19:33:42.049027 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0 2026-08-24 19:33:42.049048 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-08-24 19:33:42.049080 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0 2026-08-24 19:33:42.049101 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0 2026-08-24 19:33:42.049120 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-08-24 19:33:42.049139 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-08-24 19:33:42.049168 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-08-24 19:33:42.049187 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0 2026-08-24 19:33:42.049206 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3 2026-08-24 19:33:42.049224 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-08-24 19:33:42.049243 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-08-24 19:33:42.049262 | instance | Checked out ansible.netcommon to 1.2.0 2026-08-24 19:33:42.049280 | 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 19:33:42.049308 | instance | Starting galaxy collection install process 2026-08-24 19:33:42.049326 | instance | Process install dependency map 2026-08-24 19:33:42.049345 | instance | Starting collection install process 2026-08-24 19:33:42.049364 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon' 2026-08-24 19:33:42.049382 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon 2026-08-24 19:33:42.049400 | instance | ansible.netcommon:* was installed successfully 2026-08-24 19:33:42.049419 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-08-24 19:33:42.049437 | instance | Creating virtual environment at: .venv 2026-08-24 19:33:42.049455 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-08-24 19:33:42.049474 | instance | Downloading kubernetes (1.9MiB) 2026-08-24 19:33:42.049498 | instance | Downloading openstacksdk (1.7MiB) 2026-08-24 19:33:42.049524 | instance | Downloading pygments (1.2MiB) 2026-08-24 19:33:42.049565 | instance | Downloading setuptools (1.1MiB) 2026-08-24 19:33:42.049592 | instance | Downloading ansible-core (2.1MiB) 2026-08-24 19:33:42.049611 | instance | Downloading rjsonnet (1.2MiB) 2026-08-24 19:33:42.049631 | instance | Downloading netaddr (2.2MiB) 2026-08-24 19:33:42.049650 | instance | Downloading cryptography (4.2MiB) 2026-08-24 19:33:42.049669 | instance | Building pyperclip==1.9.0 2026-08-24 19:33:42.049687 | instance | Downloading rjsonnet 2026-08-24 19:33:42.049708 | instance | Downloading netaddr 2026-08-24 19:33:42.049734 | instance | Downloading pygments 2026-08-24 19:33:42.049758 | instance | Downloading cryptography 2026-08-24 19:33:42.049777 | instance | Downloading setuptools 2026-08-24 19:33:42.049796 | instance | Downloading kubernetes 2026-08-24 19:33:42.049815 | instance | Downloading ansible-core 2026-08-24 19:33:42.049834 | instance | Downloading openstacksdk 2026-08-24 19:33:42.049852 | instance | Built pyperclip==1.9.0 2026-08-24 19:33:42.049876 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-08-24 19:33:42.049896 | instance | Installed 79 packages in 40ms 2026-08-24 19:33:42.049915 | instance | Checked out ansible.posix to 1.6.0 2026-08-24 19:33:42.049934 | 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 19:33:42.049953 | instance | Starting galaxy collection install process 2026-08-24 19:33:42.049971 | instance | Process install dependency map 2026-08-24 19:33:42.049989 | instance | Starting collection install process 2026-08-24 19:33:42.050016 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-08-24 19:33:42.050043 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix 2026-08-24 19:33:42.050062 | instance | ansible.posix:1.6.0 was installed successfully 2026-08-24 19:33:42.050081 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 19:33:42.050100 | instance | 2.17.12 2026-08-24 19:33:42.050119 | instance | Checked out ansible.utils to v6.1.0 2026-08-24 19:33:42.050137 | 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 19:33:42.050157 | instance | Starting galaxy collection install process 2026-08-24 19:33:42.050175 | instance | Process install dependency map 2026-08-24 19:33:42.050202 | instance | Starting collection install process 2026-08-24 19:33:42.050222 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils' 2026-08-24 19:33:42.050245 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils 2026-08-24 19:33:42.050269 | instance | ansible.utils:6.1.0 was installed successfully 2026-08-24 19:33:42.050292 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 19:33:42.050319 | instance | 2.17.12 2026-08-24 19:33:42.050342 | instance | Checked out atmosphere.common to v0.7.0 2026-08-24 19:33:42.050362 | 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 19:33:42.050381 | instance | Starting galaxy collection install process 2026-08-24 19:33:42.050400 | instance | Process install dependency map 2026-08-24 19:33:42.050418 | instance | Starting collection install process 2026-08-24 19:33:42.050436 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common' 2026-08-24 19:33:42.050454 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common 2026-08-24 19:33:42.050472 | instance | atmosphere.common:0.7.0 was installed successfully 2026-08-24 19:33:42.050490 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 19:33:42.050511 | instance | 2.17.12 2026-08-24 19:33:42.050535 | instance | Checked out community.crypto to 2.2.3 2026-08-24 19:33:42.050553 | 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 19:33:42.050572 | instance | Starting galaxy collection install process 2026-08-24 19:33:42.050590 | instance | Process install dependency map 2026-08-24 19:33:42.050609 | instance | Starting collection install process 2026-08-24 19:33:42.050627 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-08-24 19:33:42.050645 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto 2026-08-24 19:33:42.050663 | instance | community.crypto:2.2.3 was installed successfully 2026-08-24 19:33:42.050680 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 19:33:42.050698 | instance | 2.17.12 2026-08-24 19:33:42.050717 | instance | Checked out community.general to 7.3.0 2026-08-24 19:33:42.050735 | 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 19:33:42.050753 | instance | Starting galaxy collection install process 2026-08-24 19:33:42.050778 | instance | Process install dependency map 2026-08-24 19:33:42.050797 | instance | Starting collection install process 2026-08-24 19:33:42.050825 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-08-24 19:33:42.050844 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general 2026-08-24 19:33:42.050876 | instance | community.general:7.3.0 was installed successfully 2026-08-24 19:33:42.050896 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 19:33:42.050915 | instance | 2.17.12 2026-08-24 19:33:42.050934 | instance | Checked out community.mysql to 3.6.0 2026-08-24 19:33:42.050952 | 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 19:33:42.050971 | instance | Starting galaxy collection install process 2026-08-24 19:33:42.050992 | instance | Process install dependency map 2026-08-24 19:33:42.051012 | instance | Starting collection install process 2026-08-24 19:33:42.051031 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql' 2026-08-24 19:33:42.051094 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql 2026-08-24 19:33:42.051118 | instance | community.mysql:3.6.0 was installed successfully 2026-08-24 19:33:42.051137 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 19:33:42.051155 | instance | 2.17.12 2026-08-24 19:33:42.051183 | instance | Checked out kubernetes.core to 2.4.0 2026-08-24 19:33:42.051202 | 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 19:33:42.051221 | instance | Starting galaxy collection install process 2026-08-24 19:33:42.051244 | instance | Process install dependency map 2026-08-24 19:33:42.051267 | instance | Starting collection install process 2026-08-24 19:33:42.051287 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core' 2026-08-24 19:33:42.051305 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core 2026-08-24 19:33:42.051329 | instance | kubernetes.core:2.4.0 was installed successfully 2026-08-24 19:33:42.051357 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 19:33:42.051383 | instance | 2.17.12 2026-08-24 19:33:42.051402 | instance | Checked out openstack.cloud to 2.6.0 2026-08-24 19:33:42.051425 | 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 19:33:42.051445 | instance | Starting galaxy collection install process 2026-08-24 19:33:42.051463 | instance | Process install dependency map 2026-08-24 19:33:42.051482 | instance | Starting collection install process 2026-08-24 19:33:42.051501 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud' 2026-08-24 19:33:42.051519 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud 2026-08-24 19:33:42.051537 | instance | openstack.cloud:2.6.0 was installed successfully 2026-08-24 19:33:42.051555 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 19:33:42.051573 | instance | 2.17.12 2026-08-24 19:33:42.051591 | instance | Checked out vexxhost.ceph to v4.2.0 2026-08-24 19:33:42.051610 | 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 19:33:42.051633 | instance | Starting galaxy collection install process 2026-08-24 19:33:42.051653 | instance | Process install dependency map 2026-08-24 19:33:42.051671 | instance | Starting collection install process 2026-08-24 19:33:42.051689 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph' 2026-08-24 19:33:42.051707 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph 2026-08-24 19:33:42.051726 | instance | vexxhost.ceph:4.2.0 was installed successfully 2026-08-24 19:33:42.051744 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 19:33:42.051762 | instance | 2.17.12 2026-08-24 19:33:42.051781 | instance | Checked out vexxhost.containers to v1.6.8 2026-08-24 19:33:42.051799 | 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 19:33:42.051817 | instance | Starting galaxy collection install process 2026-08-24 19:33:42.051835 | instance | Process install dependency map 2026-08-24 19:33:42.051853 | instance | Starting collection install process 2026-08-24 19:33:42.051872 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers' 2026-08-24 19:33:42.051896 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers 2026-08-24 19:33:42.051915 | instance | vexxhost.containers:1.6.8 was installed successfully 2026-08-24 19:33:42.051934 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 19:33:42.051957 | instance | 2.17.12 2026-08-24 19:33:42.051975 | instance | Checked out vexxhost.kubernetes to v3.3.0 2026-08-24 19:33:42.051994 | 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 19:33:42.052012 | instance | Starting galaxy collection install process 2026-08-24 19:33:42.052035 | instance | Process install dependency map 2026-08-24 19:33:42.052054 | instance | Starting collection install process 2026-08-24 19:33:42.052080 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes' 2026-08-24 19:33:42.052099 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes 2026-08-24 19:33:42.052117 | instance | vexxhost.kubernetes:3.3.0 was installed successfully 2026-08-24 19:33:42.052136 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 19:33:42.052153 | instance | 2.17.12 2026-08-24 19:33:42.057803 | 2026-08-24 19:33:42.057852 | PLAY RECAP 2026-08-24 19:33:42.057897 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-24 19:33:42.057918 | 2026-08-24 19:33:42.201265 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-24 19:33:42.204045 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-08-24 19:33:42.822388 | 2026-08-24 19:33:42.822506 | PLAY [all] 2026-08-24 19:33:42.833887 | 2026-08-24 19:33:42.833958 | TASK [Install "jq" for log collection] 2026-08-24 19:33:52.314420 | instance | changed 2026-08-24 19:33:52.317199 | 2026-08-24 19:33:52.317275 | PLAY RECAP 2026-08-24 19:33:52.317343 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-24 19:33:52.317411 | 2026-08-24 19:33:52.494487 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-08-24 19:33:52.496870 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-24 19:33:53.093978 | 2026-08-24 19:33:53.095060 | PLAY [all] 2026-08-24 19:33:53.106843 | 2026-08-24 19:33:53.106924 | LOOP [Check inventory directories] 2026-08-24 19:33:53.466449 | instance | ok: "src/github.com/vexxhost/atmosphere" 2026-08-24 19:33:53.602036 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory" 2026-08-24 19:33:53.747391 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory" 2026-08-24 19:33:53.763370 | 2026-08-24 19:33:53.763527 | LOOP [Copy inventory file for Zuul] 2026-08-24 19:33:54.553477 | instance | changed: 2026-08-24 19:33:54.553763 | instance | { 2026-08-24 19:33:54.553807 | instance | "ansible_loop_var": "item", 2026-08-24 19:33:54.553841 | instance | "changed": false, 2026-08-24 19:33:54.553869 | instance | "failed": false, 2026-08-24 19:33:54.553902 | instance | "invocation": { 2026-08-24 19:33:54.553929 | instance | "module_args": { 2026-08-24 19:33:54.553955 | instance | "checksum_algorithm": "sha1", 2026-08-24 19:33:54.553980 | instance | "follow": true, 2026-08-24 19:33:54.554006 | instance | "get_attributes": true, 2026-08-24 19:33:54.554033 | instance | "get_checksum": true, 2026-08-24 19:33:54.554059 | instance | "get_mime": true, 2026-08-24 19:33:54.554084 | instance | "path": "src/github.com/vexxhost/atmosphere" 2026-08-24 19:33:54.554109 | instance | } 2026-08-24 19:33:54.554135 | instance | }, 2026-08-24 19:33:54.554159 | instance | "item": "src/github.com/vexxhost/atmosphere", 2026-08-24 19:33:54.554184 | instance | "stat": { 2026-08-24 19:33:54.554209 | instance | "atime": 1787600015.1349974, 2026-08-24 19:33:54.554234 | instance | "attr_flags": "e", 2026-08-24 19:33:54.554259 | instance | "attributes": [ 2026-08-24 19:33:54.554284 | instance | "extents" 2026-08-24 19:33:54.554308 | instance | ], 2026-08-24 19:33:54.554333 | instance | "block_size": 4096, 2026-08-24 19:33:54.554357 | instance | "blocks": 8, 2026-08-24 19:33:54.554382 | instance | "charset": "unknown", 2026-08-24 19:33:54.554408 | instance | "ctime": 1787600014.1389668, 2026-08-24 19:33:54.554433 | instance | "dev": 64513, 2026-08-24 19:33:54.554458 | instance | "device_type": 0, 2026-08-24 19:33:54.554483 | instance | "executable": true, 2026-08-24 19:33:54.554508 | instance | "exists": true, 2026-08-24 19:33:54.554532 | instance | "gid": 1000, 2026-08-24 19:33:54.554556 | instance | "gr_name": "zuul", 2026-08-24 19:33:54.554580 | instance | "inode": 1048335, 2026-08-24 19:33:54.554604 | instance | "isblk": false, 2026-08-24 19:33:54.554630 | instance | "ischr": false, 2026-08-24 19:33:54.554654 | instance | "isdir": true, 2026-08-24 19:33:54.554679 | instance | "isfifo": false, 2026-08-24 19:33:54.554702 | instance | "isgid": false, 2026-08-24 19:33:54.554726 | instance | "islnk": false, 2026-08-24 19:33:54.554750 | instance | "isreg": false, 2026-08-24 19:33:54.554773 | instance | "issock": false, 2026-08-24 19:33:54.554797 | instance | "isuid": false, 2026-08-24 19:33:54.554821 | instance | "mimetype": "unknown", 2026-08-24 19:33:54.554845 | instance | "mode": "0755", 2026-08-24 19:33:54.554869 | instance | "mtime": 1787600014.1389668, 2026-08-24 19:33:54.554893 | instance | "nlink": 21, 2026-08-24 19:33:54.554917 | instance | "path": "src/github.com/vexxhost/atmosphere", 2026-08-24 19:33:54.554941 | instance | "pw_name": "zuul", 2026-08-24 19:33:54.554970 | instance | "readable": true, 2026-08-24 19:33:54.554995 | instance | "rgrp": true, 2026-08-24 19:33:54.555019 | instance | "roth": true, 2026-08-24 19:33:54.555044 | instance | "rusr": true, 2026-08-24 19:33:54.555068 | instance | "size": 4096, 2026-08-24 19:33:54.555093 | instance | "uid": 1000, 2026-08-24 19:33:54.555132 | instance | "version": "1595463448", 2026-08-24 19:33:54.555158 | instance | "wgrp": false, 2026-08-24 19:33:54.555185 | instance | "woth": false, 2026-08-24 19:33:54.555210 | instance | "writeable": true, 2026-08-24 19:33:54.555235 | instance | "wusr": true, 2026-08-24 19:33:54.555259 | instance | "xgrp": true, 2026-08-24 19:33:54.555283 | instance | "xoth": true, 2026-08-24 19:33:54.555307 | instance | "xusr": true 2026-08-24 19:33:54.555330 | instance | } 2026-08-24 19:33:54.555355 | instance | } 2026-08-24 19:33:54.555401 | instance | ok: All items complete 2026-08-24 19:33:54.555430 | 2026-08-24 19:33:54.557201 | instance | skipping: Conditional result was False 2026-08-24 19:33:54.557799 | instance | skipping: Conditional result was False 2026-08-24 19:33:54.573159 | 2026-08-24 19:33:54.573245 | LOOP [Switch "ansible_host" to private IP] 2026-08-24 19:33:54.913737 | instance | changed: 1 replacements made 2026-08-24 19:33:54.917666 | instance | skipping: Conditional result was False 2026-08-24 19:33:54.922211 | instance | skipping: Conditional result was False 2026-08-24 19:33:54.932237 | 2026-08-24 19:33:54.932343 | TASK [Run Molecule scenario] 2026-08-24 19:33:55.842146 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-08-24 19:33:56.243424 | instance | INFO [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-08-24 19:33:56.243464 | instance | INFO [csi > prerun] Performing prerun with role_name_check=0... 2026-08-24 19:34:07.395428 | instance | INFO [csi > dependency] Executing 2026-08-24 19:34:07.395511 | instance | WARNING [csi > dependency] Missing roles requirements file: requirements.yml 2026-08-24 19:34:07.395718 | instance | WARNING [csi > dependency] Missing collections requirements file: collections.yml 2026-08-24 19:34:07.395826 | instance | WARNING [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-08-24 19:34:07.403582 | instance | INFO [csi > cleanup] Executing 2026-08-24 19:34:07.403855 | instance | WARNING [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-24 19:34:07.411341 | instance | INFO [csi > destroy] Executing 2026-08-24 19:34:07.411378 | instance | WARNING [csi > destroy] Skipping, '--destroy=never' requested. 2026-08-24 19:34:07.411464 | instance | INFO [csi > destroy] Executed: Successful 2026-08-24 19:34:07.418808 | instance | INFO [csi > syntax] Executing 2026-08-24 19:34:08.950250 | instance | 2026-08-24 19:34:08.950520 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-08-24 19:34:09.007733 | instance | INFO [csi > syntax] Executed: Successful 2026-08-24 19:34:09.020450 | instance | INFO [csi > create] Executing 2026-08-24 19:34:09.022248 | instance | WARNING [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-24 19:34:09.029568 | instance | INFO [csi > prepare] Executing 2026-08-24 19:34:09.866675 | instance | 2026-08-24 19:34:09.866861 | instance | PLAY [Prepare] ***************************************************************** 2026-08-24 19:34:09.867123 | instance | 2026-08-24 19:34:09.867497 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-24 19:34:09.867754 | instance | Monday 24 August 2026 19:34:09 +0000 (0:00:00.031) 0:00:00.031 ********* 2026-08-24 19:34:10.993380 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-08-24 19:34:10.993594 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-08-24 19:34:10.993854 | instance | interpreter could change the meaning of that path. See 2026-08-24 19:34:10.994118 | instance | https://docs.ansible.com/ansible- 2026-08-24 19:34:10.994375 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-08-24 19:34:11.001097 | instance | ok: [instance] 2026-08-24 19:34:11.001413 | instance | 2026-08-24 19:34:11.001676 | instance | TASK [Configure short hostname] ************************************************ 2026-08-24 19:34:11.001929 | instance | Monday 24 August 2026 19:34:10 +0000 (0:00:01.135) 0:00:01.166 ********* 2026-08-24 19:34:11.637164 | instance | changed: [instance] 2026-08-24 19:34:11.637474 | instance | 2026-08-24 19:34:11.637769 | instance | TASK [Ensure hostname inside hosts file] *************************************** 2026-08-24 19:34:11.638129 | instance | Monday 24 August 2026 19:34:11 +0000 (0:00:00.635) 0:00:01.802 ********* 2026-08-24 19:34:11.878798 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created 2026-08-24 19:34:11.878837 | instance | with a mode of 0700, this may cause issues when running as another user. To 2026-08-24 19:34:11.879053 | instance | avoid this, create the remote_tmp dir with the correct permissions manually 2026-08-24 19:34:11.887787 | instance | changed: [instance] 2026-08-24 19:34:11.888051 | instance | 2026-08-24 19:34:11.888377 | instance | TASK [Purge "snapd" package] *************************************************** 2026-08-24 19:34:11.888666 | instance | Monday 24 August 2026 19:34:11 +0000 (0:00:00.251) 0:00:02.053 ********* 2026-08-24 19:34:12.602157 | instance | ok: [instance] 2026-08-24 19:34:12.602476 | instance | 2026-08-24 19:34:12.602976 | instance | PLAY [Create devices for Ceph] ************************************************* 2026-08-24 19:34:12.603275 | instance | 2026-08-24 19:34:12.603635 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-24 19:34:12.604042 | instance | Monday 24 August 2026 19:34:12 +0000 (0:00:00.713) 0:00:02.767 ********* 2026-08-24 19:34:13.248388 | instance | ok: [instance] 2026-08-24 19:34:13.248616 | instance | 2026-08-24 19:34:13.248905 | instance | TASK [Install depedencies] ***************************************************** 2026-08-24 19:34:13.249195 | instance | Monday 24 August 2026 19:34:13 +0000 (0:00:00.646) 0:00:03.413 ********* 2026-08-24 19:34:32.774940 | instance | changed: [instance] 2026-08-24 19:34:32.775165 | instance | 2026-08-24 19:34:32.775432 | instance | TASK [Start up service] ******************************************************** 2026-08-24 19:34:32.775704 | instance | Monday 24 August 2026 19:34:32 +0000 (0:00:19.526) 0:00:22.940 ********* 2026-08-24 19:34:33.284559 | instance | ok: [instance] 2026-08-24 19:34:33.284620 | instance | 2026-08-24 19:34:33.284751 | instance | TASK [Generate lvm.conf] ******************************************************* 2026-08-24 19:34:33.284864 | instance | Monday 24 August 2026 19:34:33 +0000 (0:00:00.509) 0:00:23.450 ********* 2026-08-24 19:34:33.561130 | instance | ok: [instance] 2026-08-24 19:34:33.561393 | instance | 2026-08-24 19:34:33.561659 | instance | TASK [Write /etc/lvm/lvm.conf] ************************************************* 2026-08-24 19:34:33.561927 | instance | Monday 24 August 2026 19:34:33 +0000 (0:00:00.276) 0:00:23.726 ********* 2026-08-24 19:34:34.182939 | instance | changed: [instance] 2026-08-24 19:34:34.182995 | instance | 2026-08-24 19:34:34.183009 | instance | TASK [Get list of all loopback devices] **************************************** 2026-08-24 19:34:34.183020 | instance | Monday 24 August 2026 19:34:34 +0000 (0:00:00.620) 0:00:24.347 ********* 2026-08-24 19:34:34.356349 | instance | ok: [instance] 2026-08-24 19:34:34.356823 | instance | 2026-08-24 19:34:34.356843 | instance | TASK [Fail if there is any existing loopback devices] ************************** 2026-08-24 19:34:34.356851 | instance | Monday 24 August 2026 19:34:34 +0000 (0:00:00.174) 0:00:24.521 ********* 2026-08-24 19:34:34.377627 | instance | skipping: [instance] 2026-08-24 19:34:34.377784 | instance | 2026-08-24 19:34:34.378128 | instance | TASK [Create devices for Ceph] ************************************************* 2026-08-24 19:34:34.378147 | instance | Monday 24 August 2026 19:34:34 +0000 (0:00:00.021) 0:00:24.543 ********* 2026-08-24 19:34:34.888058 | instance | changed: [instance] => (item=osd0) 2026-08-24 19:34:34.888172 | instance | changed: [instance] => (item=osd1) 2026-08-24 19:34:34.888868 | instance | changed: [instance] => (item=osd2) 2026-08-24 19:34:34.888908 | instance | 2026-08-24 19:34:34.888915 | instance | TASK [Set permissions on loopback devices] ************************************* 2026-08-24 19:34:34.888922 | instance | Monday 24 August 2026 19:34:34 +0000 (0:00:00.509) 0:00:25.053 ********* 2026-08-24 19:34:35.487183 | instance | changed: [instance] => (item=osd0) 2026-08-24 19:34:35.487980 | instance | changed: [instance] => (item=osd1) 2026-08-24 19:34:35.488027 | instance | changed: [instance] => (item=osd2) 2026-08-24 19:34:35.488034 | instance | 2026-08-24 19:34:35.488041 | instance | TASK [Start loop devices] ****************************************************** 2026-08-24 19:34:35.488048 | instance | Monday 24 August 2026 19:34:35 +0000 (0:00:00.599) 0:00:25.652 ********* 2026-08-24 19:34:36.146168 | instance | changed: [instance] => (item=osd0) 2026-08-24 19:34:36.147009 | instance | changed: [instance] => (item=osd1) 2026-08-24 19:34:36.147056 | instance | changed: [instance] => (item=osd2) 2026-08-24 19:34:36.147064 | instance | 2026-08-24 19:34:36.147071 | instance | TASK [Create a volume group for each loop device] ****************************** 2026-08-24 19:34:36.147077 | instance | Monday 24 August 2026 19:34:36 +0000 (0:00:00.658) 0:00:26.311 ********* 2026-08-24 19:34:39.078981 | instance | changed: [instance] => (item=osd0) 2026-08-24 19:34:39.079826 | instance | changed: [instance] => (item=osd1) 2026-08-24 19:34:39.079870 | instance | changed: [instance] => (item=osd2) 2026-08-24 19:34:39.079898 | instance | 2026-08-24 19:34:39.079906 | instance | TASK [Create a logical volume for each loop device] **************************** 2026-08-24 19:34:39.079913 | instance | Monday 24 August 2026 19:34:39 +0000 (0:00:02.932) 0:00:29.244 ********* 2026-08-24 19:34:40.842240 | instance | changed: [instance] => (item=ceph-instance-osd0) 2026-08-24 19:34:40.842285 | instance | changed: [instance] => (item=ceph-instance-osd1) 2026-08-24 19:34:40.845210 | instance | changed: [instance] => (item=ceph-instance-osd2) 2026-08-24 19:34:40.845223 | instance | 2026-08-24 19:34:40.845230 | instance | PLAY RECAP ********************************************************************* 2026-08-24 19:34:40.845236 | instance | instance : ok=15 changed=9 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-08-24 19:34:40.845242 | instance | 2026-08-24 19:34:40.845248 | instance | Monday 24 August 2026 19:34:40 +0000 (0:00:01.762) 0:00:31.007 ********* 2026-08-24 19:34:40.845254 | instance | =============================================================================== 2026-08-24 19:34:40.845259 | instance | Install depedencies ---------------------------------------------------- 19.53s 2026-08-24 19:34:40.845265 | instance | Create a volume group for each loop device ------------------------------ 2.93s 2026-08-24 19:34:40.845270 | instance | Create a logical volume for each loop device ---------------------------- 1.76s 2026-08-24 19:34:40.845276 | instance | Gathering Facts --------------------------------------------------------- 1.14s 2026-08-24 19:34:40.845281 | instance | Purge "snapd" package --------------------------------------------------- 0.71s 2026-08-24 19:34:40.845287 | instance | Start loop devices ------------------------------------------------------ 0.66s 2026-08-24 19:34:40.845360 | instance | Gathering Facts --------------------------------------------------------- 0.65s 2026-08-24 19:34:40.845671 | instance | Configure short hostname ------------------------------------------------ 0.64s 2026-08-24 19:34:40.845946 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.62s 2026-08-24 19:34:40.846216 | instance | Set permissions on loopback devices ------------------------------------- 0.60s 2026-08-24 19:34:40.846483 | instance | Start up service -------------------------------------------------------- 0.51s 2026-08-24 19:34:40.846743 | instance | Create devices for Ceph ------------------------------------------------- 0.51s 2026-08-24 19:34:40.847004 | instance | Generate lvm.conf ------------------------------------------------------- 0.28s 2026-08-24 19:34:40.847270 | instance | Ensure hostname inside hosts file --------------------------------------- 0.25s 2026-08-24 19:34:40.847539 | instance | Get list of all loopback devices ---------------------------------------- 0.17s 2026-08-24 19:34:40.847871 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s 2026-08-24 19:34:40.906109 | instance | INFO [csi > prepare] Executed: Successful 2026-08-24 19:34:40.916198 | instance | INFO [csi > converge] Executing 2026-08-24 19:34:42.358002 | instance | 2026-08-24 19:34:42.358471 | instance | PLAY [Debug CSI driver value] ************************************************** 2026-08-24 19:34:42.358806 | instance | 2026-08-24 19:34:42.359140 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-24 19:34:42.359472 | instance | Monday 24 August 2026 19:34:42 +0000 (0:00:00.007) 0:00:00.007 ********* 2026-08-24 19:34:43.292528 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-08-24 19:34:43.292584 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-08-24 19:34:43.292596 | instance | interpreter could change the meaning of that path. See 2026-08-24 19:34:43.292606 | instance | https://docs.ansible.com/ansible- 2026-08-24 19:34:43.292615 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-08-24 19:34:43.302233 | instance | ok: [instance] 2026-08-24 19:34:43.302248 | instance | 2026-08-24 19:34:43.302254 | instance | TASK [Display CSI driver value and environment variable] *********************** 2026-08-24 19:34:43.302258 | instance | Monday 24 August 2026 19:34:43 +0000 (0:00:00.944) 0:00:00.952 ********* 2026-08-24 19:34:43.346374 | instance | ok: [instance] => { 2026-08-24 19:34:43.346396 | instance | "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER=" 2026-08-24 19:34:43.346402 | instance | } 2026-08-24 19:34:43.346406 | instance | 2026-08-24 19:34:43.346410 | instance | PLAY [all] ********************************************************************* 2026-08-24 19:34:43.346414 | instance | 2026-08-24 19:34:43.346419 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-24 19:34:43.346431 | instance | Monday 24 August 2026 19:34:43 +0000 (0:00:00.043) 0:00:00.996 ********* 2026-08-24 19:34:44.169306 | instance | ok: [instance] 2026-08-24 19:34:44.169383 | instance | 2026-08-24 19:34:44.169395 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-08-24 19:34:44.169412 | instance | Monday 24 August 2026 19:34:44 +0000 (0:00:00.822) 0:00:01.818 ********* 2026-08-24 19:34:44.343455 | instance | ok: [instance] 2026-08-24 19:34:44.343670 | instance | 2026-08-24 19:34:44.343937 | instance | PLAY [Deploy Ceph monitors & managers] ***************************************** 2026-08-24 19:34:44.344183 | instance | 2026-08-24 19:34:44.344449 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-24 19:34:44.344715 | instance | Monday 24 August 2026 19:34:44 +0000 (0:00:00.174) 0:00:01.993 ********* 2026-08-24 19:34:45.226478 | instance | ok: [instance] 2026-08-24 19:34:45.226531 | instance | 2026-08-24 19:34:45.226543 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-24 19:34:45.226565 | instance | Monday 24 August 2026 19:34:45 +0000 (0:00:00.881) 0:00:02.874 ********* 2026-08-24 19:34:45.504935 | instance | ok: [instance] 2026-08-24 19:34:45.505037 | instance | 2026-08-24 19:34:45.505220 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-24 19:34:45.505383 | instance | Monday 24 August 2026 19:34:45 +0000 (0:00:00.279) 0:00:03.154 ********* 2026-08-24 19:34:45.551349 | instance | skipping: [instance] 2026-08-24 19:34:45.551429 | instance | 2026-08-24 19:34:45.551553 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-08-24 19:34:45.551661 | instance | Monday 24 August 2026 19:34:45 +0000 (0:00:00.046) 0:00:03.201 ********* 2026-08-24 19:34:45.932857 | instance | changed: [instance] 2026-08-24 19:34:45.932923 | instance | 2026-08-24 19:34:45.933051 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-24 19:34:45.933396 | instance | Monday 24 August 2026 19:34:45 +0000 (0:00:00.381) 0:00:03.582 ********* 2026-08-24 19:34:46.007104 | instance | ok: [instance] => { 2026-08-24 19:34:46.007182 | instance | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-08-24 19:34:46.007295 | instance | } 2026-08-24 19:34:46.007458 | instance | 2026-08-24 19:34:46.007607 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-24 19:34:46.007799 | instance | Monday 24 August 2026 19:34:46 +0000 (0:00:00.074) 0:00:03.657 ********* 2026-08-24 19:34:46.750000 | instance | changed: [instance] 2026-08-24 19:34:46.750130 | instance | 2026-08-24 19:34:46.750422 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-24 19:34:46.750678 | instance | Monday 24 August 2026 19:34:46 +0000 (0:00:00.740) 0:00:04.397 ********* 2026-08-24 19:34:46.801483 | instance | skipping: [instance] 2026-08-24 19:34:46.801583 | instance | 2026-08-24 19:34:46.801708 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-24 19:34:46.801819 | instance | Monday 24 August 2026 19:34:46 +0000 (0:00:00.052) 0:00:04.450 ********* 2026-08-24 19:34:46.853471 | instance | skipping: [instance] 2026-08-24 19:34:46.853556 | instance | 2026-08-24 19:34:46.853689 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-24 19:34:46.853813 | instance | Monday 24 August 2026 19:34:46 +0000 (0:00:00.051) 0:00:04.502 ********* 2026-08-24 19:34:47.062074 | instance | ok: [instance] 2026-08-24 19:34:47.062455 | instance | 2026-08-24 19:34:47.062790 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-24 19:34:47.063118 | instance | Monday 24 August 2026 19:34:47 +0000 (0:00:00.207) 0:00:04.710 ********* 2026-08-24 19:34:48.237459 | instance | ok: [instance] 2026-08-24 19:34:48.237643 | instance | 2026-08-24 19:34:48.237798 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-24 19:34:48.237950 | instance | Monday 24 August 2026 19:34:48 +0000 (0:00:01.174) 0:00:05.884 ********* 2026-08-24 19:34:48.297890 | instance | ok: [instance] => { 2026-08-24 19:34:48.298041 | instance | "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz" 2026-08-24 19:34:48.298354 | instance | } 2026-08-24 19:34:48.298501 | instance | 2026-08-24 19:34:48.298652 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-24 19:34:48.298801 | instance | Monday 24 August 2026 19:34:48 +0000 (0:00:00.063) 0:00:05.947 ********* 2026-08-24 19:34:49.043686 | instance | changed: [instance] 2026-08-24 19:34:49.043745 | instance | 2026-08-24 19:34:49.044017 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-24 19:34:49.044062 | instance | Monday 24 August 2026 19:34:49 +0000 (0:00:00.745) 0:00:06.693 ********* 2026-08-24 19:34:51.819866 | instance | changed: [instance] 2026-08-24 19:34:51.819938 | instance | 2026-08-24 19:34:51.820184 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-08-24 19:34:51.820221 | instance | Monday 24 August 2026 19:34:51 +0000 (0:00:02.776) 0:00:09.469 ********* 2026-08-24 19:34:51.850297 | instance | skipping: [instance] 2026-08-24 19:34:51.850421 | instance | 2026-08-24 19:34:51.850606 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-08-24 19:34:51.850756 | instance | Monday 24 August 2026 19:34:51 +0000 (0:00:00.030) 0:00:09.500 ********* 2026-08-24 19:34:51.883914 | instance | skipping: [instance] 2026-08-24 19:34:51.884033 | instance | 2026-08-24 19:34:51.884400 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-08-24 19:34:51.884562 | instance | Monday 24 August 2026 19:34:51 +0000 (0:00:00.033) 0:00:09.533 ********* 2026-08-24 19:34:51.913229 | instance | skipping: [instance] 2026-08-24 19:34:51.913349 | instance | 2026-08-24 19:34:51.913542 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-08-24 19:34:51.913693 | instance | Monday 24 August 2026 19:34:51 +0000 (0:00:00.029) 0:00:09.563 ********* 2026-08-24 19:34:56.601831 | instance | changed: [instance] 2026-08-24 19:34:56.602075 | instance | 2026-08-24 19:34:56.602089 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] *** 2026-08-24 19:34:56.602147 | instance | Monday 24 August 2026 19:34:56 +0000 (0:00:04.688) 0:00:14.251 ********* 2026-08-24 19:34:57.161746 | instance | changed: [instance] 2026-08-24 19:34:57.161782 | instance | 2026-08-24 19:34:57.161787 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] ******* 2026-08-24 19:34:57.161792 | instance | Monday 24 August 2026 19:34:57 +0000 (0:00:00.559) 0:00:14.811 ********* 2026-08-24 19:34:58.030540 | instance | changed: [instance] => (item={'path': '/etc/containerd'}) 2026-08-24 19:34:58.031356 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'}) 2026-08-24 19:34:58.031467 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'}) 2026-08-24 19:34:58.031473 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'}) 2026-08-24 19:34:58.031479 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'}) 2026-08-24 19:34:58.031483 | instance | 2026-08-24 19:34:58.031491 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] ********** 2026-08-24 19:34:58.031496 | instance | Monday 24 August 2026 19:34:58 +0000 (0:00:00.869) 0:00:15.680 ********* 2026-08-24 19:34:58.597980 | instance | changed: [instance] 2026-08-24 19:34:58.598703 | instance | 2026-08-24 19:34:58.598746 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ******** 2026-08-24 19:34:58.598752 | instance | Monday 24 August 2026 19:34:58 +0000 (0:00:00.548) 0:00:16.229 ********* 2026-08-24 19:34:58.598757 | instance | 2026-08-24 19:34:58.598761 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-08-24 19:34:58.598765 | instance | Monday 24 August 2026 19:34:58 +0000 (0:00:00.018) 0:00:16.247 ********* 2026-08-24 19:34:59.486510 | instance | ok: [instance] 2026-08-24 19:34:59.486589 | instance | 2026-08-24 19:34:59.486851 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] ********** 2026-08-24 19:34:59.486887 | instance | Monday 24 August 2026 19:34:59 +0000 (0:00:00.888) 0:00:17.136 ********* 2026-08-24 19:34:59.922590 | instance | changed: [instance] 2026-08-24 19:34:59.922709 | instance | 2026-08-24 19:34:59.922775 | instance | TASK [vexxhost.containers.containerd : Enable and start service] *************** 2026-08-24 19:34:59.922919 | instance | Monday 24 August 2026 19:34:59 +0000 (0:00:00.436) 0:00:17.572 ********* 2026-08-24 19:35:00.477253 | instance | changed: [instance] 2026-08-24 19:35:00.477318 | instance | 2026-08-24 19:35:00.477617 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-24 19:35:00.477635 | instance | Monday 24 August 2026 19:35:00 +0000 (0:00:00.554) 0:00:18.127 ********* 2026-08-24 19:35:00.673334 | instance | ok: [instance] 2026-08-24 19:35:00.673406 | instance | 2026-08-24 19:35:00.673713 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-24 19:35:00.673758 | instance | Monday 24 August 2026 19:35:00 +0000 (0:00:00.196) 0:00:18.323 ********* 2026-08-24 19:35:00.731324 | instance | ok: [instance] => { 2026-08-24 19:35:00.731923 | instance | "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz" 2026-08-24 19:35:00.731965 | instance | } 2026-08-24 19:35:00.731971 | instance | 2026-08-24 19:35:00.731976 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-24 19:35:00.731981 | instance | Monday 24 August 2026 19:35:00 +0000 (0:00:00.057) 0:00:18.381 ********* 2026-08-24 19:35:01.543955 | instance | changed: [instance] 2026-08-24 19:35:01.544023 | instance | 2026-08-24 19:35:01.544327 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-24 19:35:01.544365 | instance | Monday 24 August 2026 19:35:01 +0000 (0:00:00.812) 0:00:19.194 ********* 2026-08-24 19:35:05.809405 | instance | changed: [instance] 2026-08-24 19:35:05.809477 | instance | 2026-08-24 19:35:05.809734 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ****************** 2026-08-24 19:35:05.809773 | instance | Monday 24 August 2026 19:35:05 +0000 (0:00:04.265) 0:00:23.459 ********* 2026-08-24 19:35:06.768937 | instance | ok: [instance] 2026-08-24 19:35:06.769018 | instance | 2026-08-24 19:35:06.769241 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] *************** 2026-08-24 19:35:06.769269 | instance | Monday 24 August 2026 19:35:06 +0000 (0:00:00.959) 0:00:24.419 ********* 2026-08-24 19:35:07.109665 | instance | changed: [instance] 2026-08-24 19:35:07.109774 | instance | 2026-08-24 19:35:07.110069 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] ***** 2026-08-24 19:35:07.110136 | instance | Monday 24 August 2026 19:35:07 +0000 (0:00:00.339) 0:00:24.759 ********* 2026-08-24 19:35:07.569274 | instance | changed: [instance] 2026-08-24 19:35:07.569378 | instance | 2026-08-24 19:35:07.569604 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] *********** 2026-08-24 19:35:07.569639 | instance | Monday 24 August 2026 19:35:07 +0000 (0:00:00.460) 0:00:25.219 ********* 2026-08-24 19:35:08.107287 | instance | changed: [instance] => (item={'path': '/etc/docker'}) 2026-08-24 19:35:08.107391 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'}) 2026-08-24 19:35:08.107910 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'}) 2026-08-24 19:35:08.107952 | instance | 2026-08-24 19:35:08.107957 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ****** 2026-08-24 19:35:08.107962 | instance | Monday 24 August 2026 19:35:08 +0000 (0:00:00.537) 0:00:25.757 ********* 2026-08-24 19:35:08.538897 | instance | changed: [instance] 2026-08-24 19:35:08.538967 | instance | 2026-08-24 19:35:08.539209 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] *********** 2026-08-24 19:35:08.539360 | instance | Monday 24 August 2026 19:35:08 +0000 (0:00:00.431) 0:00:26.189 ********* 2026-08-24 19:35:09.010583 | instance | changed: [instance] 2026-08-24 19:35:09.010661 | instance | 2026-08-24 19:35:09.011278 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************ 2026-08-24 19:35:09.011311 | instance | Monday 24 August 2026 19:35:08 +0000 (0:00:00.455) 0:00:26.644 ********* 2026-08-24 19:35:09.011317 | instance | 2026-08-24 19:35:09.011321 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-08-24 19:35:09.011326 | instance | Monday 24 August 2026 19:35:09 +0000 (0:00:00.016) 0:00:26.660 ********* 2026-08-24 19:35:09.712375 | instance | ok: [instance] 2026-08-24 19:35:09.712452 | instance | 2026-08-24 19:35:09.712679 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ****************** 2026-08-24 19:35:09.712717 | instance | Monday 24 August 2026 19:35:09 +0000 (0:00:00.701) 0:00:27.362 ********* 2026-08-24 19:35:10.584023 | instance | changed: [instance] 2026-08-24 19:35:10.584095 | instance | 2026-08-24 19:35:10.584383 | instance | TASK [vexxhost.containers.docker : Enable and start service] ******************* 2026-08-24 19:35:10.584421 | instance | Monday 24 August 2026 19:35:10 +0000 (0:00:00.871) 0:00:28.234 ********* 2026-08-24 19:35:11.115586 | instance | changed: [instance] 2026-08-24 19:35:11.115657 | instance | 2026-08-24 19:35:11.115899 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ****** 2026-08-24 19:35:11.115933 | instance | Monday 24 August 2026 19:35:11 +0000 (0:00:00.531) 0:00:28.765 ********* 2026-08-24 19:35:11.163140 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml) 2026-08-24 19:35:11.163207 | instance | 2026-08-24 19:35:11.163442 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ******************************** 2026-08-24 19:35:11.163459 | instance | Monday 24 August 2026 19:35:11 +0000 (0:00:00.047) 0:00:28.813 ********* 2026-08-24 19:35:15.881726 | instance | changed: [instance] 2026-08-24 19:35:15.881800 | instance | 2026-08-24 19:35:15.882062 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] ********************* 2026-08-24 19:35:15.882236 | instance | Monday 24 August 2026 19:35:15 +0000 (0:00:04.718) 0:00:33.531 ********* 2026-08-24 19:35:16.483701 | instance | ok: [instance] => (item=chronyd) 2026-08-24 19:35:16.483806 | instance | ok: [instance] => (item=sshd) 2026-08-24 19:35:16.484206 | instance | 2026-08-24 19:35:16.484242 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ****************************** 2026-08-24 19:35:16.484248 | instance | Monday 24 August 2026 19:35:16 +0000 (0:00:00.601) 0:00:34.133 ********* 2026-08-24 19:35:17.009837 | instance | changed: [instance] 2026-08-24 19:35:17.009913 | instance | 2026-08-24 19:35:17.010192 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ******************** 2026-08-24 19:35:17.010285 | instance | Monday 24 August 2026 19:35:17 +0000 (0:00:00.526) 0:00:34.659 ********* 2026-08-24 19:35:17.203351 | instance | ok: [instance] 2026-08-24 19:35:17.203419 | instance | 2026-08-24 19:35:17.203690 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] **************** 2026-08-24 19:35:17.203728 | instance | Monday 24 August 2026 19:35:17 +0000 (0:00:00.193) 0:00:34.853 ********* 2026-08-24 19:35:17.608560 | instance | changed: [instance] 2026-08-24 19:35:17.608637 | instance | 2026-08-24 19:35:17.609050 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] *** 2026-08-24 19:35:17.609093 | instance | Monday 24 August 2026 19:35:17 +0000 (0:00:00.404) 0:00:35.258 ********* 2026-08-24 19:35:17.948051 | instance | changed: [instance] 2026-08-24 19:35:17.948424 | instance | 2026-08-24 19:35:17.948463 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] ************************* 2026-08-24 19:35:17.948469 | instance | Monday 24 August 2026 19:35:17 +0000 (0:00:00.339) 0:00:35.598 ********* 2026-08-24 19:35:18.058433 | instance | ok: [instance] 2026-08-24 19:35:18.058502 | instance | 2026-08-24 19:35:18.058728 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] ******************* 2026-08-24 19:35:18.058769 | instance | Monday 24 August 2026 19:35:18 +0000 (0:00:00.110) 0:00:35.708 ********* 2026-08-24 19:35:18.270193 | instance | ok: [instance] => (item=instance) 2026-08-24 19:35:18.270266 | instance | 2026-08-24 19:35:18.270571 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ******** 2026-08-24 19:35:18.270609 | instance | Monday 24 August 2026 19:35:18 +0000 (0:00:00.211) 0:00:35.920 ********* 2026-08-24 19:35:18.322827 | instance | ok: [instance] 2026-08-24 19:35:18.323195 | instance | 2026-08-24 19:35:18.323237 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] *********************************** 2026-08-24 19:35:18.323243 | instance | Monday 24 August 2026 19:35:18 +0000 (0:00:00.052) 0:00:35.972 ********* 2026-08-24 19:35:18.385754 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance 2026-08-24 19:35:18.385823 | instance | 2026-08-24 19:35:18.386113 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] ************* 2026-08-24 19:35:18.386225 | instance | Monday 24 August 2026 19:35:18 +0000 (0:00:00.062) 0:00:36.035 ********* 2026-08-24 19:35:18.683107 | instance | changed: [instance] 2026-08-24 19:35:18.683174 | instance | 2026-08-24 19:35:18.683458 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ****************** 2026-08-24 19:35:18.683493 | instance | Monday 24 August 2026 19:35:18 +0000 (0:00:00.297) 0:00:36.333 ********* 2026-08-24 19:35:19.344743 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True}) 2026-08-24 19:35:19.344776 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0}) 2026-08-24 19:35:19.344782 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False}) 2026-08-24 19:35:19.344787 | instance | 2026-08-24 19:35:19.344792 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] ******************************* 2026-08-24 19:35:19.344796 | instance | Monday 24 August 2026 19:35:19 +0000 (0:00:00.660) 0:00:36.993 ********* 2026-08-24 19:36:42.934484 | instance | ok: [instance] 2026-08-24 19:36:42.934576 | instance | 2026-08-24 19:36:42.935004 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] *************** 2026-08-24 19:36:42.935071 | instance | Monday 24 August 2026 19:36:42 +0000 (0:01:23.589) 0:02:00.583 ********* 2026-08-24 19:36:43.154381 | instance | changed: [instance] 2026-08-24 19:36:43.154421 | instance | 2026-08-24 19:36:43.154427 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] ********************************** 2026-08-24 19:36:43.154432 | instance | Monday 24 August 2026 19:36:43 +0000 (0:00:00.220) 0:02:00.804 ********* 2026-08-24 19:36:43.227941 | instance | ok: [instance] 2026-08-24 19:36:43.227980 | instance | 2026-08-24 19:36:43.227985 | instance | TASK [Install Ceph host] ******************************************************* 2026-08-24 19:36:43.227990 | instance | Monday 24 August 2026 19:36:43 +0000 (0:00:00.073) 0:02:00.877 ********* 2026-08-24 19:36:43.307555 | instance | included: vexxhost.ceph.cephadm_host for instance 2026-08-24 19:36:43.307587 | instance | 2026-08-24 19:36:43.307592 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ****** 2026-08-24 19:36:43.307596 | instance | Monday 24 August 2026 19:36:43 +0000 (0:00:00.079) 0:02:00.957 ********* 2026-08-24 19:36:44.877915 | instance | ok: [instance] 2026-08-24 19:36:44.877956 | instance | 2026-08-24 19:36:44.877961 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] *** 2026-08-24 19:36:44.877966 | instance | Monday 24 August 2026 19:36:44 +0000 (0:00:01.569) 0:02:02.527 ********* 2026-08-24 19:36:44.934162 | instance | ok: [instance] => (item=instance) 2026-08-24 19:36:44.934178 | instance | 2026-08-24 19:36:44.934183 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] *********** 2026-08-24 19:36:44.934187 | instance | Monday 24 August 2026 19:36:44 +0000 (0:00:00.056) 0:02:02.584 ********* 2026-08-24 19:36:45.265728 | instance | ok: [instance] 2026-08-24 19:36:45.265769 | instance | 2026-08-24 19:36:45.265775 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] *********************** 2026-08-24 19:36:45.265780 | instance | Monday 24 August 2026 19:36:45 +0000 (0:00:00.331) 0:02:02.915 ********* 2026-08-24 19:36:47.571660 | instance | ok: [instance] 2026-08-24 19:36:47.571742 | instance | 2026-08-24 19:36:47.571976 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ****************** 2026-08-24 19:36:47.572015 | instance | Monday 24 August 2026 19:36:47 +0000 (0:00:02.306) 0:02:05.221 ********* 2026-08-24 19:37:30.500359 | 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 19:37:30.501310 | 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_wh8inwvq/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_wh8inwvq/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_wh8inwvq/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_wh8inwvq/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-24T19:37:30.338+0000 7f19fa3ca640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAinYxqDHxxEyAAaJ143wHSrXsdKZ9M7xNWXTBflFnAeFHKEHF/rSeYVQY=: Malformed input [buffer:3]\n2026-08-24T19:37:30.338+0000 7f19fa3ca640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T19:37:30.342+0000 7f19fa3ca640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAinYxqDHxxEyAAaJ143wHSrXsdKZ9M7xNWXTBflFnAeFHKEHF/rSeYVQY=: Malformed input [buffer:3]\n2026-08-24T19:37:30.342+0000 7f19fa3ca640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T19:37:30.342+0000 7f19fa3ca640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAinYxqDHxxEyAAaJ143wHSrXsdKZ9M7xNWXTBflFnAeFHKEHF/rSeYVQY=: Malformed input [buffer:3]\n2026-08-24T19:37:30.342+0000 7f19fa3ca640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T19:37:30.342+0000 7f19fa3ca640 -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 19:37:30.504256 | instance | 2026-08-24 19:37:30.504539 | instance | PLAY RECAP ********************************************************************* 2026-08-24 19:37:30.505261 | instance | instance : ok=55 changed=26 unreachable=0 failed=1 skipped=6 rescued=0 ignored=0 2026-08-24 19:37:30.505319 | instance | 2026-08-24 19:37:30.505338 | instance | Monday 24 August 2026 19:37:30 +0000 (0:00:42.932) 0:02:48.154 ********* 2026-08-24 19:37:30.509247 | instance | =============================================================================== 2026-08-24 19:37:30.509300 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 83.59s 2026-08-24 19:37:30.509305 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 42.93s 2026-08-24 19:37:30.509310 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 4.72s 2026-08-24 19:37:30.509314 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 4.69s 2026-08-24 19:37:30.509318 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.27s 2026-08-24 19:37:30.509323 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.78s 2026-08-24 19:37:30.509328 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.31s 2026-08-24 19:37:30.509333 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.59s 2026-08-24 19:37:30.509352 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.57s 2026-08-24 19:37:30.509357 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.17s 2026-08-24 19:37:30.509361 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 0.96s 2026-08-24 19:37:30.509365 | instance | Gathering Facts --------------------------------------------------------- 0.94s 2026-08-24 19:37:30.509369 | instance | Gathering Facts --------------------------------------------------------- 0.88s 2026-08-24 19:37:30.509373 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 0.87s 2026-08-24 19:37:30.509382 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.87s 2026-08-24 19:37:30.509629 | instance | Gathering Facts --------------------------------------------------------- 0.82s 2026-08-24 19:37:30.509974 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.81s 2026-08-24 19:37:30.510300 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.75s 2026-08-24 19:37:30.510632 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.74s 2026-08-24 19:37:30.510960 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.66s 2026-08-24 19:37:30.591331 | 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 19:37:30.591632 | instance | ERROR [csi > converge] Executed: Failed 2026-08-24 19:37:30.591826 | 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 19:37:30.765883 | instance | ERROR 2026-08-24 19:37:30.766157 | instance | { 2026-08-24 19:37:30.766229 | instance | "delta": "0:03:35.349934", 2026-08-24 19:37:30.766306 | instance | "end": "2026-08-24 19:37:30.640364", 2026-08-24 19:37:30.766346 | instance | "msg": "non-zero return code", 2026-08-24 19:37:30.766464 | instance | "rc": 2, 2026-08-24 19:37:30.766548 | instance | "start": "2026-08-24 19:33:55.290430" 2026-08-24 19:37:30.766634 | instance | } failure 2026-08-24 19:37:30.773173 | 2026-08-24 19:37:30.773238 | PLAY RECAP 2026-08-24 19:37:30.773296 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-08-24 19:37:30.773319 | 2026-08-24 19:37:30.896186 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-24 19:37:30.901247 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-08-24 19:37:31.485245 | 2026-08-24 19:37:31.485920 | PLAY [all] 2026-08-24 19:37:31.500479 | 2026-08-24 19:37:31.500563 | TASK [gather-host-logs : creating directory for system status] 2026-08-24 19:37:31.828770 | instance | changed 2026-08-24 19:37:31.836604 | 2026-08-24 19:37:31.836690 | TASK [gather-host-logs : Get logs for each host] 2026-08-24 19:37:32.173523 | instance | + systemd-cgls --full --all --no-pager 2026-08-24 19:37:32.184988 | instance | + ip addr 2026-08-24 19:37:32.187297 | instance | + ip route 2026-08-24 19:37:32.189600 | instance | + lsblk 2026-08-24 19:37:32.193124 | instance | + mount 2026-08-24 19:37:32.195537 | instance | + docker images 2026-08-24 19:37:32.214633 | instance | + brctl show 2026-08-24 19:37:32.214987 | instance | /bin/bash: line 8: brctl: command not found 2026-08-24 19:37:32.215172 | instance | + ps aux --sort=-%mem 2026-08-24 19:37:32.229112 | instance | + dpkg -l 2026-08-24 19:37:32.239786 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-08-24 19:37:32.240318 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-08-24 19:37:32.259005 | instance | + '[' '!' -z '' ']' 2026-08-24 19:37:32.372411 | instance | ok: Runtime: 0:00:00.090592 2026-08-24 19:37:32.378642 | 2026-08-24 19:37:32.378708 | TASK [gather-host-logs : Downloads logs to executor] 2026-08-24 19:37:32.989276 | instance | changed: 2026-08-24 19:37:32.989463 | instance | created directory /var/lib/zuul/builds/3adeae4facf54914b27c4baed8a45348/work/logs/instance 2026-08-24 19:37:32.989492 | instance | cd+++++++++ system/ 2026-08-24 19:37:32.989514 | instance | >f+++++++++ system/brctl-show.txt 2026-08-24 19:37:32.989535 | instance | >f+++++++++ system/docker-images.txt 2026-08-24 19:37:32.989556 | instance | >f+++++++++ system/ip-addr.txt 2026-08-24 19:37:32.989579 | instance | >f+++++++++ system/ip-route.txt 2026-08-24 19:37:32.989600 | instance | >f+++++++++ system/lsblk.txt 2026-08-24 19:37:32.989620 | instance | >f+++++++++ system/mount.txt 2026-08-24 19:37:32.989639 | instance | >f+++++++++ system/packages.txt 2026-08-24 19:37:32.989659 | instance | >f+++++++++ system/ps.txt 2026-08-24 19:37:32.989680 | instance | >f+++++++++ system/systemd-cgls.txt 2026-08-24 19:37:32.998721 | 2026-08-24 19:37:32.998788 | LOOP [helm-release-status : creating directory for helm release status] 2026-08-24 19:37:33.193238 | instance | changed: "values" 2026-08-24 19:37:33.383907 | instance | changed: "releases" 2026-08-24 19:37:33.400342 | 2026-08-24 19:37:33.400505 | TASK [helm-release-status : Gather get release status for helm charts] 2026-08-24 19:37:33.603745 | instance | /bin/bash: line 3: kubectl: command not found 2026-08-24 19:37:33.944439 | instance | ok: Runtime: 0:00:00.005226 2026-08-24 19:37:33.951505 | 2026-08-24 19:37:33.951600 | TASK [helm-release-status : Downloads logs to executor] 2026-08-24 19:37:34.405638 | instance | changed: 2026-08-24 19:37:34.405793 | instance | cd+++++++++ helm/ 2026-08-24 19:37:34.405821 | instance | cd+++++++++ helm/releases/ 2026-08-24 19:37:34.405844 | instance | cd+++++++++ helm/values/ 2026-08-24 19:37:34.416536 | 2026-08-24 19:37:34.416842 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-08-24 19:37:34.614073 | instance | changed 2026-08-24 19:37:34.622493 | 2026-08-24 19:37:34.622637 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-08-24 19:37:34.877820 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-24 19:37:34.877935 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-24 19:37:34.883616 | instance | environment: line 1: kubectl: command not found 2026-08-24 19:37:34.885042 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-24 19:37:34.885668 | instance | environment: line 1: kubectl: command not found 2026-08-24 19:37:34.886948 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-24 19:37:34.889362 | instance | environment: line 1: kubectl: command not found 2026-08-24 19:37:34.890893 | instance | environment: line 1: kubectl: command not found 2026-08-24 19:37:34.890928 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-24 19:37:34.891735 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-24 19:37:34.893166 | instance | environment: line 1: kubectl: command not found 2026-08-24 19:37:34.894426 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-24 19:37:35.158989 | instance | ok: Runtime: 0:00:00.024424 2026-08-24 19:37:35.165669 | 2026-08-24 19:37:35.165760 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-08-24 19:37:35.362571 | instance | changed 2026-08-24 19:37:35.370171 | 2026-08-24 19:37:35.370261 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-08-24 19:37:35.578275 | instance | environment: line 5: kubectl: command not found 2026-08-24 19:37:35.578907 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-24 19:37:35.579131 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-24 19:37:35.579300 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-24 19:37:35.908370 | instance | ok: Runtime: 0:00:00.010857 2026-08-24 19:37:35.915543 | 2026-08-24 19:37:35.915631 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-08-24 19:37:36.382833 | instance | changed: 2026-08-24 19:37:36.383028 | instance | cd+++++++++ objects/ 2026-08-24 19:37:36.383068 | instance | cd+++++++++ objects/cluster/ 2026-08-24 19:37:36.383101 | instance | cd+++++++++ objects/namespaced/ 2026-08-24 19:37:36.392276 | 2026-08-24 19:37:36.392340 | TASK [gather-pod-logs : creating directory for pod logs] 2026-08-24 19:37:36.588399 | instance | changed 2026-08-24 19:37:36.593846 | 2026-08-24 19:37:36.593914 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-08-24 19:37:36.830292 | instance | changed 2026-08-24 19:37:36.835159 | 2026-08-24 19:37:36.835228 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-08-24 19:37:37.040419 | instance | environment: line 3: kubectl: command not found 2026-08-24 19:37:37.369743 | instance | ok: Runtime: 0:00:00.010734 2026-08-24 19:37:37.375105 | 2026-08-24 19:37:37.375241 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-08-24 19:37:37.854963 | instance | changed: 2026-08-24 19:37:37.855220 | instance | cd+++++++++ pod-logs/ 2026-08-24 19:37:37.855302 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-08-24 19:37:37.866033 | 2026-08-24 19:37:37.866124 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-08-24 19:37:38.054971 | instance | changed 2026-08-24 19:37:38.059855 | 2026-08-24 19:37:38.059917 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-08-24 19:37:38.269809 | instance | /bin/bash: line 2: kubectl: command not found 2026-08-24 19:37:38.596226 | instance | ok: Runtime: 0:00:00.036391 2026-08-24 19:37:38.603154 | 2026-08-24 19:37:38.603245 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-08-24 19:37:38.804434 | instance | /bin/bash: line 2: kubectl: command not found 2026-08-24 19:37:38.833724 | instance | ceph-mgr endpoints: 2026-08-24 19:37:39.141313 | instance | ok: Runtime: 0:00:00.034596 2026-08-24 19:37:39.146799 | 2026-08-24 19:37:39.146867 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-08-24 19:37:39.338656 | instance | /bin/bash: line 4: kubectl: command not found 2026-08-24 19:37:39.683735 | instance | ok: Runtime: 0:00:00.037962 2026-08-24 19:37:39.690783 | 2026-08-24 19:37:39.690853 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-08-24 19:37:40.180022 | instance | changed: cd+++++++++ prometheus/ 2026-08-24 19:37:40.192485 | 2026-08-24 19:37:40.192549 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-08-24 19:37:40.396916 | instance | changed 2026-08-24 19:37:40.403689 | 2026-08-24 19:37:40.403784 | TASK [gather-selenium-data : Get selenium data] 2026-08-24 19:37:40.660223 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-08-24 19:37:40.661615 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-08-24 19:37:40.942721 | instance | ERROR 2026-08-24 19:37:40.942935 | instance | { 2026-08-24 19:37:40.942968 | instance | "delta": "0:00:00.005554", 2026-08-24 19:37:40.942990 | instance | "end": "2026-08-24 19:37:40.661999", 2026-08-24 19:37:40.943011 | instance | "msg": "non-zero return code", 2026-08-24 19:37:40.943030 | instance | "rc": 1, 2026-08-24 19:37:40.943050 | instance | "start": "2026-08-24 19:37:40.656445" 2026-08-24 19:37:40.943068 | instance | } 2026-08-24 19:37:40.943097 | instance | ERROR: Ignoring Errors 2026-08-24 19:37:40.947873 | 2026-08-24 19:37:40.947946 | TASK [gather-selenium-data : Downloads logs to executor] 2026-08-24 19:37:41.443309 | instance | changed: cd+++++++++ selenium/ 2026-08-24 19:37:41.451398 | 2026-08-24 19:37:41.451470 | PLAY RECAP 2026-08-24 19:37:41.451531 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-08-24 19:37:41.451564 | 2026-08-24 19:37:41.590495 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-08-24 19:37:41.592555 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-24 19:37:42.418381 | 2026-08-24 19:37:42.418497 | PLAY [all] 2026-08-24 19:37:42.429868 | 2026-08-24 19:37:42.429945 | TASK [fetch-output : Set log path for multiple nodes] 2026-08-24 19:37:42.464986 | instance | skipping: Conditional result was False 2026-08-24 19:37:42.473950 | 2026-08-24 19:37:42.474055 | TASK [fetch-output : Set log path for single node] 2026-08-24 19:37:42.504784 | instance | ok 2026-08-24 19:37:42.510883 | 2026-08-24 19:37:42.510972 | LOOP [fetch-output : Ensure local output dirs] 2026-08-24 19:37:42.887654 | instance -> localhost | ok: "/var/lib/zuul/builds/3adeae4facf54914b27c4baed8a45348/work/logs" 2026-08-24 19:37:43.094494 | instance -> localhost | changed: "/var/lib/zuul/builds/3adeae4facf54914b27c4baed8a45348/work/artifacts" 2026-08-24 19:37:43.304155 | instance -> localhost | changed: "/var/lib/zuul/builds/3adeae4facf54914b27c4baed8a45348/work/docs" 2026-08-24 19:37:43.326690 | 2026-08-24 19:37:43.326820 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-24 19:37:43.960700 | instance | changed: .d..t...... ./ 2026-08-24 19:37:43.960985 | instance | changed: All items complete 2026-08-24 19:37:43.961015 | 2026-08-24 19:37:44.398526 | instance | changed: .d..t...... ./ 2026-08-24 19:37:44.850279 | instance | changed: .d..t...... ./ 2026-08-24 19:37:44.879361 | 2026-08-24 19:37:44.879496 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-24 19:37:45.284802 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.006869 2026-08-24 19:37:45.506113 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007455 2026-08-24 19:37:45.520225 | 2026-08-24 19:37:45.520365 | PLAY [all] 2026-08-24 19:37:45.526767 | 2026-08-24 19:37:45.526866 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-24 19:37:45.957733 | instance | changed 2026-08-24 19:37:45.963769 | 2026-08-24 19:37:45.963891 | PLAY RECAP 2026-08-24 19:37:45.963948 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-24 19:37:45.963970 | 2026-08-24 19:37:46.134508 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-24 19:37:46.137565 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-24 19:37:46.768672 | 2026-08-24 19:37:46.769597 | PLAY [localhost] 2026-08-24 19:37:46.781973 | 2026-08-24 19:37:46.782082 | TASK [Generate Zuul manifest] 2026-08-24 19:37:46.807120 | localhost | ok 2026-08-24 19:37:46.832306 | 2026-08-24 19:37:46.832647 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-24 19:37:47.220744 | localhost | changed 2026-08-24 19:37:47.232345 | 2026-08-24 19:37:47.232424 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-24 19:37:47.263326 | localhost | ok 2026-08-24 19:37:47.273616 | 2026-08-24 19:37:47.273731 | TASK [Upload logs] 2026-08-24 19:37:47.296574 | localhost | ok 2026-08-24 19:37:47.360139 | 2026-08-24 19:37:47.360284 | TASK [Set zuul-log-path fact] 2026-08-24 19:37:47.384268 | localhost | ok 2026-08-24 19:37:47.401191 | 2026-08-24 19:37:47.401275 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-24 19:37:47.433580 | localhost | ok 2026-08-24 19:37:47.443705 | 2026-08-24 19:37:47.443798 | TASK [upload-logs : Create log directories] 2026-08-24 19:37:47.840211 | localhost | changed 2026-08-24 19:37:47.847116 | 2026-08-24 19:37:47.847209 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-24 19:37:48.285412 | localhost -> localhost | ok: Runtime: 0:00:00.006097 2026-08-24 19:37:48.293437 | 2026-08-24 19:37:48.293523 | TASK [upload-logs : Upload logs to log server] 2026-08-24 19:37:48.802809 | localhost | Output suppressed because no_log was given 2026-08-24 19:37:48.842752 | 2026-08-24 19:37:48.842884 | LOOP [upload-logs : Compress console log and json output] 2026-08-24 19:37:48.894259 | localhost | skipping: Conditional result was False 2026-08-24 19:37:48.901416 | localhost | skipping: Conditional result was False 2026-08-24 19:37:48.920418 | 2026-08-24 19:37:48.920676 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-24 19:37:48.966349 | localhost | skipping: Conditional result was False 2026-08-24 19:37:48.966752 | 2026-08-24 19:37:48.970585 | localhost | skipping: Conditional result was False 2026-08-24 19:37:48.988092 | 2026-08-24 19:37:48.988244 | LOOP [upload-logs : Upload console log and json output]