2026-08-20 06:09:15.932102 | Job console starting
2026-08-20 06:09:15.944565 | Updating git repos
2026-08-20 06:09:30.512846 | Cloning repos into workspace
2026-08-20 06:10:10.344410 | Restoring repo states
2026-08-20 06:10:17.485593 | Merging changes
2026-08-20 06:10:20.001063 | Checking out repos
2026-08-20 06:10:25.096146 | Preparing playbooks
2026-08-20 06:10:36.185742 | Running Ansible setup
2026-08-20 06:10:39.892576 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-20 06:10:40.583540 | 
2026-08-20 06:10:40.583689 | PLAY [localhost]
2026-08-20 06:10:40.591732 | 
2026-08-20 06:10:40.591835 | TASK [Gathering Facts]
2026-08-20 06:10:41.534480 | localhost | ok
2026-08-20 06:10:41.547347 | 
2026-08-20 06:10:41.553470 | TASK [Setup log path fact]
2026-08-20 06:10:41.579250 | localhost | ok
2026-08-20 06:10:41.598045 | 
2026-08-20 06:10:41.624810 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-20 06:10:41.658006 | localhost | ok
2026-08-20 06:10:41.667408 | 
2026-08-20 06:10:41.667500 | TASK [emit-job-header : Print job information]
2026-08-20 06:10:41.710195 | # Job Information
2026-08-20 06:10:41.710416 | Ansible Version: 2.16.18
2026-08-20 06:10:41.710486 | Job: atmosphere-molecule-csi-rbd
2026-08-20 06:10:41.710535 | Pipeline: check
2026-08-20 06:10:41.710579 | Executor: 2d72f0692154
2026-08-20 06:10:41.710623 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4094
2026-08-20 06:10:41.710673 | Event ID: 132af530-9c5d-11f1-9a64-d1e96d485372
2026-08-20 06:10:41.715884 | 
2026-08-20 06:10:41.715975 | LOOP [emit-job-header : Print node information]
2026-08-20 06:10:41.858991 | localhost | ok:
2026-08-20 06:10:41.859279 | localhost | # Node Information
2026-08-20 06:10:41.859347 | localhost | Inventory Hostname: instance
2026-08-20 06:10:41.859400 | localhost | Hostname: np0000190219
2026-08-20 06:10:41.859450 | localhost | Username: zuul
2026-08-20 06:10:41.859508 | localhost | Distro: Ubuntu 22.04
2026-08-20 06:10:41.859557 | localhost | Provider: yul1
2026-08-20 06:10:41.859604 | localhost | Region: ca-ymq-1
2026-08-20 06:10:41.859650 | localhost | Label: ubuntu-jammy
2026-08-20 06:10:41.859696 | localhost | Product Name: OpenStack Nova
2026-08-20 06:10:41.859741 | localhost | Interface IP: 199.19.213.238
2026-08-20 06:10:41.873982 | 
2026-08-20 06:10:41.934105 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-20 06:10:42.683943 | localhost -> localhost | changed
2026-08-20 06:10:42.691087 | 
2026-08-20 06:10:42.691166 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-20 06:10:43.812852 | localhost -> localhost | changed
2026-08-20 06:10:43.819454 | 
2026-08-20 06:10:43.819555 | PLAY [all]
2026-08-20 06:10:43.828195 | 
2026-08-20 06:10:43.828280 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-20 06:10:44.055667 | instance -> localhost | ok
2026-08-20 06:10:44.064409 | 
2026-08-20 06:10:44.064495 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-20 06:10:44.095685 | instance | ok
2026-08-20 06:10:44.108732 | instance | included: /var/lib/zuul/builds/3759624931ff4b808989abcddd006cfc/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-20 06:10:44.114241 | 
2026-08-20 06:10:44.114301 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-20 06:10:44.842800 | instance -> localhost | Generating public/private rsa key pair.
2026-08-20 06:10:44.843020 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/3759624931ff4b808989abcddd006cfc/work/3759624931ff4b808989abcddd006cfc_id_rsa
2026-08-20 06:10:44.843063 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/3759624931ff4b808989abcddd006cfc/work/3759624931ff4b808989abcddd006cfc_id_rsa.pub
2026-08-20 06:10:44.843096 | instance -> localhost | The key fingerprint is:
2026-08-20 06:10:44.843125 | instance -> localhost | SHA256:V0QBT2XMcD5vAHDphFXtMQzzqhhNp9C1pvx5NLnk0eY zuul-build-sshkey
2026-08-20 06:10:44.843172 | instance -> localhost | The key's randomart image is:
2026-08-20 06:10:44.843202 | instance -> localhost | +---[RSA 3072]----+
2026-08-20 06:10:44.843239 | instance -> localhost | |          o*X%B. |
2026-08-20 06:10:44.843268 | instance -> localhost | |          o=+=*+.|
2026-08-20 06:10:44.843296 | instance -> localhost | |         . =o++oo|
2026-08-20 06:10:44.843324 | instance -> localhost | |          =.* .++|
2026-08-20 06:10:44.843351 | instance -> localhost | |        S..= . *=|
2026-08-20 06:10:44.843377 | instance -> localhost | |         .o o =++|
2026-08-20 06:10:44.843404 | instance -> localhost | |         . . o +E|
2026-08-20 06:10:44.843470 | instance -> localhost | |              .  |
2026-08-20 06:10:44.843507 | instance -> localhost | |                 |
2026-08-20 06:10:44.843534 | instance -> localhost | +----[SHA256]-----+
2026-08-20 06:10:44.843606 | instance -> localhost | ok: Runtime: 0:00:00.298796
2026-08-20 06:10:44.852167 | 
2026-08-20 06:10:44.852245 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-20 06:10:44.884371 | instance | ok
2026-08-20 06:10:44.896892 | instance | included: /var/lib/zuul/builds/3759624931ff4b808989abcddd006cfc/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-20 06:10:44.904936 | 
2026-08-20 06:10:44.905021 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-20 06:10:44.929935 | instance | skipping: Conditional result was False
2026-08-20 06:10:44.941230 | 
2026-08-20 06:10:44.941340 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-20 06:10:45.376061 | instance | changed
2026-08-20 06:10:45.386829 | 
2026-08-20 06:10:45.387015 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-20 06:10:45.572412 | instance | ok
2026-08-20 06:10:45.580010 | 
2026-08-20 06:10:45.596331 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-20 06:10:46.083565 | instance | changed
2026-08-20 06:10:46.092058 | 
2026-08-20 06:10:46.092140 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-20 06:10:46.561444 | instance | changed
2026-08-20 06:10:46.570998 | 
2026-08-20 06:10:46.571147 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-20 06:10:46.596389 | instance | skipping: Conditional result was False
2026-08-20 06:10:46.606697 | 
2026-08-20 06:10:46.606834 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-20 06:10:47.006417 | instance -> localhost | changed
2026-08-20 06:10:47.024054 | 
2026-08-20 06:10:47.024183 | TASK [add-build-sshkey : Add back temp key]
2026-08-20 06:10:47.328128 | instance -> localhost | Identity added: /var/lib/zuul/builds/3759624931ff4b808989abcddd006cfc/work/3759624931ff4b808989abcddd006cfc_id_rsa (zuul-build-sshkey)
2026-08-20 06:10:47.328335 | instance -> localhost | ok: Runtime: 0:00:00.017373
2026-08-20 06:10:47.333265 | 
2026-08-20 06:10:47.333325 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-20 06:10:47.643063 | instance | ok
2026-08-20 06:10:47.647618 | 
2026-08-20 06:10:47.647683 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-20 06:10:47.671500 | instance | skipping: Conditional result was False
2026-08-20 06:10:47.689417 | 
2026-08-20 06:10:47.689566 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-20 06:10:48.046249 | instance | ok
2026-08-20 06:10:48.298581 | 
2026-08-20 06:10:48.298724 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-20 06:10:51.972279 | instance | Output suppressed because no_log was given
2026-08-20 06:10:51.985525 | 
2026-08-20 06:10:51.985599 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-20 06:10:52.170691 | instance | ok: "logs"
2026-08-20 06:10:52.170956 | instance | ok: All items complete
2026-08-20 06:10:52.170985 | 
2026-08-20 06:10:52.326843 | instance | ok: "artifacts"
2026-08-20 06:10:52.479033 | instance | ok: "docs"
2026-08-20 06:10:52.500302 | 
2026-08-20 06:10:52.500488 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-20 06:10:52.690355 | instance | changed: "logs"
2026-08-20 06:10:52.858044 | instance | changed: "artifacts"
2026-08-20 06:10:53.010641 | instance | changed: "docs"
2026-08-20 06:10:53.023171 | 
2026-08-20 06:10:53.023275 | PLAY RECAP
2026-08-20 06:10:53.023323 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-20 06:10:53.023353 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-20 06:10:53.023376 | 
2026-08-20 06:10:53.183013 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-20 06:10:53.185409 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-20 06:10:53.867522 | 
2026-08-20 06:10:53.867758 | PLAY [all]
2026-08-20 06:10:53.890401 | 
2026-08-20 06:10:53.890641 | TASK [setup-uv : Extract archive]
2026-08-20 06:10:56.038580 | instance | changed
2026-08-20 06:10:56.046037 | 
2026-08-20 06:10:56.046157 | TASK [setup-uv : Print version]
2026-08-20 06:10:56.401068 | instance | uv 0.8.13
2026-08-20 06:10:56.584905 | instance | ok: Runtime: 0:00:00.014668
2026-08-20 06:10:56.597344 | 
2026-08-20 06:10:56.597458 | TASK [Install Ansible collection siblings]
2026-08-20 06:11:05.448244 | instance | changed:
2026-08-20 06:11:05.448470 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-08-20 06:11:05.448514 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-08-20 06:11:05.448546 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-08-20 06:11:05.448575 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-08-20 06:11:05.448604 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-08-20 06:11:05.448639 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-08-20 06:11:05.448670 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-08-20 06:11:05.448702 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-08-20 06:11:05.448731 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-08-20 06:11:05.448760 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-08-20 06:11:05.448789 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-08-20 06:11:05.448816 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-08-20 06:11:05.448844 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-08-20 06:11:05.448871 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-08-20 06:11:05.448899 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0
2026-08-20 06:11:05.448927 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-08-20 06:11:05.448976 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-08-20 06:11:05.449008 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-08-20 06:11:05.449036 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-08-20 06:11:05.449064 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-08-20 06:11:05.449091 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0
2026-08-20 06:11:05.449119 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-08-20 06:11:05.449148 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-20 06:11:05.449193 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-08-20 06:11:05.449222 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0
2026-08-20 06:11:05.449249 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-20 06:11:05.449276 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-20 06:11:05.449303 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-20 06:11:05.449330 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-08-20 06:11:05.449357 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-08-20 06:11:05.449383 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-20 06:11:05.449411 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-20 06:11:05.449438 | instance | Checked out ansible.netcommon to 1.2.0
2026-08-20 06:11:05.449466 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-08-20 06:11:05.449501 | instance | Starting galaxy collection install process
2026-08-20 06:11:05.449528 | instance | Process install dependency map
2026-08-20 06:11:05.449556 | instance | Starting collection install process
2026-08-20 06:11:05.449583 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-08-20 06:11:05.449610 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-08-20 06:11:05.449637 | instance | ansible.netcommon:* was installed successfully
2026-08-20 06:11:05.449664 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-08-20 06:11:05.449691 | instance | Creating virtual environment at: .venv
2026-08-20 06:11:05.449718 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-20 06:11:05.449745 | instance | Downloading netaddr (2.2MiB)
2026-08-20 06:11:05.449772 | instance | Downloading rjsonnet (1.2MiB)
2026-08-20 06:11:05.449802 | instance | Downloading setuptools (1.1MiB)
2026-08-20 06:11:05.449830 | instance | Downloading pydantic-core (2.0MiB)
2026-08-20 06:11:05.449857 | instance | Downloading ansible-core (2.1MiB)
2026-08-20 06:11:05.449885 | instance | Downloading pygments (1.2MiB)
2026-08-20 06:11:05.449912 | instance | Downloading cryptography (4.2MiB)
2026-08-20 06:11:05.449940 | instance | Downloading kubernetes (1.9MiB)
2026-08-20 06:11:05.449967 | instance | Downloading openstacksdk (1.7MiB)
2026-08-20 06:11:05.449993 | instance |  Downloading rjsonnet
2026-08-20 06:11:05.450021 | instance |    Building pyperclip==1.9.0
2026-08-20 06:11:05.450049 | instance |  Downloading pydantic-core
2026-08-20 06:11:05.450076 | instance |  Downloading netaddr
2026-08-20 06:11:05.450103 | instance |  Downloading pygments
2026-08-20 06:11:05.450129 | instance |  Downloading cryptography
2026-08-20 06:11:05.450156 | instance |  Downloading setuptools
2026-08-20 06:11:05.450182 | instance |  Downloading kubernetes
2026-08-20 06:11:05.450208 | instance |  Downloading ansible-core
2026-08-20 06:11:05.450267 | instance |  Downloading openstacksdk
2026-08-20 06:11:05.450299 | instance |       Built pyperclip==1.9.0
2026-08-20 06:11:05.450325 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-20 06:11:05.450352 | instance | Installed 83 packages in 33ms
2026-08-20 06:11:05.450378 | instance | Checked out ansible.posix to 1.6.0
2026-08-20 06:11:05.450404 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-08-20 06:11:05.450431 | instance | Starting galaxy collection install process
2026-08-20 06:11:05.450464 | instance | Process install dependency map
2026-08-20 06:11:05.450509 | instance | Starting collection install process
2026-08-20 06:11:05.450542 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-08-20 06:11:05.450569 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-08-20 06:11:05.450595 | instance | ansible.posix:1.6.0 was installed successfully
2026-08-20 06:11:05.450622 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-20 06:11:05.450648 | instance | 2.17.12
2026-08-20 06:11:05.450675 | instance | Checked out ansible.utils to v6.1.0
2026-08-20 06:11:05.450701 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-08-20 06:11:05.450727 | instance | Starting galaxy collection install process
2026-08-20 06:11:05.450754 | instance | Process install dependency map
2026-08-20 06:11:05.450780 | instance | Starting collection install process
2026-08-20 06:11:05.450806 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-08-20 06:11:05.450833 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-08-20 06:11:05.450860 | instance | ansible.utils:6.1.0 was installed successfully
2026-08-20 06:11:05.450888 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-20 06:11:05.450914 | instance | 2.17.12
2026-08-20 06:11:05.450941 | instance | Checked out atmosphere.common to v0.7.0
2026-08-20 06:11:05.450968 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-08-20 06:11:05.450994 | instance | Starting galaxy collection install process
2026-08-20 06:11:05.451020 | instance | Process install dependency map
2026-08-20 06:11:05.451046 | instance | Starting collection install process
2026-08-20 06:11:05.451072 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-08-20 06:11:05.451098 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-08-20 06:11:05.451125 | instance | atmosphere.common:0.7.0 was installed successfully
2026-08-20 06:11:05.451151 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-20 06:11:05.451177 | instance | 2.17.12
2026-08-20 06:11:05.451203 | instance | Checked out community.crypto to 2.2.3
2026-08-20 06:11:05.451230 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.crypto
2026-08-20 06:11:05.451257 | instance | Starting galaxy collection install process
2026-08-20 06:11:05.451283 | instance | Process install dependency map
2026-08-20 06:11:05.451309 | instance | Starting collection install process
2026-08-20 06:11:05.451335 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-08-20 06:11:05.451361 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-08-20 06:11:05.451429 | instance | community.crypto:2.2.3 was installed successfully
2026-08-20 06:11:05.451456 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-20 06:11:05.451482 | instance | 2.17.12
2026-08-20 06:11:05.451508 | instance | Checked out community.general to 7.3.0
2026-08-20 06:11:05.451534 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.general
2026-08-20 06:11:05.451571 | instance | Starting galaxy collection install process
2026-08-20 06:11:05.451606 | instance | Process install dependency map
2026-08-20 06:11:05.451642 | instance | Starting collection install process
2026-08-20 06:11:05.451675 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-08-20 06:11:05.451720 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-08-20 06:11:05.451752 | instance | community.general:7.3.0 was installed successfully
2026-08-20 06:11:05.451784 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-20 06:11:05.451816 | instance | 2.17.12
2026-08-20 06:11:05.451848 | instance | Checked out community.mysql to 3.6.0
2026-08-20 06:11:05.451897 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.mysql
2026-08-20 06:11:05.451935 | instance | Starting galaxy collection install process
2026-08-20 06:11:05.451982 | instance | Process install dependency map
2026-08-20 06:11:05.452018 | instance | Starting collection install process
2026-08-20 06:11:05.452053 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-08-20 06:11:05.452097 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-08-20 06:11:05.452139 | instance | community.mysql:3.6.0 was installed successfully
2026-08-20 06:11:05.452171 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-20 06:11:05.452207 | instance | 2.17.12
2026-08-20 06:11:05.452239 | instance | Checked out kubernetes.core to 2.4.0
2026-08-20 06:11:05.452267 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-08-20 06:11:05.452294 | instance | Starting galaxy collection install process
2026-08-20 06:11:05.452321 | instance | Process install dependency map
2026-08-20 06:11:05.452348 | instance | Starting collection install process
2026-08-20 06:11:05.452375 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-08-20 06:11:05.452401 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-08-20 06:11:05.452428 | instance | kubernetes.core:2.4.0 was installed successfully
2026-08-20 06:11:05.452455 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-20 06:11:05.452481 | instance | 2.17.12
2026-08-20 06:11:05.452519 | instance | Checked out openstack.cloud to 2.6.0
2026-08-20 06:11:05.452547 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-08-20 06:11:05.452573 | instance | Starting galaxy collection install process
2026-08-20 06:11:05.452599 | instance | Process install dependency map
2026-08-20 06:11:05.452635 | instance | Starting collection install process
2026-08-20 06:11:05.452670 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-08-20 06:11:05.452696 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-08-20 06:11:05.452722 | instance | openstack.cloud:2.6.0 was installed successfully
2026-08-20 06:11:05.452747 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-20 06:11:05.452773 | instance | 2.17.12
2026-08-20 06:11:05.452807 | instance | Checked out vexxhost.ceph to v4.2.0
2026-08-20 06:11:05.452834 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-08-20 06:11:05.452860 | instance | Starting galaxy collection install process
2026-08-20 06:11:05.452887 | instance | Process install dependency map
2026-08-20 06:11:05.452913 | instance | Starting collection install process
2026-08-20 06:11:05.452939 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-08-20 06:11:05.452994 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-08-20 06:11:05.453023 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-08-20 06:11:05.453049 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-20 06:11:05.453075 | instance | 2.17.12
2026-08-20 06:11:05.453101 | instance | Checked out vexxhost.containers to v1.6.8
2026-08-20 06:11:05.453147 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-08-20 06:11:05.453175 | instance | Starting galaxy collection install process
2026-08-20 06:11:05.453201 | instance | Process install dependency map
2026-08-20 06:11:05.453227 | instance | Starting collection install process
2026-08-20 06:11:05.453253 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-08-20 06:11:05.453279 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-08-20 06:11:05.453305 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-08-20 06:11:05.453340 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-20 06:11:05.453369 | instance | 2.17.12
2026-08-20 06:11:05.453404 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-08-20 06:11:05.453432 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-08-20 06:11:05.453458 | instance | Starting galaxy collection install process
2026-08-20 06:11:05.453484 | instance | Process install dependency map
2026-08-20 06:11:05.453511 | instance | Starting collection install process
2026-08-20 06:11:05.453546 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-08-20 06:11:05.453582 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-08-20 06:11:05.453609 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-08-20 06:11:05.453636 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-20 06:11:05.453662 | instance | 2.17.12
2026-08-20 06:11:05.460928 | 
2026-08-20 06:11:05.460994 | PLAY RECAP
2026-08-20 06:11:05.461041 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-20 06:11:05.461063 | 
2026-08-20 06:11:05.660669 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-20 06:11:05.666100 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-20 06:11:06.250394 | 
2026-08-20 06:11:06.250526 | PLAY [all]
2026-08-20 06:11:06.261645 | 
2026-08-20 06:11:06.261718 | TASK [Install "jq" for log collection]
2026-08-20 06:11:16.127279 | instance | changed
2026-08-20 06:11:16.130110 | 
2026-08-20 06:11:16.130193 | PLAY RECAP
2026-08-20 06:11:16.130263 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-20 06:11:16.130341 | 
2026-08-20 06:11:16.303258 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-20 06:11:16.306186 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-20 06:11:16.948116 | 
2026-08-20 06:11:16.948720 | PLAY [all]
2026-08-20 06:11:16.960443 | 
2026-08-20 06:11:16.960516 | LOOP [Check inventory directories]
2026-08-20 06:11:17.296822 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-08-20 06:11:17.446550 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-08-20 06:11:17.606250 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-08-20 06:11:17.619150 | 
2026-08-20 06:11:17.619397 | LOOP [Copy inventory file for Zuul]
2026-08-20 06:11:18.416920 | instance | changed:
2026-08-20 06:11:18.417273 | instance | {
2026-08-20 06:11:18.417332 | instance |   "ansible_loop_var": "item",
2026-08-20 06:11:18.417371 | instance |   "changed": false,
2026-08-20 06:11:18.417409 | instance |   "failed": false,
2026-08-20 06:11:18.417457 | instance |   "invocation": {
2026-08-20 06:11:18.417494 | instance |     "module_args": {
2026-08-20 06:11:18.417526 | instance |       "checksum_algorithm": "sha1",
2026-08-20 06:11:18.417558 | instance |       "follow": true,
2026-08-20 06:11:18.417588 | instance |       "get_attributes": true,
2026-08-20 06:11:18.417620 | instance |       "get_checksum": true,
2026-08-20 06:11:18.417650 | instance |       "get_mime": true,
2026-08-20 06:11:18.417679 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-08-20 06:11:18.417708 | instance |     }
2026-08-20 06:11:18.417743 | instance |   },
2026-08-20 06:11:18.417778 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-08-20 06:11:18.417815 | instance |   "stat": {
2026-08-20 06:11:18.417851 | instance |     "atime": 1787206258.6888857,
2026-08-20 06:11:18.417888 | instance |     "attr_flags": "e",
2026-08-20 06:11:18.417924 | instance |     "attributes": [
2026-08-20 06:11:18.417957 | instance |       "extents"
2026-08-20 06:11:18.417992 | instance |     ],
2026-08-20 06:11:18.418025 | instance |     "block_size": 4096,
2026-08-20 06:11:18.418058 | instance |     "blocks": 8,
2026-08-20 06:11:18.418091 | instance |     "charset": "unknown",
2026-08-20 06:11:18.418126 | instance |     "ctime": 1787206257.3968716,
2026-08-20 06:11:18.418160 | instance |     "dev": 64513,
2026-08-20 06:11:18.418193 | instance |     "device_type": 0,
2026-08-20 06:11:18.418225 | instance |     "executable": true,
2026-08-20 06:11:18.418258 | instance |     "exists": true,
2026-08-20 06:11:18.418289 | instance |     "gid": 1000,
2026-08-20 06:11:18.418317 | instance |     "gr_name": "zuul",
2026-08-20 06:11:18.418345 | instance |     "inode": 1048683,
2026-08-20 06:11:18.418372 | instance |     "isblk": false,
2026-08-20 06:11:18.418401 | instance |     "ischr": false,
2026-08-20 06:11:18.418427 | instance |     "isdir": true,
2026-08-20 06:11:18.418453 | instance |     "isfifo": false,
2026-08-20 06:11:18.418480 | instance |     "isgid": false,
2026-08-20 06:11:18.418508 | instance |     "islnk": false,
2026-08-20 06:11:18.418535 | instance |     "isreg": false,
2026-08-20 06:11:18.418563 | instance |     "issock": false,
2026-08-20 06:11:18.418589 | instance |     "isuid": false,
2026-08-20 06:11:18.418616 | instance |     "mimetype": "unknown",
2026-08-20 06:11:18.418645 | instance |     "mode": "0755",
2026-08-20 06:11:18.418676 | instance |     "mtime": 1787206257.3968716,
2026-08-20 06:11:18.418709 | instance |     "nlink": 22,
2026-08-20 06:11:18.418739 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-08-20 06:11:18.418772 | instance |     "pw_name": "zuul",
2026-08-20 06:11:18.418810 | instance |     "readable": true,
2026-08-20 06:11:18.418844 | instance |     "rgrp": true,
2026-08-20 06:11:18.418878 | instance |     "roth": true,
2026-08-20 06:11:18.418927 | instance |     "rusr": true,
2026-08-20 06:11:18.418961 | instance |     "size": 4096,
2026-08-20 06:11:18.418991 | instance |     "uid": 1000,
2026-08-20 06:11:18.419020 | instance |     "version": "785383509",
2026-08-20 06:11:18.419052 | instance |     "wgrp": false,
2026-08-20 06:11:18.419089 | instance |     "woth": false,
2026-08-20 06:11:18.419123 | instance |     "writeable": true,
2026-08-20 06:11:18.419157 | instance |     "wusr": true,
2026-08-20 06:11:18.419190 | instance |     "xgrp": true,
2026-08-20 06:11:18.419220 | instance |     "xoth": true,
2026-08-20 06:11:18.419251 | instance |     "xusr": true
2026-08-20 06:11:18.419284 | instance |   }
2026-08-20 06:11:18.419315 | instance | }
2026-08-20 06:11:18.419371 | instance | ok: All items complete
2026-08-20 06:11:18.419405 | 
2026-08-20 06:11:18.421475 | instance | skipping: Conditional result was False
2026-08-20 06:11:18.422284 | instance | skipping: Conditional result was False
2026-08-20 06:11:18.435035 | 
2026-08-20 06:11:18.435179 | LOOP [Switch "ansible_host" to private IP]
2026-08-20 06:11:18.785971 | instance | changed: 1 replacements made
2026-08-20 06:11:18.789034 | instance | skipping: Conditional result was False
2026-08-20 06:11:18.792772 | instance | skipping: Conditional result was False
2026-08-20 06:11:18.810730 | 
2026-08-20 06:11:18.810919 | TASK [Run Molecule scenario]
2026-08-20 06:11:19.685912 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-08-20 06:11:20.064994 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-08-20 06:11:20.065098 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-08-20 06:11:30.901606 | instance | INFO     [csi > dependency] Executing
2026-08-20 06:11:30.901840 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-08-20 06:11:30.902171 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-08-20 06:11:30.902338 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-08-20 06:11:30.909770 | instance | INFO     [csi > cleanup] Executing
2026-08-20 06:11:30.910085 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-20 06:11:30.917568 | instance | INFO     [csi > destroy] Executing
2026-08-20 06:11:30.917633 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-08-20 06:11:30.917708 | instance | INFO     [csi > destroy] Executed: Successful
2026-08-20 06:11:30.934298 | instance | INFO     [csi > syntax] Executing
2026-08-20 06:11:32.535956 | instance |
2026-08-20 06:11:32.536238 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-20 06:11:32.597749 | instance | INFO     [csi > syntax] Executed: Successful
2026-08-20 06:11:32.610630 | instance | INFO     [csi > create] Executing
2026-08-20 06:11:32.613151 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-20 06:11:32.620810 | instance | INFO     [csi > prepare] Executing
2026-08-20 06:11:33.397383 | instance |
2026-08-20 06:11:33.397623 | instance | PLAY [Prepare] *****************************************************************
2026-08-20 06:11:33.397976 | instance |
2026-08-20 06:11:33.398298 | instance | TASK [Gathering Facts] *********************************************************
2026-08-20 06:11:33.398578 | instance | Thursday 20 August 2026  06:11:33 +0000 (0:00:00.025)       0:00:00.025 *******
2026-08-20 06:11:34.492257 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-20 06:11:34.492486 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-20 06:11:34.492750 | instance | interpreter could change the meaning of that path. See
2026-08-20 06:11:34.493062 | instance | https://docs.ansible.com/ansible-
2026-08-20 06:11:34.493330 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-20 06:11:34.501116 | instance | ok: [instance]
2026-08-20 06:11:34.501359 | instance |
2026-08-20 06:11:34.501634 | instance | TASK [Configure short hostname] ************************************************
2026-08-20 06:11:34.501877 | instance | Thursday 20 August 2026  06:11:34 +0000 (0:00:01.104)       0:00:01.130 *******
2026-08-20 06:11:35.143757 | instance | changed: [instance]
2026-08-20 06:11:35.144043 | instance |
2026-08-20 06:11:35.144428 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-08-20 06:11:35.144786 | instance | Thursday 20 August 2026  06:11:35 +0000 (0:00:00.642)       0:00:01.772 *******
2026-08-20 06:11:35.385310 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-08-20 06:11:35.385601 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-08-20 06:11:35.385869 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-08-20 06:11:35.394306 | instance | changed: [instance]
2026-08-20 06:11:35.394573 | instance |
2026-08-20 06:11:35.394843 | instance | TASK [Purge "snapd" package] ***************************************************
2026-08-20 06:11:35.395104 | instance | Thursday 20 August 2026  06:11:35 +0000 (0:00:00.250)       0:00:02.023 *******
2026-08-20 06:11:36.134820 | instance | ok: [instance]
2026-08-20 06:11:36.135047 | instance |
2026-08-20 06:11:36.135320 | instance | PLAY [Create devices for Ceph] *************************************************
2026-08-20 06:11:36.135569 | instance |
2026-08-20 06:11:36.135835 | instance | TASK [Gathering Facts] *********************************************************
2026-08-20 06:11:36.136108 | instance | Thursday 20 August 2026  06:11:36 +0000 (0:00:00.740)       0:00:02.763 *******
2026-08-20 06:11:36.805510 | instance | ok: [instance]
2026-08-20 06:11:36.805723 | instance |
2026-08-20 06:11:36.806017 | instance | TASK [Install depedencies] *****************************************************
2026-08-20 06:11:36.806272 | instance | Thursday 20 August 2026  06:11:36 +0000 (0:00:00.670)       0:00:03.434 *******
2026-08-20 06:11:55.468434 | instance | changed: [instance]
2026-08-20 06:11:55.468672 | instance |
2026-08-20 06:11:55.468992 | instance | TASK [Start up service] ********************************************************
2026-08-20 06:11:55.469302 | instance | Thursday 20 August 2026  06:11:55 +0000 (0:00:18.662)       0:00:22.096 *******
2026-08-20 06:11:55.999116 | instance | ok: [instance]
2026-08-20 06:11:55.999352 | instance |
2026-08-20 06:11:55.999624 | instance | TASK [Generate lvm.conf] *******************************************************
2026-08-20 06:11:55.999903 | instance | Thursday 20 August 2026  06:11:55 +0000 (0:00:00.531)       0:00:22.628 *******
2026-08-20 06:11:56.276955 | instance | ok: [instance]
2026-08-20 06:11:56.277138 | instance |
2026-08-20 06:11:56.277464 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-08-20 06:11:56.277741 | instance | Thursday 20 August 2026  06:11:56 +0000 (0:00:00.277)       0:00:22.905 *******
2026-08-20 06:11:56.907907 | instance | changed: [instance]
2026-08-20 06:11:56.908071 | instance |
2026-08-20 06:11:56.908355 | instance | TASK [Get list of all loopback devices] ****************************************
2026-08-20 06:11:56.908628 | instance | Thursday 20 August 2026  06:11:56 +0000 (0:00:00.630)       0:00:23.536 *******
2026-08-20 06:11:57.105155 | instance | ok: [instance]
2026-08-20 06:11:57.105403 | instance |
2026-08-20 06:11:57.105692 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-08-20 06:11:57.105923 | instance | Thursday 20 August 2026  06:11:57 +0000 (0:00:00.197)       0:00:23.733 *******
2026-08-20 06:11:57.125139 | instance | skipping: [instance]
2026-08-20 06:11:57.125401 | instance |
2026-08-20 06:11:57.125676 | instance | TASK [Create devices for Ceph] *************************************************
2026-08-20 06:11:57.125906 | instance | Thursday 20 August 2026  06:11:57 +0000 (0:00:00.021)       0:00:23.754 *******
2026-08-20 06:11:57.665471 | instance | changed: [instance] => (item=osd0)
2026-08-20 06:11:57.665711 | instance | changed: [instance] => (item=osd1)
2026-08-20 06:11:57.666014 | instance | changed: [instance] => (item=osd2)
2026-08-20 06:11:57.666269 | instance |
2026-08-20 06:11:57.666601 | instance | TASK [Set permissions on loopback devices] *************************************
2026-08-20 06:11:57.666882 | instance | Thursday 20 August 2026  06:11:57 +0000 (0:00:00.539)       0:00:24.294 *******
2026-08-20 06:11:58.256930 | instance | changed: [instance] => (item=osd0)
2026-08-20 06:11:58.257162 | instance | changed: [instance] => (item=osd1)
2026-08-20 06:11:58.257175 | instance | changed: [instance] => (item=osd2)
2026-08-20 06:11:58.257192 | instance |
2026-08-20 06:11:58.257367 | instance | TASK [Start loop devices] ******************************************************
2026-08-20 06:11:58.257613 | instance | Thursday 20 August 2026  06:11:58 +0000 (0:00:00.590)       0:00:24.884 *******
2026-08-20 06:11:58.924108 | instance | changed: [instance] => (item=osd0)
2026-08-20 06:11:58.924185 | instance | changed: [instance] => (item=osd1)
2026-08-20 06:11:58.924192 | instance | changed: [instance] => (item=osd2)
2026-08-20 06:11:58.924199 | instance |
2026-08-20 06:11:58.924206 | instance | TASK [Create a volume group for each loop device] ******************************
2026-08-20 06:11:58.924212 | instance | Thursday 20 August 2026  06:11:58 +0000 (0:00:00.666)       0:00:25.551 *******
2026-08-20 06:12:01.926926 | instance | changed: [instance] => (item=osd0)
2026-08-20 06:12:01.927036 | instance | changed: [instance] => (item=osd1)
2026-08-20 06:12:01.927821 | instance | changed: [instance] => (item=osd2)
2026-08-20 06:12:01.927882 | instance |
2026-08-20 06:12:01.927890 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-08-20 06:12:01.927897 | instance | Thursday 20 August 2026  06:12:01 +0000 (0:00:03.004)       0:00:28.555 *******
2026-08-20 06:12:03.746053 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-08-20 06:12:03.746815 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-08-20 06:12:03.746878 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-08-20 06:12:03.746890 | instance |
2026-08-20 06:12:03.746900 | instance | PLAY RECAP *********************************************************************
2026-08-20 06:12:03.746946 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-08-20 06:12:03.747714 | instance |
2026-08-20 06:12:03.747926 | instance | Thursday 20 August 2026  06:12:03 +0000 (0:00:01.819)       0:00:30.375 *******
2026-08-20 06:12:03.747939 | instance | ===============================================================================
2026-08-20 06:12:03.747949 | instance | Install depedencies ---------------------------------------------------- 18.66s
2026-08-20 06:12:03.747963 | instance | Create a volume group for each loop device ------------------------------ 3.00s
2026-08-20 06:12:03.747974 | instance | Create a logical volume for each loop device ---------------------------- 1.82s
2026-08-20 06:12:03.748921 | instance | Gathering Facts --------------------------------------------------------- 1.10s
2026-08-20 06:12:03.748938 | instance | Purge "snapd" package --------------------------------------------------- 0.74s
2026-08-20 06:12:03.748948 | instance | Gathering Facts --------------------------------------------------------- 0.67s
2026-08-20 06:12:03.748957 | instance | Start loop devices ------------------------------------------------------ 0.67s
2026-08-20 06:12:03.748966 | instance | Configure short hostname ------------------------------------------------ 0.64s
2026-08-20 06:12:03.750331 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.63s
2026-08-20 06:12:03.750358 | instance | Set permissions on loopback devices ------------------------------------- 0.59s
2026-08-20 06:12:03.750367 | instance | Create devices for Ceph ------------------------------------------------- 0.54s
2026-08-20 06:12:03.750374 | instance | Start up service -------------------------------------------------------- 0.53s
2026-08-20 06:12:03.750380 | instance | Generate lvm.conf ------------------------------------------------------- 0.28s
2026-08-20 06:12:03.750386 | instance | Ensure hostname inside hosts file --------------------------------------- 0.25s
2026-08-20 06:12:03.750392 | instance | Get list of all loopback devices ---------------------------------------- 0.20s
2026-08-20 06:12:03.750398 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s
2026-08-20 06:12:03.837278 | instance | INFO     [csi > prepare] Executed: Successful
2026-08-20 06:12:03.849420 | instance | INFO     [csi > converge] Executing
2026-08-20 06:12:05.284908 | instance |
2026-08-20 06:12:05.285088 | instance | PLAY [Debug CSI driver value] **************************************************
2026-08-20 06:12:05.285251 | instance |
2026-08-20 06:12:05.285520 | instance | TASK [Gathering Facts] *********************************************************
2026-08-20 06:12:05.285786 | instance | Thursday 20 August 2026  06:12:05 +0000 (0:00:00.007)       0:00:00.007 *******
2026-08-20 06:12:06.213393 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-20 06:12:06.213624 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-20 06:12:06.213927 | instance | interpreter could change the meaning of that path. See
2026-08-20 06:12:06.214303 | instance | https://docs.ansible.com/ansible-
2026-08-20 06:12:06.214535 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-20 06:12:06.224366 | instance | ok: [instance]
2026-08-20 06:12:06.224633 | instance |
2026-08-20 06:12:06.224953 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-08-20 06:12:06.225221 | instance | Thursday 20 August 2026  06:12:06 +0000 (0:00:00.939)       0:00:00.947 *******
2026-08-20 06:12:06.268381 | instance | ok: [instance] => {
2026-08-20 06:12:06.268641 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-08-20 06:12:06.268959 | instance | }
2026-08-20 06:12:06.269208 | instance |
2026-08-20 06:12:06.269480 | instance | PLAY [all] *********************************************************************
2026-08-20 06:12:06.269736 | instance |
2026-08-20 06:12:06.270014 | instance | TASK [Gathering Facts] *********************************************************
2026-08-20 06:12:06.270292 | instance | Thursday 20 August 2026  06:12:06 +0000 (0:00:00.044)       0:00:00.991 *******
2026-08-20 06:12:07.097846 | instance | ok: [instance]
2026-08-20 06:12:07.098121 | instance |
2026-08-20 06:12:07.098508 | instance | TASK [Fail if atmosphere_ceph_enabled is set] **********************************
2026-08-20 06:12:07.098839 | instance | Thursday 20 August 2026  06:12:07 +0000 (0:00:00.828)       0:00:01.820 *******
2026-08-20 06:12:07.136872 | instance | skipping: [instance]
2026-08-20 06:12:07.137139 | instance |
2026-08-20 06:12:07.137414 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-08-20 06:12:07.137690 | instance | Thursday 20 August 2026  06:12:07 +0000 (0:00:00.039)       0:00:01.859 *******
2026-08-20 06:12:07.318730 | instance | ok: [instance]
2026-08-20 06:12:07.319048 | instance |
2026-08-20 06:12:07.319358 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-08-20 06:12:07.319606 | instance |
2026-08-20 06:12:07.319910 | instance | TASK [Gathering Facts] *********************************************************
2026-08-20 06:12:07.320211 | instance | Thursday 20 August 2026  06:12:07 +0000 (0:00:00.182)       0:00:02.041 *******
2026-08-20 06:12:08.158745 | instance | ok: [instance]
2026-08-20 06:12:08.159167 | instance |
2026-08-20 06:12:08.159563 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-20 06:12:08.159927 | instance | Thursday 20 August 2026  06:12:08 +0000 (0:00:00.839)       0:00:02.881 *******
2026-08-20 06:12:08.465327 | instance | ok: [instance]
2026-08-20 06:12:08.465407 | instance |
2026-08-20 06:12:08.465555 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-20 06:12:08.465735 | instance | Thursday 20 August 2026  06:12:08 +0000 (0:00:00.306)       0:00:03.187 *******
2026-08-20 06:12:08.505347 | instance | skipping: [instance]
2026-08-20 06:12:08.505440 | instance |
2026-08-20 06:12:08.505616 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-08-20 06:12:08.505776 | instance | Thursday 20 August 2026  06:12:08 +0000 (0:00:00.040)       0:00:03.228 *******
2026-08-20 06:12:08.821407 | instance | changed: [instance]
2026-08-20 06:12:08.821510 | instance |
2026-08-20 06:12:08.821678 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-20 06:12:08.821890 | instance | Thursday 20 August 2026  06:12:08 +0000 (0:00:00.315)       0:00:03.544 *******
2026-08-20 06:12:08.889117 | instance | ok: [instance] => {
2026-08-20 06:12:08.889219 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-08-20 06:12:08.889344 | instance | }
2026-08-20 06:12:08.889463 | instance |
2026-08-20 06:12:08.889631 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-20 06:12:08.889781 | instance | Thursday 20 August 2026  06:12:08 +0000 (0:00:00.066)       0:00:03.610 *******
2026-08-20 06:12:09.809105 | instance | changed: [instance]
2026-08-20 06:12:09.809356 | instance |
2026-08-20 06:12:09.809587 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-20 06:12:09.809797 | instance | Thursday 20 August 2026  06:12:09 +0000 (0:00:00.918)       0:00:04.528 *******
2026-08-20 06:12:09.854017 | instance | skipping: [instance]
2026-08-20 06:12:09.854056 | instance |
2026-08-20 06:12:09.854061 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-20 06:12:09.854066 | instance | Thursday 20 August 2026  06:12:09 +0000 (0:00:00.047)       0:00:04.576 *******
2026-08-20 06:12:09.903323 | instance | skipping: [instance]
2026-08-20 06:12:09.903366 | instance |
2026-08-20 06:12:09.903373 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-20 06:12:09.903378 | instance | Thursday 20 August 2026  06:12:09 +0000 (0:00:00.049)       0:00:04.626 *******
2026-08-20 06:12:10.104301 | instance | ok: [instance]
2026-08-20 06:12:10.104337 | instance |
2026-08-20 06:12:10.104343 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-20 06:12:10.104348 | instance | Thursday 20 August 2026  06:12:10 +0000 (0:00:00.201)       0:00:04.827 *******
2026-08-20 06:12:11.246908 | instance | ok: [instance]
2026-08-20 06:12:11.246957 | instance |
2026-08-20 06:12:11.246963 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-20 06:12:11.246983 | instance | Thursday 20 August 2026  06:12:11 +0000 (0:00:01.142)       0:00:05.969 *******
2026-08-20 06:12:11.307110 | instance | ok: [instance] => {
2026-08-20 06:12:11.307161 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-08-20 06:12:11.307173 | instance | }
2026-08-20 06:12:11.307182 | instance |
2026-08-20 06:12:11.307191 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-20 06:12:11.307201 | instance | Thursday 20 August 2026  06:12:11 +0000 (0:00:00.059)       0:00:06.028 *******
2026-08-20 06:12:11.968890 | instance | changed: [instance]
2026-08-20 06:12:11.968958 | instance |
2026-08-20 06:12:11.968970 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-20 06:12:11.969060 | instance | Thursday 20 August 2026  06:12:11 +0000 (0:00:00.662)       0:00:06.691 *******
2026-08-20 06:12:14.788725 | instance | changed: [instance]
2026-08-20 06:12:14.788943 | instance |
2026-08-20 06:12:14.788958 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-08-20 06:12:14.789066 | instance | Thursday 20 August 2026  06:12:14 +0000 (0:00:02.820)       0:00:09.511 *******
2026-08-20 06:12:14.816066 | instance | skipping: [instance]
2026-08-20 06:12:14.816645 | instance |
2026-08-20 06:12:14.816679 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-08-20 06:12:14.816684 | instance | Thursday 20 August 2026  06:12:14 +0000 (0:00:00.027)       0:00:09.539 *******
2026-08-20 06:12:14.843558 | instance | skipping: [instance]
2026-08-20 06:12:14.843929 | instance |
2026-08-20 06:12:14.843946 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-08-20 06:12:14.843951 | instance | Thursday 20 August 2026  06:12:14 +0000 (0:00:00.027)       0:00:09.566 *******
2026-08-20 06:12:14.882393 | instance | skipping: [instance]
2026-08-20 06:12:14.882812 | instance |
2026-08-20 06:12:14.882873 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-08-20 06:12:14.882880 | instance | Thursday 20 August 2026  06:12:14 +0000 (0:00:00.038)       0:00:09.605 *******
2026-08-20 06:12:19.486049 | instance | changed: [instance]
2026-08-20 06:12:19.486271 | instance |
2026-08-20 06:12:19.486284 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-08-20 06:12:19.486418 | instance | Thursday 20 August 2026  06:12:19 +0000 (0:00:04.604)       0:00:14.209 *******
2026-08-20 06:12:20.036349 | instance | changed: [instance]
2026-08-20 06:12:20.036451 | instance |
2026-08-20 06:12:20.036722 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-08-20 06:12:20.036760 | instance | Thursday 20 August 2026  06:12:20 +0000 (0:00:00.550)       0:00:14.759 *******
2026-08-20 06:12:20.903984 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-08-20 06:12:20.904048 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-08-20 06:12:20.904869 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-08-20 06:12:20.904919 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-08-20 06:12:20.904927 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-08-20 06:12:20.904932 | instance |
2026-08-20 06:12:20.904938 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-08-20 06:12:20.904943 | instance | Thursday 20 August 2026  06:12:20 +0000 (0:00:00.867)       0:00:15.627 *******
2026-08-20 06:12:21.482533 | instance | changed: [instance]
2026-08-20 06:12:21.482636 | instance |
2026-08-20 06:12:21.483286 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-08-20 06:12:21.483442 | instance | Thursday 20 August 2026  06:12:21 +0000 (0:00:00.561)       0:00:16.189 *******
2026-08-20 06:12:21.483448 | instance |
2026-08-20 06:12:21.483453 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-20 06:12:21.483457 | instance | Thursday 20 August 2026  06:12:21 +0000 (0:00:00.016)       0:00:16.205 *******
2026-08-20 06:12:22.377016 | instance | ok: [instance]
2026-08-20 06:12:22.377143 | instance |
2026-08-20 06:12:22.377430 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-08-20 06:12:22.377463 | instance | Thursday 20 August 2026  06:12:22 +0000 (0:00:00.894)       0:00:17.100 *******
2026-08-20 06:12:22.797319 | instance | changed: [instance]
2026-08-20 06:12:22.797405 | instance |
2026-08-20 06:12:22.797659 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-08-20 06:12:22.797700 | instance | Thursday 20 August 2026  06:12:22 +0000 (0:00:00.420)       0:00:17.520 *******
2026-08-20 06:12:23.336558 | instance | changed: [instance]
2026-08-20 06:12:23.336664 | instance |
2026-08-20 06:12:23.336892 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-20 06:12:23.336966 | instance | Thursday 20 August 2026  06:12:23 +0000 (0:00:00.539)       0:00:18.059 *******
2026-08-20 06:12:23.541994 | instance | ok: [instance]
2026-08-20 06:12:23.542095 | instance |
2026-08-20 06:12:23.542364 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-20 06:12:23.542406 | instance | Thursday 20 August 2026  06:12:23 +0000 (0:00:00.205)       0:00:18.264 *******
2026-08-20 06:12:23.596015 | instance | ok: [instance] => {
2026-08-20 06:12:23.596637 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-08-20 06:12:23.596670 | instance | }
2026-08-20 06:12:23.596675 | instance |
2026-08-20 06:12:23.596680 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-20 06:12:23.596685 | instance | Thursday 20 August 2026  06:12:23 +0000 (0:00:00.054)       0:00:18.319 *******
2026-08-20 06:12:24.463664 | instance | changed: [instance]
2026-08-20 06:12:24.463733 | instance |
2026-08-20 06:12:24.464036 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-20 06:12:24.464074 | instance | Thursday 20 August 2026  06:12:24 +0000 (0:00:00.867)       0:00:19.186 *******
2026-08-20 06:12:28.753658 | instance | changed: [instance]
2026-08-20 06:12:28.753734 | instance |
2026-08-20 06:12:28.753958 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-08-20 06:12:28.753994 | instance | Thursday 20 August 2026  06:12:28 +0000 (0:00:04.290)       0:00:23.476 *******
2026-08-20 06:12:29.788167 | instance | ok: [instance]
2026-08-20 06:12:29.788236 | instance |
2026-08-20 06:12:29.788491 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-08-20 06:12:29.788528 | instance | Thursday 20 August 2026  06:12:29 +0000 (0:00:01.034)       0:00:24.511 *******
2026-08-20 06:12:30.129649 | instance | changed: [instance]
2026-08-20 06:12:30.129709 | instance |
2026-08-20 06:12:30.130019 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-08-20 06:12:30.130053 | instance | Thursday 20 August 2026  06:12:30 +0000 (0:00:00.341)       0:00:24.852 *******
2026-08-20 06:12:30.574156 | instance | changed: [instance]
2026-08-20 06:12:30.574227 | instance |
2026-08-20 06:12:30.574507 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-08-20 06:12:30.574628 | instance | Thursday 20 August 2026  06:12:30 +0000 (0:00:00.444)       0:00:25.297 *******
2026-08-20 06:12:31.120370 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-08-20 06:12:31.120997 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-08-20 06:12:31.121018 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-08-20 06:12:31.121025 | instance |
2026-08-20 06:12:31.121032 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-08-20 06:12:31.121037 | instance | Thursday 20 August 2026  06:12:31 +0000 (0:00:00.546)       0:00:25.843 *******
2026-08-20 06:12:31.550751 | instance | changed: [instance]
2026-08-20 06:12:31.550874 | instance |
2026-08-20 06:12:31.551244 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-08-20 06:12:31.551265 | instance | Thursday 20 August 2026  06:12:31 +0000 (0:00:00.430)       0:00:26.274 *******
2026-08-20 06:12:32.030770 | instance | changed: [instance]
2026-08-20 06:12:32.030833 | instance |
2026-08-20 06:12:32.030839 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-08-20 06:12:32.030860 | instance | Thursday 20 August 2026  06:12:31 +0000 (0:00:00.452)       0:00:26.726 *******
2026-08-20 06:12:32.030864 | instance |
2026-08-20 06:12:32.030868 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-20 06:12:32.030878 | instance | Thursday 20 August 2026  06:12:32 +0000 (0:00:00.026)       0:00:26.752 *******
2026-08-20 06:12:32.726877 | instance | ok: [instance]
2026-08-20 06:12:32.726956 | instance |
2026-08-20 06:12:32.727252 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-08-20 06:12:32.727292 | instance | Thursday 20 August 2026  06:12:32 +0000 (0:00:00.697)       0:00:27.449 *******
2026-08-20 06:12:33.642374 | instance | changed: [instance]
2026-08-20 06:12:33.642411 | instance |
2026-08-20 06:12:33.642416 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-08-20 06:12:33.642421 | instance | Thursday 20 August 2026  06:12:33 +0000 (0:00:00.915)       0:00:28.365 *******
2026-08-20 06:12:34.211470 | instance | changed: [instance]
2026-08-20 06:12:34.211566 | instance |
2026-08-20 06:12:34.211833 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-08-20 06:12:34.211864 | instance | Thursday 20 August 2026  06:12:34 +0000 (0:00:00.569)       0:00:28.934 *******
2026-08-20 06:12:34.266218 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-08-20 06:12:34.266670 | instance |
2026-08-20 06:12:34.266690 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-08-20 06:12:34.266696 | instance | Thursday 20 August 2026  06:12:34 +0000 (0:00:00.054)       0:00:28.989 *******
2026-08-20 06:12:38.645631 | instance | changed: [instance]
2026-08-20 06:12:38.645711 | instance |
2026-08-20 06:12:38.645964 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-08-20 06:12:38.646006 | instance | Thursday 20 August 2026  06:12:38 +0000 (0:00:04.379)       0:00:33.368 *******
2026-08-20 06:12:39.293174 | instance | ok: [instance] => (item=chronyd)
2026-08-20 06:12:39.293678 | instance | ok: [instance] => (item=sshd)
2026-08-20 06:12:39.293811 | instance |
2026-08-20 06:12:39.293817 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-08-20 06:12:39.293822 | instance | Thursday 20 August 2026  06:12:39 +0000 (0:00:00.647)       0:00:34.016 *******
2026-08-20 06:12:41.092444 | instance | changed: [instance]
2026-08-20 06:12:41.092508 | instance |
2026-08-20 06:12:41.092916 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-08-20 06:12:41.092998 | instance | Thursday 20 August 2026  06:12:41 +0000 (0:00:01.799)       0:00:35.815 *******
2026-08-20 06:12:41.295409 | instance | ok: [instance]
2026-08-20 06:12:41.295496 | instance |
2026-08-20 06:12:41.295780 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-08-20 06:12:41.295810 | instance | Thursday 20 August 2026  06:12:41 +0000 (0:00:00.202)       0:00:36.018 *******
2026-08-20 06:12:41.719602 | instance | changed: [instance]
2026-08-20 06:12:41.719670 | instance |
2026-08-20 06:12:41.719977 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-08-20 06:12:41.720017 | instance | Thursday 20 August 2026  06:12:41 +0000 (0:00:00.424)       0:00:36.442 *******
2026-08-20 06:12:42.050621 | instance | changed: [instance]
2026-08-20 06:12:42.050683 | instance |
2026-08-20 06:12:42.050938 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-08-20 06:12:42.050976 | instance | Thursday 20 August 2026  06:12:42 +0000 (0:00:00.330)       0:00:36.773 *******
2026-08-20 06:12:42.242887 | instance | ok: [instance]
2026-08-20 06:12:42.243363 | instance |
2026-08-20 06:12:42.243411 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-08-20 06:12:42.243419 | instance | Thursday 20 August 2026  06:12:42 +0000 (0:00:00.192)       0:00:36.965 *******
2026-08-20 06:12:42.459638 | instance | ok: [instance] => (item=instance)
2026-08-20 06:12:42.459705 | instance |
2026-08-20 06:12:42.460008 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-08-20 06:12:42.460044 | instance | Thursday 20 August 2026  06:12:42 +0000 (0:00:00.216)       0:00:37.182 *******
2026-08-20 06:12:42.513123 | instance | ok: [instance]
2026-08-20 06:12:42.513208 | instance |
2026-08-20 06:12:42.513335 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-08-20 06:12:42.513449 | instance | Thursday 20 August 2026  06:12:42 +0000 (0:00:00.053)       0:00:37.236 *******
2026-08-20 06:12:42.580499 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-08-20 06:12:42.580723 | instance |
2026-08-20 06:12:42.581046 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-08-20 06:12:42.581296 | instance | Thursday 20 August 2026  06:12:42 +0000 (0:00:00.067)       0:00:37.303 *******
2026-08-20 06:12:42.844224 | instance | changed: [instance]
2026-08-20 06:12:42.844358 | instance |
2026-08-20 06:12:42.844536 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-08-20 06:12:42.844709 | instance | Thursday 20 August 2026  06:12:42 +0000 (0:00:00.263)       0:00:37.567 *******
2026-08-20 06:12:43.502032 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-08-20 06:12:43.502300 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-08-20 06:12:43.502602 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-08-20 06:12:43.502869 | instance |
2026-08-20 06:12:43.503156 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-08-20 06:12:43.503431 | instance | Thursday 20 August 2026  06:12:43 +0000 (0:00:00.657)       0:00:38.224 *******
2026-08-20 06:14:07.013772 | instance | ok: [instance]
2026-08-20 06:14:07.013847 | instance |
2026-08-20 06:14:07.014227 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-08-20 06:14:07.014395 | instance | Thursday 20 August 2026  06:14:07 +0000 (0:01:23.511)       0:02:01.736 *******
2026-08-20 06:14:07.223276 | instance | changed: [instance]
2026-08-20 06:14:07.223364 | instance |
2026-08-20 06:14:07.223492 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-08-20 06:14:07.223617 | instance | Thursday 20 August 2026  06:14:07 +0000 (0:00:00.209)       0:02:01.946 *******
2026-08-20 06:14:07.264183 | instance | ok: [instance]
2026-08-20 06:14:07.264353 | instance |
2026-08-20 06:14:07.264465 | instance | TASK [Install Ceph host] *******************************************************
2026-08-20 06:14:07.264590 | instance | Thursday 20 August 2026  06:14:07 +0000 (0:00:00.040)       0:02:01.986 *******
2026-08-20 06:14:07.341633 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-08-20 06:14:07.341883 | instance |
2026-08-20 06:14:07.342166 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-08-20 06:14:07.342436 | instance | Thursday 20 August 2026  06:14:07 +0000 (0:00:00.077)       0:02:02.064 *******
2026-08-20 06:14:08.873847 | instance | ok: [instance]
2026-08-20 06:14:08.874089 | instance |
2026-08-20 06:14:08.874374 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-08-20 06:14:08.874631 | instance | Thursday 20 August 2026  06:14:08 +0000 (0:00:01.532)       0:02:03.596 *******
2026-08-20 06:14:08.931730 | instance | ok: [instance] => (item=instance)
2026-08-20 06:14:08.931949 | instance |
2026-08-20 06:14:08.932213 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-08-20 06:14:08.932468 | instance | Thursday 20 August 2026  06:14:08 +0000 (0:00:00.058)       0:02:03.654 *******
2026-08-20 06:14:09.270004 | instance | ok: [instance]
2026-08-20 06:14:09.270265 | instance |
2026-08-20 06:14:09.270581 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-08-20 06:14:09.270873 | instance | Thursday 20 August 2026  06:14:09 +0000 (0:00:00.337)       0:02:03.992 *******
2026-08-20 06:14:11.666893 | instance | ok: [instance]
2026-08-20 06:14:11.666958 | instance |
2026-08-20 06:14:11.666971 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-08-20 06:14:11.666981 | instance | Thursday 20 August 2026  06:14:11 +0000 (0:00:02.396)       0:02:06.388 *******
2026-08-20 06:14:54.450643 | instance | An exception occurred during task execution. To see the full traceback, use -vvv. The error was: [errno 5] RADOS I/O error (error connecting to the cluster)
2026-08-20 06:14:54.451553 | 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_eyd2t56d/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_eyd2t56d/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_eyd2t56d/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_eyd2t56d/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-20T06:14:54.288+0000 7f6e58624640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAGm4Zq6ZyxAiAAHnn7GOi+LgDlDG0yotLddUDTT6AM+3mnx4TP48c8rgc=: Malformed input [buffer:3]\n2026-08-20T06:14:54.288+0000 7f6e58624640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-20T06:14:54.292+0000 7f6e58624640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAGm4Zq6ZyxAiAAHnn7GOi+LgDlDG0yotLddUDTT6AM+3mnx4TP48c8rgc=: Malformed input [buffer:3]\n2026-08-20T06:14:54.292+0000 7f6e58624640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-20T06:14:54.292+0000 7f6e58624640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAGm4Zq6ZyxAiAAHnn7GOi+LgDlDG0yotLddUDTT6AM+3mnx4TP48c8rgc=: Malformed input [buffer:3]\n2026-08-20T06:14:54.292+0000 7f6e58624640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-20T06:14:54.292+0000 7f6e58624640 -1 monclient: keyring not found\n[errno 5] RADOS I/O error (error connecting to the cluster)\n\n", "module_stdout": "", "msg": "MODULE FAILURE\nSee stdout/stderr for the exact error", "rc": 1}
2026-08-20 06:14:54.456879 | instance |
2026-08-20 06:14:54.456946 | instance | PLAY RECAP *********************************************************************
2026-08-20 06:14:54.456960 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=7    rescued=0    ignored=0
2026-08-20 06:14:54.456971 | instance |
2026-08-20 06:14:54.456981 | instance | Thursday 20 August 2026  06:14:54 +0000 (0:00:42.789)       0:02:49.177 *******
2026-08-20 06:14:54.456991 | instance | ===============================================================================
2026-08-20 06:14:54.457001 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 83.51s
2026-08-20 06:14:54.457010 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 42.79s
2026-08-20 06:14:54.457020 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 4.60s
2026-08-20 06:14:54.457030 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 4.38s
2026-08-20 06:14:54.457039 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.29s
2026-08-20 06:14:54.457049 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.82s
2026-08-20 06:14:54.457075 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.40s
2026-08-20 06:14:54.457085 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 1.80s
2026-08-20 06:14:54.457102 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.59s
2026-08-20 06:14:54.459622 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.53s
2026-08-20 06:14:54.459652 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.14s
2026-08-20 06:14:54.459661 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.03s
2026-08-20 06:14:54.459669 | instance | Gathering Facts --------------------------------------------------------- 0.94s
2026-08-20 06:14:54.459676 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.92s
2026-08-20 06:14:54.459684 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 0.92s
2026-08-20 06:14:54.459692 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.87s
2026-08-20 06:14:54.459699 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.87s
2026-08-20 06:14:54.459707 | instance | Gathering Facts --------------------------------------------------------- 0.84s
2026-08-20 06:14:54.459715 | instance | Gathering Facts --------------------------------------------------------- 0.83s
2026-08-20 06:14:54.459723 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.66s
2026-08-20 06:14:54.544283 | instance | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-20 06:14:54.544572 | instance | ERROR    [csi > converge] Executed: Failed
2026-08-20 06:14:54.544763 | instance | ERROR    Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-20 06:14:55.112373 | instance | ERROR
2026-08-20 06:14:55.112595 | instance | {
2026-08-20 06:14:55.112635 | instance |   "delta": "0:03:35.456663",
2026-08-20 06:14:55.112663 | instance |   "end": "2026-08-20 06:14:54.604586",
2026-08-20 06:14:55.112688 | instance |   "msg": "non-zero return code",
2026-08-20 06:14:55.112713 | instance |   "rc": 2,
2026-08-20 06:14:55.112738 | instance |   "start": "2026-08-20 06:11:19.147923"
2026-08-20 06:14:55.112763 | instance | }
failure
2026-08-20 06:14:55.119373 | 
2026-08-20 06:14:55.119439 | PLAY RECAP
2026-08-20 06:14:55.119508 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-08-20 06:14:55.119544 | 
2026-08-20 06:14:55.329638 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-20 06:14:55.334226 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-20 06:14:56.590406 | 
2026-08-20 06:14:56.590551 | PLAY [all]
2026-08-20 06:14:56.604569 | 
2026-08-20 06:14:56.604648 | TASK [gather-host-logs : creating directory for system status]
2026-08-20 06:14:56.962231 | instance | changed
2026-08-20 06:14:56.969795 | 
2026-08-20 06:14:56.969916 | TASK [gather-host-logs : Get logs for each host]
2026-08-20 06:14:57.341233 | instance | + systemd-cgls --full --all --no-pager
2026-08-20 06:14:57.357691 | instance | + ip addr
2026-08-20 06:14:57.360065 | instance | + ip route
2026-08-20 06:14:57.362718 | instance | + lsblk
2026-08-20 06:14:57.366031 | instance | + mount
2026-08-20 06:14:57.368534 | instance | + docker images
2026-08-20 06:14:57.388216 | instance | + brctl show
2026-08-20 06:14:57.388661 | instance | /bin/bash: line 8: brctl: command not found
2026-08-20 06:14:57.388921 | instance | + ps aux --sort=-%mem
2026-08-20 06:14:57.412660 | instance | + dpkg -l
2026-08-20 06:14:57.420932 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-08-20 06:14:57.421307 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-08-20 06:14:57.439052 | instance | + '[' '!' -z '' ']'
2026-08-20 06:14:57.509173 | instance | ok: Runtime: 0:00:00.102852
2026-08-20 06:14:57.517291 | 
2026-08-20 06:14:57.517390 | TASK [gather-host-logs : Downloads logs to executor]
2026-08-20 06:14:58.162225 | instance | changed:
2026-08-20 06:14:58.162487 | instance | created directory /var/lib/zuul/builds/3759624931ff4b808989abcddd006cfc/work/logs/instance
2026-08-20 06:14:58.162527 | instance | cd+++++++++ system/
2026-08-20 06:14:58.162557 | instance | >f+++++++++ system/brctl-show.txt
2026-08-20 06:14:58.162585 | instance | >f+++++++++ system/docker-images.txt
2026-08-20 06:14:58.162612 | instance | >f+++++++++ system/ip-addr.txt
2026-08-20 06:14:58.162640 | instance | >f+++++++++ system/ip-route.txt
2026-08-20 06:14:58.162668 | instance | >f+++++++++ system/lsblk.txt
2026-08-20 06:14:58.162695 | instance | >f+++++++++ system/mount.txt
2026-08-20 06:14:58.162721 | instance | >f+++++++++ system/packages.txt
2026-08-20 06:14:58.162748 | instance | >f+++++++++ system/ps.txt
2026-08-20 06:14:58.162776 | instance | >f+++++++++ system/systemd-cgls.txt
2026-08-20 06:14:58.175309 | 
2026-08-20 06:14:58.175379 | LOOP [helm-release-status : creating directory for helm release status]
2026-08-20 06:14:58.380307 | instance | changed: "values"
2026-08-20 06:14:58.547801 | instance | changed: "releases"
2026-08-20 06:14:58.564640 | 
2026-08-20 06:14:58.564823 | TASK [helm-release-status : Gather get release status for helm charts]
2026-08-20 06:14:58.767898 | instance | /bin/bash: line 3: kubectl: command not found
2026-08-20 06:14:59.102811 | instance | ok: Runtime: 0:00:00.005621
2026-08-20 06:14:59.108276 | 
2026-08-20 06:14:59.108346 | TASK [helm-release-status : Downloads logs to executor]
2026-08-20 06:14:59.577350 | instance | changed:
2026-08-20 06:14:59.577583 | instance | cd+++++++++ helm/
2026-08-20 06:14:59.577622 | instance | cd+++++++++ helm/releases/
2026-08-20 06:14:59.577657 | instance | cd+++++++++ helm/values/
2026-08-20 06:14:59.587420 | 
2026-08-20 06:14:59.587489 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-08-20 06:14:59.773489 | instance | changed
2026-08-20 06:14:59.779331 | 
2026-08-20 06:14:59.779401 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-08-20 06:15:00.024652 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-20 06:15:00.024741 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-20 06:15:00.028731 | instance | environment: line 1: kubectl: command not found
2026-08-20 06:15:00.029966 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-20 06:15:00.031121 | instance | environment: line 1: kubectl: command not found
2026-08-20 06:15:00.031953 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-20 06:15:00.033041 | instance | environment: line 1: kubectl: command not found
2026-08-20 06:15:00.033962 | instance | environment: line 1: kubectl: command not found
2026-08-20 06:15:00.034600 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-20 06:15:00.035138 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-20 06:15:00.037013 | instance | environment: line 1: kubectl: command not found
2026-08-20 06:15:00.037800 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-20 06:15:00.314525 | instance | ok: Runtime: 0:00:00.020734
2026-08-20 06:15:00.321090 | 
2026-08-20 06:15:00.321195 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-08-20 06:15:00.519284 | instance | changed
2026-08-20 06:15:00.527613 | 
2026-08-20 06:15:00.527697 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-08-20 06:15:00.732210 | instance | environment: line 5: kubectl: command not found
2026-08-20 06:15:00.733283 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-20 06:15:00.733453 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-20 06:15:00.733602 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-20 06:15:01.072833 | instance | ok: Runtime: 0:00:00.008245
2026-08-20 06:15:01.080509 | 
2026-08-20 06:15:01.080604 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-08-20 06:15:01.558128 | instance | changed:
2026-08-20 06:15:01.558349 | instance | cd+++++++++ objects/
2026-08-20 06:15:01.558388 | instance | cd+++++++++ objects/cluster/
2026-08-20 06:15:01.558421 | instance | cd+++++++++ objects/namespaced/
2026-08-20 06:15:01.569444 | 
2026-08-20 06:15:01.569510 | TASK [gather-pod-logs : creating directory for pod logs]
2026-08-20 06:15:01.766653 | instance | changed
2026-08-20 06:15:01.772387 | 
2026-08-20 06:15:01.772461 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-08-20 06:15:01.981291 | instance | changed
2026-08-20 06:15:01.986432 | 
2026-08-20 06:15:01.986503 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-08-20 06:15:02.182400 | instance | environment: line 3: kubectl: command not found
2026-08-20 06:15:02.521562 | instance | ok: Runtime: 0:00:00.007964
2026-08-20 06:15:02.528689 | 
2026-08-20 06:15:02.528784 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-08-20 06:15:03.004426 | instance | changed:
2026-08-20 06:15:03.004651 | instance | cd+++++++++ pod-logs/
2026-08-20 06:15:03.004689 | instance | cd+++++++++ pod-logs/failed-pods/
2026-08-20 06:15:03.017510 | 
2026-08-20 06:15:03.017620 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-08-20 06:15:03.211978 | instance | changed
2026-08-20 06:15:03.217918 | 
2026-08-20 06:15:03.217989 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-08-20 06:15:03.430340 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-20 06:15:03.969262 | instance | ok: Runtime: 0:00:00.038009
2026-08-20 06:15:03.975608 | 
2026-08-20 06:15:03.975674 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-08-20 06:15:04.171654 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-20 06:15:04.201438 | instance | ceph-mgr endpoints:
2026-08-20 06:15:04.509664 | instance | ok: Runtime: 0:00:00.035778
2026-08-20 06:15:04.515024 | 
2026-08-20 06:15:04.515095 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-08-20 06:15:04.725542 | instance | /bin/bash: line 4: kubectl: command not found
2026-08-20 06:15:05.054658 | instance | ok: Runtime: 0:00:00.035430
2026-08-20 06:15:05.062133 | 
2026-08-20 06:15:05.062228 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-08-20 06:15:05.523120 | instance | changed: cd+++++++++ prometheus/
2026-08-20 06:15:05.535340 | 
2026-08-20 06:15:05.535425 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-08-20 06:15:05.736278 | instance | changed
2026-08-20 06:15:05.742803 | 
2026-08-20 06:15:05.742879 | TASK [gather-selenium-data : Get selenium data]
2026-08-20 06:15:05.987202 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-08-20 06:15:05.987920 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-08-20 06:15:06.284336 | instance | ERROR
2026-08-20 06:15:06.284611 | instance | {
2026-08-20 06:15:06.284655 | instance |   "delta": "0:00:00.003849",
2026-08-20 06:15:06.284684 | instance |   "end": "2026-08-20 06:15:05.988174",
2026-08-20 06:15:06.284712 | instance |   "msg": "non-zero return code",
2026-08-20 06:15:06.284739 | instance |   "rc": 1,
2026-08-20 06:15:06.284764 | instance |   "start": "2026-08-20 06:15:05.984325"
2026-08-20 06:15:06.284789 | instance | }
2026-08-20 06:15:06.284820 | instance | ERROR: Ignoring Errors
2026-08-20 06:15:06.293514 | 
2026-08-20 06:15:06.293597 | TASK [gather-selenium-data : Downloads logs to executor]
2026-08-20 06:15:06.815219 | instance | changed: cd+++++++++ selenium/
2026-08-20 06:15:06.823220 | 
2026-08-20 06:15:06.823279 | PLAY RECAP
2026-08-20 06:15:06.823330 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-08-20 06:15:06.823351 | 
2026-08-20 06:15:06.977994 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-20 06:15:06.981936 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-20 06:15:07.650575 | 
2026-08-20 06:15:07.650728 | PLAY [all]
2026-08-20 06:15:07.663435 | 
2026-08-20 06:15:07.663528 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-20 06:15:07.709077 | instance | skipping: Conditional result was False
2026-08-20 06:15:07.720151 | 
2026-08-20 06:15:07.720385 | TASK [fetch-output : Set log path for single node]
2026-08-20 06:15:07.765457 | instance | ok
2026-08-20 06:15:07.770186 | 
2026-08-20 06:15:07.770260 | LOOP [fetch-output : Ensure local output dirs]
2026-08-20 06:15:08.219464 | instance -> localhost | ok: "/var/lib/zuul/builds/3759624931ff4b808989abcddd006cfc/work/logs"
2026-08-20 06:15:08.434435 | instance -> localhost | changed: "/var/lib/zuul/builds/3759624931ff4b808989abcddd006cfc/work/artifacts"
2026-08-20 06:15:08.819437 | instance -> localhost | changed: "/var/lib/zuul/builds/3759624931ff4b808989abcddd006cfc/work/docs"
2026-08-20 06:15:08.834859 | 
2026-08-20 06:15:08.834984 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-20 06:15:09.492251 | instance | changed: .d..t...... ./
2026-08-20 06:15:09.492469 | instance | changed: All items complete
2026-08-20 06:15:09.492497 | 
2026-08-20 06:15:09.937193 | instance | changed: .d..t...... ./
2026-08-20 06:15:10.399814 | instance | changed: .d..t...... ./
2026-08-20 06:15:10.427052 | 
2026-08-20 06:15:10.427202 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-20 06:15:10.845844 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.009416
2026-08-20 06:15:11.076447 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007802
2026-08-20 06:15:11.094430 | 
2026-08-20 06:15:11.094490 | PLAY [all]
2026-08-20 06:15:11.100414 | 
2026-08-20 06:15:11.100481 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-20 06:15:11.506829 | instance | changed
2026-08-20 06:15:11.514968 | 
2026-08-20 06:15:11.515024 | PLAY RECAP
2026-08-20 06:15:11.515071 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-20 06:15:11.515093 | 
2026-08-20 06:15:11.657950 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-20 06:15:11.662506 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-20 06:15:12.505561 | 
2026-08-20 06:15:12.505700 | PLAY [localhost]
2026-08-20 06:15:12.515767 | 
2026-08-20 06:15:12.515839 | TASK [Generate Zuul manifest]
2026-08-20 06:15:12.535523 | localhost | ok
2026-08-20 06:15:12.762260 | 
2026-08-20 06:15:12.762437 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-20 06:15:13.160727 | localhost | changed
2026-08-20 06:15:13.174221 | 
2026-08-20 06:15:13.174320 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-20 06:15:13.205636 | localhost | ok
2026-08-20 06:15:13.213944 | 
2026-08-20 06:15:13.214013 | TASK [Upload logs]
2026-08-20 06:15:13.238999 | localhost | ok
2026-08-20 06:15:13.297734 | 
2026-08-20 06:15:13.297858 | TASK [Set zuul-log-path fact]
2026-08-20 06:15:13.319528 | localhost | ok
2026-08-20 06:15:13.334157 | 
2026-08-20 06:15:13.334273 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-20 06:15:13.367014 | localhost | ok
2026-08-20 06:15:13.378293 | 
2026-08-20 06:15:13.378363 | TASK [upload-logs : Create log directories]
2026-08-20 06:15:13.820504 | localhost | changed
2026-08-20 06:15:13.826598 | 
2026-08-20 06:15:13.826670 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-20 06:15:14.257175 | localhost -> localhost | ok: Runtime: 0:00:00.006610
2026-08-20 06:15:14.265509 | 
2026-08-20 06:15:14.265619 | TASK [upload-logs : Upload logs to log server]
2026-08-20 06:15:14.776604 | localhost | Output suppressed because no_log was given
2026-08-20 06:15:14.818153 | 
2026-08-20 06:15:14.818307 | LOOP [upload-logs : Compress console log and json output]
2026-08-20 06:15:14.865897 | localhost | skipping: Conditional result was False
2026-08-20 06:15:14.873013 | localhost | skipping: Conditional result was False
2026-08-20 06:15:14.885158 | 
2026-08-20 06:15:14.885337 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-20 06:15:14.931605 | localhost | skipping: Conditional result was False
2026-08-20 06:15:14.932042 | 
2026-08-20 06:15:14.936365 | localhost | skipping: Conditional result was False
2026-08-20 06:15:14.953271 | 
2026-08-20 06:15:14.953426 | LOOP [upload-logs : Upload console log and json output]