2026-09-08 01:54:40.366958 | Job console starting 2026-09-08 01:54:40.380747 | Updating git repos 2026-09-08 01:54:43.216839 | Cloning repos into workspace 2026-09-08 01:55:01.091934 | Restoring repo states 2026-09-08 01:55:11.284822 | Merging changes 2026-09-08 01:55:12.618805 | Checking out repos 2026-09-08 01:55:18.596216 | Preparing playbooks 2026-09-08 01:55:25.512690 | Running Ansible setup 2026-09-08 01:55:29.529259 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-09-08 01:55:30.124371 | 2026-09-08 01:55:30.124487 | PLAY [localhost] 2026-09-08 01:55:30.131672 | 2026-09-08 01:55:30.131737 | TASK [Gathering Facts] 2026-09-08 01:55:31.050525 | localhost | ok 2026-09-08 01:55:31.077968 | 2026-09-08 01:55:31.078122 | TASK [Setup log path fact] 2026-09-08 01:55:31.095149 | localhost | ok 2026-09-08 01:55:31.108302 | 2026-09-08 01:55:31.108393 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-08 01:55:31.159153 | localhost | ok 2026-09-08 01:55:31.168564 | 2026-09-08 01:55:31.168672 | TASK [emit-job-header : Print job information] 2026-09-08 01:55:31.219573 | # Job Information 2026-09-08 01:55:31.219835 | Ansible Version: 2.16.18 2026-09-08 01:55:31.219921 | Job: atmosphere-molecule-aio-openvswitch 2026-09-08 01:55:31.219968 | Pipeline: check 2026-09-08 01:55:31.220009 | Executor: 2d72f0692154 2026-09-08 01:55:31.220049 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3501 2026-09-08 01:55:31.220096 | Event ID: e69d9fc0-ab27-11f1-927b-815621266e96 2026-09-08 01:55:31.225996 | 2026-09-08 01:55:31.226127 | LOOP [emit-job-header : Print node information] 2026-09-08 01:55:31.324049 | localhost | ok: 2026-09-08 01:55:31.324277 | localhost | # Node Information 2026-09-08 01:55:31.324335 | localhost | Inventory Hostname: instance 2026-09-08 01:55:31.324380 | localhost | Hostname: np0000192195 2026-09-08 01:55:31.324420 | localhost | Username: zuul 2026-09-08 01:55:31.324469 | localhost | Distro: Ubuntu 22.04 2026-09-08 01:55:31.324616 | localhost | Provider: yul1 2026-09-08 01:55:31.324720 | localhost | Region: ca-ymq-1 2026-09-08 01:55:31.324765 | localhost | Label: ubuntu-jammy-16 2026-09-08 01:55:31.324805 | localhost | Product Name: OpenStack Nova 2026-09-08 01:55:31.324843 | localhost | Interface IP: 162.253.55.239 2026-09-08 01:55:31.339736 | 2026-09-08 01:55:31.339887 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-08 01:55:31.721709 | localhost -> localhost | changed 2026-09-08 01:55:31.727278 | 2026-09-08 01:55:31.727361 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-08 01:55:32.591258 | localhost -> localhost | changed 2026-09-08 01:55:32.602369 | 2026-09-08 01:55:32.602482 | PLAY [all] 2026-09-08 01:55:32.616320 | 2026-09-08 01:55:32.616451 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-08 01:55:32.864129 | instance -> localhost | ok 2026-09-08 01:55:32.877240 | 2026-09-08 01:55:32.877371 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-08 01:55:32.911272 | instance | ok 2026-09-08 01:55:32.938519 | instance | included: /var/lib/zuul/builds/4ca16e723aa54547b83cb83c032b01cc/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-08 01:55:32.945705 | 2026-09-08 01:55:32.945787 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-08 01:55:33.666735 | instance -> localhost | Generating public/private rsa key pair. 2026-09-08 01:55:33.666981 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/4ca16e723aa54547b83cb83c032b01cc/work/4ca16e723aa54547b83cb83c032b01cc_id_rsa 2026-09-08 01:55:33.667039 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/4ca16e723aa54547b83cb83c032b01cc/work/4ca16e723aa54547b83cb83c032b01cc_id_rsa.pub 2026-09-08 01:55:33.667084 | instance -> localhost | The key fingerprint is: 2026-09-08 01:55:33.667126 | instance -> localhost | SHA256:Mkpc73OkcgfYCxCs8hdlNF3lTTOIvexhP4sHNn3/COw zuul-build-sshkey 2026-09-08 01:55:33.667185 | instance -> localhost | The key's randomart image is: 2026-09-08 01:55:33.667228 | instance -> localhost | +---[RSA 3072]----+ 2026-09-08 01:55:33.667279 | instance -> localhost | | ...o. ..+..+ | 2026-09-08 01:55:33.667323 | instance -> localhost | | ..o.. ..oo o | 2026-09-08 01:55:33.667363 | instance -> localhost | | ..o. .... | 2026-09-08 01:55:33.667404 | instance -> localhost | |. ...o + = | 2026-09-08 01:55:33.667443 | instance -> localhost | | o o.= S .o + | 2026-09-08 01:55:33.667483 | instance -> localhost | | .... = = .= + .| 2026-09-08 01:55:33.667521 | instance -> localhost | | .. . * o.o+ +.| 2026-09-08 01:55:33.667560 | instance -> localhost | | o + ...o..| 2026-09-08 01:55:33.667604 | instance -> localhost | | E.. o| 2026-09-08 01:55:33.667669 | instance -> localhost | +----[SHA256]-----+ 2026-09-08 01:55:33.667788 | instance -> localhost | ok: Runtime: 0:00:00.263461 2026-09-08 01:55:33.678731 | 2026-09-08 01:55:33.678855 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-08 01:55:33.708683 | instance | ok 2026-09-08 01:55:33.718800 | instance | included: /var/lib/zuul/builds/4ca16e723aa54547b83cb83c032b01cc/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-08 01:55:33.727691 | 2026-09-08 01:55:33.727790 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-08 01:55:33.743414 | instance | skipping: Conditional result was False 2026-09-08 01:55:33.750624 | 2026-09-08 01:55:33.750734 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-08 01:55:34.259317 | instance | changed 2026-09-08 01:55:34.270049 | 2026-09-08 01:55:34.270178 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-08 01:55:34.496886 | instance | ok 2026-09-08 01:55:34.502619 | 2026-09-08 01:55:34.502714 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-08 01:55:35.018936 | instance | changed 2026-09-08 01:55:35.028367 | 2026-09-08 01:55:35.028537 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-08 01:55:35.571259 | instance | changed 2026-09-08 01:55:35.584823 | 2026-09-08 01:55:35.585017 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-08 01:55:35.610784 | instance | skipping: Conditional result was False 2026-09-08 01:55:35.622476 | 2026-09-08 01:55:35.622615 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-08 01:55:35.951151 | instance -> localhost | changed 2026-09-08 01:55:35.960594 | 2026-09-08 01:55:35.960673 | TASK [add-build-sshkey : Add back temp key] 2026-09-08 01:55:36.328871 | instance -> localhost | Identity added: /var/lib/zuul/builds/4ca16e723aa54547b83cb83c032b01cc/work/4ca16e723aa54547b83cb83c032b01cc_id_rsa (zuul-build-sshkey) 2026-09-08 01:55:36.329210 | instance -> localhost | ok: Runtime: 0:00:00.015718 2026-09-08 01:55:36.338826 | 2026-09-08 01:55:36.338951 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-08 01:55:36.639309 | instance | ok 2026-09-08 01:55:36.652104 | 2026-09-08 01:55:36.652292 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-08 01:55:36.687598 | instance | skipping: Conditional result was False 2026-09-08 01:55:36.708274 | 2026-09-08 01:55:36.708413 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-09-08 01:55:37.026978 | instance | ok 2026-09-08 01:55:37.037501 | 2026-09-08 01:55:37.037626 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-09-08 01:55:42.416950 | instance | Output suppressed because no_log was given 2026-09-08 01:55:42.437002 | 2026-09-08 01:55:42.437204 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-09-08 01:55:42.653924 | instance | ok: "logs" 2026-09-08 01:55:42.654339 | instance | ok: All items complete 2026-09-08 01:55:42.654404 | 2026-09-08 01:55:42.835557 | instance | ok: "artifacts" 2026-09-08 01:55:42.981956 | instance | ok: "docs" 2026-09-08 01:55:43.000385 | 2026-09-08 01:55:43.000593 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-09-08 01:55:43.215231 | instance | changed: "logs" 2026-09-08 01:55:43.391283 | instance | changed: "artifacts" 2026-09-08 01:55:43.572007 | instance | changed: "docs" 2026-09-08 01:55:43.594183 | 2026-09-08 01:55:43.594345 | PLAY RECAP 2026-09-08 01:55:43.594450 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-09-08 01:55:43.594524 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-08 01:55:43.594581 | 2026-09-08 01:55:43.727599 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-09-08 01:55:43.736136 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-09-08 01:55:44.293749 | 2026-09-08 01:55:44.294044 | PLAY [all] 2026-09-08 01:55:44.305433 | 2026-09-08 01:55:44.305514 | TASK [setup-uv : Extract archive] 2026-09-08 01:55:46.625929 | instance | changed 2026-09-08 01:55:46.636943 | 2026-09-08 01:55:46.637106 | TASK [setup-uv : Print version] 2026-09-08 01:55:47.034563 | instance | uv 0.8.13 2026-09-08 01:55:47.186054 | instance | ok: Runtime: 0:00:00.012848 2026-09-08 01:55:47.203867 | 2026-09-08 01:55:47.204020 | TASK [Install Ansible collection siblings] 2026-09-08 01:55:56.446098 | instance | changed: 2026-09-08 01:55:56.446411 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-09-08 01:55:56.446472 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-09-08 01:55:56.446518 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-09-08 01:55:56.446559 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto 2026-09-08 01:55:56.446599 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general 2026-09-08 01:55:56.446665 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql 2026-09-08 01:55:56.446709 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-09-08 01:55:56.446754 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-09-08 01:55:56.446794 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-09-08 01:55:56.446834 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-09-08 01:55:56.446874 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-09-08 01:55:56.446912 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-09-08 01:55:56.446951 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0 2026-09-08 01:55:56.446989 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0 2026-09-08 01:55:56.447027 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0 2026-09-08 01:55:56.447067 | instance | Resolved community.crypto to 2.2.3 for 2.2.3 2026-09-08 01:55:56.447104 | instance | Resolved community.general to 7.3.0 for 7.3.0 2026-09-08 01:55:56.447141 | instance | Resolved community.mysql to 3.6.0 for 3.6.0 2026-09-08 01:55:56.447179 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0 2026-09-08 01:55:56.447216 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0 2026-09-08 01:55:56.447253 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0 2026-09-08 01:55:56.447291 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0 2026-09-08 01:55:56.447330 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-09-08 01:55:56.447395 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0 2026-09-08 01:55:56.447434 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0 2026-09-08 01:55:56.447471 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-09-08 01:55:56.447507 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-09-08 01:55:56.447543 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-09-08 01:55:56.447579 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0 2026-09-08 01:55:56.447637 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3 2026-09-08 01:55:56.447675 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-09-08 01:55:56.447712 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-09-08 01:55:56.447748 | instance | Checked out ansible.netcommon to 1.2.0 2026-09-08 01:55:56.447785 | 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-08 01:55:56.447833 | instance | Starting galaxy collection install process 2026-09-08 01:55:56.447869 | instance | Process install dependency map 2026-09-08 01:55:56.447906 | instance | Starting collection install process 2026-09-08 01:55:56.447943 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon' 2026-09-08 01:55:56.447979 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon 2026-09-08 01:55:56.448015 | instance | ansible.netcommon:* was installed successfully 2026-09-08 01:55:56.448050 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-09-08 01:55:56.448086 | instance | Creating virtual environment at: .venv 2026-09-08 01:55:56.448121 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-09-08 01:55:56.448156 | instance | Downloading rjsonnet (1.2MiB) 2026-09-08 01:55:56.448210 | instance | Downloading ansible-core (2.1MiB) 2026-09-08 01:55:56.448254 | instance | Downloading openstacksdk (1.7MiB) 2026-09-08 01:55:56.448292 | instance | Downloading kubernetes (1.9MiB) 2026-09-08 01:55:56.448329 | instance | Downloading pygments (1.2MiB) 2026-09-08 01:55:56.448365 | instance | Downloading netaddr (2.2MiB) 2026-09-08 01:55:56.448401 | instance | Downloading cryptography (4.2MiB) 2026-09-08 01:55:56.448438 | instance | Downloading pydantic-core (2.0MiB) 2026-09-08 01:55:56.448474 | instance | Downloading setuptools (1.1MiB) 2026-09-08 01:55:56.448542 | instance | Downloading rjsonnet 2026-09-08 01:55:56.448584 | instance | Building pyperclip==1.9.0 2026-09-08 01:55:56.448644 | instance | Downloading pydantic-core 2026-09-08 01:55:56.448682 | instance | Downloading pygments 2026-09-08 01:55:56.448717 | instance | Downloading netaddr 2026-09-08 01:55:56.448752 | instance | Downloading cryptography 2026-09-08 01:55:56.448788 | instance | Downloading setuptools 2026-09-08 01:55:56.448823 | instance | Downloading kubernetes 2026-09-08 01:55:56.448858 | instance | Downloading ansible-core 2026-09-08 01:55:56.448894 | instance | Downloading openstacksdk 2026-09-08 01:55:56.448929 | instance | Built pyperclip==1.9.0 2026-09-08 01:55:56.448966 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-09-08 01:55:56.449003 | instance | Installed 83 packages in 56ms 2026-09-08 01:55:56.449038 | instance | Checked out ansible.posix to 1.6.0 2026-09-08 01:55:56.449073 | 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-08 01:55:56.449108 | instance | Starting galaxy collection install process 2026-09-08 01:55:56.449143 | instance | Process install dependency map 2026-09-08 01:55:56.449188 | instance | Starting collection install process 2026-09-08 01:55:56.449225 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-09-08 01:55:56.449262 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix 2026-09-08 01:55:56.449299 | instance | ansible.posix:1.6.0 was installed successfully 2026-09-08 01:55:56.449336 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-08 01:55:56.449373 | instance | 2.17.12 2026-09-08 01:55:56.449409 | instance | Checked out ansible.utils to v6.1.0 2026-09-08 01:55:56.449446 | 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-08 01:55:56.449481 | instance | Starting galaxy collection install process 2026-09-08 01:55:56.449517 | instance | Process install dependency map 2026-09-08 01:55:56.449551 | instance | Starting collection install process 2026-09-08 01:55:56.449588 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils' 2026-09-08 01:55:56.449643 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils 2026-09-08 01:55:56.449682 | instance | ansible.utils:6.1.0 was installed successfully 2026-09-08 01:55:56.449718 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-08 01:55:56.449755 | instance | 2.17.12 2026-09-08 01:55:56.449791 | instance | Checked out atmosphere.common to v0.7.0 2026-09-08 01:55:56.449827 | 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-08 01:55:56.449863 | instance | Starting galaxy collection install process 2026-09-08 01:55:56.449898 | instance | Process install dependency map 2026-09-08 01:55:56.449934 | instance | Starting collection install process 2026-09-08 01:55:56.449969 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common' 2026-09-08 01:55:56.450004 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common 2026-09-08 01:55:56.450040 | instance | atmosphere.common:0.7.0 was installed successfully 2026-09-08 01:55:56.450076 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-08 01:55:56.450111 | instance | 2.17.12 2026-09-08 01:55:56.450146 | instance | Checked out community.crypto to 2.2.3 2026-09-08 01:55:56.450181 | 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-08 01:55:56.450217 | instance | Starting galaxy collection install process 2026-09-08 01:55:56.450253 | instance | Process install dependency map 2026-09-08 01:55:56.450287 | instance | Starting collection install process 2026-09-08 01:55:56.450322 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-09-08 01:55:56.450359 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto 2026-09-08 01:55:56.450394 | instance | community.crypto:2.2.3 was installed successfully 2026-09-08 01:55:56.450429 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-08 01:55:56.450465 | instance | 2.17.12 2026-09-08 01:55:56.450501 | instance | Checked out community.general to 7.3.0 2026-09-08 01:55:56.450537 | 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-08 01:55:56.450582 | instance | Starting galaxy collection install process 2026-09-08 01:55:56.450635 | instance | Process install dependency map 2026-09-08 01:55:56.450674 | instance | Starting collection install process 2026-09-08 01:55:56.450709 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-09-08 01:55:56.450745 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general 2026-09-08 01:55:56.450781 | instance | community.general:7.3.0 was installed successfully 2026-09-08 01:55:56.450817 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-08 01:55:56.450854 | instance | 2.17.12 2026-09-08 01:55:56.450890 | instance | Checked out community.mysql to 3.6.0 2026-09-08 01:55:56.450931 | 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-08 01:55:56.450968 | instance | Starting galaxy collection install process 2026-09-08 01:55:56.451003 | instance | Process install dependency map 2026-09-08 01:55:56.451039 | instance | Starting collection install process 2026-09-08 01:55:56.451075 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql' 2026-09-08 01:55:56.451111 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql 2026-09-08 01:55:56.451147 | instance | community.mysql:3.6.0 was installed successfully 2026-09-08 01:55:56.451184 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-08 01:55:56.451219 | instance | 2.17.12 2026-09-08 01:55:56.451255 | instance | Checked out kubernetes.core to 2.4.0 2026-09-08 01:55:56.451292 | 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-08 01:55:56.451328 | instance | Starting galaxy collection install process 2026-09-08 01:55:56.451364 | instance | Process install dependency map 2026-09-08 01:55:56.451400 | instance | Starting collection install process 2026-09-08 01:55:56.451436 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core' 2026-09-08 01:55:56.451471 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core 2026-09-08 01:55:56.451507 | instance | kubernetes.core:2.4.0 was installed successfully 2026-09-08 01:55:56.451543 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-08 01:55:56.451579 | instance | 2.17.12 2026-09-08 01:55:56.451614 | instance | Checked out openstack.cloud to 2.6.0 2026-09-08 01:55:56.451671 | 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-08 01:55:56.451707 | instance | Starting galaxy collection install process 2026-09-08 01:55:56.451743 | instance | Process install dependency map 2026-09-08 01:55:56.451777 | instance | Starting collection install process 2026-09-08 01:55:56.451813 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud' 2026-09-08 01:55:56.451847 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud 2026-09-08 01:55:56.451883 | instance | openstack.cloud:2.6.0 was installed successfully 2026-09-08 01:55:56.451919 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-08 01:55:56.451954 | instance | 2.17.12 2026-09-08 01:55:56.451999 | instance | Checked out vexxhost.ceph to v4.2.0 2026-09-08 01:55:56.452036 | 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-08 01:55:56.452072 | instance | Starting galaxy collection install process 2026-09-08 01:55:56.452108 | instance | Process install dependency map 2026-09-08 01:55:56.452144 | instance | Starting collection install process 2026-09-08 01:55:56.452180 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph' 2026-09-08 01:55:56.452216 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph 2026-09-08 01:55:56.452252 | instance | vexxhost.ceph:4.2.0 was installed successfully 2026-09-08 01:55:56.452287 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-08 01:55:56.452322 | instance | 2.17.12 2026-09-08 01:55:56.452358 | instance | Checked out vexxhost.containers to v1.6.8 2026-09-08 01:55:56.452394 | 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-08 01:55:56.452430 | instance | Starting galaxy collection install process 2026-09-08 01:55:56.452466 | instance | Process install dependency map 2026-09-08 01:55:56.452574 | instance | Starting collection install process 2026-09-08 01:55:56.452636 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers' 2026-09-08 01:55:56.452678 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers 2026-09-08 01:55:56.452714 | instance | vexxhost.containers:1.6.8 was installed successfully 2026-09-08 01:55:56.452752 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-08 01:55:56.452789 | instance | 2.17.12 2026-09-08 01:55:56.452825 | instance | Checked out vexxhost.kubernetes to v3.3.0 2026-09-08 01:55:56.452861 | 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-08 01:55:56.452896 | instance | Starting galaxy collection install process 2026-09-08 01:55:56.452932 | instance | Process install dependency map 2026-09-08 01:55:56.452966 | instance | Starting collection install process 2026-09-08 01:55:56.453001 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes' 2026-09-08 01:55:56.453036 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes 2026-09-08 01:55:56.453072 | instance | vexxhost.kubernetes:3.3.0 was installed successfully 2026-09-08 01:55:56.453108 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-08 01:55:56.453143 | instance | 2.17.12 2026-09-08 01:55:56.464264 | 2026-09-08 01:55:56.464359 | PLAY RECAP 2026-09-08 01:55:56.464447 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-08 01:55:56.464537 | 2026-09-08 01:55:56.641870 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-09-08 01:55:56.651238 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-09-08 01:55:57.264840 | 2026-09-08 01:55:57.264937 | PLAY [all] 2026-09-08 01:55:57.275145 | 2026-09-08 01:55:57.275212 | TASK [Install "jq" for log collection] 2026-09-08 01:56:05.837978 | instance | changed 2026-09-08 01:56:05.841065 | 2026-09-08 01:56:05.841187 | PLAY RECAP 2026-09-08 01:56:05.841277 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-08 01:56:05.841383 | 2026-09-08 01:56:05.966199 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-09-08 01:56:05.978698 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-09-08 01:56:06.616137 | 2026-09-08 01:56:06.616306 | PLAY [all] 2026-09-08 01:56:06.628798 | 2026-09-08 01:56:06.628934 | LOOP [Check inventory directories] 2026-09-08 01:56:07.012593 | instance | ok: "src/github.com/vexxhost/atmosphere" 2026-09-08 01:56:07.175245 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/aio/inventory" 2026-09-08 01:56:07.343597 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/aio/inventory" 2026-09-08 01:56:07.357868 | 2026-09-08 01:56:07.358195 | LOOP [Copy inventory file for Zuul] 2026-09-08 01:56:08.181454 | instance | changed: 2026-09-08 01:56:08.182047 | instance | { 2026-09-08 01:56:08.182108 | instance | "ansible_loop_var": "item", 2026-09-08 01:56:08.182153 | instance | "changed": false, 2026-09-08 01:56:08.182191 | instance | "failed": false, 2026-09-08 01:56:08.182234 | instance | "invocation": { 2026-09-08 01:56:08.182269 | instance | "module_args": { 2026-09-08 01:56:08.182304 | instance | "checksum_algorithm": "sha1", 2026-09-08 01:56:08.182338 | instance | "follow": true, 2026-09-08 01:56:08.182371 | instance | "get_attributes": true, 2026-09-08 01:56:08.182408 | instance | "get_checksum": true, 2026-09-08 01:56:08.182441 | instance | "get_mime": true, 2026-09-08 01:56:08.182474 | instance | "path": "src/github.com/vexxhost/atmosphere" 2026-09-08 01:56:08.182508 | instance | } 2026-09-08 01:56:08.182540 | instance | }, 2026-09-08 01:56:08.182573 | instance | "item": "src/github.com/vexxhost/atmosphere", 2026-09-08 01:56:08.182605 | instance | "stat": { 2026-09-08 01:56:08.182663 | instance | "atime": 1788832549.465408, 2026-09-08 01:56:08.182698 | instance | "attr_flags": "e", 2026-09-08 01:56:08.182731 | instance | "attributes": [ 2026-09-08 01:56:08.182764 | instance | "extents" 2026-09-08 01:56:08.182797 | instance | ], 2026-09-08 01:56:08.182828 | instance | "block_size": 4096, 2026-09-08 01:56:08.182860 | instance | "blocks": 8, 2026-09-08 01:56:08.182892 | instance | "charset": "unknown", 2026-09-08 01:56:08.182926 | instance | "ctime": 1788832548.1733527, 2026-09-08 01:56:08.182959 | instance | "dev": 64513, 2026-09-08 01:56:08.182991 | instance | "device_type": 0, 2026-09-08 01:56:08.183023 | instance | "executable": true, 2026-09-08 01:56:08.183056 | instance | "exists": true, 2026-09-08 01:56:08.183087 | instance | "gid": 1000, 2026-09-08 01:56:08.183119 | instance | "gr_name": "zuul", 2026-09-08 01:56:08.183151 | instance | "inode": 1047571, 2026-09-08 01:56:08.183182 | instance | "isblk": false, 2026-09-08 01:56:08.183217 | instance | "ischr": false, 2026-09-08 01:56:08.183250 | instance | "isdir": true, 2026-09-08 01:56:08.183281 | instance | "isfifo": false, 2026-09-08 01:56:08.183313 | instance | "isgid": false, 2026-09-08 01:56:08.183344 | instance | "islnk": false, 2026-09-08 01:56:08.183376 | instance | "isreg": false, 2026-09-08 01:56:08.183407 | instance | "issock": false, 2026-09-08 01:56:08.183439 | instance | "isuid": false, 2026-09-08 01:56:08.183470 | instance | "mimetype": "unknown", 2026-09-08 01:56:08.183502 | instance | "mode": "0755", 2026-09-08 01:56:08.183533 | instance | "mtime": 1788832548.1733527, 2026-09-08 01:56:08.183564 | instance | "nlink": 23, 2026-09-08 01:56:08.183596 | instance | "path": "src/github.com/vexxhost/atmosphere", 2026-09-08 01:56:08.183646 | instance | "pw_name": "zuul", 2026-09-08 01:56:08.183687 | instance | "readable": true, 2026-09-08 01:56:08.183721 | instance | "rgrp": true, 2026-09-08 01:56:08.183753 | instance | "roth": true, 2026-09-08 01:56:08.183800 | instance | "rusr": true, 2026-09-08 01:56:08.183835 | instance | "size": 4096, 2026-09-08 01:56:08.183868 | instance | "uid": 1000, 2026-09-08 01:56:08.183901 | instance | "version": "160287045", 2026-09-08 01:56:08.183933 | instance | "wgrp": false, 2026-09-08 01:56:08.183969 | instance | "woth": false, 2026-09-08 01:56:08.184004 | instance | "writeable": true, 2026-09-08 01:56:08.184036 | instance | "wusr": true, 2026-09-08 01:56:08.184068 | instance | "xgrp": true, 2026-09-08 01:56:08.184100 | instance | "xoth": true, 2026-09-08 01:56:08.184132 | instance | "xusr": true 2026-09-08 01:56:08.184164 | instance | } 2026-09-08 01:56:08.184196 | instance | } 2026-09-08 01:56:08.184261 | instance | ok: All items complete 2026-09-08 01:56:08.184301 | 2026-09-08 01:56:08.186644 | instance | skipping: Conditional result was False 2026-09-08 01:56:08.187781 | instance | skipping: Conditional result was False 2026-09-08 01:56:08.212394 | 2026-09-08 01:56:08.212681 | LOOP [Switch "ansible_host" to private IP] 2026-09-08 01:56:08.597083 | instance | changed: 1 replacements made 2026-09-08 01:56:08.599457 | instance | skipping: Conditional result was False 2026-09-08 01:56:08.605387 | instance | skipping: Conditional result was False 2026-09-08 01:56:08.619186 | 2026-09-08 01:56:08.619369 | TASK [Run Molecule scenario] 2026-09-08 01:56:09.506318 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-09-08 01:56:09.921939 | instance | INFO [aio > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-09-08 01:56:09.922092 | instance | INFO [aio > prerun] Performing prerun with role_name_check=0... 2026-09-08 01:56:20.971013 | instance | INFO [aio > dependency] Executing 2026-09-08 01:56:20.971401 | instance | WARNING [aio > dependency] Missing roles requirements file: requirements.yml 2026-09-08 01:56:20.971806 | instance | WARNING [aio > dependency] Missing collections requirements file: collections.yml 2026-09-08 01:56:20.972105 | instance | WARNING [aio > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-09-08 01:56:20.987206 | instance | INFO [aio > cleanup] Executing 2026-09-08 01:56:20.987875 | instance | WARNING [aio > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-09-08 01:56:21.001452 | instance | INFO [aio > destroy] Executing 2026-09-08 01:56:21.001508 | instance | WARNING [aio > destroy] Skipping, '--destroy=never' requested. 2026-09-08 01:56:21.001652 | instance | INFO [aio > destroy] Executed: Successful 2026-09-08 01:56:21.010544 | instance | INFO [aio > syntax] Executing 2026-09-08 01:56:23.734496 | instance | 2026-09-08 01:56:23.734842 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/aio/converge.yml 2026-09-08 01:56:23.881033 | instance | INFO [aio > syntax] Executed: Successful 2026-09-08 01:56:23.897795 | instance | INFO [aio > create] Executing 2026-09-08 01:56:23.911846 | instance | WARNING [aio > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-09-08 01:56:23.927912 | instance | INFO [aio > prepare] Executing 2026-09-08 01:56:24.715412 | instance | 2026-09-08 01:56:24.715579 | instance | PLAY [Prepare] ***************************************************************** 2026-09-08 01:56:24.715790 | instance | 2026-09-08 01:56:24.716057 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-08 01:56:24.716291 | instance | Tuesday 08 September 2026 01:56:24 +0000 (0:00:00.024) 0:00:00.024 ***** 2026-09-08 01:56:25.946037 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-09-08 01:56:25.946150 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-09-08 01:56:25.946388 | instance | interpreter could change the meaning of that path. See 2026-09-08 01:56:25.946642 | instance | https://docs.ansible.com/ansible- 2026-09-08 01:56:25.946902 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-09-08 01:56:25.956991 | instance | ok: [instance] 2026-09-08 01:56:25.957194 | instance | 2026-09-08 01:56:25.957418 | instance | TASK [Configure short hostname] ************************************************ 2026-09-08 01:56:25.957645 | instance | Tuesday 08 September 2026 01:56:25 +0000 (0:00:01.242) 0:00:01.266 ***** 2026-09-08 01:56:26.703881 | instance | changed: [instance] 2026-09-08 01:56:26.704145 | instance | 2026-09-08 01:56:26.704486 | instance | TASK [Ensure hostname inside hosts file] *************************************** 2026-09-08 01:56:26.704784 | instance | Tuesday 08 September 2026 01:56:26 +0000 (0:00:00.746) 0:00:02.013 ***** 2026-09-08 01:56:26.988737 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created 2026-09-08 01:56:26.989046 | instance | with a mode of 0700, this may cause issues when running as another user. To 2026-09-08 01:56:26.989328 | instance | avoid this, create the remote_tmp dir with the correct permissions manually 2026-09-08 01:56:26.998194 | instance | changed: [instance] 2026-09-08 01:56:26.998462 | instance | 2026-09-08 01:56:26.998752 | instance | TASK [Install "dirmngr" for GPG keyserver operations] ************************** 2026-09-08 01:56:26.999072 | instance | Tuesday 08 September 2026 01:56:26 +0000 (0:00:00.294) 0:00:02.308 ***** 2026-09-08 01:56:28.301053 | instance | ok: [instance] 2026-09-08 01:56:28.301238 | instance | 2026-09-08 01:56:28.301465 | instance | TASK [Purge "snapd" package] *************************************************** 2026-09-08 01:56:28.301692 | instance | Tuesday 08 September 2026 01:56:28 +0000 (0:00:01.302) 0:00:03.610 ***** 2026-09-08 01:56:29.035626 | instance | ok: [instance] 2026-09-08 01:56:29.035776 | instance | 2026-09-08 01:56:29.036025 | instance | PLAY [Generate workspace for Atmosphere] *************************************** 2026-09-08 01:56:29.036236 | instance | 2026-09-08 01:56:29.036594 | instance | TASK [Create folders for workspace] ******************************************** 2026-09-08 01:56:29.036847 | instance | Tuesday 08 September 2026 01:56:29 +0000 (0:00:00.734) 0:00:04.345 ***** 2026-09-08 01:56:30.065221 | instance | changed: [localhost] => (item=group_vars) 2026-09-08 01:56:30.065475 | instance | changed: [localhost] => (item=group_vars/all) 2026-09-08 01:56:30.065727 | instance | changed: [localhost] => (item=group_vars/controllers) 2026-09-08 01:56:30.065957 | instance | changed: [localhost] => (item=group_vars/cephs) 2026-09-08 01:56:30.066197 | instance | changed: [localhost] => (item=group_vars/computes) 2026-09-08 01:56:30.066399 | instance | changed: [localhost] => (item=host_vars) 2026-09-08 01:56:30.066594 | instance | 2026-09-08 01:56:30.066867 | instance | PLAY [Generate Ceph control plane configuration for workspace] ***************** 2026-09-08 01:56:30.067071 | instance | 2026-09-08 01:56:30.067295 | instance | TASK [Ensure the Ceph control plane configuration file exists] ***************** 2026-09-08 01:56:30.067505 | instance | Tuesday 08 September 2026 01:56:30 +0000 (0:00:01.029) 0:00:05.374 ***** 2026-09-08 01:56:30.254058 | instance | changed: [localhost] 2026-09-08 01:56:30.254220 | instance | 2026-09-08 01:56:30.254453 | instance | TASK [Load the current Ceph control plane configuration into a variable] ******* 2026-09-08 01:56:30.254680 | instance | Tuesday 08 September 2026 01:56:30 +0000 (0:00:00.188) 0:00:05.563 ***** 2026-09-08 01:56:30.276998 | instance | ok: [localhost] 2026-09-08 01:56:30.277216 | instance | 2026-09-08 01:56:30.277442 | instance | TASK [Generate Ceph control plane values for missing variables] **************** 2026-09-08 01:56:30.277665 | instance | Tuesday 08 September 2026 01:56:30 +0000 (0:00:00.023) 0:00:05.587 ***** 2026-09-08 01:56:30.341929 | instance | ok: [localhost] => (item={'key': 'ceph_fsid', 'value': 'cbb9d5b4-68a4-5fbe-ac27-640cedf901e0'}) 2026-09-08 01:56:30.342149 | instance | ok: [localhost] => (item={'key': 'ceph_mon_public_network', 'value': '10.96.240.0/24'}) 2026-09-08 01:56:30.342355 | instance | 2026-09-08 01:56:30.342582 | instance | TASK [Write new Ceph control plane configuration file to disk] ***************** 2026-09-08 01:56:30.342804 | instance | Tuesday 08 September 2026 01:56:30 +0000 (0:00:00.064) 0:00:05.651 ***** 2026-09-08 01:56:30.923829 | instance | changed: [localhost] 2026-09-08 01:56:30.924043 | instance | 2026-09-08 01:56:30.924311 | instance | PLAY [Generate Ceph OSD configuration for workspace] *************************** 2026-09-08 01:56:30.924562 | instance | 2026-09-08 01:56:30.924817 | instance | TASK [Ensure the Ceph OSDs configuration file exists] ************************** 2026-09-08 01:56:30.925173 | instance | Tuesday 08 September 2026 01:56:30 +0000 (0:00:00.581) 0:00:06.233 ***** 2026-09-08 01:56:31.107974 | instance | changed: [localhost] 2026-09-08 01:56:31.108041 | instance | 2026-09-08 01:56:31.108053 | instance | TASK [Load the current Ceph OSDs configuration into a variable] **************** 2026-09-08 01:56:31.108063 | instance | Tuesday 08 September 2026 01:56:31 +0000 (0:00:00.183) 0:00:06.416 ***** 2026-09-08 01:56:31.138253 | instance | ok: [localhost] 2026-09-08 01:56:31.138564 | instance | 2026-09-08 01:56:31.138906 | instance | TASK [Generate Ceph OSDs values for missing variables] ************************* 2026-09-08 01:56:31.139205 | instance | Tuesday 08 September 2026 01:56:31 +0000 (0:00:00.031) 0:00:06.447 ***** 2026-09-08 01:56:31.184525 | instance | ok: [localhost] => (item={'key': 'ceph_osd_devices', 'value': ['/dev/vdb', '/dev/vdc', '/dev/vdd']}) 2026-09-08 01:56:31.185247 | instance | 2026-09-08 01:56:31.185328 | instance | TASK [Write new Ceph OSDs configuration file to disk] ************************** 2026-09-08 01:56:31.185340 | instance | Tuesday 08 September 2026 01:56:31 +0000 (0:00:00.045) 0:00:06.493 ***** 2026-09-08 01:56:31.591602 | instance | changed: [localhost] 2026-09-08 01:56:31.591883 | instance | 2026-09-08 01:56:31.592466 | instance | PLAY [Generate Kubernetes configuration for workspace] ************************* 2026-09-08 01:56:31.592528 | instance | 2026-09-08 01:56:31.592943 | instance | TASK [Ensure the Kubernetes configuration file exists] ************************* 2026-09-08 01:56:31.593174 | instance | Tuesday 08 September 2026 01:56:31 +0000 (0:00:00.407) 0:00:06.901 ***** 2026-09-08 01:56:31.789616 | instance | changed: [localhost] 2026-09-08 01:56:31.789683 | instance | 2026-09-08 01:56:31.789697 | instance | TASK [Load the current Kubernetes configuration into a variable] *************** 2026-09-08 01:56:31.789709 | instance | Tuesday 08 September 2026 01:56:31 +0000 (0:00:00.196) 0:00:07.097 ***** 2026-09-08 01:56:31.819772 | instance | ok: [localhost] 2026-09-08 01:56:31.819854 | instance | 2026-09-08 01:56:31.820058 | instance | TASK [Generate Kubernetes values for missing variables] ************************ 2026-09-08 01:56:31.820302 | instance | Tuesday 08 September 2026 01:56:31 +0000 (0:00:00.031) 0:00:07.129 ***** 2026-09-08 01:56:31.882840 | instance | ok: [localhost] => (item={'key': 'kubernetes_hostname', 'value': '10.96.240.10'}) 2026-09-08 01:56:31.883096 | instance | ok: [localhost] => (item={'key': 'kubernetes_keepalived_vrid', 'value': 42}) 2026-09-08 01:56:31.883434 | instance | ok: [localhost] => (item={'key': 'kubernetes_keepalived_vip', 'value': '10.96.240.10'}) 2026-09-08 01:56:31.883722 | instance | 2026-09-08 01:56:31.884050 | instance | TASK [Write new Kubernetes configuration file to disk] ************************* 2026-09-08 01:56:31.884387 | instance | Tuesday 08 September 2026 01:56:31 +0000 (0:00:00.062) 0:00:07.192 ***** 2026-09-08 01:56:32.274270 | instance | changed: [localhost] 2026-09-08 01:56:32.274349 | instance | 2026-09-08 01:56:32.275136 | instance | PLAY [Generate Keepalived configuration for workspace] ************************* 2026-09-08 01:56:32.275197 | instance | 2026-09-08 01:56:32.275204 | instance | TASK [Ensure the Keeaplived configuration file exists] ************************* 2026-09-08 01:56:32.275211 | instance | Tuesday 08 September 2026 01:56:32 +0000 (0:00:00.391) 0:00:07.584 ***** 2026-09-08 01:56:32.470761 | instance | changed: [localhost] 2026-09-08 01:56:32.471711 | instance | 2026-09-08 01:56:32.471771 | instance | TASK [Load the current Keepalived configuration into a variable] *************** 2026-09-08 01:56:32.471804 | instance | Tuesday 08 September 2026 01:56:32 +0000 (0:00:00.195) 0:00:07.780 ***** 2026-09-08 01:56:32.505021 | instance | ok: [localhost] 2026-09-08 01:56:32.505438 | instance | 2026-09-08 01:56:32.505469 | instance | TASK [Generate Keepalived values for missing variables] ************************ 2026-09-08 01:56:32.505477 | instance | Tuesday 08 September 2026 01:56:32 +0000 (0:00:00.034) 0:00:07.815 ***** 2026-09-08 01:56:32.553656 | instance | ok: [localhost] => (item={'key': 'keepalived_interface', 'value': 'br-ex'}) 2026-09-08 01:56:32.553909 | instance | ok: [localhost] => (item={'key': 'keepalived_vip', 'value': '10.96.250.10'}) 2026-09-08 01:56:32.554196 | instance | 2026-09-08 01:56:32.554484 | instance | TASK [Write new Keepalived configuration file to disk] ************************* 2026-09-08 01:56:32.554767 | instance | Tuesday 08 September 2026 01:56:32 +0000 (0:00:00.048) 0:00:07.863 ***** 2026-09-08 01:56:32.952845 | instance | changed: [localhost] 2026-09-08 01:56:32.952909 | instance | 2026-09-08 01:56:32.952996 | instance | PLAY [Generate endpoints for workspace] **************************************** 2026-09-08 01:56:32.953164 | instance | 2026-09-08 01:56:32.953333 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-08 01:56:32.953502 | instance | Tuesday 08 September 2026 01:56:32 +0000 (0:00:00.399) 0:00:08.262 ***** 2026-09-08 01:56:33.732249 | instance | ok: [localhost] 2026-09-08 01:56:33.732981 | instance | 2026-09-08 01:56:33.733013 | instance | TASK [Ensure the endpoints file exists] **************************************** 2026-09-08 01:56:33.733025 | instance | Tuesday 08 September 2026 01:56:33 +0000 (0:00:00.778) 0:00:09.041 ***** 2026-09-08 01:56:33.928219 | instance | changed: [localhost] 2026-09-08 01:56:33.928284 | instance | 2026-09-08 01:56:33.928561 | instance | TASK [Load the current endpoints into a variable] ****************************** 2026-09-08 01:56:33.928580 | instance | Tuesday 08 September 2026 01:56:33 +0000 (0:00:00.196) 0:00:09.238 ***** 2026-09-08 01:56:33.966552 | instance | ok: [localhost] 2026-09-08 01:56:33.966778 | instance | 2026-09-08 01:56:33.967277 | instance | TASK [Generate endpoint skeleton for missing variables] ************************ 2026-09-08 01:56:33.967307 | instance | Tuesday 08 September 2026 01:56:33 +0000 (0:00:00.038) 0:00:09.276 ***** 2026-09-08 01:56:34.659740 | instance | ok: [localhost] => (item=keycloak_host) 2026-09-08 01:56:34.660012 | instance | ok: [localhost] => (item=kube_prometheus_stack_grafana_host) 2026-09-08 01:56:34.660457 | instance | ok: [localhost] => (item=kube_prometheus_stack_alertmanager_host) 2026-09-08 01:56:34.660876 | instance | ok: [localhost] => (item=kube_prometheus_stack_prometheus_host) 2026-09-08 01:56:34.661250 | instance | ok: [localhost] => (item=openstack_helm_endpoints_region_name) 2026-09-08 01:56:34.661626 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_api_host) 2026-09-08 01:56:34.662022 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_api_host) 2026-09-08 01:56:34.662395 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_api_host) 2026-09-08 01:56:34.662815 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_api_host) 2026-09-08 01:56:34.663232 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_api_host) 2026-09-08 01:56:34.663646 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_api_host) 2026-09-08 01:56:34.664025 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_api_host) 2026-09-08 01:56:34.664342 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_novnc_host) 2026-09-08 01:56:34.664705 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_api_host) 2026-09-08 01:56:34.665083 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_api_host) 2026-09-08 01:56:34.665379 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_api_host) 2026-09-08 01:56:34.665659 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_api_host) 2026-09-08 01:56:34.666000 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_registry_host) 2026-09-08 01:56:34.666321 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_api_host) 2026-09-08 01:56:34.666612 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_cfn_api_host) 2026-09-08 01:56:34.666930 | instance | ok: [localhost] => (item=openstack_helm_endpoints_horizon_api_host) 2026-09-08 01:56:34.667272 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rgw_host) 2026-09-08 01:56:34.667575 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_api_host) 2026-09-08 01:56:34.667880 | instance | 2026-09-08 01:56:34.668175 | instance | TASK [Write new endpoints file to disk] **************************************** 2026-09-08 01:56:34.668566 | instance | Tuesday 08 September 2026 01:56:34 +0000 (0:00:00.692) 0:00:09.969 ***** 2026-09-08 01:56:35.046799 | instance | changed: [localhost] 2026-09-08 01:56:35.047159 | instance | 2026-09-08 01:56:35.047475 | instance | TASK [Ensure the endpoints file exists] **************************************** 2026-09-08 01:56:35.047804 | instance | Tuesday 08 September 2026 01:56:35 +0000 (0:00:00.387) 0:00:10.356 ***** 2026-09-08 01:56:35.236687 | instance | changed: [localhost] 2026-09-08 01:56:35.237024 | instance | 2026-09-08 01:56:35.237328 | instance | PLAY [Generate Neutron configuration for workspace] **************************** 2026-09-08 01:56:35.237600 | instance | 2026-09-08 01:56:35.237918 | instance | TASK [Ensure the Neutron configuration file exists] **************************** 2026-09-08 01:56:35.238208 | instance | Tuesday 08 September 2026 01:56:35 +0000 (0:00:00.190) 0:00:10.546 ***** 2026-09-08 01:56:35.427981 | instance | changed: [localhost] 2026-09-08 01:56:35.428287 | instance | 2026-09-08 01:56:35.428609 | instance | TASK [Load the current Neutron configuration into a variable] ****************** 2026-09-08 01:56:35.428931 | instance | Tuesday 08 September 2026 01:56:35 +0000 (0:00:00.191) 0:00:10.738 ***** 2026-09-08 01:56:35.454096 | instance | ok: [localhost] 2026-09-08 01:56:35.454400 | instance | 2026-09-08 01:56:35.454695 | instance | TASK [Generate Neutron values for missing variables] *************************** 2026-09-08 01:56:35.455006 | instance | Tuesday 08 September 2026 01:56:35 +0000 (0:00:00.026) 0:00:10.764 ***** 2026-09-08 01:56:35.491726 | 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-08 01:56:35.492103 | instance | 2026-09-08 01:56:35.492463 | instance | TASK [Write new Neutron configuration file to disk] **************************** 2026-09-08 01:56:35.492781 | instance | Tuesday 08 September 2026 01:56:35 +0000 (0:00:00.037) 0:00:10.802 ***** 2026-09-08 01:56:35.927297 | instance | changed: [localhost] 2026-09-08 01:56:35.927357 | instance | 2026-09-08 01:56:35.927368 | instance | PLAY [Generate Nova configuration for workspace] ******************************* 2026-09-08 01:56:35.927378 | instance | 2026-09-08 01:56:35.927388 | instance | TASK [Ensure the Nova configuration file exists] ******************************* 2026-09-08 01:56:35.927397 | instance | Tuesday 08 September 2026 01:56:35 +0000 (0:00:00.433) 0:00:11.235 ***** 2026-09-08 01:56:36.128486 | instance | changed: [localhost] 2026-09-08 01:56:36.128583 | instance | 2026-09-08 01:56:36.129120 | instance | TASK [Load the current Nova configuration into a variable] ********************* 2026-09-08 01:56:36.129164 | instance | Tuesday 08 September 2026 01:56:36 +0000 (0:00:00.202) 0:00:11.438 ***** 2026-09-08 01:56:36.166260 | instance | ok: [localhost] 2026-09-08 01:56:36.166926 | instance | 2026-09-08 01:56:36.166957 | instance | TASK [Generate Nova values for missing variables] ****************************** 2026-09-08 01:56:36.166968 | instance | Tuesday 08 September 2026 01:56:36 +0000 (0:00:00.037) 0:00:11.476 ***** 2026-09-08 01:56:36.222437 | 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-08 01:56:36.223431 | instance | 2026-09-08 01:56:36.223516 | instance | TASK [Write new Nova configuration file to disk] ******************************* 2026-09-08 01:56:36.223531 | instance | Tuesday 08 September 2026 01:56:36 +0000 (0:00:00.054) 0:00:11.531 ***** 2026-09-08 01:56:36.629649 | instance | changed: [localhost] 2026-09-08 01:56:36.629694 | instance | 2026-09-08 01:56:36.629707 | instance | PLAY [Generate secrets for workspace] ****************************************** 2026-09-08 01:56:36.629717 | instance | 2026-09-08 01:56:36.629726 | instance | TASK [Ensure the secrets file exists] ****************************************** 2026-09-08 01:56:36.629752 | instance | Tuesday 08 September 2026 01:56:36 +0000 (0:00:00.406) 0:00:11.938 ***** 2026-09-08 01:56:36.838157 | instance | changed: [localhost] 2026-09-08 01:56:36.838349 | instance | 2026-09-08 01:56:36.838362 | instance | TASK [Load the current secrets into a variable] ******************************** 2026-09-08 01:56:36.838383 | instance | Tuesday 08 September 2026 01:56:36 +0000 (0:00:00.208) 0:00:12.146 ***** 2026-09-08 01:56:36.878110 | instance | ok: [localhost] 2026-09-08 01:56:36.878354 | instance | 2026-09-08 01:56:36.878787 | instance | TASK [Generate secrets for missing variables] ********************************** 2026-09-08 01:56:36.879174 | instance | Tuesday 08 September 2026 01:56:36 +0000 (0:00:00.040) 0:00:12.187 ***** 2026-09-08 01:56:37.272758 | instance | ok: [localhost] => (item=heat_auth_encryption_key) 2026-09-08 01:56:37.273153 | instance | ok: [localhost] => (item=keepalived_password) 2026-09-08 01:56:37.273474 | instance | ok: [localhost] => (item=keycloak_admin_password) 2026-09-08 01:56:37.273843 | instance | ok: [localhost] => (item=keycloak_database_password) 2026-09-08 01:56:37.274155 | instance | ok: [localhost] => (item=keystone_keycloak_client_secret) 2026-09-08 01:56:37.274478 | instance | ok: [localhost] => (item=keystone_oidc_crypto_passphrase) 2026-09-08 01:56:37.274802 | instance | ok: [localhost] => (item=kube_prometheus_stack_grafana_admin_password) 2026-09-08 01:56:37.275093 | instance | ok: [localhost] => (item=octavia_heartbeat_key) 2026-09-08 01:56:37.275386 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rabbitmq_admin_password) 2026-09-08 01:56:37.275676 | instance | ok: [localhost] => (item=openstack_helm_endpoints_memcached_secret_key) 2026-09-08 01:56:37.275988 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_admin_password) 2026-09-08 01:56:37.276301 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_mariadb_password) 2026-09-08 01:56:37.276658 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_rabbitmq_password) 2026-09-08 01:56:37.277276 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_keystone_password) 2026-09-08 01:56:37.277596 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_mariadb_password) 2026-09-08 01:56:37.277916 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_rabbitmq_password) 2026-09-08 01:56:37.278210 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_keystone_password) 2026-09-08 01:56:37.278512 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_mariadb_password) 2026-09-08 01:56:37.278852 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_rabbitmq_password) 2026-09-08 01:56:37.279224 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_keystone_password) 2026-09-08 01:56:37.279573 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_mariadb_password) 2026-09-08 01:56:37.279911 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_keystone_password) 2026-09-08 01:56:37.280206 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_mariadb_password) 2026-09-08 01:56:37.280528 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_keystone_password) 2026-09-08 01:56:37.280848 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_mariadb_password) 2026-09-08 01:56:37.281142 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_rabbitmq_password) 2026-09-08 01:56:37.281589 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_metadata_secret) 2026-09-08 01:56:37.281902 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_keystone_password) 2026-09-08 01:56:37.282193 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_mariadb_password) 2026-09-08 01:56:37.282485 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_rabbitmq_password) 2026-09-08 01:56:37.282796 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_keystone_password) 2026-09-08 01:56:37.283088 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_mariadb_password) 2026-09-08 01:56:37.283377 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_rabbitmq_password) 2026-09-08 01:56:37.283665 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_keystone_password) 2026-09-08 01:56:37.283975 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_mariadb_password) 2026-09-08 01:56:37.284266 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_rabbitmq_password) 2026-09-08 01:56:37.284600 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_keystone_password) 2026-09-08 01:56:37.284921 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_mariadb_password) 2026-09-08 01:56:37.285210 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_rabbitmq_password) 2026-09-08 01:56:37.285500 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_keystone_password) 2026-09-08 01:56:37.285812 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_mariadb_password) 2026-09-08 01:56:37.286102 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_rabbitmq_password) 2026-09-08 01:56:37.286414 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_keystone_password) 2026-09-08 01:56:37.286742 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_trustee_keystone_password) 2026-09-08 01:56:37.287051 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_stack_user_keystone_password) 2026-09-08 01:56:37.287342 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_mariadb_password) 2026-09-08 01:56:37.287629 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_rabbitmq_password) 2026-09-08 01:56:37.287936 | instance | ok: [localhost] => (item=openstack_helm_endpoints_horizon_mariadb_password) 2026-09-08 01:56:37.288248 | instance | ok: [localhost] => (item=openstack_helm_endpoints_tempest_keystone_password) 2026-09-08 01:56:37.288584 | instance | ok: [localhost] => (item=openstack_helm_endpoints_openstack_exporter_keystone_password) 2026-09-08 01:56:37.288899 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rgw_keystone_password) 2026-09-08 01:56:37.289202 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_keystone_password) 2026-09-08 01:56:37.289488 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_mariadb_password) 2026-09-08 01:56:37.289800 | instance | ok: [localhost] => (item=openstack_helm_endpoints_staffeln_mariadb_password) 2026-09-08 01:56:37.290101 | instance | 2026-09-08 01:56:37.290397 | instance | TASK [Generate base64 encoded secrets] ***************************************** 2026-09-08 01:56:37.290687 | instance | Tuesday 08 September 2026 01:56:37 +0000 (0:00:00.394) 0:00:12.582 ***** 2026-09-08 01:56:37.336097 | instance | ok: [localhost] => (item=barbican_kek) 2026-09-08 01:56:37.336542 | instance | 2026-09-08 01:56:37.336884 | instance | TASK [Generate temporary files for generating keys for missing variables] ****** 2026-09-08 01:56:37.337188 | instance | Tuesday 08 September 2026 01:56:37 +0000 (0:00:00.060) 0:00:12.643 ***** 2026-09-08 01:56:37.837085 | instance | changed: [localhost] => (item=manila_ssh_key) 2026-09-08 01:56:37.837354 | instance | changed: [localhost] => (item=nova_ssh_key) 2026-09-08 01:56:37.837528 | instance | 2026-09-08 01:56:37.837711 | instance | TASK [Generate SSH keys for missing variables] ********************************* 2026-09-08 01:56:37.837914 | instance | Tuesday 08 September 2026 01:56:37 +0000 (0:00:00.500) 0:00:13.143 ***** 2026-09-08 01:56:43.935519 | instance | changed: [localhost] => (item=manila_ssh_key) 2026-09-08 01:56:43.935581 | instance | changed: [localhost] => (item=nova_ssh_key) 2026-09-08 01:56:43.935592 | instance | 2026-09-08 01:56:43.935602 | instance | TASK [Set values for SSH keys] ************************************************* 2026-09-08 01:56:43.935612 | instance | Tuesday 08 September 2026 01:56:43 +0000 (0:00:06.100) 0:00:19.244 ***** 2026-09-08 01:56:44.011042 | instance | ok: [localhost] => (item=manila_ssh_key) 2026-09-08 01:56:44.011091 | instance | ok: [localhost] => (item=nova_ssh_key) 2026-09-08 01:56:44.011103 | instance | 2026-09-08 01:56:44.011113 | instance | TASK [Delete the temporary files generated for SSH keys] *********************** 2026-09-08 01:56:44.011122 | instance | Tuesday 08 September 2026 01:56:44 +0000 (0:00:00.075) 0:00:19.319 ***** 2026-09-08 01:56:44.396562 | instance | changed: [localhost] => (item=manila_ssh_key) 2026-09-08 01:56:44.396641 | instance | changed: [localhost] => (item=nova_ssh_key) 2026-09-08 01:56:44.396654 | instance | 2026-09-08 01:56:44.396665 | instance | TASK [Write new secrets file to disk] ****************************************** 2026-09-08 01:56:44.396676 | instance | Tuesday 08 September 2026 01:56:44 +0000 (0:00:00.385) 0:00:19.704 ***** 2026-09-08 01:56:44.794347 | instance | changed: [localhost] 2026-09-08 01:56:44.794486 | instance | 2026-09-08 01:56:44.794799 | instance | TASK [Encrypt secrets file with Vault password] ******************************** 2026-09-08 01:56:44.795038 | instance | Tuesday 08 September 2026 01:56:44 +0000 (0:00:00.398) 0:00:20.103 ***** 2026-09-08 01:56:44.835890 | instance | skipping: [localhost] 2026-09-08 01:56:44.836013 | instance | 2026-09-08 01:56:44.836136 | instance | PLAY [Setup networking] ******************************************************** 2026-09-08 01:56:44.836240 | instance | 2026-09-08 01:56:44.836376 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-08 01:56:44.836473 | instance | Tuesday 08 September 2026 01:56:44 +0000 (0:00:00.042) 0:00:20.146 ***** 2026-09-08 01:56:45.618260 | instance | ok: [instance] 2026-09-08 01:56:45.618330 | instance | 2026-09-08 01:56:45.618343 | instance | TASK [Create bridge for management network] ************************************ 2026-09-08 01:56:45.618354 | instance | Tuesday 08 September 2026 01:56:45 +0000 (0:00:00.780) 0:00:20.926 ***** 2026-09-08 01:56:45.998632 | instance | ok: [instance] 2026-09-08 01:56:45.998834 | instance | 2026-09-08 01:56:45.999175 | instance | TASK [Create fake interface for management bridge] ***************************** 2026-09-08 01:56:45.999464 | instance | Tuesday 08 September 2026 01:56:45 +0000 (0:00:00.381) 0:00:21.308 ***** 2026-09-08 01:56:46.244166 | instance | ok: [instance] 2026-09-08 01:56:46.244419 | instance | 2026-09-08 01:56:46.244841 | instance | TASK [Assign dummy interface to management bridge] ***************************** 2026-09-08 01:56:46.245243 | instance | Tuesday 08 September 2026 01:56:46 +0000 (0:00:00.245) 0:00:21.553 ***** 2026-09-08 01:56:46.462636 | instance | ok: [instance] 2026-09-08 01:56:46.462810 | instance | 2026-09-08 01:56:46.463146 | instance | TASK [Assign IP address for management bridge] ********************************* 2026-09-08 01:56:46.463438 | instance | Tuesday 08 September 2026 01:56:46 +0000 (0:00:00.218) 0:00:21.772 ***** 2026-09-08 01:56:46.693408 | instance | ok: [instance] 2026-09-08 01:56:46.693632 | instance | 2026-09-08 01:56:46.694015 | instance | TASK [Bring up interfaces] ***************************************************** 2026-09-08 01:56:46.694364 | instance | Tuesday 08 September 2026 01:56:46 +0000 (0:00:00.228) 0:00:22.000 ***** 2026-09-08 01:56:47.125398 | instance | ok: [instance] => (item=br-mgmt) 2026-09-08 01:56:47.125814 | instance | ok: [instance] => (item=dummy0) 2026-09-08 01:56:47.126109 | instance | 2026-09-08 01:56:47.126417 | instance | PLAY [Create devices for Ceph] ************************************************* 2026-09-08 01:56:47.126731 | instance | 2026-09-08 01:56:47.127030 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-08 01:56:47.127332 | instance | Tuesday 08 September 2026 01:56:47 +0000 (0:00:00.431) 0:00:22.432 ***** 2026-09-08 01:56:47.917025 | instance | ok: [instance] 2026-09-08 01:56:47.917372 | instance | 2026-09-08 01:56:47.917690 | instance | TASK [Install depedencies] ***************************************************** 2026-09-08 01:56:47.918009 | instance | Tuesday 08 September 2026 01:56:47 +0000 (0:00:00.791) 0:00:23.224 ***** 2026-09-08 01:57:11.595099 | instance | changed: [instance] 2026-09-08 01:57:11.595188 | instance | 2026-09-08 01:57:11.595196 | instance | TASK [Start up service] ******************************************************** 2026-09-08 01:57:11.595202 | instance | Tuesday 08 September 2026 01:57:11 +0000 (0:00:23.679) 0:00:46.904 ***** 2026-09-08 01:57:12.160448 | instance | ok: [instance] 2026-09-08 01:57:12.160511 | instance | 2026-09-08 01:57:12.160524 | instance | TASK [Generate lvm.conf] ******************************************************* 2026-09-08 01:57:12.160655 | instance | Tuesday 08 September 2026 01:57:12 +0000 (0:00:00.565) 0:00:47.469 ***** 2026-09-08 01:57:12.397216 | instance | ok: [instance] 2026-09-08 01:57:12.397321 | instance | 2026-09-08 01:57:12.397472 | instance | TASK [Write /etc/lvm/lvm.conf] ************************************************* 2026-09-08 01:57:12.397622 | instance | Tuesday 08 September 2026 01:57:12 +0000 (0:00:00.237) 0:00:47.706 ***** 2026-09-08 01:57:12.902759 | instance | changed: [instance] 2026-09-08 01:57:12.903532 | instance | 2026-09-08 01:57:12.903604 | instance | TASK [Get list of all loopback devices] **************************************** 2026-09-08 01:57:12.903617 | instance | Tuesday 08 September 2026 01:57:12 +0000 (0:00:00.505) 0:00:48.212 ***** 2026-09-08 01:57:13.124399 | instance | ok: [instance] 2026-09-08 01:57:13.124506 | instance | 2026-09-08 01:57:13.124782 | instance | TASK [Fail if there is any existing loopback devices] ************************** 2026-09-08 01:57:13.125003 | instance | Tuesday 08 September 2026 01:57:13 +0000 (0:00:00.221) 0:00:48.433 ***** 2026-09-08 01:57:13.152033 | instance | skipping: [instance] 2026-09-08 01:57:13.152179 | instance | 2026-09-08 01:57:13.152429 | instance | TASK [Create devices for Ceph] ************************************************* 2026-09-08 01:57:13.152679 | instance | Tuesday 08 September 2026 01:57:13 +0000 (0:00:00.028) 0:00:48.461 ***** 2026-09-08 01:57:13.757308 | instance | changed: [instance] => (item=osd0) 2026-09-08 01:57:13.757470 | instance | changed: [instance] => (item=osd1) 2026-09-08 01:57:13.757689 | instance | changed: [instance] => (item=osd2) 2026-09-08 01:57:13.757890 | instance | 2026-09-08 01:57:13.758115 | instance | TASK [Set permissions on loopback devices] ************************************* 2026-09-08 01:57:13.758357 | instance | Tuesday 08 September 2026 01:57:13 +0000 (0:00:00.604) 0:00:49.066 ***** 2026-09-08 01:57:14.386821 | instance | changed: [instance] => (item=osd0) 2026-09-08 01:57:14.387002 | instance | changed: [instance] => (item=osd1) 2026-09-08 01:57:14.387252 | instance | changed: [instance] => (item=osd2) 2026-09-08 01:57:14.387468 | instance | 2026-09-08 01:57:14.387693 | instance | TASK [Start loop devices] ****************************************************** 2026-09-08 01:57:14.387920 | instance | Tuesday 08 September 2026 01:57:14 +0000 (0:00:00.629) 0:00:49.696 ***** 2026-09-08 01:57:15.218720 | instance | changed: [instance] => (item=osd0) 2026-09-08 01:57:15.218985 | instance | changed: [instance] => (item=osd1) 2026-09-08 01:57:15.219318 | instance | changed: [instance] => (item=osd2) 2026-09-08 01:57:15.219577 | instance | 2026-09-08 01:57:15.219861 | instance | TASK [Create a volume group for each loop device] ****************************** 2026-09-08 01:57:15.220141 | instance | Tuesday 08 September 2026 01:57:15 +0000 (0:00:00.831) 0:00:50.528 ***** 2026-09-08 01:57:18.550698 | instance | changed: [instance] => (item=osd0) 2026-09-08 01:57:18.551863 | instance | changed: [instance] => (item=osd1) 2026-09-08 01:57:18.551940 | instance | changed: [instance] => (item=osd2) 2026-09-08 01:57:18.551952 | instance | 2026-09-08 01:57:18.551962 | instance | TASK [Create a logical volume for each loop device] **************************** 2026-09-08 01:57:18.551972 | instance | Tuesday 08 September 2026 01:57:18 +0000 (0:00:03.331) 0:00:53.859 ***** 2026-09-08 01:57:20.528466 | instance | changed: [instance] => (item=ceph-instance-osd0) 2026-09-08 01:57:20.528642 | instance | changed: [instance] => (item=ceph-instance-osd1) 2026-09-08 01:57:20.528873 | instance | changed: [instance] => (item=ceph-instance-osd2) 2026-09-08 01:57:20.529114 | instance | 2026-09-08 01:57:20.529337 | instance | PLAY [controllers] ************************************************************* 2026-09-08 01:57:20.529542 | instance | 2026-09-08 01:57:20.529763 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-08 01:57:20.529972 | instance | Tuesday 08 September 2026 01:57:20 +0000 (0:00:01.978) 0:00:55.837 ***** 2026-09-08 01:57:21.496598 | instance | ok: [instance] 2026-09-08 01:57:21.496737 | instance | 2026-09-08 01:57:21.496991 | instance | TASK [Set masquerade rule] ***************************************************** 2026-09-08 01:57:21.497234 | instance | Tuesday 08 September 2026 01:57:21 +0000 (0:00:00.968) 0:00:56.806 ***** 2026-09-08 01:57:22.016247 | instance | changed: [instance] 2026-09-08 01:57:22.016457 | instance | 2026-09-08 01:57:22.016705 | instance | PLAY RECAP ********************************************************************* 2026-09-08 01:57:22.016959 | instance | instance : ok=24 changed=10 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-09-08 01:57:22.017238 | instance | localhost : ok=40 changed=21 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-09-08 01:57:22.017433 | instance | 2026-09-08 01:57:22.017655 | instance | Tuesday 08 September 2026 01:57:22 +0000 (0:00:00.519) 0:00:57.326 ***** 2026-09-08 01:57:22.017869 | instance | =============================================================================== 2026-09-08 01:57:22.018115 | instance | Install depedencies ---------------------------------------------------- 23.68s 2026-09-08 01:57:22.018337 | instance | Generate SSH keys for missing variables --------------------------------- 6.10s 2026-09-08 01:57:22.018558 | instance | Create a volume group for each loop device ------------------------------ 3.33s 2026-09-08 01:57:22.018792 | instance | Create a logical volume for each loop device ---------------------------- 1.98s 2026-09-08 01:57:22.019042 | instance | Install "dirmngr" for GPG keyserver operations -------------------------- 1.30s 2026-09-08 01:57:22.019264 | instance | Gathering Facts --------------------------------------------------------- 1.24s 2026-09-08 01:57:22.019486 | instance | Create folders for workspace -------------------------------------------- 1.03s 2026-09-08 01:57:22.019708 | instance | Gathering Facts --------------------------------------------------------- 0.97s 2026-09-08 01:57:22.019931 | instance | Start loop devices ------------------------------------------------------ 0.83s 2026-09-08 01:57:22.020156 | instance | Gathering Facts --------------------------------------------------------- 0.79s 2026-09-08 01:57:22.020449 | instance | Gathering Facts --------------------------------------------------------- 0.78s 2026-09-08 01:57:22.020708 | instance | Gathering Facts --------------------------------------------------------- 0.78s 2026-09-08 01:57:22.020929 | instance | Configure short hostname ------------------------------------------------ 0.75s 2026-09-08 01:57:22.021184 | instance | Purge "snapd" package --------------------------------------------------- 0.73s 2026-09-08 01:57:22.021402 | instance | Generate endpoint skeleton for missing variables ------------------------ 0.69s 2026-09-08 01:57:22.021611 | instance | Set permissions on loopback devices ------------------------------------- 0.63s 2026-09-08 01:57:22.021829 | instance | Create devices for Ceph ------------------------------------------------- 0.60s 2026-09-08 01:57:22.022088 | instance | Write new Ceph control plane configuration file to disk ----------------- 0.58s 2026-09-08 01:57:22.022311 | instance | Start up service -------------------------------------------------------- 0.57s 2026-09-08 01:57:22.022526 | instance | Set masquerade rule ----------------------------------------------------- 0.52s 2026-09-08 01:57:22.103608 | instance | INFO [aio > prepare] Executed: Successful 2026-09-08 01:57:22.117834 | instance | INFO [aio > converge] Executing 2026-09-08 01:57:24.822355 | instance | 2026-09-08 01:57:24.822492 | instance | PLAY [all] ********************************************************************* 2026-09-08 01:57:24.822770 | instance | 2026-09-08 01:57:24.823025 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-08 01:57:24.823222 | instance | Tuesday 08 September 2026 01:57:24 +0000 (0:00:00.017) 0:00:00.017 ***** 2026-09-08 01:57:26.157538 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-09-08 01:57:26.157731 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-09-08 01:57:26.158038 | instance | interpreter could change the meaning of that path. See 2026-09-08 01:57:26.158275 | instance | https://docs.ansible.com/ansible- 2026-09-08 01:57:26.158513 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-09-08 01:57:26.165396 | instance | ok: [instance] 2026-09-08 01:57:26.165651 | instance | 2026-09-08 01:57:26.165928 | instance | TASK [Fail if atmosphere_ceph_enabled is set] ********************************** 2026-09-08 01:57:26.166202 | instance | Tuesday 08 September 2026 01:57:26 +0000 (0:00:01.343) 0:00:01.360 ***** 2026-09-08 01:57:26.217934 | instance | skipping: [instance] 2026-09-08 01:57:26.218117 | instance | 2026-09-08 01:57:26.218342 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-09-08 01:57:26.218564 | instance | Tuesday 08 September 2026 01:57:26 +0000 (0:00:00.052) 0:00:01.413 ***** 2026-09-08 01:57:26.439070 | instance | ok: [instance] 2026-09-08 01:57:26.439237 | instance | 2026-09-08 01:57:26.439455 | instance | PLAY [Deploy Ceph monitors & managers] ***************************************** 2026-09-08 01:57:26.439659 | instance | 2026-09-08 01:57:26.439881 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-08 01:57:26.440134 | instance | Tuesday 08 September 2026 01:57:26 +0000 (0:00:00.221) 0:00:01.634 ***** 2026-09-08 01:57:27.451056 | instance | ok: [instance] 2026-09-08 01:57:27.451209 | instance | 2026-09-08 01:57:27.451435 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-09-08 01:57:27.451665 | instance | Tuesday 08 September 2026 01:57:27 +0000 (0:00:01.011) 0:00:02.645 ***** 2026-09-08 01:57:27.869661 | instance | ok: [instance] 2026-09-08 01:57:27.869759 | instance | 2026-09-08 01:57:27.869961 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-09-08 01:57:27.870120 | instance | Tuesday 08 September 2026 01:57:27 +0000 (0:00:00.418) 0:00:03.064 ***** 2026-09-08 01:57:27.922572 | instance | skipping: [instance] 2026-09-08 01:57:27.922744 | instance | 2026-09-08 01:57:27.923032 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-09-08 01:57:27.923282 | instance | Tuesday 08 September 2026 01:57:27 +0000 (0:00:00.053) 0:00:03.117 ***** 2026-09-08 01:57:28.360324 | instance | changed: [instance] 2026-09-08 01:57:28.360431 | instance | 2026-09-08 01:57:28.360571 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-09-08 01:57:28.360706 | instance | Tuesday 08 September 2026 01:57:28 +0000 (0:00:00.437) 0:00:03.555 ***** 2026-09-08 01:57:28.461974 | instance | ok: [instance] => { 2026-09-08 01:57:28.462025 | instance | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-09-08 01:57:28.462180 | instance | } 2026-09-08 01:57:28.462304 | instance | 2026-09-08 01:57:28.462441 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-09-08 01:57:28.462577 | instance | Tuesday 08 September 2026 01:57:28 +0000 (0:00:00.101) 0:00:03.657 ***** 2026-09-08 01:57:29.291380 | instance | changed: [instance] 2026-09-08 01:57:29.291468 | instance | 2026-09-08 01:57:29.291537 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-09-08 01:57:29.291672 | instance | Tuesday 08 September 2026 01:57:29 +0000 (0:00:00.829) 0:00:04.486 ***** 2026-09-08 01:57:29.346444 | instance | skipping: [instance] 2026-09-08 01:57:29.346486 | instance | 2026-09-08 01:57:29.346687 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-09-08 01:57:29.346778 | instance | Tuesday 08 September 2026 01:57:29 +0000 (0:00:00.055) 0:00:04.542 ***** 2026-09-08 01:57:29.399889 | instance | skipping: [instance] 2026-09-08 01:57:29.399980 | instance | 2026-09-08 01:57:29.400123 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-09-08 01:57:29.400262 | instance | Tuesday 08 September 2026 01:57:29 +0000 (0:00:00.053) 0:00:04.595 ***** 2026-09-08 01:57:29.669039 | instance | ok: [instance] 2026-09-08 01:57:29.669115 | instance | 2026-09-08 01:57:29.669317 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-09-08 01:57:29.669590 | instance | Tuesday 08 September 2026 01:57:29 +0000 (0:00:00.267) 0:00:04.862 ***** 2026-09-08 01:57:31.281367 | instance | ok: [instance] 2026-09-08 01:57:31.281467 | instance | 2026-09-08 01:57:31.281624 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-09-08 01:57:31.281906 | instance | Tuesday 08 September 2026 01:57:31 +0000 (0:00:01.608) 0:00:06.471 ***** 2026-09-08 01:57:31.390093 | instance | ok: [instance] => { 2026-09-08 01:57:31.390394 | instance | "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz" 2026-09-08 01:57:31.390821 | instance | } 2026-09-08 01:57:31.391432 | instance | 2026-09-08 01:57:31.391906 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-09-08 01:57:31.392279 | instance | Tuesday 08 September 2026 01:57:31 +0000 (0:00:00.108) 0:00:06.579 ***** 2026-09-08 01:57:32.212928 | instance | changed: [instance] 2026-09-08 01:57:32.213227 | instance | 2026-09-08 01:57:32.213364 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-09-08 01:57:32.213495 | instance | Tuesday 08 September 2026 01:57:32 +0000 (0:00:00.826) 0:00:07.406 ***** 2026-09-08 01:57:35.333065 | instance | changed: [instance] 2026-09-08 01:57:35.333137 | instance | 2026-09-08 01:57:35.333240 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-09-08 01:57:35.333442 | instance | Tuesday 08 September 2026 01:57:35 +0000 (0:00:03.121) 0:00:10.528 ***** 2026-09-08 01:57:35.381239 | instance | skipping: [instance] 2026-09-08 01:57:35.381421 | instance | 2026-09-08 01:57:35.381698 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-09-08 01:57:35.381918 | instance | Tuesday 08 September 2026 01:57:35 +0000 (0:00:00.046) 0:00:10.575 ***** 2026-09-08 01:57:35.420824 | instance | skipping: [instance] 2026-09-08 01:57:35.420895 | instance | 2026-09-08 01:57:35.421027 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-09-08 01:57:35.421183 | instance | Tuesday 08 September 2026 01:57:35 +0000 (0:00:00.040) 0:00:10.615 ***** 2026-09-08 01:57:35.469284 | instance | skipping: [instance] 2026-09-08 01:57:35.469554 | instance | 2026-09-08 01:57:35.470042 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-09-08 01:57:35.470284 | instance | Tuesday 08 September 2026 01:57:35 +0000 (0:00:00.048) 0:00:10.663 ***** 2026-09-08 01:57:41.621316 | instance | changed: [instance] 2026-09-08 01:57:41.621774 | instance | 2026-09-08 01:57:41.622215 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] *** 2026-09-08 01:57:41.622546 | instance | Tuesday 08 September 2026 01:57:41 +0000 (0:00:06.151) 0:00:16.815 ***** 2026-09-08 01:57:42.301305 | instance | changed: [instance] 2026-09-08 01:57:42.301677 | instance | 2026-09-08 01:57:42.302013 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] ******* 2026-09-08 01:57:42.302353 | instance | Tuesday 08 September 2026 01:57:42 +0000 (0:00:00.679) 0:00:17.495 ***** 2026-09-08 01:57:43.341234 | instance | changed: [instance] => (item={'path': '/etc/containerd'}) 2026-09-08 01:57:43.341626 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'}) 2026-09-08 01:57:43.341977 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'}) 2026-09-08 01:57:43.342464 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'}) 2026-09-08 01:57:43.342814 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'}) 2026-09-08 01:57:43.343130 | instance | 2026-09-08 01:57:43.343433 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] ********** 2026-09-08 01:57:43.343734 | instance | Tuesday 08 September 2026 01:57:43 +0000 (0:00:01.039) 0:00:18.534 ***** 2026-09-08 01:57:43.985001 | instance | changed: [instance] 2026-09-08 01:57:43.985183 | instance | 2026-09-08 01:57:43.985475 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ******** 2026-09-08 01:57:43.985958 | instance | Tuesday 08 September 2026 01:57:43 +0000 (0:00:00.632) 0:00:19.167 ***** 2026-09-08 01:57:43.986154 | instance | 2026-09-08 01:57:43.986349 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-09-08 01:57:43.986554 | instance | Tuesday 08 September 2026 01:57:43 +0000 (0:00:00.009) 0:00:19.177 ***** 2026-09-08 01:57:44.989022 | instance | ok: [instance] 2026-09-08 01:57:44.989259 | instance | 2026-09-08 01:57:44.989452 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] ********** 2026-09-08 01:57:44.989637 | instance | Tuesday 08 September 2026 01:57:44 +0000 (0:00:01.006) 0:00:20.183 ***** 2026-09-08 01:57:45.490744 | instance | changed: [instance] 2026-09-08 01:57:45.491160 | instance | 2026-09-08 01:57:45.491465 | instance | TASK [vexxhost.containers.containerd : Enable and start service] *************** 2026-09-08 01:57:45.491757 | instance | Tuesday 08 September 2026 01:57:45 +0000 (0:00:00.501) 0:00:20.684 ***** 2026-09-08 01:57:46.145668 | instance | changed: [instance] 2026-09-08 01:57:46.146049 | instance | 2026-09-08 01:57:46.146367 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-09-08 01:57:46.146676 | instance | Tuesday 08 September 2026 01:57:46 +0000 (0:00:00.655) 0:00:21.340 ***** 2026-09-08 01:57:46.384465 | instance | ok: [instance] 2026-09-08 01:57:46.384542 | instance | 2026-09-08 01:57:46.384562 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-09-08 01:57:46.384700 | instance | Tuesday 08 September 2026 01:57:46 +0000 (0:00:00.238) 0:00:21.579 ***** 2026-09-08 01:57:46.452004 | instance | ok: [instance] => { 2026-09-08 01:57:46.452268 | instance | "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz" 2026-09-08 01:57:46.452528 | instance | } 2026-09-08 01:57:46.452764 | instance | 2026-09-08 01:57:46.453031 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-09-08 01:57:46.453265 | instance | Tuesday 08 September 2026 01:57:46 +0000 (0:00:00.068) 0:00:21.647 ***** 2026-09-08 01:57:47.326027 | instance | changed: [instance] 2026-09-08 01:57:47.326386 | instance | 2026-09-08 01:57:47.326690 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-09-08 01:57:47.327004 | instance | Tuesday 08 September 2026 01:57:47 +0000 (0:00:00.873) 0:00:22.520 ***** 2026-09-08 01:57:51.774862 | instance | changed: [instance] 2026-09-08 01:57:51.775586 | instance | 2026-09-08 01:57:51.775831 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ****************** 2026-09-08 01:57:51.775845 | instance | Tuesday 08 September 2026 01:57:51 +0000 (0:00:04.448) 0:00:26.969 ***** 2026-09-08 01:57:52.909521 | instance | ok: [instance] 2026-09-08 01:57:52.909675 | instance | 2026-09-08 01:57:52.910196 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] *************** 2026-09-08 01:57:52.910273 | instance | Tuesday 08 September 2026 01:57:52 +0000 (0:00:01.134) 0:00:28.104 ***** 2026-09-08 01:57:53.349660 | instance | changed: [instance] 2026-09-08 01:57:53.350384 | instance | 2026-09-08 01:57:53.350465 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] ***** 2026-09-08 01:57:53.350478 | instance | Tuesday 08 September 2026 01:57:53 +0000 (0:00:00.440) 0:00:28.544 ***** 2026-09-08 01:57:53.872176 | instance | changed: [instance] 2026-09-08 01:57:53.872503 | instance | 2026-09-08 01:57:53.872939 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] *********** 2026-09-08 01:57:53.872970 | instance | Tuesday 08 September 2026 01:57:53 +0000 (0:00:00.522) 0:00:29.066 ***** 2026-09-08 01:57:54.482906 | instance | changed: [instance] => (item={'path': '/etc/docker'}) 2026-09-08 01:57:54.483000 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'}) 2026-09-08 01:57:54.483543 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'}) 2026-09-08 01:57:54.483839 | instance | 2026-09-08 01:57:54.483850 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ****** 2026-09-08 01:57:54.483857 | instance | Tuesday 08 September 2026 01:57:54 +0000 (0:00:00.611) 0:00:29.677 ***** 2026-09-08 01:57:54.995857 | instance | changed: [instance] 2026-09-08 01:57:54.995995 | instance | 2026-09-08 01:57:54.996449 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] *********** 2026-09-08 01:57:54.996538 | instance | Tuesday 08 September 2026 01:57:54 +0000 (0:00:00.512) 0:00:30.190 ***** 2026-09-08 01:57:55.519092 | instance | changed: [instance] 2026-09-08 01:57:55.520494 | instance | 2026-09-08 01:57:55.520570 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************ 2026-09-08 01:57:55.520583 | instance | Tuesday 08 September 2026 01:57:55 +0000 (0:00:00.506) 0:00:30.697 ***** 2026-09-08 01:57:55.520594 | instance | 2026-09-08 01:57:55.520603 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-09-08 01:57:55.520619 | instance | Tuesday 08 September 2026 01:57:55 +0000 (0:00:00.016) 0:00:30.713 ***** 2026-09-08 01:57:56.346348 | instance | ok: [instance] 2026-09-08 01:57:56.347129 | instance | 2026-09-08 01:57:56.347220 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ****************** 2026-09-08 01:57:56.347239 | instance | Tuesday 08 September 2026 01:57:56 +0000 (0:00:00.826) 0:00:31.540 ***** 2026-09-08 01:57:57.408429 | instance | changed: [instance] 2026-09-08 01:57:57.409173 | instance | 2026-09-08 01:57:57.409239 | instance | TASK [vexxhost.containers.docker : Enable and start service] ******************* 2026-09-08 01:57:57.409250 | instance | Tuesday 08 September 2026 01:57:57 +0000 (0:00:01.062) 0:00:32.603 ***** 2026-09-08 01:57:58.037223 | instance | changed: [instance] 2026-09-08 01:57:58.037787 | instance | 2026-09-08 01:57:58.037813 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ****** 2026-09-08 01:57:58.037823 | instance | Tuesday 08 September 2026 01:57:58 +0000 (0:00:00.629) 0:00:33.232 ***** 2026-09-08 01:57:58.113011 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml) 2026-09-08 01:57:58.113909 | instance | 2026-09-08 01:57:58.113944 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ******************************** 2026-09-08 01:57:58.113958 | instance | Tuesday 08 September 2026 01:57:58 +0000 (0:00:00.075) 0:00:33.308 ***** 2026-09-08 01:58:03.606828 | instance | changed: [instance] 2026-09-08 01:58:03.606949 | instance | 2026-09-08 01:58:03.607486 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] ********************* 2026-09-08 01:58:03.607552 | instance | Tuesday 08 September 2026 01:58:03 +0000 (0:00:05.493) 0:00:38.801 ***** 2026-09-08 01:58:05.314237 | instance | ok: [instance] => (item=chronyd) 2026-09-08 01:58:05.315249 | instance | ok: [instance] => (item=sshd) 2026-09-08 01:58:05.315326 | instance | 2026-09-08 01:58:05.315338 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ****************************** 2026-09-08 01:58:05.315349 | instance | Tuesday 08 September 2026 01:58:05 +0000 (0:00:01.707) 0:00:40.509 ***** 2026-09-08 01:58:06.705036 | instance | changed: [instance] 2026-09-08 01:58:06.705129 | instance | 2026-09-08 01:58:06.705662 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ******************** 2026-09-08 01:58:06.705737 | instance | Tuesday 08 September 2026 01:58:06 +0000 (0:00:01.390) 0:00:41.899 ***** 2026-09-08 01:58:06.947187 | instance | ok: [instance] 2026-09-08 01:58:06.947292 | instance | 2026-09-08 01:58:06.947809 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] **************** 2026-09-08 01:58:06.947881 | instance | Tuesday 08 September 2026 01:58:06 +0000 (0:00:00.242) 0:00:42.141 ***** 2026-09-08 01:58:07.501479 | instance | changed: [instance] 2026-09-08 01:58:07.502272 | instance | 2026-09-08 01:58:07.502345 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] *** 2026-09-08 01:58:07.502357 | instance | Tuesday 08 September 2026 01:58:07 +0000 (0:00:00.554) 0:00:42.695 ***** 2026-09-08 01:58:07.948183 | instance | changed: [instance] 2026-09-08 01:58:07.948464 | instance | 2026-09-08 01:58:07.948756 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] ************************* 2026-09-08 01:58:07.948927 | instance | Tuesday 08 September 2026 01:58:07 +0000 (0:00:00.447) 0:00:43.143 ***** 2026-09-08 01:58:08.093448 | instance | ok: [instance] 2026-09-08 01:58:08.094288 | instance | 2026-09-08 01:58:08.094356 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] ******************* 2026-09-08 01:58:08.094373 | instance | Tuesday 08 September 2026 01:58:08 +0000 (0:00:00.144) 0:00:43.287 ***** 2026-09-08 01:58:08.351140 | instance | ok: [instance] => (item=instance) 2026-09-08 01:58:08.351248 | instance | 2026-09-08 01:58:08.351593 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ******** 2026-09-08 01:58:08.351645 | instance | Tuesday 08 September 2026 01:58:08 +0000 (0:00:00.258) 0:00:43.546 ***** 2026-09-08 01:58:08.430897 | instance | ok: [instance] 2026-09-08 01:58:08.431110 | instance | 2026-09-08 01:58:08.431457 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] *********************************** 2026-09-08 01:58:08.431788 | instance | Tuesday 08 September 2026 01:58:08 +0000 (0:00:00.079) 0:00:43.625 ***** 2026-09-08 01:58:08.518614 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance 2026-09-08 01:58:08.518656 | instance | 2026-09-08 01:58:08.518808 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] ************* 2026-09-08 01:58:08.519006 | instance | Tuesday 08 September 2026 01:58:08 +0000 (0:00:00.088) 0:00:43.713 ***** 2026-09-08 01:58:08.915468 | instance | changed: [instance] 2026-09-08 01:58:08.915698 | instance | 2026-09-08 01:58:08.916082 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ****************** 2026-09-08 01:58:08.916433 | instance | Tuesday 08 September 2026 01:58:08 +0000 (0:00:00.395) 0:00:44.109 ***** 2026-09-08 01:58:09.678541 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True}) 2026-09-08 01:58:09.679653 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0}) 2026-09-08 01:58:09.679731 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False}) 2026-09-08 01:58:09.679743 | instance | 2026-09-08 01:58:09.679754 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] ******************************* 2026-09-08 01:58:09.679764 | instance | Tuesday 08 September 2026 01:58:09 +0000 (0:00:00.764) 0:00:44.873 ***** 2026-09-08 02:01:08.279273 | instance | fatal: [instance]: FAILED! => {"changed": false, "cmd": ["cephadm", "bootstrap", "--fsid", "4837cbf8-4f90-4300-b3f6-726c9b9f89b4", "--mon-ip", "10.96.240.200", "--cluster-network", "10.96.240.0/24", "--ssh-user", "cephadm", "--config", "/tmp/ceph_ccdufujf.conf", "--skip-monitoring-stack"], "delta": "0:02:58.207284", "end": "2026-09-08 02:01:08.240416", "msg": "non-zero return code", "rc": 1, "start": "2026-09-08 01:58:10.033132", "stderr": "Specifying an fsid for your cluster offers no advantages and may increase the likelihood of fsid conflicts.\nError: Failed command: /usr/bin/docker pull quay.io/ceph/ceph:v18\nERROR: Failed command: /usr/bin/docker pull quay.io/ceph/ceph:v18", "stderr_lines": ["Specifying an fsid for your cluster offers no advantages and may increase the likelihood of fsid conflicts.", "Error: Failed command: /usr/bin/docker pull quay.io/ceph/ceph:v18", "ERROR: Failed command: /usr/bin/docker pull quay.io/ceph/ceph:v18"], "stdout": "Creating directory /etc/ceph for ceph.conf\nVerifying ssh connectivity using standard pubkey authentication ...\nAdding key to cephadm@localhost authorized_keys...\nVerifying podman|docker is present...\nVerifying lvm2 is present...\nVerifying time synchronization is in place...\nUnit chrony.service is enabled and running\nRepeating the final host check...\ndocker (/usr/bin/docker) is present\nsystemctl is present\nlvcreate is present\nUnit chrony.service is enabled and running\nHost looks OK\nCluster fsid: 4837cbf8-4f90-4300-b3f6-726c9b9f89b4\nVerifying IP 10.96.240.200 port 3300 ...\nVerifying IP 10.96.240.200 port 6789 ...\nMon IP `10.96.240.200` is in CIDR network `10.96.240.0/24`\nMon IP `10.96.240.200` is in CIDR network `10.96.240.0/24`\nPulling container image quay.io/ceph/ceph:v18...\nNon-zero exit code 1 from /usr/bin/docker pull quay.io/ceph/ceph:v18\n/usr/bin/docker: stderr Error response from daemon: Get \"https://quay.io/v2/ceph/ceph/manifests/sha256:69cbef90eb58cf96e572e7497227a2bcb0ec9175bc2247809c0a37857db9b820\": read tcp [2604:e100:1:0:f816:3eff:fec3:d353]:49662->[2600:1f18:d77:9000:d1a7:954d:4862:974a]:443: read: connection reset by peer\n\n\n\t***************\n\tCephadm hit an issue during cluster installation. Current cluster files will NOT BE DELETED automatically to change\n\tthis behaviour you can pass the --cleanup-on-failure. To remove this broken cluster manually please run:\n\n\t > cephadm rm-cluster --force --fsid 4837cbf8-4f90-4300-b3f6-726c9b9f89b4\n\n\tin case of any previous broken installation user must use the rm-cluster command to delete the broken cluster:\n\n\t > cephadm rm-cluster --force --zap-osds --fsid \n\n\tfor more information please refer to https://docs.ceph.com/en/latest/cephadm/operations/#purging-a-cluster\n\t***************", "stdout_lines": ["Creating directory /etc/ceph for ceph.conf", "Verifying ssh connectivity using standard pubkey authentication ...", "Adding key to cephadm@localhost authorized_keys...", "Verifying podman|docker is present...", "Verifying lvm2 is present...", "Verifying time synchronization is in place...", "Unit chrony.service is enabled and running", "Repeating the final host check...", "docker (/usr/bin/docker) is present", "systemctl is present", "lvcreate is present", "Unit chrony.service is enabled and running", "Host looks OK", "Cluster fsid: 4837cbf8-4f90-4300-b3f6-726c9b9f89b4", "Verifying IP 10.96.240.200 port 3300 ...", "Verifying IP 10.96.240.200 port 6789 ...", "Mon IP `10.96.240.200` is in CIDR network `10.96.240.0/24`", "Mon IP `10.96.240.200` is in CIDR network `10.96.240.0/24`", "Pulling container image quay.io/ceph/ceph:v18...", "Non-zero exit code 1 from /usr/bin/docker pull quay.io/ceph/ceph:v18", "/usr/bin/docker: stderr Error response from daemon: Get \"https://quay.io/v2/ceph/ceph/manifests/sha256:69cbef90eb58cf96e572e7497227a2bcb0ec9175bc2247809c0a37857db9b820\": read tcp [2604:e100:1:0:f816:3eff:fec3:d353]:49662->[2600:1f18:d77:9000:d1a7:954d:4862:974a]:443: read: connection reset by peer", "", "", "\t***************", "\tCephadm hit an issue during cluster installation. Current cluster files will NOT BE DELETED automatically to change", "\tthis behaviour you can pass the --cleanup-on-failure. To remove this broken cluster manually please run:", "", "\t > cephadm rm-cluster --force --fsid 4837cbf8-4f90-4300-b3f6-726c9b9f89b4", "", "\tin case of any previous broken installation user must use the rm-cluster command to delete the broken cluster:", "", "\t > cephadm rm-cluster --force --zap-osds --fsid ", "", "\tfor more information please refer to https://docs.ceph.com/en/latest/cephadm/operations/#purging-a-cluster", "\t***************"]} 2026-09-08 02:01:08.301457 | instance | 2026-09-08 02:01:08.301983 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] *************** 2026-09-08 02:01:08.302040 | instance | Tuesday 08 September 2026 02:01:08 +0000 (0:02:58.623) 0:03:43.496 ***** 2026-09-08 02:01:08.537318 | instance | changed: [instance] 2026-09-08 02:01:08.537977 | instance | 2026-09-08 02:01:08.537989 | instance | PLAY RECAP ********************************************************************* 2026-09-08 02:01:08.539706 | instance | instance : ok=46 changed=26 unreachable=0 failed=1 skipped=7 rescued=0 ignored=0 2026-09-08 02:01:08.539763 | instance | 2026-09-08 02:01:08.539775 | instance | Tuesday 08 September 2026 02:01:08 +0000 (0:00:00.236) 0:03:43.732 ***** 2026-09-08 02:01:08.539785 | instance | =============================================================================== 2026-09-08 02:01:08.539794 | instance | vexxhost.ceph.mon : Run Bootstrap command ----------------------------- 178.62s 2026-09-08 02:01:08.539803 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 6.15s 2026-09-08 02:01:08.539833 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 5.49s 2026-09-08 02:01:08.539849 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.45s 2026-09-08 02:01:08.540428 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 3.12s 2026-09-08 02:01:08.540444 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.83s 2026-09-08 02:01:08.544342 | instance | vexxhost.ceph.cephadm : Ensure services are started --------------------- 1.71s 2026-09-08 02:01:08.544643 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.61s 2026-09-08 02:01:08.544677 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 1.39s 2026-09-08 02:01:08.544690 | instance | Gathering Facts --------------------------------------------------------- 1.34s 2026-09-08 02:01:08.544702 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.13s 2026-09-08 02:01:08.544714 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 1.06s 2026-09-08 02:01:08.544726 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 1.04s 2026-09-08 02:01:08.544737 | instance | Gathering Facts --------------------------------------------------------- 1.01s 2026-09-08 02:01:08.544749 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.87s 2026-09-08 02:01:08.544761 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.83s 2026-09-08 02:01:08.544773 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.83s 2026-09-08 02:01:08.544785 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.76s 2026-09-08 02:01:08.544797 | instance | vexxhost.containers.containerd : Create systemd service file for containerd --- 0.68s 2026-09-08 02:01:08.544837 | instance | vexxhost.containers.containerd : Enable and start service --------------- 0.66s 2026-09-08 02:01:08.721585 | 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-08 02:01:08.721906 | instance | ERROR [aio > converge] Executed: Failed 2026-09-08 02:01:08.722097 | 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-08 02:01:09.067279 | instance | ERROR 2026-09-08 02:01:09.067600 | instance | { 2026-09-08 02:01:09.067690 | instance | "delta": "0:04:59.846089", 2026-09-08 02:01:09.067735 | instance | "end": "2026-09-08 02:01:08.798997", 2026-09-08 02:01:09.067771 | instance | "msg": "non-zero return code", 2026-09-08 02:01:09.067805 | instance | "rc": 2, 2026-09-08 02:01:09.067840 | instance | "start": "2026-09-08 01:56:08.952908" 2026-09-08 02:01:09.067875 | instance | } failure 2026-09-08 02:01:09.081539 | 2026-09-08 02:01:09.081650 | PLAY RECAP 2026-09-08 02:01:09.081745 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-09-08 02:01:09.081793 | 2026-09-08 02:01:09.211179 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-09-08 02:01:09.223728 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-09-08 02:01:09.775915 | 2026-09-08 02:01:09.776037 | PLAY [all] 2026-09-08 02:01:09.788291 | 2026-09-08 02:01:09.788368 | TASK [gather-host-logs : creating directory for system status] 2026-09-08 02:01:10.153856 | instance | changed 2026-09-08 02:01:10.163426 | 2026-09-08 02:01:10.163582 | TASK [gather-host-logs : Get logs for each host] 2026-09-08 02:01:10.536930 | instance | + systemd-cgls --full --all --no-pager 2026-09-08 02:01:10.551589 | instance | + ip addr 2026-09-08 02:01:10.554882 | instance | + ip route 2026-09-08 02:01:10.557477 | instance | + lsblk 2026-09-08 02:01:10.562923 | instance | + mount 2026-09-08 02:01:10.565964 | instance | + docker images 2026-09-08 02:01:10.589015 | instance | + brctl show 2026-09-08 02:01:10.589546 | instance | /bin/bash: line 8: brctl: command not found 2026-09-08 02:01:10.589845 | instance | + ps aux --sort=-%mem 2026-09-08 02:01:10.612628 | instance | + dpkg -l 2026-09-08 02:01:10.624868 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-09-08 02:01:10.625476 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-09-08 02:01:10.647090 | instance | + '[' '!' -z '' ']' 2026-09-08 02:01:10.711529 | instance | ok: Runtime: 0:00:00.115349 2026-09-08 02:01:10.723076 | 2026-09-08 02:01:10.723224 | TASK [gather-host-logs : Downloads logs to executor] 2026-09-08 02:01:11.363143 | instance | changed: 2026-09-08 02:01:11.363385 | instance | created directory /var/lib/zuul/builds/4ca16e723aa54547b83cb83c032b01cc/work/logs/instance 2026-09-08 02:01:11.363440 | instance | cd+++++++++ system/ 2026-09-08 02:01:11.363482 | instance | >f+++++++++ system/brctl-show.txt 2026-09-08 02:01:11.363522 | instance | >f+++++++++ system/docker-images.txt 2026-09-08 02:01:11.363560 | instance | >f+++++++++ system/ip-addr.txt 2026-09-08 02:01:11.363604 | instance | >f+++++++++ system/ip-route.txt 2026-09-08 02:01:11.363643 | instance | >f+++++++++ system/lsblk.txt 2026-09-08 02:01:11.363784 | instance | >f+++++++++ system/mount.txt 2026-09-08 02:01:11.363834 | instance | >f+++++++++ system/packages.txt 2026-09-08 02:01:11.363872 | instance | >f+++++++++ system/ps.txt 2026-09-08 02:01:11.363913 | instance | >f+++++++++ system/systemd-cgls.txt 2026-09-08 02:01:11.384693 | 2026-09-08 02:01:11.384887 | LOOP [helm-release-status : creating directory for helm release status] 2026-09-08 02:01:11.609851 | instance | changed: "values" 2026-09-08 02:01:11.788399 | instance | changed: "releases" 2026-09-08 02:01:11.798246 | 2026-09-08 02:01:11.798456 | TASK [helm-release-status : Gather get release status for helm charts] 2026-09-08 02:01:12.049782 | instance | /bin/bash: line 3: kubectl: command not found 2026-09-08 02:01:12.325417 | instance | ok: Runtime: 0:00:00.005539 2026-09-08 02:01:12.329779 | 2026-09-08 02:01:12.329843 | TASK [helm-release-status : Downloads logs to executor] 2026-09-08 02:01:12.857555 | instance | changed: 2026-09-08 02:01:12.857803 | instance | cd+++++++++ helm/ 2026-09-08 02:01:12.857857 | instance | cd+++++++++ helm/releases/ 2026-09-08 02:01:12.857898 | instance | cd+++++++++ helm/values/ 2026-09-08 02:01:12.875650 | 2026-09-08 02:01:12.875786 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-09-08 02:01:13.084136 | instance | changed 2026-09-08 02:01:13.093355 | 2026-09-08 02:01:13.093490 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-09-08 02:01:13.359236 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-08 02:01:13.359593 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-08 02:01:13.365380 | instance | environment: line 1: kubectl: command not found 2026-09-08 02:01:13.367009 | instance | environment: line 1: kubectl: command not found 2026-09-08 02:01:13.367099 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-08 02:01:13.367793 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-08 02:01:13.370514 | instance | environment: line 1: kubectl: command not found 2026-09-08 02:01:13.371766 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-08 02:01:13.372864 | instance | environment: line 1: kubectl: command not found 2026-09-08 02:01:13.373587 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-08 02:01:13.374910 | instance | environment: line 1: kubectl: command not found 2026-09-08 02:01:13.376170 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-08 02:01:13.641251 | instance | ok: Runtime: 0:00:00.026100 2026-09-08 02:01:13.651683 | 2026-09-08 02:01:13.651807 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-09-08 02:01:13.876692 | instance | changed 2026-09-08 02:01:13.885735 | 2026-09-08 02:01:13.885866 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-09-08 02:01:14.144880 | instance | environment: line 5: kubectl: command not found 2026-09-08 02:01:14.145235 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-08 02:01:14.146187 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-08 02:01:14.146330 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-08 02:01:14.433386 | instance | ok: Runtime: 0:00:00.009910 2026-09-08 02:01:14.440942 | 2026-09-08 02:01:14.441090 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-09-08 02:01:14.957051 | instance | changed: 2026-09-08 02:01:14.957267 | instance | cd+++++++++ objects/ 2026-09-08 02:01:14.957292 | instance | cd+++++++++ objects/cluster/ 2026-09-08 02:01:14.957313 | instance | cd+++++++++ objects/namespaced/ 2026-09-08 02:01:14.965831 | 2026-09-08 02:01:14.965899 | TASK [gather-pod-logs : creating directory for pod logs] 2026-09-08 02:01:15.177173 | instance | changed 2026-09-08 02:01:15.183512 | 2026-09-08 02:01:15.183587 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-09-08 02:01:15.369147 | instance | changed 2026-09-08 02:01:15.379470 | 2026-09-08 02:01:15.379633 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-09-08 02:01:15.608363 | instance | environment: line 3: kubectl: command not found 2026-09-08 02:01:15.925373 | instance | ok: Runtime: 0:00:00.008342 2026-09-08 02:01:15.935556 | 2026-09-08 02:01:15.935692 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-09-08 02:01:16.459412 | instance | changed: 2026-09-08 02:01:16.459673 | instance | cd+++++++++ pod-logs/ 2026-09-08 02:01:16.459728 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-09-08 02:01:16.478456 | 2026-09-08 02:01:16.478615 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-09-08 02:01:16.704294 | instance | changed 2026-09-08 02:01:16.713945 | 2026-09-08 02:01:16.714111 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-09-08 02:01:16.977512 | instance | /bin/bash: line 2: kubectl: command not found 2026-09-08 02:01:17.262494 | instance | ok: Runtime: 0:00:00.048060 2026-09-08 02:01:17.271812 | 2026-09-08 02:01:17.271947 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-09-08 02:01:17.537989 | instance | /bin/bash: line 2: kubectl: command not found 2026-09-08 02:01:17.580305 | instance | ceph-mgr endpoints: 2026-09-08 02:01:17.822625 | instance | ok: Runtime: 0:00:00.048602 2026-09-08 02:01:17.832433 | 2026-09-08 02:01:17.832643 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-09-08 02:01:18.124077 | instance | /bin/bash: line 4: kubectl: command not found 2026-09-08 02:01:18.376936 | instance | ok: Runtime: 0:00:00.028160 2026-09-08 02:01:18.385943 | 2026-09-08 02:01:18.386096 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-09-08 02:01:18.942019 | instance | changed: cd+++++++++ prometheus/ 2026-09-08 02:01:18.961098 | 2026-09-08 02:01:18.961179 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-09-08 02:01:19.187343 | instance | changed 2026-09-08 02:01:19.198178 | 2026-09-08 02:01:19.198307 | TASK [gather-selenium-data : Get selenium data] 2026-09-08 02:01:19.446100 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-09-08 02:01:19.447847 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-09-08 02:01:19.737404 | instance | ERROR 2026-09-08 02:01:19.737529 | instance | { 2026-09-08 02:01:19.737562 | instance | "delta": "0:00:00.006673", 2026-09-08 02:01:19.737580 | instance | "end": "2026-09-08 02:01:19.448112", 2026-09-08 02:01:19.737599 | instance | "msg": "non-zero return code", 2026-09-08 02:01:19.737616 | instance | "rc": 1, 2026-09-08 02:01:19.737632 | instance | "start": "2026-09-08 02:01:19.441439" 2026-09-08 02:01:19.737648 | instance | } 2026-09-08 02:01:19.737670 | instance | ERROR: Ignoring Errors 2026-09-08 02:01:19.741831 | 2026-09-08 02:01:19.741888 | TASK [gather-selenium-data : Downloads logs to executor] 2026-09-08 02:01:20.258574 | instance | changed: cd+++++++++ selenium/ 2026-09-08 02:01:20.269521 | 2026-09-08 02:01:20.269618 | PLAY RECAP 2026-09-08 02:01:20.269695 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-09-08 02:01:20.269739 | 2026-09-08 02:01:20.403571 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-09-08 02:01:20.414418 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-09-08 02:01:20.970845 | 2026-09-08 02:01:20.970951 | PLAY [all] 2026-09-08 02:01:20.980902 | 2026-09-08 02:01:20.980972 | TASK [fetch-output : Set log path for multiple nodes] 2026-09-08 02:01:21.024435 | instance | skipping: Conditional result was False 2026-09-08 02:01:21.031994 | 2026-09-08 02:01:21.032120 | TASK [fetch-output : Set log path for single node] 2026-09-08 02:01:21.061182 | instance | ok 2026-09-08 02:01:21.066684 | 2026-09-08 02:01:21.066767 | LOOP [fetch-output : Ensure local output dirs] 2026-09-08 02:01:21.446962 | instance -> localhost | ok: "/var/lib/zuul/builds/4ca16e723aa54547b83cb83c032b01cc/work/logs" 2026-09-08 02:01:21.662665 | instance -> localhost | changed: "/var/lib/zuul/builds/4ca16e723aa54547b83cb83c032b01cc/work/artifacts" 2026-09-08 02:01:21.872855 | instance -> localhost | changed: "/var/lib/zuul/builds/4ca16e723aa54547b83cb83c032b01cc/work/docs" 2026-09-08 02:01:21.884549 | 2026-09-08 02:01:21.884699 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-08 02:01:22.544614 | instance | changed: .d..t...... ./ 2026-09-08 02:01:22.544989 | instance | changed: All items complete 2026-09-08 02:01:22.545065 | 2026-09-08 02:01:23.035627 | instance | changed: .d..t...... ./ 2026-09-08 02:01:23.513268 | instance | changed: .d..t...... ./ 2026-09-08 02:01:23.544094 | 2026-09-08 02:01:23.544420 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-08 02:01:23.982285 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007197 2026-09-08 02:01:24.211480 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.006014 2026-09-08 02:01:24.223854 | 2026-09-08 02:01:24.224010 | PLAY [all] 2026-09-08 02:01:24.231358 | 2026-09-08 02:01:24.231441 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-08 02:01:24.628184 | instance | changed 2026-09-08 02:01:24.637870 | 2026-09-08 02:01:24.637962 | PLAY RECAP 2026-09-08 02:01:24.638067 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-09-08 02:01:24.638114 | 2026-09-08 02:01:24.758494 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-09-08 02:01:24.773286 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-08 02:01:25.324917 | 2026-09-08 02:01:25.325035 | PLAY [localhost] 2026-09-08 02:01:25.333766 | 2026-09-08 02:01:25.333833 | TASK [Generate Zuul manifest] 2026-09-08 02:01:25.349767 | localhost | ok 2026-09-08 02:01:25.362371 | 2026-09-08 02:01:25.362443 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-08 02:01:25.819834 | localhost | changed 2026-09-08 02:01:25.838112 | 2026-09-08 02:01:25.838255 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-08 02:01:26.024548 | localhost | ok 2026-09-08 02:01:26.040912 | 2026-09-08 02:01:26.041087 | TASK [Upload logs] 2026-09-08 02:01:26.061704 | localhost | ok 2026-09-08 02:01:26.154502 | 2026-09-08 02:01:26.154620 | TASK [Set zuul-log-path fact] 2026-09-08 02:01:26.171295 | localhost | ok 2026-09-08 02:01:26.180802 | 2026-09-08 02:01:26.180861 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-08 02:01:26.209634 | localhost | ok 2026-09-08 02:01:26.221143 | 2026-09-08 02:01:26.221244 | TASK [upload-logs : Create log directories] 2026-09-08 02:01:26.615790 | localhost | changed 2026-09-08 02:01:26.625964 | 2026-09-08 02:01:26.626118 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-08 02:01:27.002015 | localhost -> localhost | ok: Runtime: 0:00:00.004673 2026-09-08 02:01:27.010997 | 2026-09-08 02:01:27.011146 | TASK [upload-logs : Upload logs to log server] 2026-09-08 02:01:27.464216 | localhost | Output suppressed because no_log was given 2026-09-08 02:01:27.470957 | 2026-09-08 02:01:27.471100 | LOOP [upload-logs : Compress console log and json output] 2026-09-08 02:01:27.532215 | localhost | skipping: Conditional result was False 2026-09-08 02:01:27.541268 | localhost | skipping: Conditional result was False 2026-09-08 02:01:27.555989 | 2026-09-08 02:01:27.556142 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-08 02:01:27.617938 | localhost | skipping: Conditional result was False 2026-09-08 02:01:27.618355 | 2026-09-08 02:01:27.623065 | localhost | skipping: Conditional result was False 2026-09-08 02:01:27.639831 | 2026-09-08 02:01:27.640001 | LOOP [upload-logs : Upload console log and json output]