2026-04-08 02:12:05.296664 | Job console starting 2026-04-08 02:12:05.308032 | Updating git repos 2026-04-08 02:12:05.365675 | Cloning repos into workspace 2026-04-08 02:12:07.769407 | Restoring repo states 2026-04-08 02:12:07.792472 | Merging changes 2026-04-08 02:12:08.988371 | Checking out repos 2026-04-08 02:12:09.980248 | Preparing playbooks 2026-04-08 02:12:27.733463 | Running Ansible setup 2026-04-08 02:12:33.801732 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-08 02:12:34.373320 | 2026-04-08 02:12:34.373720 | PLAY [localhost] 2026-04-08 02:12:34.390658 | 2026-04-08 02:12:34.390832 | TASK [Gathering Facts] 2026-04-08 02:12:35.387927 | localhost | ok 2026-04-08 02:12:35.395528 | 2026-04-08 02:12:35.395618 | TASK [Setup log path fact] 2026-04-08 02:12:35.417710 | localhost | ok 2026-04-08 02:12:35.453266 | 2026-04-08 02:12:35.453367 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-08 02:12:35.484401 | localhost | ok 2026-04-08 02:12:35.493256 | 2026-04-08 02:12:35.493335 | TASK [emit-job-header : Print job information] 2026-04-08 02:12:35.534543 | # Job Information 2026-04-08 02:12:35.534737 | Ansible Version: 2.16.16 2026-04-08 02:12:35.534782 | Job: atmosphere-molecule-keycloak 2026-04-08 02:12:35.534814 | Pipeline: check 2026-04-08 02:12:35.534841 | Executor: 0a8996d2b663 2026-04-08 02:12:35.534869 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3809 2026-04-08 02:12:35.534901 | Event ID: 3faa6ef0-32f0-11f1-9c46-33f09b115a2a 2026-04-08 02:12:35.538721 | 2026-04-08 02:12:35.538817 | LOOP [emit-job-header : Print node information] 2026-04-08 02:12:35.634443 | localhost | ok: 2026-04-08 02:12:35.634995 | localhost | # Node Information 2026-04-08 02:12:35.635040 | localhost | Inventory Hostname: instance 2026-04-08 02:12:35.635071 | localhost | Hostname: np0000164177 2026-04-08 02:12:35.635099 | localhost | Username: zuul 2026-04-08 02:12:35.635130 | localhost | Distro: Ubuntu 22.04 2026-04-08 02:12:35.635158 | localhost | Provider: yul1 2026-04-08 02:12:35.635185 | localhost | Region: ca-ymq-1 2026-04-08 02:12:35.635211 | localhost | Label: ubuntu-jammy 2026-04-08 02:12:35.635237 | localhost | Product Name: OpenStack Nova 2026-04-08 02:12:35.635261 | localhost | Interface IP: 199.204.45.248 2026-04-08 02:12:35.651437 | 2026-04-08 02:12:35.651524 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-08 02:12:36.195037 | localhost -> localhost | changed 2026-04-08 02:12:36.200051 | 2026-04-08 02:12:36.200122 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-08 02:12:37.023301 | localhost -> localhost | changed 2026-04-08 02:12:37.034955 | 2026-04-08 02:12:37.035011 | PLAY [all] 2026-04-08 02:12:37.042508 | 2026-04-08 02:12:37.042574 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-08 02:12:37.258150 | instance -> localhost | ok 2026-04-08 02:12:37.266535 | 2026-04-08 02:12:37.266641 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-08 02:12:37.296908 | instance | ok 2026-04-08 02:12:37.312505 | instance | included: /var/lib/zuul/builds/f22521f16fbe45b8bb1b8efc1fd01d36/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-08 02:12:37.320515 | 2026-04-08 02:12:37.320579 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-08 02:12:38.205214 | instance -> localhost | Generating public/private rsa key pair. 2026-04-08 02:12:38.205413 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/f22521f16fbe45b8bb1b8efc1fd01d36/work/f22521f16fbe45b8bb1b8efc1fd01d36_id_rsa 2026-04-08 02:12:38.205474 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/f22521f16fbe45b8bb1b8efc1fd01d36/work/f22521f16fbe45b8bb1b8efc1fd01d36_id_rsa.pub 2026-04-08 02:12:38.205525 | instance -> localhost | The key fingerprint is: 2026-04-08 02:12:38.205565 | instance -> localhost | SHA256:eAU4mi5bOIOJM1PVCxCC6pacUOriUJ0HOtoiGvJne8I zuul-build-sshkey 2026-04-08 02:12:38.205618 | instance -> localhost | The key's randomart image is: 2026-04-08 02:12:38.205656 | instance -> localhost | +---[RSA 3072]----+ 2026-04-08 02:12:38.205700 | instance -> localhost | |o oo . .. | 2026-04-08 02:12:38.205738 | instance -> localhost | |... + + . | 2026-04-08 02:12:38.205774 | instance -> localhost | |.o + * o . | 2026-04-08 02:12:38.205808 | instance -> localhost | |+ = = o. . | 2026-04-08 02:12:38.205843 | instance -> localhost | |*Bo+ .. S | 2026-04-08 02:12:38.205879 | instance -> localhost | |/B* o . | 2026-04-08 02:12:38.205919 | instance -> localhost | |OB B | 2026-04-08 02:12:38.206020 | instance -> localhost | |..o E . | 2026-04-08 02:12:38.206067 | instance -> localhost | | o.+ | 2026-04-08 02:12:38.206104 | instance -> localhost | +----[SHA256]-----+ 2026-04-08 02:12:38.206177 | instance -> localhost | ok: Runtime: 0:00:00.324341 2026-04-08 02:12:38.213470 | 2026-04-08 02:12:38.213555 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-08 02:12:38.245283 | instance | ok 2026-04-08 02:12:38.257206 | instance | included: /var/lib/zuul/builds/f22521f16fbe45b8bb1b8efc1fd01d36/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-08 02:12:38.268135 | 2026-04-08 02:12:38.268255 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-08 02:12:38.293692 | instance | skipping: Conditional result was False 2026-04-08 02:12:38.300313 | 2026-04-08 02:12:38.300447 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-08 02:12:38.723423 | instance | changed 2026-04-08 02:12:38.728405 | 2026-04-08 02:12:38.728470 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-08 02:12:38.909638 | instance | ok 2026-04-08 02:12:38.914629 | 2026-04-08 02:12:38.914785 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-08 02:12:39.349667 | instance | changed 2026-04-08 02:12:39.357422 | 2026-04-08 02:12:39.357491 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-08 02:12:39.772346 | instance | changed 2026-04-08 02:12:39.777963 | 2026-04-08 02:12:39.778025 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-08 02:12:39.801656 | instance | skipping: Conditional result was False 2026-04-08 02:12:39.812715 | 2026-04-08 02:12:39.812791 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-08 02:12:40.163370 | instance -> localhost | changed 2026-04-08 02:12:40.175360 | 2026-04-08 02:12:40.175435 | TASK [add-build-sshkey : Add back temp key] 2026-04-08 02:12:40.430369 | instance -> localhost | Identity added: /var/lib/zuul/builds/f22521f16fbe45b8bb1b8efc1fd01d36/work/f22521f16fbe45b8bb1b8efc1fd01d36_id_rsa (zuul-build-sshkey) 2026-04-08 02:12:40.430574 | instance -> localhost | ok: Runtime: 0:00:00.008579 2026-04-08 02:12:40.437211 | 2026-04-08 02:12:40.437296 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-08 02:12:40.734221 | instance | ok 2026-04-08 02:12:40.807495 | 2026-04-08 02:12:40.807607 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-08 02:12:40.831791 | instance | skipping: Conditional result was False 2026-04-08 02:12:40.847769 | 2026-04-08 02:12:40.847854 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-08 02:12:41.151825 | instance | ok 2026-04-08 02:12:41.157799 | 2026-04-08 02:12:41.157938 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-08 02:12:42.800640 | instance | Output suppressed because no_log was given 2026-04-08 02:12:42.809357 | 2026-04-08 02:12:42.809423 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-08 02:12:42.993541 | instance | ok: "logs" 2026-04-08 02:12:42.993773 | instance | ok: All items complete 2026-04-08 02:12:42.993802 | 2026-04-08 02:12:43.149060 | instance | ok: "artifacts" 2026-04-08 02:12:43.309034 | instance | ok: "docs" 2026-04-08 02:12:43.768200 | 2026-04-08 02:12:43.768327 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-08 02:12:43.950926 | instance | changed: "logs" 2026-04-08 02:12:44.107592 | instance | changed: "artifacts" 2026-04-08 02:12:44.263596 | instance | changed: "docs" 2026-04-08 02:12:44.281437 | 2026-04-08 02:12:44.281536 | PLAY RECAP 2026-04-08 02:12:44.281583 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-08 02:12:44.281611 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-08 02:12:44.281633 | 2026-04-08 02:12:44.381653 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-08 02:12:44.386121 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-08 02:12:44.942505 | 2026-04-08 02:12:44.942620 | PLAY [all] 2026-04-08 02:12:44.954346 | 2026-04-08 02:12:44.954420 | TASK [setup-uv : Extract archive] 2026-04-08 02:12:47.124225 | instance | changed 2026-04-08 02:12:47.129745 | 2026-04-08 02:12:47.129822 | TASK [setup-uv : Print version] 2026-04-08 02:12:47.459818 | instance | uv 0.8.13 2026-04-08 02:12:47.666332 | instance | ok: Runtime: 0:00:00.012825 2026-04-08 02:12:47.672476 | 2026-04-08 02:12:47.672529 | PLAY RECAP 2026-04-08 02:12:47.672580 | instance | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-08 02:12:47.672651 | 2026-04-08 02:12:47.771855 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-08 02:12:47.776862 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main] 2026-04-08 02:12:48.389098 | 2026-04-08 02:12:48.444569 | PLAY [all] 2026-04-08 02:12:48.472535 | 2026-04-08 02:12:48.472802 | TASK [Install "jq" for log collection] 2026-04-08 02:13:26.591304 | instance | changed 2026-04-08 02:13:26.594459 | 2026-04-08 02:13:26.594545 | PLAY RECAP 2026-04-08 02:13:26.594659 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-08 02:13:26.594736 | 2026-04-08 02:13:26.773439 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main] 2026-04-08 02:13:26.778209 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-08 02:13:27.328884 | 2026-04-08 02:13:27.329012 | PLAY [all] 2026-04-08 02:13:27.339897 | 2026-04-08 02:13:27.339967 | TASK [Copy inventory file for Zuul] 2026-04-08 02:13:28.141911 | instance | changed 2026-04-08 02:13:28.146832 | 2026-04-08 02:13:28.146903 | TASK [Switch "ansible_host" to private IP] 2026-04-08 02:13:28.434155 | instance | changed: 1 replacements made 2026-04-08 02:13:28.439334 | 2026-04-08 02:13:28.439397 | TASK [Run Molecule scenario] 2026-04-08 02:13:28.824713 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-04-08 02:13:28.824891 | instance | Creating virtual environment at: .venv 2026-04-08 02:13:28.853809 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-04-08 02:13:28.871923 | instance | Downloading kubernetes (1.9MiB) 2026-04-08 02:13:28.883414 | instance | Downloading openstacksdk (1.7MiB) 2026-04-08 02:13:28.884529 | instance | Downloading ansible-core (2.1MiB) 2026-04-08 02:13:28.885659 | instance | Downloading setuptools (1.1MiB) 2026-04-08 02:13:28.885942 | instance | Downloading rjsonnet (1.2MiB) 2026-04-08 02:13:28.886259 | instance | Downloading pygments (1.2MiB) 2026-04-08 02:13:28.886863 | instance | Downloading pydantic-core (2.0MiB) 2026-04-08 02:13:28.887195 | instance | Downloading netaddr (2.2MiB) 2026-04-08 02:13:28.887499 | instance | Downloading cryptography (4.2MiB) 2026-04-08 02:13:29.231066 | instance | Building pyperclip==1.9.0 2026-04-08 02:13:29.247949 | instance | Downloading rjsonnet 2026-04-08 02:13:29.351453 | instance | Downloading pydantic-core 2026-04-08 02:13:29.401683 | instance | Downloading netaddr 2026-04-08 02:13:29.418242 | instance | Downloading pygments 2026-04-08 02:13:29.428237 | instance | Downloading cryptography 2026-04-08 02:13:29.459211 | instance | Downloading setuptools 2026-04-08 02:13:29.514970 | instance | Downloading kubernetes 2026-04-08 02:13:29.544261 | instance | Downloading ansible-core 2026-04-08 02:13:29.577340 | instance | Downloading openstacksdk 2026-04-08 02:13:29.984723 | instance | Built pyperclip==1.9.0 2026-04-08 02:13:30.105996 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-04-08 02:13:30.158084 | instance | Installed 83 packages in 49ms 2026-04-08 02:13:30.760740 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-04-08 02:13:31.376053 | instance | INFO [keycloak > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-04-08 02:13:31.376128 | instance | INFO [keycloak > prerun] Performing prerun with role_name_check=0... 2026-04-08 02:14:13.415860 | instance | INFO [keycloak > dependency] Executing 2026-04-08 02:14:13.416038 | instance | WARNING [keycloak > dependency] Missing roles requirements file: requirements.yml 2026-04-08 02:14:13.416240 | instance | WARNING [keycloak > dependency] Missing collections requirements file: collections.yml 2026-04-08 02:14:13.416359 | instance | WARNING [keycloak > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-04-08 02:14:13.425975 | instance | INFO [keycloak > cleanup] Executing 2026-04-08 02:14:13.426280 | instance | WARNING [keycloak > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-08 02:14:13.435900 | instance | INFO [keycloak > destroy] Executing 2026-04-08 02:14:13.435972 | instance | WARNING [keycloak > destroy] Skipping, '--destroy=never' requested. 2026-04-08 02:14:13.436045 | instance | INFO [keycloak > destroy] Executed: Successful 2026-04-08 02:14:13.445492 | instance | INFO [keycloak > syntax] Executing 2026-04-08 02:14:14.071647 | instance | [WARNING]: Unable to parse /home/zuul/src/github.com/vexxhost/atmosphere/molecu 2026-04-08 02:14:14.071924 | instance | le/keycloak/src/github.com/vexxhost/atmosphere/inventory.yaml as an inventory 2026-04-08 02:14:14.072189 | instance | source 2026-04-08 02:14:14.567530 | instance | 2026-04-08 02:14:14.567832 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/keycloak/converge.yml 2026-04-08 02:14:14.634645 | instance | INFO [keycloak > syntax] Executed: Successful 2026-04-08 02:14:14.650783 | instance | INFO [keycloak > create] Executing 2026-04-08 02:14:14.652660 | instance | WARNING [keycloak > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-08 02:14:14.666290 | instance | INFO [keycloak > prepare] Executing 2026-04-08 02:14:15.288107 | instance | [WARNING]: Unable to parse /home/zuul/src/github.com/vexxhost/atmosphere/molecu 2026-04-08 02:14:15.288390 | instance | le/keycloak/src/github.com/vexxhost/atmosphere/inventory.yaml as an inventory 2026-04-08 02:14:15.288654 | instance | source 2026-04-08 02:14:15.855153 | instance | 2026-04-08 02:14:15.855318 | instance | PLAY [Prepare] ***************************************************************** 2026-04-08 02:14:15.855496 | instance | 2026-04-08 02:14:15.855666 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-08 02:14:15.855837 | instance | Wednesday 08 April 2026 02:14:15 +0000 (0:00:00.025) 0:00:00.025 ******* 2026-04-08 02:14:16.847620 | instance | ok: [instance] 2026-04-08 02:14:16.847921 | instance | 2026-04-08 02:14:16.848236 | instance | TASK [Configure short hostname] ************************************************ 2026-04-08 02:14:16.848545 | instance | Wednesday 08 April 2026 02:14:16 +0000 (0:00:00.992) 0:00:01.018 ******* 2026-04-08 02:14:17.544500 | instance | changed: [instance] 2026-04-08 02:14:17.544760 | instance | 2026-04-08 02:14:17.545044 | instance | TASK [Ensure hostname inside hosts file] *************************************** 2026-04-08 02:14:17.545364 | instance | Wednesday 08 April 2026 02:14:17 +0000 (0:00:00.696) 0:00:01.715 ******* 2026-04-08 02:14:17.853164 | instance | changed: [instance] 2026-04-08 02:14:17.853335 | instance | 2026-04-08 02:14:17.853519 | instance | TASK [Install "dirmngr" for GPG keyserver operations] ************************** 2026-04-08 02:14:17.853694 | instance | Wednesday 08 April 2026 02:14:17 +0000 (0:00:00.308) 0:00:02.023 ******* 2026-04-08 02:14:19.284681 | instance | ok: [instance] 2026-04-08 02:14:19.284892 | instance | 2026-04-08 02:14:19.285166 | instance | TASK [Purge "snapd" package] *************************************************** 2026-04-08 02:14:19.285445 | instance | Wednesday 08 April 2026 02:14:19 +0000 (0:00:01.431) 0:00:03.455 ******* 2026-04-08 02:14:20.245682 | instance | ok: [instance] 2026-04-08 02:14:20.245890 | instance | 2026-04-08 02:14:20.246163 | instance | PLAY [Generate workspace for Atmosphere] *************************************** 2026-04-08 02:14:20.246442 | instance | 2026-04-08 02:14:20.246763 | instance | TASK [Create folders for workspace] ******************************************** 2026-04-08 02:14:20.247047 | instance | Wednesday 08 April 2026 02:14:20 +0000 (0:00:00.961) 0:00:04.416 ******* 2026-04-08 02:14:21.433251 | instance | changed: [localhost] => (item=group_vars) 2026-04-08 02:14:21.433518 | instance | changed: [localhost] => (item=group_vars/all) 2026-04-08 02:14:21.433806 | instance | changed: [localhost] => (item=group_vars/controllers) 2026-04-08 02:14:21.434091 | instance | changed: [localhost] => (item=group_vars/cephs) 2026-04-08 02:14:21.434375 | instance | changed: [localhost] => (item=group_vars/computes) 2026-04-08 02:14:21.434659 | instance | changed: [localhost] => (item=host_vars) 2026-04-08 02:14:21.434927 | instance | 2026-04-08 02:14:21.435260 | instance | PLAY [Generate Ceph control plane configuration for workspace] ***************** 2026-04-08 02:14:21.435566 | instance | 2026-04-08 02:14:21.435863 | instance | TASK [Ensure the Ceph control plane configuration file exists] ***************** 2026-04-08 02:14:21.436157 | instance | Wednesday 08 April 2026 02:14:21 +0000 (0:00:01.187) 0:00:05.603 ******* 2026-04-08 02:14:21.628124 | instance | changed: [localhost] 2026-04-08 02:14:21.628357 | instance | 2026-04-08 02:14:21.628628 | instance | TASK [Load the current Ceph control plane configuration into a variable] ******* 2026-04-08 02:14:21.628927 | instance | Wednesday 08 April 2026 02:14:21 +0000 (0:00:00.194) 0:00:05.798 ******* 2026-04-08 02:14:21.652347 | instance | ok: [localhost] 2026-04-08 02:14:21.652629 | instance | 2026-04-08 02:14:21.652913 | instance | TASK [Generate Ceph control plane values for missing variables] **************** 2026-04-08 02:14:21.653187 | instance | Wednesday 08 April 2026 02:14:21 +0000 (0:00:00.024) 0:00:05.822 ******* 2026-04-08 02:14:21.700083 | instance | ok: [localhost] => (item={'key': 'ceph_fsid', 'value': 'ce6031ca-f90f-5b76-9458-39cf5c9efde4'}) 2026-04-08 02:14:21.700317 | instance | ok: [localhost] => (item={'key': 'ceph_mon_public_network', 'value': '10.96.240.0/24'}) 2026-04-08 02:14:21.700570 | instance | 2026-04-08 02:14:21.700841 | instance | TASK [Write new Ceph control plane configuration file to disk] ***************** 2026-04-08 02:14:21.701110 | instance | Wednesday 08 April 2026 02:14:21 +0000 (0:00:00.047) 0:00:05.870 ******* 2026-04-08 02:14:22.227974 | instance | changed: [localhost] 2026-04-08 02:14:22.228213 | instance | 2026-04-08 02:14:22.228554 | instance | PLAY [Generate Ceph OSD configuration for workspace] *************************** 2026-04-08 02:14:22.228829 | instance | 2026-04-08 02:14:22.229125 | instance | TASK [Ensure the Ceph OSDs configuration file exists] ************************** 2026-04-08 02:14:22.229376 | instance | Wednesday 08 April 2026 02:14:22 +0000 (0:00:00.528) 0:00:06.398 ******* 2026-04-08 02:14:22.428499 | instance | changed: [localhost] 2026-04-08 02:14:22.428711 | instance | 2026-04-08 02:14:22.428989 | instance | TASK [Load the current Ceph OSDs configuration into a variable] **************** 2026-04-08 02:14:22.429271 | instance | Wednesday 08 April 2026 02:14:22 +0000 (0:00:00.200) 0:00:06.598 ******* 2026-04-08 02:14:22.454574 | instance | ok: [localhost] 2026-04-08 02:14:22.454813 | instance | 2026-04-08 02:14:22.455088 | instance | TASK [Generate Ceph OSDs values for missing variables] ************************* 2026-04-08 02:14:22.455369 | instance | Wednesday 08 April 2026 02:14:22 +0000 (0:00:00.026) 0:00:06.625 ******* 2026-04-08 02:14:22.486269 | instance | ok: [localhost] => (item={'key': 'ceph_osd_devices', 'value': ['/dev/vdb', '/dev/vdc', '/dev/vdd']}) 2026-04-08 02:14:22.486502 | instance | 2026-04-08 02:14:22.486817 | instance | TASK [Write new Ceph OSDs configuration file to disk] ************************** 2026-04-08 02:14:22.487167 | instance | Wednesday 08 April 2026 02:14:22 +0000 (0:00:00.031) 0:00:06.656 ******* 2026-04-08 02:14:22.830772 | instance | changed: [localhost] 2026-04-08 02:14:22.831024 | instance | 2026-04-08 02:14:22.831301 | instance | PLAY [Generate Kubernetes configuration for workspace] ************************* 2026-04-08 02:14:22.831590 | instance | 2026-04-08 02:14:22.831859 | instance | TASK [Ensure the Kubernetes configuration file exists] ************************* 2026-04-08 02:14:22.832159 | instance | Wednesday 08 April 2026 02:14:22 +0000 (0:00:00.344) 0:00:07.001 ******* 2026-04-08 02:14:23.018207 | instance | changed: [localhost] 2026-04-08 02:14:23.018474 | instance | 2026-04-08 02:14:23.018755 | instance | TASK [Load the current Kubernetes configuration into a variable] *************** 2026-04-08 02:14:23.019036 | instance | Wednesday 08 April 2026 02:14:23 +0000 (0:00:00.187) 0:00:07.188 ******* 2026-04-08 02:14:23.043418 | instance | ok: [localhost] 2026-04-08 02:14:23.043664 | instance | 2026-04-08 02:14:23.043933 | instance | TASK [Generate Kubernetes values for missing variables] ************************ 2026-04-08 02:14:23.044232 | instance | Wednesday 08 April 2026 02:14:23 +0000 (0:00:00.025) 0:00:07.214 ******* 2026-04-08 02:14:23.085562 | instance | ok: [localhost] => (item={'key': 'kubernetes_hostname', 'value': '10.96.240.10'}) 2026-04-08 02:14:23.085821 | instance | ok: [localhost] => (item={'key': 'kubernetes_keepalived_vrid', 'value': 42}) 2026-04-08 02:14:23.086094 | instance | ok: [localhost] => (item={'key': 'kubernetes_keepalived_vip', 'value': '10.96.240.10'}) 2026-04-08 02:14:23.086341 | instance | 2026-04-08 02:14:23.086608 | instance | TASK [Write new Kubernetes configuration file to disk] ************************* 2026-04-08 02:14:23.086876 | instance | Wednesday 08 April 2026 02:14:23 +0000 (0:00:00.042) 0:00:07.256 ******* 2026-04-08 02:14:23.434800 | instance | changed: [localhost] 2026-04-08 02:14:23.435051 | instance | 2026-04-08 02:14:23.435339 | instance | PLAY [Generate Keepalived configuration for workspace] ************************* 2026-04-08 02:14:23.435703 | instance | 2026-04-08 02:14:23.435998 | instance | TASK [Ensure the Keeaplived configuration file exists] ************************* 2026-04-08 02:14:23.436307 | instance | Wednesday 08 April 2026 02:14:23 +0000 (0:00:00.348) 0:00:07.605 ******* 2026-04-08 02:14:23.618261 | instance | changed: [localhost] 2026-04-08 02:14:23.618497 | instance | 2026-04-08 02:14:23.618773 | instance | TASK [Load the current Keepalived configuration into a variable] *************** 2026-04-08 02:14:23.619043 | instance | Wednesday 08 April 2026 02:14:23 +0000 (0:00:00.183) 0:00:07.788 ******* 2026-04-08 02:14:23.643177 | instance | ok: [localhost] 2026-04-08 02:14:23.643446 | instance | 2026-04-08 02:14:23.643716 | instance | TASK [Generate Keepalived values for missing variables] ************************ 2026-04-08 02:14:23.643983 | instance | Wednesday 08 April 2026 02:14:23 +0000 (0:00:00.025) 0:00:07.813 ******* 2026-04-08 02:14:23.677960 | instance | ok: [localhost] => (item={'key': 'keepalived_interface', 'value': 'br-ex'}) 2026-04-08 02:14:23.678256 | instance | ok: [localhost] => (item={'key': 'keepalived_vip', 'value': '10.96.250.10'}) 2026-04-08 02:14:23.678501 | instance | 2026-04-08 02:14:23.678768 | instance | TASK [Write new Keepalived configuration file to disk] ************************* 2026-04-08 02:14:23.679042 | instance | Wednesday 08 April 2026 02:14:23 +0000 (0:00:00.034) 0:00:07.848 ******* 2026-04-08 02:14:24.034728 | instance | changed: [localhost] 2026-04-08 02:14:24.034977 | instance | 2026-04-08 02:14:24.035254 | instance | PLAY [Generate endpoints for workspace] **************************************** 2026-04-08 02:14:24.035539 | instance | 2026-04-08 02:14:24.035811 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-08 02:14:24.036092 | instance | Wednesday 08 April 2026 02:14:24 +0000 (0:00:00.356) 0:00:08.205 ******* 2026-04-08 02:14:24.708127 | instance | ok: [localhost] 2026-04-08 02:14:24.708384 | instance | 2026-04-08 02:14:24.708670 | instance | TASK [Ensure the endpoints file exists] **************************************** 2026-04-08 02:14:24.708953 | instance | Wednesday 08 April 2026 02:14:24 +0000 (0:00:00.673) 0:00:08.878 ******* 2026-04-08 02:14:24.904664 | instance | changed: [localhost] 2026-04-08 02:14:24.904903 | instance | 2026-04-08 02:14:24.905248 | instance | TASK [Load the current endpoints into a variable] ****************************** 2026-04-08 02:14:24.905539 | instance | Wednesday 08 April 2026 02:14:24 +0000 (0:00:00.196) 0:00:09.075 ******* 2026-04-08 02:14:24.940606 | instance | ok: [localhost] 2026-04-08 02:14:24.940789 | instance | 2026-04-08 02:14:24.941068 | instance | TASK [Generate endpoint skeleton for missing variables] ************************ 2026-04-08 02:14:24.941381 | instance | Wednesday 08 April 2026 02:14:24 +0000 (0:00:00.035) 0:00:09.110 ******* 2026-04-08 02:14:25.714786 | instance | ok: [localhost] => (item=keycloak_host) 2026-04-08 02:14:25.714839 | instance | ok: [localhost] => (item=kube_prometheus_stack_grafana_host) 2026-04-08 02:14:25.714847 | instance | ok: [localhost] => (item=kube_prometheus_stack_alertmanager_host) 2026-04-08 02:14:25.714854 | instance | ok: [localhost] => (item=kube_prometheus_stack_prometheus_host) 2026-04-08 02:14:25.714860 | instance | ok: [localhost] => (item=openstack_helm_endpoints_region_name) 2026-04-08 02:14:25.714866 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_api_host) 2026-04-08 02:14:25.714872 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_api_host) 2026-04-08 02:14:25.715427 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_api_host) 2026-04-08 02:14:25.715447 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_api_host) 2026-04-08 02:14:25.715847 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_api_host) 2026-04-08 02:14:25.716915 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_api_host) 2026-04-08 02:14:25.716922 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_api_host) 2026-04-08 02:14:25.716926 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_novnc_host) 2026-04-08 02:14:25.716931 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_api_host) 2026-04-08 02:14:25.717068 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_api_host) 2026-04-08 02:14:25.717451 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_api_host) 2026-04-08 02:14:25.717800 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_api_host) 2026-04-08 02:14:25.718132 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_registry_host) 2026-04-08 02:14:25.718457 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_api_host) 2026-04-08 02:14:25.718781 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_cfn_api_host) 2026-04-08 02:14:25.719103 | instance | ok: [localhost] => (item=openstack_helm_endpoints_horizon_api_host) 2026-04-08 02:14:25.719465 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rgw_host) 2026-04-08 02:14:25.719800 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_api_host) 2026-04-08 02:14:25.720108 | instance | 2026-04-08 02:14:25.720436 | instance | TASK [Write new endpoints file to disk] **************************************** 2026-04-08 02:14:25.720763 | instance | Wednesday 08 April 2026 02:14:25 +0000 (0:00:00.772) 0:00:09.883 ******* 2026-04-08 02:14:26.073597 | instance | changed: [localhost] 2026-04-08 02:14:26.073654 | instance | 2026-04-08 02:14:26.073665 | instance | TASK [Ensure the endpoints file exists] **************************************** 2026-04-08 02:14:26.073675 | instance | Wednesday 08 April 2026 02:14:26 +0000 (0:00:00.359) 0:00:10.243 ******* 2026-04-08 02:14:26.268829 | instance | changed: [localhost] 2026-04-08 02:14:26.268873 | instance | 2026-04-08 02:14:26.268879 | instance | PLAY [Generate Neutron configuration for workspace] **************************** 2026-04-08 02:14:26.268883 | instance | 2026-04-08 02:14:26.268888 | instance | TASK [Ensure the Neutron configuration file exists] **************************** 2026-04-08 02:14:26.268957 | instance | Wednesday 08 April 2026 02:14:26 +0000 (0:00:00.195) 0:00:10.438 ******* 2026-04-08 02:14:26.458619 | instance | changed: [localhost] 2026-04-08 02:14:26.458862 | instance | 2026-04-08 02:14:26.459132 | instance | TASK [Load the current Neutron configuration into a variable] ****************** 2026-04-08 02:14:26.459448 | instance | Wednesday 08 April 2026 02:14:26 +0000 (0:00:00.190) 0:00:10.629 ******* 2026-04-08 02:14:26.482965 | instance | ok: [localhost] 2026-04-08 02:14:26.483237 | instance | 2026-04-08 02:14:26.483555 | instance | TASK [Generate Neutron values for missing variables] *************************** 2026-04-08 02:14:26.483827 | instance | Wednesday 08 April 2026 02:14:26 +0000 (0:00:00.024) 0:00:10.654 ******* 2026-04-08 02:14:26.522109 | 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:14:26.522385 | instance | 2026-04-08 02:14:26.522676 | instance | TASK [Write new Neutron configuration file to disk] **************************** 2026-04-08 02:14:26.522962 | instance | Wednesday 08 April 2026 02:14:26 +0000 (0:00:00.038) 0:00:10.693 ******* 2026-04-08 02:14:26.873658 | instance | changed: [localhost] 2026-04-08 02:14:26.873904 | instance | 2026-04-08 02:14:26.874209 | instance | PLAY [Generate Nova configuration for workspace] ******************************* 2026-04-08 02:14:26.874463 | instance | 2026-04-08 02:14:26.874732 | instance | TASK [Ensure the Nova configuration file exists] ******************************* 2026-04-08 02:14:26.874995 | instance | Wednesday 08 April 2026 02:14:26 +0000 (0:00:00.351) 0:00:11.044 ******* 2026-04-08 02:14:27.065617 | instance | changed: [localhost] 2026-04-08 02:14:27.065866 | instance | 2026-04-08 02:14:27.066147 | instance | TASK [Load the current Nova configuration into a variable] ********************* 2026-04-08 02:14:27.066457 | instance | Wednesday 08 April 2026 02:14:27 +0000 (0:00:00.191) 0:00:11.236 ******* 2026-04-08 02:14:27.096770 | instance | ok: [localhost] 2026-04-08 02:14:27.097029 | instance | 2026-04-08 02:14:27.097305 | instance | TASK [Generate Nova values for missing variables] ****************************** 2026-04-08 02:14:27.097583 | instance | Wednesday 08 April 2026 02:14:27 +0000 (0:00:00.031) 0:00:11.267 ******* 2026-04-08 02:14:27.137296 | 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:14:27.137556 | instance | 2026-04-08 02:14:27.137835 | instance | TASK [Write new Nova configuration file to disk] ******************************* 2026-04-08 02:14:27.138110 | instance | Wednesday 08 April 2026 02:14:27 +0000 (0:00:00.040) 0:00:11.308 ******* 2026-04-08 02:14:27.517624 | instance | changed: [localhost] 2026-04-08 02:14:27.517777 | instance | 2026-04-08 02:14:27.517957 | instance | PLAY [Generate secrets for workspace] ****************************************** 2026-04-08 02:14:27.518129 | instance | 2026-04-08 02:14:27.518288 | instance | TASK [Ensure the secrets file exists] ****************************************** 2026-04-08 02:14:27.518439 | instance | Wednesday 08 April 2026 02:14:27 +0000 (0:00:00.379) 0:00:11.688 ******* 2026-04-08 02:14:27.716536 | instance | changed: [localhost] 2026-04-08 02:14:27.716887 | instance | 2026-04-08 02:14:27.717026 | instance | TASK [Load the current secrets into a variable] ******************************** 2026-04-08 02:14:27.717157 | instance | Wednesday 08 April 2026 02:14:27 +0000 (0:00:00.198) 0:00:11.887 ******* 2026-04-08 02:14:27.745584 | instance | ok: [localhost] 2026-04-08 02:14:27.745693 | instance | 2026-04-08 02:14:27.745816 | instance | TASK [Generate secrets for missing variables] ********************************** 2026-04-08 02:14:27.745940 | instance | Wednesday 08 April 2026 02:14:27 +0000 (0:00:00.029) 0:00:11.916 ******* 2026-04-08 02:14:28.198932 | instance | ok: [localhost] => (item=heat_auth_encryption_key) 2026-04-08 02:14:28.198978 | instance | ok: [localhost] => (item=keepalived_password) 2026-04-08 02:14:28.198985 | instance | ok: [localhost] => (item=keycloak_admin_password) 2026-04-08 02:14:28.198990 | instance | ok: [localhost] => (item=keycloak_database_password) 2026-04-08 02:14:28.198995 | instance | ok: [localhost] => (item=keystone_keycloak_client_secret) 2026-04-08 02:14:28.198999 | instance | ok: [localhost] => (item=keystone_oidc_crypto_passphrase) 2026-04-08 02:14:28.199004 | instance | ok: [localhost] => (item=kube_prometheus_stack_grafana_admin_password) 2026-04-08 02:14:28.199405 | instance | ok: [localhost] => (item=octavia_heartbeat_key) 2026-04-08 02:14:28.199948 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rabbitmq_admin_password) 2026-04-08 02:14:28.199957 | instance | ok: [localhost] => (item=openstack_helm_endpoints_memcached_secret_key) 2026-04-08 02:14:28.201030 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_admin_password) 2026-04-08 02:14:28.201046 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_mariadb_password) 2026-04-08 02:14:28.201052 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_rabbitmq_password) 2026-04-08 02:14:28.201057 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_keystone_password) 2026-04-08 02:14:28.201063 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_mariadb_password) 2026-04-08 02:14:28.201289 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_rabbitmq_password) 2026-04-08 02:14:28.201624 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_keystone_password) 2026-04-08 02:14:28.201946 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_mariadb_password) 2026-04-08 02:14:28.202264 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_rabbitmq_password) 2026-04-08 02:14:28.202581 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_keystone_password) 2026-04-08 02:14:28.202964 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_mariadb_password) 2026-04-08 02:14:28.203334 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_keystone_password) 2026-04-08 02:14:28.203684 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_mariadb_password) 2026-04-08 02:14:28.203992 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_keystone_password) 2026-04-08 02:14:28.204205 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_mariadb_password) 2026-04-08 02:14:28.204418 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_rabbitmq_password) 2026-04-08 02:14:28.204631 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_metadata_secret) 2026-04-08 02:14:28.204842 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_keystone_password) 2026-04-08 02:14:28.205058 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_mariadb_password) 2026-04-08 02:14:28.205272 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_rabbitmq_password) 2026-04-08 02:14:28.205483 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_keystone_password) 2026-04-08 02:14:28.205695 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_mariadb_password) 2026-04-08 02:14:28.205906 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_rabbitmq_password) 2026-04-08 02:14:28.206119 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_keystone_password) 2026-04-08 02:14:28.206330 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_mariadb_password) 2026-04-08 02:14:28.206541 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_rabbitmq_password) 2026-04-08 02:14:28.206759 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_keystone_password) 2026-04-08 02:14:28.206994 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_mariadb_password) 2026-04-08 02:14:28.207222 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_rabbitmq_password) 2026-04-08 02:14:28.207451 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_keystone_password) 2026-04-08 02:14:28.207666 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_mariadb_password) 2026-04-08 02:14:28.207879 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_rabbitmq_password) 2026-04-08 02:14:28.208120 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_keystone_password) 2026-04-08 02:14:28.208347 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_trustee_keystone_password) 2026-04-08 02:14:28.208555 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_stack_user_keystone_password) 2026-04-08 02:14:28.208759 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_mariadb_password) 2026-04-08 02:14:28.208961 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_rabbitmq_password) 2026-04-08 02:14:28.209163 | instance | ok: [localhost] => (item=openstack_helm_endpoints_horizon_mariadb_password) 2026-04-08 02:14:28.209364 | instance | ok: [localhost] => (item=openstack_helm_endpoints_tempest_keystone_password) 2026-04-08 02:14:28.209572 | instance | ok: [localhost] => (item=openstack_helm_endpoints_openstack_exporter_keystone_password) 2026-04-08 02:14:28.209776 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rgw_keystone_password) 2026-04-08 02:14:28.209976 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_keystone_password) 2026-04-08 02:14:28.210178 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_mariadb_password) 2026-04-08 02:14:28.210379 | instance | ok: [localhost] => (item=openstack_helm_endpoints_staffeln_mariadb_password) 2026-04-08 02:14:28.210569 | instance | 2026-04-08 02:14:28.210771 | instance | TASK [Generate base64 encoded secrets] ***************************************** 2026-04-08 02:14:28.211017 | instance | Wednesday 08 April 2026 02:14:28 +0000 (0:00:00.451) 0:00:12.368 ******* 2026-04-08 02:14:28.252784 | instance | ok: [localhost] => (item=barbican_kek) 2026-04-08 02:14:28.253282 | instance | 2026-04-08 02:14:28.253302 | instance | TASK [Generate temporary files for generating keys for missing variables] ****** 2026-04-08 02:14:28.253309 | instance | Wednesday 08 April 2026 02:14:28 +0000 (0:00:00.055) 0:00:12.423 ******* 2026-04-08 02:14:28.714396 | instance | changed: [localhost] => (item=manila_ssh_key) 2026-04-08 02:14:28.715085 | instance | changed: [localhost] => (item=nova_ssh_key) 2026-04-08 02:14:28.715160 | instance | 2026-04-08 02:14:28.715168 | instance | TASK [Generate SSH keys for missing variables] ********************************* 2026-04-08 02:14:28.715176 | instance | Wednesday 08 April 2026 02:14:28 +0000 (0:00:00.461) 0:00:12.885 ******* 2026-04-08 02:14:33.141965 | instance | changed: [localhost] => (item=manila_ssh_key) 2026-04-08 02:14:33.142695 | instance | changed: [localhost] => (item=nova_ssh_key) 2026-04-08 02:14:33.142742 | instance | 2026-04-08 02:14:33.142750 | instance | TASK [Set values for SSH keys] ************************************************* 2026-04-08 02:14:33.142758 | instance | Wednesday 08 April 2026 02:14:33 +0000 (0:00:04.427) 0:00:17.312 ******* 2026-04-08 02:14:33.196962 | instance | ok: [localhost] => (item=manila_ssh_key) 2026-04-08 02:14:33.197465 | instance | ok: [localhost] => (item=nova_ssh_key) 2026-04-08 02:14:33.197509 | instance | 2026-04-08 02:14:33.197515 | instance | TASK [Delete the temporary files generated for SSH keys] *********************** 2026-04-08 02:14:33.197521 | instance | Wednesday 08 April 2026 02:14:33 +0000 (0:00:00.055) 0:00:17.368 ******* 2026-04-08 02:14:33.563688 | instance | changed: [localhost] => (item=manila_ssh_key) 2026-04-08 02:14:33.563764 | instance | changed: [localhost] => (item=nova_ssh_key) 2026-04-08 02:14:33.564113 | instance | 2026-04-08 02:14:33.564151 | instance | TASK [Write new secrets file to disk] ****************************************** 2026-04-08 02:14:33.564157 | instance | Wednesday 08 April 2026 02:14:33 +0000 (0:00:00.366) 0:00:17.734 ******* 2026-04-08 02:14:33.915276 | instance | changed: [localhost] 2026-04-08 02:14:33.915361 | instance | 2026-04-08 02:14:33.915608 | instance | TASK [Encrypt secrets file with Vault password] ******************************** 2026-04-08 02:14:33.915763 | instance | Wednesday 08 April 2026 02:14:33 +0000 (0:00:00.351) 0:00:18.086 ******* 2026-04-08 02:14:33.960403 | instance | skipping: [localhost] 2026-04-08 02:14:33.960653 | instance | 2026-04-08 02:14:33.960922 | instance | PLAY [all] ********************************************************************* 2026-04-08 02:14:33.961169 | instance | 2026-04-08 02:14:33.961445 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-08 02:14:33.961735 | instance | Wednesday 08 April 2026 02:14:33 +0000 (0:00:00.045) 0:00:18.131 ******* 2026-04-08 02:14:34.676460 | instance | ok: [instance] 2026-04-08 02:14:34.676708 | instance | 2026-04-08 02:14:34.676975 | instance | TASK [vexxhost.atmosphere.sysctl : Configure sysctl values] ******************** 2026-04-08 02:14:34.677235 | instance | Wednesday 08 April 2026 02:14:34 +0000 (0:00:00.715) 0:00:18.847 ******* 2026-04-08 02:14:38.521305 | instance | changed: [instance] => (item={'name': 'fs.aio-max-nr', 'value': 1048576}) 2026-04-08 02:14:38.521359 | instance | changed: [instance] => (item={'name': 'net.ipv4.tcp_timestamps', 'value': 0}) 2026-04-08 02:14:38.521367 | instance | changed: [instance] => (item={'name': 'net.ipv4.tcp_sack', 'value': 1}) 2026-04-08 02:14:38.521371 | instance | changed: [instance] => (item={'name': 'net.core.netdev_budget', 'value': 1000}) 2026-04-08 02:14:38.521379 | instance | changed: [instance] => (item={'name': 'net.core.netdev_max_backlog', 'value': 250000}) 2026-04-08 02:14:38.522350 | instance | changed: [instance] => (item={'name': 'net.core.rmem_max', 'value': 4194304}) 2026-04-08 02:14:38.522360 | instance | changed: [instance] => (item={'name': 'net.core.wmem_max', 'value': 4194304}) 2026-04-08 02:14:38.522365 | instance | changed: [instance] => (item={'name': 'net.core.rmem_default', 'value': 4194304}) 2026-04-08 02:14:38.523491 | instance | changed: [instance] => (item={'name': 'net.core.wmem_default', 'value': 4194304}) 2026-04-08 02:14:38.523548 | instance | changed: [instance] => (item={'name': 'net.core.optmem_max', 'value': 4194304}) 2026-04-08 02:14:38.523560 | instance | changed: [instance] => (item={'name': 'net.ipv4.tcp_rmem', 'value': '4096 87380 4194304'}) 2026-04-08 02:14:38.523576 | instance | changed: [instance] => (item={'name': 'net.ipv4.tcp_wmem', 'value': '4096 65536 4194304'}) 2026-04-08 02:14:38.523808 | instance | changed: [instance] => (item={'name': 'net.ipv4.tcp_low_latency', 'value': 1}) 2026-04-08 02:14:38.524189 | instance | changed: [instance] => (item={'name': 'net.ipv4.tcp_adv_win_scale', 'value': 1}) 2026-04-08 02:14:38.524660 | instance | changed: [instance] => (item={'name': 'net.ipv4.neigh.default.gc_thresh1', 'value': 128}) 2026-04-08 02:14:38.525031 | instance | changed: [instance] => (item={'name': 'net.ipv4.neigh.default.gc_thresh2', 'value': 28872}) 2026-04-08 02:14:38.525392 | instance | changed: [instance] => (item={'name': 'net.ipv4.neigh.default.gc_thresh3', 'value': 32768}) 2026-04-08 02:14:38.525617 | instance | changed: [instance] => (item={'name': 'net.ipv6.neigh.default.gc_thresh1', 'value': 128}) 2026-04-08 02:14:38.525828 | instance | changed: [instance] => (item={'name': 'net.ipv6.neigh.default.gc_thresh2', 'value': 28872}) 2026-04-08 02:14:38.526039 | instance | changed: [instance] => (item={'name': 'net.ipv6.neigh.default.gc_thresh3', 'value': 32768}) 2026-04-08 02:14:38.526233 | instance | 2026-04-08 02:14:38.526443 | instance | TASK [vexxhost.atmosphere.ethtool : Create folder for persistent configuration] *** 2026-04-08 02:14:38.526655 | instance | Wednesday 08 April 2026 02:14:38 +0000 (0:00:03.843) 0:00:22.690 ******* 2026-04-08 02:14:38.721048 | instance | changed: [instance] 2026-04-08 02:14:38.721617 | instance | 2026-04-08 02:14:38.721671 | instance | TASK [vexxhost.atmosphere.ethtool : Install persistent "ethtool" tuning] ******* 2026-04-08 02:14:38.721679 | instance | Wednesday 08 April 2026 02:14:38 +0000 (0:00:00.200) 0:00:22.891 ******* 2026-04-08 02:14:39.079240 | instance | changed: [instance] 2026-04-08 02:14:39.079616 | instance | 2026-04-08 02:14:39.079699 | instance | TASK [vexxhost.atmosphere.ethtool : Run "ethtool" tuning] ********************** 2026-04-08 02:14:39.079852 | instance | Wednesday 08 April 2026 02:14:39 +0000 (0:00:00.358) 0:00:23.250 ******* 2026-04-08 02:14:39.398981 | instance | ok: [instance] 2026-04-08 02:14:39.399085 | instance | 2026-04-08 02:14:39.399364 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-04-08 02:14:39.399424 | instance | Wednesday 08 April 2026 02:14:39 +0000 (0:00:00.319) 0:00:23.570 ******* 2026-04-08 02:14:39.541776 | instance | ok: [instance] 2026-04-08 02:14:39.542622 | instance | 2026-04-08 02:14:39.542662 | instance | PLAY [Configure Kubernetes VIP] ************************************************ 2026-04-08 02:14:39.542670 | instance | 2026-04-08 02:14:39.542677 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-08 02:14:39.542683 | instance | Wednesday 08 April 2026 02:14:39 +0000 (0:00:00.142) 0:00:23.712 ******* 2026-04-08 02:14:40.227302 | instance | ok: [instance] 2026-04-08 02:14:40.227850 | instance | 2026-04-08 02:14:40.227890 | instance | TASK [vexxhost.containers.directory : Create directory (/etc/kubernetes/manifests)] *** 2026-04-08 02:14:40.227899 | instance | Wednesday 08 April 2026 02:14:40 +0000 (0:00:00.685) 0:00:24.398 ******* 2026-04-08 02:14:40.440715 | instance | changed: [instance] 2026-04-08 02:14:40.441611 | instance | 2026-04-08 02:14:40.441665 | instance | TASK [vexxhost.kubernetes.kube_vip : Uninstall legacy HA stack] **************** 2026-04-08 02:14:40.441677 | instance | Wednesday 08 April 2026 02:14:40 +0000 (0:00:00.212) 0:00:24.611 ******* 2026-04-08 02:14:41.376754 | instance | ok: [instance] => (item=/etc/keepalived/keepalived.conf) 2026-04-08 02:14:41.376832 | instance | ok: [instance] => (item=/etc/keepalived/check_apiserver.sh) 2026-04-08 02:14:41.377570 | instance | ok: [instance] => (item=/etc/kubernetes/manifests/keepalived.yaml) 2026-04-08 02:14:41.377601 | instance | ok: [instance] => (item=/etc/haproxy/haproxy.cfg) 2026-04-08 02:14:41.377607 | instance | ok: [instance] => (item=/etc/kubernetes/manifests/haproxy.yaml) 2026-04-08 02:14:41.377612 | instance | 2026-04-08 02:14:41.377617 | instance | TASK [vexxhost.kubernetes.kube_vip : Switch API server to run on port 6443] **** 2026-04-08 02:14:41.377621 | instance | Wednesday 08 April 2026 02:14:41 +0000 (0:00:00.936) 0:00:25.547 ******* 2026-04-08 02:14:41.634379 | 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:14:41.802090 | 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:14:41.971940 | 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:14:41.983029 | instance | ...ignoring 2026-04-08 02:14:41.983177 | instance | 2026-04-08 02:14:41.983481 | instance | TASK [vexxhost.kubernetes.kube_vip : Check if super-admin.conf exists] ********* 2026-04-08 02:14:41.983584 | instance | Wednesday 08 April 2026 02:14:41 +0000 (0:00:00.606) 0:00:26.154 ******* 2026-04-08 02:14:42.177305 | instance | ok: [instance] 2026-04-08 02:14:42.177797 | instance | 2026-04-08 02:14:42.177929 | instance | TASK [vexxhost.kubernetes.kube_vip : Check if kubeadm has already run] ********* 2026-04-08 02:14:42.177938 | instance | Wednesday 08 April 2026 02:14:42 +0000 (0:00:00.194) 0:00:26.348 ******* 2026-04-08 02:14:42.372785 | instance | ok: [instance] 2026-04-08 02:14:42.373287 | instance | 2026-04-08 02:14:42.373326 | instance | TASK [vexxhost.kubernetes.kube_vip : Set fact with KUBECONFIG path] ************ 2026-04-08 02:14:42.373333 | instance | Wednesday 08 April 2026 02:14:42 +0000 (0:00:00.195) 0:00:26.543 ******* 2026-04-08 02:14:42.402446 | instance | ok: [instance] 2026-04-08 02:14:42.403363 | instance | 2026-04-08 02:14:42.403426 | instance | TASK [vexxhost.kubernetes.kube_vip : Set fact with KUBECONFIG path (with super-admin.conf)] *** 2026-04-08 02:14:42.403439 | instance | Wednesday 08 April 2026 02:14:42 +0000 (0:00:00.029) 0:00:26.572 ******* 2026-04-08 02:14:42.438787 | instance | ok: [instance] 2026-04-08 02:14:42.439358 | instance | 2026-04-08 02:14:42.439409 | instance | TASK [vexxhost.kubernetes.kube_vip : Upload Kubernetes manifest] *************** 2026-04-08 02:14:42.439418 | instance | Wednesday 08 April 2026 02:14:42 +0000 (0:00:00.036) 0:00:26.609 ******* 2026-04-08 02:14:42.581567 | 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:14:42.582143 | instance | fatal: [instance]: FAILED! => {"changed": false, "msg": "AnsibleUndefinedVariable: {{ keepalived_vip | default(kubernetes_keepalived_vip) }}: 'kubernetes_keepalived_vip' is undefined"} 2026-04-08 02:14:42.584572 | instance | 2026-04-08 02:14:42.587460 | instance | PLAY RECAP ********************************************************************* 2026-04-08 02:14:42.587507 | instance | instance : ok=19 changed=6 unreachable=0 failed=1 skipped=0 rescued=0 ignored=1 2026-04-08 02:14:42.587519 | instance | localhost : ok=40 changed=21 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-04-08 02:14:42.587529 | instance | 2026-04-08 02:14:42.587538 | instance | Wednesday 08 April 2026 02:14:42 +0000 (0:00:00.146) 0:00:26.755 ******* 2026-04-08 02:14:42.587548 | instance | =============================================================================== 2026-04-08 02:14:42.587557 | instance | Generate SSH keys for missing variables --------------------------------- 4.43s 2026-04-08 02:14:42.587565 | instance | vexxhost.atmosphere.sysctl : Configure sysctl values -------------------- 3.84s 2026-04-08 02:14:42.587574 | instance | Install "dirmngr" for GPG keyserver operations -------------------------- 1.43s 2026-04-08 02:14:42.587583 | instance | Create folders for workspace -------------------------------------------- 1.19s 2026-04-08 02:14:42.587592 | instance | Gathering Facts --------------------------------------------------------- 0.99s 2026-04-08 02:14:42.591311 | instance | Purge "snapd" package --------------------------------------------------- 0.96s 2026-04-08 02:14:42.591344 | instance | vexxhost.kubernetes.kube_vip : Uninstall legacy HA stack ---------------- 0.94s 2026-04-08 02:14:42.591356 | instance | Generate endpoint skeleton for missing variables ------------------------ 0.77s 2026-04-08 02:14:42.591365 | instance | Gathering Facts --------------------------------------------------------- 0.72s 2026-04-08 02:14:42.591374 | instance | Configure short hostname ------------------------------------------------ 0.70s 2026-04-08 02:14:42.591407 | instance | Gathering Facts --------------------------------------------------------- 0.69s 2026-04-08 02:14:42.591418 | instance | Gathering Facts --------------------------------------------------------- 0.67s 2026-04-08 02:14:42.591427 | instance | vexxhost.kubernetes.kube_vip : Switch API server to run on port 6443 ---- 0.61s 2026-04-08 02:14:42.591436 | instance | Write new Ceph control plane configuration file to disk ----------------- 0.53s 2026-04-08 02:14:42.591445 | instance | Generate temporary files for generating keys for missing variables ------ 0.46s 2026-04-08 02:14:42.591453 | instance | Generate secrets for missing variables ---------------------------------- 0.45s 2026-04-08 02:14:42.591462 | instance | Write new Nova configuration file to disk ------------------------------- 0.38s 2026-04-08 02:14:42.591471 | instance | Delete the temporary files generated for SSH keys ----------------------- 0.37s 2026-04-08 02:14:42.591480 | instance | Write new endpoints file to disk ---------------------------------------- 0.36s 2026-04-08 02:14:42.591489 | instance | vexxhost.atmosphere.ethtool : Install persistent "ethtool" tuning ------- 0.36s 2026-04-08 02:14:42.672300 | 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:14:42.672595 | instance | ERROR [keycloak > prepare] Executed: Failed 2026-04-08 02:14:42.672788 | 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:14:43.194536 | instance | ERROR 2026-04-08 02:14:43.194731 | instance | { 2026-04-08 02:14:43.194773 | instance | "delta": "0:01:13.997375", 2026-04-08 02:14:43.194815 | instance | "end": "2026-04-08 02:14:42.756458", 2026-04-08 02:14:43.194844 | instance | "msg": "non-zero return code", 2026-04-08 02:14:43.194869 | instance | "rc": 2, 2026-04-08 02:14:43.194899 | instance | "start": "2026-04-08 02:13:28.759083" 2026-04-08 02:14:43.194924 | instance | } failure 2026-04-08 02:14:43.201384 | 2026-04-08 02:14:43.201436 | PLAY RECAP 2026-04-08 02:14:43.201479 | instance | ok: 2 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-04-08 02:14:43.201501 | 2026-04-08 02:14:43.301635 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-08 02:14:43.303881 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main] 2026-04-08 02:14:43.860691 | 2026-04-08 02:14:43.860799 | PLAY [all] 2026-04-08 02:14:43.873916 | 2026-04-08 02:14:43.873997 | TASK [gather-host-logs : creating directory for system status] 2026-04-08 02:14:44.201338 | instance | changed 2026-04-08 02:14:44.206475 | 2026-04-08 02:14:44.206552 | TASK [gather-host-logs : Get logs for each host] 2026-04-08 02:14:44.527483 | instance | + systemd-cgls --full --all --no-pager 2026-04-08 02:14:44.538371 | instance | + ip addr 2026-04-08 02:14:44.539754 | instance | + ip route 2026-04-08 02:14:44.541023 | instance | + lsblk 2026-04-08 02:14:44.543368 | instance | + mount 2026-04-08 02:14:44.544879 | instance | + docker images 2026-04-08 02:14:44.545270 | instance | /bin/bash: line 7: docker: command not found 2026-04-08 02:14:44.545384 | instance | + brctl show 2026-04-08 02:14:44.545767 | instance | /bin/bash: line 8: brctl: command not found 2026-04-08 02:14:44.545956 | instance | + ps aux --sort=-%mem 2026-04-08 02:14:44.555335 | instance | + dpkg -l 2026-04-08 02:14:44.564938 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-04-08 02:14:44.565308 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-04-08 02:14:44.565400 | instance | /bin/bash: line 11: docker: command not found 2026-04-08 02:14:44.565655 | instance | + '[' '!' -z '' ']' 2026-04-08 02:14:44.741591 | instance | ok: Runtime: 0:00:00.042766 2026-04-08 02:14:44.749673 | 2026-04-08 02:14:44.749740 | TASK [gather-host-logs : Downloads logs to executor] 2026-04-08 02:14:45.341406 | instance | changed: 2026-04-08 02:14:45.341574 | instance | created directory /var/lib/zuul/builds/f22521f16fbe45b8bb1b8efc1fd01d36/work/logs/instance 2026-04-08 02:14:45.341602 | instance | cd+++++++++ system/ 2026-04-08 02:14:45.341624 | instance | >f+++++++++ system/brctl-show.txt 2026-04-08 02:14:45.341644 | instance | >f+++++++++ system/docker-images.txt 2026-04-08 02:14:45.341663 | instance | >f+++++++++ system/ip-addr.txt 2026-04-08 02:14:45.341685 | instance | >f+++++++++ system/ip-route.txt 2026-04-08 02:14:45.341705 | instance | >f+++++++++ system/lsblk.txt 2026-04-08 02:14:45.341725 | instance | >f+++++++++ system/mount.txt 2026-04-08 02:14:45.341746 | instance | >f+++++++++ system/packages.txt 2026-04-08 02:14:45.341765 | instance | >f+++++++++ system/ps.txt 2026-04-08 02:14:45.341785 | instance | >f+++++++++ system/systemd-cgls.txt 2026-04-08 02:14:45.350632 | 2026-04-08 02:14:45.350697 | LOOP [helm-release-status : creating directory for helm release status] 2026-04-08 02:14:45.540558 | instance | changed: "values" 2026-04-08 02:14:45.695975 | instance | changed: "releases" 2026-04-08 02:14:45.716290 | 2026-04-08 02:14:45.716439 | TASK [helm-release-status : Gather get release status for helm charts] 2026-04-08 02:14:45.910313 | instance | /bin/bash: line 3: kubectl: command not found 2026-04-08 02:14:46.251122 | instance | ok: Runtime: 0:00:00.004961 2026-04-08 02:14:46.257971 | 2026-04-08 02:14:46.258064 | TASK [helm-release-status : Downloads logs to executor] 2026-04-08 02:14:46.726864 | instance | changed: 2026-04-08 02:14:46.727041 | instance | cd+++++++++ helm/ 2026-04-08 02:14:46.727070 | instance | cd+++++++++ helm/releases/ 2026-04-08 02:14:46.727103 | instance | cd+++++++++ helm/values/ 2026-04-08 02:14:46.736899 | 2026-04-08 02:14:46.737074 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-04-08 02:14:46.935400 | instance | changed 2026-04-08 02:14:46.940005 | 2026-04-08 02:14:46.940073 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-04-08 02:14:47.137981 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-08 02:14:47.138145 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-08 02:14:47.143507 | instance | environment: line 1: kubectl: command not found 2026-04-08 02:14:47.144684 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-08 02:14:47.144884 | instance | environment: line 1: kubectl: command not found 2026-04-08 02:14:47.147044 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-08 02:14:47.147624 | instance | environment: line 1: kubectl: command not found 2026-04-08 02:14:47.148338 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-08 02:14:47.151023 | instance | environment: line 1: kubectl: command not found 2026-04-08 02:14:47.152279 | instance | environment: line 1: kubectl: command not found 2026-04-08 02:14:47.152392 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-08 02:14:47.153652 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-08 02:14:47.475921 | instance | ok: Runtime: 0:00:00.021409 2026-04-08 02:14:47.481995 | 2026-04-08 02:14:47.482057 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-04-08 02:14:47.676565 | instance | changed 2026-04-08 02:14:47.682803 | 2026-04-08 02:14:47.682869 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-04-08 02:14:47.908906 | instance | environment: line 5: kubectl: command not found 2026-04-08 02:14:47.909821 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-08 02:14:47.910106 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-08 02:14:47.910191 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-08 02:14:48.242371 | instance | ok: Runtime: 0:00:00.008420 2026-04-08 02:14:48.248416 | 2026-04-08 02:14:48.248483 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-04-08 02:14:48.719537 | instance | changed: 2026-04-08 02:14:48.719761 | instance | cd+++++++++ objects/ 2026-04-08 02:14:48.719799 | instance | cd+++++++++ objects/cluster/ 2026-04-08 02:14:48.719830 | instance | cd+++++++++ objects/namespaced/ 2026-04-08 02:14:48.731034 | 2026-04-08 02:14:48.731100 | TASK [gather-pod-logs : creating directory for pod logs] 2026-04-08 02:14:48.925550 | instance | changed 2026-04-08 02:14:48.932517 | 2026-04-08 02:14:48.932582 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-04-08 02:14:49.116445 | instance | changed 2026-04-08 02:14:49.122184 | 2026-04-08 02:14:49.122251 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-04-08 02:14:49.321278 | instance | environment: line 3: kubectl: command not found 2026-04-08 02:14:49.657834 | instance | ok: Runtime: 0:00:00.007425 2026-04-08 02:14:49.664305 | 2026-04-08 02:14:49.664369 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-04-08 02:14:50.126567 | instance | changed: 2026-04-08 02:14:50.126941 | instance | cd+++++++++ pod-logs/ 2026-04-08 02:14:50.127008 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-04-08 02:14:50.140597 | 2026-04-08 02:14:50.140672 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-04-08 02:14:50.340468 | instance | changed 2026-04-08 02:14:50.345837 | 2026-04-08 02:14:50.345911 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-04-08 02:14:50.562848 | instance | /bin/bash: line 2: kubectl: command not found 2026-04-08 02:14:50.882664 | instance | ok: Runtime: 0:00:00.038992 2026-04-08 02:14:50.889751 | 2026-04-08 02:14:50.889885 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-04-08 02:14:51.102378 | instance | /bin/bash: line 2: kubectl: command not found 2026-04-08 02:14:51.135324 | instance | ceph-mgr endpoints: 2026-04-08 02:14:51.434271 | instance | ok: Runtime: 0:00:00.039636 2026-04-08 02:14:51.440087 | 2026-04-08 02:14:51.440153 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-04-08 02:14:51.678018 | instance | /bin/bash: line 4: kubectl: command not found 2026-04-08 02:14:51.974717 | instance | ok: Runtime: 0:00:00.039831 2026-04-08 02:14:51.981426 | 2026-04-08 02:14:51.981587 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-04-08 02:14:52.450059 | instance | changed: cd+++++++++ prometheus/ 2026-04-08 02:14:52.459210 | 2026-04-08 02:14:52.459271 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-04-08 02:14:52.644434 | instance | changed 2026-04-08 02:14:52.649802 | 2026-04-08 02:14:52.649865 | TASK [gather-selenium-data : Get selenium data] 2026-04-08 02:14:52.847272 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-04-08 02:14:52.848977 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-04-08 02:14:53.183808 | instance | ERROR 2026-04-08 02:14:53.184085 | instance | { 2026-04-08 02:14:53.184155 | instance | "delta": "0:00:00.007136", 2026-04-08 02:14:53.184202 | instance | "end": "2026-04-08 02:14:52.849374", 2026-04-08 02:14:53.184243 | instance | "msg": "non-zero return code", 2026-04-08 02:14:53.184282 | instance | "rc": 1, 2026-04-08 02:14:53.184320 | instance | "start": "2026-04-08 02:14:52.842238" 2026-04-08 02:14:53.184359 | instance | } 2026-04-08 02:14:53.184408 | instance | ERROR: Ignoring Errors 2026-04-08 02:14:53.189723 | 2026-04-08 02:14:53.189785 | TASK [gather-selenium-data : Downloads logs to executor] 2026-04-08 02:14:53.648771 | instance | changed: cd+++++++++ selenium/ 2026-04-08 02:14:53.655152 | 2026-04-08 02:14:53.655196 | PLAY RECAP 2026-04-08 02:14:53.655239 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-04-08 02:14:53.655262 | 2026-04-08 02:14:53.752525 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main] 2026-04-08 02:14:53.758437 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-08 02:14:54.305525 | 2026-04-08 02:14:54.305635 | PLAY [all] 2026-04-08 02:14:54.316369 | 2026-04-08 02:14:54.316445 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-08 02:14:54.351400 | instance | skipping: Conditional result was False 2026-04-08 02:14:54.360529 | 2026-04-08 02:14:54.360633 | TASK [fetch-output : Set log path for single node] 2026-04-08 02:14:54.402037 | instance | ok 2026-04-08 02:14:54.408235 | 2026-04-08 02:14:54.408305 | LOOP [fetch-output : Ensure local output dirs] 2026-04-08 02:14:54.747488 | instance -> localhost | ok: "/var/lib/zuul/builds/f22521f16fbe45b8bb1b8efc1fd01d36/work/logs" 2026-04-08 02:14:54.937037 | instance -> localhost | changed: "/var/lib/zuul/builds/f22521f16fbe45b8bb1b8efc1fd01d36/work/artifacts" 2026-04-08 02:14:55.139562 | instance -> localhost | changed: "/var/lib/zuul/builds/f22521f16fbe45b8bb1b8efc1fd01d36/work/docs" 2026-04-08 02:14:55.156685 | 2026-04-08 02:14:55.156781 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-08 02:14:55.772338 | instance | changed: .d..t...... ./ 2026-04-08 02:14:55.772662 | instance | changed: All items complete 2026-04-08 02:14:55.772726 | 2026-04-08 02:14:56.198570 | instance | changed: .d..t...... ./ 2026-04-08 02:14:56.630082 | instance | changed: .d..t...... ./ 2026-04-08 02:14:56.650803 | 2026-04-08 02:14:56.651017 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-08 02:14:57.072584 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007275 2026-04-08 02:14:57.283264 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.005931 2026-04-08 02:14:57.302896 | 2026-04-08 02:14:57.303000 | PLAY [all] 2026-04-08 02:14:57.308879 | 2026-04-08 02:14:57.308945 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-08 02:14:57.684660 | instance | changed 2026-04-08 02:14:57.692521 | 2026-04-08 02:14:57.692577 | PLAY RECAP 2026-04-08 02:14:57.692627 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-08 02:14:57.692649 | 2026-04-08 02:14:57.795858 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-08 02:14:57.799300 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-08 02:14:58.333631 | 2026-04-08 02:14:58.333985 | PLAY [localhost] 2026-04-08 02:14:58.344235 | 2026-04-08 02:14:58.344316 | TASK [Generate Zuul manifest] 2026-04-08 02:14:58.366009 | localhost | ok 2026-04-08 02:14:58.381960 | 2026-04-08 02:14:58.382048 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-08 02:14:58.726334 | localhost | changed 2026-04-08 02:14:58.737795 | 2026-04-08 02:14:58.737870 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-08 02:14:58.770038 | localhost | ok 2026-04-08 02:14:58.778301 | 2026-04-08 02:14:58.778361 | TASK [Upload logs] 2026-04-08 02:14:58.798665 | localhost | ok 2026-04-08 02:14:58.857105 | 2026-04-08 02:14:58.857292 | TASK [Set zuul-log-path fact] 2026-04-08 02:14:58.877808 | localhost | ok 2026-04-08 02:14:58.889938 | 2026-04-08 02:14:58.890005 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-08 02:14:58.920805 | localhost | ok 2026-04-08 02:14:58.929363 | 2026-04-08 02:14:58.929427 | TASK [upload-logs : Create log directories] 2026-04-08 02:14:59.305737 | localhost | changed 2026-04-08 02:14:59.312223 | 2026-04-08 02:14:59.312290 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-08 02:14:59.680381 | localhost -> localhost | ok: Runtime: 0:00:00.005693 2026-04-08 02:14:59.685254 | 2026-04-08 02:14:59.685319 | TASK [upload-logs : Upload logs to log server] 2026-04-08 02:15:00.132541 | localhost | Output suppressed because no_log was given 2026-04-08 02:15:00.138910 | 2026-04-08 02:15:00.138977 | LOOP [upload-logs : Compress console log and json output] 2026-04-08 02:15:00.180334 | localhost | skipping: Conditional result was False 2026-04-08 02:15:00.187344 | localhost | skipping: Conditional result was False 2026-04-08 02:15:00.200607 | 2026-04-08 02:15:00.200755 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-08 02:15:00.240531 | localhost | skipping: Conditional result was False 2026-04-08 02:15:00.240899 | 2026-04-08 02:15:00.244643 | localhost | skipping: Conditional result was False 2026-04-08 02:15:00.254850 | 2026-04-08 02:15:00.254969 | LOOP [upload-logs : Upload console log and json output]