2026-09-07 03:17:09.313275 | Job console starting
2026-09-07 03:17:09.327316 | Updating git repos
2026-09-07 03:17:15.237439 | Cloning repos into workspace
2026-09-07 03:17:31.171489 | Restoring repo states
2026-09-07 03:17:40.859841 | Merging changes
2026-09-07 03:17:42.385566 | Checking out repos
2026-09-07 03:17:45.011749 | Preparing playbooks
2026-09-07 03:17:47.181954 | Running Ansible setup
2026-09-07 03:17:50.974137 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-07 03:17:51.573447 | 
2026-09-07 03:17:51.573672 | PLAY [localhost]
2026-09-07 03:17:51.582223 | 
2026-09-07 03:17:51.582331 | TASK [Gathering Facts]
2026-09-07 03:17:52.555909 | localhost | ok
2026-09-07 03:17:52.570428 | 
2026-09-07 03:17:52.570587 | TASK [Setup log path fact]
2026-09-07 03:17:52.593151 | localhost | ok
2026-09-07 03:17:52.612046 | 
2026-09-07 03:17:52.612215 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-07 03:17:52.652867 | localhost | ok
2026-09-07 03:17:52.664756 | 
2026-09-07 03:17:52.664902 | TASK [emit-job-header : Print job information]
2026-09-07 03:17:52.716451 | # Job Information
2026-09-07 03:17:52.716738 | Ansible Version: 2.16.18
2026-09-07 03:17:52.716791 | Job: atmosphere-molecule-csi-rbd
2026-09-07 03:17:52.716826 | Pipeline: check
2026-09-07 03:17:52.716857 | Executor: 2d72f0692154
2026-09-07 03:17:52.716888 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3501
2026-09-07 03:17:52.716924 | Event ID: 210cac50-aa6a-11f1-9bb3-43ee60184194
2026-09-07 03:17:52.720875 | 
2026-09-07 03:17:52.720955 | LOOP [emit-job-header : Print node information]
2026-09-07 03:17:52.836813 | localhost | ok:
2026-09-07 03:17:52.837112 | localhost | # Node Information
2026-09-07 03:17:52.837175 | localhost | Inventory Hostname: instance
2026-09-07 03:17:52.837222 | localhost | Hostname: np0000192006
2026-09-07 03:17:52.837263 | localhost | Username: zuul
2026-09-07 03:17:52.837321 | localhost | Distro: Ubuntu 22.04
2026-09-07 03:17:52.837376 | localhost | Provider: yul1
2026-09-07 03:17:52.837437 | localhost | Region: ca-ymq-1
2026-09-07 03:17:52.837492 | localhost | Label: ubuntu-jammy
2026-09-07 03:17:52.837540 | localhost | Product Name: OpenStack Nova
2026-09-07 03:17:52.837598 | localhost | Interface IP: 162.253.55.33
2026-09-07 03:17:52.851374 | 
2026-09-07 03:17:52.851577 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-09-07 03:17:53.333844 | localhost -> localhost | changed
2026-09-07 03:17:53.340535 | 
2026-09-07 03:17:53.340614 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-09-07 03:17:54.167667 | localhost -> localhost | changed
2026-09-07 03:17:54.180636 | 
2026-09-07 03:17:54.180769 | PLAY [all]
2026-09-07 03:17:54.189492 | 
2026-09-07 03:17:54.189685 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-09-07 03:17:54.419185 | instance -> localhost | ok
2026-09-07 03:17:54.425555 | 
2026-09-07 03:17:54.425654 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-09-07 03:17:54.455013 | instance | ok
2026-09-07 03:17:54.472364 | instance | included: /var/lib/zuul/builds/d265e85873e6461ab2420c9801648720/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-09-07 03:17:54.480936 | 
2026-09-07 03:17:54.481122 | TASK [add-build-sshkey : Create Temp SSH key]
2026-09-07 03:17:55.695691 | instance -> localhost | Generating public/private rsa key pair.
2026-09-07 03:17:55.695872 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/d265e85873e6461ab2420c9801648720/work/d265e85873e6461ab2420c9801648720_id_rsa
2026-09-07 03:17:55.695900 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/d265e85873e6461ab2420c9801648720/work/d265e85873e6461ab2420c9801648720_id_rsa.pub
2026-09-07 03:17:55.695921 | instance -> localhost | The key fingerprint is:
2026-09-07 03:17:55.695940 | instance -> localhost | SHA256:pIEC3OdbWmIrPtiUTlpaY/AcXh49eJsktzNOWC9F99o zuul-build-sshkey
2026-09-07 03:17:55.695975 | instance -> localhost | The key's randomart image is:
2026-09-07 03:17:55.695995 | instance -> localhost | +---[RSA 3072]----+
2026-09-07 03:17:55.696014 | instance -> localhost | |o .              |
2026-09-07 03:17:55.696034 | instance -> localhost | | o . o   . .     |
2026-09-07 03:17:55.696053 | instance -> localhost | |  . + + o . .    |
2026-09-07 03:17:55.696071 | instance -> localhost | | . o O & .   .   |
2026-09-07 03:17:55.696090 | instance -> localhost | |  = * ^ S   o    |
2026-09-07 03:17:55.696108 | instance -> localhost | |   & * O . . E   |
2026-09-07 03:17:55.696126 | instance -> localhost | |  & o o +        |
2026-09-07 03:17:55.696144 | instance -> localhost | | + =   .         |
2026-09-07 03:17:55.696165 | instance -> localhost | |    .            |
2026-09-07 03:17:55.696183 | instance -> localhost | +----[SHA256]-----+
2026-09-07 03:17:55.696231 | instance -> localhost | ok: Runtime: 0:00:00.773389
2026-09-07 03:17:55.702247 | 
2026-09-07 03:17:55.702373 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-09-07 03:17:55.731348 | instance | ok
2026-09-07 03:17:55.739379 | instance | included: /var/lib/zuul/builds/d265e85873e6461ab2420c9801648720/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-09-07 03:17:55.745944 | 
2026-09-07 03:17:55.746013 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-09-07 03:17:55.769894 | instance | skipping: Conditional result was False
2026-09-07 03:17:55.775045 | 
2026-09-07 03:17:55.775110 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-09-07 03:17:56.283259 | instance | changed
2026-09-07 03:17:56.306675 | 
2026-09-07 03:17:56.306959 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-09-07 03:17:56.515160 | instance | ok
2026-09-07 03:17:56.527427 | 
2026-09-07 03:17:56.527522 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-09-07 03:17:57.028674 | instance | changed
2026-09-07 03:17:57.040924 | 
2026-09-07 03:17:57.041023 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-09-07 03:17:57.547269 | instance | changed
2026-09-07 03:17:57.581211 | 
2026-09-07 03:17:57.581411 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-09-07 03:17:57.606930 | instance | skipping: Conditional result was False
2026-09-07 03:17:57.618018 | 
2026-09-07 03:17:57.618180 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-09-07 03:17:58.019560 | instance -> localhost | changed
2026-09-07 03:17:58.031234 | 
2026-09-07 03:17:58.031338 | TASK [add-build-sshkey : Add back temp key]
2026-09-07 03:17:58.313024 | instance -> localhost | Identity added: /var/lib/zuul/builds/d265e85873e6461ab2420c9801648720/work/d265e85873e6461ab2420c9801648720_id_rsa (zuul-build-sshkey)
2026-09-07 03:17:58.313491 | instance -> localhost | ok: Runtime: 0:00:00.015630
2026-09-07 03:17:58.324746 | 
2026-09-07 03:17:58.324976 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-09-07 03:17:58.657610 | instance | ok
2026-09-07 03:17:58.663257 | 
2026-09-07 03:17:58.663345 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-09-07 03:17:58.687578 | instance | skipping: Conditional result was False
2026-09-07 03:17:58.707339 | 
2026-09-07 03:17:58.707443 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-09-07 03:17:59.074739 | instance | ok
2026-09-07 03:17:59.087362 | 
2026-09-07 03:17:59.087664 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-09-07 03:18:07.802304 | instance | Output suppressed because no_log was given
2026-09-07 03:18:07.819820 | 
2026-09-07 03:18:07.820045 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-09-07 03:18:08.051284 | instance | ok: "logs"
2026-09-07 03:18:08.051760 | instance | ok: All items complete
2026-09-07 03:18:08.051875 | 
2026-09-07 03:18:08.218378 | instance | ok: "artifacts"
2026-09-07 03:18:08.373937 | instance | ok: "docs"
2026-09-07 03:18:08.396999 | 
2026-09-07 03:18:08.397221 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-09-07 03:18:08.597029 | instance | changed: "logs"
2026-09-07 03:18:08.758503 | instance | changed: "artifacts"
2026-09-07 03:18:08.941898 | instance | changed: "docs"
2026-09-07 03:18:08.964728 | 
2026-09-07 03:18:08.964879 | PLAY RECAP
2026-09-07 03:18:08.964946 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-09-07 03:18:08.964983 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-07 03:18:08.965018 | 
2026-09-07 03:18:09.218778 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-07 03:18:09.222404 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-07 03:18:09.916059 | 
2026-09-07 03:18:09.916480 | PLAY [all]
2026-09-07 03:18:09.926337 | 
2026-09-07 03:18:09.926405 | TASK [setup-uv : Extract archive]
2026-09-07 03:18:12.371231 | instance | changed
2026-09-07 03:18:12.382992 | 
2026-09-07 03:18:12.383101 | TASK [setup-uv : Print version]
2026-09-07 03:18:12.776798 | instance | uv 0.8.13
2026-09-07 03:18:12.923723 | instance | ok: Runtime: 0:00:00.008580
2026-09-07 03:18:12.934817 | 
2026-09-07 03:18:12.934938 | TASK [Install Ansible collection siblings]
2026-09-07 03:18:22.649721 | instance | changed:
2026-09-07 03:18:22.650036 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-09-07 03:18:22.650098 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-09-07 03:18:22.650142 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-09-07 03:18:22.650192 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-09-07 03:18:22.650248 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-09-07 03:18:22.650302 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-09-07 03:18:22.650344 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-09-07 03:18:22.650387 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-09-07 03:18:22.650427 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-09-07 03:18:22.650465 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-09-07 03:18:22.650502 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-09-07 03:18:22.650538 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-09-07 03:18:22.650575 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-09-07 03:18:22.650612 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-09-07 03:18:22.650650 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0
2026-09-07 03:18:22.650720 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-09-07 03:18:22.650759 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-09-07 03:18:22.650797 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-09-07 03:18:22.650834 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-09-07 03:18:22.650871 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-09-07 03:18:22.650907 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0
2026-09-07 03:18:22.650945 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-09-07 03:18:22.650984 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-09-07 03:18:22.651039 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-09-07 03:18:22.651078 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0
2026-09-07 03:18:22.651115 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-09-07 03:18:22.651152 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-09-07 03:18:22.651188 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-09-07 03:18:22.651231 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-09-07 03:18:22.651282 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-09-07 03:18:22.651330 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-09-07 03:18:22.651382 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-09-07 03:18:22.651434 | instance | Checked out ansible.netcommon to 1.2.0
2026-09-07 03:18:22.651485 | 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-09-07 03:18:22.651552 | instance | Starting galaxy collection install process
2026-09-07 03:18:22.651593 | instance | Process install dependency map
2026-09-07 03:18:22.651631 | instance | Starting collection install process
2026-09-07 03:18:22.651742 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-09-07 03:18:22.651787 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-09-07 03:18:22.651824 | instance | ansible.netcommon:* was installed successfully
2026-09-07 03:18:22.651863 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-09-07 03:18:22.651897 | instance | Creating virtual environment at: .venv
2026-09-07 03:18:22.651933 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-09-07 03:18:22.651969 | instance | Downloading pydantic-core (2.0MiB)
2026-09-07 03:18:22.652004 | instance | Downloading netaddr (2.2MiB)
2026-09-07 03:18:22.652049 | instance | Downloading pygments (1.2MiB)
2026-09-07 03:18:22.652086 | instance | Downloading rjsonnet (1.2MiB)
2026-09-07 03:18:22.652122 | instance | Downloading kubernetes (1.9MiB)
2026-09-07 03:18:22.652162 | instance | Downloading cryptography (4.2MiB)
2026-09-07 03:18:22.652214 | instance | Downloading setuptools (1.1MiB)
2026-09-07 03:18:22.652256 | instance | Downloading openstacksdk (1.7MiB)
2026-09-07 03:18:22.652292 | instance | Downloading ansible-core (2.1MiB)
2026-09-07 03:18:22.652328 | instance |    Building pyperclip==1.9.0
2026-09-07 03:18:22.652368 | instance |  Downloading rjsonnet
2026-09-07 03:18:22.652405 | instance |  Downloading pydantic-core
2026-09-07 03:18:22.652442 | instance |  Downloading netaddr
2026-09-07 03:18:22.652478 | instance |  Downloading pygments
2026-09-07 03:18:22.652711 | instance |  Downloading cryptography
2026-09-07 03:18:22.652784 | instance |  Downloading setuptools
2026-09-07 03:18:22.652826 | instance |  Downloading kubernetes
2026-09-07 03:18:22.652867 | instance |  Downloading ansible-core
2026-09-07 03:18:22.652904 | instance |  Downloading openstacksdk
2026-09-07 03:18:22.652940 | instance |       Built pyperclip==1.9.0
2026-09-07 03:18:22.652976 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-09-07 03:18:22.653012 | instance | Installed 83 packages in 58ms
2026-09-07 03:18:22.653046 | instance | Checked out ansible.posix to 1.6.0
2026-09-07 03:18:22.653083 | 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-09-07 03:18:22.653120 | instance | Starting galaxy collection install process
2026-09-07 03:18:22.653155 | instance | Process install dependency map
2026-09-07 03:18:22.653220 | instance | Starting collection install process
2026-09-07 03:18:22.653300 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-09-07 03:18:22.653364 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-09-07 03:18:22.653406 | instance | ansible.posix:1.6.0 was installed successfully
2026-09-07 03:18:22.653445 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 03:18:22.653483 | instance | 2.17.12
2026-09-07 03:18:22.653519 | instance | Checked out ansible.utils to v6.1.0
2026-09-07 03:18:22.653555 | 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-09-07 03:18:22.653592 | instance | Starting galaxy collection install process
2026-09-07 03:18:22.653628 | instance | Process install dependency map
2026-09-07 03:18:22.653696 | instance | Starting collection install process
2026-09-07 03:18:22.653752 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-09-07 03:18:22.653801 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-09-07 03:18:22.653839 | instance | ansible.utils:6.1.0 was installed successfully
2026-09-07 03:18:22.653877 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 03:18:22.653913 | instance | 2.17.12
2026-09-07 03:18:22.653948 | instance | Checked out atmosphere.common to v0.7.0
2026-09-07 03:18:22.653984 | 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-09-07 03:18:22.654020 | instance | Starting galaxy collection install process
2026-09-07 03:18:22.654057 | instance | Process install dependency map
2026-09-07 03:18:22.654092 | instance | Starting collection install process
2026-09-07 03:18:22.654128 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-09-07 03:18:22.654164 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-09-07 03:18:22.654199 | instance | atmosphere.common:0.7.0 was installed successfully
2026-09-07 03:18:22.654235 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 03:18:22.654271 | instance | 2.17.12
2026-09-07 03:18:22.654307 | instance | Checked out community.crypto to 2.2.3
2026-09-07 03:18:22.654344 | 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-09-07 03:18:22.654379 | instance | Starting galaxy collection install process
2026-09-07 03:18:22.654425 | instance | Process install dependency map
2026-09-07 03:18:22.654478 | instance | Starting collection install process
2026-09-07 03:18:22.654520 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-09-07 03:18:22.654558 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-09-07 03:18:22.654597 | instance | community.crypto:2.2.3 was installed successfully
2026-09-07 03:18:22.654635 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 03:18:22.654699 | instance | 2.17.12
2026-09-07 03:18:22.654742 | instance | Checked out community.general to 7.3.0
2026-09-07 03:18:22.654781 | 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-09-07 03:18:22.654834 | instance | Starting galaxy collection install process
2026-09-07 03:18:22.654873 | instance | Process install dependency map
2026-09-07 03:18:22.654914 | instance | Starting collection install process
2026-09-07 03:18:22.654951 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-09-07 03:18:22.654989 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-09-07 03:18:22.655028 | instance | community.general:7.3.0 was installed successfully
2026-09-07 03:18:22.655073 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 03:18:22.655126 | instance | 2.17.12
2026-09-07 03:18:22.655222 | instance | Checked out community.mysql to 3.6.0
2026-09-07 03:18:22.655269 | 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-09-07 03:18:22.655308 | instance | Starting galaxy collection install process
2026-09-07 03:18:22.655346 | instance | Process install dependency map
2026-09-07 03:18:22.655383 | instance | Starting collection install process
2026-09-07 03:18:22.655420 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-09-07 03:18:22.655455 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-09-07 03:18:22.655492 | instance | community.mysql:3.6.0 was installed successfully
2026-09-07 03:18:22.655529 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 03:18:22.655566 | instance | 2.17.12
2026-09-07 03:18:22.655600 | instance | Checked out kubernetes.core to 2.4.0
2026-09-07 03:18:22.655637 | 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-09-07 03:18:22.655701 | instance | Starting galaxy collection install process
2026-09-07 03:18:22.655740 | instance | Process install dependency map
2026-09-07 03:18:22.655778 | instance | Starting collection install process
2026-09-07 03:18:22.655814 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-09-07 03:18:22.655850 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-09-07 03:18:22.655885 | instance | kubernetes.core:2.4.0 was installed successfully
2026-09-07 03:18:22.655921 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 03:18:22.655956 | instance | 2.17.12
2026-09-07 03:18:22.655991 | instance | Checked out openstack.cloud to 2.6.0
2026-09-07 03:18:22.656025 | 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-09-07 03:18:22.656059 | instance | Starting galaxy collection install process
2026-09-07 03:18:22.656093 | instance | Process install dependency map
2026-09-07 03:18:22.656126 | instance | Starting collection install process
2026-09-07 03:18:22.656161 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-09-07 03:18:22.656212 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-09-07 03:18:22.656308 | instance | openstack.cloud:2.6.0 was installed successfully
2026-09-07 03:18:22.656371 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 03:18:22.656417 | instance | 2.17.12
2026-09-07 03:18:22.656469 | instance | Checked out vexxhost.ceph to v4.2.0
2026-09-07 03:18:22.656545 | 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-09-07 03:18:22.656585 | instance | Starting galaxy collection install process
2026-09-07 03:18:22.656621 | instance | Process install dependency map
2026-09-07 03:18:22.656656 | instance | Starting collection install process
2026-09-07 03:18:22.656718 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-09-07 03:18:22.656755 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-09-07 03:18:22.656790 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-09-07 03:18:22.656824 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 03:18:22.656859 | instance | 2.17.12
2026-09-07 03:18:22.656895 | instance | Checked out vexxhost.containers to v1.6.8
2026-09-07 03:18:22.656931 | 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-09-07 03:18:22.656967 | instance | Starting galaxy collection install process
2026-09-07 03:18:22.657005 | instance | Process install dependency map
2026-09-07 03:18:22.657040 | instance | Starting collection install process
2026-09-07 03:18:22.657075 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-09-07 03:18:22.657110 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-09-07 03:18:22.657145 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-09-07 03:18:22.657182 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 03:18:22.657218 | instance | 2.17.12
2026-09-07 03:18:22.657254 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-09-07 03:18:22.657290 | 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-09-07 03:18:22.657325 | instance | Starting galaxy collection install process
2026-09-07 03:18:22.657363 | instance | Process install dependency map
2026-09-07 03:18:22.657415 | instance | Starting collection install process
2026-09-07 03:18:22.657471 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-09-07 03:18:22.657510 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-09-07 03:18:22.657547 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-09-07 03:18:22.657583 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-07 03:18:22.657617 | instance | 2.17.12
2026-09-07 03:18:22.669139 | 
2026-09-07 03:18:22.669370 | PLAY RECAP
2026-09-07 03:18:22.669456 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-07 03:18:22.669495 | 
2026-09-07 03:18:22.875893 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-07 03:18:22.879541 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-09-07 03:18:23.466919 | 
2026-09-07 03:18:23.467073 | PLAY [all]
2026-09-07 03:18:23.483338 | 
2026-09-07 03:18:23.483480 | TASK [Install "jq" for log collection]
2026-09-07 03:18:33.453005 | instance | changed
2026-09-07 03:18:33.455725 | 
2026-09-07 03:18:33.455799 | PLAY RECAP
2026-09-07 03:18:33.455866 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-07 03:18:33.455947 | 
2026-09-07 03:18:33.579539 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-09-07 03:18:33.583096 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-07 03:18:34.224753 | 
2026-09-07 03:18:34.224952 | PLAY [all]
2026-09-07 03:18:34.238183 | 
2026-09-07 03:18:34.238394 | LOOP [Check inventory directories]
2026-09-07 03:18:34.631973 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-09-07 03:18:34.813263 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-09-07 03:18:34.971488 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-09-07 03:18:34.983909 | 
2026-09-07 03:18:34.984135 | LOOP [Copy inventory file for Zuul]
2026-09-07 03:18:35.864284 | instance | changed:
2026-09-07 03:18:35.864624 | instance | {
2026-09-07 03:18:35.864720 | instance |   "ansible_loop_var": "item",
2026-09-07 03:18:35.864772 | instance |   "changed": false,
2026-09-07 03:18:35.864812 | instance |   "failed": false,
2026-09-07 03:18:35.864863 | instance |   "invocation": {
2026-09-07 03:18:35.864914 | instance |     "module_args": {
2026-09-07 03:18:35.864972 | instance |       "checksum_algorithm": "sha1",
2026-09-07 03:18:35.865025 | instance |       "follow": true,
2026-09-07 03:18:35.865084 | instance |       "get_attributes": true,
2026-09-07 03:18:35.865139 | instance |       "get_checksum": true,
2026-09-07 03:18:35.865175 | instance |       "get_mime": true,
2026-09-07 03:18:35.865445 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-09-07 03:18:35.865507 | instance |     }
2026-09-07 03:18:35.865561 | instance |   },
2026-09-07 03:18:35.865632 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-09-07 03:18:35.865712 | instance |   "stat": {
2026-09-07 03:18:35.865750 | instance |     "atime": 1788751095.1576946,
2026-09-07 03:18:35.865785 | instance |     "attr_flags": "e",
2026-09-07 03:18:35.865829 | instance |     "attributes": [
2026-09-07 03:18:35.865878 | instance |       "extents"
2026-09-07 03:18:35.865924 | instance |     ],
2026-09-07 03:18:35.865973 | instance |     "block_size": 4096,
2026-09-07 03:18:35.866023 | instance |     "blocks": 8,
2026-09-07 03:18:35.866072 | instance |     "charset": "unknown",
2026-09-07 03:18:35.866120 | instance |     "ctime": 1788751093.8256218,
2026-09-07 03:18:35.866170 | instance |     "dev": 64513,
2026-09-07 03:18:35.866219 | instance |     "device_type": 0,
2026-09-07 03:18:35.866267 | instance |     "executable": true,
2026-09-07 03:18:35.866317 | instance |     "exists": true,
2026-09-07 03:18:35.866355 | instance |     "gid": 1000,
2026-09-07 03:18:35.866399 | instance |     "gr_name": "zuul",
2026-09-07 03:18:35.866487 | instance |     "inode": 1047199,
2026-09-07 03:18:35.866545 | instance |     "isblk": false,
2026-09-07 03:18:35.866595 | instance |     "ischr": false,
2026-09-07 03:18:35.866667 | instance |     "isdir": true,
2026-09-07 03:18:35.866721 | instance |     "isfifo": false,
2026-09-07 03:18:35.866767 | instance |     "isgid": false,
2026-09-07 03:18:35.866812 | instance |     "islnk": false,
2026-09-07 03:18:35.866861 | instance |     "isreg": false,
2026-09-07 03:18:35.866907 | instance |     "issock": false,
2026-09-07 03:18:35.866952 | instance |     "isuid": false,
2026-09-07 03:18:35.866999 | instance |     "mimetype": "unknown",
2026-09-07 03:18:35.867047 | instance |     "mode": "0755",
2026-09-07 03:18:35.867098 | instance |     "mtime": 1788751093.8256218,
2026-09-07 03:18:35.867133 | instance |     "nlink": 23,
2026-09-07 03:18:35.867168 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-09-07 03:18:35.867201 | instance |     "pw_name": "zuul",
2026-09-07 03:18:35.867243 | instance |     "readable": true,
2026-09-07 03:18:35.867277 | instance |     "rgrp": true,
2026-09-07 03:18:35.867312 | instance |     "roth": true,
2026-09-07 03:18:35.867365 | instance |     "rusr": true,
2026-09-07 03:18:35.867400 | instance |     "size": 4096,
2026-09-07 03:18:35.867436 | instance |     "uid": 1000,
2026-09-07 03:18:35.867469 | instance |     "version": "3638644858",
2026-09-07 03:18:35.867501 | instance |     "wgrp": false,
2026-09-07 03:18:35.867538 | instance |     "woth": false,
2026-09-07 03:18:35.867573 | instance |     "writeable": true,
2026-09-07 03:18:35.867607 | instance |     "wusr": true,
2026-09-07 03:18:35.867641 | instance |     "xgrp": true,
2026-09-07 03:18:35.867708 | instance |     "xoth": true,
2026-09-07 03:18:35.867743 | instance |     "xusr": true
2026-09-07 03:18:35.867776 | instance |   }
2026-09-07 03:18:35.867812 | instance | }
2026-09-07 03:18:35.867884 | instance | ok: All items complete
2026-09-07 03:18:35.867926 | 
2026-09-07 03:18:35.870510 | instance | skipping: Conditional result was False
2026-09-07 03:18:35.876176 | instance | skipping: Conditional result was False
2026-09-07 03:18:35.899870 | 
2026-09-07 03:18:35.900148 | LOOP [Switch "ansible_host" to private IP]
2026-09-07 03:18:36.254663 | instance | changed: 1 replacements made
2026-09-07 03:18:36.262798 | instance | skipping: Conditional result was False
2026-09-07 03:18:36.267563 | instance | skipping: Conditional result was False
2026-09-07 03:18:36.287711 | 
2026-09-07 03:18:36.287928 | TASK [Run Molecule scenario]
2026-09-07 03:18:37.247937 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-09-07 03:18:37.683665 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-09-07 03:18:37.683778 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-09-07 03:18:49.224801 | instance | INFO     [csi > dependency] Executing
2026-09-07 03:18:49.225286 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-09-07 03:18:49.225704 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-09-07 03:18:49.225991 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-09-07 03:18:49.239803 | instance | INFO     [csi > cleanup] Executing
2026-09-07 03:18:49.240043 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-09-07 03:18:49.247466 | instance | INFO     [csi > destroy] Executing
2026-09-07 03:18:49.247633 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-09-07 03:18:49.247662 | instance | INFO     [csi > destroy] Executed: Successful
2026-09-07 03:18:49.257311 | instance | INFO     [csi > syntax] Executing
2026-09-07 03:18:50.865636 | instance |
2026-09-07 03:18:50.866323 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-09-07 03:18:50.932611 | instance | INFO     [csi > syntax] Executed: Successful
2026-09-07 03:18:50.951413 | instance | INFO     [csi > create] Executing
2026-09-07 03:18:50.955050 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-09-07 03:18:50.971999 | instance | INFO     [csi > prepare] Executing
2026-09-07 03:18:51.865605 | instance |
2026-09-07 03:18:51.865804 | instance | PLAY [Prepare] *****************************************************************
2026-09-07 03:18:51.866039 | instance |
2026-09-07 03:18:51.866303 | instance | TASK [Gathering Facts] *********************************************************
2026-09-07 03:18:51.866674 | instance | Monday 07 September 2026  03:18:51 +0000 (0:00:00.027)       0:00:00.027 ******
2026-09-07 03:18:53.106087 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-09-07 03:18:53.106168 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-09-07 03:18:53.106342 | instance | interpreter could change the meaning of that path. See
2026-09-07 03:18:53.106488 | instance | https://docs.ansible.com/ansible-
2026-09-07 03:18:53.106683 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-09-07 03:18:53.114069 | instance | ok: [instance]
2026-09-07 03:18:53.114188 | instance |
2026-09-07 03:18:53.114361 | instance | TASK [Configure short hostname] ************************************************
2026-09-07 03:18:53.114542 | instance | Monday 07 September 2026  03:18:53 +0000 (0:00:01.249)       0:00:01.277 ******
2026-09-07 03:18:53.919340 | instance | changed: [instance]
2026-09-07 03:18:53.919527 | instance |
2026-09-07 03:18:53.919806 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-09-07 03:18:53.920051 | instance | Monday 07 September 2026  03:18:53 +0000 (0:00:00.804)       0:00:02.082 ******
2026-09-07 03:18:54.179138 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-09-07 03:18:54.179987 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-09-07 03:18:54.180067 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-09-07 03:18:54.188958 | instance | changed: [instance]
2026-09-07 03:18:54.189379 | instance |
2026-09-07 03:18:54.189986 | instance | TASK [Purge "snapd" package] ***************************************************
2026-09-07 03:18:54.190373 | instance | Monday 07 September 2026  03:18:54 +0000 (0:00:00.269)       0:00:02.352 ******
2026-09-07 03:18:54.959117 | instance | ok: [instance]
2026-09-07 03:18:54.959454 | instance |
2026-09-07 03:18:54.959685 | instance | PLAY [Create devices for Ceph] *************************************************
2026-09-07 03:18:54.959876 | instance |
2026-09-07 03:18:54.960076 | instance | TASK [Gathering Facts] *********************************************************
2026-09-07 03:18:54.960295 | instance | Monday 07 September 2026  03:18:54 +0000 (0:00:00.769)       0:00:03.122 ******
2026-09-07 03:18:55.700267 | instance | ok: [instance]
2026-09-07 03:18:55.700635 | instance |
2026-09-07 03:18:55.700929 | instance | TASK [Install depedencies] *****************************************************
2026-09-07 03:18:55.701246 | instance | Monday 07 September 2026  03:18:55 +0000 (0:00:00.741)       0:00:03.863 ******
2026-09-07 03:19:18.975501 | instance | changed: [instance]
2026-09-07 03:19:18.975663 | instance |
2026-09-07 03:19:18.976197 | instance | TASK [Start up service] ********************************************************
2026-09-07 03:19:18.976257 | instance | Monday 07 September 2026  03:19:18 +0000 (0:00:23.274)       0:00:27.138 ******
2026-09-07 03:19:19.513129 | instance | ok: [instance]
2026-09-07 03:19:19.513183 | instance |
2026-09-07 03:19:19.513740 | instance | TASK [Generate lvm.conf] *******************************************************
2026-09-07 03:19:19.513822 | instance | Monday 07 September 2026  03:19:19 +0000 (0:00:00.537)       0:00:27.675 ******
2026-09-07 03:19:19.801162 | instance | ok: [instance]
2026-09-07 03:19:19.802228 | instance |
2026-09-07 03:19:19.802289 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-09-07 03:19:19.802301 | instance | Monday 07 September 2026  03:19:19 +0000 (0:00:00.287)       0:00:27.963 ******
2026-09-07 03:19:20.511885 | instance | changed: [instance]
2026-09-07 03:19:20.512140 | instance |
2026-09-07 03:19:20.512527 | instance | TASK [Get list of all loopback devices] ****************************************
2026-09-07 03:19:20.512884 | instance | Monday 07 September 2026  03:19:20 +0000 (0:00:00.710)       0:00:28.674 ******
2026-09-07 03:19:20.732211 | instance | ok: [instance]
2026-09-07 03:19:20.732305 | instance |
2026-09-07 03:19:20.732494 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-09-07 03:19:20.732785 | instance | Monday 07 September 2026  03:19:20 +0000 (0:00:00.220)       0:00:28.895 ******
2026-09-07 03:19:20.766123 | instance | skipping: [instance]
2026-09-07 03:19:20.766392 | instance |
2026-09-07 03:19:20.766920 | instance | TASK [Create devices for Ceph] *************************************************
2026-09-07 03:19:20.767343 | instance | Monday 07 September 2026  03:19:20 +0000 (0:00:00.032)       0:00:28.928 ******
2026-09-07 03:19:21.410067 | instance | changed: [instance] => (item=osd0)
2026-09-07 03:19:21.410413 | instance | changed: [instance] => (item=osd1)
2026-09-07 03:19:21.410866 | instance | changed: [instance] => (item=osd2)
2026-09-07 03:19:21.411249 | instance |
2026-09-07 03:19:21.411599 | instance | TASK [Set permissions on loopback devices] *************************************
2026-09-07 03:19:21.411942 | instance | Monday 07 September 2026  03:19:21 +0000 (0:00:00.642)       0:00:29.570 ******
2026-09-07 03:19:22.121887 | instance | changed: [instance] => (item=osd0)
2026-09-07 03:19:22.122149 | instance | changed: [instance] => (item=osd1)
2026-09-07 03:19:22.122623 | instance | changed: [instance] => (item=osd2)
2026-09-07 03:19:22.122953 | instance |
2026-09-07 03:19:22.123290 | instance | TASK [Start loop devices] ******************************************************
2026-09-07 03:19:22.123650 | instance | Monday 07 September 2026  03:19:22 +0000 (0:00:00.711)       0:00:30.282 ******
2026-09-07 03:19:22.964260 | instance | changed: [instance] => (item=osd0)
2026-09-07 03:19:22.964903 | instance | changed: [instance] => (item=osd1)
2026-09-07 03:19:22.965251 | instance | changed: [instance] => (item=osd2)
2026-09-07 03:19:22.965550 | instance |
2026-09-07 03:19:22.965966 | instance | TASK [Create a volume group for each loop device] ******************************
2026-09-07 03:19:22.966291 | instance | Monday 07 September 2026  03:19:22 +0000 (0:00:00.842)       0:00:31.125 ******
2026-09-07 03:19:26.412231 | instance | changed: [instance] => (item=osd0)
2026-09-07 03:19:26.412300 | instance | changed: [instance] => (item=osd1)
2026-09-07 03:19:26.412311 | instance | changed: [instance] => (item=osd2)
2026-09-07 03:19:26.412321 | instance |
2026-09-07 03:19:26.412331 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-09-07 03:19:26.412341 | instance | Monday 07 September 2026  03:19:26 +0000 (0:00:03.448)       0:00:34.573 ******
2026-09-07 03:19:28.477169 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-09-07 03:19:28.477279 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-09-07 03:19:28.477326 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-09-07 03:19:28.477341 | instance |
2026-09-07 03:19:28.477355 | instance | PLAY RECAP *********************************************************************
2026-09-07 03:19:28.477381 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-09-07 03:19:28.477607 | instance |
2026-09-07 03:19:28.477883 | instance | Monday 07 September 2026  03:19:28 +0000 (0:00:02.066)       0:00:36.639 ******
2026-09-07 03:19:28.478111 | instance | ===============================================================================
2026-09-07 03:19:28.478336 | instance | Install depedencies ---------------------------------------------------- 23.27s
2026-09-07 03:19:28.478568 | instance | Create a volume group for each loop device ------------------------------ 3.45s
2026-09-07 03:19:28.478831 | instance | Create a logical volume for each loop device ---------------------------- 2.07s
2026-09-07 03:19:28.479056 | instance | Gathering Facts --------------------------------------------------------- 1.25s
2026-09-07 03:19:28.479291 | instance | Start loop devices ------------------------------------------------------ 0.84s
2026-09-07 03:19:28.479528 | instance | Configure short hostname ------------------------------------------------ 0.80s
2026-09-07 03:19:28.479755 | instance | Purge "snapd" package --------------------------------------------------- 0.77s
2026-09-07 03:19:28.479994 | instance | Gathering Facts --------------------------------------------------------- 0.74s
2026-09-07 03:19:28.480225 | instance | Set permissions on loopback devices ------------------------------------- 0.71s
2026-09-07 03:19:28.480455 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.71s
2026-09-07 03:19:28.480713 | instance | Create devices for Ceph ------------------------------------------------- 0.64s
2026-09-07 03:19:28.480955 | instance | Start up service -------------------------------------------------------- 0.54s
2026-09-07 03:19:28.481318 | instance | Generate lvm.conf ------------------------------------------------------- 0.29s
2026-09-07 03:19:28.481571 | instance | Ensure hostname inside hosts file --------------------------------------- 0.27s
2026-09-07 03:19:28.481823 | instance | Get list of all loopback devices ---------------------------------------- 0.22s
2026-09-07 03:19:28.482061 | instance | Fail if there is any existing loopback devices -------------------------- 0.03s
2026-09-07 03:19:28.594306 | instance | INFO     [csi > prepare] Executed: Successful
2026-09-07 03:19:28.615849 | instance | INFO     [csi > converge] Executing
2026-09-07 03:19:30.140699 | instance |
2026-09-07 03:19:30.140848 | instance | PLAY [Debug CSI driver value] **************************************************
2026-09-07 03:19:30.141114 | instance |
2026-09-07 03:19:30.141359 | instance | TASK [Gathering Facts] *********************************************************
2026-09-07 03:19:30.141632 | instance | Monday 07 September 2026  03:19:30 +0000 (0:00:00.008)       0:00:00.008 ******
2026-09-07 03:19:31.106716 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-09-07 03:19:31.106969 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-09-07 03:19:31.107254 | instance | interpreter could change the meaning of that path. See
2026-09-07 03:19:31.107510 | instance | https://docs.ansible.com/ansible-
2026-09-07 03:19:31.107793 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-09-07 03:19:31.114164 | instance | ok: [instance]
2026-09-07 03:19:31.114485 | instance |
2026-09-07 03:19:31.114799 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-09-07 03:19:31.115143 | instance | Monday 07 September 2026  03:19:31 +0000 (0:00:00.974)       0:00:00.983 ******
2026-09-07 03:19:31.170850 | instance | ok: [instance] => {
2026-09-07 03:19:31.170980 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-09-07 03:19:31.171283 | instance | }
2026-09-07 03:19:31.171605 | instance |
2026-09-07 03:19:31.171804 | instance | PLAY [all] *********************************************************************
2026-09-07 03:19:31.172022 | instance |
2026-09-07 03:19:31.172253 | instance | TASK [Gathering Facts] *********************************************************
2026-09-07 03:19:31.172483 | instance | Monday 07 September 2026  03:19:31 +0000 (0:00:00.055)       0:00:01.039 ******
2026-09-07 03:19:32.154830 | instance | ok: [instance]
2026-09-07 03:19:32.154958 | instance |
2026-09-07 03:19:32.155314 | instance | TASK [Fail if atmosphere_ceph_enabled is set] **********************************
2026-09-07 03:19:32.155629 | instance | Monday 07 September 2026  03:19:32 +0000 (0:00:00.983)       0:00:02.023 ******
2026-09-07 03:19:32.204111 | instance | skipping: [instance]
2026-09-07 03:19:32.204295 | instance |
2026-09-07 03:19:32.204547 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-09-07 03:19:32.204857 | instance | Monday 07 September 2026  03:19:32 +0000 (0:00:00.049)       0:00:02.072 ******
2026-09-07 03:19:32.427753 | instance | ok: [instance]
2026-09-07 03:19:32.427909 | instance |
2026-09-07 03:19:32.428204 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-09-07 03:19:32.428461 | instance |
2026-09-07 03:19:32.428791 | instance | TASK [Gathering Facts] *********************************************************
2026-09-07 03:19:32.429239 | instance | Monday 07 September 2026  03:19:32 +0000 (0:00:00.223)       0:00:02.296 ******
2026-09-07 03:19:33.340542 | instance | ok: [instance]
2026-09-07 03:19:33.340833 | instance |
2026-09-07 03:19:33.342233 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-07 03:19:33.342249 | instance | Monday 07 September 2026  03:19:33 +0000 (0:00:00.911)       0:00:03.208 ******
2026-09-07 03:19:33.738351 | instance | ok: [instance]
2026-09-07 03:19:33.738406 | instance |
2026-09-07 03:19:33.738414 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-07 03:19:33.738421 | instance | Monday 07 September 2026  03:19:33 +0000 (0:00:00.398)       0:00:03.606 ******
2026-09-07 03:19:33.785717 | instance | skipping: [instance]
2026-09-07 03:19:33.785773 | instance |
2026-09-07 03:19:33.785779 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-09-07 03:19:33.785785 | instance | Monday 07 September 2026  03:19:33 +0000 (0:00:00.047)       0:00:03.654 ******
2026-09-07 03:19:34.179289 | instance | changed: [instance]
2026-09-07 03:19:34.179353 | instance |
2026-09-07 03:19:34.179360 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-07 03:19:34.179368 | instance | Monday 07 September 2026  03:19:34 +0000 (0:00:00.392)       0:00:04.046 ******
2026-09-07 03:19:34.276964 | instance | ok: [instance] => {
2026-09-07 03:19:34.277053 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-09-07 03:19:34.277061 | instance | }
2026-09-07 03:19:34.277065 | instance |
2026-09-07 03:19:34.277070 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-07 03:19:34.277074 | instance | Monday 07 September 2026  03:19:34 +0000 (0:00:00.097)       0:00:04.144 ******
2026-09-07 03:19:35.130100 | instance | changed: [instance]
2026-09-07 03:19:35.130189 | instance |
2026-09-07 03:19:35.130217 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-07 03:19:35.130554 | instance | Monday 07 September 2026  03:19:35 +0000 (0:00:00.853)       0:00:04.997 ******
2026-09-07 03:19:35.200224 | instance | skipping: [instance]
2026-09-07 03:19:35.200301 | instance |
2026-09-07 03:19:35.200714 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-07 03:19:35.200778 | instance | Monday 07 September 2026  03:19:35 +0000 (0:00:00.070)       0:00:05.068 ******
2026-09-07 03:19:35.257690 | instance | skipping: [instance]
2026-09-07 03:19:35.257758 | instance |
2026-09-07 03:19:35.257764 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-07 03:19:35.257770 | instance | Monday 07 September 2026  03:19:35 +0000 (0:00:00.057)       0:00:05.125 ******
2026-09-07 03:19:35.517969 | instance | ok: [instance]
2026-09-07 03:19:35.518061 | instance |
2026-09-07 03:19:35.518154 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-07 03:19:35.518396 | instance | Monday 07 September 2026  03:19:35 +0000 (0:00:00.260)       0:00:05.386 ******
2026-09-07 03:19:37.174488 | instance | ok: [instance]
2026-09-07 03:19:37.174582 | instance |
2026-09-07 03:19:37.174779 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-07 03:19:37.175050 | instance | Monday 07 September 2026  03:19:37 +0000 (0:00:01.656)       0:00:07.043 ******
2026-09-07 03:19:37.246154 | instance | ok: [instance] => {
2026-09-07 03:19:37.246247 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-09-07 03:19:37.246257 | instance | }
2026-09-07 03:19:37.246541 | instance |
2026-09-07 03:19:37.246745 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-07 03:19:37.246893 | instance | Monday 07 September 2026  03:19:37 +0000 (0:00:00.071)       0:00:07.115 ******
2026-09-07 03:19:38.058990 | instance | changed: [instance]
2026-09-07 03:19:38.059176 | instance |
2026-09-07 03:19:38.059540 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-07 03:19:38.059885 | instance | Monday 07 September 2026  03:19:38 +0000 (0:00:00.812)       0:00:07.927 ******
2026-09-07 03:19:41.045795 | instance | changed: [instance]
2026-09-07 03:19:41.046040 | instance |
2026-09-07 03:19:41.046410 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-09-07 03:19:41.046738 | instance | Monday 07 September 2026  03:19:41 +0000 (0:00:02.984)       0:00:10.912 ******
2026-09-07 03:19:41.081685 | instance | skipping: [instance]
2026-09-07 03:19:41.081842 | instance |
2026-09-07 03:19:41.082323 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-09-07 03:19:41.082542 | instance | Monday 07 September 2026  03:19:41 +0000 (0:00:00.034)       0:00:10.947 ******
2026-09-07 03:19:41.113957 | instance | skipping: [instance]
2026-09-07 03:19:41.114312 | instance |
2026-09-07 03:19:41.114628 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-09-07 03:19:41.114920 | instance | Monday 07 September 2026  03:19:41 +0000 (0:00:00.034)       0:00:10.981 ******
2026-09-07 03:19:41.157868 | instance | skipping: [instance]
2026-09-07 03:19:41.157968 | instance |
2026-09-07 03:19:41.158145 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-09-07 03:19:41.158430 | instance | Monday 07 September 2026  03:19:41 +0000 (0:00:00.043)       0:00:11.025 ******
2026-09-07 03:19:48.383173 | instance | changed: [instance]
2026-09-07 03:19:48.383934 | instance |
2026-09-07 03:19:48.383987 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-09-07 03:19:48.383999 | instance | Monday 07 September 2026  03:19:48 +0000 (0:00:07.225)       0:00:18.251 ******
2026-09-07 03:19:49.097184 | instance | changed: [instance]
2026-09-07 03:19:49.097289 | instance |
2026-09-07 03:19:49.097317 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-09-07 03:19:49.097547 | instance | Monday 07 September 2026  03:19:49 +0000 (0:00:00.713)       0:00:18.964 ******
2026-09-07 03:19:50.173710 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-09-07 03:19:50.175707 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-09-07 03:19:50.175788 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-09-07 03:19:50.175812 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-09-07 03:19:50.175823 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-09-07 03:19:50.175833 | instance |
2026-09-07 03:19:50.175844 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-09-07 03:19:50.175853 | instance | Monday 07 September 2026  03:19:50 +0000 (0:00:01.077)       0:00:20.041 ******
2026-09-07 03:19:50.836359 | instance | changed: [instance]
2026-09-07 03:19:50.836609 | instance |
2026-09-07 03:19:50.837174 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-09-07 03:19:50.837265 | instance | Monday 07 September 2026  03:19:50 +0000 (0:00:00.634)       0:00:20.675 ******
2026-09-07 03:19:50.837275 | instance |
2026-09-07 03:19:50.837292 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-09-07 03:19:50.837432 | instance | Monday 07 September 2026  03:19:50 +0000 (0:00:00.028)       0:00:20.704 ******
2026-09-07 03:19:51.986924 | instance | ok: [instance]
2026-09-07 03:19:51.987071 | instance |
2026-09-07 03:19:51.987700 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-09-07 03:19:51.987773 | instance | Monday 07 September 2026  03:19:51 +0000 (0:00:01.150)       0:00:21.855 ******
2026-09-07 03:19:52.541056 | instance | changed: [instance]
2026-09-07 03:19:52.541888 | instance |
2026-09-07 03:19:52.542176 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-09-07 03:19:52.542194 | instance | Monday 07 September 2026  03:19:52 +0000 (0:00:00.554)       0:00:22.409 ******
2026-09-07 03:19:53.084677 | instance | changed: [instance]
2026-09-07 03:19:53.085098 | instance |
2026-09-07 03:19:53.085322 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-07 03:19:53.085616 | instance | Monday 07 September 2026  03:19:53 +0000 (0:00:00.543)       0:00:22.953 ******
2026-09-07 03:19:53.362626 | instance | ok: [instance]
2026-09-07 03:19:53.362702 | instance |
2026-09-07 03:19:53.362933 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-07 03:19:53.363096 | instance | Monday 07 September 2026  03:19:53 +0000 (0:00:00.277)       0:00:23.231 ******
2026-09-07 03:19:53.426469 | instance | ok: [instance] => {
2026-09-07 03:19:53.426705 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-09-07 03:19:53.426944 | instance | }
2026-09-07 03:19:53.427164 | instance |
2026-09-07 03:19:53.427406 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-07 03:19:53.427683 | instance | Monday 07 September 2026  03:19:53 +0000 (0:00:00.063)       0:00:23.294 ******
2026-09-07 03:19:54.397128 | instance | changed: [instance]
2026-09-07 03:19:54.397195 | instance |
2026-09-07 03:19:54.397368 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-07 03:19:54.397488 | instance | Monday 07 September 2026  03:19:54 +0000 (0:00:00.970)       0:00:24.265 ******
2026-09-07 03:19:58.852805 | instance | changed: [instance]
2026-09-07 03:19:58.852927 | instance |
2026-09-07 03:19:58.853176 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-09-07 03:19:58.853262 | instance | Monday 07 September 2026  03:19:58 +0000 (0:00:04.454)       0:00:28.720 ******
2026-09-07 03:20:00.271332 | instance | ok: [instance]
2026-09-07 03:20:00.271424 | instance |
2026-09-07 03:20:00.271738 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-09-07 03:20:00.271809 | instance | Monday 07 September 2026  03:20:00 +0000 (0:00:01.419)       0:00:30.140 ******
2026-09-07 03:20:00.720279 | instance | changed: [instance]
2026-09-07 03:20:00.721153 | instance |
2026-09-07 03:20:00.721232 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-09-07 03:20:00.721245 | instance | Monday 07 September 2026  03:20:00 +0000 (0:00:00.448)       0:00:30.588 ******
2026-09-07 03:20:01.296510 | instance | changed: [instance]
2026-09-07 03:20:01.296673 | instance |
2026-09-07 03:20:01.297196 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-09-07 03:20:01.297296 | instance | Monday 07 September 2026  03:20:01 +0000 (0:00:00.576)       0:00:31.164 ******
2026-09-07 03:20:01.949554 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-09-07 03:20:01.949677 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-09-07 03:20:01.950346 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-09-07 03:20:01.950411 | instance |
2026-09-07 03:20:01.950419 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-09-07 03:20:01.950425 | instance | Monday 07 September 2026  03:20:01 +0000 (0:00:00.653)       0:00:31.818 ******
2026-09-07 03:20:02.430476 | instance | changed: [instance]
2026-09-07 03:20:02.431338 | instance |
2026-09-07 03:20:02.431415 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-09-07 03:20:02.431427 | instance | Monday 07 September 2026  03:20:02 +0000 (0:00:00.480)       0:00:32.298 ******
2026-09-07 03:20:02.974200 | instance | changed: [instance]
2026-09-07 03:20:02.974248 | instance |
2026-09-07 03:20:02.974255 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-09-07 03:20:02.974275 | instance | Monday 07 September 2026  03:20:02 +0000 (0:00:00.514)       0:00:32.813 ******
2026-09-07 03:20:02.974280 | instance |
2026-09-07 03:20:02.974286 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-09-07 03:20:02.974298 | instance | Monday 07 September 2026  03:20:02 +0000 (0:00:00.028)       0:00:32.842 ******
2026-09-07 03:20:03.724863 | instance | ok: [instance]
2026-09-07 03:20:03.724950 | instance |
2026-09-07 03:20:03.724962 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-09-07 03:20:03.724975 | instance | Monday 07 September 2026  03:20:03 +0000 (0:00:00.750)       0:00:33.592 ******
2026-09-07 03:20:04.766171 | instance | changed: [instance]
2026-09-07 03:20:04.766263 | instance |
2026-09-07 03:20:04.766276 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-09-07 03:20:04.766287 | instance | Monday 07 September 2026  03:20:04 +0000 (0:00:01.040)       0:00:34.633 ******
2026-09-07 03:20:05.312152 | instance | changed: [instance]
2026-09-07 03:20:05.312542 | instance |
2026-09-07 03:20:05.312594 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-09-07 03:20:05.312602 | instance | Monday 07 September 2026  03:20:05 +0000 (0:00:00.548)       0:00:35.181 ******
2026-09-07 03:20:05.380173 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-09-07 03:20:05.380261 | instance |
2026-09-07 03:20:05.380271 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-09-07 03:20:05.380435 | instance | Monday 07 September 2026  03:20:05 +0000 (0:00:00.067)       0:00:35.249 ******
2026-09-07 03:20:11.579831 | instance | changed: [instance]
2026-09-07 03:20:11.580598 | instance |
2026-09-07 03:20:11.580894 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-09-07 03:20:11.580907 | instance | Monday 07 September 2026  03:20:11 +0000 (0:00:06.198)       0:00:41.447 ******
2026-09-07 03:20:12.256686 | instance | ok: [instance] => (item=chronyd)
2026-09-07 03:20:12.256787 | instance | ok: [instance] => (item=sshd)
2026-09-07 03:20:12.257101 | instance |
2026-09-07 03:20:12.257426 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-09-07 03:20:12.257445 | instance | Monday 07 September 2026  03:20:12 +0000 (0:00:00.677)       0:00:42.125 ******
2026-09-07 03:20:18.468483 | instance | changed: [instance]
2026-09-07 03:20:18.469167 | instance |
2026-09-07 03:20:18.469262 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-09-07 03:20:18.469281 | instance | Monday 07 September 2026  03:20:18 +0000 (0:00:06.211)       0:00:48.336 ******
2026-09-07 03:20:18.706282 | instance | ok: [instance]
2026-09-07 03:20:18.706396 | instance |
2026-09-07 03:20:18.706411 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-09-07 03:20:18.706589 | instance | Monday 07 September 2026  03:20:18 +0000 (0:00:00.238)       0:00:48.575 ******
2026-09-07 03:20:19.258739 | instance | changed: [instance]
2026-09-07 03:20:19.259614 | instance |
2026-09-07 03:20:19.259700 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-09-07 03:20:19.259716 | instance | Monday 07 September 2026  03:20:19 +0000 (0:00:00.551)       0:00:49.126 ******
2026-09-07 03:20:19.653975 | instance | changed: [instance]
2026-09-07 03:20:19.654399 | instance |
2026-09-07 03:20:19.654419 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-09-07 03:20:19.654425 | instance | Monday 07 September 2026  03:20:19 +0000 (0:00:00.395)       0:00:49.522 ******
2026-09-07 03:20:19.881223 | instance | ok: [instance]
2026-09-07 03:20:19.881332 | instance |
2026-09-07 03:20:19.881655 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-09-07 03:20:19.881726 | instance | Monday 07 September 2026  03:20:19 +0000 (0:00:00.227)       0:00:49.750 ******
2026-09-07 03:20:20.124388 | instance | ok: [instance] => (item=instance)
2026-09-07 03:20:20.124492 | instance |
2026-09-07 03:20:20.124858 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-09-07 03:20:20.124932 | instance | Monday 07 September 2026  03:20:20 +0000 (0:00:00.242)       0:00:49.992 ******
2026-09-07 03:20:20.177195 | instance | ok: [instance]
2026-09-07 03:20:20.177291 | instance |
2026-09-07 03:20:20.177721 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-09-07 03:20:20.177788 | instance | Monday 07 September 2026  03:20:20 +0000 (0:00:00.052)       0:00:50.045 ******
2026-09-07 03:20:20.256940 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-09-07 03:20:20.257088 | instance |
2026-09-07 03:20:20.257104 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-09-07 03:20:20.257203 | instance | Monday 07 September 2026  03:20:20 +0000 (0:00:00.080)       0:00:50.125 ******
2026-09-07 03:20:20.584540 | instance | changed: [instance]
2026-09-07 03:20:20.584630 | instance |
2026-09-07 03:20:20.584853 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-09-07 03:20:20.584916 | instance | Monday 07 September 2026  03:20:20 +0000 (0:00:00.327)       0:00:50.453 ******
2026-09-07 03:20:21.355154 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-09-07 03:20:21.355234 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-09-07 03:20:21.355247 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-09-07 03:20:21.355258 | instance |
2026-09-07 03:20:21.355269 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-09-07 03:20:21.355281 | instance | Monday 07 September 2026  03:20:21 +0000 (0:00:00.768)       0:00:51.221 ******
2026-09-07 03:21:47.384810 | instance | ok: [instance]
2026-09-07 03:21:47.384884 | instance |
2026-09-07 03:21:47.385155 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-09-07 03:21:47.385217 | instance | Monday 07 September 2026  03:21:47 +0000 (0:01:26.032)       0:02:17.253 ******
2026-09-07 03:21:47.634066 | instance | changed: [instance]
2026-09-07 03:21:47.634139 | instance |
2026-09-07 03:21:47.634307 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-09-07 03:21:47.634464 | instance | Monday 07 September 2026  03:21:47 +0000 (0:00:00.249)       0:02:17.502 ******
2026-09-07 03:21:47.681803 | instance | ok: [instance]
2026-09-07 03:21:47.681942 | instance |
2026-09-07 03:21:47.682141 | instance | TASK [Install Ceph host] *******************************************************
2026-09-07 03:21:47.682303 | instance | Monday 07 September 2026  03:21:47 +0000 (0:00:00.047)       0:02:17.550 ******
2026-09-07 03:21:47.774479 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-09-07 03:21:47.774911 | instance |
2026-09-07 03:21:47.774929 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-09-07 03:21:47.774936 | instance | Monday 07 September 2026  03:21:47 +0000 (0:00:00.093)       0:02:17.643 ******
2026-09-07 03:21:49.513973 | instance | ok: [instance]
2026-09-07 03:21:49.514054 | instance |
2026-09-07 03:21:49.514258 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-09-07 03:21:49.514437 | instance | Monday 07 September 2026  03:21:49 +0000 (0:00:01.738)       0:02:19.382 ******
2026-09-07 03:21:49.583832 | instance | ok: [instance] => (item=instance)
2026-09-07 03:21:49.583935 | instance |
2026-09-07 03:21:49.584130 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-09-07 03:21:49.584293 | instance | Monday 07 September 2026  03:21:49 +0000 (0:00:00.070)       0:02:19.452 ******
2026-09-07 03:21:49.985411 | instance | ok: [instance]
2026-09-07 03:21:49.985490 | instance |
2026-09-07 03:21:49.985792 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-09-07 03:21:49.985860 | instance | Monday 07 September 2026  03:21:49 +0000 (0:00:00.401)       0:02:19.854 ******
2026-09-07 03:21:52.575966 | instance | ok: [instance]
2026-09-07 03:21:52.576037 | instance |
2026-09-07 03:21:52.576242 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-09-07 03:21:52.576258 | instance | Monday 07 September 2026  03:21:52 +0000 (0:00:02.590)       0:02:22.445 ******
2026-09-07 03:22:35.142819 | 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-09-07 03:22:35.142956 | 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_ji_e7whw/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_ji_e7whw/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_ji_e7whw/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_ji_e7whw/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-09-07T03:22:34.920+0000 7f4b5b77b640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCgLZ5q9aGYHiAAmz2eXCZPzyi73MiV7ggswWC8ylwzbj2xxagDVvnBdPU=: Malformed input [buffer:3]\n2026-09-07T03:22:34.920+0000 7f4b5b77b640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-07T03:22:34.924+0000 7f4b5b77b640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCgLZ5q9aGYHiAAmz2eXCZPzyi73MiV7ggswWC8ylwzbj2xxagDVvnBdPU=: Malformed input [buffer:3]\n2026-09-07T03:22:34.924+0000 7f4b5b77b640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-07T03:22:34.924+0000 7f4b5b77b640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCgLZ5q9aGYHiAAmz2eXCZPzyi73MiV7ggswWC8ylwzbj2xxagDVvnBdPU=: Malformed input [buffer:3]\n2026-09-07T03:22:34.924+0000 7f4b5b77b640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-07T03:22:34.924+0000 7f4b5b77b640 -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-09-07 03:22:35.145703 | instance |
2026-09-07 03:22:35.146054 | instance | PLAY RECAP *********************************************************************
2026-09-07 03:22:35.146459 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=7    rescued=0    ignored=0
2026-09-07 03:22:35.146769 | instance |
2026-09-07 03:22:35.147086 | instance | Monday 07 September 2026  03:22:35 +0000 (0:00:42.569)       0:03:05.014 ******
2026-09-07 03:22:35.147378 | instance | ===============================================================================
2026-09-07 03:22:35.147704 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 86.03s
2026-09-07 03:22:35.148063 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 42.57s
2026-09-07 03:22:35.148368 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 7.23s
2026-09-07 03:22:35.148683 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 6.21s
2026-09-07 03:22:35.149072 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 6.20s
2026-09-07 03:22:35.149380 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.45s
2026-09-07 03:22:35.149844 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.98s
2026-09-07 03:22:35.150200 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.59s
2026-09-07 03:22:35.150495 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.90s
2026-09-07 03:22:35.150813 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.74s
2026-09-07 03:22:35.151261 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.66s
2026-09-07 03:22:35.151580 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.42s
2026-09-07 03:22:35.151905 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 1.08s
2026-09-07 03:22:35.152298 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 1.04s
2026-09-07 03:22:35.152635 | instance | Gathering Facts --------------------------------------------------------- 0.98s
2026-09-07 03:22:35.153170 | instance | Gathering Facts --------------------------------------------------------- 0.97s
2026-09-07 03:22:35.153496 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.97s
2026-09-07 03:22:35.153815 | instance | Gathering Facts --------------------------------------------------------- 0.91s
2026-09-07 03:22:35.154112 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.85s
2026-09-07 03:22:35.154398 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.81s
2026-09-07 03:22:35.314540 | 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-09-07 03:22:35.314869 | instance | ERROR    [csi > converge] Executed: Failed
2026-09-07 03:22:35.315063 | 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-09-07 03:22:35.672091 | instance | ERROR
2026-09-07 03:22:35.672283 | instance | {
2026-09-07 03:22:35.672323 | instance |   "delta": "0:03:58.734797",
2026-09-07 03:22:35.672350 | instance |   "end": "2026-09-07 03:22:35.416386",
2026-09-07 03:22:35.672395 | instance |   "msg": "non-zero return code",
2026-09-07 03:22:35.672425 | instance |   "rc": 2,
2026-09-07 03:22:35.672451 | instance |   "start": "2026-09-07 03:18:36.681589"
2026-09-07 03:22:35.672478 | instance | }
failure
2026-09-07 03:22:35.680044 | 
2026-09-07 03:22:35.680134 | PLAY RECAP
2026-09-07 03:22:35.680215 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-09-07 03:22:35.680249 | 
2026-09-07 03:22:35.867480 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-07 03:22:35.871666 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-09-07 03:22:36.575868 | 
2026-09-07 03:22:36.576037 | PLAY [all]
2026-09-07 03:22:36.593064 | 
2026-09-07 03:22:36.593265 | TASK [gather-host-logs : creating directory for system status]
2026-09-07 03:22:36.985969 | instance | changed
2026-09-07 03:22:36.998111 | 
2026-09-07 03:22:36.998329 | TASK [gather-host-logs : Get logs for each host]
2026-09-07 03:22:37.407068 | instance | + systemd-cgls --full --all --no-pager
2026-09-07 03:22:37.424432 | instance | + ip addr
2026-09-07 03:22:37.427883 | instance | + ip route
2026-09-07 03:22:37.431182 | instance | + lsblk
2026-09-07 03:22:37.435961 | instance | + mount
2026-09-07 03:22:37.439398 | instance | + docker images
2026-09-07 03:22:37.465588 | instance | + brctl show
2026-09-07 03:22:37.466323 | instance | /bin/bash: line 8: brctl: command not found
2026-09-07 03:22:37.466676 | instance | + ps aux --sort=-%mem
2026-09-07 03:22:37.489571 | instance | + dpkg -l
2026-09-07 03:22:37.501816 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-09-07 03:22:37.502381 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-09-07 03:22:37.518260 | instance | + '[' '!' -z '' ']'
2026-09-07 03:22:37.562859 | instance | ok: Runtime: 0:00:00.116504
2026-09-07 03:22:37.574008 | 
2026-09-07 03:22:37.574259 | TASK [gather-host-logs : Downloads logs to executor]
2026-09-07 03:22:38.282978 | instance | changed:
2026-09-07 03:22:38.283206 | instance | created directory /var/lib/zuul/builds/d265e85873e6461ab2420c9801648720/work/logs/instance
2026-09-07 03:22:38.283244 | instance | cd+++++++++ system/
2026-09-07 03:22:38.283272 | instance | >f+++++++++ system/brctl-show.txt
2026-09-07 03:22:38.283298 | instance | >f+++++++++ system/docker-images.txt
2026-09-07 03:22:38.283323 | instance | >f+++++++++ system/ip-addr.txt
2026-09-07 03:22:38.283354 | instance | >f+++++++++ system/ip-route.txt
2026-09-07 03:22:38.283398 | instance | >f+++++++++ system/lsblk.txt
2026-09-07 03:22:38.283425 | instance | >f+++++++++ system/mount.txt
2026-09-07 03:22:38.283450 | instance | >f+++++++++ system/packages.txt
2026-09-07 03:22:38.283474 | instance | >f+++++++++ system/ps.txt
2026-09-07 03:22:38.283501 | instance | >f+++++++++ system/systemd-cgls.txt
2026-09-07 03:22:38.305434 | 
2026-09-07 03:22:38.305838 | LOOP [helm-release-status : creating directory for helm release status]
2026-09-07 03:22:38.519927 | instance | changed: "values"
2026-09-07 03:22:38.723990 | instance | changed: "releases"
2026-09-07 03:22:38.840228 | 
2026-09-07 03:22:38.840476 | TASK [helm-release-status : Gather get release status for helm charts]
2026-09-07 03:22:39.124782 | instance | /bin/bash: line 3: kubectl: command not found
2026-09-07 03:22:39.399016 | instance | ok: Runtime: 0:00:00.005083
2026-09-07 03:22:39.410599 | 
2026-09-07 03:22:39.410754 | TASK [helm-release-status : Downloads logs to executor]
2026-09-07 03:22:40.035169 | instance | changed:
2026-09-07 03:22:40.035412 | instance | cd+++++++++ helm/
2026-09-07 03:22:40.035477 | instance | cd+++++++++ helm/releases/
2026-09-07 03:22:40.035535 | instance | cd+++++++++ helm/values/
2026-09-07 03:22:40.047669 | 
2026-09-07 03:22:40.047777 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-09-07 03:22:40.286159 | instance | changed
2026-09-07 03:22:40.298390 | 
2026-09-07 03:22:40.298543 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-09-07 03:22:40.604397 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-07 03:22:40.604499 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-07 03:22:40.609876 | instance | environment: line 1: kubectl: command not found
2026-09-07 03:22:40.611257 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-07 03:22:40.612465 | instance | environment: line 1: kubectl: command not found
2026-09-07 03:22:40.614140 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-07 03:22:40.615515 | instance | environment: line 1: kubectl: command not found
2026-09-07 03:22:40.616902 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-07 03:22:40.618909 | instance | environment: line 1: kubectl: command not found
2026-09-07 03:22:40.620554 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-07 03:22:40.622419 | instance | environment: line 1: kubectl: command not found
2026-09-07 03:22:40.623598 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-07 03:22:40.896132 | instance | ok: Runtime: 0:00:00.027615
2026-09-07 03:22:40.906186 | 
2026-09-07 03:22:40.906346 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-09-07 03:22:41.141641 | instance | changed
2026-09-07 03:22:41.148778 | 
2026-09-07 03:22:41.148928 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-09-07 03:22:41.391804 | instance | environment: line 5: kubectl: command not found
2026-09-07 03:22:41.392705 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-07 03:22:41.393545 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-07 03:22:41.394258 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-07 03:22:41.688100 | instance | ok: Runtime: 0:00:00.011655
2026-09-07 03:22:41.698751 | 
2026-09-07 03:22:41.699998 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-09-07 03:22:42.226807 | instance | changed:
2026-09-07 03:22:42.227220 | instance | cd+++++++++ objects/
2026-09-07 03:22:42.227322 | instance | cd+++++++++ objects/cluster/
2026-09-07 03:22:42.227433 | instance | cd+++++++++ objects/namespaced/
2026-09-07 03:22:42.254178 | 
2026-09-07 03:22:42.254389 | TASK [gather-pod-logs : creating directory for pod logs]
2026-09-07 03:22:42.463397 | instance | changed
2026-09-07 03:22:42.476940 | 
2026-09-07 03:22:42.477080 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-09-07 03:22:42.700944 | instance | changed
2026-09-07 03:22:42.749662 | 
2026-09-07 03:22:42.749917 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-09-07 03:22:42.981446 | instance | environment: line 3: kubectl: command not found
2026-09-07 03:22:43.306722 | instance | ok: Runtime: 0:00:00.010890
2026-09-07 03:22:43.323447 | 
2026-09-07 03:22:43.323616 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-09-07 03:22:43.827989 | instance | changed:
2026-09-07 03:22:43.828312 | instance | cd+++++++++ pod-logs/
2026-09-07 03:22:43.828402 | instance | cd+++++++++ pod-logs/failed-pods/
2026-09-07 03:22:43.861718 | 
2026-09-07 03:22:43.861902 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-09-07 03:22:44.111166 | instance | changed
2026-09-07 03:22:44.121881 | 
2026-09-07 03:22:44.122147 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-09-07 03:22:44.375362 | instance | /bin/bash: line 2: kubectl: command not found
2026-09-07 03:22:44.671611 | instance | ok: Runtime: 0:00:00.048678
2026-09-07 03:22:44.683344 | 
2026-09-07 03:22:44.683551 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-09-07 03:22:44.950410 | instance | /bin/bash: line 2: kubectl: command not found
2026-09-07 03:22:44.993717 | instance | ceph-mgr endpoints:
2026-09-07 03:22:45.233759 | instance | ok: Runtime: 0:00:00.050149
2026-09-07 03:22:45.240709 | 
2026-09-07 03:22:45.240793 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-09-07 03:22:45.478925 | instance | /bin/bash: line 4: kubectl: command not found
2026-09-07 03:22:45.782026 | instance | ok: Runtime: 0:00:00.033019
2026-09-07 03:22:45.791603 | 
2026-09-07 03:22:45.791812 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-09-07 03:22:46.280885 | instance | changed: cd+++++++++ prometheus/
2026-09-07 03:22:46.292160 | 
2026-09-07 03:22:46.292278 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-09-07 03:22:46.539329 | instance | changed
2026-09-07 03:22:46.544434 | 
2026-09-07 03:22:46.544574 | TASK [gather-selenium-data : Get selenium data]
2026-09-07 03:22:46.812948 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-09-07 03:22:46.814612 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-09-07 03:22:47.082360 | instance | ERROR
2026-09-07 03:22:47.082660 | instance | {
2026-09-07 03:22:47.082722 | instance |   "delta": "0:00:00.007645",
2026-09-07 03:22:47.082762 | instance |   "end": "2026-09-07 03:22:46.815048",
2026-09-07 03:22:47.082805 | instance |   "msg": "non-zero return code",
2026-09-07 03:22:47.082846 | instance |   "rc": 1,
2026-09-07 03:22:47.082882 | instance |   "start": "2026-09-07 03:22:46.807403"
2026-09-07 03:22:47.082917 | instance | }
2026-09-07 03:22:47.082962 | instance | ERROR: Ignoring Errors
2026-09-07 03:22:47.093495 | 
2026-09-07 03:22:47.093646 | TASK [gather-selenium-data : Downloads logs to executor]
2026-09-07 03:22:47.675123 | instance | changed: cd+++++++++ selenium/
2026-09-07 03:22:47.687451 | 
2026-09-07 03:22:47.687570 | PLAY RECAP
2026-09-07 03:22:47.687664 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-09-07 03:22:47.687710 | 
2026-09-07 03:22:47.835286 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-09-07 03:22:47.839851 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-07 03:22:48.646250 | 
2026-09-07 03:22:48.646402 | PLAY [all]
2026-09-07 03:22:48.657992 | 
2026-09-07 03:22:48.658110 | TASK [fetch-output : Set log path for multiple nodes]
2026-09-07 03:22:48.712559 | instance | skipping: Conditional result was False
2026-09-07 03:22:48.720448 | 
2026-09-07 03:22:48.720586 | TASK [fetch-output : Set log path for single node]
2026-09-07 03:22:48.761446 | instance | ok
2026-09-07 03:22:48.769063 | 
2026-09-07 03:22:48.769163 | LOOP [fetch-output : Ensure local output dirs]
2026-09-07 03:22:49.196161 | instance -> localhost | ok: "/var/lib/zuul/builds/d265e85873e6461ab2420c9801648720/work/logs"
2026-09-07 03:22:49.458427 | instance -> localhost | changed: "/var/lib/zuul/builds/d265e85873e6461ab2420c9801648720/work/artifacts"
2026-09-07 03:22:49.668561 | instance -> localhost | changed: "/var/lib/zuul/builds/d265e85873e6461ab2420c9801648720/work/docs"
2026-09-07 03:22:49.690298 | 
2026-09-07 03:22:49.997870 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-09-07 03:22:50.757012 | instance | changed: .d..t...... ./
2026-09-07 03:22:50.757355 | instance | changed: All items complete
2026-09-07 03:22:50.757480 | 
2026-09-07 03:22:51.294397 | instance | changed: .d..t...... ./
2026-09-07 03:22:51.823012 | instance | changed: .d..t...... ./
2026-09-07 03:22:51.844637 | 
2026-09-07 03:22:51.844798 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-09-07 03:22:52.312436 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.011688
2026-09-07 03:22:52.598992 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.010480
2026-09-07 03:22:52.622016 | 
2026-09-07 03:22:52.622194 | PLAY [all]
2026-09-07 03:22:52.634941 | 
2026-09-07 03:22:52.635123 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-09-07 03:22:53.151721 | instance | changed
2026-09-07 03:22:53.220870 | 
2026-09-07 03:22:53.221021 | PLAY RECAP
2026-09-07 03:22:53.221103 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-09-07 03:22:53.221148 | 
2026-09-07 03:22:53.713044 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-07 03:22:53.721900 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-09-07 03:22:54.368718 | 
2026-09-07 03:22:54.368951 | PLAY [localhost]
2026-09-07 03:22:54.380133 | 
2026-09-07 03:22:54.380212 | TASK [Generate Zuul manifest]
2026-09-07 03:22:54.398550 | localhost | ok
2026-09-07 03:22:54.415752 | 
2026-09-07 03:22:54.415866 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-09-07 03:22:54.819556 | localhost | changed
2026-09-07 03:22:54.841470 | 
2026-09-07 03:22:54.841697 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-09-07 03:22:54.881245 | localhost | ok
2026-09-07 03:22:54.910497 | 
2026-09-07 03:22:54.911125 | TASK [Upload logs]
2026-09-07 03:22:54.942688 | localhost | ok
2026-09-07 03:22:55.040175 | 
2026-09-07 03:22:55.040376 | TASK [Set zuul-log-path fact]
2026-09-07 03:22:55.058559 | localhost | ok
2026-09-07 03:22:55.071584 | 
2026-09-07 03:22:55.071702 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-07 03:22:55.108639 | localhost | ok
2026-09-07 03:22:55.114624 | 
2026-09-07 03:22:55.114690 | TASK [upload-logs : Create log directories]
2026-09-07 03:22:55.895475 | localhost | changed
2026-09-07 03:22:55.899826 | 
2026-09-07 03:22:55.899913 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-09-07 03:22:56.355773 | localhost -> localhost | ok: Runtime: 0:00:00.003399
2026-09-07 03:22:56.360696 | 
2026-09-07 03:22:56.360766 | TASK [upload-logs : Upload logs to log server]
2026-09-07 03:22:56.894692 | localhost | Output suppressed because no_log was given
2026-09-07 03:22:56.942803 | 
2026-09-07 03:22:56.942915 | LOOP [upload-logs : Compress console log and json output]
2026-09-07 03:22:57.025802 | localhost | skipping: Conditional result was False
2026-09-07 03:22:57.034060 | localhost | skipping: Conditional result was False
2026-09-07 03:22:57.046611 | 
2026-09-07 03:22:57.046931 | LOOP [upload-logs : Upload compressed console log and json output]
2026-09-07 03:22:57.081955 | localhost | skipping: Conditional result was False
2026-09-07 03:22:57.082200 | 
2026-09-07 03:22:57.086560 | localhost | skipping: Conditional result was False
2026-09-07 03:22:57.103795 | 
2026-09-07 03:22:57.103980 | LOOP [upload-logs : Upload console log and json output]