2026-08-24 15:12:02.249200 | Job console starting
2026-08-24 15:12:02.292267 | Updating git repos
2026-08-24 15:12:09.760114 | Cloning repos into workspace
2026-08-24 15:12:26.167834 | Restoring repo states
2026-08-24 15:12:33.433196 | Merging changes
2026-08-24 15:12:35.289222 | Checking out repos
2026-08-24 15:12:39.976346 | Preparing playbooks
2026-08-24 15:12:47.402380 | Running Ansible setup
2026-08-24 15:12:51.512461 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-24 15:12:52.151123 | 
2026-08-24 15:12:52.151262 | PLAY [localhost]
2026-08-24 15:12:52.159507 | 
2026-08-24 15:12:52.159586 | TASK [Gathering Facts]
2026-08-24 15:12:53.072502 | localhost | ok
2026-08-24 15:12:53.082272 | 
2026-08-24 15:12:53.082351 | TASK [Setup log path fact]
2026-08-24 15:12:53.100208 | localhost | ok
2026-08-24 15:12:53.114337 | 
2026-08-24 15:12:53.114493 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-24 15:12:53.146048 | localhost | ok
2026-08-24 15:12:53.154745 | 
2026-08-24 15:12:53.154853 | TASK [emit-job-header : Print job information]
2026-08-24 15:12:53.195194 | # Job Information
2026-08-24 15:12:53.195405 | Ansible Version: 2.16.18
2026-08-24 15:12:53.195442 | Job: atmosphere-molecule-csi-rbd
2026-08-24 15:12:53.195468 | Pipeline: check
2026-08-24 15:12:53.195492 | Executor: 2d72f0692154
2026-08-24 15:12:53.195515 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3385
2026-08-24 15:12:53.195542 | Event ID: 9f122fb0-9fcc-11f1-8bb8-d5728a845166
2026-08-24 15:12:53.199529 | 
2026-08-24 15:12:53.199675 | LOOP [emit-job-header : Print node information]
2026-08-24 15:12:53.301564 | localhost | ok:
2026-08-24 15:12:53.301767 | localhost | # Node Information
2026-08-24 15:12:53.301810 | localhost | Inventory Hostname: instance
2026-08-24 15:12:53.301842 | localhost | Hostname: np0000190812
2026-08-24 15:12:53.301871 | localhost | Username: zuul
2026-08-24 15:12:53.301905 | localhost | Distro: Ubuntu 22.04
2026-08-24 15:12:53.301935 | localhost | Provider: yul1
2026-08-24 15:12:53.301962 | localhost | Region: ca-ymq-1
2026-08-24 15:12:53.301990 | localhost | Label: ubuntu-jammy
2026-08-24 15:12:53.302017 | localhost | Product Name: OpenStack Nova
2026-08-24 15:12:53.302043 | localhost | Interface IP: 199.19.213.225
2026-08-24 15:12:53.319324 | 
2026-08-24 15:12:53.319450 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-24 15:12:53.760775 | localhost -> localhost | changed
2026-08-24 15:12:53.768979 | 
2026-08-24 15:12:53.769136 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-24 15:12:54.760844 | localhost -> localhost | changed
2026-08-24 15:12:54.770481 | 
2026-08-24 15:12:54.770579 | PLAY [all]
2026-08-24 15:12:54.779938 | 
2026-08-24 15:12:54.780033 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-24 15:12:55.077421 | instance -> localhost | ok
2026-08-24 15:12:55.083328 | 
2026-08-24 15:12:55.083396 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-24 15:12:55.112057 | instance | ok
2026-08-24 15:12:55.128247 | instance | included: /var/lib/zuul/builds/ba86265a93c54bd5878fc852acdbab40/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-24 15:12:55.133786 | 
2026-08-24 15:12:55.133859 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-24 15:12:55.870266 | instance -> localhost | Generating public/private rsa key pair.
2026-08-24 15:12:55.870446 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/ba86265a93c54bd5878fc852acdbab40/work/ba86265a93c54bd5878fc852acdbab40_id_rsa
2026-08-24 15:12:55.870487 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/ba86265a93c54bd5878fc852acdbab40/work/ba86265a93c54bd5878fc852acdbab40_id_rsa.pub
2026-08-24 15:12:55.870519 | instance -> localhost | The key fingerprint is:
2026-08-24 15:12:55.870548 | instance -> localhost | SHA256:zVNq5NE6z2MZUpkCuXDdFf3UfCDsKPLucVRaSmzwVdY zuul-build-sshkey
2026-08-24 15:12:55.870590 | instance -> localhost | The key's randomart image is:
2026-08-24 15:12:55.870619 | instance -> localhost | +---[RSA 3072]----+
2026-08-24 15:12:55.870653 | instance -> localhost | |        oo ooo**.|
2026-08-24 15:12:55.870683 | instance -> localhost | |      . o=.oo=  E|
2026-08-24 15:12:55.870711 | instance -> localhost | |       o .OoO  .o|
2026-08-24 15:12:55.870738 | instance -> localhost | |      . oB.%.   .|
2026-08-24 15:12:55.870764 | instance -> localhost | |       oS.# .    |
2026-08-24 15:12:55.870791 | instance -> localhost | |        .o * o   |
2026-08-24 15:12:55.870817 | instance -> localhost | |       .. . *    |
2026-08-24 15:12:55.870844 | instance -> localhost | |        .o . .   |
2026-08-24 15:12:55.870874 | instance -> localhost | |       ..        |
2026-08-24 15:12:55.870902 | instance -> localhost | +----[SHA256]-----+
2026-08-24 15:12:55.870961 | instance -> localhost | ok: Runtime: 0:00:00.282810
2026-08-24 15:12:55.879495 | 
2026-08-24 15:12:55.879582 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-24 15:12:55.912232 | instance | ok
2026-08-24 15:12:55.925601 | instance | included: /var/lib/zuul/builds/ba86265a93c54bd5878fc852acdbab40/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-24 15:12:55.933052 | 
2026-08-24 15:12:55.933113 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-24 15:12:55.957338 | instance | skipping: Conditional result was False
2026-08-24 15:12:55.967486 | 
2026-08-24 15:12:55.967563 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-24 15:12:56.386094 | instance | changed
2026-08-24 15:12:56.395364 | 
2026-08-24 15:12:56.395497 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-24 15:12:56.608377 | instance | ok
2026-08-24 15:12:56.621642 | 
2026-08-24 15:12:56.621795 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-24 15:12:57.138218 | instance | changed
2026-08-24 15:12:57.145298 | 
2026-08-24 15:12:57.145384 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-24 15:12:57.586191 | instance | changed
2026-08-24 15:12:57.594542 | 
2026-08-24 15:12:57.594630 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-24 15:12:57.618973 | instance | skipping: Conditional result was False
2026-08-24 15:12:57.627272 | 
2026-08-24 15:12:57.627433 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-24 15:12:57.987005 | instance -> localhost | changed
2026-08-24 15:12:57.997753 | 
2026-08-24 15:12:57.997872 | TASK [add-build-sshkey : Add back temp key]
2026-08-24 15:12:58.348311 | instance -> localhost | Identity added: /var/lib/zuul/builds/ba86265a93c54bd5878fc852acdbab40/work/ba86265a93c54bd5878fc852acdbab40_id_rsa (zuul-build-sshkey)
2026-08-24 15:12:58.348673 | instance -> localhost | ok: Runtime: 0:00:00.016117
2026-08-24 15:12:58.356008 | 
2026-08-24 15:12:58.356085 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-24 15:12:58.687482 | instance | ok
2026-08-24 15:12:59.123622 | 
2026-08-24 15:12:59.123763 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-24 15:12:59.159681 | instance | skipping: Conditional result was False
2026-08-24 15:12:59.175160 | 
2026-08-24 15:12:59.175339 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-24 15:12:59.550322 | instance | ok
2026-08-24 15:12:59.556016 | 
2026-08-24 15:12:59.556134 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-24 15:13:03.087615 | instance | Output suppressed because no_log was given
2026-08-24 15:13:03.097226 | 
2026-08-24 15:13:03.097289 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-24 15:13:03.287869 | instance | ok: "logs"
2026-08-24 15:13:03.288092 | instance | ok: All items complete
2026-08-24 15:13:03.288120 | 
2026-08-24 15:13:03.453573 | instance | ok: "artifacts"
2026-08-24 15:13:03.615765 | instance | ok: "docs"
2026-08-24 15:13:03.636275 | 
2026-08-24 15:13:03.636378 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-24 15:13:03.827514 | instance | changed: "logs"
2026-08-24 15:13:04.001870 | instance | changed: "artifacts"
2026-08-24 15:13:04.161745 | instance | changed: "docs"
2026-08-24 15:13:04.172150 | 
2026-08-24 15:13:04.172267 | PLAY RECAP
2026-08-24 15:13:04.172323 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-24 15:13:04.172354 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-24 15:13:04.172423 | 
2026-08-24 15:13:04.347878 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-24 15:13:04.353678 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-24 15:13:04.993350 | 
2026-08-24 15:13:04.993499 | PLAY [all]
2026-08-24 15:13:05.004888 | 
2026-08-24 15:13:05.005063 | TASK [setup-uv : Extract archive]
2026-08-24 15:13:07.209047 | instance | changed
2026-08-24 15:13:07.215018 | 
2026-08-24 15:13:07.215117 | TASK [setup-uv : Print version]
2026-08-24 15:13:07.550775 | instance | uv 0.8.13
2026-08-24 15:13:07.752611 | instance | ok: Runtime: 0:00:00.013857
2026-08-24 15:13:07.764401 | 
2026-08-24 15:13:07.764748 | TASK [Install Ansible collection siblings]
2026-08-24 15:13:17.172617 | instance | changed:
2026-08-24 15:13:17.172806 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-08-24 15:13:17.172843 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-08-24 15:13:17.172872 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-08-24 15:13:17.172907 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-08-24 15:13:17.173001 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-08-24 15:13:17.173049 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-08-24 15:13:17.173079 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-08-24 15:13:17.173108 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-08-24 15:13:17.173133 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-08-24 15:13:17.173158 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-08-24 15:13:17.173181 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-08-24 15:13:17.173207 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-08-24 15:13:17.173232 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-08-24 15:13:17.173256 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-08-24 15:13:17.173283 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0
2026-08-24 15:13:17.173308 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-08-24 15:13:17.173331 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-08-24 15:13:17.173354 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-08-24 15:13:17.173380 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-08-24 15:13:17.173406 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-08-24 15:13:17.173429 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0
2026-08-24 15:13:17.173451 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-08-24 15:13:17.173476 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-24 15:13:17.173513 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-08-24 15:13:17.173541 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0
2026-08-24 15:13:17.173567 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-24 15:13:17.173591 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-24 15:13:17.173615 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-24 15:13:17.173640 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-08-24 15:13:17.173665 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-08-24 15:13:17.173688 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-24 15:13:17.173711 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-24 15:13:17.173734 | instance | Checked out ansible.netcommon to 1.2.0
2026-08-24 15:13:17.173759 | 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-24 15:13:17.173828 | instance | Starting galaxy collection install process
2026-08-24 15:13:17.173855 | instance | Process install dependency map
2026-08-24 15:13:17.173879 | instance | Starting collection install process
2026-08-24 15:13:17.173901 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-08-24 15:13:17.173925 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-08-24 15:13:17.173951 | instance | ansible.netcommon:* was installed successfully
2026-08-24 15:13:17.173975 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-08-24 15:13:17.173998 | instance | Creating virtual environment at: .venv
2026-08-24 15:13:17.174024 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-24 15:13:17.174061 | instance | Downloading openstacksdk (1.7MiB)
2026-08-24 15:13:17.174087 | instance | Downloading kubernetes (1.9MiB)
2026-08-24 15:13:17.174116 | instance | Downloading pygments (1.2MiB)
2026-08-24 15:13:17.174139 | instance | Downloading rjsonnet (1.2MiB)
2026-08-24 15:13:17.174162 | instance | Downloading cryptography (4.2MiB)
2026-08-24 15:13:17.174185 | instance | Downloading netaddr (2.2MiB)
2026-08-24 15:13:17.174207 | instance | Downloading setuptools (1.1MiB)
2026-08-24 15:13:17.174231 | instance | Downloading pydantic-core (2.0MiB)
2026-08-24 15:13:17.174255 | instance | Downloading ansible-core (2.1MiB)
2026-08-24 15:13:17.174280 | instance |    Building pyperclip==1.9.0
2026-08-24 15:13:17.174307 | instance |  Downloading rjsonnet
2026-08-24 15:13:17.174330 | instance |  Downloading pydantic-core
2026-08-24 15:13:17.174353 | instance |  Downloading netaddr
2026-08-24 15:13:17.174376 | instance |  Downloading pygments
2026-08-24 15:13:17.174399 | instance |  Downloading cryptography
2026-08-24 15:13:17.174425 | instance |  Downloading setuptools
2026-08-24 15:13:17.174449 | instance |  Downloading kubernetes
2026-08-24 15:13:17.174472 | instance |  Downloading ansible-core
2026-08-24 15:13:17.174499 | instance |  Downloading openstacksdk
2026-08-24 15:13:17.174522 | instance |       Built pyperclip==1.9.0
2026-08-24 15:13:17.174546 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-24 15:13:17.174568 | instance | Installed 83 packages in 88ms
2026-08-24 15:13:17.174591 | instance | Checked out ansible.posix to 1.6.0
2026-08-24 15:13:17.174616 | 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-24 15:13:17.174642 | instance | Starting galaxy collection install process
2026-08-24 15:13:17.174665 | instance | Process install dependency map
2026-08-24 15:13:17.174697 | instance | Starting collection install process
2026-08-24 15:13:17.174723 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-08-24 15:13:17.174747 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-08-24 15:13:17.174771 | instance | ansible.posix:1.6.0 was installed successfully
2026-08-24 15:13:17.174797 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:13:17.174820 | instance | 2.17.12
2026-08-24 15:13:17.174842 | instance | Checked out ansible.utils to v6.1.0
2026-08-24 15:13:17.174867 | 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-24 15:13:17.174893 | instance | Starting galaxy collection install process
2026-08-24 15:13:17.174916 | instance | Process install dependency map
2026-08-24 15:13:17.174940 | instance | Starting collection install process
2026-08-24 15:13:17.174965 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-08-24 15:13:17.174991 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-08-24 15:13:17.175015 | instance | ansible.utils:6.1.0 was installed successfully
2026-08-24 15:13:17.175041 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:13:17.175068 | instance | 2.17.12
2026-08-24 15:13:17.175092 | instance | Checked out atmosphere.common to v0.7.0
2026-08-24 15:13:17.175117 | 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-24 15:13:17.175141 | instance | Starting galaxy collection install process
2026-08-24 15:13:17.175165 | instance | Process install dependency map
2026-08-24 15:13:17.175191 | instance | Starting collection install process
2026-08-24 15:13:17.175215 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-08-24 15:13:17.175239 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-08-24 15:13:17.175263 | instance | atmosphere.common:0.7.0 was installed successfully
2026-08-24 15:13:17.175288 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:13:17.175311 | instance | 2.17.12
2026-08-24 15:13:17.175334 | instance | Checked out community.crypto to 2.2.3
2026-08-24 15:13:17.175357 | 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-24 15:13:17.175380 | instance | Starting galaxy collection install process
2026-08-24 15:13:17.175406 | instance | Process install dependency map
2026-08-24 15:13:17.175431 | instance | Starting collection install process
2026-08-24 15:13:17.175454 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-08-24 15:13:17.175477 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-08-24 15:13:17.175502 | instance | community.crypto:2.2.3 was installed successfully
2026-08-24 15:13:17.175526 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:13:17.175570 | instance | 2.17.12
2026-08-24 15:13:17.175600 | instance | Checked out community.general to 7.3.0
2026-08-24 15:13:17.175626 | 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-24 15:13:17.175886 | instance | Starting galaxy collection install process
2026-08-24 15:13:17.175919 | instance | Process install dependency map
2026-08-24 15:13:17.175943 | instance | Starting collection install process
2026-08-24 15:13:17.175968 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-08-24 15:13:17.175992 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-08-24 15:13:17.176017 | instance | community.general:7.3.0 was installed successfully
2026-08-24 15:13:17.176041 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:13:17.176067 | instance | 2.17.12
2026-08-24 15:13:17.176093 | instance | Checked out community.mysql to 3.6.0
2026-08-24 15:13:17.176119 | 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-24 15:13:17.176143 | instance | Starting galaxy collection install process
2026-08-24 15:13:17.176169 | instance | Process install dependency map
2026-08-24 15:13:17.176194 | instance | Starting collection install process
2026-08-24 15:13:17.176217 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-08-24 15:13:17.176240 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-08-24 15:13:17.176263 | instance | community.mysql:3.6.0 was installed successfully
2026-08-24 15:13:17.176286 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:13:17.176312 | instance | 2.17.12
2026-08-24 15:13:17.176337 | instance | Checked out kubernetes.core to 2.4.0
2026-08-24 15:13:17.176361 | 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-24 15:13:17.176386 | instance | Starting galaxy collection install process
2026-08-24 15:13:17.176411 | instance | Process install dependency map
2026-08-24 15:13:17.176435 | instance | Starting collection install process
2026-08-24 15:13:17.176459 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-08-24 15:13:17.176485 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-08-24 15:13:17.176508 | instance | kubernetes.core:2.4.0 was installed successfully
2026-08-24 15:13:17.176531 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:13:17.176553 | instance | 2.17.12
2026-08-24 15:13:17.176577 | instance | Checked out openstack.cloud to 2.6.0
2026-08-24 15:13:17.176601 | 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-24 15:13:17.176626 | instance | Starting galaxy collection install process
2026-08-24 15:13:17.176649 | instance | Process install dependency map
2026-08-24 15:13:17.176671 | instance | Starting collection install process
2026-08-24 15:13:17.176693 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-08-24 15:13:17.176716 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-08-24 15:13:17.176741 | instance | openstack.cloud:2.6.0 was installed successfully
2026-08-24 15:13:17.176764 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:13:17.176789 | instance | 2.17.12
2026-08-24 15:13:17.176820 | instance | Checked out vexxhost.ceph to v4.2.0
2026-08-24 15:13:17.176844 | 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-24 15:13:17.176866 | instance | Starting galaxy collection install process
2026-08-24 15:13:17.176889 | instance | Process install dependency map
2026-08-24 15:13:17.176914 | instance | Starting collection install process
2026-08-24 15:13:17.176939 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-08-24 15:13:17.176982 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-08-24 15:13:17.177009 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-08-24 15:13:17.177034 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:13:17.177058 | instance | 2.17.12
2026-08-24 15:13:17.177081 | instance | Checked out vexxhost.containers to v1.6.8
2026-08-24 15:13:17.177107 | 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-24 15:13:17.177131 | instance | Starting galaxy collection install process
2026-08-24 15:13:17.177972 | instance | Process install dependency map
2026-08-24 15:13:17.178025 | instance | Starting collection install process
2026-08-24 15:13:17.178056 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-08-24 15:13:17.178083 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-08-24 15:13:17.178107 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-08-24 15:13:17.178131 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:13:17.178157 | instance | 2.17.12
2026-08-24 15:13:17.178398 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-08-24 15:13:17.178444 | 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-24 15:13:17.178471 | instance | Starting galaxy collection install process
2026-08-24 15:13:17.178522 | instance | Process install dependency map
2026-08-24 15:13:17.178696 | instance | Starting collection install process
2026-08-24 15:13:17.178733 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-08-24 15:13:17.178762 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-08-24 15:13:17.178787 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-08-24 15:13:17.178810 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:13:17.178833 | instance | 2.17.12
2026-08-24 15:13:17.185269 | 
2026-08-24 15:13:17.185315 | PLAY RECAP
2026-08-24 15:13:17.185359 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-24 15:13:17.185380 | 
2026-08-24 15:13:17.299668 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-24 15:13:17.304015 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-24 15:13:17.926994 | 
2026-08-24 15:13:17.927117 | PLAY [all]
2026-08-24 15:13:17.937920 | 
2026-08-24 15:13:17.938008 | TASK [Install "jq" for log collection]
2026-08-24 15:13:27.438408 | instance | changed
2026-08-24 15:13:27.440865 | 
2026-08-24 15:13:27.440923 | PLAY RECAP
2026-08-24 15:13:27.440989 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-24 15:13:27.441057 | 
2026-08-24 15:13:27.581163 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-24 15:13:27.585218 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-24 15:13:28.280813 | 
2026-08-24 15:13:28.280977 | PLAY [all]
2026-08-24 15:13:28.292269 | 
2026-08-24 15:13:28.292440 | LOOP [Check inventory directories]
2026-08-24 15:13:28.668080 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-08-24 15:13:28.827239 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-08-24 15:13:28.999402 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-08-24 15:13:29.010201 | 
2026-08-24 15:13:29.010661 | LOOP [Copy inventory file for Zuul]
2026-08-24 15:13:29.838342 | instance | changed:
2026-08-24 15:13:29.838533 | instance | {
2026-08-24 15:13:29.838563 | instance |   "ansible_loop_var": "item",
2026-08-24 15:13:29.838587 | instance |   "changed": false,
2026-08-24 15:13:29.838608 | instance |   "failed": false,
2026-08-24 15:13:29.838635 | instance |   "invocation": {
2026-08-24 15:13:29.838655 | instance |     "module_args": {
2026-08-24 15:13:29.838675 | instance |       "checksum_algorithm": "sha1",
2026-08-24 15:13:29.838694 | instance |       "follow": true,
2026-08-24 15:13:29.838712 | instance |       "get_attributes": true,
2026-08-24 15:13:29.838731 | instance |       "get_checksum": true,
2026-08-24 15:13:29.838749 | instance |       "get_mime": true,
2026-08-24 15:13:29.838768 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-08-24 15:13:29.838786 | instance |     }
2026-08-24 15:13:29.838804 | instance |   },
2026-08-24 15:13:29.838823 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-08-24 15:13:29.838841 | instance |   "stat": {
2026-08-24 15:13:29.838859 | instance |     "atime": 1787584389.4556215,
2026-08-24 15:13:29.838878 | instance |     "attr_flags": "e",
2026-08-24 15:13:29.838896 | instance |     "attributes": [
2026-08-24 15:13:29.838943 | instance |       "extents"
2026-08-24 15:13:29.838965 | instance |     ],
2026-08-24 15:13:29.838983 | instance |     "block_size": 4096,
2026-08-24 15:13:29.839003 | instance |     "blocks": 8,
2026-08-24 15:13:29.839020 | instance |     "charset": "unknown",
2026-08-24 15:13:29.839041 | instance |     "ctime": 1787584388.4835594,
2026-08-24 15:13:29.839060 | instance |     "dev": 64513,
2026-08-24 15:13:29.839078 | instance |     "device_type": 0,
2026-08-24 15:13:29.839095 | instance |     "executable": true,
2026-08-24 15:13:29.839113 | instance |     "exists": true,
2026-08-24 15:13:29.839130 | instance |     "gid": 1000,
2026-08-24 15:13:29.839147 | instance |     "gr_name": "zuul",
2026-08-24 15:13:29.839165 | instance |     "inode": 1048361,
2026-08-24 15:13:29.839182 | instance |     "isblk": false,
2026-08-24 15:13:29.839200 | instance |     "ischr": false,
2026-08-24 15:13:29.839218 | instance |     "isdir": true,
2026-08-24 15:13:29.839235 | instance |     "isfifo": false,
2026-08-24 15:13:29.839253 | instance |     "isgid": false,
2026-08-24 15:13:29.839270 | instance |     "islnk": false,
2026-08-24 15:13:29.839287 | instance |     "isreg": false,
2026-08-24 15:13:29.839304 | instance |     "issock": false,
2026-08-24 15:13:29.839321 | instance |     "isuid": false,
2026-08-24 15:13:29.839338 | instance |     "mimetype": "unknown",
2026-08-24 15:13:29.839356 | instance |     "mode": "0755",
2026-08-24 15:13:29.839373 | instance |     "mtime": 1787584388.4835594,
2026-08-24 15:13:29.839391 | instance |     "nlink": 23,
2026-08-24 15:13:29.839409 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-08-24 15:13:29.839426 | instance |     "pw_name": "zuul",
2026-08-24 15:13:29.839445 | instance |     "readable": true,
2026-08-24 15:13:29.839463 | instance |     "rgrp": true,
2026-08-24 15:13:29.839481 | instance |     "roth": true,
2026-08-24 15:13:29.839513 | instance |     "rusr": true,
2026-08-24 15:13:29.839533 | instance |     "size": 4096,
2026-08-24 15:13:29.839552 | instance |     "uid": 1000,
2026-08-24 15:13:29.839570 | instance |     "version": "3914670982",
2026-08-24 15:13:29.839589 | instance |     "wgrp": false,
2026-08-24 15:13:29.839609 | instance |     "woth": false,
2026-08-24 15:13:29.839627 | instance |     "writeable": true,
2026-08-24 15:13:29.839645 | instance |     "wusr": true,
2026-08-24 15:13:29.839664 | instance |     "xgrp": true,
2026-08-24 15:13:29.839681 | instance |     "xoth": true,
2026-08-24 15:13:29.839699 | instance |     "xusr": true
2026-08-24 15:13:29.839716 | instance |   }
2026-08-24 15:13:29.839734 | instance | }
2026-08-24 15:13:29.839768 | instance | ok: All items complete
2026-08-24 15:13:29.839790 | 
2026-08-24 15:13:29.841169 | instance | skipping: Conditional result was False
2026-08-24 15:13:29.841756 | instance | skipping: Conditional result was False
2026-08-24 15:13:29.852993 | 
2026-08-24 15:13:29.853112 | LOOP [Switch "ansible_host" to private IP]
2026-08-24 15:13:30.207300 | instance | changed: 1 replacements made
2026-08-24 15:13:30.210778 | instance | skipping: Conditional result was False
2026-08-24 15:13:30.214974 | instance | skipping: Conditional result was False
2026-08-24 15:13:30.228115 | 
2026-08-24 15:13:30.228287 | TASK [Run Molecule scenario]
2026-08-24 15:13:31.236998 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-08-24 15:13:31.682400 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-08-24 15:13:31.682500 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-08-24 15:13:43.681928 | instance | INFO     [csi > dependency] Executing
2026-08-24 15:13:43.682039 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-08-24 15:13:43.682300 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-08-24 15:13:43.682422 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-08-24 15:13:43.691054 | instance | INFO     [csi > cleanup] Executing
2026-08-24 15:13:43.691379 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-24 15:13:43.699397 | instance | INFO     [csi > destroy] Executing
2026-08-24 15:13:43.699451 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-08-24 15:13:43.699532 | instance | INFO     [csi > destroy] Executed: Successful
2026-08-24 15:13:43.707732 | instance | INFO     [csi > syntax] Executing
2026-08-24 15:13:45.468061 | instance |
2026-08-24 15:13:45.468297 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-24 15:13:45.583777 | instance | INFO     [csi > syntax] Executed: Successful
2026-08-24 15:13:45.595189 | instance | INFO     [csi > create] Executing
2026-08-24 15:13:45.597623 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-24 15:13:45.606708 | instance | INFO     [csi > prepare] Executing
2026-08-24 15:13:46.517944 | instance |
2026-08-24 15:13:46.518209 | instance | PLAY [Prepare] *****************************************************************
2026-08-24 15:13:46.518505 | instance |
2026-08-24 15:13:46.518943 | instance | TASK [Gathering Facts] *********************************************************
2026-08-24 15:13:46.519335 | instance | Monday 24 August 2026  15:13:46 +0000 (0:00:00.026)       0:00:00.026 *********
2026-08-24 15:13:47.725275 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-24 15:13:47.725514 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-24 15:13:47.725798 | instance | interpreter could change the meaning of that path. See
2026-08-24 15:13:47.726070 | instance | https://docs.ansible.com/ansible-
2026-08-24 15:13:47.726347 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-24 15:13:47.734683 | instance | ok: [instance]
2026-08-24 15:13:47.734937 | instance |
2026-08-24 15:13:47.735208 | instance | TASK [Configure short hostname] ************************************************
2026-08-24 15:13:47.735479 | instance | Monday 24 August 2026  15:13:47 +0000 (0:00:01.218)       0:00:01.244 *********
2026-08-24 15:13:48.419595 | instance | changed: [instance]
2026-08-24 15:13:48.419796 | instance |
2026-08-24 15:13:48.420108 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-08-24 15:13:48.420469 | instance | Monday 24 August 2026  15:13:48 +0000 (0:00:00.684)       0:00:01.928 *********
2026-08-24 15:13:48.703086 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-08-24 15:13:48.703314 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-08-24 15:13:48.703590 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-08-24 15:13:48.714225 | instance | changed: [instance]
2026-08-24 15:13:48.714492 | instance |
2026-08-24 15:13:48.714771 | instance | TASK [Purge "snapd" package] ***************************************************
2026-08-24 15:13:48.715042 | instance | Monday 24 August 2026  15:13:48 +0000 (0:00:00.294)       0:00:02.223 *********
2026-08-24 15:13:49.611496 | instance | ok: [instance]
2026-08-24 15:13:49.611717 | instance |
2026-08-24 15:13:49.612000 | instance | PLAY [Create devices for Ceph] *************************************************
2026-08-24 15:13:49.612270 | instance |
2026-08-24 15:13:49.612594 | instance | TASK [Gathering Facts] *********************************************************
2026-08-24 15:13:49.612885 | instance | Monday 24 August 2026  15:13:49 +0000 (0:00:00.897)       0:00:03.120 *********
2026-08-24 15:13:50.362062 | instance | ok: [instance]
2026-08-24 15:13:50.362259 | instance |
2026-08-24 15:13:50.362551 | instance | TASK [Install depedencies] *****************************************************
2026-08-24 15:13:50.362885 | instance | Monday 24 August 2026  15:13:50 +0000 (0:00:00.749)       0:00:03.870 *********
2026-08-24 15:14:11.130898 | instance | changed: [instance]
2026-08-24 15:14:11.131118 | instance |
2026-08-24 15:14:11.131384 | instance | TASK [Start up service] ********************************************************
2026-08-24 15:14:11.131656 | instance | Monday 24 August 2026  15:14:11 +0000 (0:00:20.769)       0:00:24.639 *********
2026-08-24 15:14:11.728795 | instance | ok: [instance]
2026-08-24 15:14:11.729007 | instance |
2026-08-24 15:14:11.729330 | instance | TASK [Generate lvm.conf] *******************************************************
2026-08-24 15:14:11.729613 | instance | Monday 24 August 2026  15:14:11 +0000 (0:00:00.597)       0:00:25.237 *********
2026-08-24 15:14:12.051881 | instance | ok: [instance]
2026-08-24 15:14:12.052141 | instance |
2026-08-24 15:14:12.052437 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-08-24 15:14:12.052723 | instance | Monday 24 August 2026  15:14:12 +0000 (0:00:00.323)       0:00:25.560 *********
2026-08-24 15:14:12.720033 | instance | changed: [instance]
2026-08-24 15:14:12.720122 | instance |
2026-08-24 15:14:12.720135 | instance | TASK [Get list of all loopback devices] ****************************************
2026-08-24 15:14:12.720147 | instance | Monday 24 August 2026  15:14:12 +0000 (0:00:00.666)       0:00:26.227 *********
2026-08-24 15:14:12.916111 | instance | ok: [instance]
2026-08-24 15:14:12.916195 | instance |
2026-08-24 15:14:12.916583 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-08-24 15:14:12.916606 | instance | Monday 24 August 2026  15:14:12 +0000 (0:00:00.197)       0:00:26.425 *********
2026-08-24 15:14:12.943501 | instance | skipping: [instance]
2026-08-24 15:14:12.944152 | instance |
2026-08-24 15:14:12.944176 | instance | TASK [Create devices for Ceph] *************************************************
2026-08-24 15:14:12.944185 | instance | Monday 24 August 2026  15:14:12 +0000 (0:00:00.027)       0:00:26.452 *********
2026-08-24 15:14:13.519712 | instance | changed: [instance] => (item=osd0)
2026-08-24 15:14:13.519818 | instance | changed: [instance] => (item=osd1)
2026-08-24 15:14:13.520022 | instance | changed: [instance] => (item=osd2)
2026-08-24 15:14:13.520276 | instance |
2026-08-24 15:14:13.520490 | instance | TASK [Set permissions on loopback devices] *************************************
2026-08-24 15:14:13.520707 | instance | Monday 24 August 2026  15:14:13 +0000 (0:00:00.576)       0:00:27.028 *********
2026-08-24 15:14:14.183812 | instance | changed: [instance] => (item=osd0)
2026-08-24 15:14:14.183895 | instance | changed: [instance] => (item=osd1)
2026-08-24 15:14:14.184035 | instance | changed: [instance] => (item=osd2)
2026-08-24 15:14:14.184238 | instance |
2026-08-24 15:14:14.184392 | instance | TASK [Start loop devices] ******************************************************
2026-08-24 15:14:14.184568 | instance | Monday 24 August 2026  15:14:14 +0000 (0:00:00.664)       0:00:27.692 *********
2026-08-24 15:14:14.936858 | instance | changed: [instance] => (item=osd0)
2026-08-24 15:14:14.936913 | instance | changed: [instance] => (item=osd1)
2026-08-24 15:14:14.936918 | instance | changed: [instance] => (item=osd2)
2026-08-24 15:14:14.936924 | instance |
2026-08-24 15:14:14.936929 | instance | TASK [Create a volume group for each loop device] ******************************
2026-08-24 15:14:14.936935 | instance | Monday 24 August 2026  15:14:14 +0000 (0:00:00.752)       0:00:28.445 *********
2026-08-24 15:14:18.258053 | instance | changed: [instance] => (item=osd0)
2026-08-24 15:14:18.258857 | instance | changed: [instance] => (item=osd1)
2026-08-24 15:14:18.258877 | instance | changed: [instance] => (item=osd2)
2026-08-24 15:14:18.258885 | instance |
2026-08-24 15:14:18.258892 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-08-24 15:14:18.258898 | instance | Monday 24 August 2026  15:14:18 +0000 (0:00:03.321)       0:00:31.767 *********
2026-08-24 15:14:20.231777 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-08-24 15:14:20.232334 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-08-24 15:14:20.232385 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-08-24 15:14:20.233098 | instance |
2026-08-24 15:14:20.233173 | instance | PLAY RECAP *********************************************************************
2026-08-24 15:14:20.233196 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-08-24 15:14:20.237127 | instance |
2026-08-24 15:14:20.237220 | instance | Monday 24 August 2026  15:14:20 +0000 (0:00:01.973)       0:00:33.741 *********
2026-08-24 15:14:20.237234 | instance | ===============================================================================
2026-08-24 15:14:20.237244 | instance | Install depedencies ---------------------------------------------------- 20.77s
2026-08-24 15:14:20.237253 | instance | Create a volume group for each loop device ------------------------------ 3.32s
2026-08-24 15:14:20.237262 | instance | Create a logical volume for each loop device ---------------------------- 1.97s
2026-08-24 15:14:20.237274 | instance | Gathering Facts --------------------------------------------------------- 1.22s
2026-08-24 15:14:20.237284 | instance | Purge "snapd" package --------------------------------------------------- 0.90s
2026-08-24 15:14:20.237293 | instance | Start loop devices ------------------------------------------------------ 0.75s
2026-08-24 15:14:20.237302 | instance | Gathering Facts --------------------------------------------------------- 0.75s
2026-08-24 15:14:20.237312 | instance | Configure short hostname ------------------------------------------------ 0.68s
2026-08-24 15:14:20.237321 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.67s
2026-08-24 15:14:20.237330 | instance | Set permissions on loopback devices ------------------------------------- 0.66s
2026-08-24 15:14:20.237423 | instance | Start up service -------------------------------------------------------- 0.60s
2026-08-24 15:14:20.237702 | instance | Create devices for Ceph ------------------------------------------------- 0.58s
2026-08-24 15:14:20.238046 | instance | Generate lvm.conf ------------------------------------------------------- 0.32s
2026-08-24 15:14:20.238329 | instance | Ensure hostname inside hosts file --------------------------------------- 0.29s
2026-08-24 15:14:20.238596 | instance | Get list of all loopback devices ---------------------------------------- 0.20s
2026-08-24 15:14:20.238866 | instance | Fail if there is any existing loopback devices -------------------------- 0.03s
2026-08-24 15:14:20.348037 | instance | INFO     [csi > prepare] Executed: Successful
2026-08-24 15:14:20.360497 | instance | INFO     [csi > converge] Executing
2026-08-24 15:14:21.963394 | instance |
2026-08-24 15:14:21.963556 | instance | PLAY [Debug CSI driver value] **************************************************
2026-08-24 15:14:21.963725 | instance |
2026-08-24 15:14:21.963902 | instance | TASK [Gathering Facts] *********************************************************
2026-08-24 15:14:21.964081 | instance | Monday 24 August 2026  15:14:21 +0000 (0:00:00.013)       0:00:00.013 *********
2026-08-24 15:14:22.994129 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-24 15:14:22.994434 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-24 15:14:22.995354 | instance | interpreter could change the meaning of that path. See
2026-08-24 15:14:22.995773 | instance | https://docs.ansible.com/ansible-
2026-08-24 15:14:22.996191 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-24 15:14:23.008181 | instance | ok: [instance]
2026-08-24 15:14:23.008333 | instance |
2026-08-24 15:14:23.008513 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-08-24 15:14:23.008685 | instance | Monday 24 August 2026  15:14:23 +0000 (0:00:01.045)       0:00:01.059 *********
2026-08-24 15:14:23.059746 | instance | ok: [instance] => {
2026-08-24 15:14:23.060028 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-08-24 15:14:23.060290 | instance | }
2026-08-24 15:14:23.060542 | instance |
2026-08-24 15:14:23.060807 | instance | PLAY [all] *********************************************************************
2026-08-24 15:14:23.061088 | instance |
2026-08-24 15:14:23.061463 | instance | TASK [Gathering Facts] *********************************************************
2026-08-24 15:14:23.061860 | instance | Monday 24 August 2026  15:14:23 +0000 (0:00:00.051)       0:00:01.110 *********
2026-08-24 15:14:23.967814 | instance | ok: [instance]
2026-08-24 15:14:23.968020 | instance |
2026-08-24 15:14:23.968315 | instance | TASK [Fail if atmosphere_ceph_enabled is set] **********************************
2026-08-24 15:14:23.968590 | instance | Monday 24 August 2026  15:14:23 +0000 (0:00:00.907)       0:00:02.018 *********
2026-08-24 15:14:24.010296 | instance | skipping: [instance]
2026-08-24 15:14:24.010722 | instance |
2026-08-24 15:14:24.011079 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-08-24 15:14:24.011410 | instance | Monday 24 August 2026  15:14:24 +0000 (0:00:00.042)       0:00:02.060 *********
2026-08-24 15:14:24.206026 | instance | ok: [instance]
2026-08-24 15:14:24.206428 | instance |
2026-08-24 15:14:24.206875 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-08-24 15:14:24.207207 | instance |
2026-08-24 15:14:24.207542 | instance | TASK [Gathering Facts] *********************************************************
2026-08-24 15:14:24.207897 | instance | Monday 24 August 2026  15:14:24 +0000 (0:00:00.195)       0:00:02.256 *********
2026-08-24 15:14:25.133650 | instance | ok: [instance]
2026-08-24 15:14:25.133746 | instance |
2026-08-24 15:14:25.133889 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-24 15:14:25.135840 | instance | Monday 24 August 2026  15:14:25 +0000 (0:00:00.926)       0:00:03.182 *********
2026-08-24 15:14:25.493587 | instance | ok: [instance]
2026-08-24 15:14:25.493688 | instance |
2026-08-24 15:14:25.493785 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-24 15:14:25.493978 | instance | Monday 24 August 2026  15:14:25 +0000 (0:00:00.360)       0:00:03.543 *********
2026-08-24 15:14:25.545859 | instance | skipping: [instance]
2026-08-24 15:14:25.545931 | instance |
2026-08-24 15:14:25.546103 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-08-24 15:14:25.546318 | instance | Monday 24 August 2026  15:14:25 +0000 (0:00:00.050)       0:00:03.593 *********
2026-08-24 15:14:25.925884 | instance | changed: [instance]
2026-08-24 15:14:25.926307 | instance |
2026-08-24 15:14:25.926652 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-24 15:14:25.926992 | instance | Monday 24 August 2026  15:14:25 +0000 (0:00:00.381)       0:00:03.975 *********
2026-08-24 15:14:26.005876 | instance | ok: [instance] => {
2026-08-24 15:14:26.006304 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-08-24 15:14:26.006637 | instance | }
2026-08-24 15:14:26.006952 | instance |
2026-08-24 15:14:26.007322 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-24 15:14:26.007685 | instance | Monday 24 August 2026  15:14:25 +0000 (0:00:00.078)       0:00:04.053 *********
2026-08-24 15:14:26.721633 | instance | changed: [instance]
2026-08-24 15:14:26.721757 | instance |
2026-08-24 15:14:26.721938 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-24 15:14:26.722097 | instance | Monday 24 August 2026  15:14:26 +0000 (0:00:00.717)       0:00:04.771 *********
2026-08-24 15:14:26.776914 | instance | skipping: [instance]
2026-08-24 15:14:26.777192 | instance |
2026-08-24 15:14:26.777359 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-24 15:14:26.777530 | instance | Monday 24 August 2026  15:14:26 +0000 (0:00:00.053)       0:00:04.824 *********
2026-08-24 15:14:26.828323 | instance | skipping: [instance]
2026-08-24 15:14:26.828370 | instance |
2026-08-24 15:14:26.828376 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-24 15:14:26.828381 | instance | Monday 24 August 2026  15:14:26 +0000 (0:00:00.053)       0:00:04.878 *********
2026-08-24 15:14:27.042780 | instance | ok: [instance]
2026-08-24 15:14:27.042825 | instance |
2026-08-24 15:14:27.042874 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-24 15:14:27.043197 | instance | Monday 24 August 2026  15:14:27 +0000 (0:00:00.214)       0:00:05.092 *********
2026-08-24 15:14:28.535684 | instance | ok: [instance]
2026-08-24 15:14:28.535926 | instance |
2026-08-24 15:14:28.536283 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-24 15:14:28.536558 | instance | Monday 24 August 2026  15:14:28 +0000 (0:00:01.493)       0:00:06.586 *********
2026-08-24 15:14:28.604256 | instance | ok: [instance] => {
2026-08-24 15:14:28.604523 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-08-24 15:14:28.604843 | instance | }
2026-08-24 15:14:28.605139 | instance |
2026-08-24 15:14:28.605413 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-24 15:14:28.605679 | instance | Monday 24 August 2026  15:14:28 +0000 (0:00:00.069)       0:00:06.655 *********
2026-08-24 15:14:29.362844 | instance | changed: [instance]
2026-08-24 15:14:29.363069 | instance |
2026-08-24 15:14:29.363356 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-24 15:14:29.363645 | instance | Monday 24 August 2026  15:14:29 +0000 (0:00:00.758)       0:00:07.413 *********
2026-08-24 15:14:32.243058 | instance | changed: [instance]
2026-08-24 15:14:32.243273 | instance |
2026-08-24 15:14:32.243285 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-08-24 15:14:32.243295 | instance | Monday 24 August 2026  15:14:32 +0000 (0:00:02.879)       0:00:10.292 *********
2026-08-24 15:14:32.271776 | instance | skipping: [instance]
2026-08-24 15:14:32.272383 | instance |
2026-08-24 15:14:32.272427 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-08-24 15:14:32.272433 | instance | Monday 24 August 2026  15:14:32 +0000 (0:00:00.029)       0:00:10.322 *********
2026-08-24 15:14:32.313848 | instance | skipping: [instance]
2026-08-24 15:14:32.314326 | instance |
2026-08-24 15:14:32.314375 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-08-24 15:14:32.314380 | instance | Monday 24 August 2026  15:14:32 +0000 (0:00:00.041)       0:00:10.364 *********
2026-08-24 15:14:32.346797 | instance | skipping: [instance]
2026-08-24 15:14:32.346884 | instance |
2026-08-24 15:14:32.346995 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-08-24 15:14:32.347195 | instance | Monday 24 August 2026  15:14:32 +0000 (0:00:00.033)       0:00:10.397 *********
2026-08-24 15:14:37.204939 | instance | changed: [instance]
2026-08-24 15:14:37.205154 | instance |
2026-08-24 15:14:37.205529 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-08-24 15:14:37.205582 | instance | Monday 24 August 2026  15:14:37 +0000 (0:00:04.858)       0:00:15.255 *********
2026-08-24 15:14:37.800871 | instance | changed: [instance]
2026-08-24 15:14:37.800953 | instance |
2026-08-24 15:14:37.801264 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-08-24 15:14:37.801309 | instance | Monday 24 August 2026  15:14:37 +0000 (0:00:00.596)       0:00:15.851 *********
2026-08-24 15:14:38.708763 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-08-24 15:14:38.708841 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-08-24 15:14:38.709098 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-08-24 15:14:38.709213 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-08-24 15:14:38.709673 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-08-24 15:14:38.709718 | instance |
2026-08-24 15:14:38.709724 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-08-24 15:14:38.709729 | instance | Monday 24 August 2026  15:14:38 +0000 (0:00:00.907)       0:00:16.759 *********
2026-08-24 15:14:39.304918 | instance | changed: [instance]
2026-08-24 15:14:39.305002 | instance |
2026-08-24 15:14:39.305633 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-08-24 15:14:39.305678 | instance | Monday 24 August 2026  15:14:39 +0000 (0:00:00.579)       0:00:17.339 *********
2026-08-24 15:14:39.305684 | instance |
2026-08-24 15:14:39.305688 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-24 15:14:39.305692 | instance | Monday 24 August 2026  15:14:39 +0000 (0:00:00.016)       0:00:17.355 *********
2026-08-24 15:14:40.311043 | instance | ok: [instance]
2026-08-24 15:14:40.311671 | instance |
2026-08-24 15:14:40.311858 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-08-24 15:14:40.311867 | instance | Monday 24 August 2026  15:14:40 +0000 (0:00:01.005)       0:00:18.361 *********
2026-08-24 15:14:40.799340 | instance | changed: [instance]
2026-08-24 15:14:40.799435 | instance |
2026-08-24 15:14:40.799809 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-08-24 15:14:40.799865 | instance | Monday 24 August 2026  15:14:40 +0000 (0:00:00.488)       0:00:18.850 *********
2026-08-24 15:14:41.368080 | instance | changed: [instance]
2026-08-24 15:14:41.368162 | instance |
2026-08-24 15:14:41.368456 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-24 15:14:41.368614 | instance | Monday 24 August 2026  15:14:41 +0000 (0:00:00.569)       0:00:19.419 *********
2026-08-24 15:14:41.577412 | instance | ok: [instance]
2026-08-24 15:14:41.577903 | instance |
2026-08-24 15:14:41.577924 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-24 15:14:41.577931 | instance | Monday 24 August 2026  15:14:41 +0000 (0:00:00.209)       0:00:19.628 *********
2026-08-24 15:14:41.630243 | instance | ok: [instance] => {
2026-08-24 15:14:41.630439 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-08-24 15:14:41.631464 | instance | }
2026-08-24 15:14:41.631484 | instance |
2026-08-24 15:14:41.631491 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-24 15:14:41.631498 | instance | Monday 24 August 2026  15:14:41 +0000 (0:00:00.052)       0:00:19.681 *********
2026-08-24 15:14:42.379964 | instance | changed: [instance]
2026-08-24 15:14:42.380051 | instance |
2026-08-24 15:14:42.380308 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-24 15:14:42.380357 | instance | Monday 24 August 2026  15:14:42 +0000 (0:00:00.749)       0:00:20.430 *********
2026-08-24 15:14:46.879788 | instance | changed: [instance]
2026-08-24 15:14:46.879829 | instance |
2026-08-24 15:14:46.879835 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-08-24 15:14:46.879840 | instance | Monday 24 August 2026  15:14:46 +0000 (0:00:04.499)       0:00:24.930 *********
2026-08-24 15:14:47.908240 | instance | ok: [instance]
2026-08-24 15:14:47.908308 | instance |
2026-08-24 15:14:47.908593 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-08-24 15:14:47.908634 | instance | Monday 24 August 2026  15:14:47 +0000 (0:00:01.028)       0:00:25.959 *********
2026-08-24 15:14:48.314664 | instance | changed: [instance]
2026-08-24 15:14:48.314731 | instance |
2026-08-24 15:14:48.314981 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-08-24 15:14:48.314997 | instance | Monday 24 August 2026  15:14:48 +0000 (0:00:00.406)       0:00:26.365 *********
2026-08-24 15:14:48.841142 | instance | changed: [instance]
2026-08-24 15:14:48.841744 | instance |
2026-08-24 15:14:48.841812 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-08-24 15:14:48.841821 | instance | Monday 24 August 2026  15:14:48 +0000 (0:00:00.525)       0:00:26.891 *********
2026-08-24 15:14:49.450188 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-08-24 15:14:49.450272 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-08-24 15:14:49.450793 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-08-24 15:14:49.450953 | instance |
2026-08-24 15:14:49.450961 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-08-24 15:14:49.450966 | instance | Monday 24 August 2026  15:14:49 +0000 (0:00:00.609)       0:00:27.500 *********
2026-08-24 15:14:49.929156 | instance | changed: [instance]
2026-08-24 15:14:49.929279 | instance |
2026-08-24 15:14:49.929575 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-08-24 15:14:49.929629 | instance | Monday 24 August 2026  15:14:49 +0000 (0:00:00.479)       0:00:27.979 *********
2026-08-24 15:14:50.427583 | instance | changed: [instance]
2026-08-24 15:14:50.427655 | instance |
2026-08-24 15:14:50.428284 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-08-24 15:14:50.428349 | instance | Monday 24 August 2026  15:14:50 +0000 (0:00:00.480)       0:00:28.460 *********
2026-08-24 15:14:50.428355 | instance |
2026-08-24 15:14:50.428360 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-24 15:14:50.428370 | instance | Monday 24 August 2026  15:14:50 +0000 (0:00:00.018)       0:00:28.478 *********
2026-08-24 15:14:51.145121 | instance | ok: [instance]
2026-08-24 15:14:51.145163 | instance |
2026-08-24 15:14:51.145170 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-08-24 15:14:51.145177 | instance | Monday 24 August 2026  15:14:51 +0000 (0:00:00.716)       0:00:29.195 *********
2026-08-24 15:14:51.980923 | instance | changed: [instance]
2026-08-24 15:14:51.981014 | instance |
2026-08-24 15:14:51.981157 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-08-24 15:14:51.981281 | instance | Monday 24 August 2026  15:14:51 +0000 (0:00:00.836)       0:00:30.031 *********
2026-08-24 15:14:52.570583 | instance | changed: [instance]
2026-08-24 15:14:52.570708 | instance |
2026-08-24 15:14:52.570870 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-08-24 15:14:52.571030 | instance | Monday 24 August 2026  15:14:52 +0000 (0:00:00.589)       0:00:30.621 *********
2026-08-24 15:14:52.636019 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-08-24 15:14:52.636266 | instance |
2026-08-24 15:14:52.636549 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-08-24 15:14:52.636826 | instance | Monday 24 August 2026  15:14:52 +0000 (0:00:00.065)       0:00:30.686 *********
2026-08-24 15:14:57.620450 | instance | changed: [instance]
2026-08-24 15:14:57.620523 | instance |
2026-08-24 15:14:57.620529 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-08-24 15:14:57.620534 | instance | Monday 24 August 2026  15:14:57 +0000 (0:00:04.983)       0:00:35.669 *********
2026-08-24 15:14:58.348004 | instance | ok: [instance] => (item=chronyd)
2026-08-24 15:14:58.348129 | instance | ok: [instance] => (item=sshd)
2026-08-24 15:14:58.348678 | instance |
2026-08-24 15:14:58.348885 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-08-24 15:14:58.348900 | instance | Monday 24 August 2026  15:14:58 +0000 (0:00:00.728)       0:00:36.398 *********
2026-08-24 15:14:59.604509 | instance | changed: [instance]
2026-08-24 15:14:59.604583 | instance |
2026-08-24 15:14:59.604835 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-08-24 15:14:59.604876 | instance | Monday 24 August 2026  15:14:59 +0000 (0:00:01.257)       0:00:37.655 *********
2026-08-24 15:14:59.825312 | instance | ok: [instance]
2026-08-24 15:14:59.825937 | instance |
2026-08-24 15:14:59.825951 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-08-24 15:14:59.825961 | instance | Monday 24 August 2026  15:14:59 +0000 (0:00:00.220)       0:00:37.875 *********
2026-08-24 15:15:00.254194 | instance | changed: [instance]
2026-08-24 15:15:00.254691 | instance |
2026-08-24 15:15:00.254710 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-08-24 15:15:00.254717 | instance | Monday 24 August 2026  15:15:00 +0000 (0:00:00.429)       0:00:38.305 *********
2026-08-24 15:15:00.600708 | instance | changed: [instance]
2026-08-24 15:15:00.600779 | instance |
2026-08-24 15:15:00.601050 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-08-24 15:15:00.601094 | instance | Monday 24 August 2026  15:15:00 +0000 (0:00:00.346)       0:00:38.651 *********
2026-08-24 15:15:00.790118 | instance | ok: [instance]
2026-08-24 15:15:00.790179 | instance |
2026-08-24 15:15:00.790456 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-08-24 15:15:00.790505 | instance | Monday 24 August 2026  15:15:00 +0000 (0:00:00.189)       0:00:38.841 *********
2026-08-24 15:15:01.017506 | instance | ok: [instance] => (item=instance)
2026-08-24 15:15:01.017569 | instance |
2026-08-24 15:15:01.017868 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-08-24 15:15:01.017910 | instance | Monday 24 August 2026  15:15:01 +0000 (0:00:00.227)       0:00:39.068 *********
2026-08-24 15:15:01.073185 | instance | ok: [instance]
2026-08-24 15:15:01.073923 | instance |
2026-08-24 15:15:01.073976 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-08-24 15:15:01.073988 | instance | Monday 24 August 2026  15:15:01 +0000 (0:00:00.054)       0:00:39.123 *********
2026-08-24 15:15:01.147329 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-08-24 15:15:01.147450 | instance |
2026-08-24 15:15:01.147598 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-08-24 15:15:01.147717 | instance | Monday 24 August 2026  15:15:01 +0000 (0:00:00.075)       0:00:39.198 *********
2026-08-24 15:15:01.408042 | instance | changed: [instance]
2026-08-24 15:15:01.408113 | instance |
2026-08-24 15:15:01.408391 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-08-24 15:15:01.408431 | instance | Monday 24 August 2026  15:15:01 +0000 (0:00:00.260)       0:00:39.459 *********
2026-08-24 15:15:02.098048 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-08-24 15:15:02.098146 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-08-24 15:15:02.098648 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-08-24 15:15:02.098690 | instance |
2026-08-24 15:15:02.098696 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-08-24 15:15:02.098701 | instance | Monday 24 August 2026  15:15:02 +0000 (0:00:00.689)       0:00:40.148 *********
2026-08-24 15:16:30.931218 | instance | ok: [instance]
2026-08-24 15:16:30.931335 | instance |
2026-08-24 15:16:30.931349 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-08-24 15:16:30.931359 | instance | Monday 24 August 2026  15:16:30 +0000 (0:01:28.832)       0:02:08.981 *********
2026-08-24 15:16:31.146961 | instance | changed: [instance]
2026-08-24 15:16:31.147042 | instance |
2026-08-24 15:16:31.147166 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-08-24 15:16:31.147289 | instance | Monday 24 August 2026  15:16:31 +0000 (0:00:00.216)       0:02:09.197 *********
2026-08-24 15:16:31.193402 | instance | ok: [instance]
2026-08-24 15:16:31.193502 | instance |
2026-08-24 15:16:31.193632 | instance | TASK [Install Ceph host] *******************************************************
2026-08-24 15:16:31.193762 | instance | Monday 24 August 2026  15:16:31 +0000 (0:00:00.046)       0:02:09.244 *********
2026-08-24 15:16:31.278433 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-08-24 15:16:31.278501 | instance |
2026-08-24 15:16:31.278760 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-08-24 15:16:31.278823 | instance | Monday 24 August 2026  15:16:31 +0000 (0:00:00.084)       0:02:09.329 *********
2026-08-24 15:16:32.918998 | instance | ok: [instance]
2026-08-24 15:16:32.919052 | instance |
2026-08-24 15:16:32.919068 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-08-24 15:16:32.919076 | instance | Monday 24 August 2026  15:16:32 +0000 (0:00:01.640)       0:02:10.969 *********
2026-08-24 15:16:32.986036 | instance | ok: [instance] => (item=instance)
2026-08-24 15:16:32.986081 | instance |
2026-08-24 15:16:32.986089 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-08-24 15:16:32.986096 | instance | Monday 24 August 2026  15:16:32 +0000 (0:00:00.066)       0:02:11.036 *********
2026-08-24 15:16:33.343579 | instance | ok: [instance]
2026-08-24 15:16:33.343628 | instance |
2026-08-24 15:16:33.343636 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-08-24 15:16:33.343642 | instance | Monday 24 August 2026  15:16:33 +0000 (0:00:00.357)       0:02:11.393 *********
2026-08-24 15:16:35.850333 | instance | ok: [instance]
2026-08-24 15:16:35.850416 | instance |
2026-08-24 15:16:35.850661 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-08-24 15:16:35.850725 | instance | Monday 24 August 2026  15:16:35 +0000 (0:00:02.507)       0:02:13.901 *********
2026-08-24 15:17:20.584600 | 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-24 15:17:20.585323 | 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_lryml0q8/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_lryml0q8/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_lryml0q8/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_lryml0q8/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-24T15:17:20.426+0000 7f4be2c6b640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAkYIxqZUUwIyAAXHe3noeorrfUNOADK3DU3q0B+vcgp8cYISIuzSV/Llk=: Malformed input [buffer:3]\n2026-08-24T15:17:20.426+0000 7f4be2c6b640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T15:17:20.430+0000 7f4be2c6b640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAkYIxqZUUwIyAAXHe3noeorrfUNOADK3DU3q0B+vcgp8cYISIuzSV/Llk=: Malformed input [buffer:3]\n2026-08-24T15:17:20.430+0000 7f4be2c6b640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T15:17:20.430+0000 7f4be2c6b640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAkYIxqZUUwIyAAXHe3noeorrfUNOADK3DU3q0B+vcgp8cYISIuzSV/Llk=: Malformed input [buffer:3]\n2026-08-24T15:17:20.430+0000 7f4be2c6b640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T15:17:20.430+0000 7f4be2c6b640 -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-24 15:17:20.587227 | instance |
2026-08-24 15:17:20.587403 | instance | PLAY RECAP *********************************************************************
2026-08-24 15:17:20.587588 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=7    rescued=0    ignored=0
2026-08-24 15:17:20.589109 | instance |
2026-08-24 15:17:20.589195 | instance | Monday 24 August 2026  15:17:20 +0000 (0:00:44.737)       0:02:58.638 *********
2026-08-24 15:17:20.589212 | instance | ===============================================================================
2026-08-24 15:17:20.589225 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 88.83s
2026-08-24 15:17:20.589238 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 44.74s
2026-08-24 15:17:20.589251 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 4.98s
2026-08-24 15:17:20.589264 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 4.86s
2026-08-24 15:17:20.589276 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.50s
2026-08-24 15:17:20.589298 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.88s
2026-08-24 15:17:20.589334 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.51s
2026-08-24 15:17:20.591297 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.72s
2026-08-24 15:17:20.591334 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.64s
2026-08-24 15:17:20.591341 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.49s
2026-08-24 15:17:20.591347 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 1.26s
2026-08-24 15:17:20.591352 | instance | Gathering Facts --------------------------------------------------------- 1.05s
2026-08-24 15:17:20.591357 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.03s
2026-08-24 15:17:20.591363 | instance | Gathering Facts --------------------------------------------------------- 0.93s
2026-08-24 15:17:20.591368 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.91s
2026-08-24 15:17:20.591373 | instance | Gathering Facts --------------------------------------------------------- 0.91s
2026-08-24 15:17:20.591379 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 0.84s
2026-08-24 15:17:20.591384 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.76s
2026-08-24 15:17:20.591390 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.75s
2026-08-24 15:17:20.591395 | instance | vexxhost.ceph.cephadm : Ensure services are started --------------------- 0.73s
2026-08-24 15:17:20.686758 | 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-24 15:17:20.687047 | instance | ERROR    [csi > converge] Executed: Failed
2026-08-24 15:17:20.687243 | 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-24 15:17:21.365552 | instance | ERROR
2026-08-24 15:17:21.365922 | instance | {
2026-08-24 15:17:21.365992 | instance |   "delta": "0:03:50.165840",
2026-08-24 15:17:21.366050 | instance |   "end": "2026-08-24 15:17:20.736477",
2026-08-24 15:17:21.366093 | instance |   "msg": "non-zero return code",
2026-08-24 15:17:21.366131 | instance |   "rc": 2,
2026-08-24 15:17:21.366170 | instance |   "start": "2026-08-24 15:13:30.570637"
2026-08-24 15:17:21.366217 | instance | }
failure
2026-08-24 15:17:21.384053 | 
2026-08-24 15:17:21.443729 | PLAY RECAP
2026-08-24 15:17:21.445916 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-08-24 15:17:21.446024 | 
2026-08-24 15:17:21.701982 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-24 15:17:22.280568 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-24 15:17:23.138239 | 
2026-08-24 15:17:23.262561 | PLAY [all]
2026-08-24 15:17:23.325566 | 
2026-08-24 15:17:23.325771 | TASK [gather-host-logs : creating directory for system status]
2026-08-24 15:17:23.667240 | instance | changed
2026-08-24 15:17:23.674429 | 
2026-08-24 15:17:23.674531 | TASK [gather-host-logs : Get logs for each host]
2026-08-24 15:17:24.058054 | instance | + systemd-cgls --full --all --no-pager
2026-08-24 15:17:24.070890 | instance | + ip addr
2026-08-24 15:17:24.074207 | instance | + ip route
2026-08-24 15:17:24.075995 | instance | + lsblk
2026-08-24 15:17:24.081096 | instance | + mount
2026-08-24 15:17:24.084143 | instance | + docker images
2026-08-24 15:17:24.105997 | instance | + brctl show
2026-08-24 15:17:24.106699 | instance | /bin/bash: line 8: brctl: command not found
2026-08-24 15:17:24.107018 | instance | + ps aux --sort=-%mem
2026-08-24 15:17:24.123210 | instance | + dpkg -l
2026-08-24 15:17:24.137132 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-08-24 15:17:24.137537 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-08-24 15:17:24.156585 | instance | + '[' '!' -z '' ']'
2026-08-24 15:17:24.242369 | instance | ok: Runtime: 0:00:00.104102
2026-08-24 15:17:24.248974 | 
2026-08-24 15:17:24.249055 | TASK [gather-host-logs : Downloads logs to executor]
2026-08-24 15:17:24.932781 | instance | changed:
2026-08-24 15:17:24.932925 | instance | created directory /var/lib/zuul/builds/ba86265a93c54bd5878fc852acdbab40/work/logs/instance
2026-08-24 15:17:24.932972 | instance | cd+++++++++ system/
2026-08-24 15:17:24.933006 | instance | >f+++++++++ system/brctl-show.txt
2026-08-24 15:17:24.933030 | instance | >f+++++++++ system/docker-images.txt
2026-08-24 15:17:24.933053 | instance | >f+++++++++ system/ip-addr.txt
2026-08-24 15:17:24.933076 | instance | >f+++++++++ system/ip-route.txt
2026-08-24 15:17:24.933099 | instance | >f+++++++++ system/lsblk.txt
2026-08-24 15:17:24.933122 | instance | >f+++++++++ system/mount.txt
2026-08-24 15:17:24.933142 | instance | >f+++++++++ system/packages.txt
2026-08-24 15:17:24.933164 | instance | >f+++++++++ system/ps.txt
2026-08-24 15:17:24.933187 | instance | >f+++++++++ system/systemd-cgls.txt
2026-08-24 15:17:24.948444 | 
2026-08-24 15:17:24.948580 | LOOP [helm-release-status : creating directory for helm release status]
2026-08-24 15:17:25.149780 | instance | changed: "values"
2026-08-24 15:17:25.671411 | instance | changed: "releases"
2026-08-24 15:17:25.687621 | 
2026-08-24 15:17:25.687743 | TASK [helm-release-status : Gather get release status for helm charts]
2026-08-24 15:17:25.909142 | instance | /bin/bash: line 3: kubectl: command not found
2026-08-24 15:17:26.252524 | instance | ok: Runtime: 0:00:00.005847
2026-08-24 15:17:26.260619 | 
2026-08-24 15:17:26.260811 | TASK [helm-release-status : Downloads logs to executor]
2026-08-24 15:17:26.984673 | instance | changed:
2026-08-24 15:17:26.984866 | instance | cd+++++++++ helm/
2026-08-24 15:17:26.984909 | instance | cd+++++++++ helm/releases/
2026-08-24 15:17:26.984939 | instance | cd+++++++++ helm/values/
2026-08-24 15:17:26.995130 | 
2026-08-24 15:17:26.995206 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-08-24 15:17:27.222266 | instance | changed
2026-08-24 15:17:27.252327 | 
2026-08-24 15:17:27.252488 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-08-24 15:17:27.501467 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-24 15:17:27.502270 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-24 15:17:27.507986 | instance | environment: line 1: kubectl: command not found
2026-08-24 15:17:27.509361 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-24 15:17:27.509861 | instance | environment: line 1: kubectl: command not found
2026-08-24 15:17:27.511257 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-24 15:17:27.513510 | instance | environment: line 1: kubectl: command not found
2026-08-24 15:17:27.514499 | instance | environment: line 1: kubectl: command not found
2026-08-24 15:17:27.514639 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-24 15:17:27.515489 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-24 15:17:27.517244 | instance | environment: line 1: kubectl: command not found
2026-08-24 15:17:27.518190 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-24 15:17:27.804935 | instance | ok: Runtime: 0:00:00.022581
2026-08-24 15:17:27.813460 | 
2026-08-24 15:17:27.813524 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-08-24 15:17:28.027976 | instance | changed
2026-08-24 15:17:28.161379 | 
2026-08-24 15:17:28.161520 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-08-24 15:17:28.388184 | instance | environment: line 5: kubectl: command not found
2026-08-24 15:17:28.389682 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-24 15:17:28.389788 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-24 15:17:28.389919 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-24 15:17:28.702603 | instance | ok: Runtime: 0:00:00.009512
2026-08-24 15:17:28.708869 | 
2026-08-24 15:17:28.708930 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-08-24 15:17:29.195045 | instance | changed:
2026-08-24 15:17:29.195203 | instance | cd+++++++++ objects/
2026-08-24 15:17:29.195230 | instance | cd+++++++++ objects/cluster/
2026-08-24 15:17:29.195252 | instance | cd+++++++++ objects/namespaced/
2026-08-24 15:17:29.205230 | 
2026-08-24 15:17:29.205295 | TASK [gather-pod-logs : creating directory for pod logs]
2026-08-24 15:17:29.399750 | instance | changed
2026-08-24 15:17:29.406587 | 
2026-08-24 15:17:29.406679 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-08-24 15:17:29.606214 | instance | changed
2026-08-24 15:17:29.716151 | 
2026-08-24 15:17:29.716353 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-08-24 15:17:29.924185 | instance | environment: line 3: kubectl: command not found
2026-08-24 15:17:30.255533 | instance | ok: Runtime: 0:00:00.007621
2026-08-24 15:17:30.262436 | 
2026-08-24 15:17:30.262502 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-08-24 15:17:30.755964 | instance | changed:
2026-08-24 15:17:31.383807 | instance | cd+++++++++ pod-logs/
2026-08-24 15:17:31.384185 | instance | cd+++++++++ pod-logs/failed-pods/
2026-08-24 15:17:31.402345 | 
2026-08-24 15:17:31.402498 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-08-24 15:17:31.612974 | instance | changed
2026-08-24 15:17:31.621482 | 
2026-08-24 15:17:31.621565 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-08-24 15:17:31.828749 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-24 15:17:32.739907 | instance | ok: Runtime: 0:00:00.033578
2026-08-24 15:17:32.746887 | 
2026-08-24 15:17:32.746987 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-08-24 15:17:32.977292 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-24 15:17:33.006178 | instance | ceph-mgr endpoints:
2026-08-24 15:17:33.302492 | instance | ok: Runtime: 0:00:00.035163
2026-08-24 15:17:33.309099 | 
2026-08-24 15:17:33.309178 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-08-24 15:17:33.528302 | instance | /bin/bash: line 4: kubectl: command not found
2026-08-24 15:17:33.859449 | instance | ok: Runtime: 0:00:00.032194
2026-08-24 15:17:33.866888 | 
2026-08-24 15:17:33.867054 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-08-24 15:17:34.417563 | instance | changed: cd+++++++++ prometheus/
2026-08-24 15:17:34.432326 | 
2026-08-24 15:17:34.432591 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-08-24 15:17:34.631493 | instance | changed
2026-08-24 15:17:34.641889 | 
2026-08-24 15:17:34.641961 | TASK [gather-selenium-data : Get selenium data]
2026-08-24 15:17:34.889973 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-08-24 15:17:34.891354 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-08-24 15:17:37.371420 | instance | ERROR
2026-08-24 15:17:37.371691 | instance | {
2026-08-24 15:17:37.371779 | instance |   "delta": "0:00:00.005220",
2026-08-24 15:17:37.371821 | instance |   "end": "2026-08-24 15:17:34.891665",
2026-08-24 15:17:37.371860 | instance |   "msg": "non-zero return code",
2026-08-24 15:17:37.371896 | instance |   "rc": 1,
2026-08-24 15:17:37.372008 | instance |   "start": "2026-08-24 15:17:34.886445"
2026-08-24 15:17:37.372051 | instance | }
2026-08-24 15:17:37.372087 | instance | ERROR: Ignoring Errors
2026-08-24 15:17:37.377155 | 
2026-08-24 15:17:37.377229 | TASK [gather-selenium-data : Downloads logs to executor]
2026-08-24 15:17:37.870463 | instance | changed: cd+++++++++ selenium/
2026-08-24 15:17:37.877676 | 
2026-08-24 15:17:37.877744 | PLAY RECAP
2026-08-24 15:17:37.877839 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-08-24 15:17:37.877869 | 
2026-08-24 15:17:38.069245 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-24 15:17:39.467767 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-24 15:17:42.268075 | 
2026-08-24 15:17:42.550576 | PLAY [all]
2026-08-24 15:17:42.573461 | 
2026-08-24 15:17:42.573658 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-24 15:17:42.618946 | instance | skipping: Conditional result was False
2026-08-24 15:17:42.634440 | 
2026-08-24 15:17:42.634621 | TASK [fetch-output : Set log path for single node]
2026-08-24 15:17:42.678315 | instance | ok
2026-08-24 15:17:42.683271 | 
2026-08-24 15:17:42.683355 | LOOP [fetch-output : Ensure local output dirs]
2026-08-24 15:17:43.788483 | instance -> localhost | ok: "/var/lib/zuul/builds/ba86265a93c54bd5878fc852acdbab40/work/logs"
2026-08-24 15:17:44.028200 | instance -> localhost | changed: "/var/lib/zuul/builds/ba86265a93c54bd5878fc852acdbab40/work/artifacts"
2026-08-24 15:17:44.248146 | instance -> localhost | changed: "/var/lib/zuul/builds/ba86265a93c54bd5878fc852acdbab40/work/docs"
2026-08-24 15:17:44.267602 | 
2026-08-24 15:17:44.267754 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-24 15:17:44.969139 | instance | changed: .d..t...... ./
2026-08-24 15:17:44.969332 | instance | changed: All items complete
2026-08-24 15:17:44.969359 | 
2026-08-24 15:17:45.432613 | instance | changed: .d..t...... ./
2026-08-24 15:17:45.902598 | instance | changed: .d..t...... ./
2026-08-24 15:17:45.936002 | 
2026-08-24 15:17:45.936172 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-24 15:17:46.404411 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007121
2026-08-24 15:17:46.692263 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.008438
2026-08-24 15:17:46.713539 | 
2026-08-24 15:17:46.713667 | PLAY [all]
2026-08-24 15:17:46.720471 | 
2026-08-24 15:17:46.720538 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-24 15:17:47.192424 | instance | changed
2026-08-24 15:17:47.199716 | 
2026-08-24 15:17:47.199773 | PLAY RECAP
2026-08-24 15:17:47.199851 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-24 15:17:47.199877 | 
2026-08-24 15:17:47.358574 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-24 15:17:47.707555 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-24 15:17:48.439710 | 
2026-08-24 15:17:48.440129 | PLAY [localhost]
2026-08-24 15:17:48.454235 | 
2026-08-24 15:17:48.454355 | TASK [Generate Zuul manifest]
2026-08-24 15:17:48.474911 | localhost | ok
2026-08-24 15:17:48.582146 | 
2026-08-24 15:17:48.582280 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-24 15:17:49.322314 | localhost | changed
2026-08-24 15:17:49.337459 | 
2026-08-24 15:17:49.337604 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-24 15:17:49.389861 | localhost | ok
2026-08-24 15:17:49.399621 | 
2026-08-24 15:17:49.399742 | TASK [Upload logs]
2026-08-24 15:17:49.421934 | localhost | ok
2026-08-24 15:17:49.542714 | 
2026-08-24 15:17:49.542869 | TASK [Set zuul-log-path fact]
2026-08-24 15:17:49.562941 | localhost | ok
2026-08-24 15:17:49.860662 | 
2026-08-24 15:17:49.860805 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-24 15:17:49.894141 | localhost | ok
2026-08-24 15:17:49.903497 | 
2026-08-24 15:17:49.903573 | TASK [upload-logs : Create log directories]
2026-08-24 15:17:50.424144 | localhost | changed
2026-08-24 15:17:50.432109 | 
2026-08-24 15:17:50.432184 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-24 15:17:51.127267 | localhost -> localhost | ok: Runtime: 0:00:00.181665
2026-08-24 15:17:51.135031 | 
2026-08-24 15:17:51.135130 | TASK [upload-logs : Upload logs to log server]
2026-08-24 15:17:52.007488 | localhost | Output suppressed because no_log was given
2026-08-24 15:17:52.072573 | 
2026-08-24 15:17:52.176063 | LOOP [upload-logs : Compress console log and json output]
2026-08-24 15:17:52.229514 | localhost | skipping: Conditional result was False
2026-08-24 15:17:52.236372 | localhost | skipping: Conditional result was False
2026-08-24 15:17:52.251788 | 
2026-08-24 15:17:52.251962 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-24 15:17:52.294961 | localhost | skipping: Conditional result was False
2026-08-24 15:17:52.295231 | 
2026-08-24 15:17:52.299540 | localhost | skipping: Conditional result was False
2026-08-24 15:17:52.315748 | 
2026-08-24 15:17:52.315895 | LOOP [upload-logs : Upload console log and json output]