2026-08-26 06:53:17.584204 | Job console starting
2026-08-26 06:53:17.593214 | Updating git repos
2026-08-26 06:53:19.787365 | Cloning repos into workspace
2026-08-26 06:53:35.415772 | Restoring repo states
2026-08-26 06:53:48.613203 | Merging changes
2026-08-26 06:53:49.467423 | Checking out repos
2026-08-26 06:53:51.109161 | Preparing playbooks
2026-08-26 06:53:53.074195 | Running Ansible setup
2026-08-26 06:53:56.391144 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-26 06:53:57.035340 | 
2026-08-26 06:53:57.035482 | PLAY [localhost]
2026-08-26 06:53:57.044888 | 
2026-08-26 06:53:57.044969 | TASK [Gathering Facts]
2026-08-26 06:53:57.984532 | localhost | ok
2026-08-26 06:53:57.995133 | 
2026-08-26 06:53:57.995266 | TASK [Setup log path fact]
2026-08-26 06:53:58.014771 | localhost | ok
2026-08-26 06:53:58.027865 | 
2026-08-26 06:53:58.027936 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-26 06:53:58.058092 | localhost | ok
2026-08-26 06:53:58.066629 | 
2026-08-26 06:53:58.066736 | TASK [emit-job-header : Print job information]
2026-08-26 06:53:58.108348 | # Job Information
2026-08-26 06:53:58.108572 | Ansible Version: 2.16.18
2026-08-26 06:53:58.108637 | Job: atmosphere-molecule-csi-rbd
2026-08-26 06:53:58.108687 | Pipeline: check
2026-08-26 06:53:58.108726 | Executor: 2d72f0692154
2026-08-26 06:53:58.108766 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4344
2026-08-26 06:53:58.108810 | Event ID: 29b07d90-a11a-11f1-9137-b5b09c1610ce
2026-08-26 06:53:58.113276 | 
2026-08-26 06:53:58.113384 | LOOP [emit-job-header : Print node information]
2026-08-26 06:53:58.204785 | localhost | ok:
2026-08-26 06:53:58.204986 | localhost | # Node Information
2026-08-26 06:53:58.205034 | localhost | Inventory Hostname: instance
2026-08-26 06:53:58.205077 | localhost | Hostname: np0000191159
2026-08-26 06:53:58.205110 | localhost | Username: zuul
2026-08-26 06:53:58.205184 | localhost | Distro: Ubuntu 22.04
2026-08-26 06:53:58.205218 | localhost | Provider: yul1
2026-08-26 06:53:58.205245 | localhost | Region: ca-ymq-1
2026-08-26 06:53:58.205269 | localhost | Label: ubuntu-jammy
2026-08-26 06:53:58.205292 | localhost | Product Name: OpenStack Nova
2026-08-26 06:53:58.205314 | localhost | Interface IP: 162.253.55.19
2026-08-26 06:53:58.221468 | 
2026-08-26 06:53:58.221613 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-26 06:53:58.661616 | localhost -> localhost | changed
2026-08-26 06:53:58.667709 | 
2026-08-26 06:53:58.667790 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-26 06:53:59.848137 | localhost -> localhost | changed
2026-08-26 06:53:59.858135 | 
2026-08-26 06:53:59.858248 | PLAY [all]
2026-08-26 06:53:59.867569 | 
2026-08-26 06:53:59.867670 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-26 06:54:00.098165 | instance -> localhost | ok
2026-08-26 06:54:00.105871 | 
2026-08-26 06:54:00.105990 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-26 06:54:00.126790 | instance | ok
2026-08-26 06:54:00.144356 | instance | included: /var/lib/zuul/builds/9c434e1850a2403d8c9f74fd6027c094/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-26 06:54:00.152880 | 
2026-08-26 06:54:00.153022 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-26 06:54:01.054364 | instance -> localhost | Generating public/private rsa key pair.
2026-08-26 06:54:01.054548 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/9c434e1850a2403d8c9f74fd6027c094/work/9c434e1850a2403d8c9f74fd6027c094_id_rsa
2026-08-26 06:54:01.054589 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/9c434e1850a2403d8c9f74fd6027c094/work/9c434e1850a2403d8c9f74fd6027c094_id_rsa.pub
2026-08-26 06:54:01.054620 | instance -> localhost | The key fingerprint is:
2026-08-26 06:54:01.054650 | instance -> localhost | SHA256:9z6STuRpofBVxTOHguJlnVCWQWFlDHapxjerhcopmK8 zuul-build-sshkey
2026-08-26 06:54:01.054692 | instance -> localhost | The key's randomart image is:
2026-08-26 06:54:01.054723 | instance -> localhost | +---[RSA 3072]----+
2026-08-26 06:54:01.054757 | instance -> localhost | |          .*XX=o |
2026-08-26 06:54:01.054789 | instance -> localhost | |        . ++=+B .|
2026-08-26 06:54:01.054825 | instance -> localhost | |       . + ..o + |
2026-08-26 06:54:01.054874 | instance -> localhost | |        .  .+ o  |
2026-08-26 06:54:01.054912 | instance -> localhost | |      . S =. o o |
2026-08-26 06:54:01.054943 | instance -> localhost | |       o * +. o  |
2026-08-26 06:54:01.054974 | instance -> localhost | |       oo.=+.o   |
2026-08-26 06:54:01.055005 | instance -> localhost | |      o .o*.o    |
2026-08-26 06:54:01.055038 | instance -> localhost | |      Eo.o....   |
2026-08-26 06:54:01.055069 | instance -> localhost | +----[SHA256]-----+
2026-08-26 06:54:01.055141 | instance -> localhost | ok: Runtime: 0:00:00.518679
2026-08-26 06:54:01.062387 | 
2026-08-26 06:54:01.062454 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-26 06:54:01.095374 | instance | ok
2026-08-26 06:54:01.105156 | instance | included: /var/lib/zuul/builds/9c434e1850a2403d8c9f74fd6027c094/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-26 06:54:01.112458 | 
2026-08-26 06:54:01.112530 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-26 06:54:01.136101 | instance | skipping: Conditional result was False
2026-08-26 06:54:01.144073 | 
2026-08-26 06:54:01.144176 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-26 06:54:01.547879 | instance | changed
2026-08-26 06:54:01.556260 | 
2026-08-26 06:54:01.556401 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-26 06:54:01.734662 | instance | ok
2026-08-26 06:54:01.740597 | 
2026-08-26 06:54:01.740711 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-26 06:54:02.182507 | instance | changed
2026-08-26 06:54:02.187450 | 
2026-08-26 06:54:02.187532 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-26 06:54:02.602584 | instance | changed
2026-08-26 06:54:02.611661 | 
2026-08-26 06:54:02.611786 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-26 06:54:02.635602 | instance | skipping: Conditional result was False
2026-08-26 06:54:02.644913 | 
2026-08-26 06:54:02.645084 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-26 06:54:03.019807 | instance -> localhost | changed
2026-08-26 06:54:03.034495 | 
2026-08-26 06:54:03.034596 | TASK [add-build-sshkey : Add back temp key]
2026-08-26 06:54:03.313206 | instance -> localhost | Identity added: /var/lib/zuul/builds/9c434e1850a2403d8c9f74fd6027c094/work/9c434e1850a2403d8c9f74fd6027c094_id_rsa (zuul-build-sshkey)
2026-08-26 06:54:03.313551 | instance -> localhost | ok: Runtime: 0:00:00.014690
2026-08-26 06:54:03.320453 | 
2026-08-26 06:54:03.320571 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-26 06:54:03.613833 | instance | ok
2026-08-26 06:54:03.618605 | 
2026-08-26 06:54:03.618705 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-26 06:54:03.641914 | instance | skipping: Conditional result was False
2026-08-26 06:54:03.655731 | 
2026-08-26 06:54:03.655834 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-26 06:54:03.966535 | instance | ok
2026-08-26 06:54:03.973820 | 
2026-08-26 06:54:03.973897 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-26 06:54:07.274961 | instance | Output suppressed because no_log was given
2026-08-26 06:54:07.343608 | 
2026-08-26 06:54:07.343713 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-26 06:54:07.524552 | instance | ok: "logs"
2026-08-26 06:54:07.524840 | instance | ok: All items complete
2026-08-26 06:54:07.524881 | 
2026-08-26 06:54:07.673102 | instance | ok: "artifacts"
2026-08-26 06:54:07.823953 | instance | ok: "docs"
2026-08-26 06:54:07.843194 | 
2026-08-26 06:54:07.843338 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-26 06:54:08.022476 | instance | changed: "logs"
2026-08-26 06:54:08.172714 | instance | changed: "artifacts"
2026-08-26 06:54:08.325659 | instance | changed: "docs"
2026-08-26 06:54:08.337729 | 
2026-08-26 06:54:08.337838 | PLAY RECAP
2026-08-26 06:54:08.337894 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-26 06:54:08.337930 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-26 06:54:08.337961 | 
2026-08-26 06:54:08.474644 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-26 06:54:08.478463 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-26 06:54:09.126662 | 
2026-08-26 06:54:09.126793 | PLAY [all]
2026-08-26 06:54:09.139527 | 
2026-08-26 06:54:09.139655 | TASK [setup-uv : Extract archive]
2026-08-26 06:54:11.349863 | instance | changed
2026-08-26 06:54:11.355765 | 
2026-08-26 06:54:11.355859 | TASK [setup-uv : Print version]
2026-08-26 06:54:11.713627 | instance | uv 0.8.13
2026-08-26 06:54:11.894648 | instance | ok: Runtime: 0:00:00.012183
2026-08-26 06:54:11.906676 | 
2026-08-26 06:54:11.906809 | TASK [Install Ansible collection siblings]
2026-08-26 06:54:20.801581 | instance | changed:
2026-08-26 06:54:20.801731 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-08-26 06:54:20.801776 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-08-26 06:54:20.801802 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-08-26 06:54:20.801822 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-08-26 06:54:20.801842 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-08-26 06:54:20.801865 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-08-26 06:54:20.801885 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-08-26 06:54:20.801907 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-08-26 06:54:20.801927 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-08-26 06:54:20.801946 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-08-26 06:54:20.801965 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-08-26 06:54:20.801984 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-08-26 06:54:20.802002 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-08-26 06:54:20.802020 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-08-26 06:54:20.802037 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0
2026-08-26 06:54:20.802056 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-08-26 06:54:20.802074 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-08-26 06:54:20.802092 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-08-26 06:54:20.802110 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-08-26 06:54:20.802127 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-08-26 06:54:20.802145 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0
2026-08-26 06:54:20.802162 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-08-26 06:54:20.802181 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-26 06:54:20.802206 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-08-26 06:54:20.802225 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0
2026-08-26 06:54:20.802243 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-26 06:54:20.802261 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-26 06:54:20.802278 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-26 06:54:20.802295 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-08-26 06:54:20.802313 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-08-26 06:54:20.802330 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-26 06:54:20.802347 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-26 06:54:20.802365 | instance | Checked out ansible.netcommon to 1.2.0
2026-08-26 06:54:20.802382 | 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-26 06:54:20.802405 | instance | Starting galaxy collection install process
2026-08-26 06:54:20.802423 | instance | Process install dependency map
2026-08-26 06:54:20.802441 | instance | Starting collection install process
2026-08-26 06:54:20.802459 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-08-26 06:54:20.802477 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-08-26 06:54:20.802495 | instance | ansible.netcommon:* was installed successfully
2026-08-26 06:54:20.802513 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-08-26 06:54:20.802531 | instance | Creating virtual environment at: .venv
2026-08-26 06:54:20.802549 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-26 06:54:20.802567 | instance | Downloading pygments (1.2MiB)
2026-08-26 06:54:20.802585 | instance | Downloading rjsonnet (1.2MiB)
2026-08-26 06:54:20.802606 | instance | Downloading ansible-core (2.1MiB)
2026-08-26 06:54:20.802624 | instance | Downloading cryptography (4.2MiB)
2026-08-26 06:54:20.802642 | instance | Downloading openstacksdk (1.7MiB)
2026-08-26 06:54:20.802660 | instance | Downloading kubernetes (1.9MiB)
2026-08-26 06:54:20.802679 | instance | Downloading setuptools (1.1MiB)
2026-08-26 06:54:20.802698 | instance | Downloading pydantic-core (2.0MiB)
2026-08-26 06:54:20.802716 | instance | Downloading netaddr (2.2MiB)
2026-08-26 06:54:20.802735 | instance |    Building pyperclip==1.9.0
2026-08-26 06:54:20.802754 | instance |  Downloading rjsonnet
2026-08-26 06:54:20.802773 | instance |  Downloading pydantic-core
2026-08-26 06:54:20.802796 | instance |  Downloading netaddr
2026-08-26 06:54:20.802818 | instance |  Downloading pygments
2026-08-26 06:54:20.802837 | instance |  Downloading cryptography
2026-08-26 06:54:20.802855 | instance |  Downloading setuptools
2026-08-26 06:54:20.802872 | instance |  Downloading kubernetes
2026-08-26 06:54:20.802891 | instance |  Downloading ansible-core
2026-08-26 06:54:20.802909 | instance |  Downloading openstacksdk
2026-08-26 06:54:20.802927 | instance |       Built pyperclip==1.9.0
2026-08-26 06:54:20.802945 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-26 06:54:20.802963 | instance | Installed 83 packages in 43ms
2026-08-26 06:54:20.802982 | instance | Checked out ansible.posix to 1.6.0
2026-08-26 06:54:20.803000 | 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-26 06:54:20.803019 | instance | Starting galaxy collection install process
2026-08-26 06:54:20.803037 | instance | Process install dependency map
2026-08-26 06:54:20.803065 | instance | Starting collection install process
2026-08-26 06:54:20.803084 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-08-26 06:54:20.803103 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-08-26 06:54:20.803121 | instance | ansible.posix:1.6.0 was installed successfully
2026-08-26 06:54:20.803139 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-26 06:54:20.803157 | instance | 2.17.12
2026-08-26 06:54:20.803174 | instance | Checked out ansible.utils to v6.1.0
2026-08-26 06:54:20.803193 | 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-26 06:54:20.803211 | instance | Starting galaxy collection install process
2026-08-26 06:54:20.803229 | instance | Process install dependency map
2026-08-26 06:54:20.803247 | instance | Starting collection install process
2026-08-26 06:54:20.803265 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-08-26 06:54:20.803283 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-08-26 06:54:20.803302 | instance | ansible.utils:6.1.0 was installed successfully
2026-08-26 06:54:20.803321 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-26 06:54:20.803340 | instance | 2.17.12
2026-08-26 06:54:20.803358 | instance | Checked out atmosphere.common to v0.7.0
2026-08-26 06:54:20.803377 | 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-26 06:54:20.803396 | instance | Starting galaxy collection install process
2026-08-26 06:54:20.803413 | instance | Process install dependency map
2026-08-26 06:54:20.803431 | instance | Starting collection install process
2026-08-26 06:54:20.803449 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-08-26 06:54:20.803467 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-08-26 06:54:20.803486 | instance | atmosphere.common:0.7.0 was installed successfully
2026-08-26 06:54:20.803504 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-26 06:54:20.803523 | instance | 2.17.12
2026-08-26 06:54:20.803540 | instance | Checked out community.crypto to 2.2.3
2026-08-26 06:54:20.803559 | 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-26 06:54:20.803578 | instance | Starting galaxy collection install process
2026-08-26 06:54:20.803596 | instance | Process install dependency map
2026-08-26 06:54:20.803614 | instance | Starting collection install process
2026-08-26 06:54:20.803631 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-08-26 06:54:20.803649 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-08-26 06:54:20.803668 | instance | community.crypto:2.2.3 was installed successfully
2026-08-26 06:54:20.803686 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-26 06:54:20.803704 | instance | 2.17.12
2026-08-26 06:54:20.803722 | instance | Checked out community.general to 7.3.0
2026-08-26 06:54:20.803740 | 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-26 06:54:20.803763 | instance | Starting galaxy collection install process
2026-08-26 06:54:20.803782 | instance | Process install dependency map
2026-08-26 06:54:20.803800 | instance | Starting collection install process
2026-08-26 06:54:20.803818 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-08-26 06:54:20.803836 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-08-26 06:54:20.803857 | instance | community.general:7.3.0 was installed successfully
2026-08-26 06:54:20.803884 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-26 06:54:20.803906 | instance | 2.17.12
2026-08-26 06:54:20.803924 | instance | Checked out community.mysql to 3.6.0
2026-08-26 06:54:20.803945 | 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-26 06:54:20.803964 | instance | Starting galaxy collection install process
2026-08-26 06:54:20.803983 | instance | Process install dependency map
2026-08-26 06:54:20.804001 | instance | Starting collection install process
2026-08-26 06:54:20.804019 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-08-26 06:54:20.804037 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-08-26 06:54:20.804056 | instance | community.mysql:3.6.0 was installed successfully
2026-08-26 06:54:20.804074 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-26 06:54:20.804092 | instance | 2.17.12
2026-08-26 06:54:20.804110 | instance | Checked out kubernetes.core to 2.4.0
2026-08-26 06:54:20.804129 | 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-26 06:54:20.804147 | instance | Starting galaxy collection install process
2026-08-26 06:54:20.804166 | instance | Process install dependency map
2026-08-26 06:54:20.804184 | instance | Starting collection install process
2026-08-26 06:54:20.804203 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-08-26 06:54:20.804221 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-08-26 06:54:20.804239 | instance | kubernetes.core:2.4.0 was installed successfully
2026-08-26 06:54:20.804258 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-26 06:54:20.804276 | instance | 2.17.12
2026-08-26 06:54:20.804294 | instance | Checked out openstack.cloud to 2.6.0
2026-08-26 06:54:20.804313 | 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-26 06:54:20.804332 | instance | Starting galaxy collection install process
2026-08-26 06:54:20.804381 | instance | Process install dependency map
2026-08-26 06:54:20.804402 | instance | Starting collection install process
2026-08-26 06:54:20.804421 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-08-26 06:54:20.804439 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-08-26 06:54:20.804457 | instance | openstack.cloud:2.6.0 was installed successfully
2026-08-26 06:54:20.804476 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-26 06:54:20.804494 | instance | 2.17.12
2026-08-26 06:54:20.804516 | instance | Checked out vexxhost.ceph to v4.2.0
2026-08-26 06:54:20.804536 | 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-26 06:54:20.804554 | instance | Starting galaxy collection install process
2026-08-26 06:54:20.804572 | instance | Process install dependency map
2026-08-26 06:54:20.804591 | instance | Starting collection install process
2026-08-26 06:54:20.804609 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-08-26 06:54:20.804627 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-08-26 06:54:20.804645 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-08-26 06:54:20.804664 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-26 06:54:20.804682 | instance | 2.17.12
2026-08-26 06:54:20.804700 | instance | Checked out vexxhost.containers to v1.6.8
2026-08-26 06:54:20.804719 | 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-26 06:54:20.804737 | instance | Starting galaxy collection install process
2026-08-26 06:54:20.804756 | instance | Process install dependency map
2026-08-26 06:54:20.804774 | instance | Starting collection install process
2026-08-26 06:54:20.804792 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-08-26 06:54:20.804809 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-08-26 06:54:20.804828 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-08-26 06:54:20.804846 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-26 06:54:20.804864 | instance | 2.17.12
2026-08-26 06:54:20.804883 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-08-26 06:54:20.804901 | 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-26 06:54:20.804919 | instance | Starting galaxy collection install process
2026-08-26 06:54:20.804937 | instance | Process install dependency map
2026-08-26 06:54:20.804955 | instance | Starting collection install process
2026-08-26 06:54:20.805070 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-08-26 06:54:20.805103 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-08-26 06:54:20.805137 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-08-26 06:54:20.805459 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-26 06:54:20.805485 | instance | 2.17.12
2026-08-26 06:54:20.813341 | 
2026-08-26 06:54:20.813390 | PLAY RECAP
2026-08-26 06:54:20.813432 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-26 06:54:20.813455 | 
2026-08-26 06:54:20.949986 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-26 06:54:20.953285 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-26 06:54:21.589970 | 
2026-08-26 06:54:21.590099 | PLAY [all]
2026-08-26 06:54:21.601603 | 
2026-08-26 06:54:21.601741 | TASK [Install "jq" for log collection]
2026-08-26 06:54:40.318029 | instance | changed
2026-08-26 06:54:41.727150 | 
2026-08-26 06:54:41.727321 | PLAY RECAP
2026-08-26 06:54:41.727399 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-26 06:54:41.727510 | 
2026-08-26 06:54:41.984497 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-26 06:54:41.987596 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-26 06:55:17.860413 | 
2026-08-26 06:55:17.860548 | PLAY [all]
2026-08-26 06:55:18.951606 | 
2026-08-26 06:55:18.951795 | LOOP [Check inventory directories]
2026-08-26 06:55:20.315692 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-08-26 06:55:20.460388 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-08-26 06:55:20.607954 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-08-26 06:55:20.629114 | 
2026-08-26 06:55:20.629310 | LOOP [Copy inventory file for Zuul]
2026-08-26 06:55:21.368142 | instance | changed:
2026-08-26 06:55:21.368323 | instance | {
2026-08-26 06:55:21.368360 | instance |   "ansible_loop_var": "item",
2026-08-26 06:55:21.368384 | instance |   "changed": false,
2026-08-26 06:55:21.368405 | instance |   "failed": false,
2026-08-26 06:55:21.368431 | instance |   "invocation": {
2026-08-26 06:55:21.368451 | instance |     "module_args": {
2026-08-26 06:55:21.368470 | instance |       "checksum_algorithm": "sha1",
2026-08-26 06:55:21.368488 | instance |       "follow": true,
2026-08-26 06:55:21.368506 | instance |       "get_attributes": true,
2026-08-26 06:55:21.368526 | instance |       "get_checksum": true,
2026-08-26 06:55:21.368546 | instance |       "get_mime": true,
2026-08-26 06:55:21.368564 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-08-26 06:55:21.368583 | instance |     }
2026-08-26 06:55:21.368602 | instance |   },
2026-08-26 06:55:21.368621 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-08-26 06:55:21.368645 | instance |   "stat": {
2026-08-26 06:55:21.368666 | instance |     "atime": 1787727253.6385243,
2026-08-26 06:55:21.368686 | instance |     "attr_flags": "e",
2026-08-26 06:55:21.368705 | instance |     "attributes": [
2026-08-26 06:55:21.368723 | instance |       "extents"
2026-08-26 06:55:21.368742 | instance |     ],
2026-08-26 06:55:21.368760 | instance |     "block_size": 4096,
2026-08-26 06:55:21.368779 | instance |     "blocks": 8,
2026-08-26 06:55:21.368797 | instance |     "charset": "unknown",
2026-08-26 06:55:21.368817 | instance |     "ctime": 1787727252.618317,
2026-08-26 06:55:21.368839 | instance |     "dev": 64513,
2026-08-26 06:55:21.368859 | instance |     "device_type": 0,
2026-08-26 06:55:21.368878 | instance |     "executable": true,
2026-08-26 06:55:21.368897 | instance |     "exists": true,
2026-08-26 06:55:21.368916 | instance |     "gid": 1000,
2026-08-26 06:55:21.368934 | instance |     "gr_name": "zuul",
2026-08-26 06:55:21.368969 | instance |     "inode": 1048205,
2026-08-26 06:55:21.368991 | instance |     "isblk": false,
2026-08-26 06:55:21.369011 | instance |     "ischr": false,
2026-08-26 06:55:21.369029 | instance |     "isdir": true,
2026-08-26 06:55:21.369048 | instance |     "isfifo": false,
2026-08-26 06:55:21.369065 | instance |     "isgid": false,
2026-08-26 06:55:21.369083 | instance |     "islnk": false,
2026-08-26 06:55:21.369101 | instance |     "isreg": false,
2026-08-26 06:55:21.369119 | instance |     "issock": false,
2026-08-26 06:55:21.369137 | instance |     "isuid": false,
2026-08-26 06:55:21.369155 | instance |     "mimetype": "unknown",
2026-08-26 06:55:21.369171 | instance |     "mode": "0755",
2026-08-26 06:55:21.369189 | instance |     "mtime": 1787727252.618317,
2026-08-26 06:55:21.369205 | instance |     "nlink": 23,
2026-08-26 06:55:21.369222 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-08-26 06:55:21.369239 | instance |     "pw_name": "zuul",
2026-08-26 06:55:21.369258 | instance |     "readable": true,
2026-08-26 06:55:21.369277 | instance |     "rgrp": true,
2026-08-26 06:55:21.369295 | instance |     "roth": true,
2026-08-26 06:55:21.369327 | instance |     "rusr": true,
2026-08-26 06:55:21.369346 | instance |     "size": 4096,
2026-08-26 06:55:21.369365 | instance |     "uid": 1000,
2026-08-26 06:55:21.369384 | instance |     "version": "2014251305",
2026-08-26 06:55:21.369402 | instance |     "wgrp": false,
2026-08-26 06:55:21.369422 | instance |     "woth": false,
2026-08-26 06:55:21.369441 | instance |     "writeable": true,
2026-08-26 06:55:21.369460 | instance |     "wusr": true,
2026-08-26 06:55:21.369479 | instance |     "xgrp": true,
2026-08-26 06:55:21.369497 | instance |     "xoth": true,
2026-08-26 06:55:21.369515 | instance |     "xusr": true
2026-08-26 06:55:21.369533 | instance |   }
2026-08-26 06:55:21.369552 | instance | }
2026-08-26 06:55:21.369593 | instance | ok: All items complete
2026-08-26 06:55:21.369616 | 
2026-08-26 06:55:21.371006 | instance | skipping: Conditional result was False
2026-08-26 06:55:21.371755 | instance | skipping: Conditional result was False
2026-08-26 06:55:21.387249 | 
2026-08-26 06:55:21.387375 | LOOP [Switch "ansible_host" to private IP]
2026-08-26 06:55:21.717481 | instance | changed: 1 replacements made
2026-08-26 06:55:21.719341 | instance | skipping: Conditional result was False
2026-08-26 06:55:21.724412 | instance | skipping: Conditional result was False
2026-08-26 06:55:21.740443 | 
2026-08-26 06:55:21.740594 | TASK [Run Molecule scenario]
2026-08-26 06:55:22.656416 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-08-26 06:55:23.050765 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-08-26 06:55:23.050846 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-08-26 06:55:33.724943 | instance | INFO     [csi > dependency] Executing
2026-08-26 06:55:33.725127 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-08-26 06:55:33.725328 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-08-26 06:55:33.725441 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-08-26 06:55:33.735188 | instance | INFO     [csi > cleanup] Executing
2026-08-26 06:55:33.735498 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-26 06:55:33.742984 | instance | INFO     [csi > destroy] Executing
2026-08-26 06:55:33.743051 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-08-26 06:55:33.743134 | instance | INFO     [csi > destroy] Executed: Successful
2026-08-26 06:55:33.750467 | instance | INFO     [csi > syntax] Executing
2026-08-26 06:55:35.395290 | instance |
2026-08-26 06:55:35.395665 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-26 06:55:35.455826 | instance | INFO     [csi > syntax] Executed: Successful
2026-08-26 06:55:35.468794 | instance | INFO     [csi > create] Executing
2026-08-26 06:55:35.470708 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-26 06:55:35.478813 | instance | INFO     [csi > prepare] Executing
2026-08-26 06:55:36.249438 | instance |
2026-08-26 06:55:36.249734 | instance | PLAY [Prepare] *****************************************************************
2026-08-26 06:55:36.250101 | instance |
2026-08-26 06:55:36.250509 | instance | TASK [Gathering Facts] *********************************************************
2026-08-26 06:55:36.250877 | instance | Wednesday 26 August 2026  06:55:36 +0000 (0:00:00.027)       0:00:00.027 ******
2026-08-26 06:55:37.362141 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-26 06:55:37.362509 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-26 06:55:37.362803 | instance | interpreter could change the meaning of that path. See
2026-08-26 06:55:37.363171 | instance | https://docs.ansible.com/ansible-
2026-08-26 06:55:37.363522 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-26 06:55:37.371396 | instance | ok: [instance]
2026-08-26 06:55:37.371707 | instance |
2026-08-26 06:55:37.372012 | instance | TASK [Configure short hostname] ************************************************
2026-08-26 06:55:37.372401 | instance | Wednesday 26 August 2026  06:55:37 +0000 (0:00:01.122)       0:00:01.149 ******
2026-08-26 06:55:38.007617 | instance | changed: [instance]
2026-08-26 06:55:38.007885 | instance |
2026-08-26 06:55:38.008198 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-08-26 06:55:38.008539 | instance | Wednesday 26 August 2026  06:55:38 +0000 (0:00:00.635)       0:00:01.785 ******
2026-08-26 06:55:38.244498 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-08-26 06:55:38.244782 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-08-26 06:55:38.245057 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-08-26 06:55:38.251901 | instance | changed: [instance]
2026-08-26 06:55:38.252106 | instance |
2026-08-26 06:55:38.252374 | instance | TASK [Purge "snapd" package] ***************************************************
2026-08-26 06:55:38.252752 | instance | Wednesday 26 August 2026  06:55:38 +0000 (0:00:00.244)       0:00:02.030 ******
2026-08-26 06:55:38.992030 | instance | ok: [instance]
2026-08-26 06:55:38.992233 | instance |
2026-08-26 06:55:38.992570 | instance | PLAY [Create devices for Ceph] *************************************************
2026-08-26 06:55:38.992877 | instance |
2026-08-26 06:55:38.993163 | instance | TASK [Gathering Facts] *********************************************************
2026-08-26 06:55:38.993451 | instance | Wednesday 26 August 2026  06:55:38 +0000 (0:00:00.739)       0:00:02.770 ******
2026-08-26 06:55:39.666069 | instance | ok: [instance]
2026-08-26 06:55:39.666324 | instance |
2026-08-26 06:55:39.666621 | instance | TASK [Install depedencies] *****************************************************
2026-08-26 06:55:39.666915 | instance | Wednesday 26 August 2026  06:55:39 +0000 (0:00:00.673)       0:00:03.444 ******
2026-08-26 06:55:58.378027 | instance | changed: [instance]
2026-08-26 06:55:58.380517 | instance |
2026-08-26 06:55:58.380558 | instance | TASK [Start up service] ********************************************************
2026-08-26 06:55:58.380566 | instance | Wednesday 26 August 2026  06:55:58 +0000 (0:00:18.712)       0:00:22.156 ******
2026-08-26 06:55:58.878087 | instance | ok: [instance]
2026-08-26 06:55:58.878139 | instance |
2026-08-26 06:55:58.878151 | instance | TASK [Generate lvm.conf] *******************************************************
2026-08-26 06:55:58.878162 | instance | Wednesday 26 August 2026  06:55:58 +0000 (0:00:00.499)       0:00:22.655 ******
2026-08-26 06:55:59.154199 | instance | ok: [instance]
2026-08-26 06:55:59.154231 | instance |
2026-08-26 06:55:59.154238 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-08-26 06:55:59.154245 | instance | Wednesday 26 August 2026  06:55:59 +0000 (0:00:00.276)       0:00:22.932 ******
2026-08-26 06:55:59.782582 | instance | changed: [instance]
2026-08-26 06:55:59.782645 | instance |
2026-08-26 06:55:59.782661 | instance | TASK [Get list of all loopback devices] ****************************************
2026-08-26 06:55:59.782672 | instance | Wednesday 26 August 2026  06:55:59 +0000 (0:00:00.627)       0:00:23.559 ******
2026-08-26 06:55:59.968507 | instance | ok: [instance]
2026-08-26 06:55:59.968617 | instance |
2026-08-26 06:55:59.968625 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-08-26 06:55:59.968760 | instance | Wednesday 26 August 2026  06:55:59 +0000 (0:00:00.186)       0:00:23.746 ******
2026-08-26 06:55:59.991195 | instance | skipping: [instance]
2026-08-26 06:55:59.991473 | instance |
2026-08-26 06:55:59.991796 | instance | TASK [Create devices for Ceph] *************************************************
2026-08-26 06:55:59.992078 | instance | Wednesday 26 August 2026  06:55:59 +0000 (0:00:00.023)       0:00:23.769 ******
2026-08-26 06:56:00.513706 | instance | changed: [instance] => (item=osd0)
2026-08-26 06:56:00.513885 | instance | changed: [instance] => (item=osd1)
2026-08-26 06:56:00.514072 | instance | changed: [instance] => (item=osd2)
2026-08-26 06:56:00.514248 | instance |
2026-08-26 06:56:00.514442 | instance | TASK [Set permissions on loopback devices] *************************************
2026-08-26 06:56:00.514628 | instance | Wednesday 26 August 2026  06:56:00 +0000 (0:00:00.522)       0:00:24.292 ******
2026-08-26 06:56:01.098575 | instance | changed: [instance] => (item=osd0)
2026-08-26 06:56:01.098616 | instance | changed: [instance] => (item=osd1)
2026-08-26 06:56:01.098623 | instance | changed: [instance] => (item=osd2)
2026-08-26 06:56:01.098629 | instance |
2026-08-26 06:56:01.098635 | instance | TASK [Start loop devices] ******************************************************
2026-08-26 06:56:01.098645 | instance | Wednesday 26 August 2026  06:56:01 +0000 (0:00:00.583)       0:00:24.875 ******
2026-08-26 06:56:01.791345 | instance | changed: [instance] => (item=osd0)
2026-08-26 06:56:01.792206 | instance | changed: [instance] => (item=osd1)
2026-08-26 06:56:01.792242 | instance | changed: [instance] => (item=osd2)
2026-08-26 06:56:01.792249 | instance |
2026-08-26 06:56:01.792256 | instance | TASK [Create a volume group for each loop device] ******************************
2026-08-26 06:56:01.792262 | instance | Wednesday 26 August 2026  06:56:01 +0000 (0:00:00.694)       0:00:25.569 ******
2026-08-26 06:56:04.948196 | instance | changed: [instance] => (item=osd0)
2026-08-26 06:56:04.948263 | instance | changed: [instance] => (item=osd1)
2026-08-26 06:56:04.948540 | instance | changed: [instance] => (item=osd2)
2026-08-26 06:56:04.949067 | instance |
2026-08-26 06:56:04.949111 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-08-26 06:56:04.949119 | instance | Wednesday 26 August 2026  06:56:04 +0000 (0:00:03.156)       0:00:28.726 ******
2026-08-26 06:56:06.833138 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-08-26 06:56:06.833736 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-08-26 06:56:06.833767 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-08-26 06:56:06.833774 | instance |
2026-08-26 06:56:06.833783 | instance | PLAY RECAP *********************************************************************
2026-08-26 06:56:06.835150 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-08-26 06:56:06.835198 | instance |
2026-08-26 06:56:06.835210 | instance | Wednesday 26 August 2026  06:56:06 +0000 (0:00:01.885)       0:00:30.611 ******
2026-08-26 06:56:06.835220 | instance | ===============================================================================
2026-08-26 06:56:06.835242 | instance | Install depedencies ---------------------------------------------------- 18.71s
2026-08-26 06:56:06.835252 | instance | Create a volume group for each loop device ------------------------------ 3.16s
2026-08-26 06:56:06.835260 | instance | Create a logical volume for each loop device ---------------------------- 1.89s
2026-08-26 06:56:06.835276 | instance | Gathering Facts --------------------------------------------------------- 1.12s
2026-08-26 06:56:06.836467 | instance | Purge "snapd" package --------------------------------------------------- 0.74s
2026-08-26 06:56:06.836479 | instance | Start loop devices ------------------------------------------------------ 0.69s
2026-08-26 06:56:06.836483 | instance | Gathering Facts --------------------------------------------------------- 0.67s
2026-08-26 06:56:06.836488 | instance | Configure short hostname ------------------------------------------------ 0.64s
2026-08-26 06:56:06.836492 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.63s
2026-08-26 06:56:06.836496 | instance | Set permissions on loopback devices ------------------------------------- 0.58s
2026-08-26 06:56:06.836600 | instance | Create devices for Ceph ------------------------------------------------- 0.52s
2026-08-26 06:56:06.836846 | instance | Start up service -------------------------------------------------------- 0.50s
2026-08-26 06:56:06.837062 | instance | Generate lvm.conf ------------------------------------------------------- 0.28s
2026-08-26 06:56:06.837277 | instance | Ensure hostname inside hosts file --------------------------------------- 0.24s
2026-08-26 06:56:06.837488 | instance | Get list of all loopback devices ---------------------------------------- 0.19s
2026-08-26 06:56:06.837699 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s
2026-08-26 06:56:06.922653 | instance | INFO     [csi > prepare] Executed: Successful
2026-08-26 06:56:06.934491 | instance | INFO     [csi > converge] Executing
2026-08-26 06:56:08.404686 | instance |
2026-08-26 06:56:08.405112 | instance | PLAY [Debug CSI driver value] **************************************************
2026-08-26 06:56:08.405452 | instance |
2026-08-26 06:56:08.405799 | instance | TASK [Gathering Facts] *********************************************************
2026-08-26 06:56:08.406145 | instance | Wednesday 26 August 2026  06:56:08 +0000 (0:00:00.007)       0:00:00.007 ******
2026-08-26 06:56:09.308526 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-26 06:56:09.308597 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-26 06:56:09.308705 | instance | interpreter could change the meaning of that path. See
2026-08-26 06:56:09.308858 | instance | https://docs.ansible.com/ansible-
2026-08-26 06:56:09.309055 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-26 06:56:09.320060 | instance | ok: [instance]
2026-08-26 06:56:09.320306 | instance |
2026-08-26 06:56:09.320612 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-08-26 06:56:09.320913 | instance | Wednesday 26 August 2026  06:56:09 +0000 (0:00:00.915)       0:00:00.923 ******
2026-08-26 06:56:09.372515 | instance | ok: [instance] => {
2026-08-26 06:56:09.372803 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-08-26 06:56:09.373058 | instance | }
2026-08-26 06:56:09.373311 | instance |
2026-08-26 06:56:09.373572 | instance | PLAY [all] *********************************************************************
2026-08-26 06:56:09.373821 | instance |
2026-08-26 06:56:09.374114 | instance | TASK [Gathering Facts] *********************************************************
2026-08-26 06:56:09.374372 | instance | Wednesday 26 August 2026  06:56:09 +0000 (0:00:00.051)       0:00:00.975 ******
2026-08-26 06:56:10.291008 | instance | ok: [instance]
2026-08-26 06:56:10.291396 | instance |
2026-08-26 06:56:10.291761 | instance | TASK [Fail if atmosphere_ceph_enabled is set] **********************************
2026-08-26 06:56:10.292120 | instance | Wednesday 26 August 2026  06:56:10 +0000 (0:00:00.918)       0:00:01.893 ******
2026-08-26 06:56:10.329034 | instance | skipping: [instance]
2026-08-26 06:56:10.329162 | instance |
2026-08-26 06:56:10.329329 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-08-26 06:56:10.329553 | instance | Wednesday 26 August 2026  06:56:10 +0000 (0:00:00.038)       0:00:01.932 ******
2026-08-26 06:56:10.507705 | instance | ok: [instance]
2026-08-26 06:56:10.507796 | instance |
2026-08-26 06:56:10.507903 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-08-26 06:56:10.508065 | instance |
2026-08-26 06:56:10.508222 | instance | TASK [Gathering Facts] *********************************************************
2026-08-26 06:56:10.508380 | instance | Wednesday 26 August 2026  06:56:10 +0000 (0:00:00.178)       0:00:02.111 ******
2026-08-26 06:56:11.380947 | instance | ok: [instance]
2026-08-26 06:56:11.381005 | instance |
2026-08-26 06:56:11.381138 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-26 06:56:11.381316 | instance | Wednesday 26 August 2026  06:56:11 +0000 (0:00:00.871)       0:00:02.982 ******
2026-08-26 06:56:11.688970 | instance | ok: [instance]
2026-08-26 06:56:11.689043 | instance |
2026-08-26 06:56:11.689156 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-26 06:56:11.689342 | instance | Wednesday 26 August 2026  06:56:11 +0000 (0:00:00.308)       0:00:03.290 ******
2026-08-26 06:56:11.733016 | instance | skipping: [instance]
2026-08-26 06:56:11.733138 | instance |
2026-08-26 06:56:11.733239 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-08-26 06:56:11.733415 | instance | Wednesday 26 August 2026  06:56:11 +0000 (0:00:00.044)       0:00:03.334 ******
2026-08-26 06:56:12.060819 | instance | changed: [instance]
2026-08-26 06:56:12.061002 | instance |
2026-08-26 06:56:12.061161 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-26 06:56:12.061315 | instance | Wednesday 26 August 2026  06:56:12 +0000 (0:00:00.327)       0:00:03.661 ******
2026-08-26 06:56:12.131084 | instance | ok: [instance] => {
2026-08-26 06:56:12.131124 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-08-26 06:56:12.131131 | instance | }
2026-08-26 06:56:12.131137 | instance |
2026-08-26 06:56:12.131143 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-26 06:56:12.131150 | instance | Wednesday 26 August 2026  06:56:12 +0000 (0:00:00.071)       0:00:03.733 ******
2026-08-26 06:56:12.862195 | instance | changed: [instance]
2026-08-26 06:56:12.862324 | instance |
2026-08-26 06:56:12.862673 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-26 06:56:12.862691 | instance | Wednesday 26 August 2026  06:56:12 +0000 (0:00:00.731)       0:00:04.465 ******
2026-08-26 06:56:12.911733 | instance | skipping: [instance]
2026-08-26 06:56:12.911827 | instance |
2026-08-26 06:56:12.912091 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-26 06:56:12.912106 | instance | Wednesday 26 August 2026  06:56:12 +0000 (0:00:00.049)       0:00:04.515 ******
2026-08-26 06:56:12.962043 | instance | skipping: [instance]
2026-08-26 06:56:12.962397 | instance |
2026-08-26 06:56:12.962414 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-26 06:56:12.962420 | instance | Wednesday 26 August 2026  06:56:12 +0000 (0:00:00.050)       0:00:04.565 ******
2026-08-26 06:56:13.171458 | instance | ok: [instance]
2026-08-26 06:56:13.171967 | instance |
2026-08-26 06:56:13.171988 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-26 06:56:13.171996 | instance | Wednesday 26 August 2026  06:56:13 +0000 (0:00:00.209)       0:00:04.774 ******
2026-08-26 06:56:14.344596 | instance | ok: [instance]
2026-08-26 06:56:14.345033 | instance |
2026-08-26 06:56:14.345071 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-26 06:56:14.345085 | instance | Wednesday 26 August 2026  06:56:14 +0000 (0:00:01.173)       0:00:05.947 ******
2026-08-26 06:56:14.414962 | instance | ok: [instance] => {
2026-08-26 06:56:14.415830 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-08-26 06:56:14.415869 | instance | }
2026-08-26 06:56:14.415877 | instance |
2026-08-26 06:56:14.415883 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-26 06:56:14.415890 | instance | Wednesday 26 August 2026  06:56:14 +0000 (0:00:00.069)       0:00:06.017 ******
2026-08-26 06:56:15.085287 | instance | changed: [instance]
2026-08-26 06:56:15.085380 | instance |
2026-08-26 06:56:15.085645 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-26 06:56:15.085660 | instance | Wednesday 26 August 2026  06:56:15 +0000 (0:00:00.670)       0:00:06.688 ******
2026-08-26 06:56:17.857882 | instance | changed: [instance]
2026-08-26 06:56:17.857952 | instance |
2026-08-26 06:56:17.858224 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-08-26 06:56:17.858265 | instance | Wednesday 26 August 2026  06:56:17 +0000 (0:00:02.772)       0:00:09.461 ******
2026-08-26 06:56:17.889029 | instance | skipping: [instance]
2026-08-26 06:56:17.889710 | instance |
2026-08-26 06:56:17.889740 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-08-26 06:56:17.889748 | instance | Wednesday 26 August 2026  06:56:17 +0000 (0:00:00.030)       0:00:09.492 ******
2026-08-26 06:56:17.922209 | instance | skipping: [instance]
2026-08-26 06:56:17.922271 | instance |
2026-08-26 06:56:17.922569 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-08-26 06:56:17.922596 | instance | Wednesday 26 August 2026  06:56:17 +0000 (0:00:00.033)       0:00:09.525 ******
2026-08-26 06:56:17.958340 | instance | skipping: [instance]
2026-08-26 06:56:17.958495 | instance |
2026-08-26 06:56:17.958832 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-08-26 06:56:17.959174 | instance | Wednesday 26 August 2026  06:56:17 +0000 (0:00:00.035)       0:00:09.561 ******
2026-08-26 06:56:23.099274 | instance | changed: [instance]
2026-08-26 06:56:23.099348 | instance |
2026-08-26 06:56:23.099629 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-08-26 06:56:23.099660 | instance | Wednesday 26 August 2026  06:56:23 +0000 (0:00:05.141)       0:00:14.702 ******
2026-08-26 06:56:23.657973 | instance | changed: [instance]
2026-08-26 06:56:23.658462 | instance |
2026-08-26 06:56:23.658507 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-08-26 06:56:23.658515 | instance | Wednesday 26 August 2026  06:56:23 +0000 (0:00:00.558)       0:00:15.261 ******
2026-08-26 06:56:24.557742 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-08-26 06:56:24.557819 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-08-26 06:56:24.558648 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-08-26 06:56:24.558691 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-08-26 06:56:24.558699 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-08-26 06:56:24.558704 | instance |
2026-08-26 06:56:24.558709 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-08-26 06:56:24.558714 | instance | Wednesday 26 August 2026  06:56:24 +0000 (0:00:00.899)       0:00:16.161 ******
2026-08-26 06:56:25.134058 | instance | changed: [instance]
2026-08-26 06:56:25.134156 | instance |
2026-08-26 06:56:25.134787 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-08-26 06:56:25.134827 | instance | Wednesday 26 August 2026  06:56:25 +0000 (0:00:00.558)       0:00:16.719 ******
2026-08-26 06:56:25.134832 | instance |
2026-08-26 06:56:25.134837 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-26 06:56:25.134841 | instance | Wednesday 26 August 2026  06:56:25 +0000 (0:00:00.018)       0:00:16.737 ******
2026-08-26 06:56:26.084213 | instance | ok: [instance]
2026-08-26 06:56:26.084295 | instance |
2026-08-26 06:56:26.084542 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-08-26 06:56:26.084821 | instance | Wednesday 26 August 2026  06:56:26 +0000 (0:00:00.950)       0:00:17.687 ******
2026-08-26 06:56:26.502858 | instance | changed: [instance]
2026-08-26 06:56:26.502933 | instance |
2026-08-26 06:56:26.503190 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-08-26 06:56:26.503206 | instance | Wednesday 26 August 2026  06:56:26 +0000 (0:00:00.418)       0:00:18.106 ******
2026-08-26 06:56:27.039154 | instance | changed: [instance]
2026-08-26 06:56:27.039235 | instance |
2026-08-26 06:56:27.039527 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-26 06:56:27.039567 | instance | Wednesday 26 August 2026  06:56:27 +0000 (0:00:00.536)       0:00:18.642 ******
2026-08-26 06:56:27.232777 | instance | ok: [instance]
2026-08-26 06:56:27.232891 | instance |
2026-08-26 06:56:27.233151 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-26 06:56:27.233189 | instance | Wednesday 26 August 2026  06:56:27 +0000 (0:00:00.193)       0:00:18.836 ******
2026-08-26 06:56:27.286936 | instance | ok: [instance] => {
2026-08-26 06:56:27.287615 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-08-26 06:56:27.287638 | instance | }
2026-08-26 06:56:27.287643 | instance |
2026-08-26 06:56:27.287648 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-26 06:56:27.287653 | instance | Wednesday 26 August 2026  06:56:27 +0000 (0:00:00.054)       0:00:18.890 ******
2026-08-26 06:56:28.044006 | instance | changed: [instance]
2026-08-26 06:56:28.044075 | instance |
2026-08-26 06:56:28.044374 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-26 06:56:28.044512 | instance | Wednesday 26 August 2026  06:56:28 +0000 (0:00:00.757)       0:00:19.647 ******
2026-08-26 06:56:32.411505 | instance | changed: [instance]
2026-08-26 06:56:32.411581 | instance |
2026-08-26 06:56:32.411846 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-08-26 06:56:32.411880 | instance | Wednesday 26 August 2026  06:56:32 +0000 (0:00:04.367)       0:00:24.014 ******
2026-08-26 06:56:33.420372 | instance | ok: [instance]
2026-08-26 06:56:33.420483 | instance |
2026-08-26 06:56:33.420739 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-08-26 06:56:33.420780 | instance | Wednesday 26 August 2026  06:56:33 +0000 (0:00:01.008)       0:00:25.023 ******
2026-08-26 06:56:33.903475 | instance | changed: [instance]
2026-08-26 06:56:33.903561 | instance |
2026-08-26 06:56:33.903898 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-08-26 06:56:33.903953 | instance | Wednesday 26 August 2026  06:56:33 +0000 (0:00:00.482)       0:00:25.506 ******
2026-08-26 06:56:34.357195 | instance | changed: [instance]
2026-08-26 06:56:34.357268 | instance |
2026-08-26 06:56:34.357563 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-08-26 06:56:34.357606 | instance | Wednesday 26 August 2026  06:56:34 +0000 (0:00:00.453)       0:00:25.960 ******
2026-08-26 06:56:34.906050 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-08-26 06:56:34.906267 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-08-26 06:56:34.906927 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-08-26 06:56:34.906976 | instance |
2026-08-26 06:56:34.906984 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-08-26 06:56:34.906991 | instance | Wednesday 26 August 2026  06:56:34 +0000 (0:00:00.548)       0:00:26.509 ******
2026-08-26 06:56:35.363642 | instance | changed: [instance]
2026-08-26 06:56:35.363715 | instance |
2026-08-26 06:56:35.363989 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-08-26 06:56:35.364028 | instance | Wednesday 26 August 2026  06:56:35 +0000 (0:00:00.457)       0:00:26.967 ******
2026-08-26 06:56:35.820779 | instance | changed: [instance]
2026-08-26 06:56:35.820881 | instance |
2026-08-26 06:56:35.821523 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-08-26 06:56:35.821572 | instance | Wednesday 26 August 2026  06:56:35 +0000 (0:00:00.440)       0:00:27.407 ******
2026-08-26 06:56:35.821578 | instance |
2026-08-26 06:56:35.821583 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-26 06:56:35.821592 | instance | Wednesday 26 August 2026  06:56:35 +0000 (0:00:00.016)       0:00:27.424 ******
2026-08-26 06:56:36.462630 | instance | ok: [instance]
2026-08-26 06:56:36.462686 | instance |
2026-08-26 06:56:36.462956 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-08-26 06:56:36.462973 | instance | Wednesday 26 August 2026  06:56:36 +0000 (0:00:00.641)       0:00:28.065 ******
2026-08-26 06:56:37.236688 | instance | changed: [instance]
2026-08-26 06:56:37.236774 | instance |
2026-08-26 06:56:37.237075 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-08-26 06:56:37.237114 | instance | Wednesday 26 August 2026  06:56:37 +0000 (0:00:00.773)       0:00:28.839 ******
2026-08-26 06:56:37.805577 | instance | changed: [instance]
2026-08-26 06:56:37.805650 | instance |
2026-08-26 06:56:37.805936 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-08-26 06:56:37.805968 | instance | Wednesday 26 August 2026  06:56:37 +0000 (0:00:00.569)       0:00:29.408 ******
2026-08-26 06:56:37.865542 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-08-26 06:56:37.865615 | instance |
2026-08-26 06:56:37.865861 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-08-26 06:56:37.865885 | instance | Wednesday 26 August 2026  06:56:37 +0000 (0:00:00.059)       0:00:29.468 ******
2026-08-26 06:56:42.085369 | instance | changed: [instance]
2026-08-26 06:56:42.085443 | instance |
2026-08-26 06:56:42.085720 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-08-26 06:56:42.085860 | instance | Wednesday 26 August 2026  06:56:42 +0000 (0:00:04.219)       0:00:33.688 ******
2026-08-26 06:56:42.709718 | instance | ok: [instance] => (item=chronyd)
2026-08-26 06:56:42.710209 | instance | ok: [instance] => (item=sshd)
2026-08-26 06:56:42.710323 | instance |
2026-08-26 06:56:42.710329 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-08-26 06:56:42.710334 | instance | Wednesday 26 August 2026  06:56:42 +0000 (0:00:00.624)       0:00:34.313 ******
2026-08-26 06:56:43.050490 | instance | changed: [instance]
2026-08-26 06:56:43.050596 | instance |
2026-08-26 06:56:43.050874 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-08-26 06:56:43.050918 | instance | Wednesday 26 August 2026  06:56:43 +0000 (0:00:00.340)       0:00:34.653 ******
2026-08-26 06:56:43.245799 | instance | ok: [instance]
2026-08-26 06:56:43.246312 | instance |
2026-08-26 06:56:43.246354 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-08-26 06:56:43.246362 | instance | Wednesday 26 August 2026  06:56:43 +0000 (0:00:00.195)       0:00:34.848 ******
2026-08-26 06:56:43.678181 | instance | changed: [instance]
2026-08-26 06:56:43.678260 | instance |
2026-08-26 06:56:43.678543 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-08-26 06:56:43.678591 | instance | Wednesday 26 August 2026  06:56:43 +0000 (0:00:00.432)       0:00:35.281 ******
2026-08-26 06:56:44.003013 | instance | changed: [instance]
2026-08-26 06:56:44.003089 | instance |
2026-08-26 06:56:44.003365 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-08-26 06:56:44.003406 | instance | Wednesday 26 August 2026  06:56:43 +0000 (0:00:00.324)       0:00:35.606 ******
2026-08-26 06:56:44.185048 | instance | ok: [instance]
2026-08-26 06:56:44.185122 | instance |
2026-08-26 06:56:44.185376 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-08-26 06:56:44.185414 | instance | Wednesday 26 August 2026  06:56:44 +0000 (0:00:00.182)       0:00:35.788 ******
2026-08-26 06:56:44.405727 | instance | ok: [instance] => (item=instance)
2026-08-26 06:56:44.405828 | instance |
2026-08-26 06:56:44.406100 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-08-26 06:56:44.406140 | instance | Wednesday 26 August 2026  06:56:44 +0000 (0:00:00.220)       0:00:36.009 ******
2026-08-26 06:56:44.457449 | instance | ok: [instance]
2026-08-26 06:56:44.457806 | instance |
2026-08-26 06:56:44.457843 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-08-26 06:56:44.457848 | instance | Wednesday 26 August 2026  06:56:44 +0000 (0:00:00.051)       0:00:36.060 ******
2026-08-26 06:56:44.528703 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-08-26 06:56:44.529091 | instance |
2026-08-26 06:56:44.529122 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-08-26 06:56:44.529128 | instance | Wednesday 26 August 2026  06:56:44 +0000 (0:00:00.071)       0:00:36.131 ******
2026-08-26 06:56:44.791849 | instance | changed: [instance]
2026-08-26 06:56:44.791918 | instance |
2026-08-26 06:56:44.792212 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-08-26 06:56:44.792247 | instance | Wednesday 26 August 2026  06:56:44 +0000 (0:00:00.263)       0:00:36.395 ******
2026-08-26 06:56:45.423712 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-08-26 06:56:45.423814 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-08-26 06:56:45.424337 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-08-26 06:56:45.424377 | instance |
2026-08-26 06:56:45.424383 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-08-26 06:56:45.424388 | instance | Wednesday 26 August 2026  06:56:45 +0000 (0:00:00.631)       0:00:37.027 ******
2026-08-26 06:58:10.499968 | instance | ok: [instance]
2026-08-26 06:58:10.500048 | instance |
2026-08-26 06:58:10.500299 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-08-26 06:58:10.500335 | instance | Wednesday 26 August 2026  06:58:10 +0000 (0:01:25.075)       0:02:02.103 ******
2026-08-26 06:58:10.715514 | instance | changed: [instance]
2026-08-26 06:58:10.715581 | instance |
2026-08-26 06:58:10.715730 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-08-26 06:58:10.715847 | instance | Wednesday 26 August 2026  06:58:10 +0000 (0:00:00.215)       0:02:02.318 ******
2026-08-26 06:58:10.757739 | instance | ok: [instance]
2026-08-26 06:58:10.757816 | instance |
2026-08-26 06:58:10.757938 | instance | TASK [Install Ceph host] *******************************************************
2026-08-26 06:58:10.758058 | instance | Wednesday 26 August 2026  06:58:10 +0000 (0:00:00.042)       0:02:02.361 ******
2026-08-26 06:58:10.843571 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-08-26 06:58:10.844146 | instance |
2026-08-26 06:58:10.844159 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-08-26 06:58:10.844169 | instance | Wednesday 26 August 2026  06:58:10 +0000 (0:00:00.085)       0:02:02.446 ******
2026-08-26 06:58:12.406653 | instance | ok: [instance]
2026-08-26 06:58:12.406741 | instance |
2026-08-26 06:58:12.406866 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-08-26 06:58:12.406978 | instance | Wednesday 26 August 2026  06:58:12 +0000 (0:00:01.562)       0:02:04.009 ******
2026-08-26 06:58:12.471070 | instance | ok: [instance] => (item=instance)
2026-08-26 06:58:12.471188 | instance |
2026-08-26 06:58:12.471344 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-08-26 06:58:12.471485 | instance | Wednesday 26 August 2026  06:58:12 +0000 (0:00:00.064)       0:02:04.074 ******
2026-08-26 06:58:12.808592 | instance | ok: [instance]
2026-08-26 06:58:12.808693 | instance |
2026-08-26 06:58:12.809149 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-08-26 06:58:12.809195 | instance | Wednesday 26 August 2026  06:58:12 +0000 (0:00:00.337)       0:02:04.411 ******
2026-08-26 06:58:15.050534 | instance | ok: [instance]
2026-08-26 06:58:15.050616 | instance |
2026-08-26 06:58:15.050876 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-08-26 06:58:15.050915 | instance | Wednesday 26 August 2026  06:58:15 +0000 (0:00:02.242)       0:02:06.653 ******
2026-08-26 06:58:58.127189 | 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-26 06:58:58.128108 | 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_18yysel8/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_18yysel8/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_18yysel8/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_18yysel8/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-26T06:58:57.973+0000 7fc1f0bf1640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBZjo5qnRCqGSAAFtGOkagqshiD4B81xfdWo+LpB6b9JgLxEvJo4QmgU84=: Malformed input [buffer:3]\n2026-08-26T06:58:57.973+0000 7fc1f0bf1640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-26T06:58:57.973+0000 7fc1f0bf1640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBZjo5qnRCqGSAAFtGOkagqshiD4B81xfdWo+LpB6b9JgLxEvJo4QmgU84=: Malformed input [buffer:3]\n2026-08-26T06:58:57.973+0000 7fc1f0bf1640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-26T06:58:57.973+0000 7fc1f0bf1640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBZjo5qnRCqGSAAFtGOkagqshiD4B81xfdWo+LpB6b9JgLxEvJo4QmgU84=: Malformed input [buffer:3]\n2026-08-26T06:58:57.973+0000 7fc1f0bf1640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-26T06:58:57.973+0000 7fc1f0bf1640 -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-26 06:58:58.131293 | instance |
2026-08-26 06:58:58.131604 | instance | PLAY RECAP *********************************************************************
2026-08-26 06:58:58.132523 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=7    rescued=0    ignored=0
2026-08-26 06:58:58.132559 | instance |
2026-08-26 06:58:58.132571 | instance | Wednesday 26 August 2026  06:58:58 +0000 (0:00:43.080)       0:02:49.734 ******
2026-08-26 06:58:58.135600 | instance | ===============================================================================
2026-08-26 06:58:58.135643 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 85.08s
2026-08-26 06:58:58.135649 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 43.08s
2026-08-26 06:58:58.135653 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 5.14s
2026-08-26 06:58:58.135657 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.37s
2026-08-26 06:58:58.135661 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 4.22s
2026-08-26 06:58:58.135666 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.77s
2026-08-26 06:58:58.135681 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.24s
2026-08-26 06:58:58.135686 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.59s
2026-08-26 06:58:58.135690 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.56s
2026-08-26 06:58:58.135693 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.17s
2026-08-26 06:58:58.135699 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.01s
2026-08-26 06:58:58.135704 | instance | Gathering Facts --------------------------------------------------------- 0.92s
2026-08-26 06:58:58.135710 | instance | Gathering Facts --------------------------------------------------------- 0.92s
2026-08-26 06:58:58.135715 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.90s
2026-08-26 06:58:58.135721 | instance | Gathering Facts --------------------------------------------------------- 0.87s
2026-08-26 06:58:58.135726 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 0.77s
2026-08-26 06:58:58.135729 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.76s
2026-08-26 06:58:58.135733 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.73s
2026-08-26 06:58:58.135737 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.67s
2026-08-26 06:58:58.135741 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.63s
2026-08-26 06:58:58.224516 | 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-26 06:58:58.224759 | instance | ERROR    [csi > converge] Executed: Failed
2026-08-26 06:58:58.224911 | 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-26 06:58:58.548452 | instance | ERROR
2026-08-26 06:58:58.548597 | instance | {
2026-08-26 06:58:58.548636 | instance |   "delta": "0:03:36.181943",
2026-08-26 06:58:58.548682 | instance |   "end": "2026-08-26 06:58:58.276167",
2026-08-26 06:58:58.548709 | instance |   "msg": "non-zero return code",
2026-08-26 06:58:58.548751 | instance |   "rc": 2,
2026-08-26 06:58:58.548777 | instance |   "start": "2026-08-26 06:55:22.094224"
2026-08-26 06:58:58.548803 | instance | }
failure
2026-08-26 06:58:58.558082 | 
2026-08-26 06:58:58.558149 | PLAY RECAP
2026-08-26 06:58:58.558193 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-08-26 06:58:58.558215 | 
2026-08-26 06:58:58.709973 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-26 06:58:58.712627 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-26 06:58:59.802359 | 
2026-08-26 06:58:59.802479 | PLAY [all]
2026-08-26 06:58:59.816802 | 
2026-08-26 06:58:59.816901 | TASK [gather-host-logs : creating directory for system status]
2026-08-26 06:59:00.146234 | instance | changed
2026-08-26 06:59:00.153160 | 
2026-08-26 06:59:00.153264 | TASK [gather-host-logs : Get logs for each host]
2026-08-26 06:59:00.506260 | instance | + systemd-cgls --full --all --no-pager
2026-08-26 06:59:00.520144 | instance | + ip addr
2026-08-26 06:59:00.522621 | instance | + ip route
2026-08-26 06:59:00.524073 | instance | + lsblk
2026-08-26 06:59:00.528903 | instance | + mount
2026-08-26 06:59:00.531735 | instance | + docker images
2026-08-26 06:59:00.553333 | instance | + brctl show
2026-08-26 06:59:00.553744 | instance | /bin/bash: line 8: brctl: command not found
2026-08-26 06:59:00.553939 | instance | + ps aux --sort=-%mem
2026-08-26 06:59:00.569037 | instance | + dpkg -l
2026-08-26 06:59:00.578681 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-08-26 06:59:00.579238 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-08-26 06:59:00.598488 | instance | + '[' '!' -z '' ']'
2026-08-26 06:59:00.689103 | instance | ok: Runtime: 0:00:00.097387
2026-08-26 06:59:00.697222 | 
2026-08-26 06:59:00.697336 | TASK [gather-host-logs : Downloads logs to executor]
2026-08-26 06:59:01.328885 | instance | changed:
2026-08-26 06:59:01.329082 | instance | created directory /var/lib/zuul/builds/9c434e1850a2403d8c9f74fd6027c094/work/logs/instance
2026-08-26 06:59:01.329128 | instance | cd+++++++++ system/
2026-08-26 06:59:01.329161 | instance | >f+++++++++ system/brctl-show.txt
2026-08-26 06:59:01.329198 | instance | >f+++++++++ system/docker-images.txt
2026-08-26 06:59:01.329229 | instance | >f+++++++++ system/ip-addr.txt
2026-08-26 06:59:01.329260 | instance | >f+++++++++ system/ip-route.txt
2026-08-26 06:59:01.329289 | instance | >f+++++++++ system/lsblk.txt
2026-08-26 06:59:01.329318 | instance | >f+++++++++ system/mount.txt
2026-08-26 06:59:01.329346 | instance | >f+++++++++ system/packages.txt
2026-08-26 06:59:01.329373 | instance | >f+++++++++ system/ps.txt
2026-08-26 06:59:01.329403 | instance | >f+++++++++ system/systemd-cgls.txt
2026-08-26 06:59:01.341307 | 
2026-08-26 06:59:01.341379 | LOOP [helm-release-status : creating directory for helm release status]
2026-08-26 06:59:01.537967 | instance | changed: "values"
2026-08-26 06:59:01.716118 | instance | changed: "releases"
2026-08-26 06:59:01.732063 | 
2026-08-26 06:59:01.732208 | TASK [helm-release-status : Gather get release status for helm charts]
2026-08-26 06:59:01.953550 | instance | /bin/bash: line 3: kubectl: command not found
2026-08-26 06:59:02.270426 | instance | ok: Runtime: 0:00:00.007195
2026-08-26 06:59:02.276587 | 
2026-08-26 06:59:02.276662 | TASK [helm-release-status : Downloads logs to executor]
2026-08-26 06:59:02.767598 | instance | changed:
2026-08-26 06:59:02.767861 | instance | cd+++++++++ helm/
2026-08-26 06:59:02.767924 | instance | cd+++++++++ helm/releases/
2026-08-26 06:59:02.767973 | instance | cd+++++++++ helm/values/
2026-08-26 06:59:02.778698 | 
2026-08-26 06:59:02.778791 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-08-26 06:59:02.975662 | instance | changed
2026-08-26 06:59:02.983655 | 
2026-08-26 06:59:02.983731 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-08-26 06:59:03.226693 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-26 06:59:03.226789 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-26 06:59:03.232535 | instance | environment: line 1: kubectl: command not found
2026-08-26 06:59:03.233981 | instance | xargs: environment: line 1: kubectl: command not found
2026-08-26 06:59:03.233995 | instance | warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-26 06:59:03.235818 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-26 06:59:03.236796 | instance | environment: line 1: kubectl: command not found
2026-08-26 06:59:03.238099 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-26 06:59:03.239351 | instance | environment: line 1: kubectl: command not found
2026-08-26 06:59:03.240387 | instance | environment: line 1: kubectl: command not found
2026-08-26 06:59:03.240785 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-26 06:59:03.241929 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-26 06:59:03.519846 | instance | ok: Runtime: 0:00:00.023738
2026-08-26 06:59:03.526397 | 
2026-08-26 06:59:03.526484 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-08-26 06:59:03.722305 | instance | changed
2026-08-26 06:59:03.727673 | 
2026-08-26 06:59:03.727750 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-08-26 06:59:03.939601 | instance | environment: line 5: kubectl: command not found
2026-08-26 06:59:03.940823 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-26 06:59:03.940967 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-26 06:59:03.941497 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-26 06:59:04.263063 | instance | ok: Runtime: 0:00:00.008782
2026-08-26 06:59:04.270620 | 
2026-08-26 06:59:04.270711 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-08-26 06:59:04.730713 | instance | changed:
2026-08-26 06:59:04.730899 | instance | cd+++++++++ objects/
2026-08-26 06:59:04.730942 | instance | cd+++++++++ objects/cluster/
2026-08-26 06:59:04.731015 | instance | cd+++++++++ objects/namespaced/
2026-08-26 06:59:04.740777 | 
2026-08-26 06:59:04.740931 | TASK [gather-pod-logs : creating directory for pod logs]
2026-08-26 06:59:04.935333 | instance | changed
2026-08-26 06:59:04.942337 | 
2026-08-26 06:59:04.942429 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-08-26 06:59:05.140611 | instance | changed
2026-08-26 06:59:05.145628 | 
2026-08-26 06:59:05.145700 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-08-26 06:59:05.351590 | instance | environment: line 3: kubectl: command not found
2026-08-26 06:59:05.679639 | instance | ok: Runtime: 0:00:00.008379
2026-08-26 06:59:05.686356 | 
2026-08-26 06:59:05.686418 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-08-26 06:59:06.165310 | instance | changed:
2026-08-26 06:59:06.165572 | instance | cd+++++++++ pod-logs/
2026-08-26 06:59:06.165697 | instance | cd+++++++++ pod-logs/failed-pods/
2026-08-26 06:59:06.177775 | 
2026-08-26 06:59:06.177840 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-08-26 06:59:06.368296 | instance | changed
2026-08-26 06:59:06.375144 | 
2026-08-26 06:59:06.375231 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-08-26 06:59:06.577673 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-26 06:59:06.913198 | instance | ok: Runtime: 0:00:00.035736
2026-08-26 06:59:06.920161 | 
2026-08-26 06:59:06.920251 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-08-26 06:59:07.122454 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-26 06:59:07.151568 | instance | ceph-mgr endpoints:
2026-08-26 06:59:07.456411 | instance | ok: Runtime: 0:00:00.034253
2026-08-26 06:59:07.464003 | 
2026-08-26 06:59:07.464113 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-08-26 06:59:07.685074 | instance | /bin/bash: line 4: kubectl: command not found
2026-08-26 06:59:07.998680 | instance | ok: Runtime: 0:00:00.036395
2026-08-26 06:59:08.005357 | 
2026-08-26 06:59:08.005431 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-08-26 06:59:08.468084 | instance | changed: cd+++++++++ prometheus/
2026-08-26 06:59:08.481051 | 
2026-08-26 06:59:08.481145 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-08-26 06:59:08.667944 | instance | changed
2026-08-26 06:59:08.674814 | 
2026-08-26 06:59:08.674898 | TASK [gather-selenium-data : Get selenium data]
2026-08-26 06:59:08.919601 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-08-26 06:59:08.920470 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-08-26 06:59:09.216108 | instance | ERROR
2026-08-26 06:59:09.216426 | instance | {
2026-08-26 06:59:09.216537 | instance |   "delta": "0:00:00.004360",
2026-08-26 06:59:09.216586 | instance |   "end": "2026-08-26 06:59:08.920801",
2026-08-26 06:59:09.216681 | instance |   "msg": "non-zero return code",
2026-08-26 06:59:09.216739 | instance |   "rc": 1,
2026-08-26 06:59:09.216769 | instance |   "start": "2026-08-26 06:59:08.916441"
2026-08-26 06:59:09.216796 | instance | }
2026-08-26 06:59:09.216830 | instance | ERROR: Ignoring Errors
2026-08-26 06:59:09.223097 | 
2026-08-26 06:59:09.223178 | TASK [gather-selenium-data : Downloads logs to executor]
2026-08-26 06:59:09.700406 | instance | changed: cd+++++++++ selenium/
2026-08-26 06:59:09.709458 | 
2026-08-26 06:59:09.709531 | PLAY RECAP
2026-08-26 06:59:09.709577 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-08-26 06:59:09.709600 | 
2026-08-26 06:59:09.831452 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-26 06:59:09.835837 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-26 06:59:10.471314 | 
2026-08-26 06:59:10.471824 | PLAY [all]
2026-08-26 06:59:10.483928 | 
2026-08-26 06:59:10.484033 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-26 06:59:10.518832 | instance | skipping: Conditional result was False
2026-08-26 06:59:10.528313 | 
2026-08-26 06:59:10.528435 | TASK [fetch-output : Set log path for single node]
2026-08-26 06:59:10.571367 | instance | ok
2026-08-26 06:59:10.577797 | 
2026-08-26 06:59:10.577894 | LOOP [fetch-output : Ensure local output dirs]
2026-08-26 06:59:10.964445 | instance -> localhost | ok: "/var/lib/zuul/builds/9c434e1850a2403d8c9f74fd6027c094/work/logs"
2026-08-26 06:59:11.177788 | instance -> localhost | changed: "/var/lib/zuul/builds/9c434e1850a2403d8c9f74fd6027c094/work/artifacts"
2026-08-26 06:59:11.435169 | instance -> localhost | changed: "/var/lib/zuul/builds/9c434e1850a2403d8c9f74fd6027c094/work/docs"
2026-08-26 06:59:11.454936 | 
2026-08-26 06:59:11.455061 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-26 06:59:12.122040 | instance | changed: .d..t...... ./
2026-08-26 06:59:12.122238 | instance | changed: All items complete
2026-08-26 06:59:12.122266 | 
2026-08-26 06:59:12.593267 | instance | changed: .d..t...... ./
2026-08-26 06:59:13.053418 | instance | changed: .d..t...... ./
2026-08-26 06:59:13.078440 | 
2026-08-26 06:59:13.078606 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-26 06:59:13.492023 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.006490
2026-08-26 06:59:13.714952 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007336
2026-08-26 06:59:13.732382 | 
2026-08-26 06:59:13.732491 | PLAY [all]
2026-08-26 06:59:13.739559 | 
2026-08-26 06:59:13.739634 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-26 06:59:14.139389 | instance | changed
2026-08-26 06:59:14.147311 | 
2026-08-26 06:59:14.147371 | PLAY RECAP
2026-08-26 06:59:14.147420 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-26 06:59:14.147444 | 
2026-08-26 06:59:14.259261 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-26 06:59:14.264394 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-26 06:59:14.884526 | 
2026-08-26 06:59:14.884793 | PLAY [localhost]
2026-08-26 06:59:14.894699 | 
2026-08-26 06:59:14.894789 | TASK [Generate Zuul manifest]
2026-08-26 06:59:14.914862 | localhost | ok
2026-08-26 06:59:14.932531 | 
2026-08-26 06:59:14.932627 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-26 06:59:15.297934 | localhost | changed
2026-08-26 06:59:15.307943 | 
2026-08-26 06:59:15.308033 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-26 06:59:15.335506 | localhost | ok
2026-08-26 06:59:15.342848 | 
2026-08-26 06:59:15.342939 | TASK [Upload logs]
2026-08-26 06:59:15.366349 | localhost | ok
2026-08-26 06:59:15.432350 | 
2026-08-26 06:59:15.432480 | TASK [Set zuul-log-path fact]
2026-08-26 06:59:15.451822 | localhost | ok
2026-08-26 06:59:15.464277 | 
2026-08-26 06:59:15.464362 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-26 06:59:15.494723 | localhost | ok
2026-08-26 06:59:15.504457 | 
2026-08-26 06:59:15.504896 | TASK [upload-logs : Create log directories]
2026-08-26 06:59:15.904178 | localhost | changed
2026-08-26 06:59:15.910974 | 
2026-08-26 06:59:15.911066 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-26 06:59:16.321940 | localhost -> localhost | ok: Runtime: 0:00:00.004331
2026-08-26 06:59:16.330003 | 
2026-08-26 06:59:16.330081 | TASK [upload-logs : Upload logs to log server]
2026-08-26 06:59:16.789765 | localhost | Output suppressed because no_log was given
2026-08-26 06:59:16.825212 | 
2026-08-26 06:59:16.825337 | LOOP [upload-logs : Compress console log and json output]
2026-08-26 06:59:16.869426 | localhost | skipping: Conditional result was False
2026-08-26 06:59:16.877435 | localhost | skipping: Conditional result was False
2026-08-26 06:59:16.889788 | 
2026-08-26 06:59:16.889953 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-26 06:59:16.929772 | localhost | skipping: Conditional result was False
2026-08-26 06:59:16.930305 | 
2026-08-26 06:59:16.934423 | localhost | skipping: Conditional result was False
2026-08-26 06:59:16.943663 | 
2026-08-26 06:59:16.943764 | LOOP [upload-logs : Upload console log and json output]