2026-08-26 03:52:24.534204 | Job console starting 2026-08-26 03:52:24.545719 | Updating git repos 2026-08-26 03:52:30.393299 | Cloning repos into workspace 2026-08-26 03:52:45.115837 | Restoring repo states 2026-08-26 03:52:52.056217 | Merging changes 2026-08-26 03:52:53.465537 | Checking out repos 2026-08-26 03:52:57.804436 | Preparing playbooks 2026-08-26 03:53:00.898422 | Running Ansible setup 2026-08-26 03:53:04.528115 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-26 03:53:05.127581 | 2026-08-26 03:53:05.127706 | PLAY [localhost] 2026-08-26 03:53:05.135150 | 2026-08-26 03:53:05.135228 | TASK [Gathering Facts] 2026-08-26 03:53:06.090420 | localhost | ok 2026-08-26 03:53:06.100345 | 2026-08-26 03:53:06.100453 | TASK [Setup log path fact] 2026-08-26 03:53:06.120611 | localhost | ok 2026-08-26 03:53:06.131716 | 2026-08-26 03:53:06.131785 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-26 03:53:06.159028 | localhost | ok 2026-08-26 03:53:06.168830 | 2026-08-26 03:53:06.168901 | TASK [emit-job-header : Print job information] 2026-08-26 03:53:06.203284 | # Job Information 2026-08-26 03:53:06.203424 | Ansible Version: 2.16.18 2026-08-26 03:53:06.203456 | Job: atmosphere-molecule-csi-rbd 2026-08-26 03:53:06.203478 | Pipeline: check 2026-08-26 03:53:06.203498 | Executor: 2d72f0692154 2026-08-26 03:53:06.203518 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4094 2026-08-26 03:53:06.203541 | Event ID: 04106aa0-a101-11f1-8b62-5c6c56079ebc 2026-08-26 03:53:06.206337 | 2026-08-26 03:53:06.206398 | LOOP [emit-job-header : Print node information] 2026-08-26 03:53:06.373375 | localhost | ok: 2026-08-26 03:53:06.385038 | localhost | # Node Information 2026-08-26 03:53:06.385143 | localhost | Inventory Hostname: instance 2026-08-26 03:53:06.385182 | localhost | Hostname: np0000191124 2026-08-26 03:53:06.385216 | localhost | Username: zuul 2026-08-26 03:53:06.385249 | localhost | Distro: Ubuntu 22.04 2026-08-26 03:53:06.385277 | localhost | Provider: yul1 2026-08-26 03:53:06.385304 | localhost | Region: ca-ymq-1 2026-08-26 03:53:06.385330 | localhost | Label: ubuntu-jammy 2026-08-26 03:53:06.385355 | localhost | Product Name: OpenStack Nova 2026-08-26 03:53:06.385380 | localhost | Interface IP: 162.253.55.189 2026-08-26 03:53:06.402052 | 2026-08-26 03:53:06.402186 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-26 03:53:06.780947 | localhost -> localhost | changed 2026-08-26 03:53:06.785916 | 2026-08-26 03:53:06.785996 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-26 03:53:07.762576 | localhost -> localhost | changed 2026-08-26 03:53:07.773227 | 2026-08-26 03:53:07.773318 | PLAY [all] 2026-08-26 03:53:07.784004 | 2026-08-26 03:53:07.784097 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-26 03:53:08.037835 | instance -> localhost | ok 2026-08-26 03:53:08.044054 | 2026-08-26 03:53:08.044137 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-26 03:53:08.078255 | instance | ok 2026-08-26 03:53:08.098905 | instance | included: /var/lib/zuul/builds/3285a320c2374b4b90027c44c4926fe3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-26 03:53:08.104846 | 2026-08-26 03:53:08.104907 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-26 03:53:10.061649 | instance -> localhost | Generating public/private rsa key pair. 2026-08-26 03:53:10.061832 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/3285a320c2374b4b90027c44c4926fe3/work/3285a320c2374b4b90027c44c4926fe3_id_rsa 2026-08-26 03:53:10.061874 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/3285a320c2374b4b90027c44c4926fe3/work/3285a320c2374b4b90027c44c4926fe3_id_rsa.pub 2026-08-26 03:53:10.061906 | instance -> localhost | The key fingerprint is: 2026-08-26 03:53:10.061936 | instance -> localhost | SHA256:XoAjRr4hp/XO5tHw4HoXkOfKgdnlxhsm8kxnBRoIQYE zuul-build-sshkey 2026-08-26 03:53:10.061977 | instance -> localhost | The key's randomart image is: 2026-08-26 03:53:10.062008 | instance -> localhost | +---[RSA 3072]----+ 2026-08-26 03:53:10.062042 | instance -> localhost | | o=+.. | 2026-08-26 03:53:10.062073 | instance -> localhost | |E o. ... | 2026-08-26 03:53:10.062101 | instance -> localhost | | . B o+.. | 2026-08-26 03:53:10.062130 | instance -> localhost | | * =+.o.. | 2026-08-26 03:53:10.062159 | instance -> localhost | | . .++BS.. | 2026-08-26 03:53:10.062187 | instance -> localhost | | ++=*@. | 2026-08-26 03:53:10.062215 | instance -> localhost | | **O++ | 2026-08-26 03:53:10.062243 | instance -> localhost | | +*.o | 2026-08-26 03:53:10.062275 | instance -> localhost | | .... | 2026-08-26 03:53:10.062304 | instance -> localhost | +----[SHA256]-----+ 2026-08-26 03:53:10.062367 | instance -> localhost | ok: Runtime: 0:00:01.473020 2026-08-26 03:53:10.070303 | 2026-08-26 03:53:10.070388 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-26 03:53:10.103511 | instance | ok 2026-08-26 03:53:10.114447 | instance | included: /var/lib/zuul/builds/3285a320c2374b4b90027c44c4926fe3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-26 03:53:10.122187 | 2026-08-26 03:53:10.122249 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-26 03:53:10.147559 | instance | skipping: Conditional result was False 2026-08-26 03:53:10.156705 | 2026-08-26 03:53:10.156800 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-26 03:53:10.635645 | instance | changed 2026-08-26 03:53:10.835745 | 2026-08-26 03:53:10.835832 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-26 03:53:11.021127 | instance | ok 2026-08-26 03:53:11.028519 | 2026-08-26 03:53:11.028609 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-26 03:53:11.504162 | instance | changed 2026-08-26 03:53:11.509251 | 2026-08-26 03:53:11.509320 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-26 03:53:11.981542 | instance | changed 2026-08-26 03:53:11.988352 | 2026-08-26 03:53:11.988417 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-26 03:53:12.011840 | instance | skipping: Conditional result was False 2026-08-26 03:53:12.021975 | 2026-08-26 03:53:12.022142 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-26 03:53:12.362466 | instance -> localhost | changed 2026-08-26 03:53:12.378139 | 2026-08-26 03:53:12.378237 | TASK [add-build-sshkey : Add back temp key] 2026-08-26 03:53:12.656067 | instance -> localhost | Identity added: /var/lib/zuul/builds/3285a320c2374b4b90027c44c4926fe3/work/3285a320c2374b4b90027c44c4926fe3_id_rsa (zuul-build-sshkey) 2026-08-26 03:53:12.656423 | instance -> localhost | ok: Runtime: 0:00:00.013658 2026-08-26 03:53:12.661693 | 2026-08-26 03:53:12.661758 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-26 03:53:12.976390 | instance | ok 2026-08-26 03:53:12.981076 | 2026-08-26 03:53:12.981141 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-26 03:53:13.004694 | instance | skipping: Conditional result was False 2026-08-26 03:53:13.016317 | 2026-08-26 03:53:13.016465 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-08-26 03:53:13.342477 | instance | ok 2026-08-26 03:53:13.350202 | 2026-08-26 03:53:13.350291 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-08-26 03:53:16.882315 | instance | Output suppressed because no_log was given 2026-08-26 03:53:16.893716 | 2026-08-26 03:53:16.893806 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-08-26 03:53:17.084289 | instance | ok: "logs" 2026-08-26 03:53:17.084561 | instance | ok: All items complete 2026-08-26 03:53:17.084601 | 2026-08-26 03:53:17.235702 | instance | ok: "artifacts" 2026-08-26 03:53:17.394640 | instance | ok: "docs" 2026-08-26 03:53:17.417255 | 2026-08-26 03:53:17.417323 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-08-26 03:53:17.607895 | instance | changed: "logs" 2026-08-26 03:53:17.763419 | instance | changed: "artifacts" 2026-08-26 03:53:18.012175 | instance | changed: "docs" 2026-08-26 03:53:18.026129 | 2026-08-26 03:53:18.026199 | PLAY RECAP 2026-08-26 03:53:18.026257 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-08-26 03:53:18.026298 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-26 03:53:18.026329 | 2026-08-26 03:53:18.201262 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-26 03:53:18.204686 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-26 03:53:18.822205 | 2026-08-26 03:53:18.826705 | PLAY [all] 2026-08-26 03:53:18.842594 | 2026-08-26 03:53:18.842732 | TASK [setup-uv : Extract archive] 2026-08-26 03:53:20.999092 | instance | changed 2026-08-26 03:53:21.007227 | 2026-08-26 03:53:21.007569 | TASK [setup-uv : Print version] 2026-08-26 03:53:21.349039 | instance | uv 0.8.13 2026-08-26 03:53:21.554253 | instance | ok: Runtime: 0:00:00.012885 2026-08-26 03:53:21.564629 | 2026-08-26 03:53:21.564718 | TASK [Install Ansible collection siblings] 2026-08-26 03:53:30.463026 | instance | changed: 2026-08-26 03:53:30.463223 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-08-26 03:53:30.463264 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-08-26 03:53:30.463295 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-08-26 03:53:30.463325 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto 2026-08-26 03:53:30.463354 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general 2026-08-26 03:53:30.463387 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql 2026-08-26 03:53:30.463417 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-08-26 03:53:30.463447 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-08-26 03:53:30.463475 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-08-26 03:53:30.463506 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-08-26 03:53:30.463544 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-08-26 03:53:30.463575 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-08-26 03:53:30.463602 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0 2026-08-26 03:53:30.463629 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0 2026-08-26 03:53:30.463655 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0 2026-08-26 03:53:30.463695 | instance | Resolved community.crypto to 2.2.3 for 2.2.3 2026-08-26 03:53:30.463723 | instance | Resolved community.general to 7.3.0 for 7.3.0 2026-08-26 03:53:30.463750 | instance | Resolved community.mysql to 3.6.0 for 3.6.0 2026-08-26 03:53:30.463775 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0 2026-08-26 03:53:30.463800 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0 2026-08-26 03:53:30.463826 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0 2026-08-26 03:53:30.463851 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0 2026-08-26 03:53:30.463878 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-08-26 03:53:30.463918 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0 2026-08-26 03:53:30.463947 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0 2026-08-26 03:53:30.463973 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-08-26 03:53:30.464001 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-08-26 03:53:30.464027 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-08-26 03:53:30.464053 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0 2026-08-26 03:53:30.464078 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3 2026-08-26 03:53:30.464104 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-08-26 03:53:30.464130 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-08-26 03:53:30.464156 | instance | Checked out ansible.netcommon to 1.2.0 2026-08-26 03:53:30.464182 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-08-26 03:53:30.464216 | instance | Starting galaxy collection install process 2026-08-26 03:53:30.464242 | instance | Process install dependency map 2026-08-26 03:53:30.464267 | instance | Starting collection install process 2026-08-26 03:53:30.464293 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon' 2026-08-26 03:53:30.464318 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon 2026-08-26 03:53:30.464343 | instance | ansible.netcommon:* was installed successfully 2026-08-26 03:53:30.464368 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-08-26 03:53:30.464393 | instance | Creating virtual environment at: .venv 2026-08-26 03:53:30.464418 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-08-26 03:53:30.464443 | instance | Downloading rjsonnet (1.2MiB) 2026-08-26 03:53:30.464468 | instance | Downloading cryptography (4.2MiB) 2026-08-26 03:53:30.464499 | instance | Downloading pygments (1.2MiB) 2026-08-26 03:53:30.464525 | instance | Downloading ansible-core (2.1MiB) 2026-08-26 03:53:30.464550 | instance | Downloading setuptools (1.1MiB) 2026-08-26 03:53:30.464576 | instance | Downloading openstacksdk (1.7MiB) 2026-08-26 03:53:30.464601 | instance | Downloading netaddr (2.2MiB) 2026-08-26 03:53:30.464627 | instance | Downloading pydantic-core (2.0MiB) 2026-08-26 03:53:30.464654 | instance | Downloading kubernetes (1.9MiB) 2026-08-26 03:53:30.464778 | instance | Building pyperclip==1.9.0 2026-08-26 03:53:30.464811 | instance | Downloading rjsonnet 2026-08-26 03:53:30.464839 | instance | Downloading pydantic-core 2026-08-26 03:53:30.464866 | instance | Downloading pygments 2026-08-26 03:53:30.464892 | instance | Downloading netaddr 2026-08-26 03:53:30.464919 | instance | Downloading cryptography 2026-08-26 03:53:30.464945 | instance | Downloading setuptools 2026-08-26 03:53:30.464999 | instance | Downloading kubernetes 2026-08-26 03:53:30.465026 | instance | Downloading ansible-core 2026-08-26 03:53:30.465052 | instance | Downloading openstacksdk 2026-08-26 03:53:30.465078 | instance | Built pyperclip==1.9.0 2026-08-26 03:53:30.465104 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-08-26 03:53:30.465130 | instance | Installed 83 packages in 43ms 2026-08-26 03:53:30.465156 | instance | Checked out ansible.posix to 1.6.0 2026-08-26 03:53:30.465181 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-08-26 03:53:30.465227 | instance | Starting galaxy collection install process 2026-08-26 03:53:30.465254 | instance | Process install dependency map 2026-08-26 03:53:30.465288 | instance | Starting collection install process 2026-08-26 03:53:30.465315 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-08-26 03:53:30.465339 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix 2026-08-26 03:53:30.465364 | instance | ansible.posix:1.6.0 was installed successfully 2026-08-26 03:53:30.465389 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 03:53:30.465414 | instance | 2.17.12 2026-08-26 03:53:30.465440 | instance | Checked out ansible.utils to v6.1.0 2026-08-26 03:53:30.465465 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-08-26 03:53:30.465491 | instance | Starting galaxy collection install process 2026-08-26 03:53:30.465517 | instance | Process install dependency map 2026-08-26 03:53:30.465542 | instance | Starting collection install process 2026-08-26 03:53:30.465568 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils' 2026-08-26 03:53:30.465594 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils 2026-08-26 03:53:30.465620 | instance | ansible.utils:6.1.0 was installed successfully 2026-08-26 03:53:30.465645 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 03:53:30.465671 | instance | 2.17.12 2026-08-26 03:53:30.465696 | instance | Checked out atmosphere.common to v0.7.0 2026-08-26 03:53:30.465722 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-08-26 03:53:30.465747 | instance | Starting galaxy collection install process 2026-08-26 03:53:30.465772 | instance | Process install dependency map 2026-08-26 03:53:30.465797 | instance | Starting collection install process 2026-08-26 03:53:30.465822 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common' 2026-08-26 03:53:30.465847 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common 2026-08-26 03:53:30.465871 | instance | atmosphere.common:0.7.0 was installed successfully 2026-08-26 03:53:30.465896 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 03:53:30.465920 | instance | 2.17.12 2026-08-26 03:53:30.465945 | instance | Checked out community.crypto to 2.2.3 2026-08-26 03:53:30.465971 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.crypto 2026-08-26 03:53:30.465997 | instance | Starting galaxy collection install process 2026-08-26 03:53:30.466022 | instance | Process install dependency map 2026-08-26 03:53:30.466047 | instance | Starting collection install process 2026-08-26 03:53:30.466072 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-08-26 03:53:30.466097 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto 2026-08-26 03:53:30.466122 | instance | community.crypto:2.2.3 was installed successfully 2026-08-26 03:53:30.466147 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 03:53:30.466172 | instance | 2.17.12 2026-08-26 03:53:30.466197 | instance | Checked out community.general to 7.3.0 2026-08-26 03:53:30.466222 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.general 2026-08-26 03:53:30.466254 | instance | Starting galaxy collection install process 2026-08-26 03:53:30.466280 | instance | Process install dependency map 2026-08-26 03:53:30.466305 | instance | Starting collection install process 2026-08-26 03:53:30.466329 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-08-26 03:53:30.466354 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general 2026-08-26 03:53:30.466380 | instance | community.general:7.3.0 was installed successfully 2026-08-26 03:53:30.466405 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 03:53:30.466430 | instance | 2.17.12 2026-08-26 03:53:30.466456 | instance | Checked out community.mysql to 3.6.0 2026-08-26 03:53:30.466484 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.mysql 2026-08-26 03:53:30.466510 | instance | Starting galaxy collection install process 2026-08-26 03:53:30.466536 | instance | Process install dependency map 2026-08-26 03:53:30.466561 | instance | Starting collection install process 2026-08-26 03:53:30.466586 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql' 2026-08-26 03:53:30.466611 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql 2026-08-26 03:53:30.466636 | instance | community.mysql:3.6.0 was installed successfully 2026-08-26 03:53:30.466661 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 03:53:30.466686 | instance | 2.17.12 2026-08-26 03:53:30.466711 | instance | Checked out kubernetes.core to 2.4.0 2026-08-26 03:53:30.466736 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-08-26 03:53:30.466762 | instance | Starting galaxy collection install process 2026-08-26 03:53:30.466786 | instance | Process install dependency map 2026-08-26 03:53:30.466811 | instance | Starting collection install process 2026-08-26 03:53:30.466836 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core' 2026-08-26 03:53:30.466862 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core 2026-08-26 03:53:30.466887 | instance | kubernetes.core:2.4.0 was installed successfully 2026-08-26 03:53:30.466912 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 03:53:30.466937 | instance | 2.17.12 2026-08-26 03:53:30.466962 | instance | Checked out openstack.cloud to 2.6.0 2026-08-26 03:53:30.466987 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-08-26 03:53:30.467012 | instance | Starting galaxy collection install process 2026-08-26 03:53:30.467037 | instance | Process install dependency map 2026-08-26 03:53:30.467063 | instance | Starting collection install process 2026-08-26 03:53:30.467088 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud' 2026-08-26 03:53:30.467113 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud 2026-08-26 03:53:30.467138 | instance | openstack.cloud:2.6.0 was installed successfully 2026-08-26 03:53:30.467501 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 03:53:30.467545 | instance | 2.17.12 2026-08-26 03:53:30.467586 | instance | Checked out vexxhost.ceph to v4.2.0 2026-08-26 03:53:30.467615 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-08-26 03:53:30.467642 | instance | Starting galaxy collection install process 2026-08-26 03:53:30.467668 | instance | Process install dependency map 2026-08-26 03:53:30.467694 | instance | Starting collection install process 2026-08-26 03:53:30.467719 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph' 2026-08-26 03:53:30.467744 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph 2026-08-26 03:53:30.467769 | instance | vexxhost.ceph:4.2.0 was installed successfully 2026-08-26 03:53:30.467794 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 03:53:30.467819 | instance | 2.17.12 2026-08-26 03:53:30.467844 | instance | Checked out vexxhost.containers to v1.6.8 2026-08-26 03:53:30.467868 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-08-26 03:53:30.467893 | instance | Starting galaxy collection install process 2026-08-26 03:53:30.467925 | instance | Process install dependency map 2026-08-26 03:53:30.467953 | instance | Starting collection install process 2026-08-26 03:53:30.467979 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers' 2026-08-26 03:53:30.468004 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers 2026-08-26 03:53:30.468029 | instance | vexxhost.containers:1.6.8 was installed successfully 2026-08-26 03:53:30.468054 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 03:53:30.468080 | instance | 2.17.12 2026-08-26 03:53:30.468107 | instance | Checked out vexxhost.kubernetes to v3.3.0 2026-08-26 03:53:30.468132 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-08-26 03:53:30.468158 | instance | Starting galaxy collection install process 2026-08-26 03:53:30.468183 | instance | Process install dependency map 2026-08-26 03:53:30.468209 | instance | Starting collection install process 2026-08-26 03:53:30.468234 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes' 2026-08-26 03:53:30.468259 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes 2026-08-26 03:53:30.468285 | instance | vexxhost.kubernetes:3.3.0 was installed successfully 2026-08-26 03:53:30.468310 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-26 03:53:30.468334 | instance | 2.17.12 2026-08-26 03:53:30.475007 | 2026-08-26 03:53:30.475058 | PLAY RECAP 2026-08-26 03:53:30.475102 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-26 03:53:30.475123 | 2026-08-26 03:53:30.605686 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-26 03:53:30.609933 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-08-26 03:53:31.227726 | 2026-08-26 03:53:31.282251 | PLAY [all] 2026-08-26 03:53:31.297826 | 2026-08-26 03:53:31.297902 | TASK [Install "jq" for log collection] 2026-08-26 03:53:40.708923 | instance | changed 2026-08-26 03:53:40.711819 | 2026-08-26 03:53:40.711895 | PLAY RECAP 2026-08-26 03:53:40.711946 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-26 03:53:40.712003 | 2026-08-26 03:53:40.851279 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-08-26 03:53:40.857820 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-26 03:53:41.494258 | 2026-08-26 03:53:41.494534 | PLAY [all] 2026-08-26 03:53:41.505833 | 2026-08-26 03:53:41.505906 | LOOP [Check inventory directories] 2026-08-26 03:53:41.841107 | instance | ok: "src/github.com/vexxhost/atmosphere" 2026-08-26 03:53:41.979272 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory" 2026-08-26 03:53:42.130417 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory" 2026-08-26 03:53:42.149320 | 2026-08-26 03:53:42.149509 | LOOP [Copy inventory file for Zuul] 2026-08-26 03:53:42.901597 | instance | changed: 2026-08-26 03:53:42.901907 | instance | { 2026-08-26 03:53:42.901939 | instance | "ansible_loop_var": "item", 2026-08-26 03:53:42.901963 | instance | "changed": false, 2026-08-26 03:53:42.901984 | instance | "failed": false, 2026-08-26 03:53:42.902011 | instance | "invocation": { 2026-08-26 03:53:42.902032 | instance | "module_args": { 2026-08-26 03:53:42.902051 | instance | "checksum_algorithm": "sha1", 2026-08-26 03:53:42.902070 | instance | "follow": true, 2026-08-26 03:53:42.902088 | instance | "get_attributes": true, 2026-08-26 03:53:42.902108 | instance | "get_checksum": true, 2026-08-26 03:53:42.902126 | instance | "get_mime": true, 2026-08-26 03:53:42.902144 | instance | "path": "src/github.com/vexxhost/atmosphere" 2026-08-26 03:53:42.902163 | instance | } 2026-08-26 03:53:42.902181 | instance | }, 2026-08-26 03:53:42.902199 | instance | "item": "src/github.com/vexxhost/atmosphere", 2026-08-26 03:53:42.902217 | instance | "stat": { 2026-08-26 03:53:42.902235 | instance | "atime": 1787716403.3236256, 2026-08-26 03:53:42.902281 | instance | "attr_flags": "e", 2026-08-26 03:53:42.902300 | instance | "attributes": [ 2026-08-26 03:53:42.902319 | instance | "extents" 2026-08-26 03:53:42.902336 | instance | ], 2026-08-26 03:53:42.902354 | instance | "block_size": 4096, 2026-08-26 03:53:42.902371 | instance | "blocks": 8, 2026-08-26 03:53:42.902389 | instance | "charset": "unknown", 2026-08-26 03:53:42.902408 | instance | "ctime": 1787716402.3355896, 2026-08-26 03:53:42.902426 | instance | "dev": 64513, 2026-08-26 03:53:42.902444 | instance | "device_type": 0, 2026-08-26 03:53:42.902462 | instance | "executable": true, 2026-08-26 03:53:42.902480 | instance | "exists": true, 2026-08-26 03:53:42.902498 | instance | "gid": 1000, 2026-08-26 03:53:42.902515 | instance | "gr_name": "zuul", 2026-08-26 03:53:42.902533 | instance | "inode": 1047371, 2026-08-26 03:53:42.902550 | instance | "isblk": false, 2026-08-26 03:53:42.902568 | instance | "ischr": false, 2026-08-26 03:53:42.902585 | instance | "isdir": true, 2026-08-26 03:53:42.902603 | instance | "isfifo": false, 2026-08-26 03:53:42.902621 | instance | "isgid": false, 2026-08-26 03:53:42.902637 | instance | "islnk": false, 2026-08-26 03:53:42.902654 | instance | "isreg": false, 2026-08-26 03:53:42.902671 | instance | "issock": false, 2026-08-26 03:53:42.902687 | instance | "isuid": false, 2026-08-26 03:53:42.902704 | instance | "mimetype": "unknown", 2026-08-26 03:53:42.902722 | instance | "mode": "0755", 2026-08-26 03:53:42.902738 | instance | "mtime": 1787716402.3355896, 2026-08-26 03:53:42.902755 | instance | "nlink": 22, 2026-08-26 03:53:42.902773 | instance | "path": "src/github.com/vexxhost/atmosphere", 2026-08-26 03:53:42.902791 | instance | "pw_name": "zuul", 2026-08-26 03:53:42.902810 | instance | "readable": true, 2026-08-26 03:53:42.902827 | instance | "rgrp": true, 2026-08-26 03:53:42.902845 | instance | "roth": true, 2026-08-26 03:53:42.902872 | instance | "rusr": true, 2026-08-26 03:53:42.902890 | instance | "size": 4096, 2026-08-26 03:53:42.902908 | instance | "uid": 1000, 2026-08-26 03:53:42.902925 | instance | "version": "3239038138", 2026-08-26 03:53:42.902943 | instance | "wgrp": false, 2026-08-26 03:53:42.902961 | instance | "woth": false, 2026-08-26 03:53:42.902979 | instance | "writeable": true, 2026-08-26 03:53:42.902996 | instance | "wusr": true, 2026-08-26 03:53:42.903014 | instance | "xgrp": true, 2026-08-26 03:53:42.903032 | instance | "xoth": true, 2026-08-26 03:53:42.903049 | instance | "xusr": true 2026-08-26 03:53:42.903066 | instance | } 2026-08-26 03:53:42.903084 | instance | } 2026-08-26 03:53:42.903120 | instance | ok: All items complete 2026-08-26 03:53:42.903142 | 2026-08-26 03:53:42.904465 | instance | skipping: Conditional result was False 2026-08-26 03:53:42.905067 | instance | skipping: Conditional result was False 2026-08-26 03:53:42.919135 | 2026-08-26 03:53:42.919319 | LOOP [Switch "ansible_host" to private IP] 2026-08-26 03:53:43.249647 | instance | changed: 1 replacements made 2026-08-26 03:53:43.251444 | instance | skipping: Conditional result was False 2026-08-26 03:53:43.252420 | instance | skipping: Conditional result was False 2026-08-26 03:53:43.271538 | 2026-08-26 03:53:43.271931 | TASK [Run Molecule scenario] 2026-08-26 03:53:44.250009 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-08-26 03:53:44.619750 | instance | INFO [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-08-26 03:53:44.619829 | instance | INFO [csi > prerun] Performing prerun with role_name_check=0... 2026-08-26 03:53:55.120305 | instance | INFO [csi > dependency] Executing 2026-08-26 03:53:55.120557 | instance | WARNING [csi > dependency] Missing roles requirements file: requirements.yml 2026-08-26 03:53:55.120827 | instance | WARNING [csi > dependency] Missing collections requirements file: collections.yml 2026-08-26 03:53:55.120990 | instance | WARNING [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-08-26 03:53:55.130296 | instance | INFO [csi > cleanup] Executing 2026-08-26 03:53:55.130607 | instance | WARNING [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-26 03:53:55.138132 | instance | INFO [csi > destroy] Executing 2026-08-26 03:53:55.138208 | instance | WARNING [csi > destroy] Skipping, '--destroy=never' requested. 2026-08-26 03:53:55.138294 | instance | INFO [csi > destroy] Executed: Successful 2026-08-26 03:53:55.145942 | instance | INFO [csi > syntax] Executing 2026-08-26 03:53:56.685216 | instance | 2026-08-26 03:53:56.685484 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-08-26 03:53:56.742997 | instance | INFO [csi > syntax] Executed: Successful 2026-08-26 03:53:56.757273 | instance | INFO [csi > create] Executing 2026-08-26 03:53:56.759922 | instance | WARNING [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-26 03:53:56.768003 | instance | INFO [csi > prepare] Executing 2026-08-26 03:53:57.528230 | instance | 2026-08-26 03:53:57.528460 | instance | PLAY [Prepare] ***************************************************************** 2026-08-26 03:53:57.528708 | instance | 2026-08-26 03:53:57.528976 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-26 03:53:57.529246 | instance | Wednesday 26 August 2026 03:53:57 +0000 (0:00:00.024) 0:00:00.024 ****** 2026-08-26 03:53:58.639837 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-08-26 03:53:58.640096 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-08-26 03:53:58.640265 | instance | interpreter could change the meaning of that path. See 2026-08-26 03:53:58.640451 | instance | https://docs.ansible.com/ansible- 2026-08-26 03:53:58.640669 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-08-26 03:53:58.651152 | instance | ok: [instance] 2026-08-26 03:53:58.651464 | instance | 2026-08-26 03:53:58.651758 | instance | TASK [Configure short hostname] ************************************************ 2026-08-26 03:53:58.652054 | instance | Wednesday 26 August 2026 03:53:58 +0000 (0:00:01.123) 0:00:01.148 ****** 2026-08-26 03:53:59.291352 | instance | changed: [instance] 2026-08-26 03:53:59.291596 | instance | 2026-08-26 03:53:59.291876 | instance | TASK [Ensure hostname inside hosts file] *************************************** 2026-08-26 03:53:59.292155 | instance | Wednesday 26 August 2026 03:53:59 +0000 (0:00:00.639) 0:00:01.787 ****** 2026-08-26 03:53:59.535088 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created 2026-08-26 03:53:59.535375 | instance | with a mode of 0700, this may cause issues when running as another user. To 2026-08-26 03:53:59.535678 | instance | avoid this, create the remote_tmp dir with the correct permissions manually 2026-08-26 03:53:59.541139 | instance | changed: [instance] 2026-08-26 03:53:59.541390 | instance | 2026-08-26 03:53:59.541671 | instance | TASK [Purge "snapd" package] *************************************************** 2026-08-26 03:53:59.541972 | instance | Wednesday 26 August 2026 03:53:59 +0000 (0:00:00.250) 0:00:02.038 ****** 2026-08-26 03:54:00.309335 | instance | ok: [instance] 2026-08-26 03:54:00.309595 | instance | 2026-08-26 03:54:00.309870 | instance | PLAY [Create devices for Ceph] ************************************************* 2026-08-26 03:54:00.310160 | instance | 2026-08-26 03:54:00.310477 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-26 03:54:00.310739 | instance | Wednesday 26 August 2026 03:54:00 +0000 (0:00:00.767) 0:00:02.806 ****** 2026-08-26 03:54:00.968174 | instance | ok: [instance] 2026-08-26 03:54:00.968410 | instance | 2026-08-26 03:54:00.968695 | instance | TASK [Install depedencies] ***************************************************** 2026-08-26 03:54:00.968965 | instance | Wednesday 26 August 2026 03:54:00 +0000 (0:00:00.658) 0:00:03.465 ****** 2026-08-26 03:54:21.125388 | instance | changed: [instance] 2026-08-26 03:54:21.125649 | instance | 2026-08-26 03:54:21.125935 | instance | TASK [Start up service] ******************************************************** 2026-08-26 03:54:21.126250 | instance | Wednesday 26 August 2026 03:54:21 +0000 (0:00:20.156) 0:00:23.622 ****** 2026-08-26 03:54:21.692603 | instance | ok: [instance] 2026-08-26 03:54:21.692829 | instance | 2026-08-26 03:54:21.693104 | instance | TASK [Generate lvm.conf] ******************************************************* 2026-08-26 03:54:21.693372 | instance | Wednesday 26 August 2026 03:54:21 +0000 (0:00:00.567) 0:00:24.189 ****** 2026-08-26 03:54:21.971987 | instance | ok: [instance] 2026-08-26 03:54:21.972144 | instance | 2026-08-26 03:54:21.972326 | instance | TASK [Write /etc/lvm/lvm.conf] ************************************************* 2026-08-26 03:54:21.972538 | instance | Wednesday 26 August 2026 03:54:21 +0000 (0:00:00.279) 0:00:24.469 ****** 2026-08-26 03:54:22.588979 | instance | changed: [instance] 2026-08-26 03:54:22.589110 | instance | 2026-08-26 03:54:22.589333 | instance | TASK [Get list of all loopback devices] **************************************** 2026-08-26 03:54:22.589516 | instance | Wednesday 26 August 2026 03:54:22 +0000 (0:00:00.617) 0:00:25.086 ****** 2026-08-26 03:54:22.766887 | instance | ok: [instance] 2026-08-26 03:54:22.767151 | instance | 2026-08-26 03:54:22.767527 | instance | TASK [Fail if there is any existing loopback devices] ************************** 2026-08-26 03:54:22.767877 | instance | Wednesday 26 August 2026 03:54:22 +0000 (0:00:00.177) 0:00:25.263 ****** 2026-08-26 03:54:22.785103 | instance | skipping: [instance] 2026-08-26 03:54:22.785366 | instance | 2026-08-26 03:54:22.785645 | instance | TASK [Create devices for Ceph] ************************************************* 2026-08-26 03:54:22.786033 | instance | Wednesday 26 August 2026 03:54:22 +0000 (0:00:00.018) 0:00:25.282 ****** 2026-08-26 03:54:23.292378 | instance | changed: [instance] => (item=osd0) 2026-08-26 03:54:23.292696 | instance | changed: [instance] => (item=osd1) 2026-08-26 03:54:23.292982 | instance | changed: [instance] => (item=osd2) 2026-08-26 03:54:23.293314 | instance | 2026-08-26 03:54:23.293604 | instance | TASK [Set permissions on loopback devices] ************************************* 2026-08-26 03:54:23.293886 | instance | Wednesday 26 August 2026 03:54:23 +0000 (0:00:00.506) 0:00:25.789 ****** 2026-08-26 03:54:23.879381 | instance | changed: [instance] => (item=osd0) 2026-08-26 03:54:23.879677 | instance | changed: [instance] => (item=osd1) 2026-08-26 03:54:23.879967 | instance | changed: [instance] => (item=osd2) 2026-08-26 03:54:23.880224 | instance | 2026-08-26 03:54:23.880503 | instance | TASK [Start loop devices] ****************************************************** 2026-08-26 03:54:23.880827 | instance | Wednesday 26 August 2026 03:54:23 +0000 (0:00:00.586) 0:00:26.376 ****** 2026-08-26 03:54:24.538285 | instance | changed: [instance] => (item=osd0) 2026-08-26 03:54:24.538548 | instance | changed: [instance] => (item=osd1) 2026-08-26 03:54:24.538862 | instance | changed: [instance] => (item=osd2) 2026-08-26 03:54:24.539169 | instance | 2026-08-26 03:54:24.539480 | instance | TASK [Create a volume group for each loop device] ****************************** 2026-08-26 03:54:24.539843 | instance | Wednesday 26 August 2026 03:54:24 +0000 (0:00:00.658) 0:00:27.035 ****** 2026-08-26 03:54:27.873366 | instance | changed: [instance] => (item=osd0) 2026-08-26 03:54:27.874310 | instance | changed: [instance] => (item=osd1) 2026-08-26 03:54:27.874357 | instance | changed: [instance] => (item=osd2) 2026-08-26 03:54:27.874366 | instance | 2026-08-26 03:54:27.874373 | instance | TASK [Create a logical volume for each loop device] **************************** 2026-08-26 03:54:27.874380 | instance | Wednesday 26 August 2026 03:54:27 +0000 (0:00:03.335) 0:00:30.370 ****** 2026-08-26 03:54:29.669941 | instance | changed: [instance] => (item=ceph-instance-osd0) 2026-08-26 03:54:29.670793 | instance | changed: [instance] => (item=ceph-instance-osd1) 2026-08-26 03:54:29.670837 | instance | changed: [instance] => (item=ceph-instance-osd2) 2026-08-26 03:54:29.670848 | instance | 2026-08-26 03:54:29.670858 | instance | PLAY RECAP ********************************************************************* 2026-08-26 03:54:29.670868 | instance | instance : ok=15 changed=9 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-08-26 03:54:29.673046 | instance | 2026-08-26 03:54:29.673105 | instance | Wednesday 26 August 2026 03:54:29 +0000 (0:00:01.797) 0:00:32.167 ****** 2026-08-26 03:54:29.673122 | instance | =============================================================================== 2026-08-26 03:54:29.673135 | instance | Install depedencies ---------------------------------------------------- 20.16s 2026-08-26 03:54:29.673148 | instance | Create a volume group for each loop device ------------------------------ 3.34s 2026-08-26 03:54:29.673161 | instance | Create a logical volume for each loop device ---------------------------- 1.80s 2026-08-26 03:54:29.673171 | instance | Gathering Facts --------------------------------------------------------- 1.12s 2026-08-26 03:54:29.673180 | instance | Purge "snapd" package --------------------------------------------------- 0.77s 2026-08-26 03:54:29.673189 | instance | Gathering Facts --------------------------------------------------------- 0.66s 2026-08-26 03:54:29.673198 | instance | Start loop devices ------------------------------------------------------ 0.66s 2026-08-26 03:54:29.673206 | instance | Configure short hostname ------------------------------------------------ 0.64s 2026-08-26 03:54:29.673215 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.62s 2026-08-26 03:54:29.673223 | instance | Set permissions on loopback devices ------------------------------------- 0.59s 2026-08-26 03:54:29.673238 | instance | Start up service -------------------------------------------------------- 0.57s 2026-08-26 03:54:29.673283 | instance | Create devices for Ceph ------------------------------------------------- 0.51s 2026-08-26 03:54:29.673974 | instance | Generate lvm.conf ------------------------------------------------------- 0.28s 2026-08-26 03:54:29.674019 | instance | Ensure hostname inside hosts file --------------------------------------- 0.25s 2026-08-26 03:54:29.674026 | instance | Get list of all loopback devices ---------------------------------------- 0.18s 2026-08-26 03:54:29.674032 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s 2026-08-26 03:54:29.751343 | instance | INFO [csi > prepare] Executed: Successful 2026-08-26 03:54:29.764486 | instance | INFO [csi > converge] Executing 2026-08-26 03:54:31.180444 | instance | 2026-08-26 03:54:31.180904 | instance | PLAY [Debug CSI driver value] ************************************************** 2026-08-26 03:54:31.181262 | instance | 2026-08-26 03:54:31.181643 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-26 03:54:31.182035 | instance | Wednesday 26 August 2026 03:54:31 +0000 (0:00:00.007) 0:00:00.007 ****** 2026-08-26 03:54:32.099340 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-08-26 03:54:32.099611 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-08-26 03:54:32.099839 | instance | interpreter could change the meaning of that path. See 2026-08-26 03:54:32.100060 | instance | https://docs.ansible.com/ansible- 2026-08-26 03:54:32.100281 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-08-26 03:54:32.108857 | instance | ok: [instance] 2026-08-26 03:54:32.109099 | instance | 2026-08-26 03:54:32.109323 | instance | TASK [Display CSI driver value and environment variable] *********************** 2026-08-26 03:54:32.109543 | instance | Wednesday 26 August 2026 03:54:32 +0000 (0:00:00.928) 0:00:00.936 ****** 2026-08-26 03:54:32.154876 | instance | ok: [instance] => { 2026-08-26 03:54:32.155281 | instance | "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER=" 2026-08-26 03:54:32.155621 | instance | } 2026-08-26 03:54:32.155944 | instance | 2026-08-26 03:54:32.156277 | instance | PLAY [all] ********************************************************************* 2026-08-26 03:54:32.156591 | instance | 2026-08-26 03:54:32.156921 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-26 03:54:32.157282 | instance | Wednesday 26 August 2026 03:54:32 +0000 (0:00:00.046) 0:00:00.982 ****** 2026-08-26 03:54:33.003730 | instance | ok: [instance] 2026-08-26 03:54:33.004128 | instance | 2026-08-26 03:54:33.004494 | instance | TASK [Fail if atmosphere_ceph_enabled is set] ********************************** 2026-08-26 03:54:33.004853 | instance | Wednesday 26 August 2026 03:54:32 +0000 (0:00:00.848) 0:00:01.830 ****** 2026-08-26 03:54:33.042835 | instance | skipping: [instance] 2026-08-26 03:54:33.043192 | instance | 2026-08-26 03:54:33.043532 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-08-26 03:54:33.043871 | instance | Wednesday 26 August 2026 03:54:33 +0000 (0:00:00.039) 0:00:01.869 ****** 2026-08-26 03:54:33.224559 | instance | ok: [instance] 2026-08-26 03:54:33.224825 | instance | 2026-08-26 03:54:33.225065 | instance | PLAY [Deploy Ceph monitors & managers] ***************************************** 2026-08-26 03:54:33.225275 | instance | 2026-08-26 03:54:33.225507 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-26 03:54:33.225821 | instance | Wednesday 26 August 2026 03:54:33 +0000 (0:00:00.182) 0:00:02.052 ****** 2026-08-26 03:54:34.081849 | instance | ok: [instance] 2026-08-26 03:54:34.082262 | instance | 2026-08-26 03:54:34.082623 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-26 03:54:34.082974 | instance | Wednesday 26 August 2026 03:54:34 +0000 (0:00:00.856) 0:00:02.908 ****** 2026-08-26 03:54:34.407268 | instance | ok: [instance] 2026-08-26 03:54:34.407638 | instance | 2026-08-26 03:54:34.407994 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-26 03:54:34.408330 | instance | Wednesday 26 August 2026 03:54:34 +0000 (0:00:00.325) 0:00:03.234 ****** 2026-08-26 03:54:34.450277 | instance | skipping: [instance] 2026-08-26 03:54:34.450616 | instance | 2026-08-26 03:54:34.450960 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-08-26 03:54:34.451307 | instance | Wednesday 26 August 2026 03:54:34 +0000 (0:00:00.043) 0:00:03.277 ****** 2026-08-26 03:54:34.791479 | instance | changed: [instance] 2026-08-26 03:54:34.791877 | instance | 2026-08-26 03:54:34.792245 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-26 03:54:34.792601 | instance | Wednesday 26 August 2026 03:54:34 +0000 (0:00:00.340) 0:00:03.618 ****** 2026-08-26 03:54:34.859860 | instance | ok: [instance] => { 2026-08-26 03:54:34.860279 | instance | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-08-26 03:54:34.860646 | instance | } 2026-08-26 03:54:34.861040 | instance | 2026-08-26 03:54:34.861416 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-26 03:54:34.861778 | instance | Wednesday 26 August 2026 03:54:34 +0000 (0:00:00.068) 0:00:03.686 ****** 2026-08-26 03:54:35.438548 | instance | changed: [instance] 2026-08-26 03:54:35.438922 | instance | 2026-08-26 03:54:35.439275 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-26 03:54:35.439615 | instance | Wednesday 26 August 2026 03:54:35 +0000 (0:00:00.578) 0:00:04.265 ****** 2026-08-26 03:54:35.489447 | instance | skipping: [instance] 2026-08-26 03:54:35.489628 | instance | 2026-08-26 03:54:35.489781 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-26 03:54:35.489937 | instance | Wednesday 26 August 2026 03:54:35 +0000 (0:00:00.049) 0:00:04.314 ****** 2026-08-26 03:54:35.533202 | instance | skipping: [instance] 2026-08-26 03:54:35.533217 | instance | 2026-08-26 03:54:35.533222 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-26 03:54:35.533226 | instance | Wednesday 26 August 2026 03:54:35 +0000 (0:00:00.046) 0:00:04.360 ****** 2026-08-26 03:54:35.735238 | instance | ok: [instance] 2026-08-26 03:54:35.735613 | instance | 2026-08-26 03:54:35.735650 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-26 03:54:35.735656 | instance | Wednesday 26 August 2026 03:54:35 +0000 (0:00:00.201) 0:00:04.562 ****** 2026-08-26 03:54:36.920531 | instance | ok: [instance] 2026-08-26 03:54:36.920622 | instance | 2026-08-26 03:54:36.920894 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-26 03:54:36.920947 | instance | Wednesday 26 August 2026 03:54:36 +0000 (0:00:01.184) 0:00:05.747 ****** 2026-08-26 03:54:36.983378 | instance | ok: [instance] => { 2026-08-26 03:54:36.984413 | instance | "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz" 2026-08-26 03:54:36.984443 | instance | } 2026-08-26 03:54:36.984451 | instance | 2026-08-26 03:54:36.984457 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-26 03:54:36.984464 | instance | Wednesday 26 August 2026 03:54:36 +0000 (0:00:00.063) 0:00:05.810 ****** 2026-08-26 03:54:37.586275 | instance | changed: [instance] 2026-08-26 03:54:37.586875 | instance | 2026-08-26 03:54:37.586919 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-26 03:54:37.586928 | instance | Wednesday 26 August 2026 03:54:37 +0000 (0:00:00.602) 0:00:06.413 ****** 2026-08-26 03:54:41.397406 | instance | changed: [instance] 2026-08-26 03:54:41.397469 | instance | 2026-08-26 03:54:41.397769 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-08-26 03:54:41.397808 | instance | Wednesday 26 August 2026 03:54:41 +0000 (0:00:03.811) 0:00:10.224 ****** 2026-08-26 03:54:41.432388 | instance | skipping: [instance] 2026-08-26 03:54:41.432507 | instance | 2026-08-26 03:54:41.432970 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-08-26 03:54:41.433199 | instance | Wednesday 26 August 2026 03:54:41 +0000 (0:00:00.034) 0:00:10.259 ****** 2026-08-26 03:54:41.466341 | instance | skipping: [instance] 2026-08-26 03:54:41.466451 | instance | 2026-08-26 03:54:41.466643 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-08-26 03:54:41.466797 | instance | Wednesday 26 August 2026 03:54:41 +0000 (0:00:00.033) 0:00:10.293 ****** 2026-08-26 03:54:41.503836 | instance | skipping: [instance] 2026-08-26 03:54:41.503997 | instance | 2026-08-26 03:54:41.504185 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-08-26 03:54:41.504418 | instance | Wednesday 26 August 2026 03:54:41 +0000 (0:00:00.037) 0:00:10.331 ****** 2026-08-26 03:54:46.015058 | instance | changed: [instance] 2026-08-26 03:54:46.015211 | instance | 2026-08-26 03:54:46.015565 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] *** 2026-08-26 03:54:46.015792 | instance | Wednesday 26 August 2026 03:54:46 +0000 (0:00:04.511) 0:00:14.842 ****** 2026-08-26 03:54:46.571717 | instance | changed: [instance] 2026-08-26 03:54:46.571795 | instance | 2026-08-26 03:54:46.571917 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] ******* 2026-08-26 03:54:46.572125 | instance | Wednesday 26 August 2026 03:54:46 +0000 (0:00:00.556) 0:00:15.399 ****** 2026-08-26 03:54:47.455601 | instance | changed: [instance] => (item={'path': '/etc/containerd'}) 2026-08-26 03:54:47.455736 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'}) 2026-08-26 03:54:47.455986 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'}) 2026-08-26 03:54:47.456217 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'}) 2026-08-26 03:54:47.456437 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'}) 2026-08-26 03:54:47.456636 | instance | 2026-08-26 03:54:47.456847 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] ********** 2026-08-26 03:54:47.457056 | instance | Wednesday 26 August 2026 03:54:47 +0000 (0:00:00.883) 0:00:16.282 ****** 2026-08-26 03:54:48.037372 | instance | changed: [instance] 2026-08-26 03:54:48.037583 | instance | 2026-08-26 03:54:48.037763 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ******** 2026-08-26 03:54:48.037923 | instance | Wednesday 26 August 2026 03:54:48 +0000 (0:00:00.563) 0:00:16.845 ****** 2026-08-26 03:54:48.038083 | instance | 2026-08-26 03:54:48.038280 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-08-26 03:54:48.038478 | instance | Wednesday 26 August 2026 03:54:48 +0000 (0:00:00.016) 0:00:16.862 ****** 2026-08-26 03:54:48.973320 | instance | ok: [instance] 2026-08-26 03:54:48.973723 | instance | 2026-08-26 03:54:48.974203 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] ********** 2026-08-26 03:54:48.974601 | instance | Wednesday 26 August 2026 03:54:48 +0000 (0:00:00.938) 0:00:17.800 ****** 2026-08-26 03:54:49.415294 | instance | changed: [instance] 2026-08-26 03:54:49.415370 | instance | 2026-08-26 03:54:49.415382 | instance | TASK [vexxhost.containers.containerd : Enable and start service] *************** 2026-08-26 03:54:49.415392 | instance | Wednesday 26 August 2026 03:54:49 +0000 (0:00:00.441) 0:00:18.241 ****** 2026-08-26 03:54:49.953173 | instance | changed: [instance] 2026-08-26 03:54:49.953233 | instance | 2026-08-26 03:54:49.953245 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-26 03:54:49.953256 | instance | Wednesday 26 August 2026 03:54:49 +0000 (0:00:00.537) 0:00:18.779 ****** 2026-08-26 03:54:50.160785 | instance | ok: [instance] 2026-08-26 03:54:50.160838 | instance | 2026-08-26 03:54:50.160849 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-26 03:54:50.160859 | instance | Wednesday 26 August 2026 03:54:50 +0000 (0:00:00.207) 0:00:18.986 ****** 2026-08-26 03:54:50.208455 | instance | ok: [instance] => { 2026-08-26 03:54:50.209066 | instance | "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz" 2026-08-26 03:54:50.209110 | instance | } 2026-08-26 03:54:50.209115 | instance | 2026-08-26 03:54:50.209120 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-26 03:54:50.209126 | instance | Wednesday 26 August 2026 03:54:50 +0000 (0:00:00.048) 0:00:19.035 ****** 2026-08-26 03:54:50.897628 | instance | changed: [instance] 2026-08-26 03:54:50.897721 | instance | 2026-08-26 03:54:50.897958 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-26 03:54:50.897973 | instance | Wednesday 26 August 2026 03:54:50 +0000 (0:00:00.689) 0:00:19.725 ****** 2026-08-26 03:54:55.211542 | instance | changed: [instance] 2026-08-26 03:54:55.211579 | instance | 2026-08-26 03:54:55.211584 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ****************** 2026-08-26 03:54:55.211589 | instance | Wednesday 26 August 2026 03:54:55 +0000 (0:00:04.313) 0:00:24.038 ****** 2026-08-26 03:54:56.337681 | instance | ok: [instance] 2026-08-26 03:54:56.337843 | instance | 2026-08-26 03:54:56.337862 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] *************** 2026-08-26 03:54:56.338023 | instance | Wednesday 26 August 2026 03:54:56 +0000 (0:00:01.126) 0:00:25.165 ****** 2026-08-26 03:54:56.679875 | instance | changed: [instance] 2026-08-26 03:54:56.679946 | instance | 2026-08-26 03:54:56.680255 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] ***** 2026-08-26 03:54:56.680296 | instance | Wednesday 26 August 2026 03:54:56 +0000 (0:00:00.342) 0:00:25.507 ****** 2026-08-26 03:54:57.136332 | instance | changed: [instance] 2026-08-26 03:54:57.136409 | instance | 2026-08-26 03:54:57.136772 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] *********** 2026-08-26 03:54:57.136812 | instance | Wednesday 26 August 2026 03:54:57 +0000 (0:00:00.456) 0:00:25.963 ****** 2026-08-26 03:54:57.694400 | instance | changed: [instance] => (item={'path': '/etc/docker'}) 2026-08-26 03:54:57.694477 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'}) 2026-08-26 03:54:57.694998 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'}) 2026-08-26 03:54:57.695035 | instance | 2026-08-26 03:54:57.695041 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ****** 2026-08-26 03:54:57.695046 | instance | Wednesday 26 August 2026 03:54:57 +0000 (0:00:00.558) 0:00:26.521 ****** 2026-08-26 03:54:58.143927 | instance | changed: [instance] 2026-08-26 03:54:58.143990 | instance | 2026-08-26 03:54:58.144300 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] *********** 2026-08-26 03:54:58.144435 | instance | Wednesday 26 August 2026 03:54:58 +0000 (0:00:00.449) 0:00:26.971 ****** 2026-08-26 03:54:58.606228 | instance | changed: [instance] 2026-08-26 03:54:58.606305 | instance | 2026-08-26 03:54:58.606320 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************ 2026-08-26 03:54:58.606358 | instance | Wednesday 26 August 2026 03:54:58 +0000 (0:00:00.445) 0:00:27.416 ****** 2026-08-26 03:54:58.606371 | instance | 2026-08-26 03:54:58.606383 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-08-26 03:54:58.606411 | instance | Wednesday 26 August 2026 03:54:58 +0000 (0:00:00.016) 0:00:27.432 ****** 2026-08-26 03:54:59.321449 | instance | ok: [instance] 2026-08-26 03:54:59.321999 | instance | 2026-08-26 03:54:59.322056 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ****************** 2026-08-26 03:54:59.322064 | instance | Wednesday 26 August 2026 03:54:59 +0000 (0:00:00.715) 0:00:28.148 ****** 2026-08-26 03:55:00.155162 | instance | changed: [instance] 2026-08-26 03:55:00.155242 | instance | 2026-08-26 03:55:00.155502 | instance | TASK [vexxhost.containers.docker : Enable and start service] ******************* 2026-08-26 03:55:00.155536 | instance | Wednesday 26 August 2026 03:55:00 +0000 (0:00:00.833) 0:00:28.982 ****** 2026-08-26 03:55:00.707426 | instance | changed: [instance] 2026-08-26 03:55:00.707516 | instance | 2026-08-26 03:55:00.707782 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ****** 2026-08-26 03:55:00.707817 | instance | Wednesday 26 August 2026 03:55:00 +0000 (0:00:00.552) 0:00:29.534 ****** 2026-08-26 03:55:00.765794 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml) 2026-08-26 03:55:00.766181 | instance | 2026-08-26 03:55:00.766230 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ******************************** 2026-08-26 03:55:00.766246 | instance | Wednesday 26 August 2026 03:55:00 +0000 (0:00:00.058) 0:00:29.593 ****** 2026-08-26 03:55:05.597879 | instance | changed: [instance] 2026-08-26 03:55:05.597944 | instance | 2026-08-26 03:55:05.598229 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] ********************* 2026-08-26 03:55:05.598307 | instance | Wednesday 26 August 2026 03:55:05 +0000 (0:00:04.831) 0:00:34.424 ****** 2026-08-26 03:55:06.237054 | instance | ok: [instance] => (item=chronyd) 2026-08-26 03:55:06.237154 | instance | ok: [instance] => (item=sshd) 2026-08-26 03:55:06.237531 | instance | 2026-08-26 03:55:06.237660 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ****************************** 2026-08-26 03:55:06.237666 | instance | Wednesday 26 August 2026 03:55:06 +0000 (0:00:00.639) 0:00:35.064 ****** 2026-08-26 03:55:06.546077 | instance | changed: [instance] 2026-08-26 03:55:06.546223 | instance | 2026-08-26 03:55:06.546524 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ******************** 2026-08-26 03:55:06.546565 | instance | Wednesday 26 August 2026 03:55:06 +0000 (0:00:00.308) 0:00:35.373 ****** 2026-08-26 03:55:06.743231 | instance | ok: [instance] 2026-08-26 03:55:06.743298 | instance | 2026-08-26 03:55:06.743567 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] **************** 2026-08-26 03:55:06.743722 | instance | Wednesday 26 August 2026 03:55:06 +0000 (0:00:00.196) 0:00:35.570 ****** 2026-08-26 03:55:07.198087 | instance | changed: [instance] 2026-08-26 03:55:07.198663 | instance | 2026-08-26 03:55:07.198686 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] *** 2026-08-26 03:55:07.198694 | instance | Wednesday 26 August 2026 03:55:07 +0000 (0:00:00.454) 0:00:36.025 ****** 2026-08-26 03:55:07.519922 | instance | changed: [instance] 2026-08-26 03:55:07.519996 | instance | 2026-08-26 03:55:07.520246 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] ************************* 2026-08-26 03:55:07.520286 | instance | Wednesday 26 August 2026 03:55:07 +0000 (0:00:00.322) 0:00:36.347 ****** 2026-08-26 03:55:07.697500 | instance | ok: [instance] 2026-08-26 03:55:07.697606 | instance | 2026-08-26 03:55:07.697879 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] ******************* 2026-08-26 03:55:07.697909 | instance | Wednesday 26 August 2026 03:55:07 +0000 (0:00:00.177) 0:00:36.524 ****** 2026-08-26 03:55:07.905520 | instance | ok: [instance] => (item=instance) 2026-08-26 03:55:07.905641 | instance | 2026-08-26 03:55:07.905899 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ******** 2026-08-26 03:55:07.905937 | instance | Wednesday 26 August 2026 03:55:07 +0000 (0:00:00.207) 0:00:36.732 ****** 2026-08-26 03:55:07.960157 | instance | ok: [instance] 2026-08-26 03:55:07.960634 | instance | 2026-08-26 03:55:07.960655 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] *********************************** 2026-08-26 03:55:07.960661 | instance | Wednesday 26 August 2026 03:55:07 +0000 (0:00:00.054) 0:00:36.787 ****** 2026-08-26 03:55:08.030975 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance 2026-08-26 03:55:08.031105 | instance | 2026-08-26 03:55:08.031335 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] ************* 2026-08-26 03:55:08.031359 | instance | Wednesday 26 August 2026 03:55:08 +0000 (0:00:00.071) 0:00:36.858 ****** 2026-08-26 03:55:08.304063 | instance | changed: [instance] 2026-08-26 03:55:08.304145 | instance | 2026-08-26 03:55:08.304436 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ****************** 2026-08-26 03:55:08.304484 | instance | Wednesday 26 August 2026 03:55:08 +0000 (0:00:00.272) 0:00:37.131 ****** 2026-08-26 03:55:08.954564 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True}) 2026-08-26 03:55:08.954666 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0}) 2026-08-26 03:55:08.955166 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False}) 2026-08-26 03:55:08.955206 | instance | 2026-08-26 03:55:08.955211 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] ******************************* 2026-08-26 03:55:08.955216 | instance | Wednesday 26 August 2026 03:55:08 +0000 (0:00:00.650) 0:00:37.781 ****** 2026-08-26 03:56:42.478866 | instance | ok: [instance] 2026-08-26 03:56:42.479119 | instance | 2026-08-26 03:56:42.479428 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] *************** 2026-08-26 03:56:42.479745 | instance | Wednesday 26 August 2026 03:56:42 +0000 (0:01:33.523) 0:02:11.305 ****** 2026-08-26 03:56:42.726490 | instance | changed: [instance] 2026-08-26 03:56:42.726766 | instance | 2026-08-26 03:56:42.727060 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] ********************************** 2026-08-26 03:56:42.727344 | instance | Wednesday 26 August 2026 03:56:42 +0000 (0:00:00.248) 0:02:11.553 ****** 2026-08-26 03:56:42.771798 | instance | ok: [instance] 2026-08-26 03:56:42.771980 | instance | 2026-08-26 03:56:42.772259 | instance | TASK [Install Ceph host] ******************************************************* 2026-08-26 03:56:42.772631 | instance | Wednesday 26 August 2026 03:56:42 +0000 (0:00:00.045) 0:02:11.599 ****** 2026-08-26 03:56:42.851747 | instance | included: vexxhost.ceph.cephadm_host for instance 2026-08-26 03:56:42.851966 | instance | 2026-08-26 03:56:42.852247 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ****** 2026-08-26 03:56:42.852530 | instance | Wednesday 26 August 2026 03:56:42 +0000 (0:00:00.079) 0:02:11.679 ****** 2026-08-26 03:56:44.561611 | instance | ok: [instance] 2026-08-26 03:56:44.561822 | instance | 2026-08-26 03:56:44.562213 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] *** 2026-08-26 03:56:44.562399 | instance | Wednesday 26 August 2026 03:56:44 +0000 (0:00:01.709) 0:02:13.388 ****** 2026-08-26 03:56:44.629101 | instance | ok: [instance] => (item=instance) 2026-08-26 03:56:44.629297 | instance | 2026-08-26 03:56:44.629563 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] *********** 2026-08-26 03:56:44.629827 | instance | Wednesday 26 August 2026 03:56:44 +0000 (0:00:00.067) 0:02:13.455 ****** 2026-08-26 03:56:45.014612 | instance | ok: [instance] 2026-08-26 03:56:45.014784 | instance | 2026-08-26 03:56:45.015104 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] *********************** 2026-08-26 03:56:45.015242 | instance | Wednesday 26 August 2026 03:56:45 +0000 (0:00:00.385) 0:02:13.841 ****** 2026-08-26 03:56:48.130652 | instance | ok: [instance] 2026-08-26 03:56:48.130884 | instance | 2026-08-26 03:56:48.131187 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ****************** 2026-08-26 03:56:48.131473 | instance | Wednesday 26 August 2026 03:56:48 +0000 (0:00:03.116) 0:02:16.957 ****** 2026-08-26 03:57:43.873868 | instance | An exception occurred during task execution. To see the full traceback, use -vvv. The error was: [errno 5] RADOS I/O error (error connecting to the cluster) 2026-08-26 03:57:43.874328 | instance | fatal: [instance]: FAILED! => {"changed": false, "module_stderr": "Traceback (most recent call last):\n File \"\", line 107, in \n File \"\", line 99, in _ansiballz_main\n File \"\", 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_gs_btmwm/ansible_vexxhost.ceph.orch_apply_payload.zip/ansible_collections/vexxhost/ceph/plugins/modules/orch_apply.py\", line 202, in \n File \"/tmp/ansible_vexxhost.ceph.orch_apply_payload_gs_btmwm/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_gs_btmwm/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_gs_btmwm/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-26T03:57:43.711+0000 7fe3e7e1a640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgDNY45qY2JONCAAlN7buhp2PTQSyXln7gsQXoiMHILhq3nMrLXWhxd3S5A=: Malformed input [buffer:3]\n2026-08-26T03:57:43.711+0000 7fe3e7e1a640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-26T03:57:43.715+0000 7fe3e7e1a640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgDNY45qY2JONCAAlN7buhp2PTQSyXln7gsQXoiMHILhq3nMrLXWhxd3S5A=: Malformed input [buffer:3]\n2026-08-26T03:57:43.715+0000 7fe3e7e1a640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-26T03:57:43.715+0000 7fe3e7e1a640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgDNY45qY2JONCAAlN7buhp2PTQSyXln7gsQXoiMHILhq3nMrLXWhxd3S5A=: Malformed input [buffer:3]\n2026-08-26T03:57:43.715+0000 7fe3e7e1a640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-26T03:57:43.715+0000 7fe3e7e1a640 -1 monclient: keyring not found\n[errno 5] RADOS I/O error (error connecting to the cluster)\n\n", "module_stdout": "", "msg": "MODULE FAILURE\nSee stdout/stderr for the exact error", "rc": 1} 2026-08-26 03:57:43.875604 | instance | 2026-08-26 03:57:43.875936 | instance | PLAY RECAP ********************************************************************* 2026-08-26 03:57:43.876266 | instance | instance : ok=55 changed=26 unreachable=0 failed=1 skipped=7 rescued=0 ignored=0 2026-08-26 03:57:43.876563 | instance | 2026-08-26 03:57:43.876864 | instance | Wednesday 26 August 2026 03:57:43 +0000 (0:00:55.745) 0:03:12.703 ****** 2026-08-26 03:57:43.877133 | instance | =============================================================================== 2026-08-26 03:57:43.877432 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 93.52s 2026-08-26 03:57:43.877715 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 55.75s 2026-08-26 03:57:43.877997 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 4.83s 2026-08-26 03:57:43.878350 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 4.51s 2026-08-26 03:57:43.878637 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.31s 2026-08-26 03:57:43.878946 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 3.81s 2026-08-26 03:57:43.879327 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 3.12s 2026-08-26 03:57:43.879634 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.71s 2026-08-26 03:57:43.879918 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.65s 2026-08-26 03:57:43.880197 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.18s 2026-08-26 03:57:43.880497 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.13s 2026-08-26 03:57:43.880678 | instance | Gathering Facts --------------------------------------------------------- 0.93s 2026-08-26 03:57:43.880840 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.88s 2026-08-26 03:57:43.881003 | instance | Gathering Facts --------------------------------------------------------- 0.86s 2026-08-26 03:57:43.881164 | instance | Gathering Facts --------------------------------------------------------- 0.85s 2026-08-26 03:57:43.881328 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 0.83s 2026-08-26 03:57:43.881492 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.69s 2026-08-26 03:57:43.881657 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.65s 2026-08-26 03:57:43.881818 | instance | vexxhost.ceph.cephadm : Ensure services are started --------------------- 0.64s 2026-08-26 03:57:43.881980 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.60s 2026-08-26 03:57:43.959915 | instance | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-08-26 03:57:43.960053 | instance | ERROR [csi > converge] Executed: Failed 2026-08-26 03:57:43.960196 | instance | ERROR Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-08-26 03:57:44.154817 | instance | ERROR 2026-08-26 03:57:44.155031 | instance | { 2026-08-26 03:57:44.155060 | instance | "delta": "0:04:00.401230", 2026-08-26 03:57:44.155082 | instance | "end": "2026-08-26 03:57:44.014802", 2026-08-26 03:57:44.155101 | instance | "msg": "non-zero return code", 2026-08-26 03:57:44.155119 | instance | "rc": 2, 2026-08-26 03:57:44.155137 | instance | "start": "2026-08-26 03:53:43.613572" 2026-08-26 03:57:44.155157 | instance | } failure 2026-08-26 03:57:44.160117 | 2026-08-26 03:57:44.160165 | PLAY RECAP 2026-08-26 03:57:44.160208 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-08-26 03:57:44.160230 | 2026-08-26 03:57:44.313523 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-26 03:57:44.316707 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-08-26 03:57:44.965512 | 2026-08-26 03:57:44.965659 | PLAY [all] 2026-08-26 03:57:44.980932 | 2026-08-26 03:57:44.981079 | TASK [gather-host-logs : creating directory for system status] 2026-08-26 03:57:45.311087 | instance | changed 2026-08-26 03:57:45.317562 | 2026-08-26 03:57:45.317639 | TASK [gather-host-logs : Get logs for each host] 2026-08-26 03:57:45.653645 | instance | + systemd-cgls --full --all --no-pager 2026-08-26 03:57:45.667731 | instance | + ip addr 2026-08-26 03:57:45.669389 | instance | + ip route 2026-08-26 03:57:45.671815 | instance | + lsblk 2026-08-26 03:57:45.674883 | instance | + mount 2026-08-26 03:57:45.677404 | instance | + docker images 2026-08-26 03:57:45.698085 | instance | + brctl show 2026-08-26 03:57:45.698476 | instance | /bin/bash: line 8: brctl: command not found 2026-08-26 03:57:45.698687 | instance | + ps aux --sort=-%mem 2026-08-26 03:57:45.710970 | instance | + dpkg -l 2026-08-26 03:57:45.717078 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-08-26 03:57:45.717526 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-08-26 03:57:45.736010 | instance | + '[' '!' -z '' ']' 2026-08-26 03:57:45.853686 | instance | ok: Runtime: 0:00:00.086292 2026-08-26 03:57:45.861645 | 2026-08-26 03:57:45.861733 | TASK [gather-host-logs : Downloads logs to executor] 2026-08-26 03:57:46.495368 | instance | changed: 2026-08-26 03:57:46.495543 | instance | created directory /var/lib/zuul/builds/3285a320c2374b4b90027c44c4926fe3/work/logs/instance 2026-08-26 03:57:46.495583 | instance | cd+++++++++ system/ 2026-08-26 03:57:46.495614 | instance | >f+++++++++ system/brctl-show.txt 2026-08-26 03:57:46.495644 | instance | >f+++++++++ system/docker-images.txt 2026-08-26 03:57:46.495672 | instance | >f+++++++++ system/ip-addr.txt 2026-08-26 03:57:46.495703 | instance | >f+++++++++ system/ip-route.txt 2026-08-26 03:57:46.495733 | instance | >f+++++++++ system/lsblk.txt 2026-08-26 03:57:46.495762 | instance | >f+++++++++ system/mount.txt 2026-08-26 03:57:46.495790 | instance | >f+++++++++ system/packages.txt 2026-08-26 03:57:46.495816 | instance | >f+++++++++ system/ps.txt 2026-08-26 03:57:46.495846 | instance | >f+++++++++ system/systemd-cgls.txt 2026-08-26 03:57:46.506238 | 2026-08-26 03:57:46.506307 | LOOP [helm-release-status : creating directory for helm release status] 2026-08-26 03:57:46.696056 | instance | changed: "values" 2026-08-26 03:57:46.857326 | instance | changed: "releases" 2026-08-26 03:57:46.873874 | 2026-08-26 03:57:46.874086 | TASK [helm-release-status : Gather get release status for helm charts] 2026-08-26 03:57:47.086317 | instance | /bin/bash: line 3: kubectl: command not found 2026-08-26 03:57:47.423706 | instance | ok: Runtime: 0:00:00.005799 2026-08-26 03:57:47.429862 | 2026-08-26 03:57:47.429926 | TASK [helm-release-status : Downloads logs to executor] 2026-08-26 03:57:47.889651 | instance | changed: 2026-08-26 03:57:47.889836 | instance | cd+++++++++ helm/ 2026-08-26 03:57:47.889874 | instance | cd+++++++++ helm/releases/ 2026-08-26 03:57:47.889904 | instance | cd+++++++++ helm/values/ 2026-08-26 03:57:47.900075 | 2026-08-26 03:57:47.900143 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-08-26 03:57:48.095885 | instance | changed 2026-08-26 03:57:48.103183 | 2026-08-26 03:57:48.103253 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-08-26 03:57:48.338965 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-26 03:57:48.339270 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-26 03:57:48.344261 | instance | environment: line 1: kubectl: command not found 2026-08-26 03:57:48.345542 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-26 03:57:48.346873 | instance | environment: line 1: kubectl: command not found 2026-08-26 03:57:48.347590 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-26 03:57:48.348330 | instance | environment: line 1: kubectl: command not found 2026-08-26 03:57:48.349344 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-26 03:57:48.350489 | instance | environment: line 1: kubectl: command not found 2026-08-26 03:57:48.351451 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-26 03:57:48.351469 | instance | environment: line 1: kubectl: command not found 2026-08-26 03:57:48.352645 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-26 03:57:48.638032 | instance | ok: Runtime: 0:00:00.021428 2026-08-26 03:57:48.644440 | 2026-08-26 03:57:48.644507 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-08-26 03:57:48.841422 | instance | changed 2026-08-26 03:57:48.846608 | 2026-08-26 03:57:48.846678 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-08-26 03:57:49.053267 | instance | environment: line 5: kubectl: command not found 2026-08-26 03:57:49.053711 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-26 03:57:49.054085 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-26 03:57:49.055134 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-26 03:57:49.384917 | instance | ok: Runtime: 0:00:00.007683 2026-08-26 03:57:49.392100 | 2026-08-26 03:57:49.392165 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-08-26 03:57:49.862351 | instance | changed: 2026-08-26 03:57:49.862533 | instance | cd+++++++++ objects/ 2026-08-26 03:57:49.862573 | instance | cd+++++++++ objects/cluster/ 2026-08-26 03:57:49.862606 | instance | cd+++++++++ objects/namespaced/ 2026-08-26 03:57:49.872724 | 2026-08-26 03:57:49.872789 | TASK [gather-pod-logs : creating directory for pod logs] 2026-08-26 03:57:50.066842 | instance | changed 2026-08-26 03:57:50.071559 | 2026-08-26 03:57:50.071619 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-08-26 03:57:50.276870 | instance | changed 2026-08-26 03:57:50.282430 | 2026-08-26 03:57:50.282496 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-08-26 03:57:50.485292 | instance | environment: line 3: kubectl: command not found 2026-08-26 03:57:50.818563 | instance | ok: Runtime: 0:00:00.007745 2026-08-26 03:57:50.824963 | 2026-08-26 03:57:50.825047 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-08-26 03:57:51.296993 | instance | changed: 2026-08-26 03:57:51.297167 | instance | cd+++++++++ pod-logs/ 2026-08-26 03:57:51.297194 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-08-26 03:57:51.306587 | 2026-08-26 03:57:51.306652 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-08-26 03:57:51.499119 | instance | changed 2026-08-26 03:57:51.504017 | 2026-08-26 03:57:51.504082 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-08-26 03:57:51.705178 | instance | /bin/bash: line 2: kubectl: command not found 2026-08-26 03:57:52.039292 | instance | ok: Runtime: 0:00:00.035831 2026-08-26 03:57:52.045698 | 2026-08-26 03:57:52.045771 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-08-26 03:57:52.252219 | instance | /bin/bash: line 2: kubectl: command not found 2026-08-26 03:57:52.280315 | instance | ceph-mgr endpoints: 2026-08-26 03:57:52.580100 | instance | ok: Runtime: 0:00:00.034397 2026-08-26 03:57:52.586644 | 2026-08-26 03:57:52.586709 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-08-26 03:57:52.800298 | instance | /bin/bash: line 4: kubectl: command not found 2026-08-26 03:57:53.120109 | instance | ok: Runtime: 0:00:00.034673 2026-08-26 03:57:53.126424 | 2026-08-26 03:57:53.126489 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-08-26 03:57:53.595879 | instance | changed: cd+++++++++ prometheus/ 2026-08-26 03:57:53.607283 | 2026-08-26 03:57:53.607349 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-08-26 03:57:53.805760 | instance | changed 2026-08-26 03:57:53.810966 | 2026-08-26 03:57:53.811044 | TASK [gather-selenium-data : Get selenium data] 2026-08-26 03:57:54.042589 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-08-26 03:57:54.043516 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-08-26 03:57:54.347888 | instance | ERROR 2026-08-26 03:57:54.348175 | instance | { 2026-08-26 03:57:54.348224 | instance | "delta": "0:00:00.005797", 2026-08-26 03:57:54.348244 | instance | "end": "2026-08-26 03:57:54.043824", 2026-08-26 03:57:54.348284 | instance | "msg": "non-zero return code", 2026-08-26 03:57:54.348333 | instance | "rc": 1, 2026-08-26 03:57:54.348364 | instance | "start": "2026-08-26 03:57:54.038027" 2026-08-26 03:57:54.348387 | instance | } 2026-08-26 03:57:54.348415 | instance | ERROR: Ignoring Errors 2026-08-26 03:57:54.353141 | 2026-08-26 03:57:54.353201 | TASK [gather-selenium-data : Downloads logs to executor] 2026-08-26 03:57:54.834688 | instance | changed: cd+++++++++ selenium/ 2026-08-26 03:57:54.840365 | 2026-08-26 03:57:54.840415 | PLAY RECAP 2026-08-26 03:57:54.840459 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-08-26 03:57:54.840481 | 2026-08-26 03:57:54.956323 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-08-26 03:57:54.960493 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-26 03:57:55.611571 | 2026-08-26 03:57:55.611741 | PLAY [all] 2026-08-26 03:57:55.625743 | 2026-08-26 03:57:55.625854 | TASK [fetch-output : Set log path for multiple nodes] 2026-08-26 03:57:55.681714 | instance | skipping: Conditional result was False 2026-08-26 03:57:55.691547 | 2026-08-26 03:57:55.691630 | TASK [fetch-output : Set log path for single node] 2026-08-26 03:57:55.732243 | instance | ok 2026-08-26 03:57:55.738865 | 2026-08-26 03:57:55.738937 | LOOP [fetch-output : Ensure local output dirs] 2026-08-26 03:57:56.106514 | instance -> localhost | ok: "/var/lib/zuul/builds/3285a320c2374b4b90027c44c4926fe3/work/logs" 2026-08-26 03:57:56.327685 | instance -> localhost | changed: "/var/lib/zuul/builds/3285a320c2374b4b90027c44c4926fe3/work/artifacts" 2026-08-26 03:57:56.527477 | instance -> localhost | changed: "/var/lib/zuul/builds/3285a320c2374b4b90027c44c4926fe3/work/docs" 2026-08-26 03:57:56.542011 | 2026-08-26 03:57:56.542130 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-26 03:57:57.155115 | instance | changed: .d..t...... ./ 2026-08-26 03:57:57.155355 | instance | changed: All items complete 2026-08-26 03:57:57.155400 | 2026-08-26 03:57:57.594589 | instance | changed: .d..t...... ./ 2026-08-26 03:57:58.048834 | instance | changed: .d..t...... ./ 2026-08-26 03:57:58.068077 | 2026-08-26 03:57:58.068246 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-26 03:57:58.480701 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007696 2026-08-26 03:57:58.745840 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007808 2026-08-26 03:57:58.766907 | 2026-08-26 03:57:58.767028 | PLAY [all] 2026-08-26 03:57:58.773161 | 2026-08-26 03:57:58.773272 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-26 03:57:59.171429 | instance | changed 2026-08-26 03:57:59.178117 | 2026-08-26 03:57:59.178164 | PLAY RECAP 2026-08-26 03:57:59.178210 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-26 03:57:59.178232 | 2026-08-26 03:57:59.302727 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-26 03:57:59.305577 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-26 03:57:59.901119 | 2026-08-26 03:57:59.901251 | PLAY [localhost] 2026-08-26 03:57:59.910880 | 2026-08-26 03:57:59.910953 | TASK [Generate Zuul manifest] 2026-08-26 03:57:59.929182 | localhost | ok 2026-08-26 03:57:59.948812 | 2026-08-26 03:57:59.949053 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-26 03:58:00.347690 | localhost | changed 2026-08-26 03:58:00.359673 | 2026-08-26 03:58:00.359753 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-26 03:58:00.392019 | localhost | ok 2026-08-26 03:58:00.400508 | 2026-08-26 03:58:00.400576 | TASK [Upload logs] 2026-08-26 03:58:00.421837 | localhost | ok 2026-08-26 03:58:00.483590 | 2026-08-26 03:58:00.483723 | TASK [Set zuul-log-path fact] 2026-08-26 03:58:00.503950 | localhost | ok 2026-08-26 03:58:00.517189 | 2026-08-26 03:58:00.517261 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-26 03:58:00.549318 | localhost | ok 2026-08-26 03:58:00.556994 | 2026-08-26 03:58:00.557064 | TASK [upload-logs : Create log directories] 2026-08-26 03:58:00.956065 | localhost | changed 2026-08-26 03:58:00.964495 | 2026-08-26 03:58:00.964602 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-26 03:58:01.372935 | localhost -> localhost | ok: Runtime: 0:00:00.005508 2026-08-26 03:58:01.380109 | 2026-08-26 03:58:01.380173 | TASK [upload-logs : Upload logs to log server] 2026-08-26 03:58:01.879546 | localhost | Output suppressed because no_log was given 2026-08-26 03:58:01.910755 | 2026-08-26 03:58:01.910882 | LOOP [upload-logs : Compress console log and json output] 2026-08-26 03:58:01.952996 | localhost | skipping: Conditional result was False 2026-08-26 03:58:01.960140 | localhost | skipping: Conditional result was False 2026-08-26 03:58:01.974654 | 2026-08-26 03:58:01.974753 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-26 03:58:02.013777 | localhost | skipping: Conditional result was False 2026-08-26 03:58:02.014159 | 2026-08-26 03:58:02.017935 | localhost | skipping: Conditional result was False 2026-08-26 03:58:02.026593 | 2026-08-26 03:58:02.026712 | LOOP [upload-logs : Upload console log and json output]