2026-08-26 04:57:17.090565 | Job console starting 2026-08-26 04:57:17.100068 | Updating git repos 2026-08-26 04:57:23.252208 | Cloning repos into workspace 2026-08-26 04:58:00.411026 | Restoring repo states 2026-08-26 04:58:15.115611 | Merging changes 2026-08-26 04:58:18.901620 | Checking out repos 2026-08-26 04:58:21.184223 | Preparing playbooks 2026-08-26 04:58:24.593121 | Running Ansible setup 2026-08-26 04:58:27.954286 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-26 04:58:28.560224 | 2026-08-26 04:58:28.560349 | PLAY [localhost] 2026-08-26 04:58:28.568127 | 2026-08-26 04:58:28.568258 | TASK [Gathering Facts] 2026-08-26 04:58:29.542211 | localhost | ok 2026-08-26 04:58:29.552782 | 2026-08-26 04:58:29.552897 | TASK [Setup log path fact] 2026-08-26 04:58:29.575268 | localhost | ok 2026-08-26 04:58:29.589114 | 2026-08-26 04:58:29.589224 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-26 04:58:29.621931 | localhost | ok 2026-08-26 04:58:29.629933 | 2026-08-26 04:58:29.630009 | TASK [emit-job-header : Print job information] 2026-08-26 04:58:29.671905 | # Job Information 2026-08-26 04:58:29.672147 | Ansible Version: 2.16.18 2026-08-26 04:58:29.672216 | Job: atmosphere-molecule-csi-rbd 2026-08-26 04:58:29.672266 | Pipeline: check 2026-08-26 04:58:29.672311 | Executor: 2d72f0692154 2026-08-26 04:58:29.672356 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4092 2026-08-26 04:58:29.672407 | Event ID: fe96f680-a109-11f1-829b-5614f83403ff 2026-08-26 04:58:29.677162 | 2026-08-26 04:58:29.677256 | LOOP [emit-job-header : Print node information] 2026-08-26 04:58:29.780850 | localhost | ok: 2026-08-26 04:58:29.781136 | localhost | # Node Information 2026-08-26 04:58:29.781204 | localhost | Inventory Hostname: instance 2026-08-26 04:58:29.781256 | localhost | Hostname: np0000191154 2026-08-26 04:58:29.781303 | localhost | Username: zuul 2026-08-26 04:58:29.781356 | localhost | Distro: Ubuntu 22.04 2026-08-26 04:58:29.781402 | localhost | Provider: yul1 2026-08-26 04:58:29.781446 | localhost | Region: ca-ymq-1 2026-08-26 04:58:29.781488 | localhost | Label: ubuntu-jammy 2026-08-26 04:58:29.781530 | localhost | Product Name: OpenStack Nova 2026-08-26 04:58:29.781574 | localhost | Interface IP: 162.253.55.112 2026-08-26 04:58:29.798788 | 2026-08-26 04:58:29.798956 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-26 04:58:30.185155 | localhost -> localhost | changed 2026-08-26 04:58:30.193527 | 2026-08-26 04:58:30.193626 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-26 04:58:31.019184 | localhost -> localhost | changed 2026-08-26 04:58:31.031399 | 2026-08-26 04:58:31.031558 | PLAY [all] 2026-08-26 04:58:31.045056 | 2026-08-26 04:58:31.045225 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-26 04:58:31.254372 | instance -> localhost | ok 2026-08-26 04:58:31.264736 | 2026-08-26 04:58:31.264857 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-26 04:58:31.301193 | instance | ok 2026-08-26 04:58:31.316079 | instance | included: /var/lib/zuul/builds/a3499b909caa4e9ebf8fbf44b36a4f9d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-26 04:58:31.321963 | 2026-08-26 04:58:31.322028 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-26 04:58:32.270858 | instance -> localhost | Generating public/private rsa key pair. 2026-08-26 04:58:32.271054 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/a3499b909caa4e9ebf8fbf44b36a4f9d/work/a3499b909caa4e9ebf8fbf44b36a4f9d_id_rsa 2026-08-26 04:58:32.271107 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/a3499b909caa4e9ebf8fbf44b36a4f9d/work/a3499b909caa4e9ebf8fbf44b36a4f9d_id_rsa.pub 2026-08-26 04:58:32.271140 | instance -> localhost | The key fingerprint is: 2026-08-26 04:58:32.271170 | instance -> localhost | SHA256:KK93OSJ84DFeQqFgH/yGrTmYvOsxX2/z6sI4wdp6qd0 zuul-build-sshkey 2026-08-26 04:58:32.271214 | instance -> localhost | The key's randomart image is: 2026-08-26 04:58:32.271244 | instance -> localhost | +---[RSA 3072]----+ 2026-08-26 04:58:32.271283 | instance -> localhost | | . | 2026-08-26 04:58:32.271313 | instance -> localhost | |.. o. | 2026-08-26 04:58:32.271341 | instance -> localhost | |....=. | 2026-08-26 04:58:32.271369 | instance -> localhost | | .o.+ . | 2026-08-26 04:58:32.271410 | instance -> localhost | |. +.= . S | 2026-08-26 04:58:32.271439 | instance -> localhost | | + *=o. | 2026-08-26 04:58:32.271466 | instance -> localhost | | o++*B. . | 2026-08-26 04:58:32.271494 | instance -> localhost | | o=*B+=o+ | 2026-08-26 04:58:32.271525 | instance -> localhost | |.==ooE+*+o | 2026-08-26 04:58:32.271784 | instance -> localhost | +----[SHA256]-----+ 2026-08-26 04:58:32.271914 | instance -> localhost | ok: Runtime: 0:00:00.515792 2026-08-26 04:58:32.278659 | 2026-08-26 04:58:32.278729 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-26 04:58:32.311330 | instance | ok 2026-08-26 04:58:32.321082 | instance | included: /var/lib/zuul/builds/a3499b909caa4e9ebf8fbf44b36a4f9d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-26 04:58:32.328459 | 2026-08-26 04:58:32.328519 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-26 04:58:32.353586 | instance | skipping: Conditional result was False 2026-08-26 04:58:32.362127 | 2026-08-26 04:58:32.362214 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-26 04:58:32.792389 | instance | changed 2026-08-26 04:58:32.798425 | 2026-08-26 04:58:32.798488 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-26 04:58:32.986651 | instance | ok 2026-08-26 04:58:32.992928 | 2026-08-26 04:58:32.993015 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-26 04:58:33.441419 | instance | changed 2026-08-26 04:58:33.448302 | 2026-08-26 04:58:33.448389 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-26 04:58:33.889957 | instance | changed 2026-08-26 04:58:33.895881 | 2026-08-26 04:58:33.895953 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-26 04:58:33.921261 | instance | skipping: Conditional result was False 2026-08-26 04:58:33.929979 | 2026-08-26 04:58:33.930058 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-26 04:58:34.280165 | instance -> localhost | changed 2026-08-26 04:58:34.294200 | 2026-08-26 04:58:34.294396 | TASK [add-build-sshkey : Add back temp key] 2026-08-26 04:58:34.546710 | instance -> localhost | Identity added: /var/lib/zuul/builds/a3499b909caa4e9ebf8fbf44b36a4f9d/work/a3499b909caa4e9ebf8fbf44b36a4f9d_id_rsa (zuul-build-sshkey) 2026-08-26 04:58:34.546880 | instance -> localhost | ok: Runtime: 0:00:00.014521 2026-08-26 04:58:34.551931 | 2026-08-26 04:58:34.551994 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-26 04:58:34.853446 | instance | ok 2026-08-26 04:58:34.859379 | 2026-08-26 04:58:34.859441 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-26 04:58:34.884630 | instance | skipping: Conditional result was False 2026-08-26 04:58:34.899625 | 2026-08-26 04:58:34.899693 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-08-26 04:58:35.212835 | instance | ok 2026-08-26 04:58:35.219186 | 2026-08-26 04:58:35.219257 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-08-26 04:58:38.497456 | instance | Output suppressed because no_log was given 2026-08-26 04:58:38.507355 | 2026-08-26 04:58:38.507423 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-08-26 04:58:38.694726 | instance | ok: "logs" 2026-08-26 04:58:38.694947 | instance | ok: All items complete 2026-08-26 04:58:38.694979 | 2026-08-26 04:58:38.840072 | instance | ok: "artifacts" 2026-08-26 04:58:38.994975 | instance | ok: "docs" 2026-08-26 04:58:39.012315 | 2026-08-26 04:58:39.012507 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-08-26 04:58:39.192001 | instance | changed: "logs" 2026-08-26 04:58:39.349778 | instance | changed: "artifacts" 2026-08-26 04:58:39.499120 | instance | changed: "docs" 2026-08-26 04:58:39.522646 | 2026-08-26 04:58:39.523063 | PLAY RECAP 2026-08-26 04:58:39.523117 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-08-26 04:58:39.523148 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-26 04:58:39.523169 | 2026-08-26 04:58:39.671416 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-26 04:58:39.673539 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-26 04:58:40.279463 | 2026-08-26 04:58:40.279611 | PLAY [all] 2026-08-26 04:58:40.290504 | 2026-08-26 04:58:40.290598 | TASK [setup-uv : Extract archive] 2026-08-26 04:58:42.501657 | instance | changed 2026-08-26 04:58:42.507303 | 2026-08-26 04:58:42.507382 | TASK [setup-uv : Print version] 2026-08-26 04:58:42.848533 | instance | uv 0.8.13 2026-08-26 04:58:43.043425 | instance | ok: Runtime: 0:00:00.013302 2026-08-26 04:58:43.054000 | 2026-08-26 04:58:43.054067 | TASK [Install Ansible collection siblings] 2026-08-26 04:58:51.536205 | instance | changed: 2026-08-26 04:58:51.536490 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-08-26 04:58:51.536542 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-08-26 04:58:51.536582 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-08-26 04:58:51.536618 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto 2026-08-26 04:58:51.536652 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general 2026-08-26 04:58:51.536693 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql 2026-08-26 04:58:51.536730 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-08-26 04:58:51.536768 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-08-26 04:58:51.536804 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-08-26 04:58:51.536839 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-08-26 04:58:51.536873 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-08-26 04:58:51.536907 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-08-26 04:58:51.536939 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0 2026-08-26 04:58:51.537004 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0 2026-08-26 04:58:51.537040 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0 2026-08-26 04:58:51.537078 | instance | Resolved community.crypto to 2.2.3 for 2.2.3 2026-08-26 04:58:51.537114 | instance | Resolved community.general to 7.3.0 for 7.3.0 2026-08-26 04:58:51.537147 | instance | Resolved community.mysql to 3.6.0 for 3.6.0 2026-08-26 04:58:51.537182 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0 2026-08-26 04:58:51.537218 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0 2026-08-26 04:58:51.537250 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0 2026-08-26 04:58:51.537282 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0 2026-08-26 04:58:51.537311 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-08-26 04:58:51.537357 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0 2026-08-26 04:58:51.537385 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0 2026-08-26 04:58:51.537411 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-08-26 04:58:51.537436 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-08-26 04:58:51.537462 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-08-26 04:58:51.537486 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0 2026-08-26 04:58:51.537511 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3 2026-08-26 04:58:51.537535 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-08-26 04:58:51.537570 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-08-26 04:58:51.537602 | instance | Checked out ansible.netcommon to 1.2.0 2026-08-26 04:58:51.537630 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-08-26 04:58:51.537664 | instance | Starting galaxy collection install process 2026-08-26 04:58:51.537690 | instance | Process install dependency map 2026-08-26 04:58:51.537715 | instance | Starting collection install process 2026-08-26 04:58:51.537740 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon' 2026-08-26 04:58:51.537765 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon 2026-08-26 04:58:51.537789 | instance | ansible.netcommon:* was installed successfully 2026-08-26 04:58:51.537814 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-08-26 04:58:51.537839 | instance | Creating virtual environment at: .venv 2026-08-26 04:58:51.537865 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-08-26 04:58:51.537890 | instance | Downloading netaddr (2.2MiB) 2026-08-26 04:58:51.537914 | instance | Downloading ansible-core (2.1MiB) 2026-08-26 04:58:51.537944 | instance | Downloading openstacksdk (1.7MiB) 2026-08-26 04:58:51.537969 | instance | Downloading setuptools (1.1MiB) 2026-08-26 04:58:51.537995 | instance | Downloading rjsonnet (1.2MiB) 2026-08-26 04:58:51.538020 | instance | Downloading kubernetes (1.9MiB) 2026-08-26 04:58:51.538047 | instance | Downloading pygments (1.2MiB) 2026-08-26 04:58:51.538084 | instance | Downloading cryptography (4.2MiB) 2026-08-26 04:58:51.538117 | instance | Building pyperclip==1.9.0 2026-08-26 04:58:51.538143 | instance | Downloading rjsonnet 2026-08-26 04:58:51.538171 | instance | Downloading netaddr 2026-08-26 04:58:51.538197 | instance | Downloading pygments 2026-08-26 04:58:51.538225 | instance | Downloading cryptography 2026-08-26 04:58:51.538251 | instance | Downloading setuptools 2026-08-26 04:58:51.538276 | instance | Downloading kubernetes 2026-08-26 04:58:51.538301 | instance | Downloading ansible-core 2026-08-26 04:58:51.538327 | instance | Downloading openstacksdk 2026-08-26 04:58:51.538352 | instance | Built pyperclip==1.9.0 2026-08-26 04:58:51.538418 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-08-26 04:58:51.538450 | instance | Installed 79 packages in 36ms 2026-08-26 04:58:51.538477 | instance | Checked out ansible.posix to 1.6.0 2026-08-26 04:58:51.538503 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-08-26 04:58:51.538529 | instance | Starting galaxy collection install process 2026-08-26 04:58:51.538554 | instance | Process install dependency map 2026-08-26 04:58:51.538579 | instance | Starting collection install process 2026-08-26 04:58:51.538600 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-08-26 04:58:51.538626 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix 2026-08-26 04:58:51.538646 | instance | ansible.posix:1.6.0 was installed successfully 2026-08-26 04:58:51.538664 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 04:58:51.538682 | instance | 2.17.12 2026-08-26 04:58:51.538699 | instance | Checked out ansible.utils to v6.1.0 2026-08-26 04:58:51.538717 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-08-26 04:58:51.538735 | instance | Starting galaxy collection install process 2026-08-26 04:58:51.538753 | instance | Process install dependency map 2026-08-26 04:58:51.538770 | instance | Starting collection install process 2026-08-26 04:58:51.538788 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils' 2026-08-26 04:58:51.538805 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils 2026-08-26 04:58:51.538823 | instance | ansible.utils:6.1.0 was installed successfully 2026-08-26 04:58:51.538841 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 04:58:51.538859 | instance | 2.17.12 2026-08-26 04:58:51.538877 | instance | Checked out atmosphere.common to v0.7.0 2026-08-26 04:58:51.538895 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-08-26 04:58:51.538913 | instance | Starting galaxy collection install process 2026-08-26 04:58:51.538930 | instance | Process install dependency map 2026-08-26 04:58:51.538956 | instance | Starting collection install process 2026-08-26 04:58:51.538999 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common' 2026-08-26 04:58:51.539022 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common 2026-08-26 04:58:51.539042 | instance | atmosphere.common:0.7.0 was installed successfully 2026-08-26 04:58:51.539081 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 04:58:51.539113 | instance | 2.17.12 2026-08-26 04:58:51.539134 | instance | Checked out community.crypto to 2.2.3 2026-08-26 04:58:51.539155 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.crypto 2026-08-26 04:58:51.539174 | instance | Starting galaxy collection install process 2026-08-26 04:58:51.539193 | instance | Process install dependency map 2026-08-26 04:58:51.539211 | instance | Starting collection install process 2026-08-26 04:58:51.539229 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-08-26 04:58:51.539247 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto 2026-08-26 04:58:51.539265 | instance | community.crypto:2.2.3 was installed successfully 2026-08-26 04:58:51.539283 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 04:58:51.539301 | instance | 2.17.12 2026-08-26 04:58:51.539319 | instance | Checked out community.general to 7.3.0 2026-08-26 04:58:51.539336 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.general 2026-08-26 04:58:51.539354 | instance | Starting galaxy collection install process 2026-08-26 04:58:51.539379 | instance | Process install dependency map 2026-08-26 04:58:51.539398 | instance | Starting collection install process 2026-08-26 04:58:51.539416 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-08-26 04:58:51.539433 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general 2026-08-26 04:58:51.539451 | instance | community.general:7.3.0 was installed successfully 2026-08-26 04:58:51.539469 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 04:58:51.539486 | instance | 2.17.12 2026-08-26 04:58:51.539505 | instance | Checked out community.mysql to 3.6.0 2026-08-26 04:58:51.539524 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.mysql 2026-08-26 04:58:51.539544 | instance | Starting galaxy collection install process 2026-08-26 04:58:51.539565 | instance | Process install dependency map 2026-08-26 04:58:51.539586 | instance | Starting collection install process 2026-08-26 04:58:51.539608 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql' 2026-08-26 04:58:51.539627 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql 2026-08-26 04:58:51.539646 | instance | community.mysql:3.6.0 was installed successfully 2026-08-26 04:58:51.539675 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 04:58:51.539693 | instance | 2.17.12 2026-08-26 04:58:51.539711 | instance | Checked out kubernetes.core to 2.4.0 2026-08-26 04:58:51.539729 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-08-26 04:58:51.539747 | instance | Starting galaxy collection install process 2026-08-26 04:58:51.539765 | instance | Process install dependency map 2026-08-26 04:58:51.539783 | instance | Starting collection install process 2026-08-26 04:58:51.539801 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core' 2026-08-26 04:58:51.539819 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core 2026-08-26 04:58:51.539837 | instance | kubernetes.core:2.4.0 was installed successfully 2026-08-26 04:58:51.539855 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 04:58:51.539872 | instance | 2.17.12 2026-08-26 04:58:51.539890 | instance | Checked out openstack.cloud to 2.6.0 2026-08-26 04:58:51.539907 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-08-26 04:58:51.539925 | instance | Starting galaxy collection install process 2026-08-26 04:58:51.539942 | instance | Process install dependency map 2026-08-26 04:58:51.539960 | instance | Starting collection install process 2026-08-26 04:58:51.540002 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud' 2026-08-26 04:58:51.540031 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud 2026-08-26 04:58:51.540054 | instance | openstack.cloud:2.6.0 was installed successfully 2026-08-26 04:58:51.540101 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 04:58:51.540124 | instance | 2.17.12 2026-08-26 04:58:51.540143 | instance | Checked out vexxhost.ceph to v4.2.0 2026-08-26 04:58:51.540162 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-08-26 04:58:51.540192 | instance | Starting galaxy collection install process 2026-08-26 04:58:51.540211 | instance | Process install dependency map 2026-08-26 04:58:51.540229 | instance | Starting collection install process 2026-08-26 04:58:51.540247 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph' 2026-08-26 04:58:51.540265 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph 2026-08-26 04:58:51.540283 | instance | vexxhost.ceph:4.2.0 was installed successfully 2026-08-26 04:58:51.540301 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 04:58:51.540318 | instance | 2.17.12 2026-08-26 04:58:51.540336 | instance | Checked out vexxhost.containers to v1.6.8 2026-08-26 04:58:51.540354 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-08-26 04:58:51.540372 | instance | Starting galaxy collection install process 2026-08-26 04:58:51.540390 | instance | Process install dependency map 2026-08-26 04:58:51.540407 | instance | Starting collection install process 2026-08-26 04:58:51.540424 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers' 2026-08-26 04:58:51.540442 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers 2026-08-26 04:58:51.540459 | instance | vexxhost.containers:1.6.8 was installed successfully 2026-08-26 04:58:51.540477 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 04:58:51.540494 | instance | 2.17.12 2026-08-26 04:58:51.540526 | instance | Checked out vexxhost.kubernetes to v3.3.0 2026-08-26 04:58:51.540547 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-08-26 04:58:51.540565 | instance | Starting galaxy collection install process 2026-08-26 04:58:51.540584 | instance | Process install dependency map 2026-08-26 04:58:51.540602 | instance | Starting collection install process 2026-08-26 04:58:51.540620 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes' 2026-08-26 04:58:51.540637 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes 2026-08-26 04:58:51.540655 | instance | vexxhost.kubernetes:3.3.0 was installed successfully 2026-08-26 04:58:51.540672 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 04:58:51.540689 | instance | 2.17.12 2026-08-26 04:58:51.547314 | 2026-08-26 04:58:51.547380 | PLAY RECAP 2026-08-26 04:58:51.547432 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-26 04:58:51.547455 | 2026-08-26 04:58:51.712391 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-26 04:58:51.714423 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-08-26 04:58:52.295807 | 2026-08-26 04:58:52.295933 | PLAY [all] 2026-08-26 04:58:52.306729 | 2026-08-26 04:58:52.306809 | TASK [Install "jq" for log collection] 2026-08-26 04:59:03.272553 | instance | changed 2026-08-26 04:59:03.274840 | 2026-08-26 04:59:03.274910 | PLAY RECAP 2026-08-26 04:59:03.274980 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-26 04:59:03.275047 | 2026-08-26 04:59:03.394624 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-08-26 04:59:03.398753 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-26 04:59:03.987102 | 2026-08-26 04:59:03.987224 | PLAY [all] 2026-08-26 04:59:03.998608 | 2026-08-26 04:59:03.998683 | LOOP [Check inventory directories] 2026-08-26 04:59:04.345217 | instance | ok: "src/github.com/vexxhost/atmosphere" 2026-08-26 04:59:04.493166 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory" 2026-08-26 04:59:04.647990 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory" 2026-08-26 04:59:04.665210 | 2026-08-26 04:59:04.665429 | LOOP [Copy inventory file for Zuul] 2026-08-26 04:59:05.415031 | instance | changed: 2026-08-26 04:59:05.415241 | instance | { 2026-08-26 04:59:05.415280 | instance | "ansible_loop_var": "item", 2026-08-26 04:59:05.415311 | instance | "changed": false, 2026-08-26 04:59:05.415338 | instance | "failed": false, 2026-08-26 04:59:05.415373 | instance | "invocation": { 2026-08-26 04:59:05.415400 | instance | "module_args": { 2026-08-26 04:59:05.415425 | instance | "checksum_algorithm": "sha1", 2026-08-26 04:59:05.415450 | instance | "follow": true, 2026-08-26 04:59:05.415475 | instance | "get_attributes": true, 2026-08-26 04:59:05.415501 | instance | "get_checksum": true, 2026-08-26 04:59:05.415527 | instance | "get_mime": true, 2026-08-26 04:59:05.415551 | instance | "path": "src/github.com/vexxhost/atmosphere" 2026-08-26 04:59:05.415575 | instance | } 2026-08-26 04:59:05.415600 | instance | }, 2026-08-26 04:59:05.415625 | instance | "item": "src/github.com/vexxhost/atmosphere", 2026-08-26 04:59:05.415649 | instance | "stat": { 2026-08-26 04:59:05.415673 | instance | "atime": 1787720324.689015, 2026-08-26 04:59:05.415697 | instance | "attr_flags": "e", 2026-08-26 04:59:05.415720 | instance | "attributes": [ 2026-08-26 04:59:05.415743 | instance | "extents" 2026-08-26 04:59:05.415766 | instance | ], 2026-08-26 04:59:05.415789 | instance | "block_size": 4096, 2026-08-26 04:59:05.415812 | instance | "blocks": 8, 2026-08-26 04:59:05.415836 | instance | "charset": "unknown", 2026-08-26 04:59:05.415861 | instance | "ctime": 1787720323.8368843, 2026-08-26 04:59:05.415885 | instance | "dev": 64513, 2026-08-26 04:59:05.415909 | instance | "device_type": 0, 2026-08-26 04:59:05.415933 | instance | "executable": true, 2026-08-26 04:59:05.415956 | instance | "exists": true, 2026-08-26 04:59:05.415980 | instance | "gid": 1000, 2026-08-26 04:59:05.416003 | instance | "gr_name": "zuul", 2026-08-26 04:59:05.416027 | instance | "inode": 1048660, 2026-08-26 04:59:05.416050 | instance | "isblk": false, 2026-08-26 04:59:05.416075 | instance | "ischr": false, 2026-08-26 04:59:05.416099 | instance | "isdir": true, 2026-08-26 04:59:05.416122 | instance | "isfifo": false, 2026-08-26 04:59:05.416145 | instance | "isgid": false, 2026-08-26 04:59:05.416168 | instance | "islnk": false, 2026-08-26 04:59:05.416191 | instance | "isreg": false, 2026-08-26 04:59:05.416214 | instance | "issock": false, 2026-08-26 04:59:05.416237 | instance | "isuid": false, 2026-08-26 04:59:05.416259 | instance | "mimetype": "unknown", 2026-08-26 04:59:05.416282 | instance | "mode": "0755", 2026-08-26 04:59:05.416306 | instance | "mtime": 1787720323.8368843, 2026-08-26 04:59:05.416329 | instance | "nlink": 21, 2026-08-26 04:59:05.416351 | instance | "path": "src/github.com/vexxhost/atmosphere", 2026-08-26 04:59:05.416374 | instance | "pw_name": "zuul", 2026-08-26 04:59:05.416398 | instance | "readable": true, 2026-08-26 04:59:05.416422 | instance | "rgrp": true, 2026-08-26 04:59:05.416445 | instance | "roth": true, 2026-08-26 04:59:05.416469 | instance | "rusr": true, 2026-08-26 04:59:05.416492 | instance | "size": 4096, 2026-08-26 04:59:05.416515 | instance | "uid": 1000, 2026-08-26 04:59:05.416554 | instance | "version": "3144078124", 2026-08-26 04:59:05.416580 | instance | "wgrp": false, 2026-08-26 04:59:05.416605 | instance | "woth": false, 2026-08-26 04:59:05.416628 | instance | "writeable": true, 2026-08-26 04:59:05.416651 | instance | "wusr": true, 2026-08-26 04:59:05.416674 | instance | "xgrp": true, 2026-08-26 04:59:05.416697 | instance | "xoth": true, 2026-08-26 04:59:05.416720 | instance | "xusr": true 2026-08-26 04:59:05.416742 | instance | } 2026-08-26 04:59:05.416766 | instance | } 2026-08-26 04:59:05.416813 | instance | ok: All items complete 2026-08-26 04:59:05.416841 | 2026-08-26 04:59:05.418676 | instance | skipping: Conditional result was False 2026-08-26 04:59:05.419470 | instance | skipping: Conditional result was False 2026-08-26 04:59:05.436256 | 2026-08-26 04:59:05.436392 | LOOP [Switch "ansible_host" to private IP] 2026-08-26 04:59:05.763174 | instance | changed: 1 replacements made 2026-08-26 04:59:05.764359 | instance | skipping: Conditional result was False 2026-08-26 04:59:05.767304 | instance | skipping: Conditional result was False 2026-08-26 04:59:05.783964 | 2026-08-26 04:59:05.784144 | TASK [Run Molecule scenario] 2026-08-26 04:59:06.686415 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-08-26 04:59:07.066960 | instance | INFO [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-08-26 04:59:07.067019 | instance | INFO [csi > prerun] Performing prerun with role_name_check=0... 2026-08-26 04:59:17.783230 | instance | INFO [csi > dependency] Executing 2026-08-26 04:59:17.783498 | instance | WARNING [csi > dependency] Missing roles requirements file: requirements.yml 2026-08-26 04:59:17.783781 | instance | WARNING [csi > dependency] Missing collections requirements file: collections.yml 2026-08-26 04:59:17.783909 | instance | WARNING [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-08-26 04:59:17.792160 | instance | INFO [csi > cleanup] Executing 2026-08-26 04:59:17.792486 | instance | WARNING [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-26 04:59:17.799864 | instance | INFO [csi > destroy] Executing 2026-08-26 04:59:17.799900 | instance | WARNING [csi > destroy] Skipping, '--destroy=never' requested. 2026-08-26 04:59:17.800003 | instance | INFO [csi > destroy] Executed: Successful 2026-08-26 04:59:17.807229 | instance | INFO [csi > syntax] Executing 2026-08-26 04:59:19.405078 | instance | 2026-08-26 04:59:19.405318 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-08-26 04:59:19.463569 | instance | INFO [csi > syntax] Executed: Successful 2026-08-26 04:59:19.477231 | instance | INFO [csi > create] Executing 2026-08-26 04:59:19.479034 | instance | WARNING [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-26 04:59:19.486298 | instance | INFO [csi > prepare] Executing 2026-08-26 04:59:20.284880 | instance | 2026-08-26 04:59:20.285069 | instance | PLAY [Prepare] ***************************************************************** 2026-08-26 04:59:20.285317 | instance | 2026-08-26 04:59:20.285589 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-26 04:59:20.285962 | instance | Wednesday 26 August 2026 04:59:20 +0000 (0:00:00.023) 0:00:00.023 ****** 2026-08-26 04:59:21.385320 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-08-26 04:59:21.385523 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-08-26 04:59:21.385816 | instance | interpreter could change the meaning of that path. See 2026-08-26 04:59:21.386112 | instance | https://docs.ansible.com/ansible- 2026-08-26 04:59:21.386373 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-08-26 04:59:21.392540 | instance | ok: [instance] 2026-08-26 04:59:21.392807 | instance | 2026-08-26 04:59:21.393106 | instance | TASK [Configure short hostname] ************************************************ 2026-08-26 04:59:21.393398 | instance | Wednesday 26 August 2026 04:59:21 +0000 (0:00:01.108) 0:00:01.132 ****** 2026-08-26 04:59:22.028789 | instance | changed: [instance] 2026-08-26 04:59:22.028868 | instance | 2026-08-26 04:59:22.028991 | instance | TASK [Ensure hostname inside hosts file] *************************************** 2026-08-26 04:59:22.029117 | instance | Wednesday 26 August 2026 04:59:22 +0000 (0:00:00.636) 0:00:01.768 ****** 2026-08-26 04:59:22.261915 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created 2026-08-26 04:59:22.262187 | instance | with a mode of 0700, this may cause issues when running as another user. To 2026-08-26 04:59:22.262469 | instance | avoid this, create the remote_tmp dir with the correct permissions manually 2026-08-26 04:59:22.267896 | instance | changed: [instance] 2026-08-26 04:59:22.268168 | instance | 2026-08-26 04:59:22.268446 | instance | TASK [Purge "snapd" package] *************************************************** 2026-08-26 04:59:22.268736 | instance | Wednesday 26 August 2026 04:59:22 +0000 (0:00:00.239) 0:00:02.007 ****** 2026-08-26 04:59:22.974806 | instance | ok: [instance] 2026-08-26 04:59:22.974894 | instance | 2026-08-26 04:59:22.975022 | instance | PLAY [Create devices for Ceph] ************************************************* 2026-08-26 04:59:22.975133 | instance | 2026-08-26 04:59:22.975258 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-26 04:59:22.975385 | instance | Wednesday 26 August 2026 04:59:22 +0000 (0:00:00.707) 0:00:02.714 ****** 2026-08-26 04:59:23.654698 | instance | ok: [instance] 2026-08-26 04:59:23.654907 | instance | 2026-08-26 04:59:23.655178 | instance | TASK [Install depedencies] ***************************************************** 2026-08-26 04:59:23.655449 | instance | Wednesday 26 August 2026 04:59:23 +0000 (0:00:00.679) 0:00:03.394 ****** 2026-08-26 04:59:42.221926 | instance | changed: [instance] 2026-08-26 04:59:42.222205 | instance | 2026-08-26 04:59:42.222579 | instance | TASK [Start up service] ******************************************************** 2026-08-26 04:59:42.223025 | instance | Wednesday 26 August 2026 04:59:42 +0000 (0:00:18.567) 0:00:21.961 ****** 2026-08-26 04:59:42.743276 | instance | ok: [instance] 2026-08-26 04:59:42.743507 | instance | 2026-08-26 04:59:42.743793 | instance | TASK [Generate lvm.conf] ******************************************************* 2026-08-26 04:59:42.744079 | instance | Wednesday 26 August 2026 04:59:42 +0000 (0:00:00.521) 0:00:22.482 ****** 2026-08-26 04:59:43.023817 | instance | ok: [instance] 2026-08-26 04:59:43.024086 | instance | 2026-08-26 04:59:43.024376 | instance | TASK [Write /etc/lvm/lvm.conf] ************************************************* 2026-08-26 04:59:43.024619 | instance | Wednesday 26 August 2026 04:59:43 +0000 (0:00:00.280) 0:00:22.763 ****** 2026-08-26 04:59:43.673585 | instance | changed: [instance] 2026-08-26 04:59:43.673723 | instance | 2026-08-26 04:59:43.673905 | instance | TASK [Get list of all loopback devices] **************************************** 2026-08-26 04:59:43.674073 | instance | Wednesday 26 August 2026 04:59:43 +0000 (0:00:00.649) 0:00:23.412 ****** 2026-08-26 04:59:43.861616 | instance | ok: [instance] 2026-08-26 04:59:43.861892 | instance | 2026-08-26 04:59:43.862195 | instance | TASK [Fail if there is any existing loopback devices] ************************** 2026-08-26 04:59:43.862487 | instance | Wednesday 26 August 2026 04:59:43 +0000 (0:00:00.188) 0:00:23.601 ****** 2026-08-26 04:59:43.886125 | instance | skipping: [instance] 2026-08-26 04:59:43.886398 | instance | 2026-08-26 04:59:43.886692 | instance | TASK [Create devices for Ceph] ************************************************* 2026-08-26 04:59:43.886982 | instance | Wednesday 26 August 2026 04:59:43 +0000 (0:00:00.024) 0:00:23.625 ****** 2026-08-26 04:59:44.399125 | instance | changed: [instance] => (item=osd0) 2026-08-26 04:59:44.399402 | instance | changed: [instance] => (item=osd1) 2026-08-26 04:59:44.399687 | instance | changed: [instance] => (item=osd2) 2026-08-26 04:59:44.399959 | instance | 2026-08-26 04:59:44.400248 | instance | TASK [Set permissions on loopback devices] ************************************* 2026-08-26 04:59:44.400541 | instance | Wednesday 26 August 2026 04:59:44 +0000 (0:00:00.512) 0:00:24.138 ****** 2026-08-26 04:59:44.988419 | instance | changed: [instance] => (item=osd0) 2026-08-26 04:59:44.988802 | instance | changed: [instance] => (item=osd1) 2026-08-26 04:59:44.989129 | instance | changed: [instance] => (item=osd2) 2026-08-26 04:59:44.989438 | instance | 2026-08-26 04:59:44.989800 | instance | TASK [Start loop devices] ****************************************************** 2026-08-26 04:59:44.990158 | instance | Wednesday 26 August 2026 04:59:44 +0000 (0:00:00.589) 0:00:24.727 ****** 2026-08-26 04:59:45.649164 | instance | changed: [instance] => (item=osd0) 2026-08-26 04:59:45.649196 | instance | changed: [instance] => (item=osd1) 2026-08-26 04:59:45.649201 | instance | changed: [instance] => (item=osd2) 2026-08-26 04:59:45.649205 | instance | 2026-08-26 04:59:45.649210 | instance | TASK [Create a volume group for each loop device] ****************************** 2026-08-26 04:59:45.649215 | instance | Wednesday 26 August 2026 04:59:45 +0000 (0:00:00.660) 0:00:25.388 ****** 2026-08-26 04:59:48.652515 | instance | changed: [instance] => (item=osd0) 2026-08-26 04:59:48.652613 | instance | changed: [instance] => (item=osd1) 2026-08-26 04:59:48.653125 | instance | changed: [instance] => (item=osd2) 2026-08-26 04:59:48.653163 | instance | 2026-08-26 04:59:48.653169 | instance | TASK [Create a logical volume for each loop device] **************************** 2026-08-26 04:59:48.653174 | instance | Wednesday 26 August 2026 04:59:48 +0000 (0:00:03.003) 0:00:28.392 ****** 2026-08-26 04:59:50.403712 | instance | changed: [instance] => (item=ceph-instance-osd0) 2026-08-26 04:59:50.403751 | instance | changed: [instance] => (item=ceph-instance-osd1) 2026-08-26 04:59:50.405820 | instance | changed: [instance] => (item=ceph-instance-osd2) 2026-08-26 04:59:50.405885 | instance | 2026-08-26 04:59:50.405897 | instance | PLAY RECAP ********************************************************************* 2026-08-26 04:59:50.405908 | instance | instance : ok=15 changed=9 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-08-26 04:59:50.405917 | instance | 2026-08-26 04:59:50.405926 | instance | Wednesday 26 August 2026 04:59:50 +0000 (0:00:01.750) 0:00:30.142 ****** 2026-08-26 04:59:50.405942 | instance | =============================================================================== 2026-08-26 04:59:50.406101 | instance | Install depedencies ---------------------------------------------------- 18.57s 2026-08-26 04:59:50.406274 | instance | Create a volume group for each loop device ------------------------------ 3.00s 2026-08-26 04:59:50.406439 | instance | Create a logical volume for each loop device ---------------------------- 1.75s 2026-08-26 04:59:50.406616 | instance | Gathering Facts --------------------------------------------------------- 1.11s 2026-08-26 04:59:50.406788 | instance | Purge "snapd" package --------------------------------------------------- 0.71s 2026-08-26 04:59:50.406969 | instance | Gathering Facts --------------------------------------------------------- 0.68s 2026-08-26 04:59:50.407145 | instance | Start loop devices ------------------------------------------------------ 0.66s 2026-08-26 04:59:50.407322 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.65s 2026-08-26 04:59:50.407498 | instance | Configure short hostname ------------------------------------------------ 0.64s 2026-08-26 04:59:50.407675 | instance | Set permissions on loopback devices ------------------------------------- 0.59s 2026-08-26 04:59:50.407855 | instance | Start up service -------------------------------------------------------- 0.52s 2026-08-26 04:59:50.408041 | instance | Create devices for Ceph ------------------------------------------------- 0.51s 2026-08-26 04:59:50.408216 | instance | Generate lvm.conf ------------------------------------------------------- 0.28s 2026-08-26 04:59:50.408394 | instance | Ensure hostname inside hosts file --------------------------------------- 0.24s 2026-08-26 04:59:50.408569 | instance | Get list of all loopback devices ---------------------------------------- 0.19s 2026-08-26 04:59:50.408746 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s 2026-08-26 04:59:50.465890 | instance | INFO [csi > prepare] Executed: Successful 2026-08-26 04:59:50.476749 | instance | INFO [csi > converge] Executing 2026-08-26 04:59:51.917883 | instance | 2026-08-26 04:59:51.918159 | instance | PLAY [Debug CSI driver value] ************************************************** 2026-08-26 04:59:51.918414 | instance | 2026-08-26 04:59:51.918683 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-26 04:59:51.918952 | instance | Wednesday 26 August 2026 04:59:51 +0000 (0:00:00.007) 0:00:00.007 ****** 2026-08-26 04:59:52.845924 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-08-26 04:59:52.846223 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-08-26 04:59:52.846524 | instance | interpreter could change the meaning of that path. See 2026-08-26 04:59:52.846824 | instance | https://docs.ansible.com/ansible- 2026-08-26 04:59:52.847127 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-08-26 04:59:52.855207 | instance | ok: [instance] 2026-08-26 04:59:52.855460 | instance | 2026-08-26 04:59:52.855736 | instance | TASK [Display CSI driver value and environment variable] *********************** 2026-08-26 04:59:52.856010 | instance | Wednesday 26 August 2026 04:59:52 +0000 (0:00:00.937) 0:00:00.945 ****** 2026-08-26 04:59:52.896597 | instance | ok: [instance] => { 2026-08-26 04:59:52.896900 | instance | "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER=" 2026-08-26 04:59:52.897166 | instance | } 2026-08-26 04:59:52.897416 | instance | 2026-08-26 04:59:52.897684 | instance | PLAY [all] ********************************************************************* 2026-08-26 04:59:52.897966 | instance | 2026-08-26 04:59:52.898233 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-26 04:59:52.898506 | instance | Wednesday 26 August 2026 04:59:52 +0000 (0:00:00.041) 0:00:00.987 ****** 2026-08-26 04:59:53.771446 | instance | ok: [instance] 2026-08-26 04:59:53.771677 | instance | 2026-08-26 04:59:53.771957 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-08-26 04:59:53.772229 | instance | Wednesday 26 August 2026 04:59:53 +0000 (0:00:00.874) 0:00:01.861 ****** 2026-08-26 04:59:53.944683 | instance | ok: [instance] 2026-08-26 04:59:53.945055 | instance | 2026-08-26 04:59:53.945334 | instance | PLAY [Deploy Ceph monitors & managers] ***************************************** 2026-08-26 04:59:53.945595 | instance | 2026-08-26 04:59:53.945916 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-26 04:59:53.946264 | instance | Wednesday 26 August 2026 04:59:53 +0000 (0:00:00.173) 0:00:02.034 ****** 2026-08-26 04:59:54.801538 | instance | ok: [instance] 2026-08-26 04:59:54.801809 | instance | 2026-08-26 04:59:54.802092 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-26 04:59:54.802375 | instance | Wednesday 26 August 2026 04:59:54 +0000 (0:00:00.856) 0:00:02.891 ****** 2026-08-26 04:59:55.063384 | instance | ok: [instance] 2026-08-26 04:59:55.063637 | instance | 2026-08-26 04:59:55.063918 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-26 04:59:55.064192 | instance | Wednesday 26 August 2026 04:59:55 +0000 (0:00:00.262) 0:00:03.153 ****** 2026-08-26 04:59:55.099598 | instance | skipping: [instance] 2026-08-26 04:59:55.099729 | instance | 2026-08-26 04:59:55.100022 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-08-26 04:59:55.100289 | instance | Wednesday 26 August 2026 04:59:55 +0000 (0:00:00.036) 0:00:03.189 ****** 2026-08-26 04:59:55.403651 | instance | changed: [instance] 2026-08-26 04:59:55.403831 | instance | 2026-08-26 04:59:55.404119 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-26 04:59:55.404403 | instance | Wednesday 26 August 2026 04:59:55 +0000 (0:00:00.304) 0:00:03.493 ****** 2026-08-26 04:59:55.461649 | instance | ok: [instance] => { 2026-08-26 04:59:55.461939 | instance | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-08-26 04:59:55.462205 | instance | } 2026-08-26 04:59:55.462453 | instance | 2026-08-26 04:59:55.462724 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-26 04:59:55.462992 | instance | Wednesday 26 August 2026 04:59:55 +0000 (0:00:00.057) 0:00:03.551 ****** 2026-08-26 04:59:56.135605 | instance | changed: [instance] 2026-08-26 04:59:56.135969 | instance | 2026-08-26 04:59:56.136317 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-26 04:59:56.136646 | instance | Wednesday 26 August 2026 04:59:56 +0000 (0:00:00.673) 0:00:04.225 ****** 2026-08-26 04:59:56.186092 | instance | skipping: [instance] 2026-08-26 04:59:56.186311 | instance | 2026-08-26 04:59:56.186527 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-26 04:59:56.186735 | instance | Wednesday 26 August 2026 04:59:56 +0000 (0:00:00.049) 0:00:04.275 ****** 2026-08-26 04:59:56.237968 | instance | skipping: [instance] 2026-08-26 04:59:56.238072 | instance | 2026-08-26 04:59:56.238194 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-26 04:59:56.238348 | instance | Wednesday 26 August 2026 04:59:56 +0000 (0:00:00.051) 0:00:04.326 ****** 2026-08-26 04:59:56.443683 | instance | ok: [instance] 2026-08-26 04:59:56.443746 | instance | 2026-08-26 04:59:56.444026 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-26 04:59:56.444150 | instance | Wednesday 26 August 2026 04:59:56 +0000 (0:00:00.207) 0:00:04.533 ****** 2026-08-26 04:59:57.599341 | instance | ok: [instance] 2026-08-26 04:59:57.599382 | instance | 2026-08-26 04:59:57.599388 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-26 04:59:57.599393 | instance | Wednesday 26 August 2026 04:59:57 +0000 (0:00:01.155) 0:00:05.688 ****** 2026-08-26 04:59:57.661919 | instance | ok: [instance] => { 2026-08-26 04:59:57.661988 | instance | "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz" 2026-08-26 04:59:57.662020 | instance | } 2026-08-26 04:59:57.662030 | instance | 2026-08-26 04:59:57.662046 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-26 04:59:57.662129 | instance | Wednesday 26 August 2026 04:59:57 +0000 (0:00:00.062) 0:00:05.751 ****** 2026-08-26 04:59:58.368950 | instance | changed: [instance] 2026-08-26 04:59:58.369025 | instance | 2026-08-26 04:59:58.369297 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-26 04:59:58.369336 | instance | Wednesday 26 August 2026 04:59:58 +0000 (0:00:00.707) 0:00:06.459 ****** 2026-08-26 05:00:01.141111 | instance | changed: [instance] 2026-08-26 05:00:01.141219 | instance | 2026-08-26 05:00:01.141284 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-08-26 05:00:01.141487 | instance | Wednesday 26 August 2026 05:00:01 +0000 (0:00:02.771) 0:00:09.231 ****** 2026-08-26 05:00:01.179394 | instance | skipping: [instance] 2026-08-26 05:00:01.179778 | instance | 2026-08-26 05:00:01.179805 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-08-26 05:00:01.179811 | instance | Wednesday 26 August 2026 05:00:01 +0000 (0:00:00.037) 0:00:09.268 ****** 2026-08-26 05:00:01.214582 | instance | skipping: [instance] 2026-08-26 05:00:01.214630 | instance | 2026-08-26 05:00:01.214636 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-08-26 05:00:01.214642 | instance | Wednesday 26 August 2026 05:00:01 +0000 (0:00:00.034) 0:00:09.303 ****** 2026-08-26 05:00:01.251456 | instance | skipping: [instance] 2026-08-26 05:00:01.252366 | instance | 2026-08-26 05:00:01.252422 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-08-26 05:00:01.252435 | instance | Wednesday 26 August 2026 05:00:01 +0000 (0:00:00.036) 0:00:09.340 ****** 2026-08-26 05:00:06.079864 | instance | changed: [instance] 2026-08-26 05:00:06.079968 | instance | 2026-08-26 05:00:06.080243 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] *** 2026-08-26 05:00:06.080277 | instance | Wednesday 26 August 2026 05:00:06 +0000 (0:00:04.829) 0:00:14.169 ****** 2026-08-26 05:00:06.664961 | instance | changed: [instance] 2026-08-26 05:00:06.664998 | instance | 2026-08-26 05:00:06.665005 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] ******* 2026-08-26 05:00:06.665010 | instance | Wednesday 26 August 2026 05:00:06 +0000 (0:00:00.584) 0:00:14.754 ****** 2026-08-26 05:00:07.542214 | instance | changed: [instance] => (item={'path': '/etc/containerd'}) 2026-08-26 05:00:07.542320 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'}) 2026-08-26 05:00:07.543048 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'}) 2026-08-26 05:00:07.543176 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'}) 2026-08-26 05:00:07.543183 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'}) 2026-08-26 05:00:07.543188 | instance | 2026-08-26 05:00:07.543197 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] ********** 2026-08-26 05:00:07.543202 | instance | Wednesday 26 August 2026 05:00:07 +0000 (0:00:00.877) 0:00:15.632 ****** 2026-08-26 05:00:08.102398 | instance | changed: [instance] 2026-08-26 05:00:08.103103 | instance | 2026-08-26 05:00:08.103119 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ******** 2026-08-26 05:00:08.103124 | instance | Wednesday 26 August 2026 05:00:08 +0000 (0:00:00.543) 0:00:16.175 ****** 2026-08-26 05:00:08.103129 | instance | 2026-08-26 05:00:08.103133 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-08-26 05:00:08.103137 | instance | Wednesday 26 August 2026 05:00:08 +0000 (0:00:00.016) 0:00:16.192 ****** 2026-08-26 05:00:08.961040 | instance | ok: [instance] 2026-08-26 05:00:08.961446 | instance | 2026-08-26 05:00:08.961480 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] ********** 2026-08-26 05:00:08.961486 | instance | Wednesday 26 August 2026 05:00:08 +0000 (0:00:00.858) 0:00:17.050 ****** 2026-08-26 05:00:09.381357 | instance | changed: [instance] 2026-08-26 05:00:09.381445 | instance | 2026-08-26 05:00:09.381711 | instance | TASK [vexxhost.containers.containerd : Enable and start service] *************** 2026-08-26 05:00:09.381728 | instance | Wednesday 26 August 2026 05:00:09 +0000 (0:00:00.420) 0:00:17.471 ****** 2026-08-26 05:00:09.944081 | instance | changed: [instance] 2026-08-26 05:00:09.944119 | instance | 2026-08-26 05:00:09.944124 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-26 05:00:09.944129 | instance | Wednesday 26 August 2026 05:00:09 +0000 (0:00:00.562) 0:00:18.033 ****** 2026-08-26 05:00:10.145605 | instance | ok: [instance] 2026-08-26 05:00:10.145673 | instance | 2026-08-26 05:00:10.145967 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-26 05:00:10.146032 | instance | Wednesday 26 August 2026 05:00:10 +0000 (0:00:00.201) 0:00:18.235 ****** 2026-08-26 05:00:10.207228 | instance | ok: [instance] => { 2026-08-26 05:00:10.207907 | instance | "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz" 2026-08-26 05:00:10.208200 | instance | } 2026-08-26 05:00:10.208209 | instance | 2026-08-26 05:00:10.208215 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-26 05:00:10.208221 | instance | Wednesday 26 August 2026 05:00:10 +0000 (0:00:00.061) 0:00:18.296 ****** 2026-08-26 05:00:10.912775 | instance | changed: [instance] 2026-08-26 05:00:10.912906 | instance | 2026-08-26 05:00:10.912922 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-26 05:00:10.913100 | instance | Wednesday 26 August 2026 05:00:10 +0000 (0:00:00.706) 0:00:19.002 ****** 2026-08-26 05:00:15.207289 | instance | changed: [instance] 2026-08-26 05:00:15.207364 | instance | 2026-08-26 05:00:15.207642 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ****************** 2026-08-26 05:00:15.207679 | instance | Wednesday 26 August 2026 05:00:15 +0000 (0:00:04.294) 0:00:23.297 ****** 2026-08-26 05:00:16.216989 | instance | ok: [instance] 2026-08-26 05:00:16.217081 | instance | 2026-08-26 05:00:16.217372 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] *************** 2026-08-26 05:00:16.217409 | instance | Wednesday 26 August 2026 05:00:16 +0000 (0:00:01.009) 0:00:24.307 ****** 2026-08-26 05:00:16.556723 | instance | changed: [instance] 2026-08-26 05:00:16.557137 | instance | 2026-08-26 05:00:16.557174 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] ***** 2026-08-26 05:00:16.557180 | instance | Wednesday 26 August 2026 05:00:16 +0000 (0:00:00.339) 0:00:24.646 ****** 2026-08-26 05:00:16.997857 | instance | changed: [instance] 2026-08-26 05:00:16.998205 | instance | 2026-08-26 05:00:16.998221 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] *********** 2026-08-26 05:00:16.998227 | instance | Wednesday 26 August 2026 05:00:16 +0000 (0:00:00.440) 0:00:25.087 ****** 2026-08-26 05:00:17.530721 | instance | changed: [instance] => (item={'path': '/etc/docker'}) 2026-08-26 05:00:17.531659 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'}) 2026-08-26 05:00:17.531719 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'}) 2026-08-26 05:00:17.531727 | instance | 2026-08-26 05:00:17.531734 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ****** 2026-08-26 05:00:17.531740 | instance | Wednesday 26 August 2026 05:00:17 +0000 (0:00:00.532) 0:00:25.620 ****** 2026-08-26 05:00:17.964741 | instance | changed: [instance] 2026-08-26 05:00:17.965279 | instance | 2026-08-26 05:00:17.965321 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] *********** 2026-08-26 05:00:17.965329 | instance | Wednesday 26 August 2026 05:00:17 +0000 (0:00:00.434) 0:00:26.054 ****** 2026-08-26 05:00:18.411091 | instance | changed: [instance] 2026-08-26 05:00:18.411191 | instance | 2026-08-26 05:00:18.411854 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************ 2026-08-26 05:00:18.411889 | instance | Wednesday 26 August 2026 05:00:18 +0000 (0:00:00.430) 0:00:26.484 ****** 2026-08-26 05:00:18.411895 | instance | 2026-08-26 05:00:18.411900 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-08-26 05:00:18.411904 | instance | Wednesday 26 August 2026 05:00:18 +0000 (0:00:00.016) 0:00:26.501 ****** 2026-08-26 05:00:19.113821 | instance | ok: [instance] 2026-08-26 05:00:19.114221 | instance | 2026-08-26 05:00:19.114258 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ****************** 2026-08-26 05:00:19.114269 | instance | Wednesday 26 August 2026 05:00:19 +0000 (0:00:00.702) 0:00:27.203 ****** 2026-08-26 05:00:19.987176 | instance | changed: [instance] 2026-08-26 05:00:19.987274 | instance | 2026-08-26 05:00:19.987537 | instance | TASK [vexxhost.containers.docker : Enable and start service] ******************* 2026-08-26 05:00:19.987553 | instance | Wednesday 26 August 2026 05:00:19 +0000 (0:00:00.873) 0:00:28.077 ****** 2026-08-26 05:00:20.531076 | instance | changed: [instance] 2026-08-26 05:00:20.531104 | instance | 2026-08-26 05:00:20.531110 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ****** 2026-08-26 05:00:20.531115 | instance | Wednesday 26 August 2026 05:00:20 +0000 (0:00:00.543) 0:00:28.620 ****** 2026-08-26 05:00:20.584856 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml) 2026-08-26 05:00:20.585237 | instance | 2026-08-26 05:00:20.585277 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ******************************** 2026-08-26 05:00:20.585284 | instance | Wednesday 26 August 2026 05:00:20 +0000 (0:00:00.053) 0:00:28.674 ****** 2026-08-26 05:00:24.861842 | instance | changed: [instance] 2026-08-26 05:00:24.861916 | instance | 2026-08-26 05:00:24.861930 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] ********************* 2026-08-26 05:00:24.862076 | instance | Wednesday 26 August 2026 05:00:24 +0000 (0:00:04.277) 0:00:32.951 ****** 2026-08-26 05:00:25.512704 | instance | ok: [instance] => (item=chronyd) 2026-08-26 05:00:25.512951 | instance | ok: [instance] => (item=sshd) 2026-08-26 05:00:25.513204 | instance | 2026-08-26 05:00:25.513480 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ****************************** 2026-08-26 05:00:25.513793 | instance | Wednesday 26 August 2026 05:00:25 +0000 (0:00:00.650) 0:00:33.602 ****** 2026-08-26 05:00:25.849341 | instance | changed: [instance] 2026-08-26 05:00:25.849444 | instance | 2026-08-26 05:00:25.849608 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ******************** 2026-08-26 05:00:25.849814 | instance | Wednesday 26 August 2026 05:00:25 +0000 (0:00:00.336) 0:00:33.939 ****** 2026-08-26 05:00:26.063820 | instance | ok: [instance] 2026-08-26 05:00:26.064063 | instance | 2026-08-26 05:00:26.064304 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] **************** 2026-08-26 05:00:26.064582 | instance | Wednesday 26 August 2026 05:00:26 +0000 (0:00:00.214) 0:00:34.153 ****** 2026-08-26 05:00:26.520692 | instance | changed: [instance] 2026-08-26 05:00:26.520944 | instance | 2026-08-26 05:00:26.521249 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] *** 2026-08-26 05:00:26.521541 | instance | Wednesday 26 August 2026 05:00:26 +0000 (0:00:00.456) 0:00:34.610 ****** 2026-08-26 05:00:26.888528 | instance | changed: [instance] 2026-08-26 05:00:26.888752 | instance | 2026-08-26 05:00:26.889047 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] ************************* 2026-08-26 05:00:26.889338 | instance | Wednesday 26 August 2026 05:00:26 +0000 (0:00:00.367) 0:00:34.977 ****** 2026-08-26 05:00:27.005609 | instance | ok: [instance] 2026-08-26 05:00:27.005834 | instance | 2026-08-26 05:00:27.006179 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] ******************* 2026-08-26 05:00:27.006476 | instance | Wednesday 26 August 2026 05:00:26 +0000 (0:00:00.117) 0:00:35.095 ****** 2026-08-26 05:00:27.224766 | instance | ok: [instance] => (item=instance) 2026-08-26 05:00:27.224971 | instance | 2026-08-26 05:00:27.224984 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ******** 2026-08-26 05:00:27.224994 | instance | Wednesday 26 August 2026 05:00:27 +0000 (0:00:00.218) 0:00:35.313 ****** 2026-08-26 05:00:27.272849 | instance | ok: [instance] 2026-08-26 05:00:27.273257 | instance | 2026-08-26 05:00:27.273297 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] *********************************** 2026-08-26 05:00:27.273303 | instance | Wednesday 26 August 2026 05:00:27 +0000 (0:00:00.049) 0:00:35.362 ****** 2026-08-26 05:00:27.346138 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance 2026-08-26 05:00:27.346245 | instance | 2026-08-26 05:00:27.346378 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] ************* 2026-08-26 05:00:27.346519 | instance | Wednesday 26 August 2026 05:00:27 +0000 (0:00:00.073) 0:00:35.436 ****** 2026-08-26 05:00:27.641524 | instance | changed: [instance] 2026-08-26 05:00:27.641604 | instance | 2026-08-26 05:00:27.641916 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ****************** 2026-08-26 05:00:27.641957 | instance | Wednesday 26 August 2026 05:00:27 +0000 (0:00:00.295) 0:00:35.731 ****** 2026-08-26 05:00:28.324593 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True}) 2026-08-26 05:00:28.324667 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0}) 2026-08-26 05:00:28.325195 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False}) 2026-08-26 05:00:28.325236 | instance | 2026-08-26 05:00:28.325243 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] ******************************* 2026-08-26 05:00:28.325248 | instance | Wednesday 26 August 2026 05:00:28 +0000 (0:00:00.683) 0:00:36.414 ****** 2026-08-26 05:01:49.796887 | instance | ok: [instance] 2026-08-26 05:01:49.796990 | instance | 2026-08-26 05:01:49.797258 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] *************** 2026-08-26 05:01:49.797306 | instance | Wednesday 26 August 2026 05:01:49 +0000 (0:01:21.472) 0:01:57.886 ****** 2026-08-26 05:01:50.006896 | instance | changed: [instance] 2026-08-26 05:01:50.006996 | instance | 2026-08-26 05:01:50.007131 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] ********************************** 2026-08-26 05:01:50.007255 | instance | Wednesday 26 August 2026 05:01:50 +0000 (0:00:00.209) 0:01:58.096 ****** 2026-08-26 05:01:50.074726 | instance | ok: [instance] 2026-08-26 05:01:50.074847 | instance | 2026-08-26 05:01:50.074971 | instance | TASK [Install Ceph host] ******************************************************* 2026-08-26 05:01:50.075090 | instance | Wednesday 26 August 2026 05:01:50 +0000 (0:00:00.067) 0:01:58.164 ****** 2026-08-26 05:01:50.152326 | instance | included: vexxhost.ceph.cephadm_host for instance 2026-08-26 05:01:50.152582 | instance | 2026-08-26 05:01:50.152878 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ****** 2026-08-26 05:01:50.153163 | instance | Wednesday 26 August 2026 05:01:50 +0000 (0:00:00.077) 0:01:58.242 ****** 2026-08-26 05:01:51.679221 | instance | ok: [instance] 2026-08-26 05:01:51.679481 | instance | 2026-08-26 05:01:51.679786 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] *** 2026-08-26 05:01:51.680069 | instance | Wednesday 26 August 2026 05:01:51 +0000 (0:00:01.526) 0:01:59.769 ****** 2026-08-26 05:01:51.733750 | instance | ok: [instance] => (item=instance) 2026-08-26 05:01:51.734016 | instance | 2026-08-26 05:01:51.734329 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] *********** 2026-08-26 05:01:51.734695 | instance | Wednesday 26 August 2026 05:01:51 +0000 (0:00:00.054) 0:01:59.823 ****** 2026-08-26 05:01:52.077967 | instance | ok: [instance] 2026-08-26 05:01:52.078254 | instance | 2026-08-26 05:01:52.078570 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] *********************** 2026-08-26 05:01:52.078864 | instance | Wednesday 26 August 2026 05:01:52 +0000 (0:00:00.344) 0:02:00.167 ****** 2026-08-26 05:01:54.312015 | instance | ok: [instance] 2026-08-26 05:01:54.312246 | instance | 2026-08-26 05:01:54.312530 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ****************** 2026-08-26 05:01:54.312806 | instance | Wednesday 26 August 2026 05:01:54 +0000 (0:00:02.234) 0:02:02.401 ****** 2026-08-26 05:02:36.999782 | instance | An exception occurred during task execution. To see the full traceback, use -vvv. The error was: [errno 5] RADOS I/O error (error connecting to the cluster) 2026-08-26 05:02:37.000358 | 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_e719u7wd/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_e719u7wd/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_e719u7wd/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_e719u7wd/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-26T05:02:36.842+0000 7fe7d8c83640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAVc45qFmakBiAAANDQXffIIfjvUjyXAY5Z1KTzj9qJHoQTIzoPhSF60vs=: Malformed input [buffer:3]\n2026-08-26T05:02:36.842+0000 7fe7d8c83640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-26T05:02:36.842+0000 7fe7d8c83640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAVc45qFmakBiAAANDQXffIIfjvUjyXAY5Z1KTzj9qJHoQTIzoPhSF60vs=: Malformed input [buffer:3]\n2026-08-26T05:02:36.842+0000 7fe7d8c83640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-26T05:02:36.842+0000 7fe7d8c83640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAVc45qFmakBiAAANDQXffIIfjvUjyXAY5Z1KTzj9qJHoQTIzoPhSF60vs=: Malformed input [buffer:3]\n2026-08-26T05:02:36.842+0000 7fe7d8c83640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-26T05:02:36.842+0000 7fe7d8c83640 -1 monclient: keyring not found\n[errno 5] RADOS I/O error (error connecting to the cluster)\n\n", "module_stdout": "", "msg": "MODULE FAILURE\nSee stdout/stderr for the exact error", "rc": 1} 2026-08-26 05:02:37.002185 | instance | 2026-08-26 05:02:37.002485 | instance | PLAY RECAP ********************************************************************* 2026-08-26 05:02:37.002810 | instance | instance : ok=55 changed=26 unreachable=0 failed=1 skipped=6 rescued=0 ignored=0 2026-08-26 05:02:37.003079 | instance | 2026-08-26 05:02:37.003368 | instance | Wednesday 26 August 2026 05:02:36 +0000 (0:00:42.690) 0:02:45.092 ****** 2026-08-26 05:02:37.003641 | instance | =============================================================================== 2026-08-26 05:02:37.003930 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 81.47s 2026-08-26 05:02:37.004220 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 42.69s 2026-08-26 05:02:37.004520 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 4.83s 2026-08-26 05:02:37.004811 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.29s 2026-08-26 05:02:37.005259 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 4.28s 2026-08-26 05:02:37.005525 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.77s 2026-08-26 05:02:37.005708 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.23s 2026-08-26 05:02:37.005893 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.56s 2026-08-26 05:02:37.006084 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.53s 2026-08-26 05:02:37.006258 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.16s 2026-08-26 05:02:37.006427 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.01s 2026-08-26 05:02:37.006588 | instance | Gathering Facts --------------------------------------------------------- 0.94s 2026-08-26 05:02:37.006759 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.88s 2026-08-26 05:02:37.006927 | instance | Gathering Facts --------------------------------------------------------- 0.87s 2026-08-26 05:02:37.007097 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 0.87s 2026-08-26 05:02:37.007265 | instance | Gathering Facts --------------------------------------------------------- 0.86s 2026-08-26 05:02:37.007434 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.71s 2026-08-26 05:02:37.007603 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.71s 2026-08-26 05:02:37.007857 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.68s 2026-08-26 05:02:37.008044 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.67s 2026-08-26 05:02:37.089178 | instance | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-08-26 05:02:37.089322 | instance | ERROR [csi > converge] Executed: Failed 2026-08-26 05:02:37.089455 | instance | ERROR Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-08-26 05:02:37.644301 | instance | ERROR 2026-08-26 05:02:37.644541 | instance | { 2026-08-26 05:02:37.644608 | instance | "delta": "0:03:31.023631", 2026-08-26 05:02:37.644642 | instance | "end": "2026-08-26 05:02:37.139589", 2026-08-26 05:02:37.644675 | instance | "msg": "non-zero return code", 2026-08-26 05:02:37.644708 | instance | "rc": 2, 2026-08-26 05:02:37.644738 | instance | "start": "2026-08-26 04:59:06.115958" 2026-08-26 05:02:37.644763 | instance | } failure 2026-08-26 05:02:37.651553 | 2026-08-26 05:02:37.651647 | PLAY RECAP 2026-08-26 05:02:37.651707 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-08-26 05:02:37.651738 | 2026-08-26 05:02:37.849782 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-26 05:02:37.854742 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-08-26 05:02:38.493313 | 2026-08-26 05:02:38.493449 | PLAY [all] 2026-08-26 05:02:38.509072 | 2026-08-26 05:02:38.509170 | TASK [gather-host-logs : creating directory for system status] 2026-08-26 05:02:38.838196 | instance | changed 2026-08-26 05:02:38.845867 | 2026-08-26 05:02:38.845951 | TASK [gather-host-logs : Get logs for each host] 2026-08-26 05:02:39.188572 | instance | + systemd-cgls --full --all --no-pager 2026-08-26 05:02:39.204142 | instance | + ip addr 2026-08-26 05:02:39.206651 | instance | + ip route 2026-08-26 05:02:39.208379 | instance | + lsblk 2026-08-26 05:02:39.213853 | instance | + mount 2026-08-26 05:02:39.216468 | instance | + docker images 2026-08-26 05:02:39.238382 | instance | + brctl show 2026-08-26 05:02:39.238974 | instance | /bin/bash: line 8: brctl: command not found 2026-08-26 05:02:39.239303 | instance | + ps aux --sort=-%mem 2026-08-26 05:02:39.263817 | instance | + dpkg -l 2026-08-26 05:02:39.273287 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-08-26 05:02:39.273890 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-08-26 05:02:39.293888 | instance | + '[' '!' -z '' ']' 2026-08-26 05:02:39.379508 | instance | ok: Runtime: 0:00:00.110900 2026-08-26 05:02:39.386173 | 2026-08-26 05:02:39.386244 | TASK [gather-host-logs : Downloads logs to executor] 2026-08-26 05:02:39.998136 | instance | changed: 2026-08-26 05:02:39.998306 | instance | created directory /var/lib/zuul/builds/a3499b909caa4e9ebf8fbf44b36a4f9d/work/logs/instance 2026-08-26 05:02:39.998334 | instance | cd+++++++++ system/ 2026-08-26 05:02:39.998356 | instance | >f+++++++++ system/brctl-show.txt 2026-08-26 05:02:39.998376 | instance | >f+++++++++ system/docker-images.txt 2026-08-26 05:02:39.998396 | instance | >f+++++++++ system/ip-addr.txt 2026-08-26 05:02:39.998418 | instance | >f+++++++++ system/ip-route.txt 2026-08-26 05:02:39.998438 | instance | >f+++++++++ system/lsblk.txt 2026-08-26 05:02:39.998458 | instance | >f+++++++++ system/mount.txt 2026-08-26 05:02:39.998477 | instance | >f+++++++++ system/packages.txt 2026-08-26 05:02:39.998495 | instance | >f+++++++++ system/ps.txt 2026-08-26 05:02:39.998516 | instance | >f+++++++++ system/systemd-cgls.txt 2026-08-26 05:02:40.007645 | 2026-08-26 05:02:40.007733 | LOOP [helm-release-status : creating directory for helm release status] 2026-08-26 05:02:40.189026 | instance | changed: "values" 2026-08-26 05:02:40.353314 | instance | changed: "releases" 2026-08-26 05:02:40.372771 | 2026-08-26 05:02:40.372979 | TASK [helm-release-status : Gather get release status for helm charts] 2026-08-26 05:02:40.575284 | instance | /bin/bash: line 3: kubectl: command not found 2026-08-26 05:02:40.909278 | instance | ok: Runtime: 0:00:00.005216 2026-08-26 05:02:40.916034 | 2026-08-26 05:02:40.916128 | TASK [helm-release-status : Downloads logs to executor] 2026-08-26 05:02:41.394443 | instance | changed: 2026-08-26 05:02:41.394655 | instance | cd+++++++++ helm/ 2026-08-26 05:02:41.394694 | instance | cd+++++++++ helm/releases/ 2026-08-26 05:02:41.394726 | instance | cd+++++++++ helm/values/ 2026-08-26 05:02:41.408383 | 2026-08-26 05:02:41.408564 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-08-26 05:02:41.606506 | instance | changed 2026-08-26 05:02:41.612460 | 2026-08-26 05:02:41.612534 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-08-26 05:02:41.851650 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-26 05:02:41.851819 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-26 05:02:41.856991 | instance | environment: line 1: kubectl: command not found 2026-08-26 05:02:41.858340 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-26 05:02:41.858971 | instance | environment: line 1: kubectl: command not found 2026-08-26 05:02:41.859975 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-26 05:02:41.861438 | instance | environment: line 1: kubectl: command not found 2026-08-26 05:02:41.862674 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-26 05:02:41.864201 | instance | environment: line 1: kubectl: command not found 2026-08-26 05:02:41.865033 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-26 05:02:41.865750 | instance | environment: line 1: kubectl: command not found 2026-08-26 05:02:41.867602 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-26 05:02:42.148275 | instance | ok: Runtime: 0:00:00.023797 2026-08-26 05:02:42.154189 | 2026-08-26 05:02:42.154258 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-08-26 05:02:42.349360 | instance | changed 2026-08-26 05:02:42.356180 | 2026-08-26 05:02:42.356274 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-08-26 05:02:42.559388 | instance | environment: line 5: kubectl: command not found 2026-08-26 05:02:42.560499 | instance | xargs: xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args valuewarning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-26 05:02:42.560531 | instance | 2026-08-26 05:02:42.560634 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-26 05:02:42.893064 | instance | ok: Runtime: 0:00:00.008376 2026-08-26 05:02:42.900714 | 2026-08-26 05:02:42.900786 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-08-26 05:02:43.379369 | instance | changed: 2026-08-26 05:02:43.379586 | instance | cd+++++++++ objects/ 2026-08-26 05:02:43.379628 | instance | cd+++++++++ objects/cluster/ 2026-08-26 05:02:43.379659 | instance | cd+++++++++ objects/namespaced/ 2026-08-26 05:02:43.390054 | 2026-08-26 05:02:43.390217 | TASK [gather-pod-logs : creating directory for pod logs] 2026-08-26 05:02:43.586944 | instance | changed 2026-08-26 05:02:43.594246 | 2026-08-26 05:02:43.594401 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-08-26 05:02:43.794520 | instance | changed 2026-08-26 05:02:43.800206 | 2026-08-26 05:02:43.800273 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-08-26 05:02:44.005825 | instance | environment: line 3: kubectl: command not found 2026-08-26 05:02:44.336704 | instance | ok: Runtime: 0:00:00.007998 2026-08-26 05:02:44.343140 | 2026-08-26 05:02:44.343206 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-08-26 05:02:44.828514 | instance | changed: 2026-08-26 05:02:44.828831 | instance | cd+++++++++ pod-logs/ 2026-08-26 05:02:44.828901 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-08-26 05:02:44.843318 | 2026-08-26 05:02:44.843446 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-08-26 05:02:45.044284 | instance | changed 2026-08-26 05:02:45.049703 | 2026-08-26 05:02:45.049773 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-08-26 05:02:45.259567 | instance | /bin/bash: line 2: kubectl: command not found 2026-08-26 05:02:45.583895 | instance | ok: Runtime: 0:00:00.035860 2026-08-26 05:02:45.588568 | 2026-08-26 05:02:45.588630 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-08-26 05:02:45.812877 | instance | /bin/bash: line 2: kubectl: command not found 2026-08-26 05:02:45.841607 | instance | ceph-mgr endpoints: 2026-08-26 05:02:46.139404 | instance | ok: Runtime: 0:00:00.035616 2026-08-26 05:02:46.144741 | 2026-08-26 05:02:46.144815 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-08-26 05:02:46.352139 | instance | /bin/bash: line 4: kubectl: command not found 2026-08-26 05:02:46.677262 | instance | ok: Runtime: 0:00:00.037184 2026-08-26 05:02:46.684283 | 2026-08-26 05:02:46.684351 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-08-26 05:02:47.168794 | instance | changed: cd+++++++++ prometheus/ 2026-08-26 05:02:47.178551 | 2026-08-26 05:02:47.178617 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-08-26 05:02:47.374756 | instance | changed 2026-08-26 05:02:47.379644 | 2026-08-26 05:02:47.379712 | TASK [gather-selenium-data : Get selenium data] 2026-08-26 05:02:47.625814 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-08-26 05:02:47.627421 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-08-26 05:02:47.919370 | instance | ERROR 2026-08-26 05:02:47.919590 | instance | { 2026-08-26 05:02:47.919632 | instance | "delta": "0:00:00.006581", 2026-08-26 05:02:47.919661 | instance | "end": "2026-08-26 05:02:47.627781", 2026-08-26 05:02:47.919690 | instance | "msg": "non-zero return code", 2026-08-26 05:02:47.919717 | instance | "rc": 1, 2026-08-26 05:02:47.919743 | instance | "start": "2026-08-26 05:02:47.621200" 2026-08-26 05:02:47.919768 | instance | } 2026-08-26 05:02:47.919800 | instance | ERROR: Ignoring Errors 2026-08-26 05:02:47.926521 | 2026-08-26 05:02:47.926606 | TASK [gather-selenium-data : Downloads logs to executor] 2026-08-26 05:02:48.398698 | instance | changed: cd+++++++++ selenium/ 2026-08-26 05:02:48.405085 | 2026-08-26 05:02:48.405136 | PLAY RECAP 2026-08-26 05:02:48.405180 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-08-26 05:02:48.405203 | 2026-08-26 05:02:48.532677 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-08-26 05:02:48.534805 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-26 05:02:49.101127 | 2026-08-26 05:02:49.101244 | PLAY [all] 2026-08-26 05:02:49.112403 | 2026-08-26 05:02:49.112477 | TASK [fetch-output : Set log path for multiple nodes] 2026-08-26 05:02:49.147811 | instance | skipping: Conditional result was False 2026-08-26 05:02:49.156618 | 2026-08-26 05:02:49.156695 | TASK [fetch-output : Set log path for single node] 2026-08-26 05:02:49.198546 | instance | ok 2026-08-26 05:02:49.204276 | 2026-08-26 05:02:49.204344 | LOOP [fetch-output : Ensure local output dirs] 2026-08-26 05:02:49.571429 | instance -> localhost | ok: "/var/lib/zuul/builds/a3499b909caa4e9ebf8fbf44b36a4f9d/work/logs" 2026-08-26 05:02:49.775171 | instance -> localhost | changed: "/var/lib/zuul/builds/a3499b909caa4e9ebf8fbf44b36a4f9d/work/artifacts" 2026-08-26 05:02:49.983061 | instance -> localhost | changed: "/var/lib/zuul/builds/a3499b909caa4e9ebf8fbf44b36a4f9d/work/docs" 2026-08-26 05:02:49.997068 | 2026-08-26 05:02:49.997189 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-26 05:02:50.622770 | instance | changed: .d..t...... ./ 2026-08-26 05:02:50.623149 | instance | changed: All items complete 2026-08-26 05:02:50.623214 | 2026-08-26 05:02:51.123172 | instance | changed: .d..t...... ./ 2026-08-26 05:02:51.559803 | instance | changed: .d..t...... ./ 2026-08-26 05:02:51.578013 | 2026-08-26 05:02:51.578148 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-26 05:02:51.985033 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.006733 2026-08-26 05:02:52.199241 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007737 2026-08-26 05:02:52.219317 | 2026-08-26 05:02:52.219479 | PLAY [all] 2026-08-26 05:02:52.226405 | 2026-08-26 05:02:52.226511 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-26 05:02:52.630630 | instance | changed 2026-08-26 05:02:52.636818 | 2026-08-26 05:02:52.636875 | PLAY RECAP 2026-08-26 05:02:52.636923 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-26 05:02:52.636998 | 2026-08-26 05:02:52.806233 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-26 05:02:52.812328 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-26 05:02:53.384655 | 2026-08-26 05:02:53.385235 | PLAY [localhost] 2026-08-26 05:02:53.395221 | 2026-08-26 05:02:53.395295 | TASK [Generate Zuul manifest] 2026-08-26 05:02:53.416722 | localhost | ok 2026-08-26 05:02:53.433849 | 2026-08-26 05:02:53.433932 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-26 05:02:53.791220 | localhost | changed 2026-08-26 05:02:53.803128 | 2026-08-26 05:02:53.803216 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-26 05:02:53.835645 | localhost | ok 2026-08-26 05:02:53.844079 | 2026-08-26 05:02:53.844146 | TASK [Upload logs] 2026-08-26 05:02:53.865292 | localhost | ok 2026-08-26 05:02:53.926342 | 2026-08-26 05:02:53.926489 | TASK [Set zuul-log-path fact] 2026-08-26 05:02:53.948820 | localhost | ok 2026-08-26 05:02:53.961575 | 2026-08-26 05:02:53.961644 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-26 05:02:53.992697 | localhost | ok 2026-08-26 05:02:54.001275 | 2026-08-26 05:02:54.001345 | TASK [upload-logs : Create log directories] 2026-08-26 05:02:54.372919 | localhost | changed 2026-08-26 05:02:54.379333 | 2026-08-26 05:02:54.379404 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-26 05:02:54.757859 | localhost -> localhost | ok: Runtime: 0:00:00.005832 2026-08-26 05:02:54.764351 | 2026-08-26 05:02:54.764436 | TASK [upload-logs : Upload logs to log server] 2026-08-26 05:02:55.213982 | localhost | Output suppressed because no_log was given 2026-08-26 05:02:55.251388 | 2026-08-26 05:02:55.251522 | LOOP [upload-logs : Compress console log and json output] 2026-08-26 05:02:55.294015 | localhost | skipping: Conditional result was False 2026-08-26 05:02:55.300935 | localhost | skipping: Conditional result was False 2026-08-26 05:02:55.314305 | 2026-08-26 05:02:55.314437 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-26 05:02:55.355835 | localhost | skipping: Conditional result was False 2026-08-26 05:02:55.356276 | 2026-08-26 05:02:55.359552 | localhost | skipping: Conditional result was False 2026-08-26 05:02:55.367578 | 2026-08-26 05:02:55.367703 | LOOP [upload-logs : Upload console log and json output]