2026-08-20 20:27:57.558183 | Job console starting 2026-08-20 20:27:57.569535 | Updating git repos 2026-08-20 20:28:01.014524 | Cloning repos into workspace 2026-08-20 20:28:35.787705 | Restoring repo states 2026-08-20 20:28:44.402881 | Merging changes 2026-08-20 20:28:49.780015 | Checking out repos 2026-08-20 20:28:56.536862 | Preparing playbooks 2026-08-20 20:29:02.506075 | Running Ansible setup 2026-08-20 20:29:06.758963 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-20 20:29:07.473408 | 2026-08-20 20:29:07.542824 | PLAY [localhost] 2026-08-20 20:29:07.558953 | 2026-08-20 20:29:07.559082 | TASK [Gathering Facts] 2026-08-20 20:29:08.870211 | localhost | ok 2026-08-20 20:29:08.879935 | 2026-08-20 20:29:08.880009 | TASK [Setup log path fact] 2026-08-20 20:29:08.898041 | localhost | ok 2026-08-20 20:29:08.912336 | 2026-08-20 20:29:08.912435 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-20 20:29:08.944749 | localhost | ok 2026-08-20 20:29:08.951448 | 2026-08-20 20:29:08.951590 | TASK [emit-job-header : Print job information] 2026-08-20 20:29:08.992198 | # Job Information 2026-08-20 20:29:08.992444 | Ansible Version: 2.16.18 2026-08-20 20:29:08.992517 | Job: atmosphere-molecule-csi-rbd 2026-08-20 20:29:08.992662 | Pipeline: check 2026-08-20 20:29:08.992740 | Executor: 2d72f0692154 2026-08-20 20:29:08.992794 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4314 2026-08-20 20:29:08.992846 | Event ID: adb467f0-9cd3-11f1-9ef4-b9e13e96a1f0 2026-08-20 20:29:08.997556 | 2026-08-20 20:29:08.997663 | LOOP [emit-job-header : Print node information] 2026-08-20 20:29:09.101634 | localhost | ok: 2026-08-20 20:29:09.101819 | localhost | # Node Information 2026-08-20 20:29:09.101863 | localhost | Inventory Hostname: instance 2026-08-20 20:29:09.101908 | localhost | Hostname: np0000190291 2026-08-20 20:29:09.101945 | localhost | Username: zuul 2026-08-20 20:29:09.101980 | localhost | Distro: Ubuntu 22.04 2026-08-20 20:29:09.102010 | localhost | Provider: yul1 2026-08-20 20:29:09.102038 | localhost | Region: ca-ymq-1 2026-08-20 20:29:09.102066 | localhost | Label: ubuntu-jammy 2026-08-20 20:29:09.102094 | localhost | Product Name: OpenStack Nova 2026-08-20 20:29:09.102121 | localhost | Interface IP: 199.204.45.210 2026-08-20 20:29:09.117980 | 2026-08-20 20:29:09.118104 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-20 20:29:09.599951 | localhost -> localhost | changed 2026-08-20 20:29:09.605751 | 2026-08-20 20:29:09.605851 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-20 20:29:11.047770 | localhost -> localhost | changed 2026-08-20 20:29:11.057209 | 2026-08-20 20:29:11.057414 | PLAY [all] 2026-08-20 20:29:11.071688 | 2026-08-20 20:29:11.071836 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-20 20:29:11.309649 | instance -> localhost | ok 2026-08-20 20:29:11.321451 | 2026-08-20 20:29:11.321541 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-20 20:29:11.356279 | instance | ok 2026-08-20 20:29:11.370610 | instance | included: /var/lib/zuul/builds/de1c4c608a924881867f35e1ad40cfb2/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-20 20:29:11.377573 | 2026-08-20 20:29:11.377660 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-20 20:29:12.485848 | instance -> localhost | Generating public/private rsa key pair. 2026-08-20 20:29:12.486033 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/de1c4c608a924881867f35e1ad40cfb2/work/de1c4c608a924881867f35e1ad40cfb2_id_rsa 2026-08-20 20:29:12.486075 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/de1c4c608a924881867f35e1ad40cfb2/work/de1c4c608a924881867f35e1ad40cfb2_id_rsa.pub 2026-08-20 20:29:12.486107 | instance -> localhost | The key fingerprint is: 2026-08-20 20:29:12.486136 | instance -> localhost | SHA256:ajqWTMkSxdiup5JNsnLyf35BS36/CMqK01PpHUrDJ/0 zuul-build-sshkey 2026-08-20 20:29:12.486178 | instance -> localhost | The key's randomart image is: 2026-08-20 20:29:12.486207 | instance -> localhost | +---[RSA 3072]----+ 2026-08-20 20:29:12.486245 | instance -> localhost | | + | 2026-08-20 20:29:12.486277 | instance -> localhost | | . + | 2026-08-20 20:29:12.486306 | instance -> localhost | | o | 2026-08-20 20:29:12.486333 | instance -> localhost | | . . o | 2026-08-20 20:29:12.486361 | instance -> localhost | | + o *S. | 2026-08-20 20:29:12.486388 | instance -> localhost | |. + = B.B . | 2026-08-20 20:29:12.486415 | instance -> localhost | | * B =o*.= . | 2026-08-20 20:29:12.486443 | instance -> localhost | |* =.B++.o.E.. | 2026-08-20 20:29:12.486474 | instance -> localhost | |.=o++*+. . .. | 2026-08-20 20:29:12.486502 | instance -> localhost | +----[SHA256]-----+ 2026-08-20 20:29:12.486564 | instance -> localhost | ok: Runtime: 0:00:00.587263 2026-08-20 20:29:12.496102 | 2026-08-20 20:29:12.496254 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-20 20:29:12.533066 | instance | ok 2026-08-20 20:29:12.548913 | instance | included: /var/lib/zuul/builds/de1c4c608a924881867f35e1ad40cfb2/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-20 20:29:12.558800 | 2026-08-20 20:29:12.558891 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-20 20:29:12.584200 | instance | skipping: Conditional result was False 2026-08-20 20:29:12.596147 | 2026-08-20 20:29:12.596344 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-20 20:29:13.139915 | instance | changed 2026-08-20 20:29:13.146516 | 2026-08-20 20:29:13.146616 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-20 20:29:13.361599 | instance | ok 2026-08-20 20:29:13.369398 | 2026-08-20 20:29:13.369499 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-20 20:29:13.849208 | instance | changed 2026-08-20 20:29:13.861544 | 2026-08-20 20:29:13.861657 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-20 20:29:14.368253 | instance | changed 2026-08-20 20:29:14.375022 | 2026-08-20 20:29:14.375938 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-20 20:29:14.400167 | instance | skipping: Conditional result was False 2026-08-20 20:29:14.406227 | 2026-08-20 20:29:14.406339 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-20 20:29:14.827379 | instance -> localhost | changed 2026-08-20 20:29:14.844279 | 2026-08-20 20:29:14.844445 | TASK [add-build-sshkey : Add back temp key] 2026-08-20 20:29:15.193143 | instance -> localhost | Identity added: /var/lib/zuul/builds/de1c4c608a924881867f35e1ad40cfb2/work/de1c4c608a924881867f35e1ad40cfb2_id_rsa (zuul-build-sshkey) 2026-08-20 20:29:15.193377 | instance -> localhost | ok: Runtime: 0:00:00.015962 2026-08-20 20:29:15.208771 | 2026-08-20 20:29:15.501083 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-20 20:29:15.884675 | instance | ok 2026-08-20 20:29:15.891530 | 2026-08-20 20:29:15.891640 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-20 20:29:15.915935 | instance | skipping: Conditional result was False 2026-08-20 20:29:15.930067 | 2026-08-20 20:29:15.930294 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-08-20 20:29:16.283528 | instance | ok 2026-08-20 20:29:16.291877 | 2026-08-20 20:29:16.292007 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-08-20 20:29:38.884644 | instance | Output suppressed because no_log was given 2026-08-20 20:29:39.353485 | 2026-08-20 20:29:39.353642 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-08-20 20:29:39.561521 | instance | ok: "logs" 2026-08-20 20:29:39.561788 | instance | ok: All items complete 2026-08-20 20:29:39.561826 | 2026-08-20 20:29:39.732893 | instance | ok: "artifacts" 2026-08-20 20:29:39.919693 | instance | ok: "docs" 2026-08-20 20:29:39.929045 | 2026-08-20 20:29:39.929148 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-08-20 20:29:40.138306 | instance | changed: "logs" 2026-08-20 20:29:40.301413 | instance | changed: "artifacts" 2026-08-20 20:29:40.477880 | instance | changed: "docs" 2026-08-20 20:29:40.501090 | 2026-08-20 20:29:40.501202 | PLAY RECAP 2026-08-20 20:29:40.501250 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-08-20 20:29:40.501280 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-20 20:29:40.501302 | 2026-08-20 20:29:40.681224 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-20 20:29:40.849946 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-20 20:29:41.613148 | 2026-08-20 20:29:41.613341 | PLAY [all] 2026-08-20 20:29:41.630887 | 2026-08-20 20:29:41.631096 | TASK [setup-uv : Extract archive] 2026-08-20 20:29:44.082716 | instance | changed 2026-08-20 20:29:44.104399 | 2026-08-20 20:29:44.104655 | TASK [setup-uv : Print version] 2026-08-20 20:29:44.530106 | instance | uv 0.8.13 2026-08-20 20:29:44.650861 | instance | ok: Runtime: 0:00:00.013547 2026-08-20 20:29:44.661903 | 2026-08-20 20:29:44.662111 | TASK [Install Ansible collection siblings] 2026-08-20 20:29:57.990193 | instance | changed: 2026-08-20 20:29:57.990381 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-08-20 20:29:57.990426 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-08-20 20:29:57.990459 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-08-20 20:29:57.990489 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto 2026-08-20 20:29:57.990519 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general 2026-08-20 20:29:57.990553 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql 2026-08-20 20:29:57.990584 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-08-20 20:29:57.990617 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-08-20 20:29:57.990647 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-08-20 20:29:57.990676 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-08-20 20:29:57.990704 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-08-20 20:29:57.990732 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-08-20 20:29:57.990760 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0 2026-08-20 20:29:57.990788 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0 2026-08-20 20:29:57.990816 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0 2026-08-20 20:29:57.990845 | instance | Resolved community.crypto to 2.2.3 for 2.2.3 2026-08-20 20:29:57.990872 | instance | Resolved community.general to 7.3.0 for 7.3.0 2026-08-20 20:29:57.990900 | instance | Resolved community.mysql to 3.6.0 for 3.6.0 2026-08-20 20:29:57.990926 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0 2026-08-20 20:29:57.990955 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0 2026-08-20 20:29:57.990982 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0 2026-08-20 20:29:57.991008 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0 2026-08-20 20:29:57.991037 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-08-20 20:29:57.991076 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0 2026-08-20 20:29:57.991108 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0 2026-08-20 20:29:57.991208 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-08-20 20:29:57.991251 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-08-20 20:29:57.991285 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-08-20 20:29:57.991313 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0 2026-08-20 20:29:57.991340 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3 2026-08-20 20:29:57.991367 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-08-20 20:29:57.991395 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-08-20 20:29:57.991424 | instance | Checked out ansible.netcommon to 1.2.0 2026-08-20 20:29:57.991452 | 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-20 20:29:57.991488 | instance | Starting galaxy collection install process 2026-08-20 20:29:57.991515 | instance | Process install dependency map 2026-08-20 20:29:57.991542 | instance | Starting collection install process 2026-08-20 20:29:57.991569 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon' 2026-08-20 20:29:57.991597 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon 2026-08-20 20:29:57.991623 | instance | ansible.netcommon:* was installed successfully 2026-08-20 20:29:57.991649 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-08-20 20:29:57.991675 | instance | Creating virtual environment at: .venv 2026-08-20 20:29:57.991701 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-08-20 20:29:57.991727 | instance | Downloading netaddr (2.2MiB) 2026-08-20 20:29:57.991754 | instance | Downloading rjsonnet (1.2MiB) 2026-08-20 20:29:57.991785 | instance | Downloading kubernetes (1.9MiB) 2026-08-20 20:29:57.991813 | instance | Downloading cryptography (4.2MiB) 2026-08-20 20:29:57.991840 | instance | Downloading setuptools (1.1MiB) 2026-08-20 20:29:57.991867 | instance | Downloading openstacksdk (1.7MiB) 2026-08-20 20:29:57.991895 | instance | Downloading pygments (1.2MiB) 2026-08-20 20:29:57.991922 | instance | Downloading ansible-core (2.1MiB) 2026-08-20 20:29:57.991949 | instance | Building pyperclip==1.9.0 2026-08-20 20:29:57.991976 | instance | Downloading rjsonnet 2026-08-20 20:29:57.992027 | instance | Downloading netaddr 2026-08-20 20:29:57.992056 | instance | Downloading pygments 2026-08-20 20:29:57.992084 | instance | Downloading cryptography 2026-08-20 20:29:57.992111 | instance | Downloading setuptools 2026-08-20 20:29:57.992138 | instance | Downloading kubernetes 2026-08-20 20:29:57.992164 | instance | Downloading ansible-core 2026-08-20 20:29:57.992190 | instance | Downloading openstacksdk 2026-08-20 20:29:57.992214 | instance | Built pyperclip==1.9.0 2026-08-20 20:29:57.992235 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-08-20 20:29:57.992255 | instance | Installed 79 packages in 1.02s 2026-08-20 20:29:57.992273 | instance | Checked out ansible.posix to 1.6.0 2026-08-20 20:29:57.992292 | 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-20 20:29:57.992311 | instance | Starting galaxy collection install process 2026-08-20 20:29:57.992329 | instance | Process install dependency map 2026-08-20 20:29:57.992347 | instance | Starting collection install process 2026-08-20 20:29:57.992366 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-08-20 20:29:57.992390 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix 2026-08-20 20:29:57.992410 | instance | ansible.posix:1.6.0 was installed successfully 2026-08-20 20:29:57.992429 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:29:57.992447 | instance | 2.17.12 2026-08-20 20:29:57.992466 | instance | Checked out ansible.utils to v6.1.0 2026-08-20 20:29:57.992485 | 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-20 20:29:57.992504 | instance | Starting galaxy collection install process 2026-08-20 20:29:57.992522 | instance | Process install dependency map 2026-08-20 20:29:57.992540 | instance | Starting collection install process 2026-08-20 20:29:57.992560 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils' 2026-08-20 20:29:57.992578 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils 2026-08-20 20:29:57.992596 | instance | ansible.utils:6.1.0 was installed successfully 2026-08-20 20:29:57.992821 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:29:57.992850 | instance | 2.17.12 2026-08-20 20:29:57.992871 | instance | Checked out atmosphere.common to v0.7.0 2026-08-20 20:29:57.992890 | 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-20 20:29:57.992909 | instance | Starting galaxy collection install process 2026-08-20 20:29:57.992928 | instance | Process install dependency map 2026-08-20 20:29:57.992946 | instance | Starting collection install process 2026-08-20 20:29:57.993074 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common' 2026-08-20 20:29:57.993101 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common 2026-08-20 20:29:57.993122 | instance | atmosphere.common:0.7.0 was installed successfully 2026-08-20 20:29:57.993141 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:29:57.993159 | instance | 2.17.12 2026-08-20 20:29:57.993178 | instance | Checked out community.crypto to 2.2.3 2026-08-20 20:29:57.993196 | 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-20 20:29:57.993215 | instance | Starting galaxy collection install process 2026-08-20 20:29:57.993233 | instance | Process install dependency map 2026-08-20 20:29:57.993251 | instance | Starting collection install process 2026-08-20 20:29:57.993269 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-08-20 20:29:57.993288 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto 2026-08-20 20:29:57.993306 | instance | community.crypto:2.2.3 was installed successfully 2026-08-20 20:29:57.993324 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:29:57.993342 | instance | 2.17.12 2026-08-20 20:29:57.993360 | instance | Checked out community.general to 7.3.0 2026-08-20 20:29:57.993377 | 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-20 20:29:57.993396 | instance | Starting galaxy collection install process 2026-08-20 20:29:57.993420 | instance | Process install dependency map 2026-08-20 20:29:57.993440 | instance | Starting collection install process 2026-08-20 20:29:57.993458 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-08-20 20:29:57.993476 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general 2026-08-20 20:29:57.993494 | instance | community.general:7.3.0 was installed successfully 2026-08-20 20:29:57.993512 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:29:57.993530 | instance | 2.17.12 2026-08-20 20:29:57.993549 | instance | Checked out community.mysql to 3.6.0 2026-08-20 20:29:57.993568 | 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-20 20:29:57.993586 | instance | Starting galaxy collection install process 2026-08-20 20:29:57.993606 | instance | Process install dependency map 2026-08-20 20:29:57.993626 | instance | Starting collection install process 2026-08-20 20:29:57.993644 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql' 2026-08-20 20:29:57.993663 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql 2026-08-20 20:29:57.993681 | instance | community.mysql:3.6.0 was installed successfully 2026-08-20 20:29:57.993698 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:29:57.993716 | instance | 2.17.12 2026-08-20 20:29:57.993734 | instance | Checked out kubernetes.core to 2.4.0 2026-08-20 20:29:57.993752 | 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-20 20:29:57.993769 | instance | Starting galaxy collection install process 2026-08-20 20:29:57.993787 | instance | Process install dependency map 2026-08-20 20:29:57.993806 | instance | Starting collection install process 2026-08-20 20:29:57.993824 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core' 2026-08-20 20:29:57.993842 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core 2026-08-20 20:29:57.993860 | instance | kubernetes.core:2.4.0 was installed successfully 2026-08-20 20:29:57.993878 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:29:57.993896 | instance | 2.17.12 2026-08-20 20:29:57.993914 | instance | Checked out openstack.cloud to 2.6.0 2026-08-20 20:29:57.993932 | 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-20 20:29:57.993951 | instance | Starting galaxy collection install process 2026-08-20 20:29:57.993969 | instance | Process install dependency map 2026-08-20 20:29:57.993987 | instance | Starting collection install process 2026-08-20 20:29:57.994004 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud' 2026-08-20 20:29:57.994022 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud 2026-08-20 20:29:57.994041 | instance | openstack.cloud:2.6.0 was installed successfully 2026-08-20 20:29:57.994059 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:29:57.994077 | instance | 2.17.12 2026-08-20 20:29:57.994095 | instance | Checked out vexxhost.ceph to v4.2.0 2026-08-20 20:29:57.994112 | 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-20 20:29:57.994135 | instance | Starting galaxy collection install process 2026-08-20 20:29:57.994154 | instance | Process install dependency map 2026-08-20 20:29:57.994172 | instance | Starting collection install process 2026-08-20 20:29:57.994189 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph' 2026-08-20 20:29:57.994207 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph 2026-08-20 20:29:57.994224 | instance | vexxhost.ceph:4.2.0 was installed successfully 2026-08-20 20:29:57.994242 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:29:57.994260 | instance | 2.17.12 2026-08-20 20:29:57.994278 | instance | Checked out vexxhost.containers to v1.6.8 2026-08-20 20:29:57.994296 | 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-20 20:29:57.994316 | instance | Starting galaxy collection install process 2026-08-20 20:29:57.994335 | instance | Process install dependency map 2026-08-20 20:29:57.994353 | instance | Starting collection install process 2026-08-20 20:29:57.994371 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers' 2026-08-20 20:29:57.994388 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers 2026-08-20 20:29:57.994406 | instance | vexxhost.containers:1.6.8 was installed successfully 2026-08-20 20:29:57.994424 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:29:57.994441 | instance | 2.17.12 2026-08-20 20:29:57.994460 | instance | Checked out vexxhost.kubernetes to v3.3.0 2026-08-20 20:29:57.994479 | 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-20 20:29:57.994498 | instance | Starting galaxy collection install process 2026-08-20 20:29:57.994516 | instance | Process install dependency map 2026-08-20 20:29:57.994535 | instance | Starting collection install process 2026-08-20 20:29:57.994553 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes' 2026-08-20 20:29:57.994571 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes 2026-08-20 20:29:57.994589 | instance | vexxhost.kubernetes:3.3.0 was installed successfully 2026-08-20 20:29:57.994607 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-20 20:29:57.994625 | instance | 2.17.12 2026-08-20 20:29:58.001427 | 2026-08-20 20:29:58.001508 | PLAY RECAP 2026-08-20 20:29:58.001552 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-20 20:29:58.001573 | 2026-08-20 20:29:58.160187 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-20 20:29:58.167003 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-08-20 20:29:58.819403 | 2026-08-20 20:29:59.022687 | PLAY [all] 2026-08-20 20:29:59.040871 | 2026-08-20 20:29:59.041083 | TASK [Install "jq" for log collection] 2026-08-20 20:30:15.151730 | instance | changed 2026-08-20 20:30:15.154883 | 2026-08-20 20:30:15.154976 | PLAY RECAP 2026-08-20 20:30:15.155032 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-20 20:30:15.155083 | 2026-08-20 20:30:15.357530 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-08-20 20:30:15.424561 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-20 20:30:16.187181 | 2026-08-20 20:30:16.187318 | PLAY [all] 2026-08-20 20:30:16.198749 | 2026-08-20 20:30:16.198897 | LOOP [Check inventory directories] 2026-08-20 20:30:16.636794 | instance | ok: "src/github.com/vexxhost/atmosphere" 2026-08-20 20:30:17.842156 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory" 2026-08-20 20:30:17.847426 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory" 2026-08-20 20:30:17.875234 | 2026-08-20 20:30:17.875397 | LOOP [Copy inventory file for Zuul] 2026-08-20 20:30:18.682571 | instance | changed: 2026-08-20 20:30:18.682865 | instance | { 2026-08-20 20:30:18.682913 | instance | "ansible_loop_var": "item", 2026-08-20 20:30:18.682945 | instance | "changed": false, 2026-08-20 20:30:18.682971 | instance | "failed": false, 2026-08-20 20:30:18.682998 | instance | "invocation": { 2026-08-20 20:30:18.683022 | instance | "module_args": { 2026-08-20 20:30:18.683045 | instance | "checksum_algorithm": "sha1", 2026-08-20 20:30:18.683063 | instance | "follow": true, 2026-08-20 20:30:18.683083 | instance | "get_attributes": true, 2026-08-20 20:30:18.683103 | instance | "get_checksum": true, 2026-08-20 20:30:18.683122 | instance | "get_mime": true, 2026-08-20 20:30:18.683141 | instance | "path": "src/github.com/vexxhost/atmosphere" 2026-08-20 20:30:18.683160 | instance | } 2026-08-20 20:30:18.683181 | instance | }, 2026-08-20 20:30:18.683201 | instance | "item": "src/github.com/vexxhost/atmosphere", 2026-08-20 20:30:18.683219 | instance | "stat": { 2026-08-20 20:30:18.683237 | instance | "atime": 1787257787.104377, 2026-08-20 20:30:18.683256 | instance | "attr_flags": "e", 2026-08-20 20:30:18.683274 | instance | "attributes": [ 2026-08-20 20:30:18.683292 | instance | "extents" 2026-08-20 20:30:18.683309 | instance | ], 2026-08-20 20:30:18.683327 | instance | "block_size": 4096, 2026-08-20 20:30:18.683344 | instance | "blocks": 8, 2026-08-20 20:30:18.683362 | instance | "charset": "unknown", 2026-08-20 20:30:18.683381 | instance | "ctime": 1787257785.8923547, 2026-08-20 20:30:18.683400 | instance | "dev": 64513, 2026-08-20 20:30:18.683418 | instance | "device_type": 0, 2026-08-20 20:30:18.683437 | instance | "executable": true, 2026-08-20 20:30:18.683455 | instance | "exists": true, 2026-08-20 20:30:18.683473 | instance | "gid": 1000, 2026-08-20 20:30:18.683490 | instance | "gr_name": "zuul", 2026-08-20 20:30:18.683508 | instance | "inode": 1046545, 2026-08-20 20:30:18.683527 | instance | "isblk": false, 2026-08-20 20:30:18.683545 | instance | "ischr": false, 2026-08-20 20:30:18.683564 | instance | "isdir": true, 2026-08-20 20:30:18.683582 | instance | "isfifo": false, 2026-08-20 20:30:18.683599 | instance | "isgid": false, 2026-08-20 20:30:18.683617 | instance | "islnk": false, 2026-08-20 20:30:18.683635 | instance | "isreg": false, 2026-08-20 20:30:18.683653 | instance | "issock": false, 2026-08-20 20:30:18.683670 | instance | "isuid": false, 2026-08-20 20:30:18.683687 | instance | "mimetype": "unknown", 2026-08-20 20:30:18.683705 | instance | "mode": "0755", 2026-08-20 20:30:18.683722 | instance | "mtime": 1787257785.8923547, 2026-08-20 20:30:18.683741 | instance | "nlink": 22, 2026-08-20 20:30:18.683759 | instance | "path": "src/github.com/vexxhost/atmosphere", 2026-08-20 20:30:18.683777 | instance | "pw_name": "zuul", 2026-08-20 20:30:18.683795 | instance | "readable": true, 2026-08-20 20:30:18.683813 | instance | "rgrp": true, 2026-08-20 20:30:18.683831 | instance | "roth": true, 2026-08-20 20:30:18.683849 | instance | "rusr": true, 2026-08-20 20:30:18.683867 | instance | "size": 4096, 2026-08-20 20:30:18.683884 | instance | "uid": 1000, 2026-08-20 20:30:18.683914 | instance | "version": "3450697949", 2026-08-20 20:30:18.683934 | instance | "wgrp": false, 2026-08-20 20:30:18.683954 | instance | "woth": false, 2026-08-20 20:30:18.683972 | instance | "writeable": true, 2026-08-20 20:30:18.683990 | instance | "wusr": true, 2026-08-20 20:30:18.684008 | instance | "xgrp": true, 2026-08-20 20:30:18.684026 | instance | "xoth": true, 2026-08-20 20:30:18.684045 | instance | "xusr": true 2026-08-20 20:30:18.684062 | instance | } 2026-08-20 20:30:18.684081 | instance | } 2026-08-20 20:30:18.684116 | instance | ok: All items complete 2026-08-20 20:30:18.684138 | 2026-08-20 20:30:18.685804 | instance | skipping: Conditional result was False 2026-08-20 20:30:18.689808 | instance | skipping: Conditional result was False 2026-08-20 20:30:18.706297 | 2026-08-20 20:30:18.706559 | LOOP [Switch "ansible_host" to private IP] 2026-08-20 20:30:19.070550 | instance | changed: 1 replacements made 2026-08-20 20:30:19.072314 | instance | skipping: Conditional result was False 2026-08-20 20:30:19.073750 | instance | skipping: Conditional result was False 2026-08-20 20:30:19.091348 | 2026-08-20 20:30:19.091478 | TASK [Run Molecule scenario] 2026-08-20 20:30:20.075257 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-08-20 20:30:20.495456 | instance | INFO [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-08-20 20:30:20.495555 | instance | INFO [csi > prerun] Performing prerun with role_name_check=0... 2026-08-20 20:30:32.280327 | instance | INFO [csi > dependency] Executing 2026-08-20 20:30:32.280410 | instance | WARNING [csi > dependency] Missing roles requirements file: requirements.yml 2026-08-20 20:30:32.280575 | instance | WARNING [csi > dependency] Missing collections requirements file: collections.yml 2026-08-20 20:30:32.280688 | instance | WARNING [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-08-20 20:30:32.290058 | instance | INFO [csi > cleanup] Executing 2026-08-20 20:30:32.290775 | instance | WARNING [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-20 20:30:32.298369 | instance | INFO [csi > destroy] Executing 2026-08-20 20:30:32.298409 | instance | WARNING [csi > destroy] Skipping, '--destroy=never' requested. 2026-08-20 20:30:32.298494 | instance | INFO [csi > destroy] Executed: Successful 2026-08-20 20:30:32.305905 | instance | INFO [csi > syntax] Executing 2026-08-20 20:30:34.021618 | instance | 2026-08-20 20:30:34.021770 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-08-20 20:30:34.098672 | instance | INFO [csi > syntax] Executed: Successful 2026-08-20 20:30:34.110563 | instance | INFO [csi > create] Executing 2026-08-20 20:30:34.208681 | instance | WARNING [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-20 20:30:34.217695 | instance | INFO [csi > prepare] Executing 2026-08-20 20:30:36.482667 | instance | 2026-08-20 20:30:36.482953 | instance | PLAY [Prepare] ***************************************************************** 2026-08-20 20:30:36.483225 | instance | 2026-08-20 20:30:36.483511 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-20 20:30:36.483795 | instance | Thursday 20 August 2026 20:30:36 +0000 (0:00:00.035) 0:00:00.035 ******* 2026-08-20 20:30:39.802589 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-08-20 20:30:39.802716 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-08-20 20:30:39.802733 | instance | interpreter could change the meaning of that path. See 2026-08-20 20:30:39.802922 | instance | https://docs.ansible.com/ansible- 2026-08-20 20:30:39.803085 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-08-20 20:30:39.811556 | instance | ok: [instance] 2026-08-20 20:30:39.811667 | instance | 2026-08-20 20:30:39.811855 | instance | TASK [Configure short hostname] ************************************************ 2026-08-20 20:30:39.812068 | instance | Thursday 20 August 2026 20:30:39 +0000 (0:00:03.582) 0:00:03.617 ******* 2026-08-20 20:30:41.202497 | instance | changed: [instance] 2026-08-20 20:30:41.202849 | instance | 2026-08-20 20:30:41.203229 | instance | TASK [Ensure hostname inside hosts file] *************************************** 2026-08-20 20:30:41.203588 | instance | Thursday 20 August 2026 20:30:41 +0000 (0:00:01.390) 0:00:05.008 ******* 2026-08-20 20:30:41.477902 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created 2026-08-20 20:30:41.478147 | instance | with a mode of 0700, this may cause issues when running as another user. To 2026-08-20 20:30:41.478421 | instance | avoid this, create the remote_tmp dir with the correct permissions manually 2026-08-20 20:30:41.486156 | instance | changed: [instance] 2026-08-20 20:30:41.486383 | instance | 2026-08-20 20:30:41.486635 | instance | TASK [Purge "snapd" package] *************************************************** 2026-08-20 20:30:41.486895 | instance | Thursday 20 August 2026 20:30:41 +0000 (0:00:00.283) 0:00:05.292 ******* 2026-08-20 20:30:42.225764 | instance | ok: [instance] 2026-08-20 20:30:42.225854 | instance | 2026-08-20 20:30:42.226340 | instance | PLAY [Create devices for Ceph] ************************************************* 2026-08-20 20:30:42.226435 | instance | 2026-08-20 20:30:42.226440 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-20 20:30:42.226455 | instance | Thursday 20 August 2026 20:30:42 +0000 (0:00:00.739) 0:00:06.032 ******* 2026-08-20 20:30:42.882252 | instance | ok: [instance] 2026-08-20 20:30:42.882278 | instance | 2026-08-20 20:30:42.882283 | instance | TASK [Install depedencies] ***************************************************** 2026-08-20 20:30:42.882288 | instance | Thursday 20 August 2026 20:30:42 +0000 (0:00:00.656) 0:00:06.688 ******* 2026-08-20 20:31:06.736237 | instance | changed: [instance] 2026-08-20 20:31:06.736323 | instance | 2026-08-20 20:31:06.736778 | instance | TASK [Start up service] ******************************************************** 2026-08-20 20:31:06.736818 | instance | Thursday 20 August 2026 20:31:06 +0000 (0:00:23.853) 0:00:30.542 ******* 2026-08-20 20:31:07.298843 | instance | ok: [instance] 2026-08-20 20:31:07.299401 | instance | 2026-08-20 20:31:07.299422 | instance | TASK [Generate lvm.conf] ******************************************************* 2026-08-20 20:31:07.299430 | instance | Thursday 20 August 2026 20:31:07 +0000 (0:00:00.562) 0:00:31.104 ******* 2026-08-20 20:31:07.588630 | instance | ok: [instance] 2026-08-20 20:31:07.588698 | instance | 2026-08-20 20:31:07.588998 | instance | TASK [Write /etc/lvm/lvm.conf] ************************************************* 2026-08-20 20:31:07.589031 | instance | Thursday 20 August 2026 20:31:07 +0000 (0:00:00.290) 0:00:31.394 ******* 2026-08-20 20:31:08.260695 | instance | changed: [instance] 2026-08-20 20:31:08.261249 | instance | 2026-08-20 20:31:08.261432 | instance | TASK [Get list of all loopback devices] **************************************** 2026-08-20 20:31:08.261443 | instance | Thursday 20 August 2026 20:31:08 +0000 (0:00:00.671) 0:00:32.066 ******* 2026-08-20 20:31:08.449375 | instance | ok: [instance] 2026-08-20 20:31:08.449836 | instance | 2026-08-20 20:31:08.449852 | instance | TASK [Fail if there is any existing loopback devices] ************************** 2026-08-20 20:31:08.449858 | instance | Thursday 20 August 2026 20:31:08 +0000 (0:00:00.188) 0:00:32.255 ******* 2026-08-20 20:31:08.475007 | instance | skipping: [instance] 2026-08-20 20:31:08.475272 | instance | 2026-08-20 20:31:08.475625 | instance | TASK [Create devices for Ceph] ************************************************* 2026-08-20 20:31:08.475961 | instance | Thursday 20 August 2026 20:31:08 +0000 (0:00:00.025) 0:00:32.281 ******* 2026-08-20 20:31:08.998155 | instance | changed: [instance] => (item=osd0) 2026-08-20 20:31:08.998308 | instance | changed: [instance] => (item=osd1) 2026-08-20 20:31:08.998576 | instance | changed: [instance] => (item=osd2) 2026-08-20 20:31:08.998794 | instance | 2026-08-20 20:31:08.999020 | instance | TASK [Set permissions on loopback devices] ************************************* 2026-08-20 20:31:08.999245 | instance | Thursday 20 August 2026 20:31:08 +0000 (0:00:00.523) 0:00:32.804 ******* 2026-08-20 20:31:09.636729 | instance | changed: [instance] => (item=osd0) 2026-08-20 20:31:09.637061 | instance | changed: [instance] => (item=osd1) 2026-08-20 20:31:09.637326 | instance | changed: [instance] => (item=osd2) 2026-08-20 20:31:09.637543 | instance | 2026-08-20 20:31:09.637732 | instance | TASK [Start loop devices] ****************************************************** 2026-08-20 20:31:09.637893 | instance | Thursday 20 August 2026 20:31:09 +0000 (0:00:00.636) 0:00:33.440 ******* 2026-08-20 20:31:10.318080 | instance | changed: [instance] => (item=osd0) 2026-08-20 20:31:10.318118 | instance | changed: [instance] => (item=osd1) 2026-08-20 20:31:10.318123 | instance | changed: [instance] => (item=osd2) 2026-08-20 20:31:10.318128 | instance | 2026-08-20 20:31:10.318133 | instance | TASK [Create a volume group for each loop device] ****************************** 2026-08-20 20:31:10.318137 | instance | Thursday 20 August 2026 20:31:10 +0000 (0:00:00.682) 0:00:34.123 ******* 2026-08-20 20:31:13.468628 | instance | changed: [instance] => (item=osd0) 2026-08-20 20:31:13.468735 | instance | changed: [instance] => (item=osd1) 2026-08-20 20:31:13.468991 | instance | changed: [instance] => (item=osd2) 2026-08-20 20:31:13.469307 | instance | 2026-08-20 20:31:13.469608 | instance | TASK [Create a logical volume for each loop device] **************************** 2026-08-20 20:31:13.469896 | instance | Thursday 20 August 2026 20:31:13 +0000 (0:00:03.150) 0:00:37.274 ******* 2026-08-20 20:31:15.332562 | instance | changed: [instance] => (item=ceph-instance-osd0) 2026-08-20 20:31:15.332633 | instance | changed: [instance] => (item=ceph-instance-osd1) 2026-08-20 20:31:15.332665 | instance | changed: [instance] => (item=ceph-instance-osd2) 2026-08-20 20:31:15.332677 | instance | 2026-08-20 20:31:15.332686 | instance | PLAY RECAP ********************************************************************* 2026-08-20 20:31:15.332696 | instance | instance : ok=15 changed=9 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-08-20 20:31:15.332706 | instance | 2026-08-20 20:31:15.332715 | instance | Thursday 20 August 2026 20:31:15 +0000 (0:00:01.861) 0:00:39.135 ******* 2026-08-20 20:31:15.332724 | instance | =============================================================================== 2026-08-20 20:31:15.332732 | instance | Install depedencies ---------------------------------------------------- 23.85s 2026-08-20 20:31:15.332741 | instance | Gathering Facts --------------------------------------------------------- 3.58s 2026-08-20 20:31:15.332757 | instance | Create a volume group for each loop device ------------------------------ 3.15s 2026-08-20 20:31:15.332874 | instance | Create a logical volume for each loop device ---------------------------- 1.86s 2026-08-20 20:31:15.333122 | instance | Configure short hostname ------------------------------------------------ 1.39s 2026-08-20 20:31:15.333330 | instance | Purge "snapd" package --------------------------------------------------- 0.74s 2026-08-20 20:31:15.333537 | instance | Start loop devices ------------------------------------------------------ 0.68s 2026-08-20 20:31:15.333744 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.67s 2026-08-20 20:31:15.333984 | instance | Gathering Facts --------------------------------------------------------- 0.66s 2026-08-20 20:31:15.334212 | instance | Set permissions on loopback devices ------------------------------------- 0.64s 2026-08-20 20:31:15.334419 | instance | Start up service -------------------------------------------------------- 0.56s 2026-08-20 20:31:15.334648 | instance | Create devices for Ceph ------------------------------------------------- 0.52s 2026-08-20 20:31:15.334876 | instance | Generate lvm.conf ------------------------------------------------------- 0.29s 2026-08-20 20:31:15.335089 | instance | Ensure hostname inside hosts file --------------------------------------- 0.28s 2026-08-20 20:31:15.335320 | instance | Get list of all loopback devices ---------------------------------------- 0.19s 2026-08-20 20:31:15.335556 | instance | Fail if there is any existing loopback devices -------------------------- 0.03s 2026-08-20 20:31:15.408596 | instance | INFO [csi > prepare] Executed: Successful 2026-08-20 20:31:15.421502 | instance | INFO [csi > converge] Executing 2026-08-20 20:31:16.959263 | instance | 2026-08-20 20:31:16.959819 | instance | PLAY [Debug CSI driver value] ************************************************** 2026-08-20 20:31:16.960230 | instance | 2026-08-20 20:31:16.960644 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-20 20:31:16.960867 | instance | Thursday 20 August 2026 20:31:16 +0000 (0:00:00.007) 0:00:00.007 ******* 2026-08-20 20:31:17.936073 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-08-20 20:31:17.936539 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-08-20 20:31:17.936915 | instance | interpreter could change the meaning of that path. See 2026-08-20 20:31:17.937278 | instance | https://docs.ansible.com/ansible- 2026-08-20 20:31:17.937636 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-08-20 20:31:17.947099 | instance | ok: [instance] 2026-08-20 20:31:17.947361 | instance | 2026-08-20 20:31:17.947606 | instance | TASK [Display CSI driver value and environment variable] *********************** 2026-08-20 20:31:17.947844 | instance | Thursday 20 August 2026 20:31:17 +0000 (0:00:00.987) 0:00:00.995 ******* 2026-08-20 20:31:17.998419 | instance | ok: [instance] => { 2026-08-20 20:31:17.998705 | instance | "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER=" 2026-08-20 20:31:17.998925 | instance | } 2026-08-20 20:31:17.999129 | instance | 2026-08-20 20:31:17.999343 | instance | PLAY [all] ********************************************************************* 2026-08-20 20:31:17.999543 | instance | 2026-08-20 20:31:17.999757 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-20 20:31:17.999988 | instance | Thursday 20 August 2026 20:31:17 +0000 (0:00:00.051) 0:00:01.047 ******* 2026-08-20 20:31:18.868921 | instance | ok: [instance] 2026-08-20 20:31:18.869310 | instance | 2026-08-20 20:31:18.869692 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-08-20 20:31:18.870120 | instance | Thursday 20 August 2026 20:31:18 +0000 (0:00:00.870) 0:00:01.917 ******* 2026-08-20 20:31:19.058283 | instance | ok: [instance] 2026-08-20 20:31:19.058698 | instance | 2026-08-20 20:31:19.059085 | instance | PLAY [Deploy Ceph monitors & managers] ***************************************** 2026-08-20 20:31:19.059586 | instance | 2026-08-20 20:31:19.060141 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-20 20:31:19.060692 | instance | Thursday 20 August 2026 20:31:19 +0000 (0:00:00.189) 0:00:02.107 ******* 2026-08-20 20:31:19.973248 | instance | ok: [instance] 2026-08-20 20:31:19.973323 | instance | 2026-08-20 20:31:19.973480 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-20 20:31:19.973724 | instance | Thursday 20 August 2026 20:31:19 +0000 (0:00:00.911) 0:00:03.018 ******* 2026-08-20 20:31:20.256843 | instance | ok: [instance] 2026-08-20 20:31:20.257032 | instance | 2026-08-20 20:31:20.257191 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-20 20:31:20.257347 | instance | Thursday 20 August 2026 20:31:20 +0000 (0:00:00.285) 0:00:03.303 ******* 2026-08-20 20:31:20.297109 | instance | skipping: [instance] 2026-08-20 20:31:20.297368 | instance | 2026-08-20 20:31:20.297626 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-08-20 20:31:20.297919 | instance | Thursday 20 August 2026 20:31:20 +0000 (0:00:00.039) 0:00:03.343 ******* 2026-08-20 20:31:20.629072 | instance | changed: [instance] 2026-08-20 20:31:20.629204 | instance | 2026-08-20 20:31:20.629484 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-20 20:31:20.629706 | instance | Thursday 20 August 2026 20:31:20 +0000 (0:00:00.331) 0:00:03.675 ******* 2026-08-20 20:31:20.692933 | instance | ok: [instance] => { 2026-08-20 20:31:20.693027 | instance | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-08-20 20:31:20.693129 | instance | } 2026-08-20 20:31:20.693338 | instance | 2026-08-20 20:31:20.693494 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-20 20:31:20.693645 | instance | Thursday 20 August 2026 20:31:20 +0000 (0:00:00.066) 0:00:03.741 ******* 2026-08-20 20:31:21.315577 | instance | changed: [instance] 2026-08-20 20:31:21.315655 | instance | 2026-08-20 20:31:21.315952 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-20 20:31:21.315987 | instance | Thursday 20 August 2026 20:31:21 +0000 (0:00:00.622) 0:00:04.364 ******* 2026-08-20 20:31:21.368662 | instance | skipping: [instance] 2026-08-20 20:31:21.368740 | instance | 2026-08-20 20:31:21.368996 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-20 20:31:21.369036 | instance | Thursday 20 August 2026 20:31:21 +0000 (0:00:00.053) 0:00:04.417 ******* 2026-08-20 20:31:21.420846 | instance | skipping: [instance] 2026-08-20 20:31:21.420925 | instance | 2026-08-20 20:31:21.421185 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-20 20:31:21.421225 | instance | Thursday 20 August 2026 20:31:21 +0000 (0:00:00.052) 0:00:04.469 ******* 2026-08-20 20:31:21.639571 | instance | ok: [instance] 2026-08-20 20:31:21.639660 | instance | 2026-08-20 20:31:21.639934 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-20 20:31:21.639977 | instance | Thursday 20 August 2026 20:31:21 +0000 (0:00:00.218) 0:00:04.688 ******* 2026-08-20 20:31:22.855045 | instance | ok: [instance] 2026-08-20 20:31:22.855091 | instance | 2026-08-20 20:31:22.855101 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-20 20:31:22.855114 | instance | Thursday 20 August 2026 20:31:22 +0000 (0:00:01.214) 0:00:05.902 ******* 2026-08-20 20:31:22.914937 | instance | ok: [instance] => { 2026-08-20 20:31:22.915093 | instance | "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz" 2026-08-20 20:31:22.915584 | instance | } 2026-08-20 20:31:22.915712 | instance | 2026-08-20 20:31:22.915718 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-20 20:31:22.915723 | instance | Thursday 20 August 2026 20:31:22 +0000 (0:00:00.061) 0:00:05.964 ******* 2026-08-20 20:31:23.587809 | instance | changed: [instance] 2026-08-20 20:31:23.587916 | instance | 2026-08-20 20:31:23.588168 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-20 20:31:23.588184 | instance | Thursday 20 August 2026 20:31:23 +0000 (0:00:00.672) 0:00:06.636 ******* 2026-08-20 20:31:26.409959 | instance | changed: [instance] 2026-08-20 20:31:26.410088 | instance | 2026-08-20 20:31:26.410575 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-08-20 20:31:26.410631 | instance | Thursday 20 August 2026 20:31:26 +0000 (0:00:02.821) 0:00:09.458 ******* 2026-08-20 20:31:26.449104 | instance | skipping: [instance] 2026-08-20 20:31:26.449164 | instance | 2026-08-20 20:31:26.449170 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-08-20 20:31:26.449176 | instance | Thursday 20 August 2026 20:31:26 +0000 (0:00:00.038) 0:00:09.496 ******* 2026-08-20 20:31:26.489401 | instance | skipping: [instance] 2026-08-20 20:31:26.489568 | instance | 2026-08-20 20:31:26.489576 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-08-20 20:31:26.489582 | instance | Thursday 20 August 2026 20:31:26 +0000 (0:00:00.040) 0:00:09.537 ******* 2026-08-20 20:31:26.525018 | instance | skipping: [instance] 2026-08-20 20:31:26.525631 | instance | 2026-08-20 20:31:26.525680 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-08-20 20:31:26.525686 | instance | Thursday 20 August 2026 20:31:26 +0000 (0:00:00.036) 0:00:09.573 ******* 2026-08-20 20:31:32.143478 | instance | changed: [instance] 2026-08-20 20:31:32.143562 | instance | 2026-08-20 20:31:32.143835 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] *** 2026-08-20 20:31:32.143872 | instance | Thursday 20 August 2026 20:31:32 +0000 (0:00:05.618) 0:00:15.192 ******* 2026-08-20 20:31:32.812665 | instance | changed: [instance] 2026-08-20 20:31:32.812771 | instance | 2026-08-20 20:31:32.813048 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] ******* 2026-08-20 20:31:32.813087 | instance | Thursday 20 August 2026 20:31:32 +0000 (0:00:00.669) 0:00:15.861 ******* 2026-08-20 20:31:33.769990 | instance | changed: [instance] => (item={'path': '/etc/containerd'}) 2026-08-20 20:31:33.770075 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'}) 2026-08-20 20:31:33.770968 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'}) 2026-08-20 20:31:33.771008 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'}) 2026-08-20 20:31:33.771015 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'}) 2026-08-20 20:31:33.771020 | instance | 2026-08-20 20:31:33.771029 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] ********** 2026-08-20 20:31:33.771034 | instance | Thursday 20 August 2026 20:31:33 +0000 (0:00:00.957) 0:00:16.818 ******* 2026-08-20 20:31:34.356263 | instance | changed: [instance] 2026-08-20 20:31:34.356382 | instance | 2026-08-20 20:31:34.356398 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ******** 2026-08-20 20:31:34.357029 | instance | Thursday 20 August 2026 20:31:34 +0000 (0:00:00.567) 0:00:17.386 ******* 2026-08-20 20:31:34.357095 | instance | 2026-08-20 20:31:34.357104 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-08-20 20:31:34.357110 | instance | Thursday 20 August 2026 20:31:34 +0000 (0:00:00.018) 0:00:17.404 ******* 2026-08-20 20:31:35.243879 | instance | ok: [instance] 2026-08-20 20:31:35.243932 | instance | 2026-08-20 20:31:35.244208 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] ********** 2026-08-20 20:31:35.244223 | instance | Thursday 20 August 2026 20:31:35 +0000 (0:00:00.887) 0:00:18.292 ******* 2026-08-20 20:31:35.678480 | instance | changed: [instance] 2026-08-20 20:31:35.678569 | instance | 2026-08-20 20:31:35.678708 | instance | TASK [vexxhost.containers.containerd : Enable and start service] *************** 2026-08-20 20:31:35.679064 | instance | Thursday 20 August 2026 20:31:35 +0000 (0:00:00.434) 0:00:18.727 ******* 2026-08-20 20:31:36.219915 | instance | changed: [instance] 2026-08-20 20:31:36.220004 | instance | 2026-08-20 20:31:36.220283 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-20 20:31:36.220320 | instance | Thursday 20 August 2026 20:31:36 +0000 (0:00:00.541) 0:00:19.268 ******* 2026-08-20 20:31:36.429369 | instance | ok: [instance] 2026-08-20 20:31:36.429745 | instance | 2026-08-20 20:31:36.429762 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-20 20:31:36.429768 | instance | Thursday 20 August 2026 20:31:36 +0000 (0:00:00.209) 0:00:19.478 ******* 2026-08-20 20:31:36.487576 | instance | ok: [instance] => { 2026-08-20 20:31:36.488263 | instance | "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz" 2026-08-20 20:31:36.488281 | instance | } 2026-08-20 20:31:36.488288 | instance | 2026-08-20 20:31:36.488293 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-20 20:31:36.488299 | instance | Thursday 20 August 2026 20:31:36 +0000 (0:00:00.058) 0:00:19.536 ******* 2026-08-20 20:31:37.359648 | instance | changed: [instance] 2026-08-20 20:31:37.359725 | instance | 2026-08-20 20:31:37.360036 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-20 20:31:37.360166 | instance | Thursday 20 August 2026 20:31:37 +0000 (0:00:00.872) 0:00:20.408 ******* 2026-08-20 20:31:41.723374 | instance | changed: [instance] 2026-08-20 20:31:41.723414 | instance | 2026-08-20 20:31:41.723419 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ****************** 2026-08-20 20:31:41.723424 | instance | Thursday 20 August 2026 20:31:41 +0000 (0:00:04.363) 0:00:24.771 ******* 2026-08-20 20:31:42.832089 | instance | ok: [instance] 2026-08-20 20:31:42.832296 | instance | 2026-08-20 20:31:42.832313 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] *************** 2026-08-20 20:31:42.832447 | instance | Thursday 20 August 2026 20:31:42 +0000 (0:00:01.109) 0:00:25.881 ******* 2026-08-20 20:31:43.183403 | instance | changed: [instance] 2026-08-20 20:31:43.183444 | instance | 2026-08-20 20:31:43.183450 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] ***** 2026-08-20 20:31:43.183457 | instance | Thursday 20 August 2026 20:31:43 +0000 (0:00:00.350) 0:00:26.231 ******* 2026-08-20 20:31:43.689845 | instance | changed: [instance] 2026-08-20 20:31:43.689921 | instance | 2026-08-20 20:31:43.690174 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] *********** 2026-08-20 20:31:43.690212 | instance | Thursday 20 August 2026 20:31:43 +0000 (0:00:00.506) 0:00:26.738 ******* 2026-08-20 20:31:44.311295 | instance | changed: [instance] => (item={'path': '/etc/docker'}) 2026-08-20 20:31:44.312242 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'}) 2026-08-20 20:31:44.312307 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'}) 2026-08-20 20:31:44.312316 | instance | 2026-08-20 20:31:44.312324 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ****** 2026-08-20 20:31:44.312330 | instance | Thursday 20 August 2026 20:31:44 +0000 (0:00:00.620) 0:00:27.359 ******* 2026-08-20 20:31:44.816926 | instance | changed: [instance] 2026-08-20 20:31:44.817040 | instance | 2026-08-20 20:31:44.817277 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] *********** 2026-08-20 20:31:44.817331 | instance | Thursday 20 August 2026 20:31:44 +0000 (0:00:00.506) 0:00:27.865 ******* 2026-08-20 20:31:45.305156 | instance | changed: [instance] 2026-08-20 20:31:45.306121 | instance | 2026-08-20 20:31:45.306144 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************ 2026-08-20 20:31:45.306153 | instance | Thursday 20 August 2026 20:31:45 +0000 (0:00:00.470) 0:00:28.336 ******* 2026-08-20 20:31:45.306159 | instance | 2026-08-20 20:31:45.306165 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-08-20 20:31:45.306171 | instance | Thursday 20 August 2026 20:31:45 +0000 (0:00:00.017) 0:00:28.354 ******* 2026-08-20 20:31:45.993902 | instance | ok: [instance] 2026-08-20 20:31:45.993969 | instance | 2026-08-20 20:31:45.994269 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ****************** 2026-08-20 20:31:45.994316 | instance | Thursday 20 August 2026 20:31:45 +0000 (0:00:00.688) 0:00:29.042 ******* 2026-08-20 20:31:48.269263 | instance | changed: [instance] 2026-08-20 20:31:48.269387 | instance | 2026-08-20 20:31:48.269730 | instance | TASK [vexxhost.containers.docker : Enable and start service] ******************* 2026-08-20 20:31:48.269763 | instance | Thursday 20 August 2026 20:31:48 +0000 (0:00:02.275) 0:00:31.318 ******* 2026-08-20 20:31:48.814276 | instance | changed: [instance] 2026-08-20 20:31:48.814304 | instance | 2026-08-20 20:31:48.814310 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ****** 2026-08-20 20:31:48.814314 | instance | Thursday 20 August 2026 20:31:48 +0000 (0:00:00.544) 0:00:31.863 ******* 2026-08-20 20:31:48.864054 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml) 2026-08-20 20:31:48.864089 | instance | 2026-08-20 20:31:48.864095 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ******************************** 2026-08-20 20:31:48.864100 | instance | Thursday 20 August 2026 20:31:48 +0000 (0:00:00.049) 0:00:31.912 ******* 2026-08-20 20:31:53.370642 | instance | changed: [instance] 2026-08-20 20:31:53.370731 | instance | 2026-08-20 20:31:53.371069 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] ********************* 2026-08-20 20:31:53.371119 | instance | Thursday 20 August 2026 20:31:53 +0000 (0:00:04.506) 0:00:36.419 ******* 2026-08-20 20:31:54.030876 | instance | ok: [instance] => (item=chronyd) 2026-08-20 20:31:54.030979 | instance | ok: [instance] => (item=sshd) 2026-08-20 20:31:54.031029 | instance | 2026-08-20 20:31:54.031321 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ****************************** 2026-08-20 20:31:54.031443 | instance | Thursday 20 August 2026 20:31:54 +0000 (0:00:00.660) 0:00:37.079 ******* 2026-08-20 20:31:55.063006 | instance | changed: [instance] 2026-08-20 20:31:55.063070 | instance | 2026-08-20 20:31:55.063350 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ******************** 2026-08-20 20:31:55.063478 | instance | Thursday 20 August 2026 20:31:55 +0000 (0:00:01.032) 0:00:38.112 ******* 2026-08-20 20:31:55.263693 | instance | ok: [instance] 2026-08-20 20:31:55.263768 | instance | 2026-08-20 20:31:55.264027 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] **************** 2026-08-20 20:31:55.264065 | instance | Thursday 20 August 2026 20:31:55 +0000 (0:00:00.200) 0:00:38.312 ******* 2026-08-20 20:31:56.464391 | instance | changed: [instance] 2026-08-20 20:31:56.464569 | instance | 2026-08-20 20:31:56.464889 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] *** 2026-08-20 20:31:56.465023 | instance | Thursday 20 August 2026 20:31:56 +0000 (0:00:01.200) 0:00:39.513 ******* 2026-08-20 20:31:56.799211 | instance | changed: [instance] 2026-08-20 20:31:56.799289 | instance | 2026-08-20 20:31:56.799567 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] ************************* 2026-08-20 20:31:56.799607 | instance | Thursday 20 August 2026 20:31:56 +0000 (0:00:00.334) 0:00:39.848 ******* 2026-08-20 20:31:56.911190 | instance | ok: [instance] 2026-08-20 20:31:56.911252 | instance | 2026-08-20 20:31:56.911534 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] ******************* 2026-08-20 20:31:56.911575 | instance | Thursday 20 August 2026 20:31:56 +0000 (0:00:00.111) 0:00:39.960 ******* 2026-08-20 20:31:57.142722 | instance | ok: [instance] => (item=instance) 2026-08-20 20:31:57.142758 | instance | 2026-08-20 20:31:57.142763 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ******** 2026-08-20 20:31:57.142768 | instance | Thursday 20 August 2026 20:31:57 +0000 (0:00:00.231) 0:00:40.191 ******* 2026-08-20 20:31:57.192462 | instance | ok: [instance] 2026-08-20 20:31:57.192502 | instance | 2026-08-20 20:31:57.192509 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] *********************************** 2026-08-20 20:31:57.192514 | instance | Thursday 20 August 2026 20:31:57 +0000 (0:00:00.049) 0:00:40.241 ******* 2026-08-20 20:31:57.266902 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance 2026-08-20 20:31:57.267387 | instance | 2026-08-20 20:31:57.267410 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] ************* 2026-08-20 20:31:57.267418 | instance | Thursday 20 August 2026 20:31:57 +0000 (0:00:00.074) 0:00:40.315 ******* 2026-08-20 20:31:57.596202 | instance | changed: [instance] 2026-08-20 20:31:57.596271 | instance | 2026-08-20 20:31:57.596505 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ****************** 2026-08-20 20:31:57.596680 | instance | Thursday 20 August 2026 20:31:57 +0000 (0:00:00.329) 0:00:40.645 ******* 2026-08-20 20:31:58.322095 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True}) 2026-08-20 20:31:58.322177 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0}) 2026-08-20 20:31:58.322758 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False}) 2026-08-20 20:31:58.322835 | instance | 2026-08-20 20:31:58.322843 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] ******************************* 2026-08-20 20:31:58.322849 | instance | Thursday 20 August 2026 20:31:58 +0000 (0:00:00.725) 0:00:41.371 ******* 2026-08-20 20:33:32.812225 | instance | ok: [instance] 2026-08-20 20:33:32.812479 | instance | 2026-08-20 20:33:32.812488 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] *************** 2026-08-20 20:33:32.812493 | instance | Thursday 20 August 2026 20:33:32 +0000 (0:01:34.489) 0:02:15.860 ******* 2026-08-20 20:33:33.059913 | instance | changed: [instance] 2026-08-20 20:33:33.059954 | instance | 2026-08-20 20:33:33.059959 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] ********************************** 2026-08-20 20:33:33.059964 | instance | Thursday 20 August 2026 20:33:33 +0000 (0:00:00.247) 0:02:16.108 ******* 2026-08-20 20:33:33.141701 | instance | ok: [instance] 2026-08-20 20:33:33.141739 | instance | 2026-08-20 20:33:33.141745 | instance | TASK [Install Ceph host] ******************************************************* 2026-08-20 20:33:33.141750 | instance | Thursday 20 August 2026 20:33:33 +0000 (0:00:00.081) 0:02:16.190 ******* 2026-08-20 20:33:33.226000 | instance | included: vexxhost.ceph.cephadm_host for instance 2026-08-20 20:33:33.226037 | instance | 2026-08-20 20:33:33.226042 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ****** 2026-08-20 20:33:33.226047 | instance | Thursday 20 August 2026 20:33:33 +0000 (0:00:00.084) 0:02:16.274 ******* 2026-08-20 20:33:34.853836 | instance | ok: [instance] 2026-08-20 20:33:34.854000 | instance | 2026-08-20 20:33:34.854179 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] *** 2026-08-20 20:33:34.854364 | instance | Thursday 20 August 2026 20:33:34 +0000 (0:00:01.627) 0:02:17.902 ******* 2026-08-20 20:33:34.914237 | instance | ok: [instance] => (item=instance) 2026-08-20 20:33:34.914388 | instance | 2026-08-20 20:33:34.914579 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] *********** 2026-08-20 20:33:34.914772 | instance | Thursday 20 August 2026 20:33:34 +0000 (0:00:00.060) 0:02:17.962 ******* 2026-08-20 20:33:35.266147 | instance | ok: [instance] 2026-08-20 20:33:35.266266 | instance | 2026-08-20 20:33:35.266466 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] *********************** 2026-08-20 20:33:35.266642 | instance | Thursday 20 August 2026 20:33:35 +0000 (0:00:00.351) 0:02:18.314 ******* 2026-08-20 20:33:37.747462 | instance | ok: [instance] 2026-08-20 20:33:37.747551 | instance | 2026-08-20 20:33:37.747797 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ****************** 2026-08-20 20:33:37.747841 | instance | Thursday 20 August 2026 20:33:37 +0000 (0:00:02.481) 0:02:20.796 ******* 2026-08-20 20:34:40.627919 | 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-20 20:34:40.628600 | 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_oh3s5j00/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_oh3s5j00/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_oh3s5j00/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_oh3s5j00/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-20T20:34:40.317+0000 7f93981e1640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBwZIdqpvdvBCAAPQmfp68tdmBS6rtnwf2ZDcuQRNYqv8hqs/5uaR0RC1k=: Malformed input [buffer:3]\n2026-08-20T20:34:40.317+0000 7f93981e1640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-20T20:34:40.321+0000 7f93981e1640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBwZIdqpvdvBCAAPQmfp68tdmBS6rtnwf2ZDcuQRNYqv8hqs/5uaR0RC1k=: Malformed input [buffer:3]\n2026-08-20T20:34:40.321+0000 7f93981e1640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-20T20:34:40.321+0000 7f93981e1640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgBwZIdqpvdvBCAAPQmfp68tdmBS6rtnwf2ZDcuQRNYqv8hqs/5uaR0RC1k=: Malformed input [buffer:3]\n2026-08-20T20:34:40.321+0000 7f93981e1640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-20T20:34:40.321+0000 7f93981e1640 -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-20 20:34:40.630695 | instance | 2026-08-20 20:34:40.630981 | instance | PLAY RECAP ********************************************************************* 2026-08-20 20:34:40.631790 | instance | instance : ok=55 changed=26 unreachable=0 failed=1 skipped=6 rescued=0 ignored=0 2026-08-20 20:34:40.632170 | instance | 2026-08-20 20:34:40.632653 | instance | Thursday 20 August 2026 20:34:40 +0000 (0:01:02.883) 0:03:23.680 ******* 2026-08-20 20:34:40.632824 | instance | =============================================================================== 2026-08-20 20:34:40.632994 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 94.49s 2026-08-20 20:34:40.633162 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 62.88s 2026-08-20 20:34:40.633354 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 5.62s 2026-08-20 20:34:40.633502 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 4.51s 2026-08-20 20:34:40.633667 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.36s 2026-08-20 20:34:40.633836 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.82s 2026-08-20 20:34:40.633997 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.48s 2026-08-20 20:34:40.634187 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 2.28s 2026-08-20 20:34:40.634339 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.63s 2026-08-20 20:34:40.634497 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.58s 2026-08-20 20:34:40.634674 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.21s 2026-08-20 20:34:40.634826 | instance | vexxhost.ceph.cephadm : Ensure "cephadm" user is present ---------------- 1.20s 2026-08-20 20:34:40.634998 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.11s 2026-08-20 20:34:40.635159 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 1.03s 2026-08-20 20:34:40.635322 | instance | Gathering Facts --------------------------------------------------------- 0.99s 2026-08-20 20:34:40.635490 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.96s 2026-08-20 20:34:40.635733 | instance | Gathering Facts --------------------------------------------------------- 0.91s 2026-08-20 20:34:40.635950 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.87s 2026-08-20 20:34:40.636205 | instance | Gathering Facts --------------------------------------------------------- 0.87s 2026-08-20 20:34:40.636357 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.73s 2026-08-20 20:34:40.720189 | 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-20 20:34:40.720356 | instance | ERROR [csi > converge] Executed: Failed 2026-08-20 20:34:40.720532 | 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-20 20:34:41.102332 | instance | ERROR 2026-08-20 20:34:41.102933 | instance | { 2026-08-20 20:34:41.103121 | instance | "delta": "0:04:21.329892", 2026-08-20 20:34:41.103181 | instance | "end": "2026-08-20 20:34:40.777218", 2026-08-20 20:34:41.103269 | instance | "msg": "non-zero return code", 2026-08-20 20:34:41.103350 | instance | "rc": 2, 2026-08-20 20:34:41.103412 | instance | "start": "2026-08-20 20:30:19.447326" 2026-08-20 20:34:41.103463 | instance | } failure 2026-08-20 20:34:41.113747 | 2026-08-20 20:34:41.113917 | PLAY RECAP 2026-08-20 20:34:41.113984 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-08-20 20:34:41.114016 | 2026-08-20 20:34:41.780548 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-20 20:34:42.289668 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-08-20 20:34:46.330613 | 2026-08-20 20:34:46.330793 | PLAY [all] 2026-08-20 20:34:46.391342 | 2026-08-20 20:34:46.391529 | TASK [gather-host-logs : creating directory for system status] 2026-08-20 20:34:46.801882 | instance | changed 2026-08-20 20:34:46.873480 | 2026-08-20 20:34:46.873645 | TASK [gather-host-logs : Get logs for each host] 2026-08-20 20:34:47.249066 | instance | + systemd-cgls --full --all --no-pager 2026-08-20 20:34:47.265106 | instance | + ip addr 2026-08-20 20:34:47.267744 | instance | + ip route 2026-08-20 20:34:47.269553 | instance | + lsblk 2026-08-20 20:34:47.273326 | instance | + mount 2026-08-20 20:34:47.275349 | instance | + docker images 2026-08-20 20:34:47.296344 | instance | + brctl show 2026-08-20 20:34:47.296932 | instance | /bin/bash: line 8: brctl: command not found 2026-08-20 20:34:47.297159 | instance | + ps aux --sort=-%mem 2026-08-20 20:34:47.369989 | instance | + dpkg -l 2026-08-20 20:34:47.382364 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-08-20 20:34:47.382852 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-08-20 20:34:47.398562 | instance | + '[' '!' -z '' ']' 2026-08-20 20:34:47.912525 | instance | ok: Runtime: 0:00:00.155406 2026-08-20 20:34:47.919693 | 2026-08-20 20:34:47.919825 | TASK [gather-host-logs : Downloads logs to executor] 2026-08-20 20:34:48.856837 | instance | changed: 2026-08-20 20:34:48.857093 | instance | created directory /var/lib/zuul/builds/de1c4c608a924881867f35e1ad40cfb2/work/logs/instance 2026-08-20 20:34:48.857133 | instance | cd+++++++++ system/ 2026-08-20 20:34:48.857163 | instance | >f+++++++++ system/brctl-show.txt 2026-08-20 20:34:48.857193 | instance | >f+++++++++ system/docker-images.txt 2026-08-20 20:34:48.857220 | instance | >f+++++++++ system/ip-addr.txt 2026-08-20 20:34:48.857257 | instance | >f+++++++++ system/ip-route.txt 2026-08-20 20:34:48.857301 | instance | >f+++++++++ system/lsblk.txt 2026-08-20 20:34:48.857344 | instance | >f+++++++++ system/mount.txt 2026-08-20 20:34:48.857386 | instance | >f+++++++++ system/packages.txt 2026-08-20 20:34:48.857433 | instance | >f+++++++++ system/ps.txt 2026-08-20 20:34:48.857481 | instance | >f+++++++++ system/systemd-cgls.txt 2026-08-20 20:34:48.872353 | 2026-08-20 20:34:48.872446 | LOOP [helm-release-status : creating directory for helm release status] 2026-08-20 20:34:49.088221 | instance | changed: "values" 2026-08-20 20:34:49.276645 | instance | changed: "releases" 2026-08-20 20:34:49.294362 | 2026-08-20 20:34:49.294533 | TASK [helm-release-status : Gather get release status for helm charts] 2026-08-20 20:34:49.684868 | instance | /bin/bash: line 3: kubectl: command not found 2026-08-20 20:34:49.839366 | instance | ok: Runtime: 0:00:00.006198 2026-08-20 20:34:49.846247 | 2026-08-20 20:34:49.846319 | TASK [helm-release-status : Downloads logs to executor] 2026-08-20 20:34:50.376409 | instance | changed: 2026-08-20 20:34:50.376600 | instance | cd+++++++++ helm/ 2026-08-20 20:34:50.376640 | instance | cd+++++++++ helm/releases/ 2026-08-20 20:34:50.376671 | instance | cd+++++++++ helm/values/ 2026-08-20 20:34:50.394003 | 2026-08-20 20:34:50.394258 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-08-20 20:34:50.597318 | instance | changed 2026-08-20 20:34:50.603219 | 2026-08-20 20:34:50.603298 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-08-20 20:34:50.848260 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-20 20:34:50.848506 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-20 20:34:50.854471 | instance | environment: line 1: kubectl: command not found 2026-08-20 20:34:50.855312 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-20 20:34:50.855879 | instance | environment: line 1: kubectl: command not found 2026-08-20 20:34:50.857177 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-20 20:34:50.858391 | instance | environment: line 1: kubectl: command not found 2026-08-20 20:34:50.859216 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-20 20:34:50.860701 | instance | environment: line 1: kubectl: command not found 2026-08-20 20:34:50.862053 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-20 20:34:50.863456 | instance | environment: line 1: kubectl: command not found 2026-08-20 20:34:50.864551 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-20 20:34:51.385988 | instance | ok: Runtime: 0:00:00.024296 2026-08-20 20:34:51.393857 | 2026-08-20 20:34:51.393945 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-08-20 20:34:51.610351 | instance | changed 2026-08-20 20:34:51.641434 | 2026-08-20 20:34:51.641542 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-08-20 20:34:51.854018 | instance | environment: line 5: kubectl: command not found 2026-08-20 20:34:51.854955 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-20 20:34:51.854989 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-20 20:34:51.855553 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-20 20:34:52.199305 | instance | ok: Runtime: 0:00:00.008794 2026-08-20 20:34:52.210375 | 2026-08-20 20:34:52.210538 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-08-20 20:34:52.743536 | instance | changed: 2026-08-20 20:34:52.743721 | instance | cd+++++++++ objects/ 2026-08-20 20:34:52.743750 | instance | cd+++++++++ objects/cluster/ 2026-08-20 20:34:52.743772 | instance | cd+++++++++ objects/namespaced/ 2026-08-20 20:34:52.755317 | 2026-08-20 20:34:52.755438 | TASK [gather-pod-logs : creating directory for pod logs] 2026-08-20 20:34:52.970566 | instance | changed 2026-08-20 20:34:53.150849 | 2026-08-20 20:34:53.151016 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-08-20 20:34:53.384839 | instance | changed 2026-08-20 20:34:53.509797 | 2026-08-20 20:34:53.509951 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-08-20 20:34:53.732603 | instance | environment: line 3: kubectl: command not found 2026-08-20 20:34:54.084741 | instance | ok: Runtime: 0:00:00.007924 2026-08-20 20:34:54.102419 | 2026-08-20 20:34:54.102556 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-08-20 20:34:54.670027 | instance | changed: 2026-08-20 20:34:54.670206 | instance | cd+++++++++ pod-logs/ 2026-08-20 20:34:54.670256 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-08-20 20:34:54.680947 | 2026-08-20 20:34:54.681146 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-08-20 20:34:54.882499 | instance | changed 2026-08-20 20:34:54.891647 | 2026-08-20 20:34:54.891815 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-08-20 20:34:55.111555 | instance | /bin/bash: line 2: kubectl: command not found 2026-08-20 20:34:55.437392 | instance | ok: Runtime: 0:00:00.039423 2026-08-20 20:34:55.445600 | 2026-08-20 20:34:55.445697 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-08-20 20:34:55.668339 | instance | /bin/bash: line 2: kubectl: command not found 2026-08-20 20:34:55.696151 | instance | ceph-mgr endpoints: 2026-08-20 20:34:56.067003 | instance | ok: Runtime: 0:00:00.032950 2026-08-20 20:34:56.073810 | 2026-08-20 20:34:56.073907 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-08-20 20:34:56.279410 | instance | /bin/bash: line 4: kubectl: command not found 2026-08-20 20:34:56.610922 | instance | ok: Runtime: 0:00:00.034545 2026-08-20 20:34:56.618470 | 2026-08-20 20:34:56.618537 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-08-20 20:34:57.156349 | instance | changed: cd+++++++++ prometheus/ 2026-08-20 20:34:57.169714 | 2026-08-20 20:34:57.169853 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-08-20 20:34:57.370027 | instance | changed 2026-08-20 20:34:57.420898 | 2026-08-20 20:34:57.426792 | TASK [gather-selenium-data : Get selenium data] 2026-08-20 20:34:57.697937 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-08-20 20:34:57.699351 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-08-20 20:34:57.973479 | instance | ERROR 2026-08-20 20:34:57.973683 | instance | { 2026-08-20 20:34:57.973715 | instance | "delta": "0:00:00.005461", 2026-08-20 20:34:57.973736 | instance | "end": "2026-08-20 20:34:57.699653", 2026-08-20 20:34:57.973758 | instance | "msg": "non-zero return code", 2026-08-20 20:34:57.973777 | instance | "rc": 1, 2026-08-20 20:34:57.973796 | instance | "start": "2026-08-20 20:34:57.694192" 2026-08-20 20:34:57.973814 | instance | } 2026-08-20 20:34:57.973843 | instance | ERROR: Ignoring Errors 2026-08-20 20:34:57.978885 | 2026-08-20 20:34:57.978995 | TASK [gather-selenium-data : Downloads logs to executor] 2026-08-20 20:34:58.491665 | instance | changed: cd+++++++++ selenium/ 2026-08-20 20:34:58.498709 | 2026-08-20 20:34:58.498764 | PLAY RECAP 2026-08-20 20:34:58.498812 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-08-20 20:34:58.498835 | 2026-08-20 20:34:58.633337 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-08-20 20:34:58.687565 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-20 20:34:59.914093 | 2026-08-20 20:34:59.914309 | PLAY [all] 2026-08-20 20:34:59.941080 | 2026-08-20 20:34:59.941240 | TASK [fetch-output : Set log path for multiple nodes] 2026-08-20 20:34:59.987283 | instance | skipping: Conditional result was False 2026-08-20 20:34:59.996855 | 2026-08-20 20:34:59.997104 | TASK [fetch-output : Set log path for single node] 2026-08-20 20:35:00.043132 | instance | ok 2026-08-20 20:35:00.133237 | 2026-08-20 20:35:00.176826 | LOOP [fetch-output : Ensure local output dirs] 2026-08-20 20:35:00.717722 | instance -> localhost | ok: "/var/lib/zuul/builds/de1c4c608a924881867f35e1ad40cfb2/work/logs" 2026-08-20 20:35:00.948023 | instance -> localhost | changed: "/var/lib/zuul/builds/de1c4c608a924881867f35e1ad40cfb2/work/artifacts" 2026-08-20 20:35:01.315058 | instance -> localhost | changed: "/var/lib/zuul/builds/de1c4c608a924881867f35e1ad40cfb2/work/docs" 2026-08-20 20:35:01.331136 | 2026-08-20 20:35:01.331354 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-20 20:35:02.398407 | instance | changed: .d..t...... ./ 2026-08-20 20:35:02.398727 | instance | changed: All items complete 2026-08-20 20:35:02.398785 | 2026-08-20 20:35:02.915039 | instance | changed: .d..t...... ./ 2026-08-20 20:35:03.510578 | instance | changed: .d..t...... ./ 2026-08-20 20:35:03.534134 | 2026-08-20 20:35:03.534264 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-20 20:35:04.166968 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.008157 2026-08-20 20:35:04.925334 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.008304 2026-08-20 20:35:04.958325 | 2026-08-20 20:35:04.958412 | PLAY [all] 2026-08-20 20:35:04.964721 | 2026-08-20 20:35:04.964788 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-20 20:35:05.403232 | instance | changed 2026-08-20 20:35:05.518782 | 2026-08-20 20:35:05.518891 | PLAY RECAP 2026-08-20 20:35:05.518943 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-20 20:35:05.518969 | 2026-08-20 20:35:05.663152 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-20 20:35:05.868894 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-20 20:35:06.646906 | 2026-08-20 20:35:06.647088 | PLAY [localhost] 2026-08-20 20:35:06.668915 | 2026-08-20 20:35:06.811482 | TASK [Generate Zuul manifest] 2026-08-20 20:35:06.835645 | localhost | ok 2026-08-20 20:35:07.102173 | 2026-08-20 20:35:07.102363 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-20 20:35:07.666533 | localhost | changed 2026-08-20 20:35:07.678963 | 2026-08-20 20:35:07.679049 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-20 20:35:07.737070 | localhost | ok 2026-08-20 20:35:07.750692 | 2026-08-20 20:35:07.751018 | TASK [Upload logs] 2026-08-20 20:35:07.774385 | localhost | ok 2026-08-20 20:35:08.374082 | 2026-08-20 20:35:08.374198 | TASK [Set zuul-log-path fact] 2026-08-20 20:35:08.399188 | localhost | ok 2026-08-20 20:35:08.620157 | 2026-08-20 20:35:08.620296 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-20 20:35:08.653061 | localhost | ok 2026-08-20 20:35:08.662880 | 2026-08-20 20:35:08.663005 | TASK [upload-logs : Create log directories] 2026-08-20 20:35:09.360868 | localhost | changed 2026-08-20 20:35:09.366832 | 2026-08-20 20:35:09.366970 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-20 20:35:09.839067 | localhost -> localhost | ok: Runtime: 0:00:00.004033 2026-08-20 20:35:09.844735 | 2026-08-20 20:35:09.844810 | TASK [upload-logs : Upload logs to log server] 2026-08-20 20:35:10.706706 | localhost | Output suppressed because no_log was given 2026-08-20 20:35:10.753750 | 2026-08-20 20:35:10.753887 | LOOP [upload-logs : Compress console log and json output] 2026-08-20 20:35:10.800338 | localhost | skipping: Conditional result was False 2026-08-20 20:35:10.808390 | localhost | skipping: Conditional result was False 2026-08-20 20:35:10.819919 | 2026-08-20 20:35:10.820029 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-20 20:35:10.862543 | localhost | skipping: Conditional result was False 2026-08-20 20:35:10.862987 | 2026-08-20 20:35:10.867978 | localhost | skipping: Conditional result was False 2026-08-20 20:35:10.886731 | 2026-08-20 20:35:10.886865 | LOOP [upload-logs : Upload console log and json output]