2026-08-24 15:14:55.437180 | Job console starting
2026-08-24 15:14:55.450971 | Updating git repos
2026-08-24 15:14:56.296138 | Cloning repos into workspace
2026-08-24 15:15:22.814371 | Restoring repo states
2026-08-24 15:15:33.506776 | Merging changes
2026-08-24 15:15:34.601653 | Checking out repos
2026-08-24 15:15:39.536413 | Preparing playbooks
2026-08-24 15:15:53.751619 | Running Ansible setup
2026-08-24 15:15:59.598846 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-24 15:16:00.200870 | 
2026-08-24 15:16:00.201046 | PLAY [localhost]
2026-08-24 15:16:00.208879 | 
2026-08-24 15:16:00.208974 | TASK [Gathering Facts]
2026-08-24 15:16:01.212364 | localhost | ok
2026-08-24 15:16:01.222873 | 
2026-08-24 15:16:01.222973 | TASK [Setup log path fact]
2026-08-24 15:16:01.244304 | localhost | ok
2026-08-24 15:16:01.257795 | 
2026-08-24 15:16:01.257873 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-24 15:16:01.289285 | localhost | ok
2026-08-24 15:16:01.297964 | 
2026-08-24 15:16:01.298166 | TASK [emit-job-header : Print job information]
2026-08-24 15:16:01.339132 | # Job Information
2026-08-24 15:16:01.339429 | Ansible Version: 2.16.18
2026-08-24 15:16:01.339560 | Job: atmosphere-molecule-csi-rbd
2026-08-24 15:16:01.339626 | Pipeline: check
2026-08-24 15:16:01.339676 | Executor: 2d72f0692154
2026-08-24 15:16:01.339723 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3252
2026-08-24 15:16:01.339781 | Event ID: a0aea1a0-9fcc-11f1-86be-5823bbd4623d
2026-08-24 15:16:01.343778 | 
2026-08-24 15:16:01.343849 | LOOP [emit-job-header : Print node information]
2026-08-24 15:16:01.439051 | localhost | ok:
2026-08-24 15:16:01.439293 | localhost | # Node Information
2026-08-24 15:16:01.439329 | localhost | Inventory Hostname: instance
2026-08-24 15:16:01.439352 | localhost | Hostname: np0000190822
2026-08-24 15:16:01.439372 | localhost | Username: zuul
2026-08-24 15:16:01.439395 | localhost | Distro: Ubuntu 22.04
2026-08-24 15:16:01.439414 | localhost | Provider: yul1
2026-08-24 15:16:01.439433 | localhost | Region: ca-ymq-1
2026-08-24 15:16:01.439452 | localhost | Label: ubuntu-jammy
2026-08-24 15:16:01.439471 | localhost | Product Name: OpenStack Nova
2026-08-24 15:16:01.439489 | localhost | Interface IP: 199.19.213.195
2026-08-24 15:16:01.466518 | 
2026-08-24 15:16:01.466791 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-24 15:16:01.917344 | localhost -> localhost | changed
2026-08-24 15:16:01.923394 | 
2026-08-24 15:16:01.923477 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-24 15:16:03.910112 | localhost -> localhost | changed
2026-08-24 15:16:03.919523 | 
2026-08-24 15:16:03.919602 | PLAY [all]
2026-08-24 15:16:03.929069 | 
2026-08-24 15:16:03.929176 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-24 15:16:04.198913 | instance -> localhost | ok
2026-08-24 15:16:04.209426 | 
2026-08-24 15:16:04.209508 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-24 15:16:04.242805 | instance | ok
2026-08-24 15:16:04.259975 | instance | included: /var/lib/zuul/builds/8ea661385db544a6a036d86f1a8ed02a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-24 15:16:04.266032 | 
2026-08-24 15:16:04.266103 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-24 15:16:05.744573 | instance -> localhost | Generating public/private rsa key pair.
2026-08-24 15:16:05.744788 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/8ea661385db544a6a036d86f1a8ed02a/work/8ea661385db544a6a036d86f1a8ed02a_id_rsa
2026-08-24 15:16:05.744819 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/8ea661385db544a6a036d86f1a8ed02a/work/8ea661385db544a6a036d86f1a8ed02a_id_rsa.pub
2026-08-24 15:16:05.744843 | instance -> localhost | The key fingerprint is:
2026-08-24 15:16:05.744865 | instance -> localhost | SHA256:5CkFTcSda5hRJMghj6YuVARdXNQU/nBe+FKNKiIizb4 zuul-build-sshkey
2026-08-24 15:16:05.744907 | instance -> localhost | The key's randomart image is:
2026-08-24 15:16:05.744930 | instance -> localhost | +---[RSA 3072]----+
2026-08-24 15:16:05.745088 | instance -> localhost | | .o.+o=X**+.     |
2026-08-24 15:16:05.745119 | instance -> localhost | |  .. =o.=oo . o  |
2026-08-24 15:16:05.745141 | instance -> localhost | |   .o . o* + + . |
2026-08-24 15:16:05.745161 | instance -> localhost | |  +o   +o.B =    |
2026-08-24 15:16:05.745181 | instance -> localhost | | o.+ ...So = .   |
2026-08-24 15:16:05.745201 | instance -> localhost | |..o . ... . .    |
2026-08-24 15:16:05.745221 | instance -> localhost | |. ..             |
2026-08-24 15:16:05.745241 | instance -> localhost | | .  .            |
2026-08-24 15:16:05.745263 | instance -> localhost | |   E             |
2026-08-24 15:16:05.745284 | instance -> localhost | +----[SHA256]-----+
2026-08-24 15:16:05.745334 | instance -> localhost | ok: Runtime: 0:00:00.559418
2026-08-24 15:16:05.753482 | 
2026-08-24 15:16:05.753553 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-24 15:16:05.794458 | instance | ok
2026-08-24 15:16:05.805357 | instance | included: /var/lib/zuul/builds/8ea661385db544a6a036d86f1a8ed02a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-24 15:16:05.814226 | 
2026-08-24 15:16:05.814316 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-24 15:16:05.839162 | instance | skipping: Conditional result was False
2026-08-24 15:16:05.850373 | 
2026-08-24 15:16:05.850451 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-24 15:16:06.280599 | instance | changed
2026-08-24 15:16:06.286722 | 
2026-08-24 15:16:06.286787 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-24 15:16:06.471920 | instance | ok
2026-08-24 15:16:06.478809 | 
2026-08-24 15:16:06.478914 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-24 15:16:06.937957 | instance | changed
2026-08-24 15:16:06.945252 | 
2026-08-24 15:16:06.945323 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-24 15:16:07.416504 | instance | changed
2026-08-24 15:16:07.460845 | 
2026-08-24 15:16:07.481031 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-24 15:16:07.506250 | instance | skipping: Conditional result was False
2026-08-24 15:16:07.512367 | 
2026-08-24 15:16:07.512512 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-24 15:16:07.922629 | instance -> localhost | changed
2026-08-24 15:16:07.936693 | 
2026-08-24 15:16:07.936836 | TASK [add-build-sshkey : Add back temp key]
2026-08-24 15:16:08.244707 | instance -> localhost | Identity added: /var/lib/zuul/builds/8ea661385db544a6a036d86f1a8ed02a/work/8ea661385db544a6a036d86f1a8ed02a_id_rsa (zuul-build-sshkey)
2026-08-24 15:16:08.244915 | instance -> localhost | ok: Runtime: 0:00:00.014693
2026-08-24 15:16:08.250847 | 
2026-08-24 15:16:08.250908 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-24 15:16:08.574052 | instance | ok
2026-08-24 15:16:08.578431 | 
2026-08-24 15:16:08.578492 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-24 15:16:08.602968 | instance | skipping: Conditional result was False
2026-08-24 15:16:08.617273 | 
2026-08-24 15:16:08.617339 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-24 15:16:08.953366 | instance | ok
2026-08-24 15:16:08.961918 | 
2026-08-24 15:16:08.962024 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-24 15:16:12.464313 | instance | Output suppressed because no_log was given
2026-08-24 15:16:12.475544 | 
2026-08-24 15:16:12.475628 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-24 15:16:12.659680 | instance | ok: "logs"
2026-08-24 15:16:12.761007 | instance | ok: All items complete
2026-08-24 15:16:12.761190 | 
2026-08-24 15:16:12.810150 | instance | ok: "artifacts"
2026-08-24 15:16:12.966895 | instance | ok: "docs"
2026-08-24 15:16:12.987991 | 
2026-08-24 15:16:12.988620 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-24 15:16:13.181835 | instance | changed: "logs"
2026-08-24 15:16:13.330235 | instance | changed: "artifacts"
2026-08-24 15:16:13.482745 | instance | changed: "docs"
2026-08-24 15:16:13.504908 | 
2026-08-24 15:16:13.505076 | PLAY RECAP
2026-08-24 15:16:13.505148 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-24 15:16:13.505200 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-24 15:16:13.505243 | 
2026-08-24 15:16:13.705627 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-24 15:16:13.708779 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-24 15:16:14.429214 | 
2026-08-24 15:16:14.429396 | PLAY [all]
2026-08-24 15:16:14.442034 | 
2026-08-24 15:16:14.442224 | TASK [setup-uv : Extract archive]
2026-08-24 15:16:16.736495 | instance | changed
2026-08-24 15:16:16.742490 | 
2026-08-24 15:16:16.742572 | TASK [setup-uv : Print version]
2026-08-24 15:16:17.094522 | instance | uv 0.8.13
2026-08-24 15:16:17.297147 | instance | ok: Runtime: 0:00:00.021888
2026-08-24 15:16:17.308517 | 
2026-08-24 15:16:17.308605 | TASK [Install Ansible collection siblings]
2026-08-24 15:16:25.990766 | instance | changed:
2026-08-24 15:16:25.991061 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-08-24 15:16:25.991101 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-08-24 15:16:25.991125 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-08-24 15:16:25.991151 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-08-24 15:16:25.991198 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-08-24 15:16:25.991228 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-08-24 15:16:25.991267 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-08-24 15:16:25.991304 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-08-24 15:16:25.991326 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-08-24 15:16:25.991346 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-08-24 15:16:25.991368 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-08-24 15:16:25.991387 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-08-24 15:16:25.991407 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-08-24 15:16:25.991426 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-08-24 15:16:25.991444 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0
2026-08-24 15:16:25.991463 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-08-24 15:16:25.991480 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-08-24 15:16:25.991499 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-08-24 15:16:25.991517 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-08-24 15:16:25.991534 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-08-24 15:16:25.991552 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0
2026-08-24 15:16:25.991569 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-08-24 15:16:25.991588 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-24 15:16:25.991621 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-08-24 15:16:25.991640 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0
2026-08-24 15:16:25.991661 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-24 15:16:25.991679 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-24 15:16:25.991697 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-24 15:16:25.991714 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-08-24 15:16:25.991732 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-08-24 15:16:25.991749 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-24 15:16:25.991767 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-24 15:16:25.991785 | instance | Checked out ansible.netcommon to 1.2.0
2026-08-24 15:16:25.991803 | 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 15:16:25.991827 | instance | Starting galaxy collection install process
2026-08-24 15:16:25.991845 | instance | Process install dependency map
2026-08-24 15:16:25.991862 | instance | Starting collection install process
2026-08-24 15:16:25.991879 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-08-24 15:16:25.991896 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-08-24 15:16:25.991914 | instance | ansible.netcommon:* was installed successfully
2026-08-24 15:16:25.991934 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-08-24 15:16:25.991951 | instance | Creating virtual environment at: .venv
2026-08-24 15:16:25.991968 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-24 15:16:25.991986 | instance | Downloading netaddr (2.2MiB)
2026-08-24 15:16:25.992003 | instance | Downloading rjsonnet (1.2MiB)
2026-08-24 15:16:25.992021 | instance | Downloading openstacksdk (1.7MiB)
2026-08-24 15:16:25.992040 | instance | Downloading cryptography (4.2MiB)
2026-08-24 15:16:25.992058 | instance | Downloading setuptools (1.1MiB)
2026-08-24 15:16:25.992105 | instance | Downloading pygments (1.2MiB)
2026-08-24 15:16:25.992124 | instance | Downloading ansible-core (2.1MiB)
2026-08-24 15:16:25.992141 | instance | Downloading pydantic-core (2.0MiB)
2026-08-24 15:16:25.992160 | instance | Downloading kubernetes (1.9MiB)
2026-08-24 15:16:25.992204 | instance |    Building pyperclip==1.9.0
2026-08-24 15:16:25.992235 | instance |  Downloading rjsonnet
2026-08-24 15:16:25.992256 | instance |  Downloading pydantic-core
2026-08-24 15:16:25.992275 | instance |  Downloading netaddr
2026-08-24 15:16:25.992293 | instance |  Downloading pygments
2026-08-24 15:16:25.992311 | instance |  Downloading cryptography
2026-08-24 15:16:25.992329 | instance |  Downloading setuptools
2026-08-24 15:16:25.992346 | instance |  Downloading kubernetes
2026-08-24 15:16:25.992363 | instance |  Downloading ansible-core
2026-08-24 15:16:25.992381 | instance |  Downloading openstacksdk
2026-08-24 15:16:25.992398 | instance |       Built pyperclip==1.9.0
2026-08-24 15:16:25.992415 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-24 15:16:25.992433 | instance | Installed 83 packages in 37ms
2026-08-24 15:16:25.992451 | instance | Checked out ansible.posix to 1.6.0
2026-08-24 15:16:25.992469 | 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 15:16:25.992487 | instance | Starting galaxy collection install process
2026-08-24 15:16:25.992504 | instance | Process install dependency map
2026-08-24 15:16:25.992528 | instance | Starting collection install process
2026-08-24 15:16:25.992547 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-08-24 15:16:25.992564 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-08-24 15:16:25.992581 | instance | ansible.posix:1.6.0 was installed successfully
2026-08-24 15:16:25.992599 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:16:25.992616 | instance | 2.17.12
2026-08-24 15:16:25.992633 | instance | Checked out ansible.utils to v6.1.0
2026-08-24 15:16:25.992651 | 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 15:16:25.992668 | instance | Starting galaxy collection install process
2026-08-24 15:16:25.992686 | instance | Process install dependency map
2026-08-24 15:16:25.992703 | instance | Starting collection install process
2026-08-24 15:16:25.992720 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-08-24 15:16:25.992738 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-08-24 15:16:25.992756 | instance | ansible.utils:6.1.0 was installed successfully
2026-08-24 15:16:25.992773 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:16:25.992790 | instance | 2.17.12
2026-08-24 15:16:25.992808 | instance | Checked out atmosphere.common to v0.7.0
2026-08-24 15:16:25.992826 | 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 15:16:25.992846 | instance | Starting galaxy collection install process
2026-08-24 15:16:25.992865 | instance | Process install dependency map
2026-08-24 15:16:25.992881 | instance | Starting collection install process
2026-08-24 15:16:25.992899 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-08-24 15:16:25.992916 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-08-24 15:16:25.992934 | instance | atmosphere.common:0.7.0 was installed successfully
2026-08-24 15:16:25.992951 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:16:25.993093 | instance | 2.17.12
2026-08-24 15:16:25.993120 | instance | Checked out community.crypto to 2.2.3
2026-08-24 15:16:25.993139 | 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 15:16:25.993158 | instance | Starting galaxy collection install process
2026-08-24 15:16:25.993177 | instance | Process install dependency map
2026-08-24 15:16:25.993218 | instance | Starting collection install process
2026-08-24 15:16:25.993247 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-08-24 15:16:25.993266 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-08-24 15:16:25.993285 | instance | community.crypto:2.2.3 was installed successfully
2026-08-24 15:16:25.993303 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:16:25.993321 | instance | 2.17.12
2026-08-24 15:16:25.993338 | instance | Checked out community.general to 7.3.0
2026-08-24 15:16:25.993356 | 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 15:16:25.993380 | instance | Starting galaxy collection install process
2026-08-24 15:16:25.993398 | instance | Process install dependency map
2026-08-24 15:16:25.993416 | instance | Starting collection install process
2026-08-24 15:16:25.993437 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-08-24 15:16:25.993455 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-08-24 15:16:25.993472 | instance | community.general:7.3.0 was installed successfully
2026-08-24 15:16:25.993492 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:16:25.993510 | instance | 2.17.12
2026-08-24 15:16:25.993528 | instance | Checked out community.mysql to 3.6.0
2026-08-24 15:16:25.993548 | 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 15:16:25.993566 | instance | Starting galaxy collection install process
2026-08-24 15:16:25.993584 | instance | Process install dependency map
2026-08-24 15:16:25.993602 | instance | Starting collection install process
2026-08-24 15:16:25.993649 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-08-24 15:16:25.993682 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-08-24 15:16:25.993707 | instance | community.mysql:3.6.0 was installed successfully
2026-08-24 15:16:25.993733 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:16:25.993759 | instance | 2.17.12
2026-08-24 15:16:25.993783 | instance | Checked out kubernetes.core to 2.4.0
2026-08-24 15:16:25.993809 | 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 15:16:25.993832 | instance | Starting galaxy collection install process
2026-08-24 15:16:25.993855 | instance | Process install dependency map
2026-08-24 15:16:25.993877 | instance | Starting collection install process
2026-08-24 15:16:25.993901 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-08-24 15:16:25.993924 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-08-24 15:16:25.993949 | instance | kubernetes.core:2.4.0 was installed successfully
2026-08-24 15:16:25.993974 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:16:25.993997 | instance | 2.17.12
2026-08-24 15:16:25.994022 | instance | Checked out openstack.cloud to 2.6.0
2026-08-24 15:16:25.994048 | 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 15:16:25.994071 | instance | Starting galaxy collection install process
2026-08-24 15:16:25.994093 | instance | Process install dependency map
2026-08-24 15:16:25.994114 | instance | Starting collection install process
2026-08-24 15:16:25.994137 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-08-24 15:16:25.994158 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-08-24 15:16:25.994182 | instance | openstack.cloud:2.6.0 was installed successfully
2026-08-24 15:16:25.994207 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:16:25.994230 | instance | 2.17.12
2026-08-24 15:16:25.994259 | instance | Checked out vexxhost.ceph to v4.2.0
2026-08-24 15:16:25.994283 | 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 15:16:25.994306 | instance | Starting galaxy collection install process
2026-08-24 15:16:25.994328 | instance | Process install dependency map
2026-08-24 15:16:25.994350 | instance | Starting collection install process
2026-08-24 15:16:25.994370 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-08-24 15:16:25.994388 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-08-24 15:16:25.994412 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-08-24 15:16:25.994438 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:16:25.994461 | instance | 2.17.12
2026-08-24 15:16:25.994482 | instance | Checked out vexxhost.containers to v1.6.8
2026-08-24 15:16:25.994501 | 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 15:16:25.994518 | instance | Starting galaxy collection install process
2026-08-24 15:16:25.994537 | instance | Process install dependency map
2026-08-24 15:16:25.994554 | instance | Starting collection install process
2026-08-24 15:16:25.994572 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-08-24 15:16:25.994589 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-08-24 15:16:25.994607 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-08-24 15:16:25.994625 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:16:25.994643 | instance | 2.17.12
2026-08-24 15:16:25.994660 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-08-24 15:16:25.994679 | 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 15:16:25.994696 | instance | Starting galaxy collection install process
2026-08-24 15:16:25.994714 | instance | Process install dependency map
2026-08-24 15:16:25.994731 | instance | Starting collection install process
2026-08-24 15:16:25.994748 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-08-24 15:16:25.994765 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-08-24 15:16:25.994784 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-08-24 15:16:25.994809 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 15:16:25.994837 | instance | 2.17.12
2026-08-24 15:16:26.001534 | 
2026-08-24 15:16:26.001601 | PLAY RECAP
2026-08-24 15:16:26.001650 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-24 15:16:26.001672 | 
2026-08-24 15:16:26.141150 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-24 15:16:26.144167 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-24 15:16:26.776467 | 
2026-08-24 15:16:26.776584 | PLAY [all]
2026-08-24 15:16:26.787844 | 
2026-08-24 15:16:26.787934 | TASK [Install "jq" for log collection]
2026-08-24 15:16:36.678536 | instance | changed
2026-08-24 15:16:36.681055 | 
2026-08-24 15:16:36.681157 | PLAY RECAP
2026-08-24 15:16:36.681239 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-24 15:16:36.681322 | 
2026-08-24 15:16:36.809511 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-24 15:16:36.812183 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-24 15:16:37.456244 | 
2026-08-24 15:16:37.456377 | PLAY [all]
2026-08-24 15:16:37.467198 | 
2026-08-24 15:16:37.467272 | LOOP [Check inventory directories]
2026-08-24 15:16:37.793729 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-08-24 15:16:37.949294 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-08-24 15:16:38.107486 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-08-24 15:16:38.119988 | 
2026-08-24 15:16:38.120217 | LOOP [Copy inventory file for Zuul]
2026-08-24 15:16:38.912341 | instance | changed:
2026-08-24 15:16:38.912546 | instance | {
2026-08-24 15:16:38.912575 | instance |   "ansible_loop_var": "item",
2026-08-24 15:16:38.912598 | instance |   "changed": false,
2026-08-24 15:16:38.912618 | instance |   "failed": false,
2026-08-24 15:16:38.912642 | instance |   "invocation": {
2026-08-24 15:16:38.912661 | instance |     "module_args": {
2026-08-24 15:16:38.912680 | instance |       "checksum_algorithm": "sha1",
2026-08-24 15:16:38.912697 | instance |       "follow": true,
2026-08-24 15:16:38.912715 | instance |       "get_attributes": true,
2026-08-24 15:16:38.912733 | instance |       "get_checksum": true,
2026-08-24 15:16:38.912751 | instance |       "get_mime": true,
2026-08-24 15:16:38.912768 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-08-24 15:16:38.912786 | instance |     }
2026-08-24 15:16:38.912803 | instance |   },
2026-08-24 15:16:38.912820 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-08-24 15:16:38.912837 | instance |   "stat": {
2026-08-24 15:16:38.912855 | instance |     "atime": 1787584578.984283,
2026-08-24 15:16:38.912873 | instance |     "attr_flags": "e",
2026-08-24 15:16:38.912890 | instance |     "attributes": [
2026-08-24 15:16:38.912908 | instance |       "extents"
2026-08-24 15:16:38.912924 | instance |     ],
2026-08-24 15:16:38.912941 | instance |     "block_size": 4096,
2026-08-24 15:16:38.912975 | instance |     "blocks": 8,
2026-08-24 15:16:38.912996 | instance |     "charset": "unknown",
2026-08-24 15:16:38.913014 | instance |     "ctime": 1787584578.0402777,
2026-08-24 15:16:38.913031 | instance |     "dev": 64513,
2026-08-24 15:16:38.913048 | instance |     "device_type": 0,
2026-08-24 15:16:38.913065 | instance |     "executable": true,
2026-08-24 15:16:38.913082 | instance |     "exists": true,
2026-08-24 15:16:38.913099 | instance |     "gid": 1000,
2026-08-24 15:16:38.913116 | instance |     "gr_name": "zuul",
2026-08-24 15:16:38.913133 | instance |     "inode": 1047860,
2026-08-24 15:16:38.913150 | instance |     "isblk": false,
2026-08-24 15:16:38.913167 | instance |     "ischr": false,
2026-08-24 15:16:38.913184 | instance |     "isdir": true,
2026-08-24 15:16:38.913204 | instance |     "isfifo": false,
2026-08-24 15:16:38.913251 | instance |     "isgid": false,
2026-08-24 15:16:38.913276 | instance |     "islnk": false,
2026-08-24 15:16:38.913294 | instance |     "isreg": false,
2026-08-24 15:16:38.913315 | instance |     "issock": false,
2026-08-24 15:16:38.913334 | instance |     "isuid": false,
2026-08-24 15:16:38.913351 | instance |     "mimetype": "unknown",
2026-08-24 15:16:38.913368 | instance |     "mode": "0755",
2026-08-24 15:16:38.913385 | instance |     "mtime": 1787584578.0402777,
2026-08-24 15:16:38.913402 | instance |     "nlink": 23,
2026-08-24 15:16:38.913419 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-08-24 15:16:38.913436 | instance |     "pw_name": "zuul",
2026-08-24 15:16:38.913455 | instance |     "readable": true,
2026-08-24 15:16:38.913472 | instance |     "rgrp": true,
2026-08-24 15:16:38.913489 | instance |     "roth": true,
2026-08-24 15:16:38.913521 | instance |     "rusr": true,
2026-08-24 15:16:38.913539 | instance |     "size": 4096,
2026-08-24 15:16:38.913556 | instance |     "uid": 1000,
2026-08-24 15:16:38.913573 | instance |     "version": "4189820849",
2026-08-24 15:16:38.913590 | instance |     "wgrp": false,
2026-08-24 15:16:38.913609 | instance |     "woth": false,
2026-08-24 15:16:38.913625 | instance |     "writeable": true,
2026-08-24 15:16:38.913642 | instance |     "wusr": true,
2026-08-24 15:16:38.913812 | instance |     "xgrp": true,
2026-08-24 15:16:38.913840 | instance |     "xoth": true,
2026-08-24 15:16:38.913863 | instance |     "xusr": true
2026-08-24 15:16:38.913884 | instance |   }
2026-08-24 15:16:38.913906 | instance | }
2026-08-24 15:16:38.913945 | instance | ok: All items complete
2026-08-24 15:16:38.913972 | 
2026-08-24 15:16:38.915383 | instance | skipping: Conditional result was False
2026-08-24 15:16:38.916143 | instance | skipping: Conditional result was False
2026-08-24 15:16:38.927887 | 
2026-08-24 15:16:38.928026 | LOOP [Switch "ansible_host" to private IP]
2026-08-24 15:16:39.308358 | instance | changed: 1 replacements made
2026-08-24 15:16:39.309816 | instance | skipping: Conditional result was False
2026-08-24 15:16:39.310486 | instance | skipping: Conditional result was False
2026-08-24 15:16:39.328135 | 
2026-08-24 15:16:39.328276 | TASK [Run Molecule scenario]
2026-08-24 15:16:40.285434 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-08-24 15:16:40.675089 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-08-24 15:16:40.675160 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-08-24 15:16:51.091571 | instance | INFO     [csi > dependency] Executing
2026-08-24 15:16:51.091814 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-08-24 15:16:51.092042 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-08-24 15:16:51.092187 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-08-24 15:16:51.099739 | instance | INFO     [csi > cleanup] Executing
2026-08-24 15:16:51.100077 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-24 15:16:51.107704 | instance | INFO     [csi > destroy] Executing
2026-08-24 15:16:51.107785 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-08-24 15:16:51.107893 | instance | INFO     [csi > destroy] Executed: Successful
2026-08-24 15:16:51.115460 | instance | INFO     [csi > syntax] Executing
2026-08-24 15:16:52.698856 | instance |
2026-08-24 15:16:52.698938 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-24 15:16:52.760591 | instance | INFO     [csi > syntax] Executed: Successful
2026-08-24 15:16:52.774384 | instance | INFO     [csi > create] Executing
2026-08-24 15:16:52.776307 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-24 15:16:52.783947 | instance | INFO     [csi > prepare] Executing
2026-08-24 15:16:53.557415 | instance |
2026-08-24 15:16:53.557758 | instance | PLAY [Prepare] *****************************************************************
2026-08-24 15:16:53.558158 | instance |
2026-08-24 15:16:53.558429 | instance | TASK [Gathering Facts] *********************************************************
2026-08-24 15:16:53.558781 | instance | Monday 24 August 2026  15:16:53 +0000 (0:00:00.023)       0:00:00.023 *********
2026-08-24 15:16:54.669025 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-24 15:16:54.669293 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-24 15:16:54.669567 | instance | interpreter could change the meaning of that path. See
2026-08-24 15:16:54.669833 | instance | https://docs.ansible.com/ansible-
2026-08-24 15:16:54.670101 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-24 15:16:54.679655 | instance | ok: [instance]
2026-08-24 15:16:54.679798 | instance |
2026-08-24 15:16:54.679967 | instance | TASK [Configure short hostname] ************************************************
2026-08-24 15:16:54.680140 | instance | Monday 24 August 2026  15:16:54 +0000 (0:00:01.123)       0:00:01.147 *********
2026-08-24 15:16:55.309988 | instance | changed: [instance]
2026-08-24 15:16:55.310290 | instance |
2026-08-24 15:16:55.310671 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-08-24 15:16:55.310996 | instance | Monday 24 August 2026  15:16:55 +0000 (0:00:00.629)       0:00:01.777 *********
2026-08-24 15:16:55.544393 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-08-24 15:16:55.544693 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-08-24 15:16:55.544949 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-08-24 15:16:55.552181 | instance | changed: [instance]
2026-08-24 15:16:55.552434 | instance |
2026-08-24 15:16:55.552713 | instance | TASK [Purge "snapd" package] ***************************************************
2026-08-24 15:16:55.553049 | instance | Monday 24 August 2026  15:16:55 +0000 (0:00:00.242)       0:00:02.019 *********
2026-08-24 15:16:56.297714 | instance | ok: [instance]
2026-08-24 15:16:56.297968 | instance |
2026-08-24 15:16:56.298257 | instance | PLAY [Create devices for Ceph] *************************************************
2026-08-24 15:16:56.298503 | instance |
2026-08-24 15:16:56.298776 | instance | TASK [Gathering Facts] *********************************************************
2026-08-24 15:16:56.299221 | instance | Monday 24 August 2026  15:16:56 +0000 (0:00:00.745)       0:00:02.764 *********
2026-08-24 15:16:56.987852 | instance | ok: [instance]
2026-08-24 15:16:56.988123 | instance |
2026-08-24 15:16:56.988538 | instance | TASK [Install depedencies] *****************************************************
2026-08-24 15:16:56.988881 | instance | Monday 24 August 2026  15:16:56 +0000 (0:00:00.690)       0:00:03.455 *********
2026-08-24 15:17:16.048547 | instance | changed: [instance]
2026-08-24 15:17:16.048722 | instance |
2026-08-24 15:17:16.049048 | instance | TASK [Start up service] ********************************************************
2026-08-24 15:17:16.049326 | instance | Monday 24 August 2026  15:17:16 +0000 (0:00:19.060)       0:00:22.515 *********
2026-08-24 15:17:16.573381 | instance | ok: [instance]
2026-08-24 15:17:16.573635 | instance |
2026-08-24 15:17:16.573948 | instance | TASK [Generate lvm.conf] *******************************************************
2026-08-24 15:17:16.574251 | instance | Monday 24 August 2026  15:17:16 +0000 (0:00:00.525)       0:00:23.040 *********
2026-08-24 15:17:16.852136 | instance | ok: [instance]
2026-08-24 15:17:16.852458 | instance |
2026-08-24 15:17:16.852764 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-08-24 15:17:16.853050 | instance | Monday 24 August 2026  15:17:16 +0000 (0:00:00.278)       0:00:23.318 *********
2026-08-24 15:17:17.472506 | instance | changed: [instance]
2026-08-24 15:17:17.472759 | instance |
2026-08-24 15:17:17.473043 | instance | TASK [Get list of all loopback devices] ****************************************
2026-08-24 15:17:17.473319 | instance | Monday 24 August 2026  15:17:17 +0000 (0:00:00.620)       0:00:23.939 *********
2026-08-24 15:17:17.647119 | instance | ok: [instance]
2026-08-24 15:17:17.647391 | instance |
2026-08-24 15:17:17.647765 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-08-24 15:17:17.648055 | instance | Monday 24 August 2026  15:17:17 +0000 (0:00:00.174)       0:00:24.113 *********
2026-08-24 15:17:17.665755 | instance | skipping: [instance]
2026-08-24 15:17:17.665993 | instance |
2026-08-24 15:17:17.666263 | instance | TASK [Create devices for Ceph] *************************************************
2026-08-24 15:17:17.666533 | instance | Monday 24 August 2026  15:17:17 +0000 (0:00:00.019)       0:00:24.133 *********
2026-08-24 15:17:18.167096 | instance | changed: [instance] => (item=osd0)
2026-08-24 15:17:18.167344 | instance | changed: [instance] => (item=osd1)
2026-08-24 15:17:18.167669 | instance | changed: [instance] => (item=osd2)
2026-08-24 15:17:18.168031 | instance |
2026-08-24 15:17:18.168319 | instance | TASK [Set permissions on loopback devices] *************************************
2026-08-24 15:17:18.168593 | instance | Monday 24 August 2026  15:17:18 +0000 (0:00:00.500)       0:00:24.634 *********
2026-08-24 15:17:18.746460 | instance | changed: [instance] => (item=osd0)
2026-08-24 15:17:18.746583 | instance | changed: [instance] => (item=osd1)
2026-08-24 15:17:18.746591 | instance | changed: [instance] => (item=osd2)
2026-08-24 15:17:18.746597 | instance |
2026-08-24 15:17:18.746603 | instance | TASK [Start loop devices] ******************************************************
2026-08-24 15:17:18.746778 | instance | Monday 24 August 2026  15:17:18 +0000 (0:00:00.578)       0:00:25.212 *********
2026-08-24 15:17:19.439156 | instance | changed: [instance] => (item=osd0)
2026-08-24 15:17:19.439539 | instance | changed: [instance] => (item=osd1)
2026-08-24 15:17:19.439601 | instance | changed: [instance] => (item=osd2)
2026-08-24 15:17:19.439770 | instance |
2026-08-24 15:17:19.439962 | instance | TASK [Create a volume group for each loop device] ******************************
2026-08-24 15:17:19.440157 | instance | Monday 24 August 2026  15:17:19 +0000 (0:00:00.694)       0:00:25.906 *********
2026-08-24 15:17:22.433961 | instance | changed: [instance] => (item=osd0)
2026-08-24 15:17:22.434224 | instance | changed: [instance] => (item=osd1)
2026-08-24 15:17:22.434492 | instance | changed: [instance] => (item=osd2)
2026-08-24 15:17:22.434755 | instance |
2026-08-24 15:17:22.435038 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-08-24 15:17:22.435317 | instance | Monday 24 August 2026  15:17:22 +0000 (0:00:02.994)       0:00:28.900 *********
2026-08-24 15:17:24.230041 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-08-24 15:17:24.231494 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-08-24 15:17:24.231526 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-08-24 15:17:24.231533 | instance |
2026-08-24 15:17:24.231540 | instance | PLAY RECAP *********************************************************************
2026-08-24 15:17:24.231546 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-08-24 15:17:24.231552 | instance |
2026-08-24 15:17:24.231558 | instance | Monday 24 August 2026  15:17:24 +0000 (0:00:01.797)       0:00:30.697 *********
2026-08-24 15:17:24.231563 | instance | ===============================================================================
2026-08-24 15:17:24.231569 | instance | Install depedencies ---------------------------------------------------- 19.06s
2026-08-24 15:17:24.231574 | instance | Create a volume group for each loop device ------------------------------ 2.99s
2026-08-24 15:17:24.231580 | instance | Create a logical volume for each loop device ---------------------------- 1.80s
2026-08-24 15:17:24.231586 | instance | Gathering Facts --------------------------------------------------------- 1.12s
2026-08-24 15:17:24.231614 | instance | Purge "snapd" package --------------------------------------------------- 0.75s
2026-08-24 15:17:24.231734 | instance | Start loop devices ------------------------------------------------------ 0.69s
2026-08-24 15:17:24.231869 | instance | Gathering Facts --------------------------------------------------------- 0.69s
2026-08-24 15:17:24.232008 | instance | Configure short hostname ------------------------------------------------ 0.63s
2026-08-24 15:17:24.232153 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.62s
2026-08-24 15:17:24.232312 | instance | Set permissions on loopback devices ------------------------------------- 0.58s
2026-08-24 15:17:24.232469 | instance | Start up service -------------------------------------------------------- 0.53s
2026-08-24 15:17:24.232623 | instance | Create devices for Ceph ------------------------------------------------- 0.50s
2026-08-24 15:17:24.232784 | instance | Generate lvm.conf ------------------------------------------------------- 0.28s
2026-08-24 15:17:24.232946 | instance | Ensure hostname inside hosts file --------------------------------------- 0.24s
2026-08-24 15:17:24.233103 | instance | Get list of all loopback devices ---------------------------------------- 0.17s
2026-08-24 15:17:24.233243 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s
2026-08-24 15:17:24.293363 | instance | INFO     [csi > prepare] Executed: Successful
2026-08-24 15:17:24.304426 | instance | INFO     [csi > converge] Executing
2026-08-24 15:17:25.777567 | instance |
2026-08-24 15:17:25.777818 | instance | PLAY [Debug CSI driver value] **************************************************
2026-08-24 15:17:25.778066 | instance |
2026-08-24 15:17:25.778344 | instance | TASK [Gathering Facts] *********************************************************
2026-08-24 15:17:25.778619 | instance | Monday 24 August 2026  15:17:25 +0000 (0:00:00.007)       0:00:00.007 *********
2026-08-24 15:17:26.681667 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-24 15:17:26.681933 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-24 15:17:26.682254 | instance | interpreter could change the meaning of that path. See
2026-08-24 15:17:26.682491 | instance | https://docs.ansible.com/ansible-
2026-08-24 15:17:26.682764 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-24 15:17:26.692138 | instance | ok: [instance]
2026-08-24 15:17:26.692389 | instance |
2026-08-24 15:17:26.692656 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-08-24 15:17:26.692918 | instance | Monday 24 August 2026  15:17:26 +0000 (0:00:00.915)       0:00:00.923 *********
2026-08-24 15:17:26.737070 | instance | ok: [instance] => {
2026-08-24 15:17:26.737338 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-08-24 15:17:26.737596 | instance | }
2026-08-24 15:17:26.737803 | instance |
2026-08-24 15:17:26.738063 | instance | PLAY [all] *********************************************************************
2026-08-24 15:17:26.738309 | instance |
2026-08-24 15:17:26.738575 | instance | TASK [Gathering Facts] *********************************************************
2026-08-24 15:17:26.738845 | instance | Monday 24 August 2026  15:17:26 +0000 (0:00:00.044)       0:00:00.968 *********
2026-08-24 15:17:27.555165 | instance | ok: [instance]
2026-08-24 15:17:27.555282 | instance |
2026-08-24 15:17:27.555480 | instance | TASK [Fail if atmosphere_ceph_enabled is set] **********************************
2026-08-24 15:17:27.555765 | instance | Monday 24 August 2026  15:17:27 +0000 (0:00:00.818)       0:00:01.786 *********
2026-08-24 15:17:27.585194 | instance | skipping: [instance]
2026-08-24 15:17:27.585300 | instance |
2026-08-24 15:17:27.585427 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-08-24 15:17:27.585552 | instance | Monday 24 August 2026  15:17:27 +0000 (0:00:00.030)       0:00:01.816 *********
2026-08-24 15:17:27.767523 | instance | ok: [instance]
2026-08-24 15:17:27.767848 | instance |
2026-08-24 15:17:27.768156 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-08-24 15:17:27.768434 | instance |
2026-08-24 15:17:27.768721 | instance | TASK [Gathering Facts] *********************************************************
2026-08-24 15:17:27.769032 | instance | Monday 24 August 2026  15:17:27 +0000 (0:00:00.182)       0:00:01.998 *********
2026-08-24 15:17:28.629583 | instance | ok: [instance]
2026-08-24 15:17:28.629968 | instance |
2026-08-24 15:17:28.630315 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-24 15:17:28.630652 | instance | Monday 24 August 2026  15:17:28 +0000 (0:00:00.861)       0:00:02.860 *********
2026-08-24 15:17:28.932039 | instance | ok: [instance]
2026-08-24 15:17:28.932296 | instance |
2026-08-24 15:17:28.932522 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-24 15:17:28.932723 | instance | Monday 24 August 2026  15:17:28 +0000 (0:00:00.300)       0:00:03.161 *********
2026-08-24 15:17:28.971913 | instance | skipping: [instance]
2026-08-24 15:17:28.972030 | instance |
2026-08-24 15:17:28.972176 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-08-24 15:17:28.972373 | instance | Monday 24 August 2026  15:17:28 +0000 (0:00:00.040)       0:00:03.201 *********
2026-08-24 15:17:29.293037 | instance | changed: [instance]
2026-08-24 15:17:29.293086 | instance |
2026-08-24 15:17:29.293092 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-24 15:17:29.293097 | instance | Monday 24 August 2026  15:17:29 +0000 (0:00:00.322)       0:00:03.523 *********
2026-08-24 15:17:29.355422 | instance | ok: [instance] => {
2026-08-24 15:17:29.355468 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-08-24 15:17:29.355475 | instance | }
2026-08-24 15:17:29.355479 | instance |
2026-08-24 15:17:29.355484 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-24 15:17:29.355488 | instance | Monday 24 August 2026  15:17:29 +0000 (0:00:00.062)       0:00:03.586 *********
2026-08-24 15:17:30.010094 | instance | changed: [instance]
2026-08-24 15:17:30.010157 | instance |
2026-08-24 15:17:30.010441 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-24 15:17:30.010473 | instance | Monday 24 August 2026  15:17:30 +0000 (0:00:00.654)       0:00:04.241 *********
2026-08-24 15:17:30.059726 | instance | skipping: [instance]
2026-08-24 15:17:30.060139 | instance |
2026-08-24 15:17:30.060163 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-24 15:17:30.060169 | instance | Monday 24 August 2026  15:17:30 +0000 (0:00:00.049)       0:00:04.291 *********
2026-08-24 15:17:30.108445 | instance | skipping: [instance]
2026-08-24 15:17:30.108523 | instance |
2026-08-24 15:17:30.108839 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-24 15:17:30.108866 | instance | Monday 24 August 2026  15:17:30 +0000 (0:00:00.048)       0:00:04.339 *********
2026-08-24 15:17:30.319750 | instance | ok: [instance]
2026-08-24 15:17:30.319851 | instance |
2026-08-24 15:17:30.320107 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-24 15:17:30.320143 | instance | Monday 24 August 2026  15:17:30 +0000 (0:00:00.211)       0:00:04.551 *********
2026-08-24 15:17:31.438702 | instance | ok: [instance]
2026-08-24 15:17:31.438737 | instance |
2026-08-24 15:17:31.438743 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-24 15:17:31.438757 | instance | Monday 24 August 2026  15:17:31 +0000 (0:00:01.118)       0:00:05.669 *********
2026-08-24 15:17:31.502762 | instance | ok: [instance] => {
2026-08-24 15:17:31.502797 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-08-24 15:17:31.502802 | instance | }
2026-08-24 15:17:31.502807 | instance |
2026-08-24 15:17:31.502811 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-24 15:17:31.502816 | instance | Monday 24 August 2026  15:17:31 +0000 (0:00:00.063)       0:00:05.733 *********
2026-08-24 15:17:32.237838 | instance | changed: [instance]
2026-08-24 15:17:32.237967 | instance |
2026-08-24 15:17:32.238248 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-24 15:17:32.238292 | instance | Monday 24 August 2026  15:17:32 +0000 (0:00:00.735)       0:00:06.468 *********
2026-08-24 15:17:36.020309 | instance | changed: [instance]
2026-08-24 15:17:36.020401 | instance |
2026-08-24 15:17:36.020654 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-08-24 15:17:36.020670 | instance | Monday 24 August 2026  15:17:36 +0000 (0:00:03.782)       0:00:10.251 *********
2026-08-24 15:17:36.053502 | instance | skipping: [instance]
2026-08-24 15:17:36.053610 | instance |
2026-08-24 15:17:36.053912 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-08-24 15:17:36.054053 | instance | Monday 24 August 2026  15:17:36 +0000 (0:00:00.033)       0:00:10.285 *********
2026-08-24 15:17:36.085728 | instance | skipping: [instance]
2026-08-24 15:17:36.085835 | instance |
2026-08-24 15:17:36.085958 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-08-24 15:17:36.086077 | instance | Monday 24 August 2026  15:17:36 +0000 (0:00:00.032)       0:00:10.317 *********
2026-08-24 15:17:36.115183 | instance | skipping: [instance]
2026-08-24 15:17:36.115313 | instance |
2026-08-24 15:17:36.115549 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-08-24 15:17:36.115611 | instance | Monday 24 August 2026  15:17:36 +0000 (0:00:00.029)       0:00:10.346 *********
2026-08-24 15:17:41.301715 | instance | changed: [instance]
2026-08-24 15:17:41.301794 | instance |
2026-08-24 15:17:41.302091 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-08-24 15:17:41.302121 | instance | Monday 24 August 2026  15:17:41 +0000 (0:00:05.186)       0:00:15.533 *********
2026-08-24 15:17:41.876899 | instance | changed: [instance]
2026-08-24 15:17:41.877407 | instance |
2026-08-24 15:17:41.877444 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-08-24 15:17:41.877452 | instance | Monday 24 August 2026  15:17:41 +0000 (0:00:00.575)       0:00:16.108 *********
2026-08-24 15:17:42.750008 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-08-24 15:17:42.750076 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-08-24 15:17:42.750864 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-08-24 15:17:42.750906 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-08-24 15:17:42.750913 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-08-24 15:17:42.750918 | instance |
2026-08-24 15:17:42.750922 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-08-24 15:17:42.750926 | instance | Monday 24 August 2026  15:17:42 +0000 (0:00:00.873)       0:00:16.981 *********
2026-08-24 15:17:43.296136 | instance | changed: [instance]
2026-08-24 15:17:43.296202 | instance |
2026-08-24 15:17:43.296856 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-08-24 15:17:43.296894 | instance | Monday 24 August 2026  15:17:43 +0000 (0:00:00.530)       0:00:17.511 *********
2026-08-24 15:17:43.296899 | instance |
2026-08-24 15:17:43.296904 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-24 15:17:43.296908 | instance | Monday 24 August 2026  15:17:43 +0000 (0:00:00.015)       0:00:17.527 *********
2026-08-24 15:17:44.184629 | instance | ok: [instance]
2026-08-24 15:17:44.184713 | instance |
2026-08-24 15:17:44.184983 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-08-24 15:17:44.185015 | instance | Monday 24 August 2026  15:17:44 +0000 (0:00:00.888)       0:00:18.416 *********
2026-08-24 15:17:44.604875 | instance | changed: [instance]
2026-08-24 15:17:44.604961 | instance |
2026-08-24 15:17:44.605224 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-08-24 15:17:44.605260 | instance | Monday 24 August 2026  15:17:44 +0000 (0:00:00.420)       0:00:18.836 *********
2026-08-24 15:17:45.140625 | instance | changed: [instance]
2026-08-24 15:17:45.140698 | instance |
2026-08-24 15:17:45.140979 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-24 15:17:45.141015 | instance | Monday 24 August 2026  15:17:45 +0000 (0:00:00.535)       0:00:19.372 *********
2026-08-24 15:17:45.347944 | instance | ok: [instance]
2026-08-24 15:17:45.347979 | instance |
2026-08-24 15:17:45.347985 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-24 15:17:45.347989 | instance | Monday 24 August 2026  15:17:45 +0000 (0:00:00.206)       0:00:19.578 *********
2026-08-24 15:17:45.397976 | instance | ok: [instance] => {
2026-08-24 15:17:45.398625 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-08-24 15:17:45.398668 | instance | }
2026-08-24 15:17:45.398674 | instance |
2026-08-24 15:17:45.398678 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-24 15:17:45.398683 | instance | Monday 24 August 2026  15:17:45 +0000 (0:00:00.050)       0:00:19.629 *********
2026-08-24 15:17:46.181717 | instance | changed: [instance]
2026-08-24 15:17:46.182233 | instance |
2026-08-24 15:17:46.182273 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-24 15:17:46.182281 | instance | Monday 24 August 2026  15:17:46 +0000 (0:00:00.783)       0:00:20.413 *********
2026-08-24 15:17:50.450347 | instance | changed: [instance]
2026-08-24 15:17:50.450419 | instance |
2026-08-24 15:17:50.450708 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-08-24 15:17:50.450744 | instance | Monday 24 August 2026  15:17:50 +0000 (0:00:04.268)       0:00:24.681 *********
2026-08-24 15:17:51.476512 | instance | ok: [instance]
2026-08-24 15:17:51.476733 | instance |
2026-08-24 15:17:51.477037 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-08-24 15:17:51.477081 | instance | Monday 24 August 2026  15:17:51 +0000 (0:00:01.025)       0:00:25.707 *********
2026-08-24 15:17:51.811489 | instance | changed: [instance]
2026-08-24 15:17:51.811560 | instance |
2026-08-24 15:17:51.811838 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-08-24 15:17:51.811874 | instance | Monday 24 August 2026  15:17:51 +0000 (0:00:00.335)       0:00:26.042 *********
2026-08-24 15:17:52.253770 | instance | changed: [instance]
2026-08-24 15:17:52.253923 | instance |
2026-08-24 15:17:52.254315 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-08-24 15:17:52.254354 | instance | Monday 24 August 2026  15:17:52 +0000 (0:00:00.442)       0:00:26.485 *********
2026-08-24 15:17:52.796749 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-08-24 15:17:52.797397 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-08-24 15:17:52.797433 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-08-24 15:17:52.797438 | instance |
2026-08-24 15:17:52.797443 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-08-24 15:17:52.797448 | instance | Monday 24 August 2026  15:17:52 +0000 (0:00:00.543)       0:00:27.028 *********
2026-08-24 15:17:53.223383 | instance | changed: [instance]
2026-08-24 15:17:53.223479 | instance |
2026-08-24 15:17:53.223758 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-08-24 15:17:53.223794 | instance | Monday 24 August 2026  15:17:53 +0000 (0:00:00.425)       0:00:27.453 *********
2026-08-24 15:17:53.680564 | instance | changed: [instance]
2026-08-24 15:17:53.680654 | instance |
2026-08-24 15:17:53.681309 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-08-24 15:17:53.681357 | instance | Monday 24 August 2026  15:17:53 +0000 (0:00:00.441)       0:00:27.895 *********
2026-08-24 15:17:53.681363 | instance |
2026-08-24 15:17:53.681368 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-24 15:17:53.681376 | instance | Monday 24 August 2026  15:17:53 +0000 (0:00:00.016)       0:00:27.912 *********
2026-08-24 15:17:54.348558 | instance | ok: [instance]
2026-08-24 15:17:54.348624 | instance |
2026-08-24 15:17:54.348901 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-08-24 15:17:54.348938 | instance | Monday 24 August 2026  15:17:54 +0000 (0:00:00.667)       0:00:28.580 *********
2026-08-24 15:17:55.518464 | instance | changed: [instance]
2026-08-24 15:17:55.518554 | instance |
2026-08-24 15:17:55.518797 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-08-24 15:17:55.518833 | instance | Monday 24 August 2026  15:17:55 +0000 (0:00:01.169)       0:00:29.749 *********
2026-08-24 15:17:56.034526 | instance | changed: [instance]
2026-08-24 15:17:56.034593 | instance |
2026-08-24 15:17:56.034878 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-08-24 15:17:56.034910 | instance | Monday 24 August 2026  15:17:56 +0000 (0:00:00.516)       0:00:30.266 *********
2026-08-24 15:17:56.086124 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-08-24 15:17:56.086183 | instance |
2026-08-24 15:17:56.086546 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-08-24 15:17:56.086575 | instance | Monday 24 August 2026  15:17:56 +0000 (0:00:00.051)       0:00:30.317 *********
2026-08-24 15:18:01.066695 | instance | changed: [instance]
2026-08-24 15:18:01.066769 | instance |
2026-08-24 15:18:01.067037 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-08-24 15:18:01.067136 | instance | Monday 24 August 2026  15:18:01 +0000 (0:00:04.980)       0:00:35.298 *********
2026-08-24 15:18:01.705538 | instance | ok: [instance] => (item=chronyd)
2026-08-24 15:18:01.705654 | instance | ok: [instance] => (item=sshd)
2026-08-24 15:18:01.706026 | instance |
2026-08-24 15:18:01.706064 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-08-24 15:18:01.706070 | instance | Monday 24 August 2026  15:18:01 +0000 (0:00:00.638)       0:00:35.936 *********
2026-08-24 15:18:02.512452 | instance | changed: [instance]
2026-08-24 15:18:02.512506 | instance |
2026-08-24 15:18:02.512767 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-08-24 15:18:02.512783 | instance | Monday 24 August 2026  15:18:02 +0000 (0:00:00.806)       0:00:36.743 *********
2026-08-24 15:18:02.716055 | instance | ok: [instance]
2026-08-24 15:18:02.716495 | instance |
2026-08-24 15:18:02.716657 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-08-24 15:18:02.716665 | instance | Monday 24 August 2026  15:18:02 +0000 (0:00:00.203)       0:00:36.947 *********
2026-08-24 15:18:03.158105 | instance | changed: [instance]
2026-08-24 15:18:03.160817 | instance |
2026-08-24 15:18:03.160886 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-08-24 15:18:03.160898 | instance | Monday 24 August 2026  15:18:03 +0000 (0:00:00.442)       0:00:37.389 *********
2026-08-24 15:18:03.510977 | instance | changed: [instance]
2026-08-24 15:18:03.511070 | instance |
2026-08-24 15:18:03.511318 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-08-24 15:18:03.511333 | instance | Monday 24 August 2026  15:18:03 +0000 (0:00:00.353)       0:00:37.742 *********
2026-08-24 15:18:03.688787 | instance | ok: [instance]
2026-08-24 15:18:03.688884 | instance |
2026-08-24 15:18:03.689140 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-08-24 15:18:03.689155 | instance | Monday 24 August 2026  15:18:03 +0000 (0:00:00.177)       0:00:37.920 *********
2026-08-24 15:18:03.901249 | instance | ok: [instance] => (item=instance)
2026-08-24 15:18:03.901341 | instance |
2026-08-24 15:18:03.901566 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-08-24 15:18:03.901604 | instance | Monday 24 August 2026  15:18:03 +0000 (0:00:00.212)       0:00:38.132 *********
2026-08-24 15:18:03.954076 | instance | ok: [instance]
2026-08-24 15:18:03.954141 | instance |
2026-08-24 15:18:03.954401 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-08-24 15:18:03.954581 | instance | Monday 24 August 2026  15:18:03 +0000 (0:00:00.052)       0:00:38.185 *********
2026-08-24 15:18:04.029346 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-08-24 15:18:04.029449 | instance |
2026-08-24 15:18:04.029581 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-08-24 15:18:04.029699 | instance | Monday 24 August 2026  15:18:04 +0000 (0:00:00.075)       0:00:38.260 *********
2026-08-24 15:18:04.295661 | instance | changed: [instance]
2026-08-24 15:18:04.295926 | instance |
2026-08-24 15:18:04.296236 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-08-24 15:18:04.296515 | instance | Monday 24 August 2026  15:18:04 +0000 (0:00:00.266)       0:00:38.526 *********
2026-08-24 15:18:04.934716 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-08-24 15:18:04.935085 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-08-24 15:18:04.935395 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-08-24 15:18:04.935700 | instance |
2026-08-24 15:18:04.936006 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-08-24 15:18:04.936297 | instance | Monday 24 August 2026  15:18:04 +0000 (0:00:00.638)       0:00:39.165 *********
2026-08-24 15:19:29.278549 | instance | ok: [instance]
2026-08-24 15:19:29.278607 | instance |
2026-08-24 15:19:29.278626 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-08-24 15:19:29.278828 | instance | Monday 24 August 2026  15:19:29 +0000 (0:01:24.343)       0:02:03.508 *********
2026-08-24 15:19:29.496534 | instance | changed: [instance]
2026-08-24 15:19:29.496582 | instance |
2026-08-24 15:19:29.496589 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-08-24 15:19:29.496595 | instance | Monday 24 August 2026  15:19:29 +0000 (0:00:00.218)       0:02:03.727 *********
2026-08-24 15:19:29.535363 | instance | ok: [instance]
2026-08-24 15:19:29.535384 | instance |
2026-08-24 15:19:29.535389 | instance | TASK [Install Ceph host] *******************************************************
2026-08-24 15:19:29.535394 | instance | Monday 24 August 2026  15:19:29 +0000 (0:00:00.039)       0:02:03.766 *********
2026-08-24 15:19:29.625459 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-08-24 15:19:29.625523 | instance |
2026-08-24 15:19:29.625534 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-08-24 15:19:29.625551 | instance | Monday 24 August 2026  15:19:29 +0000 (0:00:00.089)       0:02:03.856 *********
2026-08-24 15:19:31.230139 | instance | ok: [instance]
2026-08-24 15:19:31.230183 | instance |
2026-08-24 15:19:31.230197 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-08-24 15:19:31.230204 | instance | Monday 24 August 2026  15:19:31 +0000 (0:00:01.604)       0:02:05.460 *********
2026-08-24 15:19:31.289494 | instance | ok: [instance] => (item=instance)
2026-08-24 15:19:31.289514 | instance |
2026-08-24 15:19:31.289519 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-08-24 15:19:31.289523 | instance | Monday 24 August 2026  15:19:31 +0000 (0:00:00.059)       0:02:05.520 *********
2026-08-24 15:19:31.619682 | instance | ok: [instance]
2026-08-24 15:19:31.619739 | instance |
2026-08-24 15:19:31.620027 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-08-24 15:19:31.620071 | instance | Monday 24 August 2026  15:19:31 +0000 (0:00:00.330)       0:02:05.851 *********
2026-08-24 15:19:33.986878 | instance | ok: [instance]
2026-08-24 15:19:33.986948 | instance |
2026-08-24 15:19:33.987229 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-08-24 15:19:33.987262 | instance | Monday 24 August 2026  15:19:33 +0000 (0:00:02.367)       0:02:08.218 *********
2026-08-24 15:20:16.857022 | 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 15:20:16.857565 | 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_a1a1bu9k/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_a1a1bu9k/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_a1a1bu9k/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_a1a1bu9k/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-24T15:20:16.698+0000 7f475f943640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgDXYIxqLfifMSAAAV+5S0v/LiOEozt90uthguxtg40xmhn6e06Y0F0fYeo=: Malformed input [buffer:3]\n2026-08-24T15:20:16.698+0000 7f475f943640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T15:20:16.698+0000 7f475f943640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgDXYIxqLfifMSAAAV+5S0v/LiOEozt90uthguxtg40xmhn6e06Y0F0fYeo=: Malformed input [buffer:3]\n2026-08-24T15:20:16.698+0000 7f475f943640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T15:20:16.698+0000 7f475f943640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgDXYIxqLfifMSAAAV+5S0v/LiOEozt90uthguxtg40xmhn6e06Y0F0fYeo=: Malformed input [buffer:3]\n2026-08-24T15:20:16.698+0000 7f475f943640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T15:20:16.698+0000 7f475f943640 -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 15:20:16.859579 | instance |
2026-08-24 15:20:16.859745 | instance | PLAY RECAP *********************************************************************
2026-08-24 15:20:16.863546 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=7    rescued=0    ignored=0
2026-08-24 15:20:16.863586 | instance |
2026-08-24 15:20:16.863594 | instance | Monday 24 August 2026  15:20:16 +0000 (0:00:42.873)       0:02:51.091 *********
2026-08-24 15:20:16.863600 | instance | ===============================================================================
2026-08-24 15:20:16.863606 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 84.34s
2026-08-24 15:20:16.863611 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 42.87s
2026-08-24 15:20:16.863617 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 5.19s
2026-08-24 15:20:16.863622 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 4.98s
2026-08-24 15:20:16.863628 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.27s
2026-08-24 15:20:16.863633 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 3.78s
2026-08-24 15:20:16.863653 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.37s
2026-08-24 15:20:16.863659 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.60s
2026-08-24 15:20:16.863664 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.56s
2026-08-24 15:20:16.863670 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 1.17s
2026-08-24 15:20:16.863675 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.12s
2026-08-24 15:20:16.863680 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.03s
2026-08-24 15:20:16.863686 | instance | Gathering Facts --------------------------------------------------------- 0.92s
2026-08-24 15:20:16.863691 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.87s
2026-08-24 15:20:16.863696 | instance | Gathering Facts --------------------------------------------------------- 0.86s
2026-08-24 15:20:16.863702 | instance | Gathering Facts --------------------------------------------------------- 0.82s
2026-08-24 15:20:16.863707 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 0.81s
2026-08-24 15:20:16.863712 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.78s
2026-08-24 15:20:16.863989 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.74s
2026-08-24 15:20:16.864003 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.65s
2026-08-24 15:20:16.964379 | 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 15:20:16.964681 | instance | ERROR    [csi > converge] Executed: Failed
2026-08-24 15:20:16.964880 | 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 15:20:17.188236 | instance | ERROR
2026-08-24 15:20:17.188474 | instance | {
2026-08-24 15:20:17.188517 | instance |   "delta": "0:03:37.290314",
2026-08-24 15:20:17.188548 | instance |   "end": "2026-08-24 15:20:17.014303",
2026-08-24 15:20:17.188576 | instance |   "msg": "non-zero return code",
2026-08-24 15:20:17.188603 | instance |   "rc": 2,
2026-08-24 15:20:17.188629 | instance |   "start": "2026-08-24 15:16:39.723989"
2026-08-24 15:20:17.188658 | instance | }
failure
2026-08-24 15:20:17.195858 | 
2026-08-24 15:20:17.195944 | PLAY RECAP
2026-08-24 15:20:17.195988 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-08-24 15:20:17.196010 | 
2026-08-24 15:20:17.378143 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-24 15:20:17.383569 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-24 15:20:19.200004 | 
2026-08-24 15:20:19.200230 | PLAY [all]
2026-08-24 15:20:19.220954 | 
2026-08-24 15:20:19.221241 | TASK [gather-host-logs : creating directory for system status]
2026-08-24 15:20:19.612328 | instance | changed
2026-08-24 15:20:19.618875 | 
2026-08-24 15:20:19.619053 | TASK [gather-host-logs : Get logs for each host]
2026-08-24 15:20:19.981650 | instance | + systemd-cgls --full --all --no-pager
2026-08-24 15:20:19.994093 | instance | + ip addr
2026-08-24 15:20:19.996532 | instance | + ip route
2026-08-24 15:20:19.998935 | instance | + lsblk
2026-08-24 15:20:20.004282 | instance | + mount
2026-08-24 15:20:20.006040 | instance | + docker images
2026-08-24 15:20:20.026208 | instance | + brctl show
2026-08-24 15:20:20.026681 | instance | /bin/bash: line 8: brctl: command not found
2026-08-24 15:20:20.026954 | instance | + ps aux --sort=-%mem
2026-08-24 15:20:20.043225 | instance | + dpkg -l
2026-08-24 15:20:20.054368 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-08-24 15:20:20.055025 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-08-24 15:20:20.072058 | instance | + '[' '!' -z '' ']'
2026-08-24 15:20:20.162692 | instance | ok: Runtime: 0:00:00.095269
2026-08-24 15:20:20.169586 | 
2026-08-24 15:20:20.169756 | TASK [gather-host-logs : Downloads logs to executor]
2026-08-24 15:20:20.897943 | instance | changed:
2026-08-24 15:20:20.898187 | instance | created directory /var/lib/zuul/builds/8ea661385db544a6a036d86f1a8ed02a/work/logs/instance
2026-08-24 15:20:20.898230 | instance | cd+++++++++ system/
2026-08-24 15:20:20.898264 | instance | >f+++++++++ system/brctl-show.txt
2026-08-24 15:20:20.898295 | instance | >f+++++++++ system/docker-images.txt
2026-08-24 15:20:20.898324 | instance | >f+++++++++ system/ip-addr.txt
2026-08-24 15:20:20.898356 | instance | >f+++++++++ system/ip-route.txt
2026-08-24 15:20:20.898387 | instance | >f+++++++++ system/lsblk.txt
2026-08-24 15:20:20.898417 | instance | >f+++++++++ system/mount.txt
2026-08-24 15:20:20.898446 | instance | >f+++++++++ system/packages.txt
2026-08-24 15:20:20.898474 | instance | >f+++++++++ system/ps.txt
2026-08-24 15:20:20.898506 | instance | >f+++++++++ system/systemd-cgls.txt
2026-08-24 15:20:20.909357 | 
2026-08-24 15:20:20.909560 | LOOP [helm-release-status : creating directory for helm release status]
2026-08-24 15:20:21.101434 | instance | changed: "values"
2026-08-24 15:20:21.272035 | instance | changed: "releases"
2026-08-24 15:20:21.286637 | 
2026-08-24 15:20:21.286804 | TASK [helm-release-status : Gather get release status for helm charts]
2026-08-24 15:20:21.490629 | instance | /bin/bash: line 3: kubectl: command not found
2026-08-24 15:20:21.825302 | instance | ok: Runtime: 0:00:00.005997
2026-08-24 15:20:21.833441 | 
2026-08-24 15:20:21.833572 | TASK [helm-release-status : Downloads logs to executor]
2026-08-24 15:20:22.371676 | instance | changed:
2026-08-24 15:20:22.371887 | instance | cd+++++++++ helm/
2026-08-24 15:20:22.371922 | instance | cd+++++++++ helm/releases/
2026-08-24 15:20:22.371945 | instance | cd+++++++++ helm/values/
2026-08-24 15:20:22.385756 | 
2026-08-24 15:20:22.386108 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-08-24 15:20:22.606296 | instance | changed
2026-08-24 15:20:22.614099 | 
2026-08-24 15:20:22.614244 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-08-24 15:20:22.872429 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-24 15:20:22.872610 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-24 15:20:22.877594 | instance | environment: line 1: kubectl: command not found
2026-08-24 15:20:22.879143 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-24 15:20:22.880284 | instance | environment: line 1: kubectl: command not found
2026-08-24 15:20:22.881255 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-24 15:20:22.881990 | instance | environment: line 1: kubectl: command not found
2026-08-24 15:20:22.882930 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-24 15:20:22.884429 | instance | environment: line 1: kubectl: command not found
2026-08-24 15:20:22.885438 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-24 15:20:22.887097 | instance | environment: line 1: kubectl: command not found
2026-08-24 15:20:22.888177 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-24 15:20:23.161364 | instance | ok: Runtime: 0:00:00.025095
2026-08-24 15:20:23.171577 | 
2026-08-24 15:20:23.171733 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-08-24 15:20:23.380588 | instance | changed
2026-08-24 15:20:23.386791 | 
2026-08-24 15:20:23.386870 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-08-24 15:20:23.611388 | instance | environment: line 5: kubectl: command not found
2026-08-24 15:20:23.612788 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-24 15:20:23.612924 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-24 15:20:23.613002 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-24 15:20:23.940867 | instance | ok: Runtime: 0:00:00.009780
2026-08-24 15:20:23.961076 | 
2026-08-24 15:20:23.961285 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-08-24 15:20:24.471474 | instance | changed:
2026-08-24 15:20:24.471669 | instance | cd+++++++++ objects/
2026-08-24 15:20:24.471709 | instance | cd+++++++++ objects/cluster/
2026-08-24 15:20:24.471735 | instance | cd+++++++++ objects/namespaced/
2026-08-24 15:20:24.483614 | 
2026-08-24 15:20:24.483725 | TASK [gather-pod-logs : creating directory for pod logs]
2026-08-24 15:20:24.691123 | instance | changed
2026-08-24 15:20:24.698367 | 
2026-08-24 15:20:24.698441 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-08-24 15:20:24.895512 | instance | changed
2026-08-24 15:20:24.901078 | 
2026-08-24 15:20:24.901175 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-08-24 15:20:25.122036 | instance | environment: line 3: kubectl: command not found
2026-08-24 15:20:25.435488 | instance | ok: Runtime: 0:00:00.009287
2026-08-24 15:20:25.443278 | 
2026-08-24 15:20:25.443357 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-08-24 15:20:26.293180 | instance | changed:
2026-08-24 15:20:26.293417 | instance | cd+++++++++ pod-logs/
2026-08-24 15:20:26.293469 | instance | cd+++++++++ pod-logs/failed-pods/
2026-08-24 15:20:26.310670 | 
2026-08-24 15:20:26.310779 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-08-24 15:20:26.504035 | instance | changed
2026-08-24 15:20:26.510942 | 
2026-08-24 15:20:26.511039 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-08-24 15:20:26.745397 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-24 15:20:27.053383 | instance | ok: Runtime: 0:00:00.034658
2026-08-24 15:20:27.063214 | 
2026-08-24 15:20:27.063325 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-08-24 15:20:27.313771 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-24 15:20:27.344831 | instance | ceph-mgr endpoints:
2026-08-24 15:20:27.600793 | instance | ok: Runtime: 0:00:00.037071
2026-08-24 15:20:27.608839 | 
2026-08-24 15:20:27.608953 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-08-24 15:20:27.831533 | instance | /bin/bash: line 4: kubectl: command not found
2026-08-24 15:20:28.151057 | instance | ok: Runtime: 0:00:00.037188
2026-08-24 15:20:28.158306 | 
2026-08-24 15:20:28.158453 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-08-24 15:20:28.658999 | instance | changed: cd+++++++++ prometheus/
2026-08-24 15:20:28.671611 | 
2026-08-24 15:20:28.671715 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-08-24 15:20:28.869967 | instance | changed
2026-08-24 15:20:28.875980 | 
2026-08-24 15:20:28.876327 | TASK [gather-selenium-data : Get selenium data]
2026-08-24 15:20:29.137707 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-08-24 15:20:29.139162 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-08-24 15:20:29.416801 | instance | ERROR
2026-08-24 15:20:29.417055 | instance | {
2026-08-24 15:20:29.417089 | instance |   "delta": "0:00:00.006526",
2026-08-24 15:20:29.417111 | instance |   "end": "2026-08-24 15:20:29.139802",
2026-08-24 15:20:29.417132 | instance |   "msg": "non-zero return code",
2026-08-24 15:20:29.417151 | instance |   "rc": 1,
2026-08-24 15:20:29.417170 | instance |   "start": "2026-08-24 15:20:29.133276"
2026-08-24 15:20:29.417188 | instance | }
2026-08-24 15:20:29.417212 | instance | ERROR: Ignoring Errors
2026-08-24 15:20:29.422063 | 
2026-08-24 15:20:29.422132 | TASK [gather-selenium-data : Downloads logs to executor]
2026-08-24 15:20:29.921172 | instance | changed: cd+++++++++ selenium/
2026-08-24 15:20:29.930613 | 
2026-08-24 15:20:29.930682 | PLAY RECAP
2026-08-24 15:20:29.930730 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-08-24 15:20:29.930752 | 
2026-08-24 15:20:30.069398 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-24 15:20:30.074180 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-24 15:20:32.285792 | 
2026-08-24 15:20:34.105086 | PLAY [all]
2026-08-24 15:20:34.139957 | 
2026-08-24 15:20:34.140183 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-24 15:20:34.193302 | instance | skipping: Conditional result was False
2026-08-24 15:20:34.203361 | 
2026-08-24 15:20:34.203448 | TASK [fetch-output : Set log path for single node]
2026-08-24 15:20:34.249620 | instance | ok
2026-08-24 15:20:34.261378 | 
2026-08-24 15:20:34.261622 | LOOP [fetch-output : Ensure local output dirs]
2026-08-24 15:20:34.857523 | instance -> localhost | ok: "/var/lib/zuul/builds/8ea661385db544a6a036d86f1a8ed02a/work/logs"
2026-08-24 15:20:35.118256 | instance -> localhost | changed: "/var/lib/zuul/builds/8ea661385db544a6a036d86f1a8ed02a/work/artifacts"
2026-08-24 15:20:35.489331 | instance -> localhost | changed: "/var/lib/zuul/builds/8ea661385db544a6a036d86f1a8ed02a/work/docs"
2026-08-24 15:20:35.505643 | 
2026-08-24 15:20:35.505799 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-24 15:20:36.194398 | instance | changed: .d..t...... ./
2026-08-24 15:20:36.194621 | instance | changed: All items complete
2026-08-24 15:20:36.194662 | 
2026-08-24 15:20:36.705660 | instance | changed: .d..t...... ./
2026-08-24 15:20:37.358620 | instance | changed: .d..t...... ./
2026-08-24 15:20:37.384793 | 
2026-08-24 15:20:37.384936 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-24 15:20:37.919424 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.010838
2026-08-24 15:20:38.195591 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.008115
2026-08-24 15:20:38.210813 | 
2026-08-24 15:20:38.211361 | PLAY [all]
2026-08-24 15:20:38.218938 | 
2026-08-24 15:20:38.219016 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-24 15:20:38.700485 | instance | changed
2026-08-24 15:20:38.784137 | 
2026-08-24 15:20:38.784217 | PLAY RECAP
2026-08-24 15:20:38.784264 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-24 15:20:38.784289 | 
2026-08-24 15:20:38.908233 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-24 15:20:38.914268 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-24 15:20:39.776798 | 
2026-08-24 15:20:39.777056 | PLAY [localhost]
2026-08-24 15:20:39.788721 | 
2026-08-24 15:20:39.788867 | TASK [Generate Zuul manifest]
2026-08-24 15:20:39.810488 | localhost | ok
2026-08-24 15:20:40.142975 | 
2026-08-24 15:20:40.143152 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-24 15:20:40.756893 | localhost | changed
2026-08-24 15:20:40.772466 | 
2026-08-24 15:20:40.772689 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-24 15:20:41.020641 | localhost | ok
2026-08-24 15:20:41.028013 | 
2026-08-24 15:20:41.028088 | TASK [Upload logs]
2026-08-24 15:20:41.053796 | localhost | ok
2026-08-24 15:20:41.619104 | 
2026-08-24 15:20:41.619358 | TASK [Set zuul-log-path fact]
2026-08-24 15:20:41.646756 | localhost | ok
2026-08-24 15:20:41.665573 | 
2026-08-24 15:20:41.665780 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-24 15:20:41.702455 | localhost | ok
2026-08-24 15:20:41.911071 | 
2026-08-24 15:20:41.911248 | TASK [upload-logs : Create log directories]
2026-08-24 15:20:42.487727 | localhost | changed
2026-08-24 15:20:42.497801 | 
2026-08-24 15:20:42.498017 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-24 15:20:43.109143 | localhost -> localhost | ok: Runtime: 0:00:00.122431
2026-08-24 15:20:43.115920 | 
2026-08-24 15:20:43.116033 | TASK [upload-logs : Upload logs to log server]
2026-08-24 15:20:44.328769 | localhost | Output suppressed because no_log was given
2026-08-24 15:20:44.371105 | 
2026-08-24 15:20:44.371227 | LOOP [upload-logs : Compress console log and json output]
2026-08-24 15:20:44.427097 | localhost | skipping: Conditional result was False
2026-08-24 15:20:44.437107 | localhost | skipping: Conditional result was False
2026-08-24 15:20:44.447440 | 
2026-08-24 15:20:44.447589 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-24 15:20:44.506206 | localhost | skipping: Conditional result was False
2026-08-24 15:20:44.506606 | 
2026-08-24 15:20:44.512583 | localhost | skipping: Conditional result was False
2026-08-24 15:20:44.529635 | 
2026-08-24 15:20:44.530040 | LOOP [upload-logs : Upload console log and json output]