2026-04-13 22:29:08.191905 | Job console starting 2026-04-13 22:29:08.202026 | Updating git repos 2026-04-13 22:29:08.262676 | Cloning repos into workspace 2026-04-13 22:29:08.619032 | Restoring repo states 2026-04-13 22:29:08.638111 | Merging changes 2026-04-13 22:29:09.500670 | Checking out repos 2026-04-13 22:29:09.601863 | Preparing playbooks 2026-04-13 22:29:12.106899 | Running Ansible setup 2026-04-13 22:29:15.823376 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-13 22:29:16.462361 | 2026-04-13 22:29:16.462498 | PLAY [localhost] 2026-04-13 22:29:16.470064 | 2026-04-13 22:29:16.470136 | TASK [Gathering Facts] 2026-04-13 22:29:17.333976 | localhost | ok 2026-04-13 22:29:17.344271 | 2026-04-13 22:29:17.344348 | TASK [Setup log path fact] 2026-04-13 22:29:17.364738 | localhost | ok 2026-04-13 22:29:17.376474 | 2026-04-13 22:29:17.376535 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-13 22:29:17.406429 | localhost | ok 2026-04-13 22:29:17.415169 | 2026-04-13 22:29:17.415257 | TASK [emit-job-header : Print job information] 2026-04-13 22:29:17.458088 | # Job Information 2026-04-13 22:29:17.458348 | Ansible Version: 2.16.16 2026-04-13 22:29:17.458408 | Job: atmosphere-molecule-aio-openvswitch 2026-04-13 22:29:17.458450 | Pipeline: check 2026-04-13 22:29:17.458490 | Executor: 0a8996d2b663 2026-04-13 22:29:17.458528 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3818 2026-04-13 22:29:17.458571 | Event ID: 1814c3d0-3788-11f1-8424-5cb41ea20737 2026-04-13 22:29:17.463811 | 2026-04-13 22:29:17.463959 | LOOP [emit-job-header : Print node information] 2026-04-13 22:29:17.574727 | localhost | ok: 2026-04-13 22:29:17.575002 | localhost | # Node Information 2026-04-13 22:29:17.575068 | localhost | Inventory Hostname: instance 2026-04-13 22:29:17.575127 | localhost | Hostname: np0000165846 2026-04-13 22:29:17.575174 | localhost | Username: zuul 2026-04-13 22:29:17.575228 | localhost | Distro: Ubuntu 22.04 2026-04-13 22:29:17.575273 | localhost | Provider: yul1 2026-04-13 22:29:17.575317 | localhost | Region: ca-ymq-1 2026-04-13 22:29:17.575375 | localhost | Label: ubuntu-jammy-16 2026-04-13 22:29:17.575421 | localhost | Product Name: OpenStack Nova 2026-04-13 22:29:17.575471 | localhost | Interface IP: 199.204.45.246 2026-04-13 22:29:17.588418 | 2026-04-13 22:29:17.588568 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-13 22:29:17.970940 | localhost -> localhost | changed 2026-04-13 22:29:18.026131 | 2026-04-13 22:29:18.026315 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-13 22:29:18.901342 | localhost -> localhost | changed 2026-04-13 22:29:18.910988 | 2026-04-13 22:29:18.911061 | PLAY [all] 2026-04-13 22:29:18.918901 | 2026-04-13 22:29:18.918988 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-13 22:29:19.156779 | instance -> localhost | ok 2026-04-13 22:29:19.167837 | 2026-04-13 22:29:19.167948 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-13 22:29:19.201391 | instance | ok 2026-04-13 22:29:19.216064 | instance | included: /var/lib/zuul/builds/5010206435994aa399fb021f4b428425/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-13 22:29:19.221761 | 2026-04-13 22:29:19.221828 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-13 22:29:20.632709 | instance -> localhost | Generating public/private rsa key pair. 2026-04-13 22:29:20.632918 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/5010206435994aa399fb021f4b428425/work/5010206435994aa399fb021f4b428425_id_rsa 2026-04-13 22:29:20.632982 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/5010206435994aa399fb021f4b428425/work/5010206435994aa399fb021f4b428425_id_rsa.pub 2026-04-13 22:29:20.633020 | instance -> localhost | The key fingerprint is: 2026-04-13 22:29:20.633051 | instance -> localhost | SHA256:Ppq1t/nWPHncEvHCQfLXmS3l9iCAeqUfjR9VkfZ+XKE zuul-build-sshkey 2026-04-13 22:29:20.633107 | instance -> localhost | The key's randomart image is: 2026-04-13 22:29:20.633145 | instance -> localhost | +---[RSA 3072]----+ 2026-04-13 22:29:20.633179 | instance -> localhost | | . o+| 2026-04-13 22:29:20.633209 | instance -> localhost | | . o . o+.| 2026-04-13 22:29:20.633238 | instance -> localhost | | . o + =ooB| 2026-04-13 22:29:20.633266 | instance -> localhost | | . o o +E*oO| 2026-04-13 22:29:20.633294 | instance -> localhost | | .S. o + @o| 2026-04-13 22:29:20.633322 | instance -> localhost | | . . . + *| 2026-04-13 22:29:20.633349 | instance -> localhost | | + o =o| 2026-04-13 22:29:20.633376 | instance -> localhost | | + o... * +| 2026-04-13 22:29:20.633409 | instance -> localhost | | o ..o+. + | 2026-04-13 22:29:20.633438 | instance -> localhost | +----[SHA256]-----+ 2026-04-13 22:29:20.633501 | instance -> localhost | ok: Runtime: 0:00:00.961923 2026-04-13 22:29:20.639526 | 2026-04-13 22:29:20.639589 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-13 22:29:20.673325 | instance | ok 2026-04-13 22:29:20.682551 | instance | included: /var/lib/zuul/builds/5010206435994aa399fb021f4b428425/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-13 22:29:20.689915 | 2026-04-13 22:29:20.689978 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-13 22:29:20.715496 | instance | skipping: Conditional result was False 2026-04-13 22:29:20.727157 | 2026-04-13 22:29:20.727289 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-13 22:29:21.190332 | instance | changed 2026-04-13 22:29:21.196607 | 2026-04-13 22:29:21.196690 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-13 22:29:21.383133 | instance | ok 2026-04-13 22:29:21.389046 | 2026-04-13 22:29:21.389110 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-13 22:29:21.837913 | instance | changed 2026-04-13 22:29:21.844385 | 2026-04-13 22:29:21.844446 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-13 22:29:22.301782 | instance | changed 2026-04-13 22:29:22.308625 | 2026-04-13 22:29:22.308690 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-13 22:29:22.333839 | instance | skipping: Conditional result was False 2026-04-13 22:29:22.374607 | 2026-04-13 22:29:22.374737 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-13 22:29:22.703705 | instance -> localhost | changed 2026-04-13 22:29:22.718864 | 2026-04-13 22:29:22.718930 | TASK [add-build-sshkey : Add back temp key] 2026-04-13 22:29:23.037302 | instance -> localhost | Identity added: /var/lib/zuul/builds/5010206435994aa399fb021f4b428425/work/5010206435994aa399fb021f4b428425_id_rsa (zuul-build-sshkey) 2026-04-13 22:29:23.037601 | instance -> localhost | ok: Runtime: 0:00:00.014006 2026-04-13 22:29:23.042679 | 2026-04-13 22:29:23.042742 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-13 22:29:23.299082 | instance | ok 2026-04-13 22:29:23.306072 | 2026-04-13 22:29:23.306132 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-13 22:29:23.330923 | instance | skipping: Conditional result was False 2026-04-13 22:29:23.344305 | 2026-04-13 22:29:23.344370 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-13 22:29:23.606564 | instance | ok 2026-04-13 22:29:23.614430 | 2026-04-13 22:29:23.614572 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-13 22:29:25.162619 | instance | Output suppressed because no_log was given 2026-04-13 22:29:25.171446 | 2026-04-13 22:29:25.171562 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-13 22:29:25.356593 | instance | ok: "logs" 2026-04-13 22:29:25.357345 | instance | ok: All items complete 2026-04-13 22:29:25.357403 | 2026-04-13 22:29:25.514504 | instance | ok: "artifacts" 2026-04-13 22:29:25.665996 | instance | ok: "docs" 2026-04-13 22:29:25.680236 | 2026-04-13 22:29:25.680656 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-13 22:29:25.864218 | instance | changed: "logs" 2026-04-13 22:29:26.012192 | instance | changed: "artifacts" 2026-04-13 22:29:26.164019 | instance | changed: "docs" 2026-04-13 22:29:26.182218 | 2026-04-13 22:29:26.182359 | PLAY RECAP 2026-04-13 22:29:26.182424 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-13 22:29:26.182465 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-13 22:29:26.182495 | 2026-04-13 22:29:26.310957 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-13 22:29:26.321702 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-13 22:29:26.921756 | 2026-04-13 22:29:26.921921 | PLAY [all] 2026-04-13 22:29:26.935366 | 2026-04-13 22:29:26.935451 | TASK [setup-uv : Extract archive] 2026-04-13 22:29:29.213415 | instance | changed 2026-04-13 22:29:29.220820 | 2026-04-13 22:29:29.220903 | TASK [setup-uv : Print version] 2026-04-13 22:29:28.255215 | instance | uv 0.8.13 2026-04-13 22:29:29.763035 | instance | ok: Runtime: 0:00:00.012801 2026-04-13 22:29:29.771238 | 2026-04-13 22:29:29.771292 | PLAY RECAP 2026-04-13 22:29:29.771339 | instance | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-13 22:29:29.771363 | 2026-04-13 22:29:29.912905 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-13 22:29:29.921389 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main] 2026-04-13 22:29:30.528760 | 2026-04-13 22:29:30.528886 | PLAY [all] 2026-04-13 22:29:30.539779 | 2026-04-13 22:29:30.539891 | TASK [Install "jq" for log collection] 2026-04-13 22:29:42.513838 | instance | changed 2026-04-13 22:29:42.520143 | 2026-04-13 22:29:42.520223 | TASK [Install pip3 for Python package management] 2026-04-13 22:29:47.109756 | instance | changed 2026-04-13 22:29:47.114885 | 2026-04-13 22:29:47.114949 | TASK [Install Python "kubernetes" library for kubernetes.core modules] 2026-04-13 22:29:50.146411 | instance | changed 2026-04-13 22:29:50.149393 | 2026-04-13 22:29:50.149449 | PLAY [all] 2026-04-13 22:29:50.156569 | 2026-04-13 22:29:50.156636 | TASK [ensure-go : Check installed go version] 2026-04-13 22:29:50.689214 | instance | ok: ERROR (ignored) 2026-04-13 22:29:50.689548 | instance | { 2026-04-13 22:29:50.689598 | instance | "failed_when_result": false, 2026-04-13 22:29:50.689629 | instance | "msg": "[Errno 2] No such file or directory: b'go'", 2026-04-13 22:29:50.689658 | instance | "rc": 2 2026-04-13 22:29:50.689689 | instance | } 2026-04-13 22:29:50.696283 | 2026-04-13 22:29:50.696372 | TASK [ensure-go : Skip if correct version of go is installed] 2026-04-13 22:29:50.751864 | instance | ok 2026-04-13 22:29:50.760036 | instance | included: /var/lib/zuul/builds/5010206435994aa399fb021f4b428425/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-go/tasks/install-go.yaml 2026-04-13 22:29:50.765854 | 2026-04-13 22:29:50.765923 | TASK [ensure-go : Create temp directory] 2026-04-13 22:29:51.073157 | instance | changed 2026-04-13 22:29:51.079943 | 2026-04-13 22:29:51.080010 | TASK [ensure-go : Get archive checksum] 2026-04-13 22:29:51.702698 | instance | ok: OK (64 bytes) 2026-04-13 22:29:51.709727 | 2026-04-13 22:29:51.709805 | TASK [ensure-go : Download go archive] 2026-04-13 22:29:52.991202 | instance | changed: OK (78559214 bytes) 2026-04-13 22:29:52.997790 | 2026-04-13 22:29:52.997858 | TASK [ensure-go : Install go] 2026-04-13 22:29:58.877827 | instance | changed 2026-04-13 22:29:58.886561 | 2026-04-13 22:29:58.886623 | PLAY [all] 2026-04-13 22:29:58.893891 | 2026-04-13 22:29:58.893971 | TASK [Copy inventory file for Zuul] 2026-04-13 22:29:59.623570 | instance | changed 2026-04-13 22:29:59.628865 | 2026-04-13 22:29:59.628943 | TASK [Switch "ansible_host" to private IP] 2026-04-13 22:29:59.939068 | instance | changed: 1 replacements made 2026-04-13 22:29:59.975292 | 2026-04-13 22:29:59.975431 | TASK [Run molecule prepare] 2026-04-13 22:30:00.214237 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-04-13 22:30:00.214384 | instance | Creating virtual environment at: .venv 2026-04-13 22:30:00.240078 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-04-13 22:30:00.269527 | instance | Downloading openstacksdk (1.7MiB) 2026-04-13 22:30:00.269676 | instance | Downloading cryptography (4.2MiB) 2026-04-13 22:30:00.269868 | instance | Downloading pydantic-core (2.0MiB) 2026-04-13 22:30:00.273470 | instance | Downloading rjsonnet (1.2MiB) 2026-04-13 22:30:00.273665 | instance | Downloading kubernetes (1.9MiB) 2026-04-13 22:30:00.274089 | instance | Downloading netaddr (2.2MiB) 2026-04-13 22:30:00.274357 | instance | Downloading pygments (1.2MiB) 2026-04-13 22:30:00.285702 | instance | Downloading ansible-core (2.1MiB) 2026-04-13 22:30:00.307114 | instance | Downloading setuptools (1.1MiB) 2026-04-13 22:30:00.586252 | instance | Building pyperclip==1.9.0 2026-04-13 22:30:00.609912 | instance | Downloading rjsonnet 2026-04-13 22:30:00.702155 | instance | Downloading pydantic-core 2026-04-13 22:30:00.751274 | instance | Downloading netaddr 2026-04-13 22:30:00.769047 | instance | Downloading pygments 2026-04-13 22:30:00.782142 | instance | Downloading cryptography 2026-04-13 22:30:00.819179 | instance | Downloading setuptools 2026-04-13 22:30:00.878016 | instance | Downloading kubernetes 2026-04-13 22:30:00.912901 | instance | Downloading ansible-core 2026-04-13 22:30:00.947395 | instance | Downloading openstacksdk 2026-04-13 22:30:01.296442 | instance | Built pyperclip==1.9.0 2026-04-13 22:30:01.481449 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-04-13 22:30:01.520455 | instance | Installed 83 packages in 36ms 2026-04-13 22:30:02.215875 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-04-13 22:30:02.799103 | instance | INFO [aio > discovery] scenario test matrix: prepare 2026-04-13 22:30:02.799203 | instance | INFO [aio > prerun] Performing prerun with role_name_check=0... 2026-04-13 22:30:59.285856 | instance | INFO [aio > prepare] Executing 2026-04-13 22:31:00.240566 | instance | 2026-04-13 22:31:00.241108 | instance | PLAY [Prepare] ***************************************************************** 2026-04-13 22:31:00.241370 | instance | 2026-04-13 22:31:00.241632 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-13 22:31:00.241844 | instance | Monday 13 April 2026 22:31:00 +0000 (0:00:00.024) 0:00:00.024 ********** 2026-04-13 22:31:01.378497 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-04-13 22:31:01.378627 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-04-13 22:31:01.378794 | instance | interpreter could change the meaning of that path. See 2026-04-13 22:31:01.378943 | instance | https://docs.ansible.com/ansible- 2026-04-13 22:31:01.379100 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-04-13 22:31:01.388456 | instance | ok: [instance] 2026-04-13 22:31:01.388636 | instance | 2026-04-13 22:31:01.388807 | instance | TASK [Configure short hostname] ************************************************ 2026-04-13 22:31:01.388976 | instance | Monday 13 April 2026 22:31:01 +0000 (0:00:01.149) 0:00:01.173 ********** 2026-04-13 22:31:02.046208 | instance | changed: [instance] 2026-04-13 22:31:02.046518 | instance | 2026-04-13 22:31:02.046838 | instance | TASK [Ensure hostname inside hosts file] *************************************** 2026-04-13 22:31:02.047139 | instance | Monday 13 April 2026 22:31:02 +0000 (0:00:00.655) 0:00:01.828 ********** 2026-04-13 22:31:02.288644 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created 2026-04-13 22:31:02.288935 | instance | with a mode of 0700, this may cause issues when running as another user. To 2026-04-13 22:31:02.289277 | instance | avoid this, create the remote_tmp dir with the correct permissions manually 2026-04-13 22:31:02.298001 | instance | changed: [instance] 2026-04-13 22:31:02.298285 | instance | 2026-04-13 22:31:02.298589 | instance | TASK [Install "dirmngr" for GPG keyserver operations] ************************** 2026-04-13 22:31:02.298885 | instance | Monday 13 April 2026 22:31:02 +0000 (0:00:00.253) 0:00:02.082 ********** 2026-04-13 22:31:03.317704 | instance | ok: [instance] 2026-04-13 22:31:03.317974 | instance | 2026-04-13 22:31:03.318295 | instance | TASK [Purge "snapd" package] *************************************************** 2026-04-13 22:31:03.318603 | instance | Monday 13 April 2026 22:31:03 +0000 (0:00:01.018) 0:00:03.101 ********** 2026-04-13 22:31:03.971196 | instance | ok: [instance] 2026-04-13 22:31:03.971442 | instance | 2026-04-13 22:31:03.971722 | instance | PLAY [Generate workspace for Atmosphere] *************************************** 2026-04-13 22:31:03.971968 | instance | 2026-04-13 22:31:03.972231 | instance | TASK [Create folders for workspace] ******************************************** 2026-04-13 22:31:03.972493 | instance | Monday 13 April 2026 22:31:03 +0000 (0:00:00.654) 0:00:03.755 ********** 2026-04-13 22:31:04.927402 | instance | changed: [localhost] => (item=group_vars) 2026-04-13 22:31:04.927684 | instance | changed: [localhost] => (item=group_vars/all) 2026-04-13 22:31:04.927999 | instance | changed: [localhost] => (item=group_vars/controllers) 2026-04-13 22:31:04.928294 | instance | changed: [localhost] => (item=group_vars/cephs) 2026-04-13 22:31:04.928565 | instance | changed: [localhost] => (item=group_vars/computes) 2026-04-13 22:31:04.928846 | instance | changed: [localhost] => (item=host_vars) 2026-04-13 22:31:04.929125 | instance | 2026-04-13 22:31:04.929419 | instance | PLAY [Generate Ceph control plane configuration for workspace] ***************** 2026-04-13 22:31:04.929686 | instance | 2026-04-13 22:31:04.929977 | instance | TASK [Ensure the Ceph control plane configuration file exists] ***************** 2026-04-13 22:31:04.930330 | instance | Monday 13 April 2026 22:31:04 +0000 (0:00:00.956) 0:00:04.711 ********** 2026-04-13 22:31:05.093005 | instance | changed: [localhost] 2026-04-13 22:31:05.093273 | instance | 2026-04-13 22:31:05.093570 | instance | TASK [Load the current Ceph control plane configuration into a variable] ******* 2026-04-13 22:31:05.093892 | instance | Monday 13 April 2026 22:31:05 +0000 (0:00:00.165) 0:00:04.877 ********** 2026-04-13 22:31:05.116773 | instance | ok: [localhost] 2026-04-13 22:31:05.117077 | instance | 2026-04-13 22:31:05.117342 | instance | TASK [Generate Ceph control plane values for missing variables] **************** 2026-04-13 22:31:05.117617 | instance | Monday 13 April 2026 22:31:05 +0000 (0:00:00.023) 0:00:04.901 ********** 2026-04-13 22:31:05.161096 | instance | ok: [localhost] => (item={'key': 'ceph_fsid', 'value': '5e474da5-0db9-582e-94d4-b1904c9a12aa'}) 2026-04-13 22:31:05.161361 | instance | ok: [localhost] => (item={'key': 'ceph_mon_public_network', 'value': '10.96.240.0/24'}) 2026-04-13 22:31:05.161657 | instance | 2026-04-13 22:31:05.161935 | instance | TASK [Write new Ceph control plane configuration file to disk] ***************** 2026-04-13 22:31:05.162347 | instance | Monday 13 April 2026 22:31:05 +0000 (0:00:00.044) 0:00:04.945 ********** 2026-04-13 22:31:05.675621 | instance | changed: [localhost] 2026-04-13 22:31:05.675693 | instance | 2026-04-13 22:31:05.675828 | instance | PLAY [Generate Ceph OSD configuration for workspace] *************************** 2026-04-13 22:31:05.675942 | instance | 2026-04-13 22:31:05.676069 | instance | TASK [Ensure the Ceph OSDs configuration file exists] ************************** 2026-04-13 22:31:05.676194 | instance | Monday 13 April 2026 22:31:05 +0000 (0:00:00.514) 0:00:05.459 ********** 2026-04-13 22:31:05.857163 | instance | changed: [localhost] 2026-04-13 22:31:05.857366 | instance | 2026-04-13 22:31:05.857641 | instance | TASK [Load the current Ceph OSDs configuration into a variable] **************** 2026-04-13 22:31:05.857908 | instance | Monday 13 April 2026 22:31:05 +0000 (0:00:00.181) 0:00:05.641 ********** 2026-04-13 22:31:05.883686 | instance | ok: [localhost] 2026-04-13 22:31:05.883930 | instance | 2026-04-13 22:31:05.884198 | instance | TASK [Generate Ceph OSDs values for missing variables] ************************* 2026-04-13 22:31:05.884464 | instance | Monday 13 April 2026 22:31:05 +0000 (0:00:00.026) 0:00:05.668 ********** 2026-04-13 22:31:05.915056 | instance | ok: [localhost] => (item={'key': 'ceph_osd_devices', 'value': ['/dev/vdb', '/dev/vdc', '/dev/vdd']}) 2026-04-13 22:31:05.915399 | instance | 2026-04-13 22:31:05.915686 | instance | TASK [Write new Ceph OSDs configuration file to disk] ************************** 2026-04-13 22:31:05.915998 | instance | Monday 13 April 2026 22:31:05 +0000 (0:00:00.031) 0:00:05.699 ********** 2026-04-13 22:31:06.265250 | instance | changed: [localhost] 2026-04-13 22:31:06.265494 | instance | 2026-04-13 22:31:06.265777 | instance | PLAY [Generate Kubernetes configuration for workspace] ************************* 2026-04-13 22:31:06.266022 | instance | 2026-04-13 22:31:06.266356 | instance | TASK [Ensure the Kubernetes configuration file exists] ************************* 2026-04-13 22:31:06.266637 | instance | Monday 13 April 2026 22:31:06 +0000 (0:00:00.350) 0:00:06.049 ********** 2026-04-13 22:31:06.429173 | instance | changed: [localhost] 2026-04-13 22:31:06.429417 | instance | 2026-04-13 22:31:06.429700 | instance | TASK [Load the current Kubernetes configuration into a variable] *************** 2026-04-13 22:31:06.430005 | instance | Monday 13 April 2026 22:31:06 +0000 (0:00:00.163) 0:00:06.213 ********** 2026-04-13 22:31:06.461184 | instance | ok: [localhost] 2026-04-13 22:31:06.461625 | instance | 2026-04-13 22:31:06.461923 | instance | TASK [Generate Kubernetes values for missing variables] ************************ 2026-04-13 22:31:06.462252 | instance | Monday 13 April 2026 22:31:06 +0000 (0:00:00.032) 0:00:06.245 ********** 2026-04-13 22:31:06.504345 | instance | ok: [localhost] => (item={'key': 'kubernetes_hostname', 'value': '10.96.240.10'}) 2026-04-13 22:31:06.504602 | instance | ok: [localhost] => (item={'key': 'kubernetes_keepalived_vrid', 'value': 42}) 2026-04-13 22:31:06.504894 | instance | ok: [localhost] => (item={'key': 'kubernetes_keepalived_vip', 'value': '10.96.240.10'}) 2026-04-13 22:31:06.505159 | instance | 2026-04-13 22:31:06.505439 | instance | TASK [Write new Kubernetes configuration file to disk] ************************* 2026-04-13 22:31:06.505723 | instance | Monday 13 April 2026 22:31:06 +0000 (0:00:00.042) 0:00:06.288 ********** 2026-04-13 22:31:06.876629 | instance | changed: [localhost] 2026-04-13 22:31:06.876870 | instance | 2026-04-13 22:31:06.877142 | instance | PLAY [Generate Keepalived configuration for workspace] ************************* 2026-04-13 22:31:06.877393 | instance | 2026-04-13 22:31:06.877653 | instance | TASK [Ensure the Keeaplived configuration file exists] ************************* 2026-04-13 22:31:06.877914 | instance | Monday 13 April 2026 22:31:06 +0000 (0:00:00.372) 0:00:06.661 ********** 2026-04-13 22:31:07.048222 | instance | changed: [localhost] 2026-04-13 22:31:07.048498 | instance | 2026-04-13 22:31:07.048774 | instance | TASK [Load the current Keepalived configuration into a variable] *************** 2026-04-13 22:31:07.049046 | instance | Monday 13 April 2026 22:31:07 +0000 (0:00:00.171) 0:00:06.832 ********** 2026-04-13 22:31:07.073619 | instance | ok: [localhost] 2026-04-13 22:31:07.073858 | instance | 2026-04-13 22:31:07.074175 | instance | TASK [Generate Keepalived values for missing variables] ************************ 2026-04-13 22:31:07.074433 | instance | Monday 13 April 2026 22:31:07 +0000 (0:00:00.025) 0:00:06.858 ********** 2026-04-13 22:31:07.107281 | instance | ok: [localhost] => (item={'key': 'keepalived_interface', 'value': 'br-ex'}) 2026-04-13 22:31:07.107580 | instance | ok: [localhost] => (item={'key': 'keepalived_vip', 'value': '10.96.250.10'}) 2026-04-13 22:31:07.107978 | instance | 2026-04-13 22:31:07.108289 | instance | TASK [Write new Keepalived configuration file to disk] ************************* 2026-04-13 22:31:07.108571 | instance | Monday 13 April 2026 22:31:07 +0000 (0:00:00.033) 0:00:06.891 ********** 2026-04-13 22:31:07.445345 | instance | changed: [localhost] 2026-04-13 22:31:07.445606 | instance | 2026-04-13 22:31:07.445899 | instance | PLAY [Generate endpoints for workspace] **************************************** 2026-04-13 22:31:07.446249 | instance | 2026-04-13 22:31:07.446537 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-13 22:31:07.446822 | instance | Monday 13 April 2026 22:31:07 +0000 (0:00:00.338) 0:00:07.230 ********** 2026-04-13 22:31:08.100365 | instance | ok: [localhost] 2026-04-13 22:31:08.100611 | instance | 2026-04-13 22:31:08.100886 | instance | TASK [Ensure the endpoints file exists] **************************************** 2026-04-13 22:31:08.101160 | instance | Monday 13 April 2026 22:31:08 +0000 (0:00:00.655) 0:00:07.885 ********** 2026-04-13 22:31:08.294499 | instance | changed: [localhost] 2026-04-13 22:31:08.294693 | instance | 2026-04-13 22:31:08.294971 | instance | TASK [Load the current endpoints into a variable] ****************************** 2026-04-13 22:31:08.295260 | instance | Monday 13 April 2026 22:31:08 +0000 (0:00:00.193) 0:00:08.079 ********** 2026-04-13 22:31:08.321092 | instance | ok: [localhost] 2026-04-13 22:31:08.321313 | instance | 2026-04-13 22:31:08.321610 | instance | TASK [Generate endpoint skeleton for missing variables] ************************ 2026-04-13 22:31:08.321894 | instance | Monday 13 April 2026 22:31:08 +0000 (0:00:00.026) 0:00:08.105 ********** 2026-04-13 22:31:09.051253 | instance | ok: [localhost] => (item=keycloak_host) 2026-04-13 22:31:09.051404 | instance | ok: [localhost] => (item=kube_prometheus_stack_grafana_host) 2026-04-13 22:31:09.051647 | instance | ok: [localhost] => (item=kube_prometheus_stack_alertmanager_host) 2026-04-13 22:31:09.051864 | instance | ok: [localhost] => (item=kube_prometheus_stack_prometheus_host) 2026-04-13 22:31:09.052088 | instance | ok: [localhost] => (item=openstack_helm_endpoints_region_name) 2026-04-13 22:31:09.052311 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_api_host) 2026-04-13 22:31:09.052539 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_api_host) 2026-04-13 22:31:09.052767 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_api_host) 2026-04-13 22:31:09.053061 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_api_host) 2026-04-13 22:31:09.053307 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_api_host) 2026-04-13 22:31:09.053427 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_api_host) 2026-04-13 22:31:09.053550 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_api_host) 2026-04-13 22:31:09.053669 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_novnc_host) 2026-04-13 22:31:09.053792 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_api_host) 2026-04-13 22:31:09.053902 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_api_host) 2026-04-13 22:31:09.054021 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_api_host) 2026-04-13 22:31:09.054164 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_api_host) 2026-04-13 22:31:09.054291 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_registry_host) 2026-04-13 22:31:09.054427 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_api_host) 2026-04-13 22:31:09.054551 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_cfn_api_host) 2026-04-13 22:31:09.054672 | instance | ok: [localhost] => (item=openstack_helm_endpoints_horizon_api_host) 2026-04-13 22:31:09.054792 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rgw_host) 2026-04-13 22:31:09.054912 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_api_host) 2026-04-13 22:31:09.055025 | instance | 2026-04-13 22:31:09.055146 | instance | TASK [Write new endpoints file to disk] **************************************** 2026-04-13 22:31:09.055272 | instance | Monday 13 April 2026 22:31:09 +0000 (0:00:00.729) 0:00:08.835 ********** 2026-04-13 22:31:09.409097 | instance | changed: [localhost] 2026-04-13 22:31:09.409327 | instance | 2026-04-13 22:31:09.409587 | instance | TASK [Ensure the endpoints file exists] **************************************** 2026-04-13 22:31:09.409869 | instance | Monday 13 April 2026 22:31:09 +0000 (0:00:00.357) 0:00:09.193 ********** 2026-04-13 22:31:09.586247 | instance | changed: [localhost] 2026-04-13 22:31:09.586476 | instance | 2026-04-13 22:31:09.586756 | instance | PLAY [Generate Neutron configuration for workspace] **************************** 2026-04-13 22:31:09.587003 | instance | 2026-04-13 22:31:09.587268 | instance | TASK [Ensure the Neutron configuration file exists] **************************** 2026-04-13 22:31:09.587532 | instance | Monday 13 April 2026 22:31:09 +0000 (0:00:00.177) 0:00:09.370 ********** 2026-04-13 22:31:09.752359 | instance | changed: [localhost] 2026-04-13 22:31:09.752588 | instance | 2026-04-13 22:31:09.752861 | instance | TASK [Load the current Neutron configuration into a variable] ****************** 2026-04-13 22:31:09.753126 | instance | Monday 13 April 2026 22:31:09 +0000 (0:00:00.166) 0:00:09.537 ********** 2026-04-13 22:31:09.781509 | instance | ok: [localhost] 2026-04-13 22:31:09.781747 | instance | 2026-04-13 22:31:09.782021 | instance | TASK [Generate Neutron values for missing variables] *************************** 2026-04-13 22:31:09.782334 | instance | Monday 13 April 2026 22:31:09 +0000 (0:00:00.029) 0:00:09.566 ********** 2026-04-13 22:31:09.821191 | 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-13 22:31:09.821460 | instance | 2026-04-13 22:31:09.821751 | instance | TASK [Write new Neutron configuration file to disk] **************************** 2026-04-13 22:31:09.822022 | instance | Monday 13 April 2026 22:31:09 +0000 (0:00:00.039) 0:00:09.605 ********** 2026-04-13 22:31:10.158699 | instance | changed: [localhost] 2026-04-13 22:31:10.158962 | instance | 2026-04-13 22:31:10.159311 | instance | PLAY [Generate Nova configuration for workspace] ******************************* 2026-04-13 22:31:10.159614 | instance | 2026-04-13 22:31:10.159989 | instance | TASK [Ensure the Nova configuration file exists] ******************************* 2026-04-13 22:31:10.160323 | instance | Monday 13 April 2026 22:31:10 +0000 (0:00:00.337) 0:00:09.943 ********** 2026-04-13 22:31:10.322474 | instance | changed: [localhost] 2026-04-13 22:31:10.322719 | instance | 2026-04-13 22:31:10.322997 | instance | TASK [Load the current Nova configuration into a variable] ********************* 2026-04-13 22:31:10.323272 | instance | Monday 13 April 2026 22:31:10 +0000 (0:00:00.163) 0:00:10.106 ********** 2026-04-13 22:31:10.351473 | instance | ok: [localhost] 2026-04-13 22:31:10.351711 | instance | 2026-04-13 22:31:10.351981 | instance | TASK [Generate Nova values for missing variables] ****************************** 2026-04-13 22:31:10.352248 | instance | Monday 13 April 2026 22:31:10 +0000 (0:00:00.029) 0:00:10.136 ********** 2026-04-13 22:31:10.386745 | 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-13 22:31:10.386903 | instance | 2026-04-13 22:31:10.387106 | instance | TASK [Write new Nova configuration file to disk] ******************************* 2026-04-13 22:31:10.387265 | instance | Monday 13 April 2026 22:31:10 +0000 (0:00:00.035) 0:00:10.171 ********** 2026-04-13 22:31:10.719628 | instance | changed: [localhost] 2026-04-13 22:31:10.719986 | instance | 2026-04-13 22:31:10.720293 | instance | PLAY [Generate secrets for workspace] ****************************************** 2026-04-13 22:31:10.720503 | instance | 2026-04-13 22:31:10.720743 | instance | TASK [Ensure the secrets file exists] ****************************************** 2026-04-13 22:31:10.720909 | instance | Monday 13 April 2026 22:31:10 +0000 (0:00:00.332) 0:00:10.504 ********** 2026-04-13 22:31:10.894328 | instance | changed: [localhost] 2026-04-13 22:31:10.894600 | instance | 2026-04-13 22:31:10.894924 | instance | TASK [Load the current secrets into a variable] ******************************** 2026-04-13 22:31:10.895216 | instance | Monday 13 April 2026 22:31:10 +0000 (0:00:00.174) 0:00:10.678 ********** 2026-04-13 22:31:10.922693 | instance | ok: [localhost] 2026-04-13 22:31:10.922972 | instance | 2026-04-13 22:31:10.923263 | instance | TASK [Generate secrets for missing variables] ********************************** 2026-04-13 22:31:10.923555 | instance | Monday 13 April 2026 22:31:10 +0000 (0:00:00.029) 0:00:10.707 ********** 2026-04-13 22:31:11.316148 | instance | ok: [localhost] => (item=heat_auth_encryption_key) 2026-04-13 22:31:11.316247 | instance | ok: [localhost] => (item=keepalived_password) 2026-04-13 22:31:11.316409 | instance | ok: [localhost] => (item=keycloak_admin_password) 2026-04-13 22:31:11.316579 | instance | ok: [localhost] => (item=keycloak_database_password) 2026-04-13 22:31:11.316784 | instance | ok: [localhost] => (item=keystone_keycloak_client_secret) 2026-04-13 22:31:11.316932 | instance | ok: [localhost] => (item=keystone_oidc_crypto_passphrase) 2026-04-13 22:31:11.317091 | instance | ok: [localhost] => (item=kube_prometheus_stack_grafana_admin_password) 2026-04-13 22:31:11.317255 | instance | ok: [localhost] => (item=octavia_heartbeat_key) 2026-04-13 22:31:11.317428 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rabbitmq_admin_password) 2026-04-13 22:31:11.317594 | instance | ok: [localhost] => (item=openstack_helm_endpoints_memcached_secret_key) 2026-04-13 22:31:11.317761 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_admin_password) 2026-04-13 22:31:11.317931 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_mariadb_password) 2026-04-13 22:31:11.318095 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_rabbitmq_password) 2026-04-13 22:31:11.318282 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_keystone_password) 2026-04-13 22:31:11.318459 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_mariadb_password) 2026-04-13 22:31:11.318638 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_rabbitmq_password) 2026-04-13 22:31:11.318815 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_keystone_password) 2026-04-13 22:31:11.318992 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_mariadb_password) 2026-04-13 22:31:11.319171 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_rabbitmq_password) 2026-04-13 22:31:11.319347 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_keystone_password) 2026-04-13 22:31:11.319528 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_mariadb_password) 2026-04-13 22:31:11.319704 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_keystone_password) 2026-04-13 22:31:11.319889 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_mariadb_password) 2026-04-13 22:31:11.320063 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_keystone_password) 2026-04-13 22:31:11.320238 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_mariadb_password) 2026-04-13 22:31:11.320419 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_rabbitmq_password) 2026-04-13 22:31:11.320597 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_metadata_secret) 2026-04-13 22:31:11.320790 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_keystone_password) 2026-04-13 22:31:11.320967 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_mariadb_password) 2026-04-13 22:31:11.321145 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_rabbitmq_password) 2026-04-13 22:31:11.321324 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_keystone_password) 2026-04-13 22:31:11.321500 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_mariadb_password) 2026-04-13 22:31:11.321677 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_rabbitmq_password) 2026-04-13 22:31:11.321854 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_keystone_password) 2026-04-13 22:31:11.322032 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_mariadb_password) 2026-04-13 22:31:11.322249 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_rabbitmq_password) 2026-04-13 22:31:11.322413 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_keystone_password) 2026-04-13 22:31:11.322585 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_mariadb_password) 2026-04-13 22:31:11.322758 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_rabbitmq_password) 2026-04-13 22:31:11.322929 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_keystone_password) 2026-04-13 22:31:11.323102 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_mariadb_password) 2026-04-13 22:31:11.323282 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_rabbitmq_password) 2026-04-13 22:31:11.323460 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_keystone_password) 2026-04-13 22:31:11.323643 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_trustee_keystone_password) 2026-04-13 22:31:11.323826 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_stack_user_keystone_password) 2026-04-13 22:31:11.323999 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_mariadb_password) 2026-04-13 22:31:11.324172 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_rabbitmq_password) 2026-04-13 22:31:11.324349 | instance | ok: [localhost] => (item=openstack_helm_endpoints_horizon_mariadb_password) 2026-04-13 22:31:11.324522 | instance | ok: [localhost] => (item=openstack_helm_endpoints_tempest_keystone_password) 2026-04-13 22:31:11.325157 | instance | ok: [localhost] => (item=openstack_helm_endpoints_openstack_exporter_keystone_password) 2026-04-13 22:31:11.325265 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rgw_keystone_password) 2026-04-13 22:31:11.325371 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_keystone_password) 2026-04-13 22:31:11.325489 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_mariadb_password) 2026-04-13 22:31:11.325607 | instance | ok: [localhost] => (item=openstack_helm_endpoints_staffeln_mariadb_password) 2026-04-13 22:31:11.325718 | instance | 2026-04-13 22:31:11.325832 | instance | TASK [Generate base64 encoded secrets] ***************************************** 2026-04-13 22:31:11.325949 | instance | Monday 13 April 2026 22:31:11 +0000 (0:00:00.393) 0:00:11.101 ********** 2026-04-13 22:31:11.364864 | instance | ok: [localhost] => (item=barbican_kek) 2026-04-13 22:31:11.364975 | instance | 2026-04-13 22:31:11.365091 | instance | TASK [Generate temporary files for generating keys for missing variables] ****** 2026-04-13 22:31:11.365211 | instance | Monday 13 April 2026 22:31:11 +0000 (0:00:00.048) 0:00:11.149 ********** 2026-04-13 22:31:11.753746 | instance | changed: [localhost] => (item=manila_ssh_key) 2026-04-13 22:31:11.753920 | instance | changed: [localhost] => (item=nova_ssh_key) 2026-04-13 22:31:11.754240 | instance | 2026-04-13 22:31:11.754549 | instance | TASK [Generate SSH keys for missing variables] ********************************* 2026-04-13 22:31:11.754868 | instance | Monday 13 April 2026 22:31:11 +0000 (0:00:00.388) 0:00:11.538 ********** 2026-04-13 22:31:18.349471 | instance | changed: [localhost] => (item=manila_ssh_key) 2026-04-13 22:31:18.349706 | instance | changed: [localhost] => (item=nova_ssh_key) 2026-04-13 22:31:18.349984 | instance | 2026-04-13 22:31:18.350337 | instance | TASK [Set values for SSH keys] ************************************************* 2026-04-13 22:31:18.350603 | instance | Monday 13 April 2026 22:31:18 +0000 (0:00:06.595) 0:00:18.134 ********** 2026-04-13 22:31:18.400130 | instance | ok: [localhost] => (item=manila_ssh_key) 2026-04-13 22:31:18.400393 | instance | ok: [localhost] => (item=nova_ssh_key) 2026-04-13 22:31:18.400646 | instance | 2026-04-13 22:31:18.400921 | instance | TASK [Delete the temporary files generated for SSH keys] *********************** 2026-04-13 22:31:18.401220 | instance | Monday 13 April 2026 22:31:18 +0000 (0:00:00.050) 0:00:18.184 ********** 2026-04-13 22:31:18.724400 | instance | changed: [localhost] => (item=manila_ssh_key) 2026-04-13 22:31:18.724627 | instance | changed: [localhost] => (item=nova_ssh_key) 2026-04-13 22:31:18.724886 | instance | 2026-04-13 22:31:18.725164 | instance | TASK [Write new secrets file to disk] ****************************************** 2026-04-13 22:31:18.725425 | instance | Monday 13 April 2026 22:31:18 +0000 (0:00:00.324) 0:00:18.509 ********** 2026-04-13 22:31:19.057937 | instance | changed: [localhost] 2026-04-13 22:31:19.058177 | instance | 2026-04-13 22:31:19.058504 | instance | TASK [Encrypt secrets file with Vault password] ******************************** 2026-04-13 22:31:19.058780 | instance | Monday 13 April 2026 22:31:19 +0000 (0:00:00.333) 0:00:18.842 ********** 2026-04-13 22:31:19.091972 | instance | skipping: [localhost] 2026-04-13 22:31:19.092196 | instance | 2026-04-13 22:31:19.092463 | instance | PLAY [Setup networking] ******************************************************** 2026-04-13 22:31:19.092708 | instance | 2026-04-13 22:31:19.092970 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-13 22:31:19.093233 | instance | Monday 13 April 2026 22:31:19 +0000 (0:00:00.034) 0:00:18.877 ********** 2026-04-13 22:31:19.764478 | instance | ok: [instance] 2026-04-13 22:31:19.764697 | instance | 2026-04-13 22:31:19.764977 | instance | TASK [Create bridge for management network] ************************************ 2026-04-13 22:31:19.765255 | instance | Monday 13 April 2026 22:31:19 +0000 (0:00:00.671) 0:00:19.549 ********** 2026-04-13 22:31:20.068826 | instance | ok: [instance] 2026-04-13 22:31:20.069052 | instance | 2026-04-13 22:31:20.069373 | instance | TASK [Create fake interface for management bridge] ***************************** 2026-04-13 22:31:20.069719 | instance | Monday 13 April 2026 22:31:20 +0000 (0:00:00.304) 0:00:19.853 ********** 2026-04-13 22:31:20.264926 | instance | ok: [instance] 2026-04-13 22:31:20.265339 | instance | 2026-04-13 22:31:20.265637 | instance | TASK [Assign dummy interface to management bridge] ***************************** 2026-04-13 22:31:20.265929 | instance | Monday 13 April 2026 22:31:20 +0000 (0:00:00.195) 0:00:20.049 ********** 2026-04-13 22:31:20.447949 | instance | ok: [instance] 2026-04-13 22:31:20.448289 | instance | 2026-04-13 22:31:20.448633 | instance | TASK [Assign IP address for management bridge] ********************************* 2026-04-13 22:31:20.448887 | instance | Monday 13 April 2026 22:31:20 +0000 (0:00:00.182) 0:00:20.232 ********** 2026-04-13 22:31:20.636000 | instance | ok: [instance] 2026-04-13 22:31:20.636306 | instance | 2026-04-13 22:31:20.636596 | instance | TASK [Bring up interfaces] ***************************************************** 2026-04-13 22:31:20.636902 | instance | Monday 13 April 2026 22:31:20 +0000 (0:00:00.187) 0:00:20.420 ********** 2026-04-13 22:31:21.011628 | instance | ok: [instance] => (item=br-mgmt) 2026-04-13 22:31:21.012017 | instance | ok: [instance] => (item=dummy0) 2026-04-13 22:31:21.012319 | instance | 2026-04-13 22:31:21.012643 | instance | PLAY [Create devices for Ceph] ************************************************* 2026-04-13 22:31:21.012941 | instance | 2026-04-13 22:31:21.013254 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-13 22:31:21.013593 | instance | Monday 13 April 2026 22:31:21 +0000 (0:00:00.376) 0:00:20.796 ********** 2026-04-13 22:31:21.724411 | instance | ok: [instance] 2026-04-13 22:31:21.724845 | instance | 2026-04-13 22:31:21.725233 | instance | TASK [Install depedencies] ***************************************************** 2026-04-13 22:31:21.725571 | instance | Monday 13 April 2026 22:31:21 +0000 (0:00:00.707) 0:00:21.503 ********** 2026-04-13 22:31:42.077565 | instance | changed: [instance] 2026-04-13 22:31:42.077885 | instance | 2026-04-13 22:31:42.078142 | instance | TASK [Start up service] ******************************************************** 2026-04-13 22:31:42.078379 | instance | Monday 13 April 2026 22:31:42 +0000 (0:00:20.353) 0:00:41.857 ********** 2026-04-13 22:31:42.582582 | instance | ok: [instance] 2026-04-13 22:31:42.582839 | instance | 2026-04-13 22:31:42.583047 | instance | TASK [Generate lvm.conf] ******************************************************* 2026-04-13 22:31:42.583270 | instance | Monday 13 April 2026 22:31:42 +0000 (0:00:00.508) 0:00:42.365 ********** 2026-04-13 22:31:42.790463 | instance | ok: [instance] 2026-04-13 22:31:42.790832 | instance | 2026-04-13 22:31:42.791166 | instance | TASK [Write /etc/lvm/lvm.conf] ************************************************* 2026-04-13 22:31:42.791488 | instance | Monday 13 April 2026 22:31:42 +0000 (0:00:00.209) 0:00:42.575 ********** 2026-04-13 22:31:43.247254 | instance | changed: [instance] 2026-04-13 22:31:43.247639 | instance | 2026-04-13 22:31:43.248045 | instance | TASK [Get list of all loopback devices] **************************************** 2026-04-13 22:31:43.248399 | instance | Monday 13 April 2026 22:31:43 +0000 (0:00:00.456) 0:00:43.031 ********** 2026-04-13 22:31:43.442156 | instance | ok: [instance] 2026-04-13 22:31:43.442556 | instance | 2026-04-13 22:31:43.442921 | instance | TASK [Fail if there is any existing loopback devices] ************************** 2026-04-13 22:31:43.443286 | instance | Monday 13 April 2026 22:31:43 +0000 (0:00:00.194) 0:00:43.226 ********** 2026-04-13 22:31:43.463242 | instance | skipping: [instance] 2026-04-13 22:31:43.463460 | instance | 2026-04-13 22:31:43.463696 | instance | TASK [Create devices for Ceph] ************************************************* 2026-04-13 22:31:43.463906 | instance | Monday 13 April 2026 22:31:43 +0000 (0:00:00.021) 0:00:43.248 ********** 2026-04-13 22:31:43.976204 | instance | changed: [instance] => (item=osd0) 2026-04-13 22:31:43.976645 | instance | changed: [instance] => (item=osd1) 2026-04-13 22:31:43.976978 | instance | changed: [instance] => (item=osd2) 2026-04-13 22:31:43.977322 | instance | 2026-04-13 22:31:43.977646 | instance | TASK [Set permissions on loopback devices] ************************************* 2026-04-13 22:31:43.977975 | instance | Monday 13 April 2026 22:31:43 +0000 (0:00:00.512) 0:00:43.760 ********** 2026-04-13 22:31:44.498747 | instance | changed: [instance] => (item=osd0) 2026-04-13 22:31:44.499038 | instance | changed: [instance] => (item=osd1) 2026-04-13 22:31:44.499262 | instance | changed: [instance] => (item=osd2) 2026-04-13 22:31:44.499460 | instance | 2026-04-13 22:31:44.499668 | instance | TASK [Start loop devices] ****************************************************** 2026-04-13 22:31:44.499894 | instance | Monday 13 April 2026 22:31:44 +0000 (0:00:00.522) 0:00:44.283 ********** 2026-04-13 22:31:45.202749 | instance | changed: [instance] => (item=osd0) 2026-04-13 22:31:45.203462 | instance | changed: [instance] => (item=osd1) 2026-04-13 22:31:45.203787 | instance | changed: [instance] => (item=osd2) 2026-04-13 22:31:45.203985 | instance | 2026-04-13 22:31:45.204195 | instance | TASK [Create a volume group for each loop device] ****************************** 2026-04-13 22:31:45.204401 | instance | Monday 13 April 2026 22:31:45 +0000 (0:00:00.703) 0:00:44.987 ********** 2026-04-13 22:31:48.245050 | instance | changed: [instance] => (item=osd0) 2026-04-13 22:31:48.245268 | instance | changed: [instance] => (item=osd1) 2026-04-13 22:31:48.245419 | instance | changed: [instance] => (item=osd2) 2026-04-13 22:31:48.245561 | instance | 2026-04-13 22:31:48.245723 | instance | TASK [Create a logical volume for each loop device] **************************** 2026-04-13 22:31:48.245877 | instance | Monday 13 April 2026 22:31:48 +0000 (0:00:03.040) 0:00:48.028 ********** 2026-04-13 22:31:50.064785 | instance | changed: [instance] => (item=ceph-instance-osd0) 2026-04-13 22:31:50.064828 | instance | changed: [instance] => (item=ceph-instance-osd1) 2026-04-13 22:31:50.064833 | instance | changed: [instance] => (item=ceph-instance-osd2) 2026-04-13 22:31:50.064838 | instance | 2026-04-13 22:31:50.064843 | instance | PLAY [controllers] ************************************************************* 2026-04-13 22:31:50.064847 | instance | 2026-04-13 22:31:50.064851 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-13 22:31:50.064855 | instance | Monday 13 April 2026 22:31:50 +0000 (0:00:01.820) 0:00:49.848 ********** 2026-04-13 22:31:50.968393 | instance | ok: [instance] 2026-04-13 22:31:50.968436 | instance | 2026-04-13 22:31:50.968444 | instance | TASK [Set masquerade rule] ***************************************************** 2026-04-13 22:31:50.968451 | instance | Monday 13 April 2026 22:31:50 +0000 (0:00:00.903) 0:00:50.752 ********** 2026-04-13 22:31:51.422206 | instance | changed: [instance] 2026-04-13 22:31:51.422485 | instance | 2026-04-13 22:31:51.422499 | instance | PLAY RECAP ********************************************************************* 2026-04-13 22:31:51.422510 | instance | instance : ok=24 changed=10 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-04-13 22:31:51.422520 | instance | localhost : ok=40 changed=21 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-04-13 22:31:51.422529 | instance | 2026-04-13 22:31:51.422538 | instance | Monday 13 April 2026 22:31:51 +0000 (0:00:00.452) 0:00:51.204 ********** 2026-04-13 22:31:51.422547 | instance | =============================================================================== 2026-04-13 22:31:51.422562 | instance | Install depedencies ---------------------------------------------------- 20.35s 2026-04-13 22:31:51.426242 | instance | Generate SSH keys for missing variables --------------------------------- 6.60s 2026-04-13 22:31:51.426280 | instance | Create a volume group for each loop device ------------------------------ 3.04s 2026-04-13 22:31:51.426291 | instance | Create a logical volume for each loop device ---------------------------- 1.82s 2026-04-13 22:31:51.426301 | instance | Gathering Facts --------------------------------------------------------- 1.15s 2026-04-13 22:31:51.426311 | instance | Install "dirmngr" for GPG keyserver operations -------------------------- 1.02s 2026-04-13 22:31:51.426320 | instance | Create folders for workspace -------------------------------------------- 0.96s 2026-04-13 22:31:51.426330 | instance | Gathering Facts --------------------------------------------------------- 0.90s 2026-04-13 22:31:51.426339 | instance | Generate endpoint skeleton for missing variables ------------------------ 0.73s 2026-04-13 22:31:51.426348 | instance | Gathering Facts --------------------------------------------------------- 0.71s 2026-04-13 22:31:51.426358 | instance | Start loop devices ------------------------------------------------------ 0.70s 2026-04-13 22:31:51.426367 | instance | Gathering Facts --------------------------------------------------------- 0.67s 2026-04-13 22:31:51.426376 | instance | Configure short hostname ------------------------------------------------ 0.66s 2026-04-13 22:31:51.426403 | instance | Gathering Facts --------------------------------------------------------- 0.66s 2026-04-13 22:31:51.426413 | instance | Purge "snapd" package --------------------------------------------------- 0.65s 2026-04-13 22:31:51.426427 | instance | Set permissions on loopback devices ------------------------------------- 0.52s 2026-04-13 22:31:51.426651 | instance | Write new Ceph control plane configuration file to disk ----------------- 0.51s 2026-04-13 22:31:51.427012 | instance | Create devices for Ceph ------------------------------------------------- 0.51s 2026-04-13 22:31:51.427330 | instance | Start up service -------------------------------------------------------- 0.51s 2026-04-13 22:31:51.427714 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.46s 2026-04-13 22:31:51.521314 | instance | INFO [aio > prepare] Executed: Successful 2026-04-13 22:31:51.521939 | instance | INFO Molecule executed 1 scenario (1 successful) 2026-04-13 22:31:51.726909 | instance | ok: Runtime: 0:01:51.435196 2026-04-13 22:31:51.731501 | 2026-04-13 22:31:51.731545 | PLAY RECAP 2026-04-13 22:31:51.731592 | instance | ok: 12 changed: 9 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-13 22:31:51.731615 | 2026-04-13 22:31:51.842371 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main] 2026-04-13 22:31:51.853097 | RUN START: [untrusted : github.com/vexxhost/atmosphere/molecule/aio/converge.yml@main] 2026-04-13 22:31:52.459398 | 2026-04-13 22:31:52.459578 | PLAY [all] 2026-04-13 22:31:52.472087 | 2026-04-13 22:31:52.472182 | TASK [Build atmosphere binary] 2026-04-13 22:31:52.818372 | instance | go: downloading github.com/spf13/cobra v1.9.1 2026-04-13 22:31:52.821311 | instance | go: downloading golang.org/x/sync v0.18.0 2026-04-13 22:31:53.070322 | instance | go: downloading github.com/spf13/pflag v1.0.7 2026-04-13 22:31:59.016133 | instance | ok: Runtime: 0:00:05.983572 2026-04-13 22:31:59.020897 | 2026-04-13 22:31:59.020988 | TASK [Deploy with parallel orchestrator] 2026-04-13 22:31:59.213206 | instance | ==> Starting parallel deployment 2026-04-13 22:31:59.213385 | instance | ==> [kubernetes] Starting deployment 2026-04-13 22:31:59.213433 | instance | ==> [lpfc] Starting deployment 2026-04-13 22:31:59.213449 | instance | ==> [ceph] Starting deployment 2026-04-13 22:31:59.213459 | instance | ==> [iscsi] Starting deployment 2026-04-13 22:31:59.213473 | instance | ==> [udev] Starting deployment 2026-04-13 22:31:59.213485 | instance | ==> [multipathd] Starting deployment 2026-04-13 22:31:59.213679 | instance | Error: component kubernetes failed: starting ansible-playbook for kubernetes: exec: "ansible-playbook": cannot run executable found relative to current directory 2026-04-13 22:31:59.213694 | instance | Usage: 2026-04-13 22:31:59.213704 | instance | atmosphere deploy [flags] 2026-04-13 22:31:59.213713 | instance | 2026-04-13 22:31:59.213722 | instance | Flags: 2026-04-13 22:31:59.213732 | instance | --concurrency int Max concurrent deployments per wave (0 = unlimited) 2026-04-13 22:31:59.213742 | instance | -h, --help help for deploy 2026-04-13 22:31:59.213751 | instance | -i, --inventory string Path to Ansible inventory file (required) 2026-04-13 22:31:59.213761 | instance | -t, --tags string Comma-separated list of component tags to deploy 2026-04-13 22:31:59.213769 | instance | 2026-04-13 22:31:59.213781 | instance | component kubernetes failed: starting ansible-playbook for kubernetes: exec: "ansible-playbook": cannot run executable found relative to current directory 2026-04-13 22:31:59.554965 | instance | ERROR 2026-04-13 22:31:59.555221 | instance | { 2026-04-13 22:31:59.555264 | instance | "delta": "0:00:00.005699", 2026-04-13 22:31:59.555293 | instance | "end": "2026-04-13 22:31:59.214473", 2026-04-13 22:31:59.555320 | instance | "msg": "non-zero return code", 2026-04-13 22:31:59.555345 | instance | "rc": 1, 2026-04-13 22:31:59.555373 | instance | "start": "2026-04-13 22:31:59.208774" 2026-04-13 22:31:59.555401 | instance | } failure 2026-04-13 22:31:59.557516 | 2026-04-13 22:31:59.557582 | PLAY RECAP 2026-04-13 22:31:59.557644 | instance | ok: 1 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-04-13 22:31:59.557675 | 2026-04-13 22:31:59.713093 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/molecule/aio/converge.yml@main] 2026-04-13 22:31:59.725167 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main] 2026-04-13 22:32:00.362405 | 2026-04-13 22:32:00.534463 | PLAY [all] 2026-04-13 22:32:00.554934 | 2026-04-13 22:32:00.555029 | TASK [gather-host-logs : creating directory for system status] 2026-04-13 22:32:00.884596 | instance | changed 2026-04-13 22:32:00.890324 | 2026-04-13 22:32:00.890425 | TASK [gather-host-logs : Get logs for each host] 2026-04-13 22:32:01.226580 | instance | + systemd-cgls --full --all --no-pager 2026-04-13 22:32:01.238337 | instance | + ip addr 2026-04-13 22:32:01.241133 | instance | + ip route 2026-04-13 22:32:01.243013 | instance | + lsblk 2026-04-13 22:32:01.246473 | instance | + mount 2026-04-13 22:32:01.248112 | instance | + docker images 2026-04-13 22:32:01.248481 | instance | /bin/bash: line 7: docker: command not found 2026-04-13 22:32:01.248669 | instance | + brctl show 2026-04-13 22:32:01.249031 | instance | /bin/bash: line 8: brctl: command not found 2026-04-13 22:32:01.249207 | instance | + ps aux --sort=-%mem 2026-04-13 22:32:01.262944 | instance | + dpkg -l 2026-04-13 22:32:01.273391 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-04-13 22:32:01.273796 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-04-13 22:32:01.273860 | instance | /bin/bash: line 11: docker: command not found 2026-04-13 22:32:01.274141 | instance | + '[' '!' -z '' ']' 2026-04-13 22:32:01.433476 | instance | ok: Runtime: 0:00:00.052303 2026-04-13 22:32:01.443291 | 2026-04-13 22:32:01.443482 | TASK [gather-host-logs : Downloads logs to executor] 2026-04-13 22:32:02.097902 | instance | changed: 2026-04-13 22:32:02.098203 | instance | created directory /var/lib/zuul/builds/5010206435994aa399fb021f4b428425/work/logs/instance 2026-04-13 22:32:02.098269 | instance | cd+++++++++ system/ 2026-04-13 22:32:02.098319 | instance | >f+++++++++ system/brctl-show.txt 2026-04-13 22:32:02.098367 | instance | >f+++++++++ system/docker-images.txt 2026-04-13 22:32:02.098412 | instance | >f+++++++++ system/ip-addr.txt 2026-04-13 22:32:02.098463 | instance | >f+++++++++ system/ip-route.txt 2026-04-13 22:32:02.098510 | instance | >f+++++++++ system/lsblk.txt 2026-04-13 22:32:02.098585 | instance | >f+++++++++ system/mount.txt 2026-04-13 22:32:02.098635 | instance | >f+++++++++ system/packages.txt 2026-04-13 22:32:02.098681 | instance | >f+++++++++ system/ps.txt 2026-04-13 22:32:02.098725 | instance | >f+++++++++ system/systemd-cgls.txt 2026-04-13 22:32:02.112678 | 2026-04-13 22:32:02.112768 | LOOP [helm-release-status : creating directory for helm release status] 2026-04-13 22:32:02.307268 | instance | changed: "values" 2026-04-13 22:32:02.473919 | instance | changed: "releases" 2026-04-13 22:32:02.494317 | 2026-04-13 22:32:02.494532 | TASK [helm-release-status : Gather get release status for helm charts] 2026-04-13 22:32:02.702052 | instance | /bin/bash: line 3: kubectl: command not found 2026-04-13 22:32:03.031887 | instance | ok: Runtime: 0:00:00.005589 2026-04-13 22:32:03.039094 | 2026-04-13 22:32:03.039187 | TASK [helm-release-status : Downloads logs to executor] 2026-04-13 22:32:03.591137 | instance | changed: 2026-04-13 22:32:03.591410 | instance | cd+++++++++ helm/ 2026-04-13 22:32:03.591473 | instance | cd+++++++++ helm/releases/ 2026-04-13 22:32:03.591521 | instance | cd+++++++++ helm/values/ 2026-04-13 22:32:03.602552 | 2026-04-13 22:32:03.602655 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-04-13 22:32:03.874834 | instance | changed 2026-04-13 22:32:03.880150 | 2026-04-13 22:32:03.880224 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-04-13 22:32:04.077040 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-13 22:32:04.077473 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-13 22:32:04.083816 | instance | environment: line 1: kubectl: command not found 2026-04-13 22:32:04.084677 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-13 22:32:04.085718 | instance | environment: line 1: kubectl: command not found 2026-04-13 22:32:04.087116 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-13 22:32:04.088902 | instance | environment: line 1: kubectl: command not found 2026-04-13 22:32:04.089904 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-13 22:32:04.090396 | instance | environment: line 1: kubectl: command not found 2026-04-13 22:32:04.091844 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-13 22:32:04.092816 | instance | environment: line 1: kubectl: command not found 2026-04-13 22:32:04.093650 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-13 22:32:04.419436 | instance | ok: Runtime: 0:00:00.022976 2026-04-13 22:32:04.426429 | 2026-04-13 22:32:04.426519 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-04-13 22:32:04.623916 | instance | changed 2026-04-13 22:32:04.630790 | 2026-04-13 22:32:04.630899 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-04-13 22:32:04.836569 | instance | environment: line 5: kubectl: command not found 2026-04-13 22:32:04.837260 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-13 22:32:04.837515 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-13 22:32:04.837531 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-13 22:32:05.167931 | instance | ok: Runtime: 0:00:00.007139 2026-04-13 22:32:05.175254 | 2026-04-13 22:32:05.175364 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-04-13 22:32:05.677151 | instance | changed: 2026-04-13 22:32:05.677368 | instance | cd+++++++++ objects/ 2026-04-13 22:32:05.677405 | instance | cd+++++++++ objects/cluster/ 2026-04-13 22:32:05.677435 | instance | cd+++++++++ objects/namespaced/ 2026-04-13 22:32:05.689168 | 2026-04-13 22:32:05.689261 | TASK [gather-pod-logs : creating directory for pod logs] 2026-04-13 22:32:05.890837 | instance | changed 2026-04-13 22:32:05.897406 | 2026-04-13 22:32:05.897482 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-04-13 22:32:06.096772 | instance | changed 2026-04-13 22:32:06.102522 | 2026-04-13 22:32:06.102598 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-04-13 22:32:06.317811 | instance | environment: line 3: kubectl: command not found 2026-04-13 22:32:06.641813 | instance | ok: Runtime: 0:00:00.007927 2026-04-13 22:32:06.647372 | 2026-04-13 22:32:06.650101 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-04-13 22:32:07.140849 | instance | changed: 2026-04-13 22:32:07.141077 | instance | cd+++++++++ pod-logs/ 2026-04-13 22:32:07.141116 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-04-13 22:32:07.153195 | 2026-04-13 22:32:07.153258 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-04-13 22:32:07.349221 | instance | changed 2026-04-13 22:32:07.356536 | 2026-04-13 22:32:07.356605 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-04-13 22:32:07.560789 | instance | /bin/bash: line 2: kubectl: command not found 2026-04-13 22:32:07.894644 | instance | ok: Runtime: 0:00:00.034813 2026-04-13 22:32:07.899633 | 2026-04-13 22:32:07.899710 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-04-13 22:32:08.098832 | instance | /bin/bash: line 2: kubectl: command not found 2026-04-13 22:32:08.128021 | instance | ceph-mgr endpoints: 2026-04-13 22:32:08.438067 | instance | ok: Runtime: 0:00:00.034074 2026-04-13 22:32:08.446348 | 2026-04-13 22:32:08.446416 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-04-13 22:32:08.649847 | instance | /bin/bash: line 4: kubectl: command not found 2026-04-13 22:32:08.983342 | instance | ok: Runtime: 0:00:00.034434 2026-04-13 22:32:08.990250 | 2026-04-13 22:32:08.990336 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-04-13 22:32:09.479773 | instance | changed: cd+++++++++ prometheus/ 2026-04-13 22:32:09.493244 | 2026-04-13 22:32:09.493418 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-04-13 22:32:09.728763 | instance | changed 2026-04-13 22:32:09.733828 | 2026-04-13 22:32:09.733896 | TASK [gather-selenium-data : Get selenium data] 2026-04-13 22:32:09.936811 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-04-13 22:32:09.938397 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-04-13 22:32:10.268332 | instance | ERROR 2026-04-13 22:32:10.268666 | instance | { 2026-04-13 22:32:10.268736 | instance | "delta": "0:00:00.006131", 2026-04-13 22:32:10.268925 | instance | "end": "2026-04-13 22:32:09.938750", 2026-04-13 22:32:10.269020 | instance | "msg": "non-zero return code", 2026-04-13 22:32:10.269051 | instance | "rc": 1, 2026-04-13 22:32:10.269080 | instance | "start": "2026-04-13 22:32:09.932619" 2026-04-13 22:32:10.269107 | instance | } 2026-04-13 22:32:10.269146 | instance | ERROR: Ignoring Errors 2026-04-13 22:32:10.277002 | 2026-04-13 22:32:10.277135 | TASK [gather-selenium-data : Downloads logs to executor] 2026-04-13 22:32:10.787442 | instance | changed: cd+++++++++ selenium/ 2026-04-13 22:32:10.795356 | 2026-04-13 22:32:10.795421 | PLAY RECAP 2026-04-13 22:32:10.795477 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-04-13 22:32:10.795508 | 2026-04-13 22:32:10.908488 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main] 2026-04-13 22:32:10.920402 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-13 22:32:11.533414 | 2026-04-13 22:32:11.533538 | PLAY [all] 2026-04-13 22:32:11.544475 | 2026-04-13 22:32:11.544553 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-13 22:32:11.589821 | instance | skipping: Conditional result was False 2026-04-13 22:32:11.596216 | 2026-04-13 22:32:11.596301 | TASK [fetch-output : Set log path for single node] 2026-04-13 22:32:11.638306 | instance | ok 2026-04-13 22:32:11.645775 | 2026-04-13 22:32:11.645863 | LOOP [fetch-output : Ensure local output dirs] 2026-04-13 22:32:11.999127 | instance -> localhost | ok: "/var/lib/zuul/builds/5010206435994aa399fb021f4b428425/work/logs" 2026-04-13 22:32:12.195656 | instance -> localhost | changed: "/var/lib/zuul/builds/5010206435994aa399fb021f4b428425/work/artifacts" 2026-04-13 22:32:12.402181 | instance -> localhost | changed: "/var/lib/zuul/builds/5010206435994aa399fb021f4b428425/work/docs" 2026-04-13 22:32:12.426557 | 2026-04-13 22:32:12.426700 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-13 22:32:13.049992 | instance | changed: .d..t...... ./ 2026-04-13 22:32:13.050305 | instance | changed: All items complete 2026-04-13 22:32:13.050333 | 2026-04-13 22:32:13.506478 | instance | changed: .d..t...... ./ 2026-04-13 22:32:13.971062 | instance | changed: .d..t...... ./ 2026-04-13 22:32:13.991794 | 2026-04-13 22:32:13.991934 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-13 22:32:14.434317 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.009285 2026-04-13 22:32:14.647554 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.006194 2026-04-13 22:32:14.667378 | 2026-04-13 22:32:14.667552 | PLAY [all] 2026-04-13 22:32:14.673568 | 2026-04-13 22:32:14.673632 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-13 22:32:15.083148 | instance | changed 2026-04-13 22:32:15.090396 | 2026-04-13 22:32:15.090474 | PLAY RECAP 2026-04-13 22:32:15.090526 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-13 22:32:15.090550 | 2026-04-13 22:32:15.227580 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-13 22:32:15.244474 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-13 22:32:15.864049 | 2026-04-13 22:32:15.864187 | PLAY [localhost] 2026-04-13 22:32:15.874180 | 2026-04-13 22:32:15.874252 | TASK [Generate Zuul manifest] 2026-04-13 22:32:15.896414 | localhost | ok 2026-04-13 22:32:15.911953 | 2026-04-13 22:32:15.912033 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-13 22:32:16.286851 | localhost | changed 2026-04-13 22:32:16.305298 | 2026-04-13 22:32:16.305420 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-13 22:32:16.338092 | localhost | ok 2026-04-13 22:32:16.346581 | 2026-04-13 22:32:16.346647 | TASK [Upload logs] 2026-04-13 22:32:16.367993 | localhost | ok 2026-04-13 22:32:16.473162 | 2026-04-13 22:32:16.473278 | TASK [Set zuul-log-path fact] 2026-04-13 22:32:16.494554 | localhost | ok 2026-04-13 22:32:16.507548 | 2026-04-13 22:32:16.507638 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-13 22:32:16.540898 | localhost | ok 2026-04-13 22:32:16.548569 | 2026-04-13 22:32:16.548637 | TASK [upload-logs : Create log directories] 2026-04-13 22:32:16.888221 | localhost | changed 2026-04-13 22:32:16.894691 | 2026-04-13 22:32:16.894793 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-13 22:32:17.253901 | localhost -> localhost | ok: Runtime: 0:00:00.005684 2026-04-13 22:32:17.260479 | 2026-04-13 22:32:17.260545 | TASK [upload-logs : Upload logs to log server] 2026-04-13 22:32:17.689633 | localhost | Output suppressed because no_log was given 2026-04-13 22:32:17.695106 | 2026-04-13 22:32:17.695218 | LOOP [upload-logs : Compress console log and json output] 2026-04-13 22:32:17.739978 | localhost | skipping: Conditional result was False 2026-04-13 22:32:17.747002 | localhost | skipping: Conditional result was False 2026-04-13 22:32:17.760879 | 2026-04-13 22:32:17.761112 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-13 22:32:17.803985 | localhost | skipping: Conditional result was False 2026-04-13 22:32:17.804483 | 2026-04-13 22:32:17.808145 | localhost | skipping: Conditional result was False 2026-04-13 22:32:17.829303 | 2026-04-13 22:32:17.829473 | LOOP [upload-logs : Upload console log and json output]