2026-08-19 20:21:04.058797 | Job console starting
2026-08-19 20:21:04.068473 | Updating git repos
2026-08-19 20:21:10.047355 | Cloning repos into workspace
2026-08-19 20:21:25.779074 | Restoring repo states
2026-08-19 20:21:30.272910 | Merging changes
2026-08-19 20:21:31.432773 | Checking out repos
2026-08-19 20:21:33.982945 | Preparing playbooks
2026-08-19 20:21:38.879984 | Running Ansible setup
2026-08-19 20:21:42.950700 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-19 20:21:43.569706 | 
2026-08-19 20:21:43.569846 | PLAY [localhost]
2026-08-19 20:21:43.577182 | 
2026-08-19 20:21:43.577252 | TASK [Gathering Facts]
2026-08-19 20:21:44.484670 | localhost | ok
2026-08-19 20:21:44.494446 | 
2026-08-19 20:21:44.494555 | TASK [Setup log path fact]
2026-08-19 20:21:44.514660 | localhost | ok
2026-08-19 20:21:44.527909 | 
2026-08-19 20:21:44.527977 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-19 20:21:44.558254 | localhost | ok
2026-08-19 20:21:44.578618 | 
2026-08-19 20:21:44.578689 | TASK [emit-job-header : Print job information]
2026-08-19 20:21:44.621316 | # Job Information
2026-08-19 20:21:44.621558 | Ansible Version: 2.16.18
2026-08-19 20:21:44.621631 | Job: atmosphere-molecule-csi-rbd
2026-08-19 20:21:44.621667 | Pipeline: check
2026-08-19 20:21:44.621696 | Executor: 2d72f0692154
2026-08-19 20:21:44.621723 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4092
2026-08-19 20:21:44.621754 | Event ID: d3c7f8e0-9c0a-11f1-9b5a-31b6f7cc9af4
2026-08-19 20:21:44.629402 | 
2026-08-19 20:21:44.629471 | LOOP [emit-job-header : Print node information]
2026-08-19 20:21:44.727914 | localhost | ok:
2026-08-19 20:21:44.728358 | localhost | # Node Information
2026-08-19 20:21:44.728442 | localhost | Inventory Hostname: instance
2026-08-19 20:21:44.728494 | localhost | Hostname: np0000190118
2026-08-19 20:21:44.728542 | localhost | Username: zuul
2026-08-19 20:21:44.728593 | localhost | Distro: Ubuntu 22.04
2026-08-19 20:21:44.728640 | localhost | Provider: yul1
2026-08-19 20:21:44.728683 | localhost | Region: ca-ymq-1
2026-08-19 20:21:44.728727 | localhost | Label: ubuntu-jammy
2026-08-19 20:21:44.728768 | localhost | Product Name: OpenStack Nova
2026-08-19 20:21:44.728810 | localhost | Interface IP: 199.19.213.25
2026-08-19 20:21:44.747304 | 
2026-08-19 20:21:44.747641 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-19 20:21:45.224839 | localhost -> localhost | changed
2026-08-19 20:21:45.231644 | 
2026-08-19 20:21:45.231742 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-19 20:21:46.100648 | localhost -> localhost | changed
2026-08-19 20:21:46.113531 | 
2026-08-19 20:21:46.113614 | PLAY [all]
2026-08-19 20:21:46.122790 | 
2026-08-19 20:21:46.122867 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-19 20:21:46.421079 | instance -> localhost | ok
2026-08-19 20:21:46.431274 | 
2026-08-19 20:21:46.431369 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-19 20:21:46.462573 | instance | ok
2026-08-19 20:21:46.478735 | instance | included: /var/lib/zuul/builds/f01867a8466b4f56b395ee2da212f248/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-19 20:21:46.486257 | 
2026-08-19 20:21:46.486362 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-19 20:21:47.507923 | instance -> localhost | Generating public/private rsa key pair.
2026-08-19 20:21:47.508259 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/f01867a8466b4f56b395ee2da212f248/work/f01867a8466b4f56b395ee2da212f248_id_rsa
2026-08-19 20:21:47.508318 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/f01867a8466b4f56b395ee2da212f248/work/f01867a8466b4f56b395ee2da212f248_id_rsa.pub
2026-08-19 20:21:47.508358 | instance -> localhost | The key fingerprint is:
2026-08-19 20:21:47.508398 | instance -> localhost | SHA256:s2d11sfWCCE8wIbC/Wcuhv07xo7GlFHyPgAHpXvEMOw zuul-build-sshkey
2026-08-19 20:21:47.508455 | instance -> localhost | The key's randomart image is:
2026-08-19 20:21:47.508495 | instance -> localhost | +---[RSA 3072]----+
2026-08-19 20:21:47.508541 | instance -> localhost | |   . o+=oo. .    |
2026-08-19 20:21:47.508580 | instance -> localhost | |    o === +. .   |
2026-08-19 20:21:47.508616 | instance -> localhost | |     o.=o+ ..    |
2026-08-19 20:21:47.508652 | instance -> localhost | |      Eo+ +  . +.|
2026-08-19 20:21:47.508687 | instance -> localhost | |      .oSO  . + *|
2026-08-19 20:21:47.508723 | instance -> localhost | |      ..*o+. o ..|
2026-08-19 20:21:47.508759 | instance -> localhost | |       +.+o.     |
2026-08-19 20:21:47.508794 | instance -> localhost | |        o+=      |
2026-08-19 20:21:47.508834 | instance -> localhost | |       ..ooo     |
2026-08-19 20:21:47.508870 | instance -> localhost | +----[SHA256]-----+
2026-08-19 20:21:47.508978 | instance -> localhost | ok: Runtime: 0:00:00.591007
2026-08-19 20:21:47.518810 | 
2026-08-19 20:21:47.518879 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-19 20:21:47.553320 | instance | ok
2026-08-19 20:21:47.561551 | instance | included: /var/lib/zuul/builds/f01867a8466b4f56b395ee2da212f248/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-19 20:21:47.568763 | 
2026-08-19 20:21:47.568823 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-19 20:21:47.593384 | instance | skipping: Conditional result was False
2026-08-19 20:21:47.604264 | 
2026-08-19 20:21:47.604353 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-19 20:21:48.116750 | instance | changed
2026-08-19 20:21:48.130492 | 
2026-08-19 20:21:48.130676 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-19 20:21:48.314195 | instance | ok
2026-08-19 20:21:48.319630 | 
2026-08-19 20:21:48.319700 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-19 20:21:48.785425 | instance | changed
2026-08-19 20:21:48.792059 | 
2026-08-19 20:21:48.792153 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-19 20:21:49.256349 | instance | changed
2026-08-19 20:21:49.262494 | 
2026-08-19 20:21:49.262571 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-19 20:21:49.288740 | instance | skipping: Conditional result was False
2026-08-19 20:21:49.298558 | 
2026-08-19 20:21:49.298698 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-19 20:21:49.686933 | instance -> localhost | changed
2026-08-19 20:21:49.700644 | 
2026-08-19 20:21:49.700731 | TASK [add-build-sshkey : Add back temp key]
2026-08-19 20:21:49.997411 | instance -> localhost | Identity added: /var/lib/zuul/builds/f01867a8466b4f56b395ee2da212f248/work/f01867a8466b4f56b395ee2da212f248_id_rsa (zuul-build-sshkey)
2026-08-19 20:21:49.997635 | instance -> localhost | ok: Runtime: 0:00:00.026883
2026-08-19 20:21:50.004282 | 
2026-08-19 20:21:50.004364 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-19 20:21:50.332298 | instance | ok
2026-08-19 20:21:50.337701 | 
2026-08-19 20:21:50.337799 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-19 20:21:50.367429 | instance | skipping: Conditional result was False
2026-08-19 20:21:50.377873 | 
2026-08-19 20:21:50.378073 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-19 20:21:50.738064 | instance | ok
2026-08-19 20:21:50.745408 | 
2026-08-19 20:21:50.745552 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-19 20:21:54.219679 | instance | Output suppressed because no_log was given
2026-08-19 20:21:54.228736 | 
2026-08-19 20:21:54.228805 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-19 20:21:54.420169 | instance | ok: "logs"
2026-08-19 20:21:54.420468 | instance | ok: All items complete
2026-08-19 20:21:54.420497 | 
2026-08-19 20:21:54.565466 | instance | ok: "artifacts"
2026-08-19 20:21:54.715321 | instance | ok: "docs"
2026-08-19 20:21:54.729967 | 
2026-08-19 20:21:54.730141 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-19 20:21:54.915222 | instance | changed: "logs"
2026-08-19 20:21:55.072505 | instance | changed: "artifacts"
2026-08-19 20:21:55.221455 | instance | changed: "docs"
2026-08-19 20:21:55.235982 | 
2026-08-19 20:21:55.236105 | PLAY RECAP
2026-08-19 20:21:55.236157 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-19 20:21:55.236186 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-19 20:21:55.236207 | 
2026-08-19 20:21:55.416048 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-19 20:21:55.418557 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-19 20:21:56.010311 | 
2026-08-19 20:21:56.010442 | PLAY [all]
2026-08-19 20:21:56.021198 | 
2026-08-19 20:21:56.021280 | TASK [setup-uv : Extract archive]
2026-08-19 20:21:58.187132 | instance | changed
2026-08-19 20:21:58.194062 | 
2026-08-19 20:21:58.194189 | TASK [setup-uv : Print version]
2026-08-19 20:21:58.578764 | instance | uv 0.8.13
2026-08-19 20:21:58.733072 | instance | ok: Runtime: 0:00:00.012583
2026-08-19 20:21:58.743583 | 
2026-08-19 20:21:58.743690 | TASK [Install Ansible collection siblings]
2026-08-19 20:22:07.784971 | instance | changed:
2026-08-19 20:22:07.785157 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-08-19 20:22:07.785215 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-08-19 20:22:07.785267 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-08-19 20:22:07.785340 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-08-19 20:22:07.785408 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-08-19 20:22:07.785444 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-08-19 20:22:07.785467 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-08-19 20:22:07.785488 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-08-19 20:22:07.785508 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-08-19 20:22:07.785527 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-08-19 20:22:07.785546 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-08-19 20:22:07.785564 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-08-19 20:22:07.785582 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-08-19 20:22:07.785601 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-08-19 20:22:07.785619 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0
2026-08-19 20:22:07.785637 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-08-19 20:22:07.785655 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-08-19 20:22:07.785673 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-08-19 20:22:07.785691 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-08-19 20:22:07.785709 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-08-19 20:22:07.785726 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0
2026-08-19 20:22:07.785744 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-08-19 20:22:07.785763 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-19 20:22:07.785798 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-08-19 20:22:07.785817 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0
2026-08-19 20:22:07.785835 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-19 20:22:07.785852 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-19 20:22:07.785870 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-19 20:22:07.785888 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-08-19 20:22:07.785905 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-08-19 20:22:07.785923 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-19 20:22:07.785940 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-19 20:22:07.785958 | instance | Checked out ansible.netcommon to 1.2.0
2026-08-19 20:22:07.785976 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-08-19 20:22:07.786001 | instance | Starting galaxy collection install process
2026-08-19 20:22:07.786019 | instance | Process install dependency map
2026-08-19 20:22:07.786037 | instance | Starting collection install process
2026-08-19 20:22:07.786054 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-08-19 20:22:07.786072 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-08-19 20:22:07.786089 | instance | ansible.netcommon:* was installed successfully
2026-08-19 20:22:07.786106 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-08-19 20:22:07.786123 | instance | Creating virtual environment at: .venv
2026-08-19 20:22:07.786140 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-19 20:22:07.786157 | instance | Downloading netaddr (2.2MiB)
2026-08-19 20:22:07.786174 | instance | Downloading setuptools (1.1MiB)
2026-08-19 20:22:07.786195 | instance | Downloading kubernetes (1.9MiB)
2026-08-19 20:22:07.786213 | instance | Downloading rjsonnet (1.2MiB)
2026-08-19 20:22:07.786231 | instance | Downloading openstacksdk (1.7MiB)
2026-08-19 20:22:07.786248 | instance | Downloading pygments (1.2MiB)
2026-08-19 20:22:07.786266 | instance | Downloading ansible-core (2.1MiB)
2026-08-19 20:22:07.786283 | instance | Downloading cryptography (4.2MiB)
2026-08-19 20:22:07.786336 | instance |    Building pyperclip==1.9.0
2026-08-19 20:22:07.786376 | instance |  Downloading rjsonnet
2026-08-19 20:22:07.786445 | instance |  Downloading netaddr
2026-08-19 20:22:07.786509 | instance |  Downloading pygments
2026-08-19 20:22:07.786549 | instance |  Downloading cryptography
2026-08-19 20:22:07.786615 | instance |  Downloading setuptools
2026-08-19 20:22:07.786645 | instance |  Downloading kubernetes
2026-08-19 20:22:07.786717 | instance |  Downloading ansible-core
2026-08-19 20:22:07.786793 | instance |  Downloading openstacksdk
2026-08-19 20:22:07.786826 | instance |       Built pyperclip==1.9.0
2026-08-19 20:22:07.786897 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-19 20:22:07.786959 | instance | Installed 79 packages in 44ms
2026-08-19 20:22:07.786995 | instance | Checked out ansible.posix to 1.6.0
2026-08-19 20:22:07.787016 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-08-19 20:22:07.787035 | instance | Starting galaxy collection install process
2026-08-19 20:22:07.787053 | instance | Process install dependency map
2026-08-19 20:22:07.787071 | instance | Starting collection install process
2026-08-19 20:22:07.787089 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-08-19 20:22:07.787118 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-08-19 20:22:07.787137 | instance | ansible.posix:1.6.0 was installed successfully
2026-08-19 20:22:07.787155 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-19 20:22:07.787173 | instance | 2.17.12
2026-08-19 20:22:07.787192 | instance | Checked out ansible.utils to v6.1.0
2026-08-19 20:22:07.787210 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-08-19 20:22:07.787229 | instance | Starting galaxy collection install process
2026-08-19 20:22:07.787246 | instance | Process install dependency map
2026-08-19 20:22:07.787264 | instance | Starting collection install process
2026-08-19 20:22:07.787282 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-08-19 20:22:07.787299 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-08-19 20:22:07.787317 | instance | ansible.utils:6.1.0 was installed successfully
2026-08-19 20:22:07.787336 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-19 20:22:07.787354 | instance | 2.17.12
2026-08-19 20:22:07.787372 | instance | Checked out atmosphere.common to v0.7.0
2026-08-19 20:22:07.787390 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-08-19 20:22:07.787408 | instance | Starting galaxy collection install process
2026-08-19 20:22:07.787426 | instance | Process install dependency map
2026-08-19 20:22:07.787443 | instance | Starting collection install process
2026-08-19 20:22:07.787460 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-08-19 20:22:07.787477 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-08-19 20:22:07.787495 | instance | atmosphere.common:0.7.0 was installed successfully
2026-08-19 20:22:07.787512 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-19 20:22:07.787530 | instance | 2.17.12
2026-08-19 20:22:07.787548 | instance | Checked out community.crypto to 2.2.3
2026-08-19 20:22:07.787566 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.crypto
2026-08-19 20:22:07.787584 | instance | Starting galaxy collection install process
2026-08-19 20:22:07.787602 | instance | Process install dependency map
2026-08-19 20:22:07.787620 | instance | Starting collection install process
2026-08-19 20:22:07.787637 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-08-19 20:22:07.787654 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-08-19 20:22:07.787671 | instance | community.crypto:2.2.3 was installed successfully
2026-08-19 20:22:07.787689 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-19 20:22:07.787706 | instance | 2.17.12
2026-08-19 20:22:07.787723 | instance | Checked out community.general to 7.3.0
2026-08-19 20:22:07.787740 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.general
2026-08-19 20:22:07.787758 | instance | Starting galaxy collection install process
2026-08-19 20:22:07.787780 | instance | Process install dependency map
2026-08-19 20:22:07.787797 | instance | Starting collection install process
2026-08-19 20:22:07.787815 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-08-19 20:22:07.787832 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-08-19 20:22:07.787849 | instance | community.general:7.3.0 was installed successfully
2026-08-19 20:22:07.787867 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-19 20:22:07.787884 | instance | 2.17.12
2026-08-19 20:22:07.787902 | instance | Checked out community.mysql to 3.6.0
2026-08-19 20:22:07.787920 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.mysql
2026-08-19 20:22:07.787938 | instance | Starting galaxy collection install process
2026-08-19 20:22:07.787958 | instance | Process install dependency map
2026-08-19 20:22:07.787976 | instance | Starting collection install process
2026-08-19 20:22:07.787994 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-08-19 20:22:07.788012 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-08-19 20:22:07.788030 | instance | community.mysql:3.6.0 was installed successfully
2026-08-19 20:22:07.788048 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-19 20:22:07.788076 | instance | 2.17.12
2026-08-19 20:22:07.788096 | instance | Checked out kubernetes.core to 2.4.0
2026-08-19 20:22:07.788113 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-08-19 20:22:07.788131 | instance | Starting galaxy collection install process
2026-08-19 20:22:07.788149 | instance | Process install dependency map
2026-08-19 20:22:07.788166 | instance | Starting collection install process
2026-08-19 20:22:07.788183 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-08-19 20:22:07.788201 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-08-19 20:22:07.788218 | instance | kubernetes.core:2.4.0 was installed successfully
2026-08-19 20:22:07.788236 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-19 20:22:07.788253 | instance | 2.17.12
2026-08-19 20:22:07.788270 | instance | Checked out openstack.cloud to 2.6.0
2026-08-19 20:22:07.788288 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-08-19 20:22:07.788306 | instance | Starting galaxy collection install process
2026-08-19 20:22:07.788324 | instance | Process install dependency map
2026-08-19 20:22:07.788341 | instance | Starting collection install process
2026-08-19 20:22:07.788359 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-08-19 20:22:07.788377 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-08-19 20:22:07.788394 | instance | openstack.cloud:2.6.0 was installed successfully
2026-08-19 20:22:07.788412 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-19 20:22:07.788429 | instance | 2.17.12
2026-08-19 20:22:07.788446 | instance | Checked out vexxhost.ceph to v4.2.0
2026-08-19 20:22:07.788464 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-08-19 20:22:07.788485 | instance | Starting galaxy collection install process
2026-08-19 20:22:07.788504 | instance | Process install dependency map
2026-08-19 20:22:07.788521 | instance | Starting collection install process
2026-08-19 20:22:07.788539 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-08-19 20:22:07.788556 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-08-19 20:22:07.788573 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-08-19 20:22:07.788591 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-19 20:22:07.788608 | instance | 2.17.12
2026-08-19 20:22:07.788626 | instance | Checked out vexxhost.containers to v1.6.8
2026-08-19 20:22:07.788643 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-08-19 20:22:07.788661 | instance | Starting galaxy collection install process
2026-08-19 20:22:07.788679 | instance | Process install dependency map
2026-08-19 20:22:07.788696 | instance | Starting collection install process
2026-08-19 20:22:07.788714 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-08-19 20:22:07.788732 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-08-19 20:22:07.788749 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-08-19 20:22:07.788767 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-19 20:22:07.788785 | instance | 2.17.12
2026-08-19 20:22:07.788806 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-08-19 20:22:07.788826 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-08-19 20:22:07.788844 | instance | Starting galaxy collection install process
2026-08-19 20:22:07.788862 | instance | Process install dependency map
2026-08-19 20:22:07.788879 | instance | Starting collection install process
2026-08-19 20:22:07.788897 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-08-19 20:22:07.788915 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-08-19 20:22:07.788932 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-08-19 20:22:07.788949 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-19 20:22:07.788992 | instance | 2.17.12
2026-08-19 20:22:07.794905 | 
2026-08-19 20:22:07.794962 | PLAY RECAP
2026-08-19 20:22:07.795014 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-19 20:22:07.795036 | 
2026-08-19 20:22:07.919125 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-19 20:22:07.923273 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-19 20:22:08.511031 | 
2026-08-19 20:22:08.511155 | PLAY [all]
2026-08-19 20:22:08.522769 | 
2026-08-19 20:22:08.522857 | TASK [Install "jq" for log collection]
2026-08-19 20:22:18.185529 | instance | changed
2026-08-19 20:22:18.188052 | 
2026-08-19 20:22:18.188129 | PLAY RECAP
2026-08-19 20:22:18.188194 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-19 20:22:18.188261 | 
2026-08-19 20:22:18.349587 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-19 20:22:18.352072 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-19 20:22:18.948104 | 
2026-08-19 20:22:18.948230 | PLAY [all]
2026-08-19 20:22:18.959212 | 
2026-08-19 20:22:18.959288 | LOOP [Check inventory directories]
2026-08-19 20:22:19.324827 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-08-19 20:22:19.474766 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-08-19 20:22:19.630590 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-08-19 20:22:19.652875 | 
2026-08-19 20:22:19.653162 | LOOP [Copy inventory file for Zuul]
2026-08-19 20:22:20.440466 | instance | changed:
2026-08-19 20:22:20.441107 | instance | {
2026-08-19 20:22:20.441149 | instance |   "ansible_loop_var": "item",
2026-08-19 20:22:20.441172 | instance |   "changed": false,
2026-08-19 20:22:20.441192 | instance |   "failed": false,
2026-08-19 20:22:20.441215 | instance |   "invocation": {
2026-08-19 20:22:20.441235 | instance |     "module_args": {
2026-08-19 20:22:20.441254 | instance |       "checksum_algorithm": "sha1",
2026-08-19 20:22:20.441272 | instance |       "follow": true,
2026-08-19 20:22:20.441290 | instance |       "get_attributes": true,
2026-08-19 20:22:20.441308 | instance |       "get_checksum": true,
2026-08-19 20:22:20.441326 | instance |       "get_mime": true,
2026-08-19 20:22:20.441343 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-08-19 20:22:20.441366 | instance |     }
2026-08-19 20:22:20.441408 | instance |   },
2026-08-19 20:22:20.441441 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-08-19 20:22:20.441461 | instance |   "stat": {
2026-08-19 20:22:20.441479 | instance |     "atime": 1787170920.7510092,
2026-08-19 20:22:20.441497 | instance |     "attr_flags": "e",
2026-08-19 20:22:20.441515 | instance |     "attributes": [
2026-08-19 20:22:20.441533 | instance |       "extents"
2026-08-19 20:22:20.441549 | instance |     ],
2026-08-19 20:22:20.441566 | instance |     "block_size": 4096,
2026-08-19 20:22:20.441583 | instance |     "blocks": 8,
2026-08-19 20:22:20.441601 | instance |     "charset": "unknown",
2026-08-19 20:22:20.441620 | instance |     "ctime": 1787170919.5189674,
2026-08-19 20:22:20.441638 | instance |     "dev": 64513,
2026-08-19 20:22:20.441655 | instance |     "device_type": 0,
2026-08-19 20:22:20.441673 | instance |     "executable": true,
2026-08-19 20:22:20.441690 | instance |     "exists": true,
2026-08-19 20:22:20.441707 | instance |     "gid": 1000,
2026-08-19 20:22:20.441723 | instance |     "gr_name": "zuul",
2026-08-19 20:22:20.441740 | instance |     "inode": 1048628,
2026-08-19 20:22:20.441757 | instance |     "isblk": false,
2026-08-19 20:22:20.441775 | instance |     "ischr": false,
2026-08-19 20:22:20.441792 | instance |     "isdir": true,
2026-08-19 20:22:20.441809 | instance |     "isfifo": false,
2026-08-19 20:22:20.441826 | instance |     "isgid": false,
2026-08-19 20:22:20.441843 | instance |     "islnk": false,
2026-08-19 20:22:20.441859 | instance |     "isreg": false,
2026-08-19 20:22:20.441876 | instance |     "issock": false,
2026-08-19 20:22:20.441893 | instance |     "isuid": false,
2026-08-19 20:22:20.441910 | instance |     "mimetype": "unknown",
2026-08-19 20:22:20.441927 | instance |     "mode": "0755",
2026-08-19 20:22:20.441944 | instance |     "mtime": 1787170919.5189674,
2026-08-19 20:22:20.441960 | instance |     "nlink": 21,
2026-08-19 20:22:20.441977 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-08-19 20:22:20.441994 | instance |     "pw_name": "zuul",
2026-08-19 20:22:20.442012 | instance |     "readable": true,
2026-08-19 20:22:20.442029 | instance |     "rgrp": true,
2026-08-19 20:22:20.442046 | instance |     "roth": true,
2026-08-19 20:22:20.442063 | instance |     "rusr": true,
2026-08-19 20:22:20.442080 | instance |     "size": 4096,
2026-08-19 20:22:20.442096 | instance |     "uid": 1000,
2026-08-19 20:22:20.442124 | instance |     "version": "1624232366",
2026-08-19 20:22:20.442142 | instance |     "wgrp": false,
2026-08-19 20:22:20.442161 | instance |     "woth": false,
2026-08-19 20:22:20.442178 | instance |     "writeable": true,
2026-08-19 20:22:20.442196 | instance |     "wusr": true,
2026-08-19 20:22:20.442213 | instance |     "xgrp": true,
2026-08-19 20:22:20.442230 | instance |     "xoth": true,
2026-08-19 20:22:20.442247 | instance |     "xusr": true
2026-08-19 20:22:20.442264 | instance |   }
2026-08-19 20:22:20.442281 | instance | }
2026-08-19 20:22:20.442320 | instance | ok: All items complete
2026-08-19 20:22:20.442342 | 
2026-08-19 20:22:20.443642 | instance | skipping: Conditional result was False
2026-08-19 20:22:20.446489 | instance | skipping: Conditional result was False
2026-08-19 20:22:20.465868 | 
2026-08-19 20:22:20.466026 | LOOP [Switch "ansible_host" to private IP]
2026-08-19 20:22:20.826812 | instance | changed: 1 replacements made
2026-08-19 20:22:20.828121 | instance | skipping: Conditional result was False
2026-08-19 20:22:20.828701 | instance | skipping: Conditional result was False
2026-08-19 20:22:20.847175 | 
2026-08-19 20:22:20.847362 | TASK [Run Molecule scenario]
2026-08-19 20:22:21.768593 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-08-19 20:22:22.144512 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-08-19 20:22:22.144582 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-08-19 20:22:33.207901 | instance | INFO     [csi > dependency] Executing
2026-08-19 20:22:33.208060 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-08-19 20:22:33.208275 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-08-19 20:22:33.208394 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-08-19 20:22:33.216078 | instance | INFO     [csi > cleanup] Executing
2026-08-19 20:22:33.216402 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-19 20:22:33.224000 | instance | INFO     [csi > destroy] Executing
2026-08-19 20:22:33.224069 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-08-19 20:22:33.224149 | instance | INFO     [csi > destroy] Executed: Successful
2026-08-19 20:22:33.231541 | instance | INFO     [csi > syntax] Executing
2026-08-19 20:22:34.857320 | instance |
2026-08-19 20:22:34.857554 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-19 20:22:34.927583 | instance | INFO     [csi > syntax] Executed: Successful
2026-08-19 20:22:34.941345 | instance | INFO     [csi > create] Executing
2026-08-19 20:22:34.943188 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-19 20:22:34.950582 | instance | INFO     [csi > prepare] Executing
2026-08-19 20:22:35.750105 | instance |
2026-08-19 20:22:35.750189 | instance | PLAY [Prepare] *****************************************************************
2026-08-19 20:22:35.750419 | instance |
2026-08-19 20:22:35.750643 | instance | TASK [Gathering Facts] *********************************************************
2026-08-19 20:22:35.750888 | instance | Wednesday 19 August 2026  20:22:35 +0000 (0:00:00.027)       0:00:00.027 ******
2026-08-19 20:22:36.913940 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-19 20:22:36.914278 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-19 20:22:36.914634 | instance | interpreter could change the meaning of that path. See
2026-08-19 20:22:36.914991 | instance | https://docs.ansible.com/ansible-
2026-08-19 20:22:36.915462 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-19 20:22:36.926637 | instance | ok: [instance]
2026-08-19 20:22:36.926764 | instance |
2026-08-19 20:22:36.927020 | instance | TASK [Configure short hostname] ************************************************
2026-08-19 20:22:36.927212 | instance | Wednesday 19 August 2026  20:22:36 +0000 (0:00:01.173)       0:00:01.200 ******
2026-08-19 20:22:38.098257 | instance | changed: [instance]
2026-08-19 20:22:38.098480 | instance |
2026-08-19 20:22:38.098763 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-08-19 20:22:38.099047 | instance | Wednesday 19 August 2026  20:22:38 +0000 (0:00:01.173)       0:00:02.374 ******
2026-08-19 20:22:38.358053 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-08-19 20:22:38.358112 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-08-19 20:22:38.358164 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-08-19 20:22:38.365323 | instance | changed: [instance]
2026-08-19 20:22:38.365588 | instance |
2026-08-19 20:22:38.365891 | instance | TASK [Purge "snapd" package] ***************************************************
2026-08-19 20:22:38.366180 | instance | Wednesday 19 August 2026  20:22:38 +0000 (0:00:00.269)       0:00:02.643 ******
2026-08-19 20:22:39.193461 | instance | ok: [instance]
2026-08-19 20:22:39.193678 | instance |
2026-08-19 20:22:39.193962 | instance | PLAY [Create devices for Ceph] *************************************************
2026-08-19 20:22:39.194221 | instance |
2026-08-19 20:22:39.194541 | instance | TASK [Gathering Facts] *********************************************************
2026-08-19 20:22:39.194811 | instance | Wednesday 19 August 2026  20:22:39 +0000 (0:00:00.827)       0:00:03.471 ******
2026-08-19 20:22:39.879476 | instance | ok: [instance]
2026-08-19 20:22:39.879678 | instance |
2026-08-19 20:22:39.879973 | instance | TASK [Install depedencies] *****************************************************
2026-08-19 20:22:39.880223 | instance | Wednesday 19 August 2026  20:22:39 +0000 (0:00:00.685)       0:00:04.157 ******
2026-08-19 20:23:04.417649 | instance | changed: [instance]
2026-08-19 20:23:04.417867 | instance |
2026-08-19 20:23:04.418140 | instance | TASK [Start up service] ********************************************************
2026-08-19 20:23:04.418417 | instance | Wednesday 19 August 2026  20:23:04 +0000 (0:00:24.538)       0:00:28.695 ******
2026-08-19 20:23:04.953414 | instance | ok: [instance]
2026-08-19 20:23:04.953649 | instance |
2026-08-19 20:23:04.954011 | instance | TASK [Generate lvm.conf] *******************************************************
2026-08-19 20:23:04.954334 | instance | Wednesday 19 August 2026  20:23:04 +0000 (0:00:00.535)       0:00:29.230 ******
2026-08-19 20:23:05.242800 | instance | ok: [instance]
2026-08-19 20:23:05.242869 | instance |
2026-08-19 20:23:05.242991 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-08-19 20:23:05.243120 | instance | Wednesday 19 August 2026  20:23:05 +0000 (0:00:00.289)       0:00:29.520 ******
2026-08-19 20:23:05.897680 | instance | changed: [instance]
2026-08-19 20:23:05.897920 | instance |
2026-08-19 20:23:05.897927 | instance | TASK [Get list of all loopback devices] ****************************************
2026-08-19 20:23:05.897933 | instance | Wednesday 19 August 2026  20:23:05 +0000 (0:00:00.654)       0:00:30.174 ******
2026-08-19 20:23:06.092446 | instance | ok: [instance]
2026-08-19 20:23:06.092516 | instance |
2026-08-19 20:23:06.092808 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-08-19 20:23:06.092857 | instance | Wednesday 19 August 2026  20:23:06 +0000 (0:00:00.195)       0:00:30.370 ******
2026-08-19 20:23:06.116927 | instance | skipping: [instance]
2026-08-19 20:23:06.117422 | instance |
2026-08-19 20:23:06.117468 | instance | TASK [Create devices for Ceph] *************************************************
2026-08-19 20:23:06.117475 | instance | Wednesday 19 August 2026  20:23:06 +0000 (0:00:00.024)       0:00:30.394 ******
2026-08-19 20:23:06.674354 | instance | changed: [instance] => (item=osd0)
2026-08-19 20:23:06.674425 | instance | changed: [instance] => (item=osd1)
2026-08-19 20:23:06.674431 | instance | changed: [instance] => (item=osd2)
2026-08-19 20:23:06.674474 | instance |
2026-08-19 20:23:06.674480 | instance | TASK [Set permissions on loopback devices] *************************************
2026-08-19 20:23:06.674485 | instance | Wednesday 19 August 2026  20:23:06 +0000 (0:00:00.556)       0:00:30.951 ******
2026-08-19 20:23:07.291914 | instance | changed: [instance] => (item=osd0)
2026-08-19 20:23:07.292034 | instance | changed: [instance] => (item=osd1)
2026-08-19 20:23:07.292739 | instance | changed: [instance] => (item=osd2)
2026-08-19 20:23:07.292792 | instance |
2026-08-19 20:23:07.292800 | instance | TASK [Start loop devices] ******************************************************
2026-08-19 20:23:07.292808 | instance | Wednesday 19 August 2026  20:23:07 +0000 (0:00:00.618)       0:00:31.569 ******
2026-08-19 20:23:07.964427 | instance | changed: [instance] => (item=osd0)
2026-08-19 20:23:07.964507 | instance | changed: [instance] => (item=osd1)
2026-08-19 20:23:07.965024 | instance | changed: [instance] => (item=osd2)
2026-08-19 20:23:07.965064 | instance |
2026-08-19 20:23:07.965070 | instance | TASK [Create a volume group for each loop device] ******************************
2026-08-19 20:23:07.965075 | instance | Wednesday 19 August 2026  20:23:07 +0000 (0:00:00.672)       0:00:32.242 ******
2026-08-19 20:23:10.930286 | instance | changed: [instance] => (item=osd0)
2026-08-19 20:23:10.930371 | instance | changed: [instance] => (item=osd1)
2026-08-19 20:23:10.930887 | instance | changed: [instance] => (item=osd2)
2026-08-19 20:23:10.930927 | instance |
2026-08-19 20:23:10.930933 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-08-19 20:23:10.930938 | instance | Wednesday 19 August 2026  20:23:10 +0000 (0:00:02.965)       0:00:35.208 ******
2026-08-19 20:23:12.739032 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-08-19 20:23:12.740033 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-08-19 20:23:12.740073 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-08-19 20:23:12.740085 | instance |
2026-08-19 20:23:12.740096 | instance | PLAY RECAP *********************************************************************
2026-08-19 20:23:12.740110 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-08-19 20:23:12.742368 | instance |
2026-08-19 20:23:12.742621 | instance | Wednesday 19 August 2026  20:23:12 +0000 (0:00:01.808)       0:00:37.017 ******
2026-08-19 20:23:12.742636 | instance | ===============================================================================
2026-08-19 20:23:12.742645 | instance | Install depedencies ---------------------------------------------------- 24.54s
2026-08-19 20:23:12.742654 | instance | Create a volume group for each loop device ------------------------------ 2.97s
2026-08-19 20:23:12.742663 | instance | Create a logical volume for each loop device ---------------------------- 1.81s
2026-08-19 20:23:12.742672 | instance | Configure short hostname ------------------------------------------------ 1.17s
2026-08-19 20:23:12.742681 | instance | Gathering Facts --------------------------------------------------------- 1.17s
2026-08-19 20:23:12.742690 | instance | Purge "snapd" package --------------------------------------------------- 0.83s
2026-08-19 20:23:12.742705 | instance | Gathering Facts --------------------------------------------------------- 0.69s
2026-08-19 20:23:12.742715 | instance | Start loop devices ------------------------------------------------------ 0.67s
2026-08-19 20:23:12.744120 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.65s
2026-08-19 20:23:12.744171 | instance | Set permissions on loopback devices ------------------------------------- 0.62s
2026-08-19 20:23:12.744180 | instance | Create devices for Ceph ------------------------------------------------- 0.56s
2026-08-19 20:23:12.744186 | instance | Start up service -------------------------------------------------------- 0.54s
2026-08-19 20:23:12.744192 | instance | Generate lvm.conf ------------------------------------------------------- 0.29s
2026-08-19 20:23:12.744199 | instance | Ensure hostname inside hosts file --------------------------------------- 0.27s
2026-08-19 20:23:12.744206 | instance | Get list of all loopback devices ---------------------------------------- 0.20s
2026-08-19 20:23:12.744212 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s
2026-08-19 20:23:12.809214 | instance | INFO     [csi > prepare] Executed: Successful
2026-08-19 20:23:12.817033 | instance | INFO     [csi > converge] Executing
2026-08-19 20:23:14.259907 | instance |
2026-08-19 20:23:14.260125 | instance | PLAY [Debug CSI driver value] **************************************************
2026-08-19 20:23:14.260381 | instance |
2026-08-19 20:23:14.260661 | instance | TASK [Gathering Facts] *********************************************************
2026-08-19 20:23:14.260942 | instance | Wednesday 19 August 2026  20:23:14 +0000 (0:00:00.007)       0:00:00.007 ******
2026-08-19 20:23:15.195439 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-19 20:23:15.195681 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-19 20:23:15.195966 | instance | interpreter could change the meaning of that path. See
2026-08-19 20:23:15.196228 | instance | https://docs.ansible.com/ansible-
2026-08-19 20:23:15.196498 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-19 20:23:15.208064 | instance | ok: [instance]
2026-08-19 20:23:15.208226 | instance |
2026-08-19 20:23:15.208411 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-08-19 20:23:15.208607 | instance | Wednesday 19 August 2026  20:23:15 +0000 (0:00:00.948)       0:00:00.956 ******
2026-08-19 20:23:15.253121 | instance | ok: [instance] => {
2026-08-19 20:23:15.253283 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-08-19 20:23:15.253450 | instance | }
2026-08-19 20:23:15.253606 | instance |
2026-08-19 20:23:15.253773 | instance | PLAY [all] *********************************************************************
2026-08-19 20:23:15.253980 | instance |
2026-08-19 20:23:15.254147 | instance | TASK [Gathering Facts] *********************************************************
2026-08-19 20:23:15.254312 | instance | Wednesday 19 August 2026  20:23:15 +0000 (0:00:00.044)       0:00:01.001 ******
2026-08-19 20:23:16.104885 | instance | ok: [instance]
2026-08-19 20:23:16.105147 | instance |
2026-08-19 20:23:16.105444 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-08-19 20:23:16.105762 | instance | Wednesday 19 August 2026  20:23:16 +0000 (0:00:00.850)       0:00:01.852 ******
2026-08-19 20:23:16.280311 | instance | ok: [instance]
2026-08-19 20:23:16.280553 | instance |
2026-08-19 20:23:16.280887 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-08-19 20:23:16.281140 | instance |
2026-08-19 20:23:16.281408 | instance | TASK [Gathering Facts] *********************************************************
2026-08-19 20:23:16.281678 | instance | Wednesday 19 August 2026  20:23:16 +0000 (0:00:00.176)       0:00:02.028 ******
2026-08-19 20:23:17.166556 | instance | ok: [instance]
2026-08-19 20:23:17.166827 | instance |
2026-08-19 20:23:17.167133 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-19 20:23:17.167419 | instance | Wednesday 19 August 2026  20:23:17 +0000 (0:00:00.885)       0:00:02.914 ******
2026-08-19 20:23:17.436761 | instance | ok: [instance]
2026-08-19 20:23:17.436844 | instance |
2026-08-19 20:23:17.436974 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-19 20:23:17.437087 | instance | Wednesday 19 August 2026  20:23:17 +0000 (0:00:00.270)       0:00:03.185 ******
2026-08-19 20:23:17.477096 | instance | skipping: [instance]
2026-08-19 20:23:17.477195 | instance |
2026-08-19 20:23:17.477339 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-08-19 20:23:17.477468 | instance | Wednesday 19 August 2026  20:23:17 +0000 (0:00:00.040)       0:00:03.225 ******
2026-08-19 20:23:17.793324 | instance | changed: [instance]
2026-08-19 20:23:17.793608 | instance |
2026-08-19 20:23:17.793943 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-19 20:23:17.794246 | instance | Wednesday 19 August 2026  20:23:17 +0000 (0:00:00.315)       0:00:03.541 ******
2026-08-19 20:23:17.860559 | instance | ok: [instance] => {
2026-08-19 20:23:17.860791 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-08-19 20:23:17.861051 | instance | }
2026-08-19 20:23:17.861298 | instance |
2026-08-19 20:23:17.861627 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-19 20:23:17.861945 | instance | Wednesday 19 August 2026  20:23:17 +0000 (0:00:00.067)       0:00:03.608 ******
2026-08-19 20:23:18.523879 | instance | changed: [instance]
2026-08-19 20:23:18.524187 | instance |
2026-08-19 20:23:18.524505 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-19 20:23:18.524847 | instance | Wednesday 19 August 2026  20:23:18 +0000 (0:00:00.663)       0:00:04.272 ******
2026-08-19 20:23:18.575136 | instance | skipping: [instance]
2026-08-19 20:23:18.575518 | instance |
2026-08-19 20:23:18.575919 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-19 20:23:18.576299 | instance | Wednesday 19 August 2026  20:23:18 +0000 (0:00:00.048)       0:00:04.320 ******
2026-08-19 20:23:18.626949 | instance | skipping: [instance]
2026-08-19 20:23:18.627032 | instance |
2026-08-19 20:23:18.627129 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-19 20:23:18.627322 | instance | Wednesday 19 August 2026  20:23:18 +0000 (0:00:00.052)       0:00:04.373 ******
2026-08-19 20:23:18.831085 | instance | ok: [instance]
2026-08-19 20:23:18.831473 | instance |
2026-08-19 20:23:18.831831 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-19 20:23:18.832182 | instance | Wednesday 19 August 2026  20:23:18 +0000 (0:00:00.204)       0:00:04.578 ******
2026-08-19 20:23:20.015251 | instance | ok: [instance]
2026-08-19 20:23:20.015901 | instance |
2026-08-19 20:23:20.016291 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-19 20:23:20.016647 | instance | Wednesday 19 August 2026  20:23:20 +0000 (0:00:01.182)       0:00:05.761 ******
2026-08-19 20:23:20.074922 | instance | ok: [instance] => {
2026-08-19 20:23:20.075021 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-08-19 20:23:20.075217 | instance | }
2026-08-19 20:23:20.075359 | instance |
2026-08-19 20:23:20.075512 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-19 20:23:20.075702 | instance | Wednesday 19 August 2026  20:23:20 +0000 (0:00:00.062)       0:00:05.823 ******
2026-08-19 20:23:20.807142 | instance | changed: [instance]
2026-08-19 20:23:20.807520 | instance |
2026-08-19 20:23:20.807866 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-19 20:23:20.808205 | instance | Wednesday 19 August 2026  20:23:20 +0000 (0:00:00.728)       0:00:06.551 ******
2026-08-19 20:23:23.677701 | instance | changed: [instance]
2026-08-19 20:23:23.677733 | instance |
2026-08-19 20:23:23.677739 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-08-19 20:23:23.677744 | instance | Wednesday 19 August 2026  20:23:23 +0000 (0:00:02.874)       0:00:09.425 ******
2026-08-19 20:23:23.706885 | instance | skipping: [instance]
2026-08-19 20:23:23.706907 | instance |
2026-08-19 20:23:23.706911 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-08-19 20:23:23.706916 | instance | Wednesday 19 August 2026  20:23:23 +0000 (0:00:00.029)       0:00:09.455 ******
2026-08-19 20:23:23.733780 | instance | skipping: [instance]
2026-08-19 20:23:23.733802 | instance |
2026-08-19 20:23:23.733807 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-08-19 20:23:23.733812 | instance | Wednesday 19 August 2026  20:23:23 +0000 (0:00:00.026)       0:00:09.482 ******
2026-08-19 20:23:23.769541 | instance | skipping: [instance]
2026-08-19 20:23:23.769574 | instance |
2026-08-19 20:23:23.769579 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-08-19 20:23:23.769583 | instance | Wednesday 19 August 2026  20:23:23 +0000 (0:00:00.035)       0:00:09.517 ******
2026-08-19 20:23:29.542470 | instance | changed: [instance]
2026-08-19 20:23:29.542545 | instance |
2026-08-19 20:23:29.542801 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-08-19 20:23:29.542820 | instance | Wednesday 19 August 2026  20:23:29 +0000 (0:00:05.773)       0:00:15.290 ******
2026-08-19 20:23:30.139497 | instance | changed: [instance]
2026-08-19 20:23:30.139559 | instance |
2026-08-19 20:23:30.139882 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-08-19 20:23:30.139917 | instance | Wednesday 19 August 2026  20:23:30 +0000 (0:00:00.597)       0:00:15.887 ******
2026-08-19 20:23:31.088344 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-08-19 20:23:31.088455 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-08-19 20:23:31.089241 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-08-19 20:23:31.089283 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-08-19 20:23:31.089290 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-08-19 20:23:31.089295 | instance |
2026-08-19 20:23:31.089303 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-08-19 20:23:31.089308 | instance | Wednesday 19 August 2026  20:23:31 +0000 (0:00:00.948)       0:00:16.836 ******
2026-08-19 20:23:31.682399 | instance | changed: [instance]
2026-08-19 20:23:31.682477 | instance |
2026-08-19 20:23:31.683123 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-08-19 20:23:31.683160 | instance | Wednesday 19 August 2026  20:23:31 +0000 (0:00:00.577)       0:00:17.413 ******
2026-08-19 20:23:31.683165 | instance |
2026-08-19 20:23:31.683170 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-19 20:23:31.683174 | instance | Wednesday 19 August 2026  20:23:31 +0000 (0:00:00.016)       0:00:17.430 ******
2026-08-19 20:23:32.572908 | instance | ok: [instance]
2026-08-19 20:23:32.572984 | instance |
2026-08-19 20:23:32.573279 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-08-19 20:23:32.573314 | instance | Wednesday 19 August 2026  20:23:32 +0000 (0:00:00.890)       0:00:18.321 ******
2026-08-19 20:23:32.996672 | instance | changed: [instance]
2026-08-19 20:23:32.996786 | instance |
2026-08-19 20:23:32.997164 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-08-19 20:23:32.997208 | instance | Wednesday 19 August 2026  20:23:32 +0000 (0:00:00.423)       0:00:18.744 ******
2026-08-19 20:23:33.508471 | instance | changed: [instance]
2026-08-19 20:23:33.508571 | instance |
2026-08-19 20:23:33.508860 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-19 20:23:33.508899 | instance | Wednesday 19 August 2026  20:23:33 +0000 (0:00:00.511)       0:00:19.256 ******
2026-08-19 20:23:33.709615 | instance | ok: [instance]
2026-08-19 20:23:33.709718 | instance |
2026-08-19 20:23:33.710037 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-19 20:23:33.710078 | instance | Wednesday 19 August 2026  20:23:33 +0000 (0:00:00.200)       0:00:19.457 ******
2026-08-19 20:23:33.767402 | instance | ok: [instance] => {
2026-08-19 20:23:33.767449 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-08-19 20:23:33.767653 | instance | }
2026-08-19 20:23:33.767768 | instance |
2026-08-19 20:23:33.767892 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-19 20:23:33.768016 | instance | Wednesday 19 August 2026  20:23:33 +0000 (0:00:00.057)       0:00:19.515 ******
2026-08-19 20:23:34.537486 | instance | changed: [instance]
2026-08-19 20:23:34.537769 | instance |
2026-08-19 20:23:34.538079 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-19 20:23:34.538367 | instance | Wednesday 19 August 2026  20:23:34 +0000 (0:00:00.769)       0:00:20.285 ******
2026-08-19 20:23:38.846642 | instance | changed: [instance]
2026-08-19 20:23:38.846830 | instance |
2026-08-19 20:23:38.847106 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-08-19 20:23:38.847364 | instance | Wednesday 19 August 2026  20:23:38 +0000 (0:00:04.308)       0:00:24.594 ******
2026-08-19 20:23:39.847249 | instance | ok: [instance]
2026-08-19 20:23:39.847593 | instance |
2026-08-19 20:23:39.848180 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-08-19 20:23:39.848786 | instance | Wednesday 19 August 2026  20:23:39 +0000 (0:00:00.999)       0:00:25.594 ******
2026-08-19 20:23:40.195561 | instance | changed: [instance]
2026-08-19 20:23:40.195844 | instance |
2026-08-19 20:23:40.196169 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-08-19 20:23:40.196475 | instance | Wednesday 19 August 2026  20:23:40 +0000 (0:00:00.349)       0:00:25.943 ******
2026-08-19 20:23:40.637355 | instance | changed: [instance]
2026-08-19 20:23:40.637577 | instance |
2026-08-19 20:23:40.637909 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-08-19 20:23:40.638201 | instance | Wednesday 19 August 2026  20:23:40 +0000 (0:00:00.441)       0:00:26.385 ******
2026-08-19 20:23:41.186710 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-08-19 20:23:41.187030 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-08-19 20:23:41.187380 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-08-19 20:23:41.187708 | instance |
2026-08-19 20:23:41.188033 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-08-19 20:23:41.188375 | instance | Wednesday 19 August 2026  20:23:41 +0000 (0:00:00.549)       0:00:26.934 ******
2026-08-19 20:23:41.612366 | instance | changed: [instance]
2026-08-19 20:23:41.612405 | instance |
2026-08-19 20:23:41.612411 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-08-19 20:23:41.612416 | instance | Wednesday 19 August 2026  20:23:41 +0000 (0:00:00.425)       0:00:27.360 ******
2026-08-19 20:23:42.084425 | instance | changed: [instance]
2026-08-19 20:23:42.084462 | instance |
2026-08-19 20:23:42.084467 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-08-19 20:23:42.084472 | instance | Wednesday 19 August 2026  20:23:42 +0000 (0:00:00.455)       0:00:27.815 ******
2026-08-19 20:23:42.084477 | instance |
2026-08-19 20:23:42.084480 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-19 20:23:42.084484 | instance | Wednesday 19 August 2026  20:23:42 +0000 (0:00:00.016)       0:00:27.832 ******
2026-08-19 20:23:42.745111 | instance | ok: [instance]
2026-08-19 20:23:42.745218 | instance |
2026-08-19 20:23:42.745453 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-08-19 20:23:42.745473 | instance | Wednesday 19 August 2026  20:23:42 +0000 (0:00:00.661)       0:00:28.493 ******
2026-08-19 20:23:44.730984 | instance | changed: [instance]
2026-08-19 20:23:44.731098 | instance |
2026-08-19 20:23:44.731393 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-08-19 20:23:44.731438 | instance | Wednesday 19 August 2026  20:23:44 +0000 (0:00:01.985)       0:00:30.479 ******
2026-08-19 20:23:45.260345 | instance | changed: [instance]
2026-08-19 20:23:45.260763 | instance |
2026-08-19 20:23:45.260779 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-08-19 20:23:45.260785 | instance | Wednesday 19 August 2026  20:23:45 +0000 (0:00:00.529)       0:00:31.008 ******
2026-08-19 20:23:45.311448 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-08-19 20:23:45.311887 | instance |
2026-08-19 20:23:45.311923 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-08-19 20:23:45.311929 | instance | Wednesday 19 August 2026  20:23:45 +0000 (0:00:00.051)       0:00:31.059 ******
2026-08-19 20:23:49.641647 | instance | changed: [instance]
2026-08-19 20:23:49.641726 | instance |
2026-08-19 20:23:49.642000 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-08-19 20:23:49.642039 | instance | Wednesday 19 August 2026  20:23:49 +0000 (0:00:04.330)       0:00:35.390 ******
2026-08-19 20:23:50.281325 | instance | ok: [instance] => (item=chronyd)
2026-08-19 20:23:50.281438 | instance | ok: [instance] => (item=sshd)
2026-08-19 20:23:50.281883 | instance |
2026-08-19 20:23:50.282054 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-08-19 20:23:50.282061 | instance | Wednesday 19 August 2026  20:23:50 +0000 (0:00:00.639)       0:00:36.029 ******
2026-08-19 20:23:51.401120 | instance | changed: [instance]
2026-08-19 20:23:51.401192 | instance |
2026-08-19 20:23:51.401470 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-08-19 20:23:51.401509 | instance | Wednesday 19 August 2026  20:23:51 +0000 (0:00:01.119)       0:00:37.149 ******
2026-08-19 20:23:51.603417 | instance | ok: [instance]
2026-08-19 20:23:51.603999 | instance |
2026-08-19 20:23:51.604043 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-08-19 20:23:51.604051 | instance | Wednesday 19 August 2026  20:23:51 +0000 (0:00:00.201)       0:00:37.351 ******
2026-08-19 20:23:52.042335 | instance | changed: [instance]
2026-08-19 20:23:52.042430 | instance |
2026-08-19 20:23:52.042440 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-08-19 20:23:52.042445 | instance | Wednesday 19 August 2026  20:23:52 +0000 (0:00:00.439)       0:00:37.790 ******
2026-08-19 20:23:52.370097 | instance | changed: [instance]
2026-08-19 20:23:52.370168 | instance |
2026-08-19 20:23:52.370439 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-08-19 20:23:52.370507 | instance | Wednesday 19 August 2026  20:23:52 +0000 (0:00:00.328)       0:00:38.118 ******
2026-08-19 20:23:52.478682 | instance | ok: [instance]
2026-08-19 20:23:52.478745 | instance |
2026-08-19 20:23:52.479013 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-08-19 20:23:52.479050 | instance | Wednesday 19 August 2026  20:23:52 +0000 (0:00:00.108)       0:00:38.226 ******
2026-08-19 20:23:52.687618 | instance | ok: [instance] => (item=instance)
2026-08-19 20:23:52.687655 | instance |
2026-08-19 20:23:52.687661 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-08-19 20:23:52.687665 | instance | Wednesday 19 August 2026  20:23:52 +0000 (0:00:00.208)       0:00:38.435 ******
2026-08-19 20:23:52.737226 | instance | ok: [instance]
2026-08-19 20:23:52.737260 | instance |
2026-08-19 20:23:52.737266 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-08-19 20:23:52.737271 | instance | Wednesday 19 August 2026  20:23:52 +0000 (0:00:00.049)       0:00:38.485 ******
2026-08-19 20:23:52.805982 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-08-19 20:23:52.806019 | instance |
2026-08-19 20:23:52.806025 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-08-19 20:23:52.806030 | instance | Wednesday 19 August 2026  20:23:52 +0000 (0:00:00.068)       0:00:38.553 ******
2026-08-19 20:23:53.100653 | instance | changed: [instance]
2026-08-19 20:23:53.100724 | instance |
2026-08-19 20:23:53.100993 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-08-19 20:23:53.101032 | instance | Wednesday 19 August 2026  20:23:53 +0000 (0:00:00.295)       0:00:38.848 ******
2026-08-19 20:23:53.751609 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-08-19 20:23:53.752173 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-08-19 20:23:53.752278 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-08-19 20:23:53.752284 | instance |
2026-08-19 20:23:53.752288 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-08-19 20:23:53.752293 | instance | Wednesday 19 August 2026  20:23:53 +0000 (0:00:00.651)       0:00:39.500 ******
2026-08-19 20:25:29.370168 | instance | ok: [instance]
2026-08-19 20:25:29.370211 | instance |
2026-08-19 20:25:29.370217 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-08-19 20:25:29.370222 | instance | Wednesday 19 August 2026  20:25:29 +0000 (0:01:35.617)       0:02:15.117 ******
2026-08-19 20:25:29.593725 | instance | changed: [instance]
2026-08-19 20:25:29.593852 | instance |
2026-08-19 20:25:29.594005 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-08-19 20:25:29.594189 | instance | Wednesday 19 August 2026  20:25:29 +0000 (0:00:00.224)       0:02:15.342 ******
2026-08-19 20:25:29.678741 | instance | ok: [instance]
2026-08-19 20:25:29.679195 | instance |
2026-08-19 20:25:29.679217 | instance | TASK [Install Ceph host] *******************************************************
2026-08-19 20:25:29.679224 | instance | Wednesday 19 August 2026  20:25:29 +0000 (0:00:00.084)       0:02:15.427 ******
2026-08-19 20:25:29.765500 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-08-19 20:25:29.765566 | instance |
2026-08-19 20:25:29.765889 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-08-19 20:25:29.765927 | instance | Wednesday 19 August 2026  20:25:29 +0000 (0:00:00.086)       0:02:15.513 ******
2026-08-19 20:25:31.377663 | instance | ok: [instance]
2026-08-19 20:25:31.377727 | instance |
2026-08-19 20:25:31.377892 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-08-19 20:25:31.378015 | instance | Wednesday 19 August 2026  20:25:31 +0000 (0:00:01.612)       0:02:17.126 ******
2026-08-19 20:25:31.430657 | instance | ok: [instance] => (item=instance)
2026-08-19 20:25:31.430766 | instance |
2026-08-19 20:25:31.430896 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-08-19 20:25:31.431022 | instance | Wednesday 19 August 2026  20:25:31 +0000 (0:00:00.053)       0:02:17.179 ******
2026-08-19 20:25:31.789241 | instance | ok: [instance]
2026-08-19 20:25:31.789361 | instance |
2026-08-19 20:25:31.789559 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-08-19 20:25:31.789693 | instance | Wednesday 19 August 2026  20:25:31 +0000 (0:00:00.358)       0:02:17.537 ******
2026-08-19 20:25:33.984680 | instance | ok: [instance]
2026-08-19 20:25:33.984758 | instance |
2026-08-19 20:25:33.984976 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-08-19 20:25:33.985013 | instance | Wednesday 19 August 2026  20:25:33 +0000 (0:00:02.195)       0:02:19.733 ******
2026-08-19 20:26:39.136867 | instance | An exception occurred during task execution. To see the full traceback, use -vvv. The error was: [errno 5] RADOS I/O error (error connecting to the cluster)
2026-08-19 20:26:39.137508 | 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_qvz37lpu/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_qvz37lpu/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_qvz37lpu/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_qvz37lpu/ansible_vexxhost.ceph.orch_apply_payload.zip/ansible_collections/vexxhost/ceph/plugins/modules/orch_apply.py\", line 120, in apply_spec\nRuntimeError: Inferring config /var/lib/ceph/4837cbf8-4f90-4300-b3f6-726c9b9f89b4/mon.instance/config\n2026-08-19T20:26:38.997+0000 7f46176bd640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgALEYZqIMzOCyAA3C1X8NvA6TZwP7Ax6xYL3Ww3IVlm30FqiG2B7Y4Vx0w=: Malformed input [buffer:3]\n2026-08-19T20:26:38.997+0000 7f46176bd640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-19T20:26:38.997+0000 7f46176bd640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgALEYZqIMzOCyAA3C1X8NvA6TZwP7Ax6xYL3Ww3IVlm30FqiG2B7Y4Vx0w=: Malformed input [buffer:3]\n2026-08-19T20:26:38.997+0000 7f46176bd640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-19T20:26:38.997+0000 7f46176bd640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgALEYZqIMzOCyAA3C1X8NvA6TZwP7Ax6xYL3Ww3IVlm30FqiG2B7Y4Vx0w=: Malformed input [buffer:3]\n2026-08-19T20:26:38.997+0000 7f46176bd640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-19T20:26:38.997+0000 7f46176bd640 -1 monclient: keyring not found\n[errno 5] RADOS I/O error (error connecting to the cluster)\n\n", "module_stdout": "", "msg": "MODULE FAILURE\nSee stdout/stderr for the exact error", "rc": 1}
2026-08-19 20:26:39.142389 | instance |
2026-08-19 20:26:39.142407 | instance | PLAY RECAP *********************************************************************
2026-08-19 20:26:39.142412 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=6    rescued=0    ignored=0
2026-08-19 20:26:39.142417 | instance |
2026-08-19 20:26:39.142421 | instance | Wednesday 19 August 2026  20:26:39 +0000 (0:01:05.155)       0:03:24.888 ******
2026-08-19 20:26:39.142425 | instance | ===============================================================================
2026-08-19 20:26:39.142429 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 95.62s
2026-08-19 20:26:39.142433 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 65.16s
2026-08-19 20:26:39.142437 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 5.77s
2026-08-19 20:26:39.142441 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 4.33s
2026-08-19 20:26:39.142444 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.31s
2026-08-19 20:26:39.142449 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.87s
2026-08-19 20:26:39.142452 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.20s
2026-08-19 20:26:39.142456 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 1.99s
2026-08-19 20:26:39.142466 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.61s
2026-08-19 20:26:39.142470 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.55s
2026-08-19 20:26:39.142474 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.18s
2026-08-19 20:26:39.143874 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 1.12s
2026-08-19 20:26:39.143895 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.00s
2026-08-19 20:26:39.143902 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.95s
2026-08-19 20:26:39.143908 | instance | Gathering Facts --------------------------------------------------------- 0.95s
2026-08-19 20:26:39.143914 | instance | Gathering Facts --------------------------------------------------------- 0.89s
2026-08-19 20:26:39.143919 | instance | Gathering Facts --------------------------------------------------------- 0.85s
2026-08-19 20:26:39.143925 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.77s
2026-08-19 20:26:39.143931 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.73s
2026-08-19 20:26:39.143937 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.66s
2026-08-19 20:26:39.240266 | instance | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-19 20:26:39.240544 | instance | ERROR    [csi > converge] Executed: Failed
2026-08-19 20:26:39.240742 | instance | ERROR    Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-19 20:26:39.338650 | instance | ERROR
2026-08-19 20:26:39.338936 | instance | {
2026-08-19 20:26:39.339008 | instance |   "delta": "0:04:18.101475",
2026-08-19 20:26:39.339043 | instance |   "end": "2026-08-19 20:26:39.289837",
2026-08-19 20:26:39.339071 | instance |   "msg": "non-zero return code",
2026-08-19 20:26:39.339097 | instance |   "rc": 2,
2026-08-19 20:26:39.339122 | instance |   "start": "2026-08-19 20:22:21.188362"
2026-08-19 20:26:39.339148 | instance | }
failure
2026-08-19 20:26:39.345892 | 
2026-08-19 20:26:39.346003 | PLAY RECAP
2026-08-19 20:26:39.346067 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-08-19 20:26:39.346099 | 
2026-08-19 20:26:39.532831 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-19 20:26:39.543707 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-19 20:26:40.234094 | 
2026-08-19 20:26:40.234255 | PLAY [all]
2026-08-19 20:26:40.251511 | 
2026-08-19 20:26:40.251621 | TASK [gather-host-logs : creating directory for system status]
2026-08-19 20:26:40.608035 | instance | changed
2026-08-19 20:26:40.615516 | 
2026-08-19 20:26:40.615631 | TASK [gather-host-logs : Get logs for each host]
2026-08-19 20:26:40.979004 | instance | + systemd-cgls --full --all --no-pager
2026-08-19 20:26:40.996183 | instance | + ip addr
2026-08-19 20:26:40.998541 | instance | + ip route
2026-08-19 20:26:40.999579 | instance | + lsblk
2026-08-19 20:26:41.003795 | instance | + mount
2026-08-19 20:26:41.006231 | instance | + docker images
2026-08-19 20:26:41.024051 | instance | + brctl show
2026-08-19 20:26:41.024546 | instance | /bin/bash: line 8: brctl: command not found
2026-08-19 20:26:41.024818 | instance | + ps aux --sort=-%mem
2026-08-19 20:26:41.047346 | instance | + dpkg -l
2026-08-19 20:26:41.059298 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-08-19 20:26:41.059932 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-08-19 20:26:41.078234 | instance | + '[' '!' -z '' ']'
2026-08-19 20:26:41.151183 | instance | ok: Runtime: 0:00:00.104084
2026-08-19 20:26:41.160351 | 
2026-08-19 20:26:41.160496 | TASK [gather-host-logs : Downloads logs to executor]
2026-08-19 20:26:41.833647 | instance | changed:
2026-08-19 20:26:41.833878 | instance | created directory /var/lib/zuul/builds/f01867a8466b4f56b395ee2da212f248/work/logs/instance
2026-08-19 20:26:41.833917 | instance | cd+++++++++ system/
2026-08-19 20:26:41.833948 | instance | >f+++++++++ system/brctl-show.txt
2026-08-19 20:26:41.833976 | instance | >f+++++++++ system/docker-images.txt
2026-08-19 20:26:41.834003 | instance | >f+++++++++ system/ip-addr.txt
2026-08-19 20:26:41.834034 | instance | >f+++++++++ system/ip-route.txt
2026-08-19 20:26:41.834065 | instance | >f+++++++++ system/lsblk.txt
2026-08-19 20:26:41.834093 | instance | >f+++++++++ system/mount.txt
2026-08-19 20:26:41.834119 | instance | >f+++++++++ system/packages.txt
2026-08-19 20:26:41.834146 | instance | >f+++++++++ system/ps.txt
2026-08-19 20:26:41.834175 | instance | >f+++++++++ system/systemd-cgls.txt
2026-08-19 20:26:41.847255 | 
2026-08-19 20:26:41.847386 | LOOP [helm-release-status : creating directory for helm release status]
2026-08-19 20:26:42.040733 | instance | changed: "values"
2026-08-19 20:26:42.205608 | instance | changed: "releases"
2026-08-19 20:26:42.217896 | 
2026-08-19 20:26:42.218151 | TASK [helm-release-status : Gather get release status for helm charts]
2026-08-19 20:26:42.430179 | instance | /bin/bash: line 3: kubectl: command not found
2026-08-19 20:26:42.761195 | instance | ok: Runtime: 0:00:00.006418
2026-08-19 20:26:42.768161 | 
2026-08-19 20:26:42.768261 | TASK [helm-release-status : Downloads logs to executor]
2026-08-19 20:26:43.289007 | instance | changed:
2026-08-19 20:26:43.289216 | instance | cd+++++++++ helm/
2026-08-19 20:26:43.289254 | instance | cd+++++++++ helm/releases/
2026-08-19 20:26:43.289285 | instance | cd+++++++++ helm/values/
2026-08-19 20:26:43.301058 | 
2026-08-19 20:26:43.301137 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-08-19 20:26:43.496640 | instance | changed
2026-08-19 20:26:43.504747 | 
2026-08-19 20:26:43.504846 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-08-19 20:26:43.749987 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-19 20:26:43.750525 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-19 20:26:43.755212 | instance | environment: line 1: kubectl: command not found
2026-08-19 20:26:43.757119 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-19 20:26:43.758295 | instance | environment: line 1: kubectl: command not found
2026-08-19 20:26:43.758894 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-19 20:26:43.761416 | instance | environment: line 1: kubectl: command not found
2026-08-19 20:26:43.762175 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-19 20:26:43.762597 | instance | environment: line 1: kubectl: command not found
2026-08-19 20:26:43.763905 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-19 20:26:43.764156 | instance | environment: line 1: kubectl: command not found
2026-08-19 20:26:43.765312 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-19 20:26:44.041909 | instance | ok: Runtime: 0:00:00.023902
2026-08-19 20:26:44.048294 | 
2026-08-19 20:26:44.048364 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-08-19 20:26:44.245834 | instance | changed
2026-08-19 20:26:44.252843 | 
2026-08-19 20:26:44.252963 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-08-19 20:26:44.464213 | instance | environment: line 5: kubectl: command not found
2026-08-19 20:26:44.465065 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-19 20:26:44.465276 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-19 20:26:44.465542 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-19 20:26:44.794329 | instance | ok: Runtime: 0:00:00.010329
2026-08-19 20:26:44.800364 | 
2026-08-19 20:26:44.800431 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-08-19 20:26:45.300998 | instance | changed:
2026-08-19 20:26:45.301216 | instance | cd+++++++++ objects/
2026-08-19 20:26:45.301255 | instance | cd+++++++++ objects/cluster/
2026-08-19 20:26:45.301288 | instance | cd+++++++++ objects/namespaced/
2026-08-19 20:26:45.312907 | 
2026-08-19 20:26:45.312999 | TASK [gather-pod-logs : creating directory for pod logs]
2026-08-19 20:26:45.519204 | instance | changed
2026-08-19 20:26:45.526266 | 
2026-08-19 20:26:45.526367 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-08-19 20:26:45.735299 | instance | changed
2026-08-19 20:26:45.742020 | 
2026-08-19 20:26:45.742118 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-08-19 20:26:45.958667 | instance | environment: line 3: kubectl: command not found
2026-08-19 20:26:46.277356 | instance | ok: Runtime: 0:00:00.008278
2026-08-19 20:26:46.290303 | 
2026-08-19 20:26:46.290556 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-08-19 20:26:46.786648 | instance | changed:
2026-08-19 20:26:46.786842 | instance | cd+++++++++ pod-logs/
2026-08-19 20:26:46.786902 | instance | cd+++++++++ pod-logs/failed-pods/
2026-08-19 20:26:46.802659 | 
2026-08-19 20:26:46.802776 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-08-19 20:26:47.008542 | instance | changed
2026-08-19 20:26:47.014665 | 
2026-08-19 20:26:47.014762 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-08-19 20:26:47.226507 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-19 20:26:47.561446 | instance | ok: Runtime: 0:00:00.034327
2026-08-19 20:26:47.570128 | 
2026-08-19 20:26:47.570215 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-08-19 20:26:47.780879 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-19 20:26:47.810902 | instance | ceph-mgr endpoints:
2026-08-19 20:26:48.109589 | instance | ok: Runtime: 0:00:00.035731
2026-08-19 20:26:48.114949 | 
2026-08-19 20:26:48.115018 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-08-19 20:26:48.314735 | instance | /bin/bash: line 4: kubectl: command not found
2026-08-19 20:26:48.646571 | instance | ok: Runtime: 0:00:00.035826
2026-08-19 20:26:48.652110 | 
2026-08-19 20:26:48.652224 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-08-19 20:26:49.153522 | instance | changed: cd+++++++++ prometheus/
2026-08-19 20:26:49.170688 | 
2026-08-19 20:26:49.170758 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-08-19 20:26:49.399448 | instance | changed
2026-08-19 20:26:49.408393 | 
2026-08-19 20:26:49.408481 | TASK [gather-selenium-data : Get selenium data]
2026-08-19 20:26:49.668411 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-08-19 20:26:49.669122 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-08-19 20:26:49.941093 | instance | ERROR
2026-08-19 20:26:49.941284 | instance | {
2026-08-19 20:26:49.941316 | instance |   "delta": "0:00:00.003742",
2026-08-19 20:26:49.941338 | instance |   "end": "2026-08-19 20:26:49.669357",
2026-08-19 20:26:49.941359 | instance |   "msg": "non-zero return code",
2026-08-19 20:26:49.941378 | instance |   "rc": 1,
2026-08-19 20:26:49.941396 | instance |   "start": "2026-08-19 20:26:49.665615"
2026-08-19 20:26:49.941414 | instance | }
2026-08-19 20:26:49.941437 | instance | ERROR: Ignoring Errors
2026-08-19 20:26:49.949262 | 
2026-08-19 20:26:49.949353 | TASK [gather-selenium-data : Downloads logs to executor]
2026-08-19 20:26:50.444722 | instance | changed: cd+++++++++ selenium/
2026-08-19 20:26:50.451674 | 
2026-08-19 20:26:50.451760 | PLAY RECAP
2026-08-19 20:26:50.451812 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-08-19 20:26:50.451836 | 
2026-08-19 20:26:50.652623 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-19 20:26:50.657052 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-19 20:26:52.054255 | 
2026-08-19 20:26:52.054405 | PLAY [all]
2026-08-19 20:26:52.066525 | 
2026-08-19 20:26:52.066614 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-19 20:26:52.112317 | instance | skipping: Conditional result was False
2026-08-19 20:26:52.122730 | 
2026-08-19 20:26:52.122830 | TASK [fetch-output : Set log path for single node]
2026-08-19 20:26:52.168992 | instance | ok
2026-08-19 20:26:52.173813 | 
2026-08-19 20:26:52.173880 | LOOP [fetch-output : Ensure local output dirs]
2026-08-19 20:26:52.683570 | instance -> localhost | ok: "/var/lib/zuul/builds/f01867a8466b4f56b395ee2da212f248/work/logs"
2026-08-19 20:26:52.897043 | instance -> localhost | changed: "/var/lib/zuul/builds/f01867a8466b4f56b395ee2da212f248/work/artifacts"
2026-08-19 20:26:53.126502 | instance -> localhost | changed: "/var/lib/zuul/builds/f01867a8466b4f56b395ee2da212f248/work/docs"
2026-08-19 20:26:53.145199 | 
2026-08-19 20:26:53.145358 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-19 20:26:53.867428 | instance | changed: .d..t...... ./
2026-08-19 20:26:53.867684 | instance | changed: All items complete
2026-08-19 20:26:53.867715 | 
2026-08-19 20:26:54.353158 | instance | changed: .d..t...... ./
2026-08-19 20:26:54.849500 | instance | changed: .d..t...... ./
2026-08-19 20:26:54.878437 | 
2026-08-19 20:26:54.878644 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-19 20:26:55.304397 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007499
2026-08-19 20:26:55.527459 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.008331
2026-08-19 20:26:55.545876 | 
2026-08-19 20:26:55.546025 | PLAY [all]
2026-08-19 20:26:55.553152 | 
2026-08-19 20:26:55.553219 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-19 20:26:55.997505 | instance | changed
2026-08-19 20:26:56.003200 | 
2026-08-19 20:26:56.003254 | PLAY RECAP
2026-08-19 20:26:56.003302 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-19 20:26:56.003324 | 
2026-08-19 20:26:56.156524 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-19 20:26:56.161076 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-19 20:26:56.824884 | 
2026-08-19 20:26:56.825066 | PLAY [localhost]
2026-08-19 20:26:56.836931 | 
2026-08-19 20:26:56.837095 | TASK [Generate Zuul manifest]
2026-08-19 20:26:56.861410 | localhost | ok
2026-08-19 20:26:56.907940 | 
2026-08-19 20:26:56.908048 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-19 20:26:57.557886 | localhost | changed
2026-08-19 20:26:57.568841 | 
2026-08-19 20:26:57.568943 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-19 20:26:57.601753 | localhost | ok
2026-08-19 20:26:57.609346 | 
2026-08-19 20:26:57.609415 | TASK [Upload logs]
2026-08-19 20:26:57.633409 | localhost | ok
2026-08-19 20:26:57.854771 | 
2026-08-19 20:26:57.854912 | TASK [Set zuul-log-path fact]
2026-08-19 20:26:57.874697 | localhost | ok
2026-08-19 20:26:57.888597 | 
2026-08-19 20:26:57.888667 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-19 20:26:57.921031 | localhost | ok
2026-08-19 20:26:57.928100 | 
2026-08-19 20:26:57.928164 | TASK [upload-logs : Create log directories]
2026-08-19 20:26:58.364438 | localhost | changed
2026-08-19 20:26:58.371392 | 
2026-08-19 20:26:58.371481 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-19 20:27:01.643627 | localhost -> localhost | ok: Runtime: 0:00:00.773712
2026-08-19 20:27:01.649259 | 
2026-08-19 20:27:01.649327 | TASK [upload-logs : Upload logs to log server]
2026-08-19 20:27:02.252285 | localhost | Output suppressed because no_log was given
2026-08-19 20:27:02.295009 | 
2026-08-19 20:27:02.295163 | LOOP [upload-logs : Compress console log and json output]
2026-08-19 20:27:02.347734 | localhost | skipping: Conditional result was False
2026-08-19 20:27:02.355683 | localhost | skipping: Conditional result was False
2026-08-19 20:27:02.370549 | 
2026-08-19 20:27:02.370732 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-19 20:27:02.418447 | localhost | skipping: Conditional result was False
2026-08-19 20:27:02.418904 | 
2026-08-19 20:27:02.422981 | localhost | skipping: Conditional result was False
2026-08-19 20:27:02.440607 | 
2026-08-19 20:27:02.440779 | LOOP [upload-logs : Upload console log and json output]