2026-08-12 17:22:50.477664 | Job console starting 2026-08-12 17:22:50.487261 | Updating git repos 2026-08-12 17:22:53.347968 | Cloning repos into workspace 2026-08-12 17:23:11.796149 | Restoring repo states 2026-08-12 17:23:17.818243 | Merging changes 2026-08-12 17:23:19.434370 | Checking out repos 2026-08-12 17:23:22.077538 | Preparing playbooks 2026-08-12 17:23:24.464537 | Running Ansible setup 2026-08-12 17:23:27.907905 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-12 17:23:28.557260 | 2026-08-12 17:23:28.557777 | PLAY [localhost] 2026-08-12 17:23:28.565726 | 2026-08-12 17:23:28.565797 | TASK [Gathering Facts] 2026-08-12 17:23:29.557771 | localhost | ok 2026-08-12 17:23:29.568354 | 2026-08-12 17:23:29.568509 | TASK [Setup log path fact] 2026-08-12 17:23:29.589985 | localhost | ok 2026-08-12 17:23:29.604357 | 2026-08-12 17:23:29.604443 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-12 17:23:29.633275 | localhost | ok 2026-08-12 17:23:29.639367 | 2026-08-12 17:23:29.639436 | TASK [emit-job-header : Print job information] 2026-08-12 17:23:29.682141 | # Job Information 2026-08-12 17:23:29.682381 | Ansible Version: 2.16.18 2026-08-12 17:23:29.682450 | Job: atmosphere-molecule-aio-ovn 2026-08-12 17:23:29.682497 | Pipeline: check 2026-08-12 17:23:29.682540 | Executor: 2d72f0692154 2026-08-12 17:23:29.682582 | Triggered by: https://github.com/vexxhost/atmosphere/pull/4089 2026-08-12 17:23:29.682631 | Event ID: ef8297a0-9671-11f1-80d3-25d23e1f0c08 2026-08-12 17:23:29.687192 | 2026-08-12 17:23:29.687280 | LOOP [emit-job-header : Print node information] 2026-08-12 17:23:29.782353 | localhost | ok: 2026-08-12 17:23:29.782843 | localhost | # Node Information 2026-08-12 17:23:29.782890 | localhost | Inventory Hostname: instance 2026-08-12 17:23:29.782922 | localhost | Hostname: np0000189042 2026-08-12 17:23:29.782950 | localhost | Username: zuul 2026-08-12 17:23:29.782984 | localhost | Distro: Ubuntu 22.04 2026-08-12 17:23:29.783013 | localhost | Provider: yul1 2026-08-12 17:23:29.783040 | localhost | Region: ca-ymq-1 2026-08-12 17:23:29.783067 | localhost | Label: ubuntu-jammy-16 2026-08-12 17:23:29.783093 | localhost | Product Name: OpenStack Nova 2026-08-12 17:23:29.783119 | localhost | Interface IP: 199.19.213.123 2026-08-12 17:23:29.795129 | 2026-08-12 17:23:29.795288 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-08-12 17:23:30.197749 | localhost -> localhost | changed 2026-08-12 17:23:30.208032 | 2026-08-12 17:23:30.208150 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-08-12 17:23:31.140067 | localhost -> localhost | changed 2026-08-12 17:23:31.148789 | 2026-08-12 17:23:31.148888 | PLAY [all] 2026-08-12 17:23:31.157743 | 2026-08-12 17:23:31.157811 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-08-12 17:23:31.598709 | instance -> localhost | ok 2026-08-12 17:23:31.610535 | 2026-08-12 17:23:31.610660 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-08-12 17:23:31.643722 | instance | ok 2026-08-12 17:23:31.663352 | instance | included: /var/lib/zuul/builds/4f76212407884224aa67669ec3ca01a4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-08-12 17:23:31.671108 | 2026-08-12 17:23:31.671192 | TASK [add-build-sshkey : Create Temp SSH key] 2026-08-12 17:23:32.552897 | instance -> localhost | Generating public/private rsa key pair. 2026-08-12 17:23:32.553188 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/4f76212407884224aa67669ec3ca01a4/work/4f76212407884224aa67669ec3ca01a4_id_rsa 2026-08-12 17:23:32.553231 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/4f76212407884224aa67669ec3ca01a4/work/4f76212407884224aa67669ec3ca01a4_id_rsa.pub 2026-08-12 17:23:32.553263 | instance -> localhost | The key fingerprint is: 2026-08-12 17:23:32.553293 | instance -> localhost | SHA256:nDeq75ti7Gbatqyc8a8pZKgdZL8TBtx2i0l9rW0aWxo zuul-build-sshkey 2026-08-12 17:23:32.553337 | instance -> localhost | The key's randomart image is: 2026-08-12 17:23:32.553382 | instance -> localhost | +---[RSA 3072]----+ 2026-08-12 17:23:32.553436 | instance -> localhost | | | 2026-08-12 17:23:32.553469 | instance -> localhost | | | 2026-08-12 17:23:32.553498 | instance -> localhost | | . . . . | 2026-08-12 17:23:32.553527 | instance -> localhost | | = + o.... | 2026-08-12 17:23:32.553555 | instance -> localhost | | o * + oSoo | 2026-08-12 17:23:32.553583 | instance -> localhost | | o O . Eo+. | 2026-08-12 17:23:32.553617 | instance -> localhost | | o =.+ .O | 2026-08-12 17:23:32.553652 | instance -> localhost | |. ..+*Bo+. | 2026-08-12 17:23:32.553685 | instance -> localhost | | =@XB*. | 2026-08-12 17:23:32.553720 | instance -> localhost | +----[SHA256]-----+ 2026-08-12 17:23:32.553794 | instance -> localhost | ok: Runtime: 0:00:00.460313 2026-08-12 17:23:32.561949 | 2026-08-12 17:23:32.562024 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-08-12 17:23:32.597942 | instance | ok 2026-08-12 17:23:32.608498 | instance | included: /var/lib/zuul/builds/4f76212407884224aa67669ec3ca01a4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-08-12 17:23:32.615974 | 2026-08-12 17:23:32.616045 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-08-12 17:23:32.641044 | instance | skipping: Conditional result was False 2026-08-12 17:23:32.653073 | 2026-08-12 17:23:32.653147 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-08-12 17:23:33.110417 | instance | changed 2026-08-12 17:23:33.118893 | 2026-08-12 17:23:33.119143 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-08-12 17:23:33.379420 | instance | ok 2026-08-12 17:23:33.384333 | 2026-08-12 17:23:33.384400 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-08-12 17:23:33.839106 | instance | changed 2026-08-12 17:23:33.844423 | 2026-08-12 17:23:33.844491 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-08-12 17:23:34.310256 | instance | changed 2026-08-12 17:23:34.316515 | 2026-08-12 17:23:34.316584 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-08-12 17:23:34.341869 | instance | skipping: Conditional result was False 2026-08-12 17:23:34.353353 | 2026-08-12 17:23:34.353432 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-08-12 17:23:34.675193 | instance -> localhost | changed 2026-08-12 17:23:34.687951 | 2026-08-12 17:23:34.688071 | TASK [add-build-sshkey : Add back temp key] 2026-08-12 17:23:35.278779 | instance -> localhost | Identity added: /var/lib/zuul/builds/4f76212407884224aa67669ec3ca01a4/work/4f76212407884224aa67669ec3ca01a4_id_rsa (zuul-build-sshkey) 2026-08-12 17:23:35.279003 | instance -> localhost | ok: Runtime: 0:00:00.014519 2026-08-12 17:23:35.284731 | 2026-08-12 17:23:35.284799 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-08-12 17:23:35.552583 | instance | ok 2026-08-12 17:23:35.561224 | 2026-08-12 17:23:35.561322 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-08-12 17:23:35.597025 | instance | skipping: Conditional result was False 2026-08-12 17:23:35.612086 | 2026-08-12 17:23:35.612207 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-08-12 17:23:35.911671 | instance | ok 2026-08-12 17:23:35.920352 | 2026-08-12 17:23:35.920463 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-08-12 17:23:39.129316 | instance | Output suppressed because no_log was given 2026-08-12 17:23:39.142126 | 2026-08-12 17:23:39.142212 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-08-12 17:23:39.324208 | instance | ok: "logs" 2026-08-12 17:23:39.324518 | instance | ok: All items complete 2026-08-12 17:23:39.324560 | 2026-08-12 17:23:39.469051 | instance | ok: "artifacts" 2026-08-12 17:23:39.626023 | instance | ok: "docs" 2026-08-12 17:23:39.645052 | 2026-08-12 17:23:39.645286 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-08-12 17:23:39.834335 | instance | changed: "logs" 2026-08-12 17:23:39.978954 | instance | changed: "artifacts" 2026-08-12 17:23:40.138006 | instance | changed: "docs" 2026-08-12 17:23:40.149799 | 2026-08-12 17:23:40.149942 | PLAY RECAP 2026-08-12 17:23:40.149998 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-08-12 17:23:40.150028 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-12 17:23:40.150052 | 2026-08-12 17:23:40.377348 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-08-12 17:23:40.383954 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-12 17:23:41.001885 | 2026-08-12 17:23:41.002021 | PLAY [all] 2026-08-12 17:23:41.013356 | 2026-08-12 17:23:41.013451 | TASK [setup-uv : Extract archive] 2026-08-12 17:23:43.405032 | instance | changed 2026-08-12 17:23:43.412483 | 2026-08-12 17:23:43.412560 | TASK [setup-uv : Print version] 2026-08-12 17:23:43.752839 | instance | uv 0.8.13 2026-08-12 17:23:43.947717 | instance | ok: Runtime: 0:00:00.012465 2026-08-12 17:23:43.957118 | 2026-08-12 17:23:43.957187 | TASK [Install Ansible collection siblings] 2026-08-12 17:23:52.820254 | instance | changed: 2026-08-12 17:23:52.820490 | instance | Sibling collection ansible.netcommon at /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-08-12 17:23:52.820530 | instance | Sibling collection ansible.posix at /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-08-12 17:23:52.820562 | instance | Sibling collection ansible.utils at /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-08-12 17:23:52.820590 | instance | Sibling collection community.crypto at /home/zuul/src/github.com/ansible-collections/community.crypto 2026-08-12 17:23:52.820619 | instance | Sibling collection community.general at /home/zuul/src/github.com/ansible-collections/community.general 2026-08-12 17:23:52.820650 | instance | Sibling collection community.mysql at /home/zuul/src/github.com/ansible-collections/community.mysql 2026-08-12 17:23:52.820679 | instance | Sibling collection kubernetes.core at /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-08-12 17:23:52.820709 | instance | Sibling collection vexxhost.ceph at /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-08-12 17:23:52.820738 | instance | Sibling collection vexxhost.containers at /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-08-12 17:23:52.820766 | instance | Sibling collection vexxhost.kubernetes at /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-08-12 17:23:52.820793 | instance | Sibling collection atmosphere.common at /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-08-12 17:23:52.820820 | instance | Sibling collection openstack.cloud at /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-08-12 17:23:52.820847 | instance | Resolved ansible.netcommon to v8.6.2 for >=1.2.0 2026-08-12 17:23:52.820873 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0 2026-08-12 17:23:52.820901 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=3.0.0 2026-08-12 17:23:52.820928 | instance | Resolved community.crypto to 2.2.3 for 2.2.3 2026-08-12 17:23:52.820955 | instance | Resolved community.general to 7.3.0 for 7.3.0 2026-08-12 17:23:52.821008 | instance | Resolved community.mysql to 3.6.0 for 3.6.0 2026-08-12 17:23:52.821035 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0 2026-08-12 17:23:52.821062 | instance | Resolved openstack.cloud to 1.7.0 for 1.7.0 2026-08-12 17:23:52.821088 | instance | Resolved atmosphere.common to v0.6.0 for >=0.6.0,<0.7.0 2026-08-12 17:23:52.821113 | instance | Resolved vexxhost.ceph to v4.2.0 for >=3.1.2 2026-08-12 17:23:52.821141 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-08-12 17:23:52.821188 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=3.0.0,>=6.0.0 2026-08-12 17:23:52.821215 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-08-12 17:23:52.821241 | instance | Resolved vexxhost.kubernetes to v3.3.0 for >=3.3.0,>=2.5.0 2026-08-12 17:23:52.821266 | instance | Resolved community.general to 7.3.0 for 7.3.0,>=4.5.0 2026-08-12 17:23:52.821292 | instance | Resolved ansible.utils to v6.1.0 for >=2.9.0,>=3.0.0,>=6.0.0 2026-08-12 17:23:52.821318 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-08-12 17:23:52.821343 | instance | Resolved ansible.posix to 1.6.0 for 1.6.0,>=1.6.0 2026-08-12 17:23:52.821368 | instance | Resolved community.crypto to 2.2.3 for 2.2.3,>=2.2.3 2026-08-12 17:23:52.821394 | instance | Resolved kubernetes.core to 2.4.0 for 2.4.0,>=2.4.0,>=2.3.2 2026-08-12 17:23:52.821421 | instance | Resolved vexxhost.containers to v1.6.8 for >=1.1.1,>=1.6.0 2026-08-12 17:23:52.821447 | instance | Checked out ansible.netcommon to v8.6.2 2026-08-12 17:23:52.821474 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.netcommon 2026-08-12 17:23:52.821507 | instance | Starting galaxy collection install process 2026-08-12 17:23:52.821534 | instance | Process install dependency map 2026-08-12 17:23:52.821560 | instance | Starting collection install process 2026-08-12 17:23:52.821586 | instance | Installing 'ansible.netcommon:8.6.2' to '/home/zuul/.ansible/collections/ansible_collections/ansible/netcommon' 2026-08-12 17:23:52.821612 | instance | Created collection for ansible.netcommon:8.6.2 at /home/zuul/.ansible/collections/ansible_collections/ansible/netcommon 2026-08-12 17:23:52.821638 | instance | ansible.netcommon:8.6.2 was installed successfully 2026-08-12 17:23:52.821663 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-08-12 17:23:52.821688 | instance | Creating virtual environment at: .venv 2026-08-12 17:23:52.821714 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-08-12 17:23:52.821739 | instance | Downloading pygments (1.2MiB) 2026-08-12 17:23:52.821770 | instance | Downloading setuptools (1.1MiB) 2026-08-12 17:23:52.821796 | instance | Downloading ansible-core (2.1MiB) 2026-08-12 17:23:52.821822 | instance | Downloading cryptography (4.2MiB) 2026-08-12 17:23:52.821849 | instance | Downloading openstacksdk (1.7MiB) 2026-08-12 17:23:52.821875 | instance | Downloading kubernetes (1.9MiB) 2026-08-12 17:23:52.821901 | instance | Downloading rjsonnet (1.2MiB) 2026-08-12 17:23:52.821928 | instance | Downloading netaddr (2.2MiB) 2026-08-12 17:23:52.821954 | instance | Building pyperclip==1.9.0 2026-08-12 17:23:52.821981 | instance | Downloading rjsonnet 2026-08-12 17:23:52.822008 | instance | Downloading netaddr 2026-08-12 17:23:52.822034 | instance | Downloading pygments 2026-08-12 17:23:52.822060 | instance | Downloading cryptography 2026-08-12 17:23:52.822086 | instance | Downloading setuptools 2026-08-12 17:23:52.822112 | instance | Downloading kubernetes 2026-08-12 17:23:52.822137 | instance | Downloading ansible-core 2026-08-12 17:23:52.822163 | instance | Downloading openstacksdk 2026-08-12 17:23:52.822190 | instance | Built pyperclip==1.9.0 2026-08-12 17:23:52.822216 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-08-12 17:23:52.822243 | instance | Installed 79 packages in 46ms 2026-08-12 17:23:52.822269 | instance | Checked out ansible.posix to 1.6.0 2026-08-12 17:23:52.822295 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.posix 2026-08-12 17:23:52.822321 | instance | Starting galaxy collection install process 2026-08-12 17:23:52.822347 | instance | Process install dependency map 2026-08-12 17:23:52.822381 | instance | Starting collection install process 2026-08-12 17:23:52.822409 | instance | Installing 'ansible.posix:1.6.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/posix' 2026-08-12 17:23:52.822435 | instance | Created collection for ansible.posix:1.6.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/posix 2026-08-12 17:23:52.822461 | instance | ansible.posix:1.6.0 was installed successfully 2026-08-12 17:23:52.822488 | instance | Checked out ansible.utils to v6.1.0 2026-08-12 17:23:52.822515 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/ansible.utils 2026-08-12 17:23:52.822541 | instance | Starting galaxy collection install process 2026-08-12 17:23:52.822567 | instance | Process install dependency map 2026-08-12 17:23:52.822593 | instance | Starting collection install process 2026-08-12 17:23:52.822619 | instance | Installing 'ansible.utils:6.1.0' to '/home/zuul/.ansible/collections/ansible_collections/ansible/utils' 2026-08-12 17:23:52.822645 | instance | Created collection for ansible.utils:6.1.0 at /home/zuul/.ansible/collections/ansible_collections/ansible/utils 2026-08-12 17:23:52.822671 | instance | ansible.utils:6.1.0 was installed successfully 2026-08-12 17:23:52.822697 | instance | Checked out atmosphere.common to v0.6.0 2026-08-12 17:23:52.822724 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/atmosphere.common 2026-08-12 17:23:52.822750 | instance | Starting galaxy collection install process 2026-08-12 17:23:52.822778 | instance | Process install dependency map 2026-08-12 17:23:52.822805 | instance | Starting collection install process 2026-08-12 17:23:52.822831 | instance | Installing 'atmosphere.common:0.6.0' to '/home/zuul/.ansible/collections/ansible_collections/atmosphere/common' 2026-08-12 17:23:52.822857 | instance | Created collection for atmosphere.common:0.6.0 at /home/zuul/.ansible/collections/ansible_collections/atmosphere/common 2026-08-12 17:23:52.822883 | instance | atmosphere.common:0.6.0 was installed successfully 2026-08-12 17:23:52.822909 | instance | Checked out community.crypto to 2.2.3 2026-08-12 17:23:52.822935 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.crypto 2026-08-12 17:23:52.822961 | instance | Starting galaxy collection install process 2026-08-12 17:23:52.822986 | instance | Process install dependency map 2026-08-12 17:23:52.823012 | instance | Starting collection install process 2026-08-12 17:23:52.823037 | instance | Installing 'community.crypto:2.2.3' to '/home/zuul/.ansible/collections/ansible_collections/community/crypto' 2026-08-12 17:23:52.823063 | instance | Created collection for community.crypto:2.2.3 at /home/zuul/.ansible/collections/ansible_collections/community/crypto 2026-08-12 17:23:52.823089 | instance | community.crypto:2.2.3 was installed successfully 2026-08-12 17:23:52.823115 | instance | Checked out community.general to 7.3.0 2026-08-12 17:23:52.823140 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.general 2026-08-12 17:23:52.823167 | instance | Starting galaxy collection install process 2026-08-12 17:23:52.823193 | instance | Process install dependency map 2026-08-12 17:23:52.823219 | instance | Starting collection install process 2026-08-12 17:23:52.823245 | instance | Installing 'community.general:7.3.0' to '/home/zuul/.ansible/collections/ansible_collections/community/general' 2026-08-12 17:23:52.823271 | instance | Created collection for community.general:7.3.0 at /home/zuul/.ansible/collections/ansible_collections/community/general 2026-08-12 17:23:52.823297 | instance | community.general:7.3.0 was installed successfully 2026-08-12 17:23:52.823336 | instance | Checked out community.mysql to 3.6.0 2026-08-12 17:23:52.823363 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/community.mysql 2026-08-12 17:23:52.823389 | instance | Starting galaxy collection install process 2026-08-12 17:23:52.823415 | instance | Process install dependency map 2026-08-12 17:23:52.823441 | instance | Starting collection install process 2026-08-12 17:23:52.823466 | instance | Installing 'community.mysql:3.6.0' to '/home/zuul/.ansible/collections/ansible_collections/community/mysql' 2026-08-12 17:23:52.823493 | instance | Created collection for community.mysql:3.6.0 at /home/zuul/.ansible/collections/ansible_collections/community/mysql 2026-08-12 17:23:52.823519 | instance | community.mysql:3.6.0 was installed successfully 2026-08-12 17:23:52.823545 | instance | Checked out kubernetes.core to 2.4.0 2026-08-12 17:23:52.823572 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/ansible-collections/kubernetes.core 2026-08-12 17:23:52.823598 | instance | Starting galaxy collection install process 2026-08-12 17:23:52.823624 | instance | Process install dependency map 2026-08-12 17:23:52.823652 | instance | Starting collection install process 2026-08-12 17:23:52.823678 | instance | Installing 'kubernetes.core:2.4.0' to '/home/zuul/.ansible/collections/ansible_collections/kubernetes/core' 2026-08-12 17:23:52.823705 | instance | Created collection for kubernetes.core:2.4.0 at /home/zuul/.ansible/collections/ansible_collections/kubernetes/core 2026-08-12 17:23:52.823731 | instance | kubernetes.core:2.4.0 was installed successfully 2026-08-12 17:23:52.823757 | instance | Checked out openstack.cloud to 1.7.0 2026-08-12 17:23:52.823783 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/opendev.org/openstack/ansible-collections-openstack 2026-08-12 17:23:52.823809 | instance | Starting galaxy collection install process 2026-08-12 17:23:52.823835 | instance | Process install dependency map 2026-08-12 17:23:52.823861 | instance | Starting collection install process 2026-08-12 17:23:52.823887 | instance | Installing 'openstack.cloud:1.7.0' to '/home/zuul/.ansible/collections/ansible_collections/openstack/cloud' 2026-08-12 17:23:52.823913 | instance | Created collection for openstack.cloud:1.7.0 at /home/zuul/.ansible/collections/ansible_collections/openstack/cloud 2026-08-12 17:23:52.823940 | instance | openstack.cloud:1.7.0 was installed successfully 2026-08-12 17:23:52.823965 | instance | Checked out vexxhost.ceph to v4.2.0 2026-08-12 17:23:52.823992 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-ceph 2026-08-12 17:23:52.824038 | instance | Starting galaxy collection install process 2026-08-12 17:23:52.824066 | instance | Process install dependency map 2026-08-12 17:23:52.824092 | instance | Starting collection install process 2026-08-12 17:23:52.824118 | instance | Installing 'vexxhost.ceph:4.2.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph' 2026-08-12 17:23:52.824145 | instance | Created collection for vexxhost.ceph:4.2.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph 2026-08-12 17:23:52.824171 | instance | vexxhost.ceph:4.2.0 was installed successfully 2026-08-12 17:23:52.824198 | instance | Checked out vexxhost.containers to v1.6.8 2026-08-12 17:23:52.824224 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-containers 2026-08-12 17:23:52.824250 | instance | Starting galaxy collection install process 2026-08-12 17:23:52.824285 | instance | Process install dependency map 2026-08-12 17:23:52.824312 | instance | Starting collection install process 2026-08-12 17:23:52.824339 | instance | Installing 'vexxhost.containers:1.6.8' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/containers' 2026-08-12 17:23:52.824366 | instance | Created collection for vexxhost.containers:1.6.8 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers 2026-08-12 17:23:52.824392 | instance | vexxhost.containers:1.6.8 was installed successfully 2026-08-12 17:23:52.824419 | instance | Checked out vexxhost.kubernetes to v3.3.0 2026-08-12 17:23:52.824444 | instance | Running: uv run ansible-galaxy collection install --force --no-deps --collections-path /home/zuul/.ansible/collections /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes 2026-08-12 17:23:52.824470 | instance | Starting galaxy collection install process 2026-08-12 17:23:52.824496 | instance | Process install dependency map 2026-08-12 17:23:52.824522 | instance | Starting collection install process 2026-08-12 17:23:52.824548 | instance | Installing 'vexxhost.kubernetes:3.3.0' to '/home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes' 2026-08-12 17:23:52.824573 | instance | Created collection for vexxhost.kubernetes:3.3.0 at /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes 2026-08-12 17:23:52.824599 | instance | vexxhost.kubernetes:3.3.0 was installed successfully 2026-08-12 17:23:52.830929 | 2026-08-12 17:23:52.830970 | PLAY RECAP 2026-08-12 17:23:52.831013 | instance | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-12 17:23:52.831033 | 2026-08-12 17:23:52.953851 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-08-12 17:23:53.069296 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-08-12 17:23:53.693258 | 2026-08-12 17:23:53.693396 | PLAY [all] 2026-08-12 17:23:53.705205 | 2026-08-12 17:23:53.705324 | TASK [Install "jq" for log collection] 2026-08-12 17:24:03.357394 | instance | changed 2026-08-12 17:24:03.359926 | 2026-08-12 17:24:03.360103 | PLAY RECAP 2026-08-12 17:24:03.360218 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-08-12 17:24:03.360321 | 2026-08-12 17:24:03.489354 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/pre.yml@main] 2026-08-12 17:24:03.498624 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-12 17:24:04.099360 | 2026-08-12 17:24:04.099497 | PLAY [all] 2026-08-12 17:24:04.110685 | 2026-08-12 17:24:04.110757 | LOOP [Check inventory directories] 2026-08-12 17:24:04.437087 | instance | ok: "src/github.com/vexxhost/atmosphere" 2026-08-12 17:24:04.588240 | instance | ok: "src/github.com/vexxhost/atmosphere/molecule/aio/inventory" 2026-08-12 17:24:04.736076 | instance | ok: "src/github.com/vexxhost/atmosphere/extensions/molecule/aio/inventory" 2026-08-12 17:24:04.755048 | 2026-08-12 17:24:04.755272 | LOOP [Copy inventory file for Zuul] 2026-08-12 17:24:05.533877 | instance | changed: 2026-08-12 17:24:05.558013 | instance | { 2026-08-12 17:24:05.558138 | instance | "ansible_loop_var": "item", 2026-08-12 17:24:05.558266 | instance | "changed": false, 2026-08-12 17:24:05.558334 | instance | "failed": false, 2026-08-12 17:24:05.558399 | instance | "invocation": { 2026-08-12 17:24:05.558443 | instance | "module_args": { 2026-08-12 17:24:05.558483 | instance | "checksum_algorithm": "sha1", 2026-08-12 17:24:05.558532 | instance | "follow": true, 2026-08-12 17:24:05.558571 | instance | "get_attributes": true, 2026-08-12 17:24:05.558613 | instance | "get_checksum": true, 2026-08-12 17:24:05.558652 | instance | "get_mime": true, 2026-08-12 17:24:05.558691 | instance | "path": "src/github.com/vexxhost/atmosphere" 2026-08-12 17:24:05.558769 | instance | } 2026-08-12 17:24:05.558812 | instance | }, 2026-08-12 17:24:05.558851 | instance | "item": "src/github.com/vexxhost/atmosphere", 2026-08-12 17:24:05.558890 | instance | "stat": { 2026-08-12 17:24:05.558928 | instance | "atime": 1786555425.656215, 2026-08-12 17:24:05.558976 | instance | "attr_flags": "e", 2026-08-12 17:24:05.559017 | instance | "attributes": [ 2026-08-12 17:24:05.559055 | instance | "extents" 2026-08-12 17:24:05.559094 | instance | ], 2026-08-12 17:24:05.559131 | instance | "block_size": 4096, 2026-08-12 17:24:05.559170 | instance | "blocks": 8, 2026-08-12 17:24:05.559207 | instance | "charset": "unknown", 2026-08-12 17:24:05.559247 | instance | "ctime": 1786555424.760196, 2026-08-12 17:24:05.559286 | instance | "dev": 64513, 2026-08-12 17:24:05.559324 | instance | "device_type": 0, 2026-08-12 17:24:05.559363 | instance | "executable": true, 2026-08-12 17:24:05.559400 | instance | "exists": true, 2026-08-12 17:24:05.559438 | instance | "gid": 1000, 2026-08-12 17:24:05.559486 | instance | "gr_name": "zuul", 2026-08-12 17:24:05.559525 | instance | "inode": 1047465, 2026-08-12 17:24:05.559562 | instance | "isblk": false, 2026-08-12 17:24:05.559600 | instance | "ischr": false, 2026-08-12 17:24:05.559639 | instance | "isdir": true, 2026-08-12 17:24:05.559686 | instance | "isfifo": false, 2026-08-12 17:24:05.559738 | instance | "isgid": false, 2026-08-12 17:24:05.559790 | instance | "islnk": false, 2026-08-12 17:24:05.559830 | instance | "isreg": false, 2026-08-12 17:24:05.559879 | instance | "issock": false, 2026-08-12 17:24:05.559926 | instance | "isuid": false, 2026-08-12 17:24:05.559963 | instance | "mimetype": "unknown", 2026-08-12 17:24:05.560000 | instance | "mode": "0755", 2026-08-12 17:24:05.560038 | instance | "mtime": 1786555424.760196, 2026-08-12 17:24:05.560083 | instance | "nlink": 22, 2026-08-12 17:24:05.560121 | instance | "path": "src/github.com/vexxhost/atmosphere", 2026-08-12 17:24:05.560160 | instance | "pw_name": "zuul", 2026-08-12 17:24:05.560213 | instance | "readable": true, 2026-08-12 17:24:05.560253 | instance | "rgrp": true, 2026-08-12 17:24:05.560292 | instance | "roth": true, 2026-08-12 17:24:05.560353 | instance | "rusr": true, 2026-08-12 17:24:05.560399 | instance | "size": 4096, 2026-08-12 17:24:05.560446 | instance | "uid": 1000, 2026-08-12 17:24:05.560486 | instance | "version": "2603226549", 2026-08-12 17:24:05.560542 | instance | "wgrp": false, 2026-08-12 17:24:05.560605 | instance | "woth": false, 2026-08-12 17:24:05.560644 | instance | "writeable": true, 2026-08-12 17:24:05.560683 | instance | "wusr": true, 2026-08-12 17:24:05.560720 | instance | "xgrp": true, 2026-08-12 17:24:05.560757 | instance | "xoth": true, 2026-08-12 17:24:05.560810 | instance | "xusr": true 2026-08-12 17:24:05.560864 | instance | } 2026-08-12 17:24:05.560915 | instance | } 2026-08-12 17:24:05.561087 | instance | ok: All items complete 2026-08-12 17:24:05.561167 | 2026-08-12 17:24:05.564110 | instance | skipping: Conditional result was False 2026-08-12 17:24:05.565629 | instance | skipping: Conditional result was False 2026-08-12 17:24:05.589911 | 2026-08-12 17:24:05.590351 | LOOP [Switch "ansible_host" to private IP] 2026-08-12 17:24:05.931697 | instance | changed: 1 replacements made 2026-08-12 17:24:05.933415 | instance | skipping: Conditional result was False 2026-08-12 17:24:05.935315 | instance | skipping: Conditional result was False 2026-08-12 17:24:05.955952 | 2026-08-12 17:24:05.956039 | TASK [Run Molecule scenario] 2026-08-12 17:24:06.875197 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-08-12 17:24:07.256071 | instance | INFO [aio > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-08-12 17:24:07.256162 | instance | INFO [aio > prerun] Performing prerun with role_name_check=0... 2026-08-12 17:24:17.754460 | instance | INFO [aio > dependency] Executing 2026-08-12 17:24:17.754643 | instance | WARNING [aio > dependency] Missing roles requirements file: requirements.yml 2026-08-12 17:24:17.754848 | instance | WARNING [aio > dependency] Missing collections requirements file: collections.yml 2026-08-12 17:24:17.754967 | instance | WARNING [aio > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-08-12 17:24:17.762513 | instance | INFO [aio > cleanup] Executing 2026-08-12 17:24:17.762830 | instance | WARNING [aio > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-12 17:24:17.770541 | instance | INFO [aio > destroy] Executing 2026-08-12 17:24:17.770619 | instance | WARNING [aio > destroy] Skipping, '--destroy=never' requested. 2026-08-12 17:24:17.770697 | instance | INFO [aio > destroy] Executed: Successful 2026-08-12 17:24:17.778831 | instance | INFO [aio > syntax] Executing 2026-08-12 17:24:20.661064 | instance | 2026-08-12 17:24:20.661326 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/aio/converge.yml 2026-08-12 17:24:20.774986 | instance | INFO [aio > syntax] Executed: Successful 2026-08-12 17:24:20.786953 | instance | INFO [aio > create] Executing 2026-08-12 17:24:20.788888 | instance | WARNING [aio > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-08-12 17:24:20.796290 | instance | INFO [aio > prepare] Executing 2026-08-12 17:24:21.624278 | instance | 2026-08-12 17:24:21.624508 | instance | PLAY [Prepare] ***************************************************************** 2026-08-12 17:24:21.624702 | instance | 2026-08-12 17:24:21.625009 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-12 17:24:21.625319 | instance | Wednesday 12 August 2026 17:24:21 +0000 (0:00:00.026) 0:00:00.026 ****** 2026-08-12 17:24:22.742521 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-08-12 17:24:22.742664 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-08-12 17:24:22.742849 | instance | interpreter could change the meaning of that path. See 2026-08-12 17:24:22.743066 | instance | https://docs.ansible.com/ansible- 2026-08-12 17:24:22.743248 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-08-12 17:24:22.748989 | instance | ok: [instance] 2026-08-12 17:24:22.749164 | instance | 2026-08-12 17:24:22.749348 | instance | TASK [Configure short hostname] ************************************************ 2026-08-12 17:24:22.749563 | instance | Wednesday 12 August 2026 17:24:22 +0000 (0:00:01.125) 0:00:01.151 ****** 2026-08-12 17:24:23.418089 | instance | changed: [instance] 2026-08-12 17:24:23.418406 | instance | 2026-08-12 17:24:23.418697 | instance | TASK [Ensure hostname inside hosts file] *************************************** 2026-08-12 17:24:23.418982 | instance | Wednesday 12 August 2026 17:24:23 +0000 (0:00:00.668) 0:00:01.819 ****** 2026-08-12 17:24:23.668815 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created 2026-08-12 17:24:23.669122 | instance | with a mode of 0700, this may cause issues when running as another user. To 2026-08-12 17:24:23.669448 | instance | avoid this, create the remote_tmp dir with the correct permissions manually 2026-08-12 17:24:23.675315 | instance | changed: [instance] 2026-08-12 17:24:23.675660 | instance | 2026-08-12 17:24:23.675999 | instance | TASK [Install "dirmngr" for GPG keyserver operations] ************************** 2026-08-12 17:24:23.676329 | instance | Wednesday 12 August 2026 17:24:23 +0000 (0:00:00.257) 0:00:02.077 ****** 2026-08-12 17:24:24.846851 | instance | ok: [instance] 2026-08-12 17:24:24.847119 | instance | 2026-08-12 17:24:24.847447 | instance | TASK [Purge "snapd" package] *************************************************** 2026-08-12 17:24:24.847951 | instance | Wednesday 12 August 2026 17:24:24 +0000 (0:00:01.170) 0:00:03.248 ****** 2026-08-12 17:24:25.533585 | instance | ok: [instance] 2026-08-12 17:24:25.533789 | instance | 2026-08-12 17:24:25.534071 | instance | PLAY [Generate workspace for Atmosphere] *************************************** 2026-08-12 17:24:25.534388 | instance | 2026-08-12 17:24:25.534744 | instance | TASK [Create folders for workspace] ******************************************** 2026-08-12 17:24:25.535052 | instance | Wednesday 12 August 2026 17:24:25 +0000 (0:00:00.686) 0:00:03.935 ****** 2026-08-12 17:24:26.488141 | instance | changed: [localhost] => (item=group_vars) 2026-08-12 17:24:26.488326 | instance | changed: [localhost] => (item=group_vars/all) 2026-08-12 17:24:26.488643 | instance | changed: [localhost] => (item=group_vars/controllers) 2026-08-12 17:24:26.488876 | instance | changed: [localhost] => (item=group_vars/cephs) 2026-08-12 17:24:26.489151 | instance | changed: [localhost] => (item=group_vars/computes) 2026-08-12 17:24:26.489422 | instance | changed: [localhost] => (item=host_vars) 2026-08-12 17:24:26.489681 | instance | 2026-08-12 17:24:26.489988 | instance | PLAY [Generate Ceph control plane configuration for workspace] ***************** 2026-08-12 17:24:26.490290 | instance | 2026-08-12 17:24:26.490617 | instance | TASK [Ensure the Ceph control plane configuration file exists] ***************** 2026-08-12 17:24:26.490895 | instance | Wednesday 12 August 2026 17:24:26 +0000 (0:00:00.953) 0:00:04.888 ****** 2026-08-12 17:24:26.655411 | instance | changed: [localhost] 2026-08-12 17:24:26.655548 | instance | 2026-08-12 17:24:26.655814 | instance | TASK [Load the current Ceph control plane configuration into a variable] ******* 2026-08-12 17:24:26.656084 | instance | Wednesday 12 August 2026 17:24:26 +0000 (0:00:00.168) 0:00:05.057 ****** 2026-08-12 17:24:26.678428 | instance | ok: [localhost] 2026-08-12 17:24:26.678682 | instance | 2026-08-12 17:24:26.678964 | instance | TASK [Generate Ceph control plane values for missing variables] **************** 2026-08-12 17:24:26.679236 | instance | Wednesday 12 August 2026 17:24:26 +0000 (0:00:00.023) 0:00:05.080 ****** 2026-08-12 17:24:26.725021 | instance | ok: [localhost] => (item={'key': 'ceph_fsid', 'value': 'ebbdf70c-84dd-5c91-ba73-33ce60d12285'}) 2026-08-12 17:24:26.725328 | instance | ok: [localhost] => (item={'key': 'ceph_mon_public_network', 'value': '10.96.240.0/24'}) 2026-08-12 17:24:26.725536 | instance | 2026-08-12 17:24:26.725803 | instance | TASK [Write new Ceph control plane configuration file to disk] ***************** 2026-08-12 17:24:26.726073 | instance | Wednesday 12 August 2026 17:24:26 +0000 (0:00:00.046) 0:00:05.127 ****** 2026-08-12 17:24:27.247492 | instance | changed: [localhost] 2026-08-12 17:24:27.247737 | instance | 2026-08-12 17:24:27.248025 | instance | PLAY [Generate Ceph OSD configuration for workspace] *************************** 2026-08-12 17:24:27.248281 | instance | 2026-08-12 17:24:27.248562 | instance | TASK [Ensure the Ceph OSDs configuration file exists] ************************** 2026-08-12 17:24:27.248839 | instance | Wednesday 12 August 2026 17:24:27 +0000 (0:00:00.522) 0:00:05.649 ****** 2026-08-12 17:24:27.415152 | instance | changed: [localhost] 2026-08-12 17:24:27.415309 | instance | 2026-08-12 17:24:27.415583 | instance | TASK [Load the current Ceph OSDs configuration into a variable] **************** 2026-08-12 17:24:27.415853 | instance | Wednesday 12 August 2026 17:24:27 +0000 (0:00:00.167) 0:00:05.816 ****** 2026-08-12 17:24:27.439614 | instance | ok: [localhost] 2026-08-12 17:24:27.439864 | instance | 2026-08-12 17:24:27.440155 | instance | TASK [Generate Ceph OSDs values for missing variables] ************************* 2026-08-12 17:24:27.440412 | instance | Wednesday 12 August 2026 17:24:27 +0000 (0:00:00.024) 0:00:05.841 ****** 2026-08-12 17:24:27.467418 | instance | ok: [localhost] => (item={'key': 'ceph_osd_devices', 'value': ['/dev/vdb', '/dev/vdc', '/dev/vdd']}) 2026-08-12 17:24:27.467651 | instance | 2026-08-12 17:24:27.467944 | instance | TASK [Write new Ceph OSDs configuration file to disk] ************************** 2026-08-12 17:24:27.468300 | instance | Wednesday 12 August 2026 17:24:27 +0000 (0:00:00.027) 0:00:05.869 ****** 2026-08-12 17:24:28.169669 | instance | changed: [localhost] 2026-08-12 17:24:28.170234 | instance | 2026-08-12 17:24:28.170622 | instance | PLAY [Generate Kubernetes configuration for workspace] ************************* 2026-08-12 17:24:28.170932 | instance | 2026-08-12 17:24:28.171256 | instance | TASK [Ensure the Kubernetes configuration file exists] ************************* 2026-08-12 17:24:28.171582 | instance | Wednesday 12 August 2026 17:24:28 +0000 (0:00:00.701) 0:00:06.571 ****** 2026-08-12 17:24:28.343076 | instance | changed: [localhost] 2026-08-12 17:24:28.343475 | instance | 2026-08-12 17:24:28.343865 | instance | TASK [Load the current Kubernetes configuration into a variable] *************** 2026-08-12 17:24:28.344221 | instance | Wednesday 12 August 2026 17:24:28 +0000 (0:00:00.172) 0:00:06.744 ****** 2026-08-12 17:24:28.366948 | instance | ok: [localhost] 2026-08-12 17:24:28.367204 | instance | 2026-08-12 17:24:28.367446 | instance | TASK [Generate Kubernetes values for missing variables] ************************ 2026-08-12 17:24:28.367734 | instance | Wednesday 12 August 2026 17:24:28 +0000 (0:00:00.023) 0:00:06.767 ****** 2026-08-12 17:24:28.404889 | instance | ok: [localhost] => (item={'key': 'kubernetes_hostname', 'value': '10.96.240.10'}) 2026-08-12 17:24:28.405392 | instance | ok: [localhost] => (item={'key': 'kubernetes_keepalived_vrid', 'value': 42}) 2026-08-12 17:24:28.405807 | instance | ok: [localhost] => (item={'key': 'kubernetes_keepalived_vip', 'value': '10.96.240.10'}) 2026-08-12 17:24:28.406158 | instance | 2026-08-12 17:24:28.406590 | instance | TASK [Write new Kubernetes configuration file to disk] ************************* 2026-08-12 17:24:28.406992 | instance | Wednesday 12 August 2026 17:24:28 +0000 (0:00:00.039) 0:00:06.807 ****** 2026-08-12 17:24:28.744543 | instance | changed: [localhost] 2026-08-12 17:24:28.744589 | instance | 2026-08-12 17:24:28.744596 | instance | PLAY [Generate Keepalived configuration for workspace] ************************* 2026-08-12 17:24:28.744602 | instance | 2026-08-12 17:24:28.744608 | instance | TASK [Ensure the Keeaplived configuration file exists] ************************* 2026-08-12 17:24:28.744732 | instance | Wednesday 12 August 2026 17:24:28 +0000 (0:00:00.338) 0:00:07.145 ****** 2026-08-12 17:24:28.911377 | instance | changed: [localhost] 2026-08-12 17:24:28.911630 | instance | 2026-08-12 17:24:28.912043 | instance | TASK [Load the current Keepalived configuration into a variable] *************** 2026-08-12 17:24:28.912418 | instance | Wednesday 12 August 2026 17:24:28 +0000 (0:00:00.167) 0:00:07.313 ****** 2026-08-12 17:24:28.938424 | instance | ok: [localhost] 2026-08-12 17:24:28.938671 | instance | 2026-08-12 17:24:28.939051 | instance | TASK [Generate Keepalived values for missing variables] ************************ 2026-08-12 17:24:28.939363 | instance | Wednesday 12 August 2026 17:24:28 +0000 (0:00:00.027) 0:00:07.340 ****** 2026-08-12 17:24:28.969988 | instance | ok: [localhost] => (item={'key': 'keepalived_interface', 'value': 'br-ex'}) 2026-08-12 17:24:28.970129 | instance | ok: [localhost] => (item={'key': 'keepalived_vip', 'value': '10.96.250.10'}) 2026-08-12 17:24:28.970304 | instance | 2026-08-12 17:24:28.970482 | instance | TASK [Write new Keepalived configuration file to disk] ************************* 2026-08-12 17:24:28.970655 | instance | Wednesday 12 August 2026 17:24:28 +0000 (0:00:00.031) 0:00:07.372 ****** 2026-08-12 17:24:29.305566 | instance | changed: [localhost] 2026-08-12 17:24:29.305886 | instance | 2026-08-12 17:24:29.306289 | instance | PLAY [Generate endpoints for workspace] **************************************** 2026-08-12 17:24:29.306608 | instance | 2026-08-12 17:24:29.306938 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-12 17:24:29.307292 | instance | Wednesday 12 August 2026 17:24:29 +0000 (0:00:00.335) 0:00:07.707 ****** 2026-08-12 17:24:29.968619 | instance | ok: [localhost] 2026-08-12 17:24:29.968866 | instance | 2026-08-12 17:24:29.969190 | instance | TASK [Ensure the endpoints file exists] **************************************** 2026-08-12 17:24:29.969481 | instance | Wednesday 12 August 2026 17:24:29 +0000 (0:00:00.662) 0:00:08.370 ****** 2026-08-12 17:24:30.139169 | instance | changed: [localhost] 2026-08-12 17:24:30.139371 | instance | 2026-08-12 17:24:30.139644 | instance | TASK [Load the current endpoints into a variable] ****************************** 2026-08-12 17:24:30.139920 | instance | Wednesday 12 August 2026 17:24:30 +0000 (0:00:00.170) 0:00:08.541 ****** 2026-08-12 17:24:30.171211 | instance | ok: [localhost] 2026-08-12 17:24:30.171398 | instance | 2026-08-12 17:24:30.171651 | instance | TASK [Generate endpoint skeleton for missing variables] ************************ 2026-08-12 17:24:30.171918 | instance | Wednesday 12 August 2026 17:24:30 +0000 (0:00:00.032) 0:00:08.573 ****** 2026-08-12 17:24:31.013859 | instance | ok: [localhost] => (item=keycloak_host) 2026-08-12 17:24:31.014334 | instance | ok: [localhost] => (item=kube_prometheus_stack_grafana_host) 2026-08-12 17:24:31.014703 | instance | ok: [localhost] => (item=kube_prometheus_stack_alertmanager_host) 2026-08-12 17:24:31.015058 | instance | ok: [localhost] => (item=kube_prometheus_stack_prometheus_host) 2026-08-12 17:24:31.015434 | instance | ok: [localhost] => (item=openstack_helm_endpoints_region_name) 2026-08-12 17:24:31.015827 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_api_host) 2026-08-12 17:24:31.016247 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_api_host) 2026-08-12 17:24:31.016625 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_api_host) 2026-08-12 17:24:31.016970 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_api_host) 2026-08-12 17:24:31.017342 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_api_host) 2026-08-12 17:24:31.017676 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_api_host) 2026-08-12 17:24:31.018001 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_api_host) 2026-08-12 17:24:31.018387 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_novnc_host) 2026-08-12 17:24:31.018726 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_api_host) 2026-08-12 17:24:31.019052 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_api_host) 2026-08-12 17:24:31.019376 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_api_host) 2026-08-12 17:24:31.019699 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_api_host) 2026-08-12 17:24:31.020022 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_registry_host) 2026-08-12 17:24:31.020409 | instance | ok: [localhost] => (item=openstack_helm_endpoints_senlin_api_host) 2026-08-12 17:24:31.020615 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_api_host) 2026-08-12 17:24:31.020761 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_cfn_api_host) 2026-08-12 17:24:31.020906 | instance | ok: [localhost] => (item=openstack_helm_endpoints_horizon_api_host) 2026-08-12 17:24:31.021052 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rgw_host) 2026-08-12 17:24:31.021196 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_api_host) 2026-08-12 17:24:31.021335 | instance | 2026-08-12 17:24:31.021482 | instance | TASK [Write new endpoints file to disk] **************************************** 2026-08-12 17:24:31.021634 | instance | Wednesday 12 August 2026 17:24:31 +0000 (0:00:00.842) 0:00:09.415 ****** 2026-08-12 17:24:31.374191 | instance | changed: [localhost] 2026-08-12 17:24:31.374756 | instance | 2026-08-12 17:24:31.375121 | instance | TASK [Ensure the endpoints file exists] **************************************** 2026-08-12 17:24:31.375471 | instance | Wednesday 12 August 2026 17:24:31 +0000 (0:00:00.360) 0:00:09.776 ****** 2026-08-12 17:24:31.550797 | instance | changed: [localhost] 2026-08-12 17:24:31.551267 | instance | 2026-08-12 17:24:31.551662 | instance | PLAY [Generate Neutron configuration for workspace] **************************** 2026-08-12 17:24:31.551991 | instance | 2026-08-12 17:24:31.552360 | instance | TASK [Ensure the Neutron configuration file exists] **************************** 2026-08-12 17:24:31.552703 | instance | Wednesday 12 August 2026 17:24:31 +0000 (0:00:00.176) 0:00:09.952 ****** 2026-08-12 17:24:31.723099 | instance | changed: [localhost] 2026-08-12 17:24:31.723603 | instance | 2026-08-12 17:24:31.724005 | instance | TASK [Load the current Neutron configuration into a variable] ****************** 2026-08-12 17:24:31.724368 | instance | Wednesday 12 August 2026 17:24:31 +0000 (0:00:00.172) 0:00:10.125 ****** 2026-08-12 17:24:31.756239 | instance | ok: [localhost] 2026-08-12 17:24:31.756588 | instance | 2026-08-12 17:24:31.756975 | instance | TASK [Generate Neutron values for missing variables] *************************** 2026-08-12 17:24:31.757343 | instance | Wednesday 12 August 2026 17:24:31 +0000 (0:00:00.033) 0:00:10.158 ****** 2026-08-12 17:24:31.801907 | 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-08-12 17:24:31.802344 | instance | 2026-08-12 17:24:31.802718 | instance | TASK [Write new Neutron configuration file to disk] **************************** 2026-08-12 17:24:31.803074 | instance | Wednesday 12 August 2026 17:24:31 +0000 (0:00:00.045) 0:00:10.203 ****** 2026-08-12 17:24:32.149137 | instance | changed: [localhost] 2026-08-12 17:24:32.149542 | instance | 2026-08-12 17:24:32.149882 | instance | PLAY [Generate Nova configuration for workspace] ******************************* 2026-08-12 17:24:32.150197 | instance | 2026-08-12 17:24:32.150603 | instance | TASK [Ensure the Nova configuration file exists] ******************************* 2026-08-12 17:24:32.150938 | instance | Wednesday 12 August 2026 17:24:32 +0000 (0:00:00.347) 0:00:10.551 ****** 2026-08-12 17:24:32.333335 | instance | changed: [localhost] 2026-08-12 17:24:32.333713 | instance | 2026-08-12 17:24:32.334054 | instance | TASK [Load the current Nova configuration into a variable] ********************* 2026-08-12 17:24:32.334458 | instance | Wednesday 12 August 2026 17:24:32 +0000 (0:00:00.184) 0:00:10.735 ****** 2026-08-12 17:24:32.365429 | instance | ok: [localhost] 2026-08-12 17:24:32.365779 | instance | 2026-08-12 17:24:32.366150 | instance | TASK [Generate Nova values for missing variables] ****************************** 2026-08-12 17:24:32.366524 | instance | Wednesday 12 August 2026 17:24:32 +0000 (0:00:00.032) 0:00:10.768 ****** 2026-08-12 17:24:32.410134 | 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-08-12 17:24:32.410518 | instance | 2026-08-12 17:24:32.410868 | instance | TASK [Write new Nova configuration file to disk] ******************************* 2026-08-12 17:24:32.411204 | instance | Wednesday 12 August 2026 17:24:32 +0000 (0:00:00.044) 0:00:10.812 ****** 2026-08-12 17:24:32.756901 | instance | changed: [localhost] 2026-08-12 17:24:32.757314 | instance | 2026-08-12 17:24:32.757657 | instance | PLAY [Generate secrets for workspace] ****************************************** 2026-08-12 17:24:32.757973 | instance | 2026-08-12 17:24:32.758357 | instance | TASK [Ensure the secrets file exists] ****************************************** 2026-08-12 17:24:32.758707 | instance | Wednesday 12 August 2026 17:24:32 +0000 (0:00:00.346) 0:00:11.158 ****** 2026-08-12 17:24:32.950101 | instance | changed: [localhost] 2026-08-12 17:24:32.950444 | instance | 2026-08-12 17:24:32.950684 | instance | TASK [Load the current secrets into a variable] ******************************** 2026-08-12 17:24:32.950902 | instance | Wednesday 12 August 2026 17:24:32 +0000 (0:00:00.193) 0:00:11.352 ****** 2026-08-12 17:24:32.978100 | instance | ok: [localhost] 2026-08-12 17:24:32.978357 | instance | 2026-08-12 17:24:32.978574 | instance | TASK [Generate secrets for missing variables] ********************************** 2026-08-12 17:24:32.978788 | instance | Wednesday 12 August 2026 17:24:32 +0000 (0:00:00.028) 0:00:11.380 ****** 2026-08-12 17:24:33.387122 | instance | ok: [localhost] => (item=heat_auth_encryption_key) 2026-08-12 17:24:33.387584 | instance | ok: [localhost] => (item=keepalived_password) 2026-08-12 17:24:33.387937 | instance | ok: [localhost] => (item=keycloak_admin_password) 2026-08-12 17:24:33.388277 | instance | ok: [localhost] => (item=keycloak_database_password) 2026-08-12 17:24:33.388610 | instance | ok: [localhost] => (item=keystone_keycloak_client_secret) 2026-08-12 17:24:33.388948 | instance | ok: [localhost] => (item=keystone_oidc_crypto_passphrase) 2026-08-12 17:24:33.389280 | instance | ok: [localhost] => (item=kube_prometheus_stack_grafana_admin_password) 2026-08-12 17:24:33.389613 | instance | ok: [localhost] => (item=octavia_heartbeat_key) 2026-08-12 17:24:33.389944 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rabbitmq_admin_password) 2026-08-12 17:24:33.390344 | instance | ok: [localhost] => (item=openstack_helm_endpoints_memcached_secret_key) 2026-08-12 17:24:33.390690 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_admin_password) 2026-08-12 17:24:33.391099 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_mariadb_password) 2026-08-12 17:24:33.391859 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_rabbitmq_password) 2026-08-12 17:24:33.392250 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_keystone_password) 2026-08-12 17:24:33.392589 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_mariadb_password) 2026-08-12 17:24:33.392926 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_rabbitmq_password) 2026-08-12 17:24:33.393258 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_keystone_password) 2026-08-12 17:24:33.393591 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_mariadb_password) 2026-08-12 17:24:33.393918 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_rabbitmq_password) 2026-08-12 17:24:33.394374 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_keystone_password) 2026-08-12 17:24:33.394718 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_mariadb_password) 2026-08-12 17:24:33.395033 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_keystone_password) 2026-08-12 17:24:33.395239 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_mariadb_password) 2026-08-12 17:24:33.395446 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_keystone_password) 2026-08-12 17:24:33.395651 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_mariadb_password) 2026-08-12 17:24:33.395858 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_rabbitmq_password) 2026-08-12 17:24:33.396062 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_metadata_secret) 2026-08-12 17:24:33.396265 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_keystone_password) 2026-08-12 17:24:33.396469 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_mariadb_password) 2026-08-12 17:24:33.396672 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_rabbitmq_password) 2026-08-12 17:24:33.396883 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_keystone_password) 2026-08-12 17:24:33.397085 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_mariadb_password) 2026-08-12 17:24:33.397288 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_rabbitmq_password) 2026-08-12 17:24:33.397493 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_keystone_password) 2026-08-12 17:24:33.397696 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_mariadb_password) 2026-08-12 17:24:33.397901 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_rabbitmq_password) 2026-08-12 17:24:33.398136 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_keystone_password) 2026-08-12 17:24:33.398379 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_mariadb_password) 2026-08-12 17:24:33.398587 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_rabbitmq_password) 2026-08-12 17:24:33.398794 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_keystone_password) 2026-08-12 17:24:33.398999 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_mariadb_password) 2026-08-12 17:24:33.399203 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_rabbitmq_password) 2026-08-12 17:24:33.399404 | instance | ok: [localhost] => (item=openstack_helm_endpoints_senlin_keystone_password) 2026-08-12 17:24:33.399614 | instance | ok: [localhost] => (item=openstack_helm_endpoints_senlin_mariadb_password) 2026-08-12 17:24:33.399821 | instance | ok: [localhost] => (item=openstack_helm_endpoints_senlin_rabbitmq_password) 2026-08-12 17:24:33.400025 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_keystone_password) 2026-08-12 17:24:33.400240 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_trustee_keystone_password) 2026-08-12 17:24:33.400455 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_stack_user_keystone_password) 2026-08-12 17:24:33.400671 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_mariadb_password) 2026-08-12 17:24:33.400884 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_rabbitmq_password) 2026-08-12 17:24:33.401108 | instance | ok: [localhost] => (item=openstack_helm_endpoints_horizon_mariadb_password) 2026-08-12 17:24:33.401314 | instance | ok: [localhost] => (item=openstack_helm_endpoints_tempest_keystone_password) 2026-08-12 17:24:33.401525 | instance | ok: [localhost] => (item=openstack_helm_endpoints_openstack_exporter_keystone_password) 2026-08-12 17:24:33.401732 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rgw_keystone_password) 2026-08-12 17:24:33.401935 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_keystone_password) 2026-08-12 17:24:33.402156 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_mariadb_password) 2026-08-12 17:24:33.402402 | instance | ok: [localhost] => (item=openstack_helm_endpoints_staffeln_mariadb_password) 2026-08-12 17:24:33.402601 | instance | 2026-08-12 17:24:33.402807 | instance | TASK [Generate base64 encoded secrets] ***************************************** 2026-08-12 17:24:33.403029 | instance | Wednesday 12 August 2026 17:24:33 +0000 (0:00:00.407) 0:00:11.788 ****** 2026-08-12 17:24:33.443088 | instance | ok: [localhost] => (item=barbican_kek) 2026-08-12 17:24:33.443482 | instance | 2026-08-12 17:24:33.443835 | instance | TASK [Generate temporary files for generating keys for missing variables] ****** 2026-08-12 17:24:33.444172 | instance | Wednesday 12 August 2026 17:24:33 +0000 (0:00:00.055) 0:00:11.844 ****** 2026-08-12 17:24:33.887620 | instance | changed: [localhost] => (item=manila_ssh_key) 2026-08-12 17:24:33.888071 | instance | changed: [localhost] => (item=nova_ssh_key) 2026-08-12 17:24:33.888465 | instance | 2026-08-12 17:24:33.888818 | instance | TASK [Generate SSH keys for missing variables] ********************************* 2026-08-12 17:24:33.889153 | instance | Wednesday 12 August 2026 17:24:33 +0000 (0:00:00.443) 0:00:12.288 ****** 2026-08-12 17:24:37.125811 | instance | changed: [localhost] => (item=manila_ssh_key) 2026-08-12 17:24:37.125908 | instance | changed: [localhost] => (item=nova_ssh_key) 2026-08-12 17:24:37.125967 | instance | 2026-08-12 17:24:37.126252 | instance | TASK [Set values for SSH keys] ************************************************* 2026-08-12 17:24:37.126377 | instance | Wednesday 12 August 2026 17:24:37 +0000 (0:00:03.239) 0:00:15.528 ****** 2026-08-12 17:24:37.181865 | instance | ok: [localhost] => (item=manila_ssh_key) 2026-08-12 17:24:37.182332 | instance | ok: [localhost] => (item=nova_ssh_key) 2026-08-12 17:24:37.183151 | instance | 2026-08-12 17:24:37.183202 | instance | TASK [Delete the temporary files generated for SSH keys] *********************** 2026-08-12 17:24:37.183214 | instance | Wednesday 12 August 2026 17:24:37 +0000 (0:00:00.055) 0:00:15.583 ****** 2026-08-12 17:24:37.515371 | instance | changed: [localhost] => (item=manila_ssh_key) 2026-08-12 17:24:37.516022 | instance | changed: [localhost] => (item=nova_ssh_key) 2026-08-12 17:24:37.516043 | instance | 2026-08-12 17:24:37.516051 | instance | TASK [Write new secrets file to disk] ****************************************** 2026-08-12 17:24:37.516058 | instance | Wednesday 12 August 2026 17:24:37 +0000 (0:00:00.333) 0:00:15.917 ****** 2026-08-12 17:24:37.873676 | instance | changed: [localhost] 2026-08-12 17:24:37.873795 | instance | 2026-08-12 17:24:37.874057 | instance | TASK [Encrypt secrets file with Vault password] ******************************** 2026-08-12 17:24:37.874099 | instance | Wednesday 12 August 2026 17:24:37 +0000 (0:00:00.357) 0:00:16.275 ****** 2026-08-12 17:24:37.912744 | instance | skipping: [localhost] 2026-08-12 17:24:37.913662 | instance | 2026-08-12 17:24:37.913701 | instance | PLAY [Setup networking] ******************************************************** 2026-08-12 17:24:37.913710 | instance | 2026-08-12 17:24:37.913719 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-12 17:24:37.913728 | instance | Wednesday 12 August 2026 17:24:37 +0000 (0:00:00.039) 0:00:16.314 ****** 2026-08-12 17:24:38.613760 | instance | ok: [instance] 2026-08-12 17:24:38.613878 | instance | 2026-08-12 17:24:38.614207 | instance | TASK [Create bridge for management network] ************************************ 2026-08-12 17:24:38.614279 | instance | Wednesday 12 August 2026 17:24:38 +0000 (0:00:00.701) 0:00:17.016 ****** 2026-08-12 17:24:38.938290 | instance | ok: [instance] 2026-08-12 17:24:38.938374 | instance | 2026-08-12 17:24:38.938774 | instance | TASK [Create fake interface for management bridge] ***************************** 2026-08-12 17:24:38.938841 | instance | Wednesday 12 August 2026 17:24:38 +0000 (0:00:00.324) 0:00:17.340 ****** 2026-08-12 17:24:39.139900 | instance | ok: [instance] 2026-08-12 17:24:39.140070 | instance | 2026-08-12 17:24:39.140353 | instance | TASK [Assign dummy interface to management bridge] ***************************** 2026-08-12 17:24:39.140608 | instance | Wednesday 12 August 2026 17:24:39 +0000 (0:00:00.201) 0:00:17.542 ****** 2026-08-12 17:24:39.331562 | instance | ok: [instance] 2026-08-12 17:24:39.331636 | instance | 2026-08-12 17:24:39.331760 | instance | TASK [Assign IP address for management bridge] ********************************* 2026-08-12 17:24:39.331952 | instance | Wednesday 12 August 2026 17:24:39 +0000 (0:00:00.191) 0:00:17.733 ****** 2026-08-12 17:24:39.537804 | instance | ok: [instance] 2026-08-12 17:24:39.537896 | instance | 2026-08-12 17:24:39.538110 | instance | TASK [Bring up interfaces] ***************************************************** 2026-08-12 17:24:39.538413 | instance | Wednesday 12 August 2026 17:24:39 +0000 (0:00:00.206) 0:00:17.940 ****** 2026-08-12 17:24:39.909051 | instance | ok: [instance] => (item=br-mgmt) 2026-08-12 17:24:39.909251 | instance | ok: [instance] => (item=dummy0) 2026-08-12 17:24:39.909402 | instance | 2026-08-12 17:24:39.909558 | instance | PLAY [Create devices for Ceph] ************************************************* 2026-08-12 17:24:39.909717 | instance | 2026-08-12 17:24:39.909872 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-12 17:24:39.910025 | instance | Wednesday 12 August 2026 17:24:39 +0000 (0:00:00.369) 0:00:18.309 ****** 2026-08-12 17:24:40.642675 | instance | ok: [instance] 2026-08-12 17:24:40.642747 | instance | 2026-08-12 17:24:40.642818 | instance | TASK [Install depedencies] ***************************************************** 2026-08-12 17:24:40.642958 | instance | Wednesday 12 August 2026 17:24:40 +0000 (0:00:00.735) 0:00:19.045 ****** 2026-08-12 17:24:59.937141 | instance | changed: [instance] 2026-08-12 17:24:59.937375 | instance | 2026-08-12 17:24:59.937646 | instance | TASK [Start up service] ******************************************************** 2026-08-12 17:24:59.937936 | instance | Wednesday 12 August 2026 17:24:59 +0000 (0:00:19.293) 0:00:38.339 ****** 2026-08-12 17:25:00.508409 | instance | ok: [instance] 2026-08-12 17:25:00.508652 | instance | 2026-08-12 17:25:00.508882 | instance | TASK [Generate lvm.conf] ******************************************************* 2026-08-12 17:25:00.509147 | instance | Wednesday 12 August 2026 17:25:00 +0000 (0:00:00.571) 0:00:38.910 ****** 2026-08-12 17:25:00.718694 | instance | ok: [instance] 2026-08-12 17:25:00.718972 | instance | 2026-08-12 17:25:00.719289 | instance | TASK [Write /etc/lvm/lvm.conf] ************************************************* 2026-08-12 17:25:00.719517 | instance | Wednesday 12 August 2026 17:25:00 +0000 (0:00:00.210) 0:00:39.120 ****** 2026-08-12 17:25:01.191020 | instance | changed: [instance] 2026-08-12 17:25:01.191258 | instance | 2026-08-12 17:25:01.191465 | instance | TASK [Get list of all loopback devices] **************************************** 2026-08-12 17:25:01.191664 | instance | Wednesday 12 August 2026 17:25:01 +0000 (0:00:00.472) 0:00:39.593 ****** 2026-08-12 17:25:01.385387 | instance | ok: [instance] 2026-08-12 17:25:01.385527 | instance | 2026-08-12 17:25:01.385771 | instance | TASK [Fail if there is any existing loopback devices] ************************** 2026-08-12 17:25:01.385977 | instance | Wednesday 12 August 2026 17:25:01 +0000 (0:00:00.194) 0:00:39.787 ****** 2026-08-12 17:25:01.414504 | instance | skipping: [instance] 2026-08-12 17:25:01.414735 | instance | 2026-08-12 17:25:01.414946 | instance | TASK [Create devices for Ceph] ************************************************* 2026-08-12 17:25:01.415157 | instance | Wednesday 12 August 2026 17:25:01 +0000 (0:00:00.029) 0:00:39.816 ****** 2026-08-12 17:25:01.986783 | instance | changed: [instance] => (item=osd0) 2026-08-12 17:25:01.986843 | instance | changed: [instance] => (item=osd1) 2026-08-12 17:25:01.986984 | instance | changed: [instance] => (item=osd2) 2026-08-12 17:25:01.987293 | instance | 2026-08-12 17:25:01.987442 | instance | TASK [Set permissions on loopback devices] ************************************* 2026-08-12 17:25:01.987590 | instance | Wednesday 12 August 2026 17:25:01 +0000 (0:00:00.572) 0:00:40.388 ****** 2026-08-12 17:25:02.530871 | instance | changed: [instance] => (item=osd0) 2026-08-12 17:25:02.531083 | instance | changed: [instance] => (item=osd1) 2026-08-12 17:25:02.531233 | instance | changed: [instance] => (item=osd2) 2026-08-12 17:25:02.531373 | instance | 2026-08-12 17:25:02.531522 | instance | TASK [Start loop devices] ****************************************************** 2026-08-12 17:25:02.531670 | instance | Wednesday 12 August 2026 17:25:02 +0000 (0:00:00.543) 0:00:40.932 ****** 2026-08-12 17:25:03.227245 | instance | changed: [instance] => (item=osd0) 2026-08-12 17:25:03.227808 | instance | changed: [instance] => (item=osd1) 2026-08-12 17:25:03.228243 | instance | changed: [instance] => (item=osd2) 2026-08-12 17:25:03.228637 | instance | 2026-08-12 17:25:03.229058 | instance | TASK [Create a volume group for each loop device] ****************************** 2026-08-12 17:25:03.229462 | instance | Wednesday 12 August 2026 17:25:03 +0000 (0:00:00.695) 0:00:41.628 ****** 2026-08-12 17:25:06.503205 | instance | changed: [instance] => (item=osd0) 2026-08-12 17:25:06.503853 | instance | changed: [instance] => (item=osd1) 2026-08-12 17:25:06.504191 | instance | changed: [instance] => (item=osd2) 2026-08-12 17:25:06.504504 | instance | 2026-08-12 17:25:06.504854 | instance | TASK [Create a logical volume for each loop device] **************************** 2026-08-12 17:25:06.505221 | instance | Wednesday 12 August 2026 17:25:06 +0000 (0:00:03.274) 0:00:44.902 ****** 2026-08-12 17:25:08.414847 | instance | changed: [instance] => (item=ceph-instance-osd0) 2026-08-12 17:25:08.415111 | instance | changed: [instance] => (item=ceph-instance-osd1) 2026-08-12 17:25:08.415322 | instance | changed: [instance] => (item=ceph-instance-osd2) 2026-08-12 17:25:08.415518 | instance | 2026-08-12 17:25:08.415727 | instance | PLAY [controllers] ************************************************************* 2026-08-12 17:25:08.415919 | instance | 2026-08-12 17:25:08.416121 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-12 17:25:08.416325 | instance | Wednesday 12 August 2026 17:25:08 +0000 (0:00:01.913) 0:00:46.816 ****** 2026-08-12 17:25:09.333997 | instance | ok: [instance] 2026-08-12 17:25:09.334196 | instance | 2026-08-12 17:25:09.334363 | instance | TASK [Set masquerade rule] ***************************************************** 2026-08-12 17:25:09.334515 | instance | Wednesday 12 August 2026 17:25:09 +0000 (0:00:00.917) 0:00:47.734 ****** 2026-08-12 17:25:09.794366 | instance | changed: [instance] 2026-08-12 17:25:09.794688 | instance | 2026-08-12 17:25:09.794702 | instance | PLAY RECAP ********************************************************************* 2026-08-12 17:25:09.794713 | instance | instance : ok=24 changed=10 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-08-12 17:25:09.794731 | instance | localhost : ok=40 changed=21 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-08-12 17:25:09.794741 | instance | 2026-08-12 17:25:09.798366 | instance | Wednesday 12 August 2026 17:25:09 +0000 (0:00:00.461) 0:00:48.195 ****** 2026-08-12 17:25:09.798432 | instance | =============================================================================== 2026-08-12 17:25:09.798443 | instance | Install depedencies ---------------------------------------------------- 19.29s 2026-08-12 17:25:09.798452 | instance | Create a volume group for each loop device ------------------------------ 3.27s 2026-08-12 17:25:09.798461 | instance | Generate SSH keys for missing variables --------------------------------- 3.24s 2026-08-12 17:25:09.798470 | instance | Create a logical volume for each loop device ---------------------------- 1.91s 2026-08-12 17:25:09.798479 | instance | Install "dirmngr" for GPG keyserver operations -------------------------- 1.17s 2026-08-12 17:25:09.798488 | instance | Gathering Facts --------------------------------------------------------- 1.13s 2026-08-12 17:25:09.798497 | instance | Create folders for workspace -------------------------------------------- 0.95s 2026-08-12 17:25:09.798506 | instance | Gathering Facts --------------------------------------------------------- 0.92s 2026-08-12 17:25:09.798515 | instance | Generate endpoint skeleton for missing variables ------------------------ 0.84s 2026-08-12 17:25:09.798523 | instance | Gathering Facts --------------------------------------------------------- 0.74s 2026-08-12 17:25:09.798539 | instance | Write new Ceph OSDs configuration file to disk -------------------------- 0.70s 2026-08-12 17:25:09.798752 | instance | Gathering Facts --------------------------------------------------------- 0.70s 2026-08-12 17:25:09.799114 | instance | Start loop devices ------------------------------------------------------ 0.70s 2026-08-12 17:25:09.799323 | instance | Purge "snapd" package --------------------------------------------------- 0.69s 2026-08-12 17:25:09.799538 | instance | Configure short hostname ------------------------------------------------ 0.67s 2026-08-12 17:25:09.799759 | instance | Gathering Facts --------------------------------------------------------- 0.66s 2026-08-12 17:25:09.799975 | instance | Create devices for Ceph ------------------------------------------------- 0.57s 2026-08-12 17:25:09.800181 | instance | Start up service -------------------------------------------------------- 0.57s 2026-08-12 17:25:09.800408 | instance | Set permissions on loopback devices ------------------------------------- 0.54s 2026-08-12 17:25:09.800625 | instance | Write new Ceph control plane configuration file to disk ----------------- 0.52s 2026-08-12 17:25:09.859122 | instance | INFO [aio > prepare] Executed: Successful 2026-08-12 17:25:09.869181 | instance | INFO [aio > converge] Executing 2026-08-12 17:25:12.606226 | instance | 2026-08-12 17:25:12.606684 | instance | PLAY [all] ********************************************************************* 2026-08-12 17:25:12.607007 | instance | 2026-08-12 17:25:12.607340 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-12 17:25:12.607670 | instance | Wednesday 12 August 2026 17:25:12 +0000 (0:00:00.016) 0:00:00.016 ****** 2026-08-12 17:25:13.769699 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-08-12 17:25:13.770125 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-08-12 17:25:13.770531 | instance | interpreter could change the meaning of that path. See 2026-08-12 17:25:13.770883 | instance | https://docs.ansible.com/ansible- 2026-08-12 17:25:13.771231 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-08-12 17:25:13.786699 | instance | ok: [instance] 2026-08-12 17:25:13.787083 | instance | 2026-08-12 17:25:13.787465 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-08-12 17:25:13.787810 | instance | Wednesday 12 August 2026 17:25:13 +0000 (0:00:01.180) 0:00:01.197 ****** 2026-08-12 17:25:13.960791 | instance | ok: [instance] 2026-08-12 17:25:13.961137 | instance | 2026-08-12 17:25:13.961470 | instance | PLAY [Deploy Ceph monitors & managers] ***************************************** 2026-08-12 17:25:13.961776 | instance | 2026-08-12 17:25:13.962100 | instance | TASK [Gathering Facts] ********************************************************* 2026-08-12 17:25:13.962469 | instance | Wednesday 12 August 2026 17:25:13 +0000 (0:00:00.174) 0:00:01.371 ****** 2026-08-12 17:25:14.895170 | instance | ok: [instance] 2026-08-12 17:25:14.895555 | instance | 2026-08-12 17:25:14.895983 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-08-12 17:25:14.896348 | instance | Wednesday 12 August 2026 17:25:14 +0000 (0:00:00.933) 0:00:02.305 ****** 2026-08-12 17:25:15.167035 | instance | ok: [instance] 2026-08-12 17:25:15.167403 | instance | 2026-08-12 17:25:15.167738 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-08-12 17:25:15.168064 | instance | Wednesday 12 August 2026 17:25:15 +0000 (0:00:00.271) 0:00:02.577 ****** 2026-08-12 17:25:15.209733 | instance | skipping: [instance] 2026-08-12 17:25:15.210053 | instance | 2026-08-12 17:25:15.210409 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-08-12 17:25:15.210730 | instance | Wednesday 12 August 2026 17:25:15 +0000 (0:00:00.043) 0:00:02.620 ****** 2026-08-12 17:25:15.575768 | instance | changed: [instance] 2026-08-12 17:25:15.576139 | instance | 2026-08-12 17:25:15.576515 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-08-12 17:25:15.576845 | instance | Wednesday 12 August 2026 17:25:15 +0000 (0:00:00.365) 0:00:02.985 ****** 2026-08-12 17:25:15.643515 | instance | ok: [instance] => { 2026-08-12 17:25:15.643909 | instance | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-08-12 17:25:15.644320 | instance | } 2026-08-12 17:25:15.644647 | instance | 2026-08-12 17:25:15.644983 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-08-12 17:25:15.645306 | instance | Wednesday 12 August 2026 17:25:15 +0000 (0:00:00.068) 0:00:03.054 ****** 2026-08-12 17:25:37.534120 | instance | fatal: [instance]: FAILED! => {"attempts": 4, "censored": "the output has been hidden due to the fact that 'no_log: true' was specified for this result", "changed": false} 2026-08-12 17:25:37.537150 | instance | FAILED - RETRYING: [instance]: Download item (4 retries left). 2026-08-12 17:25:37.537562 | instance | FAILED - RETRYING: [instance]: Download item (3 retries left). 2026-08-12 17:25:37.537910 | instance | FAILED - RETRYING: [instance]: Download item (2 retries left). 2026-08-12 17:25:37.538278 | instance | FAILED - RETRYING: [instance]: Download item (1 retries left). 2026-08-12 17:25:37.538608 | instance | 2026-08-12 17:25:37.538936 | instance | PLAY RECAP ********************************************************************* 2026-08-12 17:25:37.539286 | instance | instance : ok=6 changed=1 unreachable=0 failed=1 skipped=1 rescued=0 ignored=0 2026-08-12 17:25:37.539597 | instance | 2026-08-12 17:25:37.539928 | instance | Wednesday 12 August 2026 17:25:37 +0000 (0:00:21.893) 0:00:24.947 ****** 2026-08-12 17:25:37.540315 | instance | =============================================================================== 2026-08-12 17:25:37.540653 | instance | vexxhost.containers.download_artifact : Download item ------------------ 21.89s 2026-08-12 17:25:37.542811 | instance | Gathering Facts --------------------------------------------------------- 1.18s 2026-08-12 17:25:37.543238 | instance | Gathering Facts --------------------------------------------------------- 0.93s 2026-08-12 17:25:37.543660 | instance | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.37s 2026-08-12 17:25:37.544061 | instance | vexxhost.containers.forget_package : Forget package --------------------- 0.27s 2026-08-12 17:25:37.544411 | instance | Set a fact with the "atmosphere_images" for other plays ----------------- 0.17s 2026-08-12 17:25:37.544736 | instance | vexxhost.containers.download_artifact : Starting download of file ------- 0.07s 2026-08-12 17:25:37.545054 | instance | vexxhost.containers.package : Update state for tar ---------------------- 0.04s 2026-08-12 17:25:37.686391 | 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-08-12 17:25:37.686731 | instance | ERROR [aio > converge] Executed: Failed 2026-08-12 17:25:37.686955 | 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-08-12 17:25:38.154095 | instance | ERROR 2026-08-12 17:25:38.154320 | instance | { 2026-08-12 17:25:38.154360 | instance | "delta": "0:01:31.482096", 2026-08-12 17:25:38.154389 | instance | "end": "2026-08-12 17:25:37.764288", 2026-08-12 17:25:38.154415 | instance | "msg": "non-zero return code", 2026-08-12 17:25:38.154440 | instance | "rc": 2, 2026-08-12 17:25:38.154464 | instance | "start": "2026-08-12 17:24:06.282192" 2026-08-12 17:25:38.154489 | instance | } failure 2026-08-12 17:25:38.161209 | 2026-08-12 17:25:38.161275 | PLAY RECAP 2026-08-12 17:25:38.161335 | instance | ok: 3 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-08-12 17:25:38.161365 | 2026-08-12 17:25:38.296865 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-08-12 17:25:38.307499 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-08-12 17:25:38.969738 | 2026-08-12 17:25:39.310761 | PLAY [all] 2026-08-12 17:25:39.341704 | 2026-08-12 17:25:39.341923 | TASK [gather-host-logs : creating directory for system status] 2026-08-12 17:25:39.715939 | instance | changed 2026-08-12 17:25:39.975506 | 2026-08-12 17:25:39.975661 | TASK [gather-host-logs : Get logs for each host] 2026-08-12 17:25:40.339333 | instance | + systemd-cgls --full --all --no-pager 2026-08-12 17:25:40.352489 | instance | + ip addr 2026-08-12 17:25:40.355352 | instance | + ip route 2026-08-12 17:25:40.357644 | instance | + lsblk 2026-08-12 17:25:40.362842 | instance | + mount 2026-08-12 17:25:40.364391 | instance | + docker images 2026-08-12 17:25:40.364823 | instance | /bin/bash: line 7: docker: command not found 2026-08-12 17:25:40.365051 | instance | + brctl show 2026-08-12 17:25:40.365455 | instance | /bin/bash: line 8: brctl: command not found 2026-08-12 17:25:40.365666 | instance | + ps aux --sort=-%mem 2026-08-12 17:25:40.378570 | instance | + dpkg -l 2026-08-12 17:25:40.384536 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-08-12 17:25:40.385218 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-08-12 17:25:40.385357 | instance | /bin/bash: line 11: docker: command not found 2026-08-12 17:25:40.385788 | instance | + '[' '!' -z '' ']' 2026-08-12 17:25:40.525726 | instance | ok: Runtime: 0:00:00.053529 2026-08-12 17:25:40.532937 | 2026-08-12 17:25:40.533079 | TASK [gather-host-logs : Downloads logs to executor] 2026-08-12 17:25:41.160952 | instance | changed: 2026-08-12 17:25:41.161183 | instance | created directory /var/lib/zuul/builds/4f76212407884224aa67669ec3ca01a4/work/logs/instance 2026-08-12 17:25:41.161227 | instance | cd+++++++++ system/ 2026-08-12 17:25:41.161260 | instance | >f+++++++++ system/brctl-show.txt 2026-08-12 17:25:41.161291 | instance | >f+++++++++ system/docker-images.txt 2026-08-12 17:25:41.161321 | instance | >f+++++++++ system/ip-addr.txt 2026-08-12 17:25:41.161353 | instance | >f+++++++++ system/ip-route.txt 2026-08-12 17:25:41.161384 | instance | >f+++++++++ system/lsblk.txt 2026-08-12 17:25:41.161413 | instance | >f+++++++++ system/mount.txt 2026-08-12 17:25:41.161445 | instance | >f+++++++++ system/packages.txt 2026-08-12 17:25:41.161474 | instance | >f+++++++++ system/ps.txt 2026-08-12 17:25:41.161502 | instance | >f+++++++++ system/systemd-cgls.txt 2026-08-12 17:25:41.173472 | 2026-08-12 17:25:41.173542 | LOOP [helm-release-status : creating directory for helm release status] 2026-08-12 17:25:41.376018 | instance | changed: "values" 2026-08-12 17:25:41.541477 | instance | changed: "releases" 2026-08-12 17:25:41.561421 | 2026-08-12 17:25:41.561600 | TASK [helm-release-status : Gather get release status for helm charts] 2026-08-12 17:25:41.851192 | instance | /bin/bash: line 3: kubectl: command not found 2026-08-12 17:25:42.100169 | instance | ok: Runtime: 0:00:00.006382 2026-08-12 17:25:42.106876 | 2026-08-12 17:25:42.106949 | TASK [helm-release-status : Downloads logs to executor] 2026-08-12 17:25:42.750816 | instance | changed: 2026-08-12 17:25:42.997514 | instance | cd+++++++++ helm/ 2026-08-12 17:25:42.997735 | instance | cd+++++++++ helm/releases/ 2026-08-12 17:25:42.997791 | instance | cd+++++++++ helm/values/ 2026-08-12 17:25:43.013538 | 2026-08-12 17:25:43.013632 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-08-12 17:25:43.211652 | instance | changed 2026-08-12 17:25:43.216724 | 2026-08-12 17:25:43.216812 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-08-12 17:25:43.425921 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-12 17:25:43.426313 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-12 17:25:43.432516 | instance | environment: line 1: kubectl: command not found 2026-08-12 17:25:43.434072 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-12 17:25:43.435055 | instance | environment: line 1: kubectl: command not found 2026-08-12 17:25:43.436628 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-12 17:25:43.437507 | instance | environment: line 1: kubectl: command not found 2026-08-12 17:25:43.438375 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-12 17:25:43.440987 | instance | environment: line 1: kubectl: command not found 2026-08-12 17:25:43.442459 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-12 17:25:43.443529 | instance | environment: line 1: kubectl: command not found 2026-08-12 17:25:43.444869 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-08-12 17:25:43.748639 | instance | ok: Runtime: 0:00:00.027821 2026-08-12 17:25:43.865077 | 2026-08-12 17:25:43.865240 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-08-12 17:25:44.077548 | instance | changed 2026-08-12 17:25:44.087671 | 2026-08-12 17:25:44.087820 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-08-12 17:25:44.317392 | instance | environment: line 5: kubectl: command not found 2026-08-12 17:25:44.318378 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-12 17:25:44.318445 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-12 17:25:44.318657 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-08-12 17:25:44.654206 | instance | ok: Runtime: 0:00:00.007683 2026-08-12 17:25:44.660790 | 2026-08-12 17:25:44.660854 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-08-12 17:25:45.193001 | instance | changed: 2026-08-12 17:25:45.193213 | instance | cd+++++++++ objects/ 2026-08-12 17:25:45.193252 | instance | cd+++++++++ objects/cluster/ 2026-08-12 17:25:45.193282 | instance | cd+++++++++ objects/namespaced/ 2026-08-12 17:25:45.203107 | 2026-08-12 17:25:45.203174 | TASK [gather-pod-logs : creating directory for pod logs] 2026-08-12 17:25:45.398345 | instance | changed 2026-08-12 17:25:45.406534 | 2026-08-12 17:25:45.406600 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-08-12 17:25:45.614232 | instance | changed 2026-08-12 17:25:45.619346 | 2026-08-12 17:25:45.619414 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-08-12 17:25:45.823316 | instance | environment: line 3: kubectl: command not found 2026-08-12 17:25:46.153164 | instance | ok: Runtime: 0:00:00.009830 2026-08-12 17:25:46.159338 | 2026-08-12 17:25:46.159408 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-08-12 17:25:46.689018 | instance | changed: 2026-08-12 17:25:46.689313 | instance | cd+++++++++ pod-logs/ 2026-08-12 17:25:46.689357 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-08-12 17:25:46.699686 | 2026-08-12 17:25:46.699756 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-08-12 17:25:46.898279 | instance | changed 2026-08-12 17:25:46.914981 | 2026-08-12 17:25:46.915106 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-08-12 17:25:47.127037 | instance | /bin/bash: line 2: kubectl: command not found 2026-08-12 17:25:47.462278 | instance | ok: Runtime: 0:00:00.035374 2026-08-12 17:25:47.468900 | 2026-08-12 17:25:47.468977 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-08-12 17:25:47.684255 | instance | /bin/bash: line 2: kubectl: command not found 2026-08-12 17:25:47.719792 | instance | ceph-mgr endpoints: 2026-08-12 17:25:48.004666 | instance | ok: Runtime: 0:00:00.041701 2026-08-12 17:25:48.010952 | 2026-08-12 17:25:48.011019 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-08-12 17:25:48.248981 | instance | /bin/bash: line 4: kubectl: command not found 2026-08-12 17:25:48.672028 | instance | ok: Runtime: 0:00:00.038078 2026-08-12 17:25:48.678342 | 2026-08-12 17:25:48.678422 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-08-12 17:25:50.385689 | instance | changed: cd+++++++++ prometheus/ 2026-08-12 17:25:50.396377 | 2026-08-12 17:25:50.396465 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-08-12 17:25:50.601023 | instance | changed 2026-08-12 17:25:50.606583 | 2026-08-12 17:25:50.606689 | TASK [gather-selenium-data : Get selenium data] 2026-08-12 17:25:50.805016 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-08-12 17:25:50.806540 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-08-12 17:25:51.143364 | instance | ERROR 2026-08-12 17:25:51.143701 | instance | { 2026-08-12 17:25:51.143776 | instance | "delta": "0:00:00.006464", 2026-08-12 17:25:51.143824 | instance | "end": "2026-08-12 17:25:50.806885", 2026-08-12 17:25:51.143867 | instance | "msg": "non-zero return code", 2026-08-12 17:25:51.143909 | instance | "rc": 1, 2026-08-12 17:25:51.143950 | instance | "start": "2026-08-12 17:25:50.800421" 2026-08-12 17:25:51.143990 | instance | } 2026-08-12 17:25:51.144042 | instance | ERROR: Ignoring Errors 2026-08-12 17:25:51.149842 | 2026-08-12 17:25:51.149910 | TASK [gather-selenium-data : Downloads logs to executor] 2026-08-12 17:25:51.662817 | instance | changed: cd+++++++++ selenium/ 2026-08-12 17:25:51.670489 | 2026-08-12 17:25:51.670538 | PLAY RECAP 2026-08-12 17:25:51.670585 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-08-12 17:25:51.670607 | 2026-08-12 17:25:51.805575 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere-zuul-jobs/playbooks/molecule/post.yml@main] 2026-08-12 17:25:51.978151 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-12 17:25:52.741820 | 2026-08-12 17:25:52.808142 | PLAY [all] 2026-08-12 17:25:52.825155 | 2026-08-12 17:25:52.825255 | TASK [fetch-output : Set log path for multiple nodes] 2026-08-12 17:25:52.872790 | instance | skipping: Conditional result was False 2026-08-12 17:25:52.884155 | 2026-08-12 17:25:52.884272 | TASK [fetch-output : Set log path for single node] 2026-08-12 17:25:52.929821 | instance | ok 2026-08-12 17:25:52.935089 | 2026-08-12 17:25:52.935210 | LOOP [fetch-output : Ensure local output dirs] 2026-08-12 17:25:53.561304 | instance -> localhost | ok: "/var/lib/zuul/builds/4f76212407884224aa67669ec3ca01a4/work/logs" 2026-08-12 17:25:53.796213 | instance -> localhost | changed: "/var/lib/zuul/builds/4f76212407884224aa67669ec3ca01a4/work/artifacts" 2026-08-12 17:25:54.119428 | instance -> localhost | changed: "/var/lib/zuul/builds/4f76212407884224aa67669ec3ca01a4/work/docs" 2026-08-12 17:25:54.131447 | 2026-08-12 17:25:54.131982 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-08-12 17:25:54.778684 | instance | changed: .d..t...... ./ 2026-08-12 17:25:54.992641 | instance | changed: All items complete 2026-08-12 17:25:54.992862 | 2026-08-12 17:25:55.429857 | instance | changed: .d..t...... ./ 2026-08-12 17:25:56.003121 | instance | changed: .d..t...... ./ 2026-08-12 17:25:56.022121 | 2026-08-12 17:25:56.022305 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-08-12 17:25:56.496029 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007131 2026-08-12 17:25:56.723136 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.006646 2026-08-12 17:25:56.733900 | 2026-08-12 17:25:56.734042 | PLAY [all] 2026-08-12 17:25:56.743349 | 2026-08-12 17:25:56.743457 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-08-12 17:25:57.201940 | instance | changed 2026-08-12 17:25:57.207567 | 2026-08-12 17:25:57.207623 | PLAY RECAP 2026-08-12 17:25:57.207669 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-08-12 17:25:57.207691 | 2026-08-12 17:25:57.382707 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-08-12 17:25:57.394681 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-08-12 17:25:58.150280 | 2026-08-12 17:25:58.325428 | PLAY [localhost] 2026-08-12 17:25:58.341013 | 2026-08-12 17:25:58.341142 | TASK [Generate Zuul manifest] 2026-08-12 17:25:58.371440 | localhost | ok 2026-08-12 17:25:58.453635 | 2026-08-12 17:25:58.453826 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-08-12 17:25:58.856108 | localhost | changed 2026-08-12 17:25:58.901827 | 2026-08-12 17:25:58.901998 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-08-12 17:25:58.974108 | localhost | ok 2026-08-12 17:25:58.981938 | 2026-08-12 17:25:58.982010 | TASK [Upload logs] 2026-08-12 17:25:59.002661 | localhost | ok 2026-08-12 17:25:59.171420 | 2026-08-12 17:25:59.171553 | TASK [Set zuul-log-path fact] 2026-08-12 17:25:59.191141 | localhost | ok 2026-08-12 17:25:59.203856 | 2026-08-12 17:25:59.203921 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-08-12 17:25:59.235995 | localhost | ok 2026-08-12 17:25:59.243788 | 2026-08-12 17:25:59.243851 | TASK [upload-logs : Create log directories] 2026-08-12 17:25:59.644886 | localhost | changed 2026-08-12 17:25:59.651713 | 2026-08-12 17:25:59.651818 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-08-12 17:26:00.645997 | localhost -> localhost | ok: Runtime: 0:00:00.005739 2026-08-12 17:26:00.651352 | 2026-08-12 17:26:00.651423 | TASK [upload-logs : Upload logs to log server] 2026-08-12 17:26:01.131601 | localhost | Output suppressed because no_log was given 2026-08-12 17:26:01.135348 | 2026-08-12 17:26:01.135416 | LOOP [upload-logs : Compress console log and json output] 2026-08-12 17:26:01.212188 | localhost | skipping: Conditional result was False 2026-08-12 17:26:01.227346 | localhost | skipping: Conditional result was False 2026-08-12 17:26:01.237016 | 2026-08-12 17:26:01.237152 | LOOP [upload-logs : Upload compressed console log and json output] 2026-08-12 17:26:01.281478 | localhost | skipping: Conditional result was False 2026-08-12 17:26:01.283032 | 2026-08-12 17:26:01.285108 | localhost | skipping: Conditional result was False 2026-08-12 17:26:01.296875 | 2026-08-12 17:26:01.297000 | LOOP [upload-logs : Upload console log and json output]