2026-04-13 22:29:07.225704 | Job console starting 2026-04-13 22:29:07.235060 | Updating git repos 2026-04-13 22:29:07.303460 | Cloning repos into workspace 2026-04-13 22:29:07.525951 | Restoring repo states 2026-04-13 22:29:07.544598 | Merging changes 2026-04-13 22:29:08.629833 | Checking out repos 2026-04-13 22:29:08.715639 | Preparing playbooks 2026-04-13 22:29:10.999936 | Running Ansible setup 2026-04-13 22:29:14.525684 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-13 22:29:15.135718 | 2026-04-13 22:29:15.135873 | PLAY [localhost] 2026-04-13 22:29:15.143752 | 2026-04-13 22:29:15.143851 | TASK [Gathering Facts] 2026-04-13 22:29:16.074228 | localhost | ok 2026-04-13 22:29:16.084450 | 2026-04-13 22:29:16.084531 | TASK [Setup log path fact] 2026-04-13 22:29:16.105121 | localhost | ok 2026-04-13 22:29:16.117779 | 2026-04-13 22:29:16.117842 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-13 22:29:16.146396 | localhost | ok 2026-04-13 22:29:16.154520 | 2026-04-13 22:29:16.154609 | TASK [emit-job-header : Print job information] 2026-04-13 22:29:16.184553 | # Job Information 2026-04-13 22:29:16.184814 | Ansible Version: 2.16.16 2026-04-13 22:29:16.184885 | Job: atmosphere-molecule-aio-ovn 2026-04-13 22:29:16.184933 | Pipeline: check 2026-04-13 22:29:16.185057 | Executor: 0a8996d2b663 2026-04-13 22:29:16.185104 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3818 2026-04-13 22:29:16.185153 | Event ID: 1814c3d0-3788-11f1-8424-5cb41ea20737 2026-04-13 22:29:16.189822 | 2026-04-13 22:29:16.189911 | LOOP [emit-job-header : Print node information] 2026-04-13 22:29:16.283069 | localhost | ok: 2026-04-13 22:29:16.283247 | localhost | # Node Information 2026-04-13 22:29:16.283285 | localhost | Inventory Hostname: instance 2026-04-13 22:29:16.283314 | localhost | Hostname: np0000165847 2026-04-13 22:29:16.283340 | localhost | Username: zuul 2026-04-13 22:29:16.283372 | localhost | Distro: Ubuntu 22.04 2026-04-13 22:29:16.283399 | localhost | Provider: yul1 2026-04-13 22:29:16.283426 | localhost | Region: ca-ymq-1 2026-04-13 22:29:16.283461 | localhost | Label: ubuntu-jammy-16 2026-04-13 22:29:16.283523 | localhost | Product Name: OpenStack Nova 2026-04-13 22:29:16.283554 | localhost | Interface IP: 199.204.45.138 2026-04-13 22:29:16.295489 | 2026-04-13 22:29:16.295603 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-13 22:29:16.655463 | localhost -> localhost | changed 2026-04-13 22:29:16.660569 | 2026-04-13 22:29:16.660669 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-13 22:29:17.538442 | localhost -> localhost | changed 2026-04-13 22:29:17.549657 | 2026-04-13 22:29:17.550163 | PLAY [all] 2026-04-13 22:29:17.559886 | 2026-04-13 22:29:17.559969 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-13 22:29:17.808301 | instance -> localhost | ok 2026-04-13 22:29:17.817251 | 2026-04-13 22:29:17.817341 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-13 22:29:17.852688 | instance | ok 2026-04-13 22:29:17.868996 | instance | included: /var/lib/zuul/builds/da8d7adba6b841908206b3250d194039/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-13 22:29:17.874939 | 2026-04-13 22:29:17.875011 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-13 22:29:19.562620 | instance -> localhost | Generating public/private rsa key pair. 2026-04-13 22:29:19.562815 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/da8d7adba6b841908206b3250d194039/work/da8d7adba6b841908206b3250d194039_id_rsa 2026-04-13 22:29:19.562856 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/da8d7adba6b841908206b3250d194039/work/da8d7adba6b841908206b3250d194039_id_rsa.pub 2026-04-13 22:29:19.562887 | instance -> localhost | The key fingerprint is: 2026-04-13 22:29:19.562916 | instance -> localhost | SHA256:FpkPMvNmJSkqqCNIAKXiwjTdrUegsqxRDgvi0Z0V2Zk zuul-build-sshkey 2026-04-13 22:29:19.562956 | instance -> localhost | The key's randomart image is: 2026-04-13 22:29:19.562985 | instance -> localhost | +---[RSA 3072]----+ 2026-04-13 22:29:19.563023 | instance -> localhost | |... . o+ o | 2026-04-13 22:29:19.563054 | instance -> localhost | |..o + =. E | 2026-04-13 22:29:19.563082 | instance -> localhost | |B=.+ +=oB . | 2026-04-13 22:29:19.563110 | instance -> localhost | |@*= .o* * | 2026-04-13 22:29:19.563138 | instance -> localhost | |=Bo .. .S . | 2026-04-13 22:29:19.563165 | instance -> localhost | |*. . .+ | 2026-04-13 22:29:19.563192 | instance -> localhost | |* | 2026-04-13 22:29:19.563219 | instance -> localhost | |.. | 2026-04-13 22:29:19.563249 | instance -> localhost | | | 2026-04-13 22:29:19.563278 | instance -> localhost | +----[SHA256]-----+ 2026-04-13 22:29:19.563345 | instance -> localhost | ok: Runtime: 0:00:01.254015 2026-04-13 22:29:19.569205 | 2026-04-13 22:29:19.569268 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-13 22:29:19.602414 | instance | ok 2026-04-13 22:29:19.612250 | instance | included: /var/lib/zuul/builds/da8d7adba6b841908206b3250d194039/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-13 22:29:19.619540 | 2026-04-13 22:29:19.619602 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-13 22:29:19.644670 | instance | skipping: Conditional result was False 2026-04-13 22:29:19.655096 | 2026-04-13 22:29:19.655156 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-13 22:29:20.093407 | instance | changed 2026-04-13 22:29:20.100141 | 2026-04-13 22:29:20.100206 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-13 22:29:20.284953 | instance | ok 2026-04-13 22:29:20.289936 | 2026-04-13 22:29:20.289999 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-13 22:29:20.732612 | instance | changed 2026-04-13 22:29:20.739725 | 2026-04-13 22:29:20.739855 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-13 22:29:21.209143 | instance | changed 2026-04-13 22:29:21.216842 | 2026-04-13 22:29:21.216914 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-13 22:29:21.243034 | instance | skipping: Conditional result was False 2026-04-13 22:29:21.287042 | 2026-04-13 22:29:21.287169 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-13 22:29:21.616769 | instance -> localhost | changed 2026-04-13 22:29:21.632386 | 2026-04-13 22:29:21.632469 | TASK [add-build-sshkey : Add back temp key] 2026-04-13 22:29:21.960285 | instance -> localhost | Identity added: /var/lib/zuul/builds/da8d7adba6b841908206b3250d194039/work/da8d7adba6b841908206b3250d194039_id_rsa (zuul-build-sshkey) 2026-04-13 22:29:21.960460 | instance -> localhost | ok: Runtime: 0:00:00.016842 2026-04-13 22:29:21.965417 | 2026-04-13 22:29:21.965480 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-13 22:29:22.232673 | instance | ok 2026-04-13 22:29:22.238738 | 2026-04-13 22:29:22.238803 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-13 22:29:22.261826 | instance | skipping: Conditional result was False 2026-04-13 22:29:22.277782 | 2026-04-13 22:29:22.277853 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-13 22:29:22.550780 | instance | ok 2026-04-13 22:29:22.556658 | 2026-04-13 22:29:22.556723 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-13 22:29:24.112781 | instance | Output suppressed because no_log was given 2026-04-13 22:29:24.123957 | 2026-04-13 22:29:24.124033 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-13 22:29:24.318529 | instance | ok: "logs" 2026-04-13 22:29:24.319344 | instance | ok: All items complete 2026-04-13 22:29:24.319377 | 2026-04-13 22:29:24.462217 | instance | ok: "artifacts" 2026-04-13 22:29:24.613977 | instance | ok: "docs" 2026-04-13 22:29:24.634281 | 2026-04-13 22:29:24.634462 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-13 22:29:24.813458 | instance | changed: "logs" 2026-04-13 22:29:24.967538 | instance | changed: "artifacts" 2026-04-13 22:29:25.118436 | instance | changed: "docs" 2026-04-13 22:29:25.138273 | 2026-04-13 22:29:25.138425 | PLAY RECAP 2026-04-13 22:29:25.138477 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-13 22:29:25.138506 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-13 22:29:25.138528 | 2026-04-13 22:29:25.306875 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-13 22:29:25.315924 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-13 22:29:25.939801 | 2026-04-13 22:29:25.939955 | PLAY [all] 2026-04-13 22:29:25.952527 | 2026-04-13 22:29:25.952633 | TASK [setup-uv : Extract archive] 2026-04-13 22:29:28.214180 | instance | changed 2026-04-13 22:29:28.220702 | 2026-04-13 22:29:28.220790 | TASK [setup-uv : Print version] 2026-04-13 22:29:27.590314 | instance | uv 0.8.13 2026-04-13 22:29:28.760909 | instance | ok: Runtime: 0:00:00.014377 2026-04-13 22:29:28.767809 | 2026-04-13 22:29:28.767891 | PLAY RECAP 2026-04-13 22:29:28.767938 | instance | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-13 22:29:28.767963 | 2026-04-13 22:29:28.895696 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-13 22:29:28.906920 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main] 2026-04-13 22:29:29.501665 | 2026-04-13 22:29:29.501789 | PLAY [all] 2026-04-13 22:29:29.512491 | 2026-04-13 22:29:29.512566 | TASK [Install "jq" for log collection] 2026-04-13 22:29:40.100352 | instance | changed 2026-04-13 22:29:40.107412 | 2026-04-13 22:29:40.107514 | TASK [Install pip3 for Python package management] 2026-04-13 22:29:46.132524 | instance | changed 2026-04-13 22:29:46.139592 | 2026-04-13 22:29:46.139680 | TASK [Install Python "kubernetes" library for kubernetes.core modules] 2026-04-13 22:29:49.247664 | instance | changed 2026-04-13 22:29:49.251337 | 2026-04-13 22:29:49.251393 | PLAY [all] 2026-04-13 22:29:49.259014 | 2026-04-13 22:29:49.259079 | TASK [ensure-go : Check installed go version] 2026-04-13 22:29:49.798450 | instance | ok: ERROR (ignored) 2026-04-13 22:29:49.798836 | instance | { 2026-04-13 22:29:49.798901 | instance | "failed_when_result": false, 2026-04-13 22:29:49.798946 | instance | "msg": "[Errno 2] No such file or directory: b'go'", 2026-04-13 22:29:49.798990 | instance | "rc": 2 2026-04-13 22:29:49.799038 | instance | } 2026-04-13 22:29:49.806097 | 2026-04-13 22:29:49.806167 | TASK [ensure-go : Skip if correct version of go is installed] 2026-04-13 22:29:49.860782 | instance | ok 2026-04-13 22:29:49.871834 | instance | included: /var/lib/zuul/builds/da8d7adba6b841908206b3250d194039/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-go/tasks/install-go.yaml 2026-04-13 22:29:49.877739 | 2026-04-13 22:29:49.877805 | TASK [ensure-go : Create temp directory] 2026-04-13 22:29:50.186756 | instance | changed 2026-04-13 22:29:50.194586 | 2026-04-13 22:29:50.194657 | TASK [ensure-go : Get archive checksum] 2026-04-13 22:29:50.818980 | instance | ok: OK (64 bytes) 2026-04-13 22:29:50.824428 | 2026-04-13 22:29:50.824499 | TASK [ensure-go : Download go archive] 2026-04-13 22:29:52.275929 | instance | changed: OK (78559214 bytes) 2026-04-13 22:29:52.284682 | 2026-04-13 22:29:52.284787 | TASK [ensure-go : Install go] 2026-04-13 22:29:58.206235 | instance | changed 2026-04-13 22:29:58.214498 | 2026-04-13 22:29:58.214607 | PLAY [all] 2026-04-13 22:29:58.222115 | 2026-04-13 22:29:58.222204 | TASK [Copy inventory file for Zuul] 2026-04-13 22:29:58.996099 | instance | changed 2026-04-13 22:29:59.002124 | 2026-04-13 22:29:59.002214 | TASK [Switch "ansible_host" to private IP] 2026-04-13 22:29:59.332276 | instance | changed: 1 replacements made 2026-04-13 22:29:59.371588 | 2026-04-13 22:29:59.371735 | TASK [Run molecule prepare] 2026-04-13 22:29:59.657901 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-04-13 22:29:59.658148 | instance | Creating virtual environment at: .venv 2026-04-13 22:29:59.680449 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-04-13 22:29:59.710991 | instance | Downloading setuptools (1.1MiB) 2026-04-13 22:29:59.712077 | instance | Downloading netaddr (2.2MiB) 2026-04-13 22:29:59.712910 | instance | Downloading openstacksdk (1.7MiB) 2026-04-13 22:29:59.713638 | instance | Downloading kubernetes (1.9MiB) 2026-04-13 22:29:59.713854 | instance | Downloading ansible-core (2.1MiB) 2026-04-13 22:29:59.714121 | instance | Downloading pydantic-core (2.0MiB) 2026-04-13 22:29:59.719303 | instance | Downloading pygments (1.2MiB) 2026-04-13 22:29:59.720726 | instance | Downloading rjsonnet (1.2MiB) 2026-04-13 22:29:59.721045 | instance | Downloading cryptography (4.2MiB) 2026-04-13 22:30:00.066679 | instance | Building pyperclip==1.9.0 2026-04-13 22:30:00.094731 | instance | Downloading rjsonnet 2026-04-13 22:30:00.179852 | instance | Downloading pydantic-core 2026-04-13 22:30:00.236095 | instance | Downloading netaddr 2026-04-13 22:30:00.244995 | instance | Downloading pygments 2026-04-13 22:30:00.260967 | instance | Downloading cryptography 2026-04-13 22:30:00.296896 | instance | Downloading setuptools 2026-04-13 22:30:00.362145 | instance | Downloading kubernetes 2026-04-13 22:30:00.401446 | instance | Downloading ansible-core 2026-04-13 22:30:00.437660 | instance | Downloading openstacksdk 2026-04-13 22:30:00.784954 | instance | Built pyperclip==1.9.0 2026-04-13 22:30:00.987046 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-04-13 22:30:01.028966 | instance | Installed 83 packages in 39ms 2026-04-13 22:30:01.629438 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-04-13 22:30:02.244836 | instance | INFO [aio > discovery] scenario test matrix: prepare 2026-04-13 22:30:02.244940 | instance | INFO [aio > prerun] Performing prerun with role_name_check=0... 2026-04-13 22:31:00.565848 | instance | INFO [aio > prepare] Executing 2026-04-13 22:31:01.513863 | instance | 2026-04-13 22:31:01.514423 | instance | PLAY [Prepare] ***************************************************************** 2026-04-13 22:31:01.514714 | instance | 2026-04-13 22:31:01.515004 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-13 22:31:01.515283 | instance | Monday 13 April 2026 22:31:01 +0000 (0:00:00.028) 0:00:00.028 ********** 2026-04-13 22:31:02.681369 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-04-13 22:31:02.681592 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-04-13 22:31:02.681897 | instance | interpreter could change the meaning of that path. See 2026-04-13 22:31:02.682187 | instance | https://docs.ansible.com/ansible- 2026-04-13 22:31:02.682468 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-04-13 22:31:02.687932 | instance | ok: [instance] 2026-04-13 22:31:02.688208 | instance | 2026-04-13 22:31:02.688527 | instance | TASK [Configure short hostname] ************************************************ 2026-04-13 22:31:02.688802 | instance | Monday 13 April 2026 22:31:02 +0000 (0:00:01.175) 0:00:01.203 ********** 2026-04-13 22:31:03.388545 | instance | changed: [instance] 2026-04-13 22:31:03.388716 | instance | 2026-04-13 22:31:03.389069 | instance | TASK [Ensure hostname inside hosts file] *************************************** 2026-04-13 22:31:03.389423 | instance | Monday 13 April 2026 22:31:03 +0000 (0:00:00.700) 0:00:01.904 ********** 2026-04-13 22:31:03.660589 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created 2026-04-13 22:31:03.660679 | instance | with a mode of 0700, this may cause issues when running as another user. To 2026-04-13 22:31:03.660766 | instance | avoid this, create the remote_tmp dir with the correct permissions manually 2026-04-13 22:31:03.668530 | instance | changed: [instance] 2026-04-13 22:31:03.668777 | instance | 2026-04-13 22:31:03.669085 | instance | TASK [Install "dirmngr" for GPG keyserver operations] ************************** 2026-04-13 22:31:03.669367 | instance | Monday 13 April 2026 22:31:03 +0000 (0:00:00.280) 0:00:02.184 ********** 2026-04-13 22:31:04.898130 | instance | ok: [instance] 2026-04-13 22:31:04.898399 | instance | 2026-04-13 22:31:04.898685 | instance | TASK [Purge "snapd" package] *************************************************** 2026-04-13 22:31:04.898991 | instance | Monday 13 April 2026 22:31:04 +0000 (0:00:01.228) 0:00:03.413 ********** 2026-04-13 22:31:05.835054 | instance | ok: [instance] 2026-04-13 22:31:05.835245 | instance | 2026-04-13 22:31:05.835540 | instance | PLAY [Generate workspace for Atmosphere] *************************************** 2026-04-13 22:31:05.835787 | instance | 2026-04-13 22:31:05.836064 | instance | TASK [Create folders for workspace] ******************************************** 2026-04-13 22:31:05.836385 | instance | Monday 13 April 2026 22:31:05 +0000 (0:00:00.937) 0:00:04.350 ********** 2026-04-13 22:31:06.894365 | instance | changed: [localhost] => (item=group_vars) 2026-04-13 22:31:06.894686 | instance | changed: [localhost] => (item=group_vars/all) 2026-04-13 22:31:06.895059 | instance | changed: [localhost] => (item=group_vars/controllers) 2026-04-13 22:31:06.895515 | instance | changed: [localhost] => (item=group_vars/cephs) 2026-04-13 22:31:06.895893 | instance | changed: [localhost] => (item=group_vars/computes) 2026-04-13 22:31:06.896330 | instance | changed: [localhost] => (item=host_vars) 2026-04-13 22:31:06.896687 | instance | 2026-04-13 22:31:06.897078 | instance | PLAY [Generate Ceph control plane configuration for workspace] ***************** 2026-04-13 22:31:06.897523 | instance | 2026-04-13 22:31:06.897722 | instance | TASK [Ensure the Ceph control plane configuration file exists] ***************** 2026-04-13 22:31:06.898046 | instance | Monday 13 April 2026 22:31:06 +0000 (0:00:01.058) 0:00:05.408 ********** 2026-04-13 22:31:07.102549 | instance | changed: [localhost] 2026-04-13 22:31:07.102756 | instance | 2026-04-13 22:31:07.103041 | instance | TASK [Load the current Ceph control plane configuration into a variable] ******* 2026-04-13 22:31:07.103317 | instance | Monday 13 April 2026 22:31:07 +0000 (0:00:00.208) 0:00:05.617 ********** 2026-04-13 22:31:07.130380 | instance | ok: [localhost] 2026-04-13 22:31:07.130609 | instance | 2026-04-13 22:31:07.130869 | instance | TASK [Generate Ceph control plane values for missing variables] **************** 2026-04-13 22:31:07.131134 | instance | Monday 13 April 2026 22:31:07 +0000 (0:00:00.028) 0:00:05.646 ********** 2026-04-13 22:31:07.188996 | instance | ok: [localhost] => (item={'key': 'ceph_fsid', 'value': '791c17f0-f57e-558b-9a5d-06828c1034bd'}) 2026-04-13 22:31:07.189258 | instance | ok: [localhost] => (item={'key': 'ceph_mon_public_network', 'value': '10.96.240.0/24'}) 2026-04-13 22:31:07.189501 | instance | 2026-04-13 22:31:07.189767 | instance | TASK [Write new Ceph control plane configuration file to disk] ***************** 2026-04-13 22:31:07.190030 | instance | Monday 13 April 2026 22:31:07 +0000 (0:00:00.058) 0:00:05.704 ********** 2026-04-13 22:31:07.766188 | instance | changed: [localhost] 2026-04-13 22:31:07.766381 | instance | 2026-04-13 22:31:07.766655 | instance | PLAY [Generate Ceph OSD configuration for workspace] *************************** 2026-04-13 22:31:07.766902 | instance | 2026-04-13 22:31:07.767158 | instance | TASK [Ensure the Ceph OSDs configuration file exists] ************************** 2026-04-13 22:31:07.767421 | instance | Monday 13 April 2026 22:31:07 +0000 (0:00:00.577) 0:00:06.281 ********** 2026-04-13 22:31:07.952031 | instance | changed: [localhost] 2026-04-13 22:31:07.952282 | instance | 2026-04-13 22:31:07.952566 | instance | TASK [Load the current Ceph OSDs configuration into a variable] **************** 2026-04-13 22:31:07.952952 | instance | Monday 13 April 2026 22:31:07 +0000 (0:00:00.185) 0:00:06.467 ********** 2026-04-13 22:31:07.977525 | instance | ok: [localhost] 2026-04-13 22:31:07.977745 | instance | 2026-04-13 22:31:07.978070 | instance | TASK [Generate Ceph OSDs values for missing variables] ************************* 2026-04-13 22:31:07.978371 | instance | Monday 13 April 2026 22:31:07 +0000 (0:00:00.025) 0:00:06.492 ********** 2026-04-13 22:31:08.005215 | instance | ok: [localhost] => (item={'key': 'ceph_osd_devices', 'value': ['/dev/vdb', '/dev/vdc', '/dev/vdd']}) 2026-04-13 22:31:08.005463 | instance | 2026-04-13 22:31:08.005737 | instance | TASK [Write new Ceph OSDs configuration file to disk] ************************** 2026-04-13 22:31:08.006027 | instance | Monday 13 April 2026 22:31:07 +0000 (0:00:00.027) 0:00:06.520 ********** 2026-04-13 22:31:08.358393 | instance | changed: [localhost] 2026-04-13 22:31:08.358606 | instance | 2026-04-13 22:31:08.358883 | instance | PLAY [Generate Kubernetes configuration for workspace] ************************* 2026-04-13 22:31:08.359127 | instance | 2026-04-13 22:31:08.359475 | instance | TASK [Ensure the Kubernetes configuration file exists] ************************* 2026-04-13 22:31:08.359797 | instance | Monday 13 April 2026 22:31:08 +0000 (0:00:00.353) 0:00:06.874 ********** 2026-04-13 22:31:08.532658 | instance | changed: [localhost] 2026-04-13 22:31:08.533052 | instance | 2026-04-13 22:31:08.533485 | instance | TASK [Load the current Kubernetes configuration into a variable] *************** 2026-04-13 22:31:08.533797 | instance | Monday 13 April 2026 22:31:08 +0000 (0:00:00.173) 0:00:07.047 ********** 2026-04-13 22:31:08.559676 | instance | ok: [localhost] 2026-04-13 22:31:08.560025 | instance | 2026-04-13 22:31:08.560504 | instance | TASK [Generate Kubernetes values for missing variables] ************************ 2026-04-13 22:31:08.560905 | instance | Monday 13 April 2026 22:31:08 +0000 (0:00:00.027) 0:00:07.074 ********** 2026-04-13 22:31:08.600228 | instance | ok: [localhost] => (item={'key': 'kubernetes_hostname', 'value': '10.96.240.10'}) 2026-04-13 22:31:08.600590 | instance | ok: [localhost] => (item={'key': 'kubernetes_keepalived_vrid', 'value': 42}) 2026-04-13 22:31:08.600874 | instance | ok: [localhost] => (item={'key': 'kubernetes_keepalived_vip', 'value': '10.96.240.10'}) 2026-04-13 22:31:08.601127 | instance | 2026-04-13 22:31:08.601396 | instance | TASK [Write new Kubernetes configuration file to disk] ************************* 2026-04-13 22:31:08.601669 | instance | Monday 13 April 2026 22:31:08 +0000 (0:00:00.040) 0:00:07.115 ********** 2026-04-13 22:31:08.950933 | instance | changed: [localhost] 2026-04-13 22:31:08.951158 | instance | 2026-04-13 22:31:08.951448 | instance | PLAY [Generate Keepalived configuration for workspace] ************************* 2026-04-13 22:31:08.951713 | instance | 2026-04-13 22:31:08.951993 | instance | TASK [Ensure the Keeaplived configuration file exists] ************************* 2026-04-13 22:31:08.952332 | instance | Monday 13 April 2026 22:31:08 +0000 (0:00:00.350) 0:00:07.466 ********** 2026-04-13 22:31:09.119411 | instance | changed: [localhost] 2026-04-13 22:31:09.119656 | instance | 2026-04-13 22:31:09.119964 | instance | TASK [Load the current Keepalived configuration into a variable] *************** 2026-04-13 22:31:09.120301 | instance | Monday 13 April 2026 22:31:09 +0000 (0:00:00.168) 0:00:07.634 ********** 2026-04-13 22:31:09.142129 | instance | ok: [localhost] 2026-04-13 22:31:09.142369 | instance | 2026-04-13 22:31:09.142653 | instance | TASK [Generate Keepalived values for missing variables] ************************ 2026-04-13 22:31:09.142916 | instance | Monday 13 April 2026 22:31:09 +0000 (0:00:00.023) 0:00:07.658 ********** 2026-04-13 22:31:09.178177 | instance | ok: [localhost] => (item={'key': 'keepalived_interface', 'value': 'br-ex'}) 2026-04-13 22:31:09.178408 | instance | ok: [localhost] => (item={'key': 'keepalived_vip', 'value': '10.96.250.10'}) 2026-04-13 22:31:09.178664 | instance | 2026-04-13 22:31:09.178938 | instance | TASK [Write new Keepalived configuration file to disk] ************************* 2026-04-13 22:31:09.179224 | instance | Monday 13 April 2026 22:31:09 +0000 (0:00:00.035) 0:00:07.693 ********** 2026-04-13 22:31:09.530954 | instance | changed: [localhost] 2026-04-13 22:31:09.531173 | instance | 2026-04-13 22:31:09.531449 | instance | PLAY [Generate endpoints for workspace] **************************************** 2026-04-13 22:31:09.531708 | instance | 2026-04-13 22:31:09.531991 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-13 22:31:09.532300 | instance | Monday 13 April 2026 22:31:09 +0000 (0:00:00.352) 0:00:08.046 ********** 2026-04-13 22:31:10.233547 | instance | ok: [localhost] 2026-04-13 22:31:10.233743 | instance | 2026-04-13 22:31:10.234017 | instance | TASK [Ensure the endpoints file exists] **************************************** 2026-04-13 22:31:10.234295 | instance | Monday 13 April 2026 22:31:10 +0000 (0:00:00.702) 0:00:08.748 ********** 2026-04-13 22:31:10.416349 | instance | changed: [localhost] 2026-04-13 22:31:10.416439 | instance | 2026-04-13 22:31:10.416658 | instance | TASK [Load the current endpoints into a variable] ****************************** 2026-04-13 22:31:10.416896 | instance | Monday 13 April 2026 22:31:10 +0000 (0:00:00.183) 0:00:08.931 ********** 2026-04-13 22:31:10.444040 | instance | ok: [localhost] 2026-04-13 22:31:10.444314 | instance | 2026-04-13 22:31:10.444620 | instance | TASK [Generate endpoint skeleton for missing variables] ************************ 2026-04-13 22:31:10.444897 | instance | Monday 13 April 2026 22:31:10 +0000 (0:00:00.028) 0:00:08.960 ********** 2026-04-13 22:31:11.221240 | instance | ok: [localhost] => (item=keycloak_host) 2026-04-13 22:31:11.221459 | instance | ok: [localhost] => (item=kube_prometheus_stack_grafana_host) 2026-04-13 22:31:11.221721 | instance | ok: [localhost] => (item=kube_prometheus_stack_alertmanager_host) 2026-04-13 22:31:11.221983 | instance | ok: [localhost] => (item=kube_prometheus_stack_prometheus_host) 2026-04-13 22:31:11.222234 | instance | ok: [localhost] => (item=openstack_helm_endpoints_region_name) 2026-04-13 22:31:11.222528 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_api_host) 2026-04-13 22:31:11.222712 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_api_host) 2026-04-13 22:31:11.222904 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_api_host) 2026-04-13 22:31:11.223064 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_api_host) 2026-04-13 22:31:11.223255 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_api_host) 2026-04-13 22:31:11.223411 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_api_host) 2026-04-13 22:31:11.223572 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_api_host) 2026-04-13 22:31:11.223735 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_novnc_host) 2026-04-13 22:31:11.223898 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_api_host) 2026-04-13 22:31:11.224058 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_api_host) 2026-04-13 22:31:11.224249 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_api_host) 2026-04-13 22:31:11.224443 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_api_host) 2026-04-13 22:31:11.224607 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_registry_host) 2026-04-13 22:31:11.224790 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_api_host) 2026-04-13 22:31:11.224959 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_cfn_api_host) 2026-04-13 22:31:11.225124 | instance | ok: [localhost] => (item=openstack_helm_endpoints_horizon_api_host) 2026-04-13 22:31:11.225288 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rgw_host) 2026-04-13 22:31:11.225452 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_api_host) 2026-04-13 22:31:11.225607 | instance | 2026-04-13 22:31:11.225772 | instance | TASK [Write new endpoints file to disk] **************************************** 2026-04-13 22:31:11.225935 | instance | Monday 13 April 2026 22:31:11 +0000 (0:00:00.776) 0:00:09.736 ********** 2026-04-13 22:31:11.576809 | instance | changed: [localhost] 2026-04-13 22:31:11.577031 | instance | 2026-04-13 22:31:11.577416 | instance | TASK [Ensure the endpoints file exists] **************************************** 2026-04-13 22:31:11.577700 | instance | Monday 13 April 2026 22:31:11 +0000 (0:00:00.355) 0:00:10.092 ********** 2026-04-13 22:31:11.762007 | instance | changed: [localhost] 2026-04-13 22:31:11.762232 | instance | 2026-04-13 22:31:11.764994 | instance | PLAY [Generate Neutron configuration for workspace] **************************** 2026-04-13 22:31:11.765021 | instance | 2026-04-13 22:31:11.765032 | instance | TASK [Ensure the Neutron configuration file exists] **************************** 2026-04-13 22:31:11.765041 | instance | Monday 13 April 2026 22:31:11 +0000 (0:00:00.185) 0:00:10.277 ********** 2026-04-13 22:31:11.950929 | instance | changed: [localhost] 2026-04-13 22:31:11.951144 | instance | 2026-04-13 22:31:11.951458 | instance | TASK [Load the current Neutron configuration into a variable] ****************** 2026-04-13 22:31:11.951722 | instance | Monday 13 April 2026 22:31:11 +0000 (0:00:00.188) 0:00:10.466 ********** 2026-04-13 22:31:11.983406 | instance | ok: [localhost] 2026-04-13 22:31:11.983636 | instance | 2026-04-13 22:31:11.983899 | instance | TASK [Generate Neutron values for missing variables] *************************** 2026-04-13 22:31:11.984163 | instance | Monday 13 April 2026 22:31:11 +0000 (0:00:00.033) 0:00:10.499 ********** 2026-04-13 22:31:12.021757 | 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:12.021978 | instance | 2026-04-13 22:31:12.022250 | instance | TASK [Write new Neutron configuration file to disk] **************************** 2026-04-13 22:31:12.022502 | instance | Monday 13 April 2026 22:31:12 +0000 (0:00:00.038) 0:00:10.537 ********** 2026-04-13 22:31:12.401094 | instance | changed: [localhost] 2026-04-13 22:31:12.401398 | instance | 2026-04-13 22:31:12.401734 | instance | PLAY [Generate Nova configuration for workspace] ******************************* 2026-04-13 22:31:12.402029 | instance | 2026-04-13 22:31:12.402349 | instance | TASK [Ensure the Nova configuration file exists] ******************************* 2026-04-13 22:31:12.402675 | instance | Monday 13 April 2026 22:31:12 +0000 (0:00:00.378) 0:00:10.916 ********** 2026-04-13 22:31:12.600463 | instance | changed: [localhost] 2026-04-13 22:31:12.600812 | instance | 2026-04-13 22:31:12.601181 | instance | TASK [Load the current Nova configuration into a variable] ********************* 2026-04-13 22:31:12.601513 | instance | Monday 13 April 2026 22:31:12 +0000 (0:00:00.198) 0:00:11.115 ********** 2026-04-13 22:31:12.628572 | instance | ok: [localhost] 2026-04-13 22:31:12.628893 | instance | 2026-04-13 22:31:12.629226 | instance | TASK [Generate Nova values for missing variables] ****************************** 2026-04-13 22:31:12.629546 | instance | Monday 13 April 2026 22:31:12 +0000 (0:00:00.028) 0:00:11.144 ********** 2026-04-13 22:31:12.669068 | 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:12.669359 | instance | 2026-04-13 22:31:12.669683 | instance | TASK [Write new Nova configuration file to disk] ******************************* 2026-04-13 22:31:12.670000 | instance | Monday 13 April 2026 22:31:12 +0000 (0:00:00.040) 0:00:11.184 ********** 2026-04-13 22:31:13.039023 | instance | changed: [localhost] 2026-04-13 22:31:13.039242 | instance | 2026-04-13 22:31:13.039523 | instance | PLAY [Generate secrets for workspace] ****************************************** 2026-04-13 22:31:13.039791 | instance | 2026-04-13 22:31:13.040067 | instance | TASK [Ensure the secrets file exists] ****************************************** 2026-04-13 22:31:13.040434 | instance | Monday 13 April 2026 22:31:13 +0000 (0:00:00.369) 0:00:11.554 ********** 2026-04-13 22:31:13.220397 | instance | changed: [localhost] 2026-04-13 22:31:13.220618 | instance | 2026-04-13 22:31:13.220888 | instance | TASK [Load the current secrets into a variable] ******************************** 2026-04-13 22:31:13.221256 | instance | Monday 13 April 2026 22:31:13 +0000 (0:00:00.181) 0:00:11.735 ********** 2026-04-13 22:31:13.253528 | instance | ok: [localhost] 2026-04-13 22:31:13.253775 | instance | 2026-04-13 22:31:13.254104 | instance | TASK [Generate secrets for missing variables] ********************************** 2026-04-13 22:31:13.254400 | instance | Monday 13 April 2026 22:31:13 +0000 (0:00:00.033) 0:00:11.769 ********** 2026-04-13 22:31:13.657900 | instance | ok: [localhost] => (item=heat_auth_encryption_key) 2026-04-13 22:31:13.658126 | instance | ok: [localhost] => (item=keepalived_password) 2026-04-13 22:31:13.658396 | instance | ok: [localhost] => (item=keycloak_admin_password) 2026-04-13 22:31:13.658653 | instance | ok: [localhost] => (item=keycloak_database_password) 2026-04-13 22:31:13.658914 | instance | ok: [localhost] => (item=keystone_keycloak_client_secret) 2026-04-13 22:31:13.659171 | instance | ok: [localhost] => (item=keystone_oidc_crypto_passphrase) 2026-04-13 22:31:13.659430 | instance | ok: [localhost] => (item=kube_prometheus_stack_grafana_admin_password) 2026-04-13 22:31:13.659714 | instance | ok: [localhost] => (item=octavia_heartbeat_key) 2026-04-13 22:31:13.659948 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rabbitmq_admin_password) 2026-04-13 22:31:13.660233 | instance | ok: [localhost] => (item=openstack_helm_endpoints_memcached_secret_key) 2026-04-13 22:31:13.660504 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_admin_password) 2026-04-13 22:31:13.660753 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_mariadb_password) 2026-04-13 22:31:13.661006 | instance | ok: [localhost] => (item=openstack_helm_endpoints_keystone_rabbitmq_password) 2026-04-13 22:31:13.661263 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_keystone_password) 2026-04-13 22:31:13.661534 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_mariadb_password) 2026-04-13 22:31:13.661796 | instance | ok: [localhost] => (item=openstack_helm_endpoints_glance_rabbitmq_password) 2026-04-13 22:31:13.662033 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_keystone_password) 2026-04-13 22:31:13.662328 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_mariadb_password) 2026-04-13 22:31:13.662585 | instance | ok: [localhost] => (item=openstack_helm_endpoints_cinder_rabbitmq_password) 2026-04-13 22:31:13.662833 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_keystone_password) 2026-04-13 22:31:13.663082 | instance | ok: [localhost] => (item=openstack_helm_endpoints_placement_mariadb_password) 2026-04-13 22:31:13.663338 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_keystone_password) 2026-04-13 22:31:13.663612 | instance | ok: [localhost] => (item=openstack_helm_endpoints_barbican_mariadb_password) 2026-04-13 22:31:13.663847 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_keystone_password) 2026-04-13 22:31:13.664107 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_mariadb_password) 2026-04-13 22:31:13.664507 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_rabbitmq_password) 2026-04-13 22:31:13.664752 | instance | ok: [localhost] => (item=openstack_helm_endpoints_neutron_metadata_secret) 2026-04-13 22:31:13.665003 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_keystone_password) 2026-04-13 22:31:13.665256 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_mariadb_password) 2026-04-13 22:31:13.665513 | instance | ok: [localhost] => (item=openstack_helm_endpoints_nova_rabbitmq_password) 2026-04-13 22:31:13.665771 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_keystone_password) 2026-04-13 22:31:13.666025 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_mariadb_password) 2026-04-13 22:31:13.666340 | instance | ok: [localhost] => (item=openstack_helm_endpoints_ironic_rabbitmq_password) 2026-04-13 22:31:13.666516 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_keystone_password) 2026-04-13 22:31:13.666633 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_mariadb_password) 2026-04-13 22:31:13.666750 | instance | ok: [localhost] => (item=openstack_helm_endpoints_designate_rabbitmq_password) 2026-04-13 22:31:13.666867 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_keystone_password) 2026-04-13 22:31:13.666976 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_mariadb_password) 2026-04-13 22:31:13.667101 | instance | ok: [localhost] => (item=openstack_helm_endpoints_octavia_rabbitmq_password) 2026-04-13 22:31:13.667209 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_keystone_password) 2026-04-13 22:31:13.667325 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_mariadb_password) 2026-04-13 22:31:13.667440 | instance | ok: [localhost] => (item=openstack_helm_endpoints_magnum_rabbitmq_password) 2026-04-13 22:31:13.667559 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_keystone_password) 2026-04-13 22:31:13.667681 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_trustee_keystone_password) 2026-04-13 22:31:13.667802 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_stack_user_keystone_password) 2026-04-13 22:31:13.667917 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_mariadb_password) 2026-04-13 22:31:13.668033 | instance | ok: [localhost] => (item=openstack_helm_endpoints_heat_rabbitmq_password) 2026-04-13 22:31:13.668150 | instance | ok: [localhost] => (item=openstack_helm_endpoints_horizon_mariadb_password) 2026-04-13 22:31:13.668287 | instance | ok: [localhost] => (item=openstack_helm_endpoints_tempest_keystone_password) 2026-04-13 22:31:13.668408 | instance | ok: [localhost] => (item=openstack_helm_endpoints_openstack_exporter_keystone_password) 2026-04-13 22:31:13.668524 | instance | ok: [localhost] => (item=openstack_helm_endpoints_rgw_keystone_password) 2026-04-13 22:31:13.668640 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_keystone_password) 2026-04-13 22:31:13.668755 | instance | ok: [localhost] => (item=openstack_helm_endpoints_manila_mariadb_password) 2026-04-13 22:31:13.668871 | instance | ok: [localhost] => (item=openstack_helm_endpoints_staffeln_mariadb_password) 2026-04-13 22:31:13.668982 | instance | 2026-04-13 22:31:13.669100 | instance | TASK [Generate base64 encoded secrets] ***************************************** 2026-04-13 22:31:13.669216 | instance | Monday 13 April 2026 22:31:13 +0000 (0:00:00.403) 0:00:12.173 ********** 2026-04-13 22:31:13.710387 | instance | ok: [localhost] => (item=barbican_kek) 2026-04-13 22:31:13.710596 | instance | 2026-04-13 22:31:13.710865 | instance | TASK [Generate temporary files for generating keys for missing variables] ****** 2026-04-13 22:31:13.711119 | instance | Monday 13 April 2026 22:31:13 +0000 (0:00:00.052) 0:00:12.225 ********** 2026-04-13 22:31:14.114044 | instance | changed: [localhost] => (item=manila_ssh_key) 2026-04-13 22:31:14.114305 | instance | changed: [localhost] => (item=nova_ssh_key) 2026-04-13 22:31:14.114591 | instance | 2026-04-13 22:31:14.114891 | instance | TASK [Generate SSH keys for missing variables] ********************************* 2026-04-13 22:31:14.115135 | instance | Monday 13 April 2026 22:31:14 +0000 (0:00:00.403) 0:00:12.629 ********** 2026-04-13 22:31:17.495077 | instance | changed: [localhost] => (item=manila_ssh_key) 2026-04-13 22:31:17.495320 | instance | changed: [localhost] => (item=nova_ssh_key) 2026-04-13 22:31:17.495594 | instance | 2026-04-13 22:31:17.495894 | instance | TASK [Set values for SSH keys] ************************************************* 2026-04-13 22:31:17.496172 | instance | Monday 13 April 2026 22:31:17 +0000 (0:00:03.378) 0:00:16.007 ********** 2026-04-13 22:31:17.545271 | instance | ok: [localhost] => (item=manila_ssh_key) 2026-04-13 22:31:17.545492 | instance | ok: [localhost] => (item=nova_ssh_key) 2026-04-13 22:31:17.545714 | instance | 2026-04-13 22:31:17.545901 | instance | TASK [Delete the temporary files generated for SSH keys] *********************** 2026-04-13 22:31:17.546131 | instance | Monday 13 April 2026 22:31:17 +0000 (0:00:00.053) 0:00:16.060 ********** 2026-04-13 22:31:17.893367 | instance | changed: [localhost] => (item=manila_ssh_key) 2026-04-13 22:31:17.893608 | instance | changed: [localhost] => (item=nova_ssh_key) 2026-04-13 22:31:17.893873 | instance | 2026-04-13 22:31:17.894142 | instance | TASK [Write new secrets file to disk] ****************************************** 2026-04-13 22:31:17.894408 | instance | Monday 13 April 2026 22:31:17 +0000 (0:00:00.347) 0:00:16.408 ********** 2026-04-13 22:31:18.245497 | instance | changed: [localhost] 2026-04-13 22:31:18.245582 | instance | 2026-04-13 22:31:18.245784 | instance | TASK [Encrypt secrets file with Vault password] ******************************** 2026-04-13 22:31:18.245976 | instance | Monday 13 April 2026 22:31:18 +0000 (0:00:00.352) 0:00:16.761 ********** 2026-04-13 22:31:18.282223 | instance | skipping: [localhost] 2026-04-13 22:31:18.282595 | instance | 2026-04-13 22:31:18.283024 | instance | PLAY [Setup networking] ******************************************************** 2026-04-13 22:31:18.283389 | instance | 2026-04-13 22:31:18.283747 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-13 22:31:18.284086 | instance | Monday 13 April 2026 22:31:18 +0000 (0:00:00.036) 0:00:16.797 ********** 2026-04-13 22:31:19.022291 | instance | ok: [instance] 2026-04-13 22:31:19.022549 | instance | 2026-04-13 22:31:19.022820 | instance | TASK [Create bridge for management network] ************************************ 2026-04-13 22:31:19.023097 | instance | Monday 13 April 2026 22:31:19 +0000 (0:00:00.738) 0:00:17.536 ********** 2026-04-13 22:31:19.367732 | instance | ok: [instance] 2026-04-13 22:31:19.368026 | instance | 2026-04-13 22:31:19.368451 | instance | TASK [Create fake interface for management bridge] ***************************** 2026-04-13 22:31:19.368759 | instance | Monday 13 April 2026 22:31:19 +0000 (0:00:00.346) 0:00:17.883 ********** 2026-04-13 22:31:19.591508 | instance | ok: [instance] 2026-04-13 22:31:19.591984 | instance | 2026-04-13 22:31:19.592409 | instance | TASK [Assign dummy interface to management bridge] ***************************** 2026-04-13 22:31:19.592706 | instance | Monday 13 April 2026 22:31:19 +0000 (0:00:00.223) 0:00:18.106 ********** 2026-04-13 22:31:19.805159 | instance | ok: [instance] 2026-04-13 22:31:19.805384 | instance | 2026-04-13 22:31:19.805754 | instance | TASK [Assign IP address for management bridge] ********************************* 2026-04-13 22:31:19.806157 | instance | Monday 13 April 2026 22:31:19 +0000 (0:00:00.213) 0:00:18.320 ********** 2026-04-13 22:31:20.008868 | instance | ok: [instance] 2026-04-13 22:31:20.009083 | instance | 2026-04-13 22:31:20.009320 | instance | TASK [Bring up interfaces] ***************************************************** 2026-04-13 22:31:20.009545 | instance | Monday 13 April 2026 22:31:20 +0000 (0:00:00.203) 0:00:18.524 ********** 2026-04-13 22:31:20.392270 | instance | ok: [instance] => (item=br-mgmt) 2026-04-13 22:31:20.392670 | instance | ok: [instance] => (item=dummy0) 2026-04-13 22:31:20.392992 | instance | 2026-04-13 22:31:20.393328 | instance | PLAY [Create devices for Ceph] ************************************************* 2026-04-13 22:31:20.393644 | instance | 2026-04-13 22:31:20.393975 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-13 22:31:20.394318 | instance | Monday 13 April 2026 22:31:20 +0000 (0:00:00.383) 0:00:18.908 ********** 2026-04-13 22:31:21.116816 | instance | ok: [instance] 2026-04-13 22:31:21.116897 | instance | 2026-04-13 22:31:21.117017 | instance | TASK [Install depedencies] ***************************************************** 2026-04-13 22:31:21.117217 | instance | Monday 13 April 2026 22:31:21 +0000 (0:00:00.722) 0:00:19.630 ********** 2026-04-13 22:31:42.356803 | instance | changed: [instance] 2026-04-13 22:31:42.356845 | instance | 2026-04-13 22:31:42.356851 | instance | TASK [Start up service] ******************************************************** 2026-04-13 22:31:42.356856 | instance | Monday 13 April 2026 22:31:42 +0000 (0:00:21.242) 0:00:40.872 ********** 2026-04-13 22:31:42.926710 | instance | ok: [instance] 2026-04-13 22:31:42.926807 | instance | 2026-04-13 22:31:42.927188 | instance | TASK [Generate lvm.conf] ******************************************************* 2026-04-13 22:31:42.927252 | instance | Monday 13 April 2026 22:31:42 +0000 (0:00:00.569) 0:00:41.442 ********** 2026-04-13 22:31:43.152778 | instance | ok: [instance] 2026-04-13 22:31:43.152833 | instance | 2026-04-13 22:31:43.152850 | instance | TASK [Write /etc/lvm/lvm.conf] ************************************************* 2026-04-13 22:31:43.152858 | instance | Monday 13 April 2026 22:31:43 +0000 (0:00:00.225) 0:00:41.668 ********** 2026-04-13 22:31:43.650734 | instance | changed: [instance] 2026-04-13 22:31:43.650849 | instance | 2026-04-13 22:31:43.651261 | instance | TASK [Get list of all loopback devices] **************************************** 2026-04-13 22:31:43.651317 | instance | Monday 13 April 2026 22:31:43 +0000 (0:00:00.498) 0:00:42.166 ********** 2026-04-13 22:31:43.850863 | instance | ok: [instance] 2026-04-13 22:31:43.850949 | instance | 2026-04-13 22:31:43.851012 | instance | TASK [Fail if there is any existing loopback devices] ************************** 2026-04-13 22:31:43.851162 | instance | Monday 13 April 2026 22:31:43 +0000 (0:00:00.200) 0:00:42.366 ********** 2026-04-13 22:31:43.881478 | instance | skipping: [instance] 2026-04-13 22:31:43.881648 | instance | 2026-04-13 22:31:43.881936 | instance | TASK [Create devices for Ceph] ************************************************* 2026-04-13 22:31:43.882166 | instance | Monday 13 April 2026 22:31:43 +0000 (0:00:00.030) 0:00:42.396 ********** 2026-04-13 22:31:44.444555 | instance | changed: [instance] => (item=osd0) 2026-04-13 22:31:44.444715 | instance | changed: [instance] => (item=osd1) 2026-04-13 22:31:44.444992 | instance | changed: [instance] => (item=osd2) 2026-04-13 22:31:44.445200 | instance | 2026-04-13 22:31:44.445402 | instance | TASK [Set permissions on loopback devices] ************************************* 2026-04-13 22:31:44.445599 | instance | Monday 13 April 2026 22:31:44 +0000 (0:00:00.563) 0:00:42.960 ********** 2026-04-13 22:31:44.996868 | instance | changed: [instance] => (item=osd0) 2026-04-13 22:31:44.997075 | instance | changed: [instance] => (item=osd1) 2026-04-13 22:31:44.997230 | instance | changed: [instance] => (item=osd2) 2026-04-13 22:31:44.997377 | instance | 2026-04-13 22:31:44.997531 | instance | TASK [Start loop devices] ****************************************************** 2026-04-13 22:31:44.997702 | instance | Monday 13 April 2026 22:31:44 +0000 (0:00:00.551) 0:00:43.511 ********** 2026-04-13 22:31:45.755924 | instance | changed: [instance] => (item=osd0) 2026-04-13 22:31:45.756230 | instance | changed: [instance] => (item=osd1) 2026-04-13 22:31:45.756473 | instance | changed: [instance] => (item=osd2) 2026-04-13 22:31:45.756685 | instance | 2026-04-13 22:31:45.756909 | instance | TASK [Create a volume group for each loop device] ****************************** 2026-04-13 22:31:45.757130 | instance | Monday 13 April 2026 22:31:45 +0000 (0:00:00.756) 0:00:44.268 ********** 2026-04-13 22:31:48.927218 | instance | changed: [instance] => (item=osd0) 2026-04-13 22:31:48.927283 | instance | changed: [instance] => (item=osd1) 2026-04-13 22:31:48.927292 | instance | changed: [instance] => (item=osd2) 2026-04-13 22:31:48.927300 | instance | 2026-04-13 22:31:48.927307 | instance | TASK [Create a logical volume for each loop device] **************************** 2026-04-13 22:31:48.927315 | instance | Monday 13 April 2026 22:31:48 +0000 (0:00:03.173) 0:00:47.441 ********** 2026-04-13 22:31:50.891744 | instance | changed: [instance] => (item=ceph-instance-osd0) 2026-04-13 22:31:50.891822 | instance | changed: [instance] => (item=ceph-instance-osd1) 2026-04-13 22:31:50.891835 | instance | changed: [instance] => (item=ceph-instance-osd2) 2026-04-13 22:31:50.891845 | instance | 2026-04-13 22:31:50.891854 | instance | PLAY [controllers] ************************************************************* 2026-04-13 22:31:50.891864 | instance | 2026-04-13 22:31:50.891873 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-13 22:31:50.891882 | instance | Monday 13 April 2026 22:31:50 +0000 (0:00:01.963) 0:00:49.405 ********** 2026-04-13 22:31:51.840890 | instance | ok: [instance] 2026-04-13 22:31:51.840961 | instance | 2026-04-13 22:31:51.841380 | instance | TASK [Set masquerade rule] ***************************************************** 2026-04-13 22:31:51.841451 | instance | Monday 13 April 2026 22:31:51 +0000 (0:00:00.950) 0:00:50.356 ********** 2026-04-13 22:31:52.301294 | instance | changed: [instance] 2026-04-13 22:31:52.301546 | instance | 2026-04-13 22:31:52.301942 | instance | PLAY RECAP ********************************************************************* 2026-04-13 22:31:52.302300 | instance | instance : ok=24 changed=10 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-04-13 22:31:52.302644 | instance | localhost : ok=40 changed=21 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-04-13 22:31:52.302951 | instance | 2026-04-13 22:31:52.303317 | instance | Monday 13 April 2026 22:31:52 +0000 (0:00:00.460) 0:00:50.817 ********** 2026-04-13 22:31:52.303642 | instance | =============================================================================== 2026-04-13 22:31:52.303968 | instance | Install depedencies ---------------------------------------------------- 21.24s 2026-04-13 22:31:52.304389 | instance | Generate SSH keys for missing variables --------------------------------- 3.38s 2026-04-13 22:31:52.304728 | instance | Create a volume group for each loop device ------------------------------ 3.17s 2026-04-13 22:31:52.305052 | instance | Create a logical volume for each loop device ---------------------------- 1.96s 2026-04-13 22:31:52.305376 | instance | Install "dirmngr" for GPG keyserver operations -------------------------- 1.23s 2026-04-13 22:31:52.305698 | instance | Gathering Facts --------------------------------------------------------- 1.18s 2026-04-13 22:31:52.306033 | instance | Create folders for workspace -------------------------------------------- 1.06s 2026-04-13 22:31:52.306356 | instance | Gathering Facts --------------------------------------------------------- 0.95s 2026-04-13 22:31:52.306675 | instance | Purge "snapd" package --------------------------------------------------- 0.94s 2026-04-13 22:31:52.306997 | instance | Generate endpoint skeleton for missing variables ------------------------ 0.78s 2026-04-13 22:31:52.307390 | instance | Start loop devices ------------------------------------------------------ 0.76s 2026-04-13 22:31:52.307724 | instance | Gathering Facts --------------------------------------------------------- 0.74s 2026-04-13 22:31:52.308052 | instance | Gathering Facts --------------------------------------------------------- 0.72s 2026-04-13 22:31:52.308380 | instance | Gathering Facts --------------------------------------------------------- 0.70s 2026-04-13 22:31:52.308558 | instance | Configure short hostname ------------------------------------------------ 0.70s 2026-04-13 22:31:52.308722 | instance | Write new Ceph control plane configuration file to disk ----------------- 0.58s 2026-04-13 22:31:52.308886 | instance | Start up service -------------------------------------------------------- 0.57s 2026-04-13 22:31:52.309052 | instance | Create devices for Ceph ------------------------------------------------- 0.56s 2026-04-13 22:31:52.309218 | instance | Set permissions on loopback devices ------------------------------------- 0.55s 2026-04-13 22:31:52.309386 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.50s 2026-04-13 22:31:52.401263 | instance | INFO [aio > prepare] Executed: Successful 2026-04-13 22:31:52.401992 | instance | INFO Molecule executed 1 scenario (1 successful) 2026-04-13 22:31:52.619113 | instance | ok: Runtime: 0:01:52.890378 2026-04-13 22:31:52.625075 | 2026-04-13 22:31:52.625131 | PLAY RECAP 2026-04-13 22:31:52.625178 | instance | ok: 12 changed: 9 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-13 22:31:52.625201 | 2026-04-13 22:31:52.778660 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main] 2026-04-13 22:31:52.788570 | RUN START: [untrusted : github.com/vexxhost/atmosphere/molecule/aio/converge.yml@main] 2026-04-13 22:31:53.359329 | 2026-04-13 22:31:53.359445 | PLAY [all] 2026-04-13 22:31:53.370787 | 2026-04-13 22:31:53.370863 | TASK [Build atmosphere binary] 2026-04-13 22:31:53.732719 | instance | go: downloading github.com/spf13/cobra v1.9.1 2026-04-13 22:31:53.739028 | instance | go: downloading golang.org/x/sync v0.18.0 2026-04-13 22:31:53.974287 | instance | go: downloading github.com/spf13/pflag v1.0.7 2026-04-13 22:32:00.915907 | instance | ok: Runtime: 0:00:06.926148 2026-04-13 22:32:00.925057 | 2026-04-13 22:32:00.925132 | TASK [Deploy with parallel orchestrator] 2026-04-13 22:32:01.141945 | instance | ==> Starting parallel deployment 2026-04-13 22:32:01.142210 | instance | ==> [ceph] Starting deployment 2026-04-13 22:32:01.142225 | instance | ==> [iscsi] Starting deployment 2026-04-13 22:32:01.142235 | instance | ==> [kubernetes] Starting deployment 2026-04-13 22:32:01.142246 | instance | ==> [multipathd] Starting deployment 2026-04-13 22:32:01.142261 | instance | ==> [lpfc] Starting deployment 2026-04-13 22:32:01.142275 | instance | ==> [udev] Starting deployment 2026-04-13 22:32:01.142462 | instance | Error: component ceph failed: starting ansible-playbook for ceph: exec: "ansible-playbook": cannot run executable found relative to current directory 2026-04-13 22:32:01.142480 | instance | Usage: 2026-04-13 22:32:01.142489 | instance | atmosphere deploy [flags] 2026-04-13 22:32:01.142498 | instance | 2026-04-13 22:32:01.142507 | instance | Flags: 2026-04-13 22:32:01.142517 | instance | --concurrency int Max concurrent deployments per wave (0 = unlimited) 2026-04-13 22:32:01.142527 | instance | -h, --help help for deploy 2026-04-13 22:32:01.142536 | instance | -i, --inventory string Path to Ansible inventory file (required) 2026-04-13 22:32:01.142552 | instance | -t, --tags string Comma-separated list of component tags to deploy 2026-04-13 22:32:01.142562 | instance | 2026-04-13 22:32:01.142571 | instance | component ceph failed: starting ansible-playbook for ceph: exec: "ansible-playbook": cannot run executable found relative to current directory 2026-04-13 22:32:01.463005 | instance | ERROR 2026-04-13 22:32:01.463321 | instance | { 2026-04-13 22:32:01.463367 | instance | "delta": "0:00:00.007390", 2026-04-13 22:32:01.463398 | instance | "end": "2026-04-13 22:32:01.143269", 2026-04-13 22:32:01.463426 | instance | "msg": "non-zero return code", 2026-04-13 22:32:01.463453 | instance | "rc": 1, 2026-04-13 22:32:01.463483 | instance | "start": "2026-04-13 22:32:01.135879" 2026-04-13 22:32:01.463513 | instance | } failure 2026-04-13 22:32:01.465453 | 2026-04-13 22:32:01.465514 | PLAY RECAP 2026-04-13 22:32:01.465578 | instance | ok: 1 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-04-13 22:32:01.465610 | 2026-04-13 22:32:01.646859 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/molecule/aio/converge.yml@main] 2026-04-13 22:32:01.658221 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main] 2026-04-13 22:32:02.283689 | 2026-04-13 22:32:02.283814 | PLAY [all] 2026-04-13 22:32:02.299834 | 2026-04-13 22:32:02.299914 | TASK [gather-host-logs : creating directory for system status] 2026-04-13 22:32:02.648147 | instance | changed 2026-04-13 22:32:02.656536 | 2026-04-13 22:32:02.656641 | TASK [gather-host-logs : Get logs for each host] 2026-04-13 22:32:03.001331 | instance | + systemd-cgls --full --all --no-pager 2026-04-13 22:32:03.013876 | instance | + ip addr 2026-04-13 22:32:03.015772 | instance | + ip route 2026-04-13 22:32:03.017161 | instance | + lsblk 2026-04-13 22:32:03.019929 | instance | + mount 2026-04-13 22:32:03.021240 | instance | + docker images 2026-04-13 22:32:03.021621 | instance | /bin/bash: line 7: docker: command not found 2026-04-13 22:32:03.021825 | instance | + brctl show 2026-04-13 22:32:03.022182 | instance | /bin/bash: line 8: brctl: command not found 2026-04-13 22:32:03.022372 | instance | + ps aux --sort=-%mem 2026-04-13 22:32:03.036459 | instance | + dpkg -l 2026-04-13 22:32:03.047921 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-04-13 22:32:03.048708 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-04-13 22:32:03.048840 | instance | /bin/bash: line 11: docker: command not found 2026-04-13 22:32:03.049230 | instance | + '[' '!' -z '' ']' 2026-04-13 22:32:03.196851 | instance | ok: Runtime: 0:00:00.053663 2026-04-13 22:32:03.204160 | 2026-04-13 22:32:03.204229 | TASK [gather-host-logs : Downloads logs to executor] 2026-04-13 22:32:03.859250 | instance | changed: 2026-04-13 22:32:03.859502 | instance | created directory /var/lib/zuul/builds/da8d7adba6b841908206b3250d194039/work/logs/instance 2026-04-13 22:32:03.859545 | instance | cd+++++++++ system/ 2026-04-13 22:32:03.859577 | instance | >f+++++++++ system/brctl-show.txt 2026-04-13 22:32:03.859607 | instance | >f+++++++++ system/docker-images.txt 2026-04-13 22:32:03.859635 | instance | >f+++++++++ system/ip-addr.txt 2026-04-13 22:32:03.859667 | instance | >f+++++++++ system/ip-route.txt 2026-04-13 22:32:03.859698 | instance | >f+++++++++ system/lsblk.txt 2026-04-13 22:32:03.859727 | instance | >f+++++++++ system/mount.txt 2026-04-13 22:32:03.859759 | instance | >f+++++++++ system/packages.txt 2026-04-13 22:32:03.859786 | instance | >f+++++++++ system/ps.txt 2026-04-13 22:32:03.859813 | instance | >f+++++++++ system/systemd-cgls.txt 2026-04-13 22:32:03.873380 | 2026-04-13 22:32:03.873538 | LOOP [helm-release-status : creating directory for helm release status] 2026-04-13 22:32:04.085764 | instance | changed: "values" 2026-04-13 22:32:04.281974 | instance | changed: "releases" 2026-04-13 22:32:04.301120 | 2026-04-13 22:32:04.301280 | TASK [helm-release-status : Gather get release status for helm charts] 2026-04-13 22:32:04.508642 | instance | /bin/bash: line 3: kubectl: command not found 2026-04-13 22:32:04.835455 | instance | ok: Runtime: 0:00:00.007121 2026-04-13 22:32:04.842524 | 2026-04-13 22:32:04.842610 | TASK [helm-release-status : Downloads logs to executor] 2026-04-13 22:32:05.328114 | instance | changed: 2026-04-13 22:32:05.328289 | instance | cd+++++++++ helm/ 2026-04-13 22:32:05.328318 | instance | cd+++++++++ helm/releases/ 2026-04-13 22:32:05.328342 | instance | cd+++++++++ helm/values/ 2026-04-13 22:32:05.337541 | 2026-04-13 22:32:05.346708 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-04-13 22:32:05.587382 | instance | changed 2026-04-13 22:32:05.592641 | 2026-04-13 22:32:05.592714 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-04-13 22:32:05.810478 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-13 22:32:05.810768 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-13 22:32:05.816789 | instance | environment: line 1: kubectl: command not found 2026-04-13 22:32:05.817973 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-13 22:32:05.819493 | instance | environment: line 1: kubectl: command not found 2026-04-13 22:32:05.820944 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-13 22:32:05.821044 | instance | environment: line 1: kubectl: command not found 2026-04-13 22:32:05.822806 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-13 22:32:05.824666 | instance | environment: line 1: kubectl: command not found 2026-04-13 22:32:05.826016 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-13 22:32:05.827438 | instance | environment: line 1: kubectl: command not found 2026-04-13 22:32:05.828696 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-13 22:32:06.134098 | instance | ok: Runtime: 0:00:00.027690 2026-04-13 22:32:06.139232 | 2026-04-13 22:32:06.139304 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-04-13 22:32:06.346156 | instance | changed 2026-04-13 22:32:06.351259 | 2026-04-13 22:32:06.351337 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-04-13 22:32:06.565377 | instance | environment: line 5: kubectl: command not found 2026-04-13 22:32:06.566808 | instance | xargs: xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args valuewarning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-13 22:32:06.566837 | instance | 2026-04-13 22:32:06.566861 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-13 22:32:06.889492 | instance | ok: Runtime: 0:00:00.009332 2026-04-13 22:32:06.897025 | 2026-04-13 22:32:06.897101 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-04-13 22:32:07.388688 | instance | changed: 2026-04-13 22:32:07.388987 | instance | cd+++++++++ objects/ 2026-04-13 22:32:07.389062 | instance | cd+++++++++ objects/cluster/ 2026-04-13 22:32:07.389117 | instance | cd+++++++++ objects/namespaced/ 2026-04-13 22:32:07.400647 | 2026-04-13 22:32:07.400711 | TASK [gather-pod-logs : creating directory for pod logs] 2026-04-13 22:32:07.618714 | instance | changed 2026-04-13 22:32:07.626189 | 2026-04-13 22:32:07.626311 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-04-13 22:32:07.834913 | instance | changed 2026-04-13 22:32:07.840092 | 2026-04-13 22:32:07.840170 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-04-13 22:32:08.049367 | instance | environment: line 3: kubectl: command not found 2026-04-13 22:32:08.378411 | instance | ok: Runtime: 0:00:00.008728 2026-04-13 22:32:08.385427 | 2026-04-13 22:32:08.385514 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-04-13 22:32:08.879739 | instance | changed: 2026-04-13 22:32:08.880002 | instance | cd+++++++++ pod-logs/ 2026-04-13 22:32:08.880042 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-04-13 22:32:08.893550 | 2026-04-13 22:32:08.893656 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-04-13 22:32:09.101197 | instance | changed 2026-04-13 22:32:09.108054 | 2026-04-13 22:32:09.108152 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-04-13 22:32:09.330601 | instance | /bin/bash: line 2: kubectl: command not found 2026-04-13 22:32:09.652368 | instance | ok: Runtime: 0:00:00.034276 2026-04-13 22:32:09.659422 | 2026-04-13 22:32:09.659521 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-04-13 22:32:09.865267 | instance | /bin/bash: line 2: kubectl: command not found 2026-04-13 22:32:09.894244 | instance | ceph-mgr endpoints: 2026-04-13 22:32:10.197986 | instance | ok: Runtime: 0:00:00.035901 2026-04-13 22:32:10.205819 | 2026-04-13 22:32:10.206153 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-04-13 22:32:10.442374 | instance | /bin/bash: line 4: kubectl: command not found 2026-04-13 22:32:10.755822 | instance | ok: Runtime: 0:00:00.036410 2026-04-13 22:32:10.761560 | 2026-04-13 22:32:10.761624 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-04-13 22:32:11.260622 | instance | changed: cd+++++++++ prometheus/ 2026-04-13 22:32:11.277833 | 2026-04-13 22:32:11.277982 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-04-13 22:32:11.515699 | instance | changed 2026-04-13 22:32:11.520698 | 2026-04-13 22:32:11.520764 | TASK [gather-selenium-data : Get selenium data] 2026-04-13 22:32:11.725661 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-04-13 22:32:11.726767 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-04-13 22:32:12.060790 | instance | ERROR 2026-04-13 22:32:12.061142 | instance | { 2026-04-13 22:32:12.061179 | instance | "delta": "0:00:00.006467", 2026-04-13 22:32:12.061202 | instance | "end": "2026-04-13 22:32:11.727083", 2026-04-13 22:32:12.061220 | instance | "msg": "non-zero return code", 2026-04-13 22:32:12.061239 | instance | "rc": 1, 2026-04-13 22:32:12.061256 | instance | "start": "2026-04-13 22:32:11.720616" 2026-04-13 22:32:12.061274 | instance | } 2026-04-13 22:32:12.061298 | instance | ERROR: Ignoring Errors 2026-04-13 22:32:12.066326 | 2026-04-13 22:32:12.066396 | TASK [gather-selenium-data : Downloads logs to executor] 2026-04-13 22:32:12.559031 | instance | changed: cd+++++++++ selenium/ 2026-04-13 22:32:12.564840 | 2026-04-13 22:32:12.564889 | PLAY RECAP 2026-04-13 22:32:12.564934 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-04-13 22:32:12.564961 | 2026-04-13 22:32:12.675533 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main] 2026-04-13 22:32:12.689414 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-13 22:32:13.310081 | 2026-04-13 22:32:13.310212 | PLAY [all] 2026-04-13 22:32:13.322603 | 2026-04-13 22:32:13.322728 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-13 22:32:13.368652 | instance | skipping: Conditional result was False 2026-04-13 22:32:13.379471 | 2026-04-13 22:32:13.379565 | TASK [fetch-output : Set log path for single node] 2026-04-13 22:32:13.424591 | instance | ok 2026-04-13 22:32:13.429551 | 2026-04-13 22:32:13.429619 | LOOP [fetch-output : Ensure local output dirs] 2026-04-13 22:32:13.790343 | instance -> localhost | ok: "/var/lib/zuul/builds/da8d7adba6b841908206b3250d194039/work/logs" 2026-04-13 22:32:14.024017 | instance -> localhost | changed: "/var/lib/zuul/builds/da8d7adba6b841908206b3250d194039/work/artifacts" 2026-04-13 22:32:14.234030 | instance -> localhost | changed: "/var/lib/zuul/builds/da8d7adba6b841908206b3250d194039/work/docs" 2026-04-13 22:32:14.250660 | 2026-04-13 22:32:14.250818 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-13 22:32:14.871310 | instance | changed: .d..t...... ./ 2026-04-13 22:32:14.871569 | instance | changed: All items complete 2026-04-13 22:32:14.871608 | 2026-04-13 22:32:15.329092 | instance | changed: .d..t...... ./ 2026-04-13 22:32:15.785570 | instance | changed: .d..t...... ./ 2026-04-13 22:32:15.808049 | 2026-04-13 22:32:15.808173 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-13 22:32:16.219980 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.008648 2026-04-13 22:32:16.466637 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007716 2026-04-13 22:32:16.480860 | 2026-04-13 22:32:16.481009 | PLAY [all] 2026-04-13 22:32:16.487172 | 2026-04-13 22:32:16.487242 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-13 22:32:16.946365 | instance | changed 2026-04-13 22:32:16.951565 | 2026-04-13 22:32:16.951608 | PLAY RECAP 2026-04-13 22:32:16.951651 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-13 22:32:16.951673 | 2026-04-13 22:32:17.061201 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-13 22:32:17.073611 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-13 22:32:17.660278 | 2026-04-13 22:32:17.660642 | PLAY [localhost] 2026-04-13 22:32:17.670814 | 2026-04-13 22:32:17.670909 | TASK [Generate Zuul manifest] 2026-04-13 22:32:17.691020 | localhost | ok 2026-04-13 22:32:17.708863 | 2026-04-13 22:32:17.708945 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-13 22:32:18.075653 | localhost | changed 2026-04-13 22:32:18.086495 | 2026-04-13 22:32:18.086580 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-13 22:32:18.118753 | localhost | ok 2026-04-13 22:32:18.127378 | 2026-04-13 22:32:18.127465 | TASK [Upload logs] 2026-04-13 22:32:18.148770 | localhost | ok 2026-04-13 22:32:18.263107 | 2026-04-13 22:32:18.263253 | TASK [Set zuul-log-path fact] 2026-04-13 22:32:18.284569 | localhost | ok 2026-04-13 22:32:18.296848 | 2026-04-13 22:32:18.296915 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-13 22:32:18.329912 | localhost | ok 2026-04-13 22:32:18.337316 | 2026-04-13 22:32:18.337382 | TASK [upload-logs : Create log directories] 2026-04-13 22:32:18.705623 | localhost | changed 2026-04-13 22:32:18.710384 | 2026-04-13 22:32:18.710457 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-13 22:32:19.081343 | localhost -> localhost | ok: Runtime: 0:00:00.004334 2026-04-13 22:32:19.088019 | 2026-04-13 22:32:19.088085 | TASK [upload-logs : Upload logs to log server] 2026-04-13 22:32:19.507888 | localhost | Output suppressed because no_log was given 2026-04-13 22:32:19.512765 | 2026-04-13 22:32:19.512832 | LOOP [upload-logs : Compress console log and json output] 2026-04-13 22:32:19.555437 | localhost | skipping: Conditional result was False 2026-04-13 22:32:19.561521 | localhost | skipping: Conditional result was False 2026-04-13 22:32:19.577860 | 2026-04-13 22:32:19.578061 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-13 22:32:19.618233 | localhost | skipping: Conditional result was False 2026-04-13 22:32:19.618864 | 2026-04-13 22:32:19.621264 | localhost | skipping: Conditional result was False 2026-04-13 22:32:19.634303 | 2026-04-13 22:32:19.634515 | LOOP [upload-logs : Upload console log and json output]