2026-08-24 20:30:56.394108 | Job console starting 2026-08-24 20:30:56.403974 | Updating git repos 2026-08-24 20:31:01.070215 | Cloning repos into workspace 2026-08-24 20:31:18.457862 | Restoring repo states 2026-08-24 20:31:27.552951 | Merging changes 2026-08-24 20:31:29.419850 | Checking out repos 2026-08-24 20:31:32.169458 | Preparing playbooks 2026-08-24 20:31:36.151779 | Running Ansible setup 2026-08-24 20:31:39.694250 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-24 20:31:40.335948 | 2026-08-24 20:31:40.336073 | PLAY [localhost] 2026-08-24 20:31:40.343498 | 2026-08-24 20:31:40.343567 | TASK [Gathering Facts] 2026-08-24 20:31:41.235181 | localhost | ok 2026-08-24 20:31:41.248383 | 2026-08-24 20:31:41.248464 | TASK [Setup log path fact] 2026-08-24 20:31:41.279857 | localhost | ok 2026-08-24 20:31:41.291160 | 2026-08-24 20:31:41.291228 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-24 20:31:41.322349 | localhost | ok 2026-08-24 20:31:41.330137 | 2026-08-24 20:31:41.330224 | TASK [emit-job-header : Print job information] 2026-08-24 20:31:41.372464 | # Job Information 2026-08-24 20:31:41.372614 | Ansible Version: 2.16.18 2026-08-24 20:31:41.372657 | Job: atmosphere-molecule-csi-rbd 2026-08-24 20:31:41.372687 | Pipeline: check 2026-08-24 20:31:41.372715 | Executor: 2d72f0692154 2026-08-24 20:31:41.372741 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4092 2026-08-24 20:31:41.372773 | Event ID: d90c96b0-9ff9-11f1-9043-f7ca46c03658 2026-08-24 20:31:41.376617 | 2026-08-24 20:31:41.376709 | LOOP [emit-job-header : Print node information] 2026-08-24 20:31:41.479360 | localhost | ok: 2026-08-24 20:31:41.479618 | localhost | # Node Information 2026-08-24 20:31:41.479659 | localhost | Inventory Hostname: instance 2026-08-24 20:31:41.479691 | localhost | Hostname: np0000191015 2026-08-24 20:31:41.479719 | localhost | Username: zuul 2026-08-24 20:31:41.479754 | localhost | Distro: Ubuntu 22.04 2026-08-24 20:31:41.479782 | localhost | Provider: yul1 2026-08-24 20:31:41.479809 | localhost | Region: ca-ymq-1 2026-08-24 20:31:41.479835 | localhost | Label: ubuntu-jammy 2026-08-24 20:31:41.479861 | localhost | Product Name: OpenStack Nova 2026-08-24 20:31:41.479887 | localhost | Interface IP: 199.19.213.74 2026-08-24 20:31:41.496691 | 2026-08-24 20:31:41.496826 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-24 20:31:41.885776 | localhost -> localhost | changed 2026-08-24 20:31:41.891144 | 2026-08-24 20:31:41.891214 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-24 20:31:42.673888 | localhost -> localhost | changed 2026-08-24 20:31:42.684982 | 2026-08-24 20:31:42.685039 | PLAY [all] 2026-08-24 20:31:42.721285 | 2026-08-24 20:31:42.721446 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-24 20:31:42.949202 | instance -> localhost | ok 2026-08-24 20:31:42.956754 | 2026-08-24 20:31:42.956834 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-24 20:31:43.003129 | instance | ok 2026-08-24 20:31:43.017569 | instance | included: /var/lib/zuul/builds/371e415a0a4d449e80d9ffb2a18ceb84/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-24 20:31:43.023772 | 2026-08-24 20:31:43.023839 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-24 20:31:43.866610 | instance -> localhost | Generating public/private rsa key pair. 2026-08-24 20:31:43.866876 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/371e415a0a4d449e80d9ffb2a18ceb84/work/371e415a0a4d449e80d9ffb2a18ceb84_id_rsa 2026-08-24 20:31:43.866919 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/371e415a0a4d449e80d9ffb2a18ceb84/work/371e415a0a4d449e80d9ffb2a18ceb84_id_rsa.pub 2026-08-24 20:31:43.866953 | instance -> localhost | The key fingerprint is: 2026-08-24 20:31:43.866994 | instance -> localhost | SHA256:uQmIM5/FX0TKF6p5814lH0cm6Z1OpEUc/ukevHaTp5A zuul-build-sshkey 2026-08-24 20:31:43.867051 | instance -> localhost | The key's randomart image is: 2026-08-24 20:31:43.867081 | instance -> localhost | +---[RSA 3072]----+ 2026-08-24 20:31:43.867118 | instance -> localhost | | o .o.| 2026-08-24 20:31:43.867149 | instance -> localhost | | . + . oo | 2026-08-24 20:31:43.867177 | instance -> localhost | | + o o+o| 2026-08-24 20:31:43.867206 | instance -> localhost | | . o o + .+=+| 2026-08-24 20:31:43.867233 | instance -> localhost | | + . * S . ..+++| 2026-08-24 20:31:43.867286 | instance -> localhost | | + o + * ==o | 2026-08-24 20:31:43.867346 | instance -> localhost | | o + . E .=.| 2026-08-24 20:31:43.867380 | instance -> localhost | | . . ..+=| 2026-08-24 20:31:43.867413 | instance -> localhost | | . o++| 2026-08-24 20:31:43.867441 | instance -> localhost | +----[SHA256]-----+ 2026-08-24 20:31:43.867686 | instance -> localhost | ok: Runtime: 0:00:00.391137 2026-08-24 20:31:43.876286 | 2026-08-24 20:31:43.876356 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-24 20:31:43.910627 | instance | ok 2026-08-24 20:31:43.921042 | instance | included: /var/lib/zuul/builds/371e415a0a4d449e80d9ffb2a18ceb84/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-24 20:31:43.929629 | 2026-08-24 20:31:43.929711 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-24 20:31:43.956643 | instance | skipping: Conditional result was False 2026-08-24 20:31:43.964670 | 2026-08-24 20:31:43.964860 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-24 20:31:44.440758 | instance | changed 2026-08-24 20:31:44.452519 | 2026-08-24 20:31:44.452588 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-24 20:31:44.642587 | instance | ok 2026-08-24 20:31:44.649689 | 2026-08-24 20:31:44.649760 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-24 20:31:45.165896 | instance | changed 2026-08-24 20:31:45.179651 | 2026-08-24 20:31:45.179828 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-24 20:31:45.658158 | instance | changed 2026-08-24 20:31:45.664332 | 2026-08-24 20:31:45.664403 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-24 20:31:45.690543 | instance | skipping: Conditional result was False 2026-08-24 20:31:45.700086 | 2026-08-24 20:31:45.700151 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-24 20:31:46.143377 | instance -> localhost | changed 2026-08-24 20:31:46.157938 | 2026-08-24 20:31:46.158021 | TASK [add-build-sshkey : Add back temp key] 2026-08-24 20:31:46.507162 | instance -> localhost | Identity added: /var/lib/zuul/builds/371e415a0a4d449e80d9ffb2a18ceb84/work/371e415a0a4d449e80d9ffb2a18ceb84_id_rsa (zuul-build-sshkey) 2026-08-24 20:31:46.507336 | instance -> localhost | ok: Runtime: 0:00:00.014383 2026-08-24 20:31:46.512154 | 2026-08-24 20:31:46.512218 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-24 20:31:46.812614 | instance | ok 2026-08-24 20:31:46.956572 | 2026-08-24 20:31:46.956688 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-24 20:31:46.986519 | instance | skipping: Conditional result was False 2026-08-24 20:31:47.000895 | 2026-08-24 20:31:47.000966 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-08-24 20:31:47.316300 | instance | ok 2026-08-24 20:31:47.322057 | 2026-08-24 20:31:47.322123 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-08-24 20:31:51.023887 | instance | Output suppressed because no_log was given 2026-08-24 20:31:51.036555 | 2026-08-24 20:31:51.036629 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-08-24 20:31:51.222245 | instance | ok: "logs" 2026-08-24 20:31:51.222475 | instance | ok: All items complete 2026-08-24 20:31:51.222503 | 2026-08-24 20:31:51.369721 | instance | ok: "artifacts" 2026-08-24 20:31:51.518299 | instance | ok: "docs" 2026-08-24 20:31:51.538800 | 2026-08-24 20:31:51.538941 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-08-24 20:31:51.719036 | instance | changed: "logs" 2026-08-24 20:31:51.876902 | instance | changed: "artifacts" 2026-08-24 20:31:52.027794 | instance | changed: "docs" 2026-08-24 20:31:52.050758 | 2026-08-24 20:31:52.050854 | PLAY RECAP 2026-08-24 20:31:52.050905 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-08-24 20:31:52.050965 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-24 20:31:52.050990 | 2026-08-24 20:31:52.208266 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-24 20:31:52.210582 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-24 20:31:52.871453 | 2026-08-24 20:31:52.871619 | PLAY [all] 2026-08-24 20:31:52.882120 | 2026-08-24 20:31:52.882199 | TASK [setup-uv : Extract archive] 2026-08-24 20:31:55.480144 | instance | changed 2026-08-24 20:31:55.489079 | 2026-08-24 20:31:55.489185 | TASK [setup-uv : Print version] 2026-08-24 20:31:55.823233 | instance | uv 0.8.13 2026-08-24 20:31:56.026092 | instance | ok: Runtime: 0:00:00.013434 2026-08-24 20:31:56.036138 | 2026-08-24 20:31:56.036212 | TASK [Install Ansible collection siblings] 2026-08-24 20:32:04.901191 | instance | changed: 2026-08-24 20:32:04.901352 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-08-24 20:32:04.901382 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-08-24 20:32:04.901404 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-08-24 20:32:04.901424 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto 2026-08-24 20:32:04.901444 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general 2026-08-24 20:32:04.901467 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql 2026-08-24 20:32:04.901488 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-08-24 20:32:04.901509 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-08-24 20:32:04.901529 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-08-24 20:32:04.901548 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-08-24 20:32:04.901567 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-08-24 20:32:04.901586 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-08-24 20:32:04.901604 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0 2026-08-24 20:32:04.901622 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0 2026-08-24 20:32:04.901640 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0 2026-08-24 20:32:04.901659 | instance | Resolved community.crypto to 2.2.3 for 2.2.3 2026-08-24 20:32:04.901678 | instance | Resolved community.general to 7.3.0 for 7.3.0 2026-08-24 20:32:04.901696 | instance | Resolved community.mysql to 3.6.0 for 3.6.0 2026-08-24 20:32:04.901714 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0 2026-08-24 20:32:04.901732 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0 2026-08-24 20:32:04.901751 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0 2026-08-24 20:32:04.901769 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0 2026-08-24 20:32:04.901789 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-08-24 20:32:04.901818 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0 2026-08-24 20:32:04.901838 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0 2026-08-24 20:32:04.901856 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-08-24 20:32:04.901874 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-08-24 20:32:04.901892 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-08-24 20:32:04.901909 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0 2026-08-24 20:32:04.901927 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3 2026-08-24 20:32:04.901944 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-08-24 20:32:04.901962 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-08-24 20:32:04.901980 | instance | Checked out ansible.netcommon to 1.2.0 2026-08-24 20:32:04.901998 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-08-24 20:32:04.902023 | instance | Starting galaxy collection install process 2026-08-24 20:32:04.902041 | instance | Process install dependency map 2026-08-24 20:32:04.902059 | instance | Starting collection install process 2026-08-24 20:32:04.902077 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon' 2026-08-24 20:32:04.902095 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon 2026-08-24 20:32:04.902113 | instance | ansible.netcommon:* was installed successfully 2026-08-24 20:32:04.902130 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-08-24 20:32:04.902148 | instance | Creating virtual environment at: .venv 2026-08-24 20:32:04.902165 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-08-24 20:32:04.902184 | instance | Downloading rjsonnet (1.2MiB) 2026-08-24 20:32:04.902202 | instance | Downloading ansible-core (2.1MiB) 2026-08-24 20:32:04.902224 | instance | Downloading setuptools (1.1MiB) 2026-08-24 20:32:04.902243 | instance | Downloading netaddr (2.2MiB) 2026-08-24 20:32:04.902261 | instance | Downloading openstacksdk (1.7MiB) 2026-08-24 20:32:04.902279 | instance | Downloading cryptography (4.2MiB) 2026-08-24 20:32:04.902297 | instance | Downloading pygments (1.2MiB) 2026-08-24 20:32:04.902315 | instance | Downloading kubernetes (1.9MiB) 2026-08-24 20:32:04.902332 | instance | Building pyperclip==1.9.0 2026-08-24 20:32:04.902350 | instance | Downloading rjsonnet 2026-08-24 20:32:04.902370 | instance | Downloading netaddr 2026-08-24 20:32:04.902389 | instance | Downloading pygments 2026-08-24 20:32:04.902407 | instance | Downloading cryptography 2026-08-24 20:32:04.902425 | instance | Downloading setuptools 2026-08-24 20:32:04.902443 | instance | Downloading kubernetes 2026-08-24 20:32:04.902461 | instance | Downloading ansible-core 2026-08-24 20:32:04.902479 | instance | Downloading openstacksdk 2026-08-24 20:32:04.902497 | instance | Built pyperclip==1.9.0 2026-08-24 20:32:04.902515 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-08-24 20:32:04.902533 | instance | Installed 79 packages in 46ms 2026-08-24 20:32:04.902551 | instance | Checked out ansible.posix to 1.6.0 2026-08-24 20:32:04.902569 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-08-24 20:32:04.902588 | instance | Starting galaxy collection install process 2026-08-24 20:32:04.902606 | instance | Process install dependency map 2026-08-24 20:32:04.902623 | instance | Starting collection install process 2026-08-24 20:32:04.902641 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-08-24 20:32:04.902664 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix 2026-08-24 20:32:04.902682 | instance | ansible.posix:1.6.0 was installed successfully 2026-08-24 20:32:04.902700 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 20:32:04.902717 | instance | 2.17.12 2026-08-24 20:32:04.902735 | instance | Checked out ansible.utils to v6.1.0 2026-08-24 20:32:04.902753 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-08-24 20:32:04.902771 | instance | Starting galaxy collection install process 2026-08-24 20:32:04.902788 | instance | Process install dependency map 2026-08-24 20:32:04.902806 | instance | Starting collection install process 2026-08-24 20:32:04.902823 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils' 2026-08-24 20:32:04.902841 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils 2026-08-24 20:32:04.902859 | instance | ansible.utils:6.1.0 was installed successfully 2026-08-24 20:32:04.902877 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 20:32:04.902894 | instance | 2.17.12 2026-08-24 20:32:04.902913 | instance | Checked out atmosphere.common to v0.7.0 2026-08-24 20:32:04.902931 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-08-24 20:32:04.902948 | instance | Starting galaxy collection install process 2026-08-24 20:32:04.902966 | instance | Process install dependency map 2026-08-24 20:32:04.902984 | instance | Starting collection install process 2026-08-24 20:32:04.903002 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common' 2026-08-24 20:32:04.903019 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common 2026-08-24 20:32:04.903037 | instance | atmosphere.common:0.7.0 was installed successfully 2026-08-24 20:32:04.903055 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 20:32:04.903072 | instance | 2.17.12 2026-08-24 20:32:04.903131 | instance | Checked out community.crypto to 2.2.3 2026-08-24 20:32:04.903152 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.crypto 2026-08-24 20:32:04.903170 | instance | Starting galaxy collection install process 2026-08-24 20:32:04.903187 | instance | Process install dependency map 2026-08-24 20:32:04.903224 | instance | Starting collection install process 2026-08-24 20:32:04.903271 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-08-24 20:32:04.903293 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto 2026-08-24 20:32:04.903311 | instance | community.crypto:2.2.3 was installed successfully 2026-08-24 20:32:04.903329 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 20:32:04.903346 | instance | 2.17.12 2026-08-24 20:32:04.903364 | instance | Checked out community.general to 7.3.0 2026-08-24 20:32:04.903382 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.general 2026-08-24 20:32:04.903400 | instance | Starting galaxy collection install process 2026-08-24 20:32:04.903424 | instance | Process install dependency map 2026-08-24 20:32:04.903443 | instance | Starting collection install process 2026-08-24 20:32:04.903460 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-08-24 20:32:04.903573 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general 2026-08-24 20:32:04.903595 | instance | community.general:7.3.0 was installed successfully 2026-08-24 20:32:04.903615 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 20:32:04.903633 | instance | 2.17.12 2026-08-24 20:32:04.903652 | instance | Checked out community.mysql to 3.6.0 2026-08-24 20:32:04.903672 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.mysql 2026-08-24 20:32:04.903691 | instance | Starting galaxy collection install process 2026-08-24 20:32:04.903711 | instance | Process install dependency map 2026-08-24 20:32:04.903729 | instance | Starting collection install process 2026-08-24 20:32:04.903748 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql' 2026-08-24 20:32:04.903766 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql 2026-08-24 20:32:04.903784 | instance | community.mysql:3.6.0 was installed successfully 2026-08-24 20:32:04.903802 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 20:32:04.903820 | instance | 2.17.12 2026-08-24 20:32:04.903839 | instance | Checked out kubernetes.core to 2.4.0 2026-08-24 20:32:04.903858 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-08-24 20:32:04.903876 | instance | Starting galaxy collection install process 2026-08-24 20:32:04.903894 | instance | Process install dependency map 2026-08-24 20:32:04.903912 | instance | Starting collection install process 2026-08-24 20:32:04.903931 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core' 2026-08-24 20:32:04.903949 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core 2026-08-24 20:32:04.903967 | instance | kubernetes.core:2.4.0 was installed successfully 2026-08-24 20:32:04.903985 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 20:32:04.904003 | instance | 2.17.12 2026-08-24 20:32:04.904022 | instance | Checked out openstack.cloud to 2.6.0 2026-08-24 20:32:04.904040 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-08-24 20:32:04.904058 | instance | Starting galaxy collection install process 2026-08-24 20:32:04.904076 | instance | Process install dependency map 2026-08-24 20:32:04.904094 | instance | Starting collection install process 2026-08-24 20:32:04.904130 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud' 2026-08-24 20:32:04.904150 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud 2026-08-24 20:32:04.904167 | instance | openstack.cloud:2.6.0 was installed successfully 2026-08-24 20:32:04.904185 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 20:32:04.904203 | instance | 2.17.12 2026-08-24 20:32:04.904221 | instance | Checked out vexxhost.ceph to v4.2.0 2026-08-24 20:32:04.904239 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-08-24 20:32:04.904263 | instance | Starting galaxy collection install process 2026-08-24 20:32:04.904282 | instance | Process install dependency map 2026-08-24 20:32:04.904300 | instance | Starting collection install process 2026-08-24 20:32:04.904318 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph' 2026-08-24 20:32:04.904335 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph 2026-08-24 20:32:04.904353 | instance | vexxhost.ceph:4.2.0 was installed successfully 2026-08-24 20:32:04.904411 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 20:32:04.904430 | instance | 2.17.12 2026-08-24 20:32:04.904448 | instance | Checked out vexxhost.containers to v1.6.8 2026-08-24 20:32:04.904467 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-08-24 20:32:04.904485 | instance | Starting galaxy collection install process 2026-08-24 20:32:04.904503 | instance | Process install dependency map 2026-08-24 20:32:04.904521 | instance | Starting collection install process 2026-08-24 20:32:04.904539 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers' 2026-08-24 20:32:04.904557 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers 2026-08-24 20:32:04.904575 | instance | vexxhost.containers:1.6.8 was installed successfully 2026-08-24 20:32:04.904593 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 20:32:04.904612 | instance | 2.17.12 2026-08-24 20:32:04.904660 | instance | Checked out vexxhost.kubernetes to v3.3.0 2026-08-24 20:32:04.904681 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-08-24 20:32:04.904701 | instance | Starting galaxy collection install process 2026-08-24 20:32:04.904718 | instance | Process install dependency map 2026-08-24 20:32:04.904736 | instance | Starting collection install process 2026-08-24 20:32:04.904754 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes' 2026-08-24 20:32:04.904793 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes 2026-08-24 20:32:04.904812 | instance | vexxhost.kubernetes:3.3.0 was installed successfully 2026-08-24 20:32:04.904831 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-08-24 20:32:04.904848 | instance | 2.17.12 2026-08-24 20:32:04.910616 | 2026-08-24 20:32:04.910664 | PLAY RECAP 2026-08-24 20:32:04.910706 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-24 20:32:04.910726 | 2026-08-24 20:32:05.034614 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-24 20:32:05.039134 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-08-24 20:32:05.666548 | 2026-08-24 20:32:05.666721 | PLAY [all] 2026-08-24 20:32:05.682199 | 2026-08-24 20:32:05.682318 | TASK [Install "jq" for log collection] 2026-08-24 20:32:15.781827 | instance | changed 2026-08-24 20:32:15.784537 | 2026-08-24 20:32:15.784598 | PLAY RECAP 2026-08-24 20:32:15.784651 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-24 20:32:15.784705 | 2026-08-24 20:32:15.958017 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-08-24 20:32:15.962120 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-24 20:32:16.574602 | 2026-08-24 20:32:16.590032 | PLAY [all] 2026-08-24 20:32:16.612973 | 2026-08-24 20:32:16.613182 | LOOP [Check inventory directories] 2026-08-24 20:32:16.943438 | instance | ok: "src/github.com/vexxhost/atmosphere" 2026-08-24 20:32:17.105799 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/csi/inventory" 2026-08-24 20:32:17.251038 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/csi/inventory" 2026-08-24 20:32:17.265914 | 2026-08-24 20:32:17.266135 | LOOP [Copy inventory file for Zuul] 2026-08-24 20:32:18.030651 | instance | changed: 2026-08-24 20:32:18.030866 | instance | { 2026-08-24 20:32:18.030904 | instance | "ansible_loop_var": "item", 2026-08-24 20:32:18.030935 | instance | "changed": false, 2026-08-24 20:32:18.030963 | instance | "failed": false, 2026-08-24 20:32:18.030995 | instance | "invocation": { 2026-08-24 20:32:18.031022 | instance | "module_args": { 2026-08-24 20:32:18.031047 | instance | "checksum_algorithm": "sha1", 2026-08-24 20:32:18.031072 | instance | "follow": true, 2026-08-24 20:32:18.031097 | instance | "get_attributes": true, 2026-08-24 20:32:18.031124 | instance | "get_checksum": true, 2026-08-24 20:32:18.031149 | instance | "get_mime": true, 2026-08-24 20:32:18.031174 | instance | "path": "src/github.com/vexxhost/atmosphere" 2026-08-24 20:32:18.031199 | instance | } 2026-08-24 20:32:18.031223 | instance | }, 2026-08-24 20:32:18.031247 | instance | "item": "src/github.com/vexxhost/atmosphere", 2026-08-24 20:32:18.031272 | instance | "stat": { 2026-08-24 20:32:18.031295 | instance | "atime": 1787603517.7298498, 2026-08-24 20:32:18.031320 | instance | "attr_flags": "e", 2026-08-24 20:32:18.031345 | instance | "attributes": [ 2026-08-24 20:32:18.031369 | instance | "extents" 2026-08-24 20:32:18.031393 | instance | ], 2026-08-24 20:32:18.031417 | instance | "block_size": 4096, 2026-08-24 20:32:18.031440 | instance | "blocks": 8, 2026-08-24 20:32:18.031464 | instance | "charset": "unknown", 2026-08-24 20:32:18.031489 | instance | "ctime": 1787603516.817806, 2026-08-24 20:32:18.031514 | instance | "dev": 64513, 2026-08-24 20:32:18.031539 | instance | "device_type": 0, 2026-08-24 20:32:18.031562 | instance | "executable": true, 2026-08-24 20:32:18.031586 | instance | "exists": true, 2026-08-24 20:32:18.031610 | instance | "gid": 1000, 2026-08-24 20:32:18.031634 | instance | "gr_name": "zuul", 2026-08-24 20:32:18.031658 | instance | "inode": 1047754, 2026-08-24 20:32:18.031682 | instance | "isblk": false, 2026-08-24 20:32:18.031706 | instance | "ischr": false, 2026-08-24 20:32:18.031730 | instance | "isdir": true, 2026-08-24 20:32:18.031754 | instance | "isfifo": false, 2026-08-24 20:32:18.031777 | instance | "isgid": false, 2026-08-24 20:32:18.031800 | instance | "islnk": false, 2026-08-24 20:32:18.031823 | instance | "isreg": false, 2026-08-24 20:32:18.031847 | instance | "issock": false, 2026-08-24 20:32:18.031870 | instance | "isuid": false, 2026-08-24 20:32:18.031893 | instance | "mimetype": "unknown", 2026-08-24 20:32:18.031916 | instance | "mode": "0755", 2026-08-24 20:32:18.031939 | instance | "mtime": 1787603516.817806, 2026-08-24 20:32:18.031962 | instance | "nlink": 21, 2026-08-24 20:32:18.031985 | instance | "path": "src/github.com/vexxhost/atmosphere", 2026-08-24 20:32:18.032009 | instance | "pw_name": "zuul", 2026-08-24 20:32:18.032040 | instance | "readable": true, 2026-08-24 20:32:18.032065 | instance | "rgrp": true, 2026-08-24 20:32:18.032089 | instance | "roth": true, 2026-08-24 20:32:18.032114 | instance | "rusr": true, 2026-08-24 20:32:18.032137 | instance | "size": 4096, 2026-08-24 20:32:18.032161 | instance | "uid": 1000, 2026-08-24 20:32:18.032196 | instance | "version": "3223312455", 2026-08-24 20:32:18.032222 | instance | "wgrp": false, 2026-08-24 20:32:18.032248 | instance | "woth": false, 2026-08-24 20:32:18.032272 | instance | "writeable": true, 2026-08-24 20:32:18.032297 | instance | "wusr": true, 2026-08-24 20:32:18.032320 | instance | "xgrp": true, 2026-08-24 20:32:18.032344 | instance | "xoth": true, 2026-08-24 20:32:18.032367 | instance | "xusr": true 2026-08-24 20:32:18.032390 | instance | } 2026-08-24 20:32:18.032414 | instance | } 2026-08-24 20:32:18.032459 | instance | ok: All items complete 2026-08-24 20:32:18.032488 | 2026-08-24 20:32:18.034059 | instance | skipping: Conditional result was False 2026-08-24 20:32:18.034637 | instance | skipping: Conditional result was False 2026-08-24 20:32:18.049722 | 2026-08-24 20:32:18.049871 | LOOP [Switch "ansible_host" to private IP] 2026-08-24 20:32:18.450399 | instance | changed: 1 replacements made 2026-08-24 20:32:18.452835 | instance | skipping: Conditional result was False 2026-08-24 20:32:18.456169 | instance | skipping: Conditional result was False 2026-08-24 20:32:18.478145 | 2026-08-24 20:32:18.478295 | TASK [Run Molecule scenario] 2026-08-24 20:32:19.438017 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-08-24 20:32:19.851777 | instance | INFO [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-08-24 20:32:19.851903 | instance | INFO [csi > prerun] Performing prerun with role_name_check=0... 2026-08-24 20:32:31.170119 | instance | INFO [csi > dependency] Executing 2026-08-24 20:32:31.170323 | instance | WARNING [csi > dependency] Missing roles requirements file: requirements.yml 2026-08-24 20:32:31.170412 | instance | WARNING [csi > dependency] Missing collections requirements file: collections.yml 2026-08-24 20:32:31.170584 | instance | WARNING [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-08-24 20:32:31.178113 | instance | INFO [csi > cleanup] Executing 2026-08-24 20:32:31.178479 | instance | WARNING [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-24 20:32:31.186012 | instance | INFO [csi > destroy] Executing 2026-08-24 20:32:31.186071 | instance | WARNING [csi > destroy] Skipping, '--destroy=never' requested. 2026-08-24 20:32:31.186133 | instance | INFO [csi > destroy] Executed: Successful 2026-08-24 20:32:31.193636 | instance | INFO [csi > syntax] Executing 2026-08-24 20:32:32.805615 | instance | 2026-08-24 20:32:32.805863 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-08-24 20:32:32.878553 | instance | INFO [csi > syntax] Executed: Successful 2026-08-24 20:32:32.891506 | instance | INFO [csi > create] Executing 2026-08-24 20:32:32.893440 | instance | WARNING [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-24 20:32:32.901292 | instance | INFO [csi > prepare] Executing 2026-08-24 20:32:33.759335 | instance | 2026-08-24 20:32:33.759568 | instance | PLAY [Prepare] ***************************************************************** 2026-08-24 20:32:33.759860 | instance | 2026-08-24 20:32:33.760224 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-24 20:32:33.760414 | instance | Monday 24 August 2026 20:32:33 +0000 (0:00:00.026) 0:00:00.026 ********* 2026-08-24 20:32:34.915744 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-08-24 20:32:34.915977 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-08-24 20:32:34.916249 | instance | interpreter could change the meaning of that path. See 2026-08-24 20:32:34.916517 | instance | https://docs.ansible.com/ansible- 2026-08-24 20:32:34.916789 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-08-24 20:32:34.923768 | instance | ok: [instance] 2026-08-24 20:32:34.923999 | instance | 2026-08-24 20:32:34.924316 | instance | TASK [Configure short hostname] ************************************************ 2026-08-24 20:32:34.924594 | instance | Monday 24 August 2026 20:32:34 +0000 (0:00:01.165) 0:00:01.192 ********* 2026-08-24 20:32:35.596282 | instance | changed: [instance] 2026-08-24 20:32:35.596487 | instance | 2026-08-24 20:32:35.596765 | instance | TASK [Ensure hostname inside hosts file] *************************************** 2026-08-24 20:32:35.597042 | instance | Monday 24 August 2026 20:32:35 +0000 (0:00:00.671) 0:00:01.864 ********* 2026-08-24 20:32:35.848723 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created 2026-08-24 20:32:35.849003 | instance | with a mode of 0700, this may cause issues when running as another user. To 2026-08-24 20:32:35.849274 | instance | avoid this, create the remote_tmp dir with the correct permissions manually 2026-08-24 20:32:35.858245 | instance | changed: [instance] 2026-08-24 20:32:35.858531 | instance | 2026-08-24 20:32:35.858801 | instance | TASK [Purge "snapd" package] *************************************************** 2026-08-24 20:32:35.859068 | instance | Monday 24 August 2026 20:32:35 +0000 (0:00:00.262) 0:00:02.126 ********* 2026-08-24 20:32:36.686153 | instance | ok: [instance] 2026-08-24 20:32:36.686385 | instance | 2026-08-24 20:32:36.686676 | instance | PLAY [Create devices for Ceph] ************************************************* 2026-08-24 20:32:36.686970 | instance | 2026-08-24 20:32:36.687252 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-24 20:32:36.687524 | instance | Monday 24 August 2026 20:32:36 +0000 (0:00:00.827) 0:00:02.954 ********* 2026-08-24 20:32:37.392552 | instance | ok: [instance] 2026-08-24 20:32:37.392776 | instance | 2026-08-24 20:32:37.393053 | instance | TASK [Install depedencies] ***************************************************** 2026-08-24 20:32:37.393329 | instance | Monday 24 August 2026 20:32:37 +0000 (0:00:00.706) 0:00:03.660 ********* 2026-08-24 20:32:55.702641 | instance | changed: [instance] 2026-08-24 20:32:55.702706 | instance | 2026-08-24 20:32:55.702713 | instance | TASK [Start up service] ******************************************************** 2026-08-24 20:32:55.702725 | instance | Monday 24 August 2026 20:32:55 +0000 (0:00:18.309) 0:00:21.969 ********* 2026-08-24 20:32:56.264666 | instance | ok: [instance] 2026-08-24 20:32:56.264905 | instance | 2026-08-24 20:32:56.265213 | instance | TASK [Generate lvm.conf] ******************************************************* 2026-08-24 20:32:56.265527 | instance | Monday 24 August 2026 20:32:56 +0000 (0:00:00.562) 0:00:22.532 ********* 2026-08-24 20:32:56.547328 | instance | ok: [instance] 2026-08-24 20:32:56.547563 | instance | 2026-08-24 20:32:56.547852 | instance | TASK [Write /etc/lvm/lvm.conf] ************************************************* 2026-08-24 20:32:56.548135 | instance | Monday 24 August 2026 20:32:56 +0000 (0:00:00.282) 0:00:22.815 ********* 2026-08-24 20:32:57.228392 | instance | changed: [instance] 2026-08-24 20:32:57.228514 | instance | 2026-08-24 20:32:57.228692 | instance | TASK [Get list of all loopback devices] **************************************** 2026-08-24 20:32:57.228858 | instance | Monday 24 August 2026 20:32:57 +0000 (0:00:00.681) 0:00:23.496 ********* 2026-08-24 20:32:57.418208 | instance | ok: [instance] 2026-08-24 20:32:57.418468 | instance | 2026-08-24 20:32:57.418762 | instance | TASK [Fail if there is any existing loopback devices] ************************** 2026-08-24 20:32:57.419020 | instance | Monday 24 August 2026 20:32:57 +0000 (0:00:00.189) 0:00:23.686 ********* 2026-08-24 20:32:57.444007 | instance | skipping: [instance] 2026-08-24 20:32:57.444251 | instance | 2026-08-24 20:32:57.444531 | instance | TASK [Create devices for Ceph] ************************************************* 2026-08-24 20:32:57.444805 | instance | Monday 24 August 2026 20:32:57 +0000 (0:00:00.025) 0:00:23.712 ********* 2026-08-24 20:32:57.976115 | instance | changed: [instance] => (item=osd0) 2026-08-24 20:32:57.976364 | instance | changed: [instance] => (item=osd1) 2026-08-24 20:32:57.976642 | instance | changed: [instance] => (item=osd2) 2026-08-24 20:32:57.977005 | instance | 2026-08-24 20:32:57.977201 | instance | TASK [Set permissions on loopback devices] ************************************* 2026-08-24 20:32:57.977475 | instance | Monday 24 August 2026 20:32:57 +0000 (0:00:00.532) 0:00:24.244 ********* 2026-08-24 20:32:58.594181 | instance | changed: [instance] => (item=osd0) 2026-08-24 20:32:58.594257 | instance | changed: [instance] => (item=osd1) 2026-08-24 20:32:58.595344 | instance | changed: [instance] => (item=osd2) 2026-08-24 20:32:58.595400 | instance | 2026-08-24 20:32:58.595412 | instance | TASK [Start loop devices] ****************************************************** 2026-08-24 20:32:58.595422 | instance | Monday 24 August 2026 20:32:58 +0000 (0:00:00.617) 0:00:24.862 ********* 2026-08-24 20:32:59.304085 | instance | changed: [instance] => (item=osd0) 2026-08-24 20:32:59.304136 | instance | changed: [instance] => (item=osd1) 2026-08-24 20:32:59.304143 | instance | changed: [instance] => (item=osd2) 2026-08-24 20:32:59.304150 | instance | 2026-08-24 20:32:59.304157 | instance | TASK [Create a volume group for each loop device] ****************************** 2026-08-24 20:32:59.304163 | instance | Monday 24 August 2026 20:32:59 +0000 (0:00:00.709) 0:00:25.571 ********* 2026-08-24 20:33:02.498465 | instance | changed: [instance] => (item=osd0) 2026-08-24 20:33:02.498537 | instance | changed: [instance] => (item=osd1) 2026-08-24 20:33:02.499057 | instance | changed: [instance] => (item=osd2) 2026-08-24 20:33:02.499102 | instance | 2026-08-24 20:33:02.499108 | instance | TASK [Create a logical volume for each loop device] **************************** 2026-08-24 20:33:02.499113 | instance | Monday 24 August 2026 20:33:02 +0000 (0:00:03.195) 0:00:28.766 ********* 2026-08-24 20:33:04.380102 | instance | changed: [instance] => (item=ceph-instance-osd0) 2026-08-24 20:33:04.380882 | instance | changed: [instance] => (item=ceph-instance-osd1) 2026-08-24 20:33:04.380924 | instance | changed: [instance] => (item=ceph-instance-osd2) 2026-08-24 20:33:04.380949 | instance | 2026-08-24 20:33:04.380959 | instance | PLAY RECAP ********************************************************************* 2026-08-24 20:33:04.380973 | instance | instance : ok=15 changed=9 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-08-24 20:33:04.382157 | instance | 2026-08-24 20:33:04.382226 | instance | Monday 24 August 2026 20:33:04 +0000 (0:00:01.882) 0:00:30.649 ********* 2026-08-24 20:33:04.382239 | instance | =============================================================================== 2026-08-24 20:33:04.382248 | instance | Install depedencies ---------------------------------------------------- 18.31s 2026-08-24 20:33:04.382257 | instance | Create a volume group for each loop device ------------------------------ 3.20s 2026-08-24 20:33:04.382266 | instance | Create a logical volume for each loop device ---------------------------- 1.88s 2026-08-24 20:33:04.382284 | instance | Gathering Facts --------------------------------------------------------- 1.17s 2026-08-24 20:33:04.384212 | instance | Purge "snapd" package --------------------------------------------------- 0.83s 2026-08-24 20:33:04.384265 | instance | Start loop devices ------------------------------------------------------ 0.71s 2026-08-24 20:33:04.384272 | instance | Gathering Facts --------------------------------------------------------- 0.71s 2026-08-24 20:33:04.384278 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.68s 2026-08-24 20:33:04.384283 | instance | Configure short hostname ------------------------------------------------ 0.67s 2026-08-24 20:33:04.384289 | instance | Set permissions on loopback devices ------------------------------------- 0.62s 2026-08-24 20:33:04.384295 | instance | Start up service -------------------------------------------------------- 0.56s 2026-08-24 20:33:04.384301 | instance | Create devices for Ceph ------------------------------------------------- 0.53s 2026-08-24 20:33:04.384306 | instance | Generate lvm.conf ------------------------------------------------------- 0.28s 2026-08-24 20:33:04.384312 | instance | Ensure hostname inside hosts file --------------------------------------- 0.26s 2026-08-24 20:33:04.384318 | instance | Get list of all loopback devices ---------------------------------------- 0.19s 2026-08-24 20:33:04.384324 | instance | Fail if there is any existing loopback devices -------------------------- 0.03s 2026-08-24 20:33:04.454759 | instance | INFO [csi > prepare] Executed: Successful 2026-08-24 20:33:04.467479 | instance | INFO [csi > converge] Executing 2026-08-24 20:33:05.935793 | instance | 2026-08-24 20:33:05.936249 | instance | PLAY [Debug CSI driver value] ************************************************** 2026-08-24 20:33:05.936611 | instance | 2026-08-24 20:33:05.936990 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-24 20:33:05.937371 | instance | Monday 24 August 2026 20:33:05 +0000 (0:00:00.007) 0:00:00.007 ********* 2026-08-24 20:33:06.897003 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-08-24 20:33:06.897485 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-08-24 20:33:06.897848 | instance | interpreter could change the meaning of that path. See 2026-08-24 20:33:06.898229 | instance | https://docs.ansible.com/ansible- 2026-08-24 20:33:06.898577 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-08-24 20:33:06.908029 | instance | ok: [instance] 2026-08-24 20:33:06.908390 | instance | 2026-08-24 20:33:06.908793 | instance | TASK [Display CSI driver value and environment variable] *********************** 2026-08-24 20:33:06.909289 | instance | Monday 24 August 2026 20:33:06 +0000 (0:00:00.972) 0:00:00.979 ********* 2026-08-24 20:33:06.958508 | instance | ok: [instance] => { 2026-08-24 20:33:06.958876 | instance | "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER=" 2026-08-24 20:33:06.959203 | instance | } 2026-08-24 20:33:06.959518 | instance | 2026-08-24 20:33:06.959851 | instance | PLAY [all] ********************************************************************* 2026-08-24 20:33:06.960244 | instance | 2026-08-24 20:33:06.960709 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-24 20:33:06.961208 | instance | Monday 24 August 2026 20:33:06 +0000 (0:00:00.050) 0:00:01.030 ********* 2026-08-24 20:33:07.795429 | instance | ok: [instance] 2026-08-24 20:33:07.795805 | instance | 2026-08-24 20:33:07.796173 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-08-24 20:33:07.796666 | instance | Monday 24 August 2026 20:33:07 +0000 (0:00:00.836) 0:00:01.866 ********* 2026-08-24 20:33:07.972387 | instance | ok: [instance] 2026-08-24 20:33:07.972765 | instance | 2026-08-24 20:33:07.973107 | instance | PLAY [Deploy Ceph monitors & managers] ***************************************** 2026-08-24 20:33:07.973420 | instance | 2026-08-24 20:33:07.973753 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-24 20:33:07.974123 | instance | Monday 24 August 2026 20:33:07 +0000 (0:00:00.177) 0:00:02.044 ********* 2026-08-24 20:33:08.864017 | instance | ok: [instance] 2026-08-24 20:33:08.864421 | instance | 2026-08-24 20:33:08.864800 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-24 20:33:08.865234 | instance | Monday 24 August 2026 20:33:08 +0000 (0:00:00.891) 0:00:02.935 ********* 2026-08-24 20:33:09.148827 | instance | ok: [instance] 2026-08-24 20:33:09.149219 | instance | 2026-08-24 20:33:09.149571 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-24 20:33:09.149930 | instance | Monday 24 August 2026 20:33:09 +0000 (0:00:00.285) 0:00:03.220 ********* 2026-08-24 20:33:09.193388 | instance | skipping: [instance] 2026-08-24 20:33:09.193584 | instance | 2026-08-24 20:33:09.193740 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-08-24 20:33:09.193892 | instance | Monday 24 August 2026 20:33:09 +0000 (0:00:00.042) 0:00:03.262 ********* 2026-08-24 20:33:09.527080 | instance | changed: [instance] 2026-08-24 20:33:09.527122 | instance | 2026-08-24 20:33:09.527128 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-24 20:33:09.527133 | instance | Monday 24 August 2026 20:33:09 +0000 (0:00:00.335) 0:00:03.598 ********* 2026-08-24 20:33:09.601979 | instance | ok: [instance] => { 2026-08-24 20:33:09.602024 | instance | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-08-24 20:33:09.602031 | instance | } 2026-08-24 20:33:09.602036 | instance | 2026-08-24 20:33:09.602040 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-24 20:33:09.602045 | instance | Monday 24 August 2026 20:33:09 +0000 (0:00:00.074) 0:00:03.673 ********* 2026-08-24 20:33:10.194445 | instance | changed: [instance] 2026-08-24 20:33:10.194998 | instance | 2026-08-24 20:33:10.195036 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-24 20:33:10.195045 | instance | Monday 24 August 2026 20:33:10 +0000 (0:00:00.592) 0:00:04.266 ********* 2026-08-24 20:33:10.248657 | instance | skipping: [instance] 2026-08-24 20:33:10.249049 | instance | 2026-08-24 20:33:10.249091 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-24 20:33:10.249098 | instance | Monday 24 August 2026 20:33:10 +0000 (0:00:00.054) 0:00:04.320 ********* 2026-08-24 20:33:10.295643 | instance | skipping: [instance] 2026-08-24 20:33:10.296018 | instance | 2026-08-24 20:33:10.296058 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-24 20:33:10.296064 | instance | Monday 24 August 2026 20:33:10 +0000 (0:00:00.047) 0:00:04.367 ********* 2026-08-24 20:33:10.502006 | instance | ok: [instance] 2026-08-24 20:33:10.502099 | instance | 2026-08-24 20:33:10.502398 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-24 20:33:10.502447 | instance | Monday 24 August 2026 20:33:10 +0000 (0:00:00.206) 0:00:04.573 ********* 2026-08-24 20:33:11.696997 | instance | ok: [instance] 2026-08-24 20:33:11.697070 | instance | 2026-08-24 20:33:11.697357 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-24 20:33:11.697399 | instance | Monday 24 August 2026 20:33:11 +0000 (0:00:01.194) 0:00:05.768 ********* 2026-08-24 20:33:11.764811 | instance | ok: [instance] => { 2026-08-24 20:33:11.764931 | instance | "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz" 2026-08-24 20:33:11.765078 | instance | } 2026-08-24 20:33:11.765314 | instance | 2026-08-24 20:33:11.765527 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-24 20:33:11.765737 | instance | Monday 24 August 2026 20:33:11 +0000 (0:00:00.067) 0:00:05.836 ********* 2026-08-24 20:33:12.395950 | instance | changed: [instance] 2026-08-24 20:33:12.396021 | instance | 2026-08-24 20:33:12.396164 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-24 20:33:12.396348 | instance | Monday 24 August 2026 20:33:12 +0000 (0:00:00.631) 0:00:06.467 ********* 2026-08-24 20:33:15.196427 | instance | changed: [instance] 2026-08-24 20:33:15.196495 | instance | 2026-08-24 20:33:15.196630 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-08-24 20:33:15.196818 | instance | Monday 24 August 2026 20:33:15 +0000 (0:00:02.800) 0:00:09.268 ********* 2026-08-24 20:33:15.227445 | instance | skipping: [instance] 2026-08-24 20:33:15.227513 | instance | 2026-08-24 20:33:15.227690 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-08-24 20:33:15.227885 | instance | Monday 24 August 2026 20:33:15 +0000 (0:00:00.030) 0:00:09.299 ********* 2026-08-24 20:33:15.266555 | instance | skipping: [instance] 2026-08-24 20:33:15.266660 | instance | 2026-08-24 20:33:15.267066 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-08-24 20:33:15.267228 | instance | Monday 24 August 2026 20:33:15 +0000 (0:00:00.036) 0:00:09.335 ********* 2026-08-24 20:33:15.300939 | instance | skipping: [instance] 2026-08-24 20:33:15.301136 | instance | 2026-08-24 20:33:15.301299 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-08-24 20:33:15.301476 | instance | Monday 24 August 2026 20:33:15 +0000 (0:00:00.035) 0:00:09.371 ********* 2026-08-24 20:33:19.757736 | instance | changed: [instance] 2026-08-24 20:33:19.757962 | instance | 2026-08-24 20:33:19.757975 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] *** 2026-08-24 20:33:19.757987 | instance | Monday 24 August 2026 20:33:19 +0000 (0:00:04.457) 0:00:13.828 ********* 2026-08-24 20:33:20.321155 | instance | changed: [instance] 2026-08-24 20:33:20.321211 | instance | 2026-08-24 20:33:20.321222 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] ******* 2026-08-24 20:33:20.321233 | instance | Monday 24 August 2026 20:33:20 +0000 (0:00:00.563) 0:00:14.391 ********* 2026-08-24 20:33:21.212785 | instance | changed: [instance] => (item={'path': '/etc/containerd'}) 2026-08-24 20:33:21.212849 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'}) 2026-08-24 20:33:21.212862 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'}) 2026-08-24 20:33:21.212871 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'}) 2026-08-24 20:33:21.212881 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'}) 2026-08-24 20:33:21.212892 | instance | 2026-08-24 20:33:21.212909 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] ********** 2026-08-24 20:33:21.212918 | instance | Monday 24 August 2026 20:33:21 +0000 (0:00:00.890) 0:00:15.282 ********* 2026-08-24 20:33:21.820901 | instance | changed: [instance] 2026-08-24 20:33:21.820970 | instance | 2026-08-24 20:33:21.821606 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ******** 2026-08-24 20:33:21.821647 | instance | Monday 24 August 2026 20:33:21 +0000 (0:00:00.592) 0:00:15.875 ********* 2026-08-24 20:33:21.821653 | instance | 2026-08-24 20:33:21.821658 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-08-24 20:33:21.821662 | instance | Monday 24 August 2026 20:33:21 +0000 (0:00:00.017) 0:00:15.892 ********* 2026-08-24 20:33:22.692257 | instance | ok: [instance] 2026-08-24 20:33:22.692866 | instance | 2026-08-24 20:33:22.692911 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] ********** 2026-08-24 20:33:22.692920 | instance | Monday 24 August 2026 20:33:22 +0000 (0:00:00.871) 0:00:16.763 ********* 2026-08-24 20:33:23.118353 | instance | changed: [instance] 2026-08-24 20:33:23.118443 | instance | 2026-08-24 20:33:23.118709 | instance | TASK [vexxhost.containers.containerd : Enable and start service] *************** 2026-08-24 20:33:23.118726 | instance | Monday 24 August 2026 20:33:23 +0000 (0:00:00.426) 0:00:17.190 ********* 2026-08-24 20:33:23.652853 | instance | changed: [instance] 2026-08-24 20:33:23.652900 | instance | 2026-08-24 20:33:23.652906 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-24 20:33:23.652911 | instance | Monday 24 August 2026 20:33:23 +0000 (0:00:00.533) 0:00:17.724 ********* 2026-08-24 20:33:23.861053 | instance | ok: [instance] 2026-08-24 20:33:23.861140 | instance | 2026-08-24 20:33:23.861420 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-24 20:33:23.861469 | instance | Monday 24 August 2026 20:33:23 +0000 (0:00:00.208) 0:00:17.932 ********* 2026-08-24 20:33:23.924025 | instance | ok: [instance] => { 2026-08-24 20:33:23.924660 | instance | "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz" 2026-08-24 20:33:23.924692 | instance | } 2026-08-24 20:33:23.924698 | instance | 2026-08-24 20:33:23.924702 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-24 20:33:23.924707 | instance | Monday 24 August 2026 20:33:23 +0000 (0:00:00.062) 0:00:17.995 ********* 2026-08-24 20:33:24.972804 | instance | changed: [instance] 2026-08-24 20:33:24.972875 | instance | 2026-08-24 20:33:24.973173 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-08-24 20:33:24.973214 | instance | Monday 24 August 2026 20:33:24 +0000 (0:00:01.048) 0:00:19.044 ********* 2026-08-24 20:33:29.293479 | instance | changed: [instance] 2026-08-24 20:33:29.293561 | instance | 2026-08-24 20:33:29.293806 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ****************** 2026-08-24 20:33:29.293848 | instance | Monday 24 August 2026 20:33:29 +0000 (0:00:04.320) 0:00:23.365 ********* 2026-08-24 20:33:30.244814 | instance | ok: [instance] 2026-08-24 20:33:30.244899 | instance | 2026-08-24 20:33:30.245167 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] *************** 2026-08-24 20:33:30.245206 | instance | Monday 24 August 2026 20:33:30 +0000 (0:00:00.951) 0:00:24.316 ********* 2026-08-24 20:33:30.586853 | instance | changed: [instance] 2026-08-24 20:33:30.586922 | instance | 2026-08-24 20:33:30.587204 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] ***** 2026-08-24 20:33:30.587243 | instance | Monday 24 August 2026 20:33:30 +0000 (0:00:00.341) 0:00:24.658 ********* 2026-08-24 20:33:31.043342 | instance | changed: [instance] 2026-08-24 20:33:31.043406 | instance | 2026-08-24 20:33:31.043638 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] *********** 2026-08-24 20:33:31.043699 | instance | Monday 24 August 2026 20:33:31 +0000 (0:00:00.456) 0:00:25.115 ********* 2026-08-24 20:33:31.619289 | instance | changed: [instance] => (item={'path': '/etc/docker'}) 2026-08-24 20:33:31.619360 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'}) 2026-08-24 20:33:31.619921 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'}) 2026-08-24 20:33:31.619987 | instance | 2026-08-24 20:33:31.619994 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ****** 2026-08-24 20:33:31.619999 | instance | Monday 24 August 2026 20:33:31 +0000 (0:00:00.575) 0:00:25.690 ********* 2026-08-24 20:33:32.076298 | instance | changed: [instance] 2026-08-24 20:33:32.076789 | instance | 2026-08-24 20:33:32.076935 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] *********** 2026-08-24 20:33:32.076943 | instance | Monday 24 August 2026 20:33:32 +0000 (0:00:00.457) 0:00:26.148 ********* 2026-08-24 20:33:32.538073 | instance | changed: [instance] 2026-08-24 20:33:32.538808 | instance | 2026-08-24 20:33:32.538828 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************ 2026-08-24 20:33:32.538834 | instance | Monday 24 August 2026 20:33:32 +0000 (0:00:00.444) 0:00:26.592 ********* 2026-08-24 20:33:32.538838 | instance | 2026-08-24 20:33:32.538842 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-08-24 20:33:32.538847 | instance | Monday 24 August 2026 20:33:32 +0000 (0:00:00.017) 0:00:26.609 ********* 2026-08-24 20:33:33.200842 | instance | ok: [instance] 2026-08-24 20:33:33.200911 | instance | 2026-08-24 20:33:33.201196 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ****************** 2026-08-24 20:33:33.201242 | instance | Monday 24 August 2026 20:33:33 +0000 (0:00:00.663) 0:00:27.272 ********* 2026-08-24 20:33:34.014313 | instance | changed: [instance] 2026-08-24 20:33:34.014386 | instance | 2026-08-24 20:33:34.014676 | instance | TASK [vexxhost.containers.docker : Enable and start service] ******************* 2026-08-24 20:33:34.014722 | instance | Monday 24 August 2026 20:33:34 +0000 (0:00:00.813) 0:00:28.086 ********* 2026-08-24 20:33:34.556600 | instance | changed: [instance] 2026-08-24 20:33:34.556666 | instance | 2026-08-24 20:33:34.556967 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ****** 2026-08-24 20:33:34.557004 | instance | Monday 24 August 2026 20:33:34 +0000 (0:00:00.542) 0:00:28.628 ********* 2026-08-24 20:33:34.611531 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml) 2026-08-24 20:33:34.611622 | instance | 2026-08-24 20:33:34.611895 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ******************************** 2026-08-24 20:33:34.611930 | instance | Monday 24 August 2026 20:33:34 +0000 (0:00:00.054) 0:00:28.683 ********* 2026-08-24 20:33:39.590719 | instance | changed: [instance] 2026-08-24 20:33:39.590771 | instance | 2026-08-24 20:33:39.590778 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] ********************* 2026-08-24 20:33:39.590785 | instance | Monday 24 August 2026 20:33:39 +0000 (0:00:04.978) 0:00:33.661 ********* 2026-08-24 20:33:40.229561 | instance | ok: [instance] => (item=chronyd) 2026-08-24 20:33:40.230157 | instance | ok: [instance] => (item=sshd) 2026-08-24 20:33:40.230231 | instance | 2026-08-24 20:33:40.230243 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ****************************** 2026-08-24 20:33:40.230253 | instance | Monday 24 August 2026 20:33:40 +0000 (0:00:00.639) 0:00:34.301 ********* 2026-08-24 20:33:41.042019 | instance | changed: [instance] 2026-08-24 20:33:41.042617 | instance | 2026-08-24 20:33:41.042773 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ******************** 2026-08-24 20:33:41.042781 | instance | Monday 24 August 2026 20:33:41 +0000 (0:00:00.812) 0:00:35.113 ********* 2026-08-24 20:33:41.255672 | instance | ok: [instance] 2026-08-24 20:33:41.255739 | instance | 2026-08-24 20:33:41.256019 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] **************** 2026-08-24 20:33:41.256061 | instance | Monday 24 August 2026 20:33:41 +0000 (0:00:00.213) 0:00:35.327 ********* 2026-08-24 20:33:41.697207 | instance | changed: [instance] 2026-08-24 20:33:41.697279 | instance | 2026-08-24 20:33:41.697577 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] *** 2026-08-24 20:33:41.697619 | instance | Monday 24 August 2026 20:33:41 +0000 (0:00:00.441) 0:00:35.768 ********* 2026-08-24 20:33:42.030902 | instance | changed: [instance] 2026-08-24 20:33:42.030989 | instance | 2026-08-24 20:33:42.031010 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] ************************* 2026-08-24 20:33:42.031178 | instance | Monday 24 August 2026 20:33:42 +0000 (0:00:00.333) 0:00:36.102 ********* 2026-08-24 20:33:42.147615 | instance | ok: [instance] 2026-08-24 20:33:42.147975 | instance | 2026-08-24 20:33:42.148016 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] ******************* 2026-08-24 20:33:42.148022 | instance | Monday 24 August 2026 20:33:42 +0000 (0:00:00.116) 0:00:36.219 ********* 2026-08-24 20:33:42.356473 | instance | ok: [instance] => (item=instance) 2026-08-24 20:33:42.356544 | instance | 2026-08-24 20:33:42.356812 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ******** 2026-08-24 20:33:42.356982 | instance | Monday 24 August 2026 20:33:42 +0000 (0:00:00.208) 0:00:36.428 ********* 2026-08-24 20:33:42.400816 | instance | ok: [instance] 2026-08-24 20:33:42.401223 | instance | 2026-08-24 20:33:42.401265 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] *********************************** 2026-08-24 20:33:42.401272 | instance | Monday 24 August 2026 20:33:42 +0000 (0:00:00.044) 0:00:36.472 ********* 2026-08-24 20:33:42.470638 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance 2026-08-24 20:33:42.471056 | instance | 2026-08-24 20:33:42.471226 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] ************* 2026-08-24 20:33:42.471233 | instance | Monday 24 August 2026 20:33:42 +0000 (0:00:00.069) 0:00:36.542 ********* 2026-08-24 20:33:42.776571 | instance | changed: [instance] 2026-08-24 20:33:42.776643 | instance | 2026-08-24 20:33:42.776924 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ****************** 2026-08-24 20:33:42.776964 | instance | Monday 24 August 2026 20:33:42 +0000 (0:00:00.305) 0:00:36.848 ********* 2026-08-24 20:33:43.451233 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True}) 2026-08-24 20:33:43.451303 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0}) 2026-08-24 20:33:43.451773 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False}) 2026-08-24 20:33:43.451816 | instance | 2026-08-24 20:33:43.451822 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] ******************************* 2026-08-24 20:33:43.451827 | instance | Monday 24 August 2026 20:33:43 +0000 (0:00:00.674) 0:00:37.522 ********* 2026-08-24 20:35:06.217127 | instance | ok: [instance] 2026-08-24 20:35:06.217193 | instance | 2026-08-24 20:35:06.217357 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] *************** 2026-08-24 20:35:06.217481 | instance | Monday 24 August 2026 20:35:06 +0000 (0:01:22.765) 0:02:00.288 ********* 2026-08-24 20:35:06.439917 | instance | changed: [instance] 2026-08-24 20:35:06.440189 | instance | 2026-08-24 20:35:06.440494 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] ********************************** 2026-08-24 20:35:06.440807 | instance | Monday 24 August 2026 20:35:06 +0000 (0:00:00.222) 0:02:00.511 ********* 2026-08-24 20:35:06.517547 | instance | ok: [instance] 2026-08-24 20:35:06.517784 | instance | 2026-08-24 20:35:06.518087 | instance | TASK [Install Ceph host] ******************************************************* 2026-08-24 20:35:06.518438 | instance | Monday 24 August 2026 20:35:06 +0000 (0:00:00.077) 0:02:00.589 ********* 2026-08-24 20:35:06.609125 | instance | included: vexxhost.ceph.cephadm_host for instance 2026-08-24 20:35:06.609377 | instance | 2026-08-24 20:35:06.609682 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ****** 2026-08-24 20:35:06.609951 | instance | Monday 24 August 2026 20:35:06 +0000 (0:00:00.091) 0:02:00.680 ********* 2026-08-24 20:35:08.166355 | instance | ok: [instance] 2026-08-24 20:35:08.166465 | instance | 2026-08-24 20:35:08.166579 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] *** 2026-08-24 20:35:08.166703 | instance | Monday 24 August 2026 20:35:08 +0000 (0:00:01.557) 0:02:02.238 ********* 2026-08-24 20:35:08.229828 | instance | ok: [instance] => (item=instance) 2026-08-24 20:35:08.230088 | instance | 2026-08-24 20:35:08.230395 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] *********** 2026-08-24 20:35:08.230671 | instance | Monday 24 August 2026 20:35:08 +0000 (0:00:00.063) 0:02:02.301 ********* 2026-08-24 20:35:08.591894 | instance | ok: [instance] 2026-08-24 20:35:08.592196 | instance | 2026-08-24 20:35:08.592486 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] *********************** 2026-08-24 20:35:08.592772 | instance | Monday 24 August 2026 20:35:08 +0000 (0:00:00.361) 0:02:02.663 ********* 2026-08-24 20:35:10.810670 | instance | ok: [instance] 2026-08-24 20:35:10.810887 | instance | 2026-08-24 20:35:10.811164 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ****************** 2026-08-24 20:35:10.811432 | instance | Monday 24 August 2026 20:35:10 +0000 (0:00:02.218) 0:02:04.882 ********* 2026-08-24 20:35:54.260337 | instance | An exception occurred during task execution. To see the full traceback, use -vvv. The error was: [errno 5] RADOS I/O error (error connecting to the cluster) 2026-08-24 20:35:54.261122 | 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_l6f3ojts/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_l6f3ojts/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_l6f3ojts/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_l6f3ojts/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-24T20:35:54.103+0000 7f51241cb640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgDRqoxqkPlMDyAAK4MIWKcRRFLlprRxxG4Jw5+pYgbOMyS62AR8QhMv0Qs=: Malformed input [buffer:3]\n2026-08-24T20:35:54.103+0000 7f51241cb640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T20:35:54.107+0000 7f51241cb640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgDRqoxqkPlMDyAAK4MIWKcRRFLlprRxxG4Jw5+pYgbOMyS62AR8QhMv0Qs=: Malformed input [buffer:3]\n2026-08-24T20:35:54.107+0000 7f51241cb640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T20:35:54.107+0000 7f51241cb640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgDRqoxqkPlMDyAAK4MIWKcRRFLlprRxxG4Jw5+pYgbOMyS62AR8QhMv0Qs=: Malformed input [buffer:3]\n2026-08-24T20:35:54.107+0000 7f51241cb640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-08-24T20:35:54.107+0000 7f51241cb640 -1 monclient: keyring not found\n[errno 5] RADOS I/O error (error connecting to the cluster)\n\n", "module_stdout": "", "msg": "MODULE FAILURE\nSee stdout/stderr for the exact error", "rc": 1} 2026-08-24 20:35:54.263332 | instance | 2026-08-24 20:35:54.266110 | instance | PLAY RECAP ********************************************************************* 2026-08-24 20:35:54.266140 | instance | instance : ok=55 changed=26 unreachable=0 failed=1 skipped=6 rescued=0 ignored=0 2026-08-24 20:35:54.266153 | instance | 2026-08-24 20:35:54.266163 | instance | Monday 24 August 2026 20:35:54 +0000 (0:00:43.453) 0:02:48.335 ********* 2026-08-24 20:35:54.266173 | instance | =============================================================================== 2026-08-24 20:35:54.266183 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 82.77s 2026-08-24 20:35:54.266192 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 43.45s 2026-08-24 20:35:54.266202 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 4.98s 2026-08-24 20:35:54.266212 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 4.46s 2026-08-24 20:35:54.266225 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.32s 2026-08-24 20:35:54.266339 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.80s 2026-08-24 20:35:54.266581 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.22s 2026-08-24 20:35:54.266832 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.56s 2026-08-24 20:35:54.267073 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.53s 2026-08-24 20:35:54.267326 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.19s 2026-08-24 20:35:54.267588 | instance | vexxhost.containers.download_artifact : Download item ------------------- 1.05s 2026-08-24 20:35:54.267825 | instance | Gathering Facts --------------------------------------------------------- 0.97s 2026-08-24 20:35:54.268052 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 0.95s 2026-08-24 20:35:54.268272 | instance | Gathering Facts --------------------------------------------------------- 0.89s 2026-08-24 20:35:54.268503 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 0.89s 2026-08-24 20:35:54.268749 | instance | Gathering Facts --------------------------------------------------------- 0.84s 2026-08-24 20:35:54.269036 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 0.81s 2026-08-24 20:35:54.269281 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 0.81s 2026-08-24 20:35:54.269520 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.67s 2026-08-24 20:35:54.269737 | instance | vexxhost.ceph.cephadm : Ensure services are started --------------------- 0.64s 2026-08-24 20:35:54.354952 | instance | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-08-24 20:35:54.355249 | instance | ERROR [csi > converge] Executed: Failed 2026-08-24 20:35:54.355460 | instance | ERROR Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-08-24 20:35:54.795490 | instance | ERROR 2026-08-24 20:35:54.795761 | instance | { 2026-08-24 20:35:54.795837 | instance | "delta": "0:03:35.560617", 2026-08-24 20:35:54.795884 | instance | "end": "2026-08-24 20:35:54.412373", 2026-08-24 20:35:54.795925 | instance | "msg": "non-zero return code", 2026-08-24 20:35:54.795962 | instance | "rc": 2, 2026-08-24 20:35:54.796051 | instance | "start": "2026-08-24 20:32:18.851756" 2026-08-24 20:35:54.796091 | instance | } failure 2026-08-24 20:35:54.800947 | 2026-08-24 20:35:54.801007 | PLAY RECAP 2026-08-24 20:35:54.801052 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-08-24 20:35:54.801074 | 2026-08-24 20:35:54.950614 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-24 20:35:54.954221 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-08-24 20:35:56.561625 | 2026-08-24 20:35:56.561750 | PLAY [all] 2026-08-24 20:35:56.576039 | 2026-08-24 20:35:56.576126 | TASK [gather-host-logs : creating directory for system status] 2026-08-24 20:35:56.935879 | instance | changed 2026-08-24 20:35:57.071220 | 2026-08-24 20:35:57.071399 | TASK [gather-host-logs : Get logs for each host] 2026-08-24 20:35:57.418550 | instance | + systemd-cgls --full --all --no-pager 2026-08-24 20:35:57.432861 | instance | + ip addr 2026-08-24 20:35:57.436164 | instance | + ip route 2026-08-24 20:35:57.437743 | instance | + lsblk 2026-08-24 20:35:57.443462 | instance | + mount 2026-08-24 20:35:57.445851 | instance | + docker images 2026-08-24 20:35:57.467714 | instance | + brctl show 2026-08-24 20:35:57.468360 | instance | /bin/bash: line 8: brctl: command not found 2026-08-24 20:35:57.468644 | instance | + ps aux --sort=-%mem 2026-08-24 20:35:57.483608 | instance | + dpkg -l 2026-08-24 20:35:57.493708 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-08-24 20:35:57.494305 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-08-24 20:35:57.509408 | instance | + '[' '!' -z '' ']' 2026-08-24 20:35:57.634780 | instance | ok: Runtime: 0:00:00.097841 2026-08-24 20:35:57.640900 | 2026-08-24 20:35:57.640991 | TASK [gather-host-logs : Downloads logs to executor] 2026-08-24 20:35:58.293987 | instance | changed: 2026-08-24 20:35:58.294180 | instance | created directory /var/lib/zuul/builds/371e415a0a4d449e80d9ffb2a18ceb84/work/logs/instance 2026-08-24 20:35:58.294210 | instance | cd+++++++++ system/ 2026-08-24 20:35:58.294233 | instance | >f+++++++++ system/brctl-show.txt 2026-08-24 20:35:58.294254 | instance | >f+++++++++ system/docker-images.txt 2026-08-24 20:35:58.294275 | instance | >f+++++++++ system/ip-addr.txt 2026-08-24 20:35:58.294298 | instance | >f+++++++++ system/ip-route.txt 2026-08-24 20:35:58.294321 | instance | >f+++++++++ system/lsblk.txt 2026-08-24 20:35:58.294341 | instance | >f+++++++++ system/mount.txt 2026-08-24 20:35:58.294360 | instance | >f+++++++++ system/packages.txt 2026-08-24 20:35:58.294380 | instance | >f+++++++++ system/ps.txt 2026-08-24 20:35:58.294401 | instance | >f+++++++++ system/systemd-cgls.txt 2026-08-24 20:35:58.305519 | 2026-08-24 20:35:58.305610 | LOOP [helm-release-status : creating directory for helm release status] 2026-08-24 20:35:58.507849 | instance | changed: "values" 2026-08-24 20:35:58.678770 | instance | changed: "releases" 2026-08-24 20:35:58.694562 | 2026-08-24 20:35:58.694729 | TASK [helm-release-status : Gather get release status for helm charts] 2026-08-24 20:35:58.897496 | instance | /bin/bash: line 3: kubectl: command not found 2026-08-24 20:35:59.230959 | instance | ok: Runtime: 0:00:00.003165 2026-08-24 20:35:59.237733 | 2026-08-24 20:35:59.237878 | TASK [helm-release-status : Downloads logs to executor] 2026-08-24 20:35:59.710853 | instance | changed: 2026-08-24 20:35:59.711135 | instance | cd+++++++++ helm/ 2026-08-24 20:35:59.711194 | instance | cd+++++++++ helm/releases/ 2026-08-24 20:35:59.711242 | instance | cd+++++++++ helm/values/ 2026-08-24 20:35:59.720407 | 2026-08-24 20:35:59.720493 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-08-24 20:35:59.926179 | instance | changed 2026-08-24 20:35:59.933333 | 2026-08-24 20:35:59.933403 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-08-24 20:36:00.168710 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-24 20:36:00.168762 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-24 20:36:00.172926 | instance | environment: line 1: kubectl: command not found 2026-08-24 20:36:00.174254 | instance | environment: line 1: kubectl: command not found 2026-08-24 20:36:00.174560 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-24 20:36:00.175891 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-24 20:36:00.177180 | instance | environment: line 1: kubectl: command not found 2026-08-24 20:36:00.178298 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-24 20:36:00.180380 | instance | environment: line 1: kubectl: command not found 2026-08-24 20:36:00.181674 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-24 20:36:00.182734 | instance | environment: line 1: kubectl: command not found 2026-08-24 20:36:00.183467 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-24 20:36:00.467738 | instance | ok: Runtime: 0:00:00.023074 2026-08-24 20:36:00.474333 | 2026-08-24 20:36:00.474416 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-08-24 20:36:00.680368 | instance | changed 2026-08-24 20:36:00.688802 | 2026-08-24 20:36:00.688899 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-08-24 20:36:00.893891 | instance | environment: line 5: kubectl: command not found 2026-08-24 20:36:00.894676 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-24 20:36:00.894751 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-24 20:36:00.895519 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-24 20:36:01.231052 | instance | ok: Runtime: 0:00:00.008097 2026-08-24 20:36:01.239023 | 2026-08-24 20:36:01.239141 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-08-24 20:36:01.743915 | instance | changed: 2026-08-24 20:36:01.744239 | instance | cd+++++++++ objects/ 2026-08-24 20:36:01.744303 | instance | cd+++++++++ objects/cluster/ 2026-08-24 20:36:01.744354 | instance | cd+++++++++ objects/namespaced/ 2026-08-24 20:36:01.756980 | 2026-08-24 20:36:01.757051 | TASK [gather-pod-logs : creating directory for pod logs] 2026-08-24 20:36:01.954242 | instance | changed 2026-08-24 20:36:02.049909 | 2026-08-24 20:36:02.050055 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-08-24 20:36:02.250656 | instance | changed 2026-08-24 20:36:02.382029 | 2026-08-24 20:36:02.382135 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-08-24 20:36:02.602309 | instance | environment: line 3: kubectl: command not found 2026-08-24 20:36:02.920440 | instance | ok: Runtime: 0:00:00.008064 2026-08-24 20:36:02.927377 | 2026-08-24 20:36:02.927465 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-08-24 20:36:03.407616 | instance | changed: 2026-08-24 20:36:03.407832 | instance | cd+++++++++ pod-logs/ 2026-08-24 20:36:03.407874 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-08-24 20:36:03.418264 | 2026-08-24 20:36:03.418335 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-08-24 20:36:03.614004 | instance | changed 2026-08-24 20:36:03.620996 | 2026-08-24 20:36:03.621085 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-08-24 20:36:03.847443 | instance | /bin/bash: line 2: kubectl: command not found 2026-08-24 20:36:04.156403 | instance | ok: Runtime: 0:00:00.038201 2026-08-24 20:36:04.161848 | 2026-08-24 20:36:04.161922 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-08-24 20:36:04.365384 | instance | /bin/bash: line 2: kubectl: command not found 2026-08-24 20:36:04.396104 | instance | ceph-mgr endpoints: 2026-08-24 20:36:04.697647 | instance | ok: Runtime: 0:00:00.037029 2026-08-24 20:36:04.704525 | 2026-08-24 20:36:04.704610 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-08-24 20:36:04.919228 | instance | /bin/bash: line 4: kubectl: command not found 2026-08-24 20:36:05.244012 | instance | ok: Runtime: 0:00:00.035957 2026-08-24 20:36:05.251695 | 2026-08-24 20:36:05.251760 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-08-24 20:36:05.739475 | instance | changed: cd+++++++++ prometheus/ 2026-08-24 20:36:05.750368 | 2026-08-24 20:36:05.750433 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-08-24 20:36:05.977610 | instance | changed 2026-08-24 20:36:05.984092 | 2026-08-24 20:36:05.984180 | TASK [gather-selenium-data : Get selenium data] 2026-08-24 20:36:06.225772 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-08-24 20:36:06.227004 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-08-24 20:36:06.515251 | instance | ERROR 2026-08-24 20:36:06.515454 | instance | { 2026-08-24 20:36:06.515497 | instance | "delta": "0:00:00.005784", 2026-08-24 20:36:06.515528 | instance | "end": "2026-08-24 20:36:06.227273", 2026-08-24 20:36:06.515559 | instance | "msg": "non-zero return code", 2026-08-24 20:36:06.515587 | instance | "rc": 1, 2026-08-24 20:36:06.515615 | instance | "start": "2026-08-24 20:36:06.221489" 2026-08-24 20:36:06.515642 | instance | } 2026-08-24 20:36:06.515677 | instance | ERROR: Ignoring Errors 2026-08-24 20:36:06.521823 | 2026-08-24 20:36:06.533200 | TASK [gather-selenium-data : Downloads logs to executor] 2026-08-24 20:36:07.301305 | instance | changed: cd+++++++++ selenium/ 2026-08-24 20:36:07.309315 | 2026-08-24 20:36:07.309390 | PLAY RECAP 2026-08-24 20:36:07.309454 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-08-24 20:36:07.309486 | 2026-08-24 20:36:07.453773 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-08-24 20:36:07.458594 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-24 20:36:08.069102 | 2026-08-24 20:36:08.161150 | PLAY [all] 2026-08-24 20:36:08.180448 | 2026-08-24 20:36:08.180589 | TASK [fetch-output : Set log path for multiple nodes] 2026-08-24 20:36:08.225843 | instance | skipping: Conditional result was False 2026-08-24 20:36:08.234528 | 2026-08-24 20:36:08.234655 | TASK [fetch-output : Set log path for single node] 2026-08-24 20:36:08.276885 | instance | ok 2026-08-24 20:36:08.312025 | 2026-08-24 20:36:08.312167 | LOOP [fetch-output : Ensure local output dirs] 2026-08-24 20:36:08.873020 | instance -> localhost | ok: "/var/lib/zuul/builds/371e415a0a4d449e80d9ffb2a18ceb84/work/logs" 2026-08-24 20:36:09.076621 | instance -> localhost | changed: "/var/lib/zuul/builds/371e415a0a4d449e80d9ffb2a18ceb84/work/artifacts" 2026-08-24 20:36:09.284369 | instance -> localhost | changed: "/var/lib/zuul/builds/371e415a0a4d449e80d9ffb2a18ceb84/work/docs" 2026-08-24 20:36:09.298691 | 2026-08-24 20:36:09.298892 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-24 20:36:09.936114 | instance | changed: .d..t...... ./ 2026-08-24 20:36:09.936344 | instance | changed: All items complete 2026-08-24 20:36:09.936377 | 2026-08-24 20:36:10.392691 | instance | changed: .d..t...... ./ 2026-08-24 20:36:10.846732 | instance | changed: .d..t...... ./ 2026-08-24 20:36:10.871169 | 2026-08-24 20:36:10.871301 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-24 20:36:11.324835 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.005320 2026-08-24 20:36:11.552365 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.006840 2026-08-24 20:36:11.572743 | 2026-08-24 20:36:11.573094 | PLAY [all] 2026-08-24 20:36:11.578789 | 2026-08-24 20:36:11.578874 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-24 20:36:11.976572 | instance | changed 2026-08-24 20:36:11.982169 | 2026-08-24 20:36:11.982253 | PLAY RECAP 2026-08-24 20:36:11.982300 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-24 20:36:11.982324 | 2026-08-24 20:36:12.113949 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-24 20:36:12.116985 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-24 20:36:12.753891 | 2026-08-24 20:36:12.754208 | PLAY [localhost] 2026-08-24 20:36:12.763766 | 2026-08-24 20:36:12.763841 | TASK [Generate Zuul manifest] 2026-08-24 20:36:12.784880 | localhost | ok 2026-08-24 20:36:12.803622 | 2026-08-24 20:36:12.803706 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-24 20:36:13.187959 | localhost | changed 2026-08-24 20:36:13.199176 | 2026-08-24 20:36:13.199269 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-24 20:36:13.231351 | localhost | ok 2026-08-24 20:36:13.241168 | 2026-08-24 20:36:13.241278 | TASK [Upload logs] 2026-08-24 20:36:13.262042 | localhost | ok 2026-08-24 20:36:13.322759 | 2026-08-24 20:36:13.658629 | TASK [Set zuul-log-path fact] 2026-08-24 20:36:13.684321 | localhost | ok 2026-08-24 20:36:13.700310 | 2026-08-24 20:36:13.700412 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-24 20:36:13.731858 | localhost | ok 2026-08-24 20:36:13.742683 | 2026-08-24 20:36:13.742768 | TASK [upload-logs : Create log directories] 2026-08-24 20:36:14.149210 | localhost | changed 2026-08-24 20:36:14.155701 | 2026-08-24 20:36:14.155806 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-24 20:36:14.563869 | localhost -> localhost | ok: Runtime: 0:00:00.005351 2026-08-24 20:36:14.571829 | 2026-08-24 20:36:14.571921 | TASK [upload-logs : Upload logs to log server] 2026-08-24 20:36:15.440922 | localhost | Output suppressed because no_log was given 2026-08-24 20:36:15.475223 | 2026-08-24 20:36:15.475346 | LOOP [upload-logs : Compress console log and json output] 2026-08-24 20:36:15.524754 | localhost | skipping: Conditional result was False 2026-08-24 20:36:15.533467 | localhost | skipping: Conditional result was False 2026-08-24 20:36:15.553190 | 2026-08-24 20:36:15.553293 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-24 20:36:15.596754 | localhost | skipping: Conditional result was False 2026-08-24 20:36:15.597240 | 2026-08-24 20:36:15.600846 | localhost | skipping: Conditional result was False 2026-08-24 20:36:15.615281 | 2026-08-24 20:36:15.615398 | LOOP [upload-logs : Upload console log and json output]