2026-08-22 10:25:14.080880 | Job console starting 2026-08-22 10:25:14.089923 | Updating git repos 2026-08-22 10:25:16.471981 | Cloning repos into workspace 2026-08-22 10:25:37.629793 | Restoring repo states 2026-08-22 10:25:42.877519 | Merging changes 2026-08-22 10:25:43.840130 | Checking out repos 2026-08-22 10:25:45.822763 | Preparing playbooks 2026-08-22 10:25:47.860055 | Running Ansible setup 2026-08-22 10:25:51.594032 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-22 10:25:52.220649 | 2026-08-22 10:25:52.220983 | PLAY [localhost] 2026-08-22 10:25:52.229223 | 2026-08-22 10:25:52.229299 | TASK [Gathering Facts] 2026-08-22 10:25:53.141703 | localhost | ok 2026-08-22 10:25:53.154252 | 2026-08-22 10:25:53.155732 | TASK [Setup log path fact] 2026-08-22 10:25:53.177291 | localhost | ok 2026-08-22 10:25:53.190687 | 2026-08-22 10:25:53.190758 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-22 10:25:53.221788 | localhost | ok 2026-08-22 10:25:53.231403 | 2026-08-22 10:25:53.231518 | TASK [emit-job-header : Print job information] 2026-08-22 10:25:53.274242 | # Job Information 2026-08-22 10:25:53.274578 | Ansible Version: 2.16.18 2026-08-22 10:25:53.274653 | Job: atmosphere-molecule-csi-rbd 2026-08-22 10:25:53.274702 | Pipeline: check 2026-08-22 10:25:53.274745 | Executor: 2d72f0692154 2026-08-22 10:25:53.274776 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4091 2026-08-22 10:25:53.274810 | Event ID: 0aa70040-9e13-11f1-941b-a2f3dba5e3c2 2026-08-22 10:25:53.278936 | 2026-08-22 10:25:53.279036 | LOOP [emit-job-header : Print node information] 2026-08-22 10:25:53.372894 | localhost | ok: 2026-08-22 10:25:53.373151 | localhost | # Node Information 2026-08-22 10:25:53.373192 | localhost | Inventory Hostname: instance 2026-08-22 10:25:53.373223 | localhost | Hostname: np0000190568 2026-08-22 10:25:53.373251 | localhost | Username: zuul 2026-08-22 10:25:53.373284 | localhost | Distro: Ubuntu 22.04 2026-08-22 10:25:53.373312 | localhost | Provider: yul1 2026-08-22 10:25:53.373338 | localhost | Region: ca-ymq-1 2026-08-22 10:25:53.373365 | localhost | Label: ubuntu-jammy 2026-08-22 10:25:53.373391 | localhost | Product Name: OpenStack Nova 2026-08-22 10:25:53.373416 | localhost | Interface IP: 199.204.45.156 2026-08-22 10:25:53.390291 | 2026-08-22 10:25:53.390457 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-22 10:25:53.759282 | localhost -> localhost | changed 2026-08-22 10:25:53.768569 | 2026-08-22 10:25:53.768668 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-22 10:25:55.099165 | localhost -> localhost | changed 2026-08-22 10:25:55.110062 | 2026-08-22 10:25:55.110148 | PLAY [all] 2026-08-22 10:25:55.120437 | 2026-08-22 10:25:55.120505 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-22 10:25:55.368919 | instance -> localhost | ok 2026-08-22 10:25:55.380182 | 2026-08-22 10:25:55.380258 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-22 10:25:55.415162 | instance | ok 2026-08-22 10:25:55.428560 | instance | included: /var/lib/zuul/builds/8e1c3ee72bc449cf8a1c216b3f9d0816/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-22 10:25:55.434725 | 2026-08-22 10:25:55.434789 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-22 10:25:56.491971 | instance -> localhost | Generating public/private rsa key pair. 2026-08-22 10:25:56.492553 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/8e1c3ee72bc449cf8a1c216b3f9d0816/work/8e1c3ee72bc449cf8a1c216b3f9d0816_id_rsa 2026-08-22 10:25:56.492589 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/8e1c3ee72bc449cf8a1c216b3f9d0816/work/8e1c3ee72bc449cf8a1c216b3f9d0816_id_rsa.pub 2026-08-22 10:25:56.492613 | instance -> localhost | The key fingerprint is: 2026-08-22 10:25:56.492635 | instance -> localhost | SHA256:KsQ8H8gd7l/ncjkBeiOa8FMObC8DG9pvheUxVPErVbg zuul-build-sshkey 2026-08-22 10:25:56.492677 | instance -> localhost | The key's randomart image is: 2026-08-22 10:25:56.492700 | instance -> localhost | +---[RSA 3072]----+ 2026-08-22 10:25:56.492727 | instance -> localhost | | .o. .. | 2026-08-22 10:25:56.492749 | instance -> localhost | | . ... | 2026-08-22 10:25:56.492770 | instance -> localhost | | .. o. | 2026-08-22 10:25:56.492790 | instance -> localhost | | + + .+ ..E. | 2026-08-22 10:25:56.492811 | instance -> localhost | | B.++S+... | 2026-08-22 10:25:56.492830 | instance -> localhost | | .++=o* o.. | 2026-08-22 10:25:56.492850 | instance -> localhost | | o.B+O o...o | 2026-08-22 10:25:56.492870 | instance -> localhost | | . o.O.o..o+ | 2026-08-22 10:25:56.492893 | instance -> localhost | | o.+. o.. | 2026-08-22 10:25:56.492913 | instance -> localhost | +----[SHA256]-----+ 2026-08-22 10:25:56.492985 | instance -> localhost | ok: Runtime: 0:00:00.636580 2026-08-22 10:25:56.499821 | 2026-08-22 10:25:56.499893 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-22 10:25:56.534104 | instance | ok 2026-08-22 10:25:56.546087 | instance | included: /var/lib/zuul/builds/8e1c3ee72bc449cf8a1c216b3f9d0816/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-22 10:25:56.553752 | 2026-08-22 10:25:56.553815 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-22 10:25:56.579002 | instance | skipping: Conditional result was False 2026-08-22 10:25:56.589573 | 2026-08-22 10:25:56.589664 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-22 10:25:57.060409 | instance | changed 2026-08-22 10:25:57.066707 | 2026-08-22 10:25:57.066776 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-22 10:25:57.252083 | instance | ok 2026-08-22 10:25:57.278864 | 2026-08-22 10:25:57.278956 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-22 10:25:57.758655 | instance | changed 2026-08-22 10:25:57.766568 | 2026-08-22 10:25:57.766659 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-22 10:25:58.226119 | instance | changed 2026-08-22 10:25:58.235494 | 2026-08-22 10:25:58.235570 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-22 10:25:58.261193 | instance | skipping: Conditional result was False 2026-08-22 10:25:58.272121 | 2026-08-22 10:25:58.272186 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-22 10:25:58.672377 | instance -> localhost | changed 2026-08-22 10:25:58.687371 | 2026-08-22 10:25:58.687499 | TASK [add-build-sshkey : Add back temp key] 2026-08-22 10:25:58.990707 | instance -> localhost | Identity added: /var/lib/zuul/builds/8e1c3ee72bc449cf8a1c216b3f9d0816/work/8e1c3ee72bc449cf8a1c216b3f9d0816_id_rsa (zuul-build-sshkey) 2026-08-22 10:25:58.991046 | instance -> localhost | ok: Runtime: 0:00:00.015055 2026-08-22 10:25:58.998449 | 2026-08-22 10:25:58.998582 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-22 10:25:59.336996 | instance | ok 2026-08-22 10:25:59.342827 | 2026-08-22 10:25:59.342890 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-22 10:25:59.367564 | instance | skipping: Conditional result was False 2026-08-22 10:25:59.384581 | 2026-08-22 10:25:59.384649 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-08-22 10:25:59.722148 | instance | ok 2026-08-22 10:25:59.732486 | 2026-08-22 10:25:59.732557 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-08-22 10:26:03.033971 | instance | Output suppressed because no_log was given 2026-08-22 10:26:03.045206 | 2026-08-22 10:26:03.045272 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-08-22 10:26:03.238415 | instance | ok: "logs" 2026-08-22 10:26:03.238651 | instance | ok: All items complete 2026-08-22 10:26:03.238680 | 2026-08-22 10:26:03.389080 | instance | ok: "artifacts" 2026-08-22 10:26:03.548143 | instance | ok: "docs" 2026-08-22 10:26:03.562461 | 2026-08-22 10:26:03.562695 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-08-22 10:26:03.744297 | instance | changed: "logs" 2026-08-22 10:26:03.900082 | instance | changed: "artifacts" 2026-08-22 10:26:04.042497 | instance | changed: "docs" 2026-08-22 10:26:04.068570 | 2026-08-22 10:26:04.068719 | PLAY RECAP 2026-08-22 10:26:04.068769 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-08-22 10:26:04.068798 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-22 10:26:04.068821 | 2026-08-22 10:26:04.255723 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-22 10:26:04.259763 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-22 10:26:04.905413 | 2026-08-22 10:26:04.905537 | PLAY [all] 2026-08-22 10:26:04.916278 | 2026-08-22 10:26:04.916361 | TASK [setup-uv : Extract archive] 2026-08-22 10:26:07.025580 | instance | changed 2026-08-22 10:26:07.034759 | 2026-08-22 10:26:07.034901 | TASK [setup-uv : Print version] 2026-08-22 10:26:07.426353 | instance | uv 0.8.13 2026-08-22 10:26:07.579284 | instance | ok: Runtime: 0:00:00.019726 2026-08-22 10:26:07.592935 | 2026-08-22 10:26:07.593050 | TASK [Install Ansible collection siblings] 2026-08-22 10:26:17.557988 | instance | changed: 2026-08-22 10:26:17.558245 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-08-22 10:26:17.558289 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-08-22 10:26:17.558321 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-08-22 10:26:17.558351 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto 2026-08-22 10:26:17.558381 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general 2026-08-22 10:26:17.558416 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql 2026-08-22 10:26:17.558446 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-08-22 10:26:17.558478 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-08-22 10:26:17.558502 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-08-22 10:26:17.558524 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-08-22 10:26:17.558545 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-08-22 10:26:17.558563 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-08-22 10:26:17.558581 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0 2026-08-22 10:26:17.558600 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0 2026-08-22 10:26:17.558619 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0 2026-08-22 10:26:17.558637 | instance | Resolved community.crypto to 2.2.3 for 2.2.3 2026-08-22 10:26:17.558656 | instance | Resolved community.general to 7.3.0 for 7.3.0 2026-08-22 10:26:17.558675 | instance | Resolved community.mysql to 3.6.0 for 3.6.0 2026-08-22 10:26:17.558693 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0 2026-08-22 10:26:17.558711 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0 2026-08-22 10:26:17.558730 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.1.2 2026-08-22 10:26:17.558748 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0 2026-08-22 10:26:17.558768 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-08-22 10:26:17.558801 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0 2026-08-22 10:26:17.558821 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0 2026-08-22 10:26:17.558840 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-08-22 10:26:17.558859 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-08-22 10:26:17.558878 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-08-22 10:26:17.558897 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0 2026-08-22 10:26:17.558916 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3 2026-08-22 10:26:17.558934 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-08-22 10:26:17.558954 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-08-22 10:26:17.558973 | instance | Checked out ansible.netcommon to 1.2.0 2026-08-22 10:26:17.558993 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-08-22 10:26:17.559018 | instance | Starting galaxy collection install process 2026-08-22 10:26:17.559037 | instance | Process install dependency map 2026-08-22 10:26:17.559056 | instance | Starting collection install process 2026-08-22 10:26:17.559074 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon' 2026-08-22 10:26:17.559093 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon 2026-08-22 10:26:17.559111 | instance | ansible.netcommon:* was installed successfully 2026-08-22 10:26:17.559130 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-08-22 10:26:17.559148 | instance | Creating virtual environment at: .venv 2026-08-22 10:26:17.559166 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-08-22 10:26:17.559185 | instance | Downloading kubernetes (1.9MiB) 2026-08-22 10:26:17.559203 | instance | Downloading pygments (1.2MiB) 2026-08-22 10:26:17.559224 | instance | Downloading netaddr (2.2MiB) 2026-08-22 10:26:17.559243 | instance | Downloading openstacksdk (1.7MiB) 2026-08-22 10:26:17.559261 | instance | Downloading ansible-core (2.1MiB) 2026-08-22 10:26:17.559280 | instance | Downloading rjsonnet (1.2MiB) 2026-08-22 10:26:17.559299 | instance | Downloading setuptools (1.1MiB) 2026-08-22 10:26:17.559318 | instance | Downloading cryptography (4.2MiB) 2026-08-22 10:26:17.559336 | instance | Building pyperclip==1.9.0 2026-08-22 10:26:17.559355 | instance | Downloading rjsonnet 2026-08-22 10:26:17.559375 | instance | Downloading netaddr 2026-08-22 10:26:17.559395 | instance | Downloading pygments 2026-08-22 10:26:17.559414 | instance | Downloading cryptography 2026-08-22 10:26:17.559433 | instance | Downloading setuptools 2026-08-22 10:26:17.559451 | instance | Downloading kubernetes 2026-08-22 10:26:17.559469 | instance | Downloading ansible-core 2026-08-22 10:26:17.559488 | instance | Downloading openstacksdk 2026-08-22 10:26:17.559506 | instance | Built pyperclip==1.9.0 2026-08-22 10:26:17.559803 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-08-22 10:26:17.559835 | instance | Installed 79 packages in 205ms 2026-08-22 10:26:17.559856 | instance | Checked out ansible.posix to 1.6.0 2026-08-22 10:26:17.559876 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-08-22 10:26:17.559895 | instance | Starting galaxy collection install process 2026-08-22 10:26:17.559913 | instance | Process install dependency map 2026-08-22 10:26:17.559931 | instance | Starting collection install process 2026-08-22 10:26:17.559950 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-08-22 10:26:17.559976 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix 2026-08-22 10:26:17.559995 | instance | ansible.posix:1.6.0 was installed successfully 2026-08-22 10:26:17.560013 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-22 10:26:17.560031 | instance | 2.17.12 2026-08-22 10:26:17.560050 | instance | Checked out ansible.utils to v6.1.0 2026-08-22 10:26:17.560069 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-08-22 10:26:17.560087 | instance | Starting galaxy collection install process 2026-08-22 10:26:17.560105 | instance | Process install dependency map 2026-08-22 10:26:17.560123 | instance | Starting collection install process 2026-08-22 10:26:17.560142 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils' 2026-08-22 10:26:17.560160 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils 2026-08-22 10:26:17.560178 | instance | ansible.utils:6.1.0 was installed successfully 2026-08-22 10:26:17.560250 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-22 10:26:17.560283 | instance | 2.17.12 2026-08-22 10:26:17.560304 | instance | Checked out atmosphere.common to v0.7.0 2026-08-22 10:26:17.560323 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-08-22 10:26:17.560342 | instance | Starting galaxy collection install process 2026-08-22 10:26:17.560361 | instance | Process install dependency map 2026-08-22 10:26:17.560378 | instance | Starting collection install process 2026-08-22 10:26:17.560396 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common' 2026-08-22 10:26:17.560414 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common 2026-08-22 10:26:17.560431 | instance | atmosphere.common:0.7.0 was installed successfully 2026-08-22 10:26:17.560449 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-22 10:26:17.560467 | instance | 2.17.12 2026-08-22 10:26:17.560484 | instance | Checked out community.crypto to 2.2.3 2026-08-22 10:26:17.560502 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.crypto 2026-08-22 10:26:17.560521 | instance | Starting galaxy collection install process 2026-08-22 10:26:17.560541 | instance | Process install dependency map 2026-08-22 10:26:17.560559 | instance | Starting collection install process 2026-08-22 10:26:17.560577 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-08-22 10:26:17.560595 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto 2026-08-22 10:26:17.560613 | instance | community.crypto:2.2.3 was installed successfully 2026-08-22 10:26:17.560632 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-22 10:26:17.560650 | instance | 2.17.12 2026-08-22 10:26:17.560668 | instance | Checked out community.general to 7.3.0 2026-08-22 10:26:17.560686 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.general 2026-08-22 10:26:17.560705 | instance | Starting galaxy collection install process 2026-08-22 10:26:17.560729 | instance | Process install dependency map 2026-08-22 10:26:17.560748 | instance | Starting collection install process 2026-08-22 10:26:17.560766 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-08-22 10:26:17.560784 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general 2026-08-22 10:26:17.560802 | instance | community.general:7.3.0 was installed successfully 2026-08-22 10:26:17.560820 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-22 10:26:17.560838 | instance | 2.17.12 2026-08-22 10:26:17.560866 | instance | Checked out community.mysql to 3.6.0 2026-08-22 10:26:17.560886 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.mysql 2026-08-22 10:26:17.560904 | instance | Starting galaxy collection install process 2026-08-22 10:26:17.560925 | instance | Process install dependency map 2026-08-22 10:26:17.560945 | instance | Starting collection install process 2026-08-22 10:26:17.560980 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql' 2026-08-22 10:26:17.561000 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql 2026-08-22 10:26:17.561019 | instance | community.mysql:3.6.0 was installed successfully 2026-08-22 10:26:17.561038 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-22 10:26:17.561056 | instance | 2.17.12 2026-08-22 10:26:17.561074 | instance | Checked out kubernetes.core to 2.4.0 2026-08-22 10:26:17.561092 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-08-22 10:26:17.561110 | instance | Starting galaxy collection install process 2026-08-22 10:26:17.561129 | instance | Process install dependency map 2026-08-22 10:26:17.561147 | instance | Starting collection install process 2026-08-22 10:26:17.561166 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core' 2026-08-22 10:26:17.561184 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core 2026-08-22 10:26:17.561203 | instance | kubernetes.core:2.4.0 was installed successfully 2026-08-22 10:26:17.561221 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-22 10:26:17.561240 | instance | 2.17.12 2026-08-22 10:26:17.561258 | instance | Checked out openstack.cloud to 2.6.0 2026-08-22 10:26:17.561276 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-08-22 10:26:17.561295 | instance | Starting galaxy collection install process 2026-08-22 10:26:17.561313 | instance | Process install dependency map 2026-08-22 10:26:17.561331 | instance | Starting collection install process 2026-08-22 10:26:17.561349 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud' 2026-08-22 10:26:17.561367 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud 2026-08-22 10:26:17.561385 | instance | openstack.cloud:2.6.0 was installed successfully 2026-08-22 10:26:17.561403 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-22 10:26:17.561421 | instance | 2.17.12 2026-08-22 10:26:17.561439 | instance | Checked out vexxhost.ceph to v4.2.0 2026-08-22 10:26:17.561457 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-08-22 10:26:17.561481 | instance | Starting galaxy collection install process 2026-08-22 10:26:17.561500 | instance | Process install dependency map 2026-08-22 10:26:17.561518 | instance | Starting collection install process 2026-08-22 10:26:17.561536 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph' 2026-08-22 10:26:17.561554 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph 2026-08-22 10:26:17.561572 | instance | vexxhost.ceph:4.2.0 was installed successfully 2026-08-22 10:26:17.561590 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-22 10:26:17.561608 | instance | 2.17.12 2026-08-22 10:26:17.561626 | instance | Checked out vexxhost.containers to v1.6.8 2026-08-22 10:26:17.561644 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-08-22 10:26:17.561662 | instance | Starting galaxy collection install process 2026-08-22 10:26:17.561680 | instance | Process install dependency map 2026-08-22 10:26:17.561698 | instance | Starting collection install process 2026-08-22 10:26:17.561716 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers' 2026-08-22 10:26:17.561734 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers 2026-08-22 10:26:17.561752 | instance | vexxhost.containers:1.6.8 was installed successfully 2026-08-22 10:26:17.561771 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-22 10:26:17.561789 | instance | 2.17.12 2026-08-22 10:26:17.561807 | instance | Checked out vexxhost.kubernetes to v3.3.0 2026-08-22 10:26:17.561825 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-08-22 10:26:17.561843 | instance | Starting galaxy collection install process 2026-08-22 10:26:17.561862 | instance | Process install dependency map 2026-08-22 10:26:17.561880 | instance | Starting collection install process 2026-08-22 10:26:17.561898 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes' 2026-08-22 10:26:17.561916 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes 2026-08-22 10:26:17.561934 | instance | vexxhost.kubernetes:3.3.0 was installed successfully 2026-08-22 10:26:17.561953 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-22 10:26:17.561971 | instance | 2.17.12 2026-08-22 10:26:17.567667 | 2026-08-22 10:26:17.567716 | PLAY RECAP 2026-08-22 10:26:17.567759 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-22 10:26:17.567781 | 2026-08-22 10:26:17.711250 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-22 10:26:17.714225 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-08-22 10:26:18.315545 | 2026-08-22 10:26:18.316192 | PLAY [all] 2026-08-22 10:26:18.327538 | 2026-08-22 10:26:18.327614 | TASK [Install "jq" for log collection] 2026-08-22 10:26:31.063175 | instance | changed 2026-08-22 10:26:31.066144 | 2026-08-22 10:26:31.066228 | PLAY RECAP 2026-08-22 10:26:31.066309 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-22 10:26:31.066391 | 2026-08-22 10:26:31.242537 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-08-22 10:26:31.247169 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-22 10:26:31.823905 | 2026-08-22 10:26:31.824032 | PLAY [all] 2026-08-22 10:26:31.834611 | 2026-08-22 10:26:31.834687 | LOOP [Check inventory directories] 2026-08-22 10:26:32.167678 | instance | ok: "src/github.com/vexxhost/atmosphere" 2026-08-22 10:26:32.321380 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory" 2026-08-22 10:26:32.459041 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory" 2026-08-22 10:26:32.474566 | 2026-08-22 10:26:32.474844 | LOOP [Copy inventory file for Zuul] 2026-08-22 10:26:33.263053 | instance | changed: 2026-08-22 10:26:33.263258 | instance | { 2026-08-22 10:26:33.263298 | instance | "ansible_loop_var": "item", 2026-08-22 10:26:33.263330 | instance | "changed": false, 2026-08-22 10:26:33.263359 | instance | "failed": false, 2026-08-22 10:26:33.263393 | instance | "invocation": { 2026-08-22 10:26:33.263421 | instance | "module_args": { 2026-08-22 10:26:33.263447 | instance | "checksum_algorithm": "sha1", 2026-08-22 10:26:33.263473 | instance | "follow": true, 2026-08-22 10:26:33.263499 | instance | "get_attributes": true, 2026-08-22 10:26:33.263525 | instance | "get_checksum": true, 2026-08-22 10:26:33.263552 | instance | "get_mime": true, 2026-08-22 10:26:33.263577 | instance | "path": "src/github.com/vexxhost/atmosphere" 2026-08-22 10:26:33.263602 | instance | } 2026-08-22 10:26:33.263628 | instance | }, 2026-08-22 10:26:33.263653 | instance | "item": "src/github.com/vexxhost/atmosphere", 2026-08-22 10:26:33.263678 | instance | "stat": { 2026-08-22 10:26:33.263704 | instance | "atime": 1787394369.3204792, 2026-08-22 10:26:33.263730 | instance | "attr_flags": "e", 2026-08-22 10:26:33.263756 | instance | "attributes": [ 2026-08-22 10:26:33.263781 | instance | "extents" 2026-08-22 10:26:33.263806 | instance | ], 2026-08-22 10:26:33.263831 | instance | "block_size": 4096, 2026-08-22 10:26:33.263856 | instance | "blocks": 8, 2026-08-22 10:26:33.263881 | instance | "charset": "unknown", 2026-08-22 10:26:33.263908 | instance | "ctime": 1787394368.4204147, 2026-08-22 10:26:33.263934 | instance | "dev": 64513, 2026-08-22 10:26:33.263959 | instance | "device_type": 0, 2026-08-22 10:26:33.263985 | instance | "executable": true, 2026-08-22 10:26:33.264010 | instance | "exists": true, 2026-08-22 10:26:33.264034 | instance | "gid": 1000, 2026-08-22 10:26:33.264059 | instance | "gr_name": "zuul", 2026-08-22 10:26:33.264084 | instance | "inode": 1048729, 2026-08-22 10:26:33.264110 | instance | "isblk": false, 2026-08-22 10:26:33.264135 | instance | "ischr": false, 2026-08-22 10:26:33.264160 | instance | "isdir": true, 2026-08-22 10:26:33.264185 | instance | "isfifo": false, 2026-08-22 10:26:33.264210 | instance | "isgid": false, 2026-08-22 10:26:33.264234 | instance | "islnk": false, 2026-08-22 10:26:33.264258 | instance | "isreg": false, 2026-08-22 10:26:33.264282 | instance | "issock": false, 2026-08-22 10:26:33.264317 | instance | "isuid": false, 2026-08-22 10:26:33.264341 | instance | "mimetype": "unknown", 2026-08-22 10:26:33.264366 | instance | "mode": "0755", 2026-08-22 10:26:33.264390 | instance | "mtime": 1787394368.4204147, 2026-08-22 10:26:33.264415 | instance | "nlink": 21, 2026-08-22 10:26:33.264439 | instance | "path": "src/github.com/vexxhost/atmosphere", 2026-08-22 10:26:33.264465 | instance | "pw_name": "zuul", 2026-08-22 10:26:33.264491 | instance | "readable": true, 2026-08-22 10:26:33.264517 | instance | "rgrp": true, 2026-08-22 10:26:33.264542 | instance | "roth": true, 2026-08-22 10:26:33.264567 | instance | "rusr": true, 2026-08-22 10:26:33.264591 | instance | "size": 4096, 2026-08-22 10:26:33.264616 | instance | "uid": 1000, 2026-08-22 10:26:33.264651 | instance | "version": "3440175087", 2026-08-22 10:26:33.264677 | instance | "wgrp": false, 2026-08-22 10:26:33.264704 | instance | "woth": false, 2026-08-22 10:26:33.264730 | instance | "writeable": true, 2026-08-22 10:26:33.264755 | instance | "wusr": true, 2026-08-22 10:26:33.264779 | instance | "xgrp": true, 2026-08-22 10:26:33.264803 | instance | "xoth": true, 2026-08-22 10:26:33.264828 | instance | "xusr": true 2026-08-22 10:26:33.264852 | instance | } 2026-08-22 10:26:33.264877 | instance | } 2026-08-22 10:26:33.264923 | instance | ok: All items complete 2026-08-22 10:26:33.264973 | 2026-08-22 10:26:33.266628 | instance | skipping: Conditional result was False 2026-08-22 10:26:33.267431 | instance | skipping: Conditional result was False 2026-08-22 10:26:33.282517 | 2026-08-22 10:26:33.282722 | LOOP [Switch "ansible_host" to private IP] 2026-08-22 10:26:33.623313 | instance | changed: 1 replacements made 2026-08-22 10:26:33.624561 | instance | skipping: Conditional result was False 2026-08-22 10:26:33.625208 | instance | skipping: Conditional result was False 2026-08-22 10:26:33.638417 | 2026-08-22 10:26:33.638534 | TASK [Run Molecule scenario] 2026-08-22 10:26:34.548665 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-08-22 10:26:34.945835 | instance | INFO [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-08-22 10:26:34.945914 | instance | INFO [csi > prerun] Performing prerun with role_name_check=0... 2026-08-22 10:26:45.615574 | instance | INFO [csi > dependency] Executing 2026-08-22 10:26:45.615783 | instance | WARNING [csi > dependency] Missing roles requirements file: requirements.yml 2026-08-22 10:26:45.615998 | instance | WARNING [csi > dependency] Missing collections requirements file: collections.yml 2026-08-22 10:26:45.616141 | instance | WARNING [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-08-22 10:26:45.623749 | instance | INFO [csi > cleanup] Executing 2026-08-22 10:26:45.624104 | instance | WARNING [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-22 10:26:45.631556 | instance | INFO [csi > destroy] Executing 2026-08-22 10:26:45.631642 | instance | WARNING [csi > destroy] Skipping, '--destroy=never' requested. 2026-08-22 10:26:45.631739 | instance | INFO [csi > destroy] Executed: Successful 2026-08-22 10:26:45.639053 | instance | INFO [csi > syntax] Executing 2026-08-22 10:26:47.194627 | instance | 2026-08-22 10:26:47.194872 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-08-22 10:26:47.254376 | instance | INFO [csi > syntax] Executed: Successful 2026-08-22 10:26:47.267064 | instance | INFO [csi > create] Executing 2026-08-22 10:26:47.268869 | instance | WARNING [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-22 10:26:47.276160 | instance | INFO [csi > prepare] Executing 2026-08-22 10:26:48.070190 | instance | 2026-08-22 10:26:48.070307 | instance | PLAY [Prepare] ***************************************************************** 2026-08-22 10:26:48.070468 | instance | 2026-08-22 10:26:48.070642 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-22 10:26:48.070901 | instance | Saturday 22 August 2026 10:26:48 +0000 (0:00:00.024) 0:00:00.024 ******* 2026-08-22 10:26:49.210372 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-08-22 10:26:49.210532 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-08-22 10:26:49.210683 | instance | interpreter could change the meaning of that path. See 2026-08-22 10:26:49.210831 | instance | https://docs.ansible.com/ansible- 2026-08-22 10:26:49.210982 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-08-22 10:26:49.219598 | instance | ok: [instance] 2026-08-22 10:26:49.219766 | instance | 2026-08-22 10:26:49.219932 | instance | TASK [Configure short hostname] ************************************************ 2026-08-22 10:26:49.220099 | instance | Saturday 22 August 2026 10:26:49 +0000 (0:00:01.150) 0:00:01.175 ******* 2026-08-22 10:26:49.882909 | instance | changed: [instance] 2026-08-22 10:26:49.883010 | instance | 2026-08-22 10:26:49.883174 | instance | TASK [Ensure hostname inside hosts file] *************************************** 2026-08-22 10:26:49.883358 | instance | Saturday 22 August 2026 10:26:49 +0000 (0:00:00.662) 0:00:01.837 ******* 2026-08-22 10:26:50.128376 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created 2026-08-22 10:26:50.128667 | instance | with a mode of 0700, this may cause issues when running as another user. To 2026-08-22 10:26:50.128946 | instance | avoid this, create the remote_tmp dir with the correct permissions manually 2026-08-22 10:26:50.136439 | instance | changed: [instance] 2026-08-22 10:26:50.136711 | instance | 2026-08-22 10:26:50.136977 | instance | TASK [Purge "snapd" package] *************************************************** 2026-08-22 10:26:50.137237 | instance | Saturday 22 August 2026 10:26:50 +0000 (0:00:00.253) 0:00:02.091 ******* 2026-08-22 10:26:50.851353 | instance | ok: [instance] 2026-08-22 10:26:50.851579 | instance | 2026-08-22 10:26:50.851852 | instance | PLAY [Create devices for Ceph] ************************************************* 2026-08-22 10:26:50.852116 | instance | 2026-08-22 10:26:50.852380 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-22 10:26:50.852678 | instance | Saturday 22 August 2026 10:26:50 +0000 (0:00:00.714) 0:00:02.806 ******* 2026-08-22 10:26:51.545390 | instance | ok: [instance] 2026-08-22 10:26:51.545471 | instance | 2026-08-22 10:26:51.545614 | instance | TASK [Install depedencies] ***************************************************** 2026-08-22 10:26:51.545759 | instance | Saturday 22 August 2026 10:26:51 +0000 (0:00:00.694) 0:00:03.500 ******* 2026-08-22 10:27:19.306288 | instance | changed: [instance] 2026-08-22 10:27:19.306507 | instance | 2026-08-22 10:27:19.306828 | instance | TASK [Start up service] ******************************************************** 2026-08-22 10:27:19.307161 | instance | Saturday 22 August 2026 10:27:19 +0000 (0:00:27.760) 0:00:31.261 ******* 2026-08-22 10:27:19.838652 | instance | ok: [instance] 2026-08-22 10:27:19.838865 | instance | 2026-08-22 10:27:19.839179 | instance | TASK [Generate lvm.conf] ******************************************************* 2026-08-22 10:27:19.839474 | instance | Saturday 22 August 2026 10:27:19 +0000 (0:00:00.532) 0:00:31.793 ******* 2026-08-22 10:27:20.142078 | instance | ok: [instance] 2026-08-22 10:27:20.142975 | instance | 2026-08-22 10:27:20.143018 | instance | TASK [Write /etc/lvm/lvm.conf] ************************************************* 2026-08-22 10:27:20.143024 | instance | Saturday 22 August 2026 10:27:20 +0000 (0:00:00.303) 0:00:32.096 ******* 2026-08-22 10:27:20.868156 | instance | changed: [instance] 2026-08-22 10:27:20.868235 | instance | 2026-08-22 10:27:20.868310 | instance | TASK [Get list of all loopback devices] **************************************** 2026-08-22 10:27:20.868430 | instance | Saturday 22 August 2026 10:27:20 +0000 (0:00:00.726) 0:00:32.823 ******* 2026-08-22 10:27:21.088216 | instance | ok: [instance] 2026-08-22 10:27:21.088542 | instance | 2026-08-22 10:27:21.088934 | instance | TASK [Fail if there is any existing loopback devices] ************************** 2026-08-22 10:27:21.089388 | instance | Saturday 22 August 2026 10:27:21 +0000 (0:00:00.219) 0:00:33.042 ******* 2026-08-22 10:27:21.110789 | instance | skipping: [instance] 2026-08-22 10:27:21.111016 | instance | 2026-08-22 10:27:21.111278 | instance | TASK [Create devices for Ceph] ************************************************* 2026-08-22 10:27:21.111524 | instance | Saturday 22 August 2026 10:27:21 +0000 (0:00:00.022) 0:00:33.065 ******* 2026-08-22 10:27:21.633180 | instance | changed: [instance] => (item=osd0) 2026-08-22 10:27:21.633368 | instance | changed: [instance] => (item=osd1) 2026-08-22 10:27:21.633494 | instance | changed: [instance] => (item=osd2) 2026-08-22 10:27:21.633654 | instance | 2026-08-22 10:27:21.633823 | instance | TASK [Set permissions on loopback devices] ************************************* 2026-08-22 10:27:21.633993 | instance | Saturday 22 August 2026 10:27:21 +0000 (0:00:00.522) 0:00:33.587 ******* 2026-08-22 10:27:22.225587 | instance | changed: [instance] => (item=osd0) 2026-08-22 10:27:22.225630 | instance | changed: [instance] => (item=osd1) 2026-08-22 10:27:22.225636 | instance | changed: [instance] => (item=osd2) 2026-08-22 10:27:22.225644 | instance | 2026-08-22 10:27:22.225652 | instance | TASK [Start loop devices] ****************************************************** 2026-08-22 10:27:22.225660 | instance | Saturday 22 August 2026 10:27:22 +0000 (0:00:00.591) 0:00:34.179 ******* 2026-08-22 10:27:22.945675 | instance | changed: [instance] => (item=osd0) 2026-08-22 10:27:22.945757 | instance | changed: [instance] => (item=osd1) 2026-08-22 10:27:22.946464 | instance | changed: [instance] => (item=osd2) 2026-08-22 10:27:22.946507 | instance | 2026-08-22 10:27:22.946514 | instance | TASK [Create a volume group for each loop device] ****************************** 2026-08-22 10:27:22.946521 | instance | Saturday 22 August 2026 10:27:22 +0000 (0:00:00.720) 0:00:34.900 ******* 2026-08-22 10:27:26.283199 | instance | changed: [instance] => (item=osd0) 2026-08-22 10:27:26.284125 | instance | changed: [instance] => (item=osd1) 2026-08-22 10:27:26.284169 | instance | changed: [instance] => (item=osd2) 2026-08-22 10:27:26.284177 | instance | 2026-08-22 10:27:26.284184 | instance | TASK [Create a logical volume for each loop device] **************************** 2026-08-22 10:27:26.284190 | instance | Saturday 22 August 2026 10:27:26 +0000 (0:00:03.337) 0:00:38.237 ******* 2026-08-22 10:27:28.100146 | instance | changed: [instance] => (item=ceph-instance-osd0) 2026-08-22 10:27:28.100608 | instance | changed: [instance] => (item=ceph-instance-osd1) 2026-08-22 10:27:28.101243 | instance | changed: [instance] => (item=ceph-instance-osd2) 2026-08-22 10:27:28.101382 | instance | 2026-08-22 10:27:28.101404 | instance | PLAY RECAP ********************************************************************* 2026-08-22 10:27:28.104565 | instance | instance : ok=15 changed=9 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-08-22 10:27:28.104579 | instance | 2026-08-22 10:27:28.104584 | instance | Saturday 22 August 2026 10:27:28 +0000 (0:00:01.817) 0:00:40.055 ******* 2026-08-22 10:27:28.104588 | instance | =============================================================================== 2026-08-22 10:27:28.104592 | instance | Install depedencies ---------------------------------------------------- 27.76s 2026-08-22 10:27:28.104596 | instance | Create a volume group for each loop device ------------------------------ 3.34s 2026-08-22 10:27:28.104599 | instance | Create a logical volume for each loop device ---------------------------- 1.82s 2026-08-22 10:27:28.104604 | instance | Gathering Facts --------------------------------------------------------- 1.15s 2026-08-22 10:27:28.104608 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.73s 2026-08-22 10:27:28.104611 | instance | Start loop devices ------------------------------------------------------ 0.72s 2026-08-22 10:27:28.104615 | instance | Purge "snapd" package --------------------------------------------------- 0.71s 2026-08-22 10:27:28.104619 | instance | Gathering Facts --------------------------------------------------------- 0.69s 2026-08-22 10:27:28.104833 | instance | Configure short hostname ------------------------------------------------ 0.66s 2026-08-22 10:27:28.105210 | instance | Set permissions on loopback devices ------------------------------------- 0.59s 2026-08-22 10:27:28.105619 | instance | Start up service -------------------------------------------------------- 0.53s 2026-08-22 10:27:28.105818 | instance | Create devices for Ceph ------------------------------------------------- 0.52s 2026-08-22 10:27:28.105968 | instance | Generate lvm.conf ------------------------------------------------------- 0.30s 2026-08-22 10:27:28.106117 | instance | Ensure hostname inside hosts file --------------------------------------- 0.25s 2026-08-22 10:27:28.106264 | instance | Get list of all loopback devices ---------------------------------------- 0.22s 2026-08-22 10:27:28.106415 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s 2026-08-22 10:27:28.163744 | instance | INFO [csi > prepare] Executed: Successful 2026-08-22 10:27:28.175124 | instance | INFO [csi > converge] Executing 2026-08-22 10:27:29.691171 | instance | 2026-08-22 10:27:29.691573 | instance | PLAY [Debug CSI driver value] ************************************************** 2026-08-22 10:27:29.691889 | instance | 2026-08-22 10:27:29.692218 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-22 10:27:29.692586 | instance | Saturday 22 August 2026 10:27:29 +0000 (0:00:00.007) 0:00:00.007 ******* 2026-08-22 10:27:31.635112 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-08-22 10:27:31.635485 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-08-22 10:27:31.635792 | instance | interpreter could change the meaning of that path. See 2026-08-22 10:27:31.636089 | instance | https://docs.ansible.com/ansible- 2026-08-22 10:27:31.636386 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-08-22 10:27:31.645528 | instance | ok: [instance] 2026-08-22 10:27:31.645806 | instance | 2026-08-22 10:27:31.646109 | instance | TASK [Display CSI driver value and environment variable] *********************** 2026-08-22 10:27:31.646398 | instance | Saturday 22 August 2026 10:27:31 +0000 (0:00:01.954) 0:00:01.962 ******* 2026-08-22 10:27:31.691124 | instance | ok: [instance] => { 2026-08-22 10:27:31.691371 | instance | "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER=" 2026-08-22 10:27:31.691570 | instance | } 2026-08-22 10:27:31.691757 | instance | 2026-08-22 10:27:31.691954 | instance | PLAY [all] ********************************************************************* 2026-08-22 10:27:31.692138 | instance | 2026-08-22 10:27:31.692338 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-22 10:27:31.692568 | instance | Saturday 22 August 2026 10:27:31 +0000 (0:00:00.045) 0:00:02.008 ******* 2026-08-22 10:27:32.576628 | instance | ok: [instance] 2026-08-22 10:27:32.577026 | instance | 2026-08-22 10:27:32.577381 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-08-22 10:27:32.577774 | instance | Saturday 22 August 2026 10:27:32 +0000 (0:00:00.884) 0:00:02.893 ******* 2026-08-22 10:27:32.767593 | instance | ok: [instance] 2026-08-22 10:27:32.767981 | instance | 2026-08-22 10:27:32.768333 | instance | PLAY [Deploy Ceph monitors & managers] ***************************************** 2026-08-22 10:27:32.768714 | instance | 2026-08-22 10:27:32.769085 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-22 10:27:32.769423 | instance | Saturday 22 August 2026 10:27:32 +0000 (0:00:00.191) 0:00:03.084 ******* 2026-08-22 10:27:33.608080 | instance | ok: [instance] 2026-08-22 10:27:33.608122 | instance | 2026-08-22 10:27:33.608129 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-22 10:27:33.608141 | instance | Saturday 22 August 2026 10:27:33 +0000 (0:00:00.840) 0:00:03.924 ******* 2026-08-22 10:27:33.880742 | instance | ok: [instance] 2026-08-22 10:27:33.881178 | instance | 2026-08-22 10:27:33.881210 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-22 10:27:33.881216 | instance | Saturday 22 August 2026 10:27:33 +0000 (0:00:00.273) 0:00:04.197 ******* 2026-08-22 10:27:33.918972 | instance | skipping: [instance] 2026-08-22 10:27:33.919325 | instance | 2026-08-22 10:27:33.919354 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-08-22 10:27:33.919360 | instance | Saturday 22 August 2026 10:27:33 +0000 (0:00:00.038) 0:00:04.235 ******* 2026-08-22 10:27:34.248287 | instance | changed: [instance] 2026-08-22 10:27:34.248324 | instance | 2026-08-22 10:27:34.248329 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-22 10:27:34.248334 | instance | Saturday 22 August 2026 10:27:34 +0000 (0:00:00.329) 0:00:04.564 ******* 2026-08-22 10:27:34.321361 | instance | ok: [instance] => { 2026-08-22 10:27:34.321397 | instance | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-08-22 10:27:34.321403 | instance | } 2026-08-22 10:27:34.321408 | instance | 2026-08-22 10:27:34.321412 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-22 10:27:34.321416 | instance | Saturday 22 August 2026 10:27:34 +0000 (0:00:00.072) 0:00:04.637 ******* 2026-08-22 10:27:34.969236 | instance | changed: [instance] 2026-08-22 10:27:34.969761 | instance | 2026-08-22 10:27:34.969802 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-22 10:27:34.969811 | instance | Saturday 22 August 2026 10:27:34 +0000 (0:00:00.648) 0:00:05.285 ******* 2026-08-22 10:27:35.018930 | instance | skipping: [instance] 2026-08-22 10:27:35.018996 | instance | 2026-08-22 10:27:35.019291 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-22 10:27:35.019320 | instance | Saturday 22 August 2026 10:27:35 +0000 (0:00:00.050) 0:00:05.335 ******* 2026-08-22 10:27:35.076388 | instance | skipping: [instance] 2026-08-22 10:27:35.076504 | instance | 2026-08-22 10:27:35.076914 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-22 10:27:35.076958 | instance | Saturday 22 August 2026 10:27:35 +0000 (0:00:00.056) 0:00:05.392 ******* 2026-08-22 10:27:35.285094 | instance | ok: [instance] 2026-08-22 10:27:35.285130 | instance | 2026-08-22 10:27:35.285135 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-22 10:27:35.285140 | instance | Saturday 22 August 2026 10:27:35 +0000 (0:00:00.208) 0:00:05.601 ******* 2026-08-22 10:27:36.486732 | instance | ok: [instance] 2026-08-22 10:27:36.486820 | instance | 2026-08-22 10:27:36.487180 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-22 10:27:36.487222 | instance | Saturday 22 August 2026 10:27:36 +0000 (0:00:01.201) 0:00:06.803 ******* 2026-08-22 10:27:36.555001 | instance | ok: [instance] => { 2026-08-22 10:27:36.555913 | instance | "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz" 2026-08-22 10:27:36.555970 | instance | } 2026-08-22 10:27:36.555978 | instance | 2026-08-22 10:27:36.555985 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-22 10:27:36.555992 | instance | Saturday 22 August 2026 10:27:36 +0000 (0:00:00.067) 0:00:06.871 ******* 2026-08-22 10:27:37.216452 | instance | changed: [instance] 2026-08-22 10:27:37.216694 | instance | 2026-08-22 10:27:37.216795 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-22 10:27:37.217182 | instance | Saturday 22 August 2026 10:27:37 +0000 (0:00:00.661) 0:00:07.533 ******* 2026-08-22 10:27:40.060795 | instance | changed: [instance] 2026-08-22 10:27:40.060882 | instance | 2026-08-22 10:27:40.061158 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-08-22 10:27:40.061277 | instance | Saturday 22 August 2026 10:27:40 +0000 (0:00:02.844) 0:00:10.377 ******* 2026-08-22 10:27:40.097719 | instance | skipping: [instance] 2026-08-22 10:27:40.097905 | instance | 2026-08-22 10:27:40.098219 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-08-22 10:27:40.098426 | instance | Saturday 22 August 2026 10:27:40 +0000 (0:00:00.036) 0:00:10.414 ******* 2026-08-22 10:27:40.129036 | instance | skipping: [instance] 2026-08-22 10:27:40.129107 | instance | 2026-08-22 10:27:40.129404 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-08-22 10:27:40.129704 | instance | Saturday 22 August 2026 10:27:40 +0000 (0:00:00.031) 0:00:10.445 ******* 2026-08-22 10:27:40.155961 | instance | skipping: [instance] 2026-08-22 10:27:40.156061 | instance | 2026-08-22 10:27:40.156253 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-08-22 10:27:40.156438 | instance | Saturday 22 August 2026 10:27:40 +0000 (0:00:00.027) 0:00:10.472 ******* 2026-08-22 10:27:50.795711 | instance | changed: [instance] 2026-08-22 10:27:50.795769 | instance | 2026-08-22 10:27:50.796044 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] *** 2026-08-22 10:27:50.796078 | instance | Saturday 22 August 2026 10:27:50 +0000 (0:00:10.639) 0:00:21.112 ******* 2026-08-22 10:27:51.401037 | instance | changed: [instance] 2026-08-22 10:27:51.401080 | instance | 2026-08-22 10:27:51.401088 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] ******* 2026-08-22 10:27:51.401095 | instance | Saturday 22 August 2026 10:27:51 +0000 (0:00:00.604) 0:00:21.717 ******* 2026-08-22 10:27:52.283269 | instance | changed: [instance] => (item={'path': '/etc/containerd'}) 2026-08-22 10:27:52.283304 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'}) 2026-08-22 10:27:52.283310 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'}) 2026-08-22 10:27:52.283314 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'}) 2026-08-22 10:27:52.283319 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'}) 2026-08-22 10:27:52.283323 | instance | 2026-08-22 10:27:52.283331 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] ********** 2026-08-22 10:27:52.283335 | instance | Saturday 22 August 2026 10:27:52 +0000 (0:00:00.882) 0:00:22.599 ******* 2026-08-22 10:27:52.875634 | instance | changed: [instance] 2026-08-22 10:27:52.875701 | instance | 2026-08-22 10:27:52.876350 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ******** 2026-08-22 10:27:52.876385 | instance | Saturday 22 August 2026 10:27:52 +0000 (0:00:00.576) 0:00:23.175 ******* 2026-08-22 10:27:52.876391 | instance | 2026-08-22 10:27:52.876395 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-08-22 10:27:52.876399 | instance | Saturday 22 August 2026 10:27:52 +0000 (0:00:00.017) 0:00:23.192 ******* 2026-08-22 10:27:53.793140 | instance | ok: [instance] 2026-08-22 10:27:53.793220 | instance | 2026-08-22 10:27:53.793507 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] ********** 2026-08-22 10:27:53.793665 | instance | Saturday 22 August 2026 10:27:53 +0000 (0:00:00.917) 0:00:24.109 ******* 2026-08-22 10:27:54.256013 | instance | changed: [instance] 2026-08-22 10:27:54.256120 | instance | 2026-08-22 10:27:54.256442 | instance | TASK [vexxhost.containers.containerd : Enable and start service] *************** 2026-08-22 10:27:54.256481 | instance | Saturday 22 August 2026 10:27:54 +0000 (0:00:00.462) 0:00:24.572 ******* 2026-08-22 10:27:54.798368 | instance | changed: [instance] 2026-08-22 10:27:54.798450 | instance | 2026-08-22 10:27:54.798733 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-22 10:27:54.798770 | instance | Saturday 22 August 2026 10:27:54 +0000 (0:00:00.542) 0:00:25.115 ******* 2026-08-22 10:27:55.009487 | instance | ok: [instance] 2026-08-22 10:27:55.009564 | instance | 2026-08-22 10:27:55.009852 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-22 10:27:55.009893 | instance | Saturday 22 August 2026 10:27:55 +0000 (0:00:00.210) 0:00:25.326 ******* 2026-08-22 10:27:55.065657 | instance | ok: [instance] => { 2026-08-22 10:27:55.066356 | instance | "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz" 2026-08-22 10:27:55.066406 | instance | } 2026-08-22 10:27:55.066413 | instance | 2026-08-22 10:27:55.066419 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-22 10:27:55.066425 | instance | Saturday 22 August 2026 10:27:55 +0000 (0:00:00.056) 0:00:25.382 ******* 2026-08-22 10:27:56.015277 | instance | changed: [instance] 2026-08-22 10:27:56.015677 | instance | 2026-08-22 10:27:56.015714 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-22 10:27:56.015720 | instance | Saturday 22 August 2026 10:27:56 +0000 (0:00:00.949) 0:00:26.332 ******* 2026-08-22 10:28:00.367556 | instance | changed: [instance] 2026-08-22 10:28:00.367634 | instance | 2026-08-22 10:28:00.367889 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ****************** 2026-08-22 10:28:00.368022 | instance | Saturday 22 August 2026 10:28:00 +0000 (0:00:04.352) 0:00:30.684 ******* 2026-08-22 10:28:01.373303 | instance | ok: [instance] 2026-08-22 10:28:01.373377 | instance | 2026-08-22 10:28:01.373753 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] *************** 2026-08-22 10:28:01.373804 | instance | Saturday 22 August 2026 10:28:01 +0000 (0:00:01.005) 0:00:31.689 ******* 2026-08-22 10:28:01.702003 | instance | changed: [instance] 2026-08-22 10:28:01.702486 | instance | 2026-08-22 10:28:01.702527 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] ***** 2026-08-22 10:28:01.702535 | instance | Saturday 22 August 2026 10:28:01 +0000 (0:00:00.328) 0:00:32.018 ******* 2026-08-22 10:28:02.176312 | instance | changed: [instance] 2026-08-22 10:28:02.176395 | instance | 2026-08-22 10:28:02.176689 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] *********** 2026-08-22 10:28:02.176784 | instance | Saturday 22 August 2026 10:28:02 +0000 (0:00:00.474) 0:00:32.492 ******* 2026-08-22 10:28:02.759908 | instance | changed: [instance] => (item={'path': '/etc/docker'}) 2026-08-22 10:28:02.759982 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'}) 2026-08-22 10:28:02.760503 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'}) 2026-08-22 10:28:02.760556 | instance | 2026-08-22 10:28:02.760562 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ****** 2026-08-22 10:28:02.760567 | instance | Saturday 22 August 2026 10:28:02 +0000 (0:00:00.583) 0:00:33.076 ******* 2026-08-22 10:28:03.220716 | instance | changed: [instance] 2026-08-22 10:28:03.220823 | instance | 2026-08-22 10:28:03.221091 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] *********** 2026-08-22 10:28:03.221129 | instance | Saturday 22 August 2026 10:28:03 +0000 (0:00:00.460) 0:00:33.537 ******* 2026-08-22 10:28:03.670545 | instance | changed: [instance] 2026-08-22 10:28:03.670616 | instance | 2026-08-22 10:28:03.671484 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************ 2026-08-22 10:28:03.671523 | instance | Saturday 22 August 2026 10:28:03 +0000 (0:00:00.433) 0:00:33.970 ******* 2026-08-22 10:28:03.671528 | instance | 2026-08-22 10:28:03.671533 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-08-22 10:28:03.671537 | instance | Saturday 22 August 2026 10:28:03 +0000 (0:00:00.016) 0:00:33.987 ******* 2026-08-22 10:28:04.433780 | instance | ok: [instance] 2026-08-22 10:28:04.433816 | instance | 2026-08-22 10:28:04.433821 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ****************** 2026-08-22 10:28:04.433831 | instance | Saturday 22 August 2026 10:28:04 +0000 (0:00:00.762) 0:00:34.750 ******* 2026-08-22 10:28:07.754434 | instance | changed: [instance] 2026-08-22 10:28:07.754796 | instance | 2026-08-22 10:28:07.754831 | instance | TASK [vexxhost.containers.docker : Enable and start service] ******************* 2026-08-22 10:28:07.754844 | instance | Saturday 22 August 2026 10:28:07 +0000 (0:00:03.320) 0:00:38.071 ******* 2026-08-22 10:28:08.292816 | instance | changed: [instance] 2026-08-22 10:28:08.292885 | instance | 2026-08-22 10:28:08.293148 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ****** 2026-08-22 10:28:08.293179 | instance | Saturday 22 August 2026 10:28:08 +0000 (0:00:00.538) 0:00:38.609 ******* 2026-08-22 10:28:08.346907 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml) 2026-08-22 10:28:08.346988 | instance | 2026-08-22 10:28:08.347247 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ******************************** 2026-08-22 10:28:08.347289 | instance | Saturday 22 August 2026 10:28:08 +0000 (0:00:00.053) 0:00:38.663 ******* 2026-08-22 10:28:13.806589 | instance | changed: [instance] 2026-08-22 10:28:13.806763 | instance | 2026-08-22 10:28:13.806796 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] ********************* 2026-08-22 10:28:13.806954 | instance | Saturday 22 August 2026 10:28:13 +0000 (0:00:05.459) 0:00:44.123 ******* 2026-08-22 10:28:14.460829 | instance | ok: [instance] => (item=chronyd) 2026-08-22 10:28:14.461523 | instance | ok: [instance] => (item=sshd) 2026-08-22 10:28:14.461565 | instance | 2026-08-22 10:28:14.461573 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ****************************** 2026-08-22 10:28:14.461579 | instance | Saturday 22 August 2026 10:28:14 +0000 (0:00:00.654) 0:00:44.777 ******* 2026-08-22 10:28:16.053834 | instance | changed: [instance] 2026-08-22 10:28:16.054208 | instance | 2026-08-22 10:28:16.054243 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ******************** 2026-08-22 10:28:16.054248 | instance | Saturday 22 August 2026 10:28:16 +0000 (0:00:01.593) 0:00:46.370 ******* 2026-08-22 10:28:16.253167 | instance | ok: [instance] 2026-08-22 10:28:16.253237 | instance | 2026-08-22 10:28:16.253536 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] **************** 2026-08-22 10:28:16.253575 | instance | Saturday 22 August 2026 10:28:16 +0000 (0:00:00.199) 0:00:46.569 ******* 2026-08-22 10:28:16.921277 | instance | changed: [instance] 2026-08-22 10:28:16.921357 | instance | 2026-08-22 10:28:16.921622 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] *** 2026-08-22 10:28:16.921657 | instance | Saturday 22 August 2026 10:28:16 +0000 (0:00:00.668) 0:00:47.238 ******* 2026-08-22 10:28:17.306061 | instance | changed: [instance] 2026-08-22 10:28:17.306529 | instance | 2026-08-22 10:28:17.306550 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] ************************* 2026-08-22 10:28:17.306558 | instance | Saturday 22 August 2026 10:28:17 +0000 (0:00:00.384) 0:00:47.623 ******* 2026-08-22 10:28:17.418157 | instance | ok: [instance] 2026-08-22 10:28:17.418614 | instance | 2026-08-22 10:28:17.418634 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] ******************* 2026-08-22 10:28:17.418641 | instance | Saturday 22 August 2026 10:28:17 +0000 (0:00:00.111) 0:00:47.734 ******* 2026-08-22 10:28:17.637319 | instance | ok: [instance] => (item=instance) 2026-08-22 10:28:17.637389 | instance | 2026-08-22 10:28:17.637637 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ******** 2026-08-22 10:28:17.637798 | instance | Saturday 22 August 2026 10:28:17 +0000 (0:00:00.219) 0:00:47.954 ******* 2026-08-22 10:28:17.693044 | instance | ok: [instance] 2026-08-22 10:28:17.693432 | instance | 2026-08-22 10:28:17.693471 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] *********************************** 2026-08-22 10:28:17.693477 | instance | Saturday 22 August 2026 10:28:17 +0000 (0:00:00.055) 0:00:48.009 ******* 2026-08-22 10:28:17.759802 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance 2026-08-22 10:28:17.759865 | instance | 2026-08-22 10:28:17.760155 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] ************* 2026-08-22 10:28:17.760192 | instance | Saturday 22 August 2026 10:28:17 +0000 (0:00:00.066) 0:00:48.076 ******* 2026-08-22 10:28:18.096494 | instance | changed: [instance] 2026-08-22 10:28:18.096651 | instance | 2026-08-22 10:28:18.096996 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ****************** 2026-08-22 10:28:18.097044 | instance | Saturday 22 August 2026 10:28:18 +0000 (0:00:00.336) 0:00:48.413 ******* 2026-08-22 10:28:18.806296 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True}) 2026-08-22 10:28:18.806413 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0}) 2026-08-22 10:28:18.807198 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False}) 2026-08-22 10:28:18.807259 | instance | 2026-08-22 10:28:18.807269 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] ******************************* 2026-08-22 10:28:18.807275 | instance | Saturday 22 August 2026 10:28:18 +0000 (0:00:00.709) 0:00:49.122 ******* 2026-08-22 10:30:15.181717 | instance | ok: [instance] 2026-08-22 10:30:15.181751 | instance | 2026-08-22 10:30:15.181757 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] *************** 2026-08-22 10:30:15.181766 | instance | Saturday 22 August 2026 10:30:15 +0000 (0:01:56.375) 0:02:45.498 ******* 2026-08-22 10:30:15.385833 | instance | changed: [instance] 2026-08-22 10:30:15.386308 | instance | 2026-08-22 10:30:15.386327 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] ********************************** 2026-08-22 10:30:15.386335 | instance | Saturday 22 August 2026 10:30:15 +0000 (0:00:00.204) 0:02:45.702 ******* 2026-08-22 10:30:15.461154 | instance | ok: [instance] 2026-08-22 10:30:15.469816 | instance | 2026-08-22 10:30:15.469835 | instance | TASK [Install Ceph host] ******************************************************* 2026-08-22 10:30:15.469842 | instance | Saturday 22 August 2026 10:30:15 +0000 (0:00:00.075) 0:02:45.778 ******* 2026-08-22 10:30:15.546725 | instance | included: vexxhost.ceph.cephadm_host for instance 2026-08-22 10:30:15.546763 | instance | 2026-08-22 10:30:15.546768 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ****** 2026-08-22 10:30:15.546773 | instance | Saturday 22 August 2026 10:30:15 +0000 (0:00:00.085) 0:02:45.863 ******* 2026-08-22 10:30:17.238155 | instance | ok: [instance] 2026-08-22 10:30:17.238740 | instance | 2026-08-22 10:30:17.238779 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] *** 2026-08-22 10:30:17.238787 | instance | Saturday 22 August 2026 10:30:17 +0000 (0:00:01.691) 0:02:47.554 ******* 2026-08-22 10:30:17.302235 | instance | ok: [instance] => (item=instance) 2026-08-22 10:30:17.302272 | instance | 2026-08-22 10:30:17.302278 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] *********** 2026-08-22 10:30:17.302283 | instance | Saturday 22 August 2026 10:30:17 +0000 (0:00:00.064) 0:02:47.618 ******* 2026-08-22 10:30:17.640999 | instance | ok: [instance] 2026-08-22 10:30:17.641327 | instance | 2026-08-22 10:30:17.641349 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] *********************** 2026-08-22 10:30:17.641532 | instance | Saturday 22 August 2026 10:30:17 +0000 (0:00:00.338) 0:02:47.957 ******* 2026-08-22 10:30:20.234665 | instance | ok: [instance] 2026-08-22 10:30:20.234723 | instance | 2026-08-22 10:30:20.234735 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ****************** 2026-08-22 10:30:20.234745 | instance | Saturday 22 August 2026 10:30:20 +0000 (0:00:02.592) 0:02:50.550 ******* 2026-08-22 10:31:24.718293 | instance | An exception occurred during task execution. To see the full traceback, use -vvv. The error was: [errno 5] RADOS I/O error (error connecting to the cluster) 2026-08-22 10:31:24.719303 | 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_p644rvv7/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_p644rvv7/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_p644rvv7/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_p644rvv7/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-22T10:31:24.451+0000 7f8d5be7e640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgD3eYlqDfQuEiAA5eldFnolJuvC11ErYmjN/33Zd63M7/JiyWo8AIj1mUk=: Malformed input [buffer:3]\n2026-08-22T10:31:24.451+0000 7f8d5be7e640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-22T10:31:24.451+0000 7f8d5be7e640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgD3eYlqDfQuEiAA5eldFnolJuvC11ErYmjN/33Zd63M7/JiyWo8AIj1mUk=: Malformed input [buffer:3]\n2026-08-22T10:31:24.451+0000 7f8d5be7e640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-22T10:31:24.451+0000 7f8d5be7e640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgD3eYlqDfQuEiAA5eldFnolJuvC11ErYmjN/33Zd63M7/JiyWo8AIj1mUk=: Malformed input [buffer:3]\n2026-08-22T10:31:24.451+0000 7f8d5be7e640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-22T10:31:24.451+0000 7f8d5be7e640 -1 monclient: keyring not found\n[errno 5] RADOS I/O error (error connecting to the cluster)\n\n", "module_stdout": "", "msg": "MODULE FAILURE\nSee stdout/stderr for the exact error", "rc": 1} 2026-08-22 10:31:24.724622 | instance | 2026-08-22 10:31:24.724683 | instance | PLAY RECAP ********************************************************************* 2026-08-22 10:31:24.724709 | instance | instance : ok=55 changed=26 unreachable=0 failed=1 skipped=6 rescued=0 ignored=0 2026-08-22 10:31:24.724719 | instance | 2026-08-22 10:31:24.724728 | instance | Saturday 22 August 2026 10:31:24 +0000 (0:01:04.489) 0:03:55.039 ******* 2026-08-22 10:31:24.724737 | instance | =============================================================================== 2026-08-22 10:31:24.724746 | instance | vexxhost.ceph.mon : Run Bootstrap command ----------------------------- 116.38s 2026-08-22 10:31:24.724755 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 64.49s 2026-08-22 10:31:24.724769 | instance | vexxhost.containers.containerd : Install AppArmor packages ------------- 10.64s 2026-08-22 10:31:24.728615 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 5.46s 2026-08-22 10:31:24.728664 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.35s 2026-08-22 10:31:24.728675 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 3.32s 2026-08-22 10:31:24.728683 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.84s 2026-08-22 10:31:24.728692 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.59s 2026-08-22 10:31:24.728719 | instance | Gathering Facts --------------------------------------------------------- 1.95s 2026-08-22 10:31:24.728728 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.69s 2026-08-22 10:31:24.728736 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.68s 2026-08-22 10:31:24.728745 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 1.59s 2026-08-22 10:31:24.728754 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.20s 2026-08-22 10:31:24.728762 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.01s 2026-08-22 10:31:24.728771 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.95s 2026-08-22 10:31:24.728780 | instance | Gathering Facts --------------------------------------------------------- 0.88s 2026-08-22 10:31:24.728788 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.88s 2026-08-22 10:31:24.728797 | instance | Gathering Facts --------------------------------------------------------- 0.84s 2026-08-22 10:31:24.728811 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.71s 2026-08-22 10:31:24.728820 | instance | vexxhost.ceph.cephadm : Ensure "cephadm" user is present ---------------- 0.67s 2026-08-22 10:31:24.812128 | instance | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-08-22 10:31:24.812208 | instance | ERROR [csi > converge] Executed: Failed 2026-08-22 10:31:24.812219 | instance | ERROR Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-08-22 10:31:25.105266 | instance | ERROR 2026-08-22 10:31:25.105529 | instance | { 2026-08-22 10:31:25.105607 | instance | "delta": "0:04:50.884676", 2026-08-22 10:31:25.105653 | instance | "end": "2026-08-22 10:31:24.857842", 2026-08-22 10:31:25.105692 | instance | "msg": "non-zero return code", 2026-08-22 10:31:25.105730 | instance | "rc": 2, 2026-08-22 10:31:25.105767 | instance | "start": "2026-08-22 10:26:33.973166" 2026-08-22 10:31:25.105804 | instance | } failure 2026-08-22 10:31:25.112560 | 2026-08-22 10:31:25.112613 | PLAY RECAP 2026-08-22 10:31:25.112658 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-08-22 10:31:25.112681 | 2026-08-22 10:31:25.244280 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-22 10:31:25.328527 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-08-22 10:31:26.475726 | 2026-08-22 10:31:26.475867 | PLAY [all] 2026-08-22 10:31:26.497150 | 2026-08-22 10:31:26.497283 | TASK [gather-host-logs : creating directory for system status] 2026-08-22 10:31:26.834469 | instance | changed 2026-08-22 10:31:26.963730 | 2026-08-22 10:31:26.963919 | TASK [gather-host-logs : Get logs for each host] 2026-08-22 10:31:27.304616 | instance | + systemd-cgls --full --all --no-pager 2026-08-22 10:31:27.319521 | instance | + ip addr 2026-08-22 10:31:27.322268 | instance | + ip route 2026-08-22 10:31:27.323501 | instance | + lsblk 2026-08-22 10:31:27.328810 | instance | + mount 2026-08-22 10:31:27.331755 | instance | + docker images 2026-08-22 10:31:27.350673 | instance | + brctl show 2026-08-22 10:31:27.351305 | instance | /bin/bash: line 8: brctl: command not found 2026-08-22 10:31:27.351611 | instance | + ps aux --sort=-%mem 2026-08-22 10:31:27.376506 | instance | + dpkg -l 2026-08-22 10:31:27.389895 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-08-22 10:31:27.390474 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-08-22 10:31:27.408165 | instance | + '[' '!' -z '' ']' 2026-08-22 10:31:27.502003 | instance | ok: Runtime: 0:00:00.109063 2026-08-22 10:31:27.510023 | 2026-08-22 10:31:27.510097 | TASK [gather-host-logs : Downloads logs to executor] 2026-08-22 10:31:28.209574 | instance | changed: 2026-08-22 10:31:28.209772 | instance | created directory /var/lib/zuul/builds/8e1c3ee72bc449cf8a1c216b3f9d0816/work/logs/instance 2026-08-22 10:31:28.209800 | instance | cd+++++++++ system/ 2026-08-22 10:31:28.209822 | instance | >f+++++++++ system/brctl-show.txt 2026-08-22 10:31:28.209842 | instance | >f+++++++++ system/docker-images.txt 2026-08-22 10:31:28.210309 | instance | >f+++++++++ system/ip-addr.txt 2026-08-22 10:31:28.210361 | instance | >f+++++++++ system/ip-route.txt 2026-08-22 10:31:28.210386 | instance | >f+++++++++ system/lsblk.txt 2026-08-22 10:31:28.210407 | instance | >f+++++++++ system/mount.txt 2026-08-22 10:31:28.210426 | instance | >f+++++++++ system/packages.txt 2026-08-22 10:31:28.210445 | instance | >f+++++++++ system/ps.txt 2026-08-22 10:31:28.210466 | instance | >f+++++++++ system/systemd-cgls.txt 2026-08-22 10:31:28.220020 | 2026-08-22 10:31:28.220106 | LOOP [helm-release-status : creating directory for helm release status] 2026-08-22 10:31:28.422523 | instance | changed: "values" 2026-08-22 10:31:28.601336 | instance | changed: "releases" 2026-08-22 10:31:28.618565 | 2026-08-22 10:31:28.618752 | TASK [helm-release-status : Gather get release status for helm charts] 2026-08-22 10:31:28.821063 | instance | /bin/bash: line 3: kubectl: command not found 2026-08-22 10:31:29.156938 | instance | ok: Runtime: 0:00:00.004323 2026-08-22 10:31:29.162475 | 2026-08-22 10:31:29.162541 | TASK [helm-release-status : Downloads logs to executor] 2026-08-22 10:31:29.642149 | instance | changed: 2026-08-22 10:31:29.642355 | instance | cd+++++++++ helm/ 2026-08-22 10:31:29.642383 | instance | cd+++++++++ helm/releases/ 2026-08-22 10:31:29.642404 | instance | cd+++++++++ helm/values/ 2026-08-22 10:31:29.651553 | 2026-08-22 10:31:29.651643 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-08-22 10:31:29.869016 | instance | changed 2026-08-22 10:31:29.876893 | 2026-08-22 10:31:29.876987 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-08-22 10:31:30.137823 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-22 10:31:30.137936 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-22 10:31:30.144120 | instance | environment: line 1: kubectl: command not found 2026-08-22 10:31:30.145745 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-22 10:31:30.146303 | instance | environment: line 1: kubectl: command not found 2026-08-22 10:31:30.147954 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-22 10:31:30.148473 | instance | environment: line 1: kubectl: command not found 2026-08-22 10:31:30.149667 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-22 10:31:30.150276 | instance | environment: line 1: kubectl: command not found 2026-08-22 10:31:30.151483 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-22 10:31:30.152414 | instance | environment: line 1: kubectl: command not found 2026-08-22 10:31:30.153412 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-22 10:31:30.413520 | instance | ok: Runtime: 0:00:00.024632 2026-08-22 10:31:30.420006 | 2026-08-22 10:31:30.420080 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-08-22 10:31:30.625745 | instance | changed 2026-08-22 10:31:30.632495 | 2026-08-22 10:31:30.632567 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-08-22 10:31:30.839412 | instance | environment: line 5: kubectl: command not found 2026-08-22 10:31:30.840387 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-22 10:31:30.840845 | instance | xargs: xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-22 10:31:30.840870 | instance | warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-22 10:31:31.172405 | instance | ok: Runtime: 0:00:00.009067 2026-08-22 10:31:31.177909 | 2026-08-22 10:31:31.177976 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-08-22 10:31:31.668353 | instance | changed: 2026-08-22 10:31:31.668616 | instance | cd+++++++++ objects/ 2026-08-22 10:31:31.668679 | instance | cd+++++++++ objects/cluster/ 2026-08-22 10:31:31.668732 | instance | cd+++++++++ objects/namespaced/ 2026-08-22 10:31:31.679665 | 2026-08-22 10:31:31.679729 | TASK [gather-pod-logs : creating directory for pod logs] 2026-08-22 10:31:31.869284 | instance | changed 2026-08-22 10:31:31.874178 | 2026-08-22 10:31:31.874242 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-08-22 10:31:32.088651 | instance | changed 2026-08-22 10:31:32.094198 | 2026-08-22 10:31:32.094270 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-08-22 10:31:32.407264 | instance | environment: line 3: kubectl: command not found 2026-08-22 10:31:32.628423 | instance | ok: Runtime: 0:00:00.008149 2026-08-22 10:31:32.634936 | 2026-08-22 10:31:32.634999 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-08-22 10:31:33.122850 | instance | changed: 2026-08-22 10:31:33.123016 | instance | cd+++++++++ pod-logs/ 2026-08-22 10:31:33.123055 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-08-22 10:31:33.132454 | 2026-08-22 10:31:33.132536 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-08-22 10:31:33.330251 | instance | changed 2026-08-22 10:31:33.336407 | 2026-08-22 10:31:33.336473 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-08-22 10:31:33.540751 | instance | /bin/bash: line 2: kubectl: command not found 2026-08-22 10:31:33.876482 | instance | ok: Runtime: 0:00:00.039473 2026-08-22 10:31:33.883682 | 2026-08-22 10:31:33.883782 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-08-22 10:31:34.121667 | instance | /bin/bash: line 2: kubectl: command not found 2026-08-22 10:31:34.148725 | instance | ceph-mgr endpoints: 2026-08-22 10:31:34.425125 | instance | ok: Runtime: 0:00:00.033309 2026-08-22 10:31:34.432998 | 2026-08-22 10:31:34.433089 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-08-22 10:31:34.636950 | instance | /bin/bash: line 4: kubectl: command not found 2026-08-22 10:31:34.966369 | instance | ok: Runtime: 0:00:00.033863 2026-08-22 10:31:34.972921 | 2026-08-22 10:31:34.973002 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-08-22 10:31:35.462338 | instance | changed: cd+++++++++ prometheus/ 2026-08-22 10:31:35.471795 | 2026-08-22 10:31:35.471881 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-08-22 10:31:35.669423 | instance | changed 2026-08-22 10:31:35.674482 | 2026-08-22 10:31:35.674543 | TASK [gather-selenium-data : Get selenium data] 2026-08-22 10:31:35.932028 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-08-22 10:31:35.933720 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-08-22 10:31:36.207879 | instance | ERROR 2026-08-22 10:31:36.208146 | instance | { 2026-08-22 10:31:36.208197 | instance | "delta": "0:00:00.006385", 2026-08-22 10:31:36.208238 | instance | "end": "2026-08-22 10:31:35.934029", 2026-08-22 10:31:36.208273 | instance | "msg": "non-zero return code", 2026-08-22 10:31:36.208311 | instance | "rc": 1, 2026-08-22 10:31:36.208345 | instance | "start": "2026-08-22 10:31:35.927644" 2026-08-22 10:31:36.208377 | instance | } 2026-08-22 10:31:36.208420 | instance | ERROR: Ignoring Errors 2026-08-22 10:31:36.215725 | 2026-08-22 10:31:36.215803 | TASK [gather-selenium-data : Downloads logs to executor] 2026-08-22 10:31:36.701744 | instance | changed: cd+++++++++ selenium/ 2026-08-22 10:31:36.707116 | 2026-08-22 10:31:36.707160 | PLAY RECAP 2026-08-22 10:31:36.707202 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-08-22 10:31:36.707223 | 2026-08-22 10:31:36.821102 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-08-22 10:31:36.832780 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-22 10:31:37.445488 | 2026-08-22 10:31:37.445611 | PLAY [all] 2026-08-22 10:31:37.458117 | 2026-08-22 10:31:37.458207 | TASK [fetch-output : Set log path for multiple nodes] 2026-08-22 10:31:37.503282 | instance | skipping: Conditional result was False 2026-08-22 10:31:37.511448 | 2026-08-22 10:31:37.511567 | TASK [fetch-output : Set log path for single node] 2026-08-22 10:31:37.554976 | instance | ok 2026-08-22 10:31:37.562146 | 2026-08-22 10:31:37.562243 | LOOP [fetch-output : Ensure local output dirs] 2026-08-22 10:31:37.945585 | instance -> localhost | ok: "/var/lib/zuul/builds/8e1c3ee72bc449cf8a1c216b3f9d0816/work/logs" 2026-08-22 10:31:38.169454 | instance -> localhost | changed: "/var/lib/zuul/builds/8e1c3ee72bc449cf8a1c216b3f9d0816/work/artifacts" 2026-08-22 10:31:38.376008 | instance -> localhost | changed: "/var/lib/zuul/builds/8e1c3ee72bc449cf8a1c216b3f9d0816/work/docs" 2026-08-22 10:31:38.397182 | 2026-08-22 10:31:38.397333 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-22 10:31:39.065387 | instance | changed: .d..t...... ./ 2026-08-22 10:31:39.065642 | instance | changed: All items complete 2026-08-22 10:31:39.065676 | 2026-08-22 10:31:39.518233 | instance | changed: .d..t...... ./ 2026-08-22 10:31:39.964389 | instance | changed: .d..t...... ./ 2026-08-22 10:31:39.983357 | 2026-08-22 10:31:39.983512 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-22 10:31:40.420608 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007623 2026-08-22 10:31:40.652148 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.008075 2026-08-22 10:31:40.673647 | 2026-08-22 10:31:40.673765 | PLAY [all] 2026-08-22 10:31:40.679731 | 2026-08-22 10:31:40.679792 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-22 10:31:41.100560 | instance | changed 2026-08-22 10:31:41.107101 | 2026-08-22 10:31:41.107146 | PLAY RECAP 2026-08-22 10:31:41.107188 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-22 10:31:41.107209 | 2026-08-22 10:31:41.270184 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-22 10:31:41.273178 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-22 10:31:41.897450 | 2026-08-22 10:31:41.897595 | PLAY [localhost] 2026-08-22 10:31:41.907846 | 2026-08-22 10:31:41.907936 | TASK [Generate Zuul manifest] 2026-08-22 10:31:41.928956 | localhost | ok 2026-08-22 10:31:41.977107 | 2026-08-22 10:31:41.977255 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-22 10:31:42.371448 | localhost | changed 2026-08-22 10:31:42.384244 | 2026-08-22 10:31:42.384349 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-22 10:31:42.416580 | localhost | ok 2026-08-22 10:31:42.423576 | 2026-08-22 10:31:42.423643 | TASK [Upload logs] 2026-08-22 10:31:42.445941 | localhost | ok 2026-08-22 10:31:42.506664 | 2026-08-22 10:31:42.506906 | TASK [Set zuul-log-path fact] 2026-08-22 10:31:42.527765 | localhost | ok 2026-08-22 10:31:42.541096 | 2026-08-22 10:31:42.541190 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-22 10:31:42.572976 | localhost | ok 2026-08-22 10:31:42.580422 | 2026-08-22 10:31:42.580493 | TASK [upload-logs : Create log directories] 2026-08-22 10:31:42.986777 | localhost | changed 2026-08-22 10:31:42.993249 | 2026-08-22 10:31:42.993341 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-22 10:31:43.416542 | localhost -> localhost | ok: Runtime: 0:00:00.006855 2026-08-22 10:31:43.424791 | 2026-08-22 10:31:43.424855 | TASK [upload-logs : Upload logs to log server] 2026-08-22 10:31:43.907969 | localhost | Output suppressed because no_log was given 2026-08-22 10:31:43.960137 | 2026-08-22 10:31:43.960332 | LOOP [upload-logs : Compress console log and json output] 2026-08-22 10:31:44.005319 | localhost | skipping: Conditional result was False 2026-08-22 10:31:44.015865 | localhost | skipping: Conditional result was False 2026-08-22 10:31:44.035472 | 2026-08-22 10:31:44.035609 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-22 10:31:44.087541 | localhost | skipping: Conditional result was False 2026-08-22 10:31:44.087867 | 2026-08-22 10:31:44.098096 | localhost | skipping: Conditional result was False 2026-08-22 10:31:44.109007 | 2026-08-22 10:31:44.109152 | LOOP [upload-logs : Upload console log and json output]