2026-08-20 20:28:50.554444 | Job console starting 2026-08-20 20:28:50.564348 | Updating git repos 2026-08-20 20:28:51.318525 | Cloning repos into workspace 2026-08-20 20:29:23.756783 | Restoring repo states 2026-08-20 20:29:33.962705 | Merging changes 2026-08-20 20:29:36.815144 | Checking out repos 2026-08-20 20:29:42.516746 | Preparing playbooks 2026-08-20 20:30:07.305437 | Running Ansible setup 2026-08-20 20:30:11.688194 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-20 20:30:12.490698 | 2026-08-20 20:30:12.490845 | PLAY [localhost] 2026-08-20 20:30:12.500050 | 2026-08-20 20:30:12.500172 | TASK [Gathering Facts] 2026-08-20 20:30:13.491286 | localhost | ok 2026-08-20 20:30:13.502127 | 2026-08-20 20:30:13.502309 | TASK [Setup log path fact] 2026-08-20 20:30:13.534167 | localhost | ok 2026-08-20 20:30:13.548650 | 2026-08-20 20:30:13.548770 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-20 20:30:13.579542 | localhost | ok 2026-08-20 20:30:13.587222 | 2026-08-20 20:30:13.587330 | TASK [emit-job-header : Print job information] 2026-08-20 20:30:13.634744 | # Job Information 2026-08-20 20:30:13.634884 | Ansible Version: 2.16.18 2026-08-20 20:30:13.634917 | Job: atmosphere-molecule-csi-rbd 2026-08-20 20:30:13.634940 | Pipeline: check 2026-08-20 20:30:13.634960 | Executor: 2d72f0692154 2026-08-20 20:30:13.634981 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4317 2026-08-20 20:30:13.635005 | Event ID: aec53bb0-9cd3-11f1-9bad-7c092ead0f36 2026-08-20 20:30:13.637955 | 2026-08-20 20:30:13.638028 | LOOP [emit-job-header : Print node information] 2026-08-20 20:30:13.764828 | localhost | ok: 2026-08-20 20:30:13.910909 | localhost | # Node Information 2026-08-20 20:30:13.911112 | localhost | Inventory Hostname: instance 2026-08-20 20:30:13.911190 | localhost | Hostname: np0000190296 2026-08-20 20:30:13.911242 | localhost | Username: zuul 2026-08-20 20:30:13.911311 | localhost | Distro: Ubuntu 22.04 2026-08-20 20:30:13.911367 | localhost | Provider: yul1 2026-08-20 20:30:13.911413 | localhost | Region: ca-ymq-1 2026-08-20 20:30:13.911461 | localhost | Label: ubuntu-jammy 2026-08-20 20:30:13.911506 | localhost | Product Name: OpenStack Nova 2026-08-20 20:30:13.911551 | localhost | Interface IP: 199.19.213.54 2026-08-20 20:30:13.926977 | 2026-08-20 20:30:13.927130 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-20 20:30:14.360311 | localhost -> localhost | changed 2026-08-20 20:30:14.371079 | 2026-08-20 20:30:14.371166 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-20 20:30:15.698970 | localhost -> localhost | changed 2026-08-20 20:30:15.706743 | 2026-08-20 20:30:15.706806 | PLAY [all] 2026-08-20 20:30:15.726830 | 2026-08-20 20:30:15.727031 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-20 20:30:16.014935 | instance -> localhost | ok 2026-08-20 20:30:16.022791 | 2026-08-20 20:30:16.022894 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-20 20:30:16.057305 | instance | ok 2026-08-20 20:30:16.076081 | instance | included: /var/lib/zuul/builds/85cb1e389e4c41968698fb1fcd25380d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-20 20:30:16.082351 | 2026-08-20 20:30:16.082449 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-20 20:30:20.142666 | instance -> localhost | Generating public/private rsa key pair. 2026-08-20 20:30:20.142913 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/85cb1e389e4c41968698fb1fcd25380d/work/85cb1e389e4c41968698fb1fcd25380d_id_rsa 2026-08-20 20:30:20.142986 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/85cb1e389e4c41968698fb1fcd25380d/work/85cb1e389e4c41968698fb1fcd25380d_id_rsa.pub 2026-08-20 20:30:20.143012 | instance -> localhost | The key fingerprint is: 2026-08-20 20:30:20.143034 | instance -> localhost | SHA256:tZN8zvedakZFW0vHvBOmUjX3OPcFUSvgn01CO0Y2z+U zuul-build-sshkey 2026-08-20 20:30:20.143073 | instance -> localhost | The key's randomart image is: 2026-08-20 20:30:20.143095 | instance -> localhost | +---[RSA 3072]----+ 2026-08-20 20:30:20.143119 | instance -> localhost | | . =+B+| 2026-08-20 20:30:20.143148 | instance -> localhost | | . =.=O@| 2026-08-20 20:30:20.143169 | instance -> localhost | | ...*B=E| 2026-08-20 20:30:20.143189 | instance -> localhost | | o +o.BOo| 2026-08-20 20:30:20.143210 | instance -> localhost | | S = oo..o| 2026-08-20 20:30:20.143229 | instance -> localhost | | = . | 2026-08-20 20:30:20.143249 | instance -> localhost | | + . | 2026-08-20 20:30:20.143268 | instance -> localhost | | + .o| 2026-08-20 20:30:20.143290 | instance -> localhost | | o...o| 2026-08-20 20:30:20.143311 | instance -> localhost | +----[SHA256]-----+ 2026-08-20 20:30:20.143376 | instance -> localhost | ok: Runtime: 0:00:03.551909 2026-08-20 20:30:20.152257 | 2026-08-20 20:30:20.152449 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-20 20:30:20.187308 | instance | ok 2026-08-20 20:30:20.197923 | instance | included: /var/lib/zuul/builds/85cb1e389e4c41968698fb1fcd25380d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-20 20:30:20.206857 | 2026-08-20 20:30:20.206963 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-20 20:30:20.231489 | instance | skipping: Conditional result was False 2026-08-20 20:30:20.243753 | 2026-08-20 20:30:20.243890 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-20 20:30:20.710574 | instance | changed 2026-08-20 20:30:20.718947 | 2026-08-20 20:30:20.719040 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-20 20:30:20.902846 | instance | ok 2026-08-20 20:30:20.910018 | 2026-08-20 20:30:20.910112 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-20 20:30:21.382628 | instance | changed 2026-08-20 20:30:21.389682 | 2026-08-20 20:30:21.389790 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-20 20:30:21.872358 | instance | changed 2026-08-20 20:30:21.878457 | 2026-08-20 20:30:21.878531 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-20 20:30:21.902763 | instance | skipping: Conditional result was False 2026-08-20 20:30:21.919679 | 2026-08-20 20:30:21.919805 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-20 20:30:22.313292 | instance -> localhost | changed 2026-08-20 20:30:22.328161 | 2026-08-20 20:30:22.328227 | TASK [add-build-sshkey : Add back temp key] 2026-08-20 20:30:22.640831 | instance -> localhost | Identity added: /var/lib/zuul/builds/85cb1e389e4c41968698fb1fcd25380d/work/85cb1e389e4c41968698fb1fcd25380d_id_rsa (zuul-build-sshkey) 2026-08-20 20:30:22.641157 | instance -> localhost | ok: Runtime: 0:00:00.014094 2026-08-20 20:30:22.649697 | 2026-08-20 20:30:22.649800 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-20 20:30:22.974656 | instance | ok 2026-08-20 20:30:22.981114 | 2026-08-20 20:30:22.981217 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-20 20:30:23.006324 | instance | skipping: Conditional result was False 2026-08-20 20:30:23.020494 | 2026-08-20 20:30:23.020563 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-08-20 20:30:23.357716 | instance | ok 2026-08-20 20:30:23.366174 | 2026-08-20 20:30:23.366306 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-08-20 20:30:42.051871 | instance | Output suppressed because no_log was given 2026-08-20 20:30:42.061744 | 2026-08-20 20:30:42.061846 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-08-20 20:30:42.275873 | instance | ok: "logs" 2026-08-20 20:30:42.276112 | instance | ok: All items complete 2026-08-20 20:30:42.276153 | 2026-08-20 20:30:42.455786 | instance | ok: "artifacts" 2026-08-20 20:30:42.641880 | instance | ok: "docs" 2026-08-20 20:30:42.654204 | 2026-08-20 20:30:42.654402 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-08-20 20:30:42.844803 | instance | changed: "logs" 2026-08-20 20:30:43.001313 | instance | changed: "artifacts" 2026-08-20 20:30:43.169201 | instance | changed: "docs" 2026-08-20 20:30:43.190110 | 2026-08-20 20:30:43.190206 | PLAY RECAP 2026-08-20 20:30:43.190251 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-08-20 20:30:43.190281 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-20 20:30:43.190305 | 2026-08-20 20:30:43.363178 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-20 20:30:43.383395 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-20 20:30:44.116482 | 2026-08-20 20:30:44.127547 | PLAY [all] 2026-08-20 20:30:44.143092 | 2026-08-20 20:30:44.143229 | TASK [setup-uv : Extract archive] 2026-08-20 20:30:46.418189 | instance | changed 2026-08-20 20:30:46.425676 | 2026-08-20 20:30:46.425761 | TASK [setup-uv : Print version] 2026-08-20 20:30:46.787343 | instance | uv 0.8.13 2026-08-20 20:30:47.149833 | instance | ok: Runtime: 0:00:00.013172 2026-08-20 20:30:47.164238 | 2026-08-20 20:30:47.164630 | TASK [Install Ansible collection siblings] 2026-08-20 20:30:55.938342 | instance | changed: 2026-08-20 20:30:55.938602 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-08-20 20:30:55.938678 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-08-20 20:30:55.938721 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-08-20 20:30:55.938751 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto 2026-08-20 20:30:55.938780 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general 2026-08-20 20:30:55.938814 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql 2026-08-20 20:30:55.938846 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-08-20 20:30:55.938877 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-08-20 20:30:55.938906 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-08-20 20:30:55.938933 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-08-20 20:30:55.938960 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-08-20 20:30:55.938987 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-08-20 20:30:55.939014 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0 2026-08-20 20:30:55.939041 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0 2026-08-20 20:30:55.939067 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0 2026-08-20 20:30:55.939094 | instance | Resolved community.crypto to 2.2.3 for 2.2.3 2026-08-20 20:30:55.939128 | instance | Resolved community.general to 7.3.0 for 7.3.0 2026-08-20 20:30:55.939157 | instance | Resolved community.mysql to 3.6.0 for 3.6.0 2026-08-20 20:30:55.939185 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0 2026-08-20 20:30:55.939212 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0 2026-08-20 20:30:55.939239 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.1.2 2026-08-20 20:30:55.939274 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0 2026-08-20 20:30:55.939345 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-08-20 20:30:55.939411 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0 2026-08-20 20:30:55.939446 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0 2026-08-20 20:30:55.939476 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-08-20 20:30:55.939516 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-08-20 20:30:55.939555 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-08-20 20:30:55.939594 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0 2026-08-20 20:30:55.939631 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3 2026-08-20 20:30:55.939660 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-08-20 20:30:55.939689 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-08-20 20:30:55.939717 | instance | Checked out ansible.netcommon to 1.2.0 2026-08-20 20:30:55.939746 | 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-20 20:30:55.939782 | instance | Starting galaxy collection install process 2026-08-20 20:30:55.939810 | instance | Process install dependency map 2026-08-20 20:30:55.939837 | instance | Starting collection install process 2026-08-20 20:30:55.939865 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon' 2026-08-20 20:30:55.939893 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon 2026-08-20 20:30:55.939919 | instance | ansible.netcommon:* was installed successfully 2026-08-20 20:30:55.939946 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-08-20 20:30:55.940000 | instance | Creating virtual environment at: .venv 2026-08-20 20:30:55.940064 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-08-20 20:30:55.940098 | instance | Downloading ansible-core (2.1MiB) 2026-08-20 20:30:55.940128 | instance | Downloading kubernetes (1.9MiB) 2026-08-20 20:30:55.940156 | instance | Downloading openstacksdk (1.7MiB) 2026-08-20 20:30:55.940184 | instance | Downloading rjsonnet (1.2MiB) 2026-08-20 20:30:55.940211 | instance | Downloading netaddr (2.2MiB) 2026-08-20 20:30:55.940239 | instance | Downloading pygments (1.2MiB) 2026-08-20 20:30:55.940266 | instance | Downloading setuptools (1.1MiB) 2026-08-20 20:30:55.940293 | instance | Downloading cryptography (4.2MiB) 2026-08-20 20:30:55.940319 | instance | Building pyperclip==1.9.0 2026-08-20 20:30:55.940354 | instance | Downloading rjsonnet 2026-08-20 20:30:55.940423 | instance | Downloading netaddr 2026-08-20 20:30:55.940474 | instance | Downloading pygments 2026-08-20 20:30:55.940507 | instance | Downloading cryptography 2026-08-20 20:30:55.940543 | instance | Downloading setuptools 2026-08-20 20:30:55.940582 | instance | Downloading kubernetes 2026-08-20 20:30:55.940620 | instance | Downloading ansible-core 2026-08-20 20:30:55.940658 | instance | Downloading openstacksdk 2026-08-20 20:30:55.940689 | instance | Built pyperclip==1.9.0 2026-08-20 20:30:55.940718 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-08-20 20:30:55.940748 | instance | Installed 79 packages in 41ms 2026-08-20 20:30:55.940777 | instance | Checked out ansible.posix to 1.6.0 2026-08-20 20:30:55.940804 | 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-20 20:30:55.940833 | instance | Starting galaxy collection install process 2026-08-20 20:30:55.940864 | instance | Process install dependency map 2026-08-20 20:30:55.940933 | instance | Starting collection install process 2026-08-20 20:30:55.941046 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-08-20 20:30:55.941115 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix 2026-08-20 20:30:55.941152 | instance | ansible.posix:1.6.0 was installed successfully 2026-08-20 20:30:55.941181 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:30:55.941210 | instance | 2.17.12 2026-08-20 20:30:55.941238 | instance | Checked out ansible.utils to v6.1.0 2026-08-20 20:30:55.941265 | 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-20 20:30:55.941294 | instance | Starting galaxy collection install process 2026-08-20 20:30:55.941320 | instance | Process install dependency map 2026-08-20 20:30:55.941347 | instance | Starting collection install process 2026-08-20 20:30:55.941384 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils' 2026-08-20 20:30:55.941422 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils 2026-08-20 20:30:55.941461 | instance | ansible.utils:6.1.0 was installed successfully 2026-08-20 20:30:55.941498 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:30:55.941529 | instance | 2.17.12 2026-08-20 20:30:55.941558 | instance | Checked out atmosphere.common to v0.7.0 2026-08-20 20:30:55.941587 | 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-20 20:30:55.941626 | instance | Starting galaxy collection install process 2026-08-20 20:30:55.941664 | instance | Process install dependency map 2026-08-20 20:30:55.941702 | instance | Starting collection install process 2026-08-20 20:30:55.941744 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common' 2026-08-20 20:30:55.941815 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common 2026-08-20 20:30:55.941885 | instance | atmosphere.common:0.7.0 was installed successfully 2026-08-20 20:30:55.941929 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:30:55.941968 | instance | 2.17.12 2026-08-20 20:30:55.942006 | instance | Checked out community.crypto to 2.2.3 2026-08-20 20:30:55.942036 | 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-20 20:30:55.942065 | instance | Starting galaxy collection install process 2026-08-20 20:30:55.942093 | instance | Process install dependency map 2026-08-20 20:30:55.942120 | instance | Starting collection install process 2026-08-20 20:30:55.942149 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-08-20 20:30:55.942177 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto 2026-08-20 20:30:55.942206 | instance | community.crypto:2.2.3 was installed successfully 2026-08-20 20:30:55.942235 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:30:55.942264 | instance | 2.17.12 2026-08-20 20:30:55.942292 | instance | Checked out community.general to 7.3.0 2026-08-20 20:30:55.942320 | 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-20 20:30:55.942349 | instance | Starting galaxy collection install process 2026-08-20 20:30:55.942394 | instance | Process install dependency map 2026-08-20 20:30:55.942434 | instance | Starting collection install process 2026-08-20 20:30:55.942472 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-08-20 20:30:55.942600 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general 2026-08-20 20:30:55.942671 | instance | community.general:7.3.0 was installed successfully 2026-08-20 20:30:55.942718 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:30:55.942758 | instance | 2.17.12 2026-08-20 20:30:55.942799 | instance | Checked out community.mysql to 3.6.0 2026-08-20 20:30:55.942840 | 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-20 20:30:55.942882 | instance | Starting galaxy collection install process 2026-08-20 20:30:55.942927 | instance | Process install dependency map 2026-08-20 20:30:55.942967 | instance | Starting collection install process 2026-08-20 20:30:55.943007 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql' 2026-08-20 20:30:55.943045 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql 2026-08-20 20:30:55.943085 | instance | community.mysql:3.6.0 was installed successfully 2026-08-20 20:30:55.943117 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:30:55.943146 | instance | 2.17.12 2026-08-20 20:30:55.943186 | instance | Checked out kubernetes.core to 2.4.0 2026-08-20 20:30:55.943240 | 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-20 20:30:55.943269 | instance | Starting galaxy collection install process 2026-08-20 20:30:55.943291 | instance | Process install dependency map 2026-08-20 20:30:55.943311 | instance | Starting collection install process 2026-08-20 20:30:55.943331 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core' 2026-08-20 20:30:55.943351 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core 2026-08-20 20:30:55.943371 | instance | kubernetes.core:2.4.0 was installed successfully 2026-08-20 20:30:55.943390 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:30:55.943472 | instance | 2.17.12 2026-08-20 20:30:55.943496 | instance | Checked out openstack.cloud to 2.6.0 2026-08-20 20:30:55.943515 | 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-20 20:30:55.943535 | instance | Starting galaxy collection install process 2026-08-20 20:30:55.943554 | instance | Process install dependency map 2026-08-20 20:30:55.943573 | instance | Starting collection install process 2026-08-20 20:30:55.943592 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud' 2026-08-20 20:30:55.943611 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud 2026-08-20 20:30:55.943630 | instance | openstack.cloud:2.6.0 was installed successfully 2026-08-20 20:30:55.943649 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:30:55.943667 | instance | 2.17.12 2026-08-20 20:30:55.943687 | instance | Checked out vexxhost.ceph to v4.2.0 2026-08-20 20:30:55.943705 | 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-20 20:30:55.943732 | instance | Starting galaxy collection install process 2026-08-20 20:30:55.943752 | instance | Process install dependency map 2026-08-20 20:30:55.943771 | instance | Starting collection install process 2026-08-20 20:30:55.943791 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph' 2026-08-20 20:30:55.943811 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph 2026-08-20 20:30:55.943829 | instance | vexxhost.ceph:4.2.0 was installed successfully 2026-08-20 20:30:55.943848 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:30:55.943867 | instance | 2.17.12 2026-08-20 20:30:55.943887 | instance | Checked out vexxhost.containers to v1.6.8 2026-08-20 20:30:55.943918 | 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-20 20:30:55.943966 | instance | Starting galaxy collection install process 2026-08-20 20:30:55.943992 | instance | Process install dependency map 2026-08-20 20:30:55.944013 | instance | Starting collection install process 2026-08-20 20:30:55.944036 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers' 2026-08-20 20:30:55.944063 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers 2026-08-20 20:30:55.944185 | instance | vexxhost.containers:1.6.8 was installed successfully 2026-08-20 20:30:55.944209 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:30:55.944229 | instance | 2.17.12 2026-08-20 20:30:55.944250 | instance | Checked out vexxhost.kubernetes to v3.3.0 2026-08-20 20:30:55.944271 | 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-20 20:30:55.944291 | instance | Starting galaxy collection install process 2026-08-20 20:30:55.944311 | instance | Process install dependency map 2026-08-20 20:30:55.944330 | instance | Starting collection install process 2026-08-20 20:30:55.944349 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes' 2026-08-20 20:30:55.944370 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes 2026-08-20 20:30:55.944397 | instance | vexxhost.kubernetes:3.3.0 was installed successfully 2026-08-20 20:30:55.944418 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:30:55.944438 | instance | 2.17.12 2026-08-20 20:30:55.951714 | 2026-08-20 20:30:55.951828 | PLAY RECAP 2026-08-20 20:30:55.951884 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-20 20:30:55.951907 | 2026-08-20 20:30:56.130688 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-20 20:30:56.136631 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-08-20 20:30:56.801339 | 2026-08-20 20:30:56.801494 | PLAY [all] 2026-08-20 20:30:56.814350 | 2026-08-20 20:30:56.814483 | TASK [Install "jq" for log collection] 2026-08-20 20:31:06.576852 | instance | changed 2026-08-20 20:31:06.579897 | 2026-08-20 20:31:06.580000 | PLAY RECAP 2026-08-20 20:31:06.580079 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-20 20:31:06.580146 | 2026-08-20 20:31:06.728477 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-08-20 20:31:07.077579 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-20 20:31:07.819982 | 2026-08-20 20:31:07.820169 | PLAY [all] 2026-08-20 20:31:07.837260 | 2026-08-20 20:31:07.837446 | LOOP [Check inventory directories] 2026-08-20 20:31:08.213011 | instance | ok: "src/github.com/vexxhost/atmosphere" 2026-08-20 20:31:08.376813 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory" 2026-08-20 20:31:08.539929 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory" 2026-08-20 20:31:08.562000 | 2026-08-20 20:31:08.562172 | LOOP [Copy inventory file for Zuul] 2026-08-20 20:31:09.390471 | instance | changed: 2026-08-20 20:31:09.390768 | instance | { 2026-08-20 20:31:09.390828 | instance | "ansible_loop_var": "item", 2026-08-20 20:31:09.390879 | instance | "changed": false, 2026-08-20 20:31:09.390924 | instance | "failed": false, 2026-08-20 20:31:09.390972 | instance | "invocation": { 2026-08-20 20:31:09.391014 | instance | "module_args": { 2026-08-20 20:31:09.391056 | instance | "checksum_algorithm": "sha1", 2026-08-20 20:31:09.391097 | instance | "follow": true, 2026-08-20 20:31:09.391136 | instance | "get_attributes": true, 2026-08-20 20:31:09.391178 | instance | "get_checksum": true, 2026-08-20 20:31:09.391219 | instance | "get_mime": true, 2026-08-20 20:31:09.391259 | instance | "path": "src/github.com/vexxhost/atmosphere" 2026-08-20 20:31:09.391298 | instance | } 2026-08-20 20:31:09.391339 | instance | }, 2026-08-20 20:31:09.391376 | instance | "item": "src/github.com/vexxhost/atmosphere", 2026-08-20 20:31:09.391545 | instance | "stat": { 2026-08-20 20:31:09.391698 | instance | "atime": 1787257848.8581874, 2026-08-20 20:31:09.391747 | instance | "attr_flags": "e", 2026-08-20 20:31:09.391789 | instance | "attributes": [ 2026-08-20 20:31:09.391831 | instance | "extents" 2026-08-20 20:31:09.391871 | instance | ], 2026-08-20 20:31:09.391910 | instance | "block_size": 4096, 2026-08-20 20:31:09.391951 | instance | "blocks": 8, 2026-08-20 20:31:09.391991 | instance | "charset": "unknown", 2026-08-20 20:31:09.392034 | instance | "ctime": 1787257847.914182, 2026-08-20 20:31:09.392075 | instance | "dev": 64513, 2026-08-20 20:31:09.392114 | instance | "device_type": 0, 2026-08-20 20:31:09.392153 | instance | "executable": true, 2026-08-20 20:31:09.392192 | instance | "exists": true, 2026-08-20 20:31:09.392232 | instance | "gid": 1000, 2026-08-20 20:31:09.392269 | instance | "gr_name": "zuul", 2026-08-20 20:31:09.392304 | instance | "inode": 1046545, 2026-08-20 20:31:09.392339 | instance | "isblk": false, 2026-08-20 20:31:09.392374 | instance | "ischr": false, 2026-08-20 20:31:09.392410 | instance | "isdir": true, 2026-08-20 20:31:09.392443 | instance | "isfifo": false, 2026-08-20 20:31:09.392476 | instance | "isgid": false, 2026-08-20 20:31:09.392510 | instance | "islnk": false, 2026-08-20 20:31:09.392543 | instance | "isreg": false, 2026-08-20 20:31:09.392577 | instance | "issock": false, 2026-08-20 20:31:09.392610 | instance | "isuid": false, 2026-08-20 20:31:09.392643 | instance | "mimetype": "unknown", 2026-08-20 20:31:09.392677 | instance | "mode": "0755", 2026-08-20 20:31:09.392710 | instance | "mtime": 1787257847.914182, 2026-08-20 20:31:09.392744 | instance | "nlink": 21, 2026-08-20 20:31:09.392778 | instance | "path": "src/github.com/vexxhost/atmosphere", 2026-08-20 20:31:09.392811 | instance | "pw_name": "zuul", 2026-08-20 20:31:09.392851 | instance | "readable": true, 2026-08-20 20:31:09.392885 | instance | "rgrp": true, 2026-08-20 20:31:09.392919 | instance | "roth": true, 2026-08-20 20:31:09.392978 | instance | "rusr": true, 2026-08-20 20:31:09.393024 | instance | "size": 4096, 2026-08-20 20:31:09.393062 | instance | "uid": 1000, 2026-08-20 20:31:09.393116 | instance | "version": "4226527756", 2026-08-20 20:31:09.393157 | instance | "wgrp": false, 2026-08-20 20:31:09.393197 | instance | "woth": false, 2026-08-20 20:31:09.393235 | instance | "writeable": true, 2026-08-20 20:31:09.393271 | instance | "wusr": true, 2026-08-20 20:31:09.393307 | instance | "xgrp": true, 2026-08-20 20:31:09.393345 | instance | "xoth": true, 2026-08-20 20:31:09.393384 | instance | "xusr": true 2026-08-20 20:31:09.393571 | instance | } 2026-08-20 20:31:09.393622 | instance | } 2026-08-20 20:31:09.393694 | instance | ok: All items complete 2026-08-20 20:31:09.393739 | 2026-08-20 20:31:09.396804 | instance | skipping: Conditional result was False 2026-08-20 20:31:09.398642 | instance | skipping: Conditional result was False 2026-08-20 20:31:09.422431 | 2026-08-20 20:31:09.422566 | LOOP [Switch "ansible_host" to private IP] 2026-08-20 20:31:09.811026 | instance | changed: 1 replacements made 2026-08-20 20:31:09.813652 | instance | skipping: Conditional result was False 2026-08-20 20:31:09.816769 | instance | skipping: Conditional result was False 2026-08-20 20:31:09.833936 | 2026-08-20 20:31:09.834074 | TASK [Run Molecule scenario] 2026-08-20 20:31:10.767486 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-08-20 20:31:11.154100 | instance | INFO [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-08-20 20:31:11.154209 | instance | INFO [csi > prerun] Performing prerun with role_name_check=0... 2026-08-20 20:31:22.093840 | instance | INFO [csi > dependency] Executing 2026-08-20 20:31:22.094042 | instance | WARNING [csi > dependency] Missing roles requirements file: requirements.yml 2026-08-20 20:31:22.094326 | instance | WARNING [csi > dependency] Missing collections requirements file: collections.yml 2026-08-20 20:31:22.094493 | instance | WARNING [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-08-20 20:31:22.103147 | instance | INFO [csi > cleanup] Executing 2026-08-20 20:31:22.103479 | instance | WARNING [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-20 20:31:22.111094 | instance | INFO [csi > destroy] Executing 2026-08-20 20:31:22.111131 | instance | WARNING [csi > destroy] Skipping, '--destroy=never' requested. 2026-08-20 20:31:22.111220 | instance | INFO [csi > destroy] Executed: Successful 2026-08-20 20:31:22.118712 | instance | INFO [csi > syntax] Executing 2026-08-20 20:31:23.733710 | instance | 2026-08-20 20:31:23.733978 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-08-20 20:31:23.793707 | instance | INFO [csi > syntax] Executed: Successful 2026-08-20 20:31:23.807747 | instance | INFO [csi > create] Executing 2026-08-20 20:31:23.809631 | instance | WARNING [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-20 20:31:23.816997 | instance | INFO [csi > prepare] Executing 2026-08-20 20:31:24.614223 | instance | 2026-08-20 20:31:24.614474 | instance | PLAY [Prepare] ***************************************************************** 2026-08-20 20:31:24.614675 | instance | 2026-08-20 20:31:24.614863 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-20 20:31:24.615042 | instance | Thursday 20 August 2026 20:31:24 +0000 (0:00:00.025) 0:00:00.025 ******* 2026-08-20 20:31:25.740616 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-08-20 20:31:25.740897 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-08-20 20:31:25.741182 | instance | interpreter could change the meaning of that path. See 2026-08-20 20:31:25.741624 | instance | https://docs.ansible.com/ansible- 2026-08-20 20:31:25.741915 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-08-20 20:31:25.749092 | instance | ok: [instance] 2026-08-20 20:31:25.749552 | instance | 2026-08-20 20:31:25.749857 | instance | TASK [Configure short hostname] ************************************************ 2026-08-20 20:31:25.750266 | instance | Thursday 20 August 2026 20:31:25 +0000 (0:00:01.136) 0:00:01.161 ******* 2026-08-20 20:31:26.440288 | instance | changed: [instance] 2026-08-20 20:31:26.440525 | instance | 2026-08-20 20:31:26.440833 | instance | TASK [Ensure hostname inside hosts file] *************************************** 2026-08-20 20:31:26.441148 | instance | Thursday 20 August 2026 20:31:26 +0000 (0:00:00.690) 0:00:01.852 ******* 2026-08-20 20:31:26.696269 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created 2026-08-20 20:31:26.696648 | instance | with a mode of 0700, this may cause issues when running as another user. To 2026-08-20 20:31:26.696976 | instance | avoid this, create the remote_tmp dir with the correct permissions manually 2026-08-20 20:31:26.705226 | instance | changed: [instance] 2026-08-20 20:31:26.705583 | instance | 2026-08-20 20:31:26.705885 | instance | TASK [Purge "snapd" package] *************************************************** 2026-08-20 20:31:26.706164 | instance | Thursday 20 August 2026 20:31:26 +0000 (0:00:00.265) 0:00:02.117 ******* 2026-08-20 20:31:27.450158 | instance | ok: [instance] 2026-08-20 20:31:27.450267 | instance | 2026-08-20 20:31:27.450411 | instance | PLAY [Create devices for Ceph] ************************************************* 2026-08-20 20:31:27.450532 | instance | 2026-08-20 20:31:27.450662 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-20 20:31:27.450793 | instance | Thursday 20 August 2026 20:31:27 +0000 (0:00:00.744) 0:00:02.862 ******* 2026-08-20 20:31:28.116873 | instance | ok: [instance] 2026-08-20 20:31:28.116948 | instance | 2026-08-20 20:31:28.117067 | instance | TASK [Install depedencies] ***************************************************** 2026-08-20 20:31:28.117198 | instance | Thursday 20 August 2026 20:31:28 +0000 (0:00:00.666) 0:00:03.529 ******* 2026-08-20 20:31:47.598962 | instance | changed: [instance] 2026-08-20 20:31:47.599274 | instance | 2026-08-20 20:31:47.599568 | instance | TASK [Start up service] ******************************************************** 2026-08-20 20:31:47.599849 | instance | Thursday 20 August 2026 20:31:47 +0000 (0:00:19.480) 0:00:23.009 ******* 2026-08-20 20:31:48.126153 | instance | ok: [instance] 2026-08-20 20:31:48.126405 | instance | 2026-08-20 20:31:48.126705 | instance | TASK [Generate lvm.conf] ******************************************************* 2026-08-20 20:31:48.126992 | instance | Thursday 20 August 2026 20:31:48 +0000 (0:00:00.528) 0:00:23.538 ******* 2026-08-20 20:31:48.407883 | instance | ok: [instance] 2026-08-20 20:31:48.407960 | instance | 2026-08-20 20:31:48.408138 | instance | TASK [Write /etc/lvm/lvm.conf] ************************************************* 2026-08-20 20:31:48.408300 | instance | Thursday 20 August 2026 20:31:48 +0000 (0:00:00.282) 0:00:23.820 ******* 2026-08-20 20:31:49.047157 | instance | changed: [instance] 2026-08-20 20:31:49.047417 | instance | 2026-08-20 20:31:49.047698 | instance | TASK [Get list of all loopback devices] **************************************** 2026-08-20 20:31:49.047971 | instance | Thursday 20 August 2026 20:31:49 +0000 (0:00:00.638) 0:00:24.458 ******* 2026-08-20 20:31:49.241443 | instance | ok: [instance] 2026-08-20 20:31:49.241713 | instance | 2026-08-20 20:31:49.242003 | instance | TASK [Fail if there is any existing loopback devices] ************************** 2026-08-20 20:31:49.242283 | instance | Thursday 20 August 2026 20:31:49 +0000 (0:00:00.194) 0:00:24.653 ******* 2026-08-20 20:31:49.262971 | instance | skipping: [instance] 2026-08-20 20:31:49.263224 | instance | 2026-08-20 20:31:49.263507 | instance | TASK [Create devices for Ceph] ************************************************* 2026-08-20 20:31:49.263772 | instance | Thursday 20 August 2026 20:31:49 +0000 (0:00:00.022) 0:00:24.675 ******* 2026-08-20 20:31:49.799580 | instance | changed: [instance] => (item=osd0) 2026-08-20 20:31:49.799669 | instance | changed: [instance] => (item=osd1) 2026-08-20 20:31:49.799764 | instance | changed: [instance] => (item=osd2) 2026-08-20 20:31:49.799878 | instance | 2026-08-20 20:31:49.800004 | instance | TASK [Set permissions on loopback devices] ************************************* 2026-08-20 20:31:49.800126 | instance | Thursday 20 August 2026 20:31:49 +0000 (0:00:00.535) 0:00:25.211 ******* 2026-08-20 20:31:50.400135 | instance | changed: [instance] => (item=osd0) 2026-08-20 20:31:50.400183 | instance | changed: [instance] => (item=osd1) 2026-08-20 20:31:50.400188 | instance | changed: [instance] => (item=osd2) 2026-08-20 20:31:50.400193 | instance | 2026-08-20 20:31:50.400665 | instance | TASK [Start loop devices] ****************************************************** 2026-08-20 20:31:50.400759 | instance | Thursday 20 August 2026 20:31:50 +0000 (0:00:00.599) 0:00:25.810 ******* 2026-08-20 20:31:51.089950 | instance | changed: [instance] => (item=osd0) 2026-08-20 20:31:51.090819 | instance | changed: [instance] => (item=osd1) 2026-08-20 20:31:51.090865 | instance | changed: [instance] => (item=osd2) 2026-08-20 20:31:51.090872 | instance | 2026-08-20 20:31:51.090879 | instance | TASK [Create a volume group for each loop device] ****************************** 2026-08-20 20:31:51.090886 | instance | Thursday 20 August 2026 20:31:51 +0000 (0:00:00.690) 0:00:26.502 ******* 2026-08-20 20:31:54.241410 | instance | changed: [instance] => (item=osd0) 2026-08-20 20:31:54.241517 | instance | changed: [instance] => (item=osd1) 2026-08-20 20:31:54.242303 | instance | changed: [instance] => (item=osd2) 2026-08-20 20:31:54.242344 | instance | 2026-08-20 20:31:54.242352 | instance | TASK [Create a logical volume for each loop device] **************************** 2026-08-20 20:31:54.242359 | instance | Thursday 20 August 2026 20:31:54 +0000 (0:00:03.151) 0:00:29.653 ******* 2026-08-20 20:31:56.049244 | instance | changed: [instance] => (item=ceph-instance-osd0) 2026-08-20 20:31:56.049283 | instance | changed: [instance] => (item=ceph-instance-osd1) 2026-08-20 20:31:56.049297 | instance | changed: [instance] => (item=ceph-instance-osd2) 2026-08-20 20:31:56.049302 | instance | 2026-08-20 20:31:56.049307 | instance | PLAY RECAP ********************************************************************* 2026-08-20 20:31:56.049312 | instance | instance : ok=15 changed=9 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-08-20 20:31:56.049570 | instance | 2026-08-20 20:31:56.053665 | instance | Thursday 20 August 2026 20:31:56 +0000 (0:00:01.806) 0:00:31.460 ******* 2026-08-20 20:31:56.053725 | instance | =============================================================================== 2026-08-20 20:31:56.053740 | instance | Install depedencies ---------------------------------------------------- 19.48s 2026-08-20 20:31:56.053752 | instance | Create a volume group for each loop device ------------------------------ 3.15s 2026-08-20 20:31:56.053764 | instance | Create a logical volume for each loop device ---------------------------- 1.81s 2026-08-20 20:31:56.053778 | instance | Gathering Facts --------------------------------------------------------- 1.14s 2026-08-20 20:31:56.053790 | instance | Purge "snapd" package --------------------------------------------------- 0.74s 2026-08-20 20:31:56.053802 | instance | Start loop devices ------------------------------------------------------ 0.69s 2026-08-20 20:31:56.053814 | instance | Configure short hostname ------------------------------------------------ 0.69s 2026-08-20 20:31:56.053826 | instance | Gathering Facts --------------------------------------------------------- 0.67s 2026-08-20 20:31:56.053837 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.64s 2026-08-20 20:31:56.053848 | instance | Set permissions on loopback devices ------------------------------------- 0.60s 2026-08-20 20:31:56.053859 | instance | Create devices for Ceph ------------------------------------------------- 0.54s 2026-08-20 20:31:56.053870 | instance | Start up service -------------------------------------------------------- 0.53s 2026-08-20 20:31:56.053881 | instance | Generate lvm.conf ------------------------------------------------------- 0.28s 2026-08-20 20:31:56.053899 | instance | Ensure hostname inside hosts file --------------------------------------- 0.27s 2026-08-20 20:31:56.054045 | instance | Get list of all loopback devices ---------------------------------------- 0.19s 2026-08-20 20:31:56.054400 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s 2026-08-20 20:31:56.113983 | instance | INFO [csi > prepare] Executed: Successful 2026-08-20 20:31:56.121808 | instance | INFO [csi > converge] Executing 2026-08-20 20:31:57.547389 | instance | 2026-08-20 20:31:57.547804 | instance | PLAY [Debug CSI driver value] ************************************************** 2026-08-20 20:31:57.548215 | instance | 2026-08-20 20:31:57.548589 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-20 20:31:57.548922 | instance | Thursday 20 August 2026 20:31:57 +0000 (0:00:00.008) 0:00:00.008 ******* 2026-08-20 20:31:58.472751 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-08-20 20:31:58.472923 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-08-20 20:31:58.473091 | instance | interpreter could change the meaning of that path. See 2026-08-20 20:31:58.473266 | instance | https://docs.ansible.com/ansible- 2026-08-20 20:31:58.473446 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-08-20 20:31:58.484657 | instance | ok: [instance] 2026-08-20 20:31:58.484932 | instance | 2026-08-20 20:31:58.485291 | instance | TASK [Display CSI driver value and environment variable] *********************** 2026-08-20 20:31:58.485613 | instance | Thursday 20 August 2026 20:31:58 +0000 (0:00:00.937) 0:00:00.945 ******* 2026-08-20 20:31:58.528627 | instance | ok: [instance] => { 2026-08-20 20:31:58.528883 | instance | "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER=" 2026-08-20 20:31:58.529149 | instance | } 2026-08-20 20:31:58.529411 | instance | 2026-08-20 20:31:58.529748 | instance | PLAY [all] ********************************************************************* 2026-08-20 20:31:58.529982 | instance | 2026-08-20 20:31:58.530253 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-20 20:31:58.530544 | instance | Thursday 20 August 2026 20:31:58 +0000 (0:00:00.043) 0:00:00.989 ******* 2026-08-20 20:31:59.393405 | instance | ok: [instance] 2026-08-20 20:31:59.393656 | instance | 2026-08-20 20:31:59.393974 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-08-20 20:31:59.394237 | instance | Thursday 20 August 2026 20:31:59 +0000 (0:00:00.864) 0:00:01.854 ******* 2026-08-20 20:31:59.596311 | instance | ok: [instance] 2026-08-20 20:31:59.596548 | instance | 2026-08-20 20:31:59.596853 | instance | PLAY [Deploy Ceph monitors & managers] ***************************************** 2026-08-20 20:31:59.597111 | instance | 2026-08-20 20:31:59.597423 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-20 20:31:59.597749 | instance | Thursday 20 August 2026 20:31:59 +0000 (0:00:00.202) 0:00:02.057 ******* 2026-08-20 20:32:00.464973 | instance | ok: [instance] 2026-08-20 20:32:00.465236 | instance | 2026-08-20 20:32:00.465455 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-20 20:32:00.465723 | instance | Thursday 20 August 2026 20:32:00 +0000 (0:00:00.868) 0:00:02.925 ******* 2026-08-20 20:32:00.766095 | instance | ok: [instance] 2026-08-20 20:32:00.766195 | instance | 2026-08-20 20:32:00.766352 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-20 20:32:00.766543 | instance | Thursday 20 August 2026 20:32:00 +0000 (0:00:00.300) 0:00:03.226 ******* 2026-08-20 20:32:00.809378 | instance | skipping: [instance] 2026-08-20 20:32:00.809597 | instance | 2026-08-20 20:32:00.809759 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-08-20 20:32:00.809959 | instance | Thursday 20 August 2026 20:32:00 +0000 (0:00:00.042) 0:00:03.268 ******* 2026-08-20 20:32:01.145643 | instance | changed: [instance] 2026-08-20 20:32:01.145937 | instance | 2026-08-20 20:32:01.146266 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-20 20:32:01.146577 | instance | Thursday 20 August 2026 20:32:01 +0000 (0:00:00.338) 0:00:03.606 ******* 2026-08-20 20:32:01.216174 | instance | ok: [instance] => { 2026-08-20 20:32:01.216416 | instance | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-08-20 20:32:01.216681 | instance | } 2026-08-20 20:32:01.216936 | instance | 2026-08-20 20:32:01.217214 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-20 20:32:01.217486 | instance | Thursday 20 August 2026 20:32:01 +0000 (0:00:00.070) 0:00:03.677 ******* 2026-08-20 20:32:01.881183 | instance | changed: [instance] 2026-08-20 20:32:01.881411 | instance | 2026-08-20 20:32:01.881760 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-20 20:32:01.882082 | instance | Thursday 20 August 2026 20:32:01 +0000 (0:00:00.664) 0:00:04.342 ******* 2026-08-20 20:32:01.926580 | instance | skipping: [instance] 2026-08-20 20:32:01.926810 | instance | 2026-08-20 20:32:01.927182 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-20 20:32:01.927530 | instance | Thursday 20 August 2026 20:32:01 +0000 (0:00:00.045) 0:00:04.387 ******* 2026-08-20 20:32:01.971652 | instance | skipping: [instance] 2026-08-20 20:32:01.971786 | instance | 2026-08-20 20:32:01.971966 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-20 20:32:01.972144 | instance | Thursday 20 August 2026 20:32:01 +0000 (0:00:00.045) 0:00:04.433 ******* 2026-08-20 20:32:02.175436 | instance | ok: [instance] 2026-08-20 20:32:02.175687 | instance | 2026-08-20 20:32:02.176027 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-20 20:32:02.176378 | instance | Thursday 20 August 2026 20:32:02 +0000 (0:00:00.203) 0:00:04.636 ******* 2026-08-20 20:32:03.301657 | instance | ok: [instance] 2026-08-20 20:32:03.302071 | instance | 2026-08-20 20:32:03.302441 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-20 20:32:03.302803 | instance | Thursday 20 August 2026 20:32:03 +0000 (0:00:01.126) 0:00:05.762 ******* 2026-08-20 20:32:03.366069 | instance | ok: [instance] => { 2026-08-20 20:32:03.366131 | instance | "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz" 2026-08-20 20:32:03.366283 | instance | } 2026-08-20 20:32:03.366508 | instance | 2026-08-20 20:32:03.366669 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-20 20:32:03.366824 | instance | Thursday 20 August 2026 20:32:03 +0000 (0:00:00.063) 0:00:05.826 ******* 2026-08-20 20:32:04.047961 | instance | changed: [instance] 2026-08-20 20:32:04.048155 | instance | 2026-08-20 20:32:04.048319 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-20 20:32:04.048475 | instance | Thursday 20 August 2026 20:32:04 +0000 (0:00:00.682) 0:00:06.508 ******* 2026-08-20 20:32:06.850006 | instance | changed: [instance] 2026-08-20 20:32:06.850106 | instance | 2026-08-20 20:32:06.850244 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-08-20 20:32:06.850451 | instance | Thursday 20 August 2026 20:32:06 +0000 (0:00:02.802) 0:00:09.311 ******* 2026-08-20 20:32:06.885390 | instance | skipping: [instance] 2026-08-20 20:32:06.885581 | instance | 2026-08-20 20:32:06.885742 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-08-20 20:32:06.885907 | instance | Thursday 20 August 2026 20:32:06 +0000 (0:00:00.032) 0:00:09.344 ******* 2026-08-20 20:32:06.911086 | instance | skipping: [instance] 2026-08-20 20:32:06.911543 | instance | 2026-08-20 20:32:06.911772 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-08-20 20:32:06.912126 | instance | Thursday 20 August 2026 20:32:06 +0000 (0:00:00.028) 0:00:09.372 ******* 2026-08-20 20:32:06.945089 | instance | skipping: [instance] 2026-08-20 20:32:06.945432 | instance | 2026-08-20 20:32:06.945809 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-08-20 20:32:06.946149 | instance | Thursday 20 August 2026 20:32:06 +0000 (0:00:00.034) 0:00:09.406 ******* 2026-08-20 20:32:12.320832 | instance | changed: [instance] 2026-08-20 20:32:12.320959 | instance | 2026-08-20 20:32:12.320967 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] *** 2026-08-20 20:32:12.320974 | instance | Thursday 20 August 2026 20:32:12 +0000 (0:00:05.375) 0:00:14.781 ******* 2026-08-20 20:32:12.891833 | instance | changed: [instance] 2026-08-20 20:32:12.891891 | instance | 2026-08-20 20:32:12.891904 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] ******* 2026-08-20 20:32:12.891914 | instance | Thursday 20 August 2026 20:32:12 +0000 (0:00:00.570) 0:00:15.351 ******* 2026-08-20 20:32:13.799425 | instance | changed: [instance] => (item={'path': '/etc/containerd'}) 2026-08-20 20:32:13.799481 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'}) 2026-08-20 20:32:13.799487 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'}) 2026-08-20 20:32:13.800477 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'}) 2026-08-20 20:32:13.800495 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'}) 2026-08-20 20:32:13.800501 | instance | 2026-08-20 20:32:13.800509 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] ********** 2026-08-20 20:32:13.800804 | instance | Thursday 20 August 2026 20:32:13 +0000 (0:00:00.907) 0:00:16.259 ******* 2026-08-20 20:32:14.381709 | instance | changed: [instance] 2026-08-20 20:32:14.381771 | instance | 2026-08-20 20:32:14.382469 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ******** 2026-08-20 20:32:14.382522 | instance | Thursday 20 August 2026 20:32:14 +0000 (0:00:00.564) 0:00:16.823 ******* 2026-08-20 20:32:14.382528 | instance | 2026-08-20 20:32:14.382533 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-08-20 20:32:14.382537 | instance | Thursday 20 August 2026 20:32:14 +0000 (0:00:00.018) 0:00:16.842 ******* 2026-08-20 20:32:15.204415 | instance | ok: [instance] 2026-08-20 20:32:15.204495 | instance | 2026-08-20 20:32:15.204795 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] ********** 2026-08-20 20:32:15.204832 | instance | Thursday 20 August 2026 20:32:15 +0000 (0:00:00.822) 0:00:17.665 ******* 2026-08-20 20:32:15.629175 | instance | changed: [instance] 2026-08-20 20:32:15.629301 | instance | 2026-08-20 20:32:15.629576 | instance | TASK [vexxhost.containers.containerd : Enable and start service] *************** 2026-08-20 20:32:15.629834 | instance | Thursday 20 August 2026 20:32:15 +0000 (0:00:00.424) 0:00:18.090 ******* 2026-08-20 20:32:16.145607 | instance | changed: [instance] 2026-08-20 20:32:16.145670 | instance | 2026-08-20 20:32:16.145831 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-20 20:32:16.146128 | instance | Thursday 20 August 2026 20:32:16 +0000 (0:00:00.515) 0:00:18.606 ******* 2026-08-20 20:32:16.349933 | instance | ok: [instance] 2026-08-20 20:32:16.350158 | instance | 2026-08-20 20:32:16.350444 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-20 20:32:16.350719 | instance | Thursday 20 August 2026 20:32:16 +0000 (0:00:00.204) 0:00:18.811 ******* 2026-08-20 20:32:16.407316 | instance | ok: [instance] => { 2026-08-20 20:32:16.407578 | instance | "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz" 2026-08-20 20:32:16.407823 | instance | } 2026-08-20 20:32:16.408084 | instance | 2026-08-20 20:32:16.408390 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-20 20:32:16.408645 | instance | Thursday 20 August 2026 20:32:16 +0000 (0:00:00.057) 0:00:18.868 ******* 2026-08-20 20:32:17.075542 | instance | changed: [instance] 2026-08-20 20:32:17.075797 | instance | 2026-08-20 20:32:17.076221 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-20 20:32:17.076551 | instance | Thursday 20 August 2026 20:32:17 +0000 (0:00:00.668) 0:00:19.536 ******* 2026-08-20 20:32:21.415021 | instance | changed: [instance] 2026-08-20 20:32:21.415278 | instance | 2026-08-20 20:32:21.416160 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ****************** 2026-08-20 20:32:21.417273 | instance | Thursday 20 August 2026 20:32:21 +0000 (0:00:04.339) 0:00:23.876 ******* 2026-08-20 20:32:22.479931 | instance | ok: [instance] 2026-08-20 20:32:22.479980 | instance | 2026-08-20 20:32:22.479987 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] *************** 2026-08-20 20:32:22.479994 | instance | Thursday 20 August 2026 20:32:22 +0000 (0:00:01.064) 0:00:24.940 ******* 2026-08-20 20:32:22.875150 | instance | changed: [instance] 2026-08-20 20:32:22.875218 | instance | 2026-08-20 20:32:22.875519 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] ***** 2026-08-20 20:32:22.875656 | instance | Thursday 20 August 2026 20:32:22 +0000 (0:00:00.395) 0:00:25.336 ******* 2026-08-20 20:32:23.341071 | instance | changed: [instance] 2026-08-20 20:32:23.341118 | instance | 2026-08-20 20:32:23.341126 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] *********** 2026-08-20 20:32:23.341133 | instance | Thursday 20 August 2026 20:32:23 +0000 (0:00:00.464) 0:00:25.801 ******* 2026-08-20 20:32:23.903713 | instance | changed: [instance] => (item={'path': '/etc/docker'}) 2026-08-20 20:32:23.903748 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'}) 2026-08-20 20:32:23.903754 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'}) 2026-08-20 20:32:23.903758 | instance | 2026-08-20 20:32:23.903763 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ****** 2026-08-20 20:32:23.903767 | instance | Thursday 20 August 2026 20:32:23 +0000 (0:00:00.562) 0:00:26.364 ******* 2026-08-20 20:32:24.360993 | instance | changed: [instance] 2026-08-20 20:32:24.361601 | instance | 2026-08-20 20:32:24.361659 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] *********** 2026-08-20 20:32:24.361673 | instance | Thursday 20 August 2026 20:32:24 +0000 (0:00:00.457) 0:00:26.822 ******* 2026-08-20 20:32:24.834201 | instance | changed: [instance] 2026-08-20 20:32:24.834329 | instance | 2026-08-20 20:32:24.835398 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************ 2026-08-20 20:32:24.835449 | instance | Thursday 20 August 2026 20:32:24 +0000 (0:00:00.454) 0:00:27.276 ******* 2026-08-20 20:32:24.835457 | instance | 2026-08-20 20:32:24.835464 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-08-20 20:32:24.835470 | instance | Thursday 20 August 2026 20:32:24 +0000 (0:00:00.018) 0:00:27.295 ******* 2026-08-20 20:32:25.548372 | instance | ok: [instance] 2026-08-20 20:32:25.548741 | instance | 2026-08-20 20:32:25.548757 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ****************** 2026-08-20 20:32:25.548768 | instance | Thursday 20 August 2026 20:32:25 +0000 (0:00:00.714) 0:00:28.009 ******* 2026-08-20 20:32:26.444885 | instance | changed: [instance] 2026-08-20 20:32:26.445376 | instance | 2026-08-20 20:32:26.445395 | instance | TASK [vexxhost.containers.docker : Enable and start service] ******************* 2026-08-20 20:32:26.445403 | instance | Thursday 20 August 2026 20:32:26 +0000 (0:00:00.896) 0:00:28.905 ******* 2026-08-20 20:32:27.011886 | instance | changed: [instance] 2026-08-20 20:32:27.011986 | instance | 2026-08-20 20:32:27.012286 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ****** 2026-08-20 20:32:27.012320 | instance | Thursday 20 August 2026 20:32:27 +0000 (0:00:00.567) 0:00:29.473 ******* 2026-08-20 20:32:27.069122 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml) 2026-08-20 20:32:27.069552 | instance | 2026-08-20 20:32:27.069592 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ******************************** 2026-08-20 20:32:27.069598 | instance | Thursday 20 August 2026 20:32:27 +0000 (0:00:00.057) 0:00:29.530 ******* 2026-08-20 20:32:32.060243 | instance | changed: [instance] 2026-08-20 20:32:32.060320 | instance | 2026-08-20 20:32:32.060549 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] ********************* 2026-08-20 20:32:32.060590 | instance | Thursday 20 August 2026 20:32:32 +0000 (0:00:04.991) 0:00:34.521 ******* 2026-08-20 20:32:32.703051 | instance | ok: [instance] => (item=chronyd) 2026-08-20 20:32:32.703120 | instance | ok: [instance] => (item=sshd) 2026-08-20 20:32:32.703546 | instance | 2026-08-20 20:32:32.703587 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ****************************** 2026-08-20 20:32:32.703593 | instance | Thursday 20 August 2026 20:32:32 +0000 (0:00:00.642) 0:00:35.164 ******* 2026-08-20 20:32:33.700181 | instance | changed: [instance] 2026-08-20 20:32:33.700262 | instance | 2026-08-20 20:32:33.700507 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ******************** 2026-08-20 20:32:33.700541 | instance | Thursday 20 August 2026 20:32:33 +0000 (0:00:00.997) 0:00:36.161 ******* 2026-08-20 20:32:33.902273 | instance | ok: [instance] 2026-08-20 20:32:33.902799 | instance | 2026-08-20 20:32:33.902838 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] **************** 2026-08-20 20:32:33.902843 | instance | Thursday 20 August 2026 20:32:33 +0000 (0:00:00.201) 0:00:36.363 ******* 2026-08-20 20:32:34.336282 | instance | changed: [instance] 2026-08-20 20:32:34.336367 | instance | 2026-08-20 20:32:34.336656 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] *** 2026-08-20 20:32:34.336696 | instance | Thursday 20 August 2026 20:32:34 +0000 (0:00:00.434) 0:00:36.797 ******* 2026-08-20 20:32:34.654460 | instance | changed: [instance] 2026-08-20 20:32:34.654534 | instance | 2026-08-20 20:32:34.654843 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] ************************* 2026-08-20 20:32:34.654876 | instance | Thursday 20 August 2026 20:32:34 +0000 (0:00:00.318) 0:00:37.115 ******* 2026-08-20 20:32:34.768055 | instance | ok: [instance] 2026-08-20 20:32:34.768118 | instance | 2026-08-20 20:32:34.768410 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] ******************* 2026-08-20 20:32:34.768451 | instance | Thursday 20 August 2026 20:32:34 +0000 (0:00:00.113) 0:00:37.229 ******* 2026-08-20 20:32:34.982325 | instance | ok: [instance] => (item=instance) 2026-08-20 20:32:34.982400 | instance | 2026-08-20 20:32:34.982690 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ******** 2026-08-20 20:32:34.982836 | instance | Thursday 20 August 2026 20:32:34 +0000 (0:00:00.214) 0:00:37.443 ******* 2026-08-20 20:32:35.036947 | instance | ok: [instance] 2026-08-20 20:32:35.037450 | instance | 2026-08-20 20:32:35.037491 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] *********************************** 2026-08-20 20:32:35.037499 | instance | Thursday 20 August 2026 20:32:35 +0000 (0:00:00.054) 0:00:37.497 ******* 2026-08-20 20:32:35.107864 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance 2026-08-20 20:32:35.107959 | instance | 2026-08-20 20:32:35.108223 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] ************* 2026-08-20 20:32:35.108264 | instance | Thursday 20 August 2026 20:32:35 +0000 (0:00:00.071) 0:00:37.569 ******* 2026-08-20 20:32:35.419990 | instance | changed: [instance] 2026-08-20 20:32:35.420583 | instance | 2026-08-20 20:32:35.420629 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ****************** 2026-08-20 20:32:35.420636 | instance | Thursday 20 August 2026 20:32:35 +0000 (0:00:00.311) 0:00:37.880 ******* 2026-08-20 20:32:36.084976 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True}) 2026-08-20 20:32:36.085074 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0}) 2026-08-20 20:32:36.085589 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False}) 2026-08-20 20:32:36.085626 | instance | 2026-08-20 20:32:36.085632 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] ******************************* 2026-08-20 20:32:36.085637 | instance | Thursday 20 August 2026 20:32:36 +0000 (0:00:00.665) 0:00:38.546 ******* 2026-08-20 20:34:02.151088 | instance | ok: [instance] 2026-08-20 20:34:02.151174 | instance | 2026-08-20 20:34:02.151493 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] *************** 2026-08-20 20:34:02.151537 | instance | Thursday 20 August 2026 20:34:02 +0000 (0:01:26.066) 0:02:04.612 ******* 2026-08-20 20:34:02.373733 | instance | changed: [instance] 2026-08-20 20:34:02.373829 | instance | 2026-08-20 20:34:02.373974 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] ********************************** 2026-08-20 20:34:02.374129 | instance | Thursday 20 August 2026 20:34:02 +0000 (0:00:00.222) 0:02:04.834 ******* 2026-08-20 20:34:02.459676 | instance | ok: [instance] 2026-08-20 20:34:02.459741 | instance | 2026-08-20 20:34:02.460026 | instance | TASK [Install Ceph host] ******************************************************* 2026-08-20 20:34:02.460068 | instance | Thursday 20 August 2026 20:34:02 +0000 (0:00:00.085) 0:02:04.920 ******* 2026-08-20 20:34:02.539530 | instance | included: vexxhost.ceph.cephadm_host for instance 2026-08-20 20:34:02.539617 | instance | 2026-08-20 20:34:02.539857 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ****** 2026-08-20 20:34:02.539889 | instance | Thursday 20 August 2026 20:34:02 +0000 (0:00:00.079) 0:02:05.000 ******* 2026-08-20 20:34:04.148577 | instance | ok: [instance] 2026-08-20 20:34:04.148714 | instance | 2026-08-20 20:34:04.148879 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] *** 2026-08-20 20:34:04.149029 | instance | Thursday 20 August 2026 20:34:04 +0000 (0:00:01.608) 0:02:06.609 ******* 2026-08-20 20:34:04.206625 | instance | ok: [instance] => (item=instance) 2026-08-20 20:34:04.206761 | instance | 2026-08-20 20:34:04.206879 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] *********** 2026-08-20 20:34:04.207003 | instance | Thursday 20 August 2026 20:34:04 +0000 (0:00:00.057) 0:02:06.667 ******* 2026-08-20 20:34:04.584903 | instance | ok: [instance] 2026-08-20 20:34:04.584988 | instance | 2026-08-20 20:34:04.585255 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] *********************** 2026-08-20 20:34:04.585288 | instance | Thursday 20 August 2026 20:34:04 +0000 (0:00:00.378) 0:02:07.046 ******* 2026-08-20 20:34:06.820224 | instance | ok: [instance] 2026-08-20 20:34:06.820314 | instance | 2026-08-20 20:34:06.820574 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ****************** 2026-08-20 20:34:06.820613 | instance | Thursday 20 August 2026 20:34:06 +0000 (0:00:02.235) 0:02:09.281 ******* 2026-08-20 20:35:15.177230 | 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-20 20:35:15.177597 | 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_skfn3w4i/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_skfn3w4i/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_skfn3w4i/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_skfn3w4i/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-20T20:35:15.023+0000 7f45e5258640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCQZIdq4OFsLSAAR9Bh924loG0wQ96ajl90fAR9sv1bbLLHls0s+HzwY+A=: Malformed input [buffer:3]\n2026-08-20T20:35:15.023+0000 7f45e5258640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-20T20:35:15.023+0000 7f45e5258640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCQZIdq4OFsLSAAR9Bh924loG0wQ96ajl90fAR9sv1bbLLHls0s+HzwY+A=: Malformed input [buffer:3]\n2026-08-20T20:35:15.023+0000 7f45e5258640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-20T20:35:15.023+0000 7f45e5258640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCQZIdq4OFsLSAAR9Bh924loG0wQ96ajl90fAR9sv1bbLLHls0s+HzwY+A=: Malformed input [buffer:3]\n2026-08-20T20:35:15.023+0000 7f45e5258640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-20T20:35:15.023+0000 7f45e5258640 -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-20 20:35:15.178482 | instance | 2026-08-20 20:35:15.178613 | instance | PLAY RECAP ********************************************************************* 2026-08-20 20:35:15.178749 | instance | instance : ok=55 changed=26 unreachable=0 failed=1 skipped=6 rescued=0 ignored=0 2026-08-20 20:35:15.181113 | instance | 2026-08-20 20:35:15.181158 | instance | Thursday 20 August 2026 20:35:15 +0000 (0:01:08.358) 0:03:17.640 ******* 2026-08-20 20:35:15.181173 | instance | =============================================================================== 2026-08-20 20:35:15.181183 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 86.07s 2026-08-20 20:35:15.181192 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 68.36s 2026-08-20 20:35:15.181201 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 5.38s 2026-08-20 20:35:15.181210 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 4.99s 2026-08-20 20:35:15.181219 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.34s 2026-08-20 20:35:15.181228 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.80s 2026-08-20 20:35:15.181236 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.24s 2026-08-20 20:35:15.181245 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.61s 2026-08-20 20:35:15.181267 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.54s 2026-08-20 20:35:15.181276 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.13s 2026-08-20 20:35:15.181285 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.06s 2026-08-20 20:35:15.181293 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 1.00s 2026-08-20 20:35:15.181302 | instance | Gathering Facts --------------------------------------------------------- 0.94s 2026-08-20 20:35:15.181311 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.91s 2026-08-20 20:35:15.181319 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 0.90s 2026-08-20 20:35:15.181372 | instance | Gathering Facts --------------------------------------------------------- 0.87s 2026-08-20 20:35:15.181386 | instance | Gathering Facts --------------------------------------------------------- 0.86s 2026-08-20 20:35:15.181404 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.68s 2026-08-20 20:35:15.181443 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.67s 2026-08-20 20:35:15.181657 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.67s 2026-08-20 20:35:15.268076 | 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-20 20:35:15.268450 | instance | ERROR [csi > converge] Executed: Failed 2026-08-20 20:35:15.268748 | 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-20 20:35:15.749684 | instance | ERROR 2026-08-20 20:35:15.749916 | instance | { 2026-08-20 20:35:15.749975 | instance | "delta": "0:04:05.122143", 2026-08-20 20:35:15.750008 | instance | "end": "2026-08-20 20:35:15.320592", 2026-08-20 20:35:15.750036 | instance | "msg": "non-zero return code", 2026-08-20 20:35:15.750063 | instance | "rc": 2, 2026-08-20 20:35:15.750090 | instance | "start": "2026-08-20 20:31:10.198449" 2026-08-20 20:35:15.750117 | instance | } failure 2026-08-20 20:35:15.756759 | 2026-08-20 20:35:15.756827 | PLAY RECAP 2026-08-20 20:35:15.756877 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-08-20 20:35:15.756899 | 2026-08-20 20:35:15.958485 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-20 20:35:16.130409 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-08-20 20:35:17.294668 | 2026-08-20 20:35:17.294842 | PLAY [all] 2026-08-20 20:35:17.349545 | 2026-08-20 20:35:17.349712 | TASK [gather-host-logs : creating directory for system status] 2026-08-20 20:35:17.738029 | instance | changed 2026-08-20 20:35:17.744841 | 2026-08-20 20:35:17.744939 | TASK [gather-host-logs : Get logs for each host] 2026-08-20 20:35:18.143130 | instance | + systemd-cgls --full --all --no-pager 2026-08-20 20:35:18.157036 | instance | + ip addr 2026-08-20 20:35:18.159819 | instance | + ip route 2026-08-20 20:35:18.161200 | instance | + lsblk 2026-08-20 20:35:18.166644 | instance | + mount 2026-08-20 20:35:18.168491 | instance | + docker images 2026-08-20 20:35:18.188948 | instance | + brctl show 2026-08-20 20:35:18.189669 | instance | /bin/bash: line 8: brctl: command not found 2026-08-20 20:35:18.190055 | instance | + ps aux --sort=-%mem 2026-08-20 20:35:18.207389 | instance | + dpkg -l 2026-08-20 20:35:18.218969 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-08-20 20:35:18.219592 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-08-20 20:35:18.236399 | instance | + '[' '!' -z '' ']' 2026-08-20 20:35:18.285526 | instance | ok: Runtime: 0:00:00.098134 2026-08-20 20:35:18.292004 | 2026-08-20 20:35:18.292087 | TASK [gather-host-logs : Downloads logs to executor] 2026-08-20 20:35:18.967279 | instance | changed: 2026-08-20 20:35:18.967440 | instance | created directory /var/lib/zuul/builds/85cb1e389e4c41968698fb1fcd25380d/work/logs/instance 2026-08-20 20:35:18.967475 | instance | cd+++++++++ system/ 2026-08-20 20:35:18.967508 | instance | >f+++++++++ system/brctl-show.txt 2026-08-20 20:35:18.967538 | instance | >f+++++++++ system/docker-images.txt 2026-08-20 20:35:18.967567 | instance | >f+++++++++ system/ip-addr.txt 2026-08-20 20:35:18.967598 | instance | >f+++++++++ system/ip-route.txt 2026-08-20 20:35:18.967626 | instance | >f+++++++++ system/lsblk.txt 2026-08-20 20:35:18.967648 | instance | >f+++++++++ system/mount.txt 2026-08-20 20:35:18.967669 | instance | >f+++++++++ system/packages.txt 2026-08-20 20:35:18.967690 | instance | >f+++++++++ system/ps.txt 2026-08-20 20:35:18.967714 | instance | >f+++++++++ system/systemd-cgls.txt 2026-08-20 20:35:18.979691 | 2026-08-20 20:35:18.979835 | LOOP [helm-release-status : creating directory for helm release status] 2026-08-20 20:35:19.166086 | instance | changed: "values" 2026-08-20 20:35:19.328800 | instance | changed: "releases" 2026-08-20 20:35:19.343869 | 2026-08-20 20:35:19.344049 | TASK [helm-release-status : Gather get release status for helm charts] 2026-08-20 20:35:19.550179 | instance | /bin/bash: line 3: kubectl: command not found 2026-08-20 20:35:19.886208 | instance | ok: Runtime: 0:00:00.003609 2026-08-20 20:35:19.894449 | 2026-08-20 20:35:19.894547 | TASK [helm-release-status : Downloads logs to executor] 2026-08-20 20:35:20.378607 | instance | changed: 2026-08-20 20:35:20.378824 | instance | cd+++++++++ helm/ 2026-08-20 20:35:20.378884 | instance | cd+++++++++ helm/releases/ 2026-08-20 20:35:20.378926 | instance | cd+++++++++ helm/values/ 2026-08-20 20:35:20.390827 | 2026-08-20 20:35:20.391035 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-08-20 20:35:20.629138 | instance | changed 2026-08-20 20:35:20.636731 | 2026-08-20 20:35:20.636807 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-08-20 20:35:20.877919 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-20 20:35:20.878365 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-20 20:35:20.884104 | instance | environment: line 1: kubectl: command not found 2026-08-20 20:35:20.884991 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-20 20:35:20.885421 | instance | environment: line 1: kubectl: command not found 2026-08-20 20:35:20.886999 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-20 20:35:20.887645 | instance | environment: line 1: kubectl: command not found 2026-08-20 20:35:20.888947 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-20 20:35:20.890377 | instance | environment: line 1: kubectl: command not found 2026-08-20 20:35:20.892022 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-20 20:35:20.893597 | instance | environment: line 1: kubectl: command not found 2026-08-20 20:35:20.894334 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-20 20:35:21.170522 | instance | ok: Runtime: 0:00:00.024179 2026-08-20 20:35:21.177797 | 2026-08-20 20:35:21.177912 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-08-20 20:35:21.385151 | instance | changed 2026-08-20 20:35:21.390061 | 2026-08-20 20:35:21.390137 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-08-20 20:35:21.599193 | instance | environment: line 5: kubectl: command not found 2026-08-20 20:35:21.600370 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-20 20:35:21.600396 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-20 20:35:21.600534 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-20 20:35:21.923475 | instance | ok: Runtime: 0:00:00.008475 2026-08-20 20:35:22.261093 | 2026-08-20 20:35:22.261232 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-08-20 20:35:22.780345 | instance | changed: 2026-08-20 20:35:22.780534 | instance | cd+++++++++ objects/ 2026-08-20 20:35:22.780572 | instance | cd+++++++++ objects/cluster/ 2026-08-20 20:35:22.780602 | instance | cd+++++++++ objects/namespaced/ 2026-08-20 20:35:22.791273 | 2026-08-20 20:35:22.791344 | TASK [gather-pod-logs : creating directory for pod logs] 2026-08-20 20:35:22.972059 | instance | changed 2026-08-20 20:35:22.978216 | 2026-08-20 20:35:22.978294 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-08-20 20:35:23.200570 | instance | changed 2026-08-20 20:35:23.327223 | 2026-08-20 20:35:23.327480 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-08-20 20:35:23.567605 | instance | environment: line 3: kubectl: command not found 2026-08-20 20:35:23.868882 | instance | ok: Runtime: 0:00:00.009373 2026-08-20 20:35:23.875034 | 2026-08-20 20:35:23.875160 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-08-20 20:35:24.578919 | instance | changed: 2026-08-20 20:35:24.579123 | instance | cd+++++++++ pod-logs/ 2026-08-20 20:35:24.579206 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-08-20 20:35:24.600930 | 2026-08-20 20:35:24.601249 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-08-20 20:35:24.813873 | instance | changed 2026-08-20 20:35:24.824215 | 2026-08-20 20:35:24.824420 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-08-20 20:35:25.057340 | instance | /bin/bash: line 2: kubectl: command not found 2026-08-20 20:35:25.372456 | instance | ok: Runtime: 0:00:00.035660 2026-08-20 20:35:25.378163 | 2026-08-20 20:35:25.378231 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-08-20 20:35:25.606663 | instance | /bin/bash: line 2: kubectl: command not found 2026-08-20 20:35:25.634290 | instance | ceph-mgr endpoints: 2026-08-20 20:35:26.252007 | instance | ok: Runtime: 0:00:00.032503 2026-08-20 20:35:26.259167 | 2026-08-20 20:35:26.259250 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-08-20 20:35:26.473962 | instance | /bin/bash: line 4: kubectl: command not found 2026-08-20 20:35:27.287962 | instance | ok: Runtime: 0:00:00.032912 2026-08-20 20:35:27.295359 | 2026-08-20 20:35:27.295451 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-08-20 20:35:27.819835 | instance | changed: cd+++++++++ prometheus/ 2026-08-20 20:35:28.168663 | 2026-08-20 20:35:28.168836 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-08-20 20:35:28.382196 | instance | changed 2026-08-20 20:35:28.391577 | 2026-08-20 20:35:28.391722 | TASK [gather-selenium-data : Get selenium data] 2026-08-20 20:35:28.663282 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-08-20 20:35:28.664738 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-08-20 20:35:28.927776 | instance | ERROR 2026-08-20 20:35:28.927939 | instance | { 2026-08-20 20:35:28.927971 | instance | "delta": "0:00:00.006387", 2026-08-20 20:35:28.927994 | instance | "end": "2026-08-20 20:35:28.665128", 2026-08-20 20:35:28.928016 | instance | "msg": "non-zero return code", 2026-08-20 20:35:28.928052 | instance | "rc": 1, 2026-08-20 20:35:28.928083 | instance | "start": "2026-08-20 20:35:28.658741" 2026-08-20 20:35:28.928105 | instance | } 2026-08-20 20:35:28.928131 | instance | ERROR: Ignoring Errors 2026-08-20 20:35:28.933615 | 2026-08-20 20:35:28.939739 | TASK [gather-selenium-data : Downloads logs to executor] 2026-08-20 20:35:29.505513 | instance | changed: cd+++++++++ selenium/ 2026-08-20 20:35:29.636851 | 2026-08-20 20:35:29.637050 | PLAY RECAP 2026-08-20 20:35:29.637281 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-08-20 20:35:29.637419 | 2026-08-20 20:35:29.804305 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-08-20 20:35:29.811352 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-20 20:35:30.778607 | 2026-08-20 20:35:30.778779 | PLAY [all] 2026-08-20 20:35:30.797030 | 2026-08-20 20:35:30.797188 | TASK [fetch-output : Set log path for multiple nodes] 2026-08-20 20:35:30.893907 | instance | skipping: Conditional result was False 2026-08-20 20:35:30.901467 | 2026-08-20 20:35:30.901629 | TASK [fetch-output : Set log path for single node] 2026-08-20 20:35:30.969123 | instance | ok 2026-08-20 20:35:30.979579 | 2026-08-20 20:35:30.979737 | LOOP [fetch-output : Ensure local output dirs] 2026-08-20 20:35:31.538889 | instance -> localhost | ok: "/var/lib/zuul/builds/85cb1e389e4c41968698fb1fcd25380d/work/logs" 2026-08-20 20:35:31.795674 | instance -> localhost | changed: "/var/lib/zuul/builds/85cb1e389e4c41968698fb1fcd25380d/work/artifacts" 2026-08-20 20:35:32.060387 | instance -> localhost | changed: "/var/lib/zuul/builds/85cb1e389e4c41968698fb1fcd25380d/work/docs" 2026-08-20 20:35:32.075368 | 2026-08-20 20:35:32.075493 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-20 20:35:32.862016 | instance | changed: .d..t...... ./ 2026-08-20 20:35:32.862881 | instance | changed: All items complete 2026-08-20 20:35:32.862924 | 2026-08-20 20:35:33.356424 | instance | changed: .d..t...... ./ 2026-08-20 20:35:33.890694 | instance | changed: .d..t...... ./ 2026-08-20 20:35:33.917830 | 2026-08-20 20:35:33.918153 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-20 20:35:34.452000 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.024766 2026-08-20 20:35:35.313346 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.008521 2026-08-20 20:35:35.337392 | 2026-08-20 20:35:35.337529 | PLAY [all] 2026-08-20 20:35:35.347423 | 2026-08-20 20:35:35.347553 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-20 20:35:35.843160 | instance | changed 2026-08-20 20:35:35.851161 | 2026-08-20 20:35:35.851250 | PLAY RECAP 2026-08-20 20:35:35.851295 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-20 20:35:35.851318 | 2026-08-20 20:35:36.043836 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-20 20:35:36.103112 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-20 20:35:36.885122 | 2026-08-20 20:35:36.885287 | PLAY [localhost] 2026-08-20 20:35:37.005090 | 2026-08-20 20:35:37.005244 | TASK [Generate Zuul manifest] 2026-08-20 20:35:37.025154 | localhost | ok 2026-08-20 20:35:37.110458 | 2026-08-20 20:35:37.110658 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-20 20:35:37.557103 | localhost | changed 2026-08-20 20:35:37.570919 | 2026-08-20 20:35:37.571010 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-20 20:35:37.623900 | localhost | ok 2026-08-20 20:35:37.633485 | 2026-08-20 20:35:37.633603 | TASK [Upload logs] 2026-08-20 20:35:37.654198 | localhost | ok 2026-08-20 20:35:38.558420 | 2026-08-20 20:35:38.558532 | TASK [Set zuul-log-path fact] 2026-08-20 20:35:38.581646 | localhost | ok 2026-08-20 20:35:39.410656 | 2026-08-20 20:35:39.410810 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-20 20:35:39.441420 | localhost | ok 2026-08-20 20:35:39.451689 | 2026-08-20 20:35:39.451841 | TASK [upload-logs : Create log directories] 2026-08-20 20:35:39.920401 | localhost | changed 2026-08-20 20:35:39.929097 | 2026-08-20 20:35:39.929460 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-20 20:35:40.570669 | localhost -> localhost | ok: Runtime: 0:00:00.004123 2026-08-20 20:35:40.579802 | 2026-08-20 20:35:40.579928 | TASK [upload-logs : Upload logs to log server] 2026-08-20 20:35:41.710589 | localhost | Output suppressed because no_log was given 2026-08-20 20:35:41.755823 | 2026-08-20 20:35:41.755945 | LOOP [upload-logs : Compress console log and json output] 2026-08-20 20:35:41.814047 | localhost | skipping: Conditional result was False 2026-08-20 20:35:41.824163 | localhost | skipping: Conditional result was False 2026-08-20 20:35:41.839731 | 2026-08-20 20:35:41.839947 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-20 20:35:41.891857 | localhost | skipping: Conditional result was False 2026-08-20 20:35:41.892559 | 2026-08-20 20:35:41.896882 | localhost | skipping: Conditional result was False 2026-08-20 20:35:41.915584 | 2026-08-20 20:35:41.915754 | LOOP [upload-logs : Upload console log and json output]