2026-08-22 02:42:20.147227 | Job console starting
2026-08-22 02:42:20.158500 | Updating git repos
2026-08-22 02:42:22.250419 | Cloning repos into workspace
2026-08-22 02:42:36.781473 | Restoring repo states
2026-08-22 02:42:49.356444 | Merging changes
2026-08-22 02:42:50.469101 | Checking out repos
2026-08-22 02:42:51.832207 | Preparing playbooks
2026-08-22 02:42:53.475709 | Running Ansible setup
2026-08-22 02:42:57.190740 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-22 02:42:57.819554 | 
2026-08-22 02:42:57.819679 | PLAY [localhost]
2026-08-22 02:42:57.826986 | 
2026-08-22 02:42:57.827059 | TASK [Gathering Facts]
2026-08-22 02:42:58.682863 | localhost | ok
2026-08-22 02:42:58.692146 | 
2026-08-22 02:42:58.692220 | TASK [Setup log path fact]
2026-08-22 02:42:58.712891 | localhost | ok
2026-08-22 02:42:58.726214 | 
2026-08-22 02:42:58.726280 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-22 02:42:58.756334 | localhost | ok
2026-08-22 02:42:58.763645 | 
2026-08-22 02:42:58.763712 | TASK [emit-job-header : Print job information]
2026-08-22 02:42:58.803867 | # Job Information
2026-08-22 02:42:58.804091 | Ansible Version: 2.16.18
2026-08-22 02:42:58.804167 | Job: atmosphere-molecule-csi-rbd
2026-08-22 02:42:58.804220 | Pipeline: check
2026-08-22 02:42:58.804269 | Executor: 2d72f0692154
2026-08-22 02:42:58.804317 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4093
2026-08-22 02:42:58.804373 | Event ID: 4dafb5d0-9dd2-11f1-8bcd-b5218f66954c
2026-08-22 02:42:58.808791 | 
2026-08-22 02:42:58.808850 | LOOP [emit-job-header : Print node information]
2026-08-22 02:42:58.909738 | localhost | ok:
2026-08-22 02:42:58.909939 | localhost | # Node Information
2026-08-22 02:42:58.909969 | localhost | Inventory Hostname: instance
2026-08-22 02:42:58.909991 | localhost | Hostname: np0000190409
2026-08-22 02:42:58.910011 | localhost | Username: zuul
2026-08-22 02:42:58.910035 | localhost | Distro: Ubuntu 22.04
2026-08-22 02:42:58.910056 | localhost | Provider: yul1
2026-08-22 02:42:58.910075 | localhost | Region: ca-ymq-1
2026-08-22 02:42:58.910094 | localhost | Label: ubuntu-jammy
2026-08-22 02:42:58.910113 | localhost | Product Name: OpenStack Nova
2026-08-22 02:42:58.910132 | localhost | Interface IP: 199.19.213.122
2026-08-22 02:42:58.924656 | 
2026-08-22 02:42:58.924731 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-22 02:42:59.327453 | localhost -> localhost | changed
2026-08-22 02:42:59.335733 | 
2026-08-22 02:42:59.335871 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-22 02:43:00.132834 | localhost -> localhost | changed
2026-08-22 02:43:00.142763 | 
2026-08-22 02:43:00.142839 | PLAY [all]
2026-08-22 02:43:00.152340 | 
2026-08-22 02:43:00.152409 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-22 02:43:00.379224 | instance -> localhost | ok
2026-08-22 02:43:00.390854 | 
2026-08-22 02:43:00.390939 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-22 02:43:00.424362 | instance | ok
2026-08-22 02:43:00.438412 | instance | included: /var/lib/zuul/builds/a136f62cdc8b457c83e2111c69ffdaf6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-22 02:43:00.443918 | 
2026-08-22 02:43:00.443978 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-22 02:43:01.819292 | instance -> localhost | Generating public/private rsa key pair.
2026-08-22 02:43:01.819478 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/a136f62cdc8b457c83e2111c69ffdaf6/work/a136f62cdc8b457c83e2111c69ffdaf6_id_rsa
2026-08-22 02:43:01.819510 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/a136f62cdc8b457c83e2111c69ffdaf6/work/a136f62cdc8b457c83e2111c69ffdaf6_id_rsa.pub
2026-08-22 02:43:01.819533 | instance -> localhost | The key fingerprint is:
2026-08-22 02:43:01.819555 | instance -> localhost | SHA256:MzKRkFnJgQkEra7wWuCEoh1ftGECVfxvbLlnpBmgZJ4 zuul-build-sshkey
2026-08-22 02:43:01.819585 | instance -> localhost | The key's randomart image is:
2026-08-22 02:43:01.819608 | instance -> localhost | +---[RSA 3072]----+
2026-08-22 02:43:01.819647 | instance -> localhost | |.++ooX+o         |
2026-08-22 02:43:01.819670 | instance -> localhost | |  ..=.+.         |
2026-08-22 02:43:01.819691 | instance -> localhost | | .  . *.         |
2026-08-22 02:43:01.819711 | instance -> localhost | |o    +o+o        |
2026-08-22 02:43:01.819731 | instance -> localhost | |=..  +=oS+ .     |
2026-08-22 02:43:01.819773 | instance -> localhost | |*+ o .Eo oB .    |
2026-08-22 02:43:01.819797 | instance -> localhost | |+oo .    o *     |
2026-08-22 02:43:01.819817 | instance -> localhost | |...       + o    |
2026-08-22 02:43:01.819840 | instance -> localhost | |..         o     |
2026-08-22 02:43:01.819861 | instance -> localhost | +----[SHA256]-----+
2026-08-22 02:43:01.819909 | instance -> localhost | ok: Runtime: 0:00:00.938871
2026-08-22 02:43:01.834797 | 
2026-08-22 02:43:01.834920 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-22 02:43:01.863945 | instance | ok
2026-08-22 02:43:01.879361 | instance | included: /var/lib/zuul/builds/a136f62cdc8b457c83e2111c69ffdaf6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-22 02:43:01.898433 | 
2026-08-22 02:43:01.898536 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-22 02:43:01.922889 | instance | skipping: Conditional result was False
2026-08-22 02:43:01.932357 | 
2026-08-22 02:43:01.932458 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-22 02:43:02.362455 | instance | changed
2026-08-22 02:43:02.368613 | 
2026-08-22 02:43:02.368678 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-22 02:43:02.549329 | instance | ok
2026-08-22 02:43:02.556059 | 
2026-08-22 02:43:02.556143 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-22 02:43:03.004207 | instance | changed
2026-08-22 02:43:03.011296 | 
2026-08-22 02:43:03.011362 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-22 02:43:03.472609 | instance | changed
2026-08-22 02:43:03.480050 | 
2026-08-22 02:43:03.480118 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-22 02:43:03.506596 | instance | skipping: Conditional result was False
2026-08-22 02:43:03.520849 | 
2026-08-22 02:43:03.521185 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-22 02:43:03.912424 | instance -> localhost | changed
2026-08-22 02:43:03.926188 | 
2026-08-22 02:43:03.926296 | TASK [add-build-sshkey : Add back temp key]
2026-08-22 02:43:04.202714 | instance -> localhost | Identity added: /var/lib/zuul/builds/a136f62cdc8b457c83e2111c69ffdaf6/work/a136f62cdc8b457c83e2111c69ffdaf6_id_rsa (zuul-build-sshkey)
2026-08-22 02:43:04.203088 | instance -> localhost | ok: Runtime: 0:00:00.018184
2026-08-22 02:43:04.211895 | 
2026-08-22 02:43:04.211986 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-22 02:43:04.521226 | instance | ok
2026-08-22 02:43:04.527851 | 
2026-08-22 02:43:04.527929 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-22 02:43:04.552893 | instance | skipping: Conditional result was False
2026-08-22 02:43:04.566168 | 
2026-08-22 02:43:04.566250 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-22 02:43:04.894631 | instance | ok
2026-08-22 02:43:04.900749 | 
2026-08-22 02:43:04.900812 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-22 02:43:08.112659 | instance | Output suppressed because no_log was given
2026-08-22 02:43:08.124315 | 
2026-08-22 02:43:08.124406 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-22 02:43:08.322209 | instance | ok: "logs"
2026-08-22 02:43:08.322730 | instance | ok: All items complete
2026-08-22 02:43:08.322759 | 
2026-08-22 02:43:08.473756 | instance | ok: "artifacts"
2026-08-22 02:43:08.637785 | instance | ok: "docs"
2026-08-22 02:43:08.656681 | 
2026-08-22 02:43:08.656846 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-22 02:43:08.846215 | instance | changed: "logs"
2026-08-22 02:43:09.001992 | instance | changed: "artifacts"
2026-08-22 02:43:09.153889 | instance | changed: "docs"
2026-08-22 02:43:09.166407 | 
2026-08-22 02:43:09.166549 | PLAY RECAP
2026-08-22 02:43:09.166613 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-22 02:43:09.166653 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-22 02:43:09.166684 | 
2026-08-22 02:43:09.322690 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-22 02:43:09.326834 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-22 02:43:10.001252 | 
2026-08-22 02:43:10.001818 | PLAY [all]
2026-08-22 02:43:10.013893 | 
2026-08-22 02:43:10.014028 | TASK [setup-uv : Extract archive]
2026-08-22 02:43:12.215827 | instance | changed
2026-08-22 02:43:12.222909 | 
2026-08-22 02:43:12.223020 | TASK [setup-uv : Print version]
2026-08-22 02:43:12.562845 | instance | uv 0.8.13
2026-08-22 02:43:12.760827 | instance | ok: Runtime: 0:00:00.013753
2026-08-22 02:43:12.770470 | 
2026-08-22 02:43:12.770536 | TASK [Install Ansible collection siblings]
2026-08-22 02:43:21.616625 | instance | changed:
2026-08-22 02:43:21.616826 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-08-22 02:43:21.616854 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-08-22 02:43:21.616875 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-08-22 02:43:21.616895 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-08-22 02:43:21.616914 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-08-22 02:43:21.616937 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-08-22 02:43:21.616983 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-08-22 02:43:21.617006 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-08-22 02:43:21.617026 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-08-22 02:43:21.617045 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-08-22 02:43:21.617064 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-08-22 02:43:21.617083 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-08-22 02:43:21.617101 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-08-22 02:43:21.617119 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-08-22 02:43:21.617137 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0
2026-08-22 02:43:21.617155 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-08-22 02:43:21.617173 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-08-22 02:43:21.617191 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-08-22 02:43:21.617209 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-08-22 02:43:21.617227 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-08-22 02:43:21.617244 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0
2026-08-22 02:43:21.617262 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-08-22 02:43:21.617281 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-22 02:43:21.617313 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-08-22 02:43:21.617332 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0
2026-08-22 02:43:21.617350 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-22 02:43:21.617367 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-22 02:43:21.617385 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-22 02:43:21.617402 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-08-22 02:43:21.617420 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-08-22 02:43:21.617436 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-22 02:43:21.617454 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-22 02:43:21.617472 | instance | Checked out ansible.netcommon to 1.2.0
2026-08-22 02:43:21.617490 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-08-22 02:43:21.617515 | instance | Starting galaxy collection install process
2026-08-22 02:43:21.617532 | instance | Process install dependency map
2026-08-22 02:43:21.617550 | instance | Starting collection install process
2026-08-22 02:43:21.617568 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-08-22 02:43:21.617585 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-08-22 02:43:21.617603 | instance | ansible.netcommon:* was installed successfully
2026-08-22 02:43:21.617620 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-08-22 02:43:21.617637 | instance | Creating virtual environment at: .venv
2026-08-22 02:43:21.617654 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-22 02:43:21.617671 | instance | Downloading setuptools (1.1MiB)
2026-08-22 02:43:21.617688 | instance | Downloading openstacksdk (1.7MiB)
2026-08-22 02:43:21.617710 | instance | Downloading kubernetes (1.9MiB)
2026-08-22 02:43:21.617728 | instance | Downloading pygments (1.2MiB)
2026-08-22 02:43:21.617746 | instance | Downloading cryptography (4.2MiB)
2026-08-22 02:43:21.617764 | instance | Downloading ansible-core (2.1MiB)
2026-08-22 02:43:21.617782 | instance | Downloading rjsonnet (1.2MiB)
2026-08-22 02:43:21.617800 | instance | Downloading netaddr (2.2MiB)
2026-08-22 02:43:21.617818 | instance |    Building pyperclip==1.9.0
2026-08-22 02:43:21.617836 | instance |  Downloading rjsonnet
2026-08-22 02:43:21.617855 | instance |  Downloading netaddr
2026-08-22 02:43:21.617873 | instance |  Downloading pygments
2026-08-22 02:43:21.617891 | instance |  Downloading cryptography
2026-08-22 02:43:21.617909 | instance |  Downloading setuptools
2026-08-22 02:43:21.617926 | instance |  Downloading kubernetes
2026-08-22 02:43:21.617944 | instance |  Downloading ansible-core
2026-08-22 02:43:21.617961 | instance |  Downloading openstacksdk
2026-08-22 02:43:21.617979 | instance |       Built pyperclip==1.9.0
2026-08-22 02:43:21.617997 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-22 02:43:21.618015 | instance | Installed 79 packages in 37ms
2026-08-22 02:43:21.618033 | instance | Checked out ansible.posix to 1.6.0
2026-08-22 02:43:21.618051 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-08-22 02:43:21.618072 | instance | Starting galaxy collection install process
2026-08-22 02:43:21.618092 | instance | Process install dependency map
2026-08-22 02:43:21.618110 | instance | Starting collection install process
2026-08-22 02:43:21.618128 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-08-22 02:43:21.618152 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-08-22 02:43:21.618170 | instance | ansible.posix:1.6.0 was installed successfully
2026-08-22 02:43:21.618188 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 02:43:21.618206 | instance | 2.17.12
2026-08-22 02:43:21.618223 | instance | Checked out ansible.utils to v6.1.0
2026-08-22 02:43:21.618241 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-08-22 02:43:21.618258 | instance | Starting galaxy collection install process
2026-08-22 02:43:21.618276 | instance | Process install dependency map
2026-08-22 02:43:21.618293 | instance | Starting collection install process
2026-08-22 02:43:21.618311 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-08-22 02:43:21.618329 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-08-22 02:43:21.618347 | instance | ansible.utils:6.1.0 was installed successfully
2026-08-22 02:43:21.618365 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 02:43:21.618383 | instance | 2.17.12
2026-08-22 02:43:21.618401 | instance | Checked out atmosphere.common to v0.7.0
2026-08-22 02:43:21.618419 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-08-22 02:43:21.618437 | instance | Starting galaxy collection install process
2026-08-22 02:43:21.618456 | instance | Process install dependency map
2026-08-22 02:43:21.618473 | instance | Starting collection install process
2026-08-22 02:43:21.618491 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-08-22 02:43:21.618508 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-08-22 02:43:21.618526 | instance | atmosphere.common:0.7.0 was installed successfully
2026-08-22 02:43:21.618543 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 02:43:21.618561 | instance | 2.17.12
2026-08-22 02:43:21.618578 | instance | Checked out community.crypto to 2.2.3
2026-08-22 02:43:21.618595 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.crypto
2026-08-22 02:43:21.618613 | instance | Starting galaxy collection install process
2026-08-22 02:43:21.618631 | instance | Process install dependency map
2026-08-22 02:43:21.618648 | instance | Starting collection install process
2026-08-22 02:43:21.618665 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-08-22 02:43:21.618683 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-08-22 02:43:21.618700 | instance | community.crypto:2.2.3 was installed successfully
2026-08-22 02:43:21.618717 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 02:43:21.618734 | instance | 2.17.12
2026-08-22 02:43:21.618752 | instance | Checked out community.general to 7.3.0
2026-08-22 02:43:21.618769 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.general
2026-08-22 02:43:21.618786 | instance | Starting galaxy collection install process
2026-08-22 02:43:21.618808 | instance | Process install dependency map
2026-08-22 02:43:21.618826 | instance | Starting collection install process
2026-08-22 02:43:21.618844 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-08-22 02:43:21.618886 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-08-22 02:43:21.618904 | instance | community.general:7.3.0 was installed successfully
2026-08-22 02:43:21.618922 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 02:43:21.618940 | instance | 2.17.12
2026-08-22 02:43:21.618958 | instance | Checked out community.mysql to 3.6.0
2026-08-22 02:43:21.618980 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.mysql
2026-08-22 02:43:21.618998 | instance | Starting galaxy collection install process
2026-08-22 02:43:21.619017 | instance | Process install dependency map
2026-08-22 02:43:21.619036 | instance | Starting collection install process
2026-08-22 02:43:21.619055 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-08-22 02:43:21.619073 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-08-22 02:43:21.619091 | instance | community.mysql:3.6.0 was installed successfully
2026-08-22 02:43:21.619109 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 02:43:21.619126 | instance | 2.17.12
2026-08-22 02:43:21.619144 | instance | Checked out kubernetes.core to 2.4.0
2026-08-22 02:43:21.619161 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-08-22 02:43:21.619179 | instance | Starting galaxy collection install process
2026-08-22 02:43:21.619196 | instance | Process install dependency map
2026-08-22 02:43:21.619214 | instance | Starting collection install process
2026-08-22 02:43:21.619231 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-08-22 02:43:21.619249 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-08-22 02:43:21.619267 | instance | kubernetes.core:2.4.0 was installed successfully
2026-08-22 02:43:21.619285 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 02:43:21.619303 | instance | 2.17.12
2026-08-22 02:43:21.619320 | instance | Checked out openstack.cloud to 2.6.0
2026-08-22 02:43:21.619338 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-08-22 02:43:21.619355 | instance | Starting galaxy collection install process
2026-08-22 02:43:21.619373 | instance | Process install dependency map
2026-08-22 02:43:21.619391 | instance | Starting collection install process
2026-08-22 02:43:21.619408 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-08-22 02:43:21.619425 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-08-22 02:43:21.619443 | instance | openstack.cloud:2.6.0 was installed successfully
2026-08-22 02:43:21.619460 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 02:43:21.619477 | instance | 2.17.12
2026-08-22 02:43:21.619494 | instance | Checked out vexxhost.ceph to v4.2.0
2026-08-22 02:43:21.619511 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-08-22 02:43:21.619534 | instance | Starting galaxy collection install process
2026-08-22 02:43:21.619552 | instance | Process install dependency map
2026-08-22 02:43:21.619569 | instance | Starting collection install process
2026-08-22 02:43:21.619587 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-08-22 02:43:21.619604 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-08-22 02:43:21.619622 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-08-22 02:43:21.619639 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 02:43:21.619657 | instance | 2.17.12
2026-08-22 02:43:21.619674 | instance | Checked out vexxhost.containers to v1.6.8
2026-08-22 02:43:21.619691 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-08-22 02:43:21.619709 | instance | Starting galaxy collection install process
2026-08-22 02:43:21.619726 | instance | Process install dependency map
2026-08-22 02:43:21.619744 | instance | Starting collection install process
2026-08-22 02:43:21.619761 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-08-22 02:43:21.619779 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-08-22 02:43:21.619796 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-08-22 02:43:21.619814 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 02:43:21.619831 | instance | 2.17.12
2026-08-22 02:43:21.619848 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-08-22 02:43:21.619866 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-08-22 02:43:21.619883 | instance | Starting galaxy collection install process
2026-08-22 02:43:21.619901 | instance | Process install dependency map
2026-08-22 02:43:21.619918 | instance | Starting collection install process
2026-08-22 02:43:21.619936 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-08-22 02:43:21.619954 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-08-22 02:43:21.619971 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-08-22 02:43:21.619989 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 02:43:21.620006 | instance | 2.17.12
2026-08-22 02:43:21.625898 | 
2026-08-22 02:43:21.625949 | PLAY RECAP
2026-08-22 02:43:21.625999 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-22 02:43:21.626020 | 
2026-08-22 02:43:21.828282 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-22 02:43:21.833346 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-22 02:43:22.408370 | 
2026-08-22 02:43:22.408503 | PLAY [all]
2026-08-22 02:43:22.419133 | 
2026-08-22 02:43:22.419208 | TASK [Install "jq" for log collection]
2026-08-22 02:43:31.989020 | instance | changed
2026-08-22 02:43:31.991256 | 
2026-08-22 02:43:31.991335 | PLAY RECAP
2026-08-22 02:43:31.991400 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-22 02:43:31.991467 | 
2026-08-22 02:43:32.106110 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-22 02:43:32.109720 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-22 02:43:32.747720 | 
2026-08-22 02:43:32.747855 | PLAY [all]
2026-08-22 02:43:32.759093 | 
2026-08-22 02:43:32.759168 | LOOP [Check inventory directories]
2026-08-22 02:43:33.097993 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-08-22 02:43:33.250523 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-08-22 02:43:33.408153 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-08-22 02:43:33.429421 | 
2026-08-22 02:43:33.429695 | LOOP [Copy inventory file for Zuul]
2026-08-22 02:43:34.194263 | instance | changed:
2026-08-22 02:43:34.194529 | instance | {
2026-08-22 02:43:34.194570 | instance |   "ansible_loop_var": "item",
2026-08-22 02:43:34.194602 | instance |   "changed": false,
2026-08-22 02:43:34.194630 | instance |   "failed": false,
2026-08-22 02:43:34.194665 | instance |   "invocation": {
2026-08-22 02:43:34.194694 | instance |     "module_args": {
2026-08-22 02:43:34.194721 | instance |       "checksum_algorithm": "sha1",
2026-08-22 02:43:34.194747 | instance |       "follow": true,
2026-08-22 02:43:34.194832 | instance |       "get_attributes": true,
2026-08-22 02:43:34.194869 | instance |       "get_checksum": true,
2026-08-22 02:43:34.194896 | instance |       "get_mime": true,
2026-08-22 02:43:34.194922 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-08-22 02:43:34.194947 | instance |     }
2026-08-22 02:43:34.194973 | instance |   },
2026-08-22 02:43:34.194999 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-08-22 02:43:34.195031 | instance |   "stat": {
2026-08-22 02:43:34.195065 | instance |     "atime": 1787366594.5178463,
2026-08-22 02:43:34.195098 | instance |     "attr_flags": "e",
2026-08-22 02:43:34.195132 | instance |     "attributes": [
2026-08-22 02:43:34.195168 | instance |       "extents"
2026-08-22 02:43:34.195203 | instance |     ],
2026-08-22 02:43:34.195237 | instance |     "block_size": 4096,
2026-08-22 02:43:34.195263 | instance |     "blocks": 8,
2026-08-22 02:43:34.195288 | instance |     "charset": "unknown",
2026-08-22 02:43:34.195315 | instance |     "ctime": 1787366593.52575,
2026-08-22 02:43:34.195341 | instance |     "dev": 64513,
2026-08-22 02:43:34.195366 | instance |     "device_type": 0,
2026-08-22 02:43:34.195391 | instance |     "executable": true,
2026-08-22 02:43:34.195416 | instance |     "exists": true,
2026-08-22 02:43:34.195441 | instance |     "gid": 1000,
2026-08-22 02:43:34.195461 | instance |     "gr_name": "zuul",
2026-08-22 02:43:34.195481 | instance |     "inode": 1048540,
2026-08-22 02:43:34.195500 | instance |     "isblk": false,
2026-08-22 02:43:34.195517 | instance |     "ischr": false,
2026-08-22 02:43:34.195534 | instance |     "isdir": true,
2026-08-22 02:43:34.195551 | instance |     "isfifo": false,
2026-08-22 02:43:34.195568 | instance |     "isgid": false,
2026-08-22 02:43:34.195584 | instance |     "islnk": false,
2026-08-22 02:43:34.195601 | instance |     "isreg": false,
2026-08-22 02:43:34.195618 | instance |     "issock": false,
2026-08-22 02:43:34.195634 | instance |     "isuid": false,
2026-08-22 02:43:34.195650 | instance |     "mimetype": "unknown",
2026-08-22 02:43:34.195667 | instance |     "mode": "0755",
2026-08-22 02:43:34.195683 | instance |     "mtime": 1787366593.52575,
2026-08-22 02:43:34.195700 | instance |     "nlink": 22,
2026-08-22 02:43:34.195717 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-08-22 02:43:34.195734 | instance |     "pw_name": "zuul",
2026-08-22 02:43:34.195752 | instance |     "readable": true,
2026-08-22 02:43:34.195769 | instance |     "rgrp": true,
2026-08-22 02:43:34.195786 | instance |     "roth": true,
2026-08-22 02:43:34.195803 | instance |     "rusr": true,
2026-08-22 02:43:34.195820 | instance |     "size": 4096,
2026-08-22 02:43:34.195837 | instance |     "uid": 1000,
2026-08-22 02:43:34.195869 | instance |     "version": "3327255977",
2026-08-22 02:43:34.195888 | instance |     "wgrp": false,
2026-08-22 02:43:34.195906 | instance |     "woth": false,
2026-08-22 02:43:34.195924 | instance |     "writeable": true,
2026-08-22 02:43:34.195941 | instance |     "wusr": true,
2026-08-22 02:43:34.195958 | instance |     "xgrp": true,
2026-08-22 02:43:34.195975 | instance |     "xoth": true,
2026-08-22 02:43:34.195993 | instance |     "xusr": true
2026-08-22 02:43:34.196015 | instance |   }
2026-08-22 02:43:34.196037 | instance | }
2026-08-22 02:43:34.196075 | instance | ok: All items complete
2026-08-22 02:43:34.196100 | 
2026-08-22 02:43:34.197521 | instance | skipping: Conditional result was False
2026-08-22 02:43:34.198143 | instance | skipping: Conditional result was False
2026-08-22 02:43:34.210165 | 
2026-08-22 02:43:34.210333 | LOOP [Switch "ansible_host" to private IP]
2026-08-22 02:43:34.603093 | instance | changed: 1 replacements made
2026-08-22 02:43:34.605195 | instance | skipping: Conditional result was False
2026-08-22 02:43:34.607735 | instance | skipping: Conditional result was False
2026-08-22 02:43:34.617380 | 
2026-08-22 02:43:34.617527 | TASK [Run Molecule scenario]
2026-08-22 02:43:35.554595 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-08-22 02:43:35.977664 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-08-22 02:43:35.977797 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-08-22 02:43:46.679872 | instance | INFO     [csi > dependency] Executing
2026-08-22 02:43:46.680070 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-08-22 02:43:46.680317 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-08-22 02:43:46.680465 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-08-22 02:43:46.688924 | instance | INFO     [csi > cleanup] Executing
2026-08-22 02:43:46.689291 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-22 02:43:46.697341 | instance | INFO     [csi > destroy] Executing
2026-08-22 02:43:46.697396 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-08-22 02:43:46.697495 | instance | INFO     [csi > destroy] Executed: Successful
2026-08-22 02:43:46.705080 | instance | INFO     [csi > syntax] Executing
2026-08-22 02:43:48.328396 | instance |
2026-08-22 02:43:48.328622 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-22 02:43:48.385429 | instance | INFO     [csi > syntax] Executed: Successful
2026-08-22 02:43:48.397389 | instance | INFO     [csi > create] Executing
2026-08-22 02:43:48.399146 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-22 02:43:48.406530 | instance | INFO     [csi > prepare] Executing
2026-08-22 02:43:49.211404 | instance |
2026-08-22 02:43:49.211692 | instance | PLAY [Prepare] *****************************************************************
2026-08-22 02:43:49.212080 | instance |
2026-08-22 02:43:49.212464 | instance | TASK [Gathering Facts] *********************************************************
2026-08-22 02:43:49.212846 | instance | Saturday 22 August 2026  02:43:49 +0000 (0:00:00.025)       0:00:00.025 *******
2026-08-22 02:43:50.331095 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-22 02:43:50.331338 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-22 02:43:50.331615 | instance | interpreter could change the meaning of that path. See
2026-08-22 02:43:50.331890 | instance | https://docs.ansible.com/ansible-
2026-08-22 02:43:50.332163 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-22 02:43:50.338706 | instance | ok: [instance]
2026-08-22 02:43:50.339031 | instance |
2026-08-22 02:43:50.339319 | instance | TASK [Configure short hostname] ************************************************
2026-08-22 02:43:50.339597 | instance | Saturday 22 August 2026  02:43:50 +0000 (0:00:01.128)       0:00:01.153 *******
2026-08-22 02:43:50.975243 | instance | changed: [instance]
2026-08-22 02:43:50.975522 | instance |
2026-08-22 02:43:50.975827 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-08-22 02:43:50.976126 | instance | Saturday 22 August 2026  02:43:50 +0000 (0:00:00.636)       0:00:01.789 *******
2026-08-22 02:43:51.214507 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-08-22 02:43:51.214817 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-08-22 02:43:51.215201 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-08-22 02:43:51.224990 | instance | changed: [instance]
2026-08-22 02:43:51.225260 | instance |
2026-08-22 02:43:51.225554 | instance | TASK [Purge "snapd" package] ***************************************************
2026-08-22 02:43:51.225843 | instance | Saturday 22 August 2026  02:43:51 +0000 (0:00:00.249)       0:00:02.039 *******
2026-08-22 02:43:51.999372 | instance | ok: [instance]
2026-08-22 02:43:51.999651 | instance |
2026-08-22 02:43:51.999957 | instance | PLAY [Create devices for Ceph] *************************************************
2026-08-22 02:43:52.000233 | instance |
2026-08-22 02:43:52.000532 | instance | TASK [Gathering Facts] *********************************************************
2026-08-22 02:43:52.000820 | instance | Saturday 22 August 2026  02:43:51 +0000 (0:00:00.774)       0:00:02.813 *******
2026-08-22 02:43:52.679193 | instance | ok: [instance]
2026-08-22 02:43:52.679512 | instance |
2026-08-22 02:43:52.679807 | instance | TASK [Install depedencies] *****************************************************
2026-08-22 02:43:52.680087 | instance | Saturday 22 August 2026  02:43:52 +0000 (0:00:00.679)       0:00:03.493 *******
2026-08-22 02:44:11.773295 | instance | changed: [instance]
2026-08-22 02:44:11.773421 | instance |
2026-08-22 02:44:11.773583 | instance | TASK [Start up service] ********************************************************
2026-08-22 02:44:11.773750 | instance | Saturday 22 August 2026  02:44:11 +0000 (0:00:19.094)       0:00:22.587 *******
2026-08-22 02:44:12.310721 | instance | ok: [instance]
2026-08-22 02:44:12.310885 | instance |
2026-08-22 02:44:12.311166 | instance | TASK [Generate lvm.conf] *******************************************************
2026-08-22 02:44:12.311437 | instance | Saturday 22 August 2026  02:44:12 +0000 (0:00:00.537)       0:00:23.125 *******
2026-08-22 02:44:12.593597 | instance | ok: [instance]
2026-08-22 02:44:12.593833 | instance |
2026-08-22 02:44:12.594134 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-08-22 02:44:12.594521 | instance | Saturday 22 August 2026  02:44:12 +0000 (0:00:00.282)       0:00:23.407 *******
2026-08-22 02:44:13.240015 | instance | changed: [instance]
2026-08-22 02:44:13.240162 | instance |
2026-08-22 02:44:13.240336 | instance | TASK [Get list of all loopback devices] ****************************************
2026-08-22 02:44:13.240509 | instance | Saturday 22 August 2026  02:44:13 +0000 (0:00:00.646)       0:00:24.054 *******
2026-08-22 02:44:13.433703 | instance | ok: [instance]
2026-08-22 02:44:13.433862 | instance |
2026-08-22 02:44:13.434043 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-08-22 02:44:13.434215 | instance | Saturday 22 August 2026  02:44:13 +0000 (0:00:00.193)       0:00:24.248 *******
2026-08-22 02:44:13.455818 | instance | skipping: [instance]
2026-08-22 02:44:13.456076 | instance |
2026-08-22 02:44:13.456355 | instance | TASK [Create devices for Ceph] *************************************************
2026-08-22 02:44:13.456629 | instance | Saturday 22 August 2026  02:44:13 +0000 (0:00:00.021)       0:00:24.270 *******
2026-08-22 02:44:13.969588 | instance | changed: [instance] => (item=osd0)
2026-08-22 02:44:13.969837 | instance | changed: [instance] => (item=osd1)
2026-08-22 02:44:13.970127 | instance | changed: [instance] => (item=osd2)
2026-08-22 02:44:13.970371 | instance |
2026-08-22 02:44:13.970663 | instance | TASK [Set permissions on loopback devices] *************************************
2026-08-22 02:44:13.970927 | instance | Saturday 22 August 2026  02:44:13 +0000 (0:00:00.513)       0:00:24.783 *******
2026-08-22 02:44:14.570093 | instance | changed: [instance] => (item=osd0)
2026-08-22 02:44:14.570148 | instance | changed: [instance] => (item=osd1)
2026-08-22 02:44:14.570159 | instance | changed: [instance] => (item=osd2)
2026-08-22 02:44:14.570169 | instance |
2026-08-22 02:44:14.570179 | instance | TASK [Start loop devices] ******************************************************
2026-08-22 02:44:14.570189 | instance | Saturday 22 August 2026  02:44:14 +0000 (0:00:00.599)       0:00:25.382 *******
2026-08-22 02:44:15.224761 | instance | changed: [instance] => (item=osd0)
2026-08-22 02:44:15.225618 | instance | changed: [instance] => (item=osd1)
2026-08-22 02:44:15.225687 | instance | changed: [instance] => (item=osd2)
2026-08-22 02:44:15.225695 | instance |
2026-08-22 02:44:15.225701 | instance | TASK [Create a volume group for each loop device] ******************************
2026-08-22 02:44:15.225708 | instance | Saturday 22 August 2026  02:44:15 +0000 (0:00:00.655)       0:00:26.038 *******
2026-08-22 02:44:18.596193 | instance | changed: [instance] => (item=osd0)
2026-08-22 02:44:18.596336 | instance | changed: [instance] => (item=osd1)
2026-08-22 02:44:18.597100 | instance | changed: [instance] => (item=osd2)
2026-08-22 02:44:18.597156 | instance |
2026-08-22 02:44:18.597164 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-08-22 02:44:18.597171 | instance | Saturday 22 August 2026  02:44:18 +0000 (0:00:03.371)       0:00:29.410 *******
2026-08-22 02:44:20.426330 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-08-22 02:44:20.430450 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-08-22 02:44:20.430498 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-08-22 02:44:20.430510 | instance |
2026-08-22 02:44:20.430521 | instance | PLAY RECAP *********************************************************************
2026-08-22 02:44:20.430532 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-08-22 02:44:20.430542 | instance |
2026-08-22 02:44:20.430552 | instance | Saturday 22 August 2026  02:44:20 +0000 (0:00:01.830)       0:00:31.241 *******
2026-08-22 02:44:20.430562 | instance | ===============================================================================
2026-08-22 02:44:20.430571 | instance | Install depedencies ---------------------------------------------------- 19.09s
2026-08-22 02:44:20.430581 | instance | Create a volume group for each loop device ------------------------------ 3.37s
2026-08-22 02:44:20.430590 | instance | Create a logical volume for each loop device ---------------------------- 1.83s
2026-08-22 02:44:20.430600 | instance | Gathering Facts --------------------------------------------------------- 1.13s
2026-08-22 02:44:20.430610 | instance | Purge "snapd" package --------------------------------------------------- 0.77s
2026-08-22 02:44:20.430619 | instance | Gathering Facts --------------------------------------------------------- 0.68s
2026-08-22 02:44:20.430633 | instance | Start loop devices ------------------------------------------------------ 0.66s
2026-08-22 02:44:20.430924 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.65s
2026-08-22 02:44:20.431296 | instance | Configure short hostname ------------------------------------------------ 0.64s
2026-08-22 02:44:20.431625 | instance | Set permissions on loopback devices ------------------------------------- 0.60s
2026-08-22 02:44:20.431948 | instance | Start up service -------------------------------------------------------- 0.54s
2026-08-22 02:44:20.432336 | instance | Create devices for Ceph ------------------------------------------------- 0.51s
2026-08-22 02:44:20.432666 | instance | Generate lvm.conf ------------------------------------------------------- 0.28s
2026-08-22 02:44:20.432995 | instance | Ensure hostname inside hosts file --------------------------------------- 0.25s
2026-08-22 02:44:20.433287 | instance | Get list of all loopback devices ---------------------------------------- 0.19s
2026-08-22 02:44:20.433440 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s
2026-08-22 02:44:20.492356 | instance | INFO     [csi > prepare] Executed: Successful
2026-08-22 02:44:20.503830 | instance | INFO     [csi > converge] Executing
2026-08-22 02:44:21.910610 | instance |
2026-08-22 02:44:21.911026 | instance | PLAY [Debug CSI driver value] **************************************************
2026-08-22 02:44:21.911359 | instance |
2026-08-22 02:44:21.911734 | instance | TASK [Gathering Facts] *********************************************************
2026-08-22 02:44:21.912078 | instance | Saturday 22 August 2026  02:44:21 +0000 (0:00:00.007)       0:00:00.007 *******
2026-08-22 02:44:22.851906 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-22 02:44:22.852343 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-22 02:44:22.852715 | instance | interpreter could change the meaning of that path. See
2026-08-22 02:44:22.853105 | instance | https://docs.ansible.com/ansible-
2026-08-22 02:44:22.853478 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-22 02:44:22.861480 | instance | ok: [instance]
2026-08-22 02:44:22.861814 | instance |
2026-08-22 02:44:22.862170 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-08-22 02:44:22.862544 | instance | Saturday 22 August 2026  02:44:22 +0000 (0:00:00.951)       0:00:00.958 *******
2026-08-22 02:44:22.906186 | instance | ok: [instance] => {
2026-08-22 02:44:22.906621 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-08-22 02:44:22.906977 | instance | }
2026-08-22 02:44:22.907355 | instance |
2026-08-22 02:44:22.907715 | instance | PLAY [all] *********************************************************************
2026-08-22 02:44:22.908046 | instance |
2026-08-22 02:44:22.908396 | instance | TASK [Gathering Facts] *********************************************************
2026-08-22 02:44:22.908794 | instance | Saturday 22 August 2026  02:44:22 +0000 (0:00:00.044)       0:00:01.003 *******
2026-08-22 02:44:23.768491 | instance | ok: [instance]
2026-08-22 02:44:23.768863 | instance |
2026-08-22 02:44:23.769323 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-08-22 02:44:23.769750 | instance | Saturday 22 August 2026  02:44:23 +0000 (0:00:00.862)       0:00:01.865 *******
2026-08-22 02:44:23.942200 | instance | ok: [instance]
2026-08-22 02:44:23.942483 | instance |
2026-08-22 02:44:23.942739 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-08-22 02:44:23.942946 | instance |
2026-08-22 02:44:23.943161 | instance | TASK [Gathering Facts] *********************************************************
2026-08-22 02:44:23.943379 | instance | Saturday 22 August 2026  02:44:23 +0000 (0:00:00.174)       0:00:02.039 *******
2026-08-22 02:44:24.808820 | instance | ok: [instance]
2026-08-22 02:44:24.809225 | instance |
2026-08-22 02:44:24.809606 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-22 02:44:24.809984 | instance | Saturday 22 August 2026  02:44:24 +0000 (0:00:00.866)       0:00:02.905 *******
2026-08-22 02:44:25.102859 | instance | ok: [instance]
2026-08-22 02:44:25.102951 | instance |
2026-08-22 02:44:25.103086 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-22 02:44:25.103380 | instance | Saturday 22 August 2026  02:44:25 +0000 (0:00:00.293)       0:00:03.198 *******
2026-08-22 02:44:25.146944 | instance | skipping: [instance]
2026-08-22 02:44:25.147058 | instance |
2026-08-22 02:44:25.147258 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-08-22 02:44:25.147412 | instance | Saturday 22 August 2026  02:44:25 +0000 (0:00:00.042)       0:00:03.241 *******
2026-08-22 02:44:25.482149 | instance | changed: [instance]
2026-08-22 02:44:25.482336 | instance |
2026-08-22 02:44:25.482524 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-22 02:44:25.482680 | instance | Saturday 22 August 2026  02:44:25 +0000 (0:00:00.335)       0:00:03.577 *******
2026-08-22 02:44:25.544717 | instance | ok: [instance] => {
2026-08-22 02:44:25.544749 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-08-22 02:44:25.544754 | instance | }
2026-08-22 02:44:25.544759 | instance |
2026-08-22 02:44:25.544763 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-22 02:44:25.544767 | instance | Saturday 22 August 2026  02:44:25 +0000 (0:00:00.064)       0:00:03.641 *******
2026-08-22 02:44:26.266320 | instance | changed: [instance]
2026-08-22 02:44:26.266534 | instance |
2026-08-22 02:44:26.266549 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-22 02:44:26.266698 | instance | Saturday 22 August 2026  02:44:26 +0000 (0:00:00.722)       0:00:04.363 *******
2026-08-22 02:44:26.316970 | instance | skipping: [instance]
2026-08-22 02:44:26.317325 | instance |
2026-08-22 02:44:26.317366 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-22 02:44:26.317372 | instance | Saturday 22 August 2026  02:44:26 +0000 (0:00:00.050)       0:00:04.413 *******
2026-08-22 02:44:26.365412 | instance | skipping: [instance]
2026-08-22 02:44:26.365533 | instance |
2026-08-22 02:44:26.365787 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-22 02:44:26.365811 | instance | Saturday 22 August 2026  02:44:26 +0000 (0:00:00.048)       0:00:04.462 *******
2026-08-22 02:44:26.565164 | instance | ok: [instance]
2026-08-22 02:44:26.565586 | instance |
2026-08-22 02:44:26.565626 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-22 02:44:26.565632 | instance | Saturday 22 August 2026  02:44:26 +0000 (0:00:00.199)       0:00:04.662 *******
2026-08-22 02:44:27.721158 | instance | ok: [instance]
2026-08-22 02:44:27.721242 | instance |
2026-08-22 02:44:27.721487 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-22 02:44:27.721520 | instance | Saturday 22 August 2026  02:44:27 +0000 (0:00:01.156)       0:00:05.818 *******
2026-08-22 02:44:27.790164 | instance | ok: [instance] => {
2026-08-22 02:44:27.790440 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-08-22 02:44:27.790920 | instance | }
2026-08-22 02:44:27.790932 | instance |
2026-08-22 02:44:27.790937 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-22 02:44:27.790942 | instance | Saturday 22 August 2026  02:44:27 +0000 (0:00:00.068)       0:00:05.887 *******
2026-08-22 02:44:28.482037 | instance | changed: [instance]
2026-08-22 02:44:28.482073 | instance |
2026-08-22 02:44:28.482078 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-22 02:44:28.482083 | instance | Saturday 22 August 2026  02:44:28 +0000 (0:00:00.691)       0:00:06.578 *******
2026-08-22 02:44:31.267727 | instance | changed: [instance]
2026-08-22 02:44:31.267773 | instance |
2026-08-22 02:44:31.267780 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-08-22 02:44:31.267787 | instance | Saturday 22 August 2026  02:44:31 +0000 (0:00:02.785)       0:00:09.364 *******
2026-08-22 02:44:31.298258 | instance | skipping: [instance]
2026-08-22 02:44:31.298329 | instance |
2026-08-22 02:44:31.298342 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-08-22 02:44:31.298353 | instance | Saturday 22 August 2026  02:44:31 +0000 (0:00:00.029)       0:00:09.393 *******
2026-08-22 02:44:31.329938 | instance | skipping: [instance]
2026-08-22 02:44:31.329982 | instance |
2026-08-22 02:44:31.329993 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-08-22 02:44:31.330003 | instance | Saturday 22 August 2026  02:44:31 +0000 (0:00:00.031)       0:00:09.425 *******
2026-08-22 02:44:31.355549 | instance | skipping: [instance]
2026-08-22 02:44:31.355896 | instance |
2026-08-22 02:44:31.356241 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-08-22 02:44:31.356576 | instance | Saturday 22 August 2026  02:44:31 +0000 (0:00:00.026)       0:00:09.452 *******
2026-08-22 02:44:35.847303 | instance | changed: [instance]
2026-08-22 02:44:35.847787 | instance |
2026-08-22 02:44:35.848211 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-08-22 02:44:35.848582 | instance | Saturday 22 August 2026  02:44:35 +0000 (0:00:04.491)       0:00:13.943 *******
2026-08-22 02:44:36.409218 | instance | changed: [instance]
2026-08-22 02:44:36.409329 | instance |
2026-08-22 02:44:36.409517 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-08-22 02:44:36.409765 | instance | Saturday 22 August 2026  02:44:36 +0000 (0:00:00.562)       0:00:14.506 *******
2026-08-22 02:44:37.287095 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-08-22 02:44:37.287489 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-08-22 02:44:37.287830 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-08-22 02:44:37.288175 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-08-22 02:44:37.288546 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-08-22 02:44:37.288860 | instance |
2026-08-22 02:44:37.289199 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-08-22 02:44:37.289535 | instance | Saturday 22 August 2026  02:44:37 +0000 (0:00:00.876)       0:00:15.382 *******
2026-08-22 02:44:37.839301 | instance | changed: [instance]
2026-08-22 02:44:37.839352 | instance |
2026-08-22 02:44:37.839979 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-08-22 02:44:37.839994 | instance | Saturday 22 August 2026  02:44:37 +0000 (0:00:00.534)       0:00:15.917 *******
2026-08-22 02:44:37.840000 | instance |
2026-08-22 02:44:37.840004 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-22 02:44:37.840008 | instance | Saturday 22 August 2026  02:44:37 +0000 (0:00:00.018)       0:00:15.936 *******
2026-08-22 02:44:38.698223 | instance | ok: [instance]
2026-08-22 02:44:38.698299 | instance |
2026-08-22 02:44:38.698469 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-08-22 02:44:38.698615 | instance | Saturday 22 August 2026  02:44:38 +0000 (0:00:00.858)       0:00:16.795 *******
2026-08-22 02:44:39.098610 | instance | changed: [instance]
2026-08-22 02:44:39.098763 | instance |
2026-08-22 02:44:39.098943 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-08-22 02:44:39.099120 | instance | Saturday 22 August 2026  02:44:39 +0000 (0:00:00.400)       0:00:17.195 *******
2026-08-22 02:44:39.602348 | instance | changed: [instance]
2026-08-22 02:44:39.602619 | instance |
2026-08-22 02:44:39.602897 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-22 02:44:39.603169 | instance | Saturday 22 August 2026  02:44:39 +0000 (0:00:00.503)       0:00:17.699 *******
2026-08-22 02:44:39.799160 | instance | ok: [instance]
2026-08-22 02:44:39.799474 | instance |
2026-08-22 02:44:39.799763 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-22 02:44:39.800042 | instance | Saturday 22 August 2026  02:44:39 +0000 (0:00:00.196)       0:00:17.895 *******
2026-08-22 02:44:39.858111 | instance | ok: [instance] => {
2026-08-22 02:44:39.858357 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-08-22 02:44:39.858727 | instance | }
2026-08-22 02:44:39.858927 | instance |
2026-08-22 02:44:39.859197 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-22 02:44:39.859741 | instance | Saturday 22 August 2026  02:44:39 +0000 (0:00:00.059)       0:00:17.955 *******
2026-08-22 02:44:40.667756 | instance | changed: [instance]
2026-08-22 02:44:40.667952 | instance |
2026-08-22 02:44:40.668241 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-22 02:44:40.668503 | instance | Saturday 22 August 2026  02:44:40 +0000 (0:00:00.809)       0:00:18.764 *******
2026-08-22 02:44:45.942044 | instance | changed: [instance]
2026-08-22 02:44:45.942081 | instance |
2026-08-22 02:44:45.942087 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-08-22 02:44:45.942092 | instance | Saturday 22 August 2026  02:44:45 +0000 (0:00:05.274)       0:00:24.038 *******
2026-08-22 02:44:46.965980 | instance | ok: [instance]
2026-08-22 02:44:46.966496 | instance |
2026-08-22 02:44:46.966534 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-08-22 02:44:46.966547 | instance | Saturday 22 August 2026  02:44:46 +0000 (0:00:01.024)       0:00:25.062 *******
2026-08-22 02:44:47.352761 | instance | changed: [instance]
2026-08-22 02:44:47.353114 | instance |
2026-08-22 02:44:47.353217 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-08-22 02:44:47.353223 | instance | Saturday 22 August 2026  02:44:47 +0000 (0:00:00.387)       0:00:25.449 *******
2026-08-22 02:44:47.805793 | instance | changed: [instance]
2026-08-22 02:44:47.805897 | instance |
2026-08-22 02:44:47.806181 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-08-22 02:44:47.806221 | instance | Saturday 22 August 2026  02:44:47 +0000 (0:00:00.452)       0:00:25.902 *******
2026-08-22 02:44:48.367160 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-08-22 02:44:48.367263 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-08-22 02:44:48.367789 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-08-22 02:44:48.367827 | instance |
2026-08-22 02:44:48.367833 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-08-22 02:44:48.367838 | instance | Saturday 22 August 2026  02:44:48 +0000 (0:00:00.561)       0:00:26.464 *******
2026-08-22 02:44:48.805161 | instance | changed: [instance]
2026-08-22 02:44:48.805223 | instance |
2026-08-22 02:44:48.805538 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-08-22 02:44:48.805572 | instance | Saturday 22 August 2026  02:44:48 +0000 (0:00:00.437)       0:00:26.902 *******
2026-08-22 02:44:49.253534 | instance | changed: [instance]
2026-08-22 02:44:49.253624 | instance |
2026-08-22 02:44:49.254233 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-08-22 02:44:49.254272 | instance | Saturday 22 August 2026  02:44:49 +0000 (0:00:00.432)       0:00:27.334 *******
2026-08-22 02:44:49.254279 | instance |
2026-08-22 02:44:49.254284 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-22 02:44:49.254288 | instance | Saturday 22 August 2026  02:44:49 +0000 (0:00:00.016)       0:00:27.350 *******
2026-08-22 02:44:49.936833 | instance | ok: [instance]
2026-08-22 02:44:49.936865 | instance |
2026-08-22 02:44:49.936871 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-08-22 02:44:49.936880 | instance | Saturday 22 August 2026  02:44:49 +0000 (0:00:00.683)       0:00:28.033 *******
2026-08-22 02:44:50.957708 | instance | changed: [instance]
2026-08-22 02:44:50.957748 | instance |
2026-08-22 02:44:50.957754 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-08-22 02:44:50.957758 | instance | Saturday 22 August 2026  02:44:50 +0000 (0:00:01.020)       0:00:29.054 *******
2026-08-22 02:44:51.478890 | instance | changed: [instance]
2026-08-22 02:44:51.478986 | instance |
2026-08-22 02:44:51.479242 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-08-22 02:44:51.479277 | instance | Saturday 22 August 2026  02:44:51 +0000 (0:00:00.521)       0:00:29.575 *******
2026-08-22 02:44:51.533941 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-08-22 02:44:51.534014 | instance |
2026-08-22 02:44:51.534294 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-08-22 02:44:51.534330 | instance | Saturday 22 August 2026  02:44:51 +0000 (0:00:00.055)       0:00:29.631 *******
2026-08-22 02:44:56.492339 | instance | changed: [instance]
2026-08-22 02:44:56.492416 | instance |
2026-08-22 02:44:56.492676 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-08-22 02:44:56.492716 | instance | Saturday 22 August 2026  02:44:56 +0000 (0:00:04.958)       0:00:34.589 *******
2026-08-22 02:44:57.118592 | instance | ok: [instance] => (item=chronyd)
2026-08-22 02:44:57.118702 | instance | ok: [instance] => (item=sshd)
2026-08-22 02:44:57.118806 | instance |
2026-08-22 02:44:57.118931 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-08-22 02:44:57.119053 | instance | Saturday 22 August 2026  02:44:57 +0000 (0:00:00.625)       0:00:35.215 *******
2026-08-22 02:44:58.655334 | instance | changed: [instance]
2026-08-22 02:44:58.655615 | instance |
2026-08-22 02:44:58.655985 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-08-22 02:44:58.656348 | instance | Saturday 22 August 2026  02:44:58 +0000 (0:00:01.536)       0:00:36.751 *******
2026-08-22 02:44:58.848798 | instance | ok: [instance]
2026-08-22 02:44:58.849046 | instance |
2026-08-22 02:44:58.849364 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-08-22 02:44:58.849642 | instance | Saturday 22 August 2026  02:44:58 +0000 (0:00:00.193)       0:00:36.945 *******
2026-08-22 02:44:59.283931 | instance | changed: [instance]
2026-08-22 02:44:59.284175 | instance |
2026-08-22 02:44:59.284461 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-08-22 02:44:59.284731 | instance | Saturday 22 August 2026  02:44:59 +0000 (0:00:00.435)       0:00:37.380 *******
2026-08-22 02:44:59.609313 | instance | changed: [instance]
2026-08-22 02:44:59.609598 | instance |
2026-08-22 02:44:59.610032 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-08-22 02:44:59.610359 | instance | Saturday 22 August 2026  02:44:59 +0000 (0:00:00.325)       0:00:37.705 *******
2026-08-22 02:44:59.721350 | instance | ok: [instance]
2026-08-22 02:44:59.721443 | instance |
2026-08-22 02:44:59.721456 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-08-22 02:44:59.721466 | instance | Saturday 22 August 2026  02:44:59 +0000 (0:00:00.111)       0:00:37.817 *******
2026-08-22 02:44:59.947970 | instance | ok: [instance] => (item=instance)
2026-08-22 02:44:59.948060 | instance |
2026-08-22 02:44:59.948318 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-08-22 02:44:59.948334 | instance | Saturday 22 August 2026  02:44:59 +0000 (0:00:00.227)       0:00:38.044 *******
2026-08-22 02:45:00.000932 | instance | ok: [instance]
2026-08-22 02:45:00.001068 | instance |
2026-08-22 02:45:00.001446 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-08-22 02:45:00.001467 | instance | Saturday 22 August 2026  02:44:59 +0000 (0:00:00.052)       0:00:38.097 *******
2026-08-22 02:45:00.065695 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-08-22 02:45:00.065774 | instance |
2026-08-22 02:45:00.066029 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-08-22 02:45:00.066168 | instance | Saturday 22 August 2026  02:45:00 +0000 (0:00:00.064)       0:00:38.162 *******
2026-08-22 02:45:00.435523 | instance | changed: [instance]
2026-08-22 02:45:00.435600 | instance |
2026-08-22 02:45:00.435858 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-08-22 02:45:00.435895 | instance | Saturday 22 August 2026  02:45:00 +0000 (0:00:00.369)       0:00:38.532 *******
2026-08-22 02:45:01.113663 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-08-22 02:45:01.114465 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-08-22 02:45:01.114511 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-08-22 02:45:01.114518 | instance |
2026-08-22 02:45:01.114529 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-08-22 02:45:01.114541 | instance | Saturday 22 August 2026  02:45:01 +0000 (0:00:00.678)       0:00:39.210 *******
2026-08-22 02:46:27.336012 | instance | ok: [instance]
2026-08-22 02:46:27.336073 | instance |
2026-08-22 02:46:27.336411 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-08-22 02:46:27.336447 | instance | Saturday 22 August 2026  02:46:27 +0000 (0:01:26.222)       0:02:05.433 *******
2026-08-22 02:46:27.563412 | instance | changed: [instance]
2026-08-22 02:46:27.563498 | instance |
2026-08-22 02:46:27.563596 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-08-22 02:46:27.563721 | instance | Saturday 22 August 2026  02:46:27 +0000 (0:00:00.227)       0:02:05.660 *******
2026-08-22 02:46:27.636825 | instance | ok: [instance]
2026-08-22 02:46:27.636866 | instance |
2026-08-22 02:46:27.636871 | instance | TASK [Install Ceph host] *******************************************************
2026-08-22 02:46:27.636876 | instance | Saturday 22 August 2026  02:46:27 +0000 (0:00:00.073)       0:02:05.733 *******
2026-08-22 02:46:27.709664 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-08-22 02:46:27.709778 | instance |
2026-08-22 02:46:27.709903 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-08-22 02:46:27.710026 | instance | Saturday 22 August 2026  02:46:27 +0000 (0:00:00.073)       0:02:05.806 *******
2026-08-22 02:46:29.322580 | instance | ok: [instance]
2026-08-22 02:46:29.322656 | instance |
2026-08-22 02:46:29.322798 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-08-22 02:46:29.322917 | instance | Saturday 22 August 2026  02:46:29 +0000 (0:00:01.612)       0:02:07.419 *******
2026-08-22 02:46:29.382456 | instance | ok: [instance] => (item=instance)
2026-08-22 02:46:29.382566 | instance |
2026-08-22 02:46:29.382687 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-08-22 02:46:29.382810 | instance | Saturday 22 August 2026  02:46:29 +0000 (0:00:00.060)       0:02:07.479 *******
2026-08-22 02:46:29.719706 | instance | ok: [instance]
2026-08-22 02:46:29.719832 | instance |
2026-08-22 02:46:29.720102 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-08-22 02:46:29.720142 | instance | Saturday 22 August 2026  02:46:29 +0000 (0:00:00.337)       0:02:07.816 *******
2026-08-22 02:46:31.974080 | instance | ok: [instance]
2026-08-22 02:46:31.974159 | instance |
2026-08-22 02:46:31.974438 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-08-22 02:46:31.974479 | instance | Saturday 22 August 2026  02:46:31 +0000 (0:00:02.254)       0:02:10.071 *******
2026-08-22 02:47:15.420702 | instance | An exception occurred during task execution. To see the full traceback, use -vvv. The error was: [errno 5] RADOS I/O error (error connecting to the cluster)
2026-08-22 02:47:15.421564 | instance | fatal: [instance]: FAILED! => {"changed": false, "module_stderr": "Traceback (most recent call last):\n  File \"<stdin>\", line 107, in <module>\n  File \"<stdin>\", line 99, in _ansiballz_main\n  File \"<stdin>\", 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_ej1yft0k/ansible_vexxhost.ceph.orch_apply_payload.zip/ansible_collections/vexxhost/ceph/plugins/modules/orch_apply.py\", line 202, in <module>\n  File \"/tmp/ansible_vexxhost.ceph.orch_apply_payload_ej1yft0k/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_ej1yft0k/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_ej1yft0k/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-22T02:47:15.265+0000 7ff1910b8640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBZDYlqBRZGNSAAogIDFhZOiWnebL//UrEa8ds2UBdi37xgra+gJcpaFmQ=: Malformed input [buffer:3]\n2026-08-22T02:47:15.265+0000 7ff1910b8640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-22T02:47:15.265+0000 7ff1910b8640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBZDYlqBRZGNSAAogIDFhZOiWnebL//UrEa8ds2UBdi37xgra+gJcpaFmQ=: Malformed input [buffer:3]\n2026-08-22T02:47:15.265+0000 7ff1910b8640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-22T02:47:15.265+0000 7ff1910b8640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBZDYlqBRZGNSAAogIDFhZOiWnebL//UrEa8ds2UBdi37xgra+gJcpaFmQ=: Malformed input [buffer:3]\n2026-08-22T02:47:15.265+0000 7ff1910b8640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-22T02:47:15.265+0000 7ff1910b8640 -1 monclient: keyring not found\n[errno 5] RADOS I/O error (error connecting to the cluster)\n\n", "module_stdout": "", "msg": "MODULE FAILURE\nSee stdout/stderr for the exact error", "rc": 1}
2026-08-22 02:47:15.424863 | instance |
2026-08-22 02:47:15.426545 | instance | PLAY RECAP *********************************************************************
2026-08-22 02:47:15.426614 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=6    rescued=0    ignored=0
2026-08-22 02:47:15.426626 | instance |
2026-08-22 02:47:15.426636 | instance | Saturday 22 August 2026  02:47:15 +0000 (0:00:43.450)       0:02:53.522 *******
2026-08-22 02:47:15.426651 | instance | ===============================================================================
2026-08-22 02:47:15.429764 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 86.22s
2026-08-22 02:47:15.429780 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 43.45s
2026-08-22 02:47:15.429785 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 5.27s
2026-08-22 02:47:15.429790 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 4.96s
2026-08-22 02:47:15.429794 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 4.49s
2026-08-22 02:47:15.429797 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.79s
2026-08-22 02:47:15.429801 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.25s
2026-08-22 02:47:15.429805 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.61s
2026-08-22 02:47:15.429820 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.54s
2026-08-22 02:47:15.429824 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 1.54s
2026-08-22 02:47:15.429828 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.16s
2026-08-22 02:47:15.429832 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.02s
2026-08-22 02:47:15.429836 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 1.02s
2026-08-22 02:47:15.429840 | instance | Gathering Facts --------------------------------------------------------- 0.95s
2026-08-22 02:47:15.429844 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.88s
2026-08-22 02:47:15.429847 | instance | Gathering Facts --------------------------------------------------------- 0.87s
2026-08-22 02:47:15.429851 | instance | Gathering Facts --------------------------------------------------------- 0.86s
2026-08-22 02:47:15.429855 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.81s
2026-08-22 02:47:15.429879 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.72s
2026-08-22 02:47:15.429883 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.69s
2026-08-22 02:47:15.519002 | instance | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-22 02:47:15.519298 | instance | ERROR    [csi > converge] Executed: Failed
2026-08-22 02:47:15.519502 | instance | ERROR    Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-22 02:47:15.934381 | instance | ERROR
2026-08-22 02:47:15.934576 | instance | {
2026-08-22 02:47:15.934620 | instance |   "delta": "0:03:40.590167",
2026-08-22 02:47:15.934641 | instance |   "end": "2026-08-22 02:47:15.570692",
2026-08-22 02:47:15.934659 | instance |   "msg": "non-zero return code",
2026-08-22 02:47:15.934677 | instance |   "rc": 2,
2026-08-22 02:47:15.934718 | instance |   "start": "2026-08-22 02:43:34.980525"
2026-08-22 02:47:15.934742 | instance | }
failure
2026-08-22 02:47:15.942975 | 
2026-08-22 02:47:15.943051 | PLAY RECAP
2026-08-22 02:47:15.943114 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-08-22 02:47:15.943146 | 
2026-08-22 02:47:16.083008 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-22 02:47:16.087219 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-22 02:47:16.667672 | 
2026-08-22 02:47:16.667779 | PLAY [all]
2026-08-22 02:47:16.681709 | 
2026-08-22 02:47:16.681787 | TASK [gather-host-logs : creating directory for system status]
2026-08-22 02:47:17.047816 | instance | changed
2026-08-22 02:47:17.053622 | 
2026-08-22 02:47:17.053702 | TASK [gather-host-logs : Get logs for each host]
2026-08-22 02:47:17.406204 | instance | + systemd-cgls --full --all --no-pager
2026-08-22 02:47:17.424921 | instance | + ip addr
2026-08-22 02:47:17.427478 | instance | + ip route
2026-08-22 02:47:17.428874 | instance | + lsblk
2026-08-22 02:47:17.434268 | instance | + mount
2026-08-22 02:47:17.436204 | instance | + docker images
2026-08-22 02:47:17.456752 | instance | + brctl show
2026-08-22 02:47:17.457263 | instance | /bin/bash: line 8: brctl: command not found
2026-08-22 02:47:17.457539 | instance | + ps aux --sort=-%mem
2026-08-22 02:47:17.484065 | instance | + dpkg -l
2026-08-22 02:47:17.496698 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-08-22 02:47:17.497263 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-08-22 02:47:17.512875 | instance | + '[' '!' -z '' ']'
2026-08-22 02:47:17.588449 | instance | ok: Runtime: 0:00:00.111645
2026-08-22 02:47:17.598106 | 
2026-08-22 02:47:17.598198 | TASK [gather-host-logs : Downloads logs to executor]
2026-08-22 02:47:18.240396 | instance | changed:
2026-08-22 02:47:18.240650 | instance | created directory /var/lib/zuul/builds/a136f62cdc8b457c83e2111c69ffdaf6/work/logs/instance
2026-08-22 02:47:18.240714 | instance | cd+++++++++ system/
2026-08-22 02:47:18.240764 | instance | >f+++++++++ system/brctl-show.txt
2026-08-22 02:47:18.240811 | instance | >f+++++++++ system/docker-images.txt
2026-08-22 02:47:18.240860 | instance | >f+++++++++ system/ip-addr.txt
2026-08-22 02:47:18.240908 | instance | >f+++++++++ system/ip-route.txt
2026-08-22 02:47:18.240986 | instance | >f+++++++++ system/lsblk.txt
2026-08-22 02:47:18.241039 | instance | >f+++++++++ system/mount.txt
2026-08-22 02:47:18.241082 | instance | >f+++++++++ system/packages.txt
2026-08-22 02:47:18.241125 | instance | >f+++++++++ system/ps.txt
2026-08-22 02:47:18.241171 | instance | >f+++++++++ system/systemd-cgls.txt
2026-08-22 02:47:18.250268 | 
2026-08-22 02:47:18.250350 | LOOP [helm-release-status : creating directory for helm release status]
2026-08-22 02:47:18.485116 | instance | changed: "values"
2026-08-22 02:47:18.676033 | instance | changed: "releases"
2026-08-22 02:47:18.695140 | 
2026-08-22 02:47:18.695709 | TASK [helm-release-status : Gather get release status for helm charts]
2026-08-22 02:47:18.892592 | instance | /bin/bash: line 3: kubectl: command not found
2026-08-22 02:47:19.232542 | instance | ok: Runtime: 0:00:00.005892
2026-08-22 02:47:19.239006 | 
2026-08-22 02:47:19.239094 | TASK [helm-release-status : Downloads logs to executor]
2026-08-22 02:47:19.711340 | instance | changed:
2026-08-22 02:47:19.711577 | instance | cd+++++++++ helm/
2026-08-22 02:47:19.711632 | instance | cd+++++++++ helm/releases/
2026-08-22 02:47:19.711657 | instance | cd+++++++++ helm/values/
2026-08-22 02:47:19.722793 | 
2026-08-22 02:47:19.722870 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-08-22 02:47:19.925508 | instance | changed
2026-08-22 02:47:19.932731 | 
2026-08-22 02:47:19.932800 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-08-22 02:47:20.163642 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-22 02:47:20.164508 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-22 02:47:20.170544 | instance | environment: line 1: kubectl: command not found
2026-08-22 02:47:20.172166 | instance | environment: line 1: kubectl: command not found
2026-08-22 02:47:20.172261 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-22 02:47:20.173113 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-22 02:47:20.175181 | instance | environment: line 1: kubectl: command not found
2026-08-22 02:47:20.176533 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-22 02:47:20.177311 | instance | environment: line 1: kubectl: command not found
2026-08-22 02:47:20.178822 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-22 02:47:20.179572 | instance | environment: line 1: kubectl: command not found
2026-08-22 02:47:20.180865 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-22 02:47:20.466830 | instance | ok: Runtime: 0:00:00.025346
2026-08-22 02:47:20.473525 | 
2026-08-22 02:47:20.473906 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-08-22 02:47:20.679867 | instance | changed
2026-08-22 02:47:20.686650 | 
2026-08-22 02:47:20.686747 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-08-22 02:47:20.923410 | instance | environment: line 5: kubectl: command not found
2026-08-22 02:47:20.924239 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-22 02:47:20.924311 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-22 02:47:20.924480 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-22 02:47:21.220780 | instance | ok: Runtime: 0:00:00.009178
2026-08-22 02:47:21.227895 | 
2026-08-22 02:47:21.227978 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-08-22 02:47:21.703969 | instance | changed:
2026-08-22 02:47:21.704160 | instance | cd+++++++++ objects/
2026-08-22 02:47:21.704201 | instance | cd+++++++++ objects/cluster/
2026-08-22 02:47:21.704232 | instance | cd+++++++++ objects/namespaced/
2026-08-22 02:47:21.714954 | 
2026-08-22 02:47:21.715016 | TASK [gather-pod-logs : creating directory for pod logs]
2026-08-22 02:47:21.921832 | instance | changed
2026-08-22 02:47:21.929540 | 
2026-08-22 02:47:21.929678 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-08-22 02:47:22.140440 | instance | changed
2026-08-22 02:47:22.145238 | 
2026-08-22 02:47:22.145307 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-08-22 02:47:22.357679 | instance | environment: line 3: kubectl: command not found
2026-08-22 02:47:22.679866 | instance | ok: Runtime: 0:00:00.008769
2026-08-22 02:47:22.686377 | 
2026-08-22 02:47:22.686439 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-08-22 02:47:23.167156 | instance | changed:
2026-08-22 02:47:23.167364 | instance | cd+++++++++ pod-logs/
2026-08-22 02:47:23.167421 | instance | cd+++++++++ pod-logs/failed-pods/
2026-08-22 02:47:23.181020 | 
2026-08-22 02:47:23.181102 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-08-22 02:47:23.422858 | instance | changed
2026-08-22 02:47:23.427819 | 
2026-08-22 02:47:23.427881 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-08-22 02:47:23.635919 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-22 02:47:23.963692 | instance | ok: Runtime: 0:00:00.034548
2026-08-22 02:47:23.971378 | 
2026-08-22 02:47:23.971443 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-08-22 02:47:24.176156 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-22 02:47:24.204075 | instance | ceph-mgr endpoints:
2026-08-22 02:47:24.505750 | instance | ok: Runtime: 0:00:00.033648
2026-08-22 02:47:24.512840 | 
2026-08-22 02:47:24.512929 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-08-22 02:47:24.712166 | instance | /bin/bash: line 4: kubectl: command not found
2026-08-22 02:47:25.046214 | instance | ok: Runtime: 0:00:00.033582
2026-08-22 02:47:25.053038 | 
2026-08-22 02:47:25.053120 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-08-22 02:47:25.531959 | instance | changed: cd+++++++++ prometheus/
2026-08-22 02:47:25.541287 | 
2026-08-22 02:47:25.541351 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-08-22 02:47:25.738175 | instance | changed
2026-08-22 02:47:25.744999 | 
2026-08-22 02:47:25.745089 | TASK [gather-selenium-data : Get selenium data]
2026-08-22 02:47:25.988889 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-08-22 02:47:25.990287 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-08-22 02:47:26.281323 | instance | ERROR
2026-08-22 02:47:26.281545 | instance | {
2026-08-22 02:47:26.281590 | instance |   "delta": "0:00:00.005728",
2026-08-22 02:47:26.281621 | instance |   "end": "2026-08-22 02:47:25.990642",
2026-08-22 02:47:26.281654 | instance |   "msg": "non-zero return code",
2026-08-22 02:47:26.281684 | instance |   "rc": 1,
2026-08-22 02:47:26.281712 | instance |   "start": "2026-08-22 02:47:25.984914"
2026-08-22 02:47:26.281739 | instance | }
2026-08-22 02:47:26.281774 | instance | ERROR: Ignoring Errors
2026-08-22 02:47:26.289027 | 
2026-08-22 02:47:26.289128 | TASK [gather-selenium-data : Downloads logs to executor]
2026-08-22 02:47:26.768612 | instance | changed: cd+++++++++ selenium/
2026-08-22 02:47:26.775158 | 
2026-08-22 02:47:26.775205 | PLAY RECAP
2026-08-22 02:47:26.775250 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-08-22 02:47:26.775273 | 
2026-08-22 02:47:26.898475 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-22 02:47:26.902739 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-22 02:47:27.643344 | 
2026-08-22 02:47:27.643497 | PLAY [all]
2026-08-22 02:47:27.658397 | 
2026-08-22 02:47:27.658550 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-22 02:47:27.703656 | instance | skipping: Conditional result was False
2026-08-22 02:47:27.713782 | 
2026-08-22 02:47:27.713872 | TASK [fetch-output : Set log path for single node]
2026-08-22 02:47:27.756722 | instance | ok
2026-08-22 02:47:27.761695 | 
2026-08-22 02:47:27.761766 | LOOP [fetch-output : Ensure local output dirs]
2026-08-22 02:47:28.127940 | instance -> localhost | ok: "/var/lib/zuul/builds/a136f62cdc8b457c83e2111c69ffdaf6/work/logs"
2026-08-22 02:47:28.362156 | instance -> localhost | changed: "/var/lib/zuul/builds/a136f62cdc8b457c83e2111c69ffdaf6/work/artifacts"
2026-08-22 02:47:28.564160 | instance -> localhost | changed: "/var/lib/zuul/builds/a136f62cdc8b457c83e2111c69ffdaf6/work/docs"
2026-08-22 02:47:28.579034 | 
2026-08-22 02:47:28.579182 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-22 02:47:29.195302 | instance | changed: .d..t...... ./
2026-08-22 02:47:29.195540 | instance | changed: All items complete
2026-08-22 02:47:29.195582 | 
2026-08-22 02:47:29.639372 | instance | changed: .d..t...... ./
2026-08-22 02:47:30.071659 | instance | changed: .d..t...... ./
2026-08-22 02:47:30.099923 | 
2026-08-22 02:47:30.100079 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-22 02:47:30.539132 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.013847
2026-08-22 02:47:30.759527 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007244
2026-08-22 02:47:30.776426 | 
2026-08-22 02:47:30.776554 | PLAY [all]
2026-08-22 02:47:30.785498 | 
2026-08-22 02:47:30.785583 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-22 02:47:31.194538 | instance | changed
2026-08-22 02:47:31.200926 | 
2026-08-22 02:47:31.201013 | PLAY RECAP
2026-08-22 02:47:31.201058 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-22 02:47:31.201081 | 
2026-08-22 02:47:31.314641 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-22 02:47:31.319181 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-22 02:47:31.904808 | 
2026-08-22 02:47:31.905025 | PLAY [localhost]
2026-08-22 02:47:31.921629 | 
2026-08-22 02:47:31.921776 | TASK [Generate Zuul manifest]
2026-08-22 02:47:31.940245 | localhost | ok
2026-08-22 02:47:31.962548 | 
2026-08-22 02:47:31.962641 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-22 02:47:32.327401 | localhost | changed
2026-08-22 02:47:32.340840 | 
2026-08-22 02:47:32.340947 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-22 02:47:32.370987 | localhost | ok
2026-08-22 02:47:32.379736 | 
2026-08-22 02:47:32.379818 | TASK [Upload logs]
2026-08-22 02:47:32.401906 | localhost | ok
2026-08-22 02:47:32.459398 | 
2026-08-22 02:47:32.459518 | TASK [Set zuul-log-path fact]
2026-08-22 02:47:32.479696 | localhost | ok
2026-08-22 02:47:32.494911 | 
2026-08-22 02:47:32.494998 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-22 02:47:32.525338 | localhost | ok
2026-08-22 02:47:32.532889 | 
2026-08-22 02:47:32.532991 | TASK [upload-logs : Create log directories]
2026-08-22 02:47:32.905472 | localhost | changed
2026-08-22 02:47:32.912615 | 
2026-08-22 02:47:32.912763 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-22 02:47:33.286741 | localhost -> localhost | ok: Runtime: 0:00:00.003223
2026-08-22 02:47:33.293632 | 
2026-08-22 02:47:33.293773 | TASK [upload-logs : Upload logs to log server]
2026-08-22 02:47:33.771759 | localhost | Output suppressed because no_log was given
2026-08-22 02:47:33.811316 | 
2026-08-22 02:47:33.811437 | LOOP [upload-logs : Compress console log and json output]
2026-08-22 02:47:33.852732 | localhost | skipping: Conditional result was False
2026-08-22 02:47:33.860118 | localhost | skipping: Conditional result was False
2026-08-22 02:47:33.874922 | 
2026-08-22 02:47:33.875093 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-22 02:47:33.915537 | localhost | skipping: Conditional result was False
2026-08-22 02:47:33.915886 | 
2026-08-22 02:47:33.919669 | localhost | skipping: Conditional result was False
2026-08-22 02:47:33.928519 | 
2026-08-22 02:47:33.928664 | LOOP [upload-logs : Upload console log and json output]