2026-08-24 07:18:07.455886 | Job console starting
2026-08-24 07:18:07.469870 | Updating git repos
2026-08-24 07:18:10.892076 | Cloning repos into workspace
2026-08-24 07:18:26.709735 | Restoring repo states
2026-08-24 07:18:39.915478 | Merging changes
2026-08-24 07:18:41.648027 | Checking out repos
2026-08-24 07:18:43.216402 | Preparing playbooks
2026-08-24 07:18:46.326960 | Running Ansible setup
2026-08-24 07:18:49.714888 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-24 07:18:50.333532 | 
2026-08-24 07:18:50.333702 | PLAY [localhost]
2026-08-24 07:18:50.341689 | 
2026-08-24 07:18:50.341799 | TASK [Gathering Facts]
2026-08-24 07:18:51.631779 | localhost | ok
2026-08-24 07:18:51.643267 | 
2026-08-24 07:18:51.643398 | TASK [Setup log path fact]
2026-08-24 07:18:51.664456 | localhost | ok
2026-08-24 07:18:51.677292 | 
2026-08-24 07:18:51.677412 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-24 07:18:51.708267 | localhost | ok
2026-08-24 07:18:51.716883 | 
2026-08-24 07:18:51.717026 | TASK [emit-job-header : Print job information]
2026-08-24 07:18:51.758690 | # Job Information
2026-08-24 07:18:51.758888 | Ansible Version: 2.16.18
2026-08-24 07:18:51.758934 | Job: atmosphere-molecule-csi-rbd
2026-08-24 07:18:51.758966 | Pipeline: check
2026-08-24 07:18:51.758996 | Executor: 2d72f0692154
2026-08-24 07:18:51.759026 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3501
2026-08-24 07:18:51.759059 | Event ID: 5209f1d0-9f8b-11f1-97e3-0fe5638864d0
2026-08-24 07:18:51.763277 | 
2026-08-24 07:18:51.763373 | LOOP [emit-job-header : Print node information]
2026-08-24 07:18:51.865555 | localhost | ok:
2026-08-24 07:18:51.865949 | localhost | # Node Information
2026-08-24 07:18:51.866210 | localhost | Inventory Hostname: instance
2026-08-24 07:18:51.866264 | localhost | Hostname: np0000190786
2026-08-24 07:18:51.866320 | localhost | Username: zuul
2026-08-24 07:18:51.866402 | localhost | Distro: Ubuntu 22.04
2026-08-24 07:18:51.866477 | localhost | Provider: yul1
2026-08-24 07:18:51.866548 | localhost | Region: ca-ymq-1
2026-08-24 07:18:51.866599 | localhost | Label: ubuntu-jammy
2026-08-24 07:18:51.866644 | localhost | Product Name: OpenStack Nova
2026-08-24 07:18:51.866689 | localhost | Interface IP: 199.19.213.111
2026-08-24 07:18:51.881193 | 
2026-08-24 07:18:51.881307 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-24 07:18:52.280201 | localhost -> localhost | changed
2026-08-24 07:18:52.289502 | 
2026-08-24 07:18:52.289605 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-24 07:18:53.125228 | localhost -> localhost | changed
2026-08-24 07:18:53.135574 | 
2026-08-24 07:18:53.135652 | PLAY [all]
2026-08-24 07:18:53.146902 | 
2026-08-24 07:18:53.146995 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-24 07:18:53.370831 | instance -> localhost | ok
2026-08-24 07:18:53.380176 | 
2026-08-24 07:18:53.380270 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-24 07:18:53.412863 | instance | ok
2026-08-24 07:18:53.428652 | instance | included: /var/lib/zuul/builds/c5238c1c7946401fa7a92baf8df6a185/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-24 07:18:53.435620 | 
2026-08-24 07:18:53.435708 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-24 07:18:54.766724 | instance -> localhost | Generating public/private rsa key pair.
2026-08-24 07:18:54.766930 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/c5238c1c7946401fa7a92baf8df6a185/work/c5238c1c7946401fa7a92baf8df6a185_id_rsa
2026-08-24 07:18:54.766971 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/c5238c1c7946401fa7a92baf8df6a185/work/c5238c1c7946401fa7a92baf8df6a185_id_rsa.pub
2026-08-24 07:18:54.767002 | instance -> localhost | The key fingerprint is:
2026-08-24 07:18:54.767030 | instance -> localhost | SHA256:CoJ/I+mQTashEymylIDV9HnBoc2E1uwg2itSM22jyOo zuul-build-sshkey
2026-08-24 07:18:54.767072 | instance -> localhost | The key's randomart image is:
2026-08-24 07:18:54.767101 | instance -> localhost | +---[RSA 3072]----+
2026-08-24 07:18:54.767138 | instance -> localhost | |  .o.  =+.       |
2026-08-24 07:18:54.767167 | instance -> localhost | |..  o.+*+.       |
2026-08-24 07:18:54.767236 | instance -> localhost | |o  + o+o+        |
2026-08-24 07:18:54.767267 | instance -> localhost | |.o* =  ..        |
2026-08-24 07:18:54.767298 | instance -> localhost | |B=o=.o  S        |
2026-08-24 07:18:54.767326 | instance -> localhost | |*Oo+.. .         |
2026-08-24 07:18:54.767353 | instance -> localhost | |O.*.o .          |
2026-08-24 07:18:54.767380 | instance -> localhost | |o* o .           |
2026-08-24 07:18:54.767412 | instance -> localhost | |oE.              |
2026-08-24 07:18:54.767441 | instance -> localhost | +----[SHA256]-----+
2026-08-24 07:18:54.767509 | instance -> localhost | ok: Runtime: 0:00:00.894525
2026-08-24 07:18:54.775845 | 
2026-08-24 07:18:54.775932 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-24 07:18:54.809259 | instance | ok
2026-08-24 07:18:54.820573 | instance | included: /var/lib/zuul/builds/c5238c1c7946401fa7a92baf8df6a185/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-24 07:18:54.828138 | 
2026-08-24 07:18:54.828198 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-24 07:18:54.852197 | instance | skipping: Conditional result was False
2026-08-24 07:18:54.861562 | 
2026-08-24 07:18:54.861654 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-24 07:18:55.293695 | instance | changed
2026-08-24 07:18:55.302588 | 
2026-08-24 07:18:55.302655 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-24 07:18:55.485164 | instance | ok
2026-08-24 07:18:55.490352 | 
2026-08-24 07:18:55.490417 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-24 07:18:55.942363 | instance | changed
2026-08-24 07:18:55.950064 | 
2026-08-24 07:18:55.950169 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-24 07:18:56.393697 | instance | changed
2026-08-24 07:18:56.399484 | 
2026-08-24 07:18:56.399541 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-24 07:18:56.422828 | instance | skipping: Conditional result was False
2026-08-24 07:18:56.433317 | 
2026-08-24 07:18:56.433379 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-24 07:18:56.789174 | instance -> localhost | changed
2026-08-24 07:18:56.806893 | 
2026-08-24 07:18:56.806966 | TASK [add-build-sshkey : Add back temp key]
2026-08-24 07:18:57.082746 | instance -> localhost | Identity added: /var/lib/zuul/builds/c5238c1c7946401fa7a92baf8df6a185/work/c5238c1c7946401fa7a92baf8df6a185_id_rsa (zuul-build-sshkey)
2026-08-24 07:18:57.082970 | instance -> localhost | ok: Runtime: 0:00:00.011585
2026-08-24 07:18:57.088067 | 
2026-08-24 07:18:57.088128 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-24 07:18:57.458367 | instance | ok
2026-08-24 07:18:57.467217 | 
2026-08-24 07:18:57.467347 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-24 07:18:57.492988 | instance | skipping: Conditional result was False
2026-08-24 07:18:57.508331 | 
2026-08-24 07:18:57.508425 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-24 07:18:57.843741 | instance | ok
2026-08-24 07:18:57.849908 | 
2026-08-24 07:18:57.849989 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-24 07:19:01.070864 | instance | Output suppressed because no_log was given
2026-08-24 07:19:01.079748 | 
2026-08-24 07:19:01.079811 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-24 07:19:01.298175 | instance | ok: "logs"
2026-08-24 07:19:01.298409 | instance | ok: All items complete
2026-08-24 07:19:01.298438 | 
2026-08-24 07:19:01.456455 | instance | ok: "artifacts"
2026-08-24 07:19:01.619681 | instance | ok: "docs"
2026-08-24 07:19:01.635385 | 
2026-08-24 07:19:01.635490 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-24 07:19:01.824117 | instance | changed: "logs"
2026-08-24 07:19:01.995248 | instance | changed: "artifacts"
2026-08-24 07:19:02.144273 | instance | changed: "docs"
2026-08-24 07:19:02.155352 | 
2026-08-24 07:19:02.155440 | PLAY RECAP
2026-08-24 07:19:02.155484 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-24 07:19:02.155512 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-24 07:19:02.155532 | 
2026-08-24 07:19:02.276074 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-24 07:19:02.280501 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-24 07:19:02.884327 | 
2026-08-24 07:19:02.884786 | PLAY [all]
2026-08-24 07:19:02.898184 | 
2026-08-24 07:19:02.898317 | TASK [setup-uv : Extract archive]
2026-08-24 07:19:05.092067 | instance | changed
2026-08-24 07:19:05.098912 | 
2026-08-24 07:19:05.098997 | TASK [setup-uv : Print version]
2026-08-24 07:19:05.425475 | instance | uv 0.8.13
2026-08-24 07:19:05.635066 | instance | ok: Runtime: 0:00:00.010936
2026-08-24 07:19:05.646924 | 
2026-08-24 07:19:05.647065 | TASK [Install Ansible collection siblings]
2026-08-24 07:19:14.713543 | instance | changed:
2026-08-24 07:19:14.713753 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-08-24 07:19:14.713795 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-08-24 07:19:14.713826 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-08-24 07:19:14.713855 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-08-24 07:19:14.713882 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-08-24 07:19:14.713914 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-08-24 07:19:14.713943 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-08-24 07:19:14.713973 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-08-24 07:19:14.714001 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-08-24 07:19:14.714029 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-08-24 07:19:14.714153 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-08-24 07:19:14.714220 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-08-24 07:19:14.714310 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-08-24 07:19:14.714361 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-08-24 07:19:14.714394 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0
2026-08-24 07:19:14.714423 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-08-24 07:19:14.714450 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-08-24 07:19:14.714476 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-08-24 07:19:14.714501 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-08-24 07:19:14.714526 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-08-24 07:19:14.714551 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0
2026-08-24 07:19:14.714576 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-08-24 07:19:14.714604 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-24 07:19:14.714652 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-08-24 07:19:14.714692 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0
2026-08-24 07:19:14.714748 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-24 07:19:14.714777 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-24 07:19:14.714803 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-24 07:19:14.714828 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-08-24 07:19:14.714853 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-08-24 07:19:14.714879 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-24 07:19:14.714905 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-24 07:19:14.714932 | instance | Checked out ansible.netcommon to 1.2.0
2026-08-24 07:19:14.714959 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-08-24 07:19:14.715005 | instance | Starting galaxy collection install process
2026-08-24 07:19:14.715043 | instance | Process install dependency map
2026-08-24 07:19:14.715078 | instance | Starting collection install process
2026-08-24 07:19:14.715115 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-08-24 07:19:14.715144 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-08-24 07:19:14.715173 | instance | ansible.netcommon:* was installed successfully
2026-08-24 07:19:14.715208 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-08-24 07:19:14.715244 | instance | Creating virtual environment at: .venv
2026-08-24 07:19:14.715279 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-24 07:19:14.715309 | instance | Downloading ansible-core (2.1MiB)
2026-08-24 07:19:14.715340 | instance | Downloading rjsonnet (1.2MiB)
2026-08-24 07:19:14.715381 | instance | Downloading cryptography (4.2MiB)
2026-08-24 07:19:14.715415 | instance | Downloading pydantic-core (2.0MiB)
2026-08-24 07:19:14.715448 | instance | Downloading setuptools (1.1MiB)
2026-08-24 07:19:14.715484 | instance | Downloading kubernetes (1.9MiB)
2026-08-24 07:19:14.715520 | instance | Downloading pygments (1.2MiB)
2026-08-24 07:19:14.715552 | instance | Downloading openstacksdk (1.7MiB)
2026-08-24 07:19:14.715579 | instance | Downloading netaddr (2.2MiB)
2026-08-24 07:19:14.715606 | instance |    Building pyperclip==1.9.0
2026-08-24 07:19:14.715634 | instance |  Downloading rjsonnet
2026-08-24 07:19:14.715660 | instance |  Downloading pydantic-core
2026-08-24 07:19:14.715685 | instance |  Downloading netaddr
2026-08-24 07:19:14.715716 | instance |  Downloading pygments
2026-08-24 07:19:14.715752 | instance |  Downloading cryptography
2026-08-24 07:19:14.715785 | instance |  Downloading setuptools
2026-08-24 07:19:14.715817 | instance |  Downloading kubernetes
2026-08-24 07:19:14.715846 | instance |  Downloading ansible-core
2026-08-24 07:19:14.715872 | instance |  Downloading openstacksdk
2026-08-24 07:19:14.715898 | instance |       Built pyperclip==1.9.0
2026-08-24 07:19:14.715923 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-24 07:19:14.715948 | instance | Installed 83 packages in 57ms
2026-08-24 07:19:14.715973 | instance | Checked out ansible.posix to 1.6.0
2026-08-24 07:19:14.715998 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-08-24 07:19:14.716023 | instance | Starting galaxy collection install process
2026-08-24 07:19:14.716048 | instance | Process install dependency map
2026-08-24 07:19:14.716081 | instance | Starting collection install process
2026-08-24 07:19:14.716106 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-08-24 07:19:14.716131 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-08-24 07:19:14.716156 | instance | ansible.posix:1.6.0 was installed successfully
2026-08-24 07:19:14.716181 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 07:19:14.716205 | instance | 2.17.12
2026-08-24 07:19:14.716230 | instance | Checked out ansible.utils to v6.1.0
2026-08-24 07:19:14.716255 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-08-24 07:19:14.716281 | instance | Starting galaxy collection install process
2026-08-24 07:19:14.716306 | instance | Process install dependency map
2026-08-24 07:19:14.716336 | instance | Starting collection install process
2026-08-24 07:19:14.716374 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-08-24 07:19:14.716402 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-08-24 07:19:14.716428 | instance | ansible.utils:6.1.0 was installed successfully
2026-08-24 07:19:14.716453 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 07:19:14.716477 | instance | 2.17.12
2026-08-24 07:19:14.716502 | instance | Checked out atmosphere.common to v0.7.0
2026-08-24 07:19:14.716526 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-08-24 07:19:14.716551 | instance | Starting galaxy collection install process
2026-08-24 07:19:14.716575 | instance | Process install dependency map
2026-08-24 07:19:14.716600 | instance | Starting collection install process
2026-08-24 07:19:14.716624 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-08-24 07:19:14.716648 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-08-24 07:19:14.716672 | instance | atmosphere.common:0.7.0 was installed successfully
2026-08-24 07:19:14.716696 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 07:19:14.716741 | instance | 2.17.12
2026-08-24 07:19:14.716804 | instance | Checked out community.crypto to 2.2.3
2026-08-24 07:19:14.716852 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.crypto
2026-08-24 07:19:14.716893 | instance | Starting galaxy collection install process
2026-08-24 07:19:14.716923 | instance | Process install dependency map
2026-08-24 07:19:14.716949 | instance | Starting collection install process
2026-08-24 07:19:14.716998 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-08-24 07:19:14.717026 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-08-24 07:19:14.717051 | instance | community.crypto:2.2.3 was installed successfully
2026-08-24 07:19:14.717076 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 07:19:14.717101 | instance | 2.17.12
2026-08-24 07:19:14.717125 | instance | Checked out community.general to 7.3.0
2026-08-24 07:19:14.717150 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.general
2026-08-24 07:19:14.717182 | instance | Starting galaxy collection install process
2026-08-24 07:19:14.717208 | instance | Process install dependency map
2026-08-24 07:19:14.717234 | instance | Starting collection install process
2026-08-24 07:19:14.717297 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-08-24 07:19:14.717349 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-08-24 07:19:14.717385 | instance | community.general:7.3.0 was installed successfully
2026-08-24 07:19:14.717413 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 07:19:14.717440 | instance | 2.17.12
2026-08-24 07:19:14.717467 | instance | Checked out community.mysql to 3.6.0
2026-08-24 07:19:14.717496 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.mysql
2026-08-24 07:19:14.717528 | instance | Starting galaxy collection install process
2026-08-24 07:19:14.717564 | instance | Process install dependency map
2026-08-24 07:19:14.717600 | instance | Starting collection install process
2026-08-24 07:19:14.717639 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-08-24 07:19:14.717684 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-08-24 07:19:14.717729 | instance | community.mysql:3.6.0 was installed successfully
2026-08-24 07:19:14.717767 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 07:19:14.717800 | instance | 2.17.12
2026-08-24 07:19:14.717827 | instance | Checked out kubernetes.core to 2.4.0
2026-08-24 07:19:14.717854 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-08-24 07:19:14.717879 | instance | Starting galaxy collection install process
2026-08-24 07:19:14.717905 | instance | Process install dependency map
2026-08-24 07:19:14.717930 | instance | Starting collection install process
2026-08-24 07:19:14.717955 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-08-24 07:19:14.717980 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-08-24 07:19:14.718005 | instance | kubernetes.core:2.4.0 was installed successfully
2026-08-24 07:19:14.718030 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 07:19:14.718055 | instance | 2.17.12
2026-08-24 07:19:14.718080 | instance | Checked out openstack.cloud to 2.6.0
2026-08-24 07:19:14.718105 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-08-24 07:19:14.718131 | instance | Starting galaxy collection install process
2026-08-24 07:19:14.718156 | instance | Process install dependency map
2026-08-24 07:19:14.718181 | instance | Starting collection install process
2026-08-24 07:19:14.718205 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-08-24 07:19:14.718230 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-08-24 07:19:14.718254 | instance | openstack.cloud:2.6.0 was installed successfully
2026-08-24 07:19:14.718278 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 07:19:14.718302 | instance | 2.17.12
2026-08-24 07:19:14.718341 | instance | Checked out vexxhost.ceph to v4.2.0
2026-08-24 07:19:14.718376 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-08-24 07:19:14.718404 | instance | Starting galaxy collection install process
2026-08-24 07:19:14.718430 | instance | Process install dependency map
2026-08-24 07:19:14.718456 | instance | Starting collection install process
2026-08-24 07:19:14.718482 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-08-24 07:19:14.718507 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-08-24 07:19:14.718531 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-08-24 07:19:14.718556 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 07:19:14.718579 | instance | 2.17.12
2026-08-24 07:19:14.718603 | instance | Checked out vexxhost.containers to v1.6.8
2026-08-24 07:19:14.718627 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-08-24 07:19:14.718652 | instance | Starting galaxy collection install process
2026-08-24 07:19:14.718679 | instance | Process install dependency map
2026-08-24 07:19:14.718750 | instance | Starting collection install process
2026-08-24 07:19:14.718780 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-08-24 07:19:14.718809 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-08-24 07:19:14.718838 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-08-24 07:19:14.718864 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 07:19:14.718890 | instance | 2.17.12
2026-08-24 07:19:14.718915 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-08-24 07:19:14.718939 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-08-24 07:19:14.718991 | instance | Starting galaxy collection install process
2026-08-24 07:19:14.719021 | instance | Process install dependency map
2026-08-24 07:19:14.719056 | instance | Starting collection install process
2026-08-24 07:19:14.719093 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-08-24 07:19:14.719127 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-08-24 07:19:14.719153 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-08-24 07:19:14.719182 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-24 07:19:14.719217 | instance | 2.17.12
2026-08-24 07:19:14.726146 | 
2026-08-24 07:19:14.726199 | PLAY RECAP
2026-08-24 07:19:14.726245 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-24 07:19:14.726267 | 
2026-08-24 07:19:14.834309 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-24 07:19:14.838200 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-24 07:19:15.382619 | 
2026-08-24 07:19:15.382744 | PLAY [all]
2026-08-24 07:19:15.393428 | 
2026-08-24 07:19:15.393506 | TASK [Install "jq" for log collection]
2026-08-24 07:19:25.029268 | instance | changed
2026-08-24 07:19:25.031445 | 
2026-08-24 07:19:25.031516 | PLAY RECAP
2026-08-24 07:19:25.031582 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-24 07:19:25.031657 | 
2026-08-24 07:19:25.136278 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-24 07:19:25.138817 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-24 07:19:25.716672 | 
2026-08-24 07:19:25.716795 | PLAY [all]
2026-08-24 07:19:25.727687 | 
2026-08-24 07:19:25.727797 | LOOP [Check inventory directories]
2026-08-24 07:19:26.049424 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-08-24 07:19:26.202543 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-08-24 07:19:26.370254 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-08-24 07:19:26.383564 | 
2026-08-24 07:19:26.383790 | LOOP [Copy inventory file for Zuul]
2026-08-24 07:19:27.181476 | instance | changed:
2026-08-24 07:19:27.181676 | instance | {
2026-08-24 07:19:27.181715 | instance |   "ansible_loop_var": "item",
2026-08-24 07:19:27.181748 | instance |   "changed": false,
2026-08-24 07:19:27.181777 | instance |   "failed": false,
2026-08-24 07:19:27.181809 | instance |   "invocation": {
2026-08-24 07:19:27.181836 | instance |     "module_args": {
2026-08-24 07:19:27.181862 | instance |       "checksum_algorithm": "sha1",
2026-08-24 07:19:27.181888 | instance |       "follow": true,
2026-08-24 07:19:27.181913 | instance |       "get_attributes": true,
2026-08-24 07:19:27.181940 | instance |       "get_checksum": true,
2026-08-24 07:19:27.181965 | instance |       "get_mime": true,
2026-08-24 07:19:27.181991 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-08-24 07:19:27.182016 | instance |     }
2026-08-24 07:19:27.182041 | instance |   },
2026-08-24 07:19:27.182067 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-08-24 07:19:27.182092 | instance |   "stat": {
2026-08-24 07:19:27.182116 | instance |     "atime": 1787555947.3661733,
2026-08-24 07:19:27.182141 | instance |     "attr_flags": "e",
2026-08-24 07:19:27.182165 | instance |     "attributes": [
2026-08-24 07:19:27.182190 | instance |       "extents"
2026-08-24 07:19:27.182214 | instance |     ],
2026-08-24 07:19:27.182239 | instance |     "block_size": 4096,
2026-08-24 07:19:27.182263 | instance |     "blocks": 8,
2026-08-24 07:19:27.182288 | instance |     "charset": "unknown",
2026-08-24 07:19:27.182315 | instance |     "ctime": 1787555946.405652,
2026-08-24 07:19:27.182341 | instance |     "dev": 64513,
2026-08-24 07:19:27.182382 | instance |     "device_type": 0,
2026-08-24 07:19:27.182409 | instance |     "executable": true,
2026-08-24 07:19:27.182433 | instance |     "exists": true,
2026-08-24 07:19:27.182458 | instance |     "gid": 1000,
2026-08-24 07:19:27.182482 | instance |     "gr_name": "zuul",
2026-08-24 07:19:27.182507 | instance |     "inode": 1048708,
2026-08-24 07:19:27.182531 | instance |     "isblk": false,
2026-08-24 07:19:27.182557 | instance |     "ischr": false,
2026-08-24 07:19:27.182583 | instance |     "isdir": true,
2026-08-24 07:19:27.182608 | instance |     "isfifo": false,
2026-08-24 07:19:27.182632 | instance |     "isgid": false,
2026-08-24 07:19:27.182656 | instance |     "islnk": false,
2026-08-24 07:19:27.182680 | instance |     "isreg": false,
2026-08-24 07:19:27.182703 | instance |     "issock": false,
2026-08-24 07:19:27.182727 | instance |     "isuid": false,
2026-08-24 07:19:27.182751 | instance |     "mimetype": "unknown",
2026-08-24 07:19:27.182775 | instance |     "mode": "0755",
2026-08-24 07:19:27.182799 | instance |     "mtime": 1787555946.405652,
2026-08-24 07:19:27.182824 | instance |     "nlink": 23,
2026-08-24 07:19:27.182848 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-08-24 07:19:27.182873 | instance |     "pw_name": "zuul",
2026-08-24 07:19:27.182898 | instance |     "readable": true,
2026-08-24 07:19:27.182922 | instance |     "rgrp": true,
2026-08-24 07:19:27.182945 | instance |     "roth": true,
2026-08-24 07:19:27.182978 | instance |     "rusr": true,
2026-08-24 07:19:27.183003 | instance |     "size": 4096,
2026-08-24 07:19:27.183027 | instance |     "uid": 1000,
2026-08-24 07:19:27.183051 | instance |     "version": "2207222727",
2026-08-24 07:19:27.183077 | instance |     "wgrp": false,
2026-08-24 07:19:27.183103 | instance |     "woth": false,
2026-08-24 07:19:27.183129 | instance |     "writeable": true,
2026-08-24 07:19:27.183154 | instance |     "wusr": true,
2026-08-24 07:19:27.183178 | instance |     "xgrp": true,
2026-08-24 07:19:27.183202 | instance |     "xoth": true,
2026-08-24 07:19:27.183226 | instance |     "xusr": true
2026-08-24 07:19:27.183250 | instance |   }
2026-08-24 07:19:27.183275 | instance | }
2026-08-24 07:19:27.183322 | instance | ok: All items complete
2026-08-24 07:19:27.183352 | 
2026-08-24 07:19:27.185942 | instance | skipping: Conditional result was False
2026-08-24 07:19:27.186768 | instance | skipping: Conditional result was False
2026-08-24 07:19:27.202329 | 
2026-08-24 07:19:27.202493 | LOOP [Switch "ansible_host" to private IP]
2026-08-24 07:19:27.578426 | instance | changed: 1 replacements made
2026-08-24 07:19:27.580073 | instance | skipping: Conditional result was False
2026-08-24 07:19:27.581977 | instance | skipping: Conditional result was False
2026-08-24 07:19:27.598179 | 
2026-08-24 07:19:27.598303 | TASK [Run Molecule scenario]
2026-08-24 07:19:28.519454 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-08-24 07:19:28.911292 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-08-24 07:19:28.911395 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-08-24 07:19:40.227022 | instance | INFO     [csi > dependency] Executing
2026-08-24 07:19:40.227189 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-08-24 07:19:40.227378 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-08-24 07:19:40.227483 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-08-24 07:19:40.236725 | instance | INFO     [csi > cleanup] Executing
2026-08-24 07:19:40.237050 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-24 07:19:40.244780 | instance | INFO     [csi > destroy] Executing
2026-08-24 07:19:40.244814 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-08-24 07:19:40.244920 | instance | INFO     [csi > destroy] Executed: Successful
2026-08-24 07:19:40.252622 | instance | INFO     [csi > syntax] Executing
2026-08-24 07:19:41.863501 | instance |
2026-08-24 07:19:41.863786 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-24 07:19:41.937034 | instance | INFO     [csi > syntax] Executed: Successful
2026-08-24 07:19:41.952598 | instance | INFO     [csi > create] Executing
2026-08-24 07:19:41.954907 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-24 07:19:41.962683 | instance | INFO     [csi > prepare] Executing
2026-08-24 07:19:42.758462 | instance |
2026-08-24 07:19:42.758709 | instance | PLAY [Prepare] *****************************************************************
2026-08-24 07:19:42.758970 | instance |
2026-08-24 07:19:42.759253 | instance | TASK [Gathering Facts] *********************************************************
2026-08-24 07:19:42.759555 | instance | Monday 24 August 2026  07:19:42 +0000 (0:00:00.027)       0:00:00.027 *********
2026-08-24 07:19:43.912462 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-24 07:19:43.912648 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-24 07:19:43.912927 | instance | interpreter could change the meaning of that path. See
2026-08-24 07:19:43.913189 | instance | https://docs.ansible.com/ansible-
2026-08-24 07:19:43.913461 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-24 07:19:43.921023 | instance | ok: [instance]
2026-08-24 07:19:43.921251 | instance |
2026-08-24 07:19:43.921524 | instance | TASK [Configure short hostname] ************************************************
2026-08-24 07:19:43.921837 | instance | Monday 24 August 2026  07:19:43 +0000 (0:00:01.163)       0:00:01.191 *********
2026-08-24 07:19:44.636748 | instance | changed: [instance]
2026-08-24 07:19:44.636949 | instance |
2026-08-24 07:19:44.637229 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-08-24 07:19:44.637509 | instance | Monday 24 August 2026  07:19:44 +0000 (0:00:00.714)       0:00:01.905 *********
2026-08-24 07:19:44.903818 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-08-24 07:19:44.904040 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-08-24 07:19:44.904361 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-08-24 07:19:44.914690 | instance | changed: [instance]
2026-08-24 07:19:44.914953 | instance |
2026-08-24 07:19:44.915235 | instance | TASK [Purge "snapd" package] ***************************************************
2026-08-24 07:19:44.915515 | instance | Monday 24 August 2026  07:19:44 +0000 (0:00:00.278)       0:00:02.184 *********
2026-08-24 07:19:45.681732 | instance | ok: [instance]
2026-08-24 07:19:45.681847 | instance |
2026-08-24 07:19:45.681860 | instance | PLAY [Create devices for Ceph] *************************************************
2026-08-24 07:19:45.681983 | instance |
2026-08-24 07:19:45.682096 | instance | TASK [Gathering Facts] *********************************************************
2026-08-24 07:19:45.682224 | instance | Monday 24 August 2026  07:19:45 +0000 (0:00:00.767)       0:00:02.951 *********
2026-08-24 07:19:46.380080 | instance | ok: [instance]
2026-08-24 07:19:46.380201 | instance |
2026-08-24 07:19:46.380368 | instance | TASK [Install depedencies] *****************************************************
2026-08-24 07:19:46.380545 | instance | Monday 24 August 2026  07:19:46 +0000 (0:00:00.698)       0:00:03.650 *********
2026-08-24 07:20:07.149528 | instance | changed: [instance]
2026-08-24 07:20:07.149826 | instance |
2026-08-24 07:20:07.150127 | instance | TASK [Start up service] ********************************************************
2026-08-24 07:20:07.150466 | instance | Monday 24 August 2026  07:20:07 +0000 (0:00:20.769)       0:00:24.419 *********
2026-08-24 07:20:07.678409 | instance | ok: [instance]
2026-08-24 07:20:07.678654 | instance |
2026-08-24 07:20:07.678971 | instance | TASK [Generate lvm.conf] *******************************************************
2026-08-24 07:20:07.679269 | instance | Monday 24 August 2026  07:20:07 +0000 (0:00:00.528)       0:00:24.948 *********
2026-08-24 07:20:07.969967 | instance | ok: [instance]
2026-08-24 07:20:07.970221 | instance |
2026-08-24 07:20:07.970516 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-08-24 07:20:07.970820 | instance | Monday 24 August 2026  07:20:07 +0000 (0:00:00.291)       0:00:25.239 *********
2026-08-24 07:20:08.618610 | instance | changed: [instance]
2026-08-24 07:20:08.618660 | instance |
2026-08-24 07:20:08.618667 | instance | TASK [Get list of all loopback devices] ****************************************
2026-08-24 07:20:08.618674 | instance | Monday 24 August 2026  07:20:08 +0000 (0:00:00.647)       0:00:25.887 *********
2026-08-24 07:20:08.805358 | instance | ok: [instance]
2026-08-24 07:20:08.805694 | instance |
2026-08-24 07:20:08.805756 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-08-24 07:20:08.805927 | instance | Monday 24 August 2026  07:20:08 +0000 (0:00:00.187)       0:00:26.075 *********
2026-08-24 07:20:08.826661 | instance | skipping: [instance]
2026-08-24 07:20:08.827065 | instance |
2026-08-24 07:20:08.827109 | instance | TASK [Create devices for Ceph] *************************************************
2026-08-24 07:20:08.827115 | instance | Monday 24 August 2026  07:20:08 +0000 (0:00:00.021)       0:00:26.096 *********
2026-08-24 07:20:09.351038 | instance | changed: [instance] => (item=osd0)
2026-08-24 07:20:09.351950 | instance | changed: [instance] => (item=osd1)
2026-08-24 07:20:09.351993 | instance | changed: [instance] => (item=osd2)
2026-08-24 07:20:09.352001 | instance |
2026-08-24 07:20:09.352008 | instance | TASK [Set permissions on loopback devices] *************************************
2026-08-24 07:20:09.352015 | instance | Monday 24 August 2026  07:20:09 +0000 (0:00:00.524)       0:00:26.621 *********
2026-08-24 07:20:09.964677 | instance | changed: [instance] => (item=osd0)
2026-08-24 07:20:09.964776 | instance | changed: [instance] => (item=osd1)
2026-08-24 07:20:09.965528 | instance | changed: [instance] => (item=osd2)
2026-08-24 07:20:09.965627 | instance |
2026-08-24 07:20:09.965640 | instance | TASK [Start loop devices] ******************************************************
2026-08-24 07:20:09.965648 | instance | Monday 24 August 2026  07:20:09 +0000 (0:00:00.613)       0:00:27.234 *********
2026-08-24 07:20:10.652614 | instance | changed: [instance] => (item=osd0)
2026-08-24 07:20:10.652734 | instance | changed: [instance] => (item=osd1)
2026-08-24 07:20:10.653412 | instance | changed: [instance] => (item=osd2)
2026-08-24 07:20:10.653474 | instance |
2026-08-24 07:20:10.653482 | instance | TASK [Create a volume group for each loop device] ******************************
2026-08-24 07:20:10.653489 | instance | Monday 24 August 2026  07:20:10 +0000 (0:00:00.688)       0:00:27.922 *********
2026-08-24 07:20:13.879568 | instance | changed: [instance] => (item=osd0)
2026-08-24 07:20:13.879689 | instance | changed: [instance] => (item=osd1)
2026-08-24 07:20:13.879701 | instance | changed: [instance] => (item=osd2)
2026-08-24 07:20:13.879711 | instance |
2026-08-24 07:20:13.879722 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-08-24 07:20:13.879732 | instance | Monday 24 August 2026  07:20:13 +0000 (0:00:03.226)       0:00:31.148 *********
2026-08-24 07:20:15.798118 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-08-24 07:20:15.798807 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-08-24 07:20:15.798850 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-08-24 07:20:15.799225 | instance |
2026-08-24 07:20:15.799245 | instance | PLAY RECAP *********************************************************************
2026-08-24 07:20:15.801749 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-08-24 07:20:15.801839 | instance |
2026-08-24 07:20:15.801854 | instance | Monday 24 August 2026  07:20:15 +0000 (0:00:01.919)       0:00:33.068 *********
2026-08-24 07:20:15.801865 | instance | ===============================================================================
2026-08-24 07:20:15.801875 | instance | Install depedencies ---------------------------------------------------- 20.77s
2026-08-24 07:20:15.801885 | instance | Create a volume group for each loop device ------------------------------ 3.23s
2026-08-24 07:20:15.801894 | instance | Create a logical volume for each loop device ---------------------------- 1.92s
2026-08-24 07:20:15.801905 | instance | Gathering Facts --------------------------------------------------------- 1.16s
2026-08-24 07:20:15.801914 | instance | Purge "snapd" package --------------------------------------------------- 0.77s
2026-08-24 07:20:15.801934 | instance | Configure short hostname ------------------------------------------------ 0.71s
2026-08-24 07:20:15.802170 | instance | Gathering Facts --------------------------------------------------------- 0.70s
2026-08-24 07:20:15.802553 | instance | Start loop devices ------------------------------------------------------ 0.69s
2026-08-24 07:20:15.802892 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.65s
2026-08-24 07:20:15.803226 | instance | Set permissions on loopback devices ------------------------------------- 0.61s
2026-08-24 07:20:15.803553 | instance | Start up service -------------------------------------------------------- 0.53s
2026-08-24 07:20:15.803877 | instance | Create devices for Ceph ------------------------------------------------- 0.52s
2026-08-24 07:20:15.804199 | instance | Generate lvm.conf ------------------------------------------------------- 0.29s
2026-08-24 07:20:15.804613 | instance | Ensure hostname inside hosts file --------------------------------------- 0.28s
2026-08-24 07:20:15.804998 | instance | Get list of all loopback devices ---------------------------------------- 0.19s
2026-08-24 07:20:15.805329 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s
2026-08-24 07:20:15.873153 | instance | INFO     [csi > prepare] Executed: Successful
2026-08-24 07:20:15.885586 | instance | INFO     [csi > converge] Executing
2026-08-24 07:20:17.448676 | instance |
2026-08-24 07:20:17.448977 | instance | PLAY [Debug CSI driver value] **************************************************
2026-08-24 07:20:17.449191 | instance |
2026-08-24 07:20:17.449410 | instance | TASK [Gathering Facts] *********************************************************
2026-08-24 07:20:17.449727 | instance | Monday 24 August 2026  07:20:17 +0000 (0:00:00.008)       0:00:00.008 *********
2026-08-24 07:20:18.399129 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-24 07:20:18.399696 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-24 07:20:18.400194 | instance | interpreter could change the meaning of that path. See
2026-08-24 07:20:18.400684 | instance | https://docs.ansible.com/ansible-
2026-08-24 07:20:18.401176 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-24 07:20:18.408677 | instance | ok: [instance]
2026-08-24 07:20:18.408902 | instance |
2026-08-24 07:20:18.409129 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-08-24 07:20:18.409372 | instance | Monday 24 August 2026  07:20:18 +0000 (0:00:00.960)       0:00:00.969 *********
2026-08-24 07:20:18.456563 | instance | ok: [instance] => {
2026-08-24 07:20:18.457106 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-08-24 07:20:18.457572 | instance | }
2026-08-24 07:20:18.458146 | instance |
2026-08-24 07:20:18.458640 | instance | PLAY [all] *********************************************************************
2026-08-24 07:20:18.458906 | instance |
2026-08-24 07:20:18.459132 | instance | TASK [Gathering Facts] *********************************************************
2026-08-24 07:20:18.459378 | instance | Monday 24 August 2026  07:20:18 +0000 (0:00:00.047)       0:00:01.016 *********
2026-08-24 07:20:19.345635 | instance | ok: [instance]
2026-08-24 07:20:19.346061 | instance |
2026-08-24 07:20:19.346419 | instance | TASK [Fail if atmosphere_ceph_enabled is set] **********************************
2026-08-24 07:20:19.346835 | instance | Monday 24 August 2026  07:20:19 +0000 (0:00:00.888)       0:00:01.905 *********
2026-08-24 07:20:19.389548 | instance | skipping: [instance]
2026-08-24 07:20:19.389965 | instance |
2026-08-24 07:20:19.390316 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-08-24 07:20:19.390755 | instance | Monday 24 August 2026  07:20:19 +0000 (0:00:00.044)       0:00:01.949 *********
2026-08-24 07:20:19.580446 | instance | ok: [instance]
2026-08-24 07:20:19.580836 | instance |
2026-08-24 07:20:19.581329 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-08-24 07:20:19.581689 | instance |
2026-08-24 07:20:19.582033 | instance | TASK [Gathering Facts] *********************************************************
2026-08-24 07:20:19.582393 | instance | Monday 24 August 2026  07:20:19 +0000 (0:00:00.190)       0:00:02.140 *********
2026-08-24 07:20:21.485119 | instance | ok: [instance]
2026-08-24 07:20:21.485399 | instance |
2026-08-24 07:20:21.485666 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-24 07:20:21.485902 | instance | Monday 24 August 2026  07:20:21 +0000 (0:00:01.904)       0:00:04.045 *********
2026-08-24 07:20:21.815525 | instance | ok: [instance]
2026-08-24 07:20:21.815560 | instance |
2026-08-24 07:20:21.815567 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-24 07:20:21.815572 | instance | Monday 24 August 2026  07:20:21 +0000 (0:00:00.330)       0:00:04.375 *********
2026-08-24 07:20:21.858451 | instance | skipping: [instance]
2026-08-24 07:20:21.858494 | instance |
2026-08-24 07:20:21.858500 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-08-24 07:20:21.858505 | instance | Monday 24 August 2026  07:20:21 +0000 (0:00:00.042)       0:00:04.418 *********
2026-08-24 07:20:22.203654 | instance | changed: [instance]
2026-08-24 07:20:22.203723 | instance |
2026-08-24 07:20:22.203737 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-24 07:20:22.203748 | instance | Monday 24 August 2026  07:20:22 +0000 (0:00:00.344)       0:00:04.762 *********
2026-08-24 07:20:22.263311 | instance | ok: [instance] => {
2026-08-24 07:20:22.263361 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-08-24 07:20:22.263368 | instance | }
2026-08-24 07:20:22.263372 | instance |
2026-08-24 07:20:22.263377 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-24 07:20:22.263580 | instance | Monday 24 August 2026  07:20:22 +0000 (0:00:00.059)       0:00:04.822 *********
2026-08-24 07:20:22.875034 | instance | changed: [instance]
2026-08-24 07:20:22.875402 | instance |
2026-08-24 07:20:22.875744 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-24 07:20:22.876078 | instance | Monday 24 August 2026  07:20:22 +0000 (0:00:00.612)       0:00:05.435 *********
2026-08-24 07:20:22.925091 | instance | skipping: [instance]
2026-08-24 07:20:22.925160 | instance |
2026-08-24 07:20:22.925322 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-24 07:20:22.925525 | instance | Monday 24 August 2026  07:20:22 +0000 (0:00:00.050)       0:00:05.485 *********
2026-08-24 07:20:22.976165 | instance | skipping: [instance]
2026-08-24 07:20:22.976251 | instance |
2026-08-24 07:20:22.976358 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-24 07:20:22.976547 | instance | Monday 24 August 2026  07:20:22 +0000 (0:00:00.051)       0:00:05.536 *********
2026-08-24 07:20:23.183648 | instance | ok: [instance]
2026-08-24 07:20:23.183725 | instance |
2026-08-24 07:20:23.183857 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-24 07:20:23.184056 | instance | Monday 24 August 2026  07:20:23 +0000 (0:00:00.207)       0:00:05.744 *********
2026-08-24 07:20:24.486051 | instance | ok: [instance]
2026-08-24 07:20:24.486279 | instance |
2026-08-24 07:20:24.486292 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-24 07:20:24.486410 | instance | Monday 24 August 2026  07:20:24 +0000 (0:00:01.298)       0:00:07.042 *********
2026-08-24 07:20:24.547377 | instance | ok: [instance] => {
2026-08-24 07:20:24.547485 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-08-24 07:20:24.547591 | instance | }
2026-08-24 07:20:24.547702 | instance |
2026-08-24 07:20:24.547831 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-24 07:20:24.547945 | instance | Monday 24 August 2026  07:20:24 +0000 (0:00:00.065)       0:00:07.108 *********
2026-08-24 07:20:25.141985 | instance | changed: [instance]
2026-08-24 07:20:25.142239 | instance |
2026-08-24 07:20:25.142528 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-24 07:20:25.142808 | instance | Monday 24 August 2026  07:20:25 +0000 (0:00:00.593)       0:00:07.701 *********
2026-08-24 07:20:28.049303 | instance | changed: [instance]
2026-08-24 07:20:28.049492 | instance |
2026-08-24 07:20:28.049804 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-08-24 07:20:28.050074 | instance | Monday 24 August 2026  07:20:28 +0000 (0:00:02.907)       0:00:10.609 *********
2026-08-24 07:20:28.079821 | instance | skipping: [instance]
2026-08-24 07:20:28.080109 | instance |
2026-08-24 07:20:28.080743 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-08-24 07:20:28.081045 | instance | Monday 24 August 2026  07:20:28 +0000 (0:00:00.030)       0:00:10.640 *********
2026-08-24 07:20:28.110967 | instance | skipping: [instance]
2026-08-24 07:20:28.111216 | instance |
2026-08-24 07:20:28.111529 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-08-24 07:20:28.111812 | instance | Monday 24 August 2026  07:20:28 +0000 (0:00:00.031)       0:00:10.671 *********
2026-08-24 07:20:28.148410 | instance | skipping: [instance]
2026-08-24 07:20:28.148734 | instance |
2026-08-24 07:20:28.148965 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-08-24 07:20:28.149348 | instance | Monday 24 August 2026  07:20:28 +0000 (0:00:00.037)       0:00:10.708 *********
2026-08-24 07:20:33.761336 | instance | changed: [instance]
2026-08-24 07:20:33.761517 | instance |
2026-08-24 07:20:33.761531 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-08-24 07:20:33.761542 | instance | Monday 24 August 2026  07:20:33 +0000 (0:00:05.611)       0:00:16.320 *********
2026-08-24 07:20:34.333540 | instance | changed: [instance]
2026-08-24 07:20:34.333613 | instance |
2026-08-24 07:20:34.333964 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-08-24 07:20:34.334008 | instance | Monday 24 August 2026  07:20:34 +0000 (0:00:00.573)       0:00:16.893 *********
2026-08-24 07:20:35.235498 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-08-24 07:20:35.235538 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-08-24 07:20:35.235544 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-08-24 07:20:35.235554 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-08-24 07:20:35.235560 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-08-24 07:20:35.235564 | instance |
2026-08-24 07:20:35.235569 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-08-24 07:20:35.235573 | instance | Monday 24 August 2026  07:20:35 +0000 (0:00:00.901)       0:00:17.795 *********
2026-08-24 07:20:35.823372 | instance | changed: [instance]
2026-08-24 07:20:35.823461 | instance |
2026-08-24 07:20:35.824179 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-08-24 07:20:35.824228 | instance | Monday 24 August 2026  07:20:35 +0000 (0:00:00.571)       0:00:18.366 *********
2026-08-24 07:20:35.824233 | instance |
2026-08-24 07:20:35.824238 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-24 07:20:35.824242 | instance | Monday 24 August 2026  07:20:35 +0000 (0:00:00.017)       0:00:18.383 *********
2026-08-24 07:20:36.777310 | instance | ok: [instance]
2026-08-24 07:20:36.777419 | instance |
2026-08-24 07:20:36.777714 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-08-24 07:20:36.777785 | instance | Monday 24 August 2026  07:20:36 +0000 (0:00:00.954)       0:00:19.337 *********
2026-08-24 07:20:37.215434 | instance | changed: [instance]
2026-08-24 07:20:37.215522 | instance |
2026-08-24 07:20:37.215822 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-08-24 07:20:37.215871 | instance | Monday 24 August 2026  07:20:37 +0000 (0:00:00.438)       0:00:19.775 *********
2026-08-24 07:20:37.755307 | instance | changed: [instance]
2026-08-24 07:20:37.755394 | instance |
2026-08-24 07:20:37.755656 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-24 07:20:37.755700 | instance | Monday 24 August 2026  07:20:37 +0000 (0:00:00.539)       0:00:20.315 *********
2026-08-24 07:20:37.968144 | instance | ok: [instance]
2026-08-24 07:20:37.968214 | instance |
2026-08-24 07:20:37.968517 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-24 07:20:37.968565 | instance | Monday 24 August 2026  07:20:37 +0000 (0:00:00.212)       0:00:20.528 *********
2026-08-24 07:20:38.022964 | instance | ok: [instance] => {
2026-08-24 07:20:38.023864 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-08-24 07:20:38.023886 | instance | }
2026-08-24 07:20:38.023893 | instance |
2026-08-24 07:20:38.023899 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-24 07:20:38.023906 | instance | Monday 24 August 2026  07:20:38 +0000 (0:00:00.054)       0:00:20.583 *********
2026-08-24 07:20:38.872063 | instance | changed: [instance]
2026-08-24 07:20:38.872186 | instance |
2026-08-24 07:20:38.872531 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-24 07:20:38.872595 | instance | Monday 24 August 2026  07:20:38 +0000 (0:00:00.849)       0:00:21.432 *********
2026-08-24 07:20:43.228350 | instance | changed: [instance]
2026-08-24 07:20:43.228413 | instance |
2026-08-24 07:20:43.228420 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-08-24 07:20:43.228425 | instance | Monday 24 August 2026  07:20:43 +0000 (0:00:04.355)       0:00:25.788 *********
2026-08-24 07:20:44.447699 | instance | ok: [instance]
2026-08-24 07:20:44.447995 | instance |
2026-08-24 07:20:44.448008 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-08-24 07:20:44.448022 | instance | Monday 24 August 2026  07:20:44 +0000 (0:00:01.219)       0:00:27.008 *********
2026-08-24 07:20:44.815488 | instance | changed: [instance]
2026-08-24 07:20:44.815542 | instance |
2026-08-24 07:20:44.815549 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-08-24 07:20:44.815554 | instance | Monday 24 August 2026  07:20:44 +0000 (0:00:00.366)       0:00:27.374 *********
2026-08-24 07:20:45.277165 | instance | changed: [instance]
2026-08-24 07:20:45.277268 | instance |
2026-08-24 07:20:45.277284 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-08-24 07:20:45.277463 | instance | Monday 24 August 2026  07:20:45 +0000 (0:00:00.462)       0:00:27.837 *********
2026-08-24 07:20:45.879800 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-08-24 07:20:45.879887 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-08-24 07:20:45.880567 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-08-24 07:20:45.880640 | instance |
2026-08-24 07:20:45.880646 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-08-24 07:20:45.880652 | instance | Monday 24 August 2026  07:20:45 +0000 (0:00:00.602)       0:00:28.439 *********
2026-08-24 07:20:46.334744 | instance | changed: [instance]
2026-08-24 07:20:46.334828 | instance |
2026-08-24 07:20:46.335122 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-08-24 07:20:46.335191 | instance | Monday 24 August 2026  07:20:46 +0000 (0:00:00.454)       0:00:28.894 *********
2026-08-24 07:20:46.827161 | instance | changed: [instance]
2026-08-24 07:20:46.827275 | instance |
2026-08-24 07:20:46.827342 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-08-24 07:20:46.827859 | instance | Monday 24 August 2026  07:20:46 +0000 (0:00:00.476)       0:00:29.370 *********
2026-08-24 07:20:46.827904 | instance |
2026-08-24 07:20:46.827910 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-24 07:20:46.827920 | instance | Monday 24 August 2026  07:20:46 +0000 (0:00:00.016)       0:00:29.387 *********
2026-08-24 07:20:47.556838 | instance | ok: [instance]
2026-08-24 07:20:47.556908 | instance |
2026-08-24 07:20:47.557173 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-08-24 07:20:47.557218 | instance | Monday 24 August 2026  07:20:47 +0000 (0:00:00.729)       0:00:30.117 *********
2026-08-24 07:20:48.395297 | instance | changed: [instance]
2026-08-24 07:20:48.395390 | instance |
2026-08-24 07:20:48.395630 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-08-24 07:20:48.395678 | instance | Monday 24 August 2026  07:20:48 +0000 (0:00:00.838)       0:00:30.955 *********
2026-08-24 07:20:48.970239 | instance | changed: [instance]
2026-08-24 07:20:48.970272 | instance |
2026-08-24 07:20:48.970278 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-08-24 07:20:48.970283 | instance | Monday 24 August 2026  07:20:48 +0000 (0:00:00.574)       0:00:31.530 *********
2026-08-24 07:20:49.023998 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-08-24 07:20:49.024057 | instance |
2026-08-24 07:20:49.024065 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-08-24 07:20:49.024072 | instance | Monday 24 August 2026  07:20:49 +0000 (0:00:00.053)       0:00:31.583 *********
2026-08-24 07:20:54.091436 | instance | changed: [instance]
2026-08-24 07:20:54.091627 | instance |
2026-08-24 07:20:54.092127 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-08-24 07:20:54.092153 | instance | Monday 24 August 2026  07:20:54 +0000 (0:00:05.067)       0:00:36.650 *********
2026-08-24 07:20:54.788278 | instance | ok: [instance] => (item=chronyd)
2026-08-24 07:20:54.788338 | instance | ok: [instance] => (item=sshd)
2026-08-24 07:20:54.788350 | instance |
2026-08-24 07:20:54.788360 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-08-24 07:20:54.788370 | instance | Monday 24 August 2026  07:20:54 +0000 (0:00:00.696)       0:00:37.347 *********
2026-08-24 07:20:55.599590 | instance | changed: [instance]
2026-08-24 07:20:55.599656 | instance |
2026-08-24 07:20:55.599669 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-08-24 07:20:55.599680 | instance | Monday 24 August 2026  07:20:55 +0000 (0:00:00.811)       0:00:38.158 *********
2026-08-24 07:20:55.800035 | instance | ok: [instance]
2026-08-24 07:20:55.800538 | instance |
2026-08-24 07:20:55.800558 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-08-24 07:20:55.800566 | instance | Monday 24 August 2026  07:20:55 +0000 (0:00:00.201)       0:00:38.360 *********
2026-08-24 07:20:56.232663 | instance | changed: [instance]
2026-08-24 07:20:56.232739 | instance |
2026-08-24 07:20:56.233086 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-08-24 07:20:56.233150 | instance | Monday 24 August 2026  07:20:56 +0000 (0:00:00.432)       0:00:38.792 *********
2026-08-24 07:20:56.613373 | instance | changed: [instance]
2026-08-24 07:20:56.613489 | instance |
2026-08-24 07:20:56.613858 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-08-24 07:20:56.613954 | instance | Monday 24 August 2026  07:20:56 +0000 (0:00:00.380)       0:00:39.173 *********
2026-08-24 07:20:56.840841 | instance | ok: [instance]
2026-08-24 07:20:56.840931 | instance |
2026-08-24 07:20:56.841006 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-08-24 07:20:56.841194 | instance | Monday 24 August 2026  07:20:56 +0000 (0:00:00.227)       0:00:39.400 *********
2026-08-24 07:20:57.067012 | instance | ok: [instance] => (item=instance)
2026-08-24 07:20:57.067130 | instance |
2026-08-24 07:20:57.067196 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-08-24 07:20:57.067374 | instance | Monday 24 August 2026  07:20:57 +0000 (0:00:00.226)       0:00:39.626 *********
2026-08-24 07:20:57.125984 | instance | ok: [instance]
2026-08-24 07:20:57.126076 | instance |
2026-08-24 07:20:57.126096 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-08-24 07:20:57.126214 | instance | Monday 24 August 2026  07:20:57 +0000 (0:00:00.058)       0:00:39.685 *********
2026-08-24 07:20:57.205135 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-08-24 07:20:57.205235 | instance |
2026-08-24 07:20:57.205302 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-08-24 07:20:57.205468 | instance | Monday 24 August 2026  07:20:57 +0000 (0:00:00.079)       0:00:39.764 *********
2026-08-24 07:20:57.481361 | instance | changed: [instance]
2026-08-24 07:20:57.481437 | instance |
2026-08-24 07:20:57.481775 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-08-24 07:20:57.481839 | instance | Monday 24 August 2026  07:20:57 +0000 (0:00:00.276)       0:00:40.041 *********
2026-08-24 07:20:58.201075 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-08-24 07:20:58.201185 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-08-24 07:20:58.201698 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-08-24 07:20:58.201750 | instance |
2026-08-24 07:20:58.201756 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-08-24 07:20:58.201762 | instance | Monday 24 August 2026  07:20:58 +0000 (0:00:00.719)       0:00:40.761 *********
2026-08-24 07:22:24.565878 | instance | ok: [instance]
2026-08-24 07:22:24.565945 | instance |
2026-08-24 07:22:24.566231 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-08-24 07:22:24.566276 | instance | Monday 24 August 2026  07:22:24 +0000 (0:01:26.364)       0:02:07.126 *********
2026-08-24 07:22:24.792593 | instance | changed: [instance]
2026-08-24 07:22:24.792668 | instance |
2026-08-24 07:22:24.792795 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-08-24 07:22:24.792917 | instance | Monday 24 August 2026  07:22:24 +0000 (0:00:00.226)       0:02:07.353 *********
2026-08-24 07:22:24.835317 | instance | ok: [instance]
2026-08-24 07:22:24.835405 | instance |
2026-08-24 07:22:24.835528 | instance | TASK [Install Ceph host] *******************************************************
2026-08-24 07:22:24.835654 | instance | Monday 24 August 2026  07:22:24 +0000 (0:00:00.042)       0:02:07.395 *********
2026-08-24 07:22:24.916688 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-08-24 07:22:24.916768 | instance |
2026-08-24 07:22:24.916998 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-08-24 07:22:24.917036 | instance | Monday 24 August 2026  07:22:24 +0000 (0:00:00.081)       0:02:07.477 *********
2026-08-24 07:22:26.522222 | instance | ok: [instance]
2026-08-24 07:22:26.522366 | instance |
2026-08-24 07:22:26.522511 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-08-24 07:22:26.522623 | instance | Monday 24 August 2026  07:22:26 +0000 (0:00:01.605)       0:02:09.082 *********
2026-08-24 07:22:26.583910 | instance | ok: [instance] => (item=instance)
2026-08-24 07:22:26.584042 | instance |
2026-08-24 07:22:26.584221 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-08-24 07:22:26.584377 | instance | Monday 24 August 2026  07:22:26 +0000 (0:00:00.062)       0:02:09.144 *********
2026-08-24 07:22:26.936780 | instance | ok: [instance]
2026-08-24 07:22:26.936915 | instance |
2026-08-24 07:22:26.937107 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-08-24 07:22:26.937368 | instance | Monday 24 August 2026  07:22:26 +0000 (0:00:00.352)       0:02:09.496 *********
2026-08-24 07:22:29.357928 | instance | ok: [instance]
2026-08-24 07:22:29.357997 | instance |
2026-08-24 07:22:29.358269 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-08-24 07:22:29.358318 | instance | Monday 24 August 2026  07:22:29 +0000 (0:00:02.421)       0:02:11.918 *********
2026-08-24 07:23:23.271933 | instance | An exception occurred during task execution. To see the full traceback, use -vvv. The error was: [errno 5] RADOS I/O error (error connecting to the cluster)
2026-08-24 07:23:23.273003 | 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_6_ljqckw/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_6_ljqckw/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_6_ljqckw/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_6_ljqckw/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-24T07:23:23.096+0000 7f4253074640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAG8YtqQ0I2GiAAwQ6rJijY85HDjerxDU85+IuaIbUY1k/dn+ExHO7ZDo0=: Malformed input [buffer:3]\n2026-08-24T07:23:23.096+0000 7f4253074640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T07:23:23.100+0000 7f4253074640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAG8YtqQ0I2GiAAwQ6rJijY85HDjerxDU85+IuaIbUY1k/dn+ExHO7ZDo0=: Malformed input [buffer:3]\n2026-08-24T07:23:23.100+0000 7f4253074640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T07:23:23.100+0000 7f4253074640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAG8YtqQ0I2GiAAwQ6rJijY85HDjerxDU85+IuaIbUY1k/dn+ExHO7ZDo0=: Malformed input [buffer:3]\n2026-08-24T07:23:23.100+0000 7f4253074640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T07:23:23.100+0000 7f4253074640 -1 monclient: keyring not found\n[errno 5] RADOS I/O error (error connecting to the cluster)\n\n", "module_stdout": "", "msg": "MODULE FAILURE\nSee stdout/stderr for the exact error", "rc": 1}
2026-08-24 07:23:23.276518 | instance |
2026-08-24 07:23:23.277736 | instance | PLAY RECAP *********************************************************************
2026-08-24 07:23:23.277832 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=7    rescued=0    ignored=0
2026-08-24 07:23:23.277846 | instance |
2026-08-24 07:23:23.277859 | instance | Monday 24 August 2026  07:23:23 +0000 (0:00:53.918)       0:03:05.837 *********
2026-08-24 07:23:23.277870 | instance | ===============================================================================
2026-08-24 07:23:23.277881 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 86.36s
2026-08-24 07:23:23.277892 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 53.92s
2026-08-24 07:23:23.277913 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 5.61s
2026-08-24 07:23:23.277924 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 5.07s
2026-08-24 07:23:23.279713 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.36s
2026-08-24 07:23:23.279775 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.91s
2026-08-24 07:23:23.279797 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.42s
2026-08-24 07:23:23.279802 | instance | Gathering Facts --------------------------------------------------------- 1.90s
2026-08-24 07:23:23.279806 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.68s
2026-08-24 07:23:23.279810 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.61s
2026-08-24 07:23:23.279815 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.30s
2026-08-24 07:23:23.279819 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.22s
2026-08-24 07:23:23.279823 | instance | Gathering Facts --------------------------------------------------------- 0.96s
2026-08-24 07:23:23.279827 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.90s
2026-08-24 07:23:23.279831 | instance | Gathering Facts --------------------------------------------------------- 0.89s
2026-08-24 07:23:23.279836 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.85s
2026-08-24 07:23:23.279840 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 0.84s
2026-08-24 07:23:23.279844 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 0.81s
2026-08-24 07:23:23.279848 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.72s
2026-08-24 07:23:23.279870 | instance | vexxhost.ceph.cephadm : Ensure services are started --------------------- 0.70s
2026-08-24 07:23:23.424551 | instance | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-24 07:23:23.424864 | instance | ERROR    [csi > converge] Executed: Failed
2026-08-24 07:23:23.425051 | instance | ERROR    Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-24 07:23:23.957515 | instance | ERROR
2026-08-24 07:23:23.957690 | instance | {
2026-08-24 07:23:23.957721 | instance |   "delta": "0:03:55.551414",
2026-08-24 07:23:23.957742 | instance |   "end": "2026-08-24 07:23:23.498978",
2026-08-24 07:23:23.957761 | instance |   "msg": "non-zero return code",
2026-08-24 07:23:23.957780 | instance |   "rc": 2,
2026-08-24 07:23:23.957798 | instance |   "start": "2026-08-24 07:19:27.947564"
2026-08-24 07:23:23.957816 | instance | }
failure
2026-08-24 07:23:23.962707 | 
2026-08-24 07:23:23.962756 | PLAY RECAP
2026-08-24 07:23:23.962803 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-08-24 07:23:23.962826 | 
2026-08-24 07:23:24.176450 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-24 07:23:24.180542 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-24 07:23:25.087732 | 
2026-08-24 07:23:25.195967 | PLAY [all]
2026-08-24 07:23:25.221018 | 
2026-08-24 07:23:25.221201 | TASK [gather-host-logs : creating directory for system status]
2026-08-24 07:23:26.428369 | instance | changed
2026-08-24 07:23:26.433530 | 
2026-08-24 07:23:26.433607 | TASK [gather-host-logs : Get logs for each host]
2026-08-24 07:23:27.915702 | instance | + systemd-cgls --full --all --no-pager
2026-08-24 07:23:27.929527 | instance | + ip addr
2026-08-24 07:23:27.931097 | instance | + ip route
2026-08-24 07:23:27.933444 | instance | + lsblk
2026-08-24 07:23:27.939206 | instance | + mount
2026-08-24 07:23:27.941766 | instance | + docker images
2026-08-24 07:23:27.963159 | instance | + brctl show
2026-08-24 07:23:27.963730 | instance | /bin/bash: line 8: brctl: command not found
2026-08-24 07:23:27.964049 | instance | + ps aux --sort=-%mem
2026-08-24 07:23:27.979090 | instance | + dpkg -l
2026-08-24 07:23:27.989839 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-08-24 07:23:27.990292 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-08-24 07:23:28.011227 | instance | + '[' '!' -z '' ']'
2026-08-24 07:23:28.470560 | instance | ok: Runtime: 0:00:00.100876
2026-08-24 07:23:28.478691 | 
2026-08-24 07:23:28.478814 | TASK [gather-host-logs : Downloads logs to executor]
2026-08-24 07:23:29.314302 | instance | changed:
2026-08-24 07:23:29.314638 | instance | created directory /var/lib/zuul/builds/c5238c1c7946401fa7a92baf8df6a185/work/logs/instance
2026-08-24 07:23:29.314694 | instance | cd+++++++++ system/
2026-08-24 07:23:29.314729 | instance | >f+++++++++ system/brctl-show.txt
2026-08-24 07:23:29.314768 | instance | >f+++++++++ system/docker-images.txt
2026-08-24 07:23:29.314800 | instance | >f+++++++++ system/ip-addr.txt
2026-08-24 07:23:29.314836 | instance | >f+++++++++ system/ip-route.txt
2026-08-24 07:23:29.314869 | instance | >f+++++++++ system/lsblk.txt
2026-08-24 07:23:29.314905 | instance | >f+++++++++ system/mount.txt
2026-08-24 07:23:29.314943 | instance | >f+++++++++ system/packages.txt
2026-08-24 07:23:29.314976 | instance | >f+++++++++ system/ps.txt
2026-08-24 07:23:29.315015 | instance | >f+++++++++ system/systemd-cgls.txt
2026-08-24 07:23:29.326639 | 
2026-08-24 07:23:29.326721 | LOOP [helm-release-status : creating directory for helm release status]
2026-08-24 07:23:29.522410 | instance | changed: "values"
2026-08-24 07:23:29.694786 | instance | changed: "releases"
2026-08-24 07:23:29.714641 | 
2026-08-24 07:23:29.714838 | TASK [helm-release-status : Gather get release status for helm charts]
2026-08-24 07:23:29.923742 | instance | /bin/bash: line 3: kubectl: command not found
2026-08-24 07:23:30.250745 | instance | ok: Runtime: 0:00:00.005716
2026-08-24 07:23:30.258740 | 
2026-08-24 07:23:30.258816 | TASK [helm-release-status : Downloads logs to executor]
2026-08-24 07:23:30.751531 | instance | changed:
2026-08-24 07:23:30.751769 | instance | cd+++++++++ helm/
2026-08-24 07:23:30.751797 | instance | cd+++++++++ helm/releases/
2026-08-24 07:23:30.751823 | instance | cd+++++++++ helm/values/
2026-08-24 07:23:30.761112 | 
2026-08-24 07:23:30.761187 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-08-24 07:23:30.959581 | instance | changed
2026-08-24 07:23:30.967641 | 
2026-08-24 07:23:30.967725 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-08-24 07:23:31.210592 | instance | xargs: xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-24 07:23:31.210715 | instance | warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-24 07:23:31.216372 | instance | environment: line 1: kubectl: command not found
2026-08-24 07:23:31.217687 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-24 07:23:31.218761 | instance | environment: line 1: kubectl: command not found
2026-08-24 07:23:31.220501 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-24 07:23:31.221647 | instance | environment: line 1: kubectl: command not found
2026-08-24 07:23:31.223166 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-24 07:23:31.223212 | instance | environment: line 1: kubectl: command not found
2026-08-24 07:23:31.224667 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-24 07:23:31.225836 | instance | environment: line 1: kubectl: command not found
2026-08-24 07:23:31.226874 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-24 07:23:31.506030 | instance | ok: Runtime: 0:00:00.026221
2026-08-24 07:23:31.512325 | 
2026-08-24 07:23:31.512466 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-08-24 07:23:31.712337 | instance | changed
2026-08-24 07:23:31.721351 | 
2026-08-24 07:23:31.721423 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-08-24 07:23:31.924180 | instance | environment: line 5: kubectl: command not found
2026-08-24 07:23:31.924555 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-24 07:23:31.924813 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-24 07:23:31.925313 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-24 07:23:32.254077 | instance | ok: Runtime: 0:00:00.009053
2026-08-24 07:23:32.259689 | 
2026-08-24 07:23:32.259752 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-08-24 07:23:32.738079 | instance | changed:
2026-08-24 07:23:32.738251 | instance | cd+++++++++ objects/
2026-08-24 07:23:32.738289 | instance | cd+++++++++ objects/cluster/
2026-08-24 07:23:32.738321 | instance | cd+++++++++ objects/namespaced/
2026-08-24 07:23:32.748690 | 
2026-08-24 07:23:32.748754 | TASK [gather-pod-logs : creating directory for pod logs]
2026-08-24 07:23:32.942635 | instance | changed
2026-08-24 07:23:32.948172 | 
2026-08-24 07:23:32.948245 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-08-24 07:23:33.144600 | instance | changed
2026-08-24 07:23:33.149240 | 
2026-08-24 07:23:33.149306 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-08-24 07:23:33.359916 | instance | environment: line 3: kubectl: command not found
2026-08-24 07:23:33.682154 | instance | ok: Runtime: 0:00:00.009780
2026-08-24 07:23:33.687806 | 
2026-08-24 07:23:33.687873 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-08-24 07:23:34.167125 | instance | changed:
2026-08-24 07:23:34.167381 | instance | cd+++++++++ pod-logs/
2026-08-24 07:23:34.167468 | instance | cd+++++++++ pod-logs/failed-pods/
2026-08-24 07:23:34.177616 | 
2026-08-24 07:23:34.177681 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-08-24 07:23:34.383075 | instance | changed
2026-08-24 07:23:34.388489 | 
2026-08-24 07:23:34.388553 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-08-24 07:23:34.595103 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-24 07:23:34.922887 | instance | ok: Runtime: 0:00:00.039316
2026-08-24 07:23:34.928819 | 
2026-08-24 07:23:34.928903 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-08-24 07:23:35.129940 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-24 07:23:35.162934 | instance | ceph-mgr endpoints:
2026-08-24 07:23:35.463363 | instance | ok: Runtime: 0:00:00.039722
2026-08-24 07:23:35.469815 | 
2026-08-24 07:23:35.469879 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-08-24 07:23:35.678672 | instance | /bin/bash: line 4: kubectl: command not found
2026-08-24 07:23:36.004138 | instance | ok: Runtime: 0:00:00.039365
2026-08-24 07:23:36.009667 | 
2026-08-24 07:23:36.009742 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-08-24 07:23:36.479077 | instance | changed: cd+++++++++ prometheus/
2026-08-24 07:23:36.488653 | 
2026-08-24 07:23:36.488714 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-08-24 07:23:36.685639 | instance | changed
2026-08-24 07:23:36.690319 | 
2026-08-24 07:23:36.690381 | TASK [gather-selenium-data : Get selenium data]
2026-08-24 07:23:36.937447 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-08-24 07:23:36.939133 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-08-24 07:23:37.224295 | instance | ERROR
2026-08-24 07:23:37.224552 | instance | {
2026-08-24 07:23:37.224618 | instance |   "delta": "0:00:00.007319",
2026-08-24 07:23:37.224665 | instance |   "end": "2026-08-24 07:23:36.939567",
2026-08-24 07:23:37.224712 | instance |   "msg": "non-zero return code",
2026-08-24 07:23:37.224755 | instance |   "rc": 1,
2026-08-24 07:23:37.224797 | instance |   "start": "2026-08-24 07:23:36.932248"
2026-08-24 07:23:37.224837 | instance | }
2026-08-24 07:23:37.224889 | instance | ERROR: Ignoring Errors
2026-08-24 07:23:37.230177 | 
2026-08-24 07:23:37.230237 | TASK [gather-selenium-data : Downloads logs to executor]
2026-08-24 07:23:37.717095 | instance | changed: cd+++++++++ selenium/
2026-08-24 07:23:37.724293 | 
2026-08-24 07:23:37.724355 | PLAY RECAP
2026-08-24 07:23:37.724412 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-08-24 07:23:37.724442 | 
2026-08-24 07:23:37.824647 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-24 07:23:37.826753 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-24 07:23:38.396815 | 
2026-08-24 07:23:38.396921 | PLAY [all]
2026-08-24 07:23:38.408087 | 
2026-08-24 07:23:38.408159 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-24 07:23:38.452150 | instance | skipping: Conditional result was False
2026-08-24 07:23:38.457311 | 
2026-08-24 07:23:38.457389 | TASK [fetch-output : Set log path for single node]
2026-08-24 07:23:38.495545 | instance | ok
2026-08-24 07:23:38.499963 | 
2026-08-24 07:23:38.500024 | LOOP [fetch-output : Ensure local output dirs]
2026-08-24 07:23:38.835104 | instance -> localhost | ok: "/var/lib/zuul/builds/c5238c1c7946401fa7a92baf8df6a185/work/logs"
2026-08-24 07:23:39.031081 | instance -> localhost | changed: "/var/lib/zuul/builds/c5238c1c7946401fa7a92baf8df6a185/work/artifacts"
2026-08-24 07:23:39.242181 | instance -> localhost | changed: "/var/lib/zuul/builds/c5238c1c7946401fa7a92baf8df6a185/work/docs"
2026-08-24 07:23:39.257299 | 
2026-08-24 07:23:39.257419 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-24 07:23:39.930402 | instance | changed: .d..t...... ./
2026-08-24 07:23:39.930626 | instance | changed: All items complete
2026-08-24 07:23:39.930666 | 
2026-08-24 07:23:40.387115 | instance | changed: .d..t...... ./
2026-08-24 07:23:40.829699 | instance | changed: .d..t...... ./
2026-08-24 07:23:40.852353 | 
2026-08-24 07:23:40.852483 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-24 07:23:41.405382 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.139645
2026-08-24 07:23:41.606637 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.006834
2026-08-24 07:23:41.622458 | 
2026-08-24 07:23:41.622582 | PLAY [all]
2026-08-24 07:23:41.629541 | 
2026-08-24 07:23:41.629605 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-24 07:23:42.057970 | instance | changed
2026-08-24 07:23:42.064908 | 
2026-08-24 07:23:42.064954 | PLAY RECAP
2026-08-24 07:23:42.065014 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-24 07:23:42.065041 | 
2026-08-24 07:23:42.163756 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-24 07:23:42.168552 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-24 07:23:42.720341 | 
2026-08-24 07:23:42.720459 | PLAY [localhost]
2026-08-24 07:23:42.735185 | 
2026-08-24 07:23:42.735286 | TASK [Generate Zuul manifest]
2026-08-24 07:23:42.755309 | localhost | ok
2026-08-24 07:23:42.778672 | 
2026-08-24 07:23:42.778755 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-24 07:23:43.135969 | localhost | changed
2026-08-24 07:23:43.157187 | 
2026-08-24 07:23:43.157299 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-24 07:23:43.187816 | localhost | ok
2026-08-24 07:23:43.196089 | 
2026-08-24 07:23:43.196153 | TASK [Upload logs]
2026-08-24 07:23:43.218035 | localhost | ok
2026-08-24 07:23:43.282718 | 
2026-08-24 07:23:43.282938 | TASK [Set zuul-log-path fact]
2026-08-24 07:23:43.300289 | localhost | ok
2026-08-24 07:23:43.311018 | 
2026-08-24 07:23:43.311087 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-24 07:23:43.340212 | localhost | ok
2026-08-24 07:23:43.348054 | 
2026-08-24 07:23:43.348124 | TASK [upload-logs : Create log directories]
2026-08-24 07:23:43.757830 | localhost | changed
2026-08-24 07:23:43.764763 | 
2026-08-24 07:23:43.764842 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-24 07:23:44.147384 | localhost -> localhost | ok: Runtime: 0:00:00.004774
2026-08-24 07:23:44.154280 | 
2026-08-24 07:23:44.154349 | TASK [upload-logs : Upload logs to log server]
2026-08-24 07:23:44.635437 | localhost | Output suppressed because no_log was given
2026-08-24 07:23:44.664487 | 
2026-08-24 07:23:44.664629 | LOOP [upload-logs : Compress console log and json output]
2026-08-24 07:23:44.707359 | localhost | skipping: Conditional result was False
2026-08-24 07:23:44.714693 | localhost | skipping: Conditional result was False
2026-08-24 07:23:44.726730 | 
2026-08-24 07:23:44.726862 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-24 07:23:44.769952 | localhost | skipping: Conditional result was False
2026-08-24 07:23:44.770253 | 
2026-08-24 07:23:44.775625 | localhost | skipping: Conditional result was False
2026-08-24 07:23:44.791507 | 
2026-08-24 07:23:44.791647 | LOOP [upload-logs : Upload console log and json output]