2026-08-22 18:37:06.060274 | Job console starting
2026-08-22 18:37:06.069713 | Updating git repos
2026-08-22 18:37:11.041839 | Cloning repos into workspace
2026-08-22 18:37:26.416377 | Restoring repo states
2026-08-22 18:37:33.251670 | Merging changes
2026-08-22 18:37:34.471592 | Checking out repos
2026-08-22 18:37:36.945759 | Preparing playbooks
2026-08-22 18:37:38.782926 | Running Ansible setup
2026-08-22 18:37:42.378321 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-22 18:37:42.971495 | 
2026-08-22 18:37:42.971601 | PLAY [localhost]
2026-08-22 18:37:42.978708 | 
2026-08-22 18:37:42.978789 | TASK [Gathering Facts]
2026-08-22 18:37:43.843811 | localhost | ok
2026-08-22 18:37:43.854055 | 
2026-08-22 18:37:43.854168 | TASK [Setup log path fact]
2026-08-22 18:37:43.873826 | localhost | ok
2026-08-22 18:37:43.888688 | 
2026-08-22 18:37:43.888827 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-22 18:37:43.927472 | localhost | ok
2026-08-22 18:37:43.933298 | 
2026-08-22 18:37:43.933368 | TASK [emit-job-header : Print job information]
2026-08-22 18:37:43.973617 | # Job Information
2026-08-22 18:37:43.973900 | Ansible Version: 2.16.18
2026-08-22 18:37:43.973981 | Job: atmosphere-molecule-csi-rbd
2026-08-22 18:37:43.974029 | Pipeline: check
2026-08-22 18:37:43.974073 | Executor: 2d72f0692154
2026-08-22 18:37:43.974116 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4091
2026-08-22 18:37:43.974165 | Event ID: 0d5c00c0-9e58-11f1-9c1c-ad5a94bca320
2026-08-22 18:37:43.978232 | 
2026-08-22 18:37:43.978319 | LOOP [emit-job-header : Print node information]
2026-08-22 18:37:44.074785 | localhost | ok:
2026-08-22 18:37:44.075460 | localhost | # Node Information
2026-08-22 18:37:44.075550 | localhost | Inventory Hostname: instance
2026-08-22 18:37:44.075603 | localhost | Hostname: np0000190711
2026-08-22 18:37:44.075647 | localhost | Username: zuul
2026-08-22 18:37:44.075695 | localhost | Distro: Ubuntu 22.04
2026-08-22 18:37:44.075716 | localhost | Provider: yul1
2026-08-22 18:37:44.075736 | localhost | Region: ca-ymq-1
2026-08-22 18:37:44.075755 | localhost | Label: ubuntu-jammy
2026-08-22 18:37:44.075773 | localhost | Product Name: OpenStack Nova
2026-08-22 18:37:44.075791 | localhost | Interface IP: 199.204.45.129
2026-08-22 18:37:44.095588 | 
2026-08-22 18:37:44.095720 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-08-22 18:37:44.463967 | localhost -> localhost | changed
2026-08-22 18:37:44.472740 | 
2026-08-22 18:37:44.472806 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-08-22 18:37:45.391104 | localhost -> localhost | changed
2026-08-22 18:37:45.399883 | 
2026-08-22 18:37:45.399936 | PLAY [all]
2026-08-22 18:37:45.408689 | 
2026-08-22 18:37:45.408752 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-08-22 18:37:45.645632 | instance -> localhost | ok
2026-08-22 18:37:45.655333 | 
2026-08-22 18:37:45.655420 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-08-22 18:37:45.689443 | instance | ok
2026-08-22 18:37:45.704902 | instance | included: /var/lib/zuul/builds/81992bd66d3e4f8eaf5cf5b5301a8e82/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-08-22 18:37:45.710636 | 
2026-08-22 18:37:45.710701 | TASK [add-build-sshkey : Create Temp SSH key]
2026-08-22 18:37:46.911832 | instance -> localhost | Generating public/private rsa key pair.
2026-08-22 18:37:46.912016 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/81992bd66d3e4f8eaf5cf5b5301a8e82/work/81992bd66d3e4f8eaf5cf5b5301a8e82_id_rsa
2026-08-22 18:37:46.912057 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/81992bd66d3e4f8eaf5cf5b5301a8e82/work/81992bd66d3e4f8eaf5cf5b5301a8e82_id_rsa.pub
2026-08-22 18:37:46.912089 | instance -> localhost | The key fingerprint is:
2026-08-22 18:37:46.912119 | instance -> localhost | SHA256:Z7HqJkSIu9io6meBrfc9doU4Ba3KXmBCbCIn9KORmyY zuul-build-sshkey
2026-08-22 18:37:46.912160 | instance -> localhost | The key's randomart image is:
2026-08-22 18:37:46.912205 | instance -> localhost | +---[RSA 3072]----+
2026-08-22 18:37:46.912240 | instance -> localhost | |...     .        |
2026-08-22 18:37:46.912270 | instance -> localhost | |o.++   . .       |
2026-08-22 18:37:46.912298 | instance -> localhost | |.=++ .  o .      |
2026-08-22 18:37:46.912326 | instance -> localhost | |  *.oo.. . o     |
2026-08-22 18:37:46.912353 | instance -> localhost | |E=o.+.o S =      |
2026-08-22 18:37:46.912380 | instance -> localhost | |o..o o.+ = .     |
2026-08-22 18:37:46.912407 | instance -> localhost | | +..o.. o .      |
2026-08-22 18:37:46.912433 | instance -> localhost | |o.o+ .o+..       |
2026-08-22 18:37:46.912463 | instance -> localhost | |*.+ ...++        |
2026-08-22 18:37:46.912490 | instance -> localhost | +----[SHA256]-----+
2026-08-22 18:37:46.912552 | instance -> localhost | ok: Runtime: 0:00:00.808720
2026-08-22 18:37:46.921537 | 
2026-08-22 18:37:46.921641 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-08-22 18:37:46.941306 | instance | ok
2026-08-22 18:37:46.951759 | instance | included: /var/lib/zuul/builds/81992bd66d3e4f8eaf5cf5b5301a8e82/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-08-22 18:37:46.960264 | 
2026-08-22 18:37:46.960387 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-08-22 18:37:46.984447 | instance | skipping: Conditional result was False
2026-08-22 18:37:46.994017 | 
2026-08-22 18:37:46.994114 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-08-22 18:37:47.423403 | instance | changed
2026-08-22 18:37:47.432016 | 
2026-08-22 18:37:47.432158 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-08-22 18:37:47.618973 | instance | ok
2026-08-22 18:37:47.626384 | 
2026-08-22 18:37:47.626458 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-08-22 18:37:48.078623 | instance | changed
2026-08-22 18:37:48.083845 | 
2026-08-22 18:37:48.083915 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-08-22 18:37:48.546304 | instance | changed
2026-08-22 18:37:48.555135 | 
2026-08-22 18:37:48.555254 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-08-22 18:37:48.582346 | instance | skipping: Conditional result was False
2026-08-22 18:37:48.591790 | 
2026-08-22 18:37:48.591883 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-08-22 18:37:48.971438 | instance -> localhost | changed
2026-08-22 18:37:48.986581 | 
2026-08-22 18:37:48.986695 | TASK [add-build-sshkey : Add back temp key]
2026-08-22 18:37:49.291748 | instance -> localhost | Identity added: /var/lib/zuul/builds/81992bd66d3e4f8eaf5cf5b5301a8e82/work/81992bd66d3e4f8eaf5cf5b5301a8e82_id_rsa (zuul-build-sshkey)
2026-08-22 18:37:49.291966 | instance -> localhost | ok: Runtime: 0:00:00.011405
2026-08-22 18:37:49.299889 | 
2026-08-22 18:37:49.299988 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-08-22 18:37:49.621906 | instance | ok
2026-08-22 18:37:49.626957 | 
2026-08-22 18:37:49.627018 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-08-22 18:37:49.652237 | instance | skipping: Conditional result was False
2026-08-22 18:37:49.669394 | 
2026-08-22 18:37:49.669576 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-08-22 18:37:49.990102 | instance | ok
2026-08-22 18:37:50.003923 | 
2026-08-22 18:37:50.004030 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-08-22 18:37:53.256479 | instance | Output suppressed because no_log was given
2026-08-22 18:37:53.266860 | 
2026-08-22 18:37:53.266918 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-08-22 18:37:53.441464 | instance | ok: "logs"
2026-08-22 18:37:53.441672 | instance | ok: All items complete
2026-08-22 18:37:53.441699 | 
2026-08-22 18:37:53.583916 | instance | ok: "artifacts"
2026-08-22 18:37:53.735787 | instance | ok: "docs"
2026-08-22 18:37:53.745515 | 
2026-08-22 18:37:53.745664 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-08-22 18:37:53.924518 | instance | changed: "logs"
2026-08-22 18:37:54.072491 | instance | changed: "artifacts"
2026-08-22 18:37:54.228894 | instance | changed: "docs"
2026-08-22 18:37:54.251395 | 
2026-08-22 18:37:54.251504 | PLAY RECAP
2026-08-22 18:37:54.251552 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-08-22 18:37:54.251580 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-22 18:37:54.251601 | 
2026-08-22 18:37:54.369179 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main]
2026-08-22 18:37:54.374431 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-22 18:37:54.943988 | 
2026-08-22 18:37:54.944097 | PLAY [all]
2026-08-22 18:37:54.954180 | 
2026-08-22 18:37:54.954255 | TASK [setup-uv : Extract archive]
2026-08-22 18:37:57.132761 | instance | changed
2026-08-22 18:37:57.139973 | 
2026-08-22 18:37:57.140049 | TASK [setup-uv : Print version]
2026-08-22 18:37:57.479435 | instance | uv 0.8.13
2026-08-22 18:37:57.675963 | instance | ok: Runtime: 0:00:00.013395
2026-08-22 18:37:57.687836 | 
2026-08-22 18:37:57.687901 | TASK [Install Ansible collection siblings]
2026-08-22 18:38:06.740047 | instance | changed:
2026-08-22 18:38:06.740216 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon
2026-08-22 18:38:06.740258 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix
2026-08-22 18:38:06.740289 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils
2026-08-22 18:38:06.740318 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto
2026-08-22 18:38:06.740346 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general
2026-08-22 18:38:06.740379 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql
2026-08-22 18:38:06.740408 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core
2026-08-22 18:38:06.740438 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph
2026-08-22 18:38:06.740467 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers
2026-08-22 18:38:06.740494 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes
2026-08-22 18:38:06.740521 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common
2026-08-22 18:38:06.740546 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack
2026-08-22 18:38:06.740572 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0
2026-08-22 18:38:06.740598 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0
2026-08-22 18:38:06.740624 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0
2026-08-22 18:38:06.740651 | instance | Resolved community.crypto to 2.2.3 for 2.2.3
2026-08-22 18:38:06.740677 | instance | Resolved community.general to 7.3.0 for 7.3.0
2026-08-22 18:38:06.740703 | instance | Resolved community.mysql to 3.6.0 for 3.6.0
2026-08-22 18:38:06.740729 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0
2026-08-22 18:38:06.740755 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0
2026-08-22 18:38:06.740780 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.1.2
2026-08-22 18:38:06.740806 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0
2026-08-22 18:38:06.740833 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-22 18:38:06.740871 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0
2026-08-22 18:38:06.740901 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0
2026-08-22 18:38:06.740928 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-22 18:38:06.740988 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-22 18:38:06.741039 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0
2026-08-22 18:38:06.741074 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0
2026-08-22 18:38:06.741102 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3
2026-08-22 18:38:06.741129 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2
2026-08-22 18:38:06.741158 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0
2026-08-22 18:38:06.741185 | instance | Checked out ansible.netcommon to 1.2.0
2026-08-22 18:38:06.741211 | 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-22 18:38:06.741244 | instance | Starting galaxy collection install process
2026-08-22 18:38:06.741270 | instance | Process install dependency map
2026-08-22 18:38:06.741297 | instance | Starting collection install process
2026-08-22 18:38:06.741322 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon'
2026-08-22 18:38:06.741349 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon
2026-08-22 18:38:06.741375 | instance | ansible.netcommon:* was installed successfully
2026-08-22 18:38:06.741400 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3
2026-08-22 18:38:06.741426 | instance | Creating virtual environment at: .venv
2026-08-22 18:38:06.741451 | instance |    Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-22 18:38:06.741477 | instance | Downloading kubernetes (1.9MiB)
2026-08-22 18:38:06.741502 | instance | Downloading openstacksdk (1.7MiB)
2026-08-22 18:38:06.741532 | instance | Downloading ansible-core (2.1MiB)
2026-08-22 18:38:06.741559 | instance | Downloading cryptography (4.2MiB)
2026-08-22 18:38:06.741584 | instance | Downloading netaddr (2.2MiB)
2026-08-22 18:38:06.741610 | instance | Downloading rjsonnet (1.2MiB)
2026-08-22 18:38:06.741636 | instance | Downloading pygments (1.2MiB)
2026-08-22 18:38:06.741665 | instance | Downloading setuptools (1.1MiB)
2026-08-22 18:38:06.741691 | instance |    Building pyperclip==1.9.0
2026-08-22 18:38:06.741718 | instance |  Downloading rjsonnet
2026-08-22 18:38:06.741747 | instance |  Downloading netaddr
2026-08-22 18:38:06.741774 | instance |  Downloading pygments
2026-08-22 18:38:06.741801 | instance |  Downloading cryptography
2026-08-22 18:38:06.741828 | instance |  Downloading setuptools
2026-08-22 18:38:06.741854 | instance |  Downloading kubernetes
2026-08-22 18:38:06.741879 | instance |  Downloading ansible-core
2026-08-22 18:38:06.741905 | instance |  Downloading openstacksdk
2026-08-22 18:38:06.741930 | instance |       Built pyperclip==1.9.0
2026-08-22 18:38:06.741957 | instance |       Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere
2026-08-22 18:38:06.741985 | instance | Installed 79 packages in 39ms
2026-08-22 18:38:06.742012 | instance | Checked out ansible.posix to 1.6.0
2026-08-22 18:38:06.742040 | 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-22 18:38:06.742067 | instance | Starting galaxy collection install process
2026-08-22 18:38:06.742095 | instance | Process install dependency map
2026-08-22 18:38:06.742122 | instance | Starting collection install process
2026-08-22 18:38:06.742149 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix'
2026-08-22 18:38:06.742183 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix
2026-08-22 18:38:06.742211 | instance | ansible.posix:1.6.0 was installed successfully
2026-08-22 18:38:06.742237 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 18:38:06.742262 | instance | 2.17.12
2026-08-22 18:38:06.742288 | instance | Checked out ansible.utils to v6.1.0
2026-08-22 18:38:06.742314 | 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-22 18:38:06.742342 | instance | Starting galaxy collection install process
2026-08-22 18:38:06.742369 | instance | Process install dependency map
2026-08-22 18:38:06.742394 | instance | Starting collection install process
2026-08-22 18:38:06.742420 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils'
2026-08-22 18:38:06.742446 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils
2026-08-22 18:38:06.742472 | instance | ansible.utils:6.1.0 was installed successfully
2026-08-22 18:38:06.742498 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 18:38:06.742523 | instance | 2.17.12
2026-08-22 18:38:06.742580 | instance | Checked out atmosphere.common to v0.7.0
2026-08-22 18:38:06.742608 | 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-22 18:38:06.742636 | instance | Starting galaxy collection install process
2026-08-22 18:38:06.742663 | instance | Process install dependency map
2026-08-22 18:38:06.742689 | instance | Starting collection install process
2026-08-22 18:38:06.742716 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common'
2026-08-22 18:38:06.742743 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common
2026-08-22 18:38:06.742768 | instance | atmosphere.common:0.7.0 was installed successfully
2026-08-22 18:38:06.742793 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 18:38:06.742819 | instance | 2.17.12
2026-08-22 18:38:06.742844 | instance | Checked out community.crypto to 2.2.3
2026-08-22 18:38:06.742870 | 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-22 18:38:06.742896 | instance | Starting galaxy collection install process
2026-08-22 18:38:06.742922 | instance | Process install dependency map
2026-08-22 18:38:06.742949 | instance | Starting collection install process
2026-08-22 18:38:06.742984 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto'
2026-08-22 18:38:06.743048 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto
2026-08-22 18:38:06.743107 | instance | community.crypto:2.2.3 was installed successfully
2026-08-22 18:38:06.743155 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 18:38:06.743207 | instance | 2.17.12
2026-08-22 18:38:06.743245 | instance | Checked out community.general to 7.3.0
2026-08-22 18:38:06.743275 | 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-22 18:38:06.743304 | instance | Starting galaxy collection install process
2026-08-22 18:38:06.743339 | instance | Process install dependency map
2026-08-22 18:38:06.743368 | instance | Starting collection install process
2026-08-22 18:38:06.743396 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general'
2026-08-22 18:38:06.743422 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general
2026-08-22 18:38:06.743450 | instance | community.general:7.3.0 was installed successfully
2026-08-22 18:38:06.743476 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 18:38:06.743512 | instance | 2.17.12
2026-08-22 18:38:06.743552 | instance | Checked out community.mysql to 3.6.0
2026-08-22 18:38:06.743586 | 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-22 18:38:06.743613 | instance | Starting galaxy collection install process
2026-08-22 18:38:06.743642 | instance | Process install dependency map
2026-08-22 18:38:06.743669 | instance | Starting collection install process
2026-08-22 18:38:06.743695 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql'
2026-08-22 18:38:06.743721 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql
2026-08-22 18:38:06.743747 | instance | community.mysql:3.6.0 was installed successfully
2026-08-22 18:38:06.743772 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 18:38:06.743797 | instance | 2.17.12
2026-08-22 18:38:06.743822 | instance | Checked out kubernetes.core to 2.4.0
2026-08-22 18:38:06.743847 | 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-22 18:38:06.743872 | instance | Starting galaxy collection install process
2026-08-22 18:38:06.743897 | instance | Process install dependency map
2026-08-22 18:38:06.743922 | instance | Starting collection install process
2026-08-22 18:38:06.743947 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core'
2026-08-22 18:38:06.743972 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core
2026-08-22 18:38:06.743998 | instance | kubernetes.core:2.4.0 was installed successfully
2026-08-22 18:38:06.744023 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 18:38:06.744047 | instance | 2.17.12
2026-08-22 18:38:06.744072 | instance | Checked out openstack.cloud to 2.6.0
2026-08-22 18:38:06.744097 | 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-22 18:38:06.744123 | instance | Starting galaxy collection install process
2026-08-22 18:38:06.744147 | instance | Process install dependency map
2026-08-22 18:38:06.744172 | instance | Starting collection install process
2026-08-22 18:38:06.744197 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud'
2026-08-22 18:38:06.744222 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud
2026-08-22 18:38:06.744247 | instance | openstack.cloud:2.6.0 was installed successfully
2026-08-22 18:38:06.744272 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 18:38:06.744297 | instance | 2.17.12
2026-08-22 18:38:06.744322 | instance | Checked out vexxhost.ceph to v4.2.0
2026-08-22 18:38:06.744347 | 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-22 18:38:06.744379 | instance | Starting galaxy collection install process
2026-08-22 18:38:06.744405 | instance | Process install dependency map
2026-08-22 18:38:06.744431 | instance | Starting collection install process
2026-08-22 18:38:06.744456 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph'
2026-08-22 18:38:06.744481 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph
2026-08-22 18:38:06.744506 | instance | vexxhost.ceph:4.2.0 was installed successfully
2026-08-22 18:38:06.744532 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 18:38:06.744556 | instance | 2.17.12
2026-08-22 18:38:06.744581 | instance | Checked out vexxhost.containers to v1.6.8
2026-08-22 18:38:06.744614 | 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-22 18:38:06.744652 | instance | Starting galaxy collection install process
2026-08-22 18:38:06.744688 | instance | Process install dependency map
2026-08-22 18:38:06.744716 | instance | Starting collection install process
2026-08-22 18:38:06.744742 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers'
2026-08-22 18:38:06.744768 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers
2026-08-22 18:38:06.744793 | instance | vexxhost.containers:1.6.8 was installed successfully
2026-08-22 18:38:06.744819 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 18:38:06.744852 | instance | 2.17.12
2026-08-22 18:38:06.744891 | instance | Checked out vexxhost.kubernetes to v3.3.0
2026-08-22 18:38:06.744925 | 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-22 18:38:06.745012 | instance | Starting galaxy collection install process
2026-08-22 18:38:06.745061 | instance | Process install dependency map
2026-08-22 18:38:06.745091 | instance | Starting collection install process
2026-08-22 18:38:06.745118 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes'
2026-08-22 18:38:06.745143 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes
2026-08-22 18:38:06.745169 | instance | vexxhost.kubernetes:3.3.0 was installed successfully
2026-08-22 18:38:06.745194 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version
2026-08-22 18:38:06.745227 | instance | 2.17.12
2026-08-22 18:38:06.751199 | 
2026-08-22 18:38:06.751244 | PLAY RECAP
2026-08-22 18:38:06.751284 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-22 18:38:06.751306 | 
2026-08-22 18:38:06.849349 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main]
2026-08-22 18:38:06.853686 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-22 18:38:07.402561 | 
2026-08-22 18:38:07.402669 | PLAY [all]
2026-08-22 18:38:07.413256 | 
2026-08-22 18:38:07.413336 | TASK [Install "jq" for log collection]
2026-08-22 18:38:17.495961 | instance | changed
2026-08-22 18:38:17.501116 | 
2026-08-22 18:38:17.501178 | PLAY RECAP
2026-08-22 18:38:17.501227 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-08-22 18:38:17.501276 | 
2026-08-22 18:38:17.607055 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main]
2026-08-22 18:38:17.609510 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-22 18:38:18.271240 | 
2026-08-22 18:38:18.271375 | PLAY [all]
2026-08-22 18:38:18.282705 | 
2026-08-22 18:38:18.282776 | LOOP [Check inventory directories]
2026-08-22 18:38:18.630671 | instance | ok: "src/github.com/vexxhost/atmosphere"
2026-08-22 18:38:18.779904 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory"
2026-08-22 18:38:18.935411 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory"
2026-08-22 18:38:18.955143 | 
2026-08-22 18:38:18.955383 | LOOP [Copy inventory file for Zuul]
2026-08-22 18:38:19.728353 | instance | changed:
2026-08-22 18:38:19.728741 | instance | {
2026-08-22 18:38:19.728790 | instance |   "ansible_loop_var": "item",
2026-08-22 18:38:19.728823 | instance |   "changed": false,
2026-08-22 18:38:19.728851 | instance |   "failed": false,
2026-08-22 18:38:19.728888 | instance |   "invocation": {
2026-08-22 18:38:19.728915 | instance |     "module_args": {
2026-08-22 18:38:19.728940 | instance |       "checksum_algorithm": "sha1",
2026-08-22 18:38:19.728967 | instance |       "follow": true,
2026-08-22 18:38:19.728998 | instance |       "get_attributes": true,
2026-08-22 18:38:19.729049 | instance |       "get_checksum": true,
2026-08-22 18:38:19.729075 | instance |       "get_mime": true,
2026-08-22 18:38:19.729100 | instance |       "path": "src/github.com/vexxhost/atmosphere"
2026-08-22 18:38:19.729125 | instance |     }
2026-08-22 18:38:19.729149 | instance |   },
2026-08-22 18:38:19.729173 | instance |   "item": "src/github.com/vexxhost/atmosphere",
2026-08-22 18:38:19.729196 | instance |   "stat": {
2026-08-22 18:38:19.729221 | instance |     "atime": 1787423879.3748848,
2026-08-22 18:38:19.729246 | instance |     "attr_flags": "e",
2026-08-22 18:38:19.729270 | instance |     "attributes": [
2026-08-22 18:38:19.729294 | instance |       "extents"
2026-08-22 18:38:19.729318 | instance |     ],
2026-08-22 18:38:19.729341 | instance |     "block_size": 4096,
2026-08-22 18:38:19.729365 | instance |     "blocks": 8,
2026-08-22 18:38:19.729389 | instance |     "charset": "unknown",
2026-08-22 18:38:19.729415 | instance |     "ctime": 1787423878.4548826,
2026-08-22 18:38:19.729439 | instance |     "dev": 64513,
2026-08-22 18:38:19.729463 | instance |     "device_type": 0,
2026-08-22 18:38:19.729487 | instance |     "executable": true,
2026-08-22 18:38:19.729510 | instance |     "exists": true,
2026-08-22 18:38:19.729533 | instance |     "gid": 1000,
2026-08-22 18:38:19.729557 | instance |     "gr_name": "zuul",
2026-08-22 18:38:19.729580 | instance |     "inode": 1048003,
2026-08-22 18:38:19.729604 | instance |     "isblk": false,
2026-08-22 18:38:19.729629 | instance |     "ischr": false,
2026-08-22 18:38:19.729653 | instance |     "isdir": true,
2026-08-22 18:38:19.729676 | instance |     "isfifo": false,
2026-08-22 18:38:19.729700 | instance |     "isgid": false,
2026-08-22 18:38:19.729723 | instance |     "islnk": false,
2026-08-22 18:38:19.729746 | instance |     "isreg": false,
2026-08-22 18:38:19.729770 | instance |     "issock": false,
2026-08-22 18:38:19.729792 | instance |     "isuid": false,
2026-08-22 18:38:19.729815 | instance |     "mimetype": "unknown",
2026-08-22 18:38:19.729838 | instance |     "mode": "0755",
2026-08-22 18:38:19.729861 | instance |     "mtime": 1787423878.4548826,
2026-08-22 18:38:19.729884 | instance |     "nlink": 21,
2026-08-22 18:38:19.729907 | instance |     "path": "src/github.com/vexxhost/atmosphere",
2026-08-22 18:38:19.730093 | instance |     "pw_name": "zuul",
2026-08-22 18:38:19.730126 | instance |     "readable": true,
2026-08-22 18:38:19.730151 | instance |     "rgrp": true,
2026-08-22 18:38:19.730175 | instance |     "roth": true,
2026-08-22 18:38:19.730199 | instance |     "rusr": true,
2026-08-22 18:38:19.730223 | instance |     "size": 4096,
2026-08-22 18:38:19.730247 | instance |     "uid": 1000,
2026-08-22 18:38:19.730286 | instance |     "version": "2393778010",
2026-08-22 18:38:19.730310 | instance |     "wgrp": false,
2026-08-22 18:38:19.730336 | instance |     "woth": false,
2026-08-22 18:38:19.730361 | instance |     "writeable": true,
2026-08-22 18:38:19.730385 | instance |     "wusr": true,
2026-08-22 18:38:19.730409 | instance |     "xgrp": true,
2026-08-22 18:38:19.730433 | instance |     "xoth": true,
2026-08-22 18:38:19.730456 | instance |     "xusr": true
2026-08-22 18:38:19.730480 | instance |   }
2026-08-22 18:38:19.730504 | instance | }
2026-08-22 18:38:19.730552 | instance | ok: All items complete
2026-08-22 18:38:19.730597 | 
2026-08-22 18:38:19.732447 | instance | skipping: Conditional result was False
2026-08-22 18:38:19.733884 | instance | skipping: Conditional result was False
2026-08-22 18:38:19.752578 | 
2026-08-22 18:38:19.752739 | LOOP [Switch "ansible_host" to private IP]
2026-08-22 18:38:20.097861 | instance | changed: 1 replacements made
2026-08-22 18:38:20.100615 | instance | skipping: Conditional result was False
2026-08-22 18:38:20.104252 | instance | skipping: Conditional result was False
2026-08-22 18:38:20.112329 | 
2026-08-22 18:38:20.112451 | TASK [Run Molecule scenario]
2026-08-22 18:38:21.003191 | instance | WARNING  Molecule scenarios should migrate to 'extensions/molecule'
2026-08-22 18:38:21.384858 | instance | INFO     [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy
2026-08-22 18:38:21.384982 | instance | INFO     [csi > prerun] Performing prerun with role_name_check=0...
2026-08-22 18:38:32.720457 | instance | INFO     [csi > dependency] Executing
2026-08-22 18:38:32.720706 | instance | WARNING  [csi > dependency] Missing roles requirements file: requirements.yml
2026-08-22 18:38:32.720939 | instance | WARNING  [csi > dependency] Missing collections requirements file: collections.yml
2026-08-22 18:38:32.721099 | instance | WARNING  [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress)
2026-08-22 18:38:32.729462 | instance | INFO     [csi > cleanup] Executing
2026-08-22 18:38:32.729935 | instance | WARNING  [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-22 18:38:32.738282 | instance | INFO     [csi > destroy] Executing
2026-08-22 18:38:32.738375 | instance | WARNING  [csi > destroy] Skipping, '--destroy=never' requested.
2026-08-22 18:38:32.738470 | instance | INFO     [csi > destroy] Executed: Successful
2026-08-22 18:38:32.745960 | instance | INFO     [csi > syntax] Executing
2026-08-22 18:38:34.352742 | instance |
2026-08-22 18:38:34.353051 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml
2026-08-22 18:38:34.476604 | instance | INFO     [csi > syntax] Executed: Successful
2026-08-22 18:38:34.490628 | instance | INFO     [csi > create] Executing
2026-08-22 18:38:34.492425 | instance | WARNING  [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress)
2026-08-22 18:38:34.500038 | instance | INFO     [csi > prepare] Executing
2026-08-22 18:38:35.345183 | instance |
2026-08-22 18:38:35.345497 | instance | PLAY [Prepare] *****************************************************************
2026-08-22 18:38:35.345776 | instance |
2026-08-22 18:38:35.346106 | instance | TASK [Gathering Facts] *********************************************************
2026-08-22 18:38:35.346393 | instance | Saturday 22 August 2026  18:38:35 +0000 (0:00:00.028)       0:00:00.028 *******
2026-08-22 18:38:36.503760 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-22 18:38:36.504034 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-22 18:38:36.504324 | instance | interpreter could change the meaning of that path. See
2026-08-22 18:38:36.504592 | instance | https://docs.ansible.com/ansible-
2026-08-22 18:38:36.504886 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-22 18:38:36.513521 | instance | ok: [instance]
2026-08-22 18:38:36.513813 | instance |
2026-08-22 18:38:36.514166 | instance | TASK [Configure short hostname] ************************************************
2026-08-22 18:38:36.514462 | instance | Saturday 22 August 2026  18:38:36 +0000 (0:00:01.169)       0:00:01.197 *******
2026-08-22 18:38:37.192708 | instance | changed: [instance]
2026-08-22 18:38:37.192944 | instance |
2026-08-22 18:38:37.193280 | instance | TASK [Ensure hostname inside hosts file] ***************************************
2026-08-22 18:38:37.193549 | instance | Saturday 22 August 2026  18:38:37 +0000 (0:00:00.678)       0:00:01.876 *******
2026-08-22 18:38:37.446108 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created
2026-08-22 18:38:37.446238 | instance | with a mode of 0700, this may cause issues when running as another user. To
2026-08-22 18:38:37.446417 | instance | avoid this, create the remote_tmp dir with the correct permissions manually
2026-08-22 18:38:37.456086 | instance | changed: [instance]
2026-08-22 18:38:37.456263 | instance |
2026-08-22 18:38:37.456535 | instance | TASK [Purge "snapd" package] ***************************************************
2026-08-22 18:38:37.456802 | instance | Saturday 22 August 2026  18:38:37 +0000 (0:00:00.263)       0:00:02.140 *******
2026-08-22 18:38:38.251741 | instance | ok: [instance]
2026-08-22 18:38:38.251935 | instance |
2026-08-22 18:38:38.252209 | instance | PLAY [Create devices for Ceph] *************************************************
2026-08-22 18:38:38.252457 | instance |
2026-08-22 18:38:38.252726 | instance | TASK [Gathering Facts] *********************************************************
2026-08-22 18:38:38.252999 | instance | Saturday 22 August 2026  18:38:38 +0000 (0:00:00.795)       0:00:02.935 *******
2026-08-22 18:38:38.951114 | instance | ok: [instance]
2026-08-22 18:38:38.951348 | instance |
2026-08-22 18:38:38.951642 | instance | TASK [Install depedencies] *****************************************************
2026-08-22 18:38:38.951933 | instance | Saturday 22 August 2026  18:38:38 +0000 (0:00:00.699)       0:00:03.635 *******
2026-08-22 18:39:02.038299 | instance | changed: [instance]
2026-08-22 18:39:02.038407 | instance |
2026-08-22 18:39:02.038585 | instance | TASK [Start up service] ********************************************************
2026-08-22 18:39:02.038762 | instance | Saturday 22 August 2026  18:39:02 +0000 (0:00:23.087)       0:00:26.722 *******
2026-08-22 18:39:02.627651 | instance | ok: [instance]
2026-08-22 18:39:02.627901 | instance |
2026-08-22 18:39:02.628209 | instance | TASK [Generate lvm.conf] *******************************************************
2026-08-22 18:39:02.628587 | instance | Saturday 22 August 2026  18:39:02 +0000 (0:00:00.589)       0:00:27.311 *******
2026-08-22 18:39:02.921887 | instance | ok: [instance]
2026-08-22 18:39:02.922133 | instance |
2026-08-22 18:39:02.922436 | instance | TASK [Write /etc/lvm/lvm.conf] *************************************************
2026-08-22 18:39:02.922721 | instance | Saturday 22 August 2026  18:39:02 +0000 (0:00:00.294)       0:00:27.606 *******
2026-08-22 18:39:03.603559 | instance | changed: [instance]
2026-08-22 18:39:03.603941 | instance |
2026-08-22 18:39:03.604280 | instance | TASK [Get list of all loopback devices] ****************************************
2026-08-22 18:39:03.604655 | instance | Saturday 22 August 2026  18:39:03 +0000 (0:00:00.681)       0:00:28.287 *******
2026-08-22 18:39:03.796588 | instance | ok: [instance]
2026-08-22 18:39:03.796625 | instance |
2026-08-22 18:39:03.796630 | instance | TASK [Fail if there is any existing loopback devices] **************************
2026-08-22 18:39:03.796636 | instance | Saturday 22 August 2026  18:39:03 +0000 (0:00:00.193)       0:00:28.480 *******
2026-08-22 18:39:03.820294 | instance | skipping: [instance]
2026-08-22 18:39:03.820315 | instance |
2026-08-22 18:39:03.820320 | instance | TASK [Create devices for Ceph] *************************************************
2026-08-22 18:39:03.820325 | instance | Saturday 22 August 2026  18:39:03 +0000 (0:00:00.024)       0:00:28.505 *******
2026-08-22 18:39:04.358170 | instance | changed: [instance] => (item=osd0)
2026-08-22 18:39:04.358265 | instance | changed: [instance] => (item=osd1)
2026-08-22 18:39:04.358277 | instance | changed: [instance] => (item=osd2)
2026-08-22 18:39:04.358299 | instance |
2026-08-22 18:39:04.358311 | instance | TASK [Set permissions on loopback devices] *************************************
2026-08-22 18:39:04.358427 | instance | Saturday 22 August 2026  18:39:04 +0000 (0:00:00.536)       0:00:29.042 *******
2026-08-22 18:39:05.016461 | instance | changed: [instance] => (item=osd0)
2026-08-22 18:39:05.016552 | instance | changed: [instance] => (item=osd1)
2026-08-22 18:39:05.017273 | instance | changed: [instance] => (item=osd2)
2026-08-22 18:39:05.017332 | instance |
2026-08-22 18:39:05.017341 | instance | TASK [Start loop devices] ******************************************************
2026-08-22 18:39:05.017348 | instance | Saturday 22 August 2026  18:39:05 +0000 (0:00:00.658)       0:00:29.700 *******
2026-08-22 18:39:05.719359 | instance | changed: [instance] => (item=osd0)
2026-08-22 18:39:05.719461 | instance | changed: [instance] => (item=osd1)
2026-08-22 18:39:05.720166 | instance | changed: [instance] => (item=osd2)
2026-08-22 18:39:05.720227 | instance |
2026-08-22 18:39:05.720236 | instance | TASK [Create a volume group for each loop device] ******************************
2026-08-22 18:39:05.720243 | instance | Saturday 22 August 2026  18:39:05 +0000 (0:00:00.702)       0:00:30.403 *******
2026-08-22 18:39:09.038852 | instance | changed: [instance] => (item=osd0)
2026-08-22 18:39:09.039705 | instance | changed: [instance] => (item=osd1)
2026-08-22 18:39:09.039759 | instance | changed: [instance] => (item=osd2)
2026-08-22 18:39:09.039768 | instance |
2026-08-22 18:39:09.039774 | instance | TASK [Create a logical volume for each loop device] ****************************
2026-08-22 18:39:09.039781 | instance | Saturday 22 August 2026  18:39:09 +0000 (0:00:03.319)       0:00:33.723 *******
2026-08-22 18:39:10.878506 | instance | changed: [instance] => (item=ceph-instance-osd0)
2026-08-22 18:39:10.878565 | instance | changed: [instance] => (item=ceph-instance-osd1)
2026-08-22 18:39:10.878586 | instance | changed: [instance] => (item=ceph-instance-osd2)
2026-08-22 18:39:10.878591 | instance |
2026-08-22 18:39:10.878596 | instance | PLAY RECAP *********************************************************************
2026-08-22 18:39:10.878606 | instance | instance                   : ok=15   changed=9    unreachable=0    failed=0    skipped=1    rescued=0    ignored=0
2026-08-22 18:39:10.882039 | instance |
2026-08-22 18:39:10.882051 | instance | Saturday 22 August 2026  18:39:10 +0000 (0:00:01.838)       0:00:35.561 *******
2026-08-22 18:39:10.882055 | instance | ===============================================================================
2026-08-22 18:39:10.882060 | instance | Install depedencies ---------------------------------------------------- 23.09s
2026-08-22 18:39:10.882064 | instance | Create a volume group for each loop device ------------------------------ 3.32s
2026-08-22 18:39:10.882068 | instance | Create a logical volume for each loop device ---------------------------- 1.84s
2026-08-22 18:39:10.882072 | instance | Gathering Facts --------------------------------------------------------- 1.17s
2026-08-22 18:39:10.882076 | instance | Purge "snapd" package --------------------------------------------------- 0.80s
2026-08-22 18:39:10.882080 | instance | Start loop devices ------------------------------------------------------ 0.70s
2026-08-22 18:39:10.882084 | instance | Gathering Facts --------------------------------------------------------- 0.70s
2026-08-22 18:39:10.882088 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.68s
2026-08-22 18:39:10.882092 | instance | Configure short hostname ------------------------------------------------ 0.68s
2026-08-22 18:39:10.882097 | instance | Set permissions on loopback devices ------------------------------------- 0.66s
2026-08-22 18:39:10.882210 | instance | Start up service -------------------------------------------------------- 0.59s
2026-08-22 18:39:10.882588 | instance | Create devices for Ceph ------------------------------------------------- 0.54s
2026-08-22 18:39:10.882916 | instance | Generate lvm.conf ------------------------------------------------------- 0.29s
2026-08-22 18:39:10.883256 | instance | Ensure hostname inside hosts file --------------------------------------- 0.26s
2026-08-22 18:39:10.883675 | instance | Get list of all loopback devices ---------------------------------------- 0.19s
2026-08-22 18:39:10.884048 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s
2026-08-22 18:39:10.986943 | instance | INFO     [csi > prepare] Executed: Successful
2026-08-22 18:39:10.997831 | instance | INFO     [csi > converge] Executing
2026-08-22 18:39:12.425907 | instance |
2026-08-22 18:39:12.426382 | instance | PLAY [Debug CSI driver value] **************************************************
2026-08-22 18:39:12.426710 | instance |
2026-08-22 18:39:12.427087 | instance | TASK [Gathering Facts] *********************************************************
2026-08-22 18:39:12.427423 | instance | Saturday 22 August 2026  18:39:12 +0000 (0:00:00.008)       0:00:00.008 *******
2026-08-22 18:39:13.427713 | instance | [WARNING]: Platform linux on host instance is using the discovered Python
2026-08-22 18:39:13.428124 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python
2026-08-22 18:39:13.428459 | instance | interpreter could change the meaning of that path. See
2026-08-22 18:39:13.428786 | instance | https://docs.ansible.com/ansible-
2026-08-22 18:39:13.429189 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information.
2026-08-22 18:39:13.438175 | instance | ok: [instance]
2026-08-22 18:39:13.438515 | instance |
2026-08-22 18:39:13.438852 | instance | TASK [Display CSI driver value and environment variable] ***********************
2026-08-22 18:39:13.439183 | instance | Saturday 22 August 2026  18:39:13 +0000 (0:00:01.012)       0:00:01.021 *******
2026-08-22 18:39:13.484059 | instance | ok: [instance] => {
2026-08-22 18:39:13.484422 | instance |     "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER="
2026-08-22 18:39:13.484745 | instance | }
2026-08-22 18:39:13.485080 | instance |
2026-08-22 18:39:13.485402 | instance | PLAY [all] *********************************************************************
2026-08-22 18:39:13.485707 | instance |
2026-08-22 18:39:13.486056 | instance | TASK [Gathering Facts] *********************************************************
2026-08-22 18:39:13.486411 | instance | Saturday 22 August 2026  18:39:13 +0000 (0:00:00.046)       0:00:01.067 *******
2026-08-22 18:39:14.373427 | instance | ok: [instance]
2026-08-22 18:39:14.373834 | instance |
2026-08-22 18:39:14.374232 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] *****************
2026-08-22 18:39:14.374665 | instance | Saturday 22 August 2026  18:39:14 +0000 (0:00:00.888)       0:00:01.955 *******
2026-08-22 18:39:14.553770 | instance | ok: [instance]
2026-08-22 18:39:14.554191 | instance |
2026-08-22 18:39:14.554544 | instance | PLAY [Deploy Ceph monitors & managers] *****************************************
2026-08-22 18:39:14.554928 | instance |
2026-08-22 18:39:14.555280 | instance | TASK [Gathering Facts] *********************************************************
2026-08-22 18:39:14.555620 | instance | Saturday 22 August 2026  18:39:14 +0000 (0:00:00.180)       0:00:02.136 *******
2026-08-22 18:39:15.438665 | instance | ok: [instance]
2026-08-22 18:39:15.438762 | instance |
2026-08-22 18:39:15.438874 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-22 18:39:15.439087 | instance | Saturday 22 August 2026  18:39:15 +0000 (0:00:00.884)       0:00:03.020 *******
2026-08-22 18:39:15.726624 | instance | ok: [instance]
2026-08-22 18:39:15.726691 | instance |
2026-08-22 18:39:15.726827 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-22 18:39:15.727000 | instance | Saturday 22 August 2026  18:39:15 +0000 (0:00:00.288)       0:00:03.309 *******
2026-08-22 18:39:15.770419 | instance | skipping: [instance]
2026-08-22 18:39:15.770532 | instance |
2026-08-22 18:39:15.770657 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] ***
2026-08-22 18:39:15.770820 | instance | Saturday 22 August 2026  18:39:15 +0000 (0:00:00.042)       0:00:03.352 *******
2026-08-22 18:39:16.094555 | instance | changed: [instance]
2026-08-22 18:39:16.094748 | instance |
2026-08-22 18:39:16.094908 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-22 18:39:16.095064 | instance | Saturday 22 August 2026  18:39:16 +0000 (0:00:00.322)       0:00:03.674 *******
2026-08-22 18:39:16.174730 | instance | ok: [instance] => {
2026-08-22 18:39:16.174924 | instance |     "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64"
2026-08-22 18:39:16.175156 | instance | }
2026-08-22 18:39:16.175348 | instance |
2026-08-22 18:39:16.175548 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-22 18:39:16.175747 | instance | Saturday 22 August 2026  18:39:16 +0000 (0:00:00.078)       0:00:03.753 *******
2026-08-22 18:39:16.870998 | instance | changed: [instance]
2026-08-22 18:39:16.871388 | instance |
2026-08-22 18:39:16.871748 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-22 18:39:16.872085 | instance | Saturday 22 August 2026  18:39:16 +0000 (0:00:00.696)       0:00:04.450 *******
2026-08-22 18:39:16.918721 | instance | skipping: [instance]
2026-08-22 18:39:16.918813 | instance |
2026-08-22 18:39:16.918961 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-22 18:39:16.919152 | instance | Saturday 22 August 2026  18:39:16 +0000 (0:00:00.050)       0:00:04.501 *******
2026-08-22 18:39:16.974622 | instance | skipping: [instance]
2026-08-22 18:39:16.974751 | instance |
2026-08-22 18:39:16.974948 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-22 18:39:16.975102 | instance | Saturday 22 August 2026  18:39:16 +0000 (0:00:00.053)       0:00:04.555 *******
2026-08-22 18:39:17.182556 | instance | ok: [instance]
2026-08-22 18:39:17.182631 | instance |
2026-08-22 18:39:17.182752 | instance | TASK [vexxhost.containers.package : Update state for tar] **********************
2026-08-22 18:39:17.182973 | instance | Saturday 22 August 2026  18:39:17 +0000 (0:00:00.209)       0:00:04.764 *******
2026-08-22 18:39:18.378947 | instance | ok: [instance]
2026-08-22 18:39:18.379447 | instance |
2026-08-22 18:39:18.379909 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-22 18:39:18.380446 | instance | Saturday 22 August 2026  18:39:18 +0000 (0:00:01.195)       0:00:05.960 *******
2026-08-22 18:39:18.444150 | instance | ok: [instance] => {
2026-08-22 18:39:18.444407 | instance |     "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz"
2026-08-22 18:39:18.444581 | instance | }
2026-08-22 18:39:18.444736 | instance |
2026-08-22 18:39:18.444894 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-22 18:39:18.445043 | instance | Saturday 22 August 2026  18:39:18 +0000 (0:00:00.065)       0:00:06.025 *******
2026-08-22 18:39:19.068821 | instance | changed: [instance]
2026-08-22 18:39:19.069458 | instance |
2026-08-22 18:39:19.069817 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-22 18:39:19.070194 | instance | Saturday 22 August 2026  18:39:19 +0000 (0:00:00.625)       0:00:06.651 *******
2026-08-22 18:39:21.859984 | instance | changed: [instance]
2026-08-22 18:39:21.860101 | instance |
2026-08-22 18:39:21.860114 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] ***************
2026-08-22 18:39:21.860127 | instance | Saturday 22 August 2026  18:39:21 +0000 (0:00:02.790)       0:00:09.441 *******
2026-08-22 18:39:21.894163 | instance | skipping: [instance]
2026-08-22 18:39:21.894233 | instance |
2026-08-22 18:39:21.894251 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] ***
2026-08-22 18:39:21.894262 | instance | Saturday 22 August 2026  18:39:21 +0000 (0:00:00.035)       0:00:09.476 *******
2026-08-22 18:39:21.924809 | instance | skipping: [instance]
2026-08-22 18:39:21.924995 | instance |
2026-08-22 18:39:21.925539 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ********
2026-08-22 18:39:21.925821 | instance | Saturday 22 August 2026  18:39:21 +0000 (0:00:00.030)       0:00:09.507 *******
2026-08-22 18:39:21.955690 | instance | skipping: [instance]
2026-08-22 18:39:21.955909 | instance |
2026-08-22 18:39:21.956223 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] **************
2026-08-22 18:39:21.956494 | instance | Saturday 22 August 2026  18:39:21 +0000 (0:00:00.031)       0:00:09.538 *******
2026-08-22 18:39:26.557548 | instance | changed: [instance]
2026-08-22 18:39:26.557634 | instance |
2026-08-22 18:39:26.557647 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] ***
2026-08-22 18:39:26.557658 | instance | Saturday 22 August 2026  18:39:26 +0000 (0:00:04.600)       0:00:14.139 *******
2026-08-22 18:39:27.158839 | instance | changed: [instance]
2026-08-22 18:39:27.158925 | instance |
2026-08-22 18:39:27.159342 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] *******
2026-08-22 18:39:27.159597 | instance | Saturday 22 August 2026  18:39:27 +0000 (0:00:00.602)       0:00:14.741 *******
2026-08-22 18:39:28.122760 | instance | changed: [instance] => (item={'path': '/etc/containerd'})
2026-08-22 18:39:28.122835 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'})
2026-08-22 18:39:28.123644 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'})
2026-08-22 18:39:28.123689 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'})
2026-08-22 18:39:28.123696 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'})
2026-08-22 18:39:28.123702 | instance |
2026-08-22 18:39:28.123711 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] **********
2026-08-22 18:39:28.123716 | instance | Saturday 22 August 2026  18:39:28 +0000 (0:00:00.964)       0:00:15.705 *******
2026-08-22 18:39:28.726100 | instance | changed: [instance]
2026-08-22 18:39:28.726185 | instance |
2026-08-22 18:39:28.726798 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ********
2026-08-22 18:39:28.726863 | instance | Saturday 22 August 2026  18:39:28 +0000 (0:00:00.585)       0:00:16.291 *******
2026-08-22 18:39:28.726869 | instance |
2026-08-22 18:39:28.726875 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-22 18:39:28.726879 | instance | Saturday 22 August 2026  18:39:28 +0000 (0:00:00.017)       0:00:16.308 *******
2026-08-22 18:39:29.660815 | instance | ok: [instance]
2026-08-22 18:39:29.661764 | instance |
2026-08-22 18:39:29.661835 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] **********
2026-08-22 18:39:29.661848 | instance | Saturday 22 August 2026  18:39:29 +0000 (0:00:00.934)       0:00:17.243 *******
2026-08-22 18:39:30.100695 | instance | changed: [instance]
2026-08-22 18:39:30.100962 | instance |
2026-08-22 18:39:30.101769 | instance | TASK [vexxhost.containers.containerd : Enable and start service] ***************
2026-08-22 18:39:30.102234 | instance | Saturday 22 August 2026  18:39:30 +0000 (0:00:00.439)       0:00:17.682 *******
2026-08-22 18:39:30.679675 | instance | changed: [instance]
2026-08-22 18:39:30.679729 | instance |
2026-08-22 18:39:30.679735 | instance | TASK [vexxhost.containers.forget_package : Forget package] *********************
2026-08-22 18:39:30.679740 | instance | Saturday 22 August 2026  18:39:30 +0000 (0:00:00.578)       0:00:18.261 *******
2026-08-22 18:39:30.903131 | instance | ok: [instance]
2026-08-22 18:39:30.903193 | instance |
2026-08-22 18:39:30.903199 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] *******
2026-08-22 18:39:30.903204 | instance | Saturday 22 August 2026  18:39:30 +0000 (0:00:00.223)       0:00:18.485 *******
2026-08-22 18:39:30.971858 | instance | ok: [instance] => {
2026-08-22 18:39:30.971914 | instance |     "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz"
2026-08-22 18:39:30.971921 | instance | }
2026-08-22 18:39:30.971927 | instance |
2026-08-22 18:39:30.971931 | instance | TASK [vexxhost.containers.download_artifact : Download item] *******************
2026-08-22 18:39:30.971937 | instance | Saturday 22 August 2026  18:39:30 +0000 (0:00:00.068)       0:00:18.553 *******
2026-08-22 18:39:31.687077 | instance | changed: [instance]
2026-08-22 18:39:31.687130 | instance |
2026-08-22 18:39:31.687136 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] *****************
2026-08-22 18:39:31.687142 | instance | Saturday 22 August 2026  18:39:31 +0000 (0:00:00.715)       0:00:19.269 *******
2026-08-22 18:39:36.060608 | instance | changed: [instance]
2026-08-22 18:39:36.060691 | instance |
2026-08-22 18:39:36.060977 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ******************
2026-08-22 18:39:36.061023 | instance | Saturday 22 August 2026  18:39:36 +0000 (0:00:04.373)       0:00:23.643 *******
2026-08-22 18:39:37.100125 | instance | ok: [instance]
2026-08-22 18:39:37.100223 | instance |
2026-08-22 18:39:37.100483 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] ***************
2026-08-22 18:39:37.100533 | instance | Saturday 22 August 2026  18:39:37 +0000 (0:00:01.039)       0:00:24.682 *******
2026-08-22 18:39:37.999283 | instance | changed: [instance]
2026-08-22 18:39:37.999364 | instance |
2026-08-22 18:39:37.999767 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] *****
2026-08-22 18:39:37.999869 | instance | Saturday 22 August 2026  18:39:37 +0000 (0:00:00.899)       0:00:25.582 *******
2026-08-22 18:39:38.462046 | instance | changed: [instance]
2026-08-22 18:39:38.462082 | instance |
2026-08-22 18:39:38.462087 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] ***********
2026-08-22 18:39:38.462092 | instance | Saturday 22 August 2026  18:39:38 +0000 (0:00:00.462)       0:00:26.044 *******
2026-08-22 18:39:39.020174 | instance | changed: [instance] => (item={'path': '/etc/docker'})
2026-08-22 18:39:39.020255 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'})
2026-08-22 18:39:39.020771 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'})
2026-08-22 18:39:39.020821 | instance |
2026-08-22 18:39:39.020827 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ******
2026-08-22 18:39:39.020832 | instance | Saturday 22 August 2026  18:39:39 +0000 (0:00:00.558)       0:00:26.602 *******
2026-08-22 18:39:39.490757 | instance | changed: [instance]
2026-08-22 18:39:39.490842 | instance |
2026-08-22 18:39:39.491108 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] ***********
2026-08-22 18:39:39.491158 | instance | Saturday 22 August 2026  18:39:39 +0000 (0:00:00.470)       0:00:27.073 *******
2026-08-22 18:39:39.960784 | instance | changed: [instance]
2026-08-22 18:39:39.960876 | instance |
2026-08-22 18:39:39.961463 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************
2026-08-22 18:39:39.961512 | instance | Saturday 22 August 2026  18:39:39 +0000 (0:00:00.453)       0:00:27.526 *******
2026-08-22 18:39:39.961518 | instance |
2026-08-22 18:39:39.961523 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] **************
2026-08-22 18:39:39.961527 | instance | Saturday 22 August 2026  18:39:39 +0000 (0:00:00.016)       0:00:27.543 *******
2026-08-22 18:39:40.654582 | instance | ok: [instance]
2026-08-22 18:39:40.654668 | instance |
2026-08-22 18:39:40.654931 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ******************
2026-08-22 18:39:40.654983 | instance | Saturday 22 August 2026  18:39:40 +0000 (0:00:00.693)       0:00:28.237 *******
2026-08-22 18:39:41.850767 | instance | changed: [instance]
2026-08-22 18:39:41.850851 | instance |
2026-08-22 18:39:41.851188 | instance | TASK [vexxhost.containers.docker : Enable and start service] *******************
2026-08-22 18:39:41.851443 | instance | Saturday 22 August 2026  18:39:41 +0000 (0:00:01.196)       0:00:29.433 *******
2026-08-22 18:39:42.450419 | instance | changed: [instance]
2026-08-22 18:39:42.450511 | instance |
2026-08-22 18:39:42.450762 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ******
2026-08-22 18:39:42.450778 | instance | Saturday 22 August 2026  18:39:42 +0000 (0:00:00.599)       0:00:30.033 *******
2026-08-22 18:39:42.502355 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml)
2026-08-22 18:39:42.502452 | instance |
2026-08-22 18:39:42.502575 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ********************************
2026-08-22 18:39:42.502703 | instance | Saturday 22 August 2026  18:39:42 +0000 (0:00:00.052)       0:00:30.085 *******
2026-08-22 18:39:47.629722 | instance | changed: [instance]
2026-08-22 18:39:47.629770 | instance |
2026-08-22 18:39:47.629776 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] *********************
2026-08-22 18:39:47.629781 | instance | Saturday 22 August 2026  18:39:47 +0000 (0:00:05.126)       0:00:35.212 *******
2026-08-22 18:39:48.288652 | instance | ok: [instance] => (item=chronyd)
2026-08-22 18:39:48.288719 | instance | ok: [instance] => (item=sshd)
2026-08-22 18:39:48.289088 | instance |
2026-08-22 18:39:48.289218 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ******************************
2026-08-22 18:39:48.289225 | instance | Saturday 22 August 2026  18:39:48 +0000 (0:00:00.659)       0:00:35.871 *******
2026-08-22 18:39:49.968689 | instance | changed: [instance]
2026-08-22 18:39:49.968781 | instance |
2026-08-22 18:39:49.969189 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ********************
2026-08-22 18:39:49.969254 | instance | Saturday 22 August 2026  18:39:49 +0000 (0:00:01.679)       0:00:37.551 *******
2026-08-22 18:39:50.172097 | instance | ok: [instance]
2026-08-22 18:39:50.172196 | instance |
2026-08-22 18:39:50.172503 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] ****************
2026-08-22 18:39:50.172558 | instance | Saturday 22 August 2026  18:39:50 +0000 (0:00:00.203)       0:00:37.754 *******
2026-08-22 18:39:50.629032 | instance | changed: [instance]
2026-08-22 18:39:50.629116 | instance |
2026-08-22 18:39:50.629400 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] ***
2026-08-22 18:39:50.629464 | instance | Saturday 22 August 2026  18:39:50 +0000 (0:00:00.457)       0:00:38.211 *******
2026-08-22 18:39:50.998883 | instance | changed: [instance]
2026-08-22 18:39:50.998958 | instance |
2026-08-22 18:39:50.999261 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] *************************
2026-08-22 18:39:50.999311 | instance | Saturday 22 August 2026  18:39:50 +0000 (0:00:00.369)       0:00:38.581 *******
2026-08-22 18:39:51.117500 | instance | ok: [instance]
2026-08-22 18:39:51.117625 | instance |
2026-08-22 18:39:51.117693 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] *******************
2026-08-22 18:39:51.117914 | instance | Saturday 22 August 2026  18:39:51 +0000 (0:00:00.117)       0:00:38.699 *******
2026-08-22 18:39:51.355864 | instance | ok: [instance] => (item=instance)
2026-08-22 18:39:51.355936 | instance |
2026-08-22 18:39:51.356251 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ********
2026-08-22 18:39:51.356323 | instance | Saturday 22 August 2026  18:39:51 +0000 (0:00:00.238)       0:00:38.938 *******
2026-08-22 18:39:51.414746 | instance | ok: [instance]
2026-08-22 18:39:51.415127 | instance |
2026-08-22 18:39:51.415149 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] ***********************************
2026-08-22 18:39:51.415156 | instance | Saturday 22 August 2026  18:39:51 +0000 (0:00:00.058)       0:00:38.997 *******
2026-08-22 18:39:51.493029 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance
2026-08-22 18:39:51.493434 | instance |
2026-08-22 18:39:51.493473 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] *************
2026-08-22 18:39:51.493480 | instance | Saturday 22 August 2026  18:39:51 +0000 (0:00:00.078)       0:00:39.075 *******
2026-08-22 18:39:51.805116 | instance | changed: [instance]
2026-08-22 18:39:51.805200 | instance |
2026-08-22 18:39:51.805487 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ******************
2026-08-22 18:39:51.805550 | instance | Saturday 22 August 2026  18:39:51 +0000 (0:00:00.311)       0:00:39.387 *******
2026-08-22 18:39:52.542550 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True})
2026-08-22 18:39:52.542632 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0})
2026-08-22 18:39:52.543203 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False})
2026-08-22 18:39:52.543268 | instance |
2026-08-22 18:39:52.543277 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] *******************************
2026-08-22 18:39:52.543282 | instance | Saturday 22 August 2026  18:39:52 +0000 (0:00:00.737)       0:00:40.125 *******
2026-08-22 18:41:32.180767 | instance | ok: [instance]
2026-08-22 18:41:32.181299 | instance |
2026-08-22 18:41:32.181306 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] ***************
2026-08-22 18:41:32.181311 | instance | Saturday 22 August 2026  18:41:32 +0000 (0:01:39.636)       0:02:19.761 *******
2026-08-22 18:41:32.403290 | instance | changed: [instance]
2026-08-22 18:41:32.403363 | instance |
2026-08-22 18:41:32.403369 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] **********************************
2026-08-22 18:41:32.403374 | instance | Saturday 22 August 2026  18:41:32 +0000 (0:00:00.223)       0:02:19.985 *******
2026-08-22 18:41:32.522758 | instance | ok: [instance]
2026-08-22 18:41:32.522824 | instance |
2026-08-22 18:41:32.522830 | instance | TASK [Install Ceph host] *******************************************************
2026-08-22 18:41:32.522836 | instance | Saturday 22 August 2026  18:41:32 +0000 (0:00:00.119)       0:02:20.104 *******
2026-08-22 18:41:32.621908 | instance | included: vexxhost.ceph.cephadm_host for instance
2026-08-22 18:41:32.621951 | instance |
2026-08-22 18:41:32.621957 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ******
2026-08-22 18:41:32.621962 | instance | Saturday 22 August 2026  18:41:32 +0000 (0:00:00.099)       0:02:20.204 *******
2026-08-22 18:41:34.363637 | instance | ok: [instance]
2026-08-22 18:41:34.363679 | instance |
2026-08-22 18:41:34.363686 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] ***
2026-08-22 18:41:34.363691 | instance | Saturday 22 August 2026  18:41:34 +0000 (0:00:01.741)       0:02:21.946 *******
2026-08-22 18:41:34.423464 | instance | ok: [instance] => (item=instance)
2026-08-22 18:41:34.423488 | instance |
2026-08-22 18:41:34.423493 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] ***********
2026-08-22 18:41:34.423498 | instance | Saturday 22 August 2026  18:41:34 +0000 (0:00:00.060)       0:02:22.006 *******
2026-08-22 18:41:34.799263 | instance | ok: [instance]
2026-08-22 18:41:34.799337 | instance |
2026-08-22 18:41:34.799644 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] ***********************
2026-08-22 18:41:34.799696 | instance | Saturday 22 August 2026  18:41:34 +0000 (0:00:00.375)       0:02:22.381 *******
2026-08-22 18:41:37.261287 | instance | ok: [instance]
2026-08-22 18:41:37.261386 | instance |
2026-08-22 18:41:37.261665 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ******************
2026-08-22 18:41:37.261705 | instance | Saturday 22 August 2026  18:41:37 +0000 (0:00:02.462)       0:02:24.844 *******
2026-08-22 18:42:29.945606 | 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-22 18:42:29.946347 | 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_z0n204fe/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_z0n204fe/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_z0n204fe/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_z0n204fe/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-22T18:42:29.736+0000 7f27b10f5640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAp7YlqE/PRIyAAyjyuLGmSgIlMDfLsSiPMhsqYGzX7Ut05uxOYM+c0/+o=: Malformed input [buffer:3]\n2026-08-22T18:42:29.736+0000 7f27b10f5640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-22T18:42:29.736+0000 7f27b10f5640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAp7YlqE/PRIyAAyjyuLGmSgIlMDfLsSiPMhsqYGzX7Ut05uxOYM+c0/+o=: Malformed input [buffer:3]\n2026-08-22T18:42:29.736+0000 7f27b10f5640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-22T18:42:29.736+0000 7f27b10f5640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgAp7YlqE/PRIyAAyjyuLGmSgIlMDfLsSiPMhsqYGzX7Ut05uxOYM+c0/+o=: Malformed input [buffer:3]\n2026-08-22T18:42:29.736+0000 7f27b10f5640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-22T18:42:29.736+0000 7f27b10f5640 -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-22 18:42:29.948783 | instance |
2026-08-22 18:42:29.948988 | instance | PLAY RECAP *********************************************************************
2026-08-22 18:42:29.949173 | instance | instance                   : ok=55   changed=26   unreachable=0    failed=1    skipped=6    rescued=0    ignored=0
2026-08-22 18:42:29.949319 | instance |
2026-08-22 18:42:29.949487 | instance | Saturday 22 August 2026  18:42:29 +0000 (0:00:52.688)       0:03:17.532 *******
2026-08-22 18:42:29.949649 | instance | ===============================================================================
2026-08-22 18:42:29.949815 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 99.64s
2026-08-22 18:42:29.949977 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 52.69s
2026-08-22 18:42:29.950186 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 5.13s
2026-08-22 18:42:29.950352 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 4.60s
2026-08-22 18:42:29.950512 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.37s
2026-08-22 18:42:29.950673 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.79s
2026-08-22 18:42:29.950838 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.46s
2026-08-22 18:42:29.951006 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.74s
2026-08-22 18:42:29.951168 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 1.68s
2026-08-22 18:42:29.951329 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.63s
2026-08-22 18:42:29.951488 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 1.20s
2026-08-22 18:42:29.951650 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.20s
2026-08-22 18:42:29.951812 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.04s
2026-08-22 18:42:29.951970 | instance | Gathering Facts --------------------------------------------------------- 1.01s
2026-08-22 18:42:29.952132 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.96s
2026-08-22 18:42:29.952305 | instance | vexxhost.containers.docker : Ensure group "docker" exists --------------- 0.90s
2026-08-22 18:42:29.952454 | instance | Gathering Facts --------------------------------------------------------- 0.89s
2026-08-22 18:42:29.952615 | instance | Gathering Facts --------------------------------------------------------- 0.88s
2026-08-22 18:42:29.952784 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.74s
2026-08-22 18:42:29.953004 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.72s
2026-08-22 18:42:30.073461 | 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-22 18:42:30.074349 | instance | ERROR    [csi > converge] Executed: Failed
2026-08-22 18:42:30.074514 | 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-22 18:42:30.530077 | instance | ERROR
2026-08-22 18:42:30.530215 | instance | {
2026-08-22 18:42:30.530278 | instance |   "delta": "0:04:09.730272",
2026-08-22 18:42:30.530309 | instance |   "end": "2026-08-22 18:42:30.160267",
2026-08-22 18:42:30.530341 | instance |   "msg": "non-zero return code",
2026-08-22 18:42:30.530368 | instance |   "rc": 2,
2026-08-22 18:42:30.530393 | instance |   "start": "2026-08-22 18:38:20.429995"
2026-08-22 18:42:30.530417 | instance | }
failure
2026-08-22 18:42:30.537107 | 
2026-08-22 18:42:30.537209 | PLAY RECAP
2026-08-22 18:42:30.537296 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-08-22 18:42:30.537344 | 
2026-08-22 18:42:30.722526 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main]
2026-08-22 18:42:30.730980 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-22 18:42:31.548093 | 
2026-08-22 18:42:31.548239 | PLAY [all]
2026-08-22 18:42:31.583920 | 
2026-08-22 18:42:31.584067 | TASK [gather-host-logs : creating directory for system status]
2026-08-22 18:42:31.967565 | instance | changed
2026-08-22 18:42:31.972767 | 
2026-08-22 18:42:31.972846 | TASK [gather-host-logs : Get logs for each host]
2026-08-22 18:42:32.311216 | instance | + systemd-cgls --full --all --no-pager
2026-08-22 18:42:32.325732 | instance | + ip addr
2026-08-22 18:42:32.327636 | instance | + ip route
2026-08-22 18:42:32.328981 | instance | + lsblk
2026-08-22 18:42:32.334497 | instance | + mount
2026-08-22 18:42:32.337461 | instance | + docker images
2026-08-22 18:42:32.356572 | instance | + brctl show
2026-08-22 18:42:32.357206 | instance | /bin/bash: line 8: brctl: command not found
2026-08-22 18:42:32.357573 | instance | + ps aux --sort=-%mem
2026-08-22 18:42:32.376253 | instance | + dpkg -l
2026-08-22 18:42:32.389457 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul))
2026-08-22 18:42:32.390138 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul
2026-08-22 18:42:32.409650 | instance | + '[' '!' -z '' ']'
2026-08-22 18:42:33.357464 | instance | ok: Runtime: 0:00:00.105024
2026-08-22 18:42:33.363951 | 
2026-08-22 18:42:33.364031 | TASK [gather-host-logs : Downloads logs to executor]
2026-08-22 18:42:34.036181 | instance | changed:
2026-08-22 18:42:34.036358 | instance | created directory /var/lib/zuul/builds/81992bd66d3e4f8eaf5cf5b5301a8e82/work/logs/instance
2026-08-22 18:42:34.036397 | instance | cd+++++++++ system/
2026-08-22 18:42:34.036427 | instance | >f+++++++++ system/brctl-show.txt
2026-08-22 18:42:34.036456 | instance | >f+++++++++ system/docker-images.txt
2026-08-22 18:42:34.036483 | instance | >f+++++++++ system/ip-addr.txt
2026-08-22 18:42:34.036513 | instance | >f+++++++++ system/ip-route.txt
2026-08-22 18:42:34.036541 | instance | >f+++++++++ system/lsblk.txt
2026-08-22 18:42:34.036569 | instance | >f+++++++++ system/mount.txt
2026-08-22 18:42:34.036627 | instance | >f+++++++++ system/packages.txt
2026-08-22 18:42:34.036654 | instance | >f+++++++++ system/ps.txt
2026-08-22 18:42:34.036684 | instance | >f+++++++++ system/systemd-cgls.txt
2026-08-22 18:42:34.049336 | 
2026-08-22 18:42:34.049400 | LOOP [helm-release-status : creating directory for helm release status]
2026-08-22 18:42:34.275687 | instance | changed: "values"
2026-08-22 18:42:34.451140 | instance | changed: "releases"
2026-08-22 18:42:34.463461 | 
2026-08-22 18:42:34.463625 | TASK [helm-release-status : Gather get release status for helm charts]
2026-08-22 18:42:34.682642 | instance | /bin/bash: line 3: kubectl: command not found
2026-08-22 18:42:35.003575 | instance | ok: Runtime: 0:00:00.006105
2026-08-22 18:42:35.011499 | 
2026-08-22 18:42:35.011566 | TASK [helm-release-status : Downloads logs to executor]
2026-08-22 18:42:35.510659 | instance | changed:
2026-08-22 18:42:35.510888 | instance | cd+++++++++ helm/
2026-08-22 18:42:35.510951 | instance | cd+++++++++ helm/releases/
2026-08-22 18:42:35.511000 | instance | cd+++++++++ helm/values/
2026-08-22 18:42:35.520503 | 
2026-08-22 18:42:35.520574 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects]
2026-08-22 18:42:35.725356 | instance | changed
2026-08-22 18:42:35.732553 | 
2026-08-22 18:42:35.732622 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects]
2026-08-22 18:42:36.010353 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-22 18:42:36.010590 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-22 18:42:36.017242 | instance | environment: line 1: kubectl: command not found
2026-08-22 18:42:36.018247 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-22 18:42:36.018795 | instance | environment: line 1: kubectl: command not found
2026-08-22 18:42:36.019628 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-22 18:42:36.021516 | instance | environment: line 1: kubectl: command not found
2026-08-22 18:42:36.022648 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-22 18:42:36.023964 | instance | environment: line 1: kubectl: command not found
2026-08-22 18:42:36.025726 | instance | environment: line 1: kubectl: command not found
2026-08-22 18:42:36.025879 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-22 18:42:36.027773 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value
2026-08-22 18:42:36.272473 | instance | ok: Runtime: 0:00:00.026018
2026-08-22 18:42:36.278023 | 
2026-08-22 18:42:36.278083 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects]
2026-08-22 18:42:36.463411 | instance | changed
2026-08-22 18:42:36.468812 | 
2026-08-22 18:42:36.468883 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects]
2026-08-22 18:42:36.682293 | instance | environment: line 5: kubectl: command not found
2026-08-22 18:42:36.683737 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-22 18:42:36.683770 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-22 18:42:36.683905 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value
2026-08-22 18:42:37.007191 | instance | ok: Runtime: 0:00:00.009162
2026-08-22 18:42:37.013786 | 
2026-08-22 18:42:37.013859 | TASK [describe-kubernetes-objects : Downloads logs to executor]
2026-08-22 18:42:37.484726 | instance | changed:
2026-08-22 18:42:37.484907 | instance | cd+++++++++ objects/
2026-08-22 18:42:37.484947 | instance | cd+++++++++ objects/cluster/
2026-08-22 18:42:37.484986 | instance | cd+++++++++ objects/namespaced/
2026-08-22 18:42:37.495922 | 
2026-08-22 18:42:37.495983 | TASK [gather-pod-logs : creating directory for pod logs]
2026-08-22 18:42:37.691963 | instance | changed
2026-08-22 18:42:37.697125 | 
2026-08-22 18:42:37.697188 | TASK [gather-pod-logs : creating directory for failed pod logs]
2026-08-22 18:42:37.883798 | instance | changed
2026-08-22 18:42:37.888609 | 
2026-08-22 18:42:37.888691 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)]
2026-08-22 18:42:38.090269 | instance | environment: line 3: kubectl: command not found
2026-08-22 18:42:38.426102 | instance | ok: Runtime: 0:00:00.007301
2026-08-22 18:42:38.432119 | 
2026-08-22 18:42:38.432180 | TASK [gather-pod-logs : Downloads pod logs to executor]
2026-08-22 18:42:38.903925 | instance | changed:
2026-08-22 18:42:38.904105 | instance | cd+++++++++ pod-logs/
2026-08-22 18:42:38.904229 | instance | cd+++++++++ pod-logs/failed-pods/
2026-08-22 18:42:38.914908 | 
2026-08-22 18:42:38.914968 | TASK [gather-prom-metrics : creating directory for helm release descriptions]
2026-08-22 18:42:39.120588 | instance | changed
2026-08-22 18:42:39.127467 | 
2026-08-22 18:42:39.127553 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces]
2026-08-22 18:42:39.323033 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-22 18:42:39.662027 | instance | ok: Runtime: 0:00:00.034662
2026-08-22 18:42:39.668453 | 
2026-08-22 18:42:39.668646 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr]
2026-08-22 18:42:39.871325 | instance | /bin/bash: line 2: kubectl: command not found
2026-08-22 18:42:39.899667 | instance | ceph-mgr endpoints:
2026-08-22 18:42:40.207142 | instance | ok: Runtime: 0:00:00.034239
2026-08-22 18:42:40.214101 | 
2026-08-22 18:42:40.214165 | TASK [gather-prom-metrics : Get metrics from fluentd pods]
2026-08-22 18:42:40.422786 | instance | /bin/bash: line 4: kubectl: command not found
2026-08-22 18:42:40.748699 | instance | ok: Runtime: 0:00:00.032762
2026-08-22 18:42:40.755726 | 
2026-08-22 18:42:40.755788 | TASK [gather-prom-metrics : Downloads logs to executor]
2026-08-22 18:42:41.230718 | instance | changed: cd+++++++++ prometheus/
2026-08-22 18:42:41.239636 | 
2026-08-22 18:42:41.239696 | TASK [gather-selenium-data : creating directory for helm release descriptions]
2026-08-22 18:42:41.431976 | instance | changed
2026-08-22 18:42:41.437497 | 
2026-08-22 18:42:41.437561 | TASK [gather-selenium-data : Get selenium data]
2026-08-22 18:42:41.670336 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/.
2026-08-22 18:42:41.672027 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory
2026-08-22 18:42:41.977047 | instance | ERROR
2026-08-22 18:42:41.977318 | instance | {
2026-08-22 18:42:41.977388 | instance |   "delta": "0:00:00.008356",
2026-08-22 18:42:41.977438 | instance |   "end": "2026-08-22 18:42:41.672438",
2026-08-22 18:42:41.977488 | instance |   "msg": "non-zero return code",
2026-08-22 18:42:41.977533 | instance |   "rc": 1,
2026-08-22 18:42:41.977577 | instance |   "start": "2026-08-22 18:42:41.664082"
2026-08-22 18:42:41.977620 | instance | }
2026-08-22 18:42:41.977674 | instance | ERROR: Ignoring Errors
2026-08-22 18:42:41.982812 | 
2026-08-22 18:42:41.982886 | TASK [gather-selenium-data : Downloads logs to executor]
2026-08-22 18:42:42.615731 | instance | changed: cd+++++++++ selenium/
2026-08-22 18:42:42.622448 | 
2026-08-22 18:42:42.664397 | PLAY RECAP
2026-08-22 18:42:42.664640 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1
2026-08-22 18:42:42.664701 | 
2026-08-22 18:42:42.792586 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main]
2026-08-22 18:42:42.795671 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-22 18:42:43.433116 | 
2026-08-22 18:42:43.433232 | PLAY [all]
2026-08-22 18:42:43.444838 | 
2026-08-22 18:42:43.444926 | TASK [fetch-output : Set log path for multiple nodes]
2026-08-22 18:42:43.489853 | instance | skipping: Conditional result was False
2026-08-22 18:42:43.496748 | 
2026-08-22 18:42:43.496854 | TASK [fetch-output : Set log path for single node]
2026-08-22 18:42:43.539666 | instance | ok
2026-08-22 18:42:43.545481 | 
2026-08-22 18:42:43.545548 | LOOP [fetch-output : Ensure local output dirs]
2026-08-22 18:42:43.986525 | instance -> localhost | ok: "/var/lib/zuul/builds/81992bd66d3e4f8eaf5cf5b5301a8e82/work/logs"
2026-08-22 18:42:44.198645 | instance -> localhost | changed: "/var/lib/zuul/builds/81992bd66d3e4f8eaf5cf5b5301a8e82/work/artifacts"
2026-08-22 18:42:44.431981 | instance -> localhost | changed: "/var/lib/zuul/builds/81992bd66d3e4f8eaf5cf5b5301a8e82/work/docs"
2026-08-22 18:42:44.456850 | 
2026-08-22 18:42:44.457076 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-08-22 18:42:45.126184 | instance | changed: .d..t...... ./
2026-08-22 18:42:45.126414 | instance | changed: All items complete
2026-08-22 18:42:45.126459 | 
2026-08-22 18:42:45.570707 | instance | changed: .d..t...... ./
2026-08-22 18:42:46.104358 | instance | changed: .d..t...... ./
2026-08-22 18:42:46.123513 | 
2026-08-22 18:42:46.123890 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-08-22 18:42:46.519677 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.008625
2026-08-22 18:42:46.765341 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.009002
2026-08-22 18:42:46.778422 | 
2026-08-22 18:42:46.778487 | PLAY [all]
2026-08-22 18:42:46.784317 | 
2026-08-22 18:42:46.784384 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes]
2026-08-22 18:42:47.214535 | instance | changed
2026-08-22 18:42:47.220219 | 
2026-08-22 18:42:47.220272 | PLAY RECAP
2026-08-22 18:42:47.220323 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0
2026-08-22 18:42:47.220346 | 
2026-08-22 18:42:47.337727 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main]
2026-08-22 18:42:47.341913 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main]
2026-08-22 18:42:47.973821 | 
2026-08-22 18:42:47.974019 | PLAY [localhost]
2026-08-22 18:42:47.985401 | 
2026-08-22 18:42:47.985488 | TASK [Generate Zuul manifest]
2026-08-22 18:42:48.008459 | localhost | ok
2026-08-22 18:42:48.028403 | 
2026-08-22 18:42:48.028509 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-08-22 18:42:48.384095 | localhost | changed
2026-08-22 18:42:48.396485 | 
2026-08-22 18:42:48.396563 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-08-22 18:42:48.425728 | localhost | ok
2026-08-22 18:42:48.433677 | 
2026-08-22 18:42:48.433736 | TASK [Upload logs]
2026-08-22 18:42:48.454700 | localhost | ok
2026-08-22 18:42:48.563834 | 
2026-08-22 18:42:48.563952 | TASK [Set zuul-log-path fact]
2026-08-22 18:42:48.583128 | localhost | ok
2026-08-22 18:42:48.624071 | 
2026-08-22 18:42:48.624202 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-08-22 18:42:48.653554 | localhost | ok
2026-08-22 18:42:48.662978 | 
2026-08-22 18:42:48.663043 | TASK [upload-logs : Create log directories]
2026-08-22 18:42:49.077030 | localhost | changed
2026-08-22 18:42:49.083691 | 
2026-08-22 18:42:49.083757 | TASK [upload-logs : Ensure logs are readable before uploading]
2026-08-22 18:42:49.469653 | localhost -> localhost | ok: Runtime: 0:00:00.005190
2026-08-22 18:42:49.476343 | 
2026-08-22 18:42:49.476427 | TASK [upload-logs : Upload logs to log server]
2026-08-22 18:42:49.924236 | localhost | Output suppressed because no_log was given
2026-08-22 18:42:49.956538 | 
2026-08-22 18:42:49.956653 | LOOP [upload-logs : Compress console log and json output]
2026-08-22 18:42:49.997925 | localhost | skipping: Conditional result was False
2026-08-22 18:42:50.005306 | localhost | skipping: Conditional result was False
2026-08-22 18:42:50.019285 | 
2026-08-22 18:42:50.019471 | LOOP [upload-logs : Upload compressed console log and json output]
2026-08-22 18:42:50.060376 | localhost | skipping: Conditional result was False
2026-08-22 18:42:50.060779 | 
2026-08-22 18:42:50.064529 | localhost | skipping: Conditional result was False
2026-08-22 18:42:50.072542 | 
2026-08-22 18:42:50.072686 | LOOP [upload-logs : Upload console log and json output]