2026-09-17 21:20:24.044029 | Job console starting 2026-09-17 21:20:24.052076 | Updating git repos 2026-09-17 21:20:27.939818 | Cloning repos into workspace 2026-09-17 21:20:43.770097 | Restoring repo states 2026-09-17 21:21:00.621881 | Merging changes 2026-09-17 21:21:02.126671 | Checking out repos 2026-09-17 21:21:03.620457 | Preparing playbooks 2026-09-17 21:21:05.590724 | Running Ansible setup 2026-09-17 21:21:09.251552 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-09-17 21:21:09.848265 | 2026-09-17 21:21:09.848376 | PLAY [localhost] 2026-09-17 21:21:09.854940 | 2026-09-17 21:21:09.855003 | TASK [Gathering Facts] 2026-09-17 21:21:10.729179 | localhost | ok 2026-09-17 21:21:10.738086 | 2026-09-17 21:21:10.738179 | TASK [Setup log path fact] 2026-09-17 21:21:10.755017 | localhost | ok 2026-09-17 21:21:10.766913 | 2026-09-17 21:21:10.766996 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-17 21:21:10.793709 | localhost | ok 2026-09-17 21:21:10.800370 | 2026-09-17 21:21:10.800508 | TASK [emit-job-header : Print job information] 2026-09-17 21:21:10.848266 | # Job Information 2026-09-17 21:21:10.848409 | Ansible Version: 2.16.18 2026-09-17 21:21:10.848449 | Job: atmosphere-molecule-aio-ovn 2026-09-17 21:21:10.848475 | Pipeline: check 2026-09-17 21:21:10.848521 | Executor: 2d72f0692154 2026-09-17 21:21:10.848547 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4381 2026-09-17 21:21:10.848574 | Event ID: 1a19c8d0-b2dd-11f1-8aac-4e5773ee2937 2026-09-17 21:21:10.851870 | 2026-09-17 21:21:10.851948 | LOOP [emit-job-header : Print node information] 2026-09-17 21:21:10.956389 | localhost | ok: 2026-09-17 21:21:10.956722 | localhost | # Node Information 2026-09-17 21:21:10.956782 | localhost | Inventory Hostname: instance 2026-09-17 21:21:10.956825 | localhost | Hostname: np0000193121 2026-09-17 21:21:10.956864 | localhost | Username: zuul 2026-09-17 21:21:10.956908 | localhost | Distro: Ubuntu 22.04 2026-09-17 21:21:10.956946 | localhost | Provider: yul1 2026-09-17 21:21:10.956983 | localhost | Region: ca-ymq-1 2026-09-17 21:21:10.957019 | localhost | Label: ubuntu-jammy-16 2026-09-17 21:21:10.957054 | localhost | Product Name: OpenStack Nova 2026-09-17 21:21:10.957146 | localhost | Interface IP: 162.253.55.179 2026-09-17 21:21:10.974477 | 2026-09-17 21:21:10.974581 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-17 21:21:11.352195 | localhost -> localhost | changed 2026-09-17 21:21:11.357821 | 2026-09-17 21:21:11.357901 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-17 21:21:12.232411 | localhost -> localhost | changed 2026-09-17 21:21:12.243137 | 2026-09-17 21:21:12.243257 | PLAY [all] 2026-09-17 21:21:12.256912 | 2026-09-17 21:21:12.257039 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-17 21:21:12.485169 | instance -> localhost | ok 2026-09-17 21:21:12.496815 | 2026-09-17 21:21:12.496948 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-17 21:21:12.530522 | instance | ok 2026-09-17 21:21:12.555991 | instance | included: /var/lib/zuul/builds/85337bffaa1e49a7b112f7a020c6ac5f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-17 21:21:12.563804 | 2026-09-17 21:21:12.563904 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-17 21:21:13.860197 | instance -> localhost | Generating public/private rsa key pair. 2026-09-17 21:21:13.860430 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/85337bffaa1e49a7b112f7a020c6ac5f/work/85337bffaa1e49a7b112f7a020c6ac5f_id_rsa 2026-09-17 21:21:13.860487 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/85337bffaa1e49a7b112f7a020c6ac5f/work/85337bffaa1e49a7b112f7a020c6ac5f_id_rsa.pub 2026-09-17 21:21:13.860562 | instance -> localhost | The key fingerprint is: 2026-09-17 21:21:13.860605 | instance -> localhost | SHA256:CIvxhVFHOxWA8uJZgtjrxJSaUQe6TnNZfRrGPyMA9uA zuul-build-sshkey 2026-09-17 21:21:13.860663 | instance -> localhost | The key's randomart image is: 2026-09-17 21:21:13.860704 | instance -> localhost | +---[RSA 3072]----+ 2026-09-17 21:21:13.860753 | instance -> localhost | | .=...o+.o. | 2026-09-17 21:21:13.860796 | instance -> localhost | | .+ *o+. o | 2026-09-17 21:21:13.860836 | instance -> localhost | |.+.Eo*.=o. | 2026-09-17 21:21:13.860875 | instance -> localhost | |o.=+=+=.=. | 2026-09-17 21:21:13.860914 | instance -> localhost | |.O.=o=.oS+ | 2026-09-17 21:21:13.860952 | instance -> localhost | |= * o . o | 2026-09-17 21:21:13.860990 | instance -> localhost | | + | 2026-09-17 21:21:13.861027 | instance -> localhost | | . | 2026-09-17 21:21:13.861070 | instance -> localhost | | | 2026-09-17 21:21:13.861110 | instance -> localhost | +----[SHA256]-----+ 2026-09-17 21:21:13.861192 | instance -> localhost | ok: Runtime: 0:00:00.870066 2026-09-17 21:21:13.871816 | 2026-09-17 21:21:13.871937 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-17 21:21:13.904047 | instance | ok 2026-09-17 21:21:13.920639 | instance | included: /var/lib/zuul/builds/85337bffaa1e49a7b112f7a020c6ac5f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-17 21:21:13.932406 | 2026-09-17 21:21:13.932547 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-17 21:21:13.947261 | instance | skipping: Conditional result was False 2026-09-17 21:21:13.953999 | 2026-09-17 21:21:13.954083 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-17 21:21:14.400722 | instance | changed 2026-09-17 21:21:14.411338 | 2026-09-17 21:21:14.411494 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-17 21:21:14.636318 | instance | ok 2026-09-17 21:21:14.642364 | 2026-09-17 21:21:14.642443 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-17 21:21:15.157801 | instance | changed 2026-09-17 21:21:15.173061 | 2026-09-17 21:21:15.173243 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-17 21:21:15.656648 | instance | changed 2026-09-17 21:21:15.660834 | 2026-09-17 21:21:15.660889 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-17 21:21:15.683523 | instance | skipping: Conditional result was False 2026-09-17 21:21:15.688855 | 2026-09-17 21:21:15.688911 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-17 21:21:16.065476 | instance -> localhost | changed 2026-09-17 21:21:16.083741 | 2026-09-17 21:21:16.083871 | TASK [add-build-sshkey : Add back temp key] 2026-09-17 21:21:16.370691 | instance -> localhost | Identity added: /var/lib/zuul/builds/85337bffaa1e49a7b112f7a020c6ac5f/work/85337bffaa1e49a7b112f7a020c6ac5f_id_rsa (zuul-build-sshkey) 2026-09-17 21:21:16.370983 | instance -> localhost | ok: Runtime: 0:00:00.017552 2026-09-17 21:21:16.381121 | 2026-09-17 21:21:16.381268 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-17 21:21:16.659245 | instance | ok 2026-09-17 21:21:16.672144 | 2026-09-17 21:21:16.672399 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-17 21:21:16.708614 | instance | skipping: Conditional result was False 2026-09-17 21:21:16.728876 | 2026-09-17 21:21:16.729077 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-09-17 21:21:17.019557 | instance | ok 2026-09-17 21:21:17.031575 | 2026-09-17 21:21:17.031715 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-09-17 21:21:20.402777 | instance | Output suppressed because no_log was given 2026-09-17 21:21:20.411046 | 2026-09-17 21:21:20.411105 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-09-17 21:21:20.616058 | instance | ok: "logs" 2026-09-17 21:21:20.616447 | instance | ok: All items complete 2026-09-17 21:21:20.616533 | 2026-09-17 21:21:20.766879 | instance | ok: "artifacts" 2026-09-17 21:21:20.915675 | instance | ok: "docs" 2026-09-17 21:21:20.937514 | 2026-09-17 21:21:20.937693 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-09-17 21:21:21.105473 | instance | changed: "logs" 2026-09-17 21:21:21.244470 | instance | changed: "artifacts" 2026-09-17 21:21:21.396011 | instance | changed: "docs" 2026-09-17 21:21:21.410399 | 2026-09-17 21:21:21.410510 | PLAY RECAP 2026-09-17 21:21:21.410597 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-09-17 21:21:21.410655 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-17 21:21:21.410696 | 2026-09-17 21:21:21.539834 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-09-17 21:21:21.650569 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-09-17 21:21:22.243862 | 2026-09-17 21:21:22.244474 | PLAY [all] 2026-09-17 21:21:22.254058 | 2026-09-17 21:21:22.254128 | TASK [setup-uv : Extract archive] 2026-09-17 21:21:24.599012 | instance | changed 2026-09-17 21:21:24.611576 | 2026-09-17 21:21:24.611738 | TASK [setup-uv : Print version] 2026-09-17 21:21:24.982643 | instance | uv 0.8.13 2026-09-17 21:21:25.165336 | instance | ok: Runtime: 0:00:00.018448 2026-09-17 21:21:25.183855 | 2026-09-17 21:21:25.184067 | TASK [Install Ansible collection siblings] 2026-09-17 21:21:34.654386 | instance | changed: 2026-09-17 21:21:34.654659 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-09-17 21:21:34.654717 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-09-17 21:21:34.654761 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-09-17 21:21:34.654799 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto 2026-09-17 21:21:34.654838 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general 2026-09-17 21:21:34.654880 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql 2026-09-17 21:21:34.654920 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-09-17 21:21:34.654962 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-09-17 21:21:34.655001 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-09-17 21:21:34.655039 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-09-17 21:21:34.655076 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-09-17 21:21:34.655112 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-09-17 21:21:34.655149 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0 2026-09-17 21:21:34.655205 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0 2026-09-17 21:21:34.655243 | instance | Resolved ansible.utils to v6.1.1 for >=2.9.0 2026-09-17 21:21:34.655281 | instance | Resolved community.crypto to 2.2.3 for 2.2.3 2026-09-17 21:21:34.655316 | instance | Resolved community.general to 7.3.0 for 7.3.0 2026-09-17 21:21:34.655351 | instance | Resolved community.mysql to 3.6.0 for 3.6.0 2026-09-17 21:21:34.655386 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0 2026-09-17 21:21:34.655420 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0 2026-09-17 21:21:34.655456 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0 2026-09-17 21:21:34.655491 | instance | Resolved atmosphere.common to v0.7.1 for >=0.7.0 2026-09-17 21:21:34.655528 | instance | Resolved vexxhost.kubernetes to v3.4.0 for >=3.3.0,>=2.5.0 2026-09-17 21:21:34.655584 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0 2026-09-17 21:21:34.655624 | instance | Resolved ansible.utils to v6.1.1 for >=2.9.0,>=6.0.0 2026-09-17 21:21:34.655660 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-09-17 21:21:34.655696 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-09-17 21:21:34.655730 | instance | Resolved vexxhost.kubernetes to v3.4.0 for >=3.3.0,>=2.5.0 2026-09-17 21:21:34.655766 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0 2026-09-17 21:21:34.655800 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3 2026-09-17 21:21:34.655835 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-09-17 21:21:34.655872 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-09-17 21:21:34.655909 | instance | Checked out ansible.netcommon to 1.2.0 2026-09-17 21:21:34.655945 | 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-09-17 21:21:34.655983 | instance | Starting galaxy collection install process 2026-09-17 21:21:34.656019 | instance | Process install dependency map 2026-09-17 21:21:34.656054 | instance | Starting collection install process 2026-09-17 21:21:34.656089 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon' 2026-09-17 21:21:34.656123 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon 2026-09-17 21:21:34.656157 | instance | ansible.netcommon:* was installed successfully 2026-09-17 21:21:34.656211 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-09-17 21:21:34.656247 | instance | Creating virtual environment at: .venv 2026-09-17 21:21:34.656281 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-09-17 21:21:34.656316 | instance | Downloading ansible-core (2.1MiB) 2026-09-17 21:21:34.656351 | instance | Downloading pygments (1.2MiB) 2026-09-17 21:21:34.656394 | instance | Downloading cryptography (4.2MiB) 2026-09-17 21:21:34.656429 | instance | Downloading setuptools (1.1MiB) 2026-09-17 21:21:34.656464 | instance | Downloading kubernetes (1.9MiB) 2026-09-17 21:21:34.657478 | instance | Downloading openstacksdk (1.7MiB) 2026-09-17 21:21:34.657593 | instance | Downloading rjsonnet (1.2MiB) 2026-09-17 21:21:34.657664 | instance | Downloading pydantic-core (2.0MiB) 2026-09-17 21:21:34.657705 | instance | Downloading netaddr (2.2MiB) 2026-09-17 21:21:34.657741 | instance | Downloading rjsonnet (1.2MiB) 2026-09-17 21:21:34.657783 | instance | Downloading cryptography (4.2MiB) 2026-09-17 21:21:34.657820 | instance | Downloading netaddr (2.2MiB) 2026-09-17 21:21:34.657856 | instance | Downloading pydantic-core (2.0MiB) 2026-09-17 21:21:34.657892 | instance | Building pyperclip==1.9.0 2026-09-17 21:21:34.657927 | instance | Downloading rjsonnet 2026-09-17 21:21:34.657962 | instance | Downloading pygments (1.2MiB) 2026-09-17 21:21:34.657996 | instance | Downloading pydantic-core 2026-09-17 21:21:34.658031 | instance | Downloading netaddr 2026-09-17 21:21:34.658066 | instance | Downloading kubernetes (1.9MiB) 2026-09-17 21:21:34.658101 | instance | Downloading setuptools (1.1MiB) 2026-09-17 21:21:34.658136 | instance | Downloading ansible-core (2.1MiB) 2026-09-17 21:21:34.658171 | instance | Downloading cryptography 2026-09-17 21:21:34.658233 | instance | Downloading openstacksdk (1.7MiB) 2026-09-17 21:21:34.658269 | instance | Downloading pygments 2026-09-17 21:21:34.658303 | instance | Downloading setuptools 2026-09-17 21:21:34.658337 | instance | Downloading kubernetes 2026-09-17 21:21:34.658371 | instance | Downloading ansible-core 2026-09-17 21:21:34.658405 | instance | Downloading openstacksdk 2026-09-17 21:21:34.658438 | instance | Built pyperclip==1.9.0 2026-09-17 21:21:34.658488 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-09-17 21:21:34.658527 | instance | Installed 83 packages in 51ms 2026-09-17 21:21:34.658561 | instance | Checked out ansible.posix to 1.6.0 2026-09-17 21:21:34.658596 | 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-09-17 21:21:34.658631 | instance | Starting galaxy collection install process 2026-09-17 21:21:34.658665 | instance | Process install dependency map 2026-09-17 21:21:34.658701 | instance | Starting collection install process 2026-09-17 21:21:34.658736 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-09-17 21:21:34.658772 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix 2026-09-17 21:21:34.658807 | instance | ansible.posix:1.6.0 was installed successfully 2026-09-17 21:21:34.658843 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-17 21:21:34.658879 | instance | 2.17.12 2026-09-17 21:21:34.658913 | instance | Checked out ansible.utils to v6.1.1 2026-09-17 21:21:34.658948 | 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-09-17 21:21:34.658982 | instance | Starting galaxy collection install process 2026-09-17 21:21:34.659016 | instance | Process install dependency map 2026-09-17 21:21:34.659050 | instance | Starting collection install process 2026-09-17 21:21:34.659084 | instance | Installing 'ansible.utils:6.1.1' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils' 2026-09-17 21:21:34.659117 | instance | Created collection for ansible.utils:6.1.1 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils 2026-09-17 21:21:34.659150 | instance | ansible.utils:6.1.1 was installed successfully 2026-09-17 21:21:34.659201 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-17 21:21:34.659237 | instance | 2.17.12 2026-09-17 21:21:34.659270 | instance | Checked out atmosphere.common to v0.7.1 2026-09-17 21:21:34.659304 | 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-09-17 21:21:34.659339 | instance | Starting galaxy collection install process 2026-09-17 21:21:34.659373 | instance | Process install dependency map 2026-09-17 21:21:34.659407 | instance | Starting collection install process 2026-09-17 21:21:34.659441 | instance | Installing 'atmosphere.common:0.7.1' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common' 2026-09-17 21:21:34.659475 | instance | Created collection for atmosphere.common:0.7.1 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common 2026-09-17 21:21:34.659509 | instance | atmosphere.common:0.7.1 was installed successfully 2026-09-17 21:21:34.659543 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-17 21:21:34.659576 | instance | 2.17.12 2026-09-17 21:21:34.659609 | instance | Checked out community.crypto to 2.2.3 2026-09-17 21:21:34.659644 | 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-09-17 21:21:34.659678 | instance | Starting galaxy collection install process 2026-09-17 21:21:34.659713 | instance | Process install dependency map 2026-09-17 21:21:34.659747 | instance | Starting collection install process 2026-09-17 21:21:34.659781 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-09-17 21:21:34.659825 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto 2026-09-17 21:21:34.659861 | instance | community.crypto:2.2.3 was installed successfully 2026-09-17 21:21:34.659897 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-17 21:21:34.659932 | instance | 2.17.12 2026-09-17 21:21:34.659967 | instance | Checked out community.general to 7.3.0 2026-09-17 21:21:34.660002 | 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-09-17 21:21:34.660041 | instance | Starting galaxy collection install process 2026-09-17 21:21:34.660076 | instance | Process install dependency map 2026-09-17 21:21:34.660111 | instance | Starting collection install process 2026-09-17 21:21:34.660147 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-09-17 21:21:34.660198 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general 2026-09-17 21:21:34.660235 | instance | community.general:7.3.0 was installed successfully 2026-09-17 21:21:34.660269 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-17 21:21:34.660302 | instance | 2.17.12 2026-09-17 21:21:34.660336 | instance | Checked out community.mysql to 3.6.0 2026-09-17 21:21:34.660370 | 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-09-17 21:21:34.660405 | instance | Starting galaxy collection install process 2026-09-17 21:21:34.660439 | instance | Process install dependency map 2026-09-17 21:21:34.660473 | instance | Starting collection install process 2026-09-17 21:21:34.660554 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql' 2026-09-17 21:21:34.660617 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql 2026-09-17 21:21:34.660670 | instance | community.mysql:3.6.0 was installed successfully 2026-09-17 21:21:34.660708 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-17 21:21:34.660743 | instance | 2.17.12 2026-09-17 21:21:34.660777 | instance | Checked out kubernetes.core to 2.4.0 2026-09-17 21:21:34.660811 | 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-09-17 21:21:34.660845 | instance | Starting galaxy collection install process 2026-09-17 21:21:34.660879 | instance | Process install dependency map 2026-09-17 21:21:34.660913 | instance | Starting collection install process 2026-09-17 21:21:34.660947 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core' 2026-09-17 21:21:34.660981 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core 2026-09-17 21:21:34.661015 | instance | kubernetes.core:2.4.0 was installed successfully 2026-09-17 21:21:34.661049 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-17 21:21:34.661082 | instance | 2.17.12 2026-09-17 21:21:34.661114 | instance | Checked out openstack.cloud to 2.6.0 2026-09-17 21:21:34.661148 | 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-09-17 21:21:34.661207 | instance | Starting galaxy collection install process 2026-09-17 21:21:34.661245 | instance | Process install dependency map 2026-09-17 21:21:34.661291 | instance | Starting collection install process 2026-09-17 21:21:34.661327 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud' 2026-09-17 21:21:34.661361 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud 2026-09-17 21:21:34.661395 | instance | openstack.cloud:2.6.0 was installed successfully 2026-09-17 21:21:34.661429 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-17 21:21:34.661463 | instance | 2.17.12 2026-09-17 21:21:34.661496 | instance | Checked out vexxhost.ceph to v4.2.0 2026-09-17 21:21:34.661530 | 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-09-17 21:21:34.661563 | instance | Starting galaxy collection install process 2026-09-17 21:21:34.661597 | instance | Process install dependency map 2026-09-17 21:21:34.661631 | instance | Starting collection install process 2026-09-17 21:21:34.661665 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph' 2026-09-17 21:21:34.661699 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph 2026-09-17 21:21:34.661732 | instance | vexxhost.ceph:4.2.0 was installed successfully 2026-09-17 21:21:34.661765 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-17 21:21:34.661798 | instance | 2.17.12 2026-09-17 21:21:34.661832 | instance | Checked out vexxhost.containers to v1.6.8 2026-09-17 21:21:34.661866 | 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-09-17 21:21:34.661900 | instance | Starting galaxy collection install process 2026-09-17 21:21:34.661933 | instance | Process install dependency map 2026-09-17 21:21:34.661967 | instance | Starting collection install process 2026-09-17 21:21:34.662001 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers' 2026-09-17 21:21:34.662034 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers 2026-09-17 21:21:34.662067 | instance | vexxhost.containers:1.6.8 was installed successfully 2026-09-17 21:21:34.662100 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-17 21:21:34.662133 | instance | 2.17.12 2026-09-17 21:21:34.662168 | instance | Checked out vexxhost.kubernetes to v3.4.0 2026-09-17 21:21:34.662225 | 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-09-17 21:21:34.662260 | instance | Starting galaxy collection install process 2026-09-17 21:21:34.662293 | instance | Process install dependency map 2026-09-17 21:21:34.662326 | instance | Starting collection install process 2026-09-17 21:21:34.662360 | instance | Installing 'vexxhost.kubernetes:3.4.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes' 2026-09-17 21:21:34.662393 | instance | Created collection for vexxhost.kubernetes:3.4.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes 2026-09-17 21:21:34.662427 | instance | vexxhost.kubernetes:3.4.0 was installed successfully 2026-09-17 21:21:34.662461 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-17 21:21:34.662494 | instance | 2.17.12 2026-09-17 21:21:34.673415 | 2026-09-17 21:21:34.673512 | PLAY RECAP 2026-09-17 21:21:34.673597 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-17 21:21:34.673651 | 2026-09-17 21:21:34.873887 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-09-17 21:21:34.887231 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-09-17 21:21:35.520065 | 2026-09-17 21:21:35.520234 | PLAY [all] 2026-09-17 21:21:35.531746 | 2026-09-17 21:21:35.531841 | TASK [Install "jq" for log collection] 2026-09-17 21:21:44.957689 | instance | changed 2026-09-17 21:21:44.961537 | 2026-09-17 21:21:44.961700 | PLAY RECAP 2026-09-17 21:21:44.961874 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-17 21:21:44.962016 | 2026-09-17 21:21:45.102529 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-09-17 21:21:45.114442 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-09-17 21:21:45.735406 | 2026-09-17 21:21:45.735511 | PLAY [all] 2026-09-17 21:21:45.745924 | 2026-09-17 21:21:45.745990 | LOOP [Check inventory directories] 2026-09-17 21:21:46.097400 | instance | ok: "src/github.com/vexxhost/atmosphere" 2026-09-17 21:21:46.240146 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/aio/inventory" 2026-09-17 21:21:46.411568 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/aio/inventory" 2026-09-17 21:21:46.425482 | 2026-09-17 21:21:46.425763 | LOOP [Copy inventory file for Zuul] 2026-09-17 21:21:47.277779 | instance | changed: 2026-09-17 21:21:47.278106 | instance | { 2026-09-17 21:21:47.278182 | instance | "ansible_loop_var": "item", 2026-09-17 21:21:47.278231 | instance | "changed": false, 2026-09-17 21:21:47.278270 | instance | "failed": false, 2026-09-17 21:21:47.278310 | instance | "invocation": { 2026-09-17 21:21:47.278345 | instance | "module_args": { 2026-09-17 21:21:47.278379 | instance | "checksum_algorithm": "sha1", 2026-09-17 21:21:47.278413 | instance | "follow": true, 2026-09-17 21:21:47.278446 | instance | "get_attributes": true, 2026-09-17 21:21:47.278482 | instance | "get_checksum": true, 2026-09-17 21:21:47.278516 | instance | "get_mime": true, 2026-09-17 21:21:47.278549 | instance | "path": "src/github.com/vexxhost/atmosphere" 2026-09-17 21:21:47.278584 | instance | } 2026-09-17 21:21:47.278616 | instance | }, 2026-09-17 21:21:47.278649 | instance | "item": "src/github.com/vexxhost/atmosphere", 2026-09-17 21:21:47.278681 | instance | "stat": { 2026-09-17 21:21:47.278714 | instance | "atime": 1789680087.155593, 2026-09-17 21:21:47.278747 | instance | "attr_flags": "e", 2026-09-17 21:21:47.278780 | instance | "attributes": [ 2026-09-17 21:21:47.278829 | instance | "extents" 2026-09-17 21:21:47.278883 | instance | ], 2026-09-17 21:21:47.278935 | instance | "block_size": 4096, 2026-09-17 21:21:47.278972 | instance | "blocks": 8, 2026-09-17 21:21:47.279005 | instance | "charset": "unknown", 2026-09-17 21:21:47.279042 | instance | "ctime": 1789680086.0795872, 2026-09-17 21:21:47.279076 | instance | "dev": 64513, 2026-09-17 21:21:47.279108 | instance | "device_type": 0, 2026-09-17 21:21:47.279140 | instance | "executable": true, 2026-09-17 21:21:47.279194 | instance | "exists": true, 2026-09-17 21:21:47.279229 | instance | "gid": 1000, 2026-09-17 21:21:47.279261 | instance | "gr_name": "zuul", 2026-09-17 21:21:47.279294 | instance | "inode": 1570830, 2026-09-17 21:21:47.279326 | instance | "isblk": false, 2026-09-17 21:21:47.279359 | instance | "ischr": false, 2026-09-17 21:21:47.279391 | instance | "isdir": true, 2026-09-17 21:21:47.279423 | instance | "isfifo": false, 2026-09-17 21:21:47.279455 | instance | "isgid": false, 2026-09-17 21:21:47.279486 | instance | "islnk": false, 2026-09-17 21:21:47.279518 | instance | "isreg": false, 2026-09-17 21:21:47.279549 | instance | "issock": false, 2026-09-17 21:21:47.279602 | instance | "isuid": false, 2026-09-17 21:21:47.279636 | instance | "mimetype": "unknown", 2026-09-17 21:21:47.279669 | instance | "mode": "0755", 2026-09-17 21:21:47.279700 | instance | "mtime": 1789680086.0795872, 2026-09-17 21:21:47.279732 | instance | "nlink": 23, 2026-09-17 21:21:47.279763 | instance | "path": "src/github.com/vexxhost/atmosphere", 2026-09-17 21:21:47.279795 | instance | "pw_name": "zuul", 2026-09-17 21:21:47.279829 | instance | "readable": true, 2026-09-17 21:21:47.279862 | instance | "rgrp": true, 2026-09-17 21:21:47.279894 | instance | "roth": true, 2026-09-17 21:21:47.279927 | instance | "rusr": true, 2026-09-17 21:21:47.279959 | instance | "size": 4096, 2026-09-17 21:21:47.279991 | instance | "uid": 1000, 2026-09-17 21:21:47.280023 | instance | "version": "684199559", 2026-09-17 21:21:47.280056 | instance | "wgrp": false, 2026-09-17 21:21:47.280091 | instance | "woth": false, 2026-09-17 21:21:47.280123 | instance | "writeable": true, 2026-09-17 21:21:47.280155 | instance | "wusr": true, 2026-09-17 21:21:47.280214 | instance | "xgrp": true, 2026-09-17 21:21:47.280248 | instance | "xoth": true, 2026-09-17 21:21:47.280280 | instance | "xusr": true 2026-09-17 21:21:47.280313 | instance | } 2026-09-17 21:21:47.280349 | instance | } 2026-09-17 21:21:47.280422 | instance | ok: All items complete 2026-09-17 21:21:47.280464 | 2026-09-17 21:21:47.282999 | instance | skipping: Conditional result was False 2026-09-17 21:21:47.284331 | instance | skipping: Conditional result was False 2026-09-17 21:21:47.310588 | 2026-09-17 21:21:47.310846 | LOOP [Switch "ansible_host" to private IP] 2026-09-17 21:21:47.720455 | instance | changed: 1 replacements made 2026-09-17 21:21:47.722842 | instance | skipping: Conditional result was False 2026-09-17 21:21:47.733790 | instance | skipping: Conditional result was False 2026-09-17 21:21:47.751474 | 2026-09-17 21:21:47.751759 | TASK [Run Molecule scenario] 2026-09-17 21:21:48.666221 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-09-17 21:21:49.093322 | instance | INFO [aio > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-09-17 21:21:49.093428 | instance | INFO [aio > prerun] Performing prerun with role_name_check=0... 2026-09-17 21:22:00.430794 | instance | INFO [aio > dependency] Executing 2026-09-17 21:22:00.431136 | instance | WARNING [aio > dependency] Missing roles requirements file: requirements.yml 2026-09-17 21:22:00.431536 | instance | WARNING [aio > dependency] Missing collections requirements file: collections.yml 2026-09-17 21:22:00.431786 | instance | WARNING [aio > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-09-17 21:22:00.446380 | instance | INFO [aio > cleanup] Executing 2026-09-17 21:22:00.447100 | instance | WARNING [aio > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-09-17 21:22:00.461260 | instance | INFO [aio > destroy] Executing 2026-09-17 21:22:00.461356 | instance | WARNING [aio > destroy] Skipping, '--destroy=never' requested. 2026-09-17 21:22:00.461452 | instance | INFO [aio > destroy] Executed: Successful 2026-09-17 21:22:00.470471 | instance | INFO [aio > syntax] Executing 2026-09-17 21:22:03.213737 | instance | 2026-09-17 21:22:03.214103 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/aio/converge.yml 2026-09-17 21:22:03.364543 | instance | INFO [aio > syntax] Executed: Successful 2026-09-17 21:22:03.389307 | instance | INFO [aio > create] Executing 2026-09-17 21:22:03.394997 | instance | WARNING [aio > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-09-17 21:22:03.409107 | instance | INFO [aio > prepare] Executing 2026-09-17 21:22:04.319334 | instance | 2026-09-17 21:22:04.319448 | instance | PLAY [Prepare] ***************************************************************** 2026-09-17 21:22:04.319830 | instance | 2026-09-17 21:22:04.320077 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-17 21:22:04.320314 | instance | Thursday 17 September 2026 21:22:04 +0000 (0:00:00.024) 0:00:00.024 **** 2026-09-17 21:22:05.499034 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-09-17 21:22:05.499253 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-09-17 21:22:05.499496 | instance | interpreter could change the meaning of that path. See 2026-09-17 21:22:05.499764 | instance | https://docs.ansible.com/ansible- 2026-09-17 21:22:05.500003 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-09-17 21:22:05.507303 | instance | ok: [instance] 2026-09-17 21:22:05.507520 | instance | 2026-09-17 21:22:05.507853 | instance | TASK [Configure short hostname] ************************************************ 2026-09-17 21:22:05.508128 | instance | Thursday 17 September 2026 21:22:05 +0000 (0:00:01.188) 0:00:01.213 **** 2026-09-17 21:22:06.255699 | instance | changed: [instance] 2026-09-17 21:22:06.255897 | instance | 2026-09-17 21:22:06.256137 | instance | TASK [Ensure hostname inside hosts file] *************************************** 2026-09-17 21:22:06.256384 | instance | Thursday 17 September 2026 21:22:06 +0000 (0:00:00.748) 0:00:01.962 **** 2026-09-17 21:22:06.554201 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created 2026-09-17 21:22:06.554433 | instance | with a mode of 0700, this may cause issues when running as another user. To 2026-09-17 21:22:06.554711 | instance | avoid this, create the remote_tmp dir with the correct permissions manually 2026-09-17 21:22:06.560778 | instance | changed: [instance] 2026-09-17 21:22:06.560985 | instance | 2026-09-17 21:22:06.561233 | instance | TASK [Install "dirmngr" for GPG keyserver operations] ************************** 2026-09-17 21:22:06.561475 | instance | Thursday 17 September 2026 21:22:06 +0000 (0:00:00.305) 0:00:02.267 **** 2026-09-17 21:22:07.841261 | instance | ok: [instance] 2026-09-17 21:22:07.841620 | instance | 2026-09-17 21:22:07.841728 | instance | TASK [Purge "snapd" package] *************************************************** 2026-09-17 21:22:07.841918 | instance | Thursday 17 September 2026 21:22:07 +0000 (0:00:01.279) 0:00:03.547 **** 2026-09-17 21:22:08.506524 | instance | ok: [instance] 2026-09-17 21:22:08.506735 | instance | 2026-09-17 21:22:08.507032 | instance | PLAY [Generate workspace for Atmosphere] *************************************** 2026-09-17 21:22:08.507244 | instance | 2026-09-17 21:22:08.507488 | instance | TASK [Create folders for workspace] ******************************************** 2026-09-17 21:22:08.507743 | instance | Thursday 17 September 2026 21:22:08 +0000 (0:00:00.665) 0:00:04.212 **** 2026-09-17 21:22:09.527554 | instance | changed: [localhost] => (item=group_vars) 2026-09-17 21:22:09.527959 | instance | changed: [localhost] => (item=group_vars/all) 2026-09-17 21:22:09.530680 | instance | changed: [localhost] => (item=group_vars/controllers) 2026-09-17 21:22:09.530711 | instance | changed: [localhost] => (item=group_vars/cephs) 2026-09-17 21:22:09.530726 | instance | changed: [localhost] => (item=group_vars/computes) 2026-09-17 21:22:09.530739 | instance | changed: [localhost] => (item=host_vars) 2026-09-17 21:22:09.530752 | instance | 2026-09-17 21:22:09.530764 | instance | PLAY [Generate Ceph control plane configuration for workspace] ***************** 2026-09-17 21:22:09.530777 | instance | 2026-09-17 21:22:09.530789 | instance | TASK [Ensure the Ceph control plane configuration file exists] ***************** 2026-09-17 21:22:09.530800 | instance | Thursday 17 September 2026 21:22:09 +0000 (0:00:01.021) 0:00:05.233 **** 2026-09-17 21:22:09.711912 | instance | changed: [localhost] 2026-09-17 21:22:09.712272 | instance | 2026-09-17 21:22:09.712588 | instance | TASK [Load the current Ceph control plane configuration into a variable] ******* 2026-09-17 21:22:09.712883 | instance | Thursday 17 September 2026 21:22:09 +0000 (0:00:00.183) 0:00:05.417 **** 2026-09-17 21:22:09.743912 | instance | ok: [localhost] 2026-09-17 21:22:09.744303 | instance | 2026-09-17 21:22:09.744648 | instance | TASK [Generate Ceph control plane values for missing variables] **************** 2026-09-17 21:22:09.744959 | instance | Thursday 17 September 2026 21:22:09 +0000 (0:00:00.030) 0:00:05.448 **** 2026-09-17 21:22:09.811761 | instance | ok: [localhost] => (item={'key': 'ceph_fsid', 'value': '86e45327-e915-555c-9e85-3726444f2c86'}) 2026-09-17 21:22:09.812042 | instance | ok: [localhost] => (item={'key': 'ceph_mon_public_network', 'value': '10.96.240.0/24'}) 2026-09-17 21:22:09.812379 | instance | 2026-09-17 21:22:09.812703 | instance | TASK [Write new Ceph control plane configuration file to disk] ***************** 2026-09-17 21:22:09.813067 | instance | Thursday 17 September 2026 21:22:09 +0000 (0:00:00.068) 0:00:05.517 **** 2026-09-17 21:22:10.414792 | instance | changed: [localhost] 2026-09-17 21:22:10.416236 | instance | 2026-09-17 21:22:10.416316 | instance | PLAY [Generate Ceph OSD configuration for workspace] *************************** 2026-09-17 21:22:10.416328 | instance | 2026-09-17 21:22:10.416337 | instance | TASK [Ensure the Ceph OSDs configuration file exists] ************************** 2026-09-17 21:22:10.416346 | instance | Thursday 17 September 2026 21:22:10 +0000 (0:00:00.603) 0:00:06.120 **** 2026-09-17 21:22:10.606142 | instance | changed: [localhost] 2026-09-17 21:22:10.606814 | instance | 2026-09-17 21:22:10.606902 | instance | TASK [Load the current Ceph OSDs configuration into a variable] **************** 2026-09-17 21:22:10.606915 | instance | Thursday 17 September 2026 21:22:10 +0000 (0:00:00.191) 0:00:06.312 **** 2026-09-17 21:22:10.637206 | instance | ok: [localhost] 2026-09-17 21:22:10.637766 | instance | 2026-09-17 21:22:10.637833 | instance | TASK [Generate Ceph OSDs values for missing variables] ************************* 2026-09-17 21:22:10.637842 | instance | Thursday 17 September 2026 21:22:10 +0000 (0:00:00.031) 0:00:06.343 **** 2026-09-17 21:22:10.672799 | instance | ok: [localhost] => (item={'key': 'ceph_osd_devices', 'value': ['/dev/vdb', '/dev/vdc', '/dev/vdd']}) 2026-09-17 21:22:10.672945 | instance | 2026-09-17 21:22:10.673210 | instance | TASK [Write new Ceph OSDs configuration file to disk] ************************** 2026-09-17 21:22:10.673542 | instance | Thursday 17 September 2026 21:22:10 +0000 (0:00:00.035) 0:00:06.378 **** 2026-09-17 21:22:11.044143 | instance | changed: [localhost] 2026-09-17 21:22:11.044427 | instance | 2026-09-17 21:22:11.044859 | instance | PLAY [Generate Kubernetes configuration for workspace] ************************* 2026-09-17 21:22:11.045150 | instance | 2026-09-17 21:22:11.045444 | instance | TASK [Ensure the Kubernetes configuration file exists] ************************* 2026-09-17 21:22:11.045801 | instance | Thursday 17 September 2026 21:22:11 +0000 (0:00:00.371) 0:00:06.750 **** 2026-09-17 21:22:11.219458 | instance | changed: [localhost] 2026-09-17 21:22:11.219663 | instance | 2026-09-17 21:22:11.219811 | instance | TASK [Load the current Kubernetes configuration into a variable] *************** 2026-09-17 21:22:11.219955 | instance | Thursday 17 September 2026 21:22:11 +0000 (0:00:00.174) 0:00:06.925 **** 2026-09-17 21:22:11.243630 | instance | ok: [localhost] 2026-09-17 21:22:11.243860 | instance | 2026-09-17 21:22:11.244039 | instance | TASK [Generate Kubernetes values for missing variables] ************************ 2026-09-17 21:22:11.244211 | instance | Thursday 17 September 2026 21:22:11 +0000 (0:00:00.023) 0:00:06.948 **** 2026-09-17 21:22:11.307205 | instance | ok: [localhost] => (item={'key': 'kubernetes_hostname', 'value': '10.96.240.10'}) 2026-09-17 21:22:11.307393 | instance | ok: [localhost] => (item={'key': 'kubernetes_keepalived_vrid', 'value': 42}) 2026-09-17 21:22:11.307581 | instance | ok: [localhost] => (item={'key': 'kubernetes_keepalived_vip', 'value': '10.96.240.10'}) 2026-09-17 21:22:11.307745 | instance | 2026-09-17 21:22:11.307909 | instance | TASK [Write new Kubernetes configuration file to disk] ************************* 2026-09-17 21:22:11.308073 | instance | Thursday 17 September 2026 21:22:11 +0000 (0:00:00.063) 0:00:07.011 **** 2026-09-17 21:22:11.709932 | instance | changed: [localhost] 2026-09-17 21:22:11.711036 | instance | 2026-09-17 21:22:11.711094 | instance | PLAY [Generate Keepalived configuration for workspace] ************************* 2026-09-17 21:22:11.711101 | instance | 2026-09-17 21:22:11.711106 | instance | TASK [Ensure the Keeaplived configuration file exists] ************************* 2026-09-17 21:22:11.711116 | instance | Thursday 17 September 2026 21:22:11 +0000 (0:00:00.404) 0:00:07.416 **** 2026-09-17 21:22:11.895557 | instance | changed: [localhost] 2026-09-17 21:22:11.895618 | instance | 2026-09-17 21:22:11.895625 | instance | TASK [Load the current Keepalived configuration into a variable] *************** 2026-09-17 21:22:11.895631 | instance | Thursday 17 September 2026 21:22:11 +0000 (0:00:00.185) 0:00:07.601 **** 2026-09-17 21:22:11.926867 | instance | ok: [localhost] 2026-09-17 21:22:11.927177 | instance | 2026-09-17 21:22:11.927543 | instance | TASK [Generate Keepalived values for missing variables] ************************ 2026-09-17 21:22:11.927936 | instance | Thursday 17 September 2026 21:22:11 +0000 (0:00:00.031) 0:00:07.632 **** 2026-09-17 21:22:11.977654 | instance | ok: [localhost] => (item={'key': 'keepalived_interface', 'value': 'br-ex'}) 2026-09-17 21:22:11.977961 | instance | ok: [localhost] => (item={'key': 'keepalived_vip', 'value': '10.96.250.10'}) 2026-09-17 21:22:11.978345 | instance | 2026-09-17 21:22:11.978755 | instance | TASK [Write new Keepalived configuration file to disk] ************************* 2026-09-17 21:22:11.979173 | instance | Thursday 17 September 2026 21:22:11 +0000 (0:00:00.050) 0:00:07.683 **** 2026-09-17 21:22:12.345212 | instance | changed: [localhost] 2026-09-17 21:22:12.346714 | instance | 2026-09-17 21:22:12.346749 | instance | PLAY [Generate endpoints for workspace] **************************************** 2026-09-17 21:22:12.346764 | instance | 2026-09-17 21:22:12.346775 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-17 21:22:12.346787 | instance | Thursday 17 September 2026 21:22:12 +0000 (0:00:00.367) 0:00:08.051 **** 2026-09-17 21:22:13.090922 | instance | ok: [localhost] 2026-09-17 21:22:13.091028 | instance | 2026-09-17 21:22:13.091627 | instance | TASK [Ensure the endpoints file exists] **************************************** 2026-09-17 21:22:13.091695 | instance | Thursday 17 September 2026 21:22:13 +0000 (0:00:00.745) 0:00:08.796 **** 2026-09-17 21:22:13.249915 | instance | changed: [localhost] 2026-09-17 21:22:13.250064 | instance | 2026-09-17 21:22:13.250572 | instance | TASK [Load the current endpoints into a variable] ****************************** 2026-09-17 21:22:13.250909 | instance | Thursday 17 September 2026 21:22:13 +0000 (0:00:00.159) 0:00:08.955 **** 2026-09-17 21:22:13.286680 | instance | ok: [localhost] 2026-09-17 21:22:13.287662 | instance | 2026-09-17 21:22:13.287715 | instance | TASK [Generate endpoint skeleton for missing variables] ************************ 2026-09-17 21:22:13.287727 | instance | Thursday 17 September 2026 21:22:13 +0000 (0:00:00.036) 0:00:08.992 **** 2026-09-17 21:22:13.985227 | instance | ok: [localhost] => (item=keycloak_host) 2026-09-17 21:22:13.985342 | instance | ok: [localhost] => (item=kube_prometheus_stack_grafana_host) 2026-09-17 21:22:13.985354 | instance | ok: [localhost] => (item=kube_prometheus_stack_alertmanager_host) 2026-09-17 21:22:13.985527 | instance | ok: [localhost] => (item=kube_prometheus_stack_prometheus_host) 2026-09-17 21:22:13.985769 | instance | ok: [localhost] => (item=openstack_helm_endpoints_region_name) 2026-09-17 21:22:13.985937 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_api_host) 2026-09-17 21:22:13.986101 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_api_host) 2026-09-17 21:22:13.986263 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_api_host) 2026-09-17 21:22:13.986430 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_api_host) 2026-09-17 21:22:13.986607 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_api_host) 2026-09-17 21:22:13.986773 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_api_host) 2026-09-17 21:22:13.986956 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_api_host) 2026-09-17 21:22:13.987129 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_novnc_host) 2026-09-17 21:22:13.987297 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_api_host) 2026-09-17 21:22:13.987459 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_api_host) 2026-09-17 21:22:13.987646 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_api_host) 2026-09-17 21:22:13.987810 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_api_host) 2026-09-17 21:22:13.987977 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_registry_host) 2026-09-17 21:22:13.988139 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_api_host) 2026-09-17 21:22:13.988302 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_cfn_api_host) 2026-09-17 21:22:13.988467 | instance | ok: [localhost] => (item=openstack_helm_endpoints_horizon_api_host) 2026-09-17 21:22:13.988651 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rgw_host) 2026-09-17 21:22:13.988816 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_api_host) 2026-09-17 21:22:13.988970 | instance | 2026-09-17 21:22:13.989133 | instance | TASK [Write new endpoints file to disk] **************************************** 2026-09-17 21:22:13.989297 | instance | Thursday 17 September 2026 21:22:13 +0000 (0:00:00.698) 0:00:09.691 **** 2026-09-17 21:22:14.366698 | instance | changed: [localhost] 2026-09-17 21:22:14.367158 | instance | 2026-09-17 21:22:14.367531 | instance | TASK [Ensure the endpoints file exists] **************************************** 2026-09-17 21:22:14.367931 | instance | Thursday 17 September 2026 21:22:14 +0000 (0:00:00.378) 0:00:10.070 **** 2026-09-17 21:22:14.657235 | instance | changed: [localhost] 2026-09-17 21:22:14.657321 | instance | 2026-09-17 21:22:14.657339 | instance | PLAY [Generate Neutron configuration for workspace] **************************** 2026-09-17 21:22:14.657353 | instance | 2026-09-17 21:22:14.657368 | instance | TASK [Ensure the Neutron configuration file exists] **************************** 2026-09-17 21:22:14.657380 | instance | Thursday 17 September 2026 21:22:14 +0000 (0:00:00.291) 0:00:10.361 **** 2026-09-17 21:22:14.854094 | instance | changed: [localhost] 2026-09-17 21:22:14.854162 | instance | 2026-09-17 21:22:14.854170 | instance | TASK [Load the current Neutron configuration into a variable] ****************** 2026-09-17 21:22:14.854177 | instance | Thursday 17 September 2026 21:22:14 +0000 (0:00:00.198) 0:00:10.559 **** 2026-09-17 21:22:14.888152 | instance | ok: [localhost] 2026-09-17 21:22:14.888511 | instance | 2026-09-17 21:22:14.888871 | instance | TASK [Generate Neutron values for missing variables] *************************** 2026-09-17 21:22:14.889183 | instance | Thursday 17 September 2026 21:22:14 +0000 (0:00:00.034) 0:00:10.594 **** 2026-09-17 21:22:14.943121 | instance | ok: [localhost] => (item={'key': 'neutron_networks', 'value': [{'name': 'public', 'external': True, 'shared': True, 'mtu_size': 1500, 'port_security_enabled': True, 'provider_network_type': 'flat', 'provider_physical_network': 'external', 'subnets': [{'name': 'public-subnet', 'cidr': '10.96.250.0/24', 'gateway_ip': '10.96.250.10', 'allocation_pool_start': '10.96.250.200', 'allocation_pool_end': '10.96.250.220', 'enable_dhcp': True}]}]}) 2026-09-17 21:22:14.943577 | instance | 2026-09-17 21:22:14.943973 | instance | TASK [Write new Neutron configuration file to disk] **************************** 2026-09-17 21:22:14.944354 | instance | Thursday 17 September 2026 21:22:14 +0000 (0:00:00.054) 0:00:10.649 **** 2026-09-17 21:22:15.345279 | instance | changed: [localhost] 2026-09-17 21:22:15.345346 | instance | 2026-09-17 21:22:15.345362 | instance | PLAY [Generate Nova configuration for workspace] ******************************* 2026-09-17 21:22:15.345375 | instance | 2026-09-17 21:22:15.345388 | instance | TASK [Ensure the Nova configuration file exists] ******************************* 2026-09-17 21:22:15.345401 | instance | Thursday 17 September 2026 21:22:15 +0000 (0:00:00.400) 0:00:11.049 **** 2026-09-17 21:22:15.529813 | instance | changed: [localhost] 2026-09-17 21:22:15.529859 | instance | 2026-09-17 21:22:15.529869 | instance | TASK [Load the current Nova configuration into a variable] ********************* 2026-09-17 21:22:15.529879 | instance | Thursday 17 September 2026 21:22:15 +0000 (0:00:00.186) 0:00:11.236 **** 2026-09-17 21:22:15.561170 | instance | ok: [localhost] 2026-09-17 21:22:15.561201 | instance | 2026-09-17 21:22:15.561211 | instance | TASK [Generate Nova values for missing variables] ****************************** 2026-09-17 21:22:15.561220 | instance | Thursday 17 September 2026 21:22:15 +0000 (0:00:00.031) 0:00:11.267 **** 2026-09-17 21:22:15.602980 | instance | ok: [localhost] => (item={'key': 'nova_flavors', 'value': [{'name': 'm1.tiny', 'ram': 512, 'disk': 1, 'vcpus': 1}, {'name': 'm1.small', 'ram': 2048, 'disk': 20, 'vcpus': 1}, {'name': 'm1.medium', 'ram': 4096, 'disk': 40, 'vcpus': 2}, {'name': 'm1.large', 'ram': 8192, 'disk': 80, 'vcpus': 4}, {'name': 'm1.xlarge', 'ram': 16384, 'disk': 160, 'vcpus': 8}]}) 2026-09-17 21:22:15.603071 | instance | 2026-09-17 21:22:15.603078 | instance | TASK [Write new Nova configuration file to disk] ******************************* 2026-09-17 21:22:15.603092 | instance | Thursday 17 September 2026 21:22:15 +0000 (0:00:00.040) 0:00:11.308 **** 2026-09-17 21:22:15.975529 | instance | changed: [localhost] 2026-09-17 21:22:15.975682 | instance | 2026-09-17 21:22:15.975966 | instance | PLAY [Generate secrets for workspace] ****************************************** 2026-09-17 21:22:15.976176 | instance | 2026-09-17 21:22:15.976407 | instance | TASK [Ensure the secrets file exists] ****************************************** 2026-09-17 21:22:15.976689 | instance | Thursday 17 September 2026 21:22:15 +0000 (0:00:00.373) 0:00:11.681 **** 2026-09-17 21:22:16.144538 | instance | changed: [localhost] 2026-09-17 21:22:16.144706 | instance | 2026-09-17 21:22:16.144993 | instance | TASK [Load the current secrets into a variable] ******************************** 2026-09-17 21:22:16.145237 | instance | Thursday 17 September 2026 21:22:16 +0000 (0:00:00.168) 0:00:11.850 **** 2026-09-17 21:22:16.175913 | instance | ok: [localhost] 2026-09-17 21:22:16.176231 | instance | 2026-09-17 21:22:16.176513 | instance | TASK [Generate secrets for missing variables] ********************************** 2026-09-17 21:22:16.176770 | instance | Thursday 17 September 2026 21:22:16 +0000 (0:00:00.032) 0:00:11.882 **** 2026-09-17 21:22:16.546991 | instance | ok: [localhost] => (item=heat_auth_encryption_key) 2026-09-17 21:22:16.547075 | instance | ok: [localhost] => (item=keepalived_password) 2026-09-17 21:22:16.547091 | instance | ok: [localhost] => (item=keycloak_admin_password) 2026-09-17 21:22:16.547104 | instance | ok: [localhost] => (item=keycloak_database_password) 2026-09-17 21:22:16.547117 | instance | ok: [localhost] => (item=keystone_keycloak_client_secret) 2026-09-17 21:22:16.547128 | instance | ok: [localhost] => (item=keystone_oidc_crypto_passphrase) 2026-09-17 21:22:16.547136 | instance | ok: [localhost] => (item=kube_prometheus_stack_grafana_admin_password) 2026-09-17 21:22:16.547152 | instance | ok: [localhost] => (item=octavia_heartbeat_key) 2026-09-17 21:22:16.547641 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rabbitmq_admin_password) 2026-09-17 21:22:16.547687 | instance | ok: [localhost] => (item=openstack_helm_endpoints_memcached_secret_key) 2026-09-17 21:22:16.548779 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_admin_password) 2026-09-17 21:22:16.548810 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_mariadb_password) 2026-09-17 21:22:16.548842 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_rabbitmq_password) 2026-09-17 21:22:16.549915 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_keystone_password) 2026-09-17 21:22:16.549948 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_mariadb_password) 2026-09-17 21:22:16.549963 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_rabbitmq_password) 2026-09-17 21:22:16.549976 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_keystone_password) 2026-09-17 21:22:16.550074 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_mariadb_password) 2026-09-17 21:22:16.550385 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_rabbitmq_password) 2026-09-17 21:22:16.550704 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_keystone_password) 2026-09-17 21:22:16.551095 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_mariadb_password) 2026-09-17 21:22:16.551402 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_keystone_password) 2026-09-17 21:22:16.551714 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_mariadb_password) 2026-09-17 21:22:16.552008 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_keystone_password) 2026-09-17 21:22:16.552341 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_mariadb_password) 2026-09-17 21:22:16.552668 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_rabbitmq_password) 2026-09-17 21:22:16.552959 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_metadata_secret) 2026-09-17 21:22:16.553270 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_keystone_password) 2026-09-17 21:22:16.553605 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_mariadb_password) 2026-09-17 21:22:16.553901 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_rabbitmq_password) 2026-09-17 21:22:16.554185 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_keystone_password) 2026-09-17 21:22:16.554514 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_mariadb_password) 2026-09-17 21:22:16.554869 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_rabbitmq_password) 2026-09-17 21:22:16.555187 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_keystone_password) 2026-09-17 21:22:16.555485 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_mariadb_password) 2026-09-17 21:22:16.555837 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_rabbitmq_password) 2026-09-17 21:22:16.556140 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_keystone_password) 2026-09-17 21:22:16.556432 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_mariadb_password) 2026-09-17 21:22:16.556796 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_rabbitmq_password) 2026-09-17 21:22:16.557095 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_keystone_password) 2026-09-17 21:22:16.557384 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_mariadb_password) 2026-09-17 21:22:16.557697 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_rabbitmq_password) 2026-09-17 21:22:16.558194 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_keystone_password) 2026-09-17 21:22:16.558496 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_trustee_keystone_password) 2026-09-17 21:22:16.558825 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_stack_user_keystone_password) 2026-09-17 21:22:16.559213 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_mariadb_password) 2026-09-17 21:22:16.559521 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_rabbitmq_password) 2026-09-17 21:22:16.559843 | instance | ok: [localhost] => (item=openstack_helm_endpoints_horizon_mariadb_password) 2026-09-17 21:22:16.560134 | instance | ok: [localhost] => (item=openstack_helm_endpoints_tempest_keystone_password) 2026-09-17 21:22:16.560475 | instance | ok: [localhost] => (item=openstack_helm_endpoints_openstack_exporter_keystone_password) 2026-09-17 21:22:16.560799 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rgw_keystone_password) 2026-09-17 21:22:16.561102 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_keystone_password) 2026-09-17 21:22:16.561433 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_mariadb_password) 2026-09-17 21:22:16.561758 | instance | ok: [localhost] => (item=openstack_helm_endpoints_staffeln_mariadb_password) 2026-09-17 21:22:16.562033 | instance | 2026-09-17 21:22:16.562316 | instance | TASK [Generate base64 encoded secrets] ***************************************** 2026-09-17 21:22:16.562677 | instance | Thursday 17 September 2026 21:22:16 +0000 (0:00:00.367) 0:00:12.250 **** 2026-09-17 21:22:16.591927 | instance | ok: [localhost] => (item=barbican_kek) 2026-09-17 21:22:16.592304 | instance | 2026-09-17 21:22:16.592655 | instance | TASK [Generate temporary files for generating keys for missing variables] ****** 2026-09-17 21:22:16.592972 | instance | Thursday 17 September 2026 21:22:16 +0000 (0:00:00.045) 0:00:12.296 **** 2026-09-17 21:22:16.983817 | instance | changed: [localhost] => (item=manila_ssh_key) 2026-09-17 21:22:16.983920 | instance | changed: [localhost] => (item=nova_ssh_key) 2026-09-17 21:22:16.984207 | instance | 2026-09-17 21:22:16.984583 | instance | TASK [Generate SSH keys for missing variables] ********************************* 2026-09-17 21:22:16.984884 | instance | Thursday 17 September 2026 21:22:16 +0000 (0:00:00.391) 0:00:12.688 **** 2026-09-17 21:22:21.864969 | instance | changed: [localhost] => (item=manila_ssh_key) 2026-09-17 21:22:21.865898 | instance | changed: [localhost] => (item=nova_ssh_key) 2026-09-17 21:22:21.865964 | instance | 2026-09-17 21:22:21.865976 | instance | TASK [Set values for SSH keys] ************************************************* 2026-09-17 21:22:21.865987 | instance | Thursday 17 September 2026 21:22:21 +0000 (0:00:04.882) 0:00:17.571 **** 2026-09-17 21:22:21.938346 | instance | ok: [localhost] => (item=manila_ssh_key) 2026-09-17 21:22:21.939057 | instance | ok: [localhost] => (item=nova_ssh_key) 2026-09-17 21:22:21.939094 | instance | 2026-09-17 21:22:21.939546 | instance | TASK [Delete the temporary files generated for SSH keys] *********************** 2026-09-17 21:22:21.939620 | instance | Thursday 17 September 2026 21:22:21 +0000 (0:00:00.073) 0:00:17.644 **** 2026-09-17 21:22:22.325917 | instance | changed: [localhost] => (item=manila_ssh_key) 2026-09-17 21:22:22.326038 | instance | changed: [localhost] => (item=nova_ssh_key) 2026-09-17 21:22:22.326922 | instance | 2026-09-17 21:22:22.326990 | instance | TASK [Write new secrets file to disk] ****************************************** 2026-09-17 21:22:22.327003 | instance | Thursday 17 September 2026 21:22:22 +0000 (0:00:00.387) 0:00:18.031 **** 2026-09-17 21:22:22.716781 | instance | changed: [localhost] 2026-09-17 21:22:22.716891 | instance | 2026-09-17 21:22:22.717175 | instance | TASK [Encrypt secrets file with Vault password] ******************************** 2026-09-17 21:22:22.717617 | instance | Thursday 17 September 2026 21:22:22 +0000 (0:00:00.390) 0:00:18.422 **** 2026-09-17 21:22:22.761783 | instance | skipping: [localhost] 2026-09-17 21:22:22.762056 | instance | 2026-09-17 21:22:22.762443 | instance | PLAY [Setup networking] ******************************************************** 2026-09-17 21:22:22.762777 | instance | 2026-09-17 21:22:22.763144 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-17 21:22:22.763462 | instance | Thursday 17 September 2026 21:22:22 +0000 (0:00:00.044) 0:00:18.467 **** 2026-09-17 21:22:23.503784 | instance | ok: [instance] 2026-09-17 21:22:23.503984 | instance | 2026-09-17 21:22:23.504341 | instance | TASK [Create bridge for management network] ************************************ 2026-09-17 21:22:23.504710 | instance | Thursday 17 September 2026 21:22:23 +0000 (0:00:00.741) 0:00:19.209 **** 2026-09-17 21:22:23.879655 | instance | ok: [instance] 2026-09-17 21:22:23.879887 | instance | 2026-09-17 21:22:23.880063 | instance | TASK [Create fake interface for management bridge] ***************************** 2026-09-17 21:22:23.880233 | instance | Thursday 17 September 2026 21:22:23 +0000 (0:00:00.373) 0:00:19.583 **** 2026-09-17 21:22:24.115374 | instance | ok: [instance] 2026-09-17 21:22:24.115590 | instance | 2026-09-17 21:22:24.115762 | instance | TASK [Assign dummy interface to management bridge] ***************************** 2026-09-17 21:22:24.115931 | instance | Thursday 17 September 2026 21:22:24 +0000 (0:00:00.234) 0:00:19.817 **** 2026-09-17 21:22:24.339783 | instance | ok: [instance] 2026-09-17 21:22:24.339888 | instance | 2026-09-17 21:22:24.340100 | instance | TASK [Assign IP address for management bridge] ********************************* 2026-09-17 21:22:24.340366 | instance | Thursday 17 September 2026 21:22:24 +0000 (0:00:00.225) 0:00:20.043 **** 2026-09-17 21:22:24.547511 | instance | ok: [instance] 2026-09-17 21:22:24.547598 | instance | 2026-09-17 21:22:24.547677 | instance | TASK [Bring up interfaces] ***************************************************** 2026-09-17 21:22:24.547783 | instance | Thursday 17 September 2026 21:22:24 +0000 (0:00:00.210) 0:00:20.253 **** 2026-09-17 21:22:24.982928 | instance | ok: [instance] => (item=br-mgmt) 2026-09-17 21:22:24.983168 | instance | ok: [instance] => (item=dummy0) 2026-09-17 21:22:24.983347 | instance | 2026-09-17 21:22:24.983533 | instance | PLAY [Create devices for Ceph] ************************************************* 2026-09-17 21:22:24.983690 | instance | 2026-09-17 21:22:24.983853 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-17 21:22:24.984020 | instance | Thursday 17 September 2026 21:22:24 +0000 (0:00:00.432) 0:00:20.686 **** 2026-09-17 21:22:25.751988 | instance | ok: [instance] 2026-09-17 21:22:25.752031 | instance | 2026-09-17 21:22:25.752039 | instance | TASK [Install depedencies] ***************************************************** 2026-09-17 21:22:25.752045 | instance | Thursday 17 September 2026 21:22:25 +0000 (0:00:00.771) 0:00:21.458 **** 2026-09-17 21:22:48.713480 | instance | changed: [instance] 2026-09-17 21:22:48.713539 | instance | 2026-09-17 21:22:48.713551 | instance | TASK [Start up service] ******************************************************** 2026-09-17 21:22:48.713561 | instance | Thursday 17 September 2026 21:22:48 +0000 (0:00:22.960) 0:00:44.418 **** 2026-09-17 21:22:49.265313 | instance | ok: [instance] 2026-09-17 21:22:49.265380 | instance | 2026-09-17 21:22:49.265594 | instance | TASK [Generate lvm.conf] ******************************************************* 2026-09-17 21:22:49.265610 | instance | Thursday 17 September 2026 21:22:49 +0000 (0:00:00.553) 0:00:44.972 **** 2026-09-17 21:22:49.508744 | instance | ok: [instance] 2026-09-17 21:22:49.509511 | instance | 2026-09-17 21:22:49.509602 | instance | TASK [Write /etc/lvm/lvm.conf] ************************************************* 2026-09-17 21:22:49.509620 | instance | Thursday 17 September 2026 21:22:49 +0000 (0:00:00.242) 0:00:45.214 **** 2026-09-17 21:22:50.017693 | instance | changed: [instance] 2026-09-17 21:22:50.017884 | instance | 2026-09-17 21:22:50.018483 | instance | TASK [Get list of all loopback devices] **************************************** 2026-09-17 21:22:50.018790 | instance | Thursday 17 September 2026 21:22:50 +0000 (0:00:00.509) 0:00:45.723 **** 2026-09-17 21:22:50.221806 | instance | ok: [instance] 2026-09-17 21:22:50.221908 | instance | 2026-09-17 21:22:50.221984 | instance | TASK [Fail if there is any existing loopback devices] ************************** 2026-09-17 21:22:50.222124 | instance | Thursday 17 September 2026 21:22:50 +0000 (0:00:00.204) 0:00:45.928 **** 2026-09-17 21:22:50.255248 | instance | skipping: [instance] 2026-09-17 21:22:50.255689 | instance | 2026-09-17 21:22:50.256119 | instance | TASK [Create devices for Ceph] ************************************************* 2026-09-17 21:22:50.256540 | instance | Thursday 17 September 2026 21:22:50 +0000 (0:00:00.032) 0:00:45.961 **** 2026-09-17 21:22:50.843499 | instance | changed: [instance] => (item=osd0) 2026-09-17 21:22:50.843732 | instance | changed: [instance] => (item=osd1) 2026-09-17 21:22:50.843913 | instance | changed: [instance] => (item=osd2) 2026-09-17 21:22:50.844069 | instance | 2026-09-17 21:22:50.844249 | instance | TASK [Set permissions on loopback devices] ************************************* 2026-09-17 21:22:50.844415 | instance | Thursday 17 September 2026 21:22:50 +0000 (0:00:00.585) 0:00:46.546 **** 2026-09-17 21:22:51.418760 | instance | changed: [instance] => (item=osd0) 2026-09-17 21:22:51.418826 | instance | changed: [instance] => (item=osd1) 2026-09-17 21:22:51.418836 | instance | changed: [instance] => (item=osd2) 2026-09-17 21:22:51.418883 | instance | 2026-09-17 21:22:51.418910 | instance | TASK [Start loop devices] ****************************************************** 2026-09-17 21:22:51.419153 | instance | Thursday 17 September 2026 21:22:51 +0000 (0:00:00.575) 0:00:47.122 **** 2026-09-17 21:22:52.160994 | instance | changed: [instance] => (item=osd0) 2026-09-17 21:22:52.161193 | instance | changed: [instance] => (item=osd1) 2026-09-17 21:22:52.161412 | instance | changed: [instance] => (item=osd2) 2026-09-17 21:22:52.161618 | instance | 2026-09-17 21:22:52.161832 | instance | TASK [Create a volume group for each loop device] ****************************** 2026-09-17 21:22:52.162051 | instance | Thursday 17 September 2026 21:22:52 +0000 (0:00:00.744) 0:00:47.867 **** 2026-09-17 21:22:55.562797 | instance | changed: [instance] => (item=osd0) 2026-09-17 21:22:55.562898 | instance | changed: [instance] => (item=osd1) 2026-09-17 21:22:55.562911 | instance | changed: [instance] => (item=osd2) 2026-09-17 21:22:55.562920 | instance | 2026-09-17 21:22:55.562929 | instance | TASK [Create a logical volume for each loop device] **************************** 2026-09-17 21:22:55.562939 | instance | Thursday 17 September 2026 21:22:55 +0000 (0:00:03.400) 0:00:51.267 **** 2026-09-17 21:22:57.512422 | instance | changed: [instance] => (item=ceph-instance-osd0) 2026-09-17 21:22:57.514046 | instance | changed: [instance] => (item=ceph-instance-osd1) 2026-09-17 21:22:57.514141 | instance | changed: [instance] => (item=ceph-instance-osd2) 2026-09-17 21:22:57.514152 | instance | 2026-09-17 21:22:57.514162 | instance | PLAY [controllers] ************************************************************* 2026-09-17 21:22:57.514172 | instance | 2026-09-17 21:22:57.514181 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-17 21:22:57.514190 | instance | Thursday 17 September 2026 21:22:57 +0000 (0:00:01.950) 0:00:53.218 **** 2026-09-17 21:22:58.506601 | instance | ok: [instance] 2026-09-17 21:22:58.506656 | instance | 2026-09-17 21:22:58.506662 | instance | TASK [Set masquerade rule] ***************************************************** 2026-09-17 21:22:58.506667 | instance | Thursday 17 September 2026 21:22:58 +0000 (0:00:00.994) 0:00:54.212 **** 2026-09-17 21:22:59.014981 | instance | changed: [instance] 2026-09-17 21:22:59.015084 | instance | 2026-09-17 21:22:59.015097 | instance | PLAY RECAP ********************************************************************* 2026-09-17 21:22:59.015108 | instance | instance : ok=24 changed=10 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-09-17 21:22:59.015127 | instance | localhost : ok=40 changed=21 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-09-17 21:22:59.015136 | instance | 2026-09-17 21:22:59.015145 | instance | Thursday 17 September 2026 21:22:59 +0000 (0:00:00.505) 0:00:54.718 **** 2026-09-17 21:22:59.015154 | instance | =============================================================================== 2026-09-17 21:22:59.015162 | instance | Install depedencies ---------------------------------------------------- 22.96s 2026-09-17 21:22:59.015171 | instance | Generate SSH keys for missing variables --------------------------------- 4.88s 2026-09-17 21:22:59.015179 | instance | Create a volume group for each loop device ------------------------------ 3.40s 2026-09-17 21:22:59.015188 | instance | Create a logical volume for each loop device ---------------------------- 1.95s 2026-09-17 21:22:59.015197 | instance | Install "dirmngr" for GPG keyserver operations -------------------------- 1.28s 2026-09-17 21:22:59.015205 | instance | Gathering Facts --------------------------------------------------------- 1.19s 2026-09-17 21:22:59.015214 | instance | Create folders for workspace -------------------------------------------- 1.02s 2026-09-17 21:22:59.015222 | instance | Gathering Facts --------------------------------------------------------- 0.99s 2026-09-17 21:22:59.015231 | instance | Gathering Facts --------------------------------------------------------- 0.77s 2026-09-17 21:22:59.015246 | instance | Configure short hostname ------------------------------------------------ 0.75s 2026-09-17 21:22:59.015322 | instance | Gathering Facts --------------------------------------------------------- 0.75s 2026-09-17 21:22:59.015668 | instance | Start loop devices ------------------------------------------------------ 0.74s 2026-09-17 21:22:59.015954 | instance | Gathering Facts --------------------------------------------------------- 0.74s 2026-09-17 21:22:59.016264 | instance | Generate endpoint skeleton for missing variables ------------------------ 0.70s 2026-09-17 21:22:59.016548 | instance | Purge "snapd" package --------------------------------------------------- 0.67s 2026-09-17 21:22:59.016863 | instance | Write new Ceph control plane configuration file to disk ----------------- 0.60s 2026-09-17 21:22:59.017170 | instance | Create devices for Ceph ------------------------------------------------- 0.59s 2026-09-17 21:22:59.017459 | instance | Set permissions on loopback devices ------------------------------------- 0.58s 2026-09-17 21:22:59.017743 | instance | Start up service -------------------------------------------------------- 0.55s 2026-09-17 21:22:59.018036 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.51s 2026-09-17 21:22:59.123205 | instance | INFO [aio > prepare] Executed: Successful 2026-09-17 21:22:59.139812 | instance | INFO [aio > converge] Executing 2026-09-17 21:23:01.855244 | instance | 2026-09-17 21:23:01.855699 | instance | PLAY [all] ********************************************************************* 2026-09-17 21:23:01.856088 | instance | 2026-09-17 21:23:01.856482 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-17 21:23:01.856864 | instance | Thursday 17 September 2026 21:23:01 +0000 (0:00:00.016) 0:00:00.016 **** 2026-09-17 21:23:03.125389 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-09-17 21:23:03.125765 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-09-17 21:23:03.126075 | instance | interpreter could change the meaning of that path. See 2026-09-17 21:23:03.126361 | instance | https://docs.ansible.com/ansible- 2026-09-17 21:23:03.126644 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-09-17 21:23:03.135188 | instance | ok: [instance] 2026-09-17 21:23:03.135494 | instance | 2026-09-17 21:23:03.135778 | instance | TASK [Fail if atmosphere_ceph_enabled is set] ********************************** 2026-09-17 21:23:03.136093 | instance | Thursday 17 September 2026 21:23:03 +0000 (0:00:01.280) 0:00:01.296 **** 2026-09-17 21:23:03.180645 | instance | skipping: [instance] 2026-09-17 21:23:03.180953 | instance | 2026-09-17 21:23:03.181282 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-09-17 21:23:03.181563 | instance | Thursday 17 September 2026 21:23:03 +0000 (0:00:00.045) 0:00:01.342 **** 2026-09-17 21:23:03.347263 | instance | ok: [instance] 2026-09-17 21:23:03.347651 | instance | 2026-09-17 21:23:03.348021 | instance | PLAY [Deploy Ceph monitors & managers] ***************************************** 2026-09-17 21:23:03.348309 | instance | 2026-09-17 21:23:03.348597 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-17 21:23:03.348888 | instance | Thursday 17 September 2026 21:23:03 +0000 (0:00:00.166) 0:00:01.508 **** 2026-09-17 21:23:04.324598 | instance | ok: [instance] 2026-09-17 21:23:04.324940 | instance | 2026-09-17 21:23:04.325274 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-09-17 21:23:04.325581 | instance | Thursday 17 September 2026 21:23:04 +0000 (0:00:00.976) 0:00:02.485 **** 2026-09-17 21:23:04.736801 | instance | ok: [instance] 2026-09-17 21:23:04.737085 | instance | 2026-09-17 21:23:04.737296 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-09-17 21:23:04.737508 | instance | Thursday 17 September 2026 21:23:04 +0000 (0:00:00.412) 0:00:02.898 **** 2026-09-17 21:23:04.779323 | instance | skipping: [instance] 2026-09-17 21:23:04.779547 | instance | 2026-09-17 21:23:04.779713 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-09-17 21:23:04.779899 | instance | Thursday 17 September 2026 21:23:04 +0000 (0:00:00.042) 0:00:02.940 **** 2026-09-17 21:23:05.193793 | instance | changed: [instance] 2026-09-17 21:23:05.194281 | instance | 2026-09-17 21:23:05.194702 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-09-17 21:23:05.195187 | instance | Thursday 17 September 2026 21:23:05 +0000 (0:00:00.414) 0:00:03.355 **** 2026-09-17 21:23:05.294923 | instance | ok: [instance] => { 2026-09-17 21:23:05.295187 | instance | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-09-17 21:23:05.295329 | instance | } 2026-09-17 21:23:05.295460 | instance | 2026-09-17 21:23:05.295600 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-09-17 21:23:05.295757 | instance | Thursday 17 September 2026 21:23:05 +0000 (0:00:00.101) 0:00:03.456 **** 2026-09-17 21:23:06.016376 | instance | changed: [instance] 2026-09-17 21:23:06.016581 | instance | 2026-09-17 21:23:06.016766 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-09-17 21:23:06.017009 | instance | Thursday 17 September 2026 21:23:06 +0000 (0:00:00.721) 0:00:04.177 **** 2026-09-17 21:23:06.083503 | instance | skipping: [instance] 2026-09-17 21:23:06.083603 | instance | 2026-09-17 21:23:06.083735 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-09-17 21:23:06.083917 | instance | Thursday 17 September 2026 21:23:06 +0000 (0:00:00.066) 0:00:04.244 **** 2026-09-17 21:23:06.151595 | instance | skipping: [instance] 2026-09-17 21:23:06.151751 | instance | 2026-09-17 21:23:06.152025 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-09-17 21:23:06.152227 | instance | Thursday 17 September 2026 21:23:06 +0000 (0:00:00.066) 0:00:04.310 **** 2026-09-17 21:23:06.395741 | instance | ok: [instance] 2026-09-17 21:23:06.395918 | instance | 2026-09-17 21:23:06.396186 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-09-17 21:23:06.396383 | instance | Thursday 17 September 2026 21:23:06 +0000 (0:00:00.242) 0:00:04.553 **** 2026-09-17 21:23:07.851594 | instance | ok: [instance] 2026-09-17 21:23:07.851691 | instance | 2026-09-17 21:23:07.851841 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-09-17 21:23:07.852105 | instance | Thursday 17 September 2026 21:23:07 +0000 (0:00:01.459) 0:00:06.012 **** 2026-09-17 21:23:07.947597 | instance | ok: [instance] => { 2026-09-17 21:23:07.947840 | instance | "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz" 2026-09-17 21:23:07.948021 | instance | } 2026-09-17 21:23:07.948180 | instance | 2026-09-17 21:23:07.948345 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-09-17 21:23:07.948507 | instance | Thursday 17 September 2026 21:23:07 +0000 (0:00:00.093) 0:00:06.105 **** 2026-09-17 21:23:08.763745 | instance | changed: [instance] 2026-09-17 21:23:08.763973 | instance | 2026-09-17 21:23:08.764343 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-09-17 21:23:08.764675 | instance | Thursday 17 September 2026 21:23:08 +0000 (0:00:00.818) 0:00:06.924 **** 2026-09-17 21:23:11.943657 | instance | changed: [instance] 2026-09-17 21:23:11.943769 | instance | 2026-09-17 21:23:11.943781 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-09-17 21:23:11.943972 | instance | Thursday 17 September 2026 21:23:11 +0000 (0:00:03.180) 0:00:10.104 **** 2026-09-17 21:23:11.979728 | instance | skipping: [instance] 2026-09-17 21:23:11.979919 | instance | 2026-09-17 21:23:11.980185 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-09-17 21:23:11.980387 | instance | Thursday 17 September 2026 21:23:11 +0000 (0:00:00.035) 0:00:10.140 **** 2026-09-17 21:23:12.023827 | instance | skipping: [instance] 2026-09-17 21:23:12.024280 | instance | 2026-09-17 21:23:12.024579 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-09-17 21:23:12.024887 | instance | Thursday 17 September 2026 21:23:12 +0000 (0:00:00.043) 0:00:10.183 **** 2026-09-17 21:23:12.071835 | instance | skipping: [instance] 2026-09-17 21:23:12.072317 | instance | 2026-09-17 21:23:12.072804 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-09-17 21:23:12.073135 | instance | Thursday 17 September 2026 21:23:12 +0000 (0:00:00.046) 0:00:10.230 **** 2026-09-17 21:23:18.293521 | instance | changed: [instance] 2026-09-17 21:23:18.293621 | instance | 2026-09-17 21:23:18.294105 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] *** 2026-09-17 21:23:18.294157 | instance | Thursday 17 September 2026 21:23:18 +0000 (0:00:06.223) 0:00:16.454 **** 2026-09-17 21:23:18.971303 | instance | changed: [instance] 2026-09-17 21:23:18.971381 | instance | 2026-09-17 21:23:18.971679 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] ******* 2026-09-17 21:23:18.971805 | instance | Thursday 17 September 2026 21:23:18 +0000 (0:00:00.678) 0:00:17.132 **** 2026-09-17 21:23:19.982728 | instance | changed: [instance] => (item={'path': '/etc/containerd'}) 2026-09-17 21:23:19.984385 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'}) 2026-09-17 21:23:19.984457 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'}) 2026-09-17 21:23:19.984469 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'}) 2026-09-17 21:23:19.984481 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'}) 2026-09-17 21:23:19.984491 | instance | 2026-09-17 21:23:19.984501 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] ********** 2026-09-17 21:23:19.984511 | instance | Thursday 17 September 2026 21:23:19 +0000 (0:00:01.010) 0:00:18.143 **** 2026-09-17 21:23:20.653829 | instance | changed: [instance] 2026-09-17 21:23:20.653925 | instance | 2026-09-17 21:23:20.654002 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ******** 2026-09-17 21:23:20.654477 | instance | Thursday 17 September 2026 21:23:20 +0000 (0:00:00.653) 0:00:18.797 **** 2026-09-17 21:23:20.654769 | instance | 2026-09-17 21:23:20.655043 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-09-17 21:23:20.655260 | instance | Thursday 17 September 2026 21:23:20 +0000 (0:00:00.016) 0:00:18.814 **** 2026-09-17 21:23:21.625625 | instance | ok: [instance] 2026-09-17 21:23:21.625782 | instance | 2026-09-17 21:23:21.626039 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] ********** 2026-09-17 21:23:21.626243 | instance | Thursday 17 September 2026 21:23:21 +0000 (0:00:00.972) 0:00:19.787 **** 2026-09-17 21:23:22.160648 | instance | changed: [instance] 2026-09-17 21:23:22.160911 | instance | 2026-09-17 21:23:22.161305 | instance | TASK [vexxhost.containers.containerd : Enable and start service] *************** 2026-09-17 21:23:22.161647 | instance | Thursday 17 September 2026 21:23:22 +0000 (0:00:00.534) 0:00:20.321 **** 2026-09-17 21:23:22.788314 | instance | changed: [instance] 2026-09-17 21:23:22.788388 | instance | 2026-09-17 21:23:22.788777 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-09-17 21:23:22.788850 | instance | Thursday 17 September 2026 21:23:22 +0000 (0:00:00.627) 0:00:20.949 **** 2026-09-17 21:23:23.061617 | instance | ok: [instance] 2026-09-17 21:23:23.061755 | instance | 2026-09-17 21:23:23.062317 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-09-17 21:23:23.062612 | instance | Thursday 17 September 2026 21:23:23 +0000 (0:00:00.272) 0:00:21.222 **** 2026-09-17 21:23:23.147484 | instance | ok: [instance] => { 2026-09-17 21:23:23.148269 | instance | "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz" 2026-09-17 21:23:23.148338 | instance | } 2026-09-17 21:23:23.148346 | instance | 2026-09-17 21:23:23.148352 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-09-17 21:23:23.148360 | instance | Thursday 17 September 2026 21:23:23 +0000 (0:00:00.086) 0:00:21.308 **** 2026-09-17 21:23:26.123062 | instance | changed: [instance] 2026-09-17 21:23:26.123183 | instance | 2026-09-17 21:23:26.123213 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-09-17 21:23:26.123389 | instance | Thursday 17 September 2026 21:23:26 +0000 (0:00:02.975) 0:00:24.284 **** 2026-09-17 21:23:30.600679 | instance | changed: [instance] 2026-09-17 21:23:30.600779 | instance | 2026-09-17 21:23:30.601320 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ****************** 2026-09-17 21:23:30.601397 | instance | Thursday 17 September 2026 21:23:30 +0000 (0:00:04.477) 0:00:28.761 **** 2026-09-17 21:23:31.869866 | instance | ok: [instance] 2026-09-17 21:23:31.870588 | instance | 2026-09-17 21:23:31.870668 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] *************** 2026-09-17 21:23:31.870682 | instance | Thursday 17 September 2026 21:23:31 +0000 (0:00:01.269) 0:00:30.031 **** 2026-09-17 21:23:32.308103 | instance | changed: [instance] 2026-09-17 21:23:32.308825 | instance | 2026-09-17 21:23:32.308920 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] ***** 2026-09-17 21:23:32.308932 | instance | Thursday 17 September 2026 21:23:32 +0000 (0:00:00.438) 0:00:30.469 **** 2026-09-17 21:23:32.845896 | instance | changed: [instance] 2026-09-17 21:23:32.846653 | instance | 2026-09-17 21:23:32.846719 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] *********** 2026-09-17 21:23:32.846733 | instance | Thursday 17 September 2026 21:23:32 +0000 (0:00:00.537) 0:00:31.007 **** 2026-09-17 21:23:33.501934 | instance | changed: [instance] => (item={'path': '/etc/docker'}) 2026-09-17 21:23:33.502087 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'}) 2026-09-17 21:23:33.503045 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'}) 2026-09-17 21:23:33.503142 | instance | 2026-09-17 21:23:33.503155 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ****** 2026-09-17 21:23:33.503174 | instance | Thursday 17 September 2026 21:23:33 +0000 (0:00:00.655) 0:00:31.663 **** 2026-09-17 21:23:34.009160 | instance | changed: [instance] 2026-09-17 21:23:34.009265 | instance | 2026-09-17 21:23:34.009515 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] *********** 2026-09-17 21:23:34.009578 | instance | Thursday 17 September 2026 21:23:34 +0000 (0:00:00.507) 0:00:32.170 **** 2026-09-17 21:23:34.562983 | instance | changed: [instance] 2026-09-17 21:23:34.563232 | instance | 2026-09-17 21:23:34.564382 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************ 2026-09-17 21:23:34.564447 | instance | Thursday 17 September 2026 21:23:34 +0000 (0:00:00.537) 0:00:32.708 **** 2026-09-17 21:23:34.564476 | instance | 2026-09-17 21:23:34.564486 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-09-17 21:23:34.564495 | instance | Thursday 17 September 2026 21:23:34 +0000 (0:00:00.016) 0:00:32.724 **** 2026-09-17 21:23:35.361435 | instance | ok: [instance] 2026-09-17 21:23:35.361550 | instance | 2026-09-17 21:23:35.361804 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ****************** 2026-09-17 21:23:35.361863 | instance | Thursday 17 September 2026 21:23:35 +0000 (0:00:00.798) 0:00:33.523 **** 2026-09-17 21:23:36.475503 | instance | changed: [instance] 2026-09-17 21:23:36.475625 | instance | 2026-09-17 21:23:36.475637 | instance | TASK [vexxhost.containers.docker : Enable and start service] ******************* 2026-09-17 21:23:36.475805 | instance | Thursday 17 September 2026 21:23:36 +0000 (0:00:01.113) 0:00:34.637 **** 2026-09-17 21:23:37.119885 | instance | changed: [instance] 2026-09-17 21:23:37.119948 | instance | 2026-09-17 21:23:37.119960 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ****** 2026-09-17 21:23:37.119970 | instance | Thursday 17 September 2026 21:23:37 +0000 (0:00:00.642) 0:00:35.280 **** 2026-09-17 21:23:37.203257 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml) 2026-09-17 21:23:37.203327 | instance | 2026-09-17 21:23:37.203650 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ******************************** 2026-09-17 21:23:37.203672 | instance | Thursday 17 September 2026 21:23:37 +0000 (0:00:00.084) 0:00:35.364 **** 2026-09-17 21:23:42.912537 | instance | changed: [instance] 2026-09-17 21:23:42.912684 | instance | 2026-09-17 21:23:42.913226 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] ********************* 2026-09-17 21:23:42.913290 | instance | Thursday 17 September 2026 21:23:42 +0000 (0:00:05.708) 0:00:41.073 **** 2026-09-17 21:23:43.609372 | instance | ok: [instance] => (item=chronyd) 2026-09-17 21:23:43.610231 | instance | ok: [instance] => (item=sshd) 2026-09-17 21:23:43.610537 | instance | 2026-09-17 21:23:43.610550 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ****************************** 2026-09-17 21:23:43.610560 | instance | Thursday 17 September 2026 21:23:43 +0000 (0:00:00.697) 0:00:41.770 **** 2026-09-17 21:23:49.040854 | instance | changed: [instance] 2026-09-17 21:23:49.041643 | instance | 2026-09-17 21:23:49.041890 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ******************** 2026-09-17 21:23:49.041905 | instance | Thursday 17 September 2026 21:23:49 +0000 (0:00:05.431) 0:00:47.201 **** 2026-09-17 21:23:49.263394 | instance | ok: [instance] 2026-09-17 21:23:49.263667 | instance | 2026-09-17 21:23:49.264033 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] **************** 2026-09-17 21:23:49.264325 | instance | Thursday 17 September 2026 21:23:49 +0000 (0:00:00.222) 0:00:47.424 **** 2026-09-17 21:23:49.801684 | instance | changed: [instance] 2026-09-17 21:23:49.801941 | instance | 2026-09-17 21:23:49.802290 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] *** 2026-09-17 21:23:49.802584 | instance | Thursday 17 September 2026 21:23:49 +0000 (0:00:00.538) 0:00:47.962 **** 2026-09-17 21:23:50.210064 | instance | changed: [instance] 2026-09-17 21:23:50.210199 | instance | 2026-09-17 21:23:50.210486 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] ************************* 2026-09-17 21:23:50.210814 | instance | Thursday 17 September 2026 21:23:50 +0000 (0:00:00.408) 0:00:48.371 **** 2026-09-17 21:23:50.334429 | instance | ok: [instance] 2026-09-17 21:23:50.334498 | instance | 2026-09-17 21:23:50.334626 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] ******************* 2026-09-17 21:23:50.334755 | instance | Thursday 17 September 2026 21:23:50 +0000 (0:00:00.124) 0:00:48.496 **** 2026-09-17 21:23:50.580357 | instance | ok: [instance] => (item=instance) 2026-09-17 21:23:50.580421 | instance | 2026-09-17 21:23:50.580576 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ******** 2026-09-17 21:23:50.580727 | instance | Thursday 17 September 2026 21:23:50 +0000 (0:00:00.245) 0:00:48.741 **** 2026-09-17 21:23:50.660896 | instance | ok: [instance] 2026-09-17 21:23:50.660988 | instance | 2026-09-17 21:23:50.661077 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] *********************************** 2026-09-17 21:23:50.661186 | instance | Thursday 17 September 2026 21:23:50 +0000 (0:00:00.080) 0:00:48.822 **** 2026-09-17 21:23:50.746206 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance 2026-09-17 21:23:50.746328 | instance | 2026-09-17 21:23:50.746450 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] ************* 2026-09-17 21:23:50.746580 | instance | Thursday 17 September 2026 21:23:50 +0000 (0:00:00.085) 0:00:48.907 **** 2026-09-17 21:23:51.104685 | instance | changed: [instance] 2026-09-17 21:23:51.104777 | instance | 2026-09-17 21:23:51.104869 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ****************** 2026-09-17 21:23:51.104999 | instance | Thursday 17 September 2026 21:23:51 +0000 (0:00:00.357) 0:00:49.265 **** 2026-09-17 21:23:51.853298 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True}) 2026-09-17 21:23:51.853801 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0}) 2026-09-17 21:23:51.854151 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False}) 2026-09-17 21:23:51.854440 | instance | 2026-09-17 21:23:51.854889 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] ******************************* 2026-09-17 21:23:51.855251 | instance | Thursday 17 September 2026 21:23:51 +0000 (0:00:00.748) 0:00:50.014 **** 2026-09-17 21:25:24.296329 | instance | ok: [instance] 2026-09-17 21:25:24.296427 | instance | 2026-09-17 21:25:24.296454 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] *************** 2026-09-17 21:25:24.296469 | instance | Thursday 17 September 2026 21:25:24 +0000 (0:01:32.441) 0:02:22.456 **** 2026-09-17 21:25:24.556138 | instance | changed: [instance] 2026-09-17 21:25:24.556284 | instance | 2026-09-17 21:25:24.556553 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] ********************************** 2026-09-17 21:25:24.556822 | instance | Thursday 17 September 2026 21:25:24 +0000 (0:00:00.260) 0:02:22.717 **** 2026-09-17 21:25:24.610613 | instance | ok: [instance] 2026-09-17 21:25:24.610703 | instance | 2026-09-17 21:25:24.610947 | instance | TASK [Install Ceph host] ******************************************************* 2026-09-17 21:25:24.611115 | instance | Thursday 17 September 2026 21:25:24 +0000 (0:00:00.054) 0:02:22.771 **** 2026-09-17 21:25:24.702344 | instance | included: vexxhost.ceph.cephadm_host for instance 2026-09-17 21:25:24.702401 | instance | 2026-09-17 21:25:24.702697 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ****** 2026-09-17 21:25:24.702759 | instance | Thursday 17 September 2026 21:25:24 +0000 (0:00:00.092) 0:02:22.863 **** 2026-09-17 21:25:26.478879 | instance | ok: [instance] 2026-09-17 21:25:26.478944 | instance | 2026-09-17 21:25:26.478950 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] *** 2026-09-17 21:25:26.478956 | instance | Thursday 17 September 2026 21:25:26 +0000 (0:00:01.776) 0:02:24.640 **** 2026-09-17 21:25:26.540695 | instance | ok: [instance] => (item=instance) 2026-09-17 21:25:26.540751 | instance | 2026-09-17 21:25:26.540757 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] *********** 2026-09-17 21:25:26.540762 | instance | Thursday 17 September 2026 21:25:26 +0000 (0:00:00.061) 0:02:24.702 **** 2026-09-17 21:25:27.092103 | instance | ok: [instance] 2026-09-17 21:25:27.092162 | instance | 2026-09-17 21:25:27.092171 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] *********************** 2026-09-17 21:25:27.092176 | instance | Thursday 17 September 2026 21:25:27 +0000 (0:00:00.551) 0:02:25.253 **** 2026-09-17 21:25:29.528778 | instance | ok: [instance] 2026-09-17 21:25:29.528867 | instance | 2026-09-17 21:25:29.529206 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ****************** 2026-09-17 21:25:29.529270 | instance | Thursday 17 September 2026 21:25:29 +0000 (0:00:02.436) 0:02:27.690 **** 2026-09-17 21:26:12.745870 | 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-09-17 21:26:12.746390 | 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_cp124rv6/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_cp124rv6/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_cp124rv6/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_cp124rv6/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-09-17T21:26:12.470+0000 7fc2a593b640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCYWqxqY8gHHCAA3ddqSSoSrD10cpmgaU7tNI8vBOC5Zf/n3fJTyK8RhfI=: Malformed input [buffer:3]\n2026-09-17T21:26:12.470+0000 7fc2a593b640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-17T21:26:12.470+0000 7fc2a593b640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCYWqxqY8gHHCAA3ddqSSoSrD10cpmgaU7tNI8vBOC5Zf/n3fJTyK8RhfI=: Malformed input [buffer:3]\n2026-09-17T21:26:12.470+0000 7fc2a593b640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-17T21:26:12.470+0000 7fc2a593b640 -1 auth: error parsing file /etc/ceph/ceph.keyring: error setting modifier for [client.admin] type=key val=AgCYWqxqY8gHHCAA3ddqSSoSrD10cpmgaU7tNI8vBOC5Zf/n3fJTyK8RhfI=: Malformed input [buffer:3]\n2026-09-17T21:26:12.470+0000 7fc2a593b640 -1 auth: failed to load /etc/ceph/ceph.keyring: (5) Input/output error\n2026-09-17T21:26:12.470+0000 7fc2a593b640 -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-09-17 21:26:12.748903 | instance | 2026-09-17 21:26:12.749123 | instance | PLAY RECAP ********************************************************************* 2026-09-17 21:26:12.749207 | instance | instance : ok=53 changed=26 unreachable=0 failed=1 skipped=7 rescued=0 ignored=0 2026-09-17 21:26:12.749943 | instance | 2026-09-17 21:26:12.749972 | instance | Thursday 17 September 2026 21:26:12 +0000 (0:00:43.221) 0:03:10.911 **** 2026-09-17 21:26:12.749983 | instance | =============================================================================== 2026-09-17 21:26:12.749992 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 92.44s 2026-09-17 21:26:12.750001 | instance | vexxhost.ceph.mon : Configure "mon" label for monitors ----------------- 43.22s 2026-09-17 21:26:12.750011 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 6.22s 2026-09-17 21:26:12.750023 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 5.71s 2026-09-17 21:26:12.750934 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 5.43s 2026-09-17 21:26:12.750968 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.48s 2026-09-17 21:26:12.750981 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 3.18s 2026-09-17 21:26:12.750994 | instance | vexxhost.containers.download_artifact : Download item ------------------- 2.98s 2026-09-17 21:26:12.751004 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 2.44s 2026-09-17 21:26:12.751012 | instance | vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user ------ 1.78s 2026-09-17 21:26:12.751021 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.77s 2026-09-17 21:26:12.751055 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.46s 2026-09-17 21:26:12.752059 | instance | Gathering Facts --------------------------------------------------------- 1.28s 2026-09-17 21:26:12.752089 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.27s 2026-09-17 21:26:12.752099 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 1.11s 2026-09-17 21:26:12.752108 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 1.01s 2026-09-17 21:26:12.752117 | instance | Gathering Facts --------------------------------------------------------- 0.98s 2026-09-17 21:26:12.752126 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.82s 2026-09-17 21:26:12.752134 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.75s 2026-09-17 21:26:12.752143 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.72s 2026-09-17 21:26:13.014752 | instance | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.aio/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/aio/converge.yml 2026-09-17 21:26:13.015007 | instance | ERROR [aio > converge] Executed: Failed 2026-09-17 21:26:13.015155 | instance | ERROR Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.aio/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/aio/converge.yml 2026-09-17 21:26:13.177883 | instance | ERROR 2026-09-17 21:26:13.178307 | instance | { 2026-09-17 21:26:13.178382 | instance | "delta": "0:04:25.020660", 2026-09-17 21:26:13.178425 | instance | "end": "2026-09-17 21:26:13.114313", 2026-09-17 21:26:13.178462 | instance | "msg": "non-zero return code", 2026-09-17 21:26:13.178498 | instance | "rc": 2, 2026-09-17 21:26:13.178543 | instance | "start": "2026-09-17 21:21:48.093653" 2026-09-17 21:26:13.178593 | instance | } failure 2026-09-17 21:26:13.192857 | 2026-09-17 21:26:13.193015 | PLAY RECAP 2026-09-17 21:26:13.193110 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-09-17 21:26:13.193176 | 2026-09-17 21:26:13.399331 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-09-17 21:26:13.406337 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-09-17 21:26:14.074156 | 2026-09-17 21:26:14.074264 | PLAY [all] 2026-09-17 21:26:14.086712 | 2026-09-17 21:26:14.086801 | TASK [gather-host-logs : creating directory for system status] 2026-09-17 21:26:14.436480 | instance | changed 2026-09-17 21:26:14.446799 | 2026-09-17 21:26:14.447011 | TASK [gather-host-logs : Get logs for each host] 2026-09-17 21:26:14.827873 | instance | + systemd-cgls --full --all --no-pager 2026-09-17 21:26:14.855966 | instance | + ip addr 2026-09-17 21:26:14.859870 | instance | + ip route 2026-09-17 21:26:14.862781 | instance | + lsblk 2026-09-17 21:26:14.868465 | instance | + mount 2026-09-17 21:26:14.871496 | instance | + docker images 2026-09-17 21:26:14.889948 | instance | + brctl show 2026-09-17 21:26:14.890621 | instance | /bin/bash: line 8: brctl: command not found 2026-09-17 21:26:14.890949 | instance | + ip neigh 2026-09-17 21:26:14.893733 | instance | + bridge fdb show 2026-09-17 21:26:14.898500 | instance | + ps aux --sort=-%mem 2026-09-17 21:26:14.948381 | instance | + dpkg -l 2026-09-17 21:26:14.959879 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-09-17 21:26:14.960554 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-09-17 21:26:14.981718 | instance | + '[' '!' -z '' ']' 2026-09-17 21:26:15.030243 | instance | ok: Runtime: 0:00:00.159755 2026-09-17 21:26:15.035714 | 2026-09-17 21:26:15.035800 | TASK [gather-host-logs : Downloads logs to executor] 2026-09-17 21:26:15.714818 | instance | changed: 2026-09-17 21:26:15.715155 | instance | created directory /var/lib/zuul/builds/85337bffaa1e49a7b112f7a020c6ac5f/work/logs/instance 2026-09-17 21:26:15.715202 | instance | cd+++++++++ system/ 2026-09-17 21:26:15.715234 | instance | >f+++++++++ system/brctl-show.txt 2026-09-17 21:26:15.715261 | instance | >f+++++++++ system/bridge-fdb.txt 2026-09-17 21:26:15.715287 | instance | >f+++++++++ system/docker-images.txt 2026-09-17 21:26:15.715316 | instance | >f+++++++++ system/ip-addr.txt 2026-09-17 21:26:15.715343 | instance | >f+++++++++ system/ip-neigh.txt 2026-09-17 21:26:15.715371 | instance | >f+++++++++ system/ip-route.txt 2026-09-17 21:26:15.715398 | instance | >f+++++++++ system/lsblk.txt 2026-09-17 21:26:15.715425 | instance | >f+++++++++ system/mount.txt 2026-09-17 21:26:15.715452 | instance | >f+++++++++ system/packages.txt 2026-09-17 21:26:15.715478 | instance | >f+++++++++ system/ps.txt 2026-09-17 21:26:15.715505 | instance | >f+++++++++ system/systemd-cgls.txt 2026-09-17 21:26:15.728472 | 2026-09-17 21:26:15.728694 | LOOP [helm-release-status : creating directory for helm release status] 2026-09-17 21:26:15.972073 | instance | changed: "values" 2026-09-17 21:26:16.171087 | instance | changed: "releases" 2026-09-17 21:26:16.197860 | 2026-09-17 21:26:16.198150 | TASK [helm-release-status : Gather get release status for helm charts] 2026-09-17 21:26:16.506476 | instance | /bin/bash: line 3: kubectl: command not found 2026-09-17 21:26:16.787772 | instance | ok: Runtime: 0:00:00.005981 2026-09-17 21:26:16.793577 | 2026-09-17 21:26:16.793657 | TASK [helm-release-status : Downloads logs to executor] 2026-09-17 21:26:17.283026 | instance | changed: 2026-09-17 21:26:17.283275 | instance | cd+++++++++ helm/ 2026-09-17 21:26:17.283332 | instance | cd+++++++++ helm/releases/ 2026-09-17 21:26:17.283374 | instance | cd+++++++++ helm/values/ 2026-09-17 21:26:17.300990 | 2026-09-17 21:26:17.301125 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-09-17 21:26:17.537762 | instance | changed 2026-09-17 21:26:17.549295 | 2026-09-17 21:26:17.549521 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-09-17 21:26:17.802832 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-17 21:26:17.803627 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-17 21:26:17.809148 | instance | environment: line 1: kubectl: command not found 2026-09-17 21:26:17.810673 | instance | environment: line 1: kubectl: command not found 2026-09-17 21:26:17.810722 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-17 21:26:17.812006 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-17 21:26:17.815925 | instance | environment: line 1: kubectl: command not found 2026-09-17 21:26:17.816002 | instance | environment: line 1: kubectl: command not found 2026-09-17 21:26:17.816689 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-17 21:26:17.817445 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-17 21:26:17.819035 | instance | environment: line 1: kubectl: command not found 2026-09-17 21:26:17.820172 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-17 21:26:18.096459 | instance | ok: Runtime: 0:00:00.025582 2026-09-17 21:26:18.107157 | 2026-09-17 21:26:18.107384 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-09-17 21:26:18.355168 | instance | changed 2026-09-17 21:26:18.364235 | 2026-09-17 21:26:18.364452 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-09-17 21:26:18.611968 | instance | environment: line 5: kubectl: command not found 2026-09-17 21:26:18.612775 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-17 21:26:18.613011 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-17 21:26:18.613045 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-17 21:26:18.909333 | instance | ok: Runtime: 0:00:00.009960 2026-09-17 21:26:18.916470 | 2026-09-17 21:26:18.916658 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-09-17 21:26:19.468652 | instance | changed: 2026-09-17 21:26:19.468899 | instance | cd+++++++++ objects/ 2026-09-17 21:26:19.469007 | instance | cd+++++++++ objects/cluster/ 2026-09-17 21:26:19.469055 | instance | cd+++++++++ objects/namespaced/ 2026-09-17 21:26:19.485535 | 2026-09-17 21:26:19.485657 | TASK [gather-pod-logs : creating directory for pod logs] 2026-09-17 21:26:19.710660 | instance | changed 2026-09-17 21:26:19.720794 | 2026-09-17 21:26:19.720923 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-09-17 21:26:19.908545 | instance | changed 2026-09-17 21:26:19.917597 | 2026-09-17 21:26:19.917730 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-09-17 21:26:20.140904 | instance | environment: line 3: kubectl: command not found 2026-09-17 21:26:20.466909 | instance | ok: Runtime: 0:00:00.008108 2026-09-17 21:26:20.473435 | 2026-09-17 21:26:20.473496 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-09-17 21:26:20.993597 | instance | changed: 2026-09-17 21:26:20.993834 | instance | cd+++++++++ pod-logs/ 2026-09-17 21:26:20.993892 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-09-17 21:26:21.012656 | 2026-09-17 21:26:21.012810 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-09-17 21:26:21.289810 | instance | changed 2026-09-17 21:26:21.299922 | 2026-09-17 21:26:21.300082 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-09-17 21:26:21.534245 | instance | /bin/bash: line 2: kubectl: command not found 2026-09-17 21:26:21.847608 | instance | ok: Runtime: 0:00:00.057682 2026-09-17 21:26:21.856836 | 2026-09-17 21:26:21.857015 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-09-17 21:26:22.108879 | instance | /bin/bash: line 2: kubectl: command not found 2026-09-17 21:26:22.155868 | instance | ceph-mgr endpoints: 2026-09-17 21:26:22.404833 | instance | ok: Runtime: 0:00:00.053707 2026-09-17 21:26:22.414424 | 2026-09-17 21:26:22.414547 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-09-17 21:26:22.680596 | instance | /bin/bash: line 4: kubectl: command not found 2026-09-17 21:26:22.959086 | instance | ok: Runtime: 0:00:00.035924 2026-09-17 21:26:22.965504 | 2026-09-17 21:26:22.965674 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-09-17 21:26:23.436759 | instance | changed: cd+++++++++ prometheus/ 2026-09-17 21:26:23.448671 | 2026-09-17 21:26:23.448761 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-09-17 21:26:23.690050 | instance | changed 2026-09-17 21:26:23.694234 | 2026-09-17 21:26:23.694294 | TASK [gather-selenium-data : Get selenium data] 2026-09-17 21:26:23.923851 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-09-17 21:26:23.924741 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-09-17 21:26:24.220282 | instance | ERROR 2026-09-17 21:26:24.220441 | instance | { 2026-09-17 21:26:24.220471 | instance | "delta": "0:00:00.005193", 2026-09-17 21:26:24.220490 | instance | "end": "2026-09-17 21:26:23.925043", 2026-09-17 21:26:24.220540 | instance | "msg": "non-zero return code", 2026-09-17 21:26:24.220559 | instance | "rc": 1, 2026-09-17 21:26:24.220576 | instance | "start": "2026-09-17 21:26:23.919850" 2026-09-17 21:26:24.220592 | instance | } 2026-09-17 21:26:24.220613 | instance | ERROR: Ignoring Errors 2026-09-17 21:26:24.224769 | 2026-09-17 21:26:24.224828 | TASK [gather-selenium-data : Downloads logs to executor] 2026-09-17 21:26:24.699251 | instance | changed: cd+++++++++ selenium/ 2026-09-17 21:26:24.706009 | 2026-09-17 21:26:24.706072 | PLAY RECAP 2026-09-17 21:26:24.706119 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-09-17 21:26:24.706144 | 2026-09-17 21:26:24.807496 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-09-17 21:26:24.822501 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-09-17 21:26:25.392478 | 2026-09-17 21:26:25.392638 | PLAY [all] 2026-09-17 21:26:25.402658 | 2026-09-17 21:26:25.402766 | TASK [fetch-output : Set log path for multiple nodes] 2026-09-17 21:26:25.446268 | instance | skipping: Conditional result was False 2026-09-17 21:26:25.451762 | 2026-09-17 21:26:25.451834 | TASK [fetch-output : Set log path for single node] 2026-09-17 21:26:25.503299 | instance | ok 2026-09-17 21:26:25.512455 | 2026-09-17 21:26:25.512619 | LOOP [fetch-output : Ensure local output dirs] 2026-09-17 21:26:25.883753 | instance -> localhost | ok: "/var/lib/zuul/builds/85337bffaa1e49a7b112f7a020c6ac5f/work/logs" 2026-09-17 21:26:26.110492 | instance -> localhost | changed: "/var/lib/zuul/builds/85337bffaa1e49a7b112f7a020c6ac5f/work/artifacts" 2026-09-17 21:26:26.321387 | instance -> localhost | changed: "/var/lib/zuul/builds/85337bffaa1e49a7b112f7a020c6ac5f/work/docs" 2026-09-17 21:26:26.340447 | 2026-09-17 21:26:26.340673 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-17 21:26:26.959813 | instance | changed: .d..t...... ./ 2026-09-17 21:26:26.960028 | instance | changed: All items complete 2026-09-17 21:26:26.960065 | 2026-09-17 21:26:27.441446 | instance | changed: .d..t...... ./ 2026-09-17 21:26:27.920760 | instance | changed: .d..t...... ./ 2026-09-17 21:26:27.947387 | 2026-09-17 21:26:27.947571 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-17 21:26:28.375734 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.006793 2026-09-17 21:26:28.623576 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.005886 2026-09-17 21:26:28.643888 | 2026-09-17 21:26:28.644091 | PLAY [all] 2026-09-17 21:26:28.659370 | 2026-09-17 21:26:28.659604 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-17 21:26:29.070623 | instance | changed 2026-09-17 21:26:29.080122 | 2026-09-17 21:26:29.080181 | PLAY RECAP 2026-09-17 21:26:29.080231 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-09-17 21:26:29.080260 | 2026-09-17 21:26:29.194739 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-09-17 21:26:29.324423 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-17 21:26:29.922805 | 2026-09-17 21:26:29.922906 | PLAY [localhost] 2026-09-17 21:26:29.932429 | 2026-09-17 21:26:29.932514 | TASK [Generate Zuul manifest] 2026-09-17 21:26:29.958450 | localhost | ok 2026-09-17 21:26:29.971083 | 2026-09-17 21:26:29.971155 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-17 21:26:30.344724 | localhost | changed 2026-09-17 21:26:30.362812 | 2026-09-17 21:26:30.362971 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-17 21:26:30.394474 | localhost | ok 2026-09-17 21:26:30.406865 | 2026-09-17 21:26:30.407008 | TASK [Upload logs] 2026-09-17 21:26:30.427213 | localhost | ok 2026-09-17 21:26:30.522150 | 2026-09-17 21:26:30.522261 | TASK [Set zuul-log-path fact] 2026-09-17 21:26:30.538526 | localhost | ok 2026-09-17 21:26:30.547963 | 2026-09-17 21:26:30.548021 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-17 21:26:30.575161 | localhost | ok 2026-09-17 21:26:30.582874 | 2026-09-17 21:26:30.582969 | TASK [upload-logs : Create log directories] 2026-09-17 21:26:30.947282 | localhost | changed 2026-09-17 21:26:30.956371 | 2026-09-17 21:26:30.956547 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-17 21:26:31.360714 | localhost -> localhost | ok: Runtime: 0:00:00.007127 2026-09-17 21:26:31.367126 | 2026-09-17 21:26:31.367235 | TASK [upload-logs : Upload logs to log server] 2026-09-17 21:26:31.814709 | localhost | Output suppressed because no_log was given 2026-09-17 21:26:31.821969 | 2026-09-17 21:26:31.822105 | LOOP [upload-logs : Compress console log and json output] 2026-09-17 21:26:31.886465 | localhost | skipping: Conditional result was False 2026-09-17 21:26:31.895868 | localhost | skipping: Conditional result was False 2026-09-17 21:26:31.910958 | 2026-09-17 21:26:31.911203 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-17 21:26:31.962423 | localhost | skipping: Conditional result was False 2026-09-17 21:26:31.962781 | 2026-09-17 21:26:31.966183 | localhost | skipping: Conditional result was False 2026-09-17 21:26:31.975990 | 2026-09-17 21:26:31.976187 | LOOP [upload-logs : Upload console log and json output]