2026-04-28 05:58:00.114090 | Job console starting 2026-04-28 05:58:00.125006 | Updating git repos 2026-04-28 05:58:00.186841 | Cloning repos into workspace 2026-04-28 05:58:00.291541 | Restoring repo states 2026-04-28 05:58:00.310760 | Merging changes 2026-04-28 05:58:02.708215 | Checking out repos 2026-04-28 05:58:02.787095 | Preparing playbooks 2026-04-28 05:58:06.582330 | Running Ansible setup 2026-04-28 05:58:09.979736 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-28 05:58:10.585640 | 2026-04-28 05:58:10.585970 | PLAY [localhost] 2026-04-28 05:58:10.593852 | 2026-04-28 05:58:10.593920 | TASK [Gathering Facts] 2026-04-28 05:58:12.797285 | localhost | ok 2026-04-28 05:58:12.807983 | 2026-04-28 05:58:12.808081 | TASK [Setup log path fact] 2026-04-28 05:58:12.828939 | localhost | ok 2026-04-28 05:58:12.839489 | 2026-04-28 05:58:12.839558 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-28 05:58:12.869961 | localhost | ok 2026-04-28 05:58:12.878137 | 2026-04-28 05:58:12.878228 | TASK [emit-job-header : Print job information] 2026-04-28 05:58:12.921568 | # Job Information 2026-04-28 05:58:12.921768 | Ansible Version: 2.16.16 2026-04-28 05:58:12.921817 | Job: atmosphere-molecule-csi-rbd 2026-04-28 05:58:12.921849 | Pipeline: check 2026-04-28 05:58:12.921879 | Executor: 0a8996d2b663 2026-04-28 05:58:12.921909 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3882 2026-04-28 05:58:12.921942 | Event ID: 19f7c770-42c7-11f1-856e-2b2aef8c4409 2026-04-28 05:58:12.927788 | 2026-04-28 05:58:12.927887 | LOOP [emit-job-header : Print node information] 2026-04-28 05:58:13.075137 | localhost | ok: 2026-04-28 05:58:13.075375 | localhost | # Node Information 2026-04-28 05:58:13.075445 | localhost | Inventory Hostname: instance 2026-04-28 05:58:13.075501 | localhost | Hostname: np0000170872 2026-04-28 05:58:13.075538 | localhost | Username: zuul 2026-04-28 05:58:13.075578 | localhost | Distro: Ubuntu 22.04 2026-04-28 05:58:13.075613 | localhost | Provider: yul1 2026-04-28 05:58:13.075650 | localhost | Region: ca-ymq-1 2026-04-28 05:58:13.075691 | localhost | Label: ubuntu-jammy 2026-04-28 05:58:13.075722 | localhost | Product Name: OpenStack Nova 2026-04-28 05:58:13.075754 | localhost | Interface IP: 199.204.45.233 2026-04-28 05:58:13.087598 | 2026-04-28 05:58:13.087721 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-28 05:58:13.476762 | localhost -> localhost | changed 2026-04-28 05:58:13.481619 | 2026-04-28 05:58:13.481687 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-28 05:58:14.433335 | localhost -> localhost | changed 2026-04-28 05:58:14.440457 | 2026-04-28 05:58:14.440530 | PLAY [all] 2026-04-28 05:58:14.449239 | 2026-04-28 05:58:14.449301 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-28 05:58:14.664858 | instance -> localhost | ok 2026-04-28 05:58:14.674373 | 2026-04-28 05:58:14.674463 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-28 05:58:14.709627 | instance | ok 2026-04-28 05:58:14.726268 | instance | included: /var/lib/zuul/builds/4df78888cd1441b29369855e35a7737e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-28 05:58:14.731754 | 2026-04-28 05:58:14.731812 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-28 05:58:15.978588 | instance -> localhost | Generating public/private rsa key pair. 2026-04-28 05:58:15.978765 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/4df78888cd1441b29369855e35a7737e/work/4df78888cd1441b29369855e35a7737e_id_rsa 2026-04-28 05:58:15.978806 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/4df78888cd1441b29369855e35a7737e/work/4df78888cd1441b29369855e35a7737e_id_rsa.pub 2026-04-28 05:58:15.978837 | instance -> localhost | The key fingerprint is: 2026-04-28 05:58:15.978866 | instance -> localhost | SHA256:To8hdtqxzPe05StNHwt/9MVZcfNr5xQHc/9LL3eT2xc zuul-build-sshkey 2026-04-28 05:58:15.978911 | instance -> localhost | The key's randomart image is: 2026-04-28 05:58:15.978940 | instance -> localhost | +---[RSA 3072]----+ 2026-04-28 05:58:15.978972 | instance -> localhost | | | 2026-04-28 05:58:15.979001 | instance -> localhost | | ooo| 2026-04-28 05:58:15.979029 | instance -> localhost | | +*| 2026-04-28 05:58:15.979056 | instance -> localhost | | .=| 2026-04-28 05:58:15.979136 | instance -> localhost | | o S .B| 2026-04-28 05:58:15.979181 | instance -> localhost | | . X * ..EB| 2026-04-28 05:58:15.979211 | instance -> localhost | | . B o .o*=@| 2026-04-28 05:58:15.979239 | instance -> localhost | | . o.+o*@| 2026-04-28 05:58:15.979269 | instance -> localhost | | o.o=B| 2026-04-28 05:58:15.979298 | instance -> localhost | +----[SHA256]-----+ 2026-04-28 05:58:15.979357 | instance -> localhost | ok: Runtime: 0:00:00.784993 2026-04-28 05:58:15.986530 | 2026-04-28 05:58:15.986591 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-28 05:58:16.018542 | instance | ok 2026-04-28 05:58:16.028283 | instance | included: /var/lib/zuul/builds/4df78888cd1441b29369855e35a7737e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-28 05:58:16.035647 | 2026-04-28 05:58:16.035706 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-28 05:58:16.059683 | instance | skipping: Conditional result was False 2026-04-28 05:58:16.071366 | 2026-04-28 05:58:16.071427 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-28 05:58:16.499881 | instance | changed 2026-04-28 05:58:16.506356 | 2026-04-28 05:58:16.506439 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-28 05:58:16.680683 | instance | ok 2026-04-28 05:58:16.686862 | 2026-04-28 05:58:16.686934 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-28 05:58:17.136099 | instance | changed 2026-04-28 05:58:17.142813 | 2026-04-28 05:58:17.142881 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-28 05:58:17.589713 | instance | changed 2026-04-28 05:58:17.596801 | 2026-04-28 05:58:17.596910 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-28 05:58:17.621493 | instance | skipping: Conditional result was False 2026-04-28 05:58:17.632043 | 2026-04-28 05:58:17.632137 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-28 05:58:18.021833 | instance -> localhost | changed 2026-04-28 05:58:18.037854 | 2026-04-28 05:58:18.037950 | TASK [add-build-sshkey : Add back temp key] 2026-04-28 05:58:18.335391 | instance -> localhost | Identity added: /var/lib/zuul/builds/4df78888cd1441b29369855e35a7737e/work/4df78888cd1441b29369855e35a7737e_id_rsa (zuul-build-sshkey) 2026-04-28 05:58:18.335694 | instance -> localhost | ok: Runtime: 0:00:00.012871 2026-04-28 05:58:18.346487 | 2026-04-28 05:58:18.346563 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-28 05:58:18.682756 | instance | ok 2026-04-28 05:58:18.867219 | 2026-04-28 05:58:18.867346 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-28 05:58:18.891404 | instance | skipping: Conditional result was False 2026-04-28 05:58:18.907030 | 2026-04-28 05:58:18.907142 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-28 05:58:19.234746 | instance | ok 2026-04-28 05:58:19.245401 | 2026-04-28 05:58:19.245492 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-28 05:58:20.841032 | instance | Output suppressed because no_log was given 2026-04-28 05:58:20.852854 | 2026-04-28 05:58:20.852924 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-28 05:58:21.036219 | instance | ok: "logs" 2026-04-28 05:58:21.036560 | instance | ok: All items complete 2026-04-28 05:58:21.036613 | 2026-04-28 05:58:21.193012 | instance | ok: "artifacts" 2026-04-28 05:58:21.365538 | instance | ok: "docs" 2026-04-28 05:58:21.376862 | 2026-04-28 05:58:21.376998 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-28 05:58:21.562461 | instance | changed: "logs" 2026-04-28 05:58:21.741880 | instance | changed: "artifacts" 2026-04-28 05:58:21.921777 | instance | changed: "docs" 2026-04-28 05:58:21.947369 | 2026-04-28 05:58:21.947478 | PLAY RECAP 2026-04-28 05:58:21.947537 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-28 05:58:21.947568 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-28 05:58:21.947590 | 2026-04-28 05:58:22.057785 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-28 05:58:22.061762 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-28 05:58:22.629832 | 2026-04-28 05:58:22.629946 | PLAY [all] 2026-04-28 05:58:22.642427 | 2026-04-28 05:58:22.642520 | TASK [setup-uv : Extract archive] 2026-04-28 05:58:25.246596 | instance | changed 2026-04-28 05:58:25.252949 | 2026-04-28 05:58:25.253050 | TASK [setup-uv : Print version] 2026-04-28 05:58:25.589951 | instance | uv 0.8.13 2026-04-28 05:58:25.794681 | instance | ok: Runtime: 0:00:00.011379 2026-04-28 05:58:25.803307 | 2026-04-28 05:58:25.803378 | PLAY RECAP 2026-04-28 05:58:25.803447 | instance | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-28 05:58:25.803480 | 2026-04-28 05:58:25.948291 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-28 05:58:25.951972 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@stable/2024.2] 2026-04-28 05:58:26.559169 | 2026-04-28 05:58:26.559278 | PLAY [all] 2026-04-28 05:58:26.569850 | 2026-04-28 05:58:26.569929 | TASK [Install "jq" for log collection] 2026-04-28 05:58:50.009609 | instance | changed 2026-04-28 05:58:50.013183 | 2026-04-28 05:58:50.013262 | PLAY RECAP 2026-04-28 05:58:50.013318 | instance | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-28 05:58:50.013366 | 2026-04-28 05:58:50.120876 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@stable/2024.2] 2026-04-28 05:58:50.211630 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-28 05:58:50.830143 | 2026-04-28 05:58:50.830440 | PLAY [all] 2026-04-28 05:58:50.841306 | 2026-04-28 05:58:50.841387 | TASK [Copy inventory file for Zuul] 2026-04-28 05:58:51.711902 | instance | changed 2026-04-28 05:58:51.717487 | 2026-04-28 05:58:51.717558 | TASK [Switch "ansible_host" to private IP] 2026-04-28 05:58:51.983426 | instance | changed: 1 replacements made 2026-04-28 05:58:51.990986 | 2026-04-28 05:58:51.991083 | TASK [Run Molecule scenario] 2026-04-28 05:58:52.374937 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-04-28 05:58:52.375091 | instance | Creating virtual environment at: .venv 2026-04-28 05:58:52.396582 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-04-28 05:58:52.446017 | instance | Downloading openstacksdk (1.7MiB) 2026-04-28 05:58:52.446250 | instance | Downloading pygments (1.2MiB) 2026-04-28 05:58:52.446506 | instance | Downloading rjsonnet (1.2MiB) 2026-04-28 05:58:52.447016 | instance | Downloading setuptools (1.1MiB) 2026-04-28 05:58:52.466361 | instance | Downloading netaddr (2.2MiB) 2026-04-28 05:58:52.471956 | instance | Downloading ansible-core (2.1MiB) 2026-04-28 05:58:52.518115 | instance | Downloading kubernetes (1.9MiB) 2026-04-28 05:58:52.543537 | instance | Downloading cryptography (4.2MiB) 2026-04-28 05:58:52.704525 | instance | Building pyperclip==1.9.0 2026-04-28 05:58:52.725010 | instance | Downloading rjsonnet 2026-04-28 05:58:52.853375 | instance | Downloading netaddr 2026-04-28 05:58:52.853985 | instance | Downloading pygments 2026-04-28 05:58:52.914060 | instance | Downloading setuptools 2026-04-28 05:58:52.924481 | instance | Downloading cryptography 2026-04-28 05:58:52.968310 | instance | Downloading kubernetes 2026-04-28 05:58:52.996031 | instance | Downloading ansible-core 2026-04-28 05:58:53.021012 | instance | Downloading openstacksdk 2026-04-28 05:58:53.406014 | instance | Built pyperclip==1.9.0 2026-04-28 05:58:53.567313 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-04-28 05:58:53.617579 | instance | Installed 79 packages in 48ms 2026-04-28 05:58:54.245618 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-04-28 05:58:54.865687 | instance | INFO [csi > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-04-28 05:58:54.865763 | instance | INFO [csi > prerun] Performing prerun with role_name_check=0... 2026-04-28 05:59:32.292123 | instance | INFO [csi > dependency] Executing 2026-04-28 05:59:32.292326 | instance | WARNING [csi > dependency] Missing roles requirements file: requirements.yml 2026-04-28 05:59:32.292700 | instance | WARNING [csi > dependency] Missing collections requirements file: collections.yml 2026-04-28 05:59:32.292885 | instance | WARNING [csi > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-04-28 05:59:32.302006 | instance | INFO [csi > cleanup] Executing 2026-04-28 05:59:32.302324 | instance | WARNING [csi > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-28 05:59:32.310114 | instance | INFO [csi > destroy] Executing 2026-04-28 05:59:32.310185 | instance | WARNING [csi > destroy] Skipping, '--destroy=never' requested. 2026-04-28 05:59:32.310204 | instance | INFO [csi > destroy] Executed: Successful 2026-04-28 05:59:32.317748 | instance | INFO [csi > syntax] Executing 2026-04-28 05:59:33.774915 | instance | 2026-04-28 05:59:33.775226 | instance | playbook: /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-04-28 05:59:33.829949 | instance | INFO [csi > syntax] Executed: Successful 2026-04-28 05:59:33.844123 | instance | INFO [csi > create] Executing 2026-04-28 05:59:33.846726 | instance | WARNING [csi > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-28 05:59:33.854619 | instance | INFO [csi > prepare] Executing 2026-04-28 05:59:34.605878 | instance | 2026-04-28 05:59:34.606193 | instance | PLAY [Prepare] ***************************************************************** 2026-04-28 05:59:34.606479 | instance | 2026-04-28 05:59:34.606802 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-28 05:59:34.607188 | instance | Tuesday 28 April 2026 05:59:34 +0000 (0:00:00.026) 0:00:00.026 ********* 2026-04-28 05:59:35.733286 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-04-28 05:59:35.733551 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-04-28 05:59:35.733817 | instance | interpreter could change the meaning of that path. See 2026-04-28 05:59:35.734083 | instance | https://docs.ansible.com/ansible- 2026-04-28 05:59:35.734351 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-04-28 05:59:35.743581 | instance | ok: [instance] 2026-04-28 05:59:35.743837 | instance | 2026-04-28 05:59:35.744126 | instance | TASK [Configure short hostname] ************************************************ 2026-04-28 05:59:35.744416 | instance | Tuesday 28 April 2026 05:59:35 +0000 (0:00:01.138) 0:00:01.164 ********* 2026-04-28 05:59:36.394030 | instance | changed: [instance] 2026-04-28 05:59:36.394264 | instance | 2026-04-28 05:59:36.394582 | instance | TASK [Ensure hostname inside hosts file] *************************************** 2026-04-28 05:59:36.394900 | instance | Tuesday 28 April 2026 05:59:36 +0000 (0:00:00.650) 0:00:01.815 ********* 2026-04-28 05:59:36.652006 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created 2026-04-28 05:59:36.652183 | instance | with a mode of 0700, this may cause issues when running as another user. To 2026-04-28 05:59:36.652448 | instance | avoid this, create the remote_tmp dir with the correct permissions manually 2026-04-28 05:59:36.663706 | instance | changed: [instance] 2026-04-28 05:59:36.663890 | instance | 2026-04-28 05:59:36.664065 | instance | TASK [Purge "snapd" package] *************************************************** 2026-04-28 05:59:36.664242 | instance | Tuesday 28 April 2026 05:59:36 +0000 (0:00:00.269) 0:00:02.085 ********* 2026-04-28 05:59:37.403905 | instance | ok: [instance] 2026-04-28 05:59:37.404144 | instance | 2026-04-28 05:59:37.404453 | instance | PLAY [Create devices for Ceph] ************************************************* 2026-04-28 05:59:37.404741 | instance | 2026-04-28 05:59:37.405013 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-28 05:59:37.405291 | instance | Tuesday 28 April 2026 05:59:37 +0000 (0:00:00.739) 0:00:02.825 ********* 2026-04-28 05:59:38.086098 | instance | ok: [instance] 2026-04-28 05:59:38.086342 | instance | 2026-04-28 05:59:38.086621 | instance | TASK [Install depedencies] ***************************************************** 2026-04-28 05:59:38.086893 | instance | Tuesday 28 April 2026 05:59:38 +0000 (0:00:00.682) 0:00:03.507 ********* 2026-04-28 05:59:57.027551 | instance | changed: [instance] 2026-04-28 05:59:57.027784 | instance | 2026-04-28 05:59:57.028064 | instance | TASK [Start up service] ******************************************************** 2026-04-28 05:59:57.028335 | instance | Tuesday 28 April 2026 05:59:57 +0000 (0:00:18.941) 0:00:22.449 ********* 2026-04-28 05:59:57.545694 | instance | ok: [instance] 2026-04-28 05:59:57.545972 | instance | 2026-04-28 05:59:57.546400 | instance | TASK [Generate lvm.conf] ******************************************************* 2026-04-28 05:59:57.546888 | instance | Tuesday 28 April 2026 05:59:57 +0000 (0:00:00.517) 0:00:22.966 ********* 2026-04-28 05:59:57.829691 | instance | ok: [instance] 2026-04-28 05:59:57.829894 | instance | 2026-04-28 05:59:57.830172 | instance | TASK [Write /etc/lvm/lvm.conf] ************************************************* 2026-04-28 05:59:57.830445 | instance | Tuesday 28 April 2026 05:59:57 +0000 (0:00:00.283) 0:00:23.250 ********* 2026-04-28 05:59:58.451027 | instance | changed: [instance] 2026-04-28 05:59:58.451303 | instance | 2026-04-28 05:59:58.451582 | instance | TASK [Get list of all loopback devices] **************************************** 2026-04-28 05:59:58.451852 | instance | Tuesday 28 April 2026 05:59:58 +0000 (0:00:00.621) 0:00:23.872 ********* 2026-04-28 05:59:58.637062 | instance | ok: [instance] 2026-04-28 05:59:58.637301 | instance | 2026-04-28 05:59:58.637582 | instance | TASK [Fail if there is any existing loopback devices] ************************** 2026-04-28 05:59:58.637846 | instance | Tuesday 28 April 2026 05:59:58 +0000 (0:00:00.186) 0:00:24.058 ********* 2026-04-28 05:59:58.659716 | instance | skipping: [instance] 2026-04-28 05:59:58.659984 | instance | 2026-04-28 05:59:58.660263 | instance | TASK [Create devices for Ceph] ************************************************* 2026-04-28 05:59:58.660569 | instance | Tuesday 28 April 2026 05:59:58 +0000 (0:00:00.022) 0:00:24.081 ********* 2026-04-28 05:59:59.155076 | instance | changed: [instance] => (item=osd0) 2026-04-28 05:59:59.155349 | instance | changed: [instance] => (item=osd1) 2026-04-28 05:59:59.155610 | instance | changed: [instance] => (item=osd2) 2026-04-28 05:59:59.155854 | instance | 2026-04-28 05:59:59.156122 | instance | TASK [Set permissions on loopback devices] ************************************* 2026-04-28 05:59:59.156384 | instance | Tuesday 28 April 2026 05:59:59 +0000 (0:00:00.495) 0:00:24.576 ********* 2026-04-28 05:59:59.761249 | instance | changed: [instance] => (item=osd0) 2026-04-28 05:59:59.761483 | instance | changed: [instance] => (item=osd1) 2026-04-28 05:59:59.761742 | instance | changed: [instance] => (item=osd2) 2026-04-28 05:59:59.762020 | instance | 2026-04-28 05:59:59.762298 | instance | TASK [Start loop devices] ****************************************************** 2026-04-28 05:59:59.762651 | instance | Tuesday 28 April 2026 05:59:59 +0000 (0:00:00.605) 0:00:25.182 ********* 2026-04-28 06:00:00.425239 | instance | changed: [instance] => (item=osd0) 2026-04-28 06:00:00.425604 | instance | changed: [instance] => (item=osd1) 2026-04-28 06:00:00.426003 | instance | changed: [instance] => (item=osd2) 2026-04-28 06:00:00.426305 | instance | 2026-04-28 06:00:00.426733 | instance | TASK [Create a volume group for each loop device] ****************************** 2026-04-28 06:00:00.427166 | instance | Tuesday 28 April 2026 06:00:00 +0000 (0:00:00.663) 0:00:25.846 ********* 2026-04-28 06:00:03.474912 | instance | changed: [instance] => (item=osd0) 2026-04-28 06:00:03.475048 | instance | changed: [instance] => (item=osd1) 2026-04-28 06:00:03.475283 | instance | changed: [instance] => (item=osd2) 2026-04-28 06:00:03.475425 | instance | 2026-04-28 06:00:03.475581 | instance | TASK [Create a logical volume for each loop device] **************************** 2026-04-28 06:00:03.475734 | instance | Tuesday 28 April 2026 06:00:03 +0000 (0:00:03.049) 0:00:28.896 ********* 2026-04-28 06:00:05.272750 | instance | changed: [instance] => (item=ceph-instance-osd0) 2026-04-28 06:00:05.273026 | instance | changed: [instance] => (item=ceph-instance-osd1) 2026-04-28 06:00:05.273311 | instance | changed: [instance] => (item=ceph-instance-osd2) 2026-04-28 06:00:05.273582 | instance | 2026-04-28 06:00:05.273845 | instance | PLAY RECAP ********************************************************************* 2026-04-28 06:00:05.274139 | instance | instance : ok=15 changed=9 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-04-28 06:00:05.274392 | instance | 2026-04-28 06:00:05.274698 | instance | Tuesday 28 April 2026 06:00:05 +0000 (0:00:01.798) 0:00:30.694 ********* 2026-04-28 06:00:05.274964 | instance | =============================================================================== 2026-04-28 06:00:05.275273 | instance | Install depedencies ---------------------------------------------------- 18.94s 2026-04-28 06:00:05.275621 | instance | Create a volume group for each loop device ------------------------------ 3.05s 2026-04-28 06:00:05.275904 | instance | Create a logical volume for each loop device ---------------------------- 1.80s 2026-04-28 06:00:05.276224 | instance | Gathering Facts --------------------------------------------------------- 1.14s 2026-04-28 06:00:05.276495 | instance | Purge "snapd" package --------------------------------------------------- 0.74s 2026-04-28 06:00:05.276759 | instance | Gathering Facts --------------------------------------------------------- 0.68s 2026-04-28 06:00:05.277033 | instance | Start loop devices ------------------------------------------------------ 0.66s 2026-04-28 06:00:05.277289 | instance | Configure short hostname ------------------------------------------------ 0.65s 2026-04-28 06:00:05.277556 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.62s 2026-04-28 06:00:05.277826 | instance | Set permissions on loopback devices ------------------------------------- 0.61s 2026-04-28 06:00:05.278093 | instance | Start up service -------------------------------------------------------- 0.52s 2026-04-28 06:00:05.278356 | instance | Create devices for Ceph ------------------------------------------------- 0.50s 2026-04-28 06:00:05.278647 | instance | Generate lvm.conf ------------------------------------------------------- 0.28s 2026-04-28 06:00:05.278918 | instance | Ensure hostname inside hosts file --------------------------------------- 0.27s 2026-04-28 06:00:05.279291 | instance | Get list of all loopback devices ---------------------------------------- 0.19s 2026-04-28 06:00:05.279622 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s 2026-04-28 06:00:05.332663 | instance | INFO [csi > prepare] Executed: Successful 2026-04-28 06:00:05.345263 | instance | INFO [csi > converge] Executing 2026-04-28 06:00:06.702922 | instance | 2026-04-28 06:00:06.703124 | instance | PLAY [Debug CSI driver value] ************************************************** 2026-04-28 06:00:06.703294 | instance | 2026-04-28 06:00:06.703473 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-28 06:00:06.703653 | instance | Tuesday 28 April 2026 06:00:06 +0000 (0:00:00.007) 0:00:00.007 ********* 2026-04-28 06:00:07.606655 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-04-28 06:00:07.606987 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-04-28 06:00:07.607329 | instance | interpreter could change the meaning of that path. See 2026-04-28 06:00:07.607634 | instance | https://docs.ansible.com/ansible- 2026-04-28 06:00:07.607933 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-04-28 06:00:07.618188 | instance | ok: [instance] 2026-04-28 06:00:07.618465 | instance | 2026-04-28 06:00:07.618751 | instance | TASK [Display CSI driver value and environment variable] *********************** 2026-04-28 06:00:07.619019 | instance | Tuesday 28 April 2026 06:00:07 +0000 (0:00:00.915) 0:00:00.923 ********* 2026-04-28 06:00:07.657725 | instance | ok: [instance] => { 2026-04-28 06:00:07.657993 | instance | "msg": "csi_driver=rbd, MOLECULE_CSI_DRIVER=" 2026-04-28 06:00:07.658257 | instance | } 2026-04-28 06:00:07.658629 | instance | 2026-04-28 06:00:07.658919 | instance | PLAY [all] ********************************************************************* 2026-04-28 06:00:07.659203 | instance | 2026-04-28 06:00:07.659479 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-28 06:00:07.659700 | instance | Tuesday 28 April 2026 06:00:07 +0000 (0:00:00.039) 0:00:00.962 ********* 2026-04-28 06:00:08.517362 | instance | ok: [instance] 2026-04-28 06:00:08.517616 | instance | 2026-04-28 06:00:08.517911 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-04-28 06:00:08.518214 | instance | Tuesday 28 April 2026 06:00:08 +0000 (0:00:00.859) 0:00:01.821 ********* 2026-04-28 06:00:08.707324 | instance | ok: [instance] 2026-04-28 06:00:08.707482 | instance | 2026-04-28 06:00:08.707665 | instance | PLAY [Deploy Ceph monitors & managers] ***************************************** 2026-04-28 06:00:08.707827 | instance | 2026-04-28 06:00:08.708001 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-28 06:00:08.708182 | instance | Tuesday 28 April 2026 06:00:08 +0000 (0:00:00.190) 0:00:02.011 ********* 2026-04-28 06:00:09.559792 | instance | ok: [instance] 2026-04-28 06:00:09.560157 | instance | 2026-04-28 06:00:09.560491 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-28 06:00:09.560819 | instance | Tuesday 28 April 2026 06:00:09 +0000 (0:00:00.852) 0:00:02.864 ********* 2026-04-28 06:00:09.823599 | instance | ok: [instance] 2026-04-28 06:00:09.823667 | instance | 2026-04-28 06:00:09.823819 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-28 06:00:09.824003 | instance | Tuesday 28 April 2026 06:00:09 +0000 (0:00:00.263) 0:00:03.128 ********* 2026-04-28 06:00:09.867596 | instance | skipping: [instance] 2026-04-28 06:00:09.867748 | instance | 2026-04-28 06:00:09.867942 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-04-28 06:00:09.868100 | instance | Tuesday 28 April 2026 06:00:09 +0000 (0:00:00.041) 0:00:03.170 ********* 2026-04-28 06:00:10.155810 | instance | changed: [instance] 2026-04-28 06:00:10.156313 | instance | 2026-04-28 06:00:10.158183 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-28 06:00:10.158209 | instance | Tuesday 28 April 2026 06:00:10 +0000 (0:00:00.289) 0:00:03.459 ********* 2026-04-28 06:00:10.223616 | instance | ok: [instance] => { 2026-04-28 06:00:10.223752 | instance | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-04-28 06:00:10.223936 | instance | } 2026-04-28 06:00:10.224082 | instance | 2026-04-28 06:00:10.224238 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-28 06:00:10.224390 | instance | Tuesday 28 April 2026 06:00:10 +0000 (0:00:00.066) 0:00:03.526 ********* 2026-04-28 06:00:10.974573 | instance | changed: [instance] 2026-04-28 06:00:10.974751 | instance | 2026-04-28 06:00:10.974907 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-28 06:00:10.975092 | instance | Tuesday 28 April 2026 06:00:10 +0000 (0:00:00.751) 0:00:04.277 ********* 2026-04-28 06:00:11.022886 | instance | skipping: [instance] 2026-04-28 06:00:11.022902 | instance | 2026-04-28 06:00:11.022907 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-28 06:00:11.022912 | instance | Tuesday 28 April 2026 06:00:11 +0000 (0:00:00.050) 0:00:04.328 ********* 2026-04-28 06:00:11.072413 | instance | skipping: [instance] 2026-04-28 06:00:11.072442 | instance | 2026-04-28 06:00:11.072447 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-28 06:00:11.072453 | instance | Tuesday 28 April 2026 06:00:11 +0000 (0:00:00.049) 0:00:04.377 ********* 2026-04-28 06:00:11.273161 | instance | ok: [instance] 2026-04-28 06:00:11.273231 | instance | 2026-04-28 06:00:11.273523 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-28 06:00:11.273563 | instance | Tuesday 28 April 2026 06:00:11 +0000 (0:00:00.200) 0:00:04.578 ********* 2026-04-28 06:00:12.404749 | instance | ok: [instance] 2026-04-28 06:00:12.404781 | instance | 2026-04-28 06:00:12.404787 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-28 06:00:12.404792 | instance | Tuesday 28 April 2026 06:00:12 +0000 (0:00:01.131) 0:00:05.709 ********* 2026-04-28 06:00:12.485290 | instance | ok: [instance] => { 2026-04-28 06:00:12.485315 | instance | "msg": "https://github.com/containerd/containerd/releases/download/v2.2.3/containerd-2.2.3-linux-amd64.tar.gz" 2026-04-28 06:00:12.485323 | instance | } 2026-04-28 06:00:12.485328 | instance | 2026-04-28 06:00:12.485334 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-28 06:00:12.485340 | instance | Tuesday 28 April 2026 06:00:12 +0000 (0:00:00.080) 0:00:05.789 ********* 2026-04-28 06:00:13.420948 | instance | changed: [instance] 2026-04-28 06:00:13.421020 | instance | 2026-04-28 06:00:13.421264 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-28 06:00:13.421386 | instance | Tuesday 28 April 2026 06:00:13 +0000 (0:00:00.936) 0:00:06.725 ********* 2026-04-28 06:00:16.268157 | instance | changed: [instance] 2026-04-28 06:00:16.268222 | instance | 2026-04-28 06:00:16.268483 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-04-28 06:00:16.268519 | instance | Tuesday 28 April 2026 06:00:16 +0000 (0:00:02.847) 0:00:09.573 ********* 2026-04-28 06:00:16.299889 | instance | skipping: [instance] 2026-04-28 06:00:16.299987 | instance | 2026-04-28 06:00:16.300113 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-04-28 06:00:16.300250 | instance | Tuesday 28 April 2026 06:00:16 +0000 (0:00:00.031) 0:00:09.605 ********* 2026-04-28 06:00:16.338576 | instance | skipping: [instance] 2026-04-28 06:00:16.339219 | instance | 2026-04-28 06:00:16.339442 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-04-28 06:00:16.339481 | instance | Tuesday 28 April 2026 06:00:16 +0000 (0:00:00.038) 0:00:09.643 ********* 2026-04-28 06:00:16.371985 | instance | skipping: [instance] 2026-04-28 06:00:16.372088 | instance | 2026-04-28 06:00:16.372213 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-04-28 06:00:16.372335 | instance | Tuesday 28 April 2026 06:00:16 +0000 (0:00:00.033) 0:00:09.677 ********* 2026-04-28 06:00:21.351222 | instance | changed: [instance] 2026-04-28 06:00:21.351748 | instance | 2026-04-28 06:00:21.351782 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] *** 2026-04-28 06:00:21.351791 | instance | Tuesday 28 April 2026 06:00:21 +0000 (0:00:04.978) 0:00:14.656 ********* 2026-04-28 06:00:21.910826 | instance | changed: [instance] 2026-04-28 06:00:21.910884 | instance | 2026-04-28 06:00:21.911212 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] ******* 2026-04-28 06:00:21.911248 | instance | Tuesday 28 April 2026 06:00:21 +0000 (0:00:00.559) 0:00:15.216 ********* 2026-04-28 06:00:22.807840 | instance | changed: [instance] => (item={'path': '/etc/containerd'}) 2026-04-28 06:00:22.807910 | instance | changed: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'}) 2026-04-28 06:00:22.808728 | instance | changed: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'}) 2026-04-28 06:00:22.808811 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'}) 2026-04-28 06:00:22.808819 | instance | changed: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'}) 2026-04-28 06:00:22.808824 | instance | 2026-04-28 06:00:22.808830 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] ********** 2026-04-28 06:00:22.808835 | instance | Tuesday 28 April 2026 06:00:22 +0000 (0:00:00.896) 0:00:16.112 ********* 2026-04-28 06:00:23.357288 | instance | changed: [instance] 2026-04-28 06:00:23.357388 | instance | 2026-04-28 06:00:23.357453 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ******** 2026-04-28 06:00:23.357974 | instance | Tuesday 28 April 2026 06:00:23 +0000 (0:00:00.533) 0:00:16.645 ********* 2026-04-28 06:00:23.358130 | instance | 2026-04-28 06:00:23.358137 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-04-28 06:00:23.358142 | instance | Tuesday 28 April 2026 06:00:23 +0000 (0:00:00.016) 0:00:16.662 ********* 2026-04-28 06:00:24.247268 | instance | ok: [instance] 2026-04-28 06:00:24.247348 | instance | 2026-04-28 06:00:24.247484 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] ********** 2026-04-28 06:00:24.247616 | instance | Tuesday 28 April 2026 06:00:24 +0000 (0:00:00.889) 0:00:17.552 ********* 2026-04-28 06:00:24.684805 | instance | changed: [instance] 2026-04-28 06:00:24.685063 | instance | 2026-04-28 06:00:24.685348 | instance | TASK [vexxhost.containers.containerd : Enable and start service] *************** 2026-04-28 06:00:24.685626 | instance | Tuesday 28 April 2026 06:00:24 +0000 (0:00:00.437) 0:00:17.989 ********* 2026-04-28 06:00:25.212683 | instance | changed: [instance] 2026-04-28 06:00:25.212949 | instance | 2026-04-28 06:00:25.213241 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-28 06:00:25.213525 | instance | Tuesday 28 April 2026 06:00:25 +0000 (0:00:00.527) 0:00:18.517 ********* 2026-04-28 06:00:25.408388 | instance | ok: [instance] 2026-04-28 06:00:25.408716 | instance | 2026-04-28 06:00:25.409024 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-28 06:00:25.409398 | instance | Tuesday 28 April 2026 06:00:25 +0000 (0:00:00.195) 0:00:18.713 ********* 2026-04-28 06:00:25.461006 | instance | ok: [instance] => { 2026-04-28 06:00:25.461346 | instance | "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz" 2026-04-28 06:00:25.461649 | instance | } 2026-04-28 06:00:25.461928 | instance | 2026-04-28 06:00:25.462252 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-28 06:00:25.462559 | instance | Tuesday 28 April 2026 06:00:25 +0000 (0:00:00.052) 0:00:18.765 ********* 2026-04-28 06:00:26.491260 | instance | changed: [instance] 2026-04-28 06:00:26.491320 | instance | 2026-04-28 06:00:26.491332 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-28 06:00:26.491342 | instance | Tuesday 28 April 2026 06:00:26 +0000 (0:00:01.029) 0:00:19.795 ********* 2026-04-28 06:00:30.705641 | instance | changed: [instance] 2026-04-28 06:00:30.705673 | instance | 2026-04-28 06:00:30.705679 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ****************** 2026-04-28 06:00:30.705684 | instance | Tuesday 28 April 2026 06:00:30 +0000 (0:00:04.215) 0:00:24.010 ********* 2026-04-28 06:00:31.646412 | instance | ok: [instance] 2026-04-28 06:00:31.646512 | instance | 2026-04-28 06:00:31.646776 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] *************** 2026-04-28 06:00:31.646792 | instance | Tuesday 28 April 2026 06:00:31 +0000 (0:00:00.941) 0:00:24.951 ********* 2026-04-28 06:00:31.976384 | instance | changed: [instance] 2026-04-28 06:00:31.976451 | instance | 2026-04-28 06:00:31.976731 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] ***** 2026-04-28 06:00:31.976770 | instance | Tuesday 28 April 2026 06:00:31 +0000 (0:00:00.329) 0:00:25.281 ********* 2026-04-28 06:00:32.439177 | instance | changed: [instance] 2026-04-28 06:00:32.439323 | instance | 2026-04-28 06:00:32.439503 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] *********** 2026-04-28 06:00:32.439688 | instance | Tuesday 28 April 2026 06:00:32 +0000 (0:00:00.462) 0:00:25.744 ********* 2026-04-28 06:00:32.989081 | instance | changed: [instance] => (item={'path': '/etc/docker'}) 2026-04-28 06:00:32.989495 | instance | changed: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'}) 2026-04-28 06:00:32.989910 | instance | changed: [instance] => (item={'path': '/run/docker', 'mode': '0o711'}) 2026-04-28 06:00:32.990193 | instance | 2026-04-28 06:00:32.990487 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ****** 2026-04-28 06:00:32.990771 | instance | Tuesday 28 April 2026 06:00:32 +0000 (0:00:00.549) 0:00:26.293 ********* 2026-04-28 06:00:33.424197 | instance | changed: [instance] 2026-04-28 06:00:33.424246 | instance | 2026-04-28 06:00:33.424394 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] *********** 2026-04-28 06:00:33.424538 | instance | Tuesday 28 April 2026 06:00:33 +0000 (0:00:00.435) 0:00:26.729 ********* 2026-04-28 06:00:33.885905 | instance | changed: [instance] 2026-04-28 06:00:33.886150 | instance | 2026-04-28 06:00:33.886432 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************ 2026-04-28 06:00:33.886701 | instance | Tuesday 28 April 2026 06:00:33 +0000 (0:00:00.443) 0:00:27.173 ********* 2026-04-28 06:00:33.886953 | instance | 2026-04-28 06:00:33.887265 | instance | RUNNING HANDLER [vexxhost.containers.containerd : Reload systemd] ************** 2026-04-28 06:00:33.887533 | instance | Tuesday 28 April 2026 06:00:33 +0000 (0:00:00.017) 0:00:27.190 ********* 2026-04-28 06:00:34.584346 | instance | ok: [instance] 2026-04-28 06:00:34.584386 | instance | 2026-04-28 06:00:34.584391 | instance | RUNNING HANDLER [vexxhost.containers.docker : Restart docker] ****************** 2026-04-28 06:00:34.584396 | instance | Tuesday 28 April 2026 06:00:34 +0000 (0:00:00.698) 0:00:27.889 ********* 2026-04-28 06:00:35.409067 | instance | changed: [instance] 2026-04-28 06:00:35.409149 | instance | 2026-04-28 06:00:35.409414 | instance | TASK [vexxhost.containers.docker : Enable and start service] ******************* 2026-04-28 06:00:35.409447 | instance | Tuesday 28 April 2026 06:00:35 +0000 (0:00:00.825) 0:00:28.714 ********* 2026-04-28 06:00:35.950804 | instance | changed: [instance] 2026-04-28 06:00:35.951034 | instance | 2026-04-28 06:00:35.951047 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ****** 2026-04-28 06:00:35.951156 | instance | Tuesday 28 April 2026 06:00:35 +0000 (0:00:00.541) 0:00:29.256 ********* 2026-04-28 06:00:36.003994 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml) 2026-04-28 06:00:36.004107 | instance | 2026-04-28 06:00:36.004250 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ******************************** 2026-04-28 06:00:36.004379 | instance | Tuesday 28 April 2026 06:00:36 +0000 (0:00:00.053) 0:00:29.309 ********* 2026-04-28 06:00:40.965510 | instance | changed: [instance] 2026-04-28 06:00:40.965570 | instance | 2026-04-28 06:00:40.965805 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] ********************* 2026-04-28 06:00:40.965820 | instance | Tuesday 28 April 2026 06:00:40 +0000 (0:00:04.961) 0:00:34.270 ********* 2026-04-28 06:00:41.606846 | instance | ok: [instance] => (item=chronyd) 2026-04-28 06:00:41.607185 | instance | ok: [instance] => (item=sshd) 2026-04-28 06:00:41.607247 | instance | 2026-04-28 06:00:41.607465 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ****************************** 2026-04-28 06:00:41.607486 | instance | Tuesday 28 April 2026 06:00:41 +0000 (0:00:00.640) 0:00:34.911 ********* 2026-04-28 06:00:42.559960 | instance | changed: [instance] 2026-04-28 06:00:42.560030 | instance | 2026-04-28 06:00:42.560359 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ******************** 2026-04-28 06:00:42.560399 | instance | Tuesday 28 April 2026 06:00:42 +0000 (0:00:00.953) 0:00:35.865 ********* 2026-04-28 06:00:42.763857 | instance | ok: [instance] 2026-04-28 06:00:42.763923 | instance | 2026-04-28 06:00:42.764204 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] **************** 2026-04-28 06:00:42.764243 | instance | Tuesday 28 April 2026 06:00:42 +0000 (0:00:00.203) 0:00:36.068 ********* 2026-04-28 06:00:43.201493 | instance | changed: [instance] 2026-04-28 06:00:43.201587 | instance | 2026-04-28 06:00:43.201860 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] *** 2026-04-28 06:00:43.202015 | instance | Tuesday 28 April 2026 06:00:43 +0000 (0:00:00.437) 0:00:36.506 ********* 2026-04-28 06:00:43.514731 | instance | changed: [instance] 2026-04-28 06:00:43.515163 | instance | 2026-04-28 06:00:43.515232 | instance | TASK [vexxhost.ceph.mon : Get `cephadm ls` status] ***************************** 2026-04-28 06:00:43.515252 | instance | Tuesday 28 April 2026 06:00:43 +0000 (0:00:00.313) 0:00:36.819 ********* 2026-04-28 06:00:45.098674 | instance | ok: [instance] 2026-04-28 06:00:45.099095 | instance | 2026-04-28 06:00:45.099134 | instance | TASK [vexxhost.ceph.mon : Parse the `cephadm ls` output] *********************** 2026-04-28 06:00:45.099141 | instance | Tuesday 28 April 2026 06:00:45 +0000 (0:00:01.584) 0:00:38.403 ********* 2026-04-28 06:00:45.144753 | instance | ok: [instance] 2026-04-28 06:00:45.145105 | instance | 2026-04-28 06:00:45.145127 | instance | TASK [vexxhost.ceph.mon : Assimilate existing configs in `ceph.conf`] ********** 2026-04-28 06:00:45.145134 | instance | Tuesday 28 April 2026 06:00:45 +0000 (0:00:00.046) 0:00:38.449 ********* 2026-04-28 06:00:45.180160 | instance | skipping: [instance] 2026-04-28 06:00:45.180253 | instance | 2026-04-28 06:00:45.180403 | instance | TASK [vexxhost.ceph.mon : Adopt monitor to cluster] **************************** 2026-04-28 06:00:45.180531 | instance | Tuesday 28 April 2026 06:00:45 +0000 (0:00:00.035) 0:00:38.485 ********* 2026-04-28 06:00:45.218218 | instance | skipping: [instance] 2026-04-28 06:00:45.218322 | instance | 2026-04-28 06:00:45.218444 | instance | TASK [vexxhost.ceph.mon : Adopt manager to cluster] **************************** 2026-04-28 06:00:45.218583 | instance | Tuesday 28 April 2026 06:00:45 +0000 (0:00:00.038) 0:00:38.523 ********* 2026-04-28 06:00:45.258122 | instance | skipping: [instance] 2026-04-28 06:00:45.258225 | instance | 2026-04-28 06:00:45.258491 | instance | TASK [vexxhost.ceph.mon : Enable "cephadm" mgr module] ************************* 2026-04-28 06:00:45.258526 | instance | Tuesday 28 April 2026 06:00:45 +0000 (0:00:00.039) 0:00:38.563 ********* 2026-04-28 06:00:45.295766 | instance | skipping: [instance] 2026-04-28 06:00:45.295858 | instance | 2026-04-28 06:00:45.296115 | instance | TASK [vexxhost.ceph.mon : Set orchestrator backend to "cephadm"] *************** 2026-04-28 06:00:45.296138 | instance | Tuesday 28 April 2026 06:00:45 +0000 (0:00:00.037) 0:00:38.601 ********* 2026-04-28 06:00:45.337502 | instance | skipping: [instance] 2026-04-28 06:00:45.337663 | instance | 2026-04-28 06:00:45.337922 | instance | TASK [vexxhost.ceph.mon : Use `cephadm` user for cephadm] ********************** 2026-04-28 06:00:45.338123 | instance | Tuesday 28 April 2026 06:00:45 +0000 (0:00:00.041) 0:00:38.642 ********* 2026-04-28 06:00:45.372448 | instance | skipping: [instance] 2026-04-28 06:00:45.372549 | instance | 2026-04-28 06:00:45.372834 | instance | TASK [vexxhost.ceph.mon : Generate "cephadm" key] ****************************** 2026-04-28 06:00:45.372853 | instance | Tuesday 28 April 2026 06:00:45 +0000 (0:00:00.035) 0:00:38.677 ********* 2026-04-28 06:00:45.406184 | instance | skipping: [instance] 2026-04-28 06:00:45.406555 | instance | 2026-04-28 06:00:45.406593 | instance | TASK [vexxhost.ceph.mon : Set Ceph Monitor IP address] ************************* 2026-04-28 06:00:45.406599 | instance | Tuesday 28 April 2026 06:00:45 +0000 (0:00:00.033) 0:00:38.711 ********* 2026-04-28 06:00:45.514968 | instance | ok: [instance] 2026-04-28 06:00:45.515048 | instance | 2026-04-28 06:00:45.515094 | instance | TASK [vexxhost.ceph.mon : Check if any node is bootstrapped] ******************* 2026-04-28 06:00:45.515232 | instance | Tuesday 28 April 2026 06:00:45 +0000 (0:00:00.108) 0:00:38.820 ********* 2026-04-28 06:00:45.718317 | instance | ok: [instance] => (item=instance) 2026-04-28 06:00:45.718396 | instance | 2026-04-28 06:00:45.718691 | instance | TASK [vexxhost.ceph.mon : Select pre-existing bootstrap node if exists] ******** 2026-04-28 06:00:45.718731 | instance | Tuesday 28 April 2026 06:00:45 +0000 (0:00:00.203) 0:00:39.023 ********* 2026-04-28 06:00:45.769166 | instance | ok: [instance] 2026-04-28 06:00:45.769245 | instance | 2026-04-28 06:00:45.769511 | instance | TASK [vexxhost.ceph.mon : Bootstrap cluster] *********************************** 2026-04-28 06:00:45.769550 | instance | Tuesday 28 April 2026 06:00:45 +0000 (0:00:00.050) 0:00:39.074 ********* 2026-04-28 06:00:45.838054 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/mon/tasks/bootstrap-ceph.yml for instance 2026-04-28 06:00:45.838156 | instance | 2026-04-28 06:00:45.838432 | instance | TASK [vexxhost.ceph.mon : Generate temporary file for "ceph.conf"] ************* 2026-04-28 06:00:45.838456 | instance | Tuesday 28 April 2026 06:00:45 +0000 (0:00:00.069) 0:00:39.143 ********* 2026-04-28 06:00:46.128050 | instance | changed: [instance] 2026-04-28 06:00:46.128146 | instance | 2026-04-28 06:00:46.128426 | instance | TASK [vexxhost.ceph.mon : Include extra configuration values] ****************** 2026-04-28 06:00:46.128466 | instance | Tuesday 28 April 2026 06:00:46 +0000 (0:00:00.289) 0:00:39.433 ********* 2026-04-28 06:00:46.797950 | instance | changed: [instance] => (item={'option': 'mon allow pool size one', 'section': 'global', 'value': True}) 2026-04-28 06:00:46.798648 | instance | changed: [instance] => (item={'option': 'osd crush chooseleaf type', 'section': 'global', 'value': 0}) 2026-04-28 06:00:46.798667 | instance | changed: [instance] => (item={'option': 'auth allow insecure global id reclaim', 'section': 'mon', 'value': False}) 2026-04-28 06:00:46.798674 | instance | 2026-04-28 06:00:46.798680 | instance | TASK [vexxhost.ceph.mon : Run Bootstrap coomand] ******************************* 2026-04-28 06:00:46.798684 | instance | Tuesday 28 April 2026 06:00:46 +0000 (0:00:00.670) 0:00:40.103 ********* 2026-04-28 06:02:18.666748 | instance | ok: [instance] 2026-04-28 06:02:18.666819 | instance | 2026-04-28 06:02:18.667074 | instance | TASK [vexxhost.ceph.mon : Remove temporary file for "ceph.conf"] *************** 2026-04-28 06:02:18.667114 | instance | Tuesday 28 April 2026 06:02:18 +0000 (0:01:31.868) 0:02:11.971 ********* 2026-04-28 06:02:18.866227 | instance | changed: [instance] 2026-04-28 06:02:18.866327 | instance | 2026-04-28 06:02:18.866454 | instance | TASK [vexxhost.ceph.mon : Set bootstrap node] ********************************** 2026-04-28 06:02:18.866580 | instance | Tuesday 28 April 2026 06:02:18 +0000 (0:00:00.199) 0:02:12.171 ********* 2026-04-28 06:02:18.914645 | instance | ok: [instance] 2026-04-28 06:02:18.914749 | instance | 2026-04-28 06:02:18.914864 | instance | TASK [Install Ceph host] ******************************************************* 2026-04-28 06:02:18.914983 | instance | Tuesday 28 April 2026 06:02:18 +0000 (0:00:00.048) 0:02:12.220 ********* 2026-04-28 06:02:19.005775 | instance | included: vexxhost.ceph.cephadm_host for instance 2026-04-28 06:02:19.005840 | instance | 2026-04-28 06:02:19.005977 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ****** 2026-04-28 06:02:19.006101 | instance | Tuesday 28 April 2026 06:02:19 +0000 (0:00:00.090) 0:02:12.310 ********* 2026-04-28 06:02:20.378973 | instance | ok: [instance] 2026-04-28 06:02:20.379015 | instance | 2026-04-28 06:02:20.379020 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] *** 2026-04-28 06:02:20.379025 | instance | Tuesday 28 April 2026 06:02:20 +0000 (0:00:01.373) 0:02:13.683 ********* 2026-04-28 06:02:20.439129 | instance | ok: [instance] => (item=instance) 2026-04-28 06:02:20.439196 | instance | 2026-04-28 06:02:20.439603 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] *********** 2026-04-28 06:02:20.439632 | instance | Tuesday 28 April 2026 06:02:20 +0000 (0:00:00.060) 0:02:13.744 ********* 2026-04-28 06:02:20.797016 | instance | ok: [instance] 2026-04-28 06:02:20.797056 | instance | 2026-04-28 06:02:20.797064 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] *********************** 2026-04-28 06:02:20.797071 | instance | Tuesday 28 April 2026 06:02:20 +0000 (0:00:00.357) 0:02:14.101 ********* 2026-04-28 06:02:22.637042 | instance | ok: [instance] 2026-04-28 06:02:22.637118 | instance | 2026-04-28 06:02:22.637433 | instance | TASK [vexxhost.ceph.mon : Configure "mon" label for monitors] ****************** 2026-04-28 06:02:22.637480 | instance | Tuesday 28 April 2026 06:02:22 +0000 (0:00:01.840) 0:02:15.942 ********* 2026-04-28 06:02:24.096738 | instance | ok: [instance] 2026-04-28 06:02:24.096818 | instance | 2026-04-28 06:02:24.096912 | instance | TASK [vexxhost.ceph.mon : Validate monitor exist] ****************************** 2026-04-28 06:02:24.097043 | instance | Tuesday 28 April 2026 06:02:24 +0000 (0:00:01.459) 0:02:17.401 ********* 2026-04-28 06:02:35.137015 | instance | ok: [instance] 2026-04-28 06:02:35.137089 | instance | 2026-04-28 06:02:35.137335 | instance | TASK [Install Ceph host] ******************************************************* 2026-04-28 06:02:35.137417 | instance | Tuesday 28 April 2026 06:02:35 +0000 (0:00:11.040) 0:02:28.441 ********* 2026-04-28 06:02:35.221121 | instance | included: vexxhost.ceph.cephadm_host for instance 2026-04-28 06:02:35.221189 | instance | 2026-04-28 06:02:35.221468 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ****** 2026-04-28 06:02:35.221509 | instance | Tuesday 28 April 2026 06:02:35 +0000 (0:00:00.084) 0:02:28.526 ********* 2026-04-28 06:02:35.280357 | instance | skipping: [instance] 2026-04-28 06:02:35.280449 | instance | 2026-04-28 06:02:35.280740 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] *** 2026-04-28 06:02:35.280784 | instance | Tuesday 28 April 2026 06:02:35 +0000 (0:00:00.058) 0:02:28.585 ********* 2026-04-28 06:02:35.337091 | instance | skipping: [instance] => (item=instance) 2026-04-28 06:02:35.337175 | instance | skipping: [instance] 2026-04-28 06:02:35.337542 | instance | 2026-04-28 06:02:35.337569 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] *********** 2026-04-28 06:02:35.337575 | instance | Tuesday 28 April 2026 06:02:35 +0000 (0:00:00.056) 0:02:28.641 ********* 2026-04-28 06:02:35.600164 | instance | ok: [instance] 2026-04-28 06:02:35.600670 | instance | 2026-04-28 06:02:35.600744 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] *********************** 2026-04-28 06:02:35.600753 | instance | Tuesday 28 April 2026 06:02:35 +0000 (0:00:00.262) 0:02:28.904 ********* 2026-04-28 06:02:37.456395 | instance | ok: [instance] 2026-04-28 06:02:37.456479 | instance | 2026-04-28 06:02:37.456710 | instance | TASK [vexxhost.ceph.mgr : Configure "mgr" label for managers] ****************** 2026-04-28 06:02:37.456752 | instance | Tuesday 28 April 2026 06:02:37 +0000 (0:00:01.856) 0:02:30.761 ********* 2026-04-28 06:02:38.850068 | instance | ok: [instance] 2026-04-28 06:02:38.850658 | instance | 2026-04-28 06:02:38.850695 | instance | TASK [vexxhost.ceph.mgr : Validate manager exist] ****************************** 2026-04-28 06:02:38.850703 | instance | Tuesday 28 April 2026 06:02:38 +0000 (0:00:01.393) 0:02:32.155 ********* 2026-04-28 06:02:40.231009 | instance | ok: [instance] 2026-04-28 06:02:40.231132 | instance | 2026-04-28 06:02:40.231386 | instance | TASK [vexxhost.ceph.mgr : Enable the Ceph Manager prometheus module] *********** 2026-04-28 06:02:40.231402 | instance | Tuesday 28 April 2026 06:02:40 +0000 (0:00:01.381) 0:02:33.536 ********* 2026-04-28 06:02:41.950225 | instance | ok: [instance] 2026-04-28 06:02:41.950262 | instance | 2026-04-28 06:02:41.950268 | instance | PLAY [Deploy Ceph OSDs] ******************************************************** 2026-04-28 06:02:41.950272 | instance | 2026-04-28 06:02:41.950277 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-28 06:02:41.950281 | instance | Tuesday 28 April 2026 06:02:41 +0000 (0:00:01.718) 0:02:35.255 ********* 2026-04-28 06:02:42.878100 | instance | ok: [instance] 2026-04-28 06:02:42.878148 | instance | 2026-04-28 06:02:42.878157 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-28 06:02:42.878168 | instance | Tuesday 28 April 2026 06:02:42 +0000 (0:00:00.927) 0:02:36.182 ********* 2026-04-28 06:02:43.085078 | instance | ok: [instance] 2026-04-28 06:02:43.085110 | instance | 2026-04-28 06:02:43.085117 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-28 06:02:43.085122 | instance | Tuesday 28 April 2026 06:02:43 +0000 (0:00:00.207) 0:02:36.389 ********* 2026-04-28 06:02:43.128138 | instance | skipping: [instance] 2026-04-28 06:02:43.128154 | instance | 2026-04-28 06:02:43.128159 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-04-28 06:02:43.128164 | instance | Tuesday 28 April 2026 06:02:43 +0000 (0:00:00.043) 0:02:36.433 ********* 2026-04-28 06:02:43.337568 | instance | ok: [instance] 2026-04-28 06:02:43.337599 | instance | 2026-04-28 06:02:43.337604 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-28 06:02:43.337609 | instance | Tuesday 28 April 2026 06:02:43 +0000 (0:00:00.208) 0:02:36.642 ********* 2026-04-28 06:02:43.391951 | instance | ok: [instance] => { 2026-04-28 06:02:43.391969 | instance | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-04-28 06:02:43.391974 | instance | } 2026-04-28 06:02:43.391978 | instance | 2026-04-28 06:02:43.391983 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-28 06:02:43.391987 | instance | Tuesday 28 April 2026 06:02:43 +0000 (0:00:00.054) 0:02:36.696 ********* 2026-04-28 06:02:43.694892 | instance | ok: [instance] 2026-04-28 06:02:43.694932 | instance | 2026-04-28 06:02:43.694938 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-28 06:02:43.694943 | instance | Tuesday 28 April 2026 06:02:43 +0000 (0:00:00.302) 0:02:36.999 ********* 2026-04-28 06:02:43.743096 | instance | skipping: [instance] 2026-04-28 06:02:43.743124 | instance | 2026-04-28 06:02:43.743349 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-28 06:02:43.743360 | instance | Tuesday 28 April 2026 06:02:43 +0000 (0:00:00.048) 0:02:37.048 ********* 2026-04-28 06:02:43.786817 | instance | skipping: [instance] 2026-04-28 06:02:43.786856 | instance | 2026-04-28 06:02:43.786861 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-28 06:02:43.786866 | instance | Tuesday 28 April 2026 06:02:43 +0000 (0:00:00.043) 0:02:37.091 ********* 2026-04-28 06:02:43.994325 | instance | ok: [instance] 2026-04-28 06:02:43.994360 | instance | 2026-04-28 06:02:43.994368 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-28 06:02:43.994379 | instance | Tuesday 28 April 2026 06:02:43 +0000 (0:00:00.207) 0:02:37.299 ********* 2026-04-28 06:02:45.001746 | instance | ok: [instance] 2026-04-28 06:02:45.001804 | instance | 2026-04-28 06:02:45.001819 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-28 06:02:45.001830 | instance | Tuesday 28 April 2026 06:02:44 +0000 (0:00:01.006) 0:02:38.305 ********* 2026-04-28 06:02:45.067187 | instance | ok: [instance] => { 2026-04-28 06:02:45.067228 | instance | "msg": "https://github.com/containerd/containerd/releases/download/v2.2.3/containerd-2.2.3-linux-amd64.tar.gz" 2026-04-28 06:02:45.067239 | instance | } 2026-04-28 06:02:45.067249 | instance | 2026-04-28 06:02:45.067258 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-28 06:02:45.067268 | instance | Tuesday 28 April 2026 06:02:45 +0000 (0:00:00.065) 0:02:38.370 ********* 2026-04-28 06:02:45.392557 | instance | ok: [instance] 2026-04-28 06:02:45.392609 | instance | 2026-04-28 06:02:45.392621 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-28 06:02:45.392632 | instance | Tuesday 28 April 2026 06:02:45 +0000 (0:00:00.325) 0:02:38.696 ********* 2026-04-28 06:02:47.336424 | instance | ok: [instance] 2026-04-28 06:02:47.336471 | instance | 2026-04-28 06:02:47.336478 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-04-28 06:02:47.336482 | instance | Tuesday 28 April 2026 06:02:47 +0000 (0:00:01.944) 0:02:40.641 ********* 2026-04-28 06:02:47.373128 | instance | skipping: [instance] 2026-04-28 06:02:47.373171 | instance | 2026-04-28 06:02:47.373177 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-04-28 06:02:47.373181 | instance | Tuesday 28 April 2026 06:02:47 +0000 (0:00:00.036) 0:02:40.677 ********* 2026-04-28 06:02:47.408707 | instance | skipping: [instance] 2026-04-28 06:02:47.408745 | instance | 2026-04-28 06:02:47.408750 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-04-28 06:02:47.408755 | instance | Tuesday 28 April 2026 06:02:47 +0000 (0:00:00.035) 0:02:40.713 ********* 2026-04-28 06:02:47.441678 | instance | skipping: [instance] 2026-04-28 06:02:47.441716 | instance | 2026-04-28 06:02:47.441723 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-04-28 06:02:47.441730 | instance | Tuesday 28 April 2026 06:02:47 +0000 (0:00:00.032) 0:02:40.745 ********* 2026-04-28 06:02:48.435702 | instance | ok: [instance] 2026-04-28 06:02:48.435744 | instance | 2026-04-28 06:02:48.435752 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] *** 2026-04-28 06:02:48.435770 | instance | Tuesday 28 April 2026 06:02:48 +0000 (0:00:00.994) 0:02:41.740 ********* 2026-04-28 06:02:48.858194 | instance | ok: [instance] 2026-04-28 06:02:48.858235 | instance | 2026-04-28 06:02:48.858249 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] ******* 2026-04-28 06:02:48.858256 | instance | Tuesday 28 April 2026 06:02:48 +0000 (0:00:00.422) 0:02:42.162 ********* 2026-04-28 06:02:49.752749 | instance | ok: [instance] => (item={'path': '/etc/containerd'}) 2026-04-28 06:02:49.752791 | instance | ok: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'}) 2026-04-28 06:02:49.752799 | instance | ok: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'}) 2026-04-28 06:02:49.752806 | instance | ok: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'}) 2026-04-28 06:02:49.752813 | instance | ok: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'}) 2026-04-28 06:02:49.752820 | instance | 2026-04-28 06:02:49.752826 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] ********** 2026-04-28 06:02:49.752832 | instance | Tuesday 28 April 2026 06:02:49 +0000 (0:00:00.891) 0:02:43.053 ********* 2026-04-28 06:02:50.250472 | instance | ok: [instance] 2026-04-28 06:02:50.250556 | instance | 2026-04-28 06:02:50.251148 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ******** 2026-04-28 06:02:50.251255 | instance | Tuesday 28 April 2026 06:02:50 +0000 (0:00:00.486) 0:02:43.540 ********* 2026-04-28 06:02:50.251267 | instance | 2026-04-28 06:02:50.251277 | instance | TASK [vexxhost.containers.containerd : Enable and start service] *************** 2026-04-28 06:02:50.251293 | instance | Tuesday 28 April 2026 06:02:50 +0000 (0:00:00.014) 0:02:43.555 ********* 2026-04-28 06:02:50.594159 | instance | ok: [instance] 2026-04-28 06:02:50.594223 | instance | 2026-04-28 06:02:50.594497 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-28 06:02:50.594534 | instance | Tuesday 28 April 2026 06:02:50 +0000 (0:00:00.343) 0:02:43.899 ********* 2026-04-28 06:02:50.787633 | instance | ok: [instance] 2026-04-28 06:02:50.787676 | instance | 2026-04-28 06:02:50.787682 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-28 06:02:50.787687 | instance | Tuesday 28 April 2026 06:02:50 +0000 (0:00:00.192) 0:02:44.092 ********* 2026-04-28 06:02:50.841318 | instance | ok: [instance] => { 2026-04-28 06:02:50.841500 | instance | "msg": "https://download.docker.com/linux/static/stable/x86_64/docker-24.0.9.tgz" 2026-04-28 06:02:50.841568 | instance | } 2026-04-28 06:02:50.842050 | instance | 2026-04-28 06:02:50.842093 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-28 06:02:50.842099 | instance | Tuesday 28 April 2026 06:02:50 +0000 (0:00:00.053) 0:02:44.146 ********* 2026-04-28 06:02:51.178739 | instance | ok: [instance] 2026-04-28 06:02:51.178812 | instance | 2026-04-28 06:02:51.179045 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-28 06:02:51.179105 | instance | Tuesday 28 April 2026 06:02:51 +0000 (0:00:00.337) 0:02:44.483 ********* 2026-04-28 06:02:54.260200 | instance | ok: [instance] 2026-04-28 06:02:54.260239 | instance | 2026-04-28 06:02:54.260245 | instance | TASK [vexxhost.containers.docker : Install AppArmor packages] ****************** 2026-04-28 06:02:54.260250 | instance | Tuesday 28 April 2026 06:02:54 +0000 (0:00:03.081) 0:02:47.564 ********* 2026-04-28 06:02:55.275563 | instance | ok: [instance] 2026-04-28 06:02:55.275637 | instance | 2026-04-28 06:02:55.275805 | instance | TASK [vexxhost.containers.docker : Ensure group "docker" exists] *************** 2026-04-28 06:02:55.275891 | instance | Tuesday 28 April 2026 06:02:55 +0000 (0:00:01.012) 0:02:48.577 ********* 2026-04-28 06:02:55.473975 | instance | ok: [instance] 2026-04-28 06:02:55.474058 | instance | 2026-04-28 06:02:55.474077 | instance | TASK [vexxhost.containers.docker : Create systemd service file for docker] ***** 2026-04-28 06:02:55.474091 | instance | Tuesday 28 April 2026 06:02:55 +0000 (0:00:00.201) 0:02:48.778 ********* 2026-04-28 06:02:55.873291 | instance | ok: [instance] 2026-04-28 06:02:55.873890 | instance | 2026-04-28 06:02:55.873928 | instance | TASK [vexxhost.containers.docker : Create folders for configuration] *********** 2026-04-28 06:02:55.873943 | instance | Tuesday 28 April 2026 06:02:55 +0000 (0:00:00.399) 0:02:49.178 ********* 2026-04-28 06:02:56.423611 | instance | ok: [instance] => (item={'path': '/etc/docker'}) 2026-04-28 06:02:56.423756 | instance | ok: [instance] => (item={'path': '/var/lib/docker', 'mode': '0o710'}) 2026-04-28 06:02:56.424484 | instance | ok: [instance] => (item={'path': '/run/docker', 'mode': '0o711'}) 2026-04-28 06:02:56.424525 | instance | 2026-04-28 06:02:56.424533 | instance | TASK [vexxhost.containers.docker : Create systemd socket file for docker] ****** 2026-04-28 06:02:56.424540 | instance | Tuesday 28 April 2026 06:02:56 +0000 (0:00:00.550) 0:02:49.728 ********* 2026-04-28 06:02:56.853509 | instance | ok: [instance] 2026-04-28 06:02:56.853981 | instance | 2026-04-28 06:02:56.854233 | instance | TASK [vexxhost.containers.docker : Create docker daemon config file] *********** 2026-04-28 06:02:56.854242 | instance | Tuesday 28 April 2026 06:02:56 +0000 (0:00:00.429) 0:02:50.158 ********* 2026-04-28 06:02:57.294853 | instance | ok: [instance] 2026-04-28 06:02:57.295188 | instance | 2026-04-28 06:02:57.295276 | instance | TASK [vexxhost.containers.docker : Force any restarts if necessary] ************ 2026-04-28 06:02:57.295294 | instance | Tuesday 28 April 2026 06:02:57 +0000 (0:00:00.424) 0:02:50.582 ********* 2026-04-28 06:02:57.295604 | instance | 2026-04-28 06:02:57.295645 | instance | TASK [vexxhost.containers.docker : Enable and start service] ******************* 2026-04-28 06:02:57.295652 | instance | Tuesday 28 April 2026 06:02:57 +0000 (0:00:00.017) 0:02:50.600 ********* 2026-04-28 06:02:57.682547 | instance | ok: [instance] 2026-04-28 06:02:57.683025 | instance | 2026-04-28 06:02:57.683090 | instance | TASK [vexxhost.ceph.cephadm : Gather variables for each operating system] ****** 2026-04-28 06:02:57.683099 | instance | Tuesday 28 April 2026 06:02:57 +0000 (0:00:00.387) 0:02:50.987 ********* 2026-04-28 06:02:57.739337 | instance | ok: [instance] => (item=/home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/cephadm/vars/ubuntu-22.04.yml) 2026-04-28 06:02:57.739403 | instance | 2026-04-28 06:02:57.739678 | instance | TASK [vexxhost.ceph.cephadm : Install packages] ******************************** 2026-04-28 06:02:57.739717 | instance | Tuesday 28 April 2026 06:02:57 +0000 (0:00:00.056) 0:02:51.044 ********* 2026-04-28 06:02:58.783179 | instance | ok: [instance] 2026-04-28 06:02:58.783249 | instance | 2026-04-28 06:02:58.783268 | instance | TASK [vexxhost.ceph.cephadm : Ensure services are started] ********************* 2026-04-28 06:02:58.783448 | instance | Tuesday 28 April 2026 06:02:58 +0000 (0:00:01.043) 0:02:52.088 ********* 2026-04-28 06:02:59.429188 | instance | ok: [instance] => (item=chronyd) 2026-04-28 06:02:59.429295 | instance | ok: [instance] => (item=sshd) 2026-04-28 06:02:59.429673 | instance | 2026-04-28 06:02:59.429711 | instance | TASK [vexxhost.ceph.cephadm : Download "cephadm"] ****************************** 2026-04-28 06:02:59.429717 | instance | Tuesday 28 April 2026 06:02:59 +0000 (0:00:00.646) 0:02:52.734 ********* 2026-04-28 06:02:59.772253 | instance | ok: [instance] 2026-04-28 06:02:59.772409 | instance | 2026-04-28 06:02:59.772591 | instance | TASK [vexxhost.ceph.cephadm : Remove cephadm from old path] ******************** 2026-04-28 06:02:59.772767 | instance | Tuesday 28 April 2026 06:02:59 +0000 (0:00:00.342) 0:02:53.077 ********* 2026-04-28 06:02:59.963520 | instance | ok: [instance] 2026-04-28 06:02:59.963798 | instance | 2026-04-28 06:02:59.964100 | instance | TASK [vexxhost.ceph.cephadm : Ensure "cephadm" user is present] **************** 2026-04-28 06:02:59.964389 | instance | Tuesday 28 April 2026 06:02:59 +0000 (0:00:00.191) 0:02:53.268 ********* 2026-04-28 06:03:00.196400 | instance | ok: [instance] 2026-04-28 06:03:00.196675 | instance | 2026-04-28 06:03:00.196997 | instance | TASK [vexxhost.ceph.cephadm : Allow "cephadm" user to have passwordless sudo] *** 2026-04-28 06:03:00.197295 | instance | Tuesday 28 April 2026 06:03:00 +0000 (0:00:00.232) 0:02:53.501 ********* 2026-04-28 06:03:00.406697 | instance | ok: [instance] 2026-04-28 06:03:00.406888 | instance | 2026-04-28 06:03:00.407147 | instance | TASK [vexxhost.ceph.osd : Get monitor status] ********************************** 2026-04-28 06:03:00.407369 | instance | Tuesday 28 April 2026 06:03:00 +0000 (0:00:00.210) 0:02:53.711 ********* 2026-04-28 06:03:00.640498 | instance | ok: [instance] => (item=instance) 2026-04-28 06:03:00.640618 | instance | 2026-04-28 06:03:00.640783 | instance | TASK [vexxhost.ceph.osd : Select admin host] *********************************** 2026-04-28 06:03:00.640936 | instance | Tuesday 28 April 2026 06:03:00 +0000 (0:00:00.233) 0:02:53.945 ********* 2026-04-28 06:03:00.688245 | instance | ok: [instance] 2026-04-28 06:03:00.688483 | instance | 2026-04-28 06:03:00.688762 | instance | TASK [vexxhost.ceph.osd : Get `cephadm ls` status] ***************************** 2026-04-28 06:03:00.689078 | instance | Tuesday 28 April 2026 06:03:00 +0000 (0:00:00.047) 0:02:53.993 ********* 2026-04-28 06:03:05.959699 | instance | ok: [instance] 2026-04-28 06:03:05.959928 | instance | 2026-04-28 06:03:05.960246 | instance | TASK [vexxhost.ceph.osd : Parse the `cephadm ls` output] *********************** 2026-04-28 06:03:05.960513 | instance | Tuesday 28 April 2026 06:03:05 +0000 (0:00:05.271) 0:02:59.264 ********* 2026-04-28 06:03:06.008782 | instance | ok: [instance] 2026-04-28 06:03:06.009007 | instance | 2026-04-28 06:03:06.009274 | instance | TASK [Install Ceph host] ******************************************************* 2026-04-28 06:03:06.009551 | instance | Tuesday 28 April 2026 06:03:06 +0000 (0:00:00.049) 0:02:59.313 ********* 2026-04-28 06:03:06.070727 | instance | included: vexxhost.ceph.cephadm_host for instance 2026-04-28 06:03:06.070981 | instance | 2026-04-28 06:03:06.071294 | instance | TASK [vexxhost.ceph.cephadm_host : Get public SSH key for "cephadm" user] ****** 2026-04-28 06:03:06.071563 | instance | Tuesday 28 April 2026 06:03:06 +0000 (0:00:00.062) 0:02:59.375 ********* 2026-04-28 06:03:06.110955 | instance | skipping: [instance] 2026-04-28 06:03:06.111232 | instance | 2026-04-28 06:03:06.111511 | instance | TASK [vexxhost.ceph.cephadm_host : Set fact with public SSH key for "cephadm" user] *** 2026-04-28 06:03:06.111774 | instance | Tuesday 28 April 2026 06:03:06 +0000 (0:00:00.040) 0:02:59.416 ********* 2026-04-28 06:03:06.154242 | instance | skipping: [instance] => (item=instance) 2026-04-28 06:03:06.154480 | instance | skipping: [instance] 2026-04-28 06:03:06.154724 | instance | 2026-04-28 06:03:06.155033 | instance | TASK [vexxhost.ceph.cephadm_host : Set authorized key for "cephadm"] *********** 2026-04-28 06:03:06.155306 | instance | Tuesday 28 April 2026 06:03:06 +0000 (0:00:00.043) 0:02:59.459 ********* 2026-04-28 06:03:06.402797 | instance | ok: [instance] 2026-04-28 06:03:06.402947 | instance | 2026-04-28 06:03:06.403255 | instance | TASK [vexxhost.ceph.cephadm_host : Add new host to Ceph] *********************** 2026-04-28 06:03:06.403529 | instance | Tuesday 28 April 2026 06:03:06 +0000 (0:00:00.248) 0:02:59.707 ********* 2026-04-28 06:03:08.086785 | instance | ok: [instance] 2026-04-28 06:03:08.087131 | instance | 2026-04-28 06:03:08.087519 | instance | TASK [vexxhost.ceph.osd : Adopt OSDs to cluster] ******************************* 2026-04-28 06:03:08.087841 | instance | Tuesday 28 April 2026 06:03:08 +0000 (0:00:01.683) 0:03:01.391 ********* 2026-04-28 06:03:08.114693 | instance | skipping: [instance] 2026-04-28 06:03:08.114979 | instance | 2026-04-28 06:03:08.115326 | instance | TASK [vexxhost.ceph.osd : Wait until OSD added to cephadm] ********************* 2026-04-28 06:03:08.115632 | instance | Tuesday 28 April 2026 06:03:08 +0000 (0:00:00.028) 0:03:01.419 ********* 2026-04-28 06:03:08.141163 | instance | skipping: [instance] 2026-04-28 06:03:08.141459 | instance | 2026-04-28 06:03:08.141783 | instance | TASK [vexxhost.ceph.osd : Ensure all OSDs are non-legacy] ********************** 2026-04-28 06:03:08.142084 | instance | Tuesday 28 April 2026 06:03:08 +0000 (0:00:00.026) 0:03:01.446 ********* 2026-04-28 06:03:13.394249 | instance | ok: [instance] 2026-04-28 06:03:13.394313 | instance | 2026-04-28 06:03:13.394325 | instance | TASK [vexxhost.ceph.osd : Get `ceph-volume lvm list` status] ******************* 2026-04-28 06:03:13.394334 | instance | Tuesday 28 April 2026 06:03:13 +0000 (0:00:05.251) 0:03:06.698 ********* 2026-04-28 06:03:23.395973 | instance | ok: [instance] 2026-04-28 06:03:23.396423 | instance | 2026-04-28 06:03:23.396466 | instance | TASK [vexxhost.ceph.osd : Install OSDs] **************************************** 2026-04-28 06:03:23.396473 | instance | Tuesday 28 April 2026 06:03:23 +0000 (0:00:10.002) 0:03:16.700 ********* 2026-04-28 06:04:43.811111 | instance | ok: [instance] => (item=/dev/ceph-instance-osd0/data) 2026-04-28 06:04:43.811206 | instance | ok: [instance] => (item=/dev/ceph-instance-osd1/data) 2026-04-28 06:04:43.811334 | instance | ok: [instance] => (item=/dev/ceph-instance-osd2/data) 2026-04-28 06:04:43.811450 | instance | 2026-04-28 06:04:43.811580 | instance | TASK [vexxhost.ceph.osd : Get mon dump] **************************************** 2026-04-28 06:04:43.811709 | instance | Tuesday 28 April 2026 06:04:43 +0000 (0:01:20.415) 0:04:37.116 ********* 2026-04-28 06:04:45.665402 | instance | ok: [instance] 2026-04-28 06:04:45.665491 | instance | 2026-04-28 06:04:45.665749 | instance | TASK [vexxhost.ceph.osd : Mark require osd release] **************************** 2026-04-28 06:04:45.665786 | instance | Tuesday 28 April 2026 06:04:45 +0000 (0:00:01.854) 0:04:38.970 ********* 2026-04-28 06:04:47.276907 | instance | ok: [instance] 2026-04-28 06:04:47.277008 | instance | 2026-04-28 06:04:47.277021 | instance | TASK [vexxhost.ceph.osd : Wait for all OSD to be running] ********************** 2026-04-28 06:04:47.277169 | instance | Tuesday 28 April 2026 06:04:47 +0000 (0:00:01.611) 0:04:40.581 ********* 2026-04-28 06:04:47.336957 | instance | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/ceph/roles/osd/tasks/check-osds.yml for instance 2026-04-28 06:04:47.337035 | instance | 2026-04-28 06:04:47.337261 | instance | TASK [vexxhost.ceph.osd : Set the retry count] ********************************* 2026-04-28 06:04:47.337297 | instance | Tuesday 28 April 2026 06:04:47 +0000 (0:00:00.060) 0:04:40.642 ********* 2026-04-28 06:04:47.391825 | instance | ok: [instance] 2026-04-28 06:04:47.391900 | instance | 2026-04-28 06:04:47.392126 | instance | TASK [vexxhost.ceph.osd : Get `ceph orch ps`] ********************************** 2026-04-28 06:04:47.392208 | instance | Tuesday 28 April 2026 06:04:47 +0000 (0:00:00.054) 0:04:40.696 ********* 2026-04-28 06:04:48.798622 | instance | ok: [instance] 2026-04-28 06:04:48.798862 | instance | 2026-04-28 06:04:48.799460 | instance | TASK [vexxhost.ceph.osd : OSD daemon list] ************************************* 2026-04-28 06:04:48.799512 | instance | Tuesday 28 April 2026 06:04:48 +0000 (0:00:01.406) 0:04:42.103 ********* 2026-04-28 06:04:48.841715 | instance | ok: [instance] 2026-04-28 06:04:48.841809 | instance | 2026-04-28 06:04:48.841933 | instance | TASK [vexxhost.ceph.osd : Fail if any OSD not running] ************************* 2026-04-28 06:04:48.842064 | instance | Tuesday 28 April 2026 06:04:48 +0000 (0:00:00.043) 0:04:42.146 ********* 2026-04-28 06:04:48.893111 | instance | skipping: [instance] => (item=1) 2026-04-28 06:04:48.893283 | instance | skipping: [instance] => (item=1) 2026-04-28 06:04:48.893462 | instance | skipping: [instance] => (item=1) 2026-04-28 06:04:48.893639 | instance | skipping: [instance] 2026-04-28 06:04:48.893809 | instance | 2026-04-28 06:04:48.893992 | instance | TASK [vexxhost.ceph.osd : Fail if any duplicate OSD ID] ************************ 2026-04-28 06:04:48.894175 | instance | Tuesday 28 April 2026 06:04:48 +0000 (0:00:00.051) 0:04:42.198 ********* 2026-04-28 06:04:48.933073 | instance | skipping: [instance] 2026-04-28 06:04:48.933335 | instance | 2026-04-28 06:04:48.933638 | instance | PLAY [all] ********************************************************************* 2026-04-28 06:04:48.934575 | instance | 2026-04-28 06:04:48.934593 | instance | TASK [Ensure RBD kernel module is loaded] ************************************** 2026-04-28 06:04:48.934604 | instance | Tuesday 28 April 2026 06:04:48 +0000 (0:00:00.039) 0:04:42.237 ********* 2026-04-28 06:04:49.279504 | instance | changed: [instance] 2026-04-28 06:04:49.280653 | instance | 2026-04-28 06:04:49.280767 | instance | PLAY [all] ********************************************************************* 2026-04-28 06:04:49.280774 | instance | 2026-04-28 06:04:49.280778 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-28 06:04:49.280783 | instance | Tuesday 28 April 2026 06:04:49 +0000 (0:00:00.346) 0:04:42.584 ********* 2026-04-28 06:04:50.205873 | instance | ok: [instance] 2026-04-28 06:04:50.206086 | instance | 2026-04-28 06:04:50.206378 | instance | TASK [vexxhost.atmosphere.sysctl : Configure sysctl values] ******************** 2026-04-28 06:04:50.206680 | instance | Tuesday 28 April 2026 06:04:50 +0000 (0:00:00.926) 0:04:43.510 ********* 2026-04-28 06:04:55.853364 | instance | changed: [instance] => (item={'name': 'fs.aio-max-nr', 'value': 1048576}) 2026-04-28 06:04:55.853630 | instance | changed: [instance] => (item={'name': 'net.ipv4.tcp_timestamps', 'value': 0}) 2026-04-28 06:04:55.853931 | instance | changed: [instance] => (item={'name': 'net.ipv4.tcp_sack', 'value': 1}) 2026-04-28 06:04:55.854206 | instance | changed: [instance] => (item={'name': 'net.core.netdev_budget', 'value': 1000}) 2026-04-28 06:04:55.854493 | instance | changed: [instance] => (item={'name': 'net.core.netdev_max_backlog', 'value': 250000}) 2026-04-28 06:04:55.854772 | instance | changed: [instance] => (item={'name': 'net.core.rmem_max', 'value': 4194304}) 2026-04-28 06:04:55.855048 | instance | changed: [instance] => (item={'name': 'net.core.wmem_max', 'value': 4194304}) 2026-04-28 06:04:55.855487 | instance | changed: [instance] => (item={'name': 'net.core.rmem_default', 'value': 4194304}) 2026-04-28 06:04:55.855771 | instance | changed: [instance] => (item={'name': 'net.core.wmem_default', 'value': 4194304}) 2026-04-28 06:04:55.856047 | instance | changed: [instance] => (item={'name': 'net.core.optmem_max', 'value': 4194304}) 2026-04-28 06:04:55.856326 | instance | changed: [instance] => (item={'name': 'net.ipv4.tcp_rmem', 'value': '4096 87380 4194304'}) 2026-04-28 06:04:55.856506 | instance | changed: [instance] => (item={'name': 'net.ipv4.tcp_wmem', 'value': '4096 65536 4194304'}) 2026-04-28 06:04:55.856676 | instance | changed: [instance] => (item={'name': 'net.ipv4.tcp_low_latency', 'value': 1}) 2026-04-28 06:04:55.856847 | instance | changed: [instance] => (item={'name': 'net.ipv4.tcp_adv_win_scale', 'value': 1}) 2026-04-28 06:04:55.857021 | instance | changed: [instance] => (item={'name': 'net.ipv4.neigh.default.gc_thresh1', 'value': 128}) 2026-04-28 06:04:55.857193 | instance | changed: [instance] => (item={'name': 'net.ipv4.neigh.default.gc_thresh2', 'value': 28872}) 2026-04-28 06:04:55.857359 | instance | changed: [instance] => (item={'name': 'net.ipv4.neigh.default.gc_thresh3', 'value': 32768}) 2026-04-28 06:04:55.857530 | instance | changed: [instance] => (item={'name': 'net.ipv6.neigh.default.gc_thresh1', 'value': 128}) 2026-04-28 06:04:55.857701 | instance | changed: [instance] => (item={'name': 'net.ipv6.neigh.default.gc_thresh2', 'value': 28872}) 2026-04-28 06:04:55.857873 | instance | changed: [instance] => (item={'name': 'net.ipv6.neigh.default.gc_thresh3', 'value': 32768}) 2026-04-28 06:04:55.858032 | instance | 2026-04-28 06:04:55.858207 | instance | TASK [vexxhost.atmosphere.ethtool : Create folder for persistent configuration] *** 2026-04-28 06:04:55.858373 | instance | Tuesday 28 April 2026 06:04:55 +0000 (0:00:05.647) 0:04:49.158 ********* 2026-04-28 06:04:56.048806 | instance | changed: [instance] 2026-04-28 06:04:56.049186 | instance | 2026-04-28 06:04:56.049562 | instance | TASK [vexxhost.atmosphere.ethtool : Install persistent "ethtool" tuning] ******* 2026-04-28 06:04:56.049919 | instance | Tuesday 28 April 2026 06:04:56 +0000 (0:00:00.195) 0:04:49.353 ********* 2026-04-28 06:04:56.493728 | instance | changed: [instance] 2026-04-28 06:04:56.493954 | instance | 2026-04-28 06:04:56.494243 | instance | TASK [vexxhost.atmosphere.ethtool : Run "ethtool" tuning] ********************** 2026-04-28 06:04:56.494530 | instance | Tuesday 28 April 2026 06:04:56 +0000 (0:00:00.444) 0:04:49.798 ********* 2026-04-28 06:04:56.744518 | instance | ok: [instance] 2026-04-28 06:04:56.744761 | instance | 2026-04-28 06:04:56.745135 | instance | TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-04-28 06:04:56.745469 | instance | Tuesday 28 April 2026 06:04:56 +0000 (0:00:00.251) 0:04:50.049 ********* 2026-04-28 06:04:56.798118 | instance | ok: [instance] 2026-04-28 06:04:56.798346 | instance | 2026-04-28 06:04:56.798613 | instance | PLAY [Configure Kubernetes VIP] ************************************************ 2026-04-28 06:04:56.798856 | instance | 2026-04-28 06:04:56.799149 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-28 06:04:56.799413 | instance | Tuesday 28 April 2026 06:04:56 +0000 (0:00:00.053) 0:04:50.103 ********* 2026-04-28 06:04:57.683236 | instance | ok: [instance] 2026-04-28 06:04:57.683523 | instance | 2026-04-28 06:04:57.683859 | instance | TASK [vexxhost.containers.directory : Create directory (/etc/kubernetes/manifests)] *** 2026-04-28 06:04:57.684141 | instance | Tuesday 28 April 2026 06:04:57 +0000 (0:00:00.884) 0:04:50.987 ********* 2026-04-28 06:04:57.914500 | instance | changed: [instance] 2026-04-28 06:04:57.914698 | instance | 2026-04-28 06:04:57.914712 | instance | TASK [vexxhost.kubernetes.kube_vip : Uninstall legacy HA stack] **************** 2026-04-28 06:04:57.914789 | instance | Tuesday 28 April 2026 06:04:57 +0000 (0:00:00.231) 0:04:51.219 ********* 2026-04-28 06:04:58.871486 | instance | ok: [instance] => (item=/etc/keepalived/keepalived.conf) 2026-04-28 06:04:58.873126 | instance | ok: [instance] => (item=/etc/keepalived/check_apiserver.sh) 2026-04-28 06:04:58.873145 | instance | ok: [instance] => (item=/etc/kubernetes/manifests/keepalived.yaml) 2026-04-28 06:04:58.873155 | instance | ok: [instance] => (item=/etc/haproxy/haproxy.cfg) 2026-04-28 06:04:58.873165 | instance | ok: [instance] => (item=/etc/kubernetes/manifests/haproxy.yaml) 2026-04-28 06:04:58.873174 | instance | 2026-04-28 06:04:58.873184 | instance | TASK [vexxhost.kubernetes.kube_vip : Switch API server to run on port 6443] **** 2026-04-28 06:04:58.873445 | instance | Tuesday 28 April 2026 06:04:58 +0000 (0:00:00.956) 0:04:52.176 ********* 2026-04-28 06:04:59.042511 | instance | failed: [instance] (item=/etc/kubernetes/manifests/kube-apiserver.yaml) => {"ansible_loop_var": "item", "changed": false, "item": "/etc/kubernetes/manifests/kube-apiserver.yaml", "msg": "Path /etc/kubernetes/manifests/kube-apiserver.yaml does not exist !", "rc": 257} 2026-04-28 06:04:59.189308 | instance | failed: [instance] (item=/etc/kubernetes/controller-manager.conf) => {"ansible_loop_var": "item", "changed": false, "item": "/etc/kubernetes/controller-manager.conf", "msg": "Path /etc/kubernetes/controller-manager.conf does not exist !", "rc": 257} 2026-04-28 06:04:59.340569 | instance | failed: [instance] (item=/etc/kubernetes/scheduler.conf) => {"ansible_loop_var": "item", "changed": false, "item": "/etc/kubernetes/scheduler.conf", "msg": "Path /etc/kubernetes/scheduler.conf does not exist !", "rc": 257} 2026-04-28 06:04:59.350343 | instance | ...ignoring 2026-04-28 06:04:59.350508 | instance | 2026-04-28 06:04:59.350693 | instance | TASK [vexxhost.kubernetes.kube_vip : Check if super-admin.conf exists] ********* 2026-04-28 06:04:59.350873 | instance | Tuesday 28 April 2026 06:04:59 +0000 (0:00:00.479) 0:04:52.655 ********* 2026-04-28 06:04:59.539961 | instance | ok: [instance] 2026-04-28 06:04:59.540207 | instance | 2026-04-28 06:04:59.540499 | instance | TASK [vexxhost.kubernetes.kube_vip : Check if kubeadm has already run] ********* 2026-04-28 06:04:59.540785 | instance | Tuesday 28 April 2026 06:04:59 +0000 (0:00:00.188) 0:04:52.844 ********* 2026-04-28 06:04:59.735388 | instance | ok: [instance] 2026-04-28 06:04:59.735531 | instance | 2026-04-28 06:04:59.735711 | instance | TASK [vexxhost.kubernetes.kube_vip : Set fact with KUBECONFIG path] ************ 2026-04-28 06:04:59.735903 | instance | Tuesday 28 April 2026 06:04:59 +0000 (0:00:00.195) 0:04:53.040 ********* 2026-04-28 06:04:59.766484 | instance | ok: [instance] 2026-04-28 06:04:59.766677 | instance | 2026-04-28 06:04:59.766938 | instance | TASK [vexxhost.kubernetes.kube_vip : Set fact with KUBECONFIG path (with super-admin.conf)] *** 2026-04-28 06:04:59.767201 | instance | Tuesday 28 April 2026 06:04:59 +0000 (0:00:00.031) 0:04:53.071 ********* 2026-04-28 06:04:59.802740 | instance | ok: [instance] 2026-04-28 06:04:59.802996 | instance | 2026-04-28 06:04:59.803332 | instance | TASK [vexxhost.kubernetes.kube_vip : Upload Kubernetes manifest] *************** 2026-04-28 06:04:59.803619 | instance | Tuesday 28 April 2026 06:04:59 +0000 (0:00:00.036) 0:04:53.107 ********* 2026-04-28 06:05:00.306394 | instance | ok: [instance] 2026-04-28 06:05:00.306594 | instance | 2026-04-28 06:05:00.306926 | instance | TASK [vexxhost.kubernetes.kube_vip : Ensure kube-vip configuration file] ******* 2026-04-28 06:05:00.307300 | instance | Tuesday 28 April 2026 06:05:00 +0000 (0:00:00.503) 0:04:53.611 ********* 2026-04-28 06:05:00.553335 | instance | ok: [instance] 2026-04-28 06:05:00.553581 | instance | 2026-04-28 06:05:00.553876 | instance | TASK [vexxhost.kubernetes.kube_vip : Flush handlers] *************************** 2026-04-28 06:05:00.554169 | instance | Tuesday 28 April 2026 06:05:00 +0000 (0:00:00.187) 0:04:53.798 ********* 2026-04-28 06:05:00.554438 | instance | 2026-04-28 06:05:00.554734 | instance | PLAY [Install Kubernetes] ****************************************************** 2026-04-28 06:05:00.554986 | instance | 2026-04-28 06:05:00.555312 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-28 06:05:00.555605 | instance | Tuesday 28 April 2026 06:05:00 +0000 (0:00:00.059) 0:04:53.858 ********* 2026-04-28 06:05:01.426651 | instance | ok: [instance] 2026-04-28 06:05:01.426710 | instance | 2026-04-28 06:05:01.426740 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-28 06:05:01.426750 | instance | Tuesday 28 April 2026 06:05:01 +0000 (0:00:00.871) 0:04:54.729 ********* 2026-04-28 06:05:01.622851 | instance | ok: [instance] 2026-04-28 06:05:01.622949 | instance | 2026-04-28 06:05:01.623181 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-28 06:05:01.623231 | instance | Tuesday 28 April 2026 06:05:01 +0000 (0:00:00.198) 0:04:54.927 ********* 2026-04-28 06:05:01.659082 | instance | skipping: [instance] 2026-04-28 06:05:01.659137 | instance | 2026-04-28 06:05:01.659428 | instance | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-04-28 06:05:01.659468 | instance | Tuesday 28 April 2026 06:05:01 +0000 (0:00:00.036) 0:04:54.964 ********* 2026-04-28 06:05:01.851811 | instance | ok: [instance] 2026-04-28 06:05:01.851885 | instance | 2026-04-28 06:05:01.852168 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-28 06:05:01.852206 | instance | Tuesday 28 April 2026 06:05:01 +0000 (0:00:00.192) 0:04:55.157 ********* 2026-04-28 06:05:01.904881 | instance | ok: [instance] => { 2026-04-28 06:05:01.905835 | instance | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-04-28 06:05:01.905876 | instance | } 2026-04-28 06:05:01.905884 | instance | 2026-04-28 06:05:01.905890 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-28 06:05:01.905897 | instance | Tuesday 28 April 2026 06:05:01 +0000 (0:00:00.052) 0:04:55.209 ********* 2026-04-28 06:05:02.195732 | instance | ok: [instance] 2026-04-28 06:05:02.195854 | instance | 2026-04-28 06:05:02.195994 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-28 06:05:02.196114 | instance | Tuesday 28 April 2026 06:05:02 +0000 (0:00:00.291) 0:04:55.500 ********* 2026-04-28 06:05:02.238311 | instance | skipping: [instance] 2026-04-28 06:05:02.238573 | instance | 2026-04-28 06:05:02.238846 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-28 06:05:02.239138 | instance | Tuesday 28 April 2026 06:05:02 +0000 (0:00:00.042) 0:04:55.543 ********* 2026-04-28 06:05:02.431971 | instance | ok: [instance] 2026-04-28 06:05:02.432072 | instance | 2026-04-28 06:05:02.432193 | instance | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-28 06:05:02.432321 | instance | Tuesday 28 April 2026 06:05:02 +0000 (0:00:00.193) 0:04:55.737 ********* 2026-04-28 06:05:03.404679 | instance | ok: [instance] 2026-04-28 06:05:03.404984 | instance | 2026-04-28 06:05:03.405334 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-28 06:05:03.405640 | instance | Tuesday 28 April 2026 06:05:03 +0000 (0:00:00.972) 0:04:56.709 ********* 2026-04-28 06:05:03.463177 | instance | ok: [instance] => { 2026-04-28 06:05:03.463267 | instance | "msg": "https://github.com/containerd/containerd/releases/download/v2.2.3/containerd-2.2.3-linux-amd64.tar.gz" 2026-04-28 06:05:03.463287 | instance | } 2026-04-28 06:05:03.464059 | instance | 2026-04-28 06:05:03.464311 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-28 06:05:03.464326 | instance | Tuesday 28 April 2026 06:05:03 +0000 (0:00:00.057) 0:04:56.767 ********* 2026-04-28 06:05:03.807768 | instance | ok: [instance] 2026-04-28 06:05:03.807860 | instance | 2026-04-28 06:05:03.808178 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-28 06:05:03.808220 | instance | Tuesday 28 April 2026 06:05:03 +0000 (0:00:00.345) 0:04:57.112 ********* 2026-04-28 06:05:05.760255 | instance | ok: [instance] 2026-04-28 06:05:05.760317 | instance | 2026-04-28 06:05:05.760626 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-04-28 06:05:05.760662 | instance | Tuesday 28 April 2026 06:05:05 +0000 (0:00:01.952) 0:04:59.065 ********* 2026-04-28 06:05:05.793158 | instance | skipping: [instance] 2026-04-28 06:05:05.793509 | instance | 2026-04-28 06:05:05.793531 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-04-28 06:05:05.793537 | instance | Tuesday 28 April 2026 06:05:05 +0000 (0:00:00.032) 0:04:59.098 ********* 2026-04-28 06:05:05.825398 | instance | skipping: [instance] 2026-04-28 06:05:05.825495 | instance | 2026-04-28 06:05:05.825767 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-04-28 06:05:05.825802 | instance | Tuesday 28 April 2026 06:05:05 +0000 (0:00:00.032) 0:04:59.130 ********* 2026-04-28 06:05:05.855444 | instance | skipping: [instance] 2026-04-28 06:05:05.855956 | instance | 2026-04-28 06:05:05.855981 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-04-28 06:05:05.855989 | instance | Tuesday 28 April 2026 06:05:05 +0000 (0:00:00.029) 0:04:59.160 ********* 2026-04-28 06:05:06.832180 | instance | ok: [instance] 2026-04-28 06:05:06.832276 | instance | 2026-04-28 06:05:06.832537 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] *** 2026-04-28 06:05:06.832573 | instance | Tuesday 28 April 2026 06:05:06 +0000 (0:00:00.976) 0:05:00.137 ********* 2026-04-28 06:05:07.242713 | instance | ok: [instance] 2026-04-28 06:05:07.243260 | instance | 2026-04-28 06:05:07.243479 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] ******* 2026-04-28 06:05:07.243488 | instance | Tuesday 28 April 2026 06:05:07 +0000 (0:00:00.410) 0:05:00.547 ********* 2026-04-28 06:05:08.125035 | instance | ok: [instance] => (item={'path': '/etc/containerd'}) 2026-04-28 06:05:08.125117 | instance | ok: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'}) 2026-04-28 06:05:08.125889 | instance | ok: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'}) 2026-04-28 06:05:08.125930 | instance | ok: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'}) 2026-04-28 06:05:08.125936 | instance | ok: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'}) 2026-04-28 06:05:08.125941 | instance | 2026-04-28 06:05:08.125945 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] ********** 2026-04-28 06:05:08.125950 | instance | Tuesday 28 April 2026 06:05:08 +0000 (0:00:00.882) 0:05:01.430 ********* 2026-04-28 06:05:08.645613 | instance | ok: [instance] 2026-04-28 06:05:08.645679 | instance | 2026-04-28 06:05:08.646358 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ******** 2026-04-28 06:05:08.646401 | instance | Tuesday 28 April 2026 06:05:08 +0000 (0:00:00.513) 0:05:01.943 ********* 2026-04-28 06:05:08.646407 | instance | 2026-04-28 06:05:08.646413 | instance | TASK [vexxhost.containers.containerd : Enable and start service] *************** 2026-04-28 06:05:08.646417 | instance | Tuesday 28 April 2026 06:05:08 +0000 (0:00:00.007) 0:05:01.950 ********* 2026-04-28 06:05:09.002077 | instance | ok: [instance] 2026-04-28 06:05:09.002167 | instance | 2026-04-28 06:05:09.002417 | instance | TASK [vexxhost.kubernetes.kubernetes_upgrade_check : Retrieve the "kubeadm-config" ConfigMap] *** 2026-04-28 06:05:09.002433 | instance | Tuesday 28 April 2026 06:05:08 +0000 (0:00:00.356) 0:05:02.307 ********* 2026-04-28 06:05:09.516528 | instance | fatal: [instance]: FAILED! => {"changed": false, "msg": "Failed to import the required Python library (kubernetes) on instance's Python /usr/bin/python3.10. Please read the module documentation and install it in the appropriate location. If the required library is installed, but Ansible is using the wrong Python interpreter, please consult the documentation on ansible_python_interpreter"} 2026-04-28 06:05:09.528489 | instance | ...ignoring 2026-04-28 06:05:09.528724 | instance | 2026-04-28 06:05:09.529010 | instance | TASK [vexxhost.kubernetes.kubernetes_upgrade_check : Parse the ClusterConfiguration] *** 2026-04-28 06:05:09.529358 | instance | Tuesday 28 April 2026 06:05:09 +0000 (0:00:00.526) 0:05:02.833 ********* 2026-04-28 06:05:09.565752 | instance | skipping: [instance] 2026-04-28 06:05:09.566006 | instance | 2026-04-28 06:05:09.566289 | instance | TASK [vexxhost.kubernetes.kubernetes_upgrade_check : Retrieve the current Kubernetes version] *** 2026-04-28 06:05:09.566558 | instance | Tuesday 28 April 2026 06:05:09 +0000 (0:00:00.037) 0:05:02.870 ********* 2026-04-28 06:05:09.590384 | instance | skipping: [instance] 2026-04-28 06:05:09.590872 | instance | 2026-04-28 06:05:09.591211 | instance | TASK [vexxhost.kubernetes.kubernetes_upgrade_check : Extract major, minor, and patch versions] *** 2026-04-28 06:05:09.591502 | instance | Tuesday 28 April 2026 06:05:09 +0000 (0:00:00.024) 0:05:02.895 ********* 2026-04-28 06:05:09.623188 | instance | skipping: [instance] 2026-04-28 06:05:09.623443 | instance | 2026-04-28 06:05:09.623722 | instance | TASK [vexxhost.kubernetes.kubernetes_upgrade_check : Fail if we're jumping more than one minor version] *** 2026-04-28 06:05:09.624020 | instance | Tuesday 28 April 2026 06:05:09 +0000 (0:00:00.032) 0:05:02.928 ********* 2026-04-28 06:05:09.652958 | instance | skipping: [instance] 2026-04-28 06:05:09.653180 | instance | 2026-04-28 06:05:09.653456 | instance | TASK [vexxhost.kubernetes.kubernetes_upgrade_check : Set fact if we need to upgrade] *** 2026-04-28 06:05:09.653725 | instance | Tuesday 28 April 2026 06:05:09 +0000 (0:00:00.029) 0:05:02.957 ********* 2026-04-28 06:05:09.691664 | instance | skipping: [instance] 2026-04-28 06:05:09.691905 | instance | 2026-04-28 06:05:09.692172 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-28 06:05:09.692439 | instance | Tuesday 28 April 2026 06:05:09 +0000 (0:00:00.039) 0:05:02.996 ********* 2026-04-28 06:05:09.892873 | instance | ok: [instance] 2026-04-28 06:05:09.893122 | instance | 2026-04-28 06:05:09.893391 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-28 06:05:09.893655 | instance | Tuesday 28 April 2026 06:05:09 +0000 (0:00:00.201) 0:05:03.197 ********* 2026-04-28 06:05:09.933134 | instance | ok: [instance] => { 2026-04-28 06:05:09.933393 | instance | "msg": "https://dl.k8s.io/release/v1.28.13/bin/linux/amd64/kubeadm" 2026-04-28 06:05:09.933646 | instance | } 2026-04-28 06:05:09.933886 | instance | 2026-04-28 06:05:09.934146 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-28 06:05:09.934354 | instance | Tuesday 28 April 2026 06:05:09 +0000 (0:00:00.040) 0:05:03.238 ********* 2026-04-28 06:05:10.661831 | instance | changed: [instance] 2026-04-28 06:05:10.662072 | instance | 2026-04-28 06:05:10.662345 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-28 06:05:10.662610 | instance | Tuesday 28 April 2026 06:05:10 +0000 (0:00:00.728) 0:05:03.966 ********* 2026-04-28 06:05:10.705044 | instance | skipping: [instance] 2026-04-28 06:05:10.705286 | instance | 2026-04-28 06:05:10.705547 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-28 06:05:10.705819 | instance | Tuesday 28 April 2026 06:05:10 +0000 (0:00:00.043) 0:05:04.010 ********* 2026-04-28 06:05:10.906669 | instance | ok: [instance] 2026-04-28 06:05:10.906928 | instance | 2026-04-28 06:05:10.907255 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-28 06:05:10.907529 | instance | Tuesday 28 April 2026 06:05:10 +0000 (0:00:00.200) 0:05:04.211 ********* 2026-04-28 06:05:10.952124 | instance | ok: [instance] => { 2026-04-28 06:05:10.952385 | instance | "msg": "https://dl.k8s.io/release/v1.28.13/bin/linux/amd64/kubectl" 2026-04-28 06:05:10.952664 | instance | } 2026-04-28 06:05:10.952930 | instance | 2026-04-28 06:05:10.953229 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-28 06:05:10.953511 | instance | Tuesday 28 April 2026 06:05:10 +0000 (0:00:00.045) 0:05:04.256 ********* 2026-04-28 06:05:11.707158 | instance | changed: [instance] 2026-04-28 06:05:11.707220 | instance | 2026-04-28 06:05:11.707615 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-28 06:05:11.707688 | instance | Tuesday 28 April 2026 06:05:11 +0000 (0:00:00.754) 0:05:05.011 ********* 2026-04-28 06:05:11.763648 | instance | skipping: [instance] 2026-04-28 06:05:11.763743 | instance | 2026-04-28 06:05:11.764070 | instance | TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-04-28 06:05:11.764350 | instance | Tuesday 28 April 2026 06:05:11 +0000 (0:00:00.057) 0:05:05.068 ********* 2026-04-28 06:05:11.797199 | instance | skipping: [instance] 2026-04-28 06:05:11.797563 | instance | 2026-04-28 06:05:11.797589 | instance | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-04-28 06:05:11.797595 | instance | Tuesday 28 April 2026 06:05:11 +0000 (0:00:00.033) 0:05:05.102 ********* 2026-04-28 06:05:11.831624 | instance | skipping: [instance] 2026-04-28 06:05:11.832163 | instance | 2026-04-28 06:05:11.832192 | instance | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-04-28 06:05:11.832213 | instance | Tuesday 28 April 2026 06:05:11 +0000 (0:00:00.034) 0:05:05.136 ********* 2026-04-28 06:05:11.868057 | instance | skipping: [instance] 2026-04-28 06:05:11.868151 | instance | 2026-04-28 06:05:11.868275 | instance | TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-04-28 06:05:11.868396 | instance | Tuesday 28 April 2026 06:05:11 +0000 (0:00:00.036) 0:05:05.173 ********* 2026-04-28 06:05:12.864244 | instance | ok: [instance] 2026-04-28 06:05:12.864818 | instance | 2026-04-28 06:05:12.864866 | instance | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] *** 2026-04-28 06:05:12.864876 | instance | Tuesday 28 April 2026 06:05:12 +0000 (0:00:00.995) 0:05:06.168 ********* 2026-04-28 06:05:13.281312 | instance | ok: [instance] 2026-04-28 06:05:13.281842 | instance | 2026-04-28 06:05:13.281880 | instance | TASK [vexxhost.containers.containerd : Create folders for configuration] ******* 2026-04-28 06:05:13.281888 | instance | Tuesday 28 April 2026 06:05:13 +0000 (0:00:00.417) 0:05:06.586 ********* 2026-04-28 06:05:14.171329 | instance | ok: [instance] => (item={'path': '/etc/containerd'}) 2026-04-28 06:05:14.171545 | instance | ok: [instance] => (item={'path': '/var/lib/containerd', 'mode': '0o700'}) 2026-04-28 06:05:14.171562 | instance | ok: [instance] => (item={'path': '/run/containerd', 'mode': '0o711'}) 2026-04-28 06:05:14.171575 | instance | ok: [instance] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'}) 2026-04-28 06:05:14.172123 | instance | ok: [instance] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'}) 2026-04-28 06:05:14.172178 | instance | 2026-04-28 06:05:14.172184 | instance | TASK [vexxhost.containers.containerd : Create containerd config file] ********** 2026-04-28 06:05:14.172190 | instance | Tuesday 28 April 2026 06:05:14 +0000 (0:00:00.890) 0:05:07.476 ********* 2026-04-28 06:05:14.691756 | instance | ok: [instance] 2026-04-28 06:05:14.691857 | instance | 2026-04-28 06:05:14.692477 | instance | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ******** 2026-04-28 06:05:14.692509 | instance | Tuesday 28 April 2026 06:05:14 +0000 (0:00:00.513) 0:05:07.989 ********* 2026-04-28 06:05:14.692515 | instance | 2026-04-28 06:05:14.692520 | instance | TASK [vexxhost.containers.containerd : Enable and start service] *************** 2026-04-28 06:05:14.692524 | instance | Tuesday 28 April 2026 06:05:14 +0000 (0:00:00.007) 0:05:07.996 ********* 2026-04-28 06:05:15.015896 | instance | ok: [instance] 2026-04-28 06:05:15.015961 | instance | 2026-04-28 06:05:15.016246 | instance | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-28 06:05:15.016283 | instance | Tuesday 28 April 2026 06:05:15 +0000 (0:00:00.324) 0:05:08.320 ********* 2026-04-28 06:05:15.207587 | instance | ok: [instance] 2026-04-28 06:05:15.207700 | instance | 2026-04-28 06:05:15.207981 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-28 06:05:15.208018 | instance | Tuesday 28 April 2026 06:05:15 +0000 (0:00:00.191) 0:05:08.512 ********* 2026-04-28 06:05:15.256940 | instance | ok: [instance] => { 2026-04-28 06:05:15.257056 | instance | "msg": "https://github.com/kubernetes-sigs/cri-tools/releases/download/v1.35.0/crictl-v1.35.0-linux-amd64.tar.gz" 2026-04-28 06:05:15.257520 | instance | } 2026-04-28 06:05:15.257539 | instance | 2026-04-28 06:05:15.257544 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-28 06:05:15.257550 | instance | Tuesday 28 April 2026 06:05:15 +0000 (0:00:00.049) 0:05:08.562 ********* 2026-04-28 06:05:15.828216 | instance | changed: [instance] 2026-04-28 06:05:15.828268 | instance | 2026-04-28 06:05:15.828548 | instance | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-28 06:05:15.828582 | instance | Tuesday 28 April 2026 06:05:15 +0000 (0:00:00.571) 0:05:09.133 ********* 2026-04-28 06:05:17.180008 | instance | changed: [instance] 2026-04-28 06:05:17.180045 | instance | 2026-04-28 06:05:17.180051 | instance | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-28 06:05:17.180055 | instance | Tuesday 28 April 2026 06:05:17 +0000 (0:00:01.351) 0:05:10.484 ********* 2026-04-28 06:05:17.231813 | instance | ok: [instance] => { 2026-04-28 06:05:17.232411 | instance | "msg": "https://github.com/kubernetes-sigs/cri-tools/releases/download/v1.35.0/critest-v1.35.0-linux-amd64.tar.gz" 2026-04-28 06:05:17.232621 | instance | } 2026-04-28 06:05:17.232627 | instance | 2026-04-28 06:05:17.232632 | instance | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-28 06:05:17.232636 | instance | Tuesday 28 April 2026 06:05:17 +0000 (0:00:00.051) 0:05:10.536 ********* 2026-04-28 06:05:38.871513 | instance | fatal: [instance]: FAILED! => {"attempts": 4, "censored": "the output has been hidden due to the fact that 'no_log: true' was specified for this result", "changed": false} 2026-04-28 06:05:38.875254 | instance | FAILED - RETRYING: [instance]: Download item (4 retries left). 2026-04-28 06:05:38.875537 | instance | FAILED - RETRYING: [instance]: Download item (3 retries left). 2026-04-28 06:05:38.875794 | instance | FAILED - RETRYING: [instance]: Download item (2 retries left). 2026-04-28 06:05:38.876170 | instance | FAILED - RETRYING: [instance]: Download item (1 retries left). 2026-04-28 06:05:38.876427 | instance | 2026-04-28 06:05:38.876680 | instance | PLAY RECAP ********************************************************************* 2026-04-28 06:05:38.876963 | instance | instance : ok=163 changed=35 unreachable=0 failed=1 skipped=42 rescued=0 ignored=2 2026-04-28 06:05:38.877200 | instance | 2026-04-28 06:05:38.877461 | instance | Tuesday 28 April 2026 06:05:38 +0000 (0:00:21.643) 0:05:32.180 ********* 2026-04-28 06:05:38.877705 | instance | =============================================================================== 2026-04-28 06:05:38.877966 | instance | vexxhost.ceph.mon : Run Bootstrap coomand ------------------------------ 91.87s 2026-04-28 06:05:38.878219 | instance | vexxhost.ceph.osd : Install OSDs --------------------------------------- 80.42s 2026-04-28 06:05:38.878476 | instance | vexxhost.containers.download_artifact : Download item ------------------ 21.64s 2026-04-28 06:05:38.878733 | instance | vexxhost.ceph.mon : Validate monitor exist ----------------------------- 11.04s 2026-04-28 06:05:38.878984 | instance | vexxhost.ceph.osd : Get `ceph-volume lvm list` status ------------------ 10.00s 2026-04-28 06:05:38.879307 | instance | vexxhost.atmosphere.sysctl : Configure sysctl values -------------------- 5.65s 2026-04-28 06:05:38.879563 | instance | vexxhost.ceph.osd : Get `cephadm ls` status ----------------------------- 5.27s 2026-04-28 06:05:38.879834 | instance | vexxhost.ceph.osd : Ensure all OSDs are non-legacy ---------------------- 5.25s 2026-04-28 06:05:38.880139 | instance | vexxhost.containers.containerd : Install AppArmor packages -------------- 4.98s 2026-04-28 06:05:38.880397 | instance | vexxhost.ceph.cephadm : Install packages -------------------------------- 4.96s 2026-04-28 06:05:38.880652 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 4.22s 2026-04-28 06:05:38.880869 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 3.08s 2026-04-28 06:05:38.880982 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 2.85s 2026-04-28 06:05:38.881097 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 1.95s 2026-04-28 06:05:38.881250 | instance | vexxhost.containers.download_artifact : Extract archive ----------------- 1.94s 2026-04-28 06:05:38.881371 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 1.86s 2026-04-28 06:05:38.881485 | instance | vexxhost.ceph.osd : Get mon dump ---------------------------------------- 1.85s 2026-04-28 06:05:38.881600 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 1.84s 2026-04-28 06:05:38.881713 | instance | vexxhost.ceph.mgr : Enable the Ceph Manager prometheus module ----------- 1.72s 2026-04-28 06:05:38.881828 | instance | vexxhost.ceph.cephadm_host : Add new host to Ceph ----------------------- 1.68s 2026-04-28 06:05:38.986953 | instance | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-04-28 06:05:38.987200 | instance | ERROR [csi > converge] Executed: Failed 2026-04-28 06:05:38.987353 | instance | ERROR Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.v9Wo.csi/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/atmosphere/inventory.yaml /home/zuul/src/github.com/vexxhost/atmosphere/molecule/csi/converge.yml 2026-04-28 06:05:39.172871 | instance | ERROR 2026-04-28 06:05:39.173176 | instance | { 2026-04-28 06:05:39.173218 | instance | "delta": "0:06:46.735379", 2026-04-28 06:05:39.173247 | instance | "end": "2026-04-28 06:05:39.052077", 2026-04-28 06:05:39.173272 | instance | "msg": "non-zero return code", 2026-04-28 06:05:39.173296 | instance | "rc": 2, 2026-04-28 06:05:39.173323 | instance | "start": "2026-04-28 05:58:52.316698" 2026-04-28 06:05:39.173347 | instance | } failure 2026-04-28 06:05:39.191623 | 2026-04-28 06:05:39.191795 | PLAY RECAP 2026-04-28 06:05:39.191856 | instance | ok: 2 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-04-28 06:05:39.191879 | 2026-04-28 06:05:42.393954 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-28 06:05:42.407755 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@stable/2024.2] 2026-04-28 06:05:43.318734 | 2026-04-28 06:05:43.318859 | PLAY [all] 2026-04-28 06:05:43.333942 | 2026-04-28 06:05:43.334064 | TASK [gather-host-logs : creating directory for system status] 2026-04-28 06:05:43.684183 | instance | changed 2026-04-28 06:05:43.691411 | 2026-04-28 06:05:43.691497 | TASK [gather-host-logs : Get logs for each host] 2026-04-28 06:05:44.016817 | instance | + systemd-cgls --full --all --no-pager 2026-04-28 06:05:44.030378 | instance | + ip addr 2026-04-28 06:05:44.033670 | instance | + ip route 2026-04-28 06:05:44.035512 | instance | + lsblk 2026-04-28 06:05:44.041147 | instance | + mount 2026-04-28 06:05:44.044087 | instance | + docker images 2026-04-28 06:05:44.062804 | instance | + brctl show 2026-04-28 06:05:44.063384 | instance | /bin/bash: line 8: brctl: command not found 2026-04-28 06:05:44.063664 | instance | + ps aux --sort=-%mem 2026-04-28 06:05:44.080733 | instance | + dpkg -l 2026-04-28 06:05:44.092671 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-04-28 06:05:44.093213 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-04-28 06:05:44.112795 | instance | + '[' '!' -z '' ']' 2026-04-28 06:05:44.226960 | instance | ok: Runtime: 0:00:00.101318 2026-04-28 06:05:44.235250 | 2026-04-28 06:05:44.235347 | TASK [gather-host-logs : Downloads logs to executor] 2026-04-28 06:05:44.854121 | instance | changed: 2026-04-28 06:05:44.854339 | instance | created directory /var/lib/zuul/builds/4df78888cd1441b29369855e35a7737e/work/logs/instance 2026-04-28 06:05:44.854402 | instance | cd+++++++++ system/ 2026-04-28 06:05:44.854451 | instance | >f+++++++++ system/brctl-show.txt 2026-04-28 06:05:44.854502 | instance | >f+++++++++ system/docker-images.txt 2026-04-28 06:05:44.854569 | instance | >f+++++++++ system/ip-addr.txt 2026-04-28 06:05:44.854610 | instance | >f+++++++++ system/ip-route.txt 2026-04-28 06:05:44.854642 | instance | >f+++++++++ system/lsblk.txt 2026-04-28 06:05:44.854675 | instance | >f+++++++++ system/mount.txt 2026-04-28 06:05:44.854717 | instance | >f+++++++++ system/packages.txt 2026-04-28 06:05:44.854759 | instance | >f+++++++++ system/ps.txt 2026-04-28 06:05:44.854799 | instance | >f+++++++++ system/systemd-cgls.txt 2026-04-28 06:05:44.866848 | 2026-04-28 06:05:44.866938 | LOOP [helm-release-status : creating directory for helm release status] 2026-04-28 06:05:45.064099 | instance | changed: "values" 2026-04-28 06:05:45.229445 | instance | changed: "releases" 2026-04-28 06:05:45.248508 | 2026-04-28 06:05:45.248649 | TASK [helm-release-status : Gather get release status for helm charts] 2026-04-28 06:05:45.519441 | instance | E0428 06:05:45.519279 35760 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:45.520374 | instance | E0428 06:05:45.520344 35760 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:45.521971 | instance | E0428 06:05:45.521949 35760 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:45.522601 | instance | E0428 06:05:45.522556 35760 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:45.524177 | instance | E0428 06:05:45.524156 35760 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:45.524246 | instance | The connection to the server localhost:8080 was refused - did you specify the right host or port? 2026-04-28 06:05:45.788571 | instance | ok: Runtime: 0:00:00.068545 2026-04-28 06:05:45.795634 | 2026-04-28 06:05:45.795737 | TASK [helm-release-status : Downloads logs to executor] 2026-04-28 06:05:46.268787 | instance | changed: 2026-04-28 06:05:46.268999 | instance | cd+++++++++ helm/ 2026-04-28 06:05:46.269043 | instance | cd+++++++++ helm/releases/ 2026-04-28 06:05:46.269075 | instance | cd+++++++++ helm/values/ 2026-04-28 06:05:46.281284 | 2026-04-28 06:05:46.281365 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-04-28 06:05:46.471751 | instance | changed 2026-04-28 06:05:46.478588 | 2026-04-28 06:05:46.478664 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-04-28 06:05:46.695149 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-28 06:05:46.695616 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-28 06:05:46.702840 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-28 06:05:46.704193 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-28 06:05:46.752759 | instance | E0428 06:05:46.752645 35813 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:46.753080 | instance | E0428 06:05:46.753004 35810 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:46.753477 | instance | E0428 06:05:46.753438 35813 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:46.753644 | instance | E0428 06:05:46.753597 35810 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:46.754906 | instance | E0428 06:05:46.754866 35813 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:46.755572 | instance | E0428 06:05:46.755521 35813 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:46.756361 | instance | E0428 06:05:46.756142 35810 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:46.757040 | instance | E0428 06:05:46.756995 35810 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:46.757864 | instance | E0428 06:05:46.757830 35813 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:46.757891 | instance | The connection to the server localhost:8080 was refused - did you specify the right host or port? 2026-04-28 06:05:46.758625 | instance | E0428 06:05:46.758588 35810 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:46.758642 | instance | The connection to the server localhost:8080 was refused - did you specify the right host or port? 2026-04-28 06:05:46.763966 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-28 06:05:46.767080 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-28 06:05:46.816736 | instance | E0428 06:05:46.816656 35839 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:46.817239 | instance | E0428 06:05:46.817209 35839 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:46.817285 | instance | E0428 06:05:46.817201 35836 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:46.817783 | instance | E0428 06:05:46.817740 35836 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:46.819636 | instance | E0428 06:05:46.819581 35836 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:46.820626 | instance | E0428 06:05:46.820320 35839 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:46.820705 | instance | E0428 06:05:46.820439 35836 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:46.820979 | instance | E0428 06:05:46.820939 35839 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:46.821983 | instance | E0428 06:05:46.821947 35836 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:46.822006 | instance | The connection to the server localhost:8080 was refused - did you specify the right host or port? 2026-04-28 06:05:46.822942 | instance | E0428 06:05:46.822900 35839 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:46.823049 | instance | The connection to the server localhost:8080 was refused - did you specify the right host or port? 2026-04-28 06:05:46.831362 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-28 06:05:46.886481 | instance | E0428 06:05:46.886375 35859 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:46.887424 | instance | E0428 06:05:46.887378 35859 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:46.889294 | instance | E0428 06:05:46.889262 35859 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:46.890242 | instance | E0428 06:05:46.890181 35859 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:46.891865 | instance | E0428 06:05:46.891824 35859 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:46.891907 | instance | The connection to the server localhost:8080 was refused - did you specify the right host or port? 2026-04-28 06:05:47.013780 | instance | ok: Runtime: 0:00:00.208998 2026-04-28 06:05:47.020590 | 2026-04-28 06:05:47.020697 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-04-28 06:05:47.224116 | instance | changed 2026-04-28 06:05:47.231517 | 2026-04-28 06:05:47.231623 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-04-28 06:05:47.458507 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-28 06:05:47.459186 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-28 06:05:47.459380 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-28 06:05:47.515753 | instance | E0428 06:05:47.515633 35890 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:47.516484 | instance | E0428 06:05:47.516449 35890 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:47.517600 | instance | E0428 06:05:47.517568 35890 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:47.518244 | instance | E0428 06:05:47.518185 35890 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:47.519839 | instance | E0428 06:05:47.519817 35890 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:47.519888 | instance | The connection to the server localhost:8080 was refused - did you specify the right host or port? 2026-04-28 06:05:47.795203 | instance | ok: Runtime: 0:00:00.071558 2026-04-28 06:05:47.801779 | 2026-04-28 06:05:47.801853 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-04-28 06:05:48.313226 | instance | changed: 2026-04-28 06:05:48.313486 | instance | cd+++++++++ objects/ 2026-04-28 06:05:48.313547 | instance | cd+++++++++ objects/cluster/ 2026-04-28 06:05:48.313596 | instance | cd+++++++++ objects/namespaced/ 2026-04-28 06:05:48.324662 | 2026-04-28 06:05:48.324743 | TASK [gather-pod-logs : creating directory for pod logs] 2026-04-28 06:05:48.519838 | instance | changed 2026-04-28 06:05:48.525254 | 2026-04-28 06:05:48.525316 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-04-28 06:05:48.724099 | instance | changed 2026-04-28 06:05:48.731124 | 2026-04-28 06:05:48.731222 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-04-28 06:05:49.010190 | instance | E0428 06:05:49.010011 35940 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:49.010966 | instance | E0428 06:05:49.010923 35940 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:49.012885 | instance | E0428 06:05:49.012841 35940 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:49.013591 | instance | E0428 06:05:49.013557 35940 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:49.015438 | instance | E0428 06:05:49.015393 35940 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:49.015506 | instance | The connection to the server localhost:8080 was refused - did you specify the right host or port? 2026-04-28 06:05:49.263740 | instance | ok: Runtime: 0:00:00.066235 2026-04-28 06:05:49.270797 | 2026-04-28 06:05:49.270890 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-04-28 06:05:49.809436 | instance | changed: 2026-04-28 06:05:49.809692 | instance | cd+++++++++ pod-logs/ 2026-04-28 06:05:49.809731 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-04-28 06:05:49.821724 | 2026-04-28 06:05:49.821799 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-04-28 06:05:50.018128 | instance | changed 2026-04-28 06:05:50.024776 | 2026-04-28 06:05:50.024862 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-04-28 06:05:50.283940 | instance | E0428 06:05:50.283782 35985 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:50.284711 | instance | E0428 06:05:50.284670 35985 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:50.287674 | instance | E0428 06:05:50.287638 35985 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:50.288229 | instance | E0428 06:05:50.288206 35985 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:50.289832 | instance | E0428 06:05:50.289799 35985 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:50.289885 | instance | The connection to the server localhost:8080 was refused - did you specify the right host or port? 2026-04-28 06:05:50.561210 | instance | ok: Runtime: 0:00:00.067435 2026-04-28 06:05:50.567708 | 2026-04-28 06:05:50.567796 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-04-28 06:05:50.813970 | instance | E0428 06:05:50.813838 36023 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:50.814613 | instance | E0428 06:05:50.814561 36023 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:50.816554 | instance | E0428 06:05:50.816515 36023 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:50.817245 | instance | E0428 06:05:50.817208 36023 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:50.819013 | instance | E0428 06:05:50.818982 36023 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:50.819151 | instance | The connection to the server localhost:8080 was refused - did you specify the right host or port? 2026-04-28 06:05:50.822369 | instance | ceph-mgr endpoints: 2026-04-28 06:05:51.104396 | instance | ok: Runtime: 0:00:00.062889 2026-04-28 06:05:51.110017 | 2026-04-28 06:05:51.110094 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-04-28 06:05:51.366947 | instance | E0428 06:05:51.366820 36046 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:51.367648 | instance | E0428 06:05:51.367627 36046 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:51.369194 | instance | E0428 06:05:51.369171 36046 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:51.369565 | instance | E0428 06:05:51.369543 36046 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:51.371075 | instance | E0428 06:05:51.371021 36046 memcache.go:265] couldn't get current server API group list: Get "http://localhost:8080/api?timeout=32s": dial tcp [::1]:8080: connect: connection refused 2026-04-28 06:05:51.371109 | instance | The connection to the server localhost:8080 was refused - did you specify the right host or port? 2026-04-28 06:05:51.644295 | instance | ok: Runtime: 0:00:00.061032 2026-04-28 06:05:51.650618 | 2026-04-28 06:05:51.650727 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-04-28 06:05:52.128460 | instance | changed: cd+++++++++ prometheus/ 2026-04-28 06:05:52.142452 | 2026-04-28 06:05:52.142516 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-04-28 06:05:52.338312 | instance | changed 2026-04-28 06:05:52.345210 | 2026-04-28 06:05:52.345298 | TASK [gather-selenium-data : Get selenium data] 2026-04-28 06:05:52.560317 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-04-28 06:05:52.561948 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-04-28 06:05:52.885546 | instance | ERROR 2026-04-28 06:05:52.885773 | instance | { 2026-04-28 06:05:52.885816 | instance | "delta": "0:00:00.007056", 2026-04-28 06:05:52.885845 | instance | "end": "2026-04-28 06:05:52.562312", 2026-04-28 06:05:52.885871 | instance | "msg": "non-zero return code", 2026-04-28 06:05:52.885896 | instance | "rc": 1, 2026-04-28 06:05:52.885921 | instance | "start": "2026-04-28 06:05:52.555256" 2026-04-28 06:05:52.885945 | instance | } 2026-04-28 06:05:52.885977 | instance | ERROR: Ignoring Errors 2026-04-28 06:05:52.893660 | 2026-04-28 06:05:52.893748 | TASK [gather-selenium-data : Downloads logs to executor] 2026-04-28 06:05:53.384441 | instance | changed: cd+++++++++ selenium/ 2026-04-28 06:05:53.392802 | 2026-04-28 06:05:53.392850 | PLAY RECAP 2026-04-28 06:05:53.392894 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-04-28 06:05:53.392917 | 2026-04-28 06:05:53.503451 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@stable/2024.2] 2026-04-28 06:05:53.505625 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-28 06:05:54.136142 | 2026-04-28 06:05:54.136256 | PLAY [all] 2026-04-28 06:05:54.147744 | 2026-04-28 06:05:54.147821 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-28 06:05:54.182540 | instance | skipping: Conditional result was False 2026-04-28 06:05:54.187579 | 2026-04-28 06:05:54.187658 | TASK [fetch-output : Set log path for single node] 2026-04-28 06:05:54.225937 | instance | ok 2026-04-28 06:05:54.230369 | 2026-04-28 06:05:54.230435 | LOOP [fetch-output : Ensure local output dirs] 2026-04-28 06:05:54.609372 | instance -> localhost | ok: "/var/lib/zuul/builds/4df78888cd1441b29369855e35a7737e/work/logs" 2026-04-28 06:05:54.811400 | instance -> localhost | changed: "/var/lib/zuul/builds/4df78888cd1441b29369855e35a7737e/work/artifacts" 2026-04-28 06:05:55.011395 | instance -> localhost | changed: "/var/lib/zuul/builds/4df78888cd1441b29369855e35a7737e/work/docs" 2026-04-28 06:05:55.025553 | 2026-04-28 06:05:55.025676 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-28 06:05:55.625779 | instance | changed: .d..t...... ./ 2026-04-28 06:05:55.626035 | instance | changed: All items complete 2026-04-28 06:05:55.626082 | 2026-04-28 06:05:56.079592 | instance | changed: .d..t...... ./ 2026-04-28 06:05:56.545445 | instance | changed: .d..t...... ./ 2026-04-28 06:05:56.560483 | 2026-04-28 06:05:56.770300 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-28 06:05:57.171837 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007864 2026-04-28 06:05:57.415470 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.007901 2026-04-28 06:05:57.436616 | 2026-04-28 06:05:57.436730 | PLAY [all] 2026-04-28 06:05:57.444847 | 2026-04-28 06:05:57.444931 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-28 06:05:57.968362 | instance | changed 2026-04-28 06:05:57.976429 | 2026-04-28 06:05:57.976563 | PLAY RECAP 2026-04-28 06:05:57.976639 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-28 06:05:57.976673 | 2026-04-28 06:05:58.180008 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-28 06:05:58.184606 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-28 06:05:58.817119 | 2026-04-28 06:05:58.817455 | PLAY [localhost] 2026-04-28 06:05:58.828166 | 2026-04-28 06:05:58.828258 | TASK [Generate Zuul manifest] 2026-04-28 06:05:58.851733 | localhost | ok 2026-04-28 06:05:58.870937 | 2026-04-28 06:05:58.871093 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-28 06:05:59.225297 | localhost | changed 2026-04-28 06:05:59.238399 | 2026-04-28 06:05:59.238479 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-28 06:05:59.269170 | localhost | ok 2026-04-28 06:05:59.278108 | 2026-04-28 06:05:59.278213 | TASK [Upload logs] 2026-04-28 06:05:59.302934 | localhost | ok 2026-04-28 06:05:59.366499 | 2026-04-28 06:05:59.366647 | TASK [Set zuul-log-path fact] 2026-04-28 06:05:59.387214 | localhost | ok 2026-04-28 06:05:59.401078 | 2026-04-28 06:05:59.401200 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-28 06:05:59.432177 | localhost | ok 2026-04-28 06:05:59.441381 | 2026-04-28 06:05:59.441478 | TASK [upload-logs : Create log directories] 2026-04-28 06:05:59.904891 | localhost | changed 2026-04-28 06:05:59.911750 | 2026-04-28 06:05:59.911903 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-28 06:06:00.315892 | localhost -> localhost | ok: Runtime: 0:00:00.006274 2026-04-28 06:06:00.325001 | 2026-04-28 06:06:00.325111 | TASK [upload-logs : Upload logs to log server] 2026-04-28 06:06:00.807157 | localhost | Output suppressed because no_log was given 2026-04-28 06:06:00.814444 | 2026-04-28 06:06:00.814519 | LOOP [upload-logs : Compress console log and json output] 2026-04-28 06:06:00.858111 | localhost | skipping: Conditional result was False 2026-04-28 06:06:00.866757 | localhost | skipping: Conditional result was False 2026-04-28 06:06:00.876374 | 2026-04-28 06:06:00.885629 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-28 06:06:00.922018 | localhost | skipping: Conditional result was False 2026-04-28 06:06:00.922372 | 2026-04-28 06:06:00.926891 | localhost | skipping: Conditional result was False 2026-04-28 06:06:00.935178 | 2026-04-28 06:06:00.935308 | LOOP [upload-logs : Upload console log and json output]