2026-04-08 02:06:04.274241 | Job console starting 2026-04-08 02:06:04.287089 | Updating git repos 2026-04-08 02:06:04.354906 | Cloning repos into workspace 2026-04-08 02:06:05.063139 | Restoring repo states 2026-04-08 02:06:05.081589 | Merging changes 2026-04-08 02:06:07.016686 | Checking out repos 2026-04-08 02:06:07.318161 | Preparing playbooks 2026-04-08 02:06:18.947406 | Running Ansible setup 2026-04-08 02:06:22.385648 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-08 02:06:22.929286 | 2026-04-08 02:06:22.929561 | PLAY [localhost] 2026-04-08 02:06:22.936673 | 2026-04-08 02:06:22.936739 | TASK [Gathering Facts] 2026-04-08 02:06:23.755184 | localhost | ok 2026-04-08 02:06:23.767494 | 2026-04-08 02:06:23.767569 | TASK [Setup log path fact] 2026-04-08 02:06:23.785446 | localhost | ok 2026-04-08 02:06:23.799708 | 2026-04-08 02:06:23.799785 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-08 02:06:23.827805 | localhost | ok 2026-04-08 02:06:23.835646 | 2026-04-08 02:06:23.835753 | TASK [emit-job-header : Print job information] 2026-04-08 02:06:23.872713 | # Job Information 2026-04-08 02:06:23.872829 | Ansible Version: 2.16.16 2026-04-08 02:06:23.872861 | Job: atmosphere-molecule-keycloak 2026-04-08 02:06:23.872882 | Pipeline: check 2026-04-08 02:06:23.872902 | Executor: 0a8996d2b663 2026-04-08 02:06:23.872921 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3809 2026-04-08 02:06:23.872943 | Event ID: 0ad284d0-32ee-11f1-8e01-b02409c8f46b 2026-04-08 02:06:23.875539 | 2026-04-08 02:06:23.875603 | LOOP [emit-job-header : Print node information] 2026-04-08 02:06:23.967525 | localhost | ok: 2026-04-08 02:06:23.967743 | localhost | # Node Information 2026-04-08 02:06:23.967785 | localhost | Inventory Hostname: instance 2026-04-08 02:06:23.967817 | localhost | Hostname: np0000164172 2026-04-08 02:06:23.967847 | localhost | Username: zuul 2026-04-08 02:06:23.967880 | localhost | Distro: Ubuntu 22.04 2026-04-08 02:06:23.967910 | localhost | Provider: yul1 2026-04-08 02:06:23.967939 | localhost | Region: ca-ymq-1 2026-04-08 02:06:23.967967 | localhost | Label: ubuntu-jammy 2026-04-08 02:06:23.967995 | localhost | Product Name: OpenStack Nova 2026-04-08 02:06:23.968023 | localhost | Interface IP: 162.253.55.62 2026-04-08 02:06:23.990095 | 2026-04-08 02:06:23.990211 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-08 02:06:24.348026 | localhost -> localhost | changed 2026-04-08 02:06:24.354289 | 2026-04-08 02:06:24.354379 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-08 02:06:25.166828 | localhost -> localhost | changed 2026-04-08 02:06:25.179723 | 2026-04-08 02:06:25.179900 | PLAY [all] 2026-04-08 02:06:25.191609 | 2026-04-08 02:06:25.191702 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-08 02:06:25.430148 | instance -> localhost | ok 2026-04-08 02:06:25.435955 | 2026-04-08 02:06:25.436021 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-08 02:06:25.463758 | instance | ok 2026-04-08 02:06:25.478612 | instance | included: /var/lib/zuul/builds/3a1ee38dd84c44329842333eb15a0639/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-08 02:06:25.485005 | 2026-04-08 02:06:25.485072 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-08 02:06:27.257415 | instance -> localhost | Generating public/private rsa key pair. 2026-04-08 02:06:27.257614 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/3a1ee38dd84c44329842333eb15a0639/work/3a1ee38dd84c44329842333eb15a0639_id_rsa 2026-04-08 02:06:27.257704 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/3a1ee38dd84c44329842333eb15a0639/work/3a1ee38dd84c44329842333eb15a0639_id_rsa.pub 2026-04-08 02:06:27.257740 | instance -> localhost | The key fingerprint is: 2026-04-08 02:06:27.257773 | instance -> localhost | SHA256:kfW8ZL7V1EE7wNFnbZ6aGzLk4Tz/hPtSggvIZMShRbA zuul-build-sshkey 2026-04-08 02:06:27.257821 | instance -> localhost | The key's randomart image is: 2026-04-08 02:06:27.257853 | instance -> localhost | +---[RSA 3072]----+ 2026-04-08 02:06:27.257888 | instance -> localhost | | .++. . .o+o.| 2026-04-08 02:06:27.257918 | instance -> localhost | | +o o o ...O| 2026-04-08 02:06:27.257948 | instance -> localhost | | E. o = *=| 2026-04-08 02:06:27.257977 | instance -> localhost | | o . * . +o| 2026-04-08 02:06:27.258005 | instance -> localhost | | + S = = + .| 2026-04-08 02:06:27.258033 | instance -> localhost | | o . O B.. | 2026-04-08 02:06:27.258061 | instance -> localhost | | . B.=. | 2026-04-08 02:06:27.258090 | instance -> localhost | | . +o | 2026-04-08 02:06:27.258122 | instance -> localhost | | .+o | 2026-04-08 02:06:27.258152 | instance -> localhost | +----[SHA256]-----+ 2026-04-08 02:06:27.258218 | instance -> localhost | ok: Runtime: 0:00:01.384344 2026-04-08 02:06:27.265104 | 2026-04-08 02:06:27.265192 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-08 02:06:27.297457 | instance | ok 2026-04-08 02:06:27.308551 | instance | included: /var/lib/zuul/builds/3a1ee38dd84c44329842333eb15a0639/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-08 02:06:27.317002 | 2026-04-08 02:06:27.317095 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-08 02:06:27.342228 | instance | skipping: Conditional result was False 2026-04-08 02:06:27.352613 | 2026-04-08 02:06:27.402390 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-08 02:06:27.853354 | instance | changed 2026-04-08 02:06:27.864061 | 2026-04-08 02:06:27.864127 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-08 02:06:28.038987 | instance | ok 2026-04-08 02:06:28.045743 | 2026-04-08 02:06:28.045828 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-08 02:06:28.762037 | instance | changed 2026-04-08 02:06:28.768098 | 2026-04-08 02:06:28.768164 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-08 02:06:29.227002 | instance | changed 2026-04-08 02:06:29.235081 | 2026-04-08 02:06:29.235162 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-08 02:06:29.260739 | instance | skipping: Conditional result was False 2026-04-08 02:06:29.274273 | 2026-04-08 02:06:29.274416 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-08 02:06:29.681540 | instance -> localhost | changed 2026-04-08 02:06:29.698479 | 2026-04-08 02:06:29.698594 | TASK [add-build-sshkey : Add back temp key] 2026-04-08 02:06:29.965940 | instance -> localhost | Identity added: /var/lib/zuul/builds/3a1ee38dd84c44329842333eb15a0639/work/3a1ee38dd84c44329842333eb15a0639_id_rsa (zuul-build-sshkey) 2026-04-08 02:06:29.966186 | instance -> localhost | ok: Runtime: 0:00:00.014805 2026-04-08 02:06:29.973350 | 2026-04-08 02:06:29.973448 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-08 02:06:30.265527 | instance | ok 2026-04-08 02:06:30.270040 | 2026-04-08 02:06:30.270102 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-08 02:06:30.293932 | instance | skipping: Conditional result was False 2026-04-08 02:06:30.308385 | 2026-04-08 02:06:30.308453 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-08 02:06:30.623317 | instance | ok 2026-04-08 02:06:30.630461 | 2026-04-08 02:06:30.630522 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-08 02:06:32.198410 | instance | Output suppressed because no_log was given 2026-04-08 02:06:32.208034 | 2026-04-08 02:06:32.208142 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-08 02:06:32.399167 | instance | ok: "logs" 2026-04-08 02:06:32.399596 | instance | ok: All items complete 2026-04-08 02:06:32.399627 | 2026-04-08 02:06:32.563349 | instance | ok: "artifacts" 2026-04-08 02:06:32.718086 | instance | ok: "docs" 2026-04-08 02:06:32.734324 | 2026-04-08 02:06:32.734440 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-08 02:06:32.919750 | instance | changed: "logs" 2026-04-08 02:06:33.081721 | instance | changed: "artifacts" 2026-04-08 02:06:33.231722 | instance | changed: "docs" 2026-04-08 02:06:33.250215 | 2026-04-08 02:06:33.250336 | PLAY RECAP 2026-04-08 02:06:33.250399 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-08 02:06:33.250440 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-08 02:06:33.250473 | 2026-04-08 02:06:33.362182 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-08 02:06:33.365423 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-08 02:06:33.938724 | 2026-04-08 02:06:33.938840 | PLAY [all] 2026-04-08 02:06:33.950233 | 2026-04-08 02:06:33.950311 | TASK [setup-uv : Extract archive] 2026-04-08 02:06:36.138784 | instance | changed 2026-04-08 02:06:36.145208 | 2026-04-08 02:06:36.145288 | TASK [setup-uv : Print version] 2026-04-08 02:06:36.575103 | instance | uv 0.8.13 2026-04-08 02:06:36.686943 | instance | ok: Runtime: 0:00:00.022886 2026-04-08 02:06:36.694917 | 2026-04-08 02:06:36.694984 | PLAY RECAP 2026-04-08 02:06:36.695041 | instance | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-08 02:06:36.695075 | 2026-04-08 02:06:36.788599 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-08 02:06:36.791843 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main] 2026-04-08 02:06:37.326997 | 2026-04-08 02:06:37.327123 | PLAY [all] 2026-04-08 02:06:37.338268 | 2026-04-08 02:06:37.338340 | TASK [Install "jq" for log collection] 2026-04-08 02:06:47.530020 | instance | changed 2026-04-08 02:06:47.532442 | 2026-04-08 02:06:47.532519 | PLAY RECAP 2026-04-08 02:06:47.532586 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-08 02:06:47.532653 | 2026-04-08 02:06:47.627174 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main] 2026-04-08 02:06:47.632519 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-08 02:06:48.175135 | 2026-04-08 02:06:48.175272 | PLAY [all] 2026-04-08 02:06:48.185973 | 2026-04-08 02:06:48.186043 | TASK [Copy inventory file for Zuul] 2026-04-08 02:06:49.009298 | instance | changed 2026-04-08 02:06:49.016135 | 2026-04-08 02:06:49.016248 | TASK [Switch "ansible_host" to private IP] 2026-04-08 02:06:49.314257 | instance | changed: 1 replacements made 2026-04-08 02:06:49.319859 | 2026-04-08 02:06:49.319924 | TASK [Run Molecule scenario] 2026-04-08 02:06:49.731685 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-04-08 02:06:49.731856 | instance | Creating virtual environment at: .venv 2026-04-08 02:06:49.760864 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-04-08 02:06:49.780350 | instance | Downloading rjsonnet (1.2MiB) 2026-04-08 02:06:49.781038 | instance | Downloading pydantic-core (2.0MiB) 2026-04-08 02:06:49.781567 | instance | Downloading pygments (1.2MiB) 2026-04-08 02:06:49.782296 | instance | Downloading ansible-core (2.1MiB) 2026-04-08 02:06:49.784623 | instance | Downloading kubernetes (1.9MiB) 2026-04-08 02:06:49.785160 | instance | Downloading setuptools (1.1MiB) 2026-04-08 02:06:49.785766 | instance | Downloading openstacksdk (1.7MiB) 2026-04-08 02:06:49.786165 | instance | Downloading netaddr (2.2MiB) 2026-04-08 02:06:49.786381 | instance | Downloading cryptography (4.2MiB) 2026-04-08 02:06:50.109729 | instance | Building pyperclip==1.9.0 2026-04-08 02:06:50.115615 | instance | Downloading rjsonnet 2026-04-08 02:06:50.217009 | instance | Downloading pydantic-core 2026-04-08 02:06:50.247799 | instance | Downloading netaddr 2026-04-08 02:06:50.278742 | instance | Downloading pygments 2026-04-08 02:06:50.293765 | instance | Downloading cryptography 2026-04-08 02:06:50.319769 | instance | Downloading setuptools 2026-04-08 02:06:50.373538 | instance | Downloading kubernetes 2026-04-08 02:06:50.398509 | instance | Downloading ansible-core 2026-04-08 02:06:50.428905 | instance | Downloading openstacksdk 2026-04-08 02:06:50.797626 | instance | Built pyperclip==1.9.0 2026-04-08 02:06:51.007214 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-04-08 02:06:51.055489 | instance | Installed 83 packages in 46ms 2026-04-08 02:06:51.676274 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-04-08 02:06:52.285052 | instance | INFO [keycloak > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-04-08 02:06:52.285116 | instance | INFO [keycloak > prerun] Performing prerun with role_name_check=0... 2026-04-08 02:07:39.127592 | instance | INFO [keycloak > dependency] Executing 2026-04-08 02:07:39.127766 | instance | WARNING [keycloak > dependency] Missing roles requirements file: requirements.yml 2026-04-08 02:07:39.127939 | instance | WARNING [keycloak > dependency] Missing collections requirements file: collections.yml 2026-04-08 02:07:39.128076 | instance | WARNING [keycloak > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-04-08 02:07:39.139055 | instance | INFO [keycloak > cleanup] Executing 2026-04-08 02:07:39.139426 | instance | WARNING [keycloak > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-08 02:07:39.154619 | instance | INFO [keycloak > destroy] Executing 2026-04-08 02:07:39.154711 | instance | WARNING [keycloak > destroy] Skipping, '--destroy=never' requested. 2026-04-08 02:07:39.154825 | instance | INFO [keycloak > destroy] Executed: Successful 2026-04-08 02:07:39.166666 | instance | INFO [keycloak > syntax] Executing 2026-04-08 02:07:39.784015 | instance | [WARNING]: Unable to parse /home/zuul/src/github.com/vexxhost/atmosphere/molecu 2026-04-08 02:07:39.784213 | instance | le/keycloak/src/github.com/vexxhost/atmosphere/inventory.yaml as an inventory 2026-04-08 02:07:39.784474 | instance | source 2026-04-08 02:07:40.273393 | instance | 2026-04-08 02:07:40.273648 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/keycloak/converge.yml 2026-04-08 02:07:40.324098 | instance | INFO [keycloak > syntax] Executed: Successful 2026-04-08 02:07:40.339019 | instance | INFO [keycloak > create] Executing 2026-04-08 02:07:40.340768 | instance | WARNING [keycloak > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-08 02:07:40.349896 | instance | INFO [keycloak > prepare] Executing 2026-04-08 02:07:40.944691 | instance | [WARNING]: Unable to parse /home/zuul/src/github.com/vexxhost/atmosphere/molecu 2026-04-08 02:07:40.944930 | instance | le/keycloak/src/github.com/vexxhost/atmosphere/inventory.yaml as an inventory 2026-04-08 02:07:40.945198 | instance | source 2026-04-08 02:07:41.504923 | instance | 2026-04-08 02:07:41.505240 | instance | PLAY [Prepare] ***************************************************************** 2026-04-08 02:07:41.505543 | instance | 2026-04-08 02:07:41.505820 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-08 02:07:41.506095 | instance | Wednesday 08 April 2026 02:07:41 +0000 (0:00:00.026) 0:00:00.026 ******* 2026-04-08 02:07:42.465145 | instance | ok: [instance] 2026-04-08 02:07:42.465470 | instance | 2026-04-08 02:07:42.465755 | instance | TASK [Configure short hostname] ************************************************ 2026-04-08 02:07:42.466025 | instance | Wednesday 08 April 2026 02:07:42 +0000 (0:00:00.961) 0:00:00.987 ******* 2026-04-08 02:07:43.193487 | instance | changed: [instance] 2026-04-08 02:07:43.193740 | instance | 2026-04-08 02:07:43.194034 | instance | TASK [Ensure hostname inside hosts file] *************************************** 2026-04-08 02:07:43.194329 | instance | Wednesday 08 April 2026 02:07:43 +0000 (0:00:00.728) 0:00:01.715 ******* 2026-04-08 02:07:43.501277 | instance | changed: [instance] 2026-04-08 02:07:43.501507 | instance | 2026-04-08 02:07:43.501735 | instance | TASK [Install "dirmngr" for GPG keyserver operations] ************************** 2026-04-08 02:07:43.501977 | instance | Wednesday 08 April 2026 02:07:43 +0000 (0:00:00.307) 0:00:02.023 ******* 2026-04-08 02:07:44.930550 | instance | ok: [instance] 2026-04-08 02:07:44.930736 | instance | 2026-04-08 02:07:44.930979 | instance | TASK [Purge "snapd" package] *************************************************** 2026-04-08 02:07:44.931198 | instance | Wednesday 08 April 2026 02:07:44 +0000 (0:00:01.429) 0:00:03.453 ******* 2026-04-08 02:07:45.914575 | instance | ok: [instance] 2026-04-08 02:07:45.914809 | instance | 2026-04-08 02:07:45.915076 | instance | PLAY [Generate workspace for Atmosphere] *************************************** 2026-04-08 02:07:45.915320 | instance | 2026-04-08 02:07:45.915607 | instance | TASK [Create folders for workspace] ******************************************** 2026-04-08 02:07:45.915940 | instance | Wednesday 08 April 2026 02:07:45 +0000 (0:00:00.983) 0:00:04.437 ******* 2026-04-08 02:07:47.068872 | instance | changed: [localhost] => (item=group_vars) 2026-04-08 02:07:47.069141 | instance | changed: [localhost] => (item=group_vars/all) 2026-04-08 02:07:47.069451 | instance | changed: [localhost] => (item=group_vars/controllers) 2026-04-08 02:07:47.069762 | instance | changed: [localhost] => (item=group_vars/cephs) 2026-04-08 02:07:47.070037 | instance | changed: [localhost] => (item=group_vars/computes) 2026-04-08 02:07:47.070305 | instance | changed: [localhost] => (item=host_vars) 2026-04-08 02:07:47.070627 | instance | 2026-04-08 02:07:47.070922 | instance | PLAY [Generate Ceph control plane configuration for workspace] ***************** 2026-04-08 02:07:47.071147 | instance | 2026-04-08 02:07:47.071409 | instance | TASK [Ensure the Ceph control plane configuration file exists] ***************** 2026-04-08 02:07:47.071674 | instance | Wednesday 08 April 2026 02:07:47 +0000 (0:00:01.154) 0:00:05.591 ******* 2026-04-08 02:07:47.265463 | instance | changed: [localhost] 2026-04-08 02:07:47.265716 | instance | 2026-04-08 02:07:47.266004 | instance | TASK [Load the current Ceph control plane configuration into a variable] ******* 2026-04-08 02:07:47.266278 | instance | Wednesday 08 April 2026 02:07:47 +0000 (0:00:00.196) 0:00:05.787 ******* 2026-04-08 02:07:47.291130 | instance | ok: [localhost] 2026-04-08 02:07:47.291370 | instance | 2026-04-08 02:07:47.291646 | instance | TASK [Generate Ceph control plane values for missing variables] **************** 2026-04-08 02:07:47.291916 | instance | Wednesday 08 April 2026 02:07:47 +0000 (0:00:00.025) 0:00:05.813 ******* 2026-04-08 02:07:47.336000 | instance | ok: [localhost] => (item={'key': 'ceph_fsid', 'value': 'c589236b-48fe-51c1-931b-5d26786db783'}) 2026-04-08 02:07:47.336114 | instance | ok: [localhost] => (item={'key': 'ceph_mon_public_network', 'value': '10.96.240.0/24'}) 2026-04-08 02:07:47.336265 | instance | 2026-04-08 02:07:47.336497 | instance | TASK [Write new Ceph control plane configuration file to disk] ***************** 2026-04-08 02:07:47.336760 | instance | Wednesday 08 April 2026 02:07:47 +0000 (0:00:00.045) 0:00:05.859 ******* 2026-04-08 02:07:47.856891 | instance | changed: [localhost] 2026-04-08 02:07:47.857114 | instance | 2026-04-08 02:07:47.857513 | instance | PLAY [Generate Ceph OSD configuration for workspace] *************************** 2026-04-08 02:07:47.857734 | instance | 2026-04-08 02:07:47.858014 | instance | TASK [Ensure the Ceph OSDs configuration file exists] ************************** 2026-04-08 02:07:47.858339 | instance | Wednesday 08 April 2026 02:07:47 +0000 (0:00:00.520) 0:00:06.379 ******* 2026-04-08 02:07:48.043537 | instance | changed: [localhost] 2026-04-08 02:07:48.043785 | instance | 2026-04-08 02:07:48.044071 | instance | TASK [Load the current Ceph OSDs configuration into a variable] **************** 2026-04-08 02:07:48.044475 | instance | Wednesday 08 April 2026 02:07:48 +0000 (0:00:00.186) 0:00:06.565 ******* 2026-04-08 02:07:48.069361 | instance | ok: [localhost] 2026-04-08 02:07:48.069610 | instance | 2026-04-08 02:07:48.069878 | instance | TASK [Generate Ceph OSDs values for missing variables] ************************* 2026-04-08 02:07:48.070147 | instance | Wednesday 08 April 2026 02:07:48 +0000 (0:00:00.026) 0:00:06.591 ******* 2026-04-08 02:07:48.102759 | instance | ok: [localhost] => (item={'key': 'ceph_osd_devices', 'value': ['/dev/vdb', '/dev/vdc', '/dev/vdd']}) 2026-04-08 02:07:48.102991 | instance | 2026-04-08 02:07:48.103264 | instance | TASK [Write new Ceph OSDs configuration file to disk] ************************** 2026-04-08 02:07:48.103531 | instance | Wednesday 08 April 2026 02:07:48 +0000 (0:00:00.033) 0:00:06.625 ******* 2026-04-08 02:07:48.484114 | instance | changed: [localhost] 2026-04-08 02:07:48.484474 | instance | 2026-04-08 02:07:48.484771 | instance | PLAY [Generate Kubernetes configuration for workspace] ************************* 2026-04-08 02:07:48.485014 | instance | 2026-04-08 02:07:48.485283 | instance | TASK [Ensure the Kubernetes configuration file exists] ************************* 2026-04-08 02:07:48.485729 | instance | Wednesday 08 April 2026 02:07:48 +0000 (0:00:00.381) 0:00:07.006 ******* 2026-04-08 02:07:48.680138 | instance | changed: [localhost] 2026-04-08 02:07:48.680361 | instance | 2026-04-08 02:07:48.680643 | instance | TASK [Load the current Kubernetes configuration into a variable] *************** 2026-04-08 02:07:48.680916 | instance | Wednesday 08 April 2026 02:07:48 +0000 (0:00:00.195) 0:00:07.201 ******* 2026-04-08 02:07:48.704124 | instance | ok: [localhost] 2026-04-08 02:07:48.704376 | instance | 2026-04-08 02:07:48.704835 | instance | TASK [Generate Kubernetes values for missing variables] ************************ 2026-04-08 02:07:48.705130 | instance | Wednesday 08 April 2026 02:07:48 +0000 (0:00:00.024) 0:00:07.226 ******* 2026-04-08 02:07:48.747401 | instance | ok: [localhost] => (item={'key': 'kubernetes_hostname', 'value': '10.96.240.10'}) 2026-04-08 02:07:48.747694 | instance | ok: [localhost] => (item={'key': 'kubernetes_keepalived_vrid', 'value': 42}) 2026-04-08 02:07:48.747997 | instance | ok: [localhost] => (item={'key': 'kubernetes_keepalived_vip', 'value': '10.96.240.10'}) 2026-04-08 02:07:48.748269 | instance | 2026-04-08 02:07:48.748560 | instance | TASK [Write new Kubernetes configuration file to disk] ************************* 2026-04-08 02:07:48.748854 | instance | Wednesday 08 April 2026 02:07:48 +0000 (0:00:00.042) 0:00:07.269 ******* 2026-04-08 02:07:49.109006 | instance | changed: [localhost] 2026-04-08 02:07:49.109124 | instance | 2026-04-08 02:07:49.109365 | instance | PLAY [Generate Keepalived configuration for workspace] ************************* 2026-04-08 02:07:49.109485 | instance | 2026-04-08 02:07:49.109695 | instance | TASK [Ensure the Keeaplived configuration file exists] ************************* 2026-04-08 02:07:49.109867 | instance | Wednesday 08 April 2026 02:07:49 +0000 (0:00:00.362) 0:00:07.631 ******* 2026-04-08 02:07:49.294055 | instance | changed: [localhost] 2026-04-08 02:07:49.294251 | instance | 2026-04-08 02:07:49.294553 | instance | TASK [Load the current Keepalived configuration into a variable] *************** 2026-04-08 02:07:49.294810 | instance | Wednesday 08 April 2026 02:07:49 +0000 (0:00:00.184) 0:00:07.816 ******* 2026-04-08 02:07:49.316560 | instance | ok: [localhost] 2026-04-08 02:07:49.316782 | instance | 2026-04-08 02:07:49.317050 | instance | TASK [Generate Keepalived values for missing variables] ************************ 2026-04-08 02:07:49.317350 | instance | Wednesday 08 April 2026 02:07:49 +0000 (0:00:00.022) 0:00:07.839 ******* 2026-04-08 02:07:49.353138 | instance | ok: [localhost] => (item={'key': 'keepalived_interface', 'value': 'br-ex'}) 2026-04-08 02:07:49.353425 | instance | ok: [localhost] => (item={'key': 'keepalived_vip', 'value': '10.96.250.10'}) 2026-04-08 02:07:49.353648 | instance | 2026-04-08 02:07:49.353904 | instance | TASK [Write new Keepalived configuration file to disk] ************************* 2026-04-08 02:07:49.354163 | instance | Wednesday 08 April 2026 02:07:49 +0000 (0:00:00.036) 0:00:07.875 ******* 2026-04-08 02:07:49.709071 | instance | changed: [localhost] 2026-04-08 02:07:49.709284 | instance | 2026-04-08 02:07:49.709581 | instance | PLAY [Generate endpoints for workspace] **************************************** 2026-04-08 02:07:49.709828 | instance | 2026-04-08 02:07:49.710118 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-08 02:07:49.710454 | instance | Wednesday 08 April 2026 02:07:49 +0000 (0:00:00.356) 0:00:08.231 ******* 2026-04-08 02:07:50.396076 | instance | ok: [localhost] 2026-04-08 02:07:50.396307 | instance | 2026-04-08 02:07:50.396592 | instance | TASK [Ensure the endpoints file exists] **************************************** 2026-04-08 02:07:50.396872 | instance | Wednesday 08 April 2026 02:07:50 +0000 (0:00:00.686) 0:00:08.918 ******* 2026-04-08 02:07:50.593810 | instance | changed: [localhost] 2026-04-08 02:07:50.594055 | instance | 2026-04-08 02:07:50.594328 | instance | TASK [Load the current endpoints into a variable] ****************************** 2026-04-08 02:07:50.594598 | instance | Wednesday 08 April 2026 02:07:50 +0000 (0:00:00.197) 0:00:09.116 ******* 2026-04-08 02:07:50.625203 | instance | ok: [localhost] 2026-04-08 02:07:50.625540 | instance | 2026-04-08 02:07:50.625827 | instance | TASK [Generate endpoint skeleton for missing variables] ************************ 2026-04-08 02:07:50.626117 | instance | Wednesday 08 April 2026 02:07:50 +0000 (0:00:00.031) 0:00:09.147 ******* 2026-04-08 02:07:51.433038 | instance | ok: [localhost] => (item=keycloak_host) 2026-04-08 02:07:51.433221 | instance | ok: [localhost] => (item=kube_prometheus_stack_grafana_host) 2026-04-08 02:07:51.433520 | instance | ok: [localhost] => (item=kube_prometheus_stack_alertmanager_host) 2026-04-08 02:07:51.433819 | instance | ok: [localhost] => (item=kube_prometheus_stack_prometheus_host) 2026-04-08 02:07:51.434081 | instance | ok: [localhost] => (item=openstack_helm_endpoints_region_name) 2026-04-08 02:07:51.434341 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_api_host) 2026-04-08 02:07:51.434599 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_api_host) 2026-04-08 02:07:51.434859 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_api_host) 2026-04-08 02:07:51.435118 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_api_host) 2026-04-08 02:07:51.435412 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_api_host) 2026-04-08 02:07:51.435639 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_api_host) 2026-04-08 02:07:51.435899 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_api_host) 2026-04-08 02:07:51.436159 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_novnc_host) 2026-04-08 02:07:51.436425 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_api_host) 2026-04-08 02:07:51.436697 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_api_host) 2026-04-08 02:07:51.436941 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_api_host) 2026-04-08 02:07:51.437196 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_api_host) 2026-04-08 02:07:51.437509 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_registry_host) 2026-04-08 02:07:51.437827 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_api_host) 2026-04-08 02:07:51.438086 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_cfn_api_host) 2026-04-08 02:07:51.438344 | instance | ok: [localhost] => (item=openstack_helm_endpoints_horizon_api_host) 2026-04-08 02:07:51.438582 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rgw_host) 2026-04-08 02:07:51.438760 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_api_host) 2026-04-08 02:07:51.438927 | instance | 2026-04-08 02:07:51.439105 | instance | TASK [Write new endpoints file to disk] **************************************** 2026-04-08 02:07:51.439281 | instance | Wednesday 08 April 2026 02:07:51 +0000 (0:00:00.807) 0:00:09.955 ******* 2026-04-08 02:07:51.798015 | instance | changed: [localhost] 2026-04-08 02:07:51.798228 | instance | 2026-04-08 02:07:51.798495 | instance | TASK [Ensure the endpoints file exists] **************************************** 2026-04-08 02:07:51.798758 | instance | Wednesday 08 April 2026 02:07:51 +0000 (0:00:00.365) 0:00:10.320 ******* 2026-04-08 02:07:52.003909 | instance | changed: [localhost] 2026-04-08 02:07:52.004136 | instance | 2026-04-08 02:07:52.004402 | instance | PLAY [Generate Neutron configuration for workspace] **************************** 2026-04-08 02:07:52.004644 | instance | 2026-04-08 02:07:52.004957 | instance | TASK [Ensure the Neutron configuration file exists] **************************** 2026-04-08 02:07:52.005230 | instance | Wednesday 08 April 2026 02:07:51 +0000 (0:00:00.206) 0:00:10.526 ******* 2026-04-08 02:07:52.215291 | instance | changed: [localhost] 2026-04-08 02:07:52.215522 | instance | 2026-04-08 02:07:52.215805 | instance | TASK [Load the current Neutron configuration into a variable] ****************** 2026-04-08 02:07:52.216090 | instance | Wednesday 08 April 2026 02:07:52 +0000 (0:00:00.211) 0:00:10.737 ******* 2026-04-08 02:07:52.247497 | instance | ok: [localhost] 2026-04-08 02:07:52.247715 | instance | 2026-04-08 02:07:52.247982 | instance | TASK [Generate Neutron values for missing variables] *************************** 2026-04-08 02:07:52.248248 | instance | Wednesday 08 April 2026 02:07:52 +0000 (0:00:00.032) 0:00:10.770 ******* 2026-04-08 02:07:52.288540 | 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-04-08 02:07:52.288747 | instance | 2026-04-08 02:07:52.289047 | instance | TASK [Write new Neutron configuration file to disk] **************************** 2026-04-08 02:07:52.289339 | instance | Wednesday 08 April 2026 02:07:52 +0000 (0:00:00.040) 0:00:10.811 ******* 2026-04-08 02:07:52.656680 | instance | changed: [localhost] 2026-04-08 02:07:52.656925 | instance | 2026-04-08 02:07:52.657206 | instance | PLAY [Generate Nova configuration for workspace] ******************************* 2026-04-08 02:07:52.657502 | instance | 2026-04-08 02:07:52.657769 | instance | TASK [Ensure the Nova configuration file exists] ******************************* 2026-04-08 02:07:52.658070 | instance | Wednesday 08 April 2026 02:07:52 +0000 (0:00:00.367) 0:00:11.179 ******* 2026-04-08 02:07:52.856887 | instance | changed: [localhost] 2026-04-08 02:07:52.857120 | instance | 2026-04-08 02:07:52.857488 | instance | TASK [Load the current Nova configuration into a variable] ********************* 2026-04-08 02:07:52.857778 | instance | Wednesday 08 April 2026 02:07:52 +0000 (0:00:00.200) 0:00:11.379 ******* 2026-04-08 02:07:52.889514 | instance | ok: [localhost] 2026-04-08 02:07:52.889751 | instance | 2026-04-08 02:07:52.890021 | instance | TASK [Generate Nova values for missing variables] ****************************** 2026-04-08 02:07:52.890288 | instance | Wednesday 08 April 2026 02:07:52 +0000 (0:00:00.032) 0:00:11.411 ******* 2026-04-08 02:07:52.929790 | 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-04-08 02:07:52.930020 | instance | 2026-04-08 02:07:52.930302 | instance | TASK [Write new Nova configuration file to disk] ******************************* 2026-04-08 02:07:52.930554 | instance | Wednesday 08 April 2026 02:07:52 +0000 (0:00:00.040) 0:00:11.452 ******* 2026-04-08 02:07:53.291816 | instance | changed: [localhost] 2026-04-08 02:07:53.292054 | instance | 2026-04-08 02:07:53.292319 | instance | PLAY [Generate secrets for workspace] ****************************************** 2026-04-08 02:07:53.292568 | instance | 2026-04-08 02:07:53.292863 | instance | TASK [Ensure the secrets file exists] ****************************************** 2026-04-08 02:07:53.293120 | instance | Wednesday 08 April 2026 02:07:53 +0000 (0:00:00.361) 0:00:11.814 ******* 2026-04-08 02:07:53.490266 | instance | changed: [localhost] 2026-04-08 02:07:53.490733 | instance | 2026-04-08 02:07:53.491022 | instance | TASK [Load the current secrets into a variable] ******************************** 2026-04-08 02:07:53.491300 | instance | Wednesday 08 April 2026 02:07:53 +0000 (0:00:00.198) 0:00:12.012 ******* 2026-04-08 02:07:53.517859 | instance | ok: [localhost] 2026-04-08 02:07:53.518110 | instance | 2026-04-08 02:07:53.518380 | instance | TASK [Generate secrets for missing variables] ********************************** 2026-04-08 02:07:53.518644 | instance | Wednesday 08 April 2026 02:07:53 +0000 (0:00:00.027) 0:00:12.040 ******* 2026-04-08 02:07:53.992724 | instance | ok: [localhost] => (item=heat_auth_encryption_key) 2026-04-08 02:07:53.992766 | instance | ok: [localhost] => (item=keepalived_password) 2026-04-08 02:07:53.992772 | instance | ok: [localhost] => (item=keycloak_admin_password) 2026-04-08 02:07:53.992777 | instance | ok: [localhost] => (item=keycloak_database_password) 2026-04-08 02:07:53.992782 | instance | ok: [localhost] => (item=keystone_keycloak_client_secret) 2026-04-08 02:07:53.992786 | instance | ok: [localhost] => (item=keystone_oidc_crypto_passphrase) 2026-04-08 02:07:53.992791 | instance | ok: [localhost] => (item=kube_prometheus_stack_grafana_admin_password) 2026-04-08 02:07:53.992796 | instance | ok: [localhost] => (item=octavia_heartbeat_key) 2026-04-08 02:07:53.992800 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rabbitmq_admin_password) 2026-04-08 02:07:53.992804 | instance | ok: [localhost] => (item=openstack_helm_endpoints_memcached_secret_key) 2026-04-08 02:07:53.992808 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_admin_password) 2026-04-08 02:07:53.992812 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_mariadb_password) 2026-04-08 02:07:53.992821 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_rabbitmq_password) 2026-04-08 02:07:53.993330 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_keystone_password) 2026-04-08 02:07:53.993364 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_mariadb_password) 2026-04-08 02:07:53.993568 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_rabbitmq_password) 2026-04-08 02:07:53.994000 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_keystone_password) 2026-04-08 02:07:53.994364 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_mariadb_password) 2026-04-08 02:07:53.994696 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_rabbitmq_password) 2026-04-08 02:07:53.995013 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_keystone_password) 2026-04-08 02:07:53.995326 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_mariadb_password) 2026-04-08 02:07:53.995603 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_keystone_password) 2026-04-08 02:07:53.995813 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_mariadb_password) 2026-04-08 02:07:53.996025 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_keystone_password) 2026-04-08 02:07:53.996237 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_mariadb_password) 2026-04-08 02:07:53.996447 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_rabbitmq_password) 2026-04-08 02:07:53.996659 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_metadata_secret) 2026-04-08 02:07:53.996869 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_keystone_password) 2026-04-08 02:07:53.997079 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_mariadb_password) 2026-04-08 02:07:53.997311 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_rabbitmq_password) 2026-04-08 02:07:53.997529 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_keystone_password) 2026-04-08 02:07:53.997741 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_mariadb_password) 2026-04-08 02:07:53.997953 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_rabbitmq_password) 2026-04-08 02:07:53.998165 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_keystone_password) 2026-04-08 02:07:53.998395 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_mariadb_password) 2026-04-08 02:07:53.998609 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_rabbitmq_password) 2026-04-08 02:07:53.998829 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_keystone_password) 2026-04-08 02:07:53.999043 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_mariadb_password) 2026-04-08 02:07:53.999269 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_rabbitmq_password) 2026-04-08 02:07:53.999480 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_keystone_password) 2026-04-08 02:07:53.999844 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_mariadb_password) 2026-04-08 02:07:54.000055 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_rabbitmq_password) 2026-04-08 02:07:54.000268 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_keystone_password) 2026-04-08 02:07:54.000503 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_trustee_keystone_password) 2026-04-08 02:07:54.000724 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_stack_user_keystone_password) 2026-04-08 02:07:54.000937 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_mariadb_password) 2026-04-08 02:07:54.001148 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_rabbitmq_password) 2026-04-08 02:07:54.001384 | instance | ok: [localhost] => (item=openstack_helm_endpoints_horizon_mariadb_password) 2026-04-08 02:07:54.001599 | instance | ok: [localhost] => (item=openstack_helm_endpoints_tempest_keystone_password) 2026-04-08 02:07:54.001817 | instance | ok: [localhost] => (item=openstack_helm_endpoints_openstack_exporter_keystone_password) 2026-04-08 02:07:54.002030 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rgw_keystone_password) 2026-04-08 02:07:54.002244 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_keystone_password) 2026-04-08 02:07:54.002494 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_mariadb_password) 2026-04-08 02:07:54.002710 | instance | ok: [localhost] => (item=openstack_helm_endpoints_staffeln_mariadb_password) 2026-04-08 02:07:54.002912 | instance | 2026-04-08 02:07:54.003125 | instance | TASK [Generate base64 encoded secrets] ***************************************** 2026-04-08 02:07:54.003339 | instance | Wednesday 08 April 2026 02:07:53 +0000 (0:00:00.471) 0:00:12.512 ******* 2026-04-08 02:07:54.046131 | instance | ok: [localhost] => (item=barbican_kek) 2026-04-08 02:07:54.046506 | instance | 2026-04-08 02:07:54.046904 | instance | TASK [Generate temporary files for generating keys for missing variables] ****** 2026-04-08 02:07:54.047231 | instance | Wednesday 08 April 2026 02:07:54 +0000 (0:00:00.055) 0:00:12.568 ******* 2026-04-08 02:07:54.483474 | instance | changed: [localhost] => (item=manila_ssh_key) 2026-04-08 02:07:54.484201 | instance | changed: [localhost] => (item=nova_ssh_key) 2026-04-08 02:07:54.484266 | instance | 2026-04-08 02:07:54.484274 | instance | TASK [Generate SSH keys for missing variables] ********************************* 2026-04-08 02:07:54.484282 | instance | Wednesday 08 April 2026 02:07:54 +0000 (0:00:00.437) 0:00:13.006 ******* 2026-04-08 02:07:56.540710 | instance | changed: [localhost] => (item=manila_ssh_key) 2026-04-08 02:07:56.540771 | instance | changed: [localhost] => (item=nova_ssh_key) 2026-04-08 02:07:56.540779 | instance | 2026-04-08 02:07:56.540787 | instance | TASK [Set values for SSH keys] ************************************************* 2026-04-08 02:07:56.540794 | instance | Wednesday 08 April 2026 02:07:56 +0000 (0:00:02.056) 0:00:15.062 ******* 2026-04-08 02:07:56.593481 | instance | ok: [localhost] => (item=manila_ssh_key) 2026-04-08 02:07:56.593568 | instance | ok: [localhost] => (item=nova_ssh_key) 2026-04-08 02:07:56.593588 | instance | 2026-04-08 02:07:56.593801 | instance | TASK [Delete the temporary files generated for SSH keys] *********************** 2026-04-08 02:07:56.593849 | instance | Wednesday 08 April 2026 02:07:56 +0000 (0:00:00.053) 0:00:15.116 ******* 2026-04-08 02:07:56.961010 | instance | changed: [localhost] => (item=manila_ssh_key) 2026-04-08 02:07:56.961568 | instance | changed: [localhost] => (item=nova_ssh_key) 2026-04-08 02:07:56.961785 | instance | 2026-04-08 02:07:56.961799 | instance | TASK [Write new secrets file to disk] ****************************************** 2026-04-08 02:07:56.962006 | instance | Wednesday 08 April 2026 02:07:56 +0000 (0:00:00.367) 0:00:15.483 ******* 2026-04-08 02:07:57.308294 | instance | changed: [localhost] 2026-04-08 02:07:57.308366 | instance | 2026-04-08 02:07:57.308635 | instance | TASK [Encrypt secrets file with Vault password] ******************************** 2026-04-08 02:07:57.308674 | instance | Wednesday 08 April 2026 02:07:57 +0000 (0:00:00.347) 0:00:15.831 ******* 2026-04-08 02:07:57.354064 | instance | skipping: [localhost] 2026-04-08 02:07:57.354655 | instance | 2026-04-08 02:07:57.354695 | instance | PLAY [all] ********************************************************************* 2026-04-08 02:07:57.354701 | instance | 2026-04-08 02:07:57.354705 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-08 02:07:57.354710 | instance | Wednesday 08 April 2026 02:07:57 +0000 (0:00:00.045) 0:00:15.877 ******* 2026-04-08 02:07:58.071063 | instance | ok: [instance] 2026-04-08 02:07:58.071151 | instance | 2026-04-08 02:07:58.071425 | instance | TASK [vexxhost.atmosphere.sysctl : Configure sysctl values] ******************** 2026-04-08 02:07:58.071465 | instance | Wednesday 08 April 2026 02:07:58 +0000 (0:00:00.716) 0:00:16.593 ******* 2026-04-08 02:08:02.030307 | instance | changed: [instance] => (item={'name': 'fs.aio-max-nr', 'value': 1048576}) 2026-04-08 02:08:02.030385 | instance | changed: [instance] => (item={'name': 'net.ipv4.tcp_timestamps', 'value': 0}) 2026-04-08 02:08:02.033156 | instance | changed: [instance] => (item={'name': 'net.ipv4.tcp_sack', 'value': 1}) 2026-04-08 02:08:02.033235 | instance | changed: [instance] => (item={'name': 'net.core.netdev_budget', 'value': 1000}) 2026-04-08 02:08:02.033244 | instance | changed: [instance] => (item={'name': 'net.core.netdev_max_backlog', 'value': 250000}) 2026-04-08 02:08:02.033252 | instance | changed: [instance] => (item={'name': 'net.core.rmem_max', 'value': 4194304}) 2026-04-08 02:08:02.033258 | instance | changed: [instance] => (item={'name': 'net.core.wmem_max', 'value': 4194304}) 2026-04-08 02:08:02.033264 | instance | changed: [instance] => (item={'name': 'net.core.rmem_default', 'value': 4194304}) 2026-04-08 02:08:02.033292 | instance | changed: [instance] => (item={'name': 'net.core.wmem_default', 'value': 4194304}) 2026-04-08 02:08:02.033301 | instance | changed: [instance] => (item={'name': 'net.core.optmem_max', 'value': 4194304}) 2026-04-08 02:08:02.033308 | instance | changed: [instance] => (item={'name': 'net.ipv4.tcp_rmem', 'value': '4096 87380 4194304'}) 2026-04-08 02:08:02.033314 | instance | changed: [instance] => (item={'name': 'net.ipv4.tcp_wmem', 'value': '4096 65536 4194304'}) 2026-04-08 02:08:02.033329 | instance | changed: [instance] => (item={'name': 'net.ipv4.tcp_low_latency', 'value': 1}) 2026-04-08 02:08:02.033336 | instance | changed: [instance] => (item={'name': 'net.ipv4.tcp_adv_win_scale', 'value': 1}) 2026-04-08 02:08:02.033341 | instance | changed: [instance] => (item={'name': 'net.ipv4.neigh.default.gc_thresh1', 'value': 128}) 2026-04-08 02:08:02.033348 | instance | changed: [instance] => (item={'name': 'net.ipv4.neigh.default.gc_thresh2', 'value': 28872}) 2026-04-08 02:08:02.033353 | instance | changed: [instance] => (item={'name': 'net.ipv4.neigh.default.gc_thresh3', 'value': 32768}) 2026-04-08 02:08:02.033360 | instance | changed: [instance] => (item={'name': 'net.ipv6.neigh.default.gc_thresh1', 'value': 128}) 2026-04-08 02:08:02.033365 | instance | changed: [instance] => (item={'name': 'net.ipv6.neigh.default.gc_thresh2', 'value': 28872}) 2026-04-08 02:08:02.033371 | instance | changed: [instance] => (item={'name': 'net.ipv6.neigh.default.gc_thresh3', 'value': 32768}) 2026-04-08 02:08:02.033377 | instance | 2026-04-08 02:08:02.033385 | instance | TASK [vexxhost.atmosphere.ethtool : Create folder for persistent configuration] *** 2026-04-08 02:08:02.033391 | instance | Wednesday 08 April 2026 02:08:02 +0000 (0:00:03.959) 0:00:20.552 ******* 2026-04-08 02:08:02.237482 | instance | changed: [instance] 2026-04-08 02:08:02.237854 | instance | 2026-04-08 02:08:02.237869 | instance | TASK [vexxhost.atmosphere.ethtool : Install persistent "ethtool" tuning] ******* 2026-04-08 02:08:02.237876 | instance | Wednesday 08 April 2026 02:08:02 +0000 (0:00:00.207) 0:00:20.760 ******* 2026-04-08 02:08:02.604382 | instance | changed: [instance] 2026-04-08 02:08:02.604461 | instance | 2026-04-08 02:08:02.604858 | instance | TASK [vexxhost.atmosphere.ethtool : Run "ethtool" tuning] ********************** 2026-04-08 02:08:02.604899 | instance | Wednesday 08 April 2026 02:08:02 +0000 (0:00:00.366) 0:00:21.127 ******* 2026-04-08 02:08:02.947063 | instance | ok: [instance] 2026-04-08 02:08:02.947139 | instance | 2026-04-08 02:08:02.947145 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-04-08 02:08:02.947168 | instance | Wednesday 08 April 2026 02:08:02 +0000 (0:00:00.338) 0:00:21.465 ******* 2026-04-08 02:08:03.082341 | instance | ok: [instance] 2026-04-08 02:08:03.082434 | instance | 2026-04-08 02:08:03.082559 | instance | PLAY [Configure Kubernetes VIP] ************************************************ 2026-04-08 02:08:03.082763 | instance | 2026-04-08 02:08:03.082916 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-08 02:08:03.083068 | instance | Wednesday 08 April 2026 02:08:03 +0000 (0:00:00.139) 0:00:21.605 ******* 2026-04-08 02:08:03.788323 | instance | ok: [instance] 2026-04-08 02:08:03.788392 | instance | 2026-04-08 02:08:03.788682 | instance | TASK [vexxhost.containers.directory : Create directory (/etc/kubernetes/manifests)] *** 2026-04-08 02:08:03.788741 | instance | Wednesday 08 April 2026 02:08:03 +0000 (0:00:00.705) 0:00:22.310 ******* 2026-04-08 02:08:04.012531 | instance | changed: [instance] 2026-04-08 02:08:04.012944 | instance | 2026-04-08 02:08:04.014666 | instance | TASK [vexxhost.kubernetes.kube_vip : Uninstall legacy HA stack] **************** 2026-04-08 02:08:04.014676 | instance | Wednesday 08 April 2026 02:08:04 +0000 (0:00:00.224) 0:00:22.535 ******* 2026-04-08 02:08:04.963557 | instance | ok: [instance] => (item=/etc/keepalived/keepalived.conf) 2026-04-08 02:08:04.963664 | instance | ok: [instance] => (item=/etc/keepalived/check_apiserver.sh) 2026-04-08 02:08:04.964469 | instance | ok: [instance] => (item=/etc/kubernetes/manifests/keepalived.yaml) 2026-04-08 02:08:04.964515 | instance | ok: [instance] => (item=/etc/haproxy/haproxy.cfg) 2026-04-08 02:08:04.964520 | instance | ok: [instance] => (item=/etc/kubernetes/manifests/haproxy.yaml) 2026-04-08 02:08:04.964526 | instance | 2026-04-08 02:08:04.964531 | instance | TASK [vexxhost.kubernetes.kube_vip : Switch API server to run on port 6443] **** 2026-04-08 02:08:04.964536 | instance | Wednesday 08 April 2026 02:08:04 +0000 (0:00:00.951) 0:00:23.486 ******* 2026-04-08 02:08:05.233021 | instance | failed: [instance] (item=/etc/kubernetes/manifests/kube-apiserver.yaml) => {"ansible_loop_var": "item", "changed": false, "item": "/etc/kubernetes/manifests/kube-apiserver.yaml", "msg": "Path /etc/kubernetes/manifests/kube-apiserver.yaml does not exist !", "rc": 257} 2026-04-08 02:08:05.415944 | instance | failed: [instance] (item=/etc/kubernetes/controller-manager.conf) => {"ansible_loop_var": "item", "changed": false, "item": "/etc/kubernetes/controller-manager.conf", "msg": "Path /etc/kubernetes/controller-manager.conf does not exist !", "rc": 257} 2026-04-08 02:08:05.590412 | instance | failed: [instance] (item=/etc/kubernetes/scheduler.conf) => {"ansible_loop_var": "item", "changed": false, "item": "/etc/kubernetes/scheduler.conf", "msg": "Path /etc/kubernetes/scheduler.conf does not exist !", "rc": 257} 2026-04-08 02:08:05.599743 | instance | ...ignoring 2026-04-08 02:08:05.599913 | instance | 2026-04-08 02:08:05.600329 | instance | TASK [vexxhost.kubernetes.kube_vip : Check if super-admin.conf exists] ********* 2026-04-08 02:08:05.600385 | instance | Wednesday 08 April 2026 02:08:05 +0000 (0:00:00.636) 0:00:24.122 ******* 2026-04-08 02:08:05.798396 | instance | ok: [instance] 2026-04-08 02:08:05.798965 | instance | 2026-04-08 02:08:05.799027 | instance | TASK [vexxhost.kubernetes.kube_vip : Check if kubeadm has already run] ********* 2026-04-08 02:08:05.799044 | instance | Wednesday 08 April 2026 02:08:05 +0000 (0:00:00.198) 0:00:24.320 ******* 2026-04-08 02:08:05.998396 | instance | ok: [instance] 2026-04-08 02:08:05.998942 | instance | 2026-04-08 02:08:05.998982 | instance | TASK [vexxhost.kubernetes.kube_vip : Set fact with KUBECONFIG path] ************ 2026-04-08 02:08:05.998991 | instance | Wednesday 08 April 2026 02:08:05 +0000 (0:00:00.200) 0:00:24.521 ******* 2026-04-08 02:08:06.026812 | instance | ok: [instance] 2026-04-08 02:08:06.027420 | instance | 2026-04-08 02:08:06.027466 | instance | TASK [vexxhost.kubernetes.kube_vip : Set fact with KUBECONFIG path (with super-admin.conf)] *** 2026-04-08 02:08:06.027475 | instance | Wednesday 08 April 2026 02:08:06 +0000 (0:00:00.028) 0:00:24.549 ******* 2026-04-08 02:08:06.065077 | instance | ok: [instance] 2026-04-08 02:08:06.065415 | instance | 2026-04-08 02:08:06.065484 | instance | TASK [vexxhost.kubernetes.kube_vip : Upload Kubernetes manifest] *************** 2026-04-08 02:08:06.065502 | instance | Wednesday 08 April 2026 02:08:06 +0000 (0:00:00.038) 0:00:24.587 ******* 2026-04-08 02:08:06.224579 | instance | An exception occurred during task execution. To see the full traceback, use -vvv. The error was: ansible.errors.AnsibleUndefinedVariable: {{ keepalived_vip | default(kubernetes_keepalived_vip) }}: 'kubernetes_keepalived_vip' is undefined 2026-04-08 02:08:06.225391 | instance | fatal: [instance]: FAILED! => {"changed": false, "msg": "AnsibleUndefinedVariable: {{ keepalived_vip | default(kubernetes_keepalived_vip) }}: 'kubernetes_keepalived_vip' is undefined"} 2026-04-08 02:08:06.228122 | instance | 2026-04-08 02:08:06.228417 | instance | PLAY RECAP ********************************************************************* 2026-04-08 02:08:06.229356 | instance | instance : ok=19 changed=6 unreachable=0 failed=1 skipped=0 rescued=0 ignored=1 2026-04-08 02:08:06.229405 | instance | localhost : ok=40 changed=21 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-04-08 02:08:06.229419 | instance | 2026-04-08 02:08:06.233245 | instance | Wednesday 08 April 2026 02:08:06 +0000 (0:00:00.163) 0:00:24.751 ******* 2026-04-08 02:08:06.233320 | instance | =============================================================================== 2026-04-08 02:08:06.233327 | instance | vexxhost.atmosphere.sysctl : Configure sysctl values -------------------- 3.96s 2026-04-08 02:08:06.233333 | instance | Generate SSH keys for missing variables --------------------------------- 2.06s 2026-04-08 02:08:06.233338 | instance | Install "dirmngr" for GPG keyserver operations -------------------------- 1.43s 2026-04-08 02:08:06.233344 | instance | Create folders for workspace -------------------------------------------- 1.15s 2026-04-08 02:08:06.233349 | instance | Purge "snapd" package --------------------------------------------------- 0.98s 2026-04-08 02:08:06.233355 | instance | Gathering Facts --------------------------------------------------------- 0.96s 2026-04-08 02:08:06.233361 | instance | vexxhost.kubernetes.kube_vip : Uninstall legacy HA stack ---------------- 0.95s 2026-04-08 02:08:06.233367 | instance | Generate endpoint skeleton for missing variables ------------------------ 0.81s 2026-04-08 02:08:06.233373 | instance | Configure short hostname ------------------------------------------------ 0.73s 2026-04-08 02:08:06.233378 | instance | Gathering Facts --------------------------------------------------------- 0.72s 2026-04-08 02:08:06.233384 | instance | Gathering Facts --------------------------------------------------------- 0.71s 2026-04-08 02:08:06.233389 | instance | Gathering Facts --------------------------------------------------------- 0.69s 2026-04-08 02:08:06.233394 | instance | vexxhost.kubernetes.kube_vip : Switch API server to run on port 6443 ---- 0.64s 2026-04-08 02:08:06.233400 | instance | Write new Ceph control plane configuration file to disk ----------------- 0.52s 2026-04-08 02:08:06.233405 | instance | Generate secrets for missing variables ---------------------------------- 0.47s 2026-04-08 02:08:06.233411 | instance | Generate temporary files for generating keys for missing variables ------ 0.44s 2026-04-08 02:08:06.233416 | instance | Write new Ceph OSDs configuration file to disk -------------------------- 0.38s 2026-04-08 02:08:06.233422 | instance | Write new Neutron configuration file to disk ---------------------------- 0.37s 2026-04-08 02:08:06.233427 | instance | Delete the temporary files generated for SSH keys ----------------------- 0.37s 2026-04-08 02:08:06.233433 | instance | vexxhost.atmosphere.ethtool : Install persistent "ethtool" tuning ------- 0.37s 2026-04-08 02:08:06.320633 | instance | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.keycloak/inventory --skip-tags molecule-notest,notest --inventory=src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/keycloak/prepare.yml 2026-04-08 02:08:06.320907 | instance | ERROR [keycloak > prepare] Executed: Failed 2026-04-08 02:08:06.321047 | instance | ERROR Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.keycloak/inventory --skip-tags molecule-notest,notest --inventory=src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/keycloak/prepare.yml 2026-04-08 02:08:06.469048 | instance | ERROR 2026-04-08 02:08:06.469284 | instance | { 2026-04-08 02:08:06.469315 | instance | "delta": "0:01:16.740101", 2026-04-08 02:08:06.469355 | instance | "end": "2026-04-08 02:08:06.410264", 2026-04-08 02:08:06.469375 | instance | "msg": "non-zero return code", 2026-04-08 02:08:06.469393 | instance | "rc": 2, 2026-04-08 02:08:06.469415 | instance | "start": "2026-04-08 02:06:49.670163" 2026-04-08 02:08:06.469434 | instance | } failure 2026-04-08 02:08:06.474380 | 2026-04-08 02:08:06.474430 | PLAY RECAP 2026-04-08 02:08:06.474483 | instance | ok: 2 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-04-08 02:08:06.474505 | 2026-04-08 02:08:06.581420 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-08 02:08:06.586495 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main] 2026-04-08 02:08:07.188933 | 2026-04-08 02:08:07.189261 | PLAY [all] 2026-04-08 02:08:07.203331 | 2026-04-08 02:08:07.203416 | TASK [gather-host-logs : creating directory for system status] 2026-04-08 02:08:07.572596 | instance | changed 2026-04-08 02:08:07.581125 | 2026-04-08 02:08:07.581206 | TASK [gather-host-logs : Get logs for each host] 2026-04-08 02:08:07.937529 | instance | + systemd-cgls --full --all --no-pager 2026-04-08 02:08:07.950411 | instance | + ip addr 2026-04-08 02:08:07.953068 | instance | + ip route 2026-04-08 02:08:07.955371 | instance | + lsblk 2026-04-08 02:08:07.957338 | instance | + mount 2026-04-08 02:08:07.959979 | instance | + docker images 2026-04-08 02:08:07.960436 | instance | /bin/bash: line 7: docker: command not found 2026-04-08 02:08:07.960670 | instance | + brctl show 2026-04-08 02:08:07.961078 | instance | /bin/bash: line 8: brctl: command not found 2026-04-08 02:08:07.961358 | instance | + ps aux --sort=-%mem 2026-04-08 02:08:07.971337 | instance | + dpkg -l 2026-04-08 02:08:07.982629 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-04-08 02:08:07.982947 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-04-08 02:08:07.982985 | instance | /bin/bash: line 11: docker: command not found 2026-04-08 02:08:07.983215 | instance | + '[' '!' -z '' ']' 2026-04-08 02:08:08.119388 | instance | ok: Runtime: 0:00:00.050626 2026-04-08 02:08:08.128286 | 2026-04-08 02:08:08.128379 | TASK [gather-host-logs : Downloads logs to executor] 2026-04-08 02:08:08.773349 | instance | changed: 2026-04-08 02:08:08.773566 | instance | created directory /var/lib/zuul/builds/3a1ee38dd84c44329842333eb15a0639/work/logs/instance 2026-04-08 02:08:08.773605 | instance | cd+++++++++ system/ 2026-04-08 02:08:08.773634 | instance | >f+++++++++ system/brctl-show.txt 2026-04-08 02:08:08.773662 | instance | >f+++++++++ system/docker-images.txt 2026-04-08 02:08:08.773689 | instance | >f+++++++++ system/ip-addr.txt 2026-04-08 02:08:08.773719 | instance | >f+++++++++ system/ip-route.txt 2026-04-08 02:08:08.773747 | instance | >f+++++++++ system/lsblk.txt 2026-04-08 02:08:08.773775 | instance | >f+++++++++ system/mount.txt 2026-04-08 02:08:08.773804 | instance | >f+++++++++ system/packages.txt 2026-04-08 02:08:08.773832 | instance | >f+++++++++ system/ps.txt 2026-04-08 02:08:08.773858 | instance | >f+++++++++ system/systemd-cgls.txt 2026-04-08 02:08:08.785335 | 2026-04-08 02:08:08.785400 | LOOP [helm-release-status : creating directory for helm release status] 2026-04-08 02:08:08.980334 | instance | changed: "values" 2026-04-08 02:08:09.145062 | instance | changed: "releases" 2026-04-08 02:08:09.166360 | 2026-04-08 02:08:09.166631 | TASK [helm-release-status : Gather get release status for helm charts] 2026-04-08 02:08:09.396894 | instance | /bin/bash: line 3: kubectl: command not found 2026-04-08 02:08:09.708831 | instance | ok: Runtime: 0:00:00.005073 2026-04-08 02:08:09.715398 | 2026-04-08 02:08:09.715471 | TASK [helm-release-status : Downloads logs to executor] 2026-04-08 02:08:10.226058 | instance | changed: 2026-04-08 02:08:10.226257 | instance | cd+++++++++ helm/ 2026-04-08 02:08:10.226295 | instance | cd+++++++++ helm/releases/ 2026-04-08 02:08:10.226342 | instance | cd+++++++++ helm/values/ 2026-04-08 02:08:10.237938 | 2026-04-08 02:08:10.238022 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-04-08 02:08:10.430040 | instance | changed 2026-04-08 02:08:10.434846 | 2026-04-08 02:08:10.434949 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-04-08 02:08:10.648132 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-08 02:08:10.648370 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-08 02:08:10.654556 | instance | environment: line 1: kubectl: command not found 2026-04-08 02:08:10.656200 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-08 02:08:10.657644 | instance | environment: line 1: kubectl: command not found 2026-04-08 02:08:10.659027 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-08 02:08:10.659599 | instance | environment: line 1: kubectl: command not found 2026-04-08 02:08:10.660466 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-08 02:08:10.662521 | instance | environment: line 1: kubectl: command not found 2026-04-08 02:08:10.663166 | instance | environment: line 1: kubectl: command not found 2026-04-08 02:08:10.663436 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-08 02:08:10.664040 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-08 02:08:10.970003 | instance | ok: Runtime: 0:00:00.025533 2026-04-08 02:08:10.975734 | 2026-04-08 02:08:10.975798 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-04-08 02:08:11.182429 | instance | changed 2026-04-08 02:08:11.188029 | 2026-04-08 02:08:11.188099 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-04-08 02:08:11.421696 | instance | environment: line 5: kubectl: command not found 2026-04-08 02:08:11.422618 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-08 02:08:11.423178 | instance | xargs: xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args valuewarning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-08 02:08:11.423206 | instance | 2026-04-08 02:08:11.751004 | instance | ok: Runtime: 0:00:00.009832 2026-04-08 02:08:11.756166 | 2026-04-08 02:08:11.756228 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-04-08 02:08:12.246741 | instance | changed: 2026-04-08 02:08:12.247044 | instance | cd+++++++++ objects/ 2026-04-08 02:08:12.247121 | instance | cd+++++++++ objects/cluster/ 2026-04-08 02:08:12.247169 | instance | cd+++++++++ objects/namespaced/ 2026-04-08 02:08:12.258202 | 2026-04-08 02:08:12.258268 | TASK [gather-pod-logs : creating directory for pod logs] 2026-04-08 02:08:12.452604 | instance | changed 2026-04-08 02:08:12.460833 | 2026-04-08 02:08:12.460920 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-04-08 02:08:12.668344 | instance | changed 2026-04-08 02:08:12.675967 | 2026-04-08 02:08:12.676040 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-04-08 02:08:12.888698 | instance | environment: line 3: kubectl: command not found 2026-04-08 02:08:13.212012 | instance | ok: Runtime: 0:00:00.008278 2026-04-08 02:08:13.217201 | 2026-04-08 02:08:13.217288 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-04-08 02:08:13.696016 | instance | changed: 2026-04-08 02:08:13.696178 | instance | cd+++++++++ pod-logs/ 2026-04-08 02:08:13.696204 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-04-08 02:08:13.705323 | 2026-04-08 02:08:13.705384 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-04-08 02:08:13.910509 | instance | changed 2026-04-08 02:08:13.915954 | 2026-04-08 02:08:13.916016 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-04-08 02:08:14.135613 | instance | /bin/bash: line 2: kubectl: command not found 2026-04-08 02:08:14.452576 | instance | ok: Runtime: 0:00:00.034392 2026-04-08 02:08:14.461353 | 2026-04-08 02:08:14.461435 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-04-08 02:08:14.668885 | instance | /bin/bash: line 2: kubectl: command not found 2026-04-08 02:08:14.695868 | instance | ceph-mgr endpoints: 2026-04-08 02:08:15.004166 | instance | ok: Runtime: 0:00:00.033314 2026-04-08 02:08:15.011200 | 2026-04-08 02:08:15.011289 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-04-08 02:08:15.204569 | instance | /bin/bash: line 4: kubectl: command not found 2026-04-08 02:08:15.549199 | instance | ok: Runtime: 0:00:00.035389 2026-04-08 02:08:15.557219 | 2026-04-08 02:08:15.557281 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-04-08 02:08:16.049816 | instance | changed: cd+++++++++ prometheus/ 2026-04-08 02:08:16.059242 | 2026-04-08 02:08:16.059303 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-04-08 02:08:16.265039 | instance | changed 2026-04-08 02:08:16.279743 | 2026-04-08 02:08:16.280062 | TASK [gather-selenium-data : Get selenium data] 2026-04-08 02:08:16.494542 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-04-08 02:08:16.495555 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-04-08 02:08:16.815986 | instance | ERROR 2026-04-08 02:08:16.816321 | instance | { 2026-04-08 02:08:16.816389 | instance | "delta": "0:00:00.006156", 2026-04-08 02:08:16.816436 | instance | "end": "2026-04-08 02:08:16.495856", 2026-04-08 02:08:16.816478 | instance | "msg": "non-zero return code", 2026-04-08 02:08:16.816519 | instance | "rc": 1, 2026-04-08 02:08:16.816560 | instance | "start": "2026-04-08 02:08:16.489700" 2026-04-08 02:08:16.816599 | instance | } 2026-04-08 02:08:16.816649 | instance | ERROR: Ignoring Errors 2026-04-08 02:08:16.822589 | 2026-04-08 02:08:16.822652 | TASK [gather-selenium-data : Downloads logs to executor] 2026-04-08 02:08:17.310099 | instance | changed: cd+++++++++ selenium/ 2026-04-08 02:08:17.318279 | 2026-04-08 02:08:17.318326 | PLAY RECAP 2026-04-08 02:08:17.318367 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-04-08 02:08:17.318389 | 2026-04-08 02:08:17.429277 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main] 2026-04-08 02:08:17.431864 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-08 02:08:18.041721 | 2026-04-08 02:08:18.041881 | PLAY [all] 2026-04-08 02:08:18.053600 | 2026-04-08 02:08:18.053675 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-08 02:08:18.098228 | instance | skipping: Conditional result was False 2026-04-08 02:08:18.106725 | 2026-04-08 02:08:18.106825 | TASK [fetch-output : Set log path for single node] 2026-04-08 02:08:18.149567 | instance | ok 2026-04-08 02:08:18.155790 | 2026-04-08 02:08:18.155880 | LOOP [fetch-output : Ensure local output dirs] 2026-04-08 02:08:18.548759 | instance -> localhost | ok: "/var/lib/zuul/builds/3a1ee38dd84c44329842333eb15a0639/work/logs" 2026-04-08 02:08:18.760028 | instance -> localhost | changed: "/var/lib/zuul/builds/3a1ee38dd84c44329842333eb15a0639/work/artifacts" 2026-04-08 02:08:18.983556 | instance -> localhost | changed: "/var/lib/zuul/builds/3a1ee38dd84c44329842333eb15a0639/work/docs" 2026-04-08 02:08:19.005678 | 2026-04-08 02:08:19.005866 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-08 02:08:19.651684 | instance | changed: .d..t...... ./ 2026-04-08 02:08:19.652017 | instance | changed: All items complete 2026-04-08 02:08:19.652062 | 2026-04-08 02:08:20.137301 | instance | changed: .d..t...... ./ 2026-04-08 02:08:20.593135 | instance | changed: .d..t...... ./ 2026-04-08 02:08:20.609917 | 2026-04-08 02:08:20.610038 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-08 02:08:21.026765 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.008022 2026-04-08 02:08:21.257957 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007464 2026-04-08 02:08:21.275941 | 2026-04-08 02:08:21.276072 | PLAY [all] 2026-04-08 02:08:21.283499 | 2026-04-08 02:08:21.283588 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-08 02:08:21.702364 | instance | changed 2026-04-08 02:08:21.708660 | 2026-04-08 02:08:21.708716 | PLAY RECAP 2026-04-08 02:08:21.708762 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-08 02:08:21.708783 | 2026-04-08 02:08:21.810439 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-08 02:08:21.815779 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-08 02:08:22.362654 | 2026-04-08 02:08:22.362782 | PLAY [localhost] 2026-04-08 02:08:22.373314 | 2026-04-08 02:08:22.373399 | TASK [Generate Zuul manifest] 2026-04-08 02:08:22.393723 | localhost | ok 2026-04-08 02:08:22.411048 | 2026-04-08 02:08:22.411136 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-08 02:08:22.756806 | localhost | changed 2026-04-08 02:08:22.768450 | 2026-04-08 02:08:22.768529 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-08 02:08:22.831336 | localhost | ok 2026-04-08 02:08:22.837649 | 2026-04-08 02:08:22.837717 | TASK [Upload logs] 2026-04-08 02:08:22.859516 | localhost | ok 2026-04-08 02:08:22.923938 | 2026-04-08 02:08:22.924072 | TASK [Set zuul-log-path fact] 2026-04-08 02:08:22.945349 | localhost | ok 2026-04-08 02:08:22.959768 | 2026-04-08 02:08:22.959840 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-08 02:08:22.990590 | localhost | ok 2026-04-08 02:08:23.001100 | 2026-04-08 02:08:23.001169 | TASK [upload-logs : Create log directories] 2026-04-08 02:08:23.406935 | localhost | changed 2026-04-08 02:08:23.412987 | 2026-04-08 02:08:23.413055 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-08 02:08:23.837746 | localhost -> localhost | ok: Runtime: 0:00:00.005171 2026-04-08 02:08:23.843759 | 2026-04-08 02:08:23.843839 | TASK [upload-logs : Upload logs to log server] 2026-04-08 02:08:24.348965 | localhost | Output suppressed because no_log was given 2026-04-08 02:08:24.353721 | 2026-04-08 02:08:24.353807 | LOOP [upload-logs : Compress console log and json output] 2026-04-08 02:08:24.398091 | localhost | skipping: Conditional result was False 2026-04-08 02:08:24.405111 | localhost | skipping: Conditional result was False 2026-04-08 02:08:24.418332 | 2026-04-08 02:08:24.418468 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-08 02:08:24.457409 | localhost | skipping: Conditional result was False 2026-04-08 02:08:24.457782 | 2026-04-08 02:08:24.461454 | localhost | skipping: Conditional result was False 2026-04-08 02:08:24.471125 | 2026-04-08 02:08:24.471311 | LOOP [upload-logs : Upload console log and json output]