2026-08-19 20:22:00.002010 | Job console starting
2026-08-19 20:22:00.013437 | Updating git repos
2026-08-19 20:22:04.538127 | Cloning repos into workspace
2026-08-19 20:22:19.946791 | Restoring repo states
2026-08-19 20:22:33.114754 | Merging changes
2026-08-19 20:22:34.403899 | Checking out repos
2026-08-19 20:22:36.064909 | Preparing playbooks
2026-08-19 20:22:40.392404 | Running Ansible setup
2026-08-19 20:22:44.129318 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-19 20:22:44.753847 | 
2026-08-19 20:22:44.753969 | PLAY [localhost]
2026-08-19 20:22:44.761474 | 
2026-08-19 20:22:44.761543 | TASK [Gathering Facts]
2026-08-19 20:22:45.649399 | localhost | ok
2026-08-19 20:22:45.659921 | 
2026-08-19 20:22:45.660025 | TASK [Setup log path fact]
2026-08-19 20:22:45.681636 | localhost | ok
2026-08-19 20:22:45.702598 | 
2026-08-19 20:22:45.702669 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-19 20:22:45.733387 | localhost | ok
2026-08-19 20:22:45.741560 | 
2026-08-19 20:22:45.741647 | TASK [emit-job-header : Print job information]
2026-08-19 20:22:45.774474 | # Job Information
2026-08-19 20:22:45.774678 | Ansible Version: 2.16.18
2026-08-19 20:22:45.774748 | Job: atmosphere-molecule-csi-rbd
2026-08-19 20:22:45.774794 | Pipeline: check
2026-08-19 20:22:45.774838 | Executor: 2d72f0692154
2026-08-19 20:22:45.774880 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4093
2026-08-19 20:22:45.774930 | Event ID: ee6887f0-9c0a-11f1-93be-4ce05f6c05f0
2026-08-19 20:22:45.778702 | 
2026-08-19 20:22:45.778785 | LOOP [emit-job-header : Print node information]
2026-08-19 20:22:45.870904 | localhost | ok:
2026-08-19 20:22:45.871191 | localhost | # Node Information
2026-08-19 20:22:45.871253 | localhost | Inventory Hostname: instance
2026-08-19 20:22:45.871300 | localhost | Hostname: np0000190123
2026-08-19 20:22:45.871344 | localhost | Username: zuul
2026-08-19 20:22:45.871393 | localhost | Distro: Ubuntu 22.04
2026-08-19 20:22:45.871436 | localhost | Provider: yul1
2026-08-19 20:22:45.871478 | localhost | Region: ca-ymq-1
2026-08-19 20:22:45.871519 | localhost | Label: ubuntu-jammy
2026-08-19 20:22:45.871558 | localhost | Product Name: OpenStack Nova
2026-08-19 20:22:45.871599 | localhost | Interface IP: 199.19.213.129
2026-08-19 20:22:45.887455 | 
2026-08-19 20:22:45.887547 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-19 20:22:46.389144 | localhost -> localhost | changed
2026-08-19 20:22:46.399090 | 
2026-08-19 20:22:46.399164 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-19 20:22:47.326672 | localhost -> localhost | changed
2026-08-19 20:22:47.333340 | 
2026-08-19 20:22:47.333395 | PLAY [all]
2026-08-19 20:22:47.341753 | 
2026-08-19 20:22:47.341818 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-19 20:22:47.569005 | instance -> localhost | ok
2026-08-19 20:22:47.575164 | 
2026-08-19 20:22:47.575253 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-19 20:22:47.604818 | instance | ok
2026-08-19 20:22:47.629733 | instance | included: /var/lib/zuul/builds/db14f7e009d54430a708dd08bdeadd62/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-19 20:22:47.635593 | 
2026-08-19 20:22:47.635661 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-19 20:22:48.415226 | instance -> localhost | Generating public/private rsa key pair.
2026-08-19 20:22:48.415427 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/db14f7e009d54430a708dd08bdeadd62/work/db14f7e009d54430a708dd08bdeadd62_id_rsa
2026-08-19 20:22:48.415460 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/db14f7e009d54430a708dd08bdeadd62/work/db14f7e009d54430a708dd08bdeadd62_id_rsa.pub
2026-08-19 20:22:48.415483 | instance -> localhost | The key fingerprint is:
2026-08-19 20:22:48.415506 | instance -> localhost | SHA256:FIk8MHZEozMBJpkj4V2wW8cFSxRklUENu/syKTcmWf0 zuul-build-sshkey
2026-08-19 20:22:48.415543 | instance -> localhost | The key's randomart image is:
2026-08-19 20:22:48.415567 | instance -> localhost | +---[RSA 3072]----+
2026-08-19 20:22:48.415593 | instance -> localhost | |o+oo**BO*B=      |
2026-08-19 20:22:48.415616 | instance -> localhost | |*o..o=B.+o..     |
2026-08-19 20:22:48.415638 | instance -> localhost | |.o o+. =..       |
2026-08-19 20:22:48.415660 | instance -> localhost | |    oo..  .      |
2026-08-19 20:22:48.415681 | instance -> localhost | |   .    S..      |
2026-08-19 20:22:48.415701 | instance -> localhost | |         ...     |
2026-08-19 20:22:48.415722 | instance -> localhost | |        o.. .    |
2026-08-19 20:22:48.415743 | instance -> localhost | |       + B.  E   |
2026-08-19 20:22:48.415766 | instance -> localhost | |        = +.     |
2026-08-19 20:22:48.415786 | instance -> localhost | +----[SHA256]-----+
2026-08-19 20:22:48.415840 | instance -> localhost | ok: Runtime: 0:00:00.311699
2026-08-19 20:22:48.437373 | 
2026-08-19 20:22:48.437488 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-19 20:22:48.471483 | instance | ok
2026-08-19 20:22:48.482754 | instance | included: /var/lib/zuul/builds/db14f7e009d54430a708dd08bdeadd62/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-19 20:22:48.490473 | 
2026-08-19 20:22:48.490536 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-19 20:22:48.517108 | instance | skipping: Conditional result was False
2026-08-19 20:22:48.530627 | 
2026-08-19 20:22:48.530775 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-19 20:22:48.991335 | instance | changed
2026-08-19 20:22:48.998209 | 
2026-08-19 20:22:48.998283 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-19 20:22:49.182238 | instance | ok
2026-08-19 20:22:49.187217 | 
2026-08-19 20:22:49.187282 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-19 20:22:49.649550 | instance | changed
2026-08-19 20:22:49.654596 | 
2026-08-19 20:22:49.654660 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-19 20:22:50.106780 | instance | changed
2026-08-19 20:22:50.116011 | 
2026-08-19 20:22:50.116170 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-19 20:22:50.142938 | instance | skipping: Conditional result was False
2026-08-19 20:22:50.151627 | 
2026-08-19 20:22:50.151718 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-19 20:22:50.515003 | instance -> localhost | changed
2026-08-19 20:22:50.532841 | 
2026-08-19 20:22:50.532945 | TASK [add-build-sshkey : Add back temp key]
2026-08-19 20:22:50.831549 | instance -> localhost | Identity added: /var/lib/zuul/builds/db14f7e009d54430a708dd08bdeadd62/work/db14f7e009d54430a708dd08bdeadd62_id_rsa (zuul-build-sshkey)
2026-08-19 20:22:50.831869 | instance -> localhost | ok: Runtime: 0:00:00.014149
2026-08-19 20:22:50.837316 | 
2026-08-19 20:22:50.837377 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-19 20:22:51.167343 | instance | ok
2026-08-19 20:22:51.172357 | 
2026-08-19 20:22:51.172426 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-19 20:22:51.198766 | instance | skipping: Conditional result was False
2026-08-19 20:22:51.208675 | 
2026-08-19 20:22:51.208743 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-19 20:22:51.539795 | instance | ok
2026-08-19 20:22:51.546065 | 
2026-08-19 20:22:51.546129 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-19 20:22:56.956917 | instance | Output suppressed because no_log was given
2026-08-19 20:22:57.164379 | 
2026-08-19 20:22:57.164469 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-19 20:22:57.362490 | instance | ok: "logs"
2026-08-19 20:22:57.362777 | instance | ok: All items complete
2026-08-19 20:22:57.362806 | 
2026-08-19 20:22:57.514051 | instance | ok: "artifacts"
2026-08-19 20:22:57.674469 | instance | ok: "docs"
2026-08-19 20:22:57.691173 | 
2026-08-19 20:22:57.691274 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-19 20:22:57.889678 | instance | changed: "logs"
2026-08-19 20:22:58.045813 | instance | changed: "artifacts"
2026-08-19 20:22:58.197041 | instance | changed: "docs"
2026-08-19 20:22:58.211114 | 
2026-08-19 20:22:58.211238 | PLAY RECAP
2026-08-19 20:22:58.211289 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-19 20:22:58.211319 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-19 20:22:58.211339 | 
2026-08-19 20:22:58.366330 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-19 20:22:58.368649 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-19 20:22:59.182762 | 
2026-08-19 20:22:59.182905 | PLAY [all]
2026-08-19 20:22:59.203481 | 
2026-08-19 20:22:59.203602 | TASK [setup-uv : Extract archive]
2026-08-19 20:23:01.323385 | instance | changed
2026-08-19 20:23:01.329513 | 
2026-08-19 20:23:01.329601 | TASK [setup-uv : Print version]
2026-08-19 20:23:01.697724 | instance | uv 0.8.13
2026-08-19 20:23:01.865817 | instance | ok: Runtime: 0:00:00.010763
2026-08-19 20:23:01.876577 | 
2026-08-19 20:23:01.876642 | TASK [Install Ansible collection siblings]
2026-08-19 20:23:10.361292 | instance | changed:
2026-08-19 20:23:10.361527 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-08-19 20:23:10.361562 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-08-19 20:23:10.361589 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-08-19 20:23:10.361616 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-08-19 20:23:10.361642 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-08-19 20:23:10.361670 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-08-19 20:23:10.361699 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-08-19 20:23:10.361727 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-08-19 20:23:10.361753 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-08-19 20:23:10.361779 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-08-19 20:23:10.361804 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-08-19 20:23:10.361829 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-08-19 20:23:10.361853 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-08-19 20:23:10.361877 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-08-19 20:23:10.361901 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0
2026-08-19 20:23:10.361926 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-08-19 20:23:10.361950 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-08-19 20:23:10.361975 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-08-19 20:23:10.362000 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-08-19 20:23:10.362024 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-08-19 20:23:10.362049 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0
2026-08-19 20:23:10.362074 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-08-19 20:23:10.362099 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-19 20:23:10.362692 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-08-19 20:23:10.362748 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0
2026-08-19 20:23:10.362777 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-19 20:23:10.362803 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-19 20:23:10.362827 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-19 20:23:10.362851 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-08-19 20:23:10.362875 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-08-19 20:23:10.362900 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-19 20:23:10.362925 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-19 20:23:10.362950 | instance | Checked out ansible.netcommon to 1.2.0
2026-08-19 20:23:10.362975 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-08-19 20:23:10.363008 | instance | Starting galaxy collection install process
2026-08-19 20:23:10.363033 | instance | Process install dependency map
2026-08-19 20:23:10.363057 | instance | Starting collection install process
2026-08-19 20:23:10.363081 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-08-19 20:23:10.363106 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-08-19 20:23:10.363130 | instance | ansible.netcommon:* was installed successfully
2026-08-19 20:23:10.363154 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-08-19 20:23:10.363177 | instance | Creating virtual environment at: .venv
2026-08-19 20:23:10.363201 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-19 20:23:10.363225 | instance | Downloading pygments (1.2MiB)
2026-08-19 20:23:10.363249 | instance | Downloading ansible-core (2.1MiB)
2026-08-19 20:23:10.363273 | instance | Downloading kubernetes (1.9MiB)
2026-08-19 20:23:10.363298 | instance | Downloading openstacksdk (1.7MiB)
2026-08-19 20:23:10.363322 | instance | Downloading cryptography (4.2MiB)
2026-08-19 20:23:10.363346 | instance | Downloading setuptools (1.1MiB)
2026-08-19 20:23:10.363370 | instance | Downloading rjsonnet (1.2MiB)
2026-08-19 20:23:10.363395 | instance | Downloading netaddr (2.2MiB)
2026-08-19 20:23:10.363419 | instance |    Building pyperclip==1.9.0
2026-08-19 20:23:10.363443 | instance |  Downloading rjsonnet
2026-08-19 20:23:10.363469 | instance |  Downloading netaddr
2026-08-19 20:23:10.363493 | instance |  Downloading pygments
2026-08-19 20:23:10.363517 | instance |  Downloading cryptography
2026-08-19 20:23:10.363541 | instance |  Downloading setuptools
2026-08-19 20:23:10.363565 | instance |  Downloading kubernetes
2026-08-19 20:23:10.363588 | instance |  Downloading ansible-core
2026-08-19 20:23:10.363612 | instance |  Downloading openstacksdk
2026-08-19 20:23:10.363636 | instance |       Built pyperclip==1.9.0
2026-08-19 20:23:10.363659 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-19 20:23:10.363683 | instance | Installed 79 packages in 37ms
2026-08-19 20:23:10.363707 | instance | Checked out ansible.posix to 1.6.0
2026-08-19 20:23:10.363731 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-08-19 20:23:10.363755 | instance | Starting galaxy collection install process
2026-08-19 20:23:10.363779 | instance | Process install dependency map
2026-08-19 20:23:10.363802 | instance | Starting collection install process
2026-08-19 20:23:10.363826 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-08-19 20:23:10.363907 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-08-19 20:23:10.363936 | instance | ansible.posix:1.6.0 was installed successfully
2026-08-19 20:23:10.363960 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-19 20:23:10.363984 | instance | 2.17.12
2026-08-19 20:23:10.364009 | instance | Checked out ansible.utils to v6.1.0
2026-08-19 20:23:10.364032 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-08-19 20:23:10.364057 | instance | Starting galaxy collection install process
2026-08-19 20:23:10.364080 | instance | Process install dependency map
2026-08-19 20:23:10.364104 | instance | Starting collection install process
2026-08-19 20:23:10.364127 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-08-19 20:23:10.364151 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-08-19 20:23:10.364175 | instance | ansible.utils:6.1.0 was installed successfully
2026-08-19 20:23:10.364199 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-19 20:23:10.364223 | instance | 2.17.12
2026-08-19 20:23:10.364247 | instance | Checked out atmosphere.common to v0.7.0
2026-08-19 20:23:10.364271 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-08-19 20:23:10.364296 | instance | Starting galaxy collection install process
2026-08-19 20:23:10.364319 | instance | Process install dependency map
2026-08-19 20:23:10.364343 | instance | Starting collection install process
2026-08-19 20:23:10.364366 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-08-19 20:23:10.364390 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-08-19 20:23:10.364414 | instance | atmosphere.common:0.7.0 was installed successfully
2026-08-19 20:23:10.364437 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-19 20:23:10.364460 | instance | 2.17.12
2026-08-19 20:23:10.364484 | instance | Checked out community.crypto to 2.2.3
2026-08-19 20:23:10.364508 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.crypto
2026-08-19 20:23:10.364533 | instance | Starting galaxy collection install process
2026-08-19 20:23:10.364556 | instance | Process install dependency map
2026-08-19 20:23:10.364580 | instance | Starting collection install process
2026-08-19 20:23:10.364604 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-08-19 20:23:10.364627 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-08-19 20:23:10.364651 | instance | community.crypto:2.2.3 was installed successfully
2026-08-19 20:23:10.364674 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-19 20:23:10.364698 | instance | 2.17.12
2026-08-19 20:23:10.364722 | instance | Checked out community.general to 7.3.0
2026-08-19 20:23:10.364746 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.general
2026-08-19 20:23:10.364770 | instance | Starting galaxy collection install process
2026-08-19 20:23:10.364800 | instance | Process install dependency map
2026-08-19 20:23:10.364824 | instance | Starting collection install process
2026-08-19 20:23:10.364848 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-08-19 20:23:10.364871 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-08-19 20:23:10.364895 | instance | community.general:7.3.0 was installed successfully
2026-08-19 20:23:10.364918 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-19 20:23:10.364942 | instance | 2.17.12
2026-08-19 20:23:10.364996 | instance | Checked out community.mysql to 3.6.0
2026-08-19 20:23:10.365029 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.mysql
2026-08-19 20:23:10.365055 | instance | Starting galaxy collection install process
2026-08-19 20:23:10.365081 | instance | Process install dependency map
2026-08-19 20:23:10.365106 | instance | Starting collection install process
2026-08-19 20:23:10.365130 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-08-19 20:23:10.365155 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-08-19 20:23:10.365179 | instance | community.mysql:3.6.0 was installed successfully
2026-08-19 20:23:10.365203 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-19 20:23:10.365228 | instance | 2.17.12
2026-08-19 20:23:10.365253 | instance | Checked out kubernetes.core to 2.4.0
2026-08-19 20:23:10.365278 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-08-19 20:23:10.365302 | instance | Starting galaxy collection install process
2026-08-19 20:23:10.365326 | instance | Process install dependency map
2026-08-19 20:23:10.365350 | instance | Starting collection install process
2026-08-19 20:23:10.365375 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-08-19 20:23:10.365399 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-08-19 20:23:10.365423 | instance | kubernetes.core:2.4.0 was installed successfully
2026-08-19 20:23:10.365447 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-19 20:23:10.365471 | instance | 2.17.12
2026-08-19 20:23:10.365496 | instance | Checked out openstack.cloud to 2.6.0
2026-08-19 20:23:10.365520 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-08-19 20:23:10.365545 | instance | Starting galaxy collection install process
2026-08-19 20:23:10.365569 | instance | Process install dependency map
2026-08-19 20:23:10.365593 | instance | Starting collection install process
2026-08-19 20:23:10.365616 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-08-19 20:23:10.365640 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-08-19 20:23:10.365663 | instance | openstack.cloud:2.6.0 was installed successfully
2026-08-19 20:23:10.365687 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-19 20:23:10.365710 | instance | 2.17.12
2026-08-19 20:23:10.365734 | instance | Checked out vexxhost.ceph to v4.2.0
2026-08-19 20:23:10.365757 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-08-19 20:23:10.365787 | instance | Starting galaxy collection install process
2026-08-19 20:23:10.365811 | instance | Process install dependency map
2026-08-19 20:23:10.365835 | instance | Starting collection install process
2026-08-19 20:23:10.365859 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-08-19 20:23:10.365884 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-08-19 20:23:10.365907 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-08-19 20:23:10.365931 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-19 20:23:10.365954 | instance | 2.17.12
2026-08-19 20:23:10.365978 | instance | Checked out vexxhost.containers to v1.6.8
2026-08-19 20:23:10.366002 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-08-19 20:23:10.366026 | instance | Starting galaxy collection install process
2026-08-19 20:23:10.366050 | instance | Process install dependency map
2026-08-19 20:23:10.366074 | instance | Starting collection install process
2026-08-19 20:23:10.366097 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-08-19 20:23:10.366121 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-08-19 20:23:10.366145 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-08-19 20:23:10.366169 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-19 20:23:10.366192 | instance | 2.17.12
2026-08-19 20:23:10.366216 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-08-19 20:23:10.366240 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-08-19 20:23:10.366264 | instance | Starting galaxy collection install process
2026-08-19 20:23:10.366288 | instance | Process install dependency map
2026-08-19 20:23:10.366312 | instance | Starting collection install process
2026-08-19 20:23:10.366336 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-08-19 20:23:10.366361 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-08-19 20:23:10.366386 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-08-19 20:23:10.366410 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-19 20:23:10.366434 | instance | 2.17.12
2026-08-19 20:23:10.373672 | 
2026-08-19 20:23:10.373728 | PLAY RECAP
2026-08-19 20:23:10.373775 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-19 20:23:10.373796 | 
2026-08-19 20:23:10.525698 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-19 20:23:10.529771 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-19 20:23:11.176428 | 
2026-08-19 20:23:11.176653 | PLAY [all]
2026-08-19 20:23:11.190180 | 
2026-08-19 20:23:11.190351 | TASK [Install "jq" for log collection]
2026-08-19 20:23:19.893065 | instance | changed
2026-08-19 20:23:19.895397 | 
2026-08-19 20:23:19.895475 | PLAY RECAP
2026-08-19 20:23:19.895546 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-19 20:23:19.895616 | 
2026-08-19 20:23:20.102980 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-19 20:23:20.107895 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-19 20:23:20.752450 | 
2026-08-19 20:23:20.788632 | PLAY [all]
2026-08-19 20:23:20.807165 | 
2026-08-19 20:23:20.807325 | LOOP [Check inventory directories]
2026-08-19 20:23:21.153553 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-08-19 20:23:21.314959 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-08-19 20:23:21.492062 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-08-19 20:23:21.502675 | 
2026-08-19 20:23:21.502868 | LOOP [Copy inventory file for Zuul]
2026-08-19 20:23:22.326258 | instance | changed:
2026-08-19 20:23:22.471672 | instance | {
2026-08-19 20:23:22.471853 | instance |   "ansible_loop_var": "item",
2026-08-19 20:23:22.471912 | instance |   "changed": false,
2026-08-19 20:23:22.471959 | instance |   "failed": false,
2026-08-19 20:23:22.472012 | instance |   "invocation": {
2026-08-19 20:23:22.472055 | instance |     "module_args": {
2026-08-19 20:23:22.472098 | instance |       "checksum_algorithm": "sha1",
2026-08-19 20:23:22.472139 | instance |       "follow": true,
2026-08-19 20:23:22.472181 | instance |       "get_attributes": true,
2026-08-19 20:23:22.472223 | instance |       "get_checksum": true,
2026-08-19 20:23:22.472268 | instance |       "get_mime": true,
2026-08-19 20:23:22.472312 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-08-19 20:23:22.472357 | instance |     }
2026-08-19 20:23:22.472399 | instance |   },
2026-08-19 20:23:22.472442 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-08-19 20:23:22.472485 | instance |   "stat": {
2026-08-19 20:23:22.472528 | instance |     "atime": 1787170983.7886362,
2026-08-19 20:23:22.472572 | instance |     "attr_flags": "e",
2026-08-19 20:23:22.472615 | instance |     "attributes": [
2026-08-19 20:23:22.472658 | instance |       "extents"
2026-08-19 20:23:22.472700 | instance |     ],
2026-08-19 20:23:22.472742 | instance |     "block_size": 4096,
2026-08-19 20:23:22.472783 | instance |     "blocks": 8,
2026-08-19 20:23:22.472825 | instance |     "charset": "unknown",
2026-08-19 20:23:22.472899 | instance |     "ctime": 1787170982.7046318,
2026-08-19 20:23:22.472943 | instance |     "dev": 64513,
2026-08-19 20:23:22.473017 | instance |     "device_type": 0,
2026-08-19 20:23:22.473062 | instance |     "executable": true,
2026-08-19 20:23:22.473104 | instance |     "exists": true,
2026-08-19 20:23:22.473146 | instance |     "gid": 1000,
2026-08-19 20:23:22.473188 | instance |     "gr_name": "zuul",
2026-08-19 20:23:22.473230 | instance |     "inode": 1048861,
2026-08-19 20:23:22.473272 | instance |     "isblk": false,
2026-08-19 20:23:22.473315 | instance |     "ischr": false,
2026-08-19 20:23:22.473359 | instance |     "isdir": true,
2026-08-19 20:23:22.473401 | instance |     "isfifo": false,
2026-08-19 20:23:22.473445 | instance |     "isgid": false,
2026-08-19 20:23:22.473486 | instance |     "islnk": false,
2026-08-19 20:23:22.473529 | instance |     "isreg": false,
2026-08-19 20:23:22.473571 | instance |     "issock": false,
2026-08-19 20:23:22.473614 | instance |     "isuid": false,
2026-08-19 20:23:22.473657 | instance |     "mimetype": "unknown",
2026-08-19 20:23:22.473699 | instance |     "mode": "0755",
2026-08-19 20:23:22.473741 | instance |     "mtime": 1787170982.7046318,
2026-08-19 20:23:22.473785 | instance |     "nlink": 22,
2026-08-19 20:23:22.473828 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-08-19 20:23:22.473871 | instance |     "pw_name": "zuul",
2026-08-19 20:23:22.473915 | instance |     "readable": true,
2026-08-19 20:23:22.474033 | instance |     "rgrp": true,
2026-08-19 20:23:22.474092 | instance |     "roth": true,
2026-08-19 20:23:22.474138 | instance |     "rusr": true,
2026-08-19 20:23:22.474181 | instance |     "size": 4096,
2026-08-19 20:23:22.474224 | instance |     "uid": 1000,
2026-08-19 20:23:22.474284 | instance |     "version": "1129026416",
2026-08-19 20:23:22.474330 | instance |     "wgrp": false,
2026-08-19 20:23:22.474376 | instance |     "woth": false,
2026-08-19 20:23:22.474419 | instance |     "writeable": true,
2026-08-19 20:23:22.474463 | instance |     "wusr": true,
2026-08-19 20:23:22.474506 | instance |     "xgrp": true,
2026-08-19 20:23:22.474548 | instance |     "xoth": true,
2026-08-19 20:23:22.474590 | instance |     "xusr": true
2026-08-19 20:23:22.474632 | instance |   }
2026-08-19 20:23:22.474675 | instance | }
2026-08-19 20:23:22.474758 | instance | ok: All items complete
2026-08-19 20:23:22.474809 | 
2026-08-19 20:23:22.478036 | instance | skipping: Conditional result was False
2026-08-19 20:23:22.503206 | instance | skipping: Conditional result was False
2026-08-19 20:23:22.524781 | 
2026-08-19 20:23:22.525015 | LOOP [Switch "ansible_host" to private IP]
2026-08-19 20:23:22.885811 | instance | changed: 1 replacements made
2026-08-19 20:23:22.887358 | instance | skipping: Conditional result was False
2026-08-19 20:23:22.889891 | instance | skipping: Conditional result was False
2026-08-19 20:23:22.913435 | 
2026-08-19 20:23:22.913649 | TASK [Run Molecule scenario]
2026-08-19 20:23:23.853535 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-08-19 20:23:24.233322 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-08-19 20:23:24.233419 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-08-19 20:23:35.088978 | instance | INFO     [csi > dependency] Executing
2026-08-19 20:23:35.089113 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-08-19 20:23:35.089321 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-08-19 20:23:35.089451 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-08-19 20:23:35.098315 | instance | INFO     [csi > cleanup] Executing
2026-08-19 20:23:35.098612 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-19 20:23:35.106120 | instance | INFO     [csi > destroy] Executing
2026-08-19 20:23:35.106163 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-08-19 20:23:35.106254 | instance | INFO     [csi > destroy] Executed: Successful
2026-08-19 20:23:35.114254 | instance | INFO     [csi > syntax] Executing
2026-08-19 20:23:36.743492 | instance |
2026-08-19 20:23:36.743900 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-19 20:23:36.805194 | instance | INFO     [csi > syntax] Executed: Successful
2026-08-19 20:23:36.819227 | instance | INFO     [csi > create] Executing
2026-08-19 20:23:36.821259 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-19 20:23:36.828792 | instance | INFO     [csi > prepare] Executing
2026-08-19 20:23:37.593289 | instance |
2026-08-19 20:23:37.593544 | instance | PLAY [Prepare] *****************************************************************
2026-08-19 20:23:37.593821 | instance |
2026-08-19 20:23:37.594102 | instance | TASK [Gathering Facts] *********************************************************
2026-08-19 20:23:37.594406 | instance | Wednesday 19 August 2026  20:23:37 +0000 (0:00:00.024)       0:00:00.024 ******
2026-08-19 20:23:38.733477 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-19 20:23:38.733725 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-19 20:23:38.733995 | instance | interpreter could change the meaning of that path. See
2026-08-19 20:23:38.734258 | instance | https://docs.ansible.com/ansible-
2026-08-19 20:23:38.734579 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-19 20:23:38.740571 | instance | ok: [instance]
2026-08-19 20:23:38.741463 | instance |
2026-08-19 20:23:38.741508 | instance | TASK [Configure short hostname] ************************************************
2026-08-19 20:23:38.741516 | instance | Wednesday 19 August 2026  20:23:38 +0000 (0:00:01.147)       0:00:01.172 ******
2026-08-19 20:23:39.372397 | instance | changed: [instance]
2026-08-19 20:23:39.372453 | instance |
2026-08-19 20:23:39.372466 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-08-19 20:23:39.372480 | instance | Wednesday 19 August 2026  20:23:39 +0000 (0:00:00.630)       0:00:01.803 ******
2026-08-19 20:23:39.642523 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-08-19 20:23:39.642742 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-08-19 20:23:39.642994 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-08-19 20:23:39.649856 | instance | changed: [instance]
2026-08-19 20:23:39.650132 | instance |
2026-08-19 20:23:39.650418 | instance | TASK [Purge "snapd" package] ***************************************************
2026-08-19 20:23:39.650946 | instance | Wednesday 19 August 2026  20:23:39 +0000 (0:00:00.278)       0:00:02.081 ******
2026-08-19 20:23:40.442287 | instance | ok: [instance]
2026-08-19 20:23:40.442360 | instance |
2026-08-19 20:23:40.442497 | instance | PLAY [Create devices for Ceph] *************************************************
2026-08-19 20:23:40.442613 | instance |
2026-08-19 20:23:40.442735 | instance | TASK [Gathering Facts] *********************************************************
2026-08-19 20:23:40.442861 | instance | Wednesday 19 August 2026  20:23:40 +0000 (0:00:00.793)       0:00:02.874 ******
2026-08-19 20:23:41.107533 | instance | ok: [instance]
2026-08-19 20:23:41.107610 | instance |
2026-08-19 20:23:41.107771 | instance | TASK [Install depedencies] *****************************************************
2026-08-19 20:23:41.107922 | instance | Wednesday 19 August 2026  20:23:41 +0000 (0:00:00.664)       0:00:03.539 ******
2026-08-19 20:23:59.814234 | instance | changed: [instance]
2026-08-19 20:23:59.814570 | instance |
2026-08-19 20:23:59.814935 | instance | TASK [Start up service] ********************************************************
2026-08-19 20:23:59.815254 | instance | Wednesday 19 August 2026  20:23:59 +0000 (0:00:18.706)       0:00:22.245 ******
2026-08-19 20:24:00.321773 | instance | ok: [instance]
2026-08-19 20:24:00.322039 | instance |
2026-08-19 20:24:00.322324 | instance | TASK [Generate lvm.conf] *******************************************************
2026-08-19 20:24:00.322717 | instance | Wednesday 19 August 2026  20:24:00 +0000 (0:00:00.507)       0:00:22.753 ******
2026-08-19 20:24:00.596084 | instance | ok: [instance]
2026-08-19 20:24:00.596352 | instance |
2026-08-19 20:24:00.596684 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-08-19 20:24:00.597092 | instance | Wednesday 19 August 2026  20:24:00 +0000 (0:00:00.274)       0:00:23.028 ******
2026-08-19 20:24:01.219090 | instance | changed: [instance]
2026-08-19 20:24:01.219355 | instance |
2026-08-19 20:24:01.219666 | instance | TASK [Get list of all loopback devices] ****************************************
2026-08-19 20:24:01.219957 | instance | Wednesday 19 August 2026  20:24:01 +0000 (0:00:00.622)       0:00:23.650 ******
2026-08-19 20:24:01.405659 | instance | ok: [instance]
2026-08-19 20:24:01.405887 | instance |
2026-08-19 20:24:01.406232 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-08-19 20:24:01.406612 | instance | Wednesday 19 August 2026  20:24:01 +0000 (0:00:00.186)       0:00:23.837 ******
2026-08-19 20:24:01.425410 | instance | skipping: [instance]
2026-08-19 20:24:01.425653 | instance |
2026-08-19 20:24:01.425925 | instance | TASK [Create devices for Ceph] *************************************************
2026-08-19 20:24:01.426240 | instance | Wednesday 19 August 2026  20:24:01 +0000 (0:00:00.020)       0:00:23.857 ******
2026-08-19 20:24:01.946044 | instance | changed: [instance] => (item=osd0)
2026-08-19 20:24:01.946115 | instance | changed: [instance] => (item=osd1)
2026-08-19 20:24:01.946265 | instance | changed: [instance] => (item=osd2)
2026-08-19 20:24:01.946379 | instance |
2026-08-19 20:24:01.946529 | instance | TASK [Set permissions on loopback devices] *************************************
2026-08-19 20:24:01.946656 | instance | Wednesday 19 August 2026  20:24:01 +0000 (0:00:00.520)       0:00:24.378 ******
2026-08-19 20:24:02.531983 | instance | changed: [instance] => (item=osd0)
2026-08-19 20:24:02.532260 | instance | changed: [instance] => (item=osd1)
2026-08-19 20:24:02.532539 | instance | changed: [instance] => (item=osd2)
2026-08-19 20:24:02.532869 | instance |
2026-08-19 20:24:02.533149 | instance | TASK [Start loop devices] ******************************************************
2026-08-19 20:24:02.533417 | instance | Wednesday 19 August 2026  20:24:02 +0000 (0:00:00.585)       0:00:24.963 ******
2026-08-19 20:24:03.191988 | instance | changed: [instance] => (item=osd0)
2026-08-19 20:24:03.192121 | instance | changed: [instance] => (item=osd1)
2026-08-19 20:24:03.192285 | instance | changed: [instance] => (item=osd2)
2026-08-19 20:24:03.192441 | instance |
2026-08-19 20:24:03.192610 | instance | TASK [Create a volume group for each loop device] ******************************
2026-08-19 20:24:03.192776 | instance | Wednesday 19 August 2026  20:24:03 +0000 (0:00:00.659)       0:00:25.623 ******
2026-08-19 20:24:06.222072 | instance | changed: [instance] => (item=osd0)
2026-08-19 20:24:06.222297 | instance | changed: [instance] => (item=osd1)
2026-08-19 20:24:06.222687 | instance | changed: [instance] => (item=osd2)
2026-08-19 20:24:06.222966 | instance |
2026-08-19 20:24:06.223237 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-08-19 20:24:06.223566 | instance | Wednesday 19 August 2026  20:24:06 +0000 (0:00:03.030)       0:00:28.654 ******
2026-08-19 20:24:08.008434 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-08-19 20:24:08.008908 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-08-19 20:24:08.009411 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-08-19 20:24:08.009785 | instance |
2026-08-19 20:24:08.010150 | instance | PLAY RECAP *********************************************************************
2026-08-19 20:24:08.010612 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-08-19 20:24:08.010964 | instance |
2026-08-19 20:24:08.011332 | instance | Wednesday 19 August 2026  20:24:08 +0000 (0:00:01.786)       0:00:30.440 ******
2026-08-19 20:24:08.011685 | instance | ===============================================================================
2026-08-19 20:24:08.012043 | instance | Install depedencies ---------------------------------------------------- 18.71s
2026-08-19 20:24:08.012393 | instance | Create a volume group for each loop device ------------------------------ 3.03s
2026-08-19 20:24:08.012746 | instance | Create a logical volume for each loop device ---------------------------- 1.79s
2026-08-19 20:24:08.013120 | instance | Gathering Facts --------------------------------------------------------- 1.15s
2026-08-19 20:24:08.013550 | instance | Purge "snapd" package --------------------------------------------------- 0.79s
2026-08-19 20:24:08.013915 | instance | Gathering Facts --------------------------------------------------------- 0.66s
2026-08-19 20:24:08.014265 | instance | Start loop devices ------------------------------------------------------ 0.66s
2026-08-19 20:24:08.014682 | instance | Configure short hostname ------------------------------------------------ 0.63s
2026-08-19 20:24:08.014895 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.62s
2026-08-19 20:24:08.015104 | instance | Set permissions on loopback devices ------------------------------------- 0.59s
2026-08-19 20:24:08.015317 | instance | Create devices for Ceph ------------------------------------------------- 0.52s
2026-08-19 20:24:08.015523 | instance | Start up service -------------------------------------------------------- 0.51s
2026-08-19 20:24:08.015729 | instance | Ensure hostname inside hosts file --------------------------------------- 0.28s
2026-08-19 20:24:08.015935 | instance | Generate lvm.conf ------------------------------------------------------- 0.27s
2026-08-19 20:24:08.016148 | instance | Get list of all loopback devices ---------------------------------------- 0.19s
2026-08-19 20:24:08.016355 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s
2026-08-19 20:24:08.081756 | instance | INFO     [csi > prepare] Executed: Successful
2026-08-19 20:24:08.094310 | instance | INFO     [csi > converge] Executing
2026-08-19 20:24:09.584959 | instance |
2026-08-19 20:24:09.585376 | instance | PLAY [Debug CSI driver value] **************************************************
2026-08-19 20:24:09.585699 | instance |
2026-08-19 20:24:09.586029 | instance | TASK [Gathering Facts] *********************************************************
2026-08-19 20:24:09.586370 | instance | Wednesday 19 August 2026  20:24:09 +0000 (0:00:00.008)       0:00:00.008 ******
2026-08-19 20:24:10.498624 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-19 20:24:10.498681 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-19 20:24:10.498694 | instance | interpreter could change the meaning of that path. See
2026-08-19 20:24:10.498706 | instance | https://docs.ansible.com/ansible-
2026-08-19 20:24:10.498716 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-19 20:24:10.509365 | instance | ok: [instance]
2026-08-19 20:24:10.509392 | instance |
2026-08-19 20:24:10.509400 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-08-19 20:24:10.509407 | instance | Wednesday 19 August 2026  20:24:10 +0000 (0:00:00.924)       0:00:00.932 ******
2026-08-19 20:24:10.554555 | instance | ok: [instance] => {
2026-08-19 20:24:10.554620 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-08-19 20:24:10.554633 | instance | }
2026-08-19 20:24:10.554643 | instance |
2026-08-19 20:24:10.554652 | instance | PLAY [all] *********************************************************************
2026-08-19 20:24:10.554661 | instance |
2026-08-19 20:24:10.554729 | instance | TASK [Gathering Facts] *********************************************************
2026-08-19 20:24:10.555064 | instance | Wednesday 19 August 2026  20:24:10 +0000 (0:00:00.044)       0:00:00.976 ******
2026-08-19 20:24:11.413983 | instance | ok: [instance]
2026-08-19 20:24:11.414234 | instance |
2026-08-19 20:24:11.414593 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-08-19 20:24:11.414852 | instance | Wednesday 19 August 2026  20:24:11 +0000 (0:00:00.860)       0:00:01.837 ******
2026-08-19 20:24:11.586791 | instance | ok: [instance]
2026-08-19 20:24:11.587191 | instance |
2026-08-19 20:24:11.587514 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-08-19 20:24:11.587799 | instance |
2026-08-19 20:24:11.588115 | instance | TASK [Gathering Facts] *********************************************************
2026-08-19 20:24:11.588452 | instance | Wednesday 19 August 2026  20:24:11 +0000 (0:00:00.172)       0:00:02.010 ******
2026-08-19 20:24:12.460376 | instance | ok: [instance]
2026-08-19 20:24:12.460511 | instance |
2026-08-19 20:24:12.460678 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-19 20:24:12.460851 | instance | Wednesday 19 August 2026  20:24:12 +0000 (0:00:00.873)       0:00:02.883 ******
2026-08-19 20:24:12.739650 | instance | ok: [instance]
2026-08-19 20:24:12.740014 | instance |
2026-08-19 20:24:12.740344 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-19 20:24:12.740675 | instance | Wednesday 19 August 2026  20:24:12 +0000 (0:00:00.279)       0:00:03.163 ******
2026-08-19 20:24:12.777446 | instance | skipping: [instance]
2026-08-19 20:24:12.777809 | instance |
2026-08-19 20:24:12.778161 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-08-19 20:24:12.778499 | instance | Wednesday 19 August 2026  20:24:12 +0000 (0:00:00.037)       0:00:03.201 ******
2026-08-19 20:24:13.103047 | instance | changed: [instance]
2026-08-19 20:24:13.103280 | instance |
2026-08-19 20:24:13.103582 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-19 20:24:13.103841 | instance | Wednesday 19 August 2026  20:24:13 +0000 (0:00:00.325)       0:00:03.526 ******
2026-08-19 20:24:13.167149 | instance | ok: [instance] => {
2026-08-19 20:24:13.167427 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-08-19 20:24:13.167687 | instance | }
2026-08-19 20:24:13.167961 | instance |
2026-08-19 20:24:13.168325 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-19 20:24:13.168541 | instance | Wednesday 19 August 2026  20:24:13 +0000 (0:00:00.064)       0:00:03.590 ******
2026-08-19 20:24:13.884600 | instance | changed: [instance]
2026-08-19 20:24:13.884997 | instance |
2026-08-19 20:24:13.885359 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-19 20:24:13.885698 | instance | Wednesday 19 August 2026  20:24:13 +0000 (0:00:00.717)       0:00:04.308 ******
2026-08-19 20:24:13.935433 | instance | skipping: [instance]
2026-08-19 20:24:13.935838 | instance |
2026-08-19 20:24:13.936203 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-19 20:24:13.936595 | instance | Wednesday 19 August 2026  20:24:13 +0000 (0:00:00.047)       0:00:04.356 ******
2026-08-19 20:24:13.983001 | instance | skipping: [instance]
2026-08-19 20:24:13.983083 | instance |
2026-08-19 20:24:13.983221 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-19 20:24:13.983414 | instance | Wednesday 19 August 2026  20:24:13 +0000 (0:00:00.048)       0:00:04.404 ******
2026-08-19 20:24:14.181969 | instance | ok: [instance]
2026-08-19 20:24:14.182153 | instance |
2026-08-19 20:24:14.182310 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-19 20:24:14.182482 | instance | Wednesday 19 August 2026  20:24:14 +0000 (0:00:00.198)       0:00:04.603 ******
2026-08-19 20:24:15.305467 | instance | ok: [instance]
2026-08-19 20:24:15.305655 | instance |
2026-08-19 20:24:15.305730 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-19 20:24:15.305991 | instance | Wednesday 19 August 2026  20:24:15 +0000 (0:00:01.125)       0:00:05.729 ******
2026-08-19 20:24:15.371324 | instance | ok: [instance] => {
2026-08-19 20:24:15.371457 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-08-19 20:24:15.371737 | instance | }
2026-08-19 20:24:15.371949 | instance |
2026-08-19 20:24:15.372180 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-19 20:24:15.372408 | instance | Wednesday 19 August 2026  20:24:15 +0000 (0:00:00.065)       0:00:05.794 ******
2026-08-19 20:24:16.198665 | instance | changed: [instance]
2026-08-19 20:24:16.198849 | instance |
2026-08-19 20:24:16.199006 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-19 20:24:16.199160 | instance | Wednesday 19 August 2026  20:24:16 +0000 (0:00:00.825)       0:00:06.620 ******
2026-08-19 20:24:18.976015 | instance | changed: [instance]
2026-08-19 20:24:18.976075 | instance |
2026-08-19 20:24:18.976080 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-08-19 20:24:18.976086 | instance | Wednesday 19 August 2026  20:24:18 +0000 (0:00:02.779)       0:00:09.399 ******
2026-08-19 20:24:19.006419 | instance | skipping: [instance]
2026-08-19 20:24:19.007378 | instance |
2026-08-19 20:24:19.007428 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-08-19 20:24:19.007440 | instance | Wednesday 19 August 2026  20:24:19 +0000 (0:00:00.029)       0:00:09.429 ******
2026-08-19 20:24:19.038639 | instance | skipping: [instance]
2026-08-19 20:24:19.038709 | instance |
2026-08-19 20:24:19.039125 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-08-19 20:24:19.039150 | instance | Wednesday 19 August 2026  20:24:19 +0000 (0:00:00.033)       0:00:09.462 ******
2026-08-19 20:24:19.066992 | instance | skipping: [instance]
2026-08-19 20:24:19.067329 | instance |
2026-08-19 20:24:19.067345 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-08-19 20:24:19.067351 | instance | Wednesday 19 August 2026  20:24:19 +0000 (0:00:00.028)       0:00:09.490 ******
2026-08-19 20:24:24.034837 | instance | changed: [instance]
2026-08-19 20:24:24.035091 | instance |
2026-08-19 20:24:24.035105 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-08-19 20:24:24.035210 | instance | Wednesday 19 August 2026  20:24:24 +0000 (0:00:04.967)       0:00:14.458 ******
2026-08-19 20:24:24.618864 | instance | changed: [instance]
2026-08-19 20:24:24.618900 | instance |
2026-08-19 20:24:24.618905 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-08-19 20:24:24.618910 | instance | Wednesday 19 August 2026  20:24:24 +0000 (0:00:00.583)       0:00:15.042 ******
2026-08-19 20:24:25.528724 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-08-19 20:24:25.528766 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-08-19 20:24:25.528772 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-08-19 20:24:25.528777 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-08-19 20:24:25.528810 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-08-19 20:24:25.528815 | instance |
2026-08-19 20:24:25.528823 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-08-19 20:24:25.528828 | instance | Wednesday 19 August 2026  20:24:25 +0000 (0:00:00.909)       0:00:15.951 ******
2026-08-19 20:24:26.088441 | instance | changed: [instance]
2026-08-19 20:24:26.088503 | instance |
2026-08-19 20:24:26.089163 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-08-19 20:24:26.089200 | instance | Wednesday 19 August 2026  20:24:26 +0000 (0:00:00.543)       0:00:16.495 ******
2026-08-19 20:24:26.089206 | instance |
2026-08-19 20:24:26.089210 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-19 20:24:26.089214 | instance | Wednesday 19 August 2026  20:24:26 +0000 (0:00:00.017)       0:00:16.512 ******
2026-08-19 20:24:26.943957 | instance | ok: [instance]
2026-08-19 20:24:26.944077 | instance |
2026-08-19 20:24:26.944440 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-08-19 20:24:26.944478 | instance | Wednesday 19 August 2026  20:24:26 +0000 (0:00:00.855)       0:00:17.367 ******
2026-08-19 20:24:27.360882 | instance | changed: [instance]
2026-08-19 20:24:27.360977 | instance |
2026-08-19 20:24:27.361233 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-08-19 20:24:27.361271 | instance | Wednesday 19 August 2026  20:24:27 +0000 (0:00:00.417)       0:00:17.784 ******
2026-08-19 20:24:27.890921 | instance | changed: [instance]
2026-08-19 20:24:27.891053 | instance |
2026-08-19 20:24:27.891319 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-19 20:24:27.891366 | instance | Wednesday 19 August 2026  20:24:27 +0000 (0:00:00.530)       0:00:18.314 ******
2026-08-19 20:24:28.106946 | instance | ok: [instance]
2026-08-19 20:24:28.107024 | instance |
2026-08-19 20:24:28.107270 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-19 20:24:28.107307 | instance | Wednesday 19 August 2026  20:24:28 +0000 (0:00:00.215)       0:00:18.530 ******
2026-08-19 20:24:28.163501 | instance | ok: [instance] => {
2026-08-19 20:24:28.164120 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-08-19 20:24:28.164155 | instance | }
2026-08-19 20:24:28.164160 | instance |
2026-08-19 20:24:28.164165 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-19 20:24:28.164169 | instance | Wednesday 19 August 2026  20:24:28 +0000 (0:00:00.056)       0:00:18.587 ******
2026-08-19 20:24:35.258018 | instance | FAILED - RETRYING: [instance]: Download item (4 retries left).
2026-08-19 20:24:35.258090 | instance | changed: [instance]
2026-08-19 20:24:35.258492 | instance |
2026-08-19 20:24:35.258532 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-19 20:24:35.258538 | instance | Wednesday 19 August 2026  20:24:35 +0000 (0:00:07.094)       0:00:25.681 ******
2026-08-19 20:24:39.601864 | instance | changed: [instance]
2026-08-19 20:24:39.601930 | instance |
2026-08-19 20:24:39.602262 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-08-19 20:24:39.602307 | instance | Wednesday 19 August 2026  20:24:39 +0000 (0:00:04.343)       0:00:30.025 ******
2026-08-19 20:24:40.604957 | instance | ok: [instance]
2026-08-19 20:24:40.605113 | instance |
2026-08-19 20:24:40.605334 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-08-19 20:24:40.605368 | instance | Wednesday 19 August 2026  20:24:40 +0000 (0:00:01.003)       0:00:31.028 ******
2026-08-19 20:24:40.946960 | instance | changed: [instance]
2026-08-19 20:24:40.947034 | instance |
2026-08-19 20:24:40.947304 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-08-19 20:24:40.947339 | instance | Wednesday 19 August 2026  20:24:40 +0000 (0:00:00.341)       0:00:31.370 ******
2026-08-19 20:24:41.403518 | instance | changed: [instance]
2026-08-19 20:24:41.403599 | instance |
2026-08-19 20:24:41.403891 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-08-19 20:24:41.403934 | instance | Wednesday 19 August 2026  20:24:41 +0000 (0:00:00.456)       0:00:31.827 ******
2026-08-19 20:24:41.995022 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-08-19 20:24:41.995132 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-08-19 20:24:41.995692 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-08-19 20:24:41.995764 | instance |
2026-08-19 20:24:41.995771 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-08-19 20:24:41.995776 | instance | Wednesday 19 August 2026  20:24:41 +0000 (0:00:00.591)       0:00:32.418 ******
2026-08-19 20:24:42.458905 | instance | changed: [instance]
2026-08-19 20:24:42.459034 | instance |
2026-08-19 20:24:42.459098 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-08-19 20:24:42.459278 | instance | Wednesday 19 August 2026  20:24:42 +0000 (0:00:00.463)       0:00:32.882 ******
2026-08-19 20:24:42.962884 | instance | changed: [instance]
2026-08-19 20:24:42.962968 | instance |
2026-08-19 20:24:42.963652 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-08-19 20:24:42.963721 | instance | Wednesday 19 August 2026  20:24:42 +0000 (0:00:00.484)       0:00:33.367 ******
2026-08-19 20:24:42.963727 | instance |
2026-08-19 20:24:42.963732 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-19 20:24:42.963754 | instance | Wednesday 19 August 2026  20:24:42 +0000 (0:00:00.018)       0:00:33.386 ******
2026-08-19 20:24:43.687939 | instance | ok: [instance]
2026-08-19 20:24:43.688004 | instance |
2026-08-19 20:24:43.688017 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-08-19 20:24:43.688022 | instance | Wednesday 19 August 2026  20:24:43 +0000 (0:00:00.724)       0:00:34.110 ******
2026-08-19 20:24:44.492158 | instance | changed: [instance]
2026-08-19 20:24:44.492286 | instance |
2026-08-19 20:24:44.492302 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-08-19 20:24:44.492483 | instance | Wednesday 19 August 2026  20:24:44 +0000 (0:00:00.805)       0:00:34.916 ******
2026-08-19 20:24:45.064882 | instance | changed: [instance]
2026-08-19 20:24:45.064954 | instance |
2026-08-19 20:24:45.065292 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-08-19 20:24:45.065358 | instance | Wednesday 19 August 2026  20:24:45 +0000 (0:00:00.572)       0:00:35.488 ******
2026-08-19 20:24:45.123042 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-08-19 20:24:45.123089 | instance |
2026-08-19 20:24:45.123096 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-08-19 20:24:45.123102 | instance | Wednesday 19 August 2026  20:24:45 +0000 (0:00:00.057)       0:00:35.546 ******
2026-08-19 20:24:49.751867 | instance | changed: [instance]
2026-08-19 20:24:49.751940 | instance |
2026-08-19 20:24:49.752171 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-08-19 20:24:49.752208 | instance | Wednesday 19 August 2026  20:24:49 +0000 (0:00:04.629)       0:00:40.175 ******
2026-08-19 20:24:50.377762 | instance | ok: [instance] => (item=chronyd)
2026-08-19 20:24:50.377825 | instance | ok: [instance] => (item=sshd)
2026-08-19 20:24:50.378311 | instance |
2026-08-19 20:24:50.378349 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-08-19 20:24:50.378355 | instance | Wednesday 19 August 2026  20:24:50 +0000 (0:00:00.625)       0:00:40.801 ******
2026-08-19 20:24:51.404466 | instance | changed: [instance]
2026-08-19 20:24:51.404540 | instance |
2026-08-19 20:24:51.404806 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-08-19 20:24:51.404932 | instance | Wednesday 19 August 2026  20:24:51 +0000 (0:00:01.026)       0:00:41.828 ******
2026-08-19 20:24:51.612042 | instance | ok: [instance]
2026-08-19 20:24:51.612114 | instance |
2026-08-19 20:24:51.612420 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-08-19 20:24:51.612457 | instance | Wednesday 19 August 2026  20:24:51 +0000 (0:00:00.207)       0:00:42.035 ******
2026-08-19 20:24:52.031809 | instance | changed: [instance]
2026-08-19 20:24:52.031905 | instance |
2026-08-19 20:24:52.032210 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-08-19 20:24:52.032227 | instance | Wednesday 19 August 2026  20:24:52 +0000 (0:00:00.419)       0:00:42.455 ******
2026-08-19 20:24:52.364847 | instance | changed: [instance]
2026-08-19 20:24:52.364916 | instance |
2026-08-19 20:24:52.365201 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-08-19 20:24:52.365241 | instance | Wednesday 19 August 2026  20:24:52 +0000 (0:00:00.333)       0:00:42.788 ******
2026-08-19 20:24:52.474625 | instance | ok: [instance]
2026-08-19 20:24:52.475007 | instance |
2026-08-19 20:24:52.475040 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-08-19 20:24:52.475047 | instance | Wednesday 19 August 2026  20:24:52 +0000 (0:00:00.109)       0:00:42.898 ******
2026-08-19 20:24:52.689417 | instance | ok: [instance] => (item=instance)
2026-08-19 20:24:52.689865 | instance |
2026-08-19 20:24:52.690005 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-08-19 20:24:52.690014 | instance | Wednesday 19 August 2026  20:24:52 +0000 (0:00:00.214)       0:00:43.113 ******
2026-08-19 20:24:52.736179 | instance | ok: [instance]
2026-08-19 20:24:52.736254 | instance |
2026-08-19 20:24:52.736522 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-08-19 20:24:52.736569 | instance | Wednesday 19 August 2026  20:24:52 +0000 (0:00:00.046)       0:00:43.160 ******
2026-08-19 20:24:52.809723 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-08-19 20:24:52.809800 | instance |
2026-08-19 20:24:52.810079 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-08-19 20:24:52.810119 | instance | Wednesday 19 August 2026  20:24:52 +0000 (0:00:00.073)       0:00:43.233 ******
2026-08-19 20:24:53.111308 | instance | changed: [instance]
2026-08-19 20:24:53.111374 | instance |
2026-08-19 20:24:53.111621 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-08-19 20:24:53.111638 | instance | Wednesday 19 August 2026  20:24:53 +0000 (0:00:00.301)       0:00:43.535 ******
2026-08-19 20:24:53.760988 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-08-19 20:24:53.761089 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-08-19 20:24:53.761585 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-08-19 20:24:53.761632 | instance |
2026-08-19 20:24:53.761641 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-08-19 20:24:53.761647 | instance | Wednesday 19 August 2026  20:24:53 +0000 (0:00:00.649)       0:00:44.184 ******
2026-08-19 20:26:15.799441 | instance | ok: [instance]
2026-08-19 20:26:15.799477 | instance |
2026-08-19 20:26:15.799483 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-08-19 20:26:15.799488 | instance | Wednesday 19 August 2026  20:26:15 +0000 (0:01:22.037)       0:02:06.222 ******
2026-08-19 20:26:16.008936 | instance | changed: [instance]
2026-08-19 20:26:16.009004 | instance |
2026-08-19 20:26:16.009150 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-08-19 20:26:16.009275 | instance | Wednesday 19 August 2026  20:26:16 +0000 (0:00:00.210)       0:02:06.432 ******
2026-08-19 20:26:16.075463 | instance | ok: [instance]
2026-08-19 20:26:16.075556 | instance |
2026-08-19 20:26:16.075831 | instance | TASK [Install Ceph host] *******************************************************
2026-08-19 20:26:16.075873 | instance | Wednesday 19 August 2026  20:26:16 +0000 (0:00:00.066)       0:02:06.499 ******
2026-08-19 20:26:16.149174 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-08-19 20:26:16.149550 | instance |
2026-08-19 20:26:16.149582 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-08-19 20:26:16.149588 | instance | Wednesday 19 August 2026  20:26:16 +0000 (0:00:00.073)       0:02:06.573 ******
2026-08-19 20:26:17.652714 | instance | ok: [instance]
2026-08-19 20:26:17.652755 | instance |
2026-08-19 20:26:17.652760 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-08-19 20:26:17.652770 | instance | Wednesday 19 August 2026  20:26:17 +0000 (0:00:01.503)       0:02:08.076 ******
2026-08-19 20:26:17.713052 | instance | ok: [instance] => (item=instance)
2026-08-19 20:26:17.713089 | instance |
2026-08-19 20:26:17.713094 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-08-19 20:26:17.713100 | instance | Wednesday 19 August 2026  20:26:17 +0000 (0:00:00.060)       0:02:08.136 ******
2026-08-19 20:26:18.061355 | instance | ok: [instance]
2026-08-19 20:26:18.061658 | instance |
2026-08-19 20:26:18.061721 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-08-19 20:26:18.061800 | instance | Wednesday 19 August 2026  20:26:18 +0000 (0:00:00.348)       0:02:08.485 ******
2026-08-19 20:26:20.291052 | instance | ok: [instance]
2026-08-19 20:26:20.291140 | instance |
2026-08-19 20:26:20.291420 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-08-19 20:26:20.291462 | instance | Wednesday 19 August 2026  20:26:20 +0000 (0:00:02.229)       0:02:10.714 ******
2026-08-19 20:27:03.965350 | instance | An exception occurred during task execution. To see the full traceback, use -vvv. The error was: [errno 5] RADOS I/O error (error connecting to the cluster)
2026-08-19 20:27:03.966322 | 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_aeux83fd/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_aeux83fd/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_aeux83fd/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_aeux83fd/ansible_vexxhost.ceph.orch_apply_payload.zip/ansible_collections/vexxhost/ceph/plugins/modules/orch_apply.py\", line 120, in apply_spec\nRuntimeError: Inferring config /var/lib/ceph/4837cbf8-4f90-4300-b3f6-726c9b9f89b4/mon.instance/config\n2026-08-19T20:27:03.800+0000 7fc7c5cec640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgA/EYZqt/rRFiAAl+cJffuFE6vedZUBJ6uqtOPGxuDeKTyQ+UIY0KfTHbk=: Malformed input [buffer:3]\n2026-08-19T20:27:03.800+0000 7fc7c5cec640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-19T20:27:03.800+0000 7fc7c5cec640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgA/EYZqt/rRFiAAl+cJffuFE6vedZUBJ6uqtOPGxuDeKTyQ+UIY0KfTHbk=: Malformed input [buffer:3]\n2026-08-19T20:27:03.800+0000 7fc7c5cec640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-19T20:27:03.800+0000 7fc7c5cec640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgA/EYZqt/rRFiAAl+cJffuFE6vedZUBJ6uqtOPGxuDeKTyQ+UIY0KfTHbk=: Malformed input [buffer:3]\n2026-08-19T20:27:03.800+0000 7fc7c5cec640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-19T20:27:03.800+0000 7fc7c5cec640 -1 monclient: keyring not found\n[errno 5] RADOS I/O error (error connecting to the cluster)\n\n", "module_stdout": "", "msg": "MODULE FAILURE\nSee stdout/stderr for the exact error", "rc": 1}
2026-08-19 20:27:03.969646 | instance |
2026-08-19 20:27:03.970535 | instance | PLAY RECAP *********************************************************************
2026-08-19 20:27:03.970582 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=6    rescued=0    ignored=0
2026-08-19 20:27:03.970603 | instance |
2026-08-19 20:27:03.970613 | instance | Wednesday 19 August 2026  20:27:03 +0000 (0:00:43.678)       0:02:54.393 ******
2026-08-19 20:27:03.970622 | instance | ===============================================================================
2026-08-19 20:27:03.970637 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 82.04s
2026-08-19 20:27:03.970681 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 43.68s
2026-08-19 20:27:03.972928 | instance | vexxhost.containers.download_artifact : Download item ------------------- 7.09s
2026-08-19 20:27:03.972971 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 4.97s
2026-08-19 20:27:03.972976 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 4.63s
2026-08-19 20:27:03.972981 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.34s
2026-08-19 20:27:03.972985 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.78s
2026-08-19 20:27:03.973024 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.23s
2026-08-19 20:27:03.973029 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.58s
2026-08-19 20:27:03.973033 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.50s
2026-08-19 20:27:03.973037 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.13s
2026-08-19 20:27:03.973041 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 1.03s
2026-08-19 20:27:03.973045 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.00s
2026-08-19 20:27:03.973049 | instance | Gathering Facts --------------------------------------------------------- 0.92s
2026-08-19 20:27:03.973053 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.91s
2026-08-19 20:27:03.973057 | instance | Gathering Facts --------------------------------------------------------- 0.87s
2026-08-19 20:27:03.973061 | instance | Gathering Facts --------------------------------------------------------- 0.86s
2026-08-19 20:27:03.973065 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.83s
2026-08-19 20:27:03.973069 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 0.81s
2026-08-19 20:27:03.973073 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.72s
2026-08-19 20:27:04.081967 | instance | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-19 20:27:04.082294 | instance | ERROR    [csi > converge] Executed: Failed
2026-08-19 20:27:04.082529 | instance | ERROR    Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-19 20:27:04.290091 | instance | ERROR
2026-08-19 20:27:04.290448 | instance | {
2026-08-19 20:27:04.290534 | instance |   "delta": "0:03:40.834588",
2026-08-19 20:27:04.290600 | instance |   "end": "2026-08-19 20:27:04.133899",
2026-08-19 20:27:04.290663 | instance |   "msg": "non-zero return code",
2026-08-19 20:27:04.290717 | instance |   "rc": 2,
2026-08-19 20:27:04.290760 | instance |   "start": "2026-08-19 20:23:23.299311"
2026-08-19 20:27:04.290803 | instance | }
failure
2026-08-19 20:27:04.298401 | 
2026-08-19 20:27:04.298458 | PLAY RECAP
2026-08-19 20:27:04.298508 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-08-19 20:27:04.298533 | 
2026-08-19 20:27:05.257492 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-19 20:27:05.262754 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-19 20:27:06.550182 | 
2026-08-19 20:27:07.042497 | PLAY [all]
2026-08-19 20:27:07.069471 | 
2026-08-19 20:27:07.069590 | TASK [gather-host-logs : creating directory for system status]
2026-08-19 20:27:07.453738 | instance | changed
2026-08-19 20:27:07.460031 | 
2026-08-19 20:27:07.460116 | TASK [gather-host-logs : Get logs for each host]
2026-08-19 20:27:07.832894 | instance | + systemd-cgls --full --all --no-pager
2026-08-19 20:27:07.847877 | instance | + ip addr
2026-08-19 20:27:07.849692 | instance | + ip route
2026-08-19 20:27:07.851356 | instance | + lsblk
2026-08-19 20:27:07.853705 | instance | + mount
2026-08-19 20:27:07.854843 | instance | + docker images
2026-08-19 20:27:07.872505 | instance | + brctl show
2026-08-19 20:27:07.872870 | instance | /bin/bash: line 8: brctl: command not found
2026-08-19 20:27:07.873026 | instance | + ps aux --sort=-%mem
2026-08-19 20:27:07.888317 | instance | + dpkg -l
2026-08-19 20:27:07.897524 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-08-19 20:27:07.898047 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-08-19 20:27:07.916109 | instance | + '[' '!' -z '' ']'
2026-08-19 20:27:08.261204 | instance | ok: Runtime: 0:00:00.088310
2026-08-19 20:27:08.269408 | 
2026-08-19 20:27:08.269480 | TASK [gather-host-logs : Downloads logs to executor]
2026-08-19 20:27:08.907331 | instance | changed:
2026-08-19 20:27:08.907805 | instance | created directory /var/lib/zuul/builds/db14f7e009d54430a708dd08bdeadd62/work/logs/instance
2026-08-19 20:27:08.907857 | instance | cd+++++++++ system/
2026-08-19 20:27:08.907893 | instance | >f+++++++++ system/brctl-show.txt
2026-08-19 20:27:08.907925 | instance | >f+++++++++ system/docker-images.txt
2026-08-19 20:27:08.907955 | instance | >f+++++++++ system/ip-addr.txt
2026-08-19 20:27:08.907987 | instance | >f+++++++++ system/ip-route.txt
2026-08-19 20:27:08.908019 | instance | >f+++++++++ system/lsblk.txt
2026-08-19 20:27:08.908049 | instance | >f+++++++++ system/mount.txt
2026-08-19 20:27:08.908079 | instance | >f+++++++++ system/packages.txt
2026-08-19 20:27:08.908107 | instance | >f+++++++++ system/ps.txt
2026-08-19 20:27:08.908138 | instance | >f+++++++++ system/systemd-cgls.txt
2026-08-19 20:27:08.919991 | 
2026-08-19 20:27:08.920065 | LOOP [helm-release-status : creating directory for helm release status]
2026-08-19 20:27:09.119264 | instance | changed: "values"
2026-08-19 20:27:09.297427 | instance | changed: "releases"
2026-08-19 20:27:09.316331 | 
2026-08-19 20:27:09.316563 | TASK [helm-release-status : Gather get release status for helm charts]
2026-08-19 20:27:09.521293 | instance | /bin/bash: line 3: kubectl: command not found
2026-08-19 20:27:10.007454 | instance | ok: Runtime: 0:00:00.005201
2026-08-19 20:27:10.015208 | 
2026-08-19 20:27:10.015364 | TASK [helm-release-status : Downloads logs to executor]
2026-08-19 20:27:10.554361 | instance | changed:
2026-08-19 20:27:10.554551 | instance | cd+++++++++ helm/
2026-08-19 20:27:10.554580 | instance | cd+++++++++ helm/releases/
2026-08-19 20:27:10.554613 | instance | cd+++++++++ helm/values/
2026-08-19 20:27:10.573851 | 
2026-08-19 20:27:10.574030 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-08-19 20:27:10.774201 | instance | changed
2026-08-19 20:27:10.782690 | 
2026-08-19 20:27:10.782772 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-08-19 20:27:11.039828 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-19 20:27:11.039940 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-19 20:27:11.044966 | instance | environment: line 1: kubectl: command not found
2026-08-19 20:27:11.046309 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-19 20:27:11.047106 | instance | environment: line 1: kubectl: command not found
2026-08-19 20:27:11.049100 | instance | environment: line 1: kubectl: command not found
2026-08-19 20:27:11.050051 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-19 20:27:11.051534 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-19 20:27:11.052257 | instance | environment: line 1: kubectl: command not found
2026-08-19 20:27:11.053290 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-19 20:27:11.053894 | instance | environment: line 1: kubectl: command not found
2026-08-19 20:27:11.054710 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-19 20:27:11.328891 | instance | ok: Runtime: 0:00:00.022563
2026-08-19 20:27:11.336440 | 
2026-08-19 20:27:11.336546 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-08-19 20:27:11.532804 | instance | changed
2026-08-19 20:27:11.539735 | 
2026-08-19 20:27:11.539836 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-08-19 20:27:11.745905 | instance | environment: line 5: kubectl: command not found
2026-08-19 20:27:11.746877 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-19 20:27:11.746953 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-19 20:27:11.747343 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-19 20:27:12.079017 | instance | ok: Runtime: 0:00:00.008071
2026-08-19 20:27:12.087078 | 
2026-08-19 20:27:12.087173 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-08-19 20:27:12.557442 | instance | changed:
2026-08-19 20:27:12.557619 | instance | cd+++++++++ objects/
2026-08-19 20:27:12.557646 | instance | cd+++++++++ objects/cluster/
2026-08-19 20:27:12.557670 | instance | cd+++++++++ objects/namespaced/
2026-08-19 20:27:12.566413 | 
2026-08-19 20:27:12.566478 | TASK [gather-pod-logs : creating directory for pod logs]
2026-08-19 20:27:12.773079 | instance | changed
2026-08-19 20:27:12.778050 | 
2026-08-19 20:27:12.778113 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-08-19 20:27:12.985840 | instance | changed
2026-08-19 20:27:13.188581 | 
2026-08-19 20:27:13.188696 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-08-19 20:27:13.416000 | instance | environment: line 3: kubectl: command not found
2026-08-19 20:27:13.737336 | instance | ok: Runtime: 0:00:00.009266
2026-08-19 20:27:13.745291 | 
2026-08-19 20:27:13.745422 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-08-19 20:27:14.250010 | instance | changed:
2026-08-19 20:27:14.367121 | instance | cd+++++++++ pod-logs/
2026-08-19 20:27:14.367263 | instance | cd+++++++++ pod-logs/failed-pods/
2026-08-19 20:27:14.383526 | 
2026-08-19 20:27:14.383619 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-08-19 20:27:14.589573 | instance | changed
2026-08-19 20:27:14.596236 | 
2026-08-19 20:27:14.596320 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-08-19 20:27:14.801434 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-19 20:27:15.134697 | instance | ok: Runtime: 0:00:00.033845
2026-08-19 20:27:15.141486 | 
2026-08-19 20:27:15.141565 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-08-19 20:27:15.357279 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-19 20:27:15.386965 | instance | ceph-mgr endpoints:
2026-08-19 20:27:15.677808 | instance | ok: Runtime: 0:00:00.034490
2026-08-19 20:27:15.685380 | 
2026-08-19 20:27:15.685493 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-08-19 20:27:15.912889 | instance | /bin/bash: line 4: kubectl: command not found
2026-08-19 20:27:16.222057 | instance | ok: Runtime: 0:00:00.035691
2026-08-19 20:27:16.242982 | 
2026-08-19 20:27:16.243183 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-08-19 20:27:16.732541 | instance | changed: cd+++++++++ prometheus/
2026-08-19 20:27:16.744417 | 
2026-08-19 20:27:16.744494 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-08-19 20:27:16.932209 | instance | changed
2026-08-19 20:27:16.937143 | 
2026-08-19 20:27:16.937214 | TASK [gather-selenium-data : Get selenium data]
2026-08-19 20:27:17.188243 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-08-19 20:27:17.189786 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-08-19 20:27:17.473247 | instance | ERROR
2026-08-19 20:27:17.473497 | instance | {
2026-08-19 20:27:17.473531 | instance |   "delta": "0:00:00.006643",
2026-08-19 20:27:17.473553 | instance |   "end": "2026-08-19 20:27:17.190123",
2026-08-19 20:27:17.473576 | instance |   "msg": "non-zero return code",
2026-08-19 20:27:17.473597 | instance |   "rc": 1,
2026-08-19 20:27:17.473617 | instance |   "start": "2026-08-19 20:27:17.183480"
2026-08-19 20:27:17.473636 | instance | }
2026-08-19 20:27:17.473662 | instance | ERROR: Ignoring Errors
2026-08-19 20:27:17.479024 | 
2026-08-19 20:27:17.479109 | TASK [gather-selenium-data : Downloads logs to executor]
2026-08-19 20:27:17.970379 | instance | changed: cd+++++++++ selenium/
2026-08-19 20:27:17.978351 | 
2026-08-19 20:27:17.978429 | PLAY RECAP
2026-08-19 20:27:17.978514 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-08-19 20:27:17.978555 | 
2026-08-19 20:27:18.198721 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-19 20:27:18.203981 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-19 20:27:18.922994 | 
2026-08-19 20:27:18.923125 | PLAY [all]
2026-08-19 20:27:18.935087 | 
2026-08-19 20:27:18.935174 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-19 20:27:18.980879 | instance | skipping: Conditional result was False
2026-08-19 20:27:18.990135 | 
2026-08-19 20:27:18.990243 | TASK [fetch-output : Set log path for single node]
2026-08-19 20:27:19.035758 | instance | ok
2026-08-19 20:27:19.042313 | 
2026-08-19 20:27:19.042410 | LOOP [fetch-output : Ensure local output dirs]
2026-08-19 20:27:19.459095 | instance -> localhost | ok: "/var/lib/zuul/builds/db14f7e009d54430a708dd08bdeadd62/work/logs"
2026-08-19 20:27:19.677327 | instance -> localhost | changed: "/var/lib/zuul/builds/db14f7e009d54430a708dd08bdeadd62/work/artifacts"
2026-08-19 20:27:19.925151 | instance -> localhost | changed: "/var/lib/zuul/builds/db14f7e009d54430a708dd08bdeadd62/work/docs"
2026-08-19 20:27:19.938320 | 
2026-08-19 20:27:19.938507 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-19 20:27:20.589646 | instance | changed: .d..t...... ./
2026-08-19 20:27:20.589904 | instance | changed: All items complete
2026-08-19 20:27:20.589944 | 
2026-08-19 20:27:21.034196 | instance | changed: .d..t...... ./
2026-08-19 20:27:21.504455 | instance | changed: .d..t...... ./
2026-08-19 20:27:21.529202 | 
2026-08-19 20:27:21.529784 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-19 20:27:21.977284 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.008753
2026-08-19 20:27:22.222587 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.009521
2026-08-19 20:27:22.240169 | 
2026-08-19 20:27:22.240276 | PLAY [all]
2026-08-19 20:27:22.246338 | 
2026-08-19 20:27:22.246406 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-19 20:27:22.706496 | instance | changed
2026-08-19 20:27:22.714568 | 
2026-08-19 20:27:22.714642 | PLAY RECAP
2026-08-19 20:27:22.714701 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-19 20:27:22.714733 | 
2026-08-19 20:27:22.858761 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-19 20:27:22.863130 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-19 20:27:23.476558 | 
2026-08-19 20:27:23.476888 | PLAY [localhost]
2026-08-19 20:27:23.487305 | 
2026-08-19 20:27:23.487402 | TASK [Generate Zuul manifest]
2026-08-19 20:27:23.511363 | localhost | ok
2026-08-19 20:27:23.532575 | 
2026-08-19 20:27:23.532736 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-19 20:27:23.915691 | localhost | changed
2026-08-19 20:27:23.925533 | 
2026-08-19 20:27:23.925603 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-19 20:27:23.953245 | localhost | ok
2026-08-19 20:27:23.959778 | 
2026-08-19 20:27:23.959840 | TASK [Upload logs]
2026-08-19 20:27:23.979801 | localhost | ok
2026-08-19 20:27:24.062628 | 
2026-08-19 20:27:24.062744 | TASK [Set zuul-log-path fact]
2026-08-19 20:27:24.085309 | localhost | ok
2026-08-19 20:27:24.098689 | 
2026-08-19 20:27:24.098759 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-19 20:27:24.131258 | localhost | ok
2026-08-19 20:27:24.141264 | 
2026-08-19 20:27:24.141354 | TASK [upload-logs : Create log directories]
2026-08-19 20:27:24.569771 | localhost | changed
2026-08-19 20:27:24.576292 | 
2026-08-19 20:27:24.576361 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-19 20:27:25.030694 | localhost -> localhost | ok: Runtime: 0:00:00.006554
2026-08-19 20:27:25.035838 | 
2026-08-19 20:27:25.035906 | TASK [upload-logs : Upload logs to log server]
2026-08-19 20:27:25.524820 | localhost | Output suppressed because no_log was given
2026-08-19 20:27:25.570666 | 
2026-08-19 20:27:25.570822 | LOOP [upload-logs : Compress console log and json output]
2026-08-19 20:27:25.619001 | localhost | skipping: Conditional result was False
2026-08-19 20:27:25.627557 | localhost | skipping: Conditional result was False
2026-08-19 20:27:25.648331 | 
2026-08-19 20:27:25.648528 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-19 20:27:25.694778 | localhost | skipping: Conditional result was False
2026-08-19 20:27:25.695401 | 
2026-08-19 20:27:25.698877 | localhost | skipping: Conditional result was False
2026-08-19 20:27:25.717770 | 
2026-08-19 20:27:25.718012 | LOOP [upload-logs : Upload console log and json output]