2026-08-24 20:29:27.721485 | Job console starting
2026-08-24 20:29:27.741828 | Updating git repos
2026-08-24 20:29:29.848551 | Cloning repos into workspace
2026-08-24 20:29:45.470882 | Restoring repo states
2026-08-24 20:29:55.092129 | Merging changes
2026-08-24 20:29:56.556222 | Checking out repos
2026-08-24 20:29:58.339907 | Preparing playbooks
2026-08-24 20:30:00.818195 | Running Ansible setup
2026-08-24 20:30:04.806113 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-24 20:30:05.413755 | 
2026-08-24 20:30:05.413870 | PLAY [localhost]
2026-08-24 20:30:05.421011 | 
2026-08-24 20:30:05.421081 | TASK [Gathering Facts]
2026-08-24 20:30:06.297380 | localhost | ok
2026-08-24 20:30:06.307577 | 
2026-08-24 20:30:06.307700 | TASK [Setup log path fact]
2026-08-24 20:30:06.348873 | localhost | ok
2026-08-24 20:30:06.359386 | 
2026-08-24 20:30:06.359451 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-24 20:30:06.391083 | localhost | ok
2026-08-24 20:30:06.399785 | 
2026-08-24 20:30:06.399874 | TASK [emit-job-header : Print job information]
2026-08-24 20:30:06.441950 | # Job Information
2026-08-24 20:30:06.442164 | Ansible Version: 2.16.18
2026-08-24 20:30:06.442241 | Job: atmosphere-molecule-csi-rbd
2026-08-24 20:30:06.442293 | Pipeline: check
2026-08-24 20:30:06.442341 | Executor: 2d72f0692154
2026-08-24 20:30:06.442388 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4091
2026-08-24 20:30:06.442445 | Event ID: c7bfb9a0-9ff9-11f1-8caf-c0b4a97e00db
2026-08-24 20:30:06.448856 | 
2026-08-24 20:30:06.449032 | LOOP [emit-job-header : Print node information]
2026-08-24 20:30:06.539124 | localhost | ok:
2026-08-24 20:30:06.539313 | localhost | # Node Information
2026-08-24 20:30:06.539353 | localhost | Inventory Hostname: instance
2026-08-24 20:30:06.539383 | localhost | Hostname: np0000191008
2026-08-24 20:30:06.539410 | localhost | Username: zuul
2026-08-24 20:30:06.539444 | localhost | Distro: Ubuntu 22.04
2026-08-24 20:30:06.539472 | localhost | Provider: yul1
2026-08-24 20:30:06.539499 | localhost | Region: ca-ymq-1
2026-08-24 20:30:06.539524 | localhost | Label: ubuntu-jammy
2026-08-24 20:30:06.539550 | localhost | Product Name: OpenStack Nova
2026-08-24 20:30:06.539576 | localhost | Interface IP: 199.204.45.44
2026-08-24 20:30:06.556557 | 
2026-08-24 20:30:06.557037 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-24 20:30:06.983053 | localhost -> localhost | changed
2026-08-24 20:30:06.995011 | 
2026-08-24 20:30:06.995108 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-24 20:30:08.114289 | localhost -> localhost | changed
2026-08-24 20:30:08.125303 | 
2026-08-24 20:30:08.125367 | PLAY [all]
2026-08-24 20:30:08.134551 | 
2026-08-24 20:30:08.134620 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-24 20:30:08.363413 | instance -> localhost | ok
2026-08-24 20:30:08.375320 | 
2026-08-24 20:30:08.375429 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-24 20:30:08.406073 | instance | ok
2026-08-24 20:30:08.425122 | instance | included: /var/lib/zuul/builds/30238ec55b144a51b467325b5d5bd96e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-24 20:30:08.432886 | 
2026-08-24 20:30:08.432946 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-24 20:30:10.480274 | instance -> localhost | Generating public/private rsa key pair.
2026-08-24 20:30:10.480454 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/30238ec55b144a51b467325b5d5bd96e/work/30238ec55b144a51b467325b5d5bd96e_id_rsa
2026-08-24 20:30:10.480485 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/30238ec55b144a51b467325b5d5bd96e/work/30238ec55b144a51b467325b5d5bd96e_id_rsa.pub
2026-08-24 20:30:10.480509 | instance -> localhost | The key fingerprint is:
2026-08-24 20:30:10.480532 | instance -> localhost | SHA256:DRctg76vG8yx7z+47+pujq8vIvpg2T+Lki8qCZ6QkEc zuul-build-sshkey
2026-08-24 20:30:10.480570 | instance -> localhost | The key's randomart image is:
2026-08-24 20:30:10.480592 | instance -> localhost | +---[RSA 3072]----+
2026-08-24 20:30:10.480618 | instance -> localhost | |         ...     |
2026-08-24 20:30:10.480640 | instance -> localhost | |  E     . o..    |
2026-08-24 20:30:10.480660 | instance -> localhost | | o     .. .o     |
2026-08-24 20:30:10.480681 | instance -> localhost | |o .     .+       |
2026-08-24 20:30:10.480701 | instance -> localhost | |.o      S..      |
2026-08-24 20:30:10.480721 | instance -> localhost | |+  o   o.o       |
2026-08-24 20:30:10.480740 | instance -> localhost | |+.=..   =. .     |
2026-08-24 20:30:10.480760 | instance -> localhost | |o++..oo .++ .    |
2026-08-24 20:30:10.480782 | instance -> localhost | |o..*+.o+=&@*+.   |
2026-08-24 20:30:10.480804 | instance -> localhost | +----[SHA256]-----+
2026-08-24 20:30:10.480853 | instance -> localhost | ok: Runtime: 0:00:01.626453
2026-08-24 20:30:10.487400 | 
2026-08-24 20:30:10.487465 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-24 20:30:10.522675 | instance | ok
2026-08-24 20:30:10.530893 | instance | included: /var/lib/zuul/builds/30238ec55b144a51b467325b5d5bd96e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-24 20:30:10.538405 | 
2026-08-24 20:30:10.538468 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-24 20:30:10.563736 | instance | skipping: Conditional result was False
2026-08-24 20:30:10.574421 | 
2026-08-24 20:30:10.574485 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-24 20:30:10.999042 | instance | changed
2026-08-24 20:30:11.007204 | 
2026-08-24 20:30:11.007265 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-24 20:30:11.192831 | instance | ok
2026-08-24 20:30:11.200591 | 
2026-08-24 20:30:11.200659 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-24 20:30:11.651393 | instance | changed
2026-08-24 20:30:11.658103 | 
2026-08-24 20:30:11.658211 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-24 20:30:12.145376 | instance | changed
2026-08-24 20:30:12.152272 | 
2026-08-24 20:30:12.152343 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-24 20:30:12.187167 | instance | skipping: Conditional result was False
2026-08-24 20:30:12.196620 | 
2026-08-24 20:30:12.196684 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-24 20:30:12.626799 | instance -> localhost | changed
2026-08-24 20:30:12.636626 | 
2026-08-24 20:30:12.636691 | TASK [add-build-sshkey : Add back temp key]
2026-08-24 20:30:12.944591 | instance -> localhost | Identity added: /var/lib/zuul/builds/30238ec55b144a51b467325b5d5bd96e/work/30238ec55b144a51b467325b5d5bd96e_id_rsa (zuul-build-sshkey)
2026-08-24 20:30:12.944806 | instance -> localhost | ok: Runtime: 0:00:00.014826
2026-08-24 20:30:12.950441 | 
2026-08-24 20:30:12.950541 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-24 20:30:13.272074 | instance | ok
2026-08-24 20:30:13.276828 | 
2026-08-24 20:30:13.276905 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-24 20:30:13.311566 | instance | skipping: Conditional result was False
2026-08-24 20:30:13.323757 | 
2026-08-24 20:30:13.323935 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-24 20:30:13.651943 | instance | ok
2026-08-24 20:30:13.659437 | 
2026-08-24 20:30:13.659537 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-24 20:30:20.738061 | instance | Output suppressed because no_log was given
2026-08-24 20:30:20.747965 | 
2026-08-24 20:30:20.748032 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-24 20:30:20.929730 | instance | ok: "logs"
2026-08-24 20:30:20.930001 | instance | ok: All items complete
2026-08-24 20:30:20.930032 | 
2026-08-24 20:30:21.092610 | instance | ok: "artifacts"
2026-08-24 20:30:21.250176 | instance | ok: "docs"
2026-08-24 20:30:21.261067 | 
2026-08-24 20:30:21.261242 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-24 20:30:21.447187 | instance | changed: "logs"
2026-08-24 20:30:21.595498 | instance | changed: "artifacts"
2026-08-24 20:30:21.755832 | instance | changed: "docs"
2026-08-24 20:30:21.777207 | 
2026-08-24 20:30:21.777402 | PLAY RECAP
2026-08-24 20:30:21.777541 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-24 20:30:21.777605 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-24 20:30:21.777652 | 
2026-08-24 20:30:21.998927 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-24 20:30:22.039879 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-24 20:30:22.792453 | 
2026-08-24 20:30:22.793137 | PLAY [all]
2026-08-24 20:30:22.804114 | 
2026-08-24 20:30:22.804190 | TASK [setup-uv : Extract archive]
2026-08-24 20:30:25.153650 | instance | changed
2026-08-24 20:30:25.161406 | 
2026-08-24 20:30:25.161486 | TASK [setup-uv : Print version]
2026-08-24 20:30:25.525685 | instance | uv 0.8.13
2026-08-24 20:30:25.757548 | instance | ok: Runtime: 0:00:00.013438
2026-08-24 20:30:25.767907 | 
2026-08-24 20:30:25.767974 | TASK [Install Ansible collection siblings]
2026-08-24 20:30:34.759826 | instance | changed:
2026-08-24 20:30:34.760032 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-08-24 20:30:34.760071 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-08-24 20:30:34.760104 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-08-24 20:30:34.760132 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-08-24 20:30:34.760158 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-08-24 20:30:34.760190 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-08-24 20:30:34.760218 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-08-24 20:30:34.760247 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-08-24 20:30:34.760275 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-08-24 20:30:34.760303 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-08-24 20:30:34.760329 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-08-24 20:30:34.760355 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-08-24 20:30:34.760380 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-08-24 20:30:34.760406 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-08-24 20:30:34.760431 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0
2026-08-24 20:30:34.760458 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-08-24 20:30:34.760484 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-08-24 20:30:34.760508 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-08-24 20:30:34.760534 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-08-24 20:30:34.760559 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-08-24 20:30:34.760584 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.1.2
2026-08-24 20:30:34.760609 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-08-24 20:30:34.760636 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-24 20:30:34.760673 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-08-24 20:30:34.760699 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0
2026-08-24 20:30:34.760724 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-24 20:30:34.760749 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-24 20:30:34.760773 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-24 20:30:34.760798 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-08-24 20:30:34.760823 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-08-24 20:30:34.760847 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-24 20:30:34.760871 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-24 20:30:34.760896 | instance | Checked out ansible.netcommon to 1.2.0
2026-08-24 20:30:34.760921 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-08-24 20:30:34.760977 | instance | Starting galaxy collection install process
2026-08-24 20:30:34.761008 | instance | Process install dependency map
2026-08-24 20:30:34.761035 | instance | Starting collection install process
2026-08-24 20:30:34.761060 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-08-24 20:30:34.761085 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-08-24 20:30:34.761109 | instance | ansible.netcommon:* was installed successfully
2026-08-24 20:30:34.761133 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-08-24 20:30:34.761157 | instance | Creating virtual environment at: .venv
2026-08-24 20:30:34.761181 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-24 20:30:34.761206 | instance | Downloading cryptography (4.2MiB)
2026-08-24 20:30:34.761231 | instance | Downloading setuptools (1.1MiB)
2026-08-24 20:30:34.761259 | instance | Downloading pygments (1.2MiB)
2026-08-24 20:30:34.761284 | instance | Downloading ansible-core (2.1MiB)
2026-08-24 20:30:34.761309 | instance | Downloading openstacksdk (1.7MiB)
2026-08-24 20:30:34.761333 | instance | Downloading kubernetes (1.9MiB)
2026-08-24 20:30:34.761358 | instance | Downloading rjsonnet (1.2MiB)
2026-08-24 20:30:34.761411 | instance | Downloading netaddr (2.2MiB)
2026-08-24 20:30:34.761473 | instance |    Building pyperclip==1.9.0
2026-08-24 20:30:34.761526 | instance |  Downloading rjsonnet
2026-08-24 20:30:34.761558 | instance |  Downloading netaddr
2026-08-24 20:30:34.761584 | instance |  Downloading pygments
2026-08-24 20:30:34.761608 | instance |  Downloading cryptography
2026-08-24 20:30:34.761741 | instance |  Downloading setuptools
2026-08-24 20:30:34.761776 | instance |  Downloading kubernetes
2026-08-24 20:30:34.761802 | instance |  Downloading ansible-core
2026-08-24 20:30:34.761827 | instance |  Downloading openstacksdk
2026-08-24 20:30:34.761852 | instance |       Built pyperclip==1.9.0
2026-08-24 20:30:34.761877 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-24 20:30:34.761901 | instance | Installed 79 packages in 44ms
2026-08-24 20:30:34.761926 | instance | Checked out ansible.posix to 1.6.0
2026-08-24 20:30:34.761951 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-08-24 20:30:34.761976 | instance | Starting galaxy collection install process
2026-08-24 20:30:34.762000 | instance | Process install dependency map
2026-08-24 20:30:34.762024 | instance | Starting collection install process
2026-08-24 20:30:34.762049 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-08-24 20:30:34.762080 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-08-24 20:30:34.762105 | instance | ansible.posix:1.6.0 was installed successfully
2026-08-24 20:30:34.762129 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 20:30:34.762153 | instance | 2.17.12
2026-08-24 20:30:34.762177 | instance | Checked out ansible.utils to v6.1.0
2026-08-24 20:30:34.762232 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-08-24 20:30:34.762261 | instance | Starting galaxy collection install process
2026-08-24 20:30:34.762285 | instance | Process install dependency map
2026-08-24 20:30:34.762309 | instance | Starting collection install process
2026-08-24 20:30:34.762333 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-08-24 20:30:34.762357 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-08-24 20:30:34.762381 | instance | ansible.utils:6.1.0 was installed successfully
2026-08-24 20:30:34.762405 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 20:30:34.762430 | instance | 2.17.12
2026-08-24 20:30:34.762454 | instance | Checked out atmosphere.common to v0.7.0
2026-08-24 20:30:34.762479 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-08-24 20:30:34.762503 | instance | Starting galaxy collection install process
2026-08-24 20:30:34.762528 | instance | Process install dependency map
2026-08-24 20:30:34.762552 | instance | Starting collection install process
2026-08-24 20:30:34.762575 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-08-24 20:30:34.762599 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-08-24 20:30:34.762624 | instance | atmosphere.common:0.7.0 was installed successfully
2026-08-24 20:30:34.762648 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 20:30:34.762672 | instance | 2.17.12
2026-08-24 20:30:34.762696 | instance | Checked out community.crypto to 2.2.3
2026-08-24 20:30:34.762719 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.crypto
2026-08-24 20:30:34.762743 | instance | Starting galaxy collection install process
2026-08-24 20:30:34.762767 | instance | Process install dependency map
2026-08-24 20:30:34.762790 | instance | Starting collection install process
2026-08-24 20:30:34.762814 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-08-24 20:30:34.762837 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-08-24 20:30:34.762862 | instance | community.crypto:2.2.3 was installed successfully
2026-08-24 20:30:34.762886 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 20:30:34.762909 | instance | 2.17.12
2026-08-24 20:30:34.762933 | instance | Checked out community.general to 7.3.0
2026-08-24 20:30:34.762957 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.general
2026-08-24 20:30:34.762981 | instance | Starting galaxy collection install process
2026-08-24 20:30:34.763014 | instance | Process install dependency map
2026-08-24 20:30:34.763044 | instance | Starting collection install process
2026-08-24 20:30:34.763074 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-08-24 20:30:34.763103 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-08-24 20:30:34.763132 | instance | community.general:7.3.0 was installed successfully
2026-08-24 20:30:34.763153 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 20:30:34.763174 | instance | 2.17.12
2026-08-24 20:30:34.763193 | instance | Checked out community.mysql to 3.6.0
2026-08-24 20:30:34.763211 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.mysql
2026-08-24 20:30:34.763229 | instance | Starting galaxy collection install process
2026-08-24 20:30:34.763249 | instance | Process install dependency map
2026-08-24 20:30:34.763267 | instance | Starting collection install process
2026-08-24 20:30:34.763285 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-08-24 20:30:34.763303 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-08-24 20:30:34.763320 | instance | community.mysql:3.6.0 was installed successfully
2026-08-24 20:30:34.763338 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 20:30:34.763355 | instance | 2.17.12
2026-08-24 20:30:34.763372 | instance | Checked out kubernetes.core to 2.4.0
2026-08-24 20:30:34.763390 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-08-24 20:30:34.763407 | instance | Starting galaxy collection install process
2026-08-24 20:30:34.763425 | instance | Process install dependency map
2026-08-24 20:30:34.763442 | instance | Starting collection install process
2026-08-24 20:30:34.763460 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-08-24 20:30:34.763477 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-08-24 20:30:34.763495 | instance | kubernetes.core:2.4.0 was installed successfully
2026-08-24 20:30:34.763512 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 20:30:34.763530 | instance | 2.17.12
2026-08-24 20:30:34.763547 | instance | Checked out openstack.cloud to 2.6.0
2026-08-24 20:30:34.763564 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-08-24 20:30:34.763582 | instance | Starting galaxy collection install process
2026-08-24 20:30:34.763600 | instance | Process install dependency map
2026-08-24 20:30:34.763618 | instance | Starting collection install process
2026-08-24 20:30:34.763635 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-08-24 20:30:34.763652 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-08-24 20:30:34.763670 | instance | openstack.cloud:2.6.0 was installed successfully
2026-08-24 20:30:34.763687 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 20:30:34.763704 | instance | 2.17.12
2026-08-24 20:30:34.763725 | instance | Checked out vexxhost.ceph to v4.2.0
2026-08-24 20:30:34.763743 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-08-24 20:30:34.763764 | instance | Starting galaxy collection install process
2026-08-24 20:30:34.763782 | instance | Process install dependency map
2026-08-24 20:30:34.763799 | instance | Starting collection install process
2026-08-24 20:30:34.763817 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-08-24 20:30:34.763834 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-08-24 20:30:34.763851 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-08-24 20:30:34.763868 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 20:30:34.763885 | instance | 2.17.12
2026-08-24 20:30:34.763902 | instance | Checked out vexxhost.containers to v1.6.8
2026-08-24 20:30:34.763919 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-08-24 20:30:34.763936 | instance | Starting galaxy collection install process
2026-08-24 20:30:34.763953 | instance | Process install dependency map
2026-08-24 20:30:34.763970 | instance | Starting collection install process
2026-08-24 20:30:34.763988 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-08-24 20:30:34.764006 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-08-24 20:30:34.764024 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-08-24 20:30:34.764041 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 20:30:34.764059 | instance | 2.17.12
2026-08-24 20:30:34.764076 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-08-24 20:30:34.764094 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-08-24 20:30:34.764112 | instance | Starting galaxy collection install process
2026-08-24 20:30:34.764129 | instance | Process install dependency map
2026-08-24 20:30:34.764146 | instance | Starting collection install process
2026-08-24 20:30:34.764163 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-08-24 20:30:34.764180 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-08-24 20:30:34.764199 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-08-24 20:30:34.764216 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 20:30:34.764233 | instance | 2.17.12
2026-08-24 20:30:34.769829 | 
2026-08-24 20:30:34.769876 | PLAY RECAP
2026-08-24 20:30:34.769922 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-24 20:30:34.769943 | 
2026-08-24 20:30:34.895188 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-24 20:30:34.899283 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-24 20:30:35.588039 | 
2026-08-24 20:30:35.588198 | PLAY [all]
2026-08-24 20:30:35.599806 | 
2026-08-24 20:30:35.599890 | TASK [Install "jq" for log collection]
2026-08-24 20:30:48.113963 | instance | changed
2026-08-24 20:30:48.116147 | 
2026-08-24 20:30:48.116227 | PLAY RECAP
2026-08-24 20:30:48.116391 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-24 20:30:48.116447 | 
2026-08-24 20:30:48.257999 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-24 20:30:48.260349 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-24 20:30:48.895554 | 
2026-08-24 20:30:48.895738 | PLAY [all]
2026-08-24 20:30:48.907360 | 
2026-08-24 20:30:48.907459 | LOOP [Check inventory directories]
2026-08-24 20:30:49.294540 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-08-24 20:30:49.436970 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-08-24 20:30:49.604273 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-08-24 20:30:49.617834 | 
2026-08-24 20:30:49.618066 | LOOP [Copy inventory file for Zuul]
2026-08-24 20:30:50.398545 | instance | changed:
2026-08-24 20:30:50.398746 | instance | {
2026-08-24 20:30:50.398775 | instance |   "ansible_loop_var": "item",
2026-08-24 20:30:50.398798 | instance |   "changed": false,
2026-08-24 20:30:50.398818 | instance |   "failed": false,
2026-08-24 20:30:50.398839 | instance |   "invocation": {
2026-08-24 20:30:50.398858 | instance |     "module_args": {
2026-08-24 20:30:50.398876 | instance |       "checksum_algorithm": "sha1",
2026-08-24 20:30:50.398894 | instance |       "follow": true,
2026-08-24 20:30:50.398912 | instance |       "get_attributes": true,
2026-08-24 20:30:50.398931 | instance |       "get_checksum": true,
2026-08-24 20:30:50.398949 | instance |       "get_mime": true,
2026-08-24 20:30:50.398966 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-08-24 20:30:50.398984 | instance |     }
2026-08-24 20:30:50.399001 | instance |   },
2026-08-24 20:30:50.399019 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-08-24 20:30:50.399036 | instance |   "stat": {
2026-08-24 20:30:50.399053 | instance |     "atime": 1787603427.5616238,
2026-08-24 20:30:50.399071 | instance |     "attr_flags": "e",
2026-08-24 20:30:50.399088 | instance |     "attributes": [
2026-08-24 20:30:50.399105 | instance |       "extents"
2026-08-24 20:30:50.399123 | instance |     ],
2026-08-24 20:30:50.399140 | instance |     "block_size": 4096,
2026-08-24 20:30:50.399157 | instance |     "blocks": 8,
2026-08-24 20:30:50.399174 | instance |     "charset": "unknown",
2026-08-24 20:30:50.399192 | instance |     "ctime": 1787603426.617482,
2026-08-24 20:30:50.399210 | instance |     "dev": 64513,
2026-08-24 20:30:50.399227 | instance |     "device_type": 0,
2026-08-24 20:30:50.399245 | instance |     "executable": true,
2026-08-24 20:30:50.399262 | instance |     "exists": true,
2026-08-24 20:30:50.399286 | instance |     "gid": 1000,
2026-08-24 20:30:50.399309 | instance |     "gr_name": "zuul",
2026-08-24 20:30:50.399331 | instance |     "inode": 1046399,
2026-08-24 20:30:50.399353 | instance |     "isblk": false,
2026-08-24 20:30:50.399375 | instance |     "ischr": false,
2026-08-24 20:30:50.399397 | instance |     "isdir": true,
2026-08-24 20:30:50.399419 | instance |     "isfifo": false,
2026-08-24 20:30:50.399440 | instance |     "isgid": false,
2026-08-24 20:30:50.399462 | instance |     "islnk": false,
2026-08-24 20:30:50.399483 | instance |     "isreg": false,
2026-08-24 20:30:50.399504 | instance |     "issock": false,
2026-08-24 20:30:50.399525 | instance |     "isuid": false,
2026-08-24 20:30:50.399546 | instance |     "mimetype": "unknown",
2026-08-24 20:30:50.399568 | instance |     "mode": "0755",
2026-08-24 20:30:50.399590 | instance |     "mtime": 1787603426.617482,
2026-08-24 20:30:50.399611 | instance |     "nlink": 21,
2026-08-24 20:30:50.399632 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-08-24 20:30:50.399654 | instance |     "pw_name": "zuul",
2026-08-24 20:30:50.399677 | instance |     "readable": true,
2026-08-24 20:30:50.399698 | instance |     "rgrp": true,
2026-08-24 20:30:50.399720 | instance |     "roth": true,
2026-08-24 20:30:50.399742 | instance |     "rusr": true,
2026-08-24 20:30:50.399764 | instance |     "size": 4096,
2026-08-24 20:30:50.399785 | instance |     "uid": 1000,
2026-08-24 20:30:50.399879 | instance |     "version": "211893796",
2026-08-24 20:30:50.399908 | instance |     "wgrp": false,
2026-08-24 20:30:50.399928 | instance |     "woth": false,
2026-08-24 20:30:50.399946 | instance |     "writeable": true,
2026-08-24 20:30:50.399963 | instance |     "wusr": true,
2026-08-24 20:30:50.399980 | instance |     "xgrp": true,
2026-08-24 20:30:50.399997 | instance |     "xoth": true,
2026-08-24 20:30:50.400014 | instance |     "xusr": true
2026-08-24 20:30:50.400031 | instance |   }
2026-08-24 20:30:50.400048 | instance | }
2026-08-24 20:30:50.400084 | instance | ok: All items complete
2026-08-24 20:30:50.400105 | 
2026-08-24 20:30:50.401356 | instance | skipping: Conditional result was False
2026-08-24 20:30:50.401939 | instance | skipping: Conditional result was False
2026-08-24 20:30:50.417661 | 
2026-08-24 20:30:50.417803 | LOOP [Switch "ansible_host" to private IP]
2026-08-24 20:30:50.764256 | instance | changed: 1 replacements made
2026-08-24 20:30:50.766254 | instance | skipping: Conditional result was False
2026-08-24 20:30:50.770163 | instance | skipping: Conditional result was False
2026-08-24 20:30:50.783830 | 
2026-08-24 20:30:50.783985 | TASK [Run Molecule scenario]
2026-08-24 20:30:51.716716 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-08-24 20:30:52.091546 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-08-24 20:30:52.091644 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-08-24 20:31:03.083407 | instance | INFO     [csi > dependency] Executing
2026-08-24 20:31:03.083533 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-08-24 20:31:03.083788 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-08-24 20:31:03.083861 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-08-24 20:31:03.091264 | instance | INFO     [csi > cleanup] Executing
2026-08-24 20:31:03.091666 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-24 20:31:03.099078 | instance | INFO     [csi > destroy] Executing
2026-08-24 20:31:03.099119 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-08-24 20:31:03.099180 | instance | INFO     [csi > destroy] Executed: Successful
2026-08-24 20:31:03.106617 | instance | INFO     [csi > syntax] Executing
2026-08-24 20:31:04.825056 | instance |
2026-08-24 20:31:04.825269 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-24 20:31:04.901615 | instance | INFO     [csi > syntax] Executed: Successful
2026-08-24 20:31:04.917321 | instance | INFO     [csi > create] Executing
2026-08-24 20:31:04.919516 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-24 20:31:04.927957 | instance | INFO     [csi > prepare] Executing
2026-08-24 20:31:05.771785 | instance |
2026-08-24 20:31:05.771891 | instance | PLAY [Prepare] *****************************************************************
2026-08-24 20:31:05.772067 | instance |
2026-08-24 20:31:05.772315 | instance | TASK [Gathering Facts] *********************************************************
2026-08-24 20:31:05.772565 | instance | Monday 24 August 2026  20:31:05 +0000 (0:00:00.027)       0:00:00.027 *********
2026-08-24 20:31:06.918497 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-24 20:31:06.918727 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-24 20:31:06.918988 | instance | interpreter could change the meaning of that path. See
2026-08-24 20:31:06.919253 | instance | https://docs.ansible.com/ansible-
2026-08-24 20:31:06.919558 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-24 20:31:06.928447 | instance | ok: [instance]
2026-08-24 20:31:06.928670 | instance |
2026-08-24 20:31:06.928933 | instance | TASK [Configure short hostname] ************************************************
2026-08-24 20:31:06.929222 | instance | Monday 24 August 2026  20:31:06 +0000 (0:00:01.157)       0:00:01.185 *********
2026-08-24 20:31:07.626398 | instance | changed: [instance]
2026-08-24 20:31:07.627475 | instance |
2026-08-24 20:31:07.627521 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-08-24 20:31:07.627530 | instance | Monday 24 August 2026  20:31:07 +0000 (0:00:00.697)       0:00:01.883 *********
2026-08-24 20:31:07.882341 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-08-24 20:31:07.882397 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-08-24 20:31:07.882409 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-08-24 20:31:07.891487 | instance | changed: [instance]
2026-08-24 20:31:07.891592 | instance |
2026-08-24 20:31:07.891617 | instance | TASK [Purge "snapd" package] ***************************************************
2026-08-24 20:31:07.891791 | instance | Monday 24 August 2026  20:31:07 +0000 (0:00:00.264)       0:00:02.148 *********
2026-08-24 20:31:08.701328 | instance | ok: [instance]
2026-08-24 20:31:08.701660 | instance |
2026-08-24 20:31:08.701931 | instance | PLAY [Create devices for Ceph] *************************************************
2026-08-24 20:31:08.702199 | instance |
2026-08-24 20:31:08.702483 | instance | TASK [Gathering Facts] *********************************************************
2026-08-24 20:31:08.702752 | instance | Monday 24 August 2026  20:31:08 +0000 (0:00:00.809)       0:00:02.958 *********
2026-08-24 20:31:09.395568 | instance | ok: [instance]
2026-08-24 20:31:09.395779 | instance |
2026-08-24 20:31:09.396063 | instance | TASK [Install depedencies] *****************************************************
2026-08-24 20:31:09.396350 | instance | Monday 24 August 2026  20:31:09 +0000 (0:00:00.693)       0:00:03.652 *********
2026-08-24 20:31:29.394381 | instance | changed: [instance]
2026-08-24 20:31:29.395019 | instance |
2026-08-24 20:31:29.395033 | instance | TASK [Start up service] ********************************************************
2026-08-24 20:31:29.395152 | instance | Monday 24 August 2026  20:31:29 +0000 (0:00:19.998)       0:00:23.650 *********
2026-08-24 20:31:29.923867 | instance | ok: [instance]
2026-08-24 20:31:29.924081 | instance |
2026-08-24 20:31:29.924371 | instance | TASK [Generate lvm.conf] *******************************************************
2026-08-24 20:31:29.924651 | instance | Monday 24 August 2026  20:31:29 +0000 (0:00:00.529)       0:00:24.180 *********
2026-08-24 20:31:30.222036 | instance | ok: [instance]
2026-08-24 20:31:30.222209 | instance |
2026-08-24 20:31:30.222395 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-08-24 20:31:30.222569 | instance | Monday 24 August 2026  20:31:30 +0000 (0:00:00.298)       0:00:24.479 *********
2026-08-24 20:31:30.870714 | instance | changed: [instance]
2026-08-24 20:31:30.870776 | instance |
2026-08-24 20:31:30.870788 | instance | TASK [Get list of all loopback devices] ****************************************
2026-08-24 20:31:30.870799 | instance | Monday 24 August 2026  20:31:30 +0000 (0:00:00.647)       0:00:25.126 *********
2026-08-24 20:31:31.067859 | instance | ok: [instance]
2026-08-24 20:31:31.067894 | instance |
2026-08-24 20:31:31.067900 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-08-24 20:31:31.067905 | instance | Monday 24 August 2026  20:31:31 +0000 (0:00:00.197)       0:00:25.323 *********
2026-08-24 20:31:31.092740 | instance | skipping: [instance]
2026-08-24 20:31:31.092887 | instance |
2026-08-24 20:31:31.093055 | instance | TASK [Create devices for Ceph] *************************************************
2026-08-24 20:31:31.093278 | instance | Monday 24 August 2026  20:31:31 +0000 (0:00:00.026)       0:00:25.350 *********
2026-08-24 20:31:31.632162 | instance | changed: [instance] => (item=osd0)
2026-08-24 20:31:31.632285 | instance | changed: [instance] => (item=osd1)
2026-08-24 20:31:31.632984 | instance | changed: [instance] => (item=osd2)
2026-08-24 20:31:31.633041 | instance |
2026-08-24 20:31:31.633049 | instance | TASK [Set permissions on loopback devices] *************************************
2026-08-24 20:31:31.633056 | instance | Monday 24 August 2026  20:31:31 +0000 (0:00:00.539)       0:00:25.889 *********
2026-08-24 20:31:32.250629 | instance | changed: [instance] => (item=osd0)
2026-08-24 20:31:32.250678 | instance | changed: [instance] => (item=osd1)
2026-08-24 20:31:32.250685 | instance | changed: [instance] => (item=osd2)
2026-08-24 20:31:32.250690 | instance |
2026-08-24 20:31:32.250696 | instance | TASK [Start loop devices] ******************************************************
2026-08-24 20:31:32.250703 | instance | Monday 24 August 2026  20:31:32 +0000 (0:00:00.617)       0:00:26.506 *********
2026-08-24 20:31:32.988169 | instance | changed: [instance] => (item=osd0)
2026-08-24 20:31:32.988249 | instance | changed: [instance] => (item=osd1)
2026-08-24 20:31:32.988261 | instance | changed: [instance] => (item=osd2)
2026-08-24 20:31:32.988270 | instance |
2026-08-24 20:31:32.988280 | instance | TASK [Create a volume group for each loop device] ******************************
2026-08-24 20:31:32.988307 | instance | Monday 24 August 2026  20:31:32 +0000 (0:00:00.736)       0:00:27.243 *********
2026-08-24 20:31:36.267875 | instance | changed: [instance] => (item=osd0)
2026-08-24 20:31:36.267983 | instance | changed: [instance] => (item=osd1)
2026-08-24 20:31:36.268171 | instance | changed: [instance] => (item=osd2)
2026-08-24 20:31:36.268338 | instance |
2026-08-24 20:31:36.268516 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-08-24 20:31:36.268693 | instance | Monday 24 August 2026  20:31:36 +0000 (0:00:03.281)       0:00:30.524 *********
2026-08-24 20:31:38.178404 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-08-24 20:31:38.178610 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-08-24 20:31:38.178881 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-08-24 20:31:38.179484 | instance |
2026-08-24 20:31:38.179555 | instance | PLAY RECAP *********************************************************************
2026-08-24 20:31:38.179815 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-08-24 20:31:38.180064 | instance |
2026-08-24 20:31:38.180339 | instance | Monday 24 August 2026  20:31:38 +0000 (0:00:01.910)       0:00:32.435 *********
2026-08-24 20:31:38.180603 | instance | ===============================================================================
2026-08-24 20:31:38.180879 | instance | Install depedencies ---------------------------------------------------- 20.00s
2026-08-24 20:31:38.181142 | instance | Create a volume group for each loop device ------------------------------ 3.28s
2026-08-24 20:31:38.181408 | instance | Create a logical volume for each loop device ---------------------------- 1.91s
2026-08-24 20:31:38.181678 | instance | Gathering Facts --------------------------------------------------------- 1.16s
2026-08-24 20:31:38.181955 | instance | Purge "snapd" package --------------------------------------------------- 0.81s
2026-08-24 20:31:38.182235 | instance | Start loop devices ------------------------------------------------------ 0.74s
2026-08-24 20:31:38.182531 | instance | Configure short hostname ------------------------------------------------ 0.70s
2026-08-24 20:31:38.182848 | instance | Gathering Facts --------------------------------------------------------- 0.69s
2026-08-24 20:31:38.183124 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.65s
2026-08-24 20:31:38.184215 | instance | Set permissions on loopback devices ------------------------------------- 0.62s
2026-08-24 20:31:38.184398 | instance | Create devices for Ceph ------------------------------------------------- 0.54s
2026-08-24 20:31:38.184510 | instance | Start up service -------------------------------------------------------- 0.53s
2026-08-24 20:31:38.184633 | instance | Generate lvm.conf ------------------------------------------------------- 0.30s
2026-08-24 20:31:38.184750 | instance | Ensure hostname inside hosts file --------------------------------------- 0.26s
2026-08-24 20:31:38.184875 | instance | Get list of all loopback devices ---------------------------------------- 0.20s
2026-08-24 20:31:38.184988 | instance | Fail if there is any existing loopback devices -------------------------- 0.03s
2026-08-24 20:31:38.277880 | instance | INFO     [csi > prepare] Executed: Successful
2026-08-24 20:31:38.290979 | instance | INFO     [csi > converge] Executing
2026-08-24 20:31:39.755725 | instance |
2026-08-24 20:31:39.755960 | instance | PLAY [Debug CSI driver value] **************************************************
2026-08-24 20:31:39.756236 | instance |
2026-08-24 20:31:39.756512 | instance | TASK [Gathering Facts] *********************************************************
2026-08-24 20:31:39.756878 | instance | Monday 24 August 2026  20:31:39 +0000 (0:00:00.007)       0:00:00.007 *********
2026-08-24 20:31:40.692241 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-24 20:31:40.692680 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-24 20:31:40.693050 | instance | interpreter could change the meaning of that path. See
2026-08-24 20:31:40.693424 | instance | https://docs.ansible.com/ansible-
2026-08-24 20:31:40.693787 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-24 20:31:40.696884 | instance | ok: [instance]
2026-08-24 20:31:40.697234 | instance |
2026-08-24 20:31:40.697571 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-08-24 20:31:40.697904 | instance | Monday 24 August 2026  20:31:40 +0000 (0:00:00.941)       0:00:00.949 *********
2026-08-24 20:31:40.747777 | instance | ok: [instance] => {
2026-08-24 20:31:40.748180 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-08-24 20:31:40.748644 | instance | }
2026-08-24 20:31:40.749111 | instance |
2026-08-24 20:31:40.749580 | instance | PLAY [all] *********************************************************************
2026-08-24 20:31:40.750047 | instance |
2026-08-24 20:31:40.750514 | instance | TASK [Gathering Facts] *********************************************************
2026-08-24 20:31:40.751010 | instance | Monday 24 August 2026  20:31:40 +0000 (0:00:00.050)       0:00:01.000 *********
2026-08-24 20:31:41.652350 | instance | ok: [instance]
2026-08-24 20:31:41.652777 | instance |
2026-08-24 20:31:41.653133 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-08-24 20:31:41.653473 | instance | Monday 24 August 2026  20:31:41 +0000 (0:00:00.903)       0:00:01.904 *********
2026-08-24 20:31:41.833104 | instance | ok: [instance]
2026-08-24 20:31:41.833492 | instance |
2026-08-24 20:31:41.833830 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-08-24 20:31:41.834219 | instance |
2026-08-24 20:31:41.834556 | instance | TASK [Gathering Facts] *********************************************************
2026-08-24 20:31:41.834884 | instance | Monday 24 August 2026  20:31:41 +0000 (0:00:00.181)       0:00:02.085 *********
2026-08-24 20:31:42.726698 | instance | ok: [instance]
2026-08-24 20:31:42.727095 | instance |
2026-08-24 20:31:42.727513 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-24 20:31:42.727898 | instance | Monday 24 August 2026  20:31:42 +0000 (0:00:00.893)       0:00:02.978 *********
2026-08-24 20:31:43.012143 | instance | ok: [instance]
2026-08-24 20:31:43.012365 | instance |
2026-08-24 20:31:43.012521 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-24 20:31:43.012677 | instance | Monday 24 August 2026  20:31:43 +0000 (0:00:00.284)       0:00:03.263 *********
2026-08-24 20:31:43.052319 | instance | skipping: [instance]
2026-08-24 20:31:43.052835 | instance |
2026-08-24 20:31:43.054048 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-08-24 20:31:43.054081 | instance | Monday 24 August 2026  20:31:43 +0000 (0:00:00.040)       0:00:03.303 *********
2026-08-24 20:31:43.423990 | instance | changed: [instance]
2026-08-24 20:31:43.424103 | instance |
2026-08-24 20:31:43.424487 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-24 20:31:43.424653 | instance | Monday 24 August 2026  20:31:43 +0000 (0:00:00.369)       0:00:03.672 *********
2026-08-24 20:31:43.496302 | instance | ok: [instance] => {
2026-08-24 20:31:43.496723 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-08-24 20:31:43.497047 | instance | }
2026-08-24 20:31:43.497353 | instance |
2026-08-24 20:31:43.497677 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-24 20:31:43.497998 | instance | Monday 24 August 2026  20:31:43 +0000 (0:00:00.073)       0:00:03.746 *********
2026-08-24 20:31:44.144214 | instance | changed: [instance]
2026-08-24 20:31:44.144668 | instance |
2026-08-24 20:31:44.145077 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-24 20:31:44.145488 | instance | Monday 24 August 2026  20:31:44 +0000 (0:00:00.648)       0:00:04.395 *********
2026-08-24 20:31:44.200227 | instance | skipping: [instance]
2026-08-24 20:31:44.200612 | instance |
2026-08-24 20:31:44.200985 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-24 20:31:44.201338 | instance | Monday 24 August 2026  20:31:44 +0000 (0:00:00.053)       0:00:04.449 *********
2026-08-24 20:31:44.252070 | instance | skipping: [instance]
2026-08-24 20:31:44.252218 | instance |
2026-08-24 20:31:44.252449 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-24 20:31:44.252610 | instance | Monday 24 August 2026  20:31:44 +0000 (0:00:00.054)       0:00:04.503 *********
2026-08-24 20:31:44.476548 | instance | ok: [instance]
2026-08-24 20:31:44.476611 | instance |
2026-08-24 20:31:44.476617 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-24 20:31:44.476623 | instance | Monday 24 August 2026  20:31:44 +0000 (0:00:00.224)       0:00:04.728 *********
2026-08-24 20:31:45.662097 | instance | ok: [instance]
2026-08-24 20:31:45.662327 | instance |
2026-08-24 20:31:45.662341 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-24 20:31:45.662398 | instance | Monday 24 August 2026  20:31:45 +0000 (0:00:01.186)       0:00:05.914 *********
2026-08-24 20:31:45.722620 | instance | ok: [instance] => {
2026-08-24 20:31:45.722651 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-08-24 20:31:45.722666 | instance | }
2026-08-24 20:31:45.722670 | instance |
2026-08-24 20:31:45.722675 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-24 20:31:45.722679 | instance | Monday 24 August 2026  20:31:45 +0000 (0:00:00.059)       0:00:05.974 *********
2026-08-24 20:31:46.436279 | instance | changed: [instance]
2026-08-24 20:31:46.436362 | instance |
2026-08-24 20:31:46.436638 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-24 20:31:46.436794 | instance | Monday 24 August 2026  20:31:46 +0000 (0:00:00.714)       0:00:06.688 *********
2026-08-24 20:31:49.306678 | instance | changed: [instance]
2026-08-24 20:31:49.306717 | instance |
2026-08-24 20:31:49.306723 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-08-24 20:31:49.306728 | instance | Monday 24 August 2026  20:31:49 +0000 (0:00:02.870)       0:00:09.558 *********
2026-08-24 20:31:49.333429 | instance | skipping: [instance]
2026-08-24 20:31:49.333496 | instance |
2026-08-24 20:31:49.333766 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-08-24 20:31:49.333820 | instance | Monday 24 August 2026  20:31:49 +0000 (0:00:00.027)       0:00:09.586 *********
2026-08-24 20:31:49.366805 | instance | skipping: [instance]
2026-08-24 20:31:49.367581 | instance |
2026-08-24 20:31:49.367684 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-08-24 20:31:49.367706 | instance | Monday 24 August 2026  20:31:49 +0000 (0:00:00.032)       0:00:09.619 *********
2026-08-24 20:31:49.398461 | instance | skipping: [instance]
2026-08-24 20:31:49.398502 | instance |
2026-08-24 20:31:49.398775 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-08-24 20:31:49.398799 | instance | Monday 24 August 2026  20:31:49 +0000 (0:00:00.031)       0:00:09.651 *********
2026-08-24 20:31:54.526009 | instance | changed: [instance]
2026-08-24 20:31:54.526172 | instance |
2026-08-24 20:31:54.526187 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-08-24 20:31:54.526333 | instance | Monday 24 August 2026  20:31:54 +0000 (0:00:05.127)       0:00:14.778 *********
2026-08-24 20:31:55.100446 | instance | changed: [instance]
2026-08-24 20:31:55.101003 | instance |
2026-08-24 20:31:55.101050 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-08-24 20:31:55.101058 | instance | Monday 24 August 2026  20:31:55 +0000 (0:00:00.574)       0:00:15.352 *********
2026-08-24 20:31:56.083043 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-08-24 20:31:56.083475 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-08-24 20:31:56.083581 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-08-24 20:31:56.084519 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-08-24 20:31:56.084595 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-08-24 20:31:56.084605 | instance |
2026-08-24 20:31:56.084619 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-08-24 20:31:56.084627 | instance | Monday 24 August 2026  20:31:56 +0000 (0:00:00.982)       0:00:16.335 *********
2026-08-24 20:31:56.655493 | instance | changed: [instance]
2026-08-24 20:31:56.655557 | instance |
2026-08-24 20:31:56.655575 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-08-24 20:31:56.656015 | instance | Monday 24 August 2026  20:31:56 +0000 (0:00:00.556)       0:00:16.891 *********
2026-08-24 20:31:56.656054 | instance |
2026-08-24 20:31:56.656059 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-24 20:31:56.656064 | instance | Monday 24 August 2026  20:31:56 +0000 (0:00:00.016)       0:00:16.907 *********
2026-08-24 20:31:57.559020 | instance | ok: [instance]
2026-08-24 20:31:57.559741 | instance |
2026-08-24 20:31:57.559754 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-08-24 20:31:57.559764 | instance | Monday 24 August 2026  20:31:57 +0000 (0:00:00.903)       0:00:17.811 *********
2026-08-24 20:31:57.989736 | instance | changed: [instance]
2026-08-24 20:31:57.989823 | instance |
2026-08-24 20:31:57.990137 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-08-24 20:31:57.990175 | instance | Monday 24 August 2026  20:31:57 +0000 (0:00:00.430)       0:00:18.242 *********
2026-08-24 20:31:58.549114 | instance | changed: [instance]
2026-08-24 20:31:58.549179 | instance |
2026-08-24 20:31:58.549464 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-24 20:31:58.549506 | instance | Monday 24 August 2026  20:31:58 +0000 (0:00:00.559)       0:00:18.801 *********
2026-08-24 20:31:58.759314 | instance | ok: [instance]
2026-08-24 20:31:58.759419 | instance |
2026-08-24 20:31:58.759807 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-24 20:31:58.759859 | instance | Monday 24 August 2026  20:31:58 +0000 (0:00:00.209)       0:00:19.011 *********
2026-08-24 20:31:58.824157 | instance | ok: [instance] => {
2026-08-24 20:31:58.824294 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-08-24 20:31:58.824380 | instance | }
2026-08-24 20:31:58.824771 | instance |
2026-08-24 20:31:58.824841 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-24 20:31:58.824848 | instance | Monday 24 August 2026  20:31:58 +0000 (0:00:00.064)       0:00:19.076 *********
2026-08-24 20:31:59.579510 | instance | changed: [instance]
2026-08-24 20:31:59.579572 | instance |
2026-08-24 20:31:59.579583 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-24 20:31:59.579600 | instance | Monday 24 August 2026  20:31:59 +0000 (0:00:00.755)       0:00:19.831 *********
2026-08-24 20:32:03.954380 | instance | changed: [instance]
2026-08-24 20:32:03.954458 | instance |
2026-08-24 20:32:03.954725 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-08-24 20:32:03.954860 | instance | Monday 24 August 2026  20:32:03 +0000 (0:00:04.375)       0:00:24.206 *********
2026-08-24 20:32:04.982833 | instance | ok: [instance]
2026-08-24 20:32:04.982898 | instance |
2026-08-24 20:32:04.983152 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-08-24 20:32:04.983167 | instance | Monday 24 August 2026  20:32:04 +0000 (0:00:01.028)       0:00:25.235 *********
2026-08-24 20:32:05.347983 | instance | changed: [instance]
2026-08-24 20:32:05.348054 | instance |
2026-08-24 20:32:05.348363 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-08-24 20:32:05.348417 | instance | Monday 24 August 2026  20:32:05 +0000 (0:00:00.364)       0:00:25.600 *********
2026-08-24 20:32:05.806168 | instance | changed: [instance]
2026-08-24 20:32:05.806277 | instance |
2026-08-24 20:32:05.806339 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-08-24 20:32:05.806498 | instance | Monday 24 August 2026  20:32:05 +0000 (0:00:00.458)       0:00:26.058 *********
2026-08-24 20:32:06.389681 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-08-24 20:32:06.389764 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-08-24 20:32:06.390274 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-08-24 20:32:06.390317 | instance |
2026-08-24 20:32:06.390323 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-08-24 20:32:06.390328 | instance | Monday 24 August 2026  20:32:06 +0000 (0:00:00.583)       0:00:26.642 *********
2026-08-24 20:32:06.877280 | instance | changed: [instance]
2026-08-24 20:32:06.877347 | instance |
2026-08-24 20:32:06.877651 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-08-24 20:32:06.877688 | instance | Monday 24 August 2026  20:32:06 +0000 (0:00:00.487)       0:00:27.129 *********
2026-08-24 20:32:07.357995 | instance | changed: [instance]
2026-08-24 20:32:07.358069 | instance |
2026-08-24 20:32:07.358696 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-08-24 20:32:07.358742 | instance | Monday 24 August 2026  20:32:07 +0000 (0:00:00.462)       0:00:27.592 *********
2026-08-24 20:32:07.358748 | instance |
2026-08-24 20:32:07.358752 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-24 20:32:07.358756 | instance | Monday 24 August 2026  20:32:07 +0000 (0:00:00.017)       0:00:27.610 *********
2026-08-24 20:32:08.035565 | instance | ok: [instance]
2026-08-24 20:32:08.036086 | instance |
2026-08-24 20:32:08.036150 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-08-24 20:32:08.036167 | instance | Monday 24 August 2026  20:32:08 +0000 (0:00:00.677)       0:00:28.287 *********
2026-08-24 20:32:08.878423 | instance | changed: [instance]
2026-08-24 20:32:08.878521 | instance |
2026-08-24 20:32:08.878798 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-08-24 20:32:08.878855 | instance | Monday 24 August 2026  20:32:08 +0000 (0:00:00.843)       0:00:29.130 *********
2026-08-24 20:32:09.423683 | instance | changed: [instance]
2026-08-24 20:32:09.423767 | instance |
2026-08-24 20:32:09.424032 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-08-24 20:32:09.424071 | instance | Monday 24 August 2026  20:32:09 +0000 (0:00:00.545)       0:00:29.676 *********
2026-08-24 20:32:09.475692 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-08-24 20:32:09.476099 | instance |
2026-08-24 20:32:09.476141 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-08-24 20:32:09.476148 | instance | Monday 24 August 2026  20:32:09 +0000 (0:00:00.051)       0:00:29.728 *********
2026-08-24 20:32:14.092213 | instance | changed: [instance]
2026-08-24 20:32:14.092300 | instance |
2026-08-24 20:32:14.092560 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-08-24 20:32:14.092703 | instance | Monday 24 August 2026  20:32:14 +0000 (0:00:04.616)       0:00:34.344 *********
2026-08-24 20:32:14.765020 | instance | ok: [instance] => (item=chronyd)
2026-08-24 20:32:14.765119 | instance | ok: [instance] => (item=sshd)
2026-08-24 20:32:14.765537 | instance |
2026-08-24 20:32:14.765580 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-08-24 20:32:14.765586 | instance | Monday 24 August 2026  20:32:14 +0000 (0:00:00.672)       0:00:35.017 *********
2026-08-24 20:32:15.676459 | instance | changed: [instance]
2026-08-24 20:32:15.676528 | instance |
2026-08-24 20:32:15.676800 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-08-24 20:32:15.676939 | instance | Monday 24 August 2026  20:32:15 +0000 (0:00:00.911)       0:00:35.929 *********
2026-08-24 20:32:15.881899 | instance | ok: [instance]
2026-08-24 20:32:15.881972 | instance |
2026-08-24 20:32:15.882320 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-08-24 20:32:15.882395 | instance | Monday 24 August 2026  20:32:15 +0000 (0:00:00.204)       0:00:36.133 *********
2026-08-24 20:32:16.361985 | instance | changed: [instance]
2026-08-24 20:32:16.362137 | instance |
2026-08-24 20:32:16.362211 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-08-24 20:32:16.362446 | instance | Monday 24 August 2026  20:32:16 +0000 (0:00:00.479)       0:00:36.613 *********
2026-08-24 20:32:16.753976 | instance | changed: [instance]
2026-08-24 20:32:16.754068 | instance |
2026-08-24 20:32:16.754131 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-08-24 20:32:16.754308 | instance | Monday 24 August 2026  20:32:16 +0000 (0:00:00.391)       0:00:37.005 *********
2026-08-24 20:32:16.867330 | instance | ok: [instance]
2026-08-24 20:32:16.867507 | instance |
2026-08-24 20:32:16.867520 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-08-24 20:32:16.867650 | instance | Monday 24 August 2026  20:32:16 +0000 (0:00:00.113)       0:00:37.119 *********
2026-08-24 20:32:17.097820 | instance | ok: [instance] => (item=instance)
2026-08-24 20:32:17.097889 | instance |
2026-08-24 20:32:17.098167 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-08-24 20:32:17.098209 | instance | Monday 24 August 2026  20:32:17 +0000 (0:00:00.230)       0:00:37.350 *********
2026-08-24 20:32:17.144761 | instance | ok: [instance]
2026-08-24 20:32:17.144843 | instance |
2026-08-24 20:32:17.145134 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-08-24 20:32:17.145181 | instance | Monday 24 August 2026  20:32:17 +0000 (0:00:00.046)       0:00:37.397 *********
2026-08-24 20:32:17.223648 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-08-24 20:32:17.223743 | instance |
2026-08-24 20:32:17.224019 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-08-24 20:32:17.224042 | instance | Monday 24 August 2026  20:32:17 +0000 (0:00:00.079)       0:00:37.476 *********
2026-08-24 20:32:17.581622 | instance | changed: [instance]
2026-08-24 20:32:17.581661 | instance |
2026-08-24 20:32:17.581666 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-08-24 20:32:17.581671 | instance | Monday 24 August 2026  20:32:17 +0000 (0:00:00.357)       0:00:37.833 *********
2026-08-24 20:32:18.279415 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-08-24 20:32:18.279458 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-08-24 20:32:18.279464 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-08-24 20:32:18.279469 | instance |
2026-08-24 20:32:18.279473 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-08-24 20:32:18.279477 | instance | Monday 24 August 2026  20:32:18 +0000 (0:00:00.697)       0:00:38.531 *********
2026-08-24 20:33:47.465160 | instance | ok: [instance]
2026-08-24 20:33:47.465277 | instance |
2026-08-24 20:33:47.465321 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-08-24 20:33:47.465475 | instance | Monday 24 August 2026  20:33:47 +0000 (0:01:29.186)       0:02:07.717 *********
2026-08-24 20:33:47.675116 | instance | changed: [instance]
2026-08-24 20:33:47.675221 | instance |
2026-08-24 20:33:47.675479 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-08-24 20:33:47.675545 | instance | Monday 24 August 2026  20:33:47 +0000 (0:00:00.210)       0:02:07.927 *********
2026-08-24 20:33:47.760675 | instance | ok: [instance]
2026-08-24 20:33:47.760731 | instance |
2026-08-24 20:33:47.760872 | instance | TASK [Install Ceph host] *******************************************************
2026-08-24 20:33:47.760980 | instance | Monday 24 August 2026  20:33:47 +0000 (0:00:00.085)       0:02:08.013 *********
2026-08-24 20:33:47.837011 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-08-24 20:33:47.837076 | instance |
2026-08-24 20:33:47.837293 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-08-24 20:33:47.837308 | instance | Monday 24 August 2026  20:33:47 +0000 (0:00:00.076)       0:02:08.089 *********
2026-08-24 20:33:49.476375 | instance | ok: [instance]
2026-08-24 20:33:49.476502 | instance |
2026-08-24 20:33:49.476592 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-08-24 20:33:49.476712 | instance | Monday 24 August 2026  20:33:49 +0000 (0:00:01.638)       0:02:09.728 *********
2026-08-24 20:33:49.538293 | instance | ok: [instance] => (item=instance)
2026-08-24 20:33:49.538389 | instance |
2026-08-24 20:33:49.538520 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-08-24 20:33:49.538657 | instance | Monday 24 August 2026  20:33:49 +0000 (0:00:00.061)       0:02:09.790 *********
2026-08-24 20:33:49.896524 | instance | ok: [instance]
2026-08-24 20:33:49.896621 | instance |
2026-08-24 20:33:49.896709 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-08-24 20:33:49.896830 | instance | Monday 24 August 2026  20:33:49 +0000 (0:00:00.358)       0:02:10.148 *********
2026-08-24 20:33:52.395401 | instance | ok: [instance]
2026-08-24 20:33:52.395516 | instance |
2026-08-24 20:33:52.395763 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-08-24 20:33:52.395823 | instance | Monday 24 August 2026  20:33:52 +0000 (0:00:02.498)       0:02:12.647 *********
2026-08-24 20:34:39.218005 | instance | An exception occurred during task execution. To see the full traceback, use -vvv. The error was: [errno 5] RADOS I/O error (error connecting to the cluster)
2026-08-24 20:34:39.218630 | 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_h70za8z8/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_h70za8z8/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_h70za8z8/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_h70za8z8/ansible_vexxhost.ceph.orch_apply_payload.zip/ansible_collections/vexxhost/ceph/plugins/modules/orch_apply.py\", line 120, in apply_spec\nRuntimeError: Inferring config /var/lib/ceph/4837cbf8-4f90-4300-b3f6-726c9b9f89b4/mon.instance/config\n2026-08-24T20:34:39.070+0000 7f9c41cd3640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCBqoxqyzAiCiAArdMc0/QPHWA+I2rIm6Y3KzCoHLx8+Nf+7JidzmPDVtA=: Malformed input [buffer:3]\n2026-08-24T20:34:39.070+0000 7f9c41cd3640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T20:34:39.074+0000 7f9c41cd3640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCBqoxqyzAiCiAArdMc0/QPHWA+I2rIm6Y3KzCoHLx8+Nf+7JidzmPDVtA=: Malformed input [buffer:3]\n2026-08-24T20:34:39.074+0000 7f9c41cd3640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T20:34:39.074+0000 7f9c41cd3640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCBqoxqyzAiCiAArdMc0/QPHWA+I2rIm6Y3KzCoHLx8+Nf+7JidzmPDVtA=: Malformed input [buffer:3]\n2026-08-24T20:34:39.074+0000 7f9c41cd3640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T20:34:39.074+0000 7f9c41cd3640 -1 monclient: keyring not found\n[errno 5] RADOS I/O error (error connecting to the cluster)\n\n", "module_stdout": "", "msg": "MODULE FAILURE\nSee stdout/stderr for the exact error", "rc": 1}
2026-08-24 20:34:39.219582 | instance |
2026-08-24 20:34:39.219751 | instance | PLAY RECAP *********************************************************************
2026-08-24 20:34:39.219934 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=6    rescued=0    ignored=0
2026-08-24 20:34:39.220088 | instance |
2026-08-24 20:34:39.220258 | instance | Monday 24 August 2026  20:34:39 +0000 (0:00:46.825)       0:02:59.472 *********
2026-08-24 20:34:39.220414 | instance | ===============================================================================
2026-08-24 20:34:39.220575 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 89.19s
2026-08-24 20:34:39.220735 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 46.83s
2026-08-24 20:34:39.220905 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 5.13s
2026-08-24 20:34:39.221071 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 4.62s
2026-08-24 20:34:39.221232 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.38s
2026-08-24 20:34:39.221393 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.87s
2026-08-24 20:34:39.221563 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.50s
2026-08-24 20:34:39.221720 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.64s
2026-08-24 20:34:39.221999 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.58s
2026-08-24 20:34:39.222178 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.19s
2026-08-24 20:34:39.222344 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.03s
2026-08-24 20:34:39.222505 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.98s
2026-08-24 20:34:39.222668 | instance | Gathering Facts --------------------------------------------------------- 0.94s
2026-08-24 20:34:39.222830 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 0.91s
2026-08-24 20:34:39.222999 | instance | Gathering Facts --------------------------------------------------------- 0.90s
2026-08-24 20:34:39.223117 | instance | Gathering Facts --------------------------------------------------------- 0.89s
2026-08-24 20:34:39.223226 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 0.84s
2026-08-24 20:34:39.223344 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.76s
2026-08-24 20:34:39.223485 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.71s
2026-08-24 20:34:39.223598 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.70s
2026-08-24 20:34:39.308130 | instance | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-24 20:34:39.308293 | instance | ERROR    [csi > converge] Executed: Failed
2026-08-24 20:34:39.308427 | instance | ERROR    Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-24 20:34:39.699104 | instance | ERROR
2026-08-24 20:34:39.699309 | instance | {
2026-08-24 20:34:39.699351 | instance |   "delta": "0:03:48.243460",
2026-08-24 20:34:39.699372 | instance |   "end": "2026-08-24 20:34:39.377706",
2026-08-24 20:34:39.699391 | instance |   "msg": "non-zero return code",
2026-08-24 20:34:39.699408 | instance |   "rc": 2,
2026-08-24 20:34:39.699425 | instance |   "start": "2026-08-24 20:30:51.134246"
2026-08-24 20:34:39.699442 | instance | }
failure
2026-08-24 20:34:39.704283 | 
2026-08-24 20:34:39.704332 | PLAY RECAP
2026-08-24 20:34:39.704376 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-08-24 20:34:39.704397 | 
2026-08-24 20:34:39.840859 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-24 20:34:39.845888 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-24 20:34:40.471396 | 
2026-08-24 20:34:40.471513 | PLAY [all]
2026-08-24 20:34:40.492940 | 
2026-08-24 20:34:40.493215 | TASK [gather-host-logs : creating directory for system status]
2026-08-24 20:34:40.830089 | instance | changed
2026-08-24 20:34:40.835958 | 
2026-08-24 20:34:40.836041 | TASK [gather-host-logs : Get logs for each host]
2026-08-24 20:34:41.207844 | instance | + systemd-cgls --full --all --no-pager
2026-08-24 20:34:41.217212 | instance | + ip addr
2026-08-24 20:34:41.219400 | instance | + ip route
2026-08-24 20:34:41.220642 | instance | + lsblk
2026-08-24 20:34:41.224598 | instance | + mount
2026-08-24 20:34:41.226232 | instance | + docker images
2026-08-24 20:34:41.245718 | instance | + brctl show
2026-08-24 20:34:41.246169 | instance | /bin/bash: line 8: brctl: command not found
2026-08-24 20:34:41.246360 | instance | + ps aux --sort=-%mem
2026-08-24 20:34:41.264282 | instance | + dpkg -l
2026-08-24 20:34:41.276163 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-08-24 20:34:41.276596 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-08-24 20:34:41.292266 | instance | + '[' '!' -z '' ']'
2026-08-24 20:34:41.385286 | instance | ok: Runtime: 0:00:00.089825
2026-08-24 20:34:41.392572 | 
2026-08-24 20:34:41.392651 | TASK [gather-host-logs : Downloads logs to executor]
2026-08-24 20:34:42.041557 | instance | changed:
2026-08-24 20:34:42.041745 | instance | created directory /var/lib/zuul/builds/30238ec55b144a51b467325b5d5bd96e/work/logs/instance
2026-08-24 20:34:42.041794 | instance | cd+++++++++ system/
2026-08-24 20:34:42.041832 | instance | >f+++++++++ system/brctl-show.txt
2026-08-24 20:34:42.041869 | instance | >f+++++++++ system/docker-images.txt
2026-08-24 20:34:42.041902 | instance | >f+++++++++ system/ip-addr.txt
2026-08-24 20:34:42.041936 | instance | >f+++++++++ system/ip-route.txt
2026-08-24 20:34:42.041970 | instance | >f+++++++++ system/lsblk.txt
2026-08-24 20:34:42.042001 | instance | >f+++++++++ system/mount.txt
2026-08-24 20:34:42.042031 | instance | >f+++++++++ system/packages.txt
2026-08-24 20:34:42.042061 | instance | >f+++++++++ system/ps.txt
2026-08-24 20:34:42.042093 | instance | >f+++++++++ system/systemd-cgls.txt
2026-08-24 20:34:42.055352 | 
2026-08-24 20:34:42.055444 | LOOP [helm-release-status : creating directory for helm release status]
2026-08-24 20:34:42.256653 | instance | changed: "values"
2026-08-24 20:34:42.419088 | instance | changed: "releases"
2026-08-24 20:34:42.438134 | 
2026-08-24 20:34:42.438231 | TASK [helm-release-status : Gather get release status for helm charts]
2026-08-24 20:34:42.635406 | instance | /bin/bash: line 3: kubectl: command not found
2026-08-24 20:34:42.975840 | instance | ok: Runtime: 0:00:00.004039
2026-08-24 20:34:42.982392 | 
2026-08-24 20:34:42.982466 | TASK [helm-release-status : Downloads logs to executor]
2026-08-24 20:34:43.513596 | instance | changed:
2026-08-24 20:34:43.513787 | instance | cd+++++++++ helm/
2026-08-24 20:34:43.513826 | instance | cd+++++++++ helm/releases/
2026-08-24 20:34:43.513855 | instance | cd+++++++++ helm/values/
2026-08-24 20:34:43.525733 | 
2026-08-24 20:34:43.525813 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-08-24 20:34:43.719642 | instance | changed
2026-08-24 20:34:43.727547 | 
2026-08-24 20:34:43.727705 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-08-24 20:34:43.966048 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-24 20:34:43.966103 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-24 20:34:43.970338 | instance | environment: line 1: kubectl: command not found
2026-08-24 20:34:43.972496 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-24 20:34:43.973313 | instance | environment: line 1: kubectl: command not found
2026-08-24 20:34:43.974291 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-24 20:34:43.975599 | instance | environment: line 1: kubectl: command not found
2026-08-24 20:34:43.976659 | instance | environment: line 1: kubectl: command not found
2026-08-24 20:34:43.977208 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-24 20:34:43.977743 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-24 20:34:43.980155 | instance | environment: line 1: kubectl: command not found
2026-08-24 20:34:43.980965 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-24 20:34:44.260102 | instance | ok: Runtime: 0:00:00.023859
2026-08-24 20:34:44.265232 | 
2026-08-24 20:34:44.265359 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-08-24 20:34:44.468739 | instance | changed
2026-08-24 20:34:44.475373 | 
2026-08-24 20:34:44.475458 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-08-24 20:34:44.680380 | instance | environment: line 5: kubectl: command not found
2026-08-24 20:34:44.681504 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-24 20:34:44.681800 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-24 20:34:44.681981 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-24 20:34:45.015040 | instance | ok: Runtime: 0:00:00.007942
2026-08-24 20:34:45.022496 | 
2026-08-24 20:34:45.022563 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-08-24 20:34:45.501264 | instance | changed:
2026-08-24 20:34:45.501568 | instance | cd+++++++++ objects/
2026-08-24 20:34:45.501627 | instance | cd+++++++++ objects/cluster/
2026-08-24 20:34:45.501677 | instance | cd+++++++++ objects/namespaced/
2026-08-24 20:34:45.510768 | 
2026-08-24 20:34:45.510834 | TASK [gather-pod-logs : creating directory for pod logs]
2026-08-24 20:34:45.697279 | instance | changed
2026-08-24 20:34:45.702644 | 
2026-08-24 20:34:45.702708 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-08-24 20:34:45.898884 | instance | changed
2026-08-24 20:34:45.905519 | 
2026-08-24 20:34:45.905647 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-08-24 20:34:46.104710 | instance | environment: line 3: kubectl: command not found
2026-08-24 20:34:46.437878 | instance | ok: Runtime: 0:00:00.008117
2026-08-24 20:34:46.444405 | 
2026-08-24 20:34:46.444477 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-08-24 20:34:46.937079 | instance | changed:
2026-08-24 20:34:46.937408 | instance | cd+++++++++ pod-logs/
2026-08-24 20:34:46.937497 | instance | cd+++++++++ pod-logs/failed-pods/
2026-08-24 20:34:46.952641 | 
2026-08-24 20:34:46.952782 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-08-24 20:34:47.172239 | instance | changed
2026-08-24 20:34:47.178981 | 
2026-08-24 20:34:47.179053 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-08-24 20:34:47.387195 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-24 20:34:47.716423 | instance | ok: Runtime: 0:00:00.035780
2026-08-24 20:34:47.723994 | 
2026-08-24 20:34:47.724069 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-08-24 20:34:47.921250 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-24 20:34:47.952045 | instance | ceph-mgr endpoints:
2026-08-24 20:34:48.258811 | instance | ok: Runtime: 0:00:00.036673
2026-08-24 20:34:48.265587 | 
2026-08-24 20:34:48.265656 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-08-24 20:34:48.470911 | instance | /bin/bash: line 4: kubectl: command not found
2026-08-24 20:34:48.802914 | instance | ok: Runtime: 0:00:00.036745
2026-08-24 20:34:48.808242 | 
2026-08-24 20:34:48.808309 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-08-24 20:34:49.318362 | instance | changed: cd+++++++++ prometheus/
2026-08-24 20:34:49.331191 | 
2026-08-24 20:34:49.331454 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-08-24 20:34:49.539605 | instance | changed
2026-08-24 20:34:49.678542 | 
2026-08-24 20:34:49.678689 | TASK [gather-selenium-data : Get selenium data]
2026-08-24 20:34:49.967411 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-08-24 20:34:49.968467 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-08-24 20:34:50.212212 | instance | ERROR
2026-08-24 20:34:50.212384 | instance | {
2026-08-24 20:34:50.212415 | instance |   "delta": "0:00:00.005951",
2026-08-24 20:34:50.212436 | instance |   "end": "2026-08-24 20:34:49.968754",
2026-08-24 20:34:50.212458 | instance |   "msg": "non-zero return code",
2026-08-24 20:34:50.212477 | instance |   "rc": 1,
2026-08-24 20:34:50.212495 | instance |   "start": "2026-08-24 20:34:49.962803"
2026-08-24 20:34:50.212513 | instance | }
2026-08-24 20:34:50.212536 | instance | ERROR: Ignoring Errors
2026-08-24 20:34:50.220967 | 
2026-08-24 20:34:50.221034 | TASK [gather-selenium-data : Downloads logs to executor]
2026-08-24 20:34:50.710660 | instance | changed: cd+++++++++ selenium/
2026-08-24 20:34:50.719543 | 
2026-08-24 20:34:50.719620 | PLAY RECAP
2026-08-24 20:34:50.719889 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-08-24 20:34:50.719945 | 
2026-08-24 20:34:50.876512 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-24 20:34:50.880926 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-24 20:34:51.534891 | 
2026-08-24 20:34:51.535039 | PLAY [all]
2026-08-24 20:34:51.547683 | 
2026-08-24 20:34:51.547808 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-24 20:34:51.594670 | instance | skipping: Conditional result was False
2026-08-24 20:34:51.602338 | 
2026-08-24 20:34:51.602470 | TASK [fetch-output : Set log path for single node]
2026-08-24 20:34:51.646662 | instance | ok
2026-08-24 20:34:51.651497 | 
2026-08-24 20:34:51.651570 | LOOP [fetch-output : Ensure local output dirs]
2026-08-24 20:34:52.048698 | instance -> localhost | ok: "/var/lib/zuul/builds/30238ec55b144a51b467325b5d5bd96e/work/logs"
2026-08-24 20:34:52.264546 | instance -> localhost | changed: "/var/lib/zuul/builds/30238ec55b144a51b467325b5d5bd96e/work/artifacts"
2026-08-24 20:34:52.553311 | instance -> localhost | changed: "/var/lib/zuul/builds/30238ec55b144a51b467325b5d5bd96e/work/docs"
2026-08-24 20:34:52.569897 | 
2026-08-24 20:34:52.570034 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-24 20:34:53.315100 | instance | changed: .d..t...... ./
2026-08-24 20:34:53.315413 | instance | changed: All items complete
2026-08-24 20:34:53.315449 | 
2026-08-24 20:34:53.800154 | instance | changed: .d..t...... ./
2026-08-24 20:34:54.306121 | instance | changed: .d..t...... ./
2026-08-24 20:34:54.327930 | 
2026-08-24 20:34:54.328107 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-24 20:34:54.797350 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.009051
2026-08-24 20:34:55.038107 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007863
2026-08-24 20:34:55.056129 | 
2026-08-24 20:34:55.056202 | PLAY [all]
2026-08-24 20:34:55.063010 | 
2026-08-24 20:34:55.063081 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-24 20:34:55.518438 | instance | changed
2026-08-24 20:34:55.524157 | 
2026-08-24 20:34:55.524205 | PLAY RECAP
2026-08-24 20:34:55.524250 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-24 20:34:55.524273 | 
2026-08-24 20:34:55.683379 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-24 20:34:56.083206 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-24 20:34:56.810786 | 
2026-08-24 20:34:56.810932 | PLAY [localhost]
2026-08-24 20:34:56.821413 | 
2026-08-24 20:34:56.821498 | TASK [Generate Zuul manifest]
2026-08-24 20:34:56.842147 | localhost | ok
2026-08-24 20:34:57.073414 | 
2026-08-24 20:34:57.073582 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-24 20:34:57.538339 | localhost | changed
2026-08-24 20:34:57.548300 | 
2026-08-24 20:34:57.548381 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-24 20:34:57.699172 | localhost | ok
2026-08-24 20:34:57.714276 | 
2026-08-24 20:34:57.714678 | TASK [Upload logs]
2026-08-24 20:34:57.754151 | localhost | ok
2026-08-24 20:34:58.138315 | 
2026-08-24 20:34:58.138453 | TASK [Set zuul-log-path fact]
2026-08-24 20:34:58.158888 | localhost | ok
2026-08-24 20:34:58.173225 | 
2026-08-24 20:34:58.173310 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-24 20:34:58.203375 | localhost | ok
2026-08-24 20:34:58.212012 | 
2026-08-24 20:34:58.212117 | TASK [upload-logs : Create log directories]
2026-08-24 20:34:58.639612 | localhost | changed
2026-08-24 20:34:58.646124 | 
2026-08-24 20:34:58.646219 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-24 20:34:59.055455 | localhost -> localhost | ok: Runtime: 0:00:00.004845
2026-08-24 20:34:59.063004 | 
2026-08-24 20:34:59.063075 | TASK [upload-logs : Upload logs to log server]
2026-08-24 20:34:59.592381 | localhost | Output suppressed because no_log was given
2026-08-24 20:34:59.629138 | 
2026-08-24 20:34:59.629290 | LOOP [upload-logs : Compress console log and json output]
2026-08-24 20:34:59.680981 | localhost | skipping: Conditional result was False
2026-08-24 20:34:59.687488 | localhost | skipping: Conditional result was False
2026-08-24 20:34:59.703304 | 
2026-08-24 20:34:59.703421 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-24 20:34:59.744455 | localhost | skipping: Conditional result was False
2026-08-24 20:34:59.745098 | 
2026-08-24 20:34:59.748609 | localhost | skipping: Conditional result was False
2026-08-24 20:34:59.767832 | 
2026-08-24 20:34:59.767959 | LOOP [upload-logs : Upload console log and json output]