2026-09-10 10:54:59.968209 | Job console starting
2026-09-10 10:54:59.980958 | Updating git repos
2026-09-10 10:55:07.713573 | Cloning repos into workspace
2026-09-10 10:55:37.353308 | Restoring repo states
2026-09-10 10:55:50.335214 | Merging changes
2026-09-10 10:55:51.774349 | Checking out repos
2026-09-10 10:55:53.333356 | Preparing playbooks
2026-09-10 10:55:55.039522 | Running Ansible setup
2026-09-10 10:55:58.515607 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-10 10:55:59.120688 | 
2026-09-10 10:55:59.120825 | PLAY [localhost]
2026-09-10 10:55:59.127998 | 
2026-09-10 10:55:59.128090 | TASK [Gathering Facts]
2026-09-10 10:56:00.315315 | localhost | ok
2026-09-10 10:56:00.327557 | 
2026-09-10 10:56:00.327748 | TASK [Setup log path fact]
2026-09-10 10:56:00.356239 | localhost | ok
2026-09-10 10:56:00.370244 | 
2026-09-10 10:56:00.370395 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-10 10:56:00.398462 | localhost | ok
2026-09-10 10:56:00.406405 | 
2026-09-10 10:56:00.406577 | TASK [emit-job-header : Print job information]
2026-09-10 10:56:00.455930 | # Job Information
2026-09-10 10:56:00.456134 | Ansible Version: 2.16.18
2026-09-10 10:56:00.456186 | Job: atmosphere-molecule-csi-rbd
2026-09-10 10:56:00.456220 | Pipeline: check
2026-09-10 10:56:00.456252 | Executor: 2d72f0692154
2026-09-10 10:56:00.456284 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4090
2026-09-10 10:56:00.456320 | Event ID: 74b2e980-ad05-11f1-96df-9c2887dba693
2026-09-10 10:56:00.460322 | 
2026-09-10 10:56:00.460433 | LOOP [emit-job-header : Print node information]
2026-09-10 10:56:00.545114 | localhost | ok:
2026-09-10 10:56:00.545335 | localhost | # Node Information
2026-09-10 10:56:00.545390 | localhost | Inventory Hostname: instance
2026-09-10 10:56:00.545433 | localhost | Hostname: np0000192490
2026-09-10 10:56:00.545473 | localhost | Username: zuul
2026-09-10 10:56:00.545537 | localhost | Distro: Ubuntu 22.04
2026-09-10 10:56:00.545578 | localhost | Provider: yul1
2026-09-10 10:56:00.545614 | localhost | Region: ca-ymq-1
2026-09-10 10:56:00.545651 | localhost | Label: ubuntu-jammy
2026-09-10 10:56:00.545687 | localhost | Product Name: OpenStack Nova
2026-09-10 10:56:00.545722 | localhost | Interface IP: 162.253.55.211
2026-09-10 10:56:00.556746 | 
2026-09-10 10:56:00.556908 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-09-10 10:56:00.998109 | localhost -> localhost | changed
2026-09-10 10:56:01.002651 | 
2026-09-10 10:56:01.002730 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-09-10 10:56:01.908080 | localhost -> localhost | changed
2026-09-10 10:56:01.913842 | 
2026-09-10 10:56:01.913943 | PLAY [all]
2026-09-10 10:56:01.923059 | 
2026-09-10 10:56:01.923203 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-09-10 10:56:02.191624 | instance -> localhost | ok
2026-09-10 10:56:02.201485 | 
2026-09-10 10:56:02.201647 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-09-10 10:56:02.234574 | instance | ok
2026-09-10 10:56:02.250881 | instance | included: /var/lib/zuul/builds/7c5447df093443029ded37bd3f0da669/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-09-10 10:56:02.257943 | 
2026-09-10 10:56:02.258031 | TASK [add-build-sshkey : Create Temp SSH key]
2026-09-10 10:56:03.511059 | instance -> localhost | Generating public/private rsa key pair.
2026-09-10 10:56:03.511255 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/7c5447df093443029ded37bd3f0da669/work/7c5447df093443029ded37bd3f0da669_id_rsa
2026-09-10 10:56:03.511299 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/7c5447df093443029ded37bd3f0da669/work/7c5447df093443029ded37bd3f0da669_id_rsa.pub
2026-09-10 10:56:03.511335 | instance -> localhost | The key fingerprint is:
2026-09-10 10:56:03.511371 | instance -> localhost | SHA256:DI5Uwj0taAoNDRuL++ClLvm5n2YggwPNWJbDUJa07Tc zuul-build-sshkey
2026-09-10 10:56:03.511424 | instance -> localhost | The key's randomart image is:
2026-09-10 10:56:03.511459 | instance -> localhost | +---[RSA 3072]----+
2026-09-10 10:56:03.511500 | instance -> localhost | |=X++.o..         |
2026-09-10 10:56:03.511554 | instance -> localhost | |o=Xo+o+ .        |
2026-09-10 10:56:03.511588 | instance -> localhost | |+B.+o .o         |
2026-09-10 10:56:03.511621 | instance -> localhost | |o.+o o o         |
2026-09-10 10:56:03.511653 | instance -> localhost | |=  .o E S        |
2026-09-10 10:56:03.511684 | instance -> localhost | |*o+  . .         |
2026-09-10 10:56:03.511715 | instance -> localhost | | B..             |
2026-09-10 10:56:03.511745 | instance -> localhost | |+  .o.           |
2026-09-10 10:56:03.511775 | instance -> localhost | |.o+=o            |
2026-09-10 10:56:03.511800 | instance -> localhost | +----[SHA256]-----+
2026-09-10 10:56:03.511865 | instance -> localhost | ok: Runtime: 0:00:00.808574
2026-09-10 10:56:03.521344 | 
2026-09-10 10:56:03.521496 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-09-10 10:56:03.551874 | instance | ok
2026-09-10 10:56:03.560955 | instance | included: /var/lib/zuul/builds/7c5447df093443029ded37bd3f0da669/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-09-10 10:56:03.568813 | 
2026-09-10 10:56:03.568939 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-09-10 10:56:03.582085 | instance | skipping: Conditional result was False
2026-09-10 10:56:03.587413 | 
2026-09-10 10:56:03.587558 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-09-10 10:56:04.017806 | instance | changed
2026-09-10 10:56:04.274665 | 
2026-09-10 10:56:04.274810 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-09-10 10:56:04.473567 | instance | ok
2026-09-10 10:56:04.489138 | 
2026-09-10 10:56:04.489324 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-09-10 10:56:05.021347 | instance | changed
2026-09-10 10:56:05.025825 | 
2026-09-10 10:56:05.025896 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-09-10 10:56:05.492378 | instance | changed
2026-09-10 10:56:05.510558 | 
2026-09-10 10:56:05.510686 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-09-10 10:56:05.528801 | instance | skipping: Conditional result was False
2026-09-10 10:56:05.540965 | 
2026-09-10 10:56:05.541139 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-09-10 10:56:05.963335 | instance -> localhost | changed
2026-09-10 10:56:05.973234 | 
2026-09-10 10:56:05.973326 | TASK [add-build-sshkey : Add back temp key]
2026-09-10 10:56:06.266459 | instance -> localhost | Identity added: /var/lib/zuul/builds/7c5447df093443029ded37bd3f0da669/work/7c5447df093443029ded37bd3f0da669_id_rsa (zuul-build-sshkey)
2026-09-10 10:56:06.266655 | instance -> localhost | ok: Runtime: 0:00:00.012507
2026-09-10 10:56:06.272066 | 
2026-09-10 10:56:06.272134 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-09-10 10:56:06.627059 | instance | ok
2026-09-10 10:56:06.631444 | 
2026-09-10 10:56:06.631541 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-09-10 10:56:06.665369 | instance | skipping: Conditional result was False
2026-09-10 10:56:06.679799 | 
2026-09-10 10:56:06.679945 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-09-10 10:56:07.045582 | instance | ok
2026-09-10 10:56:07.052197 | 
2026-09-10 10:56:07.052287 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-09-10 10:56:10.599110 | instance | Output suppressed because no_log was given
2026-09-10 10:56:10.608197 | 
2026-09-10 10:56:10.608376 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-09-10 10:56:10.850158 | instance | ok: "logs"
2026-09-10 10:56:10.850517 | instance | ok: All items complete
2026-09-10 10:56:10.850600 | 
2026-09-10 10:56:11.002035 | instance | ok: "artifacts"
2026-09-10 10:56:11.146610 | instance | ok: "docs"
2026-09-10 10:56:11.169127 | 
2026-09-10 10:56:11.169603 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-09-10 10:56:11.378059 | instance | changed: "logs"
2026-09-10 10:56:11.532099 | instance | changed: "artifacts"
2026-09-10 10:56:11.696353 | instance | changed: "docs"
2026-09-10 10:56:11.707221 | 
2026-09-10 10:56:11.707348 | PLAY RECAP
2026-09-10 10:56:11.707396 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-09-10 10:56:11.707424 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-10 10:56:11.707442 | 
2026-09-10 10:56:11.894890 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-09-10 10:56:11.900001 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-10 10:56:12.573124 | 
2026-09-10 10:56:12.573394 | PLAY [all]
2026-09-10 10:56:12.584929 | 
2026-09-10 10:56:12.585072 | TASK [setup-uv : Extract archive]
2026-09-10 10:56:14.815219 | instance | changed
2026-09-10 10:56:14.823034 | 
2026-09-10 10:56:14.823369 | TASK [setup-uv : Print version]
2026-09-10 10:56:15.172106 | instance | uv 0.8.13
2026-09-10 10:56:15.355350 | instance | ok: Runtime: 0:00:00.016528
2026-09-10 10:56:15.363869 | 
2026-09-10 10:56:15.363972 | TASK [Install Ansible collection siblings]
2026-09-10 10:56:25.162107 | instance | changed:
2026-09-10 10:56:25.162293 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-09-10 10:56:25.162321 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-09-10 10:56:25.162340 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-09-10 10:56:25.162358 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-09-10 10:56:25.162375 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-09-10 10:56:25.162396 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-09-10 10:56:25.162417 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-09-10 10:56:25.162437 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-09-10 10:56:25.162455 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-09-10 10:56:25.162472 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-09-10 10:56:25.162491 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-09-10 10:56:25.162510 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-09-10 10:56:25.162526 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-09-10 10:56:25.162543 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-09-10 10:56:25.162577 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0
2026-09-10 10:56:25.162595 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-09-10 10:56:25.162612 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-09-10 10:56:25.162629 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-09-10 10:56:25.162646 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-09-10 10:56:25.162661 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-09-10 10:56:25.162677 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.1.2
2026-09-10 10:56:25.162692 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-09-10 10:56:25.162710 | instance | Resolved vexxhost.kubernetes to v3.4.0 for >=3.3.0,>=2.5.0
2026-09-10 10:56:25.162735 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-09-10 10:56:25.162753 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0
2026-09-10 10:56:25.162769 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-09-10 10:56:25.162785 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-09-10 10:56:25.162800 | instance | Resolved vexxhost.kubernetes to v3.4.0 for >=3.3.0,>=2.5.0
2026-09-10 10:56:25.162816 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-09-10 10:56:25.162831 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-09-10 10:56:25.162846 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-09-10 10:56:25.162863 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-09-10 10:56:25.162879 | instance | Checked out ansible.netcommon to 1.2.0
2026-09-10 10:56:25.162895 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-09-10 10:56:25.162917 | instance | Starting galaxy collection install process
2026-09-10 10:56:25.162933 | instance | Process install dependency map
2026-09-10 10:56:25.162949 | instance | Starting collection install process
2026-09-10 10:56:25.162965 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-09-10 10:56:25.162980 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-09-10 10:56:25.162996 | instance | ansible.netcommon:* was installed successfully
2026-09-10 10:56:25.163012 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-09-10 10:56:25.163028 | instance | Creating virtual environment at: .venv
2026-09-10 10:56:25.163052 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-09-10 10:56:25.163074 | instance | Downloading cryptography (4.2MiB)
2026-09-10 10:56:25.163091 | instance | Downloading rjsonnet (1.2MiB)
2026-09-10 10:56:25.163111 | instance | Downloading kubernetes (1.9MiB)
2026-09-10 10:56:25.163127 | instance | Downloading ansible-core (2.1MiB)
2026-09-10 10:56:25.163143 | instance | Downloading openstacksdk (1.7MiB)
2026-09-10 10:56:25.163160 | instance | Downloading netaddr (2.2MiB)
2026-09-10 10:56:25.163176 | instance | Downloading pygments (1.2MiB)
2026-09-10 10:56:25.163192 | instance | Downloading setuptools (1.1MiB)
2026-09-10 10:56:25.163207 | instance |    Building pyperclip==1.9.0
2026-09-10 10:56:25.163222 | instance |  Downloading rjsonnet
2026-09-10 10:56:25.163239 | instance |  Downloading netaddr
2026-09-10 10:56:25.163256 | instance |  Downloading cryptography
2026-09-10 10:56:25.163272 | instance |  Downloading pygments
2026-09-10 10:56:25.163289 | instance |  Downloading setuptools
2026-09-10 10:56:25.163304 | instance |  Downloading kubernetes
2026-09-10 10:56:25.163318 | instance |  Downloading ansible-core
2026-09-10 10:56:25.163333 | instance |  Downloading openstacksdk
2026-09-10 10:56:25.163348 | instance |       Built pyperclip==1.9.0
2026-09-10 10:56:25.163364 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-09-10 10:56:25.163380 | instance | Installed 79 packages in 43ms
2026-09-10 10:56:25.163395 | instance | Checked out ansible.posix to 1.6.0
2026-09-10 10:56:25.163411 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-09-10 10:56:25.163428 | instance | Starting galaxy collection install process
2026-09-10 10:56:25.163445 | instance | Process install dependency map
2026-09-10 10:56:25.163460 | instance | Starting collection install process
2026-09-10 10:56:25.163476 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-09-10 10:56:25.163500 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-09-10 10:56:25.163517 | instance | ansible.posix:1.6.0 was installed successfully
2026-09-10 10:56:25.163533 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-10 10:56:25.163566 | instance | 2.17.12
2026-09-10 10:56:25.163584 | instance | Checked out ansible.utils to v6.1.0
2026-09-10 10:56:25.163601 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-09-10 10:56:25.163616 | instance | Starting galaxy collection install process
2026-09-10 10:56:25.163633 | instance | Process install dependency map
2026-09-10 10:56:25.163648 | instance | Starting collection install process
2026-09-10 10:56:25.163664 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-09-10 10:56:25.163869 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-09-10 10:56:25.163885 | instance | ansible.utils:6.1.0 was installed successfully
2026-09-10 10:56:25.163902 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-10 10:56:25.163918 | instance | 2.17.12
2026-09-10 10:56:25.163934 | instance | Checked out atmosphere.common to v0.7.0
2026-09-10 10:56:25.163950 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-09-10 10:56:25.163967 | instance | Starting galaxy collection install process
2026-09-10 10:56:25.163982 | instance | Process install dependency map
2026-09-10 10:56:25.163997 | instance | Starting collection install process
2026-09-10 10:56:25.164013 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-09-10 10:56:25.164028 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-09-10 10:56:25.164044 | instance | atmosphere.common:0.7.0 was installed successfully
2026-09-10 10:56:25.164067 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-10 10:56:25.164091 | instance | 2.17.12
2026-09-10 10:56:25.164108 | instance | Checked out community.crypto to 2.2.3
2026-09-10 10:56:25.164125 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.crypto
2026-09-10 10:56:25.164142 | instance | Starting galaxy collection install process
2026-09-10 10:56:25.164157 | instance | Process install dependency map
2026-09-10 10:56:25.164173 | instance | Starting collection install process
2026-09-10 10:56:25.164188 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-09-10 10:56:25.164204 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-09-10 10:56:25.164219 | instance | community.crypto:2.2.3 was installed successfully
2026-09-10 10:56:25.164235 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-10 10:56:25.164251 | instance | 2.17.12
2026-09-10 10:56:25.164267 | instance | Checked out community.general to 7.3.0
2026-09-10 10:56:25.164284 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.general
2026-09-10 10:56:25.164300 | instance | Starting galaxy collection install process
2026-09-10 10:56:25.164382 | instance | Process install dependency map
2026-09-10 10:56:25.164400 | instance | Starting collection install process
2026-09-10 10:56:25.164417 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-09-10 10:56:25.164432 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-09-10 10:56:25.164448 | instance | community.general:7.3.0 was installed successfully
2026-09-10 10:56:25.164463 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-10 10:56:25.164478 | instance | 2.17.12
2026-09-10 10:56:25.164517 | instance | Checked out community.mysql to 3.6.0
2026-09-10 10:56:25.164537 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.mysql
2026-09-10 10:56:25.164568 | instance | Starting galaxy collection install process
2026-09-10 10:56:25.164588 | instance | Process install dependency map
2026-09-10 10:56:25.164604 | instance | Starting collection install process
2026-09-10 10:56:25.164621 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-09-10 10:56:25.164637 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-09-10 10:56:25.164652 | instance | community.mysql:3.6.0 was installed successfully
2026-09-10 10:56:25.164668 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-10 10:56:25.164684 | instance | 2.17.12
2026-09-10 10:56:25.164700 | instance | Checked out kubernetes.core to 2.4.0
2026-09-10 10:56:25.164716 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-09-10 10:56:25.164731 | instance | Starting galaxy collection install process
2026-09-10 10:56:25.164747 | instance | Process install dependency map
2026-09-10 10:56:25.164762 | instance | Starting collection install process
2026-09-10 10:56:25.164777 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-09-10 10:56:25.164793 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-09-10 10:56:25.164809 | instance | kubernetes.core:2.4.0 was installed successfully
2026-09-10 10:56:25.164824 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-10 10:56:25.164840 | instance | 2.17.12
2026-09-10 10:56:25.164855 | instance | Checked out openstack.cloud to 2.6.0
2026-09-10 10:56:25.164871 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-09-10 10:56:25.164886 | instance | Starting galaxy collection install process
2026-09-10 10:56:25.164901 | instance | Process install dependency map
2026-09-10 10:56:25.164917 | instance | Starting collection install process
2026-09-10 10:56:25.164932 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-09-10 10:56:25.164948 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-09-10 10:56:25.164964 | instance | openstack.cloud:2.6.0 was installed successfully
2026-09-10 10:56:25.164979 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-10 10:56:25.164995 | instance | 2.17.12
2026-09-10 10:56:25.165010 | instance | Checked out vexxhost.ceph to v4.2.0
2026-09-10 10:56:25.165026 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-09-10 10:56:25.165047 | instance | Starting galaxy collection install process
2026-09-10 10:56:25.165063 | instance | Process install dependency map
2026-09-10 10:56:25.165085 | instance | Starting collection install process
2026-09-10 10:56:25.165110 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-09-10 10:56:25.165127 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-09-10 10:56:25.165143 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-09-10 10:56:25.165159 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-10 10:56:25.165175 | instance | 2.17.12
2026-09-10 10:56:25.165190 | instance | Checked out vexxhost.containers to v1.6.8
2026-09-10 10:56:25.165206 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-09-10 10:56:25.165222 | instance | Starting galaxy collection install process
2026-09-10 10:56:25.165284 | instance | Process install dependency map
2026-09-10 10:56:25.165304 | instance | Starting collection install process
2026-09-10 10:56:25.165320 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-09-10 10:56:25.165336 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-09-10 10:56:25.165353 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-09-10 10:56:25.165368 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-10 10:56:25.165383 | instance | 2.17.12
2026-09-10 10:56:25.165399 | instance | Checked out vexxhost.kubernetes to v3.4.0
2026-09-10 10:56:25.165416 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-09-10 10:56:25.165433 | instance | Starting galaxy collection install process
2026-09-10 10:56:25.165449 | instance | Process install dependency map
2026-09-10 10:56:25.165464 | instance | Starting collection install process
2026-09-10 10:56:25.165480 | instance | Installing 'vexxhost.kubernetes:3.4.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-09-10 10:56:25.165495 | instance | Created collection for vexxhost.kubernetes:3.4.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-09-10 10:56:25.165511 | instance | vexxhost.kubernetes:3.4.0 was installed successfully
2026-09-10 10:56:25.165526 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-09-10 10:56:25.165542 | instance | 2.17.12
2026-09-10 10:56:25.171311 | 
2026-09-10 10:56:25.171399 | PLAY RECAP
2026-09-10 10:56:25.171450 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-10 10:56:25.171468 | 
2026-09-10 10:56:25.349787 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-09-10 10:56:25.352363 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-09-10 10:56:26.002859 | 
2026-09-10 10:56:26.003070 | PLAY [all]
2026-09-10 10:56:26.015357 | 
2026-09-10 10:56:26.015546 | TASK [Install "jq" for log collection]
2026-09-10 10:56:38.310111 | instance | changed
2026-09-10 10:56:38.320934 | 
2026-09-10 10:56:38.321140 | PLAY RECAP
2026-09-10 10:56:38.321205 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-09-10 10:56:38.321257 | 
2026-09-10 10:56:38.480485 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-09-10 10:56:38.485064 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-10 10:56:39.121174 | 
2026-09-10 10:56:39.121395 | PLAY [all]
2026-09-10 10:56:39.133686 | 
2026-09-10 10:56:39.133863 | LOOP [Check inventory directories]
2026-09-10 10:56:39.532679 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-09-10 10:56:39.693531 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-09-10 10:56:39.875893 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-09-10 10:56:39.888558 | 
2026-09-10 10:56:39.888897 | LOOP [Copy inventory file for Zuul]
2026-09-10 10:56:40.761849 | instance | changed:
2026-09-10 10:56:40.762025 | instance | {
2026-09-10 10:56:40.762051 | instance |   "ansible_loop_var": "item",
2026-09-10 10:56:40.762071 | instance |   "changed": false,
2026-09-10 10:56:40.762088 | instance |   "failed": false,
2026-09-10 10:56:40.762106 | instance |   "invocation": {
2026-09-10 10:56:40.762122 | instance |     "module_args": {
2026-09-10 10:56:40.762138 | instance |       "checksum_algorithm": "sha1",
2026-09-10 10:56:40.762154 | instance |       "follow": true,
2026-09-10 10:56:40.762169 | instance |       "get_attributes": true,
2026-09-10 10:56:40.762185 | instance |       "get_checksum": true,
2026-09-10 10:56:40.762201 | instance |       "get_mime": true,
2026-09-10 10:56:40.762216 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-09-10 10:56:40.762235 | instance |     }
2026-09-10 10:56:40.762252 | instance |   },
2026-09-10 10:56:40.762268 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-09-10 10:56:40.762283 | instance |   "stat": {
2026-09-10 10:56:40.762299 | instance |     "atime": 1789037777.7018955,
2026-09-10 10:56:40.762317 | instance |     "attr_flags": "e",
2026-09-10 10:56:40.762333 | instance |     "attributes": [
2026-09-10 10:56:40.762349 | instance |       "extents"
2026-09-10 10:56:40.762363 | instance |     ],
2026-09-10 10:56:40.762380 | instance |     "block_size": 4096,
2026-09-10 10:56:40.762395 | instance |     "blocks": 8,
2026-09-10 10:56:40.762411 | instance |     "charset": "unknown",
2026-09-10 10:56:40.762428 | instance |     "ctime": 1789037776.133865,
2026-09-10 10:56:40.762443 | instance |     "dev": 64513,
2026-09-10 10:56:40.762459 | instance |     "device_type": 0,
2026-09-10 10:56:40.762474 | instance |     "executable": true,
2026-09-10 10:56:40.762490 | instance |     "exists": true,
2026-09-10 10:56:40.762506 | instance |     "gid": 1000,
2026-09-10 10:56:40.762523 | instance |     "gr_name": "zuul",
2026-09-10 10:56:40.762539 | instance |     "inode": 1049079,
2026-09-10 10:56:40.762555 | instance |     "isblk": false,
2026-09-10 10:56:40.762570 | instance |     "ischr": false,
2026-09-10 10:56:40.762599 | instance |     "isdir": true,
2026-09-10 10:56:40.762615 | instance |     "isfifo": false,
2026-09-10 10:56:40.762630 | instance |     "isgid": false,
2026-09-10 10:56:40.762645 | instance |     "islnk": false,
2026-09-10 10:56:40.762663 | instance |     "isreg": false,
2026-09-10 10:56:40.762677 | instance |     "issock": false,
2026-09-10 10:56:40.762691 | instance |     "isuid": false,
2026-09-10 10:56:40.762705 | instance |     "mimetype": "unknown",
2026-09-10 10:56:40.762719 | instance |     "mode": "0755",
2026-09-10 10:56:40.762733 | instance |     "mtime": 1789037776.133865,
2026-09-10 10:56:40.762747 | instance |     "nlink": 21,
2026-09-10 10:56:40.762761 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-09-10 10:56:40.762776 | instance |     "pw_name": "zuul",
2026-09-10 10:56:40.762796 | instance |     "readable": true,
2026-09-10 10:56:40.762813 | instance |     "rgrp": true,
2026-09-10 10:56:40.762827 | instance |     "roth": true,
2026-09-10 10:56:40.762842 | instance |     "rusr": true,
2026-09-10 10:56:40.762856 | instance |     "size": 4096,
2026-09-10 10:56:40.762870 | instance |     "uid": 1000,
2026-09-10 10:56:40.762899 | instance |     "version": "1834152190",
2026-09-10 10:56:40.762914 | instance |     "wgrp": false,
2026-09-10 10:56:40.764475 | instance |     "woth": false,
2026-09-10 10:56:40.764554 | instance |     "writeable": true,
2026-09-10 10:56:40.764573 | instance |     "wusr": true,
2026-09-10 10:56:40.764605 | instance |     "xgrp": true,
2026-09-10 10:56:40.764621 | instance |     "xoth": true,
2026-09-10 10:56:40.764635 | instance |     "xusr": true
2026-09-10 10:56:40.764650 | instance |   }
2026-09-10 10:56:40.764665 | instance | }
2026-09-10 10:56:40.764698 | instance | ok: All items complete
2026-09-10 10:56:40.764716 | 
2026-09-10 10:56:40.765863 | instance | skipping: Conditional result was False
2026-09-10 10:56:40.772817 | instance | skipping: Conditional result was False
2026-09-10 10:56:40.795030 | 
2026-09-10 10:56:40.795194 | LOOP [Switch "ansible_host" to private IP]
2026-09-10 10:56:41.189713 | instance | changed: 1 replacements made
2026-09-10 10:56:41.190831 | instance | skipping: Conditional result was False
2026-09-10 10:56:41.194361 | instance | skipping: Conditional result was False
2026-09-10 10:56:41.215951 | 
2026-09-10 10:56:41.216104 | TASK [Run Molecule scenario]
2026-09-10 10:56:42.188304 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-09-10 10:56:42.669269 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-09-10 10:56:42.669375 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-09-10 10:56:54.515414 | instance | INFO     [csi > dependency] Executing
2026-09-10 10:56:54.515845 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-09-10 10:56:54.516346 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-09-10 10:56:54.516646 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-09-10 10:56:54.535752 | instance | INFO     [csi > cleanup] Executing
2026-09-10 10:56:54.536552 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-09-10 10:56:54.548031 | instance | INFO     [csi > destroy] Executing
2026-09-10 10:56:54.548146 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-09-10 10:56:54.548169 | instance | INFO     [csi > destroy] Executed: Successful
2026-09-10 10:56:54.557992 | instance | INFO     [csi > syntax] Executing
2026-09-10 10:56:56.196264 | instance |
2026-09-10 10:56:56.196425 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-09-10 10:56:56.318429 | instance | INFO     [csi > syntax] Executed: Successful
2026-09-10 10:56:56.333297 | instance | INFO     [csi > create] Executing
2026-09-10 10:56:56.335925 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-09-10 10:56:56.346612 | instance | INFO     [csi > prepare] Executing
2026-09-10 10:56:57.233258 | instance |
2026-09-10 10:56:57.233357 | instance | PLAY [Prepare] *****************************************************************
2026-09-10 10:56:57.233406 | instance |
2026-09-10 10:56:57.233527 | instance | TASK [Gathering Facts] *********************************************************
2026-09-10 10:56:57.233637 | instance | Thursday 10 September 2026  10:56:57 +0000 (0:00:00.026)       0:00:00.026 ****
2026-09-10 10:56:58.537572 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-09-10 10:56:58.537852 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-09-10 10:56:58.538061 | instance | interpreter could change the meaning of that path. See
2026-09-10 10:56:58.538286 | instance | https://docs.ansible.com/ansible-
2026-09-10 10:56:58.538487 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-09-10 10:56:58.542460 | instance | ok: [instance]
2026-09-10 10:56:58.542661 | instance |
2026-09-10 10:56:58.542861 | instance | TASK [Configure short hostname] ************************************************
2026-09-10 10:56:58.543056 | instance | Thursday 10 September 2026  10:56:58 +0000 (0:00:01.310)       0:00:01.336 ****
2026-09-10 10:56:59.300369 | instance | changed: [instance]
2026-09-10 10:56:59.300763 | instance |
2026-09-10 10:56:59.301271 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-09-10 10:56:59.301613 | instance | Thursday 10 September 2026  10:56:59 +0000 (0:00:00.757)       0:00:02.093 ****
2026-09-10 10:56:59.624076 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-09-10 10:56:59.624481 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-09-10 10:56:59.624827 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-09-10 10:56:59.633627 | instance | changed: [instance]
2026-09-10 10:56:59.633943 | instance |
2026-09-10 10:56:59.634285 | instance | TASK [Purge "snapd" package] ***************************************************
2026-09-10 10:56:59.634586 | instance | Thursday 10 September 2026  10:56:59 +0000 (0:00:00.333)       0:00:02.427 ****
2026-09-10 10:57:00.468112 | instance | ok: [instance]
2026-09-10 10:57:00.468201 | instance |
2026-09-10 10:57:00.468216 | instance | PLAY [Create devices for Ceph] *************************************************
2026-09-10 10:57:00.468541 | instance |
2026-09-10 10:57:00.468976 | instance | TASK [Gathering Facts] *********************************************************
2026-09-10 10:57:00.469388 | instance | Thursday 10 September 2026  10:57:00 +0000 (0:00:00.833)       0:00:03.261 ****
2026-09-10 10:57:01.191665 | instance | ok: [instance]
2026-09-10 10:57:01.191874 | instance |
2026-09-10 10:57:01.192377 | instance | TASK [Install depedencies] *****************************************************
2026-09-10 10:57:01.192737 | instance | Thursday 10 September 2026  10:57:01 +0000 (0:00:00.723)       0:00:03.984 ****
2026-09-10 10:57:25.753671 | instance | changed: [instance]
2026-09-10 10:57:25.753775 | instance |
2026-09-10 10:57:25.753921 | instance | TASK [Start up service] ********************************************************
2026-09-10 10:57:25.754095 | instance | Thursday 10 September 2026  10:57:25 +0000 (0:00:24.562)       0:00:28.547 ****
2026-09-10 10:57:26.356070 | instance | ok: [instance]
2026-09-10 10:57:26.356367 | instance |
2026-09-10 10:57:26.356646 | instance | TASK [Generate lvm.conf] *******************************************************
2026-09-10 10:57:26.357020 | instance | Thursday 10 September 2026  10:57:26 +0000 (0:00:00.602)       0:00:29.149 ****
2026-09-10 10:57:26.678441 | instance | ok: [instance]
2026-09-10 10:57:26.678678 | instance |
2026-09-10 10:57:26.679014 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-09-10 10:57:26.679393 | instance | Thursday 10 September 2026  10:57:26 +0000 (0:00:00.321)       0:00:29.471 ****
2026-09-10 10:57:27.394664 | instance | changed: [instance]
2026-09-10 10:57:27.394742 | instance |
2026-09-10 10:57:27.394755 | instance | TASK [Get list of all loopback devices] ****************************************
2026-09-10 10:57:27.394766 | instance | Thursday 10 September 2026  10:57:27 +0000 (0:00:00.716)       0:00:30.187 ****
2026-09-10 10:57:27.598469 | instance | ok: [instance]
2026-09-10 10:57:27.598577 | instance |
2026-09-10 10:57:27.598940 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-09-10 10:57:27.599000 | instance | Thursday 10 September 2026  10:57:27 +0000 (0:00:00.204)       0:00:30.392 ****
2026-09-10 10:57:27.626420 | instance | skipping: [instance]
2026-09-10 10:57:27.626918 | instance |
2026-09-10 10:57:27.626981 | instance | TASK [Create devices for Ceph] *************************************************
2026-09-10 10:57:27.626991 | instance | Thursday 10 September 2026  10:57:27 +0000 (0:00:00.027)       0:00:30.419 ****
2026-09-10 10:57:28.195861 | instance | changed: [instance] => (item=osd0)
2026-09-10 10:57:28.195943 | instance | changed: [instance] => (item=osd1)
2026-09-10 10:57:28.196589 | instance | changed: [instance] => (item=osd2)
2026-09-10 10:57:28.196649 | instance |
2026-09-10 10:57:28.196657 | instance | TASK [Set permissions on loopback devices] *************************************
2026-09-10 10:57:28.196664 | instance | Thursday 10 September 2026  10:57:28 +0000 (0:00:00.570)       0:00:30.989 ****
2026-09-10 10:57:28.888247 | instance | changed: [instance] => (item=osd0)
2026-09-10 10:57:28.888326 | instance | changed: [instance] => (item=osd1)
2026-09-10 10:57:28.888342 | instance | changed: [instance] => (item=osd2)
2026-09-10 10:57:28.888356 | instance |
2026-09-10 10:57:28.888369 | instance | TASK [Start loop devices] ******************************************************
2026-09-10 10:57:28.888382 | instance | Thursday 10 September 2026  10:57:28 +0000 (0:00:00.689)       0:00:31.679 ****
2026-09-10 10:57:29.610791 | instance | changed: [instance] => (item=osd0)
2026-09-10 10:57:29.611068 | instance | changed: [instance] => (item=osd1)
2026-09-10 10:57:29.611080 | instance | changed: [instance] => (item=osd2)
2026-09-10 10:57:29.611593 | instance |
2026-09-10 10:57:29.611656 | instance | TASK [Create a volume group for each loop device] ******************************
2026-09-10 10:57:29.611665 | instance | Thursday 10 September 2026  10:57:29 +0000 (0:00:00.725)       0:00:32.404 ****
2026-09-10 10:57:32.813451 | instance | changed: [instance] => (item=osd0)
2026-09-10 10:57:32.813522 | instance | changed: [instance] => (item=osd1)
2026-09-10 10:57:32.813533 | instance | changed: [instance] => (item=osd2)
2026-09-10 10:57:32.813543 | instance |
2026-09-10 10:57:32.813553 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-09-10 10:57:32.813563 | instance | Thursday 10 September 2026  10:57:32 +0000 (0:00:03.201)       0:00:35.605 ****
2026-09-10 10:57:34.853508 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-09-10 10:57:34.854350 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-09-10 10:57:34.854397 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-09-10 10:57:34.854412 | instance |
2026-09-10 10:57:34.854784 | instance | PLAY RECAP *********************************************************************
2026-09-10 10:57:34.856879 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-09-10 10:57:34.856913 | instance |
2026-09-10 10:57:34.856925 | instance | Thursday 10 September 2026  10:57:34 +0000 (0:00:02.041)       0:00:37.647 ****
2026-09-10 10:57:34.856935 | instance | ===============================================================================
2026-09-10 10:57:34.856944 | instance | Install depedencies ---------------------------------------------------- 24.56s
2026-09-10 10:57:34.856953 | instance | Create a volume group for each loop device ------------------------------ 3.20s
2026-09-10 10:57:34.856962 | instance | Create a logical volume for each loop device ---------------------------- 2.04s
2026-09-10 10:57:34.856977 | instance | Gathering Facts --------------------------------------------------------- 1.31s
2026-09-10 10:57:34.857261 | instance | Purge "snapd" package --------------------------------------------------- 0.83s
2026-09-10 10:57:34.857645 | instance | Configure short hostname ------------------------------------------------ 0.76s
2026-09-10 10:57:34.858076 | instance | Start loop devices ------------------------------------------------------ 0.73s
2026-09-10 10:57:34.858428 | instance | Gathering Facts --------------------------------------------------------- 0.72s
2026-09-10 10:57:34.858734 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.72s
2026-09-10 10:57:34.859184 | instance | Set permissions on loopback devices ------------------------------------- 0.69s
2026-09-10 10:57:34.859507 | instance | Start up service -------------------------------------------------------- 0.60s
2026-09-10 10:57:34.859804 | instance | Create devices for Ceph ------------------------------------------------- 0.57s
2026-09-10 10:57:34.860241 | instance | Ensure hostname inside hosts file --------------------------------------- 0.33s
2026-09-10 10:57:34.860570 | instance | Generate lvm.conf ------------------------------------------------------- 0.32s
2026-09-10 10:57:34.860969 | instance | Get list of all loopback devices ---------------------------------------- 0.20s
2026-09-10 10:57:34.861432 | instance | Fail if there is any existing loopback devices -------------------------- 0.03s
2026-09-10 10:57:34.959394 | instance | INFO     [csi > prepare] Executed: Successful
2026-09-10 10:57:34.968675 | instance | INFO     [csi > converge] Executing
2026-09-10 10:57:36.477559 | instance |
2026-09-10 10:57:36.477852 | instance | PLAY [Debug CSI driver value] **************************************************
2026-09-10 10:57:36.478078 | instance |
2026-09-10 10:57:36.478330 | instance | TASK [Gathering Facts] *********************************************************
2026-09-10 10:57:36.478549 | instance | Thursday 10 September 2026  10:57:36 +0000 (0:00:00.008)       0:00:00.008 ****
2026-09-10 10:57:37.573732 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-09-10 10:57:37.574008 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-09-10 10:57:37.574253 | instance | interpreter could change the meaning of that path. See
2026-09-10 10:57:37.574508 | instance | https://docs.ansible.com/ansible-
2026-09-10 10:57:37.574777 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-09-10 10:57:37.589631 | instance | ok: [instance]
2026-09-10 10:57:37.590000 | instance |
2026-09-10 10:57:37.590347 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-09-10 10:57:37.590697 | instance | Thursday 10 September 2026  10:57:37 +0000 (0:00:01.111)       0:00:01.119 ****
2026-09-10 10:57:37.645742 | instance | ok: [instance] => {
2026-09-10 10:57:37.646162 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-09-10 10:57:37.646482 | instance | }
2026-09-10 10:57:37.646810 | instance |
2026-09-10 10:57:37.647119 | instance | PLAY [all] *********************************************************************
2026-09-10 10:57:37.647500 | instance |
2026-09-10 10:57:37.647908 | instance | TASK [Gathering Facts] *********************************************************
2026-09-10 10:57:37.648423 | instance | Thursday 10 September 2026  10:57:37 +0000 (0:00:00.056)       0:00:01.176 ****
2026-09-10 10:57:38.518366 | instance | ok: [instance]
2026-09-10 10:57:38.518775 | instance |
2026-09-10 10:57:38.519090 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-09-10 10:57:38.519450 | instance | Thursday 10 September 2026  10:57:38 +0000 (0:00:00.872)       0:00:02.048 ****
2026-09-10 10:57:38.680330 | instance | ok: [instance]
2026-09-10 10:57:38.680525 | instance |
2026-09-10 10:57:38.680666 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-09-10 10:57:38.680853 | instance |
2026-09-10 10:57:38.681005 | instance | TASK [Gathering Facts] *********************************************************
2026-09-10 10:57:38.681200 | instance | Thursday 10 September 2026  10:57:38 +0000 (0:00:00.162)       0:00:02.211 ****
2026-09-10 10:57:39.601112 | instance | ok: [instance]
2026-09-10 10:57:39.601693 | instance |
2026-09-10 10:57:39.602112 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-10 10:57:39.602548 | instance | Thursday 10 September 2026  10:57:39 +0000 (0:00:00.920)       0:00:03.131 ****
2026-09-10 10:57:39.904732 | instance | ok: [instance]
2026-09-10 10:57:39.905314 | instance |
2026-09-10 10:57:39.905759 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-10 10:57:39.906236 | instance | Thursday 10 September 2026  10:57:39 +0000 (0:00:00.303)       0:00:03.434 ****
2026-09-10 10:57:39.953613 | instance | skipping: [instance]
2026-09-10 10:57:39.953728 | instance |
2026-09-10 10:57:39.953936 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-09-10 10:57:39.954217 | instance | Thursday 10 September 2026  10:57:39 +0000 (0:00:00.047)       0:00:03.482 ****
2026-09-10 10:57:40.285253 | instance | changed: [instance]
2026-09-10 10:57:40.285512 | instance |
2026-09-10 10:57:40.285738 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-10 10:57:40.285943 | instance | Thursday 10 September 2026  10:57:40 +0000 (0:00:00.330)       0:00:03.813 ****
2026-09-10 10:57:40.372737 | instance | ok: [instance] => {
2026-09-10 10:57:40.372832 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-09-10 10:57:40.372847 | instance | }
2026-09-10 10:57:40.372857 | instance |
2026-09-10 10:57:40.372866 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-10 10:57:40.372876 | instance | Thursday 10 September 2026  10:57:40 +0000 (0:00:00.088)       0:00:03.902 ****
2026-09-10 10:57:41.064422 | instance | changed: [instance]
2026-09-10 10:57:41.064494 | instance |
2026-09-10 10:57:41.064506 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-10 10:57:41.064516 | instance | Thursday 10 September 2026  10:57:41 +0000 (0:00:00.691)       0:00:04.593 ****
2026-09-10 10:57:41.118595 | instance | skipping: [instance]
2026-09-10 10:57:41.118684 | instance |
2026-09-10 10:57:41.118864 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-10 10:57:41.119106 | instance | Thursday 10 September 2026  10:57:41 +0000 (0:00:00.055)       0:00:04.649 ****
2026-09-10 10:57:41.167775 | instance | skipping: [instance]
2026-09-10 10:57:41.167922 | instance |
2026-09-10 10:57:41.168132 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-10 10:57:41.168396 | instance | Thursday 10 September 2026  10:57:41 +0000 (0:00:00.049)       0:00:04.698 ****
2026-09-10 10:57:41.399807 | instance | ok: [instance]
2026-09-10 10:57:41.399973 | instance |
2026-09-10 10:57:41.400251 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-09-10 10:57:41.400513 | instance | Thursday 10 September 2026  10:57:41 +0000 (0:00:00.231)       0:00:04.930 ****
2026-09-10 10:57:42.915331 | instance | ok: [instance]
2026-09-10 10:57:42.915973 | instance |
2026-09-10 10:57:42.916559 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-10 10:57:42.917101 | instance | Thursday 10 September 2026  10:57:42 +0000 (0:00:01.515)       0:00:06.445 ****
2026-09-10 10:57:43.014640 | instance | ok: [instance] => {
2026-09-10 10:57:43.014710 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-09-10 10:57:43.014736 | instance | }
2026-09-10 10:57:43.014746 | instance |
2026-09-10 10:57:43.014755 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-10 10:57:43.014765 | instance | Thursday 10 September 2026  10:57:43 +0000 (0:00:00.097)       0:00:06.543 ****
2026-09-10 10:57:43.661416 | instance | changed: [instance]
2026-09-10 10:57:43.661518 | instance |
2026-09-10 10:57:43.661529 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-10 10:57:43.661536 | instance | Thursday 10 September 2026  10:57:43 +0000 (0:00:00.646)       0:00:07.190 ****
2026-09-10 10:57:46.793944 | instance | changed: [instance]
2026-09-10 10:57:46.794046 | instance |
2026-09-10 10:57:46.794191 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-09-10 10:57:46.794354 | instance | Thursday 10 September 2026  10:57:46 +0000 (0:00:03.133)       0:00:10.324 ****
2026-09-10 10:57:46.834365 | instance | skipping: [instance]
2026-09-10 10:57:46.834510 | instance |
2026-09-10 10:57:46.834890 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-09-10 10:57:46.835320 | instance | Thursday 10 September 2026  10:57:46 +0000 (0:00:00.040)       0:00:10.364 ****
2026-09-10 10:57:46.881122 | instance | skipping: [instance]
2026-09-10 10:57:46.881250 | instance |
2026-09-10 10:57:46.881824 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-09-10 10:57:46.882045 | instance | Thursday 10 September 2026  10:57:46 +0000 (0:00:00.046)       0:00:10.411 ****
2026-09-10 10:57:46.931644 | instance | skipping: [instance]
2026-09-10 10:57:46.931760 | instance |
2026-09-10 10:57:46.931879 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-09-10 10:57:46.932044 | instance | Thursday 10 September 2026  10:57:46 +0000 (0:00:00.050)       0:00:10.461 ****
2026-09-10 10:57:53.090589 | instance | changed: [instance]
2026-09-10 10:57:53.090695 | instance |
2026-09-10 10:57:53.090703 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-09-10 10:57:53.090710 | instance | Thursday 10 September 2026  10:57:53 +0000 (0:00:06.158)       0:00:16.620 ****
2026-09-10 10:57:53.742793 | instance | changed: [instance]
2026-09-10 10:57:53.743533 | instance |
2026-09-10 10:57:53.743605 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-09-10 10:57:53.743619 | instance | Thursday 10 September 2026  10:57:53 +0000 (0:00:00.652)       0:00:17.273 ****
2026-09-10 10:57:54.818034 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-09-10 10:57:54.818143 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-09-10 10:57:54.819270 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-09-10 10:57:54.819343 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-09-10 10:57:54.819352 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-09-10 10:57:54.819359 | instance |
2026-09-10 10:57:54.819372 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-09-10 10:57:54.819379 | instance | Thursday 10 September 2026  10:57:54 +0000 (0:00:01.075)       0:00:18.348 ****
2026-09-10 10:57:55.456567 | instance | changed: [instance]
2026-09-10 10:57:55.456677 | instance |
2026-09-10 10:57:55.456926 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-09-10 10:57:55.457018 | instance | Thursday 10 September 2026  10:57:55 +0000 (0:00:00.618)       0:00:18.966 ****
2026-09-10 10:57:55.457484 | instance |
2026-09-10 10:57:55.457538 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-09-10 10:57:55.457546 | instance | Thursday 10 September 2026  10:57:55 +0000 (0:00:00.020)       0:00:18.987 ****
2026-09-10 10:57:56.511105 | instance | ok: [instance]
2026-09-10 10:57:56.511222 | instance |
2026-09-10 10:57:56.511688 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-09-10 10:57:56.511889 | instance | Thursday 10 September 2026  10:57:56 +0000 (0:00:01.054)       0:00:20.042 ****
2026-09-10 10:57:56.982863 | instance | changed: [instance]
2026-09-10 10:57:56.982994 | instance |
2026-09-10 10:57:56.983065 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-09-10 10:57:56.983230 | instance | Thursday 10 September 2026  10:57:56 +0000 (0:00:00.471)       0:00:20.513 ****
2026-09-10 10:57:57.598453 | instance | changed: [instance]
2026-09-10 10:57:57.598523 | instance |
2026-09-10 10:57:57.598881 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-09-10 10:57:57.598906 | instance | Thursday 10 September 2026  10:57:57 +0000 (0:00:00.615)       0:00:21.129 ****
2026-09-10 10:57:57.825486 | instance | ok: [instance]
2026-09-10 10:57:57.825629 | instance |
2026-09-10 10:57:57.826128 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-09-10 10:57:57.826218 | instance | Thursday 10 September 2026  10:57:57 +0000 (0:00:00.226)       0:00:21.356 ****
2026-09-10 10:57:57.914815 | instance | ok: [instance] => {
2026-09-10 10:57:57.916185 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-09-10 10:57:57.916250 | instance | }
2026-09-10 10:57:57.916262 | instance |
2026-09-10 10:57:57.916275 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-09-10 10:57:57.916289 | instance | Thursday 10 September 2026  10:57:57 +0000 (0:00:00.089)       0:00:21.445 ****
2026-09-10 10:58:00.868890 | instance | changed: [instance]
2026-09-10 10:58:00.868951 | instance |
2026-09-10 10:58:00.868959 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-09-10 10:58:00.868966 | instance | Thursday 10 September 2026  10:58:00 +0000 (0:00:02.954)       0:00:24.399 ****
2026-09-10 10:58:05.306766 | instance | changed: [instance]
2026-09-10 10:58:05.306822 | instance |
2026-09-10 10:58:05.306830 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-09-10 10:58:05.306837 | instance | Thursday 10 September 2026  10:58:05 +0000 (0:00:04.438)       0:00:28.837 ****
2026-09-10 10:58:06.654530 | instance | ok: [instance]
2026-09-10 10:58:06.654635 | instance |
2026-09-10 10:58:06.654950 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-09-10 10:58:06.655025 | instance | Thursday 10 September 2026  10:58:06 +0000 (0:00:01.346)       0:00:30.183 ****
2026-09-10 10:58:07.063376 | instance | changed: [instance]
2026-09-10 10:58:07.064110 | instance |
2026-09-10 10:58:07.064241 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-09-10 10:58:07.064256 | instance | Thursday 10 September 2026  10:58:07 +0000 (0:00:00.410)       0:00:30.593 ****
2026-09-10 10:58:07.551792 | instance | changed: [instance]
2026-09-10 10:58:07.551845 | instance |
2026-09-10 10:58:07.551853 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-09-10 10:58:07.551860 | instance | Thursday 10 September 2026  10:58:07 +0000 (0:00:00.488)       0:00:31.082 ****
2026-09-10 10:58:08.107650 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-09-10 10:58:08.107698 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-09-10 10:58:08.107706 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-09-10 10:58:08.107712 | instance |
2026-09-10 10:58:08.107718 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-09-10 10:58:08.107723 | instance | Thursday 10 September 2026  10:58:08 +0000 (0:00:00.555)       0:00:31.638 ****
2026-09-10 10:58:08.615863 | instance | changed: [instance]
2026-09-10 10:58:08.615933 | instance |
2026-09-10 10:58:08.615945 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-09-10 10:58:08.615955 | instance | Thursday 10 September 2026  10:58:08 +0000 (0:00:00.506)       0:00:32.144 ****
2026-09-10 10:58:09.120949 | instance | changed: [instance]
2026-09-10 10:58:09.121027 | instance |
2026-09-10 10:58:09.121032 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-09-10 10:58:09.121038 | instance | Thursday 10 September 2026  10:58:09 +0000 (0:00:00.492)       0:00:32.637 ****
2026-09-10 10:58:09.121042 | instance |
2026-09-10 10:58:09.121062 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-09-10 10:58:09.121066 | instance | Thursday 10 September 2026  10:58:09 +0000 (0:00:00.014)       0:00:32.651 ****
2026-09-10 10:58:09.926205 | instance | ok: [instance]
2026-09-10 10:58:09.926962 | instance |
2026-09-10 10:58:09.926994 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-09-10 10:58:09.927016 | instance | Thursday 10 September 2026  10:58:09 +0000 (0:00:00.802)       0:00:33.454 ****
2026-09-10 10:58:10.978902 | instance | changed: [instance]
2026-09-10 10:58:10.979671 | instance |
2026-09-10 10:58:10.979750 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-09-10 10:58:10.979763 | instance | Thursday 10 September 2026  10:58:10 +0000 (0:00:01.054)       0:00:34.509 ****
2026-09-10 10:58:11.636518 | instance | changed: [instance]
2026-09-10 10:58:11.636622 | instance |
2026-09-10 10:58:11.637200 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-09-10 10:58:11.637264 | instance | Thursday 10 September 2026  10:58:11 +0000 (0:00:00.657)       0:00:35.167 ****
2026-09-10 10:58:11.711696 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-09-10 10:58:11.711840 | instance |
2026-09-10 10:58:11.712165 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-09-10 10:58:11.712238 | instance | Thursday 10 September 2026  10:58:11 +0000 (0:00:00.075)       0:00:35.242 ****
2026-09-10 10:58:17.637826 | instance | changed: [instance]
2026-09-10 10:58:17.637947 | instance |
2026-09-10 10:58:17.638310 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-09-10 10:58:17.638376 | instance | Thursday 10 September 2026  10:58:17 +0000 (0:00:05.925)       0:00:41.167 ****
2026-09-10 10:58:18.360834 | instance | ok: [instance] => (item=chronyd)
2026-09-10 10:58:18.361442 | instance | ok: [instance] => (item=sshd)
2026-09-10 10:58:18.361674 | instance |
2026-09-10 10:58:18.361684 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-09-10 10:58:18.361690 | instance | Thursday 10 September 2026  10:58:18 +0000 (0:00:00.723)       0:00:41.891 ****
2026-09-10 10:58:30.774703 | instance | changed: [instance]
2026-09-10 10:58:30.774788 | instance |
2026-09-10 10:58:30.774801 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-09-10 10:58:30.774812 | instance | Thursday 10 September 2026  10:58:30 +0000 (0:00:12.412)       0:00:54.303 ****
2026-09-10 10:58:31.013952 | instance | ok: [instance]
2026-09-10 10:58:31.014040 | instance |
2026-09-10 10:58:31.014053 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-09-10 10:58:31.014065 | instance | Thursday 10 September 2026  10:58:31 +0000 (0:00:00.239)       0:00:54.542 ****
2026-09-10 10:58:31.520114 | instance | changed: [instance]
2026-09-10 10:58:31.520199 | instance |
2026-09-10 10:58:31.520612 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-09-10 10:58:31.520689 | instance | Thursday 10 September 2026  10:58:31 +0000 (0:00:00.507)       0:00:55.050 ****
2026-09-10 10:58:31.914161 | instance | changed: [instance]
2026-09-10 10:58:31.914264 | instance |
2026-09-10 10:58:31.914520 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-09-10 10:58:31.914569 | instance | Thursday 10 September 2026  10:58:31 +0000 (0:00:00.394)       0:00:55.445 ****
2026-09-10 10:58:32.053448 | instance | ok: [instance]
2026-09-10 10:58:32.053508 | instance |
2026-09-10 10:58:32.053514 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-09-10 10:58:32.053519 | instance | Thursday 10 September 2026  10:58:32 +0000 (0:00:00.138)       0:00:55.583 ****
2026-09-10 10:58:32.308918 | instance | ok: [instance] => (item=instance)
2026-09-10 10:58:32.309004 | instance |
2026-09-10 10:58:32.309011 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-09-10 10:58:32.309022 | instance | Thursday 10 September 2026  10:58:32 +0000 (0:00:00.256)       0:00:55.839 ****
2026-09-10 10:58:32.372054 | instance | ok: [instance]
2026-09-10 10:58:32.372133 | instance |
2026-09-10 10:58:32.372377 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-09-10 10:58:32.372425 | instance | Thursday 10 September 2026  10:58:32 +0000 (0:00:00.063)       0:00:55.902 ****
2026-09-10 10:58:32.464530 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-09-10 10:58:32.464661 | instance |
2026-09-10 10:58:32.465014 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-09-10 10:58:32.465143 | instance | Thursday 10 September 2026  10:58:32 +0000 (0:00:00.092)       0:00:55.995 ****
2026-09-10 10:58:32.858435 | instance | changed: [instance]
2026-09-10 10:58:32.858499 | instance |
2026-09-10 10:58:32.858508 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-09-10 10:58:32.858514 | instance | Thursday 10 September 2026  10:58:32 +0000 (0:00:00.393)       0:00:56.388 ****
2026-09-10 10:58:33.576461 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-09-10 10:58:33.576638 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-09-10 10:58:33.577659 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-09-10 10:58:33.577727 | instance |
2026-09-10 10:58:33.577740 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-09-10 10:58:33.577750 | instance | Thursday 10 September 2026  10:58:33 +0000 (0:00:00.718)       0:00:57.107 ****
2026-09-10 11:00:03.925513 | instance | ok: [instance]
2026-09-10 11:00:03.926231 | instance |
2026-09-10 11:00:03.926243 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-09-10 11:00:03.926253 | instance | Thursday 10 September 2026  11:00:03 +0000 (0:01:30.348)       0:02:27.455 ****
2026-09-10 11:00:04.172848 | instance | changed: [instance]
2026-09-10 11:00:04.173057 | instance |
2026-09-10 11:00:04.173347 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-09-10 11:00:04.173608 | instance | Thursday 10 September 2026  11:00:04 +0000 (0:00:00.247)       0:02:27.703 ****
2026-09-10 11:00:04.221637 | instance | ok: [instance]
2026-09-10 11:00:04.221805 | instance |
2026-09-10 11:00:04.222046 | instance | TASK [Install Ceph host] *******************************************************
2026-09-10 11:00:04.222323 | instance | Thursday 10 September 2026  11:00:04 +0000 (0:00:00.048)       0:02:27.751 ****
2026-09-10 11:00:04.325432 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-09-10 11:00:04.325506 | instance |
2026-09-10 11:00:04.325514 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-09-10 11:00:04.325519 | instance | Thursday 10 September 2026  11:00:04 +0000 (0:00:00.103)       0:02:27.855 ****
2026-09-10 11:00:06.103728 | instance | ok: [instance]
2026-09-10 11:00:06.103802 | instance |
2026-09-10 11:00:06.103810 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-09-10 11:00:06.103817 | instance | Thursday 10 September 2026  11:00:06 +0000 (0:00:01.778)       0:02:29.634 ****
2026-09-10 11:00:06.160444 | instance | ok: [instance] => (item=instance)
2026-09-10 11:00:06.160500 | instance |
2026-09-10 11:00:06.160507 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-09-10 11:00:06.160512 | instance | Thursday 10 September 2026  11:00:06 +0000 (0:00:00.056)       0:02:29.691 ****
2026-09-10 11:00:06.635046 | instance | ok: [instance]
2026-09-10 11:00:06.635113 | instance |
2026-09-10 11:00:06.635125 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-09-10 11:00:06.635160 | instance | Thursday 10 September 2026  11:00:06 +0000 (0:00:00.472)       0:02:30.164 ****
2026-09-10 11:00:08.966474 | instance | ok: [instance]
2026-09-10 11:00:08.966562 | instance |
2026-09-10 11:00:08.966894 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-09-10 11:00:08.966918 | instance | Thursday 10 September 2026  11:00:08 +0000 (0:00:02.332)       0:02:32.496 ****
2026-09-10 11:00:59.861504 | instance | An exception occurred during task execution. To see the full traceback, use -vvv. The error was: [errno 5] RADOS I/O error (error connecting to the cluster)
2026-09-10 11:00:59.862862 | 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_nug35sbv/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_nug35sbv/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_nug35sbv/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_nug35sbv/ansible_vexxhost.ceph.orch_apply_payload.zip/ansible_collections/vexxhost/ceph/plugins/modules/orch_apply.py\", line 120, in apply_spec\nRuntimeError: Inferring config /var/lib/ceph/4837cbf8-4f90-4300-b3f6-726c9b9f89b4/mon.instance/config\n2026-09-10T11:00:59.666+0000 7fcdc939f640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCIjaJqA23YFCAA836Oilbs8pfKZjkkThg/JmyPiSe0yQGTLPMoONmpebo=: Malformed input [buffer:3]\n2026-09-10T11:00:59.666+0000 7fcdc939f640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-10T11:00:59.670+0000 7fcdc939f640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCIjaJqA23YFCAA836Oilbs8pfKZjkkThg/JmyPiSe0yQGTLPMoONmpebo=: Malformed input [buffer:3]\n2026-09-10T11:00:59.670+0000 7fcdc939f640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-10T11:00:59.670+0000 7fcdc939f640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCIjaJqA23YFCAA836Oilbs8pfKZjkkThg/JmyPiSe0yQGTLPMoONmpebo=: Malformed input [buffer:3]\n2026-09-10T11:00:59.670+0000 7fcdc939f640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-10T11:00:59.670+0000 7fcdc939f640 -1 monclient: keyring not found\n[errno 5] RADOS I/O error (error connecting to the cluster)\n\n", "module_stdout": "", "msg": "MODULE FAILURE\nSee stdout/stderr for the exact error", "rc": 1}
2026-09-10 11:00:59.865817 | instance |
2026-09-10 11:00:59.868932 | instance | PLAY RECAP *********************************************************************
2026-09-10 11:00:59.868974 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=6    rescued=0    ignored=0
2026-09-10 11:00:59.868989 | instance |
2026-09-10 11:00:59.869004 | instance | Thursday 10 September 2026  11:00:59 +0000 (0:00:50.900)       0:03:23.397 ****
2026-09-10 11:00:59.869032 | instance | ===============================================================================
2026-09-10 11:00:59.869055 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 90.35s
2026-09-10 11:00:59.869069 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 50.90s
2026-09-10 11:00:59.869083 | instance | vexxhost.ceph.cephadm : Download "cephadm" ----------------------------- 12.41s
2026-09-10 11:00:59.869097 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 6.16s
2026-09-10 11:00:59.869110 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 5.93s
2026-09-10 11:00:59.869131 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.44s
2026-09-10 11:00:59.872439 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 3.13s
2026-09-10 11:00:59.872514 | instance | vexxhost.containers.download_artifact : Download item ------------------- 2.95s
2026-09-10 11:00:59.872542 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.33s
2026-09-10 11:00:59.872551 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.86s
2026-09-10 11:00:59.872560 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.78s
2026-09-10 11:00:59.872569 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.52s
2026-09-10 11:00:59.872578 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.35s
2026-09-10 11:00:59.872586 | instance | Gathering Facts --------------------------------------------------------- 1.11s
2026-09-10 11:00:59.872595 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 1.08s
2026-09-10 11:00:59.872603 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 1.05s
2026-09-10 11:00:59.872612 | instance | Gathering Facts --------------------------------------------------------- 0.92s
2026-09-10 11:00:59.872621 | instance | Gathering Facts --------------------------------------------------------- 0.87s
2026-09-10 11:00:59.872629 | instance | vexxhost.ceph.cephadm : Ensure services are started --------------------- 0.72s
2026-09-10 11:00:59.872638 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.72s
2026-09-10 11:01:00.023482 | instance | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-09-10 11:01:00.023777 | instance | ERROR    [csi > converge] Executed: Failed
2026-09-10 11:01:00.023967 | instance | ERROR    Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-09-10 11:01:00.172741 | instance | ERROR
2026-09-10 11:01:00.173071 | instance | {
2026-09-10 11:01:00.173146 | instance |   "delta": "0:04:18.495714",
2026-09-10 11:01:00.173187 | instance |   "end": "2026-09-10 11:01:00.099017",
2026-09-10 11:01:00.173222 | instance |   "msg": "non-zero return code",
2026-09-10 11:01:00.173255 | instance |   "rc": 2,
2026-09-10 11:01:00.173289 | instance |   "start": "2026-09-10 10:56:41.603303"
2026-09-10 11:01:00.173322 | instance | }
failure
2026-09-10 11:01:00.183985 | 
2026-09-10 11:01:00.184100 | PLAY RECAP
2026-09-10 11:01:00.184299 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-09-10 11:01:00.184352 | 
2026-09-10 11:01:00.404063 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-09-10 11:01:00.409223 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-09-10 11:01:01.112302 | 
2026-09-10 11:01:01.112489 | PLAY [all]
2026-09-10 11:01:01.128549 | 
2026-09-10 11:01:01.128685 | TASK [gather-host-logs : creating directory for system status]
2026-09-10 11:01:01.504216 | instance | changed
2026-09-10 11:01:01.513099 | 
2026-09-10 11:01:01.513224 | TASK [gather-host-logs : Get logs for each host]
2026-09-10 11:01:01.889179 | instance | + systemd-cgls --full --all --no-pager
2026-09-10 11:01:01.908850 | instance | + ip addr
2026-09-10 11:01:01.911585 | instance | + ip route
2026-09-10 11:01:01.914230 | instance | + lsblk
2026-09-10 11:01:01.918035 | instance | + mount
2026-09-10 11:01:01.920765 | instance | + docker images
2026-09-10 11:01:01.943331 | instance | + brctl show
2026-09-10 11:01:01.943766 | instance | /bin/bash: line 8: brctl: command not found
2026-09-10 11:01:01.944066 | instance | + ps aux --sort=-%mem
2026-09-10 11:01:01.961658 | instance | + dpkg -l
2026-09-10 11:01:01.974080 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-09-10 11:01:01.974782 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-09-10 11:01:01.996093 | instance | + '[' '!' -z '' ']'
2026-09-10 11:01:02.051293 | instance | ok: Runtime: 0:00:00.114159
2026-09-10 11:01:02.057524 | 
2026-09-10 11:01:02.057609 | TASK [gather-host-logs : Downloads logs to executor]
2026-09-10 11:01:02.730933 | instance | changed:
2026-09-10 11:01:02.731140 | instance | created directory /var/lib/zuul/builds/7c5447df093443029ded37bd3f0da669/work/logs/instance
2026-09-10 11:01:02.731182 | instance | cd+++++++++ system/
2026-09-10 11:01:02.731212 | instance | >f+++++++++ system/brctl-show.txt
2026-09-10 11:01:02.731240 | instance | >f+++++++++ system/docker-images.txt
2026-09-10 11:01:02.731268 | instance | >f+++++++++ system/ip-addr.txt
2026-09-10 11:01:02.731300 | instance | >f+++++++++ system/ip-route.txt
2026-09-10 11:01:02.731331 | instance | >f+++++++++ system/lsblk.txt
2026-09-10 11:01:02.731360 | instance | >f+++++++++ system/mount.txt
2026-09-10 11:01:02.731391 | instance | >f+++++++++ system/packages.txt
2026-09-10 11:01:02.731423 | instance | >f+++++++++ system/ps.txt
2026-09-10 11:01:02.731456 | instance | >f+++++++++ system/systemd-cgls.txt
2026-09-10 11:01:02.749408 | 
2026-09-10 11:01:02.749572 | LOOP [helm-release-status : creating directory for helm release status]
2026-09-10 11:01:02.981207 | instance | changed: "values"
2026-09-10 11:01:03.170700 | instance | changed: "releases"
2026-09-10 11:01:03.181926 | 
2026-09-10 11:01:03.182184 | TASK [helm-release-status : Gather get release status for helm charts]
2026-09-10 11:01:03.418817 | instance | /bin/bash: line 3: kubectl: command not found
2026-09-10 11:01:03.722657 | instance | ok: Runtime: 0:00:00.004218
2026-09-10 11:01:03.730807 | 
2026-09-10 11:01:03.730913 | TASK [helm-release-status : Downloads logs to executor]
2026-09-10 11:01:04.260271 | instance | changed:
2026-09-10 11:01:04.260458 | instance | cd+++++++++ helm/
2026-09-10 11:01:04.260545 | instance | cd+++++++++ helm/releases/
2026-09-10 11:01:04.260608 | instance | cd+++++++++ helm/values/
2026-09-10 11:01:04.274244 | 
2026-09-10 11:01:04.274464 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-09-10 11:01:04.502501 | instance | changed
2026-09-10 11:01:04.511093 | 
2026-09-10 11:01:04.511240 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-09-10 11:01:04.759760 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-10 11:01:04.761142 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-10 11:01:04.768256 | instance | environment: line 1: kubectl: command not found
2026-09-10 11:01:04.769031 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-10 11:01:04.769146 | instance | environment: line 1: kubectl: command not found
2026-09-10 11:01:04.769963 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-10 11:01:04.773041 | instance | environment: line 1: kubectl: command not found
2026-09-10 11:01:04.774698 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-10 11:01:04.775567 | instance | environment: line 1: kubectl: command not found
2026-09-10 11:01:04.776777 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-10 11:01:04.778048 | instance | environment: line 1: kubectl: command not found
2026-09-10 11:01:04.779414 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-09-10 11:01:05.050916 | instance | ok: Runtime: 0:00:00.026920
2026-09-10 11:01:05.058453 | 
2026-09-10 11:01:05.058581 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-09-10 11:01:05.287843 | instance | changed
2026-09-10 11:01:05.293173 | 
2026-09-10 11:01:05.293267 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-09-10 11:01:05.516463 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-10 11:01:05.516607 | instance | environment: line 5: kubectl: command not found
2026-09-10 11:01:05.517179 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-10 11:01:05.517486 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-09-10 11:01:05.832313 | instance | ok: Runtime: 0:00:00.009019
2026-09-10 11:01:05.841193 | 
2026-09-10 11:01:05.841355 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-09-10 11:01:06.376729 | instance | changed:
2026-09-10 11:01:06.376890 | instance | cd+++++++++ objects/
2026-09-10 11:01:06.376915 | instance | cd+++++++++ objects/cluster/
2026-09-10 11:01:06.376934 | instance | cd+++++++++ objects/namespaced/
2026-09-10 11:01:06.386742 | 
2026-09-10 11:01:06.386847 | TASK [gather-pod-logs : creating directory for pod logs]
2026-09-10 11:01:06.591605 | instance | changed
2026-09-10 11:01:06.597918 | 
2026-09-10 11:01:06.598037 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-09-10 11:01:06.796029 | instance | changed
2026-09-10 11:01:06.807217 | 
2026-09-10 11:01:06.807386 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-09-10 11:01:07.045721 | instance | environment: line 3: kubectl: command not found
2026-09-10 11:01:07.353653 | instance | ok: Runtime: 0:00:00.007126
2026-09-10 11:01:07.363817 | 
2026-09-10 11:01:07.363931 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-09-10 11:01:07.871469 | instance | changed:
2026-09-10 11:01:07.871672 | instance | cd+++++++++ pod-logs/
2026-09-10 11:01:07.871729 | instance | cd+++++++++ pod-logs/failed-pods/
2026-09-10 11:01:07.889282 | 
2026-09-10 11:01:07.889544 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-09-10 11:01:08.106102 | instance | changed
2026-09-10 11:01:08.115424 | 
2026-09-10 11:01:08.115555 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-09-10 11:01:08.362916 | instance | /bin/bash: line 2: kubectl: command not found
2026-09-10 11:01:08.668156 | instance | ok: Runtime: 0:00:00.027316
2026-09-10 11:01:08.678129 | 
2026-09-10 11:01:08.678401 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-09-10 11:01:08.925651 | instance | /bin/bash: line 2: kubectl: command not found
2026-09-10 11:01:08.970458 | instance | ceph-mgr endpoints:
2026-09-10 11:01:09.223015 | instance | ok: Runtime: 0:00:00.049908
2026-09-10 11:01:09.228301 | 
2026-09-10 11:01:09.228385 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-09-10 11:01:09.470920 | instance | /bin/bash: line 4: kubectl: command not found
2026-09-10 11:01:09.762301 | instance | ok: Runtime: 0:00:00.052860
2026-09-10 11:01:09.769107 | 
2026-09-10 11:01:09.769255 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-09-10 11:01:10.281064 | instance | changed: cd+++++++++ prometheus/
2026-09-10 11:01:10.291968 | 
2026-09-10 11:01:10.292083 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-09-10 11:01:10.490682 | instance | changed
2026-09-10 11:01:10.499846 | 
2026-09-10 11:01:10.499943 | TASK [gather-selenium-data : Get selenium data]
2026-09-10 11:01:10.793115 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-09-10 11:01:10.794012 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-09-10 11:01:11.049659 | instance | ERROR
2026-09-10 11:01:11.049923 | instance | {
2026-09-10 11:01:11.049998 | instance |   "delta": "0:00:00.005421",
2026-09-10 11:01:11.050064 | instance |   "end": "2026-09-10 11:01:10.794382",
2026-09-10 11:01:11.050105 | instance |   "msg": "non-zero return code",
2026-09-10 11:01:11.050151 | instance |   "rc": 1,
2026-09-10 11:01:11.050246 | instance |   "start": "2026-09-10 11:01:10.788961"
2026-09-10 11:01:11.050291 | instance | }
2026-09-10 11:01:11.050342 | instance | ERROR: Ignoring Errors
2026-09-10 11:01:11.055077 | 
2026-09-10 11:01:11.055150 | TASK [gather-selenium-data : Downloads logs to executor]
2026-09-10 11:01:11.614876 | instance | changed: cd+++++++++ selenium/
2026-09-10 11:01:11.622979 | 
2026-09-10 11:01:11.623090 | PLAY RECAP
2026-09-10 11:01:11.623161 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-09-10 11:01:11.623189 | 
2026-09-10 11:01:11.789605 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-09-10 11:01:11.792722 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-10 11:01:12.396200 | 
2026-09-10 11:01:12.396623 | PLAY [all]
2026-09-10 11:01:12.408170 | 
2026-09-10 11:01:12.408276 | TASK [fetch-output : Set log path for multiple nodes]
2026-09-10 11:01:12.462458 | instance | skipping: Conditional result was False
2026-09-10 11:01:12.470820 | 
2026-09-10 11:01:12.471035 | TASK [fetch-output : Set log path for single node]
2026-09-10 11:01:12.502113 | instance | ok
2026-09-10 11:01:12.507988 | 
2026-09-10 11:01:12.508207 | LOOP [fetch-output : Ensure local output dirs]
2026-09-10 11:01:12.946446 | instance -> localhost | ok: "/var/lib/zuul/builds/7c5447df093443029ded37bd3f0da669/work/logs"
2026-09-10 11:01:13.162915 | instance -> localhost | changed: "/var/lib/zuul/builds/7c5447df093443029ded37bd3f0da669/work/artifacts"
2026-09-10 11:01:13.419516 | instance -> localhost | changed: "/var/lib/zuul/builds/7c5447df093443029ded37bd3f0da669/work/docs"
2026-09-10 11:01:13.441269 | 
2026-09-10 11:01:13.441456 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-09-10 11:01:14.108912 | instance | changed: .d..t...... ./
2026-09-10 11:01:14.109329 | instance | changed: All items complete
2026-09-10 11:01:14.109386 | 
2026-09-10 11:01:14.624827 | instance | changed: .d..t...... ./
2026-09-10 11:01:15.120468 | instance | changed: .d..t...... ./
2026-09-10 11:01:15.133565 | 
2026-09-10 11:01:15.133676 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-09-10 11:01:15.562424 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.008071
2026-09-10 11:01:15.880909 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.056288
2026-09-10 11:01:15.898588 | 
2026-09-10 11:01:15.898698 | PLAY [all]
2026-09-10 11:01:15.907804 | 
2026-09-10 11:01:15.907954 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-09-10 11:01:16.334107 | instance | changed
2026-09-10 11:01:16.340432 | 
2026-09-10 11:01:16.340513 | PLAY RECAP
2026-09-10 11:01:16.340573 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-09-10 11:01:16.340601 | 
2026-09-10 11:01:16.463354 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-09-10 11:01:16.469457 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-09-10 11:01:17.103799 | 
2026-09-10 11:01:17.103918 | PLAY [localhost]
2026-09-10 11:01:17.113311 | 
2026-09-10 11:01:17.113400 | TASK [Generate Zuul manifest]
2026-09-10 11:01:17.139894 | localhost | ok
2026-09-10 11:01:17.157332 | 
2026-09-10 11:01:17.157500 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-09-10 11:01:17.585894 | localhost | changed
2026-09-10 11:01:17.601466 | 
2026-09-10 11:01:17.601628 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-09-10 11:01:17.630468 | localhost | ok
2026-09-10 11:01:17.639425 | 
2026-09-10 11:01:17.639583 | TASK [Upload logs]
2026-09-10 11:01:17.660907 | localhost | ok
2026-09-10 11:01:17.721576 | 
2026-09-10 11:01:17.721693 | TASK [Set zuul-log-path fact]
2026-09-10 11:01:17.737737 | localhost | ok
2026-09-10 11:01:17.751468 | 
2026-09-10 11:01:17.751690 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-09-10 11:01:17.789535 | localhost | ok
2026-09-10 11:01:17.796320 | 
2026-09-10 11:01:17.796456 | TASK [upload-logs : Create log directories]
2026-09-10 11:01:18.211518 | localhost | changed
2026-09-10 11:01:18.217442 | 
2026-09-10 11:01:18.217609 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-09-10 11:01:18.672869 | localhost -> localhost | ok: Runtime: 0:00:00.006257
2026-09-10 11:01:18.678715 | 
2026-09-10 11:01:18.678803 | TASK [upload-logs : Upload logs to log server]
2026-09-10 11:01:19.229971 | localhost | Output suppressed because no_log was given
2026-09-10 11:01:19.268282 | 
2026-09-10 11:01:19.268406 | LOOP [upload-logs : Compress console log and json output]
2026-09-10 11:01:19.333728 | localhost | skipping: Conditional result was False
2026-09-10 11:01:19.341194 | localhost | skipping: Conditional result was False
2026-09-10 11:01:19.349789 | 
2026-09-10 11:01:19.349952 | LOOP [upload-logs : Upload compressed console log and json output]
2026-09-10 11:01:19.411726 | localhost | skipping: Conditional result was False
2026-09-10 11:01:19.413425 | 
2026-09-10 11:01:19.416570 | localhost | skipping: Conditional result was False
2026-09-10 11:01:19.436137 | 
2026-09-10 11:01:19.436382 | LOOP [upload-logs : Upload console log and json output]