2026-09-04 03:05:24.185351 | Job console starting
2026-09-04 03:05:24.196929 | Updating git repos
2026-09-04 03:05:27.743061 | Cloning repos into workspace
2026-09-04 03:05:43.657310 | Restoring repo states
2026-09-04 03:05:58.455177 | Merging changes
2026-09-04 03:05:59.604543 | Checking out repos
2026-09-04 03:06:02.954369 | Preparing playbooks
2026-09-04 03:06:04.724610 | Running Ansible setup
2026-09-04 03:06:08.032995 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-04 03:06:08.578755 | 
2026-09-04 03:06:08.579121 | PLAY [localhost]
2026-09-04 03:06:08.585788 | 
2026-09-04 03:06:08.585850 | TASK [Gathering Facts]
2026-09-04 03:06:09.413455 | localhost | ok
2026-09-04 03:06:09.425740 | 
2026-09-04 03:06:09.425881 | TASK [Setup log path fact]
2026-09-04 03:06:09.445205 | localhost | ok
2026-09-04 03:06:09.463826 | 
2026-09-04 03:06:09.463981 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-04 03:06:09.492452 | localhost | ok
2026-09-04 03:06:09.503220 | 
2026-09-04 03:06:09.503347 | TASK [emit-job-header : Print job information]
2026-09-04 03:06:09.553543 | # Job Information
2026-09-04 03:06:09.553740 | Ansible Version: 2.16.18
2026-09-04 03:06:09.553803 | Job: atmosphere-molecule-csi-rbd
2026-09-04 03:06:09.553845 | Pipeline: check
2026-09-04 03:06:09.553884 | Executor: 2d72f0692154
2026-09-04 03:06:09.553941 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3501
2026-09-04 03:06:09.553987 | Event ID: e64065d0-a80c-11f1-8b76-daa6c81da5db
2026-09-04 03:06:09.559438 | 
2026-09-04 03:06:09.559565 | LOOP [emit-job-header : Print node information]
2026-09-04 03:06:09.659153 | localhost | ok:
2026-09-04 03:06:09.659752 | localhost | # Node Information
2026-09-04 03:06:09.659812 | localhost | Inventory Hostname: instance
2026-09-04 03:06:09.659854 | localhost | Hostname: np0000191920
2026-09-04 03:06:09.659892 | localhost | Username: zuul
2026-09-04 03:06:09.659958 | localhost | Distro: Ubuntu 22.04
2026-09-04 03:06:09.659997 | localhost | Provider: yul1
2026-09-04 03:06:09.660035 | localhost | Region: ca-ymq-1
2026-09-04 03:06:09.660071 | localhost | Label: ubuntu-jammy
2026-09-04 03:06:09.660105 | localhost | Product Name: OpenStack Nova
2026-09-04 03:06:09.660140 | localhost | Interface IP: 162.253.55.118
2026-09-04 03:06:09.676628 | 
2026-09-04 03:06:09.676786 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-09-04 03:06:10.015036 | localhost -> localhost | changed
2026-09-04 03:06:10.019836 | 
2026-09-04 03:06:10.019902 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-09-04 03:06:10.854310 | localhost -> localhost | changed
2026-09-04 03:06:10.864752 | 
2026-09-04 03:06:10.864882 | PLAY [all]
2026-09-04 03:06:10.879907 | 
2026-09-04 03:06:10.880051 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-09-04 03:06:11.117074 | instance -> localhost | ok
2026-09-04 03:06:11.127834 | 
2026-09-04 03:06:11.128231 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-09-04 03:06:11.159867 | instance | ok
2026-09-04 03:06:11.183995 | instance | included: /var/lib/zuul/builds/b7f4d2efa2b4400982c7aced734faa18/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-09-04 03:06:11.191717 | 
2026-09-04 03:06:11.191790 | TASK [add-build-sshkey : Create Temp SSH key]
2026-09-04 03:06:12.851919 | instance -> localhost | Generating public/private rsa key pair.
2026-09-04 03:06:12.852055 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/b7f4d2efa2b4400982c7aced734faa18/work/b7f4d2efa2b4400982c7aced734faa18_id_rsa
2026-09-04 03:06:12.852082 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/b7f4d2efa2b4400982c7aced734faa18/work/b7f4d2efa2b4400982c7aced734faa18_id_rsa.pub
2026-09-04 03:06:12.852102 | instance -> localhost | The key fingerprint is:
2026-09-04 03:06:12.852121 | instance -> localhost | SHA256:0oYhbuJWibsTWHil7TOzgeN61YUuRAwbiyKev0TvAHw zuul-build-sshkey
2026-09-04 03:06:12.852153 | instance -> localhost | The key's randomart image is:
2026-09-04 03:06:12.852173 | instance -> localhost | +---[RSA 3072]----+
2026-09-04 03:06:12.852196 | instance -> localhost | |  oo             |
2026-09-04 03:06:12.852215 | instance -> localhost | | . ++            |
2026-09-04 03:06:12.852232 | instance -> localhost | |+.o=. ..         |
2026-09-04 03:06:12.852251 | instance -> localhost | |* =ooo.+.        |
2026-09-04 03:06:12.852269 | instance -> localhost | | OoE=oo.S        |
2026-09-04 03:06:12.852286 | instance -> localhost | |..O=X oo         |
2026-09-04 03:06:12.852304 | instance -> localhost | | .+B O           |
2026-09-04 03:06:12.852322 | instance -> localhost | | .=.=            |
2026-09-04 03:06:12.852342 | instance -> localhost | |.o.o .           |
2026-09-04 03:06:12.852360 | instance -> localhost | +----[SHA256]-----+
2026-09-04 03:06:12.852399 | instance -> localhost | ok: Runtime: 0:00:01.247880
2026-09-04 03:06:12.857492 | 
2026-09-04 03:06:12.857546 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-09-04 03:06:12.883587 | instance | ok
2026-09-04 03:06:12.890403 | instance | included: /var/lib/zuul/builds/b7f4d2efa2b4400982c7aced734faa18/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-09-04 03:06:12.896433 | 
2026-09-04 03:06:12.896487 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-09-04 03:06:12.918945 | instance | skipping: Conditional result was False
2026-09-04 03:06:12.924871 | 
2026-09-04 03:06:12.924966 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-09-04 03:06:13.350621 | instance | changed
2026-09-04 03:06:13.361151 | 
2026-09-04 03:06:13.361280 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-09-04 03:06:13.555656 | instance | ok
2026-09-04 03:06:13.564773 | 
2026-09-04 03:06:13.564908 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-09-04 03:06:14.012443 | instance | changed
2026-09-04 03:06:14.021559 | 
2026-09-04 03:06:14.021682 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-09-04 03:06:14.488980 | instance | changed
2026-09-04 03:06:14.499219 | 
2026-09-04 03:06:14.499339 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-09-04 03:06:14.512726 | instance | skipping: Conditional result was False
2026-09-04 03:06:14.522226 | 
2026-09-04 03:06:14.522346 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-09-04 03:06:14.870146 | instance -> localhost | changed
2026-09-04 03:06:14.888592 | 
2026-09-04 03:06:14.888788 | TASK [add-build-sshkey : Add back temp key]
2026-09-04 03:06:15.198418 | instance -> localhost | Identity added: /var/lib/zuul/builds/b7f4d2efa2b4400982c7aced734faa18/work/b7f4d2efa2b4400982c7aced734faa18_id_rsa (zuul-build-sshkey)
2026-09-04 03:06:15.198837 | instance -> localhost | ok: Runtime: 0:00:00.014294
2026-09-04 03:06:15.211756 | 
2026-09-04 03:06:15.211908 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-09-04 03:06:15.530975 | instance | ok
2026-09-04 03:06:15.540330 | 
2026-09-04 03:06:15.540562 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-09-04 03:06:15.564957 | instance | skipping: Conditional result was False
2026-09-04 03:06:15.582207 | 
2026-09-04 03:06:15.582326 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-09-04 03:06:15.918002 | instance | ok
2026-09-04 03:06:15.927824 | 
2026-09-04 03:06:15.927966 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-09-04 03:06:19.509557 | instance | Output suppressed because no_log was given
2026-09-04 03:06:19.525375 | 
2026-09-04 03:06:19.525523 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-09-04 03:06:19.745216 | instance | ok: "logs"
2026-09-04 03:06:19.745575 | instance | ok: All items complete
2026-09-04 03:06:19.745631 | 
2026-09-04 03:06:19.871867 | instance | ok: "artifacts"
2026-09-04 03:06:20.017530 | instance | ok: "docs"
2026-09-04 03:06:20.035267 | 
2026-09-04 03:06:20.035445 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-09-04 03:06:20.204708 | instance | changed: "logs"
2026-09-04 03:06:20.363522 | instance | changed: "artifacts"
2026-09-04 03:06:20.501308 | instance | changed: "docs"
2026-09-04 03:06:20.521042 | 
2026-09-04 03:06:20.521187 | PLAY RECAP
2026-09-04 03:06:20.521292 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-09-04 03:06:20.521356 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-04 03:06:20.521397 | 
2026-09-04 03:06:20.637451 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-04 03:06:20.640918 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-04 03:06:21.160575 | 
2026-09-04 03:06:21.160685 | PLAY [all]
2026-09-04 03:06:21.169595 | 
2026-09-04 03:06:21.169663 | TASK [setup-uv : Extract archive]
2026-09-04 03:06:23.454727 | instance | changed
2026-09-04 03:06:23.465754 | 
2026-09-04 03:06:23.465906 | TASK [setup-uv : Print version]
2026-09-04 03:06:23.826914 | instance | uv 0.8.13
2026-09-04 03:06:24.012590 | instance | ok: Runtime: 0:00:00.012299
2026-09-04 03:06:24.028187 | 
2026-09-04 03:06:24.028300 | TASK [Install Ansible collection siblings]
2026-09-04 03:06:33.364406 | instance | changed:
2026-09-04 03:06:33.364682 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-09-04 03:06:33.364756 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-09-04 03:06:33.364801 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-09-04 03:06:33.364842 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-09-04 03:06:33.364882 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-09-04 03:06:33.364926 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-09-04 03:06:33.365034 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-09-04 03:06:33.365076 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-09-04 03:06:33.365114 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-09-04 03:06:33.365150 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-09-04 03:06:33.365187 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-09-04 03:06:33.365222 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-09-04 03:06:33.365256 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-09-04 03:06:33.365292 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-09-04 03:06:33.365327 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0
2026-09-04 03:06:33.365364 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-09-04 03:06:33.365399 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-09-04 03:06:33.365434 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-09-04 03:06:33.365470 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-09-04 03:06:33.365505 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-09-04 03:06:33.365540 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0
2026-09-04 03:06:33.365574 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-09-04 03:06:33.365612 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-09-04 03:06:33.365669 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-09-04 03:06:33.365708 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0
2026-09-04 03:06:33.365757 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-09-04 03:06:33.365794 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-09-04 03:06:33.365829 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-09-04 03:06:33.365867 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-09-04 03:06:33.365902 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-09-04 03:06:33.365957 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-09-04 03:06:33.365995 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-09-04 03:06:33.366032 | instance | Checked out ansible.netcommon to 1.2.0
2026-09-04 03:06:33.366069 | 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-04 03:06:33.366116 | instance | Starting galaxy collection install process
2026-09-04 03:06:33.366152 | instance | Process install dependency map
2026-09-04 03:06:33.366188 | instance | Starting collection install process
2026-09-04 03:06:33.366223 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-09-04 03:06:33.366258 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-09-04 03:06:33.366293 | instance | ansible.netcommon:* was installed successfully
2026-09-04 03:06:33.366327 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-09-04 03:06:33.366362 | instance | Creating virtual environment at: .venv
2026-09-04 03:06:33.366397 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-09-04 03:06:33.366432 | instance | Downloading setuptools (1.1MiB)
2026-09-04 03:06:33.366467 | instance | Downloading openstacksdk (1.7MiB)
2026-09-04 03:06:33.366502 | instance | Downloading netaddr (2.2MiB)
2026-09-04 03:06:33.366536 | instance | Downloading cryptography (4.2MiB)
2026-09-04 03:06:33.366570 | instance | Downloading rjsonnet (1.2MiB)
2026-09-04 03:06:33.366604 | instance | Downloading kubernetes (1.9MiB)
2026-09-04 03:06:33.366639 | instance | Downloading pydantic-core (2.0MiB)
2026-09-04 03:06:33.366674 | instance | Downloading ansible-core (2.1MiB)
2026-09-04 03:06:33.366709 | instance | Downloading pygments (1.2MiB)
2026-09-04 03:06:33.366756 | instance |    Building pyperclip==1.9.0
2026-09-04 03:06:33.366794 | instance |  Downloading rjsonnet
2026-09-04 03:06:33.366829 | instance |  Downloading pydantic-core
2026-09-04 03:06:33.366867 | instance |  Downloading netaddr
2026-09-04 03:06:33.366903 | instance |  Downloading pygments
2026-09-04 03:06:33.366959 | instance |  Downloading cryptography
2026-09-04 03:06:33.366997 | instance |  Downloading setuptools
2026-09-04 03:06:33.367031 | instance |  Downloading kubernetes
2026-09-04 03:06:33.367065 | instance |  Downloading ansible-core
2026-09-04 03:06:33.367100 | instance |  Downloading openstacksdk
2026-09-04 03:06:33.367133 | instance |       Built pyperclip==1.9.0
2026-09-04 03:06:33.367167 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-09-04 03:06:33.367202 | instance | Installed 83 packages in 48ms
2026-09-04 03:06:33.367236 | instance | Checked out ansible.posix to 1.6.0
2026-09-04 03:06:33.367271 | 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-04 03:06:33.367305 | instance | Starting galaxy collection install process
2026-09-04 03:06:33.367339 | instance | Process install dependency map
2026-09-04 03:06:33.367384 | instance | Starting collection install process
2026-09-04 03:06:33.367421 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-09-04 03:06:33.367456 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-09-04 03:06:33.367491 | instance | ansible.posix:1.6.0 was installed successfully
2026-09-04 03:06:33.367526 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-04 03:06:33.367561 | instance | 2.17.12
2026-09-04 03:06:33.367596 | instance | Checked out ansible.utils to v6.1.0
2026-09-04 03:06:33.367631 | 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-04 03:06:33.367666 | instance | Starting galaxy collection install process
2026-09-04 03:06:33.367701 | instance | Process install dependency map
2026-09-04 03:06:33.367750 | instance | Starting collection install process
2026-09-04 03:06:33.367787 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-09-04 03:06:33.367824 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-09-04 03:06:33.367863 | instance | ansible.utils:6.1.0 was installed successfully
2026-09-04 03:06:33.367898 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-04 03:06:33.367949 | instance | 2.17.12
2026-09-04 03:06:33.367986 | instance | Checked out atmosphere.common to v0.7.0
2026-09-04 03:06:33.368021 | 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-04 03:06:33.368055 | instance | Starting galaxy collection install process
2026-09-04 03:06:33.368089 | instance | Process install dependency map
2026-09-04 03:06:33.368123 | instance | Starting collection install process
2026-09-04 03:06:33.368157 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-09-04 03:06:33.368191 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-09-04 03:06:33.368225 | instance | atmosphere.common:0.7.0 was installed successfully
2026-09-04 03:06:33.368260 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-04 03:06:33.368294 | instance | 2.17.12
2026-09-04 03:06:33.368329 | instance | Checked out community.crypto to 2.2.3
2026-09-04 03:06:33.368363 | 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-04 03:06:33.368398 | instance | Starting galaxy collection install process
2026-09-04 03:06:33.368432 | instance | Process install dependency map
2026-09-04 03:06:33.368466 | instance | Starting collection install process
2026-09-04 03:06:33.368528 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-09-04 03:06:33.368567 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-09-04 03:06:33.368601 | instance | community.crypto:2.2.3 was installed successfully
2026-09-04 03:06:33.368636 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-04 03:06:33.368669 | instance | 2.17.12
2026-09-04 03:06:33.368717 | instance | Checked out community.general to 7.3.0
2026-09-04 03:06:33.368754 | 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-04 03:06:33.368803 | instance | Starting galaxy collection install process
2026-09-04 03:06:33.368839 | instance | Process install dependency map
2026-09-04 03:06:33.368872 | instance | Starting collection install process
2026-09-04 03:06:33.368906 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-09-04 03:06:33.368958 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-09-04 03:06:33.368994 | instance | community.general:7.3.0 was installed successfully
2026-09-04 03:06:33.369030 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-04 03:06:33.369064 | instance | 2.17.12
2026-09-04 03:06:33.369099 | instance | Checked out community.mysql to 3.6.0
2026-09-04 03:06:33.369138 | 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-04 03:06:33.369175 | instance | Starting galaxy collection install process
2026-09-04 03:06:33.369210 | instance | Process install dependency map
2026-09-04 03:06:33.369245 | instance | Starting collection install process
2026-09-04 03:06:33.369279 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-09-04 03:06:33.369314 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-09-04 03:06:33.369347 | instance | community.mysql:3.6.0 was installed successfully
2026-09-04 03:06:33.369381 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-04 03:06:33.369414 | instance | 2.17.12
2026-09-04 03:06:33.369448 | instance | Checked out kubernetes.core to 2.4.0
2026-09-04 03:06:33.369483 | 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-04 03:06:33.369517 | instance | Starting galaxy collection install process
2026-09-04 03:06:33.369551 | instance | Process install dependency map
2026-09-04 03:06:33.369586 | instance | Starting collection install process
2026-09-04 03:06:33.369621 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-09-04 03:06:33.369654 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-09-04 03:06:33.369703 | instance | kubernetes.core:2.4.0 was installed successfully
2026-09-04 03:06:33.369738 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-04 03:06:33.369774 | instance | 2.17.12
2026-09-04 03:06:33.369809 | instance | Checked out openstack.cloud to 2.6.0
2026-09-04 03:06:33.369843 | 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-04 03:06:33.369879 | instance | Starting galaxy collection install process
2026-09-04 03:06:33.369913 | instance | Process install dependency map
2026-09-04 03:06:33.369967 | instance | Starting collection install process
2026-09-04 03:06:33.370008 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-09-04 03:06:33.370043 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-09-04 03:06:33.370078 | instance | openstack.cloud:2.6.0 was installed successfully
2026-09-04 03:06:33.370112 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-04 03:06:33.370146 | instance | 2.17.12
2026-09-04 03:06:33.370191 | instance | Checked out vexxhost.ceph to v4.2.0
2026-09-04 03:06:33.370227 | 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-04 03:06:33.370262 | instance | Starting galaxy collection install process
2026-09-04 03:06:33.370296 | instance | Process install dependency map
2026-09-04 03:06:33.370330 | instance | Starting collection install process
2026-09-04 03:06:33.370364 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-09-04 03:06:33.370398 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-09-04 03:06:33.370431 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-09-04 03:06:33.370465 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-04 03:06:33.370499 | instance | 2.17.12
2026-09-04 03:06:33.370534 | instance | Checked out vexxhost.containers to v1.6.8
2026-09-04 03:06:33.370569 | 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-04 03:06:33.370603 | instance | Starting galaxy collection install process
2026-09-04 03:06:33.370639 | instance | Process install dependency map
2026-09-04 03:06:33.370686 | instance | Starting collection install process
2026-09-04 03:06:33.370722 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-09-04 03:06:33.370756 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-09-04 03:06:33.370804 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-09-04 03:06:33.370877 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-04 03:06:33.370994 | instance | 2.17.12
2026-09-04 03:06:33.371062 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-09-04 03:06:33.371106 | 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-04 03:06:33.371144 | instance | Starting galaxy collection install process
2026-09-04 03:06:33.371179 | instance | Process install dependency map
2026-09-04 03:06:33.371214 | instance | Starting collection install process
2026-09-04 03:06:33.371248 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-09-04 03:06:33.371283 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-09-04 03:06:33.371318 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-09-04 03:06:33.371351 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-04 03:06:33.371385 | instance | 2.17.12
2026-09-04 03:06:33.381264 | 
2026-09-04 03:06:33.381351 | PLAY RECAP
2026-09-04 03:06:33.381427 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-04 03:06:33.381467 | 
2026-09-04 03:06:33.483660 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-04 03:06:33.485623 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-09-04 03:06:34.012185 | 
2026-09-04 03:06:34.012302 | PLAY [all]
2026-09-04 03:06:34.022331 | 
2026-09-04 03:06:34.022403 | TASK [Install "jq" for log collection]
2026-09-04 03:06:43.716881 | instance | changed
2026-09-04 03:06:43.719847 | 
2026-09-04 03:06:43.719991 | PLAY RECAP
2026-09-04 03:06:43.720095 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-04 03:06:43.720236 | 
2026-09-04 03:06:43.822257 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-09-04 03:06:43.825903 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-04 03:06:44.352248 | 
2026-09-04 03:06:44.352350 | PLAY [all]
2026-09-04 03:06:44.361767 | 
2026-09-04 03:06:44.361832 | LOOP [Check inventory directories]
2026-09-04 03:06:44.667229 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-09-04 03:06:44.822307 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-09-04 03:06:44.985248 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-09-04 03:06:45.005322 | 
2026-09-04 03:06:45.005555 | LOOP [Copy inventory file for Zuul]
2026-09-04 03:06:45.780900 | instance | changed:
2026-09-04 03:06:45.781203 | instance | {
2026-09-04 03:06:45.781266 | instance |   "ansible_loop_var": "item",
2026-09-04 03:06:45.781318 | instance |   "changed": false,
2026-09-04 03:06:45.781362 | instance |   "failed": false,
2026-09-04 03:06:45.781411 | instance |   "invocation": {
2026-09-04 03:06:45.781454 | instance |     "module_args": {
2026-09-04 03:06:45.781494 | instance |       "checksum_algorithm": "sha1",
2026-09-04 03:06:45.781535 | instance |       "follow": true,
2026-09-04 03:06:45.781575 | instance |       "get_attributes": true,
2026-09-04 03:06:45.781618 | instance |       "get_checksum": true,
2026-09-04 03:06:45.781658 | instance |       "get_mime": true,
2026-09-04 03:06:45.781700 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-09-04 03:06:45.781740 | instance |     }
2026-09-04 03:06:45.781779 | instance |   },
2026-09-04 03:06:45.781818 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-09-04 03:06:45.781857 | instance |   "stat": {
2026-09-04 03:06:45.781895 | instance |     "atime": 1788491186.534963,
2026-09-04 03:06:45.781935 | instance |     "attr_flags": "e",
2026-09-04 03:06:45.781992 | instance |     "attributes": [
2026-09-04 03:06:45.782033 | instance |       "extents"
2026-09-04 03:06:45.782072 | instance |     ],
2026-09-04 03:06:45.782110 | instance |     "block_size": 4096,
2026-09-04 03:06:45.782155 | instance |     "blocks": 8,
2026-09-04 03:06:45.782194 | instance |     "charset": "unknown",
2026-09-04 03:06:45.782236 | instance |     "ctime": 1788491184.8069463,
2026-09-04 03:06:45.782275 | instance |     "dev": 64513,
2026-09-04 03:06:45.782314 | instance |     "device_type": 0,
2026-09-04 03:06:45.782353 | instance |     "executable": true,
2026-09-04 03:06:45.782391 | instance |     "exists": true,
2026-09-04 03:06:45.782429 | instance |     "gid": 1000,
2026-09-04 03:06:45.782467 | instance |     "gr_name": "zuul",
2026-09-04 03:06:45.782506 | instance |     "inode": 1049063,
2026-09-04 03:06:45.782543 | instance |     "isblk": false,
2026-09-04 03:06:45.782582 | instance |     "ischr": false,
2026-09-04 03:06:45.782620 | instance |     "isdir": true,
2026-09-04 03:06:45.782660 | instance |     "isfifo": false,
2026-09-04 03:06:45.782833 | instance |     "isgid": false,
2026-09-04 03:06:45.782884 | instance |     "islnk": false,
2026-09-04 03:06:45.782926 | instance |     "isreg": false,
2026-09-04 03:06:45.782990 | instance |     "issock": false,
2026-09-04 03:06:45.783030 | instance |     "isuid": false,
2026-09-04 03:06:45.783069 | instance |     "mimetype": "unknown",
2026-09-04 03:06:45.783108 | instance |     "mode": "0755",
2026-09-04 03:06:45.783145 | instance |     "mtime": 1788491184.8069463,
2026-09-04 03:06:45.783184 | instance |     "nlink": 23,
2026-09-04 03:06:45.783223 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-09-04 03:06:45.783262 | instance |     "pw_name": "zuul",
2026-09-04 03:06:45.783301 | instance |     "readable": true,
2026-09-04 03:06:45.783341 | instance |     "rgrp": true,
2026-09-04 03:06:45.783381 | instance |     "roth": true,
2026-09-04 03:06:45.783496 | instance |     "rusr": true,
2026-09-04 03:06:45.783538 | instance |     "size": 4096,
2026-09-04 03:06:45.783573 | instance |     "uid": 1000,
2026-09-04 03:06:45.783606 | instance |     "version": "2879083544",
2026-09-04 03:06:45.783640 | instance |     "wgrp": false,
2026-09-04 03:06:45.783677 | instance |     "woth": false,
2026-09-04 03:06:45.783711 | instance |     "writeable": true,
2026-09-04 03:06:45.783745 | instance |     "wusr": true,
2026-09-04 03:06:45.783778 | instance |     "xgrp": true,
2026-09-04 03:06:45.783811 | instance |     "xoth": true,
2026-09-04 03:06:45.783843 | instance |     "xusr": true
2026-09-04 03:06:45.783876 | instance |   }
2026-09-04 03:06:45.783909 | instance | }
2026-09-04 03:06:45.783999 | instance | ok: All items complete
2026-09-04 03:06:45.784042 | 
2026-09-04 03:06:45.786303 | instance | skipping: Conditional result was False
2026-09-04 03:06:45.789380 | instance | skipping: Conditional result was False
2026-09-04 03:06:45.803254 | 
2026-09-04 03:06:45.803396 | LOOP [Switch "ansible_host" to private IP]
2026-09-04 03:06:46.102008 | instance | changed: 1 replacements made
2026-09-04 03:06:46.107359 | instance | skipping: Conditional result was False
2026-09-04 03:06:46.114805 | instance | skipping: Conditional result was False
2026-09-04 03:06:46.136815 | 
2026-09-04 03:06:46.136983 | TASK [Run Molecule scenario]
2026-09-04 03:06:47.040738 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-09-04 03:06:47.432387 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-09-04 03:06:47.432475 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-09-04 03:06:57.838138 | instance | INFO     [csi > dependency] Executing
2026-09-04 03:06:57.838305 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-09-04 03:06:57.838469 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-09-04 03:06:57.838573 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-09-04 03:06:57.845038 | instance | INFO     [csi > cleanup] Executing
2026-09-04 03:06:57.845318 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-09-04 03:06:57.851687 | instance | INFO     [csi > destroy] Executing
2026-09-04 03:06:57.851735 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-09-04 03:06:57.851811 | instance | INFO     [csi > destroy] Executed: Successful
2026-09-04 03:06:57.858331 | instance | INFO     [csi > syntax] Executing
2026-09-04 03:06:59.387949 | instance |
2026-09-04 03:06:59.388118 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-09-04 03:06:59.444075 | instance | INFO     [csi > syntax] Executed: Successful
2026-09-04 03:06:59.459609 | instance | INFO     [csi > create] Executing
2026-09-04 03:06:59.463868 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-09-04 03:06:59.479124 | instance | INFO     [csi > prepare] Executing
2026-09-04 03:07:00.209957 | instance |
2026-09-04 03:07:00.210219 | instance | PLAY [Prepare] *****************************************************************
2026-09-04 03:07:00.210454 | instance |
2026-09-04 03:07:00.210692 | instance | TASK [Gathering Facts] *********************************************************
2026-09-04 03:07:00.210950 | instance | Friday 04 September 2026  03:07:00 +0000 (0:00:00.023)       0:00:00.023 ******
2026-09-04 03:07:01.415269 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-09-04 03:07:01.415641 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-09-04 03:07:01.416076 | instance | interpreter could change the meaning of that path. See
2026-09-04 03:07:01.416451 | instance | https://docs.ansible.com/ansible-
2026-09-04 03:07:01.416822 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-09-04 03:07:01.426884 | instance | ok: [instance]
2026-09-04 03:07:01.427200 | instance |
2026-09-04 03:07:01.427547 | instance | TASK [Configure short hostname] ************************************************
2026-09-04 03:07:01.427890 | instance | Friday 04 September 2026  03:07:01 +0000 (0:00:01.217)       0:00:01.240 ******
2026-09-04 03:07:02.162138 | instance | changed: [instance]
2026-09-04 03:07:02.162366 | instance |
2026-09-04 03:07:02.162652 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-09-04 03:07:02.162980 | instance | Friday 04 September 2026  03:07:02 +0000 (0:00:00.735)       0:00:01.975 ******
2026-09-04 03:07:02.450183 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-09-04 03:07:02.450483 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-09-04 03:07:02.450772 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-09-04 03:07:02.460217 | instance | changed: [instance]
2026-09-04 03:07:02.460503 | instance |
2026-09-04 03:07:02.460865 | instance | TASK [Purge "snapd" package] ***************************************************
2026-09-04 03:07:02.461163 | instance | Friday 04 September 2026  03:07:02 +0000 (0:00:00.298)       0:00:02.274 ******
2026-09-04 03:07:03.215579 | instance | ok: [instance]
2026-09-04 03:07:03.215832 | instance |
2026-09-04 03:07:03.216137 | instance | PLAY [Create devices for Ceph] *************************************************
2026-09-04 03:07:03.216415 | instance |
2026-09-04 03:07:03.216690 | instance | TASK [Gathering Facts] *********************************************************
2026-09-04 03:07:03.216986 | instance | Friday 04 September 2026  03:07:03 +0000 (0:00:00.754)       0:00:03.029 ******
2026-09-04 03:07:03.934840 | instance | ok: [instance]
2026-09-04 03:07:03.935036 | instance |
2026-09-04 03:07:03.935286 | instance | TASK [Install depedencies] *****************************************************
2026-09-04 03:07:03.935645 | instance | Friday 04 September 2026  03:07:03 +0000 (0:00:00.719)       0:00:03.748 ******
2026-09-04 03:07:30.199764 | instance | changed: [instance]
2026-09-04 03:07:30.200180 | instance |
2026-09-04 03:07:30.200483 | instance | TASK [Start up service] ********************************************************
2026-09-04 03:07:30.200799 | instance | Friday 04 September 2026  03:07:30 +0000 (0:00:26.265)       0:00:30.013 ******
2026-09-04 03:07:30.747706 | instance | ok: [instance]
2026-09-04 03:07:30.747915 | instance |
2026-09-04 03:07:30.748275 | instance | TASK [Generate lvm.conf] *******************************************************
2026-09-04 03:07:30.748579 | instance | Friday 04 September 2026  03:07:30 +0000 (0:00:00.548)       0:00:30.561 ******
2026-09-04 03:07:31.062044 | instance | ok: [instance]
2026-09-04 03:07:31.062279 | instance |
2026-09-04 03:07:31.062543 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-09-04 03:07:31.062782 | instance | Friday 04 September 2026  03:07:31 +0000 (0:00:00.311)       0:00:30.873 ******
2026-09-04 03:07:31.788904 | instance | changed: [instance]
2026-09-04 03:07:31.789096 | instance |
2026-09-04 03:07:31.789449 | instance | TASK [Get list of all loopback devices] ****************************************
2026-09-04 03:07:31.789683 | instance | Friday 04 September 2026  03:07:31 +0000 (0:00:00.726)       0:00:31.600 ******
2026-09-04 03:07:32.004254 | instance | ok: [instance]
2026-09-04 03:07:32.004443 | instance |
2026-09-04 03:07:32.004686 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-09-04 03:07:32.004926 | instance | Friday 04 September 2026  03:07:31 +0000 (0:00:00.217)       0:00:31.818 ******
2026-09-04 03:07:32.029648 | instance | skipping: [instance]
2026-09-04 03:07:32.029881 | instance |
2026-09-04 03:07:32.030121 | instance | TASK [Create devices for Ceph] *************************************************
2026-09-04 03:07:32.030379 | instance | Friday 04 September 2026  03:07:32 +0000 (0:00:00.025)       0:00:31.843 ******
2026-09-04 03:07:32.594637 | instance | changed: [instance] => (item=osd0)
2026-09-04 03:07:32.594850 | instance | changed: [instance] => (item=osd1)
2026-09-04 03:07:32.595108 | instance | changed: [instance] => (item=osd2)
2026-09-04 03:07:32.595325 | instance |
2026-09-04 03:07:32.595562 | instance | TASK [Set permissions on loopback devices] *************************************
2026-09-04 03:07:32.595795 | instance | Friday 04 September 2026  03:07:32 +0000 (0:00:00.564)       0:00:32.408 ******
2026-09-04 03:07:33.213629 | instance | changed: [instance] => (item=osd0)
2026-09-04 03:07:33.213860 | instance | changed: [instance] => (item=osd1)
2026-09-04 03:07:33.214129 | instance | changed: [instance] => (item=osd2)
2026-09-04 03:07:33.214395 | instance |
2026-09-04 03:07:33.214643 | instance | TASK [Start loop devices] ******************************************************
2026-09-04 03:07:33.214889 | instance | Friday 04 September 2026  03:07:33 +0000 (0:00:00.619)       0:00:33.027 ******
2026-09-04 03:07:33.940474 | instance | changed: [instance] => (item=osd0)
2026-09-04 03:07:33.940779 | instance | changed: [instance] => (item=osd1)
2026-09-04 03:07:33.941093 | instance | changed: [instance] => (item=osd2)
2026-09-04 03:07:33.941629 | instance |
2026-09-04 03:07:33.941961 | instance | TASK [Create a volume group for each loop device] ******************************
2026-09-04 03:07:33.942306 | instance | Friday 04 September 2026  03:07:33 +0000 (0:00:00.726)       0:00:33.754 ******
2026-09-04 03:07:37.252026 | instance | changed: [instance] => (item=osd0)
2026-09-04 03:07:37.252296 | instance | changed: [instance] => (item=osd1)
2026-09-04 03:07:37.252571 | instance | changed: [instance] => (item=osd2)
2026-09-04 03:07:37.252828 | instance |
2026-09-04 03:07:37.253088 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-09-04 03:07:37.253409 | instance | Friday 04 September 2026  03:07:37 +0000 (0:00:03.311)       0:00:37.065 ******
2026-09-04 03:07:39.231405 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-09-04 03:07:39.232321 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-09-04 03:07:39.232366 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-09-04 03:07:39.232377 | instance |
2026-09-04 03:07:39.232391 | instance | PLAY RECAP *********************************************************************
2026-09-04 03:07:39.233431 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-09-04 03:07:39.233458 | instance |
2026-09-04 03:07:39.233469 | instance | Friday 04 September 2026  03:07:39 +0000 (0:00:01.980)       0:00:39.046 ******
2026-09-04 03:07:39.233479 | instance | ===============================================================================
2026-09-04 03:07:39.237454 | instance | Install depedencies ---------------------------------------------------- 26.27s
2026-09-04 03:07:39.237489 | instance | Create a volume group for each loop device ------------------------------ 3.31s
2026-09-04 03:07:39.237500 | instance | Create a logical volume for each loop device ---------------------------- 1.98s
2026-09-04 03:07:39.237510 | instance | Gathering Facts --------------------------------------------------------- 1.22s
2026-09-04 03:07:39.237518 | instance | Purge "snapd" package --------------------------------------------------- 0.75s
2026-09-04 03:07:39.237527 | instance | Configure short hostname ------------------------------------------------ 0.74s
2026-09-04 03:07:39.237536 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.73s
2026-09-04 03:07:39.237545 | instance | Start loop devices ------------------------------------------------------ 0.73s
2026-09-04 03:07:39.237553 | instance | Gathering Facts --------------------------------------------------------- 0.72s
2026-09-04 03:07:39.237562 | instance | Set permissions on loopback devices ------------------------------------- 0.62s
2026-09-04 03:07:39.237571 | instance | Create devices for Ceph ------------------------------------------------- 0.56s
2026-09-04 03:07:39.237579 | instance | Start up service -------------------------------------------------------- 0.55s
2026-09-04 03:07:39.237588 | instance | Generate lvm.conf ------------------------------------------------------- 0.31s
2026-09-04 03:07:39.237597 | instance | Ensure hostname inside hosts file --------------------------------------- 0.30s
2026-09-04 03:07:39.237605 | instance | Get list of all loopback devices ---------------------------------------- 0.22s
2026-09-04 03:07:39.237619 | instance | Fail if there is any existing loopback devices -------------------------- 0.03s
2026-09-04 03:07:39.309599 | instance | INFO     [csi > prepare] Executed: Successful
2026-09-04 03:07:39.323940 | instance | INFO     [csi > converge] Executing
2026-09-04 03:07:40.668326 | instance |
2026-09-04 03:07:40.668596 | instance | PLAY [Debug CSI driver value] **************************************************
2026-09-04 03:07:40.668829 | instance |
2026-09-04 03:07:40.669074 | instance | TASK [Gathering Facts] *********************************************************
2026-09-04 03:07:40.669359 | instance | Friday 04 September 2026  03:07:40 +0000 (0:00:00.006)       0:00:00.006 ******
2026-09-04 03:07:41.651702 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-09-04 03:07:41.652014 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-09-04 03:07:41.652423 | instance | interpreter could change the meaning of that path. See
2026-09-04 03:07:41.652769 | instance | https://docs.ansible.com/ansible-
2026-09-04 03:07:41.653088 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-09-04 03:07:41.666073 | instance | ok: [instance]
2026-09-04 03:07:41.666368 | instance |
2026-09-04 03:07:41.666699 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-09-04 03:07:41.667149 | instance | Friday 04 September 2026  03:07:41 +0000 (0:00:00.997)       0:00:01.004 ******
2026-09-04 03:07:41.735911 | instance | ok: [instance] => {
2026-09-04 03:07:41.736237 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-09-04 03:07:41.736592 | instance | }
2026-09-04 03:07:41.736881 | instance |
2026-09-04 03:07:41.737182 | instance | PLAY [all] *********************************************************************
2026-09-04 03:07:41.737547 | instance |
2026-09-04 03:07:41.737854 | instance | TASK [Gathering Facts] *********************************************************
2026-09-04 03:07:41.738165 | instance | Friday 04 September 2026  03:07:41 +0000 (0:00:00.070)       0:00:01.074 ******
2026-09-04 03:07:42.683770 | instance | ok: [instance]
2026-09-04 03:07:42.683981 | instance |
2026-09-04 03:07:42.684229 | instance | TASK [Fail if atmosphere_ceph_enabled is set] **********************************
2026-09-04 03:07:42.684492 | instance | Friday 04 September 2026  03:07:42 +0000 (0:00:00.947)       0:00:02.022 ******
2026-09-04 03:07:42.739020 | instance | skipping: [instance]
2026-09-04 03:07:42.739251 | instance |
2026-09-04 03:07:42.739479 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-09-04 03:07:42.739683 | instance | Friday 04 September 2026  03:07:42 +0000 (0:00:00.055)       0:00:02.077 ******
2026-09-04 03:07:42.967898 | instance | ok: [instance]
2026-09-04 03:07:42.968072 | instance |
2026-09-04 03:07:42.968220 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-09-04 03:07:42.968355 | instance |
2026-09-04 03:07:42.968512 | instance | TASK [Gathering Facts] *********************************************************
2026-09-04 03:07:42.968673 | instance | Friday 04 September 2026  03:07:42 +0000 (0:00:00.227)       0:00:02.305 ******
2026-09-04 03:07:43.971838 | instance | ok: [instance]
2026-09-04 03:07:43.972185 | instance |
2026-09-04 03:07:43.972531 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-04 03:07:43.972848 | instance | Friday 04 September 2026  03:07:43 +0000 (0:00:01.004)       0:00:03.309 ******
2026-09-04 03:07:44.348873 | instance | ok: [instance]
2026-09-04 03:07:44.349250 | instance |
2026-09-04 03:07:44.349764 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-04 03:07:44.350128 | instance | Friday 04 September 2026  03:07:44 +0000 (0:00:00.377)       0:00:03.687 ******
2026-09-04 03:07:44.397297 | instance | skipping: [instance]
2026-09-04 03:07:44.397836 | instance |
2026-09-04 03:07:44.398187 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-09-04 03:07:44.398531 | instance | Friday 04 September 2026  03:07:44 +0000 (0:00:00.048)       0:00:03.735 ******
2026-09-04 03:07:44.785513 | instance | changed: [instance]
2026-09-04 03:07:44.785887 | instance |
2026-09-04 03:07:44.786220 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-04 03:07:44.786565 | instance | Friday 04 September 2026  03:07:44 +0000 (0:00:00.387)       0:00:04.123 ******
2026-09-04 03:07:44.867295 | instance | ok: [instance] => {
2026-09-04 03:07:44.867508 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-09-04 03:07:44.867679 | instance | }
2026-09-04 03:07:44.867823 | instance |
2026-09-04 03:07:44.867967 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-04 03:07:44.868105 | instance | Friday 04 September 2026  03:07:44 +0000 (0:00:00.082)       0:00:04.206 ******
2026-09-04 03:07:45.791747 | instance | changed: [instance]
2026-09-04 03:07:45.792105 | instance |
2026-09-04 03:07:45.792429 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-04 03:07:45.792766 | instance | Friday 04 September 2026  03:07:45 +0000 (0:00:00.923)       0:00:05.129 ******
2026-09-04 03:07:45.856848 | instance | skipping: [instance]
2026-09-04 03:07:45.857080 | instance |
2026-09-04 03:07:45.857280 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-04 03:07:45.857554 | instance | Friday 04 September 2026  03:07:45 +0000 (0:00:00.063)       0:00:05.193 ******
2026-09-04 03:07:45.917856 | instance | skipping: [instance]
2026-09-04 03:07:45.918247 | instance |
2026-09-04 03:07:45.918676 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-04 03:07:45.919062 | instance | Friday 04 September 2026  03:07:45 +0000 (0:00:00.062)       0:00:05.256 ******
2026-09-04 03:07:46.181840 | instance | ok: [instance]
2026-09-04 03:07:46.182343 | instance |
2026-09-04 03:07:46.182707 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-04 03:07:46.183035 | instance | Friday 04 September 2026  03:07:46 +0000 (0:00:00.263)       0:00:05.520 ******
2026-09-04 03:07:47.687616 | instance | ok: [instance]
2026-09-04 03:07:47.688049 | instance |
2026-09-04 03:07:47.688431 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-04 03:07:47.688864 | instance | Friday 04 September 2026  03:07:47 +0000 (0:00:01.505)       0:00:07.025 ******
2026-09-04 03:07:47.773590 | instance | ok: [instance] => {
2026-09-04 03:07:47.773887 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-09-04 03:07:47.774137 | instance | }
2026-09-04 03:07:47.774362 | instance |
2026-09-04 03:07:47.774621 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-04 03:07:47.774865 | instance | Friday 04 September 2026  03:07:47 +0000 (0:00:00.086)       0:00:07.112 ******
2026-09-04 03:07:48.724946 | instance | changed: [instance]
2026-09-04 03:07:48.725179 | instance |
2026-09-04 03:07:48.725413 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-04 03:07:48.725678 | instance | Friday 04 September 2026  03:07:48 +0000 (0:00:00.951)       0:00:08.063 ******
2026-09-04 03:07:51.608845 | instance | changed: [instance]
2026-09-04 03:07:51.609198 | instance |
2026-09-04 03:07:51.609553 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-09-04 03:07:51.609905 | instance | Friday 04 September 2026  03:07:51 +0000 (0:00:02.883)       0:00:10.947 ******
2026-09-04 03:07:51.646219 | instance | skipping: [instance]
2026-09-04 03:07:51.646671 | instance |
2026-09-04 03:07:51.647312 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-09-04 03:07:51.647645 | instance | Friday 04 September 2026  03:07:51 +0000 (0:00:00.035)       0:00:10.982 ******
2026-09-04 03:07:51.686218 | instance | skipping: [instance]
2026-09-04 03:07:51.686375 | instance |
2026-09-04 03:07:51.686631 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-09-04 03:07:51.686854 | instance | Friday 04 September 2026  03:07:51 +0000 (0:00:00.040)       0:00:11.023 ******
2026-09-04 03:07:51.726103 | instance | skipping: [instance]
2026-09-04 03:07:51.726324 | instance |
2026-09-04 03:07:51.726669 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-09-04 03:07:51.726994 | instance | Friday 04 September 2026  03:07:51 +0000 (0:00:00.039)       0:00:11.062 ******
2026-09-04 03:07:58.083997 | instance | changed: [instance]
2026-09-04 03:07:58.084042 | instance |
2026-09-04 03:07:58.084053 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-09-04 03:07:58.084063 | instance | Friday 04 September 2026  03:07:58 +0000 (0:00:06.358)       0:00:17.421 ******
2026-09-04 03:07:58.695825 | instance | changed: [instance]
2026-09-04 03:07:58.696040 | instance |
2026-09-04 03:07:58.696059 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-09-04 03:07:58.696073 | instance | Friday 04 September 2026  03:07:58 +0000 (0:00:00.611)       0:00:18.033 ******
2026-09-04 03:07:59.645487 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-09-04 03:07:59.645560 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-09-04 03:07:59.645580 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-09-04 03:07:59.646817 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-09-04 03:07:59.646867 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-09-04 03:07:59.646879 | instance |
2026-09-04 03:07:59.646889 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-09-04 03:07:59.646898 | instance | Friday 04 September 2026  03:07:59 +0000 (0:00:00.950)       0:00:18.983 ******
2026-09-04 03:08:00.238870 | instance | changed: [instance]
2026-09-04 03:08:00.238912 | instance |
2026-09-04 03:08:00.238919 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-09-04 03:08:00.238926 | instance | Friday 04 September 2026  03:08:00 +0000 (0:00:00.574)       0:00:19.557 ******
2026-09-04 03:08:00.238932 | instance |
2026-09-04 03:08:00.238937 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-09-04 03:08:00.238943 | instance | Friday 04 September 2026  03:08:00 +0000 (0:00:00.018)       0:00:19.576 ******
2026-09-04 03:08:01.153079 | instance | ok: [instance]
2026-09-04 03:08:01.153127 | instance |
2026-09-04 03:08:01.153134 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-09-04 03:08:01.153139 | instance | Friday 04 September 2026  03:08:01 +0000 (0:00:00.914)       0:00:20.491 ******
2026-09-04 03:08:01.645700 | instance | changed: [instance]
2026-09-04 03:08:01.645819 | instance |
2026-09-04 03:08:01.646254 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-09-04 03:08:01.646344 | instance | Friday 04 September 2026  03:08:01 +0000 (0:00:00.492)       0:00:20.983 ******
2026-09-04 03:08:02.205894 | instance | changed: [instance]
2026-09-04 03:08:02.206827 | instance |
2026-09-04 03:08:02.206879 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-04 03:08:02.206891 | instance | Friday 04 September 2026  03:08:02 +0000 (0:00:00.560)       0:00:21.544 ******
2026-09-04 03:08:02.451294 | instance | ok: [instance]
2026-09-04 03:08:02.452064 | instance |
2026-09-04 03:08:02.452119 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-04 03:08:02.452131 | instance | Friday 04 September 2026  03:08:02 +0000 (0:00:00.245)       0:00:21.789 ******
2026-09-04 03:08:02.519894 | instance | ok: [instance] => {
2026-09-04 03:08:02.520625 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-09-04 03:08:02.520667 | instance | }
2026-09-04 03:08:02.520674 | instance |
2026-09-04 03:08:02.520680 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-04 03:08:02.520687 | instance | Friday 04 September 2026  03:08:02 +0000 (0:00:00.069)       0:00:21.858 ******
2026-09-04 03:08:03.264638 | instance | changed: [instance]
2026-09-04 03:08:03.264691 | instance |
2026-09-04 03:08:03.264977 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-04 03:08:03.264994 | instance | Friday 04 September 2026  03:08:03 +0000 (0:00:00.744)       0:00:22.603 ******
2026-09-04 03:08:07.592796 | instance | changed: [instance]
2026-09-04 03:08:07.593459 | instance |
2026-09-04 03:08:07.593506 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-09-04 03:08:07.593528 | instance | Friday 04 September 2026  03:08:07 +0000 (0:00:04.327)       0:00:26.931 ******
2026-09-04 03:08:08.849081 | instance | ok: [instance]
2026-09-04 03:08:08.849209 | instance |
2026-09-04 03:08:08.849519 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-09-04 03:08:08.849611 | instance | Friday 04 September 2026  03:08:08 +0000 (0:00:01.256)       0:00:28.187 ******
2026-09-04 03:08:09.238232 | instance | changed: [instance]
2026-09-04 03:08:09.238751 | instance |
2026-09-04 03:08:09.238798 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-09-04 03:08:09.238805 | instance | Friday 04 September 2026  03:08:09 +0000 (0:00:00.389)       0:00:28.576 ******
2026-09-04 03:08:09.756305 | instance | changed: [instance]
2026-09-04 03:08:09.757011 | instance |
2026-09-04 03:08:09.757062 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-09-04 03:08:09.757074 | instance | Friday 04 September 2026  03:08:09 +0000 (0:00:00.517)       0:00:29.094 ******
2026-09-04 03:08:10.401468 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-09-04 03:08:10.402348 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-09-04 03:08:10.402411 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-09-04 03:08:10.402421 | instance |
2026-09-04 03:08:10.402430 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-09-04 03:08:10.402439 | instance | Friday 04 September 2026  03:08:10 +0000 (0:00:00.645)       0:00:29.740 ******
2026-09-04 03:08:10.872633 | instance | changed: [instance]
2026-09-04 03:08:10.873086 | instance |
2026-09-04 03:08:10.873126 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-09-04 03:08:10.873133 | instance | Friday 04 September 2026  03:08:10 +0000 (0:00:00.471)       0:00:30.211 ******
2026-09-04 03:08:11.345757 | instance | changed: [instance]
2026-09-04 03:08:11.345789 | instance |
2026-09-04 03:08:11.345795 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-09-04 03:08:11.345809 | instance | Friday 04 September 2026  03:08:11 +0000 (0:00:00.458)       0:00:30.669 ******
2026-09-04 03:08:11.345813 | instance |
2026-09-04 03:08:11.345817 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-09-04 03:08:11.345825 | instance | Friday 04 September 2026  03:08:11 +0000 (0:00:00.014)       0:00:30.684 ******
2026-09-04 03:08:12.086920 | instance | ok: [instance]
2026-09-04 03:08:12.086958 | instance |
2026-09-04 03:08:12.086967 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-09-04 03:08:12.086974 | instance | Friday 04 September 2026  03:08:12 +0000 (0:00:00.741)       0:00:31.425 ******
2026-09-04 03:08:13.091655 | instance | changed: [instance]
2026-09-04 03:08:13.092415 | instance |
2026-09-04 03:08:13.092466 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-09-04 03:08:13.092478 | instance | Friday 04 September 2026  03:08:13 +0000 (0:00:01.004)       0:00:32.429 ******
2026-09-04 03:08:13.732336 | instance | changed: [instance]
2026-09-04 03:08:13.732836 | instance |
2026-09-04 03:08:13.732877 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-09-04 03:08:13.732885 | instance | Friday 04 September 2026  03:08:13 +0000 (0:00:00.641)       0:00:33.071 ******
2026-09-04 03:08:13.804899 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-09-04 03:08:13.805439 | instance |
2026-09-04 03:08:13.805484 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-09-04 03:08:13.805492 | instance | Friday 04 September 2026  03:08:13 +0000 (0:00:00.072)       0:00:33.143 ******
2026-09-04 03:08:19.692134 | instance | changed: [instance]
2026-09-04 03:08:19.692627 | instance |
2026-09-04 03:08:19.692665 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-09-04 03:08:19.692675 | instance | Friday 04 September 2026  03:08:19 +0000 (0:00:05.887)       0:00:39.030 ******
2026-09-04 03:08:20.401016 | instance | ok: [instance] => (item=chronyd)
2026-09-04 03:08:20.401065 | instance | ok: [instance] => (item=sshd)
2026-09-04 03:08:20.401076 | instance |
2026-09-04 03:08:20.401086 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-09-04 03:08:20.401096 | instance | Friday 04 September 2026  03:08:20 +0000 (0:00:00.707)       0:00:39.738 ******
2026-09-04 03:08:21.713507 | instance | changed: [instance]
2026-09-04 03:08:21.713663 | instance |
2026-09-04 03:08:21.713681 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-09-04 03:08:21.713763 | instance | Friday 04 September 2026  03:08:21 +0000 (0:00:01.313)       0:00:41.052 ******
2026-09-04 03:08:21.943877 | instance | ok: [instance]
2026-09-04 03:08:21.945049 | instance |
2026-09-04 03:08:21.945092 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-09-04 03:08:21.945103 | instance | Friday 04 September 2026  03:08:21 +0000 (0:00:00.229)       0:00:41.282 ******
2026-09-04 03:08:22.447220 | instance | changed: [instance]
2026-09-04 03:08:22.448036 | instance |
2026-09-04 03:08:22.448092 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-09-04 03:08:22.448104 | instance | Friday 04 September 2026  03:08:22 +0000 (0:00:00.503)       0:00:41.785 ******
2026-09-04 03:08:22.802851 | instance | changed: [instance]
2026-09-04 03:08:22.802948 | instance |
2026-09-04 03:08:22.803302 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-09-04 03:08:22.803342 | instance | Friday 04 September 2026  03:08:22 +0000 (0:00:00.356)       0:00:42.141 ******
2026-09-04 03:08:23.017727 | instance | ok: [instance]
2026-09-04 03:08:23.017815 | instance |
2026-09-04 03:08:23.018175 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-09-04 03:08:23.018217 | instance | Friday 04 September 2026  03:08:23 +0000 (0:00:00.214)       0:00:42.356 ******
2026-09-04 03:08:23.272679 | instance | ok: [instance] => (item=instance)
2026-09-04 03:08:23.273530 | instance |
2026-09-04 03:08:23.273678 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-09-04 03:08:23.273692 | instance | Friday 04 September 2026  03:08:23 +0000 (0:00:00.254)       0:00:42.610 ******
2026-09-04 03:08:23.337596 | instance | ok: [instance]
2026-09-04 03:08:23.337697 | instance |
2026-09-04 03:08:23.337833 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-09-04 03:08:23.337945 | instance | Friday 04 September 2026  03:08:23 +0000 (0:00:00.065)       0:00:42.676 ******
2026-09-04 03:08:23.423768 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-09-04 03:08:23.423934 | instance |
2026-09-04 03:08:23.424197 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-09-04 03:08:23.424505 | instance | Friday 04 September 2026  03:08:23 +0000 (0:00:00.086)       0:00:42.762 ******
2026-09-04 03:08:23.716011 | instance | changed: [instance]
2026-09-04 03:08:23.716279 | instance |
2026-09-04 03:08:23.716536 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-09-04 03:08:23.716772 | instance | Friday 04 September 2026  03:08:23 +0000 (0:00:00.291)       0:00:43.054 ******
2026-09-04 03:08:24.393170 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-09-04 03:08:24.393420 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-09-04 03:08:24.393693 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-09-04 03:08:24.393911 | instance |
2026-09-04 03:08:24.394149 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-09-04 03:08:24.394409 | instance | Friday 04 September 2026  03:08:24 +0000 (0:00:00.676)       0:00:43.731 ******
2026-09-04 03:10:04.431063 | instance | ok: [instance]
2026-09-04 03:10:04.431151 | instance |
2026-09-04 03:10:04.431171 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-09-04 03:10:04.431197 | instance | Friday 04 September 2026  03:10:04 +0000 (0:01:40.036)       0:02:23.767 ******
2026-09-04 03:10:04.659115 | instance | changed: [instance]
2026-09-04 03:10:04.659194 | instance |
2026-09-04 03:10:04.659205 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-09-04 03:10:04.659216 | instance | Friday 04 September 2026  03:10:04 +0000 (0:00:00.227)       0:02:23.995 ******
2026-09-04 03:10:04.693966 | instance | ok: [instance]
2026-09-04 03:10:04.694066 | instance |
2026-09-04 03:10:04.694125 | instance | TASK [Install Ceph host] *******************************************************
2026-09-04 03:10:04.694282 | instance | Friday 04 September 2026  03:10:04 +0000 (0:00:00.036)       0:02:24.032 ******
2026-09-04 03:10:04.794140 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-09-04 03:10:04.794226 | instance |
2026-09-04 03:10:04.794302 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-09-04 03:10:04.794437 | instance | Friday 04 September 2026  03:10:04 +0000 (0:00:00.100)       0:02:24.132 ******
2026-09-04 03:10:06.567538 | instance | ok: [instance]
2026-09-04 03:10:06.567738 | instance |
2026-09-04 03:10:06.568015 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-09-04 03:10:06.568245 | instance | Friday 04 September 2026  03:10:06 +0000 (0:00:01.772)       0:02:25.905 ******
2026-09-04 03:10:06.652814 | instance | ok: [instance] => (item=instance)
2026-09-04 03:10:06.653479 | instance |
2026-09-04 03:10:06.653550 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-09-04 03:10:06.653563 | instance | Friday 04 September 2026  03:10:06 +0000 (0:00:00.085)       0:02:25.990 ******
2026-09-04 03:10:07.027211 | instance | ok: [instance]
2026-09-04 03:10:07.027284 | instance |
2026-09-04 03:10:07.027296 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-09-04 03:10:07.027306 | instance | Friday 04 September 2026  03:10:07 +0000 (0:00:00.373)       0:02:26.364 ******
2026-09-04 03:10:09.486379 | instance | ok: [instance]
2026-09-04 03:10:09.486539 | instance |
2026-09-04 03:10:09.487063 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-09-04 03:10:09.487095 | instance | Friday 04 September 2026  03:10:09 +0000 (0:00:02.459)       0:02:28.824 ******
2026-09-04 03:11:00.436441 | 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-04 03:11:00.437275 | 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_9xuple4v/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_9xuple4v/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_9xuple4v/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_9xuple4v/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-04T03:11:00.239+0000 7f7efd7c7640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBiNppqOUQKJCAAoFX6SPS3RURhlByeVgGgPHwKb8+HAgNT7Rsx+aCgnf4=: Malformed input [buffer:3]\n2026-09-04T03:11:00.239+0000 7f7efd7c7640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-04T03:11:00.239+0000 7f7efd7c7640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBiNppqOUQKJCAAoFX6SPS3RURhlByeVgGgPHwKb8+HAgNT7Rsx+aCgnf4=: Malformed input [buffer:3]\n2026-09-04T03:11:00.239+0000 7f7efd7c7640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-04T03:11:00.239+0000 7f7efd7c7640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBiNppqOUQKJCAAoFX6SPS3RURhlByeVgGgPHwKb8+HAgNT7Rsx+aCgnf4=: Malformed input [buffer:3]\n2026-09-04T03:11:00.239+0000 7f7efd7c7640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-04T03:11:00.239+0000 7f7efd7c7640 -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-04 03:11:00.440509 | instance |
2026-09-04 03:11:00.440738 | instance | PLAY RECAP *********************************************************************
2026-09-04 03:11:00.441482 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=7    rescued=0    ignored=0
2026-09-04 03:11:00.441557 | instance |
2026-09-04 03:11:00.445507 | instance | Friday 04 September 2026  03:11:00 +0000 (0:00:50.955)       0:03:19.779 ******
2026-09-04 03:11:00.445583 | instance | ===============================================================================
2026-09-04 03:11:00.445590 | instance | vexxhost.ceph.mon : Run Bootstrap command ----------------------------- 100.04s
2026-09-04 03:11:00.445596 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 50.96s
2026-09-04 03:11:00.445602 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 6.36s
2026-09-04 03:11:00.445606 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 5.89s
2026-09-04 03:11:00.445610 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.33s
2026-09-04 03:11:00.445614 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.88s
2026-09-04 03:11:00.445641 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.46s
2026-09-04 03:11:00.445645 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.77s
2026-09-04 03:11:00.445649 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.66s
2026-09-04 03:11:00.445653 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.51s
2026-09-04 03:11:00.445657 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 1.31s
2026-09-04 03:11:00.445661 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.26s
2026-09-04 03:11:00.445665 | instance | Gathering Facts --------------------------------------------------------- 1.00s
2026-09-04 03:11:00.445668 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 1.00s
2026-09-04 03:11:00.445672 | instance | Gathering Facts --------------------------------------------------------- 1.00s
2026-09-04 03:11:00.445676 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.95s
2026-09-04 03:11:00.445687 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.95s
2026-09-04 03:11:00.445895 | instance | Gathering Facts --------------------------------------------------------- 0.95s
2026-09-04 03:11:00.446126 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.92s
2026-09-04 03:11:00.446343 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.74s
2026-09-04 03:11:00.575295 | 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-04 03:11:00.575418 | instance | ERROR    [csi > converge] Executed: Failed
2026-09-04 03:11:00.575556 | 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-04 03:11:01.018979 | instance | ERROR
2026-09-04 03:11:01.019227 | instance | {
2026-09-04 03:11:01.019285 | instance |   "delta": "0:04:14.168294",
2026-09-04 03:11:01.019325 | instance |   "end": "2026-09-04 03:11:00.654685",
2026-09-04 03:11:01.019360 | instance |   "msg": "non-zero return code",
2026-09-04 03:11:01.019394 | instance |   "rc": 2,
2026-09-04 03:11:01.019428 | instance |   "start": "2026-09-04 03:06:46.486391"
2026-09-04 03:11:01.019464 | instance | }
failure
2026-09-04 03:11:01.030148 | 
2026-09-04 03:11:01.030249 | PLAY RECAP
2026-09-04 03:11:01.030334 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-09-04 03:11:01.030377 | 
2026-09-04 03:11:01.152973 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-04 03:11:01.156540 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-09-04 03:11:01.687446 | 
2026-09-04 03:11:01.687549 | PLAY [all]
2026-09-04 03:11:01.699977 | 
2026-09-04 03:11:01.700053 | TASK [gather-host-logs : creating directory for system status]
2026-09-04 03:11:02.054579 | instance | changed
2026-09-04 03:11:02.064102 | 
2026-09-04 03:11:02.064255 | TASK [gather-host-logs : Get logs for each host]
2026-09-04 03:11:02.427308 | instance | + systemd-cgls --full --all --no-pager
2026-09-04 03:11:02.447391 | instance | + ip addr
2026-09-04 03:11:02.450558 | instance | + ip route
2026-09-04 03:11:02.453466 | instance | + lsblk
2026-09-04 03:11:02.458389 | instance | + mount
2026-09-04 03:11:02.460789 | instance | + docker images
2026-09-04 03:11:02.485687 | instance | + brctl show
2026-09-04 03:11:02.486241 | instance | /bin/bash: line 8: brctl: command not found
2026-09-04 03:11:02.486535 | instance | + ps aux --sort=-%mem
2026-09-04 03:11:02.507383 | instance | + dpkg -l
2026-09-04 03:11:02.519384 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-09-04 03:11:02.519870 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-09-04 03:11:02.542118 | instance | + '[' '!' -z '' ']'
2026-09-04 03:11:02.610531 | instance | ok: Runtime: 0:00:00.120317
2026-09-04 03:11:02.621120 | 
2026-09-04 03:11:02.621252 | TASK [gather-host-logs : Downloads logs to executor]
2026-09-04 03:11:03.242114 | instance | changed:
2026-09-04 03:11:03.242345 | instance | created directory /var/lib/zuul/builds/b7f4d2efa2b4400982c7aced734faa18/work/logs/instance
2026-09-04 03:11:03.242448 | instance | cd+++++++++ system/
2026-09-04 03:11:03.242498 | instance | >f+++++++++ system/brctl-show.txt
2026-09-04 03:11:03.242541 | instance | >f+++++++++ system/docker-images.txt
2026-09-04 03:11:03.242584 | instance | >f+++++++++ system/ip-addr.txt
2026-09-04 03:11:03.242664 | instance | >f+++++++++ system/ip-route.txt
2026-09-04 03:11:03.242709 | instance | >f+++++++++ system/lsblk.txt
2026-09-04 03:11:03.242747 | instance | >f+++++++++ system/mount.txt
2026-09-04 03:11:03.242793 | instance | >f+++++++++ system/packages.txt
2026-09-04 03:11:03.242867 | instance | >f+++++++++ system/ps.txt
2026-09-04 03:11:03.242930 | instance | >f+++++++++ system/systemd-cgls.txt
2026-09-04 03:11:03.262550 | 
2026-09-04 03:11:03.262720 | LOOP [helm-release-status : creating directory for helm release status]
2026-09-04 03:11:03.483525 | instance | changed: "values"
2026-09-04 03:11:03.674455 | instance | changed: "releases"
2026-09-04 03:11:03.686356 | 
2026-09-04 03:11:03.686527 | TASK [helm-release-status : Gather get release status for helm charts]
2026-09-04 03:11:03.939594 | instance | /bin/bash: line 3: kubectl: command not found
2026-09-04 03:11:04.233349 | instance | ok: Runtime: 0:00:00.005882
2026-09-04 03:11:04.242788 | 
2026-09-04 03:11:04.242945 | TASK [helm-release-status : Downloads logs to executor]
2026-09-04 03:11:04.735802 | instance | changed:
2026-09-04 03:11:04.736058 | instance | cd+++++++++ helm/
2026-09-04 03:11:04.736114 | instance | cd+++++++++ helm/releases/
2026-09-04 03:11:04.736157 | instance | cd+++++++++ helm/values/
2026-09-04 03:11:04.752700 | 
2026-09-04 03:11:04.752827 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-09-04 03:11:04.953007 | instance | changed
2026-09-04 03:11:04.957892 | 
2026-09-04 03:11:04.957978 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-09-04 03:11:05.199826 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-04 03:11:05.199992 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-04 03:11:05.204330 | instance | environment: line 1: kubectl: command not found
2026-09-04 03:11:05.205566 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-04 03:11:05.206357 | instance | environment: line 1: kubectl: command not found
2026-09-04 03:11:05.208185 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-04 03:11:05.208293 | instance | environment: line 1: kubectl: command not found
2026-09-04 03:11:05.209049 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-04 03:11:05.212293 | instance | environment: line 1: kubectl: command not found
2026-09-04 03:11:05.213052 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-04 03:11:05.213117 | instance | environment: line 1: kubectl: command not found
2026-09-04 03:11:05.214507 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-04 03:11:05.487395 | instance | ok: Runtime: 0:00:00.021807
2026-09-04 03:11:05.497138 | 
2026-09-04 03:11:05.497301 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-09-04 03:11:05.714997 | instance | changed
2026-09-04 03:11:05.725045 | 
2026-09-04 03:11:05.725185 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-09-04 03:11:05.973219 | instance | environment: line 5: kubectl: command not found
2026-09-04 03:11:05.974071 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-04 03:11:05.974218 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-04 03:11:05.974236 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-04 03:11:06.273857 | instance | ok: Runtime: 0:00:00.009329
2026-09-04 03:11:06.283409 | 
2026-09-04 03:11:06.283534 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-09-04 03:11:06.770986 | instance | changed:
2026-09-04 03:11:06.771204 | instance | cd+++++++++ objects/
2026-09-04 03:11:06.771260 | instance | cd+++++++++ objects/cluster/
2026-09-04 03:11:06.771304 | instance | cd+++++++++ objects/namespaced/
2026-09-04 03:11:06.788215 | 
2026-09-04 03:11:06.788341 | TASK [gather-pod-logs : creating directory for pod logs]
2026-09-04 03:11:07.002454 | instance | changed
2026-09-04 03:11:07.011445 | 
2026-09-04 03:11:07.011570 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-09-04 03:11:07.238138 | instance | changed
2026-09-04 03:11:07.247215 | 
2026-09-04 03:11:07.247346 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-09-04 03:11:07.510872 | instance | environment: line 3: kubectl: command not found
2026-09-04 03:11:07.793821 | instance | ok: Runtime: 0:00:00.008668
2026-09-04 03:11:07.802832 | 
2026-09-04 03:11:07.802976 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-09-04 03:11:08.291964 | instance | changed:
2026-09-04 03:11:08.292178 | instance | cd+++++++++ pod-logs/
2026-09-04 03:11:08.292232 | instance | cd+++++++++ pod-logs/failed-pods/
2026-09-04 03:11:08.309257 | 
2026-09-04 03:11:08.309377 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-09-04 03:11:08.533424 | instance | changed
2026-09-04 03:11:08.542116 | 
2026-09-04 03:11:08.542242 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-09-04 03:11:08.775453 | instance | /bin/bash: line 2: kubectl: command not found
2026-09-04 03:11:09.087259 | instance | ok: Runtime: 0:00:00.045082
2026-09-04 03:11:09.103762 | 
2026-09-04 03:11:09.103947 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-09-04 03:11:09.353245 | instance | /bin/bash: line 2: kubectl: command not found
2026-09-04 03:11:09.404568 | instance | ceph-mgr endpoints:
2026-09-04 03:11:09.647348 | instance | ok: Runtime: 0:00:00.056536
2026-09-04 03:11:09.656432 | 
2026-09-04 03:11:09.656589 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-09-04 03:11:09.945666 | instance | /bin/bash: line 4: kubectl: command not found
2026-09-04 03:11:10.202199 | instance | ok: Runtime: 0:00:00.052526
2026-09-04 03:11:10.211431 | 
2026-09-04 03:11:10.211554 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-09-04 03:11:10.701122 | instance | changed: cd+++++++++ prometheus/
2026-09-04 03:11:10.720103 | 
2026-09-04 03:11:10.720263 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-09-04 03:11:10.943491 | instance | changed
2026-09-04 03:11:10.954239 | 
2026-09-04 03:11:10.954402 | TASK [gather-selenium-data : Get selenium data]
2026-09-04 03:11:11.233806 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-09-04 03:11:11.234708 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-09-04 03:11:11.498838 | instance | ERROR
2026-09-04 03:11:11.499196 | instance | {
2026-09-04 03:11:11.499259 | instance |   "delta": "0:00:00.004891",
2026-09-04 03:11:11.499300 | instance |   "end": "2026-09-04 03:11:11.235005",
2026-09-04 03:11:11.499341 | instance |   "msg": "non-zero return code",
2026-09-04 03:11:11.499378 | instance |   "rc": 1,
2026-09-04 03:11:11.499412 | instance |   "start": "2026-09-04 03:11:11.230114"
2026-09-04 03:11:11.499446 | instance | }
2026-09-04 03:11:11.499492 | instance | ERROR: Ignoring Errors
2026-09-04 03:11:11.508678 | 
2026-09-04 03:11:11.508810 | TASK [gather-selenium-data : Downloads logs to executor]
2026-09-04 03:11:12.030312 | instance | changed: cd+++++++++ selenium/
2026-09-04 03:11:12.040721 | 
2026-09-04 03:11:12.040821 | PLAY RECAP
2026-09-04 03:11:12.040932 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-09-04 03:11:12.040981 | 
2026-09-04 03:11:12.203546 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-09-04 03:11:12.205300 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-04 03:11:12.748848 | 
2026-09-04 03:11:12.748962 | PLAY [all]
2026-09-04 03:11:12.759309 | 
2026-09-04 03:11:12.759379 | TASK [fetch-output : Set log path for multiple nodes]
2026-09-04 03:11:12.813631 | instance | skipping: Conditional result was False
2026-09-04 03:11:12.818124 | 
2026-09-04 03:11:12.818195 | TASK [fetch-output : Set log path for single node]
2026-09-04 03:11:12.846256 | instance | ok
2026-09-04 03:11:12.851497 | 
2026-09-04 03:11:12.851579 | LOOP [fetch-output : Ensure local output dirs]
2026-09-04 03:11:13.230262 | instance -> localhost | ok: "/var/lib/zuul/builds/b7f4d2efa2b4400982c7aced734faa18/work/logs"
2026-09-04 03:11:13.433422 | instance -> localhost | changed: "/var/lib/zuul/builds/b7f4d2efa2b4400982c7aced734faa18/work/artifacts"
2026-09-04 03:11:13.645304 | instance -> localhost | changed: "/var/lib/zuul/builds/b7f4d2efa2b4400982c7aced734faa18/work/docs"
2026-09-04 03:11:13.654036 | 
2026-09-04 03:11:13.654180 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-09-04 03:11:14.333493 | instance | changed: .d..t...... ./
2026-09-04 03:11:14.333914 | instance | changed: All items complete
2026-09-04 03:11:14.333970 | 
2026-09-04 03:11:14.837108 | instance | changed: .d..t...... ./
2026-09-04 03:11:15.326751 | instance | changed: .d..t...... ./
2026-09-04 03:11:15.349028 | 
2026-09-04 03:11:15.349254 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-09-04 03:11:15.765146 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.008473
2026-09-04 03:11:16.001217 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.006853
2026-09-04 03:11:16.014994 | 
2026-09-04 03:11:16.015102 | PLAY [all]
2026-09-04 03:11:16.020248 | 
2026-09-04 03:11:16.020309 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-09-04 03:11:16.474552 | instance | changed
2026-09-04 03:11:16.481355 | 
2026-09-04 03:11:16.481417 | PLAY RECAP
2026-09-04 03:11:16.481474 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-09-04 03:11:16.481504 | 
2026-09-04 03:11:16.583446 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-04 03:11:16.587089 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-09-04 03:11:17.190416 | 
2026-09-04 03:11:17.190590 | PLAY [localhost]
2026-09-04 03:11:17.200638 | 
2026-09-04 03:11:17.200714 | TASK [Generate Zuul manifest]
2026-09-04 03:11:17.218842 | localhost | ok
2026-09-04 03:11:17.232891 | 
2026-09-04 03:11:17.232975 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-09-04 03:11:17.608085 | localhost | changed
2026-09-04 03:11:17.627896 | 
2026-09-04 03:11:17.628085 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-09-04 03:11:17.670904 | localhost | ok
2026-09-04 03:11:17.683431 | 
2026-09-04 03:11:17.683556 | TASK [Upload logs]
2026-09-04 03:11:17.707288 | localhost | ok
2026-09-04 03:11:17.777169 | 
2026-09-04 03:11:17.777302 | TASK [Set zuul-log-path fact]
2026-09-04 03:11:17.795367 | localhost | ok
2026-09-04 03:11:17.805794 | 
2026-09-04 03:11:17.805859 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-04 03:11:17.844106 | localhost | ok
2026-09-04 03:11:17.852315 | 
2026-09-04 03:11:17.852412 | TASK [upload-logs : Create log directories]
2026-09-04 03:11:18.269684 | localhost | changed
2026-09-04 03:11:18.279036 | 
2026-09-04 03:11:18.279184 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-09-04 03:11:18.697638 | localhost -> localhost | ok: Runtime: 0:00:00.006273
2026-09-04 03:11:18.707524 | 
2026-09-04 03:11:18.707657 | TASK [upload-logs : Upload logs to log server]
2026-09-04 03:11:19.148525 | localhost | Output suppressed because no_log was given
2026-09-04 03:11:19.212311 | 
2026-09-04 03:11:19.212521 | LOOP [upload-logs : Compress console log and json output]
2026-09-04 03:11:19.276172 | localhost | skipping: Conditional result was False
2026-09-04 03:11:19.284936 | localhost | skipping: Conditional result was False
2026-09-04 03:11:19.297106 | 
2026-09-04 03:11:19.297331 | LOOP [upload-logs : Upload compressed console log and json output]
2026-09-04 03:11:19.357790 | localhost | skipping: Conditional result was False
2026-09-04 03:11:19.358268 | 
2026-09-04 03:11:19.363122 | localhost | skipping: Conditional result was False
2026-09-04 03:11:19.373034 | 
2026-09-04 03:11:19.373220 | LOOP [upload-logs : Upload console log and json output]