2026-04-17 10:57:49.793661 | Job console starting 2026-04-17 10:57:49.814648 | Updating git repos 2026-04-17 10:57:49.888261 | Cloning repos into workspace 2026-04-17 10:57:50.109238 | Restoring repo states 2026-04-17 10:57:50.127135 | Merging changes 2026-04-17 10:57:51.217857 | Checking out repos 2026-04-17 10:57:51.324390 | Preparing playbooks 2026-04-17 10:57:53.610765 | Running Ansible setup 2026-04-17 10:57:57.014545 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-17 10:57:57.609438 | 2026-04-17 10:57:57.609562 | PLAY [localhost] 2026-04-17 10:57:57.618011 | 2026-04-17 10:57:57.618085 | TASK [Gathering Facts] 2026-04-17 10:57:58.772429 | localhost | ok 2026-04-17 10:57:58.782226 | 2026-04-17 10:57:58.782331 | TASK [Setup log path fact] 2026-04-17 10:57:58.801768 | localhost | ok 2026-04-17 10:57:58.814350 | 2026-04-17 10:57:58.814419 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-17 10:57:58.844003 | localhost | ok 2026-04-17 10:57:58.851789 | 2026-04-17 10:57:58.851861 | TASK [emit-job-header : Print job information] 2026-04-17 10:57:58.891963 | # Job Information 2026-04-17 10:57:58.892169 | Ansible Version: 2.16.16 2026-04-17 10:57:58.892213 | Job: atmosphere-molecule-csi-rbd 2026-04-17 10:57:58.892243 | Pipeline: check 2026-04-17 10:57:58.892271 | Executor: 0a8996d2b663 2026-04-17 10:57:58.892299 | Triggered by: https://github.com/vexxhost/atmosphere/pull/3834 2026-04-17 10:57:58.892331 | Event ID: 2b51c260-3a4c-11f1-9253-2a70ee49671c 2026-04-17 10:57:58.896599 | 2026-04-17 10:57:58.896700 | LOOP [emit-job-header : Print node information] 2026-04-17 10:57:58.990569 | localhost | ok: 2026-04-17 10:57:58.990915 | localhost | # Node Information 2026-04-17 10:57:58.990982 | localhost | Inventory Hostname: instance 2026-04-17 10:57:58.991035 | localhost | Hostname: np0000167117 2026-04-17 10:57:58.991083 | localhost | Username: zuul 2026-04-17 10:57:58.991140 | localhost | Distro: Ubuntu 22.04 2026-04-17 10:57:58.991200 | localhost | Provider: yul1 2026-04-17 10:57:58.991271 | localhost | Region: ca-ymq-1 2026-04-17 10:57:58.991333 | localhost | Label: ubuntu-jammy 2026-04-17 10:57:58.991379 | localhost | Product Name: OpenStack Nova 2026-04-17 10:57:58.991424 | localhost | Interface IP: 199.19.213.115 2026-04-17 10:57:59.005847 | 2026-04-17 10:57:59.006032 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-17 10:57:59.377587 | localhost -> localhost | changed 2026-04-17 10:57:59.383425 | 2026-04-17 10:57:59.383495 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-17 10:58:00.612837 | localhost -> localhost | changed 2026-04-17 10:58:00.623835 | 2026-04-17 10:58:00.623918 | PLAY [all] 2026-04-17 10:58:00.632963 | 2026-04-17 10:58:00.633065 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-17 10:58:00.866331 | instance -> localhost | ok 2026-04-17 10:58:00.876859 | 2026-04-17 10:58:00.876936 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-17 10:58:00.909367 | instance | ok 2026-04-17 10:58:00.922870 | instance | included: /var/lib/zuul/builds/55c0ca3e39284c1cabfc7950ba64d357/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-17 10:58:00.928451 | 2026-04-17 10:58:00.928513 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-17 10:58:01.753194 | instance -> localhost | Generating public/private rsa key pair. 2026-04-17 10:58:01.753360 | instance -> localhost | Your identification has been saved in /var/lib/zuul/builds/55c0ca3e39284c1cabfc7950ba64d357/work/55c0ca3e39284c1cabfc7950ba64d357_id_rsa 2026-04-17 10:58:01.753389 | instance -> localhost | Your public key has been saved in /var/lib/zuul/builds/55c0ca3e39284c1cabfc7950ba64d357/work/55c0ca3e39284c1cabfc7950ba64d357_id_rsa.pub 2026-04-17 10:58:01.753412 | instance -> localhost | The key fingerprint is: 2026-04-17 10:58:01.753435 | instance -> localhost | SHA256:214vVAFYniTHWsOfA5lTxOU59wAvllNtgfNHqVWk2uM zuul-build-sshkey 2026-04-17 10:58:01.753463 | instance -> localhost | The key's randomart image is: 2026-04-17 10:58:01.753485 | instance -> localhost | +---[RSA 3072]----+ 2026-04-17 10:58:01.753508 | instance -> localhost | | .=*B==B| 2026-04-17 10:58:01.753530 | instance -> localhost | | .=XOo==| 2026-04-17 10:58:01.753550 | instance -> localhost | | oB=OBo| 2026-04-17 10:58:01.753570 | instance -> localhost | | .. *=o=| 2026-04-17 10:58:01.753590 | instance -> localhost | | S ..o.o| 2026-04-17 10:58:01.753610 | instance -> localhost | | o .. . | 2026-04-17 10:58:01.753629 | instance -> localhost | | . ... E | 2026-04-17 10:58:01.753648 | instance -> localhost | | . ... | 2026-04-17 10:58:01.753672 | instance -> localhost | | . .. | 2026-04-17 10:58:01.753695 | instance -> localhost | +----[SHA256]-----+ 2026-04-17 10:58:01.753742 | instance -> localhost | ok: Runtime: 0:00:00.425951 2026-04-17 10:58:01.758796 | 2026-04-17 10:58:01.758859 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-17 10:58:01.791458 | instance | ok 2026-04-17 10:58:01.801576 | instance | included: /var/lib/zuul/builds/55c0ca3e39284c1cabfc7950ba64d357/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-17 10:58:01.809718 | 2026-04-17 10:58:01.809779 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-17 10:58:01.834612 | instance | skipping: Conditional result was False 2026-04-17 10:58:01.845064 | 2026-04-17 10:58:01.845147 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-17 10:58:02.285914 | instance | changed 2026-04-17 10:58:02.291689 | 2026-04-17 10:58:02.777520 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-17 10:58:02.966069 | instance | ok 2026-04-17 10:58:02.971421 | 2026-04-17 10:58:02.971483 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-17 10:58:03.441272 | instance | changed 2026-04-17 10:58:03.447886 | 2026-04-17 10:58:03.447947 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-17 10:58:03.884956 | instance | changed 2026-04-17 10:58:03.889965 | 2026-04-17 10:58:03.890030 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-17 10:58:03.914331 | instance | skipping: Conditional result was False 2026-04-17 10:58:03.924056 | 2026-04-17 10:58:03.924154 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-17 10:58:04.281571 | instance -> localhost | changed 2026-04-17 10:58:04.295589 | 2026-04-17 10:58:04.295719 | TASK [add-build-sshkey : Add back temp key] 2026-04-17 10:58:04.560988 | instance -> localhost | Identity added: /var/lib/zuul/builds/55c0ca3e39284c1cabfc7950ba64d357/work/55c0ca3e39284c1cabfc7950ba64d357_id_rsa (zuul-build-sshkey) 2026-04-17 10:58:04.561222 | instance -> localhost | ok: Runtime: 0:00:00.014709 2026-04-17 10:58:04.569241 | 2026-04-17 10:58:04.569309 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-17 10:58:04.867174 | instance | ok 2026-04-17 10:58:04.871804 | 2026-04-17 10:58:04.871865 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-17 10:58:04.897179 | instance | skipping: Conditional result was False 2026-04-17 10:58:04.907336 | 2026-04-17 10:58:04.907404 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-17 10:58:05.227063 | instance | ok 2026-04-17 10:58:05.235734 | 2026-04-17 10:58:05.235801 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-17 10:58:06.794400 | instance | Output suppressed because no_log was given 2026-04-17 10:58:06.804203 | 2026-04-17 10:58:06.804272 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-17 10:58:06.989350 | instance | ok: "logs" 2026-04-17 10:58:06.989615 | instance | ok: All items complete 2026-04-17 10:58:06.989643 | 2026-04-17 10:58:07.144408 | instance | ok: "artifacts" 2026-04-17 10:58:07.297037 | instance | ok: "docs" 2026-04-17 10:58:07.317108 | 2026-04-17 10:58:07.317270 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-17 10:58:07.496191 | instance | changed: "logs" 2026-04-17 10:58:07.643379 | instance | changed: "artifacts" 2026-04-17 10:58:07.785218 | instance | changed: "docs" 2026-04-17 10:58:07.799960 | 2026-04-17 10:58:07.800372 | PLAY RECAP 2026-04-17 10:58:07.800447 | instance | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-17 10:58:07.800488 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-17 10:58:07.800516 | 2026-04-17 10:58:07.913897 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-17 10:58:07.918027 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-17 10:58:08.462441 | 2026-04-17 10:58:08.462565 | PLAY [all] 2026-04-17 10:58:08.474478 | 2026-04-17 10:58:08.474556 | TASK [setup-uv : Extract archive] 2026-04-17 10:58:10.679234 | instance | changed 2026-04-17 10:58:10.685367 | 2026-04-17 10:58:10.685444 | TASK [setup-uv : Print version] 2026-04-17 10:58:10.309371 | instance | uv 0.8.13 2026-04-17 10:58:11.218698 | instance | ok: Runtime: 0:00:00.015696 2026-04-17 10:58:11.226593 | 2026-04-17 10:58:11.226642 | PLAY RECAP 2026-04-17 10:58:11.226693 | instance | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-17 10:58:11.226716 | 2026-04-17 10:58:11.335320 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-17 10:58:11.337916 | PRE-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main] 2026-04-17 10:58:11.970301 | 2026-04-17 10:58:11.970459 | PLAY [all] 2026-04-17 10:58:11.981656 | 2026-04-17 10:58:11.981729 | TASK [Install "jq" for log collection] 2026-04-17 10:58:22.843554 | instance | changed 2026-04-17 10:58:22.849137 | 2026-04-17 10:58:22.849229 | TASK [Install pip3 for Python package management] 2026-04-17 10:58:28.233372 | instance | changed 2026-04-17 10:58:28.239442 | 2026-04-17 10:58:28.239505 | TASK [Install Python "kubernetes" library for kubernetes.core modules] 2026-04-17 10:58:31.757916 | instance | changed 2026-04-17 10:58:31.760067 | 2026-04-17 10:58:31.760120 | PLAY [all] 2026-04-17 10:58:31.767542 | 2026-04-17 10:58:31.767602 | TASK [ensure-go : Check installed go version] 2026-04-17 10:58:32.301834 | instance | ok: ERROR (ignored) 2026-04-17 10:58:32.302056 | instance | { 2026-04-17 10:58:32.302087 | instance | "failed_when_result": false, 2026-04-17 10:58:32.302109 | instance | "msg": "[Errno 2] No such file or directory: b'go'", 2026-04-17 10:58:32.302130 | instance | "rc": 2 2026-04-17 10:58:32.302153 | instance | } 2026-04-17 10:58:32.306972 | 2026-04-17 10:58:32.307041 | TASK [ensure-go : Skip if correct version of go is installed] 2026-04-17 10:58:32.360911 | instance | ok 2026-04-17 10:58:32.369868 | instance | included: /var/lib/zuul/builds/55c0ca3e39284c1cabfc7950ba64d357/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-go/tasks/install-go.yaml 2026-04-17 10:58:32.374696 | 2026-04-17 10:58:32.374772 | TASK [ensure-go : Create temp directory] 2026-04-17 10:58:32.713540 | instance | changed 2026-04-17 10:58:32.718849 | 2026-04-17 10:58:32.718916 | TASK [ensure-go : Get archive checksum] 2026-04-17 10:58:33.317945 | instance | ok: OK (64 bytes) 2026-04-17 10:58:33.325144 | 2026-04-17 10:58:33.325245 | TASK [ensure-go : Download go archive] 2026-04-17 10:58:34.636406 | instance | changed: OK (78559214 bytes) 2026-04-17 10:58:34.644177 | 2026-04-17 10:58:34.644285 | TASK [ensure-go : Install go] 2026-04-17 10:58:40.565192 | instance | changed 2026-04-17 10:58:40.571391 | 2026-04-17 10:58:40.571444 | PLAY [all] 2026-04-17 10:58:40.576991 | 2026-04-17 10:58:40.577048 | TASK [Copy inventory file for Zuul] 2026-04-17 10:58:41.339706 | instance | changed 2026-04-17 10:58:41.346152 | 2026-04-17 10:58:41.346238 | TASK [Switch "ansible_host" to private IP] 2026-04-17 10:58:41.664455 | instance | changed: 1 replacements made 2026-04-17 10:58:41.671607 | 2026-04-17 10:58:41.671669 | TASK [Run molecule prepare] 2026-04-17 10:58:41.927763 | instance | Using CPython 3.10.12 interpreter at: /usr/bin/python3 2026-04-17 10:58:41.928007 | instance | Creating virtual environment at: .venv 2026-04-17 10:58:41.956268 | instance | Building atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-04-17 10:58:41.970351 | instance | Downloading openstacksdk (1.7MiB) 2026-04-17 10:58:41.970672 | instance | Downloading pygments (1.2MiB) 2026-04-17 10:58:41.970795 | instance | Downloading setuptools (1.1MiB) 2026-04-17 10:58:41.971030 | instance | Downloading pydantic-core (2.0MiB) 2026-04-17 10:58:41.987846 | instance | Downloading rjsonnet (1.2MiB) 2026-04-17 10:58:41.989176 | instance | Downloading cryptography (4.2MiB) 2026-04-17 10:58:41.989832 | instance | Downloading netaddr (2.2MiB) 2026-04-17 10:58:41.990951 | instance | Downloading ansible-core (2.1MiB) 2026-04-17 10:58:41.991291 | instance | Downloading kubernetes (1.9MiB) 2026-04-17 10:58:42.302722 | instance | Building pyperclip==1.9.0 2026-04-17 10:58:42.313375 | instance | Downloading rjsonnet 2026-04-17 10:58:42.425011 | instance | Downloading pydantic-core 2026-04-17 10:58:42.480758 | instance | Downloading netaddr 2026-04-17 10:58:42.492490 | instance | Downloading pygments 2026-04-17 10:58:42.503806 | instance | Downloading cryptography 2026-04-17 10:58:42.538233 | instance | Downloading setuptools 2026-04-17 10:58:42.602665 | instance | Downloading kubernetes 2026-04-17 10:58:42.636009 | instance | Downloading ansible-core 2026-04-17 10:58:42.664577 | instance | Downloading openstacksdk 2026-04-17 10:58:43.127488 | instance | Built pyperclip==1.9.0 2026-04-17 10:58:43.368877 | instance | Built atmosphere @ file:///home/zuul/src/github.com/vexxhost/atmosphere 2026-04-17 10:58:43.414130 | instance | Installed 83 packages in 43ms 2026-04-17 10:58:44.029367 | instance | WARNING Molecule scenarios should migrate to 'extensions/molecule' 2026-04-17 10:58:44.659773 | instance | INFO [csi > discovery] scenario test matrix: prepare 2026-04-17 10:58:44.659920 | instance | INFO [csi > prerun] Performing prerun with role_name_check=0... 2026-04-17 10:59:28.308525 | instance | INFO [csi > prepare] Executing 2026-04-17 10:59:29.351158 | instance | 2026-04-17 10:59:29.352337 | instance | PLAY [Prepare] ***************************************************************** 2026-04-17 10:59:29.352689 | instance | 2026-04-17 10:59:29.353060 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-17 10:59:29.353401 | instance | Friday 17 April 2026 10:59:29 +0000 (0:00:00.029) 0:00:00.029 ********** 2026-04-17 10:59:30.728979 | instance | [WARNING]: Platform linux on host instance is using the discovered Python 2026-04-17 10:59:30.729040 | instance | interpreter at /usr/bin/python3.10, but future installation of another Python 2026-04-17 10:59:30.729049 | instance | interpreter could change the meaning of that path. See 2026-04-17 10:59:30.729257 | instance | https://docs.ansible.com/ansible- 2026-04-17 10:59:30.729737 | instance | core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-04-17 10:59:30.740835 | instance | ok: [instance] 2026-04-17 10:59:30.741479 | instance | 2026-04-17 10:59:30.741494 | instance | TASK [Configure short hostname] ************************************************ 2026-04-17 10:59:30.741886 | instance | Friday 17 April 2026 10:59:30 +0000 (0:00:01.387) 0:00:01.417 ********** 2026-04-17 10:59:31.401709 | instance | changed: [instance] 2026-04-17 10:59:31.401897 | instance | 2026-04-17 10:59:31.402121 | instance | TASK [Ensure hostname inside hosts file] *************************************** 2026-04-17 10:59:31.402350 | instance | Friday 17 April 2026 10:59:31 +0000 (0:00:00.663) 0:00:02.081 ********** 2026-04-17 10:59:31.669306 | instance | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created 2026-04-17 10:59:31.669578 | instance | with a mode of 0700, this may cause issues when running as another user. To 2026-04-17 10:59:31.669855 | instance | avoid this, create the remote_tmp dir with the correct permissions manually 2026-04-17 10:59:31.678292 | instance | changed: [instance] 2026-04-17 10:59:31.678471 | instance | 2026-04-17 10:59:31.678681 | instance | TASK [Purge "snapd" package] *************************************************** 2026-04-17 10:59:31.678858 | instance | Friday 17 April 2026 10:59:31 +0000 (0:00:00.277) 0:00:02.358 ********** 2026-04-17 10:59:32.525476 | instance | ok: [instance] 2026-04-17 10:59:32.525748 | instance | 2026-04-17 10:59:32.526125 | instance | PLAY [Create devices for Ceph] ************************************************* 2026-04-17 10:59:32.526563 | instance | 2026-04-17 10:59:32.526953 | instance | TASK [Gathering Facts] ********************************************************* 2026-04-17 10:59:32.527356 | instance | Friday 17 April 2026 10:59:32 +0000 (0:00:00.847) 0:00:03.205 ********** 2026-04-17 10:59:33.230986 | instance | ok: [instance] 2026-04-17 10:59:33.231054 | instance | 2026-04-17 10:59:33.231193 | instance | TASK [Install depedencies] ***************************************************** 2026-04-17 10:59:33.231318 | instance | Friday 17 April 2026 10:59:33 +0000 (0:00:00.705) 0:00:03.910 ********** 2026-04-17 11:00:10.829064 | instance | changed: [instance] 2026-04-17 11:00:10.829164 | instance | 2026-04-17 11:00:10.829180 | instance | TASK [Start up service] ******************************************************** 2026-04-17 11:00:10.829436 | instance | Friday 17 April 2026 11:00:10 +0000 (0:00:37.597) 0:00:41.508 ********** 2026-04-17 11:00:11.395221 | instance | ok: [instance] 2026-04-17 11:00:11.395832 | instance | 2026-04-17 11:00:11.395845 | instance | TASK [Generate lvm.conf] ******************************************************* 2026-04-17 11:00:11.395855 | instance | Friday 17 April 2026 11:00:11 +0000 (0:00:00.566) 0:00:42.075 ********** 2026-04-17 11:00:11.688464 | instance | ok: [instance] 2026-04-17 11:00:11.688694 | instance | 2026-04-17 11:00:11.689107 | instance | TASK [Write /etc/lvm/lvm.conf] ************************************************* 2026-04-17 11:00:11.689398 | instance | Friday 17 April 2026 11:00:11 +0000 (0:00:00.292) 0:00:42.367 ********** 2026-04-17 11:00:12.337275 | instance | changed: [instance] 2026-04-17 11:00:12.337345 | instance | 2026-04-17 11:00:12.337359 | instance | TASK [Get list of all loopback devices] **************************************** 2026-04-17 11:00:12.337370 | instance | Friday 17 April 2026 11:00:12 +0000 (0:00:00.646) 0:00:43.014 ********** 2026-04-17 11:00:12.524653 | instance | ok: [instance] 2026-04-17 11:00:12.524934 | instance | 2026-04-17 11:00:12.525229 | instance | TASK [Fail if there is any existing loopback devices] ************************** 2026-04-17 11:00:12.525583 | instance | Friday 17 April 2026 11:00:12 +0000 (0:00:00.189) 0:00:43.204 ********** 2026-04-17 11:00:12.547957 | instance | skipping: [instance] 2026-04-17 11:00:12.548254 | instance | 2026-04-17 11:00:12.548637 | instance | TASK [Create devices for Ceph] ************************************************* 2026-04-17 11:00:12.548946 | instance | Friday 17 April 2026 11:00:12 +0000 (0:00:00.023) 0:00:43.227 ********** 2026-04-17 11:00:13.092338 | instance | changed: [instance] => (item=osd0) 2026-04-17 11:00:13.092578 | instance | changed: [instance] => (item=osd1) 2026-04-17 11:00:13.092870 | instance | changed: [instance] => (item=osd2) 2026-04-17 11:00:13.093386 | instance | 2026-04-17 11:00:13.093736 | instance | TASK [Set permissions on loopback devices] ************************************* 2026-04-17 11:00:13.094026 | instance | Friday 17 April 2026 11:00:13 +0000 (0:00:00.542) 0:00:43.770 ********** 2026-04-17 11:00:13.730371 | instance | changed: [instance] => (item=osd0) 2026-04-17 11:00:13.730650 | instance | changed: [instance] => (item=osd1) 2026-04-17 11:00:13.730822 | instance | changed: [instance] => (item=osd2) 2026-04-17 11:00:13.730939 | instance | 2026-04-17 11:00:13.731065 | instance | TASK [Start loop devices] ****************************************************** 2026-04-17 11:00:13.731190 | instance | Friday 17 April 2026 11:00:13 +0000 (0:00:00.639) 0:00:44.409 ********** 2026-04-17 11:00:14.391376 | instance | changed: [instance] => (item=osd0) 2026-04-17 11:00:14.391647 | instance | changed: [instance] => (item=osd1) 2026-04-17 11:00:14.391942 | instance | changed: [instance] => (item=osd2) 2026-04-17 11:00:14.392205 | instance | 2026-04-17 11:00:14.392551 | instance | TASK [Create a volume group for each loop device] ****************************** 2026-04-17 11:00:14.392837 | instance | Friday 17 April 2026 11:00:14 +0000 (0:00:00.661) 0:00:45.070 ********** 2026-04-17 11:00:17.839354 | instance | changed: [instance] => (item=osd0) 2026-04-17 11:00:17.839645 | instance | changed: [instance] => (item=osd1) 2026-04-17 11:00:17.839998 | instance | changed: [instance] => (item=osd2) 2026-04-17 11:00:17.840380 | instance | 2026-04-17 11:00:17.840667 | instance | TASK [Create a logical volume for each loop device] **************************** 2026-04-17 11:00:17.840945 | instance | Friday 17 April 2026 11:00:17 +0000 (0:00:03.447) 0:00:48.518 ********** 2026-04-17 11:00:19.648282 | instance | changed: [instance] => (item=ceph-instance-osd0) 2026-04-17 11:00:19.648594 | instance | changed: [instance] => (item=ceph-instance-osd1) 2026-04-17 11:00:19.648882 | instance | changed: [instance] => (item=ceph-instance-osd2) 2026-04-17 11:00:19.649219 | instance | 2026-04-17 11:00:19.649497 | instance | PLAY RECAP ********************************************************************* 2026-04-17 11:00:19.649912 | instance | instance : ok=15 changed=9 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-04-17 11:00:19.650089 | instance | 2026-04-17 11:00:19.650273 | instance | Friday 17 April 2026 11:00:19 +0000 (0:00:01.809) 0:00:50.328 ********** 2026-04-17 11:00:19.650448 | instance | =============================================================================== 2026-04-17 11:00:19.650643 | instance | Install depedencies ---------------------------------------------------- 37.60s 2026-04-17 11:00:19.650829 | instance | Create a volume group for each loop device ------------------------------ 3.45s 2026-04-17 11:00:19.651063 | instance | Create a logical volume for each loop device ---------------------------- 1.81s 2026-04-17 11:00:19.651329 | instance | Gathering Facts --------------------------------------------------------- 1.39s 2026-04-17 11:00:19.651521 | instance | Purge "snapd" package --------------------------------------------------- 0.85s 2026-04-17 11:00:19.651745 | instance | Gathering Facts --------------------------------------------------------- 0.71s 2026-04-17 11:00:19.651939 | instance | Configure short hostname ------------------------------------------------ 0.66s 2026-04-17 11:00:19.652118 | instance | Start loop devices ------------------------------------------------------ 0.66s 2026-04-17 11:00:19.652324 | instance | Write /etc/lvm/lvm.conf ------------------------------------------------- 0.65s 2026-04-17 11:00:19.652501 | instance | Set permissions on loopback devices ------------------------------------- 0.64s 2026-04-17 11:00:19.652690 | instance | Start up service -------------------------------------------------------- 0.57s 2026-04-17 11:00:19.652865 | instance | Create devices for Ceph ------------------------------------------------- 0.54s 2026-04-17 11:00:19.653074 | instance | Generate lvm.conf ------------------------------------------------------- 0.29s 2026-04-17 11:00:19.653245 | instance | Ensure hostname inside hosts file --------------------------------------- 0.28s 2026-04-17 11:00:19.653420 | instance | Get list of all loopback devices ---------------------------------------- 0.19s 2026-04-17 11:00:19.653660 | instance | Fail if there is any existing loopback devices -------------------------- 0.02s 2026-04-17 11:00:19.718917 | instance | INFO [csi > prepare] Executed: Successful 2026-04-17 11:00:19.719503 | instance | INFO Molecule executed 1 scenario (1 successful) 2026-04-17 11:00:19.855653 | instance | ok: Runtime: 0:01:37.929013 2026-04-17 11:00:19.858936 | 2026-04-17 11:00:19.859004 | PLAY RECAP 2026-04-17 11:00:19.859072 | instance | ok: 12 changed: 9 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-17 11:00:19.859101 | 2026-04-17 11:00:19.973991 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/pre.yml@main] 2026-04-17 11:00:19.978919 | RUN START: [untrusted : github.com/vexxhost/atmosphere/molecule/csi/converge.yml@main] 2026-04-17 11:00:20.510228 | 2026-04-17 11:00:20.510332 | PLAY [all] 2026-04-17 11:00:20.520829 | 2026-04-17 11:00:20.520903 | TASK [Build atmosphere binary] 2026-04-17 11:00:20.886876 | instance | go: downloading github.com/spf13/cobra v1.9.1 2026-04-17 11:00:20.891766 | instance | go: downloading golang.org/x/sync v0.18.0 2026-04-17 11:00:21.135867 | instance | go: downloading github.com/spf13/pflag v1.0.7 2026-04-17 11:00:27.563419 | instance | ok: Runtime: 0:00:06.189074 2026-04-17 11:00:27.570584 | 2026-04-17 11:00:27.570656 | TASK [Deploy with parallel orchestrator] 2026-04-17 11:00:27.776416 | instance | ==> Multi-tag mode: ceph, kubernetes, csi 2026-04-17 11:00:27.776612 | instance | ==> Running preflight checks 2026-04-17 11:00:28.219367 | instance | [preflight] 2026-04-17 11:00:28.219407 | instance | [preflight] PLAY [Preflight checks] ******************************************************** 2026-04-17 11:00:28.219416 | instance | [preflight] 2026-04-17 11:00:28.219422 | instance | [preflight] TASK [Fail if atmosphere_ceph_enabled is set] ********************************** 2026-04-17 11:00:28.244295 | instance | [preflight] skipping: [instance] 2026-04-17 11:00:28.244340 | instance | [preflight] 2026-04-17 11:00:28.244347 | instance | [preflight] PLAY RECAP ********************************************************************* 2026-04-17 11:00:28.244357 | instance | [preflight] instance : ok=0 changed=0 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-04-17 11:00:28.244364 | instance | [preflight] 2026-04-17 11:00:28.300469 | instance | ==> Preflight checks passed 2026-04-17 11:00:28.300647 | instance | ==> Starting parallel deployment (subgraph) 2026-04-17 11:00:28.300669 | instance | ==> [kubernetes] Starting deployment 2026-04-17 11:00:28.300822 | instance | ==> [ceph] Starting deployment 2026-04-17 11:00:29.041215 | instance | [ceph/ceph] 2026-04-17 11:00:29.041280 | instance | [ceph/ceph] PLAY [all] ********************************************************************* 2026-04-17 11:00:29.041292 | instance | [ceph/ceph] 2026-04-17 11:00:29.041302 | instance | [ceph/ceph] TASK [Gathering Facts] ********************************************************* 2026-04-17 11:00:29.278935 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:29.279005 | instance | [kubernetes/kubernetes] PLAY [all] ********************************************************************* 2026-04-17 11:00:29.279034 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:29.279044 | instance | [kubernetes/kubernetes] TASK [Gathering Facts] ********************************************************* 2026-04-17 11:00:30.498324 | instance | [ceph/ceph] [WARNING]: Platform linux on host instance is using the discovered Python 2026-04-17 11:00:30.498475 | instance | [ceph/ceph] interpreter at /usr/bin/python3.10, but future installation of another Python 2026-04-17 11:00:30.498482 | instance | [ceph/ceph] interpreter could change the meaning of that path. See 2026-04-17 11:00:30.498486 | instance | [ceph/ceph] https://docs.ansible.com/ansible- 2026-04-17 11:00:30.498491 | instance | [ceph/ceph] core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-04-17 11:00:30.506350 | instance | [ceph/ceph] ok: [instance] 2026-04-17 11:00:30.506429 | instance | [ceph/ceph] 2026-04-17 11:00:30.506439 | instance | [ceph/ceph] TASK [Fail if atmosphere_ceph_enabled is set] ********************************** 2026-04-17 11:00:30.539221 | instance | [ceph/ceph] skipping: [instance] 2026-04-17 11:00:30.539279 | instance | [ceph/ceph] 2026-04-17 11:00:30.539291 | instance | [ceph/ceph] TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-04-17 11:00:30.547601 | instance | [kubernetes/kubernetes] [WARNING]: Platform linux on host instance is using the discovered Python 2026-04-17 11:00:30.547654 | instance | [kubernetes/kubernetes] interpreter at /usr/bin/python3.10, but future installation of another Python 2026-04-17 11:00:30.547667 | instance | [kubernetes/kubernetes] interpreter could change the meaning of that path. See 2026-04-17 11:00:30.547676 | instance | [kubernetes/kubernetes] https://docs.ansible.com/ansible- 2026-04-17 11:00:30.547686 | instance | [kubernetes/kubernetes] core/2.17/reference_appendices/interpreter_discovery.html for more information. 2026-04-17 11:00:30.564814 | instance | [kubernetes/kubernetes] ok: [instance] 2026-04-17 11:00:30.564883 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:30.564895 | instance | [kubernetes/kubernetes] TASK [vexxhost.atmosphere.sysctl : Configure sysctl values] ******************** 2026-04-17 11:00:30.718609 | instance | [ceph/ceph] ok: [instance] 2026-04-17 11:00:30.718693 | instance | [ceph/ceph] 2026-04-17 11:00:30.718706 | instance | [ceph/ceph] PLAY [Deploy Ceph monitors & managers] ***************************************** 2026-04-17 11:00:30.718716 | instance | [ceph/ceph] 2026-04-17 11:00:30.718725 | instance | [ceph/ceph] TASK [Gathering Facts] ********************************************************* 2026-04-17 11:00:31.707925 | instance | [ceph/ceph] ok: [instance] 2026-04-17 11:00:31.708006 | instance | [ceph/ceph] 2026-04-17 11:00:31.708018 | instance | [ceph/ceph] TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-17 11:00:32.122014 | instance | [ceph/ceph] ok: [instance] 2026-04-17 11:00:32.122080 | instance | [ceph/ceph] 2026-04-17 11:00:32.122093 | instance | [ceph/ceph] TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-17 11:00:32.164861 | instance | [ceph/ceph] skipping: [instance] 2026-04-17 11:00:32.164928 | instance | [ceph/ceph] 2026-04-17 11:00:32.164940 | instance | [ceph/ceph] TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-04-17 11:00:32.599300 | instance | [ceph/ceph] changed: [instance] 2026-04-17 11:00:32.599364 | instance | [ceph/ceph] 2026-04-17 11:00:32.599376 | instance | [ceph/ceph] TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-17 11:00:32.665717 | instance | [ceph/ceph] ok: [instance] => { 2026-04-17 11:00:32.665773 | instance | [ceph/ceph] "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-04-17 11:00:32.665783 | instance | [ceph/ceph] } 2026-04-17 11:00:32.665789 | instance | [ceph/ceph] 2026-04-17 11:00:32.665795 | instance | [ceph/ceph] TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-17 11:00:33.881208 | instance | [ceph/ceph] changed: [instance] 2026-04-17 11:00:33.881288 | instance | [ceph/ceph] 2026-04-17 11:00:33.881301 | instance | [ceph/ceph] TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-17 11:00:33.931143 | instance | [ceph/ceph] skipping: [instance] 2026-04-17 11:00:33.931177 | instance | [ceph/ceph] 2026-04-17 11:00:33.931204 | instance | [ceph/ceph] TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-17 11:00:33.978843 | instance | [ceph/ceph] skipping: [instance] 2026-04-17 11:00:33.978910 | instance | [ceph/ceph] 2026-04-17 11:00:33.978918 | instance | [ceph/ceph] TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-17 11:00:34.323013 | instance | [ceph/ceph] ok: [instance] 2026-04-17 11:00:34.323079 | instance | [ceph/ceph] 2026-04-17 11:00:34.323091 | instance | [ceph/ceph] TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-17 11:00:35.932894 | instance | [ceph/ceph] ok: [instance] 2026-04-17 11:00:35.932969 | instance | [ceph/ceph] 2026-04-17 11:00:35.932981 | instance | [ceph/ceph] TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-17 11:00:35.993348 | instance | [ceph/ceph] ok: [instance] => { 2026-04-17 11:00:35.993396 | instance | [ceph/ceph] "msg": "https://github.com/containerd/containerd/releases/download/v2.2.2/containerd-2.2.2-linux-amd64.tar.gz" 2026-04-17 11:00:35.993402 | instance | [ceph/ceph] } 2026-04-17 11:00:35.993406 | instance | [ceph/ceph] 2026-04-17 11:00:35.993411 | instance | [ceph/ceph] TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-17 11:00:37.362406 | instance | [kubernetes/kubernetes] changed: [instance] => (item={'name': 'fs.aio-max-nr', 'value': 1048576}) 2026-04-17 11:00:37.362477 | instance | [kubernetes/kubernetes] changed: [instance] => (item={'name': 'net.ipv4.tcp_timestamps', 'value': 0}) 2026-04-17 11:00:37.362489 | instance | [kubernetes/kubernetes] changed: [instance] => (item={'name': 'net.ipv4.tcp_sack', 'value': 1}) 2026-04-17 11:00:37.362498 | instance | [kubernetes/kubernetes] changed: [instance] => (item={'name': 'net.core.netdev_budget', 'value': 1000}) 2026-04-17 11:00:37.362518 | instance | [kubernetes/kubernetes] changed: [instance] => (item={'name': 'net.core.netdev_max_backlog', 'value': 250000}) 2026-04-17 11:00:37.362528 | instance | [kubernetes/kubernetes] changed: [instance] => (item={'name': 'net.core.rmem_max', 'value': 4194304}) 2026-04-17 11:00:37.362536 | instance | [kubernetes/kubernetes] changed: [instance] => (item={'name': 'net.core.wmem_max', 'value': 4194304}) 2026-04-17 11:00:37.362545 | instance | [kubernetes/kubernetes] changed: [instance] => (item={'name': 'net.core.rmem_default', 'value': 4194304}) 2026-04-17 11:00:37.362554 | instance | [kubernetes/kubernetes] changed: [instance] => (item={'name': 'net.core.wmem_default', 'value': 4194304}) 2026-04-17 11:00:37.362562 | instance | [kubernetes/kubernetes] changed: [instance] => (item={'name': 'net.core.optmem_max', 'value': 4194304}) 2026-04-17 11:00:37.362571 | instance | [kubernetes/kubernetes] changed: [instance] => (item={'name': 'net.ipv4.tcp_rmem', 'value': '4096 87380 4194304'}) 2026-04-17 11:00:37.362592 | instance | [kubernetes/kubernetes] changed: [instance] => (item={'name': 'net.ipv4.tcp_wmem', 'value': '4096 65536 4194304'}) 2026-04-17 11:00:37.362601 | instance | [kubernetes/kubernetes] changed: [instance] => (item={'name': 'net.ipv4.tcp_low_latency', 'value': 1}) 2026-04-17 11:00:37.362609 | instance | [kubernetes/kubernetes] changed: [instance] => (item={'name': 'net.ipv4.tcp_adv_win_scale', 'value': 1}) 2026-04-17 11:00:37.362618 | instance | [kubernetes/kubernetes] changed: [instance] => (item={'name': 'net.ipv4.neigh.default.gc_thresh1', 'value': 128}) 2026-04-17 11:00:37.362627 | instance | [kubernetes/kubernetes] changed: [instance] => (item={'name': 'net.ipv4.neigh.default.gc_thresh2', 'value': 28872}) 2026-04-17 11:00:37.362635 | instance | [kubernetes/kubernetes] changed: [instance] => (item={'name': 'net.ipv4.neigh.default.gc_thresh3', 'value': 32768}) 2026-04-17 11:00:37.362644 | instance | [kubernetes/kubernetes] changed: [instance] => (item={'name': 'net.ipv6.neigh.default.gc_thresh1', 'value': 128}) 2026-04-17 11:00:37.362653 | instance | [kubernetes/kubernetes] changed: [instance] => (item={'name': 'net.ipv6.neigh.default.gc_thresh2', 'value': 28872}) 2026-04-17 11:00:37.362662 | instance | [kubernetes/kubernetes] changed: [instance] => (item={'name': 'net.ipv6.neigh.default.gc_thresh3', 'value': 32768}) 2026-04-17 11:00:37.362671 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:37.362680 | instance | [kubernetes/kubernetes] TASK [vexxhost.atmosphere.ethtool : Create folder for persistent configuration] *** 2026-04-17 11:00:37.771987 | instance | [kubernetes/kubernetes] changed: [instance] 2026-04-17 11:00:37.772038 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:37.772047 | instance | [kubernetes/kubernetes] TASK [vexxhost.atmosphere.ethtool : Install persistent "ethtool" tuning] ******* 2026-04-17 11:00:38.508652 | instance | [kubernetes/kubernetes] changed: [instance] 2026-04-17 11:00:38.508713 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:38.508725 | instance | [kubernetes/kubernetes] TASK [vexxhost.atmosphere.ethtool : Run "ethtool" tuning] ********************** 2026-04-17 11:00:38.675462 | instance | [ceph/ceph] changed: [instance] 2026-04-17 11:00:38.675492 | instance | [ceph/ceph] 2026-04-17 11:00:38.675498 | instance | [ceph/ceph] TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-17 11:00:38.967804 | instance | [kubernetes/kubernetes] ok: [instance] 2026-04-17 11:00:38.967889 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:38.967905 | instance | [kubernetes/kubernetes] TASK [Set a fact with the "atmosphere_images" for other plays] ***************** 2026-04-17 11:00:39.102945 | instance | [kubernetes/kubernetes] ok: [instance] 2026-04-17 11:00:39.102981 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:39.103007 | instance | [kubernetes/kubernetes] PLAY [Configure Kubernetes VIP] ************************************************ 2026-04-17 11:00:39.103017 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:39.103026 | instance | [kubernetes/kubernetes] TASK [Gathering Facts] ********************************************************* 2026-04-17 11:00:40.091755 | instance | [kubernetes/kubernetes] ok: [instance] 2026-04-17 11:00:40.091839 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:40.091852 | instance | [kubernetes/kubernetes] TASK [vexxhost.containers.directory : Create directory (/etc/kubernetes/manifests)] *** 2026-04-17 11:00:40.412033 | instance | [kubernetes/kubernetes] changed: [instance] 2026-04-17 11:00:40.412086 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:40.412092 | instance | [kubernetes/kubernetes] TASK [vexxhost.kubernetes.kube_vip : Uninstall legacy HA stack] **************** 2026-04-17 11:00:41.891587 | instance | [kubernetes/kubernetes] ok: [instance] => (item=/etc/keepalived/keepalived.conf) 2026-04-17 11:00:41.891804 | instance | [kubernetes/kubernetes] ok: [instance] => (item=/etc/keepalived/check_apiserver.sh) 2026-04-17 11:00:41.891818 | instance | [kubernetes/kubernetes] ok: [instance] => (item=/etc/kubernetes/manifests/keepalived.yaml) 2026-04-17 11:00:41.891826 | instance | [kubernetes/kubernetes] ok: [instance] => (item=/etc/haproxy/haproxy.cfg) 2026-04-17 11:00:41.891834 | instance | [kubernetes/kubernetes] ok: [instance] => (item=/etc/kubernetes/manifests/haproxy.yaml) 2026-04-17 11:00:41.891859 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:41.891867 | instance | [kubernetes/kubernetes] TASK [vexxhost.kubernetes.kube_vip : Switch API server to run on port 6443] **** 2026-04-17 11:00:42.686250 | instance | [ceph/ceph] changed: [instance] 2026-04-17 11:00:42.686320 | instance | [ceph/ceph] 2026-04-17 11:00:42.686332 | instance | [ceph/ceph] TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-04-17 11:00:42.718867 | instance | [ceph/ceph] skipping: [instance] 2026-04-17 11:00:42.718937 | instance | [ceph/ceph] 2026-04-17 11:00:42.718948 | instance | [ceph/ceph] TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-04-17 11:00:42.748124 | instance | [ceph/ceph] skipping: [instance] 2026-04-17 11:00:42.748188 | instance | [ceph/ceph] 2026-04-17 11:00:42.748200 | instance | [ceph/ceph] TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-04-17 11:00:42.780201 | instance | [ceph/ceph] skipping: [instance] 2026-04-17 11:00:42.780283 | instance | [ceph/ceph] 2026-04-17 11:00:42.780295 | instance | [ceph/ceph] TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-04-17 11:00:42.799969 | instance | [kubernetes/kubernetes] 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-17 11:00:42.800025 | instance | [kubernetes/kubernetes] 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-17 11:00:42.800034 | instance | [kubernetes/kubernetes] 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-17 11:00:42.800039 | instance | [kubernetes/kubernetes] ...ignoring 2026-04-17 11:00:42.800044 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:42.800049 | instance | [kubernetes/kubernetes] TASK [vexxhost.kubernetes.kube_vip : Check if super-admin.conf exists] ********* 2026-04-17 11:00:43.073602 | instance | [kubernetes/kubernetes] ok: [instance] 2026-04-17 11:00:43.073640 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:43.073655 | instance | [kubernetes/kubernetes] TASK [vexxhost.kubernetes.kube_vip : Check if kubeadm has already run] ********* 2026-04-17 11:00:43.355731 | instance | [kubernetes/kubernetes] ok: [instance] 2026-04-17 11:00:43.355793 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:43.355799 | instance | [kubernetes/kubernetes] TASK [vexxhost.kubernetes.kube_vip : Set fact with KUBECONFIG path] ************ 2026-04-17 11:00:43.377641 | instance | [kubernetes/kubernetes] ok: [instance] 2026-04-17 11:00:43.377699 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:43.377708 | instance | [kubernetes/kubernetes] TASK [vexxhost.kubernetes.kube_vip : Set fact with KUBECONFIG path (with super-admin.conf)] *** 2026-04-17 11:00:43.407378 | instance | [kubernetes/kubernetes] ok: [instance] 2026-04-17 11:00:43.407433 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:43.407439 | instance | [kubernetes/kubernetes] TASK [vexxhost.kubernetes.kube_vip : Upload Kubernetes manifest] *************** 2026-04-17 11:00:44.055811 | instance | [kubernetes/kubernetes] ok: [instance] 2026-04-17 11:00:44.055890 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:44.055903 | instance | [kubernetes/kubernetes] TASK [vexxhost.kubernetes.kube_vip : Ensure kube-vip configuration file] ******* 2026-04-17 11:00:44.409469 | instance | [kubernetes/kubernetes] ok: [instance] 2026-04-17 11:00:44.409557 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:44.409570 | instance | [kubernetes/kubernetes] TASK [vexxhost.kubernetes.kube_vip : Flush handlers] *************************** 2026-04-17 11:00:44.409581 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:44.409591 | instance | [kubernetes/kubernetes] PLAY [Install Kubernetes] ****************************************************** 2026-04-17 11:00:44.409600 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:44.409610 | instance | [kubernetes/kubernetes] TASK [Gathering Facts] ********************************************************* 2026-04-17 11:00:46.953001 | instance | [kubernetes/kubernetes] ok: [instance] 2026-04-17 11:00:46.953048 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:46.953054 | instance | [kubernetes/kubernetes] TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-17 11:00:47.234094 | instance | [kubernetes/kubernetes] ok: [instance] 2026-04-17 11:00:47.234160 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:47.234172 | instance | [kubernetes/kubernetes] TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-17 11:00:47.269727 | instance | [kubernetes/kubernetes] skipping: [instance] 2026-04-17 11:00:47.269792 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:47.269799 | instance | [kubernetes/kubernetes] TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-04-17 11:00:47.567292 | instance | [kubernetes/kubernetes] ok: [instance] 2026-04-17 11:00:47.567377 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:47.567389 | instance | [kubernetes/kubernetes] TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-17 11:00:47.670828 | instance | [kubernetes/kubernetes] ok: [instance] => { 2026-04-17 11:00:47.670912 | instance | [kubernetes/kubernetes] "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-04-17 11:00:47.670925 | instance | [kubernetes/kubernetes] } 2026-04-17 11:00:47.670936 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:47.670946 | instance | [kubernetes/kubernetes] TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-17 11:00:48.150563 | instance | [kubernetes/kubernetes] ok: [instance] 2026-04-17 11:00:48.150623 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:48.150632 | instance | [kubernetes/kubernetes] TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-17 11:00:48.194202 | instance | [kubernetes/kubernetes] skipping: [instance] 2026-04-17 11:00:48.194230 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:48.194236 | instance | [kubernetes/kubernetes] TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-17 11:00:48.496945 | instance | [kubernetes/kubernetes] ok: [instance] 2026-04-17 11:00:48.497024 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:48.497038 | instance | [kubernetes/kubernetes] TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-17 11:00:49.729507 | instance | [kubernetes/kubernetes] ok: [instance] 2026-04-17 11:00:49.729577 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:49.729590 | instance | [kubernetes/kubernetes] TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-17 11:00:49.800993 | instance | [kubernetes/kubernetes] ok: [instance] => { 2026-04-17 11:00:49.801075 | instance | [kubernetes/kubernetes] "msg": "https://github.com/containerd/containerd/releases/download/v2.2.2/containerd-2.2.2-linux-amd64.tar.gz" 2026-04-17 11:00:49.801088 | instance | [kubernetes/kubernetes] } 2026-04-17 11:00:49.801097 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:49.801107 | instance | [kubernetes/kubernetes] TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-17 11:00:50.247668 | instance | [kubernetes/kubernetes] ok: [instance] 2026-04-17 11:00:50.247739 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:50.247752 | instance | [kubernetes/kubernetes] TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-17 11:00:52.490250 | instance | [kubernetes/kubernetes] ok: [instance] 2026-04-17 11:00:52.490304 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:52.490316 | instance | [kubernetes/kubernetes] TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-04-17 11:00:52.525993 | instance | [kubernetes/kubernetes] skipping: [instance] 2026-04-17 11:00:52.526046 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:52.526057 | instance | [kubernetes/kubernetes] TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-04-17 11:00:52.555769 | instance | [kubernetes/kubernetes] skipping: [instance] 2026-04-17 11:00:52.555827 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:52.555839 | instance | [kubernetes/kubernetes] TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-04-17 11:00:52.585173 | instance | [kubernetes/kubernetes] skipping: [instance] 2026-04-17 11:00:52.585228 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:52.585240 | instance | [kubernetes/kubernetes] TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-04-17 11:00:53.911232 | instance | [kubernetes/kubernetes] fatal: [instance]: FAILED! => {"cache_update_time": 1776423497, "cache_updated": false, "changed": false, "msg": "'/usr/bin/apt-get -y -o \"Dpkg::Options::=--force-confdef\" -o \"Dpkg::Options::=--force-confold\" install 'apparmor=3.0.4-2ubuntu2.5' 'apparmor-utils=3.0.4-2ubuntu2.5'' failed: E: Could not get lock /var/lib/dpkg/lock-frontend. It is held by process 11501 (apt-get)\nE: Unable to acquire the dpkg frontend lock (/var/lib/dpkg/lock-frontend), is another process using it?\n", "rc": 100, "stderr": "E: Could not get lock /var/lib/dpkg/lock-frontend. It is held by process 11501 (apt-get)\nE: Unable to acquire the dpkg frontend lock (/var/lib/dpkg/lock-frontend), is another process using it?\n", "stderr_lines": ["E: Could not get lock /var/lib/dpkg/lock-frontend. It is held by process 11501 (apt-get)", "E: Unable to acquire the dpkg frontend lock (/var/lib/dpkg/lock-frontend), is another process using it?"], "stdout": "", "stdout_lines": []} 2026-04-17 11:00:53.911300 | instance | [kubernetes/kubernetes] 2026-04-17 11:00:53.911315 | instance | [kubernetes/kubernetes] PLAY RECAP ********************************************************************* 2026-04-17 11:00:53.911325 | instance | [kubernetes/kubernetes] instance : ok=26 changed=4 unreachable=0 failed=1 skipped=5 rescued=0 ignored=1 2026-04-17 11:00:53.911335 | instance | [kubernetes/kubernetes] 2026-04-17 11:01:47.603500 | instance | Error: component kubernetes failed: ansible-playbook failed for kubernetes/kubernetes: exit status 2 2026-04-17 11:01:47.603752 | instance | Usage: 2026-04-17 11:01:47.603766 | instance | atmosphere deploy [flags] 2026-04-17 11:01:47.603777 | instance | 2026-04-17 11:01:47.603786 | instance | Flags: 2026-04-17 11:01:47.603797 | instance | --concurrency int Max concurrent deployments per wave (0 = unlimited) 2026-04-17 11:01:47.603807 | instance | -h, --help help for deploy 2026-04-17 11:01:47.603816 | instance | -i, --inventory string Path to Ansible inventory file (required) 2026-04-17 11:01:47.603827 | instance | -t, --tags string Comma-separated list of component tags to deploy 2026-04-17 11:01:47.603836 | instance | 2026-04-17 11:01:47.603846 | instance | component kubernetes failed: ansible-playbook failed for kubernetes/kubernetes: exit status 2 2026-04-17 11:01:47.732496 | instance | ERROR 2026-04-17 11:01:47.732638 | instance | { 2026-04-17 11:01:47.732667 | instance | "delta": "0:01:19.843556", 2026-04-17 11:01:47.732688 | instance | "end": "2026-04-17 11:01:47.605228", 2026-04-17 11:01:47.732710 | instance | "msg": "non-zero return code", 2026-04-17 11:01:47.732728 | instance | "rc": 1, 2026-04-17 11:01:47.732746 | instance | "start": "2026-04-17 11:00:27.761672" 2026-04-17 11:01:47.732767 | instance | } failure 2026-04-17 11:01:47.736231 | 2026-04-17 11:01:47.736281 | PLAY RECAP 2026-04-17 11:01:47.736328 | instance | ok: 1 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-04-17 11:01:47.736349 | 2026-04-17 11:01:47.834836 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/molecule/csi/converge.yml@main] 2026-04-17 11:01:47.838473 | POST-RUN START: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main] 2026-04-17 11:01:48.405041 | 2026-04-17 11:01:48.405155 | PLAY [all] 2026-04-17 11:01:48.418751 | 2026-04-17 11:01:48.418830 | TASK [gather-host-logs : creating directory for system status] 2026-04-17 11:01:48.786793 | instance | changed 2026-04-17 11:01:48.792039 | 2026-04-17 11:01:48.792123 | TASK [gather-host-logs : Get logs for each host] 2026-04-17 11:01:49.127609 | instance | + systemd-cgls --full --all --no-pager 2026-04-17 11:01:49.136330 | instance | + ip addr 2026-04-17 11:01:49.138336 | instance | + ip route 2026-04-17 11:01:49.140740 | instance | + lsblk 2026-04-17 11:01:49.144278 | instance | + mount 2026-04-17 11:01:49.145967 | instance | + docker images 2026-04-17 11:01:49.146309 | instance | /bin/bash: line 7: docker: command not found 2026-04-17 11:01:49.146502 | instance | + brctl show 2026-04-17 11:01:49.146829 | instance | /bin/bash: line 8: brctl: command not found 2026-04-17 11:01:49.147011 | instance | + ps aux --sort=-%mem 2026-04-17 11:01:49.157634 | instance | + dpkg -l 2026-04-17 11:01:49.163938 | instance | + CONTAINERS=($(docker ps -a --format '{{ .Names }}' --filter label=zuul)) 2026-04-17 11:01:49.164469 | instance | ++ docker ps -a --format '{{ .Names }}' --filter label=zuul 2026-04-17 11:01:49.164514 | instance | /bin/bash: line 11: docker: command not found 2026-04-17 11:01:49.164770 | instance | + '[' '!' -z '' ']' 2026-04-17 11:01:49.329525 | instance | ok: Runtime: 0:00:00.043121 2026-04-17 11:01:49.339722 | 2026-04-17 11:01:49.339788 | TASK [gather-host-logs : Downloads logs to executor] 2026-04-17 11:01:49.960846 | instance | changed: 2026-04-17 11:01:49.961045 | instance | created directory /var/lib/zuul/builds/55c0ca3e39284c1cabfc7950ba64d357/work/logs/instance 2026-04-17 11:01:49.961075 | instance | cd+++++++++ system/ 2026-04-17 11:01:49.961097 | instance | >f+++++++++ system/brctl-show.txt 2026-04-17 11:01:49.961117 | instance | >f+++++++++ system/docker-images.txt 2026-04-17 11:01:49.961135 | instance | >f+++++++++ system/ip-addr.txt 2026-04-17 11:01:49.961159 | instance | >f+++++++++ system/ip-route.txt 2026-04-17 11:01:49.961180 | instance | >f+++++++++ system/lsblk.txt 2026-04-17 11:01:49.961200 | instance | >f+++++++++ system/mount.txt 2026-04-17 11:01:49.961221 | instance | >f+++++++++ system/packages.txt 2026-04-17 11:01:49.961240 | instance | >f+++++++++ system/ps.txt 2026-04-17 11:01:49.961259 | instance | >f+++++++++ system/systemd-cgls.txt 2026-04-17 11:01:49.970313 | 2026-04-17 11:01:49.970380 | LOOP [helm-release-status : creating directory for helm release status] 2026-04-17 11:01:50.190713 | instance | changed: "values" 2026-04-17 11:01:50.367619 | instance | changed: "releases" 2026-04-17 11:01:50.385580 | 2026-04-17 11:01:50.385734 | TASK [helm-release-status : Gather get release status for helm charts] 2026-04-17 11:01:50.591652 | instance | /bin/bash: line 3: kubectl: command not found 2026-04-17 11:01:50.922474 | instance | ok: Runtime: 0:00:00.005266 2026-04-17 11:01:50.929954 | 2026-04-17 11:01:50.930056 | TASK [helm-release-status : Downloads logs to executor] 2026-04-17 11:01:51.422328 | instance | changed: 2026-04-17 11:01:51.422534 | instance | cd+++++++++ helm/ 2026-04-17 11:01:51.422562 | instance | cd+++++++++ helm/releases/ 2026-04-17 11:01:51.422583 | instance | cd+++++++++ helm/values/ 2026-04-17 11:01:51.431731 | 2026-04-17 11:01:51.431804 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-04-17 11:01:51.640792 | instance | changed 2026-04-17 11:01:51.645918 | 2026-04-17 11:01:51.645995 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-04-17 11:01:51.849442 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-17 11:01:51.849858 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-17 11:01:51.855133 | instance | environment: line 1: kubectl: command not found 2026-04-17 11:01:51.856033 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-17 11:01:51.857252 | instance | environment: line 1: kubectl: command not found 2026-04-17 11:01:51.858256 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-17 11:01:51.859930 | instance | environment: line 1: kubectl: command not found 2026-04-17 11:01:51.861016 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-17 11:01:51.861061 | instance | environment: line 1: kubectl: command not found 2026-04-17 11:01:51.862198 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-17 11:01:51.863574 | instance | environment: line 1: kubectl: command not found 2026-04-17 11:01:51.865373 | instance | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-17 11:01:52.177038 | instance | ok: Runtime: 0:00:00.024976 2026-04-17 11:01:52.183196 | 2026-04-17 11:01:52.183265 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-04-17 11:01:52.390061 | instance | changed 2026-04-17 11:01:52.395326 | 2026-04-17 11:01:52.395397 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-04-17 11:01:52.639144 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-17 11:01:52.639363 | instance | environment: line 5: kubectl: command not found 2026-04-17 11:01:52.640166 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-17 11:01:52.641048 | instance | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-17 11:01:52.968460 | instance | ok: Runtime: 0:00:00.009205 2026-04-17 11:01:52.974269 | 2026-04-17 11:01:52.974340 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-04-17 11:01:53.441898 | instance | changed: 2026-04-17 11:01:53.442077 | instance | cd+++++++++ objects/ 2026-04-17 11:01:53.442115 | instance | cd+++++++++ objects/cluster/ 2026-04-17 11:01:53.442147 | instance | cd+++++++++ objects/namespaced/ 2026-04-17 11:01:53.453989 | 2026-04-17 11:01:53.454074 | TASK [gather-pod-logs : creating directory for pod logs] 2026-04-17 11:01:53.657613 | instance | changed 2026-04-17 11:01:53.664315 | 2026-04-17 11:01:53.664403 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-04-17 11:01:53.872909 | instance | changed 2026-04-17 11:01:53.877598 | 2026-04-17 11:01:53.877659 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-04-17 11:01:54.087132 | instance | environment: line 3: kubectl: command not found 2026-04-17 11:01:54.413862 | instance | ok: Runtime: 0:00:00.009269 2026-04-17 11:01:54.419597 | 2026-04-17 11:01:54.419674 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-04-17 11:01:54.901511 | instance | changed: 2026-04-17 11:01:54.901758 | instance | cd+++++++++ pod-logs/ 2026-04-17 11:01:54.901796 | instance | cd+++++++++ pod-logs/failed-pods/ 2026-04-17 11:01:54.914082 | 2026-04-17 11:01:54.914147 | TASK [gather-prom-metrics : creating directory for helm release descriptions] 2026-04-17 11:01:55.120933 | instance | changed 2026-04-17 11:01:55.126992 | 2026-04-17 11:01:55.127055 | TASK [gather-prom-metrics : Get metrics from exporter services in all namespaces] 2026-04-17 11:01:55.336744 | instance | /bin/bash: line 2: kubectl: command not found 2026-04-17 11:01:55.663773 | instance | ok: Runtime: 0:00:00.033053 2026-04-17 11:01:55.670187 | 2026-04-17 11:01:55.670271 | TASK [gather-prom-metrics : Get ceph metrics from ceph-mgr] 2026-04-17 11:01:55.879277 | instance | /bin/bash: line 2: kubectl: command not found 2026-04-17 11:01:55.907923 | instance | ceph-mgr endpoints: 2026-04-17 11:01:56.207198 | instance | ok: Runtime: 0:00:00.039390 2026-04-17 11:01:56.216295 | 2026-04-17 11:01:56.216368 | TASK [gather-prom-metrics : Get metrics from fluentd pods] 2026-04-17 11:01:56.430973 | instance | /bin/bash: line 4: kubectl: command not found 2026-04-17 11:01:56.752231 | instance | ok: Runtime: 0:00:00.046795 2026-04-17 11:01:56.760224 | 2026-04-17 11:01:56.760325 | TASK [gather-prom-metrics : Downloads logs to executor] 2026-04-17 11:01:57.241537 | instance | changed: cd+++++++++ prometheus/ 2026-04-17 11:01:57.254433 | 2026-04-17 11:01:57.254499 | TASK [gather-selenium-data : creating directory for helm release descriptions] 2026-04-17 11:01:57.463153 | instance | changed 2026-04-17 11:01:57.468035 | 2026-04-17 11:01:57.468100 | TASK [gather-selenium-data : Get selenium data] 2026-04-17 11:01:57.678149 | instance | + cp '/tmp/artifacts/*' /tmp/logs/selenium/. 2026-04-17 11:01:57.679597 | instance | cp: cannot stat '/tmp/artifacts/*': No such file or directory 2026-04-17 11:01:58.005630 | instance | ERROR 2026-04-17 11:01:58.006043 | instance | { 2026-04-17 11:01:58.006112 | instance | "delta": "0:00:00.005690", 2026-04-17 11:01:58.006159 | instance | "end": "2026-04-17 11:01:57.679939", 2026-04-17 11:01:58.006201 | instance | "msg": "non-zero return code", 2026-04-17 11:01:58.006241 | instance | "rc": 1, 2026-04-17 11:01:58.006280 | instance | "start": "2026-04-17 11:01:57.674249" 2026-04-17 11:01:58.006319 | instance | } 2026-04-17 11:01:58.006373 | instance | ERROR: Ignoring Errors 2026-04-17 11:01:58.012595 | 2026-04-17 11:01:58.012667 | TASK [gather-selenium-data : Downloads logs to executor] 2026-04-17 11:01:58.485650 | instance | changed: cd+++++++++ selenium/ 2026-04-17 11:01:58.494490 | 2026-04-17 11:01:58.494555 | PLAY RECAP 2026-04-17 11:01:58.494603 | instance | ok: 23 changed: 23 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 1 2026-04-17 11:01:58.494626 | 2026-04-17 11:01:58.657359 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/atmosphere/test-playbooks/molecule/post.yml@main] 2026-04-17 11:01:58.661523 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-17 11:01:59.204105 | 2026-04-17 11:01:59.204215 | PLAY [all] 2026-04-17 11:01:59.215396 | 2026-04-17 11:01:59.215471 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-17 11:01:59.260328 | instance | skipping: Conditional result was False 2026-04-17 11:01:59.268075 | 2026-04-17 11:01:59.268178 | TASK [fetch-output : Set log path for single node] 2026-04-17 11:01:59.312124 | instance | ok 2026-04-17 11:01:59.318205 | 2026-04-17 11:01:59.318294 | LOOP [fetch-output : Ensure local output dirs] 2026-04-17 11:01:59.706617 | instance -> localhost | ok: "/var/lib/zuul/builds/55c0ca3e39284c1cabfc7950ba64d357/work/logs" 2026-04-17 11:01:59.933141 | instance -> localhost | changed: "/var/lib/zuul/builds/55c0ca3e39284c1cabfc7950ba64d357/work/artifacts" 2026-04-17 11:02:00.152171 | instance -> localhost | changed: "/var/lib/zuul/builds/55c0ca3e39284c1cabfc7950ba64d357/work/docs" 2026-04-17 11:02:00.176760 | 2026-04-17 11:02:00.176884 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-17 11:02:00.783557 | instance | changed: .d..t...... ./ 2026-04-17 11:02:00.783771 | instance | changed: All items complete 2026-04-17 11:02:00.783798 | 2026-04-17 11:02:01.232603 | instance | changed: .d..t...... ./ 2026-04-17 11:02:01.680949 | instance | changed: .d..t...... ./ 2026-04-17 11:02:01.705031 | 2026-04-17 11:02:01.705159 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-17 11:02:02.122777 | instance -> localhost | ok: Item: artifacts Runtime: 0:00:00.007701 2026-04-17 11:02:02.358894 | instance -> localhost | ok: Item: docs Runtime: 0:00:00.008599 2026-04-17 11:02:02.382342 | 2026-04-17 11:02:02.382478 | PLAY [all] 2026-04-17 11:02:02.388553 | 2026-04-17 11:02:02.388620 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-17 11:02:02.807240 | instance | changed 2026-04-17 11:02:02.814534 | 2026-04-17 11:02:02.814585 | PLAY RECAP 2026-04-17 11:02:02.814636 | instance | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-17 11:02:02.814656 | 2026-04-17 11:02:02.916950 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-17 11:02:02.921293 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-17 11:02:03.450559 | 2026-04-17 11:02:03.450672 | PLAY [localhost] 2026-04-17 11:02:03.460041 | 2026-04-17 11:02:03.460109 | TASK [Generate Zuul manifest] 2026-04-17 11:02:03.483189 | localhost | ok 2026-04-17 11:02:03.501174 | 2026-04-17 11:02:03.501245 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-17 11:02:03.805129 | localhost | changed 2026-04-17 11:02:03.817881 | 2026-04-17 11:02:03.817952 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-17 11:02:03.848999 | localhost | ok 2026-04-17 11:02:03.857153 | 2026-04-17 11:02:03.857214 | TASK [Upload logs] 2026-04-17 11:02:03.881289 | localhost | ok 2026-04-17 11:02:03.937084 | 2026-04-17 11:02:03.937193 | TASK [Set zuul-log-path fact] 2026-04-17 11:02:03.966955 | localhost | ok 2026-04-17 11:02:03.981212 | 2026-04-17 11:02:03.981282 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-17 11:02:04.014049 | localhost | ok 2026-04-17 11:02:04.021777 | 2026-04-17 11:02:04.021842 | TASK [upload-logs : Create log directories] 2026-04-17 11:02:04.459148 | localhost | changed 2026-04-17 11:02:04.464410 | 2026-04-17 11:02:04.464474 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-17 11:02:04.841959 | localhost -> localhost | ok: Runtime: 0:00:00.005007 2026-04-17 11:02:04.849396 | 2026-04-17 11:02:04.849485 | TASK [upload-logs : Upload logs to log server] 2026-04-17 11:02:05.288552 | localhost | Output suppressed because no_log was given 2026-04-17 11:02:05.293932 | 2026-04-17 11:02:05.294026 | LOOP [upload-logs : Compress console log and json output] 2026-04-17 11:02:05.333728 | localhost | skipping: Conditional result was False 2026-04-17 11:02:05.340731 | localhost | skipping: Conditional result was False 2026-04-17 11:02:05.358345 | 2026-04-17 11:02:05.358529 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-17 11:02:05.397790 | localhost | skipping: Conditional result was False 2026-04-17 11:02:05.398191 | 2026-04-17 11:02:05.401598 | localhost | skipping: Conditional result was False 2026-04-17 11:02:05.411603 | 2026-04-17 11:02:05.411860 | LOOP [upload-logs : Upload console log and json output]