2026-09-01 05:03:14.567535 | Job console starting 2026-09-01 05:03:14.577542 | Updating git repos 2026-09-01 05:03:17.111911 | Cloning repos into workspace 2026-09-01 05:03:32.792563 | Restoring repo states 2026-09-01 05:03:50.334819 | Merging changes 2026-09-01 05:03:51.825797 | Checking out repos 2026-09-01 05:03:53.258974 | Preparing playbooks 2026-09-01 05:03:55.756553 | Running Ansible setup 2026-09-01 05:03:59.361181 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-09-01 05:03:59.984407 | 2026-09-01 05:03:59.984544 | PLAY [localhost] 2026-09-01 05:03:59.991871 | 2026-09-01 05:03:59.991941 | TASK [Gathering Facts] 2026-09-01 05:04:00.926501 | localhost | ok 2026-09-01 05:04:00.940016 | 2026-09-01 05:04:00.940097 | TASK [Setup log path fact] 2026-09-01 05:04:00.960494 | localhost | ok 2026-09-01 05:04:00.974514 | 2026-09-01 05:04:00.974581 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-01 05:04:01.003624 | localhost | ok 2026-09-01 05:04:01.011432 | 2026-09-01 05:04:01.011559 | TASK [emit-job-header : Print job information] 2026-09-01 05:04:01.055557 | # Job Information 2026-09-01 05:04:01.055794 | Ansible Version: 2.16.18 2026-09-01 05:04:01.055868 | Job: atmosphere-molecule-aio-openvswitch 2026-09-01 05:04:01.055916 | Pipeline: check 2026-09-01 05:04:01.055959 | Executor: 2d72f0692154 2026-09-01 05:04:01.056003 | Triggered by: https://github.com/vexxhost/atmosphere/pull/2851 2026-09-01 05:04:01.056053 | Event ID: 1eeb94b0-a5c2-11f1-9bb0-558340f77e91 2026-09-01 05:04:01.060688 | 2026-09-01 05:04:01.060753 | LOOP [emit-job-header : Print node information] 2026-09-01 05:04:01.154978 | localhost | ok: 2026-09-01 05:04:01.155232 | localhost | # Node Information 2026-09-01 05:04:01.155294 | localhost | Inventory Hostname: instance 2026-09-01 05:04:01.155340 | localhost | Hostname: np0000191699 2026-09-01 05:04:01.155382 | localhost | Username: zuul 2026-09-01 05:04:01.155429 | localhost | Distro: Ubuntu 22.04 2026-09-01 05:04:01.155682 | localhost | Provider: yul1 2026-09-01 05:04:01.155822 | localhost | Region: ca-ymq-1 2026-09-01 05:04:01.155880 | localhost | Label: ubuntu-jammy-16 2026-09-01 05:04:01.155922 | localhost | Product Name: OpenStack Nova 2026-09-01 05:04:01.155963 | localhost | Interface IP: 162.253.55.96 2026-09-01 05:04:01.163097 | 2026-09-01 05:04:01.163173 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-09-01 05:04:01.540849 | localhost -> localhost | changed 2026-09-01 05:04:01.550498 | 2026-09-01 05:04:01.550593 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-09-01 05:04:02.458512 | localhost -> localhost | changed 2026-09-01 05:04:02.464909 | 2026-09-01 05:04:02.464977 | PLAY [all] 2026-09-01 05:04:02.472629 | 2026-09-01 05:04:02.472703 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-09-01 05:04:02.700182 | instance -> localhost | ok 2026-09-01 05:04:02.707224 | 2026-09-01 05:04:02.707295 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-09-01 05:04:02.737629 | instance | ok 2026-09-01 05:04:02.750929 | instance | included: /var/lib/zuul/builds/0772a718f2764b0181fe1ccaa94640e2/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-09-01 05:04:02.756579 | 2026-09-01 05:04:02.756639 | TASK [add-build-sshkey : Create Temp SSH key] 2026-09-01 05:04:03.369829 | instance -> localhost | Generating public/private rsa key pair. 2026-09-01 05:04:03.370111 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/0772a718f2764b0181fe1ccaa94640e2/work/0772a718f2764b0181fe1ccaa94640e2_id_rsa 2026-09-01 05:04:03.370173 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/0772a718f2764b0181fe1ccaa94640e2/work/0772a718f2764b0181fe1ccaa94640e2_id_rsa.pub 2026-09-01 05:04:03.370220 | instance -> localhost | The key fingerprint is: 2026-09-01 05:04:03.370266 | instance -> localhost | SHA256:AaWUyvwJ8/VpJlirUKi/cDYHk3tqf1pYTOBzMGqu0UM zuul-build-sshkey 2026-09-01 05:04:03.370329 | instance -> localhost | The key's randomart image is: 2026-09-01 05:04:03.370375 | instance -> localhost | +---[RSA 3072]----+ 2026-09-01 05:04:03.370473 | instance -> localhost | | *o. | 2026-09-01 05:04:03.370529 | instance -> localhost | | +.* | 2026-09-01 05:04:03.370574 | instance -> localhost | | oEo+ + | 2026-09-01 05:04:03.370618 | instance -> localhost | | =B..=o. | 2026-09-01 05:04:03.370662 | instance -> localhost | | ..B* =So . | 2026-09-01 05:04:03.370705 | instance -> localhost | | .o.==oo = | 2026-09-01 05:04:03.370748 | instance -> localhost | | o.=.+..+ | 2026-09-01 05:04:03.370790 | instance -> localhost | | +o=... | 2026-09-01 05:04:03.370838 | instance -> localhost | | .oooo | 2026-09-01 05:04:03.370882 | instance -> localhost | +----[SHA256]-----+ 2026-09-01 05:04:03.370975 | instance -> localhost | ok: Runtime: 0:00:00.208030 2026-09-01 05:04:03.377517 | 2026-09-01 05:04:03.377583 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-09-01 05:04:03.411892 | instance | ok 2026-09-01 05:04:03.423390 | instance | included: /var/lib/zuul/builds/0772a718f2764b0181fe1ccaa94640e2/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-09-01 05:04:03.430726 | 2026-09-01 05:04:03.430786 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-09-01 05:04:03.456126 | instance | skipping: Conditional result was False 2026-09-01 05:04:03.465216 | 2026-09-01 05:04:03.465300 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-09-01 05:04:03.900006 | instance | changed 2026-09-01 05:04:03.907951 | 2026-09-01 05:04:03.908036 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-09-01 05:04:04.148996 | instance | ok 2026-09-01 05:04:04.154199 | 2026-09-01 05:04:04.154266 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-09-01 05:04:04.677138 | instance | changed 2026-09-01 05:04:04.684658 | 2026-09-01 05:04:04.684728 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-09-01 05:04:05.167346 | instance | changed 2026-09-01 05:04:05.172607 | 2026-09-01 05:04:05.172672 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-09-01 05:04:05.195662 | instance | skipping: Conditional result was False 2026-09-01 05:04:05.207266 | 2026-09-01 05:04:05.207357 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-09-01 05:04:05.503988 | instance -> localhost | changed 2026-09-01 05:04:05.518612 | 2026-09-01 05:04:05.518691 | TASK [add-build-sshkey : Add back temp key] 2026-09-01 05:04:05.804598 | instance -> localhost | Identity added: /var/lib/zuul/builds/0772a718f2764b0181fe1ccaa94640e2/work/0772a718f2764b0181fe1ccaa94640e2_id_rsa (zuul-build-sshkey) 2026-09-01 05:04:05.804826 | instance -> localhost | ok: Runtime: 0:00:00.014951 2026-09-01 05:04:05.811566 | 2026-09-01 05:04:05.811649 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-09-01 05:04:06.099990 | instance | ok 2026-09-01 05:04:06.106958 | 2026-09-01 05:04:06.107022 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-09-01 05:04:06.131648 | instance | skipping: Conditional result was False 2026-09-01 05:04:06.145139 | 2026-09-01 05:04:06.145239 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-09-01 05:04:06.445614 | instance | ok 2026-09-01 05:04:06.451448 | 2026-09-01 05:04:06.451517 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-09-01 05:04:10.195614 | instance | Output suppressed because no_log was given 2026-09-01 05:04:10.207817 | 2026-09-01 05:04:10.207945 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-09-01 05:04:10.425340 | instance | ok: "logs" 2026-09-01 05:04:10.426214 | instance | ok: All items complete 2026-09-01 05:04:10.426261 | 2026-09-01 05:04:10.564880 | instance | ok: "artifacts" 2026-09-01 05:04:10.695671 | instance | ok: "docs" 2026-09-01 05:04:10.708340 | 2026-09-01 05:04:10.708532 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-09-01 05:04:10.889532 | instance | changed: "logs" 2026-09-01 05:04:11.024716 | instance | changed: "artifacts" 2026-09-01 05:04:11.162493 | instance | changed: "docs" 2026-09-01 05:04:11.176752 | 2026-09-01 05:04:11.176867 | PLAY RECAP 2026-09-01 05:04:11.176917 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-09-01 05:04:11.176945 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-01 05:04:11.176986 | 2026-09-01 05:04:11.345016 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-09-01 05:04:11.355643 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-09-01 05:04:11.977240 | 2026-09-01 05:04:11.977377 | PLAY [all] 2026-09-01 05:04:11.988860 | 2026-09-01 05:04:11.988945 | TASK [setup-uv : Extract archive] 2026-09-01 05:04:15.418580 | instance | changed 2026-09-01 05:04:15.427645 | 2026-09-01 05:04:15.427752 | TASK [setup-uv : Print version] 2026-09-01 05:04:15.795380 | instance | uv 0.8.13 2026-09-01 05:04:15.975103 | instance | ok: Runtime: 0:00:00.009598 2026-09-01 05:04:15.989530 | 2026-09-01 05:04:15.989602 | TASK [Install Ansible collection siblings] 2026-09-01 05:04:25.062359 | instance | changed: 2026-09-01 05:04:25.062595 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-09-01 05:04:25.062636 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-09-01 05:04:25.062668 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-09-01 05:04:25.062695 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto 2026-09-01 05:04:25.062722 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general 2026-09-01 05:04:25.062765 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql 2026-09-01 05:04:25.062795 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-09-01 05:04:25.062827 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-09-01 05:04:25.062856 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-09-01 05:04:25.062883 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-09-01 05:04:25.062913 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-09-01 05:04:25.062944 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-09-01 05:04:25.062975 | instance | Resolved ansible.netcommon to 1.2.0 for 1.2.0 2026-09-01 05:04:25.063007 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0 2026-09-01 05:04:25.063038 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0 2026-09-01 05:04:25.063071 | instance | Resolved community.crypto to 2.2.3 for 2.2.3 2026-09-01 05:04:25.063103 | instance | Resolved community.general to 7.3.0 for 7.3.0 2026-09-01 05:04:25.063135 | instance | Resolved community.mysql to 3.6.0 for 3.6.0 2026-09-01 05:04:25.063167 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0 2026-09-01 05:04:25.063196 | instance | Resolved openstack.cloud to 2.6.0 for >=2.0.0 2026-09-01 05:04:25.063221 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.2.0 2026-09-01 05:04:25.063246 | instance | Resolved atmosphere.common to v0.7.0 for >=0.7.0 2026-09-01 05:04:25.063274 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-09-01 05:04:25.063320 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0 2026-09-01 05:04:25.063347 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=6.0.0 2026-09-01 05:04:25.063372 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-09-01 05:04:25.063398 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-09-01 05:04:25.063422 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-09-01 05:04:25.063447 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0 2026-09-01 05:04:25.063484 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3 2026-09-01 05:04:25.063511 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-09-01 05:04:25.063537 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-09-01 05:04:25.063562 | instance | Checked out ansible.netcommon to 1.2.0 2026-09-01 05:04:25.063588 | 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-01 05:04:25.063621 | instance | Starting galaxy collection install process 2026-09-01 05:04:25.063646 | instance | Process install dependency map 2026-09-01 05:04:25.063672 | instance | Starting collection install process 2026-09-01 05:04:25.063697 | instance | Installing 'ansible.netcommon:*' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon' 2026-09-01 05:04:25.063722 | instance | Created collection for ansible.netcommon:* at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon 2026-09-01 05:04:25.063747 | instance | ansible.netcommon:* was installed successfully 2026-09-01 05:04:25.063772 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-09-01 05:04:25.063797 | instance | Creating virtual environment at: .venv 2026-09-01 05:04:25.063822 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-09-01 05:04:25.063847 | instance | Downloading rjsonnet (1.2MiB) 2026-09-01 05:04:25.063872 | instance | Downloading netaddr (2.2MiB) 2026-09-01 05:04:25.063897 | instance | Downloading kubernetes (1.9MiB) 2026-09-01 05:04:25.063962 | instance | Downloading setuptools (1.1MiB) 2026-09-01 05:04:25.063993 | instance | Downloading cryptography (4.2MiB) 2026-09-01 05:04:25.064021 | instance | Downloading openstacksdk (1.7MiB) 2026-09-01 05:04:25.064052 | instance | Downloading pygments (1.2MiB) 2026-09-01 05:04:25.064080 | instance | Downloading pydantic-core (2.0MiB) 2026-09-01 05:04:25.064107 | instance | Downloading ansible-core (2.1MiB) 2026-09-01 05:04:25.064159 | instance | Building pyperclip==1.9.0 2026-09-01 05:04:25.064189 | instance | Downloading rjsonnet 2026-09-01 05:04:25.064215 | instance | Downloading pydantic-core 2026-09-01 05:04:25.064240 | instance | Downloading netaddr 2026-09-01 05:04:25.064265 | instance | Downloading pygments 2026-09-01 05:04:25.064290 | instance | Downloading cryptography 2026-09-01 05:04:25.064315 | instance | Downloading setuptools 2026-09-01 05:04:25.064339 | instance | Downloading kubernetes 2026-09-01 05:04:25.064365 | instance | Downloading ansible-core 2026-09-01 05:04:25.064390 | instance | Downloading openstacksdk 2026-09-01 05:04:25.064415 | instance | Built pyperclip==1.9.0 2026-09-01 05:04:25.064440 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-09-01 05:04:25.064489 | instance | Installed 83 packages in 57ms 2026-09-01 05:04:25.064517 | instance | Checked out ansible.posix to 1.6.0 2026-09-01 05:04:25.064545 | 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-01 05:04:25.064570 | instance | Starting galaxy collection install process 2026-09-01 05:04:25.064595 | instance | Process install dependency map 2026-09-01 05:04:25.064628 | instance | Starting collection install process 2026-09-01 05:04:25.064654 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-09-01 05:04:25.064678 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix 2026-09-01 05:04:25.064729 | instance | ansible.posix:1.6.0 was installed successfully 2026-09-01 05:04:25.064757 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-01 05:04:25.064782 | instance | 2.17.12 2026-09-01 05:04:25.064807 | instance | Checked out ansible.utils to v6.1.0 2026-09-01 05:04:25.064833 | 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-01 05:04:25.064858 | instance | Starting galaxy collection install process 2026-09-01 05:04:25.064904 | instance | Process install dependency map 2026-09-01 05:04:25.064932 | instance | Starting collection install process 2026-09-01 05:04:25.065218 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils' 2026-09-01 05:04:25.065271 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils 2026-09-01 05:04:25.065301 | instance | ansible.utils:6.1.0 was installed successfully 2026-09-01 05:04:25.065343 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-01 05:04:25.065369 | instance | 2.17.12 2026-09-01 05:04:25.065395 | instance | Checked out atmosphere.common to v0.7.0 2026-09-01 05:04:25.065420 | 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-01 05:04:25.065444 | instance | Starting galaxy collection install process 2026-09-01 05:04:25.065469 | instance | Process install dependency map 2026-09-01 05:04:25.065493 | instance | Starting collection install process 2026-09-01 05:04:25.065518 | instance | Installing 'atmosphere.common:0.7.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common' 2026-09-01 05:04:25.065543 | instance | Created collection for atmosphere.common:0.7.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common 2026-09-01 05:04:25.065567 | instance | atmosphere.common:0.7.0 was installed successfully 2026-09-01 05:04:25.065591 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-01 05:04:25.065616 | instance | 2.17.12 2026-09-01 05:04:25.065640 | instance | Checked out community.crypto to 2.2.3 2026-09-01 05:04:25.065665 | 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-01 05:04:25.065690 | instance | Starting galaxy collection install process 2026-09-01 05:04:25.065749 | instance | Process install dependency map 2026-09-01 05:04:25.065777 | instance | Starting collection install process 2026-09-01 05:04:25.065802 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-09-01 05:04:25.065827 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto 2026-09-01 05:04:25.065852 | instance | community.crypto:2.2.3 was installed successfully 2026-09-01 05:04:25.065876 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-01 05:04:25.065900 | instance | 2.17.12 2026-09-01 05:04:25.065924 | instance | Checked out community.general to 7.3.0 2026-09-01 05:04:25.065948 | 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-01 05:04:25.065983 | instance | Starting galaxy collection install process 2026-09-01 05:04:25.066013 | instance | Process install dependency map 2026-09-01 05:04:25.066038 | instance | Starting collection install process 2026-09-01 05:04:25.066062 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-09-01 05:04:25.066086 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general 2026-09-01 05:04:25.066111 | instance | community.general:7.3.0 was installed successfully 2026-09-01 05:04:25.066136 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-01 05:04:25.066161 | instance | 2.17.12 2026-09-01 05:04:25.066187 | instance | Checked out community.mysql to 3.6.0 2026-09-01 05:04:25.066215 | 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-01 05:04:25.066242 | instance | Starting galaxy collection install process 2026-09-01 05:04:25.066268 | instance | Process install dependency map 2026-09-01 05:04:25.066293 | instance | Starting collection install process 2026-09-01 05:04:25.066318 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql' 2026-09-01 05:04:25.066343 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql 2026-09-01 05:04:25.066368 | instance | community.mysql:3.6.0 was installed successfully 2026-09-01 05:04:25.066393 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-01 05:04:25.066418 | instance | 2.17.12 2026-09-01 05:04:25.066443 | instance | Checked out kubernetes.core to 2.4.0 2026-09-01 05:04:25.066468 | 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-01 05:04:25.066493 | instance | Starting galaxy collection install process 2026-09-01 05:04:25.066516 | instance | Process install dependency map 2026-09-01 05:04:25.066541 | instance | Starting collection install process 2026-09-01 05:04:25.066565 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core' 2026-09-01 05:04:25.066590 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core 2026-09-01 05:04:25.066615 | instance | kubernetes.core:2.4.0 was installed successfully 2026-09-01 05:04:25.066640 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-01 05:04:25.066665 | instance | 2.17.12 2026-09-01 05:04:25.066689 | instance | Checked out openstack.cloud to 2.6.0 2026-09-01 05:04:25.066714 | 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-01 05:04:25.066752 | instance | Starting galaxy collection install process 2026-09-01 05:04:25.066779 | instance | Process install dependency map 2026-09-01 05:04:25.066804 | instance | Starting collection install process 2026-09-01 05:04:25.066828 | instance | Installing 'openstack.cloud:2.6.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud' 2026-09-01 05:04:25.066852 | instance | Created collection for openstack.cloud:2.6.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud 2026-09-01 05:04:25.066877 | instance | openstack.cloud:2.6.0 was installed successfully 2026-09-01 05:04:25.066902 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-01 05:04:25.066926 | instance | 2.17.12 2026-09-01 05:04:25.066959 | instance | Checked out vexxhost.ceph to v4.2.0 2026-09-01 05:04:25.066987 | 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-01 05:04:25.067011 | instance | Starting galaxy collection install process 2026-09-01 05:04:25.067036 | instance | Process install dependency map 2026-09-01 05:04:25.067060 | instance | Starting collection install process 2026-09-01 05:04:25.067084 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph' 2026-09-01 05:04:25.067108 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph 2026-09-01 05:04:25.067132 | instance | vexxhost.ceph:4.2.0 was installed successfully 2026-09-01 05:04:25.067156 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-01 05:04:25.067180 | instance | 2.17.12 2026-09-01 05:04:25.067204 | instance | Checked out vexxhost.containers to v1.6.8 2026-09-01 05:04:25.067228 | 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-01 05:04:25.067253 | instance | Starting galaxy collection install process 2026-09-01 05:04:25.067277 | instance | Process install dependency map 2026-09-01 05:04:25.067301 | instance | Starting collection install process 2026-09-01 05:04:25.067326 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers' 2026-09-01 05:04:25.067350 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers 2026-09-01 05:04:25.067374 | instance | vexxhost.containers:1.6.8 was installed successfully 2026-09-01 05:04:25.067398 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-01 05:04:25.067424 | instance | 2.17.12 2026-09-01 05:04:25.067449 | instance | Checked out vexxhost.kubernetes to v3.3.0 2026-09-01 05:04:25.067473 | 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-01 05:04:25.067498 | instance | Starting galaxy collection install process 2026-09-01 05:04:25.067523 | instance | Process install dependency map 2026-09-01 05:04:25.067548 | instance | Starting collection install process 2026-09-01 05:04:25.067572 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes' 2026-09-01 05:04:25.067597 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes 2026-09-01 05:04:25.067621 | instance | vexxhost.kubernetes:3.3.0 was installed successfully 2026-09-01 05:04:25.067645 | instance | [WARNING]: Collection ansible.netcommon does not support Ansible version 2026-09-01 05:04:25.067669 | instance | 2.17.12 2026-09-01 05:04:25.075675 | 2026-09-01 05:04:25.075746 | PLAY RECAP 2026-09-01 05:04:25.075793 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-01 05:04:25.075814 | 2026-09-01 05:04:25.248172 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-09-01 05:04:25.268644 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-09-01 05:04:25.898818 | 2026-09-01 05:04:25.898949 | PLAY [all] 2026-09-01 05:04:25.910468 | 2026-09-01 05:04:25.910539 | TASK [Install "jq" for log collection] 2026-09-01 05:04:36.099956 | instance | changed 2026-09-01 05:04:36.102957 | 2026-09-01 05:04:36.103042 | PLAY RECAP 2026-09-01 05:04:36.103113 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-09-01 05:04:36.103193 | 2026-09-01 05:04:36.248525 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-09-01 05:04:36.260085 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-09-01 05:04:36.881527 | 2026-09-01 05:04:36.881669 | PLAY [all] 2026-09-01 05:04:36.893579 | 2026-09-01 05:04:36.893657 | LOOP [Check inventory directories] 2026-09-01 05:04:37.246842 | instance | ok: "src/github.com/vexxhost/atmosphere" 2026-09-01 05:04:37.427557 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/aio/inventory" 2026-09-01 05:04:37.601358 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/aio/inventory" 2026-09-01 05:04:37.614007 | 2026-09-01 05:04:37.614273 | LOOP [Copy inventory file for Zuul] 2026-09-01 05:04:38.457162 | instance | changed: 2026-09-01 05:04:38.457556 | instance | { 2026-09-01 05:04:38.457605 | instance | "ansible_loop_var": "item", 2026-09-01 05:04:38.457639 | instance | "changed": false, 2026-09-01 05:04:38.457694 | instance | "failed": false, 2026-09-01 05:04:38.457762 | instance | "invocation": { 2026-09-01 05:04:38.457791 | instance | "module_args": { 2026-09-01 05:04:38.457818 | instance | "checksum_algorithm": "sha1", 2026-09-01 05:04:38.457866 | instance | "follow": true, 2026-09-01 05:04:38.457919 | instance | "get_attributes": true, 2026-09-01 05:04:38.457983 | instance | "get_checksum": true, 2026-09-01 05:04:38.458018 | instance | "get_mime": true, 2026-09-01 05:04:38.458044 | instance | "path": "src/github.com/vexxhost/atmosphere" 2026-09-01 05:04:38.458070 | instance | } 2026-09-01 05:04:38.458094 | instance | }, 2026-09-01 05:04:38.458145 | instance | "item": "src/github.com/vexxhost/atmosphere", 2026-09-01 05:04:38.458208 | instance | "stat": { 2026-09-01 05:04:38.458236 | instance | "atime": 1788239057.8413124, 2026-09-01 05:04:38.458262 | instance | "attr_flags": "e", 2026-09-01 05:04:38.458286 | instance | "attributes": [ 2026-09-01 05:04:38.458338 | instance | "extents" 2026-09-01 05:04:38.458388 | instance | ], 2026-09-01 05:04:38.458464 | instance | "block_size": 4096, 2026-09-01 05:04:38.458518 | instance | "blocks": 8, 2026-09-01 05:04:38.458574 | instance | "charset": "unknown", 2026-09-01 05:04:38.458611 | instance | "ctime": 1788239056.78531, 2026-09-01 05:04:38.458638 | instance | "dev": 64513, 2026-09-01 05:04:38.458687 | instance | "device_type": 0, 2026-09-01 05:04:38.458753 | instance | "executable": true, 2026-09-01 05:04:38.458816 | instance | "exists": true, 2026-09-01 05:04:38.458857 | instance | "gid": 1000, 2026-09-01 05:04:38.458884 | instance | "gr_name": "zuul", 2026-09-01 05:04:38.458932 | instance | "inode": 1046609, 2026-09-01 05:04:38.458992 | instance | "isblk": false, 2026-09-01 05:04:38.459024 | instance | "ischr": false, 2026-09-01 05:04:38.459048 | instance | "isdir": true, 2026-09-01 05:04:38.459073 | instance | "isfifo": false, 2026-09-01 05:04:38.459119 | instance | "isgid": false, 2026-09-01 05:04:38.459171 | instance | "islnk": false, 2026-09-01 05:04:38.459200 | instance | "isreg": false, 2026-09-01 05:04:38.459306 | instance | "issock": false, 2026-09-01 05:04:38.459337 | instance | "isuid": false, 2026-09-01 05:04:38.459406 | instance | "mimetype": "unknown", 2026-09-01 05:04:38.459467 | instance | "mode": "0755", 2026-09-01 05:04:38.459501 | instance | "mtime": 1788239056.78531, 2026-09-01 05:04:38.459525 | instance | "nlink": 23, 2026-09-01 05:04:38.459572 | instance | "path": "src/github.com/vexxhost/atmosphere", 2026-09-01 05:04:38.459626 | instance | "pw_name": "zuul", 2026-09-01 05:04:38.459658 | instance | "readable": true, 2026-09-01 05:04:38.459718 | instance | "rgrp": true, 2026-09-01 05:04:38.459745 | instance | "roth": true, 2026-09-01 05:04:38.459784 | instance | "rusr": true, 2026-09-01 05:04:38.459810 | instance | "size": 4096, 2026-09-01 05:04:38.459878 | instance | "uid": 1000, 2026-09-01 05:04:38.459910 | instance | "version": "806732110", 2026-09-01 05:04:38.459970 | instance | "wgrp": false, 2026-09-01 05:04:38.460000 | instance | "woth": false, 2026-09-01 05:04:38.460025 | instance | "writeable": true, 2026-09-01 05:04:38.460095 | instance | "wusr": true, 2026-09-01 05:04:38.460126 | instance | "xgrp": true, 2026-09-01 05:04:38.460151 | instance | "xoth": true, 2026-09-01 05:04:38.460175 | instance | "xusr": true 2026-09-01 05:04:38.460200 | instance | } 2026-09-01 05:04:38.460224 | instance | } 2026-09-01 05:04:38.460274 | instance | ok: All items complete 2026-09-01 05:04:38.460303 | 2026-09-01 05:04:38.461962 | instance | skipping: Conditional result was False 2026-09-01 05:04:38.462799 | instance | skipping: Conditional result was False 2026-09-01 05:04:38.477247 | 2026-09-01 05:04:38.477435 | LOOP [Switch "ansible_host" to private IP] 2026-09-01 05:04:38.854699 | instance | changed: 1 replacements made 2026-09-01 05:04:38.856403 | instance | skipping: Conditional result was False 2026-09-01 05:04:38.857850 | instance | skipping: Conditional result was False 2026-09-01 05:04:38.877053 | 2026-09-01 05:04:38.877304 | TASK [Run Molecule scenario] 2026-09-01 05:04:39.807925 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-09-01 05:04:40.224387 | instance | INFO [aio > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-09-01 05:04:40.224480 | instance | INFO [aio > prerun] Performing prerun with role_name_check=0... 2026-09-01 05:04:51.201220 | instance | INFO [aio > dependency] Executing 2026-09-01 05:04:51.201626 | instance | WARNING [aio > dependency] Missing roles requirements file: requirements.yml 2026-09-01 05:04:51.202072 | instance | WARNING [aio > dependency] Missing collections requirements file: collections.yml 2026-09-01 05:04:51.202371 | instance | WARNING [aio > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-09-01 05:04:51.219061 | instance | INFO [aio > cleanup] Executing 2026-09-01 05:04:51.219858 | instance | WARNING [aio > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-09-01 05:04:51.232860 | instance | INFO [aio > destroy] Executing 2026-09-01 05:04:51.232922 | instance | WARNING [aio > destroy] Skipping, '--destroy=never' requested. 2026-09-01 05:04:51.233029 | instance | INFO [aio > destroy] Executed: Successful 2026-09-01 05:04:51.243235 | instance | INFO [aio > syntax] Executing 2026-09-01 05:04:53.953290 | instance | 2026-09-01 05:04:53.953533 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/aio/converge.yml 2026-09-01 05:04:54.102195 | instance | INFO [aio > syntax] Executed: Successful 2026-09-01 05:04:54.117924 | instance | INFO [aio > create] Executing 2026-09-01 05:04:54.121540 | instance | WARNING [aio > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-09-01 05:04:54.135674 | instance | INFO [aio > prepare] Executing 2026-09-01 05:04:55.014752 | instance | 2026-09-01 05:04:55.014972 | instance | PLAY [Prepare] ***************************************************************** 2026-09-01 05:04:55.015237 | instance | 2026-09-01 05:04:55.015556 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-01 05:04:55.015860 | instance | Tuesday 01 September 2026 05:04:55 +0000 (0:00:00.024) 0:00:00.024 ***** 2026-09-01 05:04:56.362381 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-09-01 05:04:56.362536 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-09-01 05:04:56.362799 | instance | interpreter could change the meaning of that path. See 2026-09-01 05:04:56.363027 | instance | https://docs.ansible.com/ansible- 2026-09-01 05:04:56.363302 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-09-01 05:04:56.373823 | instance | ok: [instance] 2026-09-01 05:04:56.373975 | instance | 2026-09-01 05:04:56.374255 | instance | TASK [Configure short hostname] ************************************************ 2026-09-01 05:04:56.374487 | instance | Tuesday 01 September 2026 05:04:56 +0000 (0:00:01.359) 0:00:01.384 ***** 2026-09-01 05:04:57.175668 | instance | changed: [instance] 2026-09-01 05:04:57.175883 | instance | 2026-09-01 05:04:57.176301 | instance | TASK [Ensure hostname inside hosts file] *************************************** 2026-09-01 05:04:57.176417 | instance | Tuesday 01 September 2026 05:04:57 +0000 (0:00:00.801) 0:00:02.185 ***** 2026-09-01 05:04:57.473843 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created 2026-09-01 05:04:57.474085 | instance | with a mode of 0700, this may cause issues when running as another user. To 2026-09-01 05:04:57.474350 | instance | avoid this, create the remote_tmp dir with the correct permissions manually 2026-09-01 05:04:57.484113 | instance | changed: [instance] 2026-09-01 05:04:57.484341 | instance | 2026-09-01 05:04:57.484586 | instance | TASK [Install "dirmngr" for GPG keyserver operations] ************************** 2026-09-01 05:04:57.484820 | instance | Tuesday 01 September 2026 05:04:57 +0000 (0:00:00.308) 0:00:02.494 ***** 2026-09-01 05:04:58.671901 | instance | ok: [instance] 2026-09-01 05:04:58.672411 | instance | 2026-09-01 05:04:58.672420 | instance | TASK [Purge "snapd" package] *************************************************** 2026-09-01 05:04:58.672428 | instance | Tuesday 01 September 2026 05:04:58 +0000 (0:00:01.186) 0:00:03.681 ***** 2026-09-01 05:04:59.405729 | instance | ok: [instance] 2026-09-01 05:04:59.405820 | instance | 2026-09-01 05:04:59.405834 | instance | PLAY [Generate workspace for Atmosphere] *************************************** 2026-09-01 05:04:59.405844 | instance | 2026-09-01 05:04:59.405853 | instance | TASK [Create folders for workspace] ******************************************** 2026-09-01 05:04:59.405870 | instance | Tuesday 01 September 2026 05:04:59 +0000 (0:00:00.732) 0:00:04.413 ***** 2026-09-01 05:05:00.504989 | instance | changed: [localhost] => (item=group_vars) 2026-09-01 05:05:00.505653 | instance | changed: [localhost] => (item=group_vars/all) 2026-09-01 05:05:00.509036 | instance | changed: [localhost] => (item=group_vars/controllers) 2026-09-01 05:05:00.509068 | instance | changed: [localhost] => (item=group_vars/cephs) 2026-09-01 05:05:00.509080 | instance | changed: [localhost] => (item=group_vars/computes) 2026-09-01 05:05:00.509090 | instance | changed: [localhost] => (item=host_vars) 2026-09-01 05:05:00.509100 | instance | 2026-09-01 05:05:00.509110 | instance | PLAY [Generate Ceph control plane configuration for workspace] ***************** 2026-09-01 05:05:00.509120 | instance | 2026-09-01 05:05:00.509130 | instance | TASK [Ensure the Ceph control plane configuration file exists] ***************** 2026-09-01 05:05:00.509139 | instance | Tuesday 01 September 2026 05:05:00 +0000 (0:00:01.100) 0:00:05.514 ***** 2026-09-01 05:05:00.703223 | instance | changed: [localhost] 2026-09-01 05:05:00.703714 | instance | 2026-09-01 05:05:00.704098 | instance | TASK [Load the current Ceph control plane configuration into a variable] ******* 2026-09-01 05:05:00.704400 | instance | Tuesday 01 September 2026 05:05:00 +0000 (0:00:00.197) 0:00:05.712 ***** 2026-09-01 05:05:00.736878 | instance | ok: [localhost] 2026-09-01 05:05:00.737285 | instance | 2026-09-01 05:05:00.737599 | instance | TASK [Generate Ceph control plane values for missing variables] **************** 2026-09-01 05:05:00.737903 | instance | Tuesday 01 September 2026 05:05:00 +0000 (0:00:00.033) 0:00:05.745 ***** 2026-09-01 05:05:00.807680 | instance | ok: [localhost] => (item={'key': 'ceph_fsid', 'value': 'b9fd0379-5fc8-5a50-8db6-c544b35c6310'}) 2026-09-01 05:05:00.807823 | instance | ok: [localhost] => (item={'key': 'ceph_mon_public_network', 'value': '10.96.240.0/24'}) 2026-09-01 05:05:00.808110 | instance | 2026-09-01 05:05:00.808355 | instance | TASK [Write new Ceph control plane configuration file to disk] ***************** 2026-09-01 05:05:00.808604 | instance | Tuesday 01 September 2026 05:05:00 +0000 (0:00:00.069) 0:00:05.815 ***** 2026-09-01 05:05:01.425783 | instance | changed: [localhost] 2026-09-01 05:05:01.425876 | instance | 2026-09-01 05:05:01.426042 | instance | PLAY [Generate Ceph OSD configuration for workspace] *************************** 2026-09-01 05:05:01.426182 | instance | 2026-09-01 05:05:01.426331 | instance | TASK [Ensure the Ceph OSDs configuration file exists] ************************** 2026-09-01 05:05:01.426484 | instance | Tuesday 01 September 2026 05:05:01 +0000 (0:00:00.621) 0:00:06.436 ***** 2026-09-01 05:05:01.638054 | instance | changed: [localhost] 2026-09-01 05:05:01.638190 | instance | 2026-09-01 05:05:01.638446 | instance | TASK [Load the current Ceph OSDs configuration into a variable] **************** 2026-09-01 05:05:01.638682 | instance | Tuesday 01 September 2026 05:05:01 +0000 (0:00:00.212) 0:00:06.648 ***** 2026-09-01 05:05:01.674532 | instance | ok: [localhost] 2026-09-01 05:05:01.674638 | instance | 2026-09-01 05:05:01.674902 | instance | TASK [Generate Ceph OSDs values for missing variables] ************************* 2026-09-01 05:05:01.675156 | instance | Tuesday 01 September 2026 05:05:01 +0000 (0:00:00.036) 0:00:06.685 ***** 2026-09-01 05:05:01.720555 | instance | ok: [localhost] => (item={'key': 'ceph_osd_devices', 'value': ['/dev/vdb', '/dev/vdc', '/dev/vdd']}) 2026-09-01 05:05:01.720861 | instance | 2026-09-01 05:05:01.721271 | instance | TASK [Write new Ceph OSDs configuration file to disk] ************************** 2026-09-01 05:05:01.721643 | instance | Tuesday 01 September 2026 05:05:01 +0000 (0:00:00.046) 0:00:06.731 ***** 2026-09-01 05:05:02.126963 | instance | changed: [localhost] 2026-09-01 05:05:02.127082 | instance | 2026-09-01 05:05:02.127440 | instance | PLAY [Generate Kubernetes configuration for workspace] ************************* 2026-09-01 05:05:02.127823 | instance | 2026-09-01 05:05:02.128217 | instance | TASK [Ensure the Kubernetes configuration file exists] ************************* 2026-09-01 05:05:02.128468 | instance | Tuesday 01 September 2026 05:05:02 +0000 (0:00:00.406) 0:00:07.137 ***** 2026-09-01 05:05:02.306702 | instance | changed: [localhost] 2026-09-01 05:05:02.306829 | instance | 2026-09-01 05:05:02.307131 | instance | TASK [Load the current Kubernetes configuration into a variable] *************** 2026-09-01 05:05:02.307354 | instance | Tuesday 01 September 2026 05:05:02 +0000 (0:00:00.179) 0:00:07.316 ***** 2026-09-01 05:05:02.338343 | instance | ok: [localhost] 2026-09-01 05:05:02.338540 | instance | 2026-09-01 05:05:02.338787 | instance | TASK [Generate Kubernetes values for missing variables] ************************ 2026-09-01 05:05:02.339060 | instance | Tuesday 01 September 2026 05:05:02 +0000 (0:00:00.032) 0:00:07.349 ***** 2026-09-01 05:05:02.390299 | instance | ok: [localhost] => (item={'key': 'kubernetes_hostname', 'value': '10.96.240.10'}) 2026-09-01 05:05:02.390492 | instance | ok: [localhost] => (item={'key': 'kubernetes_keepalived_vrid', 'value': 42}) 2026-09-01 05:05:02.390735 | instance | ok: [localhost] => (item={'key': 'kubernetes_keepalived_vip', 'value': '10.96.240.10'}) 2026-09-01 05:05:02.391016 | instance | 2026-09-01 05:05:02.391257 | instance | TASK [Write new Kubernetes configuration file to disk] ************************* 2026-09-01 05:05:02.391497 | instance | Tuesday 01 September 2026 05:05:02 +0000 (0:00:00.050) 0:00:07.400 ***** 2026-09-01 05:05:02.801063 | instance | changed: [localhost] 2026-09-01 05:05:02.801463 | instance | 2026-09-01 05:05:02.801838 | instance | PLAY [Generate Keepalived configuration for workspace] ************************* 2026-09-01 05:05:02.802172 | instance | 2026-09-01 05:05:02.802486 | instance | TASK [Ensure the Keeaplived configuration file exists] ************************* 2026-09-01 05:05:02.802799 | instance | Tuesday 01 September 2026 05:05:02 +0000 (0:00:00.411) 0:00:07.811 ***** 2026-09-01 05:05:03.000057 | instance | changed: [localhost] 2026-09-01 05:05:03.000450 | instance | 2026-09-01 05:05:03.000772 | instance | TASK [Load the current Keepalived configuration into a variable] *************** 2026-09-01 05:05:03.001118 | instance | Tuesday 01 September 2026 05:05:02 +0000 (0:00:00.197) 0:00:08.008 ***** 2026-09-01 05:05:03.028321 | instance | ok: [localhost] 2026-09-01 05:05:03.028632 | instance | 2026-09-01 05:05:03.028967 | instance | TASK [Generate Keepalived values for missing variables] ************************ 2026-09-01 05:05:03.029274 | instance | Tuesday 01 September 2026 05:05:03 +0000 (0:00:00.030) 0:00:08.039 ***** 2026-09-01 05:05:03.084024 | instance | ok: [localhost] => (item={'key': 'keepalived_interface', 'value': 'br-ex'}) 2026-09-01 05:05:03.084097 | instance | ok: [localhost] => (item={'key': 'keepalived_vip', 'value': '10.96.250.10'}) 2026-09-01 05:05:03.084197 | instance | 2026-09-01 05:05:03.084460 | instance | TASK [Write new Keepalived configuration file to disk] ************************* 2026-09-01 05:05:03.084709 | instance | Tuesday 01 September 2026 05:05:03 +0000 (0:00:00.054) 0:00:08.093 ***** 2026-09-01 05:05:03.506502 | instance | changed: [localhost] 2026-09-01 05:05:03.506695 | instance | 2026-09-01 05:05:03.507022 | instance | PLAY [Generate endpoints for workspace] **************************************** 2026-09-01 05:05:03.507327 | instance | 2026-09-01 05:05:03.507604 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-01 05:05:03.507986 | instance | Tuesday 01 September 2026 05:05:03 +0000 (0:00:00.422) 0:00:08.516 ***** 2026-09-01 05:05:04.265909 | instance | ok: [localhost] 2026-09-01 05:05:04.266143 | instance | 2026-09-01 05:05:04.266408 | instance | TASK [Ensure the endpoints file exists] **************************************** 2026-09-01 05:05:04.266664 | instance | Tuesday 01 September 2026 05:05:04 +0000 (0:00:00.759) 0:00:09.276 ***** 2026-09-01 05:05:04.460526 | instance | changed: [localhost] 2026-09-01 05:05:04.460593 | instance | 2026-09-01 05:05:04.460746 | instance | TASK [Load the current endpoints into a variable] ****************************** 2026-09-01 05:05:04.460909 | instance | Tuesday 01 September 2026 05:05:04 +0000 (0:00:00.194) 0:00:09.470 ***** 2026-09-01 05:05:04.494822 | instance | ok: [localhost] 2026-09-01 05:05:04.494955 | instance | 2026-09-01 05:05:04.495107 | instance | TASK [Generate endpoint skeleton for missing variables] ************************ 2026-09-01 05:05:04.495256 | instance | Tuesday 01 September 2026 05:05:04 +0000 (0:00:00.034) 0:00:09.505 ***** 2026-09-01 05:05:05.198421 | instance | ok: [localhost] => (item=keycloak_host) 2026-09-01 05:05:05.198717 | instance | ok: [localhost] => (item=kube_prometheus_stack_grafana_host) 2026-09-01 05:05:05.199100 | instance | ok: [localhost] => (item=kube_prometheus_stack_alertmanager_host) 2026-09-01 05:05:05.199362 | instance | ok: [localhost] => (item=kube_prometheus_stack_prometheus_host) 2026-09-01 05:05:05.199656 | instance | ok: [localhost] => (item=openstack_helm_endpoints_region_name) 2026-09-01 05:05:05.200032 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_api_host) 2026-09-01 05:05:05.200318 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_api_host) 2026-09-01 05:05:05.200599 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_api_host) 2026-09-01 05:05:05.200875 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_api_host) 2026-09-01 05:05:05.201144 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_api_host) 2026-09-01 05:05:05.201444 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_api_host) 2026-09-01 05:05:05.201698 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_api_host) 2026-09-01 05:05:05.201989 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_novnc_host) 2026-09-01 05:05:05.202228 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_api_host) 2026-09-01 05:05:05.202635 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_api_host) 2026-09-01 05:05:05.202801 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_api_host) 2026-09-01 05:05:05.203055 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_api_host) 2026-09-01 05:05:05.203326 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_registry_host) 2026-09-01 05:05:05.203540 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_api_host) 2026-09-01 05:05:05.203766 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_cfn_api_host) 2026-09-01 05:05:05.204051 | instance | ok: [localhost] => (item=openstack_helm_endpoints_horizon_api_host) 2026-09-01 05:05:05.204282 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rgw_host) 2026-09-01 05:05:05.204505 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_api_host) 2026-09-01 05:05:05.204722 | instance | 2026-09-01 05:05:05.204976 | instance | TASK [Write new endpoints file to disk] **************************************** 2026-09-01 05:05:05.205206 | instance | Tuesday 01 September 2026 05:05:05 +0000 (0:00:00.703) 0:00:10.208 ***** 2026-09-01 05:05:05.585113 | instance | changed: [localhost] 2026-09-01 05:05:05.585559 | instance | 2026-09-01 05:05:05.585909 | instance | TASK [Ensure the endpoints file exists] **************************************** 2026-09-01 05:05:05.586228 | instance | Tuesday 01 September 2026 05:05:05 +0000 (0:00:00.386) 0:00:10.595 ***** 2026-09-01 05:05:05.811885 | instance | changed: [localhost] 2026-09-01 05:05:05.812364 | instance | 2026-09-01 05:05:05.812828 | instance | PLAY [Generate Neutron configuration for workspace] **************************** 2026-09-01 05:05:05.813282 | instance | 2026-09-01 05:05:05.813743 | instance | TASK [Ensure the Neutron configuration file exists] **************************** 2026-09-01 05:05:05.814096 | instance | Tuesday 01 September 2026 05:05:05 +0000 (0:00:00.223) 0:00:10.818 ***** 2026-09-01 05:05:06.001660 | instance | changed: [localhost] 2026-09-01 05:05:06.001728 | instance | 2026-09-01 05:05:06.001740 | instance | TASK [Load the current Neutron configuration into a variable] ****************** 2026-09-01 05:05:06.001751 | instance | Tuesday 01 September 2026 05:05:05 +0000 (0:00:00.192) 0:00:11.011 ***** 2026-09-01 05:05:06.040053 | instance | ok: [localhost] 2026-09-01 05:05:06.040146 | instance | 2026-09-01 05:05:06.040155 | instance | TASK [Generate Neutron values for missing variables] *************************** 2026-09-01 05:05:06.040161 | instance | Tuesday 01 September 2026 05:05:06 +0000 (0:00:00.038) 0:00:11.049 ***** 2026-09-01 05:05:06.086062 | 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-01 05:05:06.086221 | instance | 2026-09-01 05:05:06.086511 | instance | TASK [Write new Neutron configuration file to disk] **************************** 2026-09-01 05:05:06.086845 | instance | Tuesday 01 September 2026 05:05:06 +0000 (0:00:00.047) 0:00:11.096 ***** 2026-09-01 05:05:06.453356 | instance | changed: [localhost] 2026-09-01 05:05:06.453533 | instance | 2026-09-01 05:05:06.453823 | instance | PLAY [Generate Nova configuration for workspace] ******************************* 2026-09-01 05:05:06.454037 | instance | 2026-09-01 05:05:06.454342 | instance | TASK [Ensure the Nova configuration file exists] ******************************* 2026-09-01 05:05:06.454558 | instance | Tuesday 01 September 2026 05:05:06 +0000 (0:00:00.366) 0:00:11.463 ***** 2026-09-01 05:05:06.656192 | instance | changed: [localhost] 2026-09-01 05:05:06.656373 | instance | 2026-09-01 05:05:06.656681 | instance | TASK [Load the current Nova configuration into a variable] ********************* 2026-09-01 05:05:06.656960 | instance | Tuesday 01 September 2026 05:05:06 +0000 (0:00:00.202) 0:00:11.666 ***** 2026-09-01 05:05:06.691764 | instance | ok: [localhost] 2026-09-01 05:05:06.692055 | instance | 2026-09-01 05:05:06.692400 | instance | TASK [Generate Nova values for missing variables] ****************************** 2026-09-01 05:05:06.692743 | instance | Tuesday 01 September 2026 05:05:06 +0000 (0:00:00.035) 0:00:11.701 ***** 2026-09-01 05:05:06.743341 | 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-01 05:05:06.743497 | instance | 2026-09-01 05:05:06.743850 | instance | TASK [Write new Nova configuration file to disk] ******************************* 2026-09-01 05:05:06.744120 | instance | Tuesday 01 September 2026 05:05:06 +0000 (0:00:00.051) 0:00:11.753 ***** 2026-09-01 05:05:07.129063 | instance | changed: [localhost] 2026-09-01 05:05:07.129471 | instance | 2026-09-01 05:05:07.129739 | instance | PLAY [Generate secrets for workspace] ****************************************** 2026-09-01 05:05:07.130474 | instance | 2026-09-01 05:05:07.131135 | instance | TASK [Ensure the secrets file exists] ****************************************** 2026-09-01 05:05:07.131416 | instance | Tuesday 01 September 2026 05:05:07 +0000 (0:00:00.385) 0:00:12.138 ***** 2026-09-01 05:05:07.329337 | instance | changed: [localhost] 2026-09-01 05:05:07.329520 | instance | 2026-09-01 05:05:07.329801 | instance | TASK [Load the current secrets into a variable] ******************************** 2026-09-01 05:05:07.330074 | instance | Tuesday 01 September 2026 05:05:07 +0000 (0:00:00.199) 0:00:12.338 ***** 2026-09-01 05:05:07.361743 | instance | ok: [localhost] 2026-09-01 05:05:07.361997 | instance | 2026-09-01 05:05:07.362685 | instance | TASK [Generate secrets for missing variables] ********************************** 2026-09-01 05:05:07.363058 | instance | Tuesday 01 September 2026 05:05:07 +0000 (0:00:00.033) 0:00:12.371 ***** 2026-09-01 05:05:07.737735 | instance | ok: [localhost] => (item=heat_auth_encryption_key) 2026-09-01 05:05:07.738165 | instance | ok: [localhost] => (item=keepalived_password) 2026-09-01 05:05:07.738491 | instance | ok: [localhost] => (item=keycloak_admin_password) 2026-09-01 05:05:07.738827 | instance | ok: [localhost] => (item=keycloak_database_password) 2026-09-01 05:05:07.739141 | instance | ok: [localhost] => (item=keystone_keycloak_client_secret) 2026-09-01 05:05:07.739441 | instance | ok: [localhost] => (item=keystone_oidc_crypto_passphrase) 2026-09-01 05:05:07.739874 | instance | ok: [localhost] => (item=kube_prometheus_stack_grafana_admin_password) 2026-09-01 05:05:07.740319 | instance | ok: [localhost] => (item=octavia_heartbeat_key) 2026-09-01 05:05:07.740833 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rabbitmq_admin_password) 2026-09-01 05:05:07.741147 | instance | ok: [localhost] => (item=openstack_helm_endpoints_memcached_secret_key) 2026-09-01 05:05:07.741449 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_admin_password) 2026-09-01 05:05:07.741749 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_mariadb_password) 2026-09-01 05:05:07.742113 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_rabbitmq_password) 2026-09-01 05:05:07.742816 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_keystone_password) 2026-09-01 05:05:07.743178 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_mariadb_password) 2026-09-01 05:05:07.743491 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_rabbitmq_password) 2026-09-01 05:05:07.743875 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_keystone_password) 2026-09-01 05:05:07.744328 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_mariadb_password) 2026-09-01 05:05:07.744663 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_rabbitmq_password) 2026-09-01 05:05:07.744998 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_keystone_password) 2026-09-01 05:05:07.745407 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_mariadb_password) 2026-09-01 05:05:07.745917 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_keystone_password) 2026-09-01 05:05:07.746260 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_mariadb_password) 2026-09-01 05:05:07.746565 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_keystone_password) 2026-09-01 05:05:07.746992 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_mariadb_password) 2026-09-01 05:05:07.747335 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_rabbitmq_password) 2026-09-01 05:05:07.747638 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_metadata_secret) 2026-09-01 05:05:07.748061 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_keystone_password) 2026-09-01 05:05:07.748449 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_mariadb_password) 2026-09-01 05:05:07.748789 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_rabbitmq_password) 2026-09-01 05:05:07.749106 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_keystone_password) 2026-09-01 05:05:07.749484 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_mariadb_password) 2026-09-01 05:05:07.749827 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_rabbitmq_password) 2026-09-01 05:05:07.750137 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_keystone_password) 2026-09-01 05:05:07.750437 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_mariadb_password) 2026-09-01 05:05:07.750741 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_rabbitmq_password) 2026-09-01 05:05:07.751080 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_keystone_password) 2026-09-01 05:05:07.751384 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_mariadb_password) 2026-09-01 05:05:07.751686 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_rabbitmq_password) 2026-09-01 05:05:07.752139 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_keystone_password) 2026-09-01 05:05:07.752502 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_mariadb_password) 2026-09-01 05:05:07.752858 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_rabbitmq_password) 2026-09-01 05:05:07.753346 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_keystone_password) 2026-09-01 05:05:07.753732 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_trustee_keystone_password) 2026-09-01 05:05:07.754125 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_stack_user_keystone_password) 2026-09-01 05:05:07.754455 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_mariadb_password) 2026-09-01 05:05:07.754778 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_rabbitmq_password) 2026-09-01 05:05:07.755091 | instance | ok: [localhost] => (item=openstack_helm_endpoints_horizon_mariadb_password) 2026-09-01 05:05:07.755392 | instance | ok: [localhost] => (item=openstack_helm_endpoints_tempest_keystone_password) 2026-09-01 05:05:07.755703 | instance | ok: [localhost] => (item=openstack_helm_endpoints_openstack_exporter_keystone_password) 2026-09-01 05:05:07.756212 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rgw_keystone_password) 2026-09-01 05:05:07.756559 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_keystone_password) 2026-09-01 05:05:07.756898 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_mariadb_password) 2026-09-01 05:05:07.757204 | instance | ok: [localhost] => (item=openstack_helm_endpoints_staffeln_mariadb_password) 2026-09-01 05:05:07.757511 | instance | 2026-09-01 05:05:07.757858 | instance | TASK [Generate base64 encoded secrets] ***************************************** 2026-09-01 05:05:07.758171 | instance | Tuesday 01 September 2026 05:05:07 +0000 (0:00:00.376) 0:00:12.748 ***** 2026-09-01 05:05:07.808927 | instance | ok: [localhost] => (item=barbican_kek) 2026-09-01 05:05:07.809211 | instance | 2026-09-01 05:05:07.809619 | instance | TASK [Generate temporary files for generating keys for missing variables] ****** 2026-09-01 05:05:07.809990 | instance | Tuesday 01 September 2026 05:05:07 +0000 (0:00:00.070) 0:00:12.818 ***** 2026-09-01 05:05:08.293817 | instance | changed: [localhost] => (item=manila_ssh_key) 2026-09-01 05:05:08.293893 | instance | changed: [localhost] => (item=nova_ssh_key) 2026-09-01 05:05:08.293905 | instance | 2026-09-01 05:05:08.293915 | instance | TASK [Generate SSH keys for missing variables] ********************************* 2026-09-01 05:05:08.293926 | instance | Tuesday 01 September 2026 05:05:08 +0000 (0:00:00.483) 0:00:13.302 ***** 2026-09-01 05:05:11.981934 | instance | changed: [localhost] => (item=manila_ssh_key) 2026-09-01 05:05:11.982093 | instance | changed: [localhost] => (item=nova_ssh_key) 2026-09-01 05:05:11.982881 | instance | 2026-09-01 05:05:11.982951 | instance | TASK [Set values for SSH keys] ************************************************* 2026-09-01 05:05:11.982963 | instance | Tuesday 01 September 2026 05:05:11 +0000 (0:00:03.689) 0:00:16.992 ***** 2026-09-01 05:05:12.057544 | instance | ok: [localhost] => (item=manila_ssh_key) 2026-09-01 05:05:12.057777 | instance | ok: [localhost] => (item=nova_ssh_key) 2026-09-01 05:05:12.058146 | instance | 2026-09-01 05:05:12.058476 | instance | TASK [Delete the temporary files generated for SSH keys] *********************** 2026-09-01 05:05:12.058831 | instance | Tuesday 01 September 2026 05:05:12 +0000 (0:00:00.075) 0:00:17.067 ***** 2026-09-01 05:05:12.417907 | instance | changed: [localhost] => (item=manila_ssh_key) 2026-09-01 05:05:12.418094 | instance | changed: [localhost] => (item=nova_ssh_key) 2026-09-01 05:05:12.418397 | instance | 2026-09-01 05:05:12.418718 | instance | TASK [Write new secrets file to disk] ****************************************** 2026-09-01 05:05:12.419022 | instance | Tuesday 01 September 2026 05:05:12 +0000 (0:00:00.360) 0:00:17.428 ***** 2026-09-01 05:05:12.839370 | instance | changed: [localhost] 2026-09-01 05:05:12.840022 | instance | 2026-09-01 05:05:12.840388 | instance | TASK [Encrypt secrets file with Vault password] ******************************** 2026-09-01 05:05:12.840734 | instance | Tuesday 01 September 2026 05:05:12 +0000 (0:00:00.418) 0:00:17.846 ***** 2026-09-01 05:05:12.879434 | instance | skipping: [localhost] 2026-09-01 05:05:12.879655 | instance | 2026-09-01 05:05:12.879833 | instance | PLAY [Setup networking] ******************************************************** 2026-09-01 05:05:12.879968 | instance | 2026-09-01 05:05:12.880104 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-01 05:05:12.880249 | instance | Tuesday 01 September 2026 05:05:12 +0000 (0:00:00.043) 0:00:17.890 ***** 2026-09-01 05:05:13.711848 | instance | ok: [instance] 2026-09-01 05:05:13.712228 | instance | 2026-09-01 05:05:13.712734 | instance | TASK [Create bridge for management network] ************************************ 2026-09-01 05:05:13.713122 | instance | Tuesday 01 September 2026 05:05:13 +0000 (0:00:00.831) 0:00:18.721 ***** 2026-09-01 05:05:14.101764 | instance | ok: [instance] 2026-09-01 05:05:14.102167 | instance | 2026-09-01 05:05:14.102494 | instance | TASK [Create fake interface for management bridge] ***************************** 2026-09-01 05:05:14.102834 | instance | Tuesday 01 September 2026 05:05:14 +0000 (0:00:00.390) 0:00:19.111 ***** 2026-09-01 05:05:14.340564 | instance | ok: [instance] 2026-09-01 05:05:14.340817 | instance | 2026-09-01 05:05:14.341013 | instance | TASK [Assign dummy interface to management bridge] ***************************** 2026-09-01 05:05:14.341211 | instance | Tuesday 01 September 2026 05:05:14 +0000 (0:00:00.239) 0:00:19.351 ***** 2026-09-01 05:05:14.564270 | instance | ok: [instance] 2026-09-01 05:05:14.564655 | instance | 2026-09-01 05:05:14.564972 | instance | TASK [Assign IP address for management bridge] ********************************* 2026-09-01 05:05:14.565273 | instance | Tuesday 01 September 2026 05:05:14 +0000 (0:00:00.222) 0:00:19.574 ***** 2026-09-01 05:05:14.779521 | instance | ok: [instance] 2026-09-01 05:05:14.780085 | instance | 2026-09-01 05:05:14.780443 | instance | TASK [Bring up interfaces] ***************************************************** 2026-09-01 05:05:14.780874 | instance | Tuesday 01 September 2026 05:05:14 +0000 (0:00:00.215) 0:00:19.789 ***** 2026-09-01 05:05:15.192751 | instance | ok: [instance] => (item=br-mgmt) 2026-09-01 05:05:15.193136 | instance | ok: [instance] => (item=dummy0) 2026-09-01 05:05:15.193431 | instance | 2026-09-01 05:05:15.193763 | instance | PLAY [Create devices for Ceph] ************************************************* 2026-09-01 05:05:15.194045 | instance | 2026-09-01 05:05:15.194343 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-01 05:05:15.194674 | instance | Tuesday 01 September 2026 05:05:15 +0000 (0:00:00.411) 0:00:20.201 ***** 2026-09-01 05:05:16.042768 | instance | ok: [instance] 2026-09-01 05:05:16.043151 | instance | 2026-09-01 05:05:16.043477 | instance | TASK [Install depedencies] ***************************************************** 2026-09-01 05:05:16.043861 | instance | Tuesday 01 September 2026 05:05:16 +0000 (0:00:00.849) 0:00:21.051 ***** 2026-09-01 05:05:39.059625 | instance | changed: [instance] 2026-09-01 05:05:39.059963 | instance | 2026-09-01 05:05:39.060163 | instance | TASK [Start up service] ******************************************************** 2026-09-01 05:05:39.060376 | instance | Tuesday 01 September 2026 05:05:39 +0000 (0:00:23.018) 0:00:44.069 ***** 2026-09-01 05:05:39.611606 | instance | ok: [instance] 2026-09-01 05:05:39.612109 | instance | 2026-09-01 05:05:39.612454 | instance | TASK [Generate lvm.conf] ******************************************************* 2026-09-01 05:05:39.612779 | instance | Tuesday 01 September 2026 05:05:39 +0000 (0:00:00.552) 0:00:44.621 ***** 2026-09-01 05:05:39.856631 | instance | ok: [instance] 2026-09-01 05:05:39.857024 | instance | 2026-09-01 05:05:39.857394 | instance | TASK [Write /etc/lvm/lvm.conf] ************************************************* 2026-09-01 05:05:39.857742 | instance | Tuesday 01 September 2026 05:05:39 +0000 (0:00:00.245) 0:00:44.867 ***** 2026-09-01 05:05:40.374371 | instance | changed: [instance] 2026-09-01 05:05:40.374962 | instance | 2026-09-01 05:05:40.375325 | instance | TASK [Get list of all loopback devices] **************************************** 2026-09-01 05:05:40.375645 | instance | Tuesday 01 September 2026 05:05:40 +0000 (0:00:00.517) 0:00:45.384 ***** 2026-09-01 05:05:40.579738 | instance | ok: [instance] 2026-09-01 05:05:40.580299 | instance | 2026-09-01 05:05:40.580673 | instance | TASK [Fail if there is any existing loopback devices] ************************** 2026-09-01 05:05:40.581018 | instance | Tuesday 01 September 2026 05:05:40 +0000 (0:00:00.202) 0:00:45.587 ***** 2026-09-01 05:05:40.605648 | instance | skipping: [instance] 2026-09-01 05:05:40.605715 | instance | 2026-09-01 05:05:40.605726 | instance | TASK [Create devices for Ceph] ************************************************* 2026-09-01 05:05:40.605737 | instance | Tuesday 01 September 2026 05:05:40 +0000 (0:00:00.027) 0:00:45.614 ***** 2026-09-01 05:05:41.200766 | instance | changed: [instance] => (item=osd0) 2026-09-01 05:05:41.200820 | instance | changed: [instance] => (item=osd1) 2026-09-01 05:05:41.200827 | instance | changed: [instance] => (item=osd2) 2026-09-01 05:05:41.200834 | instance | 2026-09-01 05:05:41.200857 | instance | TASK [Set permissions on loopback devices] ************************************* 2026-09-01 05:05:41.200863 | instance | Tuesday 01 September 2026 05:05:41 +0000 (0:00:00.595) 0:00:46.210 ***** 2026-09-01 05:05:41.791871 | instance | changed: [instance] => (item=osd0) 2026-09-01 05:05:41.792422 | instance | changed: [instance] => (item=osd1) 2026-09-01 05:05:41.792434 | instance | changed: [instance] => (item=osd2) 2026-09-01 05:05:41.792439 | instance | 2026-09-01 05:05:41.792444 | instance | TASK [Start loop devices] ****************************************************** 2026-09-01 05:05:41.792449 | instance | Tuesday 01 September 2026 05:05:41 +0000 (0:00:00.591) 0:00:46.802 ***** 2026-09-01 05:05:42.510268 | instance | changed: [instance] => (item=osd0) 2026-09-01 05:05:42.510333 | instance | changed: [instance] => (item=osd1) 2026-09-01 05:05:42.510345 | instance | changed: [instance] => (item=osd2) 2026-09-01 05:05:42.510355 | instance | 2026-09-01 05:05:42.510365 | instance | TASK [Create a volume group for each loop device] ****************************** 2026-09-01 05:05:42.510375 | instance | Tuesday 01 September 2026 05:05:42 +0000 (0:00:00.716) 0:00:47.519 ***** 2026-09-01 05:05:45.963329 | instance | changed: [instance] => (item=osd0) 2026-09-01 05:05:45.963398 | instance | changed: [instance] => (item=osd1) 2026-09-01 05:05:45.963404 | instance | changed: [instance] => (item=osd2) 2026-09-01 05:05:45.963413 | instance | 2026-09-01 05:05:45.963421 | instance | TASK [Create a logical volume for each loop device] **************************** 2026-09-01 05:05:45.963431 | instance | Tuesday 01 September 2026 05:05:45 +0000 (0:00:03.454) 0:00:50.973 ***** 2026-09-01 05:05:48.063944 | instance | changed: [instance] => (item=ceph-instance-osd0) 2026-09-01 05:05:48.064452 | instance | changed: [instance] => (item=ceph-instance-osd1) 2026-09-01 05:05:48.064916 | instance | changed: [instance] => (item=ceph-instance-osd2) 2026-09-01 05:05:48.065319 | instance | 2026-09-01 05:05:48.065735 | instance | PLAY [controllers] ************************************************************* 2026-09-01 05:05:48.066129 | instance | 2026-09-01 05:05:48.066559 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-01 05:05:48.067047 | instance | Tuesday 01 September 2026 05:05:48 +0000 (0:00:02.101) 0:00:53.074 ***** 2026-09-01 05:05:49.046884 | instance | ok: [instance] 2026-09-01 05:05:49.047080 | instance | 2026-09-01 05:05:49.047676 | instance | TASK [Set masquerade rule] ***************************************************** 2026-09-01 05:05:49.048057 | instance | Tuesday 01 September 2026 05:05:49 +0000 (0:00:00.982) 0:00:54.057 ***** 2026-09-01 05:05:49.536758 | instance | changed: [instance] 2026-09-01 05:05:49.537137 | instance | 2026-09-01 05:05:49.537446 | instance | PLAY RECAP ********************************************************************* 2026-09-01 05:05:49.537806 | instance | instance : ok=24 changed=10 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-09-01 05:05:49.538137 | instance | localhost : ok=40 changed=21 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-09-01 05:05:49.538422 | instance | 2026-09-01 05:05:49.538744 | instance | Tuesday 01 September 2026 05:05:49 +0000 (0:00:00.487) 0:00:54.544 ***** 2026-09-01 05:05:49.539031 | instance | =============================================================================== 2026-09-01 05:05:49.539318 | instance | Install depedencies ---------------------------------------------------- 23.02s 2026-09-01 05:05:49.539607 | instance | Generate SSH keys for missing variables --------------------------------- 3.69s 2026-09-01 05:05:49.539952 | instance | Create a volume group for each loop device ------------------------------ 3.45s 2026-09-01 05:05:49.540256 | instance | Create a logical volume for each loop device ---------------------------- 2.10s 2026-09-01 05:05:49.540545 | instance | Gathering Facts --------------------------------------------------------- 1.36s 2026-09-01 05:05:49.540856 | instance | Install "dirmngr" for GPG keyserver operations -------------------------- 1.19s 2026-09-01 05:05:49.541145 | instance | Create folders for workspace -------------------------------------------- 1.10s 2026-09-01 05:05:49.541429 | instance | Gathering Facts --------------------------------------------------------- 0.98s 2026-09-01 05:05:49.541736 | instance | Gathering Facts --------------------------------------------------------- 0.85s 2026-09-01 05:05:49.542021 | instance | Gathering Facts --------------------------------------------------------- 0.83s 2026-09-01 05:05:49.542354 | instance | Configure short hostname ------------------------------------------------ 0.80s 2026-09-01 05:05:49.542715 | instance | Gathering Facts --------------------------------------------------------- 0.76s 2026-09-01 05:05:49.543011 | instance | Purge "snapd" package --------------------------------------------------- 0.73s 2026-09-01 05:05:49.543300 | instance | Start loop devices ------------------------------------------------------ 0.72s 2026-09-01 05:05:49.543585 | instance | Generate endpoint skeleton for missing variables ------------------------ 0.70s 2026-09-01 05:05:49.544044 | instance | Write new Ceph control plane configuration file to disk ----------------- 0.62s 2026-09-01 05:05:49.544340 | instance | Create devices for Ceph ------------------------------------------------- 0.60s 2026-09-01 05:05:49.544627 | instance | Set permissions on loopback devices ------------------------------------- 0.59s 2026-09-01 05:05:49.545141 | instance | Start up service -------------------------------------------------------- 0.55s 2026-09-01 05:05:49.545471 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.52s 2026-09-01 05:05:49.636880 | instance | INFO [aio > prepare] Executed: Successful 2026-09-01 05:05:49.645325 | instance | INFO [aio > converge] Executing 2026-09-01 05:05:52.330829 | instance | 2026-09-01 05:05:52.331250 | instance | PLAY [all] ********************************************************************* 2026-09-01 05:05:52.331555 | instance | 2026-09-01 05:05:52.331931 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-01 05:05:52.332255 | instance | Tuesday 01 September 2026 05:05:52 +0000 (0:00:00.016) 0:00:00.016 ***** 2026-09-01 05:05:53.662935 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-09-01 05:05:53.663331 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-09-01 05:05:53.663683 | instance | interpreter could change the meaning of that path. See 2026-09-01 05:05:53.664223 | instance | https://docs.ansible.com/ansible- 2026-09-01 05:05:53.664591 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-09-01 05:05:53.680617 | instance | ok: [instance] 2026-09-01 05:05:53.680920 | instance | 2026-09-01 05:05:53.681217 | instance | TASK [Fail if atmosphere_ceph_enabled is set] ********************************** 2026-09-01 05:05:53.681507 | instance | Tuesday 01 September 2026 05:05:53 +0000 (0:00:01.349) 0:00:01.365 ***** 2026-09-01 05:05:53.738329 | instance | skipping: [instance] 2026-09-01 05:05:53.738665 | instance | 2026-09-01 05:05:53.738963 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-09-01 05:05:53.739255 | instance | Tuesday 01 September 2026 05:05:53 +0000 (0:00:00.057) 0:00:01.423 ***** 2026-09-01 05:05:53.955769 | instance | ok: [instance] 2026-09-01 05:05:53.956152 | instance | 2026-09-01 05:05:53.956450 | instance | PLAY [Deploy Ceph monitors & managers] ***************************************** 2026-09-01 05:05:53.956752 | instance | 2026-09-01 05:05:53.957045 | instance | TASK [Gathering Facts] ********************************************************* 2026-09-01 05:05:53.957339 | instance | Tuesday 01 September 2026 05:05:53 +0000 (0:00:00.217) 0:00:01.641 ***** 2026-09-01 05:05:54.964145 | instance | ok: [instance] 2026-09-01 05:05:54.964488 | instance | 2026-09-01 05:05:54.964823 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-09-01 05:05:54.965116 | instance | Tuesday 01 September 2026 05:05:54 +0000 (0:00:01.008) 0:00:02.649 ***** 2026-09-01 05:05:55.412459 | instance | ok: [instance] 2026-09-01 05:05:55.412808 | instance | 2026-09-01 05:05:55.412945 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-09-01 05:05:55.413078 | instance | Tuesday 01 September 2026 05:05:55 +0000 (0:00:00.446) 0:00:03.095 ***** 2026-09-01 05:05:55.456016 | instance | skipping: [instance] 2026-09-01 05:05:55.456161 | instance | 2026-09-01 05:05:55.456299 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-09-01 05:05:55.456434 | instance | Tuesday 01 September 2026 05:05:55 +0000 (0:00:00.045) 0:00:03.140 ***** 2026-09-01 05:05:55.892770 | instance | changed: [instance] 2026-09-01 05:05:55.892916 | instance | 2026-09-01 05:05:55.893109 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-09-01 05:05:55.893383 | instance | Tuesday 01 September 2026 05:05:55 +0000 (0:00:00.436) 0:00:03.577 ***** 2026-09-01 05:05:55.988901 | instance | ok: [instance] => { 2026-09-01 05:05:55.989244 | instance | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-09-01 05:05:55.989447 | instance | } 2026-09-01 05:05:55.989670 | instance | 2026-09-01 05:05:55.989869 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-09-01 05:05:55.990086 | instance | Tuesday 01 September 2026 05:05:55 +0000 (0:00:00.093) 0:00:03.671 ***** 2026-09-01 05:05:56.803115 | instance | changed: [instance] 2026-09-01 05:05:56.803513 | instance | 2026-09-01 05:05:56.803713 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-09-01 05:05:56.803970 | instance | Tuesday 01 September 2026 05:05:56 +0000 (0:00:00.815) 0:00:04.487 ***** 2026-09-01 05:05:56.864678 | instance | skipping: [instance] 2026-09-01 05:05:56.864879 | instance | 2026-09-01 05:05:56.865085 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-09-01 05:05:56.865229 | instance | Tuesday 01 September 2026 05:05:56 +0000 (0:00:00.059) 0:00:04.546 ***** 2026-09-01 05:05:56.932591 | instance | skipping: [instance] 2026-09-01 05:05:56.932702 | instance | 2026-09-01 05:05:56.932863 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-09-01 05:05:56.933095 | instance | Tuesday 01 September 2026 05:05:56 +0000 (0:00:00.068) 0:00:04.615 ***** 2026-09-01 05:05:57.208673 | instance | ok: [instance] 2026-09-01 05:05:57.208831 | instance | 2026-09-01 05:05:57.209104 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-09-01 05:05:57.209498 | instance | Tuesday 01 September 2026 05:05:57 +0000 (0:00:00.277) 0:00:04.892 ***** 2026-09-01 05:05:58.644889 | instance | ok: [instance] 2026-09-01 05:05:58.644999 | instance | 2026-09-01 05:05:58.645166 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-09-01 05:05:58.645539 | instance | Tuesday 01 September 2026 05:05:58 +0000 (0:00:01.435) 0:00:06.328 ***** 2026-09-01 05:05:58.752731 | instance | ok: [instance] => { 2026-09-01 05:05:58.752903 | instance | "msg": "https://github.com/containerd/containerd/releases/download/v2.3.2/containerd-2.3.2-linux-amd64.tar.gz" 2026-09-01 05:05:58.753167 | instance | } 2026-09-01 05:05:58.753546 | instance | 2026-09-01 05:05:58.753862 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-09-01 05:05:58.754166 | instance | Tuesday 01 September 2026 05:05:58 +0000 (0:00:00.106) 0:00:06.435 ***** 2026-09-01 05:05:59.492534 | instance | changed: [instance] 2026-09-01 05:05:59.492608 | instance | 2026-09-01 05:05:59.492820 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-09-01 05:05:59.493088 | instance | Tuesday 01 September 2026 05:05:59 +0000 (0:00:00.738) 0:00:07.174 ***** 2026-09-01 05:06:02.612023 | instance | changed: [instance] 2026-09-01 05:06:02.612218 | instance | 2026-09-01 05:06:02.612380 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-09-01 05:06:02.612524 | instance | Tuesday 01 September 2026 05:06:02 +0000 (0:00:03.120) 0:00:10.294 ***** 2026-09-01 05:06:02.654478 | instance | skipping: [instance] 2026-09-01 05:06:02.654553 | instance | 2026-09-01 05:06:02.654565 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-09-01 05:06:02.654693 | instance | Tuesday 01 September 2026 05:06:02 +0000 (0:00:00.045) 0:00:10.339 ***** 2026-09-01 05:06:02.703349 | instance | skipping: [instance] 2026-09-01 05:06:02.703430 | instance | 2026-09-01 05:06:02.703644 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-09-01 05:06:02.703920 | instance | Tuesday 01 September 2026 05:06:02 +0000 (0:00:00.048) 0:00:10.388 ***** 2026-09-01 05:06:02.750346 | instance | skipping: [instance] 2026-09-01 05:06:02.750522 | instance | 2026-09-01 05:06:02.750782 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-09-01 05:06:02.750984 | instance | Tuesday 01 September 2026 05:06:02 +0000 (0:00:00.047) 0:00:10.435 ***** 2026-09-01 05:06:09.996693 | instance | changed: [instance] 2026-09-01 05:06:09.996808 | instance | 2026-09-01 05:06:09.997102 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] *** 2026-09-01 05:06:09.997657 | instance | Tuesday 01 September 2026 05:06:09 +0000 (0:00:07.243) 0:00:17.679 ***** 2026-09-01 05:06:10.732568 | instance | changed: [instance] 2026-09-01 05:06:10.732816 | instance | 2026-09-01 05:06:10.733012 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] ******* 2026-09-01 05:06:10.733235 | instance | Tuesday 01 September 2026 05:06:10 +0000 (0:00:00.735) 0:00:18.414 ***** 2026-09-01 05:06:11.792591 | instance | changed: [instance] => (item={'path': '/etc/containerd'}) 2026-09-01 05:06:11.793058 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'}) 2026-09-01 05:06:11.793281 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'}) 2026-09-01 05:06:11.793483 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'}) 2026-09-01 05:06:11.793680 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'}) 2026-09-01 05:06:11.793857 | instance | 2026-09-01 05:06:11.794042 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] ********** 2026-09-01 05:06:11.794245 | instance | Tuesday 01 September 2026 05:06:11 +0000 (0:00:01.061) 0:00:19.476 ***** 2026-09-01 05:06:12.452510 | instance | changed: [instance] 2026-09-01 05:06:12.452633 | instance | 2026-09-01 05:06:12.452835 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ******** 2026-09-01 05:06:12.453483 | instance | Tuesday 01 September 2026 05:06:12 +0000 (0:00:00.640) 0:00:20.116 ***** 2026-09-01 05:06:12.453749 | instance | 2026-09-01 05:06:12.454019 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-09-01 05:06:12.454275 | instance | Tuesday 01 September 2026 05:06:12 +0000 (0:00:00.017) 0:00:20.133 ***** 2026-09-01 05:06:13.580701 | instance | ok: [instance] 2026-09-01 05:06:13.581090 | instance | 2026-09-01 05:06:13.581402 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] ********** 2026-09-01 05:06:13.581700 | instance | Tuesday 01 September 2026 05:06:13 +0000 (0:00:01.128) 0:00:21.262 ***** 2026-09-01 05:06:14.076705 | instance | changed: [instance] 2026-09-01 05:06:14.076824 | instance | 2026-09-01 05:06:14.076964 | instance | TASK [vexxhost.containers.containerd : Enable and start service] *************** 2026-09-01 05:06:14.077304 | instance | Tuesday 01 September 2026 05:06:14 +0000 (0:00:00.498) 0:00:21.760 ***** 2026-09-01 05:06:14.731593 | instance | changed: [instance] 2026-09-01 05:06:14.731688 | instance | 2026-09-01 05:06:14.731891 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-09-01 05:06:14.731977 | instance | Tuesday 01 September 2026 05:06:14 +0000 (0:00:00.656) 0:00:22.416 ***** 2026-09-01 05:06:14.963105 | instance | ok: [instance] 2026-09-01 05:06:14.963209 | instance | 2026-09-01 05:06:14.963530 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-09-01 05:06:14.963600 | instance | Tuesday 01 September 2026 05:06:14 +0000 (0:00:00.231) 0:00:22.648 ***** 2026-09-01 05:06:15.036980 | instance | ok: [instance] => { 2026-09-01 05:06:15.037127 | instance | "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz" 2026-09-01 05:06:15.037147 | instance | } 2026-09-01 05:06:15.037510 | instance | 2026-09-01 05:06:15.037576 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-09-01 05:06:15.037583 | instance | Tuesday 01 September 2026 05:06:15 +0000 (0:00:00.073) 0:00:22.722 ***** 2026-09-01 05:06:16.799482 | instance | changed: [instance] 2026-09-01 05:06:16.799890 | instance | 2026-09-01 05:06:16.799994 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-09-01 05:06:16.800206 | instance | Tuesday 01 September 2026 05:06:16 +0000 (0:00:01.761) 0:00:24.483 ***** 2026-09-01 05:06:21.313335 | instance | changed: [instance] 2026-09-01 05:06:21.313448 | instance | 2026-09-01 05:06:21.313529 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ****************** 2026-09-01 05:06:21.313647 | instance | Tuesday 01 September 2026 05:06:21 +0000 (0:00:04.515) 0:00:28.998 ***** 2026-09-01 05:06:22.544297 | instance | ok: [instance] 2026-09-01 05:06:22.545098 | instance | 2026-09-01 05:06:22.545166 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] *************** 2026-09-01 05:06:22.545181 | instance | Tuesday 01 September 2026 05:06:22 +0000 (0:00:01.230) 0:00:30.229 ***** 2026-09-01 05:06:22.971241 | instance | changed: [instance] 2026-09-01 05:06:22.971929 | instance | 2026-09-01 05:06:22.972035 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] ***** 2026-09-01 05:06:22.972052 | instance | Tuesday 01 September 2026 05:06:22 +0000 (0:00:00.426) 0:00:30.656 ***** 2026-09-01 05:06:23.523661 | instance | changed: [instance] 2026-09-01 05:06:23.523887 | instance | 2026-09-01 05:06:23.524369 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] *********** 2026-09-01 05:06:23.524446 | instance | Tuesday 01 September 2026 05:06:23 +0000 (0:00:00.552) 0:00:31.208 ***** 2026-09-01 05:06:24.151921 | instance | changed: [instance] => (item={'path': '/etc/docker'}) 2026-09-01 05:06:24.152002 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'}) 2026-09-01 05:06:24.152015 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'}) 2026-09-01 05:06:24.152032 | instance | 2026-09-01 05:06:24.152267 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ****** 2026-09-01 05:06:24.152487 | instance | Tuesday 01 September 2026 05:06:24 +0000 (0:00:00.627) 0:00:31.836 ***** 2026-09-01 05:06:24.657767 | instance | changed: [instance] 2026-09-01 05:06:24.657983 | instance | 2026-09-01 05:06:24.658223 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] *********** 2026-09-01 05:06:24.659040 | instance | Tuesday 01 September 2026 05:06:24 +0000 (0:00:00.506) 0:00:32.342 ***** 2026-09-01 05:06:25.193331 | instance | changed: [instance] 2026-09-01 05:06:25.193457 | instance | 2026-09-01 05:06:25.193708 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************ 2026-09-01 05:06:25.193970 | instance | Tuesday 01 September 2026 05:06:25 +0000 (0:00:00.522) 0:00:32.865 ***** 2026-09-01 05:06:25.194184 | instance | 2026-09-01 05:06:25.194420 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-09-01 05:06:25.194646 | instance | Tuesday 01 September 2026 05:06:25 +0000 (0:00:00.012) 0:00:32.878 ***** 2026-09-01 05:06:25.898727 | instance | ok: [instance] 2026-09-01 05:06:25.898825 | instance | 2026-09-01 05:06:25.898911 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ****************** 2026-09-01 05:06:25.899022 | instance | Tuesday 01 September 2026 05:06:25 +0000 (0:00:00.705) 0:00:33.583 ***** 2026-09-01 05:06:27.105878 | instance | changed: [instance] 2026-09-01 05:06:27.106240 | instance | 2026-09-01 05:06:27.106543 | instance | TASK [vexxhost.containers.docker : Enable and start service] ******************* 2026-09-01 05:06:27.106867 | instance | Tuesday 01 September 2026 05:06:27 +0000 (0:00:01.206) 0:00:34.790 ***** 2026-09-01 05:06:27.730604 | instance | changed: [instance] 2026-09-01 05:06:27.730735 | instance | 2026-09-01 05:06:27.730752 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ****** 2026-09-01 05:06:27.730872 | instance | Tuesday 01 September 2026 05:06:27 +0000 (0:00:00.625) 0:00:35.416 ***** 2026-09-01 05:06:27.800608 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml) 2026-09-01 05:06:27.800786 | instance | 2026-09-01 05:06:27.801068 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ******************************** 2026-09-01 05:06:27.801479 | instance | Tuesday 01 September 2026 05:06:27 +0000 (0:00:00.069) 0:00:35.485 ***** 2026-09-01 05:06:33.407587 | instance | changed: [instance] 2026-09-01 05:06:33.407672 | instance | 2026-09-01 05:06:33.408077 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] ********************* 2026-09-01 05:06:33.408154 | instance | Tuesday 01 September 2026 05:06:33 +0000 (0:00:05.607) 0:00:41.092 ***** 2026-09-01 05:06:34.069161 | instance | ok: [instance] => (item=chronyd) 2026-09-01 05:06:34.069258 | instance | ok: [instance] => (item=sshd) 2026-09-01 05:06:34.069776 | instance | 2026-09-01 05:06:34.069840 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ****************************** 2026-09-01 05:06:34.069848 | instance | Tuesday 01 September 2026 05:06:34 +0000 (0:00:00.661) 0:00:41.754 ***** 2026-09-01 05:06:35.823100 | instance | changed: [instance] 2026-09-01 05:06:35.823251 | instance | 2026-09-01 05:06:35.823863 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ******************** 2026-09-01 05:06:35.824177 | instance | Tuesday 01 September 2026 05:06:35 +0000 (0:00:01.753) 0:00:43.507 ***** 2026-09-01 05:06:36.056631 | instance | ok: [instance] 2026-09-01 05:06:36.057340 | instance | 2026-09-01 05:06:36.057403 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] **************** 2026-09-01 05:06:36.057415 | instance | Tuesday 01 September 2026 05:06:36 +0000 (0:00:00.233) 0:00:43.741 ***** 2026-09-01 05:06:36.653375 | instance | changed: [instance] 2026-09-01 05:06:36.654166 | instance | 2026-09-01 05:06:36.654232 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] *** 2026-09-01 05:06:36.654245 | instance | Tuesday 01 September 2026 05:06:36 +0000 (0:00:00.596) 0:00:44.338 ***** 2026-09-01 05:06:37.056182 | instance | changed: [instance] 2026-09-01 05:06:37.056279 | instance | 2026-09-01 05:06:37.056639 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] ************************* 2026-09-01 05:06:37.056693 | instance | Tuesday 01 September 2026 05:06:37 +0000 (0:00:00.403) 0:00:44.741 ***** 2026-09-01 05:06:37.198058 | instance | ok: [instance] 2026-09-01 05:06:37.198919 | instance | 2026-09-01 05:06:37.198997 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] ******************* 2026-09-01 05:06:37.199013 | instance | Tuesday 01 September 2026 05:06:37 +0000 (0:00:00.141) 0:00:44.882 ***** 2026-09-01 05:06:37.426203 | instance | ok: [instance] => (item=instance) 2026-09-01 05:06:37.427019 | instance | 2026-09-01 05:06:37.427093 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ******** 2026-09-01 05:06:37.427107 | instance | Tuesday 01 September 2026 05:06:37 +0000 (0:00:00.228) 0:00:45.111 ***** 2026-09-01 05:06:37.492963 | instance | ok: [instance] 2026-09-01 05:06:37.493040 | instance | 2026-09-01 05:06:37.493057 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] *********************************** 2026-09-01 05:06:37.493071 | instance | Tuesday 01 September 2026 05:06:37 +0000 (0:00:00.065) 0:00:45.176 ***** 2026-09-01 05:06:37.571574 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance 2026-09-01 05:06:37.571650 | instance | 2026-09-01 05:06:37.571949 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] ************* 2026-09-01 05:06:37.572037 | instance | Tuesday 01 September 2026 05:06:37 +0000 (0:00:00.080) 0:00:45.256 ***** 2026-09-01 05:06:37.981259 | instance | changed: [instance] 2026-09-01 05:06:37.981532 | instance | 2026-09-01 05:06:37.981791 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ****************** 2026-09-01 05:06:37.982031 | instance | Tuesday 01 September 2026 05:06:37 +0000 (0:00:00.408) 0:00:45.665 ***** 2026-09-01 05:06:38.810465 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True}) 2026-09-01 05:06:38.810669 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0}) 2026-09-01 05:06:38.810928 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False}) 2026-09-01 05:06:38.811151 | instance | 2026-09-01 05:06:38.811378 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap command] ******************************* 2026-09-01 05:06:38.811633 | instance | Tuesday 01 September 2026 05:06:38 +0000 (0:00:00.829) 0:00:46.495 ***** 2026-09-01 05:06:55.432047 | 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_gzdsm5am.conf", "--skip-monitoring-stack"], "delta": "0:00:16.159089", "end": "2026-09-01 05:06:55.380773", "msg": "non-zero return code", "rc": 1, "start": "2026-09-01 05:06:39.221684", "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/\": net/http: request canceled (Client.Timeout exceeded while awaiting headers)\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/\": net/http: request canceled (Client.Timeout exceeded while awaiting headers)", "", "", "\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-01 05:06:55.455169 | instance | 2026-09-01 05:06:55.455833 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] *************** 2026-09-01 05:06:55.455919 | instance | Tuesday 01 September 2026 05:06:55 +0000 (0:00:16.644) 0:01:03.139 ***** 2026-09-01 05:06:55.704916 | instance | changed: [instance] 2026-09-01 05:06:55.705029 | instance | 2026-09-01 05:06:55.705299 | instance | PLAY RECAP ********************************************************************* 2026-09-01 05:06:55.705698 | instance | instance : ok=46 changed=26 unreachable=0 failed=1 skipped=7 rescued=0 ignored=0 2026-09-01 05:06:55.706002 | instance | 2026-09-01 05:06:55.706297 | instance | Tuesday 01 September 2026 05:06:55 +0000 (0:00:00.251) 0:01:03.390 ***** 2026-09-01 05:06:55.706598 | instance | =============================================================================== 2026-09-01 05:06:55.706894 | instance | vexxhost.ceph.mon : Run Bootstrap command ------------------------------ 16.64s 2026-09-01 05:06:55.707184 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 7.24s 2026-09-01 05:06:55.707469 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 5.61s 2026-09-01 05:06:55.707818 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.52s 2026-09-01 05:06:55.708150 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 3.12s 2026-09-01 05:06:55.708452 | instance | vexxhost.containers.containerd : Reload systemd ------------------------- 1.83s 2026-09-01 05:06:55.708767 | instance | vexxhost.containers.download_artifact : Download item ------------------- 1.76s 2026-09-01 05:06:55.709055 | instance | vexxhost.ceph.cephadm : Download "cephadm" ------------------------------ 1.75s 2026-09-01 05:06:55.709340 | instance | vexxhost.containers.package : Update state for tar ---------------------- 1.44s 2026-09-01 05:06:55.709654 | instance | Gathering Facts --------------------------------------------------------- 1.35s 2026-09-01 05:06:55.709940 | instance | vexxhost.containers.docker : Install AppArmor packages ------------------ 1.23s 2026-09-01 05:06:55.710220 | instance | vexxhost.containers.docker : Restart docker ----------------------------- 1.21s 2026-09-01 05:06:55.710525 | instance | vexxhost.containers.containerd : Create folders for configuration ------- 1.06s 2026-09-01 05:06:55.710809 | instance | Gathering Facts --------------------------------------------------------- 1.01s 2026-09-01 05:06:55.711103 | instance | vexxhost.ceph.mon : Include extra configuration values ------------------ 0.83s 2026-09-01 05:06:55.711385 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.82s 2026-09-01 05:06:55.711696 | instance | vexxhost.containers.download_artifact : Download item ------------------- 0.74s 2026-09-01 05:06:55.712155 | instance | vexxhost.containers.containerd : Create systemd service file for containerd --- 0.74s 2026-09-01 05:06:55.712508 | instance | vexxhost.ceph.cephadm : Ensure services are started --------------------- 0.66s 2026-09-01 05:06:55.712832 | instance | vexxhost.containers.containerd : Enable and start service --------------- 0.66s 2026-09-01 05:06:55.999594 | 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-01 05:06:55.999960 | instance | ERROR [aio > converge] Executed: Failed 2026-09-01 05:06:56.000145 | 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-01 05:06:56.141331 | instance | ERROR 2026-09-01 05:06:56.141536 | instance | { 2026-09-01 05:06:56.141565 | instance | "delta": "0:02:16.843981", 2026-09-01 05:06:56.141585 | instance | "end": "2026-09-01 05:06:56.085951", 2026-09-01 05:06:56.141604 | instance | "msg": "non-zero return code", 2026-09-01 05:06:56.141622 | instance | "rc": 2, 2026-09-01 05:06:56.141642 | instance | "start": "2026-09-01 05:04:39.241970" 2026-09-01 05:06:56.141661 | instance | } failure 2026-09-01 05:06:56.148598 | 2026-09-01 05:06:56.148648 | PLAY RECAP 2026-09-01 05:06:56.148697 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-09-01 05:06:56.148718 | 2026-09-01 05:06:56.313941 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-09-01 05:06:56.330349 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-09-01 05:06:57.289821 | 2026-09-01 05:06:57.289962 | PLAY [all] 2026-09-01 05:06:57.304008 | 2026-09-01 05:06:57.304091 | TASK [gather-host-logs : creating directory for system status] 2026-09-01 05:06:57.714329 | instance | changed 2026-09-01 05:06:57.730788 | 2026-09-01 05:06:57.730870 | TASK [gather-host-logs : Get logs for each host] 2026-09-01 05:06:58.101723 | instance | + systemd-cgls --full --all --no-pager 2026-09-01 05:06:58.123209 | instance | + ip addr 2026-09-01 05:06:58.126854 | instance | + ip route 2026-09-01 05:06:58.129463 | instance | + lsblk 2026-09-01 05:06:58.134394 | instance | + mount 2026-09-01 05:06:58.136787 | instance | + docker images 2026-09-01 05:06:58.154610 | instance | + brctl show 2026-09-01 05:06:58.155262 | instance | /bin/bash: line 8: brctl: command not found 2026-09-01 05:06:58.155621 | instance | + ps aux --sort=-%mem 2026-09-01 05:06:58.194946 | instance | + dpkg -l 2026-09-01 05:06:58.206748 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-09-01 05:06:58.207539 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-09-01 05:06:58.232084 | instance | + '[' '!' -z '' ']' 2026-09-01 05:06:58.276488 | instance | ok: Runtime: 0:00:00.136079 2026-09-01 05:06:58.285800 | 2026-09-01 05:06:58.285877 | TASK [gather-host-logs : Downloads logs to executor] 2026-09-01 05:06:59.110777 | instance | changed: 2026-09-01 05:06:59.110977 | instance | created directory /var/lib/zuul/builds/0772a718f2764b0181fe1ccaa94640e2/work/logs/instance 2026-09-01 05:06:59.111007 | instance | cd+++++++++ system/ 2026-09-01 05:06:59.111030 | instance | >f+++++++++ system/brctl-show.txt 2026-09-01 05:06:59.111053 | instance | >f+++++++++ system/docker-images.txt 2026-09-01 05:06:59.111074 | instance | >f+++++++++ system/ip-addr.txt 2026-09-01 05:06:59.111097 | instance | >f+++++++++ system/ip-route.txt 2026-09-01 05:06:59.111119 | instance | >f+++++++++ system/lsblk.txt 2026-09-01 05:06:59.111141 | instance | >f+++++++++ system/mount.txt 2026-09-01 05:06:59.111162 | instance | >f+++++++++ system/packages.txt 2026-09-01 05:06:59.111182 | instance | >f+++++++++ system/ps.txt 2026-09-01 05:06:59.111205 | instance | >f+++++++++ system/systemd-cgls.txt 2026-09-01 05:06:59.120155 | 2026-09-01 05:06:59.120225 | LOOP [helm-release-status : creating directory for helm release status] 2026-09-01 05:06:59.323977 | instance | changed: "values" 2026-09-01 05:06:59.503587 | instance | changed: "releases" 2026-09-01 05:06:59.519790 | 2026-09-01 05:06:59.519933 | TASK [helm-release-status : Gather get release status for helm charts] 2026-09-01 05:06:59.815192 | instance | /bin/bash: line 3: kubectl: command not found 2026-09-01 05:07:00.058566 | instance | ok: Runtime: 0:00:00.006518 2026-09-01 05:07:00.065607 | 2026-09-01 05:07:00.065699 | TASK [helm-release-status : Downloads logs to executor] 2026-09-01 05:07:00.576395 | instance | changed: 2026-09-01 05:07:00.576645 | instance | cd+++++++++ helm/ 2026-09-01 05:07:00.576695 | instance | cd+++++++++ helm/releases/ 2026-09-01 05:07:00.576727 | instance | cd+++++++++ helm/values/ 2026-09-01 05:07:00.586765 | 2026-09-01 05:07:00.586835 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-09-01 05:07:00.803491 | instance | changed 2026-09-01 05:07:00.810339 | 2026-09-01 05:07:00.810449 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-09-01 05:07:01.036026 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-01 05:07:01.036763 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-01 05:07:01.042083 | instance | environment: line 1: kubectl: command not found 2026-09-01 05:07:01.043840 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-01 05:07:01.044291 | instance | environment: line 1: kubectl: command not found 2026-09-01 05:07:01.045839 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-01 05:07:01.047264 | instance | environment: line 1: kubectl: command not found 2026-09-01 05:07:01.048859 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-01 05:07:01.050000 | instance | environment: line 1: kubectl: command not found 2026-09-01 05:07:01.051763 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-01 05:07:01.052571 | instance | environment: line 1: kubectl: command not found 2026-09-01 05:07:01.054847 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-09-01 05:07:01.346147 | instance | ok: Runtime: 0:00:00.027962 2026-09-01 05:07:01.353106 | 2026-09-01 05:07:01.353197 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-09-01 05:07:01.585626 | instance | changed 2026-09-01 05:07:01.590913 | 2026-09-01 05:07:01.590993 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-09-01 05:07:01.828901 | instance | environment: line 5: kubectl: command not found 2026-09-01 05:07:01.829481 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-01 05:07:01.829641 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-01 05:07:01.830062 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-09-01 05:07:02.131627 | instance | ok: Runtime: 0:00:00.007532 2026-09-01 05:07:02.137266 | 2026-09-01 05:07:02.137335 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-09-01 05:07:02.639086 | instance | changed: 2026-09-01 05:07:02.639616 | instance | cd+++++++++ objects/ 2026-09-01 05:07:02.639686 | instance | cd+++++++++ objects/cluster/ 2026-09-01 05:07:02.639736 | instance | cd+++++++++ objects/namespaced/ 2026-09-01 05:07:02.650016 | 2026-09-01 05:07:02.650088 | TASK [gather-pod-logs : creating directory for pod logs] 2026-09-01 05:07:02.877494 | instance | changed 2026-09-01 05:07:02.884234 | 2026-09-01 05:07:02.884300 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-09-01 05:07:03.085735 | instance | changed 2026-09-01 05:07:03.090696 | 2026-09-01 05:07:03.090765 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-09-01 05:07:03.318500 | instance | environment: line 3: kubectl: command not found 2026-09-01 05:07:03.626563 | instance | ok: Runtime: 0:00:00.009060 2026-09-01 05:07:03.631945 | 2026-09-01 05:07:03.632019 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-09-01 05:07:04.110215 | instance | changed: 2026-09-01 05:07:04.110438 | instance | cd+++++++++ pod-logs/ 2026-09-01 05:07:04.110479 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-09-01 05:07:04.123418 | 2026-09-01 05:07:04.123483 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-09-01 05:07:04.324832 | instance | changed 2026-09-01 05:07:04.331042 | 2026-09-01 05:07:04.331106 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-09-01 05:07:04.560643 | instance | /bin/bash: line 2: kubectl: command not found 2026-09-01 05:07:04.864327 | instance | ok: Runtime: 0:00:00.053278 2026-09-01 05:07:04.870977 | 2026-09-01 05:07:04.871084 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-09-01 05:07:05.113780 | instance | /bin/bash: line 2: kubectl: command not found 2026-09-01 05:07:05.136354 | instance | ceph-mgr endpoints: 2026-09-01 05:07:05.408314 | instance | ok: Runtime: 0:00:00.029127 2026-09-01 05:07:05.415359 | 2026-09-01 05:07:05.415431 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-09-01 05:07:05.705781 | instance | /bin/bash: line 4: kubectl: command not found 2026-09-01 05:07:05.961876 | instance | ok: Runtime: 0:00:00.049900 2026-09-01 05:07:05.969776 | 2026-09-01 05:07:05.969871 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-09-01 05:07:06.461535 | instance | changed: cd+++++++++ prometheus/ 2026-09-01 05:07:06.475938 | 2026-09-01 05:07:06.476009 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-09-01 05:07:06.685722 | instance | changed 2026-09-01 05:07:06.692909 | 2026-09-01 05:07:06.693122 | TASK [gather-selenium-data : Get selenium data] 2026-09-01 05:07:06.927867 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-09-01 05:07:06.929410 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-09-01 05:07:07.240043 | instance | ERROR 2026-09-01 05:07:07.240294 | instance | { 2026-09-01 05:07:07.240342 | instance | "delta": "0:00:00.006145", 2026-09-01 05:07:07.240373 | instance | "end": "2026-09-01 05:07:06.929706", 2026-09-01 05:07:07.240403 | instance | "msg": "non-zero return code", 2026-09-01 05:07:07.240431 | instance | "rc": 1, 2026-09-01 05:07:07.240458 | instance | "start": "2026-09-01 05:07:06.923561" 2026-09-01 05:07:07.240486 | instance | } 2026-09-01 05:07:07.240522 | instance | ERROR: Ignoring Errors 2026-09-01 05:07:07.248048 | 2026-09-01 05:07:07.248118 | TASK [gather-selenium-data : Downloads logs to executor] 2026-09-01 05:07:07.767897 | instance | changed: cd+++++++++ selenium/ 2026-09-01 05:07:07.778263 | 2026-09-01 05:07:07.778319 | PLAY RECAP 2026-09-01 05:07:07.778368 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-09-01 05:07:07.778391 | 2026-09-01 05:07:07.937091 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-09-01 05:07:07.949420 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-09-01 05:07:08.592895 | 2026-09-01 05:07:08.593145 | PLAY [all] 2026-09-01 05:07:08.604517 | 2026-09-01 05:07:08.604604 | TASK [fetch-output : Set log path for multiple nodes] 2026-09-01 05:07:08.649367 | instance | skipping: Conditional result was False 2026-09-01 05:07:08.660367 | 2026-09-01 05:07:08.660480 | TASK [fetch-output : Set log path for single node] 2026-09-01 05:07:08.703817 | instance | ok 2026-09-01 05:07:08.710100 | 2026-09-01 05:07:08.710191 | LOOP [fetch-output : Ensure local output dirs] 2026-09-01 05:07:09.129729 | instance -> localhost | ok: "/var/lib/zuul/builds/0772a718f2764b0181fe1ccaa94640e2/work/logs" 2026-09-01 05:07:09.349399 | instance -> localhost | changed: "/var/lib/zuul/builds/0772a718f2764b0181fe1ccaa94640e2/work/artifacts" 2026-09-01 05:07:09.554677 | instance -> localhost | changed: "/var/lib/zuul/builds/0772a718f2764b0181fe1ccaa94640e2/work/docs" 2026-09-01 05:07:09.571555 | 2026-09-01 05:07:09.571973 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-09-01 05:07:10.266014 | instance | changed: .d..t...... ./ 2026-09-01 05:07:10.266251 | instance | changed: All items complete 2026-09-01 05:07:10.266279 | 2026-09-01 05:07:10.741844 | instance | changed: .d..t...... ./ 2026-09-01 05:07:11.186411 | instance | changed: .d..t...... ./ 2026-09-01 05:07:11.205598 | 2026-09-01 05:07:11.205772 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-09-01 05:07:11.815761 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.141022 2026-09-01 05:07:12.052251 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.013306 2026-09-01 05:07:12.072288 | 2026-09-01 05:07:12.072440 | PLAY [all] 2026-09-01 05:07:12.078539 | 2026-09-01 05:07:12.078606 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-09-01 05:07:12.530895 | instance | changed 2026-09-01 05:07:12.538639 | 2026-09-01 05:07:12.538707 | PLAY RECAP 2026-09-01 05:07:12.538755 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-09-01 05:07:12.538779 | 2026-09-01 05:07:12.693485 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-09-01 05:07:12.711452 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-09-01 05:07:13.382739 | 2026-09-01 05:07:13.382872 | PLAY [localhost] 2026-09-01 05:07:13.392882 | 2026-09-01 05:07:13.392968 | TASK [Generate Zuul manifest] 2026-09-01 05:07:13.415539 | localhost | ok 2026-09-01 05:07:13.684219 | 2026-09-01 05:07:13.684389 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-09-01 05:07:14.112234 | localhost | changed 2026-09-01 05:07:14.653890 | 2026-09-01 05:07:14.654091 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-09-01 05:07:14.749387 | localhost | ok 2026-09-01 05:07:14.770042 | 2026-09-01 05:07:14.770110 | TASK [Upload logs] 2026-09-01 05:07:14.790902 | localhost | ok 2026-09-01 05:07:15.163606 | 2026-09-01 05:07:15.163737 | TASK [Set zuul-log-path fact] 2026-09-01 05:07:15.185835 | localhost | ok 2026-09-01 05:07:15.197704 | 2026-09-01 05:07:15.197775 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-09-01 05:07:15.229720 | localhost | ok 2026-09-01 05:07:15.238947 | 2026-09-01 05:07:15.239036 | TASK [upload-logs : Create log directories] 2026-09-01 05:07:15.607796 | localhost | changed 2026-09-01 05:07:15.615008 | 2026-09-01 05:07:15.615411 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-09-01 05:07:15.972001 | localhost -> localhost | ok: Runtime: 0:00:00.005350 2026-09-01 05:07:15.978978 | 2026-09-01 05:07:15.979068 | TASK [upload-logs : Upload logs to log server] 2026-09-01 05:07:16.437004 | localhost | Output suppressed because no_log was given 2026-09-01 05:07:16.442131 | 2026-09-01 05:07:16.442218 | LOOP [upload-logs : Compress console log and json output] 2026-09-01 05:07:16.494597 | localhost | skipping: Conditional result was False 2026-09-01 05:07:16.501507 | localhost | skipping: Conditional result was False 2026-09-01 05:07:16.520536 | 2026-09-01 05:07:16.520682 | LOOP [upload-logs : Upload compressed console log and json output] 2026-09-01 05:07:16.561346 | localhost | skipping: Conditional result was False 2026-09-01 05:07:16.561724 | 2026-09-01 05:07:16.565299 | localhost | skipping: Conditional result was False 2026-09-01 05:07:16.574335 | 2026-09-01 05:07:16.574477 | LOOP [upload-logs : Upload console log and json output]