2026-04-30 20:05:49.689541 | Job console starting 2026-04-30 20:05:49.698594 | Updating git repos 2026-04-30 20:05:49.817565 | Cloning repos into workspace 2026-04-30 20:05:49.890411 | Restoring repo states 2026-04-30 20:05:49.909112 | Merging changes 2026-04-30 20:05:50.882969 | Checking out repos 2026-04-30 20:05:51.210114 | Preparing playbooks 2026-04-30 20:05:58.532526 | Running Ansible setup 2026-04-30 20:06:02.074750 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-30 20:06:02.741858 | 2026-04-30 20:06:02.742015 | PLAY [localhost] 2026-04-30 20:06:02.750047 | 2026-04-30 20:06:02.750124 | TASK [Gathering Facts] 2026-04-30 20:06:03.995065 | localhost | ok 2026-04-30 20:06:04.006742 | 2026-04-30 20:06:04.006843 | TASK [Setup log path fact] 2026-04-30 20:06:04.027357 | localhost | ok 2026-04-30 20:06:04.039817 | 2026-04-30 20:06:04.039888 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-30 20:06:04.073162 | localhost | ok 2026-04-30 20:06:04.082409 | 2026-04-30 20:06:04.082530 | TASK [emit-job-header : Print job information] 2026-04-30 20:06:04.137117 | # Job Information 2026-04-30 20:06:04.137475 | Ansible Version: 2.16.18 2026-04-30 20:06:04.137560 | Job: atmosphere-molecule-aio-openvswitch 2026-04-30 20:06:04.137614 | Pipeline: check 2026-04-30 20:06:04.137663 | Executor: 2d72f0692154 2026-04-30 20:06:04.137712 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3501 2026-04-30 20:06:04.137767 | Event ID: e53bda20-44cf-11f1-9992-7fa69cb94b77 2026-04-30 20:06:04.142697 | 2026-04-30 20:06:04.142773 | LOOP [emit-job-header : Print node information] 2026-04-30 20:06:04.239600 | localhost | ok: 2026-04-30 20:06:04.239843 | localhost | # Node Information 2026-04-30 20:06:04.239874 | localhost | Inventory Hostname: instance 2026-04-30 20:06:04.239896 | localhost | Hostname: np0000171387 2026-04-30 20:06:04.239917 | localhost | Username: zuul 2026-04-30 20:06:04.239940 | localhost | Distro: Ubuntu 22.04 2026-04-30 20:06:04.239960 | localhost | Provider: yul1 2026-04-30 20:06:04.239980 | localhost | Region: ca-ymq-1 2026-04-30 20:06:04.240000 | localhost | Label: ubuntu-jammy-16 2026-04-30 20:06:04.240019 | localhost | Product Name: OpenStack Nova 2026-04-30 20:06:04.240038 | localhost | Interface IP: 199.204.45.144 2026-04-30 20:06:04.246247 | 2026-04-30 20:06:04.246322 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-30 20:06:04.771134 | localhost -> localhost | changed 2026-04-30 20:06:04.777325 | 2026-04-30 20:06:04.777394 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-30 20:06:05.701503 | localhost -> localhost | changed 2026-04-30 20:06:05.707156 | 2026-04-30 20:06:05.707205 | PLAY [all] 2026-04-30 20:06:05.714741 | 2026-04-30 20:06:05.714806 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-30 20:06:05.945996 | instance -> localhost | ok 2026-04-30 20:06:05.955484 | 2026-04-30 20:06:05.955546 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-30 20:06:05.988394 | instance | ok 2026-04-30 20:06:06.004419 | instance | included: /var/lib/zuul/builds/70a032bf13c7456f8c33b0077c3729cf/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-30 20:06:06.010116 | 2026-04-30 20:06:06.010175 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-30 20:06:06.823811 | instance -> localhost | Generating public/private rsa key pair. 2026-04-30 20:06:06.824278 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/70a032bf13c7456f8c33b0077c3729cf/work/70a032bf13c7456f8c33b0077c3729cf_id_rsa 2026-04-30 20:06:06.824346 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/70a032bf13c7456f8c33b0077c3729cf/work/70a032bf13c7456f8c33b0077c3729cf_id_rsa.pub 2026-04-30 20:06:06.824523 | instance -> localhost | The key fingerprint is: 2026-04-30 20:06:06.824665 | instance -> localhost | SHA256:Wc6ylq5HaYPRQ/cJxWek42voEkfQSEyPSVtXzakg0Ks zuul-build-sshkey 2026-04-30 20:06:06.825211 | instance -> localhost | The key's randomart image is: 2026-04-30 20:06:06.825265 | instance -> localhost | +---[RSA 3072]----+ 2026-04-30 20:06:06.825546 | instance -> localhost | | =*o.ooooo.| 2026-04-30 20:06:06.825573 | instance -> localhost | | .=O+o..o.o| 2026-04-30 20:06:06.825595 | instance -> localhost | | o+o=o++. | 2026-04-30 20:06:06.825615 | instance -> localhost | | . o*..oo | 2026-04-30 20:06:06.825636 | instance -> localhost | | oS+o . | 2026-04-30 20:06:06.825657 | instance -> localhost | | .E*+.. . | 2026-04-30 20:06:06.826220 | instance -> localhost | | o++. o | 2026-04-30 20:06:06.826383 | instance -> localhost | | oo. . | 2026-04-30 20:06:06.826797 | instance -> localhost | | .o... | 2026-04-30 20:06:06.826860 | instance -> localhost | +----[SHA256]-----+ 2026-04-30 20:06:06.827458 | instance -> localhost | ok: Runtime: 0:00:00.331776 2026-04-30 20:06:06.841036 | 2026-04-30 20:06:06.841245 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-30 20:06:06.879104 | instance | ok 2026-04-30 20:06:06.895841 | instance | included: /var/lib/zuul/builds/70a032bf13c7456f8c33b0077c3729cf/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-30 20:06:06.904370 | 2026-04-30 20:06:06.904447 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-30 20:06:06.930292 | instance | skipping: Conditional result was False 2026-04-30 20:06:06.942751 | 2026-04-30 20:06:06.942877 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-30 20:06:07.383158 | instance | changed 2026-04-30 20:06:07.388179 | 2026-04-30 20:06:07.388243 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-30 20:06:07.580886 | instance | ok 2026-04-30 20:06:07.590320 | 2026-04-30 20:06:07.590388 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-30 20:06:08.111797 | instance | changed 2026-04-30 20:06:08.118955 | 2026-04-30 20:06:08.119033 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-30 20:06:08.571533 | instance | changed 2026-04-30 20:06:08.578129 | 2026-04-30 20:06:08.578200 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-30 20:06:08.603667 | instance | skipping: Conditional result was False 2026-04-30 20:06:08.613426 | 2026-04-30 20:06:08.613524 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-30 20:06:08.946515 | instance -> localhost | changed 2026-04-30 20:06:08.961881 | 2026-04-30 20:06:08.961993 | TASK [add-build-sshkey : Add back temp key] 2026-04-30 20:06:09.229554 | instance -> localhost | Identity added: /var/lib/zuul/builds/70a032bf13c7456f8c33b0077c3729cf/work/70a032bf13c7456f8c33b0077c3729cf_id_rsa (zuul-build-sshkey) 2026-04-30 20:06:09.229763 | instance -> localhost | ok: Runtime: 0:00:00.013758 2026-04-30 20:06:09.236555 | 2026-04-30 20:06:09.236617 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-30 20:06:09.487331 | instance | ok 2026-04-30 20:06:09.492160 | 2026-04-30 20:06:09.492224 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-30 20:06:09.526435 | instance | skipping: Conditional result was False 2026-04-30 20:06:09.543682 | 2026-04-30 20:06:09.543771 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-30 20:06:09.823393 | instance | ok 2026-04-30 20:06:09.829705 | 2026-04-30 20:06:09.829773 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-30 20:06:12.166188 | instance | Output suppressed because no_log was given 2026-04-30 20:06:12.176331 | 2026-04-30 20:06:12.176394 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-30 20:06:12.376345 | instance | ok: "logs" 2026-04-30 20:06:12.376619 | instance | ok: All items complete 2026-04-30 20:06:12.376648 | 2026-04-30 20:06:12.528187 | instance | ok: "artifacts" 2026-04-30 20:06:12.679242 | instance | ok: "docs" 2026-04-30 20:06:12.692366 | 2026-04-30 20:06:12.692533 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-30 20:06:12.876422 | instance | changed: "logs" 2026-04-30 20:06:13.031983 | instance | changed: "artifacts" 2026-04-30 20:06:13.193719 | instance | changed: "docs" 2026-04-30 20:06:13.213887 | 2026-04-30 20:06:13.242697 | PLAY RECAP 2026-04-30 20:06:13.242838 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-30 20:06:13.242910 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-30 20:06:13.242958 | 2026-04-30 20:06:13.410793 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-30 20:06:13.420226 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-30 20:06:14.098725 | 2026-04-30 20:06:14.153108 | PLAY [all] 2026-04-30 20:06:14.181564 | 2026-04-30 20:06:14.181809 | TASK [setup-uv : Extract archive] 2026-04-30 20:06:16.532061 | instance | changed 2026-04-30 20:06:16.539134 | 2026-04-30 20:06:16.539219 | TASK [setup-uv : Print version] 2026-04-30 20:06:16.898821 | instance | uv 0.8.13 2026-04-30 20:06:17.079189 | instance | ok: Runtime: 0:00:00.017700 2026-04-30 20:06:17.086463 | 2026-04-30 20:06:17.086516 | PLAY RECAP 2026-04-30 20:06:17.086563 | instance | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-30 20:06:17.086586 | 2026-04-30 20:06:17.234601 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-30 20:06:17.244643 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main] 2026-04-30 20:06:17.879650 | 2026-04-30 20:06:17.879803 | PLAY [all] 2026-04-30 20:06:17.891235 | 2026-04-30 20:06:17.891310 | TASK [Install "jq" for log collection] 2026-04-30 20:08:44.489606 | instance | changed 2026-04-30 20:08:44.492333 | 2026-04-30 20:08:44.492384 | PLAY RECAP 2026-04-30 20:08:44.492434 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-30 20:08:44.492483 | 2026-04-30 20:08:44.617024 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main] 2026-04-30 20:08:44.626402 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-30 20:08:45.222796 | 2026-04-30 20:08:45.222924 | PLAY [all] 2026-04-30 20:08:45.233899 | 2026-04-30 20:08:45.233972 | TASK [Copy inventory file for Zuul] 2026-04-30 20:08:46.089663 | instance | changed 2026-04-30 20:08:46.098526 | 2026-04-30 20:08:46.098633 | TASK [Switch "ansible_host" to private IP] 2026-04-30 20:08:46.431524 | instance | changed: 1 replacements made 2026-04-30 20:08:46.437661 | 2026-04-30 20:08:46.437729 | TASK [Run Molecule scenario] 2026-04-30 20:08:46.844034 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-04-30 20:08:46.844195 | instance | Creating virtual environment at: .venv 2026-04-30 20:08:46.870885 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-04-30 20:08:46.897284 | instance | Downloading pygments (1.2MiB) 2026-04-30 20:08:46.901574 | instance | Downloading ansible-core (2.1MiB) 2026-04-30 20:08:46.902212 | instance | Downloading setuptools (1.1MiB) 2026-04-30 20:08:46.902591 | instance | Downloading pydantic-core (2.0MiB) 2026-04-30 20:08:46.902844 | instance | Downloading kubernetes (1.9MiB) 2026-04-30 20:08:46.903350 | instance | Downloading cryptography (4.2MiB) 2026-04-30 20:08:46.904092 | instance | Downloading netaddr (2.2MiB) 2026-04-30 20:08:46.904310 | instance | Downloading rjsonnet (1.2MiB) 2026-04-30 20:08:46.905106 | instance | Downloading openstacksdk (1.7MiB) 2026-04-30 20:08:47.212669 | instance | Downloading rjsonnet 2026-04-30 20:08:47.219513 | instance | Building pyperclip==1.9.0 2026-04-30 20:08:47.325898 | instance | Downloading pydantic-core 2026-04-30 20:08:47.371203 | instance | Downloading netaddr 2026-04-30 20:08:47.383373 | instance | Downloading pygments 2026-04-30 20:08:47.401954 | instance | Downloading cryptography 2026-04-30 20:08:47.437946 | instance | Downloading setuptools 2026-04-30 20:08:47.497931 | instance | Downloading kubernetes 2026-04-30 20:08:47.536739 | instance | Downloading ansible-core 2026-04-30 20:08:47.569691 | instance | Downloading openstacksdk 2026-04-30 20:08:47.947779 | instance | Built pyperclip==1.9.0 2026-04-30 20:08:48.108917 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-04-30 20:08:48.154820 | instance | Installed 83 packages in 43ms 2026-04-30 20:08:48.808687 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-04-30 20:08:49.398459 | instance | INFO [aio > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-04-30 20:08:49.398552 | instance | INFO [aio > prerun] Performing prerun with role_name_check=0... 2026-04-30 20:09:35.699707 | instance | INFO [aio > dependency] Executing 2026-04-30 20:09:35.699933 | instance | WARNING [aio > dependency] Missing roles requirements file: requirements.yml 2026-04-30 20:09:35.700063 | instance | WARNING [aio > dependency] Missing collections requirements file: collections.yml 2026-04-30 20:09:35.700172 | instance | WARNING [aio > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-04-30 20:09:35.708130 | instance | INFO [aio > cleanup] Executing 2026-04-30 20:09:35.708444 | instance | WARNING [aio > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-30 20:09:35.716176 | instance | INFO [aio > destroy] Executing 2026-04-30 20:09:35.716230 | instance | WARNING [aio > destroy] Skipping, '--destroy=never' requested. 2026-04-30 20:09:35.716245 | instance | INFO [aio > destroy] Executed: Successful 2026-04-30 20:09:35.724237 | instance | INFO [aio > syntax] Executing 2026-04-30 20:09:38.551497 | instance | 2026-04-30 20:09:38.551723 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/aio/converge.yml 2026-04-30 20:09:38.665292 | instance | INFO [aio > syntax] Executed: Successful 2026-04-30 20:09:38.675925 | instance | INFO [aio > create] Executing 2026-04-30 20:09:38.678259 | instance | WARNING [aio > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-30 20:09:38.688420 | instance | INFO [aio > prepare] Executing 2026-04-30 20:09:39.533963 | instance | 2026-04-30 20:09:39.534188 | instance | PLAY [Prepare] ***************************************************************** 2026-04-30 20:09:39.534516 | instance | 2026-04-30 20:09:39.534765 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-30 20:09:39.535043 | instance | Thursday 30 April 2026 20:09:39 +0000 (0:00:00.023) 0:00:00.023 ******** 2026-04-30 20:09:40.659912 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-04-30 20:09:40.660135 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-04-30 20:09:40.660407 | instance | interpreter could change the meaning of that path. See 2026-04-30 20:09:40.660675 | instance | https://docs.ansible.com/ansible- 2026-04-30 20:09:40.660941 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-04-30 20:09:40.667510 | instance | ok: [instance] 2026-04-30 20:09:40.667760 | instance | 2026-04-30 20:09:40.668060 | instance | TASK [Configure short hostname] ************************************************ 2026-04-30 20:09:40.668362 | instance | Thursday 30 April 2026 20:09:40 +0000 (0:00:01.134) 0:00:01.158 ******** 2026-04-30 20:09:41.360025 | instance | changed: [instance] 2026-04-30 20:09:41.360338 | instance | 2026-04-30 20:09:41.360703 | instance | TASK [Ensure hostname inside hosts file] *************************************** 2026-04-30 20:09:41.361058 | instance | Thursday 30 April 2026 20:09:41 +0000 (0:00:00.691) 0:00:01.849 ******** 2026-04-30 20:09:41.620481 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created 2026-04-30 20:09:41.620559 | instance | with a mode of 0700, this may cause issues when running as another user. To 2026-04-30 20:09:41.620738 | instance | avoid this, create the remote_tmp dir with the correct permissions manually 2026-04-30 20:09:41.631941 | instance | changed: [instance] 2026-04-30 20:09:41.632076 | instance | 2026-04-30 20:09:41.632236 | instance | TASK [Install "dirmngr" for GPG keyserver operations] ************************** 2026-04-30 20:09:41.632399 | instance | Thursday 30 April 2026 20:09:41 +0000 (0:00:00.272) 0:00:02.122 ******** 2026-04-30 20:09:42.750266 | instance | ok: [instance] 2026-04-30 20:09:42.750474 | instance | 2026-04-30 20:09:42.750747 | instance | TASK [Purge "snapd" package] *************************************************** 2026-04-30 20:09:42.751065 | instance | Thursday 30 April 2026 20:09:42 +0000 (0:00:01.118) 0:00:03.240 ******** 2026-04-30 20:09:43.407469 | instance | ok: [instance] 2026-04-30 20:09:43.407563 | instance | 2026-04-30 20:09:43.407674 | instance | PLAY [Generate workspace for Atmosphere] *************************************** 2026-04-30 20:09:43.407823 | instance | 2026-04-30 20:09:43.407977 | instance | TASK [Create folders for workspace] ******************************************** 2026-04-30 20:09:43.408137 | instance | Thursday 30 April 2026 20:09:43 +0000 (0:00:00.657) 0:00:03.897 ******** 2026-04-30 20:09:44.389543 | instance | changed: [localhost] => (item=group_vars) 2026-04-30 20:09:44.389766 | instance | changed: [localhost] => (item=group_vars/all) 2026-04-30 20:09:44.390058 | instance | changed: [localhost] => (item=group_vars/controllers) 2026-04-30 20:09:44.390305 | instance | changed: [localhost] => (item=group_vars/cephs) 2026-04-30 20:09:44.390568 | instance | changed: [localhost] => (item=group_vars/computes) 2026-04-30 20:09:44.390831 | instance | changed: [localhost] => (item=host_vars) 2026-04-30 20:09:44.391109 | instance | 2026-04-30 20:09:44.391444 | instance | PLAY [Generate Ceph control plane configuration for workspace] ***************** 2026-04-30 20:09:44.391661 | instance | 2026-04-30 20:09:44.391905 | instance | TASK [Ensure the Ceph control plane configuration file exists] ***************** 2026-04-30 20:09:44.392196 | instance | Thursday 30 April 2026 20:09:44 +0000 (0:00:00.981) 0:00:04.879 ******** 2026-04-30 20:09:44.552362 | instance | changed: [localhost] 2026-04-30 20:09:44.552573 | instance | 2026-04-30 20:09:44.552846 | instance | TASK [Load the current Ceph control plane configuration into a variable] ******* 2026-04-30 20:09:44.553158 | instance | Thursday 30 April 2026 20:09:44 +0000 (0:00:00.162) 0:00:05.042 ******** 2026-04-30 20:09:44.579256 | instance | ok: [localhost] 2026-04-30 20:09:44.579500 | instance | 2026-04-30 20:09:44.579824 | instance | TASK [Generate Ceph control plane values for missing variables] **************** 2026-04-30 20:09:44.580092 | instance | Thursday 30 April 2026 20:09:44 +0000 (0:00:00.027) 0:00:05.069 ******** 2026-04-30 20:09:44.626587 | instance | ok: [localhost] => (item={'key': 'ceph_fsid', 'value': 'ef0e0db6-e11d-50d1-9f5e-b527b27469df'}) 2026-04-30 20:09:44.626900 | instance | ok: [localhost] => (item={'key': 'ceph_mon_public_network', 'value': '10.96.240.0/24'}) 2026-04-30 20:09:44.627145 | instance | 2026-04-30 20:09:44.627426 | instance | TASK [Write new Ceph control plane configuration file to disk] ***************** 2026-04-30 20:09:44.627770 | instance | Thursday 30 April 2026 20:09:44 +0000 (0:00:00.047) 0:00:05.117 ******** 2026-04-30 20:09:45.185447 | instance | changed: [localhost] 2026-04-30 20:09:45.185650 | instance | 2026-04-30 20:09:45.185945 | instance | PLAY [Generate Ceph OSD configuration for workspace] *************************** 2026-04-30 20:09:45.186197 | instance | 2026-04-30 20:09:45.186474 | instance | TASK [Ensure the Ceph OSDs configuration file exists] ************************** 2026-04-30 20:09:45.186764 | instance | Thursday 30 April 2026 20:09:45 +0000 (0:00:00.558) 0:00:05.675 ******** 2026-04-30 20:09:45.359463 | instance | changed: [localhost] 2026-04-30 20:09:45.359704 | instance | 2026-04-30 20:09:45.360096 | instance | TASK [Load the current Ceph OSDs configuration into a variable] **************** 2026-04-30 20:09:45.360384 | instance | Thursday 30 April 2026 20:09:45 +0000 (0:00:00.173) 0:00:05.849 ******** 2026-04-30 20:09:45.383990 | instance | ok: [localhost] 2026-04-30 20:09:45.384245 | instance | 2026-04-30 20:09:45.384644 | instance | TASK [Generate Ceph OSDs values for missing variables] ************************* 2026-04-30 20:09:45.385111 | instance | Thursday 30 April 2026 20:09:45 +0000 (0:00:00.025) 0:00:05.874 ******** 2026-04-30 20:09:45.411743 | instance | ok: [localhost] => (item={'key': 'ceph_osd_devices', 'value': ['/dev/vdb', '/dev/vdc', '/dev/vdd']}) 2026-04-30 20:09:45.412043 | instance | 2026-04-30 20:09:45.412323 | instance | TASK [Write new Ceph OSDs configuration file to disk] ************************** 2026-04-30 20:09:45.412594 | instance | Thursday 30 April 2026 20:09:45 +0000 (0:00:00.027) 0:00:05.902 ******** 2026-04-30 20:09:45.746921 | instance | changed: [localhost] 2026-04-30 20:09:45.747170 | instance | 2026-04-30 20:09:45.747592 | instance | PLAY [Generate Kubernetes configuration for workspace] ************************* 2026-04-30 20:09:45.747890 | instance | 2026-04-30 20:09:45.748334 | instance | TASK [Ensure the Kubernetes configuration file exists] ************************* 2026-04-30 20:09:45.748719 | instance | Thursday 30 April 2026 20:09:45 +0000 (0:00:00.334) 0:00:06.236 ******** 2026-04-30 20:09:45.915354 | instance | changed: [localhost] 2026-04-30 20:09:45.915660 | instance | 2026-04-30 20:09:45.916038 | instance | TASK [Load the current Kubernetes configuration into a variable] *************** 2026-04-30 20:09:45.916502 | instance | Thursday 30 April 2026 20:09:45 +0000 (0:00:00.168) 0:00:06.404 ******** 2026-04-30 20:09:45.943868 | instance | ok: [localhost] 2026-04-30 20:09:45.944166 | instance | 2026-04-30 20:09:45.944451 | instance | TASK [Generate Kubernetes values for missing variables] ************************ 2026-04-30 20:09:45.944745 | instance | Thursday 30 April 2026 20:09:45 +0000 (0:00:00.028) 0:00:06.433 ******** 2026-04-30 20:09:45.988943 | instance | ok: [localhost] => (item={'key': 'kubernetes_hostname', 'value': '10.96.240.10'}) 2026-04-30 20:09:45.989252 | instance | ok: [localhost] => (item={'key': 'kubernetes_keepalived_vrid', 'value': 42}) 2026-04-30 20:09:45.989712 | instance | ok: [localhost] => (item={'key': 'kubernetes_keepalived_vip', 'value': '10.96.240.10'}) 2026-04-30 20:09:45.990055 | instance | 2026-04-30 20:09:45.990352 | instance | TASK [Write new Kubernetes configuration file to disk] ************************* 2026-04-30 20:09:45.990672 | instance | Thursday 30 April 2026 20:09:45 +0000 (0:00:00.044) 0:00:06.478 ******** 2026-04-30 20:09:46.328996 | instance | changed: [localhost] 2026-04-30 20:09:46.329282 | instance | 2026-04-30 20:09:46.329655 | instance | PLAY [Generate Keepalived configuration for workspace] ************************* 2026-04-30 20:09:46.329949 | instance | 2026-04-30 20:09:46.330281 | instance | TASK [Ensure the Keeaplived configuration file exists] ************************* 2026-04-30 20:09:46.330626 | instance | Thursday 30 April 2026 20:09:46 +0000 (0:00:00.340) 0:00:06.819 ******** 2026-04-30 20:09:46.505315 | instance | changed: [localhost] 2026-04-30 20:09:46.505583 | instance | 2026-04-30 20:09:46.505888 | instance | TASK [Load the current Keepalived configuration into a variable] *************** 2026-04-30 20:09:46.506157 | instance | Thursday 30 April 2026 20:09:46 +0000 (0:00:00.176) 0:00:06.995 ******** 2026-04-30 20:09:46.532212 | instance | ok: [localhost] 2026-04-30 20:09:46.532477 | instance | 2026-04-30 20:09:46.532769 | instance | TASK [Generate Keepalived values for missing variables] ************************ 2026-04-30 20:09:46.533057 | instance | Thursday 30 April 2026 20:09:46 +0000 (0:00:00.027) 0:00:07.022 ******** 2026-04-30 20:09:46.567888 | instance | ok: [localhost] => (item={'key': 'keepalived_interface', 'value': 'br-ex'}) 2026-04-30 20:09:46.568172 | instance | ok: [localhost] => (item={'key': 'keepalived_vip', 'value': '10.96.250.10'}) 2026-04-30 20:09:46.568520 | instance | 2026-04-30 20:09:46.568888 | instance | TASK [Write new Keepalived configuration file to disk] ************************* 2026-04-30 20:09:46.569091 | instance | Thursday 30 April 2026 20:09:46 +0000 (0:00:00.035) 0:00:07.058 ******** 2026-04-30 20:09:46.948683 | instance | changed: [localhost] 2026-04-30 20:09:46.948889 | instance | 2026-04-30 20:09:46.949161 | instance | PLAY [Generate endpoints for workspace] **************************************** 2026-04-30 20:09:46.949473 | instance | 2026-04-30 20:09:46.949727 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-30 20:09:46.949992 | instance | Thursday 30 April 2026 20:09:46 +0000 (0:00:00.380) 0:00:07.439 ******** 2026-04-30 20:09:47.618997 | instance | ok: [localhost] 2026-04-30 20:09:47.619298 | instance | 2026-04-30 20:09:47.619645 | instance | TASK [Ensure the endpoints file exists] **************************************** 2026-04-30 20:09:47.620005 | instance | Thursday 30 April 2026 20:09:47 +0000 (0:00:00.670) 0:00:08.109 ******** 2026-04-30 20:09:47.808822 | instance | changed: [localhost] 2026-04-30 20:09:47.809037 | instance | 2026-04-30 20:09:47.809359 | instance | TASK [Load the current endpoints into a variable] ****************************** 2026-04-30 20:09:47.809671 | instance | Thursday 30 April 2026 20:09:47 +0000 (0:00:00.189) 0:00:08.299 ******** 2026-04-30 20:09:47.838266 | instance | ok: [localhost] 2026-04-30 20:09:47.838500 | instance | 2026-04-30 20:09:47.838792 | instance | TASK [Generate endpoint skeleton for missing variables] ************************ 2026-04-30 20:09:47.839079 | instance | Thursday 30 April 2026 20:09:47 +0000 (0:00:00.029) 0:00:08.328 ******** 2026-04-30 20:09:48.560536 | instance | ok: [localhost] => (item=keycloak_host) 2026-04-30 20:09:48.560811 | instance | ok: [localhost] => (item=kube_prometheus_stack_grafana_host) 2026-04-30 20:09:48.561071 | instance | ok: [localhost] => (item=kube_prometheus_stack_alertmanager_host) 2026-04-30 20:09:48.561407 | instance | ok: [localhost] => (item=kube_prometheus_stack_prometheus_host) 2026-04-30 20:09:48.561665 | instance | ok: [localhost] => (item=openstack_helm_endpoints_region_name) 2026-04-30 20:09:48.562033 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_api_host) 2026-04-30 20:09:48.562331 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_api_host) 2026-04-30 20:09:48.562607 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_api_host) 2026-04-30 20:09:48.562908 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_api_host) 2026-04-30 20:09:48.563225 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_api_host) 2026-04-30 20:09:48.563464 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_api_host) 2026-04-30 20:09:48.563734 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_api_host) 2026-04-30 20:09:48.564055 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_novnc_host) 2026-04-30 20:09:48.564300 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_api_host) 2026-04-30 20:09:48.564561 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_api_host) 2026-04-30 20:09:48.564867 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_api_host) 2026-04-30 20:09:48.565204 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_api_host) 2026-04-30 20:09:48.565484 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_registry_host) 2026-04-30 20:09:48.565795 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_api_host) 2026-04-30 20:09:48.566043 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_cfn_api_host) 2026-04-30 20:09:48.566315 | instance | ok: [localhost] => (item=openstack_helm_endpoints_horizon_api_host) 2026-04-30 20:09:48.566560 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rgw_host) 2026-04-30 20:09:48.566823 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_api_host) 2026-04-30 20:09:48.567079 | instance | 2026-04-30 20:09:48.567344 | instance | TASK [Write new endpoints file to disk] **************************************** 2026-04-30 20:09:48.567614 | instance | Thursday 30 April 2026 20:09:48 +0000 (0:00:00.722) 0:00:09.050 ******** 2026-04-30 20:09:48.891870 | instance | changed: [localhost] 2026-04-30 20:09:48.892084 | instance | 2026-04-30 20:09:48.892382 | instance | TASK [Ensure the endpoints file exists] **************************************** 2026-04-30 20:09:48.892637 | instance | Thursday 30 April 2026 20:09:48 +0000 (0:00:00.331) 0:00:09.382 ******** 2026-04-30 20:09:49.065927 | instance | changed: [localhost] 2026-04-30 20:09:49.066014 | instance | 2026-04-30 20:09:49.066100 | instance | PLAY [Generate Neutron configuration for workspace] **************************** 2026-04-30 20:09:49.066209 | instance | 2026-04-30 20:09:49.066335 | instance | TASK [Ensure the Neutron configuration file exists] **************************** 2026-04-30 20:09:49.066457 | instance | Thursday 30 April 2026 20:09:49 +0000 (0:00:00.174) 0:00:09.556 ******** 2026-04-30 20:09:49.238226 | instance | changed: [localhost] 2026-04-30 20:09:49.238383 | instance | 2026-04-30 20:09:49.238669 | instance | TASK [Load the current Neutron configuration into a variable] ****************** 2026-04-30 20:09:49.238947 | instance | Thursday 30 April 2026 20:09:49 +0000 (0:00:00.171) 0:00:09.728 ******** 2026-04-30 20:09:49.270496 | instance | ok: [localhost] 2026-04-30 20:09:49.270728 | instance | 2026-04-30 20:09:49.271001 | instance | TASK [Generate Neutron values for missing variables] *************************** 2026-04-30 20:09:49.271303 | instance | Thursday 30 April 2026 20:09:49 +0000 (0:00:00.032) 0:00:09.761 ******** 2026-04-30 20:09:49.314316 | 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-30 20:09:49.314530 | instance | 2026-04-30 20:09:49.314806 | instance | TASK [Write new Neutron configuration file to disk] **************************** 2026-04-30 20:09:49.315070 | instance | Thursday 30 April 2026 20:09:49 +0000 (0:00:00.043) 0:00:09.805 ******** 2026-04-30 20:09:49.670280 | instance | changed: [localhost] 2026-04-30 20:09:49.670413 | instance | 2026-04-30 20:09:49.670740 | instance | PLAY [Generate Nova configuration for workspace] ******************************* 2026-04-30 20:09:49.670948 | instance | 2026-04-30 20:09:49.671210 | instance | TASK [Ensure the Nova configuration file exists] ******************************* 2026-04-30 20:09:49.671503 | instance | Thursday 30 April 2026 20:09:49 +0000 (0:00:00.355) 0:00:10.160 ******** 2026-04-30 20:09:49.833739 | instance | changed: [localhost] 2026-04-30 20:09:49.833926 | instance | 2026-04-30 20:09:49.834207 | instance | TASK [Load the current Nova configuration into a variable] ********************* 2026-04-30 20:09:49.834483 | instance | Thursday 30 April 2026 20:09:49 +0000 (0:00:00.163) 0:00:10.324 ******** 2026-04-30 20:09:49.867547 | instance | ok: [localhost] 2026-04-30 20:09:49.867752 | instance | 2026-04-30 20:09:49.868079 | instance | TASK [Generate Nova values for missing variables] ****************************** 2026-04-30 20:09:49.868313 | instance | Thursday 30 April 2026 20:09:49 +0000 (0:00:00.033) 0:00:10.357 ******** 2026-04-30 20:09:49.912602 | 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-30 20:09:49.913023 | instance | 2026-04-30 20:09:49.913415 | instance | TASK [Write new Nova configuration file to disk] ******************************* 2026-04-30 20:09:49.913774 | instance | Thursday 30 April 2026 20:09:49 +0000 (0:00:00.043) 0:00:10.401 ******** 2026-04-30 20:09:50.282195 | instance | changed: [localhost] 2026-04-30 20:09:50.283068 | instance | 2026-04-30 20:09:50.283120 | instance | PLAY [Generate secrets for workspace] ****************************************** 2026-04-30 20:09:50.283127 | instance | 2026-04-30 20:09:50.283141 | instance | TASK [Ensure the secrets file exists] ****************************************** 2026-04-30 20:09:50.283147 | instance | Thursday 30 April 2026 20:09:50 +0000 (0:00:00.371) 0:00:10.772 ******** 2026-04-30 20:09:50.455548 | instance | changed: [localhost] 2026-04-30 20:09:50.455624 | instance | 2026-04-30 20:09:50.455894 | instance | TASK [Load the current secrets into a variable] ******************************** 2026-04-30 20:09:50.455938 | instance | Thursday 30 April 2026 20:09:50 +0000 (0:00:00.174) 0:00:10.946 ******** 2026-04-30 20:09:50.489836 | instance | ok: [localhost] 2026-04-30 20:09:50.490421 | instance | 2026-04-30 20:09:50.490448 | instance | TASK [Generate secrets for missing variables] ********************************** 2026-04-30 20:09:50.490456 | instance | Thursday 30 April 2026 20:09:50 +0000 (0:00:00.033) 0:00:10.980 ******** 2026-04-30 20:09:50.880922 | instance | ok: [localhost] => (item=heat_auth_encryption_key) 2026-04-30 20:09:50.881039 | instance | ok: [localhost] => (item=keepalived_password) 2026-04-30 20:09:50.881117 | instance | ok: [localhost] => (item=keycloak_admin_password) 2026-04-30 20:09:50.881385 | instance | ok: [localhost] => (item=keycloak_database_password) 2026-04-30 20:09:50.881489 | instance | ok: [localhost] => (item=keystone_keycloak_client_secret) 2026-04-30 20:09:50.881505 | instance | ok: [localhost] => (item=keystone_oidc_crypto_passphrase) 2026-04-30 20:09:50.884284 | instance | ok: [localhost] => (item=kube_prometheus_stack_grafana_admin_password) 2026-04-30 20:09:50.884300 | instance | ok: [localhost] => (item=octavia_heartbeat_key) 2026-04-30 20:09:50.884306 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rabbitmq_admin_password) 2026-04-30 20:09:50.884312 | instance | ok: [localhost] => (item=openstack_helm_endpoints_memcached_secret_key) 2026-04-30 20:09:50.884318 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_admin_password) 2026-04-30 20:09:50.884323 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_mariadb_password) 2026-04-30 20:09:50.884329 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_rabbitmq_password) 2026-04-30 20:09:50.884335 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_keystone_password) 2026-04-30 20:09:50.884340 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_mariadb_password) 2026-04-30 20:09:50.884346 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_rabbitmq_password) 2026-04-30 20:09:50.884352 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_keystone_password) 2026-04-30 20:09:50.884357 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_mariadb_password) 2026-04-30 20:09:50.884364 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_rabbitmq_password) 2026-04-30 20:09:50.884370 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_keystone_password) 2026-04-30 20:09:50.884376 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_mariadb_password) 2026-04-30 20:09:50.884381 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_keystone_password) 2026-04-30 20:09:50.884387 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_mariadb_password) 2026-04-30 20:09:50.884393 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_keystone_password) 2026-04-30 20:09:50.884399 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_mariadb_password) 2026-04-30 20:09:50.884404 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_rabbitmq_password) 2026-04-30 20:09:50.884410 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_metadata_secret) 2026-04-30 20:09:50.884416 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_keystone_password) 2026-04-30 20:09:50.884424 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_mariadb_password) 2026-04-30 20:09:50.884430 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_rabbitmq_password) 2026-04-30 20:09:50.884580 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_keystone_password) 2026-04-30 20:09:50.884768 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_mariadb_password) 2026-04-30 20:09:50.884918 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_rabbitmq_password) 2026-04-30 20:09:50.885066 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_keystone_password) 2026-04-30 20:09:50.885273 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_mariadb_password) 2026-04-30 20:09:50.885428 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_rabbitmq_password) 2026-04-30 20:09:50.885593 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_keystone_password) 2026-04-30 20:09:50.885741 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_mariadb_password) 2026-04-30 20:09:50.885891 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_rabbitmq_password) 2026-04-30 20:09:50.886039 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_keystone_password) 2026-04-30 20:09:50.886188 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_mariadb_password) 2026-04-30 20:09:50.886336 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_rabbitmq_password) 2026-04-30 20:09:50.886489 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_keystone_password) 2026-04-30 20:09:50.886649 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_trustee_keystone_password) 2026-04-30 20:09:50.886803 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_stack_user_keystone_password) 2026-04-30 20:09:50.886952 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_mariadb_password) 2026-04-30 20:09:50.887099 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_rabbitmq_password) 2026-04-30 20:09:50.887246 | instance | ok: [localhost] => (item=openstack_helm_endpoints_horizon_mariadb_password) 2026-04-30 20:09:50.887393 | instance | ok: [localhost] => (item=openstack_helm_endpoints_tempest_keystone_password) 2026-04-30 20:09:50.887545 | instance | ok: [localhost] => (item=openstack_helm_endpoints_openstack_exporter_keystone_password) 2026-04-30 20:09:50.887693 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rgw_keystone_password) 2026-04-30 20:09:50.887840 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_keystone_password) 2026-04-30 20:09:50.887985 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_mariadb_password) 2026-04-30 20:09:50.888131 | instance | ok: [localhost] => (item=openstack_helm_endpoints_staffeln_mariadb_password) 2026-04-30 20:09:50.888271 | instance | 2026-04-30 20:09:50.888418 | instance | TASK [Generate base64 encoded secrets] ***************************************** 2026-04-30 20:09:50.888574 | instance | Thursday 30 April 2026 20:09:50 +0000 (0:00:00.391) 0:00:11.371 ******** 2026-04-30 20:09:50.938875 | instance | ok: [localhost] => (item=barbican_kek) 2026-04-30 20:09:50.939206 | instance | 2026-04-30 20:09:50.939543 | instance | TASK [Generate temporary files for generating keys for missing variables] ****** 2026-04-30 20:09:50.939877 | instance | Thursday 30 April 2026 20:09:50 +0000 (0:00:00.057) 0:00:11.429 ******** 2026-04-30 20:09:51.335783 | instance | changed: [localhost] => (item=manila_ssh_key) 2026-04-30 20:09:51.336159 | instance | changed: [localhost] => (item=nova_ssh_key) 2026-04-30 20:09:51.336484 | instance | 2026-04-30 20:09:51.336823 | instance | TASK [Generate SSH keys for missing variables] ********************************* 2026-04-30 20:09:51.337190 | instance | Thursday 30 April 2026 20:09:51 +0000 (0:00:00.396) 0:00:11.826 ******** 2026-04-30 20:09:56.643135 | instance | changed: [localhost] => (item=manila_ssh_key) 2026-04-30 20:09:56.643547 | instance | changed: [localhost] => (item=nova_ssh_key) 2026-04-30 20:09:56.643867 | instance | 2026-04-30 20:09:56.644197 | instance | TASK [Set values for SSH keys] ************************************************* 2026-04-30 20:09:56.644526 | instance | Thursday 30 April 2026 20:09:56 +0000 (0:00:05.307) 0:00:17.133 ******** 2026-04-30 20:09:56.695977 | instance | ok: [localhost] => (item=manila_ssh_key) 2026-04-30 20:09:56.696244 | instance | ok: [localhost] => (item=nova_ssh_key) 2026-04-30 20:09:56.696464 | instance | 2026-04-30 20:09:56.696680 | instance | TASK [Delete the temporary files generated for SSH keys] *********************** 2026-04-30 20:09:56.696892 | instance | Thursday 30 April 2026 20:09:56 +0000 (0:00:00.051) 0:00:17.185 ******** 2026-04-30 20:09:57.019437 | instance | changed: [localhost] => (item=manila_ssh_key) 2026-04-30 20:09:57.019454 | instance | changed: [localhost] => (item=nova_ssh_key) 2026-04-30 20:09:57.019459 | instance | 2026-04-30 20:09:57.019464 | instance | TASK [Write new secrets file to disk] ****************************************** 2026-04-30 20:09:57.019469 | instance | Thursday 30 April 2026 20:09:57 +0000 (0:00:00.324) 0:00:17.510 ******** 2026-04-30 20:09:57.366481 | instance | changed: [localhost] 2026-04-30 20:09:57.366505 | instance | 2026-04-30 20:09:57.366512 | instance | TASK [Encrypt secrets file with Vault password] ******************************** 2026-04-30 20:09:57.366518 | instance | Thursday 30 April 2026 20:09:57 +0000 (0:00:00.346) 0:00:17.856 ******** 2026-04-30 20:09:57.402101 | instance | skipping: [localhost] 2026-04-30 20:09:57.402145 | instance | 2026-04-30 20:09:57.402151 | instance | PLAY [Setup networking] ******************************************************** 2026-04-30 20:09:57.402155 | instance | 2026-04-30 20:09:57.402160 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-30 20:09:57.402164 | instance | Thursday 30 April 2026 20:09:57 +0000 (0:00:00.035) 0:00:17.892 ******** 2026-04-30 20:09:58.101361 | instance | ok: [instance] 2026-04-30 20:09:58.101441 | instance | 2026-04-30 20:09:58.101453 | instance | TASK [Create bridge for management network] ************************************ 2026-04-30 20:09:58.101464 | instance | Thursday 30 April 2026 20:09:58 +0000 (0:00:00.698) 0:00:18.590 ******** 2026-04-30 20:09:58.411352 | instance | ok: [instance] 2026-04-30 20:09:58.411564 | instance | 2026-04-30 20:09:58.411835 | instance | TASK [Create fake interface for management bridge] ***************************** 2026-04-30 20:09:58.412106 | instance | Thursday 30 April 2026 20:09:58 +0000 (0:00:00.310) 0:00:18.901 ******** 2026-04-30 20:09:58.630899 | instance | ok: [instance] 2026-04-30 20:09:58.631137 | instance | 2026-04-30 20:09:58.631415 | instance | TASK [Assign dummy interface to management bridge] ***************************** 2026-04-30 20:09:58.631692 | instance | Thursday 30 April 2026 20:09:58 +0000 (0:00:00.219) 0:00:19.121 ******** 2026-04-30 20:09:58.821395 | instance | ok: [instance] 2026-04-30 20:09:58.821665 | instance | 2026-04-30 20:09:58.822007 | instance | TASK [Assign IP address for management bridge] ********************************* 2026-04-30 20:09:58.822277 | instance | Thursday 30 April 2026 20:09:58 +0000 (0:00:00.190) 0:00:19.311 ******** 2026-04-30 20:09:59.018686 | instance | ok: [instance] 2026-04-30 20:09:59.018903 | instance | 2026-04-30 20:09:59.019185 | instance | TASK [Bring up interfaces] ***************************************************** 2026-04-30 20:09:59.019468 | instance | Thursday 30 April 2026 20:09:59 +0000 (0:00:00.197) 0:00:19.509 ******** 2026-04-30 20:09:59.400455 | instance | ok: [instance] => (item=br-mgmt) 2026-04-30 20:09:59.400884 | instance | ok: [instance] => (item=dummy0) 2026-04-30 20:09:59.401217 | instance | 2026-04-30 20:09:59.401680 | instance | PLAY [Create devices for Ceph] ************************************************* 2026-04-30 20:09:59.402140 | instance | 2026-04-30 20:09:59.402503 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-30 20:09:59.402875 | instance | Thursday 30 April 2026 20:09:59 +0000 (0:00:00.381) 0:00:19.891 ******** 2026-04-30 20:10:00.097947 | instance | ok: [instance] 2026-04-30 20:10:00.098027 | instance | 2026-04-30 20:10:00.098222 | instance | TASK [Install depedencies] ***************************************************** 2026-04-30 20:10:00.098469 | instance | Thursday 30 April 2026 20:10:00 +0000 (0:00:00.695) 0:00:20.586 ******** 2026-04-30 20:12:43.938324 | instance | fatal: [instance]: FAILED! => {"cache_update_time": 1777579715, "cache_updated": false, "changed": false, "msg": "'/usr/bin/apt-get -y -o \"Dpkg::Options::=--force-confdef\" -o \"Dpkg::Options::=--force-confold\" install 'lvm2=2.03.11-2.1ubuntu5'' failed: E: Failed to fetch http://nova.clouds.archive.ubuntu.com/ubuntu/pool/main/liba/libaio/libaio1_0.3.112-13build1_amd64.deb 503 Service Unavailable [IP: 2620:2d:4000:1::94 80]\nE: Failed to fetch http://nova.clouds.archive.ubuntu.com/ubuntu/pool/main/l/lvm2/libdevmapper-event1.02.1_1.02.175-2.1ubuntu5_amd64.deb 503 Service Unavailable [IP: 2620:2d:4000:1::93 80]\nE: Failed to fetch http://nova.clouds.archive.ubuntu.com/ubuntu/pool/main/l/lvm2/liblvm2cmd2.03_2.03.11-2.1ubuntu5_amd64.deb 503 Service Unavailable [IP: 2620:2d:4000:1::93 80]\nE: Failed to fetch http://nova.clouds.archive.ubuntu.com/ubuntu/pool/main/l/lvm2/dmeventd_1.02.175-2.1ubuntu5_amd64.deb 503 Service Unavailable [IP: 2620:2d:4000:1::93 80]\nE: Failed to fetch http://nova.clouds.archive.ubuntu.com/ubuntu/pool/main/l/lvm2/lvm2_2.03.11-2.1ubuntu5_amd64.deb 503 Service Unavailable [IP: 2620:2d:4000:1::93 80]\nE: Unable to fetch some archives, maybe run apt-get update or try with --fix-missing?\n", "rc": 100, "stderr": "E: Failed to fetch http://nova.clouds.archive.ubuntu.com/ubuntu/pool/main/liba/libaio/libaio1_0.3.112-13build1_amd64.deb 503 Service Unavailable [IP: 2620:2d:4000:1::94 80]\nE: Failed to fetch http://nova.clouds.archive.ubuntu.com/ubuntu/pool/main/l/lvm2/libdevmapper-event1.02.1_1.02.175-2.1ubuntu5_amd64.deb 503 Service Unavailable [IP: 2620:2d:4000:1::93 80]\nE: Failed to fetch http://nova.clouds.archive.ubuntu.com/ubuntu/pool/main/l/lvm2/liblvm2cmd2.03_2.03.11-2.1ubuntu5_amd64.deb 503 Service Unavailable [IP: 2620:2d:4000:1::93 80]\nE: Failed to fetch http://nova.clouds.archive.ubuntu.com/ubuntu/pool/main/l/lvm2/dmeventd_1.02.175-2.1ubuntu5_amd64.deb 503 Service Unavailable [IP: 2620:2d:4000:1::93 80]\nE: Failed to fetch http://nova.clouds.archive.ubuntu.com/ubuntu/pool/main/l/lvm2/lvm2_2.03.11-2.1ubuntu5_amd64.deb 503 Service Unavailable [IP: 2620:2d:4000:1::93 80]\nE: Unable to fetch some archives, maybe run apt-get update or try with --fix-missing?\n", "stderr_lines": ["E: Failed to fetch http://nova.clouds.archive.ubuntu.com/ubuntu/pool/main/liba/libaio/libaio1_0.3.112-13build1_amd64.deb 503 Service Unavailable [IP: 2620:2d:4000:1::94 80]", "E: Failed to fetch http://nova.clouds.archive.ubuntu.com/ubuntu/pool/main/l/lvm2/libdevmapper-event1.02.1_1.02.175-2.1ubuntu5_amd64.deb 503 Service Unavailable [IP: 2620:2d:4000:1::93 80]", "E: Failed to fetch http://nova.clouds.archive.ubuntu.com/ubuntu/pool/main/l/lvm2/liblvm2cmd2.03_2.03.11-2.1ubuntu5_amd64.deb 503 Service Unavailable [IP: 2620:2d:4000:1::93 80]", "E: Failed to fetch http://nova.clouds.archive.ubuntu.com/ubuntu/pool/main/l/lvm2/dmeventd_1.02.175-2.1ubuntu5_amd64.deb 503 Service Unavailable [IP: 2620:2d:4000:1::93 80]", "E: Failed to fetch http://nova.clouds.archive.ubuntu.com/ubuntu/pool/main/l/lvm2/lvm2_2.03.11-2.1ubuntu5_amd64.deb 503 Service Unavailable [IP: 2620:2d:4000:1::93 80]", "E: Unable to fetch some archives, maybe run apt-get update or try with --fix-missing?"], "stdout": "Reading package lists...\nBuilding dependency tree...\nReading state information...\nThe following additional packages will be installed:\n dmeventd libaio1 libdevmapper-event1.02.1 liblvm2cmd2.03\nRecommended packages:\n thin-provisioning-tools\nThe following NEW packages will be installed:\n dmeventd libaio1 libdevmapper-event1.02.1 liblvm2cmd2.03 lvm2\n0 upgraded, 5 newly installed, 0 to remove and 3 not upgraded.\nNeed to get 1969 kB of archives.\nAfter this operation, 7508 kB of additional disk space will be used.\nIgn:1 http://nova.clouds.archive.ubuntu.com/ubuntu jammy/main amd64 libaio1 amd64 0.3.112-13build1\nIgn:2 http://nova.clouds.archive.ubuntu.com/ubuntu jammy-updates/main amd64 libdevmapper-event1.02.1 amd64 2:1.02.175-2.1ubuntu5\nIgn:3 http://nova.clouds.archive.ubuntu.com/ubuntu jammy-updates/main amd64 liblvm2cmd2.03 amd64 2.03.11-2.1ubuntu5\nIgn:4 http://nova.clouds.archive.ubuntu.com/ubuntu jammy-updates/main amd64 dmeventd amd64 2:1.02.175-2.1ubuntu5\nIgn:5 http://nova.clouds.archive.ubuntu.com/ubuntu jammy-updates/main amd64 lvm2 amd64 2.03.11-2.1ubuntu5\nIgn:1 http://nova.clouds.archive.ubuntu.com/ubuntu jammy/main amd64 libaio1 amd64 0.3.112-13build1\nIgn:2 http://nova.clouds.archive.ubuntu.com/ubuntu jammy-updates/main amd64 libdevmapper-event1.02.1 amd64 2:1.02.175-2.1ubuntu5\nIgn:3 http://nova.clouds.archive.ubuntu.com/ubuntu jammy-updates/main amd64 liblvm2cmd2.03 amd64 2.03.11-2.1ubuntu5\nIgn:4 http://nova.clouds.archive.ubuntu.com/ubuntu jammy-updates/main amd64 dmeventd amd64 2:1.02.175-2.1ubuntu5\nIgn:5 http://nova.clouds.archive.ubuntu.com/ubuntu jammy-updates/main amd64 lvm2 amd64 2.03.11-2.1ubuntu5\nIgn:1 http://nova.clouds.archive.ubuntu.com/ubuntu jammy/main amd64 libaio1 amd64 0.3.112-13build1\nIgn:2 http://nova.clouds.archive.ubuntu.com/ubuntu jammy-updates/main amd64 libdevmapper-event1.02.1 amd64 2:1.02.175-2.1ubuntu5\nIgn:3 http://nova.clouds.archive.ubuntu.com/ubuntu jammy-updates/main amd64 liblvm2cmd2.03 amd64 2.03.11-2.1ubuntu5\nIgn:4 http://nova.clouds.archive.ubuntu.com/ubuntu jammy-updates/main amd64 dmeventd amd64 2:1.02.175-2.1ubuntu5\nIgn:5 http://nova.clouds.archive.ubuntu.com/ubuntu jammy-updates/main amd64 lvm2 amd64 2.03.11-2.1ubuntu5\nErr:1 http://nova.clouds.archive.ubuntu.com/ubuntu jammy/main amd64 libaio1 amd64 0.3.112-13build1\n 503 Service Unavailable [IP: 2620:2d:4000:1::94 80]\nErr:2 http://nova.clouds.archive.ubuntu.com/ubuntu jammy-updates/main amd64 libdevmapper-event1.02.1 amd64 2:1.02.175-2.1ubuntu5\n 503 Service Unavailable [IP: 2620:2d:4000:1::93 80]\nErr:3 http://nova.clouds.archive.ubuntu.com/ubuntu jammy-updates/main amd64 liblvm2cmd2.03 amd64 2.03.11-2.1ubuntu5\n 503 Service Unavailable [IP: 2620:2d:4000:1::93 80]\nErr:4 http://nova.clouds.archive.ubuntu.com/ubuntu jammy-updates/main amd64 dmeventd amd64 2:1.02.175-2.1ubuntu5\n 503 Service Unavailable [IP: 2620:2d:4000:1::93 80]\nErr:5 http://nova.clouds.archive.ubuntu.com/ubuntu jammy-updates/main amd64 lvm2 amd64 2.03.11-2.1ubuntu5\n 503 Service Unavailable [IP: 2620:2d:4000:1::93 80]\n", "stdout_lines": ["Reading package lists...", "Building dependency tree...", "Reading state information...", "The following additional packages will be installed:", " dmeventd libaio1 libdevmapper-event1.02.1 liblvm2cmd2.03", "Recommended packages:", " thin-provisioning-tools", "The following NEW packages will be installed:", " dmeventd libaio1 libdevmapper-event1.02.1 liblvm2cmd2.03 lvm2", "0 upgraded, 5 newly installed, 0 to remove and 3 not upgraded.", "Need to get 1969 kB of archives.", "After this operation, 7508 kB of additional disk space will be used.", "Ign:1 http://nova.clouds.archive.ubuntu.com/ubuntu jammy/main amd64 libaio1 amd64 0.3.112-13build1", "Ign:2 http://nova.clouds.archive.ubuntu.com/ubuntu jammy-updates/main amd64 libdevmapper-event1.02.1 amd64 2:1.02.175-2.1ubuntu5", "Ign:3 http://nova.clouds.archive.ubuntu.com/ubuntu jammy-updates/main amd64 liblvm2cmd2.03 amd64 2.03.11-2.1ubuntu5", "Ign:4 http://nova.clouds.archive.ubuntu.com/ubuntu jammy-updates/main amd64 dmeventd amd64 2:1.02.175-2.1ubuntu5", "Ign:5 http://nova.clouds.archive.ubuntu.com/ubuntu jammy-updates/main amd64 lvm2 amd64 2.03.11-2.1ubuntu5", "Ign:1 http://nova.clouds.archive.ubuntu.com/ubuntu jammy/main amd64 libaio1 amd64 0.3.112-13build1", "Ign:2 http://nova.clouds.archive.ubuntu.com/ubuntu jammy-updates/main amd64 libdevmapper-event1.02.1 amd64 2:1.02.175-2.1ubuntu5", "Ign:3 http://nova.clouds.archive.ubuntu.com/ubuntu jammy-updates/main amd64 liblvm2cmd2.03 amd64 2.03.11-2.1ubuntu5", "Ign:4 http://nova.clouds.archive.ubuntu.com/ubuntu jammy-updates/main amd64 dmeventd amd64 2:1.02.175-2.1ubuntu5", "Ign:5 http://nova.clouds.archive.ubuntu.com/ubuntu jammy-updates/main amd64 lvm2 amd64 2.03.11-2.1ubuntu5", "Ign:1 http://nova.clouds.archive.ubuntu.com/ubuntu jammy/main amd64 libaio1 amd64 0.3.112-13build1", "Ign:2 http://nova.clouds.archive.ubuntu.com/ubuntu jammy-updates/main amd64 libdevmapper-event1.02.1 amd64 2:1.02.175-2.1ubuntu5", "Ign:3 http://nova.clouds.archive.ubuntu.com/ubuntu jammy-updates/main amd64 liblvm2cmd2.03 amd64 2.03.11-2.1ubuntu5", "Ign:4 http://nova.clouds.archive.ubuntu.com/ubuntu jammy-updates/main amd64 dmeventd amd64 2:1.02.175-2.1ubuntu5", "Ign:5 http://nova.clouds.archive.ubuntu.com/ubuntu jammy-updates/main amd64 lvm2 amd64 2.03.11-2.1ubuntu5", "Err:1 http://nova.clouds.archive.ubuntu.com/ubuntu jammy/main amd64 libaio1 amd64 0.3.112-13build1", " 503 Service Unavailable [IP: 2620:2d:4000:1::94 80]", "Err:2 http://nova.clouds.archive.ubuntu.com/ubuntu jammy-updates/main amd64 libdevmapper-event1.02.1 amd64 2:1.02.175-2.1ubuntu5", " 503 Service Unavailable [IP: 2620:2d:4000:1::93 80]", "Err:3 http://nova.clouds.archive.ubuntu.com/ubuntu jammy-updates/main amd64 liblvm2cmd2.03 amd64 2.03.11-2.1ubuntu5", " 503 Service Unavailable [IP: 2620:2d:4000:1::93 80]", "Err:4 http://nova.clouds.archive.ubuntu.com/ubuntu jammy-updates/main amd64 dmeventd amd64 2:1.02.175-2.1ubuntu5", " 503 Service Unavailable [IP: 2620:2d:4000:1::93 80]", "Err:5 http://nova.clouds.archive.ubuntu.com/ubuntu jammy-updates/main amd64 lvm2 amd64 2.03.11-2.1ubuntu5", " 503 Service Unavailable [IP: 2620:2d:4000:1::93 80]"]} 2026-04-30 20:12:43.938968 | instance | 2026-04-30 20:12:43.939355 | instance | PLAY RECAP ********************************************************************* 2026-04-30 20:12:43.939746 | instance | instance : ok=12 changed=2 unreachable=0 failed=1 skipped=0 rescued=0 ignored=0 2026-04-30 20:12:43.940099 | instance | localhost : ok=40 changed=21 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-04-30 20:12:43.940240 | instance | 2026-04-30 20:12:43.940398 | instance | Thursday 30 April 2026 20:12:43 +0000 (0:02:43.841) 0:03:04.428 ******** 2026-04-30 20:12:43.940545 | instance | =============================================================================== 2026-04-30 20:12:43.940704 | instance | Install depedencies --------------------------------------------------- 163.84s 2026-04-30 20:12:43.940857 | instance | Generate SSH keys for missing variables --------------------------------- 5.31s 2026-04-30 20:12:43.941005 | instance | Gathering Facts --------------------------------------------------------- 1.13s 2026-04-30 20:12:43.941153 | instance | Install "dirmngr" for GPG keyserver operations -------------------------- 1.12s 2026-04-30 20:12:43.941317 | instance | Create folders for workspace -------------------------------------------- 0.98s 2026-04-30 20:12:43.941468 | instance | Generate endpoint skeleton for missing variables ------------------------ 0.72s 2026-04-30 20:12:43.941616 | instance | Gathering Facts --------------------------------------------------------- 0.70s 2026-04-30 20:12:43.941765 | instance | Gathering Facts --------------------------------------------------------- 0.70s 2026-04-30 20:12:43.941934 | instance | Configure short hostname ------------------------------------------------ 0.69s 2026-04-30 20:12:43.942085 | instance | Gathering Facts --------------------------------------------------------- 0.67s 2026-04-30 20:12:43.942232 | instance | Purge "snapd" package --------------------------------------------------- 0.66s 2026-04-30 20:12:43.942381 | instance | Write new Ceph control plane configuration file to disk ----------------- 0.56s 2026-04-30 20:12:43.942529 | instance | Generate temporary files for generating keys for missing variables ------ 0.40s 2026-04-30 20:12:43.942678 | instance | Generate secrets for missing variables ---------------------------------- 0.39s 2026-04-30 20:12:43.942856 | instance | Bring up interfaces ----------------------------------------------------- 0.38s 2026-04-30 20:12:43.943007 | instance | Write new Keepalived configuration file to disk ------------------------- 0.38s 2026-04-30 20:12:43.943156 | instance | Write new Nova configuration file to disk ------------------------------- 0.37s 2026-04-30 20:12:43.943305 | instance | Write new Neutron configuration file to disk ---------------------------- 0.36s 2026-04-30 20:12:43.943452 | instance | Write new secrets file to disk ------------------------------------------ 0.35s 2026-04-30 20:12:43.943610 | instance | Write new Kubernetes configuration file to disk ------------------------- 0.34s 2026-04-30 20:12:44.004392 | instance | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.aio/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/aio/prepare.yml 2026-04-30 20:12:44.004682 | instance | ERROR [aio > prepare] Executed: Failed 2026-04-30 20:12:44.004873 | instance | ERROR Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.aio/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/aio/prepare.yml 2026-04-30 20:12:44.303563 | instance | ERROR 2026-04-30 20:12:44.303881 | instance | { 2026-04-30 20:12:44.303946 | instance | "delta": "0:03:57.305343", 2026-04-30 20:12:44.303995 | instance | "end": "2026-04-30 20:12:44.084384", 2026-04-30 20:12:44.304038 | instance | "msg": "non-zero return code", 2026-04-30 20:12:44.304081 | instance | "rc": 2, 2026-04-30 20:12:44.304126 | instance | "start": "2026-04-30 20:08:46.779041" 2026-04-30 20:12:44.304168 | instance | } failure 2026-04-30 20:12:44.310989 | 2026-04-30 20:12:44.311044 | PLAY RECAP 2026-04-30 20:12:44.311091 | instance | ok: 2 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-04-30 20:12:44.311115 | 2026-04-30 20:12:44.450206 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-30 20:12:44.460727 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main] 2026-04-30 20:12:45.110292 | 2026-04-30 20:12:45.110416 | PLAY [all] 2026-04-30 20:12:45.124642 | 2026-04-30 20:12:45.124722 | TASK [gather-host-logs : creating directory for system status] 2026-04-30 20:12:45.485043 | instance | changed 2026-04-30 20:12:45.490631 | 2026-04-30 20:12:45.490719 | TASK [gather-host-logs : Get logs for each host] 2026-04-30 20:12:45.827574 | instance | + systemd-cgls --full --all --no-pager 2026-04-30 20:12:45.839656 | instance | + ip addr 2026-04-30 20:12:45.841048 | instance | + ip route 2026-04-30 20:12:45.842253 | instance | + lsblk 2026-04-30 20:12:45.844307 | instance | + mount 2026-04-30 20:12:45.845584 | instance | + docker images 2026-04-30 20:12:45.846639 | instance | /bin/bash: line 7: docker: command not found 2026-04-30 20:12:45.846908 | instance | + brctl show 2026-04-30 20:12:45.847297 | instance | /bin/bash: line 8: brctl: command not found 2026-04-30 20:12:45.847523 | instance | + ps aux --sort=-%mem 2026-04-30 20:12:45.860157 | instance | + dpkg -l 2026-04-30 20:12:45.870993 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-04-30 20:12:45.871303 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-04-30 20:12:45.871346 | instance | /bin/bash: line 11: docker: command not found 2026-04-30 20:12:45.871546 | instance | + '[' '!' -z '' ']' 2026-04-30 20:12:46.031401 | instance | ok: Runtime: 0:00:00.049146 2026-04-30 20:12:46.040152 | 2026-04-30 20:12:46.040246 | TASK [gather-host-logs : Downloads logs to executor] 2026-04-30 20:12:46.672601 | instance | changed: 2026-04-30 20:12:46.672792 | instance | created directory /var/lib/zuul/builds/70a032bf13c7456f8c33b0077c3729cf/work/logs/instance 2026-04-30 20:12:46.672833 | instance | cd+++++++++ system/ 2026-04-30 20:12:46.672864 | instance | >f+++++++++ system/brctl-show.txt 2026-04-30 20:12:46.672894 | instance | >f+++++++++ system/docker-images.txt 2026-04-30 20:12:46.672922 | instance | >f+++++++++ system/ip-addr.txt 2026-04-30 20:12:46.672972 | instance | >f+++++++++ system/ip-route.txt 2026-04-30 20:12:46.673007 | instance | >f+++++++++ system/lsblk.txt 2026-04-30 20:12:46.673036 | instance | >f+++++++++ system/mount.txt 2026-04-30 20:12:46.673066 | instance | >f+++++++++ system/packages.txt 2026-04-30 20:12:46.673097 | instance | >f+++++++++ system/ps.txt 2026-04-30 20:12:46.673123 | instance | >f+++++++++ system/systemd-cgls.txt 2026-04-30 20:12:46.685327 | 2026-04-30 20:12:46.685397 | LOOP [helm-release-status : creating directory for helm release status] 2026-04-30 20:12:46.884741 | instance | changed: "values" 2026-04-30 20:12:47.042201 | instance | changed: "releases" 2026-04-30 20:12:47.060719 | 2026-04-30 20:12:47.060851 | TASK [helm-release-status : Gather get release status for helm charts] 2026-04-30 20:12:47.266879 | instance | /bin/bash: line 3: kubectl: command not found 2026-04-30 20:12:47.597800 | instance | ok: Runtime: 0:00:00.006253 2026-04-30 20:12:47.644645 | 2026-04-30 20:12:47.644824 | TASK [helm-release-status : Downloads logs to executor] 2026-04-30 20:12:48.135757 | instance | changed: 2026-04-30 20:12:48.135932 | instance | cd+++++++++ helm/ 2026-04-30 20:12:48.135959 | instance | cd+++++++++ helm/releases/ 2026-04-30 20:12:48.135980 | instance | cd+++++++++ helm/values/ 2026-04-30 20:12:48.145161 | 2026-04-30 20:12:48.145228 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-04-30 20:12:48.341065 | instance | changed 2026-04-30 20:12:48.347827 | 2026-04-30 20:12:48.347919 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-04-30 20:12:48.558760 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-30 20:12:48.559150 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-30 20:12:48.564250 | instance | environment: line 1: kubectl: command not found 2026-04-30 20:12:48.565631 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-30 20:12:48.566007 | instance | environment: line 1: kubectl: command not found 2026-04-30 20:12:48.567248 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-30 20:12:48.569005 | instance | environment: line 1: kubectl: command not found 2026-04-30 20:12:48.570715 | instance | environment: line 1: kubectl: command not found 2026-04-30 20:12:48.571026 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-30 20:12:48.571975 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-30 20:12:48.573528 | instance | environment: line 1: kubectl: command not found 2026-04-30 20:12:48.574886 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-30 20:12:48.889619 | instance | ok: Runtime: 0:00:00.024375 2026-04-30 20:12:48.896544 | 2026-04-30 20:12:48.896606 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-04-30 20:12:49.103233 | instance | changed 2026-04-30 20:12:49.109311 | 2026-04-30 20:12:49.109386 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-04-30 20:12:49.343665 | instance | environment: line 5: kubectl: command not found 2026-04-30 20:12:49.344399 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-30 20:12:49.344423 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-30 20:12:49.344798 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-30 20:12:49.648254 | instance | ok: Runtime: 0:00:00.008859 2026-04-30 20:12:49.655738 | 2026-04-30 20:12:49.655827 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-04-30 20:12:50.139026 | instance | changed: 2026-04-30 20:12:50.139230 | instance | cd+++++++++ objects/ 2026-04-30 20:12:50.139257 | instance | cd+++++++++ objects/cluster/ 2026-04-30 20:12:50.139280 | instance | cd+++++++++ objects/namespaced/ 2026-04-30 20:12:50.148887 | 2026-04-30 20:12:50.148974 | TASK [gather-pod-logs : creating directory for pod logs] 2026-04-30 20:12:50.345868 | instance | changed 2026-04-30 20:12:50.353206 | 2026-04-30 20:12:50.353276 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-04-30 20:12:50.560906 | instance | changed 2026-04-30 20:12:50.569495 | 2026-04-30 20:12:50.569634 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-04-30 20:12:50.789520 | instance | environment: line 3: kubectl: command not found 2026-04-30 20:12:51.107427 | instance | ok: Runtime: 0:00:00.007547 2026-04-30 20:12:51.114633 | 2026-04-30 20:12:51.114729 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-04-30 20:12:51.595716 | instance | changed: 2026-04-30 20:12:51.595915 | instance | cd+++++++++ pod-logs/ 2026-04-30 20:12:51.595941 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-04-30 20:12:51.605190 | 2026-04-30 20:12:51.605256 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-04-30 20:12:51.792644 | instance | changed 2026-04-30 20:12:51.797887 | 2026-04-30 20:12:51.797983 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-04-30 20:12:52.005332 | instance | /bin/bash: line 2: kubectl: command not found 2026-04-30 20:12:52.335047 | instance | ok: Runtime: 0:00:00.038240 2026-04-30 20:12:52.340300 | 2026-04-30 20:12:52.340369 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-04-30 20:12:52.540251 | instance | /bin/bash: line 2: kubectl: command not found 2026-04-30 20:12:52.570828 | instance | ceph-mgr endpoints: 2026-04-30 20:12:52.876828 | instance | ok: Runtime: 0:00:00.036064 2026-04-30 20:12:52.882651 | 2026-04-30 20:12:52.882718 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-04-30 20:12:53.085897 | instance | /bin/bash: line 4: kubectl: command not found 2026-04-30 20:12:53.419515 | instance | ok: Runtime: 0:00:00.034486 2026-04-30 20:12:53.478725 | 2026-04-30 20:12:53.478888 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-04-30 20:12:53.964147 | instance | changed: cd+++++++++ prometheus/ 2026-04-30 20:12:53.974856 | 2026-04-30 20:12:53.974924 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-04-30 20:12:54.172565 | instance | changed 2026-04-30 20:12:54.179609 | 2026-04-30 20:12:54.179703 | TASK [gather-selenium-data : Get selenium data] 2026-04-30 20:12:54.386943 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-04-30 20:12:54.388334 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-04-30 20:12:54.721202 | instance | ERROR 2026-04-30 20:12:54.721465 | instance | { 2026-04-30 20:12:54.721517 | instance | "delta": "0:00:00.005519", 2026-04-30 20:12:54.721553 | instance | "end": "2026-04-30 20:12:54.388658", 2026-04-30 20:12:54.721617 | instance | "msg": "non-zero return code", 2026-04-30 20:12:54.721652 | instance | "rc": 1, 2026-04-30 20:12:54.721680 | instance | "start": "2026-04-30 20:12:54.383139" 2026-04-30 20:12:54.721706 | instance | } 2026-04-30 20:12:54.721744 | instance | ERROR: Ignoring Errors 2026-04-30 20:12:54.729114 | 2026-04-30 20:12:54.729218 | TASK [gather-selenium-data : Downloads logs to executor] 2026-04-30 20:12:55.229744 | instance | changed: cd+++++++++ selenium/ 2026-04-30 20:12:55.235735 | 2026-04-30 20:12:55.235785 | PLAY RECAP 2026-04-30 20:12:55.235832 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-04-30 20:12:55.235853 | 2026-04-30 20:12:55.364685 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main] 2026-04-30 20:12:55.377128 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-30 20:12:55.984177 | 2026-04-30 20:12:55.984300 | PLAY [all] 2026-04-30 20:12:55.995007 | 2026-04-30 20:12:55.995082 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-30 20:12:56.039782 | instance | skipping: Conditional result was False 2026-04-30 20:12:56.049636 | 2026-04-30 20:12:56.049712 | TASK [fetch-output : Set log path for single node] 2026-04-30 20:12:56.093650 | instance | ok 2026-04-30 20:12:56.101384 | 2026-04-30 20:12:56.101473 | LOOP [fetch-output : Ensure local output dirs] 2026-04-30 20:12:56.505291 | instance -> localhost | ok: "/var/lib/zuul/builds/70a032bf13c7456f8c33b0077c3729cf/work/logs" 2026-04-30 20:12:56.753009 | instance -> localhost | changed: "/var/lib/zuul/builds/70a032bf13c7456f8c33b0077c3729cf/work/artifacts" 2026-04-30 20:12:56.962693 | instance -> localhost | changed: "/var/lib/zuul/builds/70a032bf13c7456f8c33b0077c3729cf/work/docs" 2026-04-30 20:12:56.978226 | 2026-04-30 20:12:56.978374 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-30 20:12:57.608041 | instance | changed: .d..t...... ./ 2026-04-30 20:12:57.608318 | instance | changed: All items complete 2026-04-30 20:12:57.608363 | 2026-04-30 20:12:58.047806 | instance | changed: .d..t...... ./ 2026-04-30 20:12:58.496480 | instance | changed: .d..t...... ./ 2026-04-30 20:12:58.517187 | 2026-04-30 20:12:58.517343 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-30 20:12:59.946294 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.008328 2026-04-30 20:13:00.178384 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007772 2026-04-30 20:13:00.199753 | 2026-04-30 20:13:00.199899 | PLAY [all] 2026-04-30 20:13:00.207271 | 2026-04-30 20:13:00.207340 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-30 20:13:00.638222 | instance | changed 2026-04-30 20:13:00.645814 | 2026-04-30 20:13:00.645868 | PLAY RECAP 2026-04-30 20:13:00.645917 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-30 20:13:00.645940 | 2026-04-30 20:13:00.796758 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-30 20:13:00.809756 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-30 20:13:01.408751 | 2026-04-30 20:13:01.408891 | PLAY [localhost] 2026-04-30 20:13:01.418817 | 2026-04-30 20:13:01.418891 | TASK [Generate Zuul manifest] 2026-04-30 20:13:01.441496 | localhost | ok 2026-04-30 20:13:01.457902 | 2026-04-30 20:13:01.457980 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-30 20:13:01.824788 | localhost | changed 2026-04-30 20:13:01.836146 | 2026-04-30 20:13:01.836223 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-30 20:13:02.214979 | localhost | ok 2026-04-30 20:13:02.222816 | 2026-04-30 20:13:02.222885 | TASK [Upload logs] 2026-04-30 20:13:02.244780 | localhost | ok 2026-04-30 20:13:02.355967 | 2026-04-30 20:13:02.356127 | TASK [Set zuul-log-path fact] 2026-04-30 20:13:02.378082 | localhost | ok 2026-04-30 20:13:02.390854 | 2026-04-30 20:13:02.390922 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-30 20:13:02.422119 | localhost | ok 2026-04-30 20:13:02.430823 | 2026-04-30 20:13:02.430901 | TASK [upload-logs : Create log directories] 2026-04-30 20:13:02.792196 | localhost | changed 2026-04-30 20:13:02.800129 | 2026-04-30 20:13:02.800197 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-30 20:13:03.149881 | localhost -> localhost | ok: Runtime: 0:00:00.004679 2026-04-30 20:13:03.155792 | 2026-04-30 20:13:03.155877 | TASK [upload-logs : Upload logs to log server] 2026-04-30 20:13:03.577905 | localhost | Output suppressed because no_log was given 2026-04-30 20:13:03.583093 | 2026-04-30 20:13:03.583181 | LOOP [upload-logs : Compress console log and json output] 2026-04-30 20:13:03.628157 | localhost | skipping: Conditional result was False 2026-04-30 20:13:03.636493 | localhost | skipping: Conditional result was False 2026-04-30 20:13:03.649370 | 2026-04-30 20:13:03.649620 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-30 20:13:03.689572 | localhost | skipping: Conditional result was False 2026-04-30 20:13:03.689881 | 2026-04-30 20:13:03.693762 | localhost | skipping: Conditional result was False 2026-04-30 20:13:03.706505 | 2026-04-30 20:13:03.706671 | LOOP [upload-logs : Upload console log and json output]