2026-04-18 17:31:24.708920 | Job console starting 2026-04-18 17:31:24.722904 | Updating git repos 2026-04-18 17:31:24.769755 | Cloning repos into workspace 2026-04-18 17:31:48.948463 | Restoring repo states 2026-04-18 17:31:48.963482 | Merging changes 2026-04-18 17:31:50.876450 | Checking out repos 2026-04-18 17:31:51.618719 | Preparing playbooks 2026-04-18 17:32:26.755027 | Running Ansible setup 2026-04-18 17:32:32.593566 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-18 17:32:33.217004 | 2026-04-18 17:32:33.217134 | PLAY [localhost] 2026-04-18 17:32:33.224464 | 2026-04-18 17:32:33.224536 | TASK [Gathering Facts] 2026-04-18 17:32:34.367623 | localhost | ok 2026-04-18 17:32:34.380461 | 2026-04-18 17:32:34.380703 | TASK [Setup log path fact] 2026-04-18 17:32:34.406212 | localhost | ok 2026-04-18 17:32:34.420618 | 2026-04-18 17:32:34.420787 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-18 17:32:34.473974 | localhost | ok 2026-04-18 17:32:34.492807 | 2026-04-18 17:32:34.493476 | TASK [emit-job-header : Print job information] 2026-04-18 17:32:34.531975 | # Job Information 2026-04-18 17:32:34.532132 | Ansible Version: 2.16.16 2026-04-18 17:32:34.532164 | Job: ansible-collection-kubernetes-molecule-cluster-api 2026-04-18 17:32:34.532186 | Pipeline: check 2026-04-18 17:32:34.532206 | Executor: 0a8996d2b663 2026-04-18 17:32:34.532226 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/257 2026-04-18 17:32:34.532248 | Event ID: a3a4eef0-3b4a-11f1-8954-de302ad0b341 2026-04-18 17:32:34.535018 | 2026-04-18 17:32:34.535084 | LOOP [emit-job-header : Print node information] 2026-04-18 17:32:34.616134 | localhost | ok: 2026-04-18 17:32:34.616703 | localhost | # Node Information 2026-04-18 17:32:34.616749 | localhost | Inventory Hostname: controller 2026-04-18 17:32:34.616781 | localhost | Hostname: np0000167516 2026-04-18 17:32:34.616810 | localhost | Username: zuul 2026-04-18 17:32:34.616842 | localhost | Distro: Debian 13.4 2026-04-18 17:32:34.616871 | localhost | Provider: yul1 2026-04-18 17:32:34.616899 | localhost | Region: ca-ymq-1 2026-04-18 17:32:34.616927 | localhost | Label: debian-trixie 2026-04-18 17:32:34.616974 | localhost | Product Name: OpenStack Nova 2026-04-18 17:32:34.617005 | localhost | Interface IP: 199.204.45.138 2026-04-18 17:32:34.639361 | 2026-04-18 17:32:34.639634 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-18 17:32:35.135173 | localhost -> localhost | changed 2026-04-18 17:32:35.141193 | 2026-04-18 17:32:35.141265 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-18 17:32:36.940577 | localhost -> localhost | changed 2026-04-18 17:32:36.946765 | 2026-04-18 17:32:36.946847 | PLAY [all] 2026-04-18 17:32:36.956856 | 2026-04-18 17:32:36.956975 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-18 17:32:37.188682 | controller -> localhost | ok 2026-04-18 17:32:37.197974 | 2026-04-18 17:32:37.198065 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-18 17:32:37.229073 | controller | ok 2026-04-18 17:32:37.858942 | controller | included: /var/lib/zuul/builds/4acbcb7c976b408e9eb0c99e57524dac/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-18 17:32:37.864909 | 2026-04-18 17:32:37.864998 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-18 17:32:39.723263 | controller -> localhost | Generating public/private rsa key pair. 2026-04-18 17:32:39.723533 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/4acbcb7c976b408e9eb0c99e57524dac/work/4acbcb7c976b408e9eb0c99e57524dac_id_rsa 2026-04-18 17:32:39.723565 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/4acbcb7c976b408e9eb0c99e57524dac/work/4acbcb7c976b408e9eb0c99e57524dac_id_rsa.pub 2026-04-18 17:32:39.723587 | controller -> localhost | The key fingerprint is: 2026-04-18 17:32:39.723608 | controller -> localhost | SHA256:mvlss4j4B/HnKrfMXyAjWn65+Aoq3CiDrJaJnnyYDzI zuul-build-sshkey 2026-04-18 17:32:39.723697 | controller -> localhost | The key's randomart image is: 2026-04-18 17:32:39.723738 | controller -> localhost | +---[RSA 3072]----+ 2026-04-18 17:32:39.723765 | controller -> localhost | | | 2026-04-18 17:32:39.723787 | controller -> localhost | | | 2026-04-18 17:32:39.723807 | controller -> localhost | | | 2026-04-18 17:32:39.723827 | controller -> localhost | | . | 2026-04-18 17:32:39.723846 | controller -> localhost | | ooo S | 2026-04-18 17:32:39.723865 | controller -> localhost | | +...B.. | 2026-04-18 17:32:39.723884 | controller -> localhost | |E.X ..*o . | 2026-04-18 17:32:39.723903 | controller -> localhost | |O%o=.*o=+. | 2026-04-18 17:32:39.726009 | controller -> localhost | |O=+o=*O==o | 2026-04-18 17:32:39.726044 | controller -> localhost | +----[SHA256]-----+ 2026-04-18 17:32:39.726093 | controller -> localhost | ok: Runtime: 0:00:01.321849 2026-04-18 17:32:39.731411 | 2026-04-18 17:32:39.731473 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-18 17:32:39.772852 | controller | ok 2026-04-18 17:32:39.787173 | controller | included: /var/lib/zuul/builds/4acbcb7c976b408e9eb0c99e57524dac/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-18 17:32:39.796888 | 2026-04-18 17:32:39.796968 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-18 17:32:39.826173 | controller | skipping: Conditional result was False 2026-04-18 17:32:39.836325 | 2026-04-18 17:32:39.836586 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-18 17:32:40.417323 | controller | changed 2026-04-18 17:32:40.425173 | 2026-04-18 17:32:40.425246 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-18 17:32:40.630862 | controller | ok 2026-04-18 17:32:40.641013 | 2026-04-18 17:32:40.641099 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-18 17:32:41.179195 | controller | changed 2026-04-18 17:32:41.185354 | 2026-04-18 17:32:41.185444 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-18 17:32:41.735195 | controller | changed 2026-04-18 17:32:41.740626 | 2026-04-18 17:32:41.740694 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-18 17:32:41.766191 | controller | skipping: Conditional result was False 2026-04-18 17:32:41.772140 | 2026-04-18 17:32:41.772226 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-18 17:32:42.161374 | controller -> localhost | changed 2026-04-18 17:32:42.169268 | 2026-04-18 17:32:42.169334 | TASK [add-build-sshkey : Add back temp key] 2026-04-18 17:32:53.013675 | controller -> localhost | Identity added: /var/lib/zuul/builds/4acbcb7c976b408e9eb0c99e57524dac/work/4acbcb7c976b408e9eb0c99e57524dac_id_rsa (zuul-build-sshkey) 2026-04-18 17:32:53.013926 | controller -> localhost | ok: Runtime: 0:00:00.012778 2026-04-18 17:32:53.018276 | 2026-04-18 17:32:53.018339 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-18 17:32:53.412714 | controller | ok 2026-04-18 17:32:53.417141 | 2026-04-18 17:32:53.417206 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-18 17:32:53.441274 | controller | skipping: Conditional result was False 2026-04-18 17:32:53.453484 | 2026-04-18 17:32:53.453572 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-18 17:32:53.829129 | controller | ok 2026-04-18 17:32:53.835709 | 2026-04-18 17:32:53.835775 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-18 17:35:58.322811 | controller | Output suppressed because no_log was given 2026-04-18 17:35:58.331766 | 2026-04-18 17:35:58.331830 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-18 17:36:14.263651 | controller | ok: "logs" 2026-04-18 17:36:14.263910 | controller | ok: All items complete 2026-04-18 17:36:14.263962 | 2026-04-18 17:36:14.447547 | controller | ok: "artifacts" 2026-04-18 17:36:14.630970 | controller | ok: "docs" 2026-04-18 17:36:14.645640 | 2026-04-18 17:36:14.645765 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-18 17:36:14.871940 | controller | changed: "logs" 2026-04-18 17:36:15.058718 | controller | changed: "artifacts" 2026-04-18 17:36:15.291878 | controller | changed: "docs" 2026-04-18 17:36:15.303003 | 2026-04-18 17:36:15.303081 | PLAY RECAP 2026-04-18 17:36:15.303141 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-18 17:36:15.303181 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-18 17:36:15.303210 | 2026-04-18 17:36:15.449357 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-18 17:36:15.450993 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-18 17:36:16.041311 | 2026-04-18 17:36:16.041447 | PLAY [all] 2026-04-18 17:36:16.052149 | 2026-04-18 17:36:16.052253 | TASK [setup-uv : Extract archive] 2026-04-18 17:36:18.780367 | controller | changed 2026-04-18 17:36:23.895847 | 2026-04-18 17:36:23.896002 | TASK [setup-uv : Print version] 2026-04-18 17:36:24.260503 | controller | uv 0.8.13 2026-04-18 17:36:24.434501 | controller | ok: Runtime: 0:00:00.014469 2026-04-18 17:36:24.442366 | 2026-04-18 17:36:24.442413 | PLAY RECAP 2026-04-18 17:36:24.442461 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-18 17:36:24.442487 | 2026-04-18 17:36:24.541629 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-18 17:36:24.547124 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-04-18 17:36:25.117742 | 2026-04-18 17:36:25.117867 | PLAY [all] 2026-04-18 17:36:25.127616 | 2026-04-18 17:36:25.127692 | TASK [Update apt cache] 2026-04-18 17:36:30.131915 | controller | ok 2026-04-18 17:36:30.897496 | 2026-04-18 17:36:30.897626 | TASK [Disable firewalld] 2026-04-18 17:36:30.921763 | controller | skipping: Conditional result was False 2026-04-18 17:36:30.927809 | 2026-04-18 17:36:30.927881 | TASK [Install "jq" for log collection] 2026-04-18 17:36:32.997848 | controller | changed 2026-04-18 17:36:33.000439 | 2026-04-18 17:36:33.000493 | PLAY RECAP 2026-04-18 17:36:33.000548 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-18 17:36:33.000570 | 2026-04-18 17:36:33.154593 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-04-18 17:36:33.157494 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-18 17:36:33.761713 | 2026-04-18 17:36:34.014053 | PLAY [all] 2026-04-18 17:36:34.038289 | 2026-04-18 17:36:34.038471 | TASK [Copy inventory file for Zuul] 2026-04-18 17:36:35.220056 | controller | changed 2026-04-18 17:36:35.232268 | 2026-04-18 17:36:35.232427 | TASK [Switch "ansible_host" to private IP] 2026-04-18 17:36:35.546849 | controller | changed: 1 replacements made 2026-04-18 17:36:35.554282 | 2026-04-18 17:36:35.554356 | TASK [Run Molecule scenario] 2026-04-18 17:36:35.997356 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-04-18 17:36:35.997462 | controller | Creating virtual environment at: .venv 2026-04-18 17:36:36.278680 | controller | Downloading pygments (1.2MiB) 2026-04-18 17:36:36.282279 | controller | Downloading cryptography (4.3MiB) 2026-04-18 17:36:36.282592 | controller | Downloading ansible-core (2.3MiB) 2026-04-18 17:36:36.454093 | controller | Downloading cryptography 2026-04-18 17:36:36.505898 | controller | Downloading pygments 2026-04-18 17:36:36.677395 | controller | Downloading ansible-core 2026-04-18 17:36:36.724226 | controller | Installed 36 packages in 46ms 2026-04-18 17:36:37.386125 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-04-18 17:36:37.386204 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-04-18 17:36:38.249559 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-04-18 17:36:38.249620 | controller | INFO default scenario not found, disabling shared state. 2026-04-18 17:36:38.249651 | controller | INFO [cluster-api > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-04-18 17:36:38.249744 | controller | INFO [cluster-api > prerun] Performing prerun with role_name_check=0... 2026-04-18 17:36:53.175215 | controller | INFO [cluster-api > dependency] Executing 2026-04-18 17:36:53.175290 | controller | WARNING [cluster-api > dependency] Missing roles requirements file: requirements.yml 2026-04-18 17:36:53.175508 | controller | WARNING [cluster-api > dependency] Missing collections requirements file: collections.yml 2026-04-18 17:36:53.175603 | controller | WARNING [cluster-api > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-04-18 17:36:53.180899 | controller | INFO [cluster-api > cleanup] Executing 2026-04-18 17:36:53.181194 | controller | WARNING [cluster-api > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-18 17:36:53.186427 | controller | INFO [cluster-api > destroy] Executing 2026-04-18 17:36:53.186448 | controller | WARNING [cluster-api > destroy] Skipping, '--destroy=never' requested. 2026-04-18 17:36:53.186462 | controller | INFO [cluster-api > destroy] Executed: Successful 2026-04-18 17:36:53.191815 | controller | INFO [cluster-api > syntax] Executing 2026-04-18 17:36:54.114638 | controller | 2026-04-18 17:36:54.114678 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/cluster-api/converge.yml 2026-04-18 17:36:54.178936 | controller | INFO [cluster-api > syntax] Executed: Successful 2026-04-18 17:36:54.190249 | controller | INFO [cluster-api > create] Executing 2026-04-18 17:36:54.191722 | controller | WARNING [cluster-api > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-18 17:36:54.197075 | controller | INFO [cluster-api > prepare] Executing 2026-04-18 17:36:55.553332 | controller | 2026-04-18 17:36:55.553385 | controller | PLAY [Prepare] ***************************************************************** 2026-04-18 17:36:55.553396 | controller | 2026-04-18 17:36:55.553406 | controller | TASK [Gathering Facts] ********************************************************* 2026-04-18 17:36:55.553415 | controller | Saturday 18 April 2026 17:36:55 +0000 (0:00:00.028) 0:00:00.028 ******** 2026-04-18 17:36:57.818641 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-04-18 17:36:57.821778 | controller | ok: [controller] 2026-04-18 17:36:57.821950 | controller | 2026-04-18 17:36:57.822148 | controller | TASK [Install Debian packages] ************************************************* 2026-04-18 17:36:57.822340 | controller | Saturday 18 April 2026 17:36:57 +0000 (0:00:02.269) 0:00:02.298 ******** 2026-04-18 17:36:59.421639 | controller | ok: [controller] 2026-04-18 17:36:59.421777 | controller | 2026-04-18 17:36:59.421958 | controller | PLAY [Configure Kubernetes VIP] ************************************************ 2026-04-18 17:36:59.422130 | controller | 2026-04-18 17:36:59.422323 | controller | TASK [Gathering Facts] ********************************************************* 2026-04-18 17:36:59.422518 | controller | Saturday 18 April 2026 17:36:59 +0000 (0:00:01.599) 0:00:03.898 ******** 2026-04-18 17:37:00.270001 | controller | ok: [controller] 2026-04-18 17:37:00.270169 | controller | 2026-04-18 17:37:00.270406 | controller | TASK [vexxhost.containers.directory : Create directory (/etc/kubernetes/manifests)] *** 2026-04-18 17:37:00.270632 | controller | Saturday 18 April 2026 17:37:00 +0000 (0:00:00.848) 0:00:04.746 ******** 2026-04-18 17:37:00.703791 | controller | changed: [controller] 2026-04-18 17:37:00.703961 | controller | 2026-04-18 17:37:00.704168 | controller | TASK [vexxhost.kubernetes.kube_vip : Uninstall legacy HA stack] **************** 2026-04-18 17:37:00.704363 | controller | Saturday 18 April 2026 17:37:00 +0000 (0:00:00.433) 0:00:05.180 ******** 2026-04-18 17:37:02.104406 | controller | ok: [controller] => (item=/etc/keepalived/keepalived.conf) 2026-04-18 17:37:02.104557 | controller | ok: [controller] => (item=/etc/keepalived/check_apiserver.sh) 2026-04-18 17:37:02.104766 | controller | ok: [controller] => (item=/etc/kubernetes/manifests/keepalived.yaml) 2026-04-18 17:37:02.104957 | controller | ok: [controller] => (item=/etc/haproxy/haproxy.cfg) 2026-04-18 17:37:02.105144 | controller | ok: [controller] => (item=/etc/kubernetes/manifests/haproxy.yaml) 2026-04-18 17:37:02.105310 | controller | 2026-04-18 17:37:02.105527 | controller | TASK [vexxhost.kubernetes.kube_vip : Switch API server to run on port 6443] **** 2026-04-18 17:37:02.105702 | controller | Saturday 18 April 2026 17:37:02 +0000 (0:00:01.400) 0:00:06.580 ******** 2026-04-18 17:37:02.508620 | controller | [ERROR]: Task failed: Module failed: Path /etc/kubernetes/manifests/kube-apiserver.yaml does not exist ! 2026-04-18 17:37:02.508815 | controller | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/kube_vip/tasks/main.yml:32:3 2026-04-18 17:37:02.508988 | controller | 2026-04-18 17:37:02.509181 | controller | 30 - Restart "kubelet" service 2026-04-18 17:37:02.509364 | controller | 31 2026-04-18 17:37:02.509562 | controller | 32 - name: Switch API server to run on port 6443 2026-04-18 17:37:02.509750 | controller | ^ column 3 2026-04-18 17:37:02.509920 | controller | 2026-04-18 17:37:02.510258 | controller | failed: [controller] (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-18 17:37:02.767564 | controller | [ERROR]: Task failed: Module failed: Path /etc/kubernetes/controller-manager.conf does not exist ! 2026-04-18 17:37:02.767749 | controller | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/kube_vip/tasks/main.yml:32:3 2026-04-18 17:37:02.767931 | controller | 2026-04-18 17:37:02.768131 | controller | 30 - Restart "kubelet" service 2026-04-18 17:37:02.768328 | controller | 31 2026-04-18 17:37:02.768653 | controller | 32 - name: Switch API server to run on port 6443 2026-04-18 17:37:02.768851 | controller | ^ column 3 2026-04-18 17:37:02.769028 | controller | 2026-04-18 17:37:02.769362 | controller | failed: [controller] (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-18 17:37:03.044165 | controller | [ERROR]: Task failed: Module failed: Path /etc/kubernetes/scheduler.conf does not exist ! 2026-04-18 17:37:03.044327 | controller | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/kube_vip/tasks/main.yml:32:3 2026-04-18 17:37:03.044449 | controller | 2026-04-18 17:37:03.044574 | controller | 30 - Restart "kubelet" service 2026-04-18 17:37:03.044691 | controller | 31 2026-04-18 17:37:03.046742 | controller | 32 - name: Switch API server to run on port 6443 2026-04-18 17:37:03.047348 | controller | ^ column 3 2026-04-18 17:37:03.047591 | controller | 2026-04-18 17:37:03.047985 | controller | failed: [controller] (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-18 17:37:03.056339 | controller | ...ignoring 2026-04-18 17:37:03.056534 | controller | 2026-04-18 17:37:03.056743 | controller | TASK [vexxhost.kubernetes.kube_vip : Check if super-admin.conf exists] ********* 2026-04-18 17:37:03.056940 | controller | Saturday 18 April 2026 17:37:03 +0000 (0:00:00.949) 0:00:07.529 ******** 2026-04-18 17:37:03.466966 | controller | ok: [controller] 2026-04-18 17:37:03.467102 | controller | 2026-04-18 17:37:03.467321 | controller | TASK [vexxhost.kubernetes.kube_vip : Check if kubeadm has already run] ********* 2026-04-18 17:37:03.467576 | controller | Saturday 18 April 2026 17:37:03 +0000 (0:00:00.412) 0:00:07.942 ******** 2026-04-18 17:37:03.761469 | controller | ok: [controller] 2026-04-18 17:37:03.761599 | controller | 2026-04-18 17:37:03.761812 | controller | TASK [vexxhost.kubernetes.kube_vip : Set fact with KUBECONFIG path] ************ 2026-04-18 17:37:03.762012 | controller | Saturday 18 April 2026 17:37:03 +0000 (0:00:00.294) 0:00:08.237 ******** 2026-04-18 17:37:03.799734 | controller | ok: [controller] 2026-04-18 17:37:03.799810 | controller | 2026-04-18 17:37:03.800074 | controller | TASK [vexxhost.kubernetes.kube_vip : Set fact with KUBECONFIG path (with super-admin.conf)] *** 2026-04-18 17:37:03.800249 | controller | Saturday 18 April 2026 17:37:03 +0000 (0:00:00.038) 0:00:08.276 ******** 2026-04-18 17:37:03.858259 | controller | ok: [controller] 2026-04-18 17:37:03.858334 | controller | 2026-04-18 17:37:03.858521 | controller | TASK [vexxhost.kubernetes.kube_vip : Upload Kubernetes manifest] *************** 2026-04-18 17:37:03.858767 | controller | Saturday 18 April 2026 17:37:03 +0000 (0:00:00.058) 0:00:08.334 ******** 2026-04-18 17:37:04.800722 | controller | ok: [controller] 2026-04-18 17:37:04.800842 | controller | 2026-04-18 17:37:04.801072 | controller | TASK [vexxhost.kubernetes.kube_vip : Ensure kube-vip configuration file] ******* 2026-04-18 17:37:04.801275 | controller | Saturday 18 April 2026 17:37:04 +0000 (0:00:00.941) 0:00:09.275 ******** 2026-04-18 17:37:05.168568 | controller | ok: [controller] 2026-04-18 17:37:05.168679 | controller | 2026-04-18 17:37:05.169059 | controller | TASK [vexxhost.kubernetes.kube_vip : Flush handlers] *************************** 2026-04-18 17:37:05.169265 | controller | Saturday 18 April 2026 17:37:05 +0000 (0:00:00.317) 0:00:09.593 ******** 2026-04-18 17:37:05.169443 | controller | 2026-04-18 17:37:05.169645 | controller | PLAY [Install Kubernetes] ****************************************************** 2026-04-18 17:37:05.169826 | controller | 2026-04-18 17:37:05.170022 | controller | TASK [Gathering Facts] ********************************************************* 2026-04-18 17:37:05.170226 | controller | Saturday 18 April 2026 17:37:05 +0000 (0:00:00.051) 0:00:09.645 ******** 2026-04-18 17:37:05.986693 | controller | ok: [controller] 2026-04-18 17:37:05.986822 | controller | 2026-04-18 17:37:05.987037 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-18 17:37:05.987230 | controller | Saturday 18 April 2026 17:37:05 +0000 (0:00:00.817) 0:00:10.462 ******** 2026-04-18 17:37:06.367864 | controller | ok: [controller] 2026-04-18 17:37:06.368086 | controller | 2026-04-18 17:37:06.368414 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-18 17:37:06.368698 | controller | Saturday 18 April 2026 17:37:06 +0000 (0:00:00.381) 0:00:10.844 ******** 2026-04-18 17:37:06.405981 | controller | skipping: [controller] 2026-04-18 17:37:06.406226 | controller | 2026-04-18 17:37:06.406512 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-04-18 17:37:06.406827 | controller | Saturday 18 April 2026 17:37:06 +0000 (0:00:00.038) 0:00:10.883 ******** 2026-04-18 17:37:06.727082 | controller | changed: [controller] 2026-04-18 17:37:06.727236 | controller | 2026-04-18 17:37:06.727458 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-18 17:37:06.727688 | controller | Saturday 18 April 2026 17:37:06 +0000 (0:00:00.320) 0:00:11.203 ******** 2026-04-18 17:37:06.823411 | controller | ok: [controller] => { 2026-04-18 17:37:06.823675 | controller | "msg": "https://github.com/opencontainers/runc/releases/download/v1.4.2/runc.amd64" 2026-04-18 17:37:06.823903 | controller | } 2026-04-18 17:37:06.824093 | controller | 2026-04-18 17:37:06.824310 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-18 17:37:06.824537 | controller | Saturday 18 April 2026 17:37:06 +0000 (0:00:00.096) 0:00:11.299 ******** 2026-04-18 17:37:07.771510 | controller | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created with a mode of 0700, this may cause issues when running as another user. To avoid this, create the remote_tmp dir with the correct permissions manually 2026-04-18 17:37:07.785062 | controller | changed: [controller] 2026-04-18 17:37:07.785209 | controller | 2026-04-18 17:37:07.785406 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-18 17:37:07.785608 | controller | Saturday 18 April 2026 17:37:07 +0000 (0:00:00.961) 0:00:12.261 ******** 2026-04-18 17:37:07.833847 | controller | skipping: [controller] 2026-04-18 17:37:07.833970 | controller | 2026-04-18 17:37:07.834173 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-18 17:37:07.834366 | controller | Saturday 18 April 2026 17:37:07 +0000 (0:00:00.049) 0:00:12.310 ******** 2026-04-18 17:37:08.140185 | controller | ok: [controller] 2026-04-18 17:37:08.140331 | controller | 2026-04-18 17:37:08.140557 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-18 17:37:08.140740 | controller | Saturday 18 April 2026 17:37:08 +0000 (0:00:00.305) 0:00:12.616 ******** 2026-04-18 17:37:09.110083 | controller | ok: [controller] 2026-04-18 17:37:09.110234 | controller | 2026-04-18 17:37:09.110441 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-18 17:37:09.110704 | controller | Saturday 18 April 2026 17:37:09 +0000 (0:00:00.969) 0:00:13.586 ******** 2026-04-18 17:37:09.199227 | controller | ok: [controller] => { 2026-04-18 17:37:09.199426 | controller | "msg": "https://github.com/containerd/containerd/releases/download/v2.2.2/containerd-2.2.2-linux-amd64.tar.gz" 2026-04-18 17:37:09.199724 | controller | } 2026-04-18 17:37:09.199802 | controller | 2026-04-18 17:37:09.200081 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-18 17:37:09.200268 | controller | Saturday 18 April 2026 17:37:09 +0000 (0:00:00.089) 0:00:13.676 ******** 2026-04-18 17:37:10.098663 | controller | changed: [controller] 2026-04-18 17:37:10.098920 | controller | 2026-04-18 17:37:10.099133 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-18 17:37:10.099339 | controller | Saturday 18 April 2026 17:37:10 +0000 (0:00:00.898) 0:00:14.574 ******** 2026-04-18 17:37:13.255463 | controller | changed: [controller] 2026-04-18 17:37:13.255502 | controller | 2026-04-18 17:37:13.255511 | controller | TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-04-18 17:37:13.255519 | controller | Saturday 18 April 2026 17:37:13 +0000 (0:00:03.156) 0:00:17.731 ******** 2026-04-18 17:37:13.291055 | controller | skipping: [controller] 2026-04-18 17:37:13.291086 | controller | 2026-04-18 17:37:13.291295 | controller | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-04-18 17:37:13.291323 | controller | Saturday 18 April 2026 17:37:13 +0000 (0:00:00.034) 0:00:17.765 ******** 2026-04-18 17:37:13.327004 | controller | skipping: [controller] 2026-04-18 17:37:13.327082 | controller | 2026-04-18 17:37:13.327172 | controller | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-04-18 17:37:13.327260 | controller | Saturday 18 April 2026 17:37:13 +0000 (0:00:00.036) 0:00:17.802 ******** 2026-04-18 17:37:13.356979 | controller | skipping: [controller] 2026-04-18 17:37:13.358609 | controller | 2026-04-18 17:37:13.358626 | controller | TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-04-18 17:37:13.358635 | controller | Saturday 18 April 2026 17:37:13 +0000 (0:00:00.031) 0:00:17.833 ******** 2026-04-18 17:37:18.915490 | controller | changed: [controller] 2026-04-18 17:37:18.915521 | controller | 2026-04-18 17:37:18.915528 | controller | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] *** 2026-04-18 17:37:18.915534 | controller | Saturday 18 April 2026 17:37:18 +0000 (0:00:05.556) 0:00:23.390 ******** 2026-04-18 17:37:19.646965 | controller | changed: [controller] 2026-04-18 17:37:19.647031 | controller | 2026-04-18 17:37:19.647168 | controller | TASK [vexxhost.containers.containerd : Create folders for configuration] ******* 2026-04-18 17:37:19.647297 | controller | Saturday 18 April 2026 17:37:19 +0000 (0:00:00.733) 0:00:24.123 ******** 2026-04-18 17:37:21.085936 | controller | changed: [controller] => (item={'path': '/etc/containerd'}) 2026-04-18 17:37:21.085996 | controller | changed: [controller] => (item={'path': '/var/lib/containerd', 'mode': '0o700'}) 2026-04-18 17:37:21.086103 | controller | changed: [controller] => (item={'path': '/run/containerd', 'mode': '0o711'}) 2026-04-18 17:37:21.086202 | controller | changed: [controller] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'}) 2026-04-18 17:37:21.086300 | controller | changed: [controller] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'}) 2026-04-18 17:37:21.086386 | controller | 2026-04-18 17:37:21.086468 | controller | TASK [vexxhost.containers.containerd : Create containerd config file] ********** 2026-04-18 17:37:21.086667 | controller | Saturday 18 April 2026 17:37:21 +0000 (0:00:01.439) 0:00:25.562 ******** 2026-04-18 17:37:21.923131 | controller | changed: [controller] 2026-04-18 17:37:21.923184 | controller | 2026-04-18 17:37:21.923240 | controller | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ******** 2026-04-18 17:37:21.923330 | controller | Saturday 18 April 2026 17:37:21 +0000 (0:00:00.824) 0:00:26.387 ******** 2026-04-18 17:37:21.923405 | controller | 2026-04-18 17:37:21.923487 | controller | RUNNING HANDLER [vexxhost.containers.containerd : Restart containerd] ********** 2026-04-18 17:37:21.923572 | controller | Saturday 18 April 2026 17:37:21 +0000 (0:00:00.010) 0:00:26.398 ******** 2026-04-18 17:37:22.816053 | controller | changed: [controller] 2026-04-18 17:37:22.816127 | controller | 2026-04-18 17:37:22.816221 | controller | RUNNING HANDLER [vexxhost.kubernetes.kubelet : Reload systemd] ***************** 2026-04-18 17:37:22.816336 | controller | Saturday 18 April 2026 17:37:22 +0000 (0:00:00.894) 0:00:27.292 ******** 2026-04-18 17:37:24.458644 | controller | ok: [controller] 2026-04-18 17:37:24.458706 | controller | 2026-04-18 17:37:24.458752 | controller | TASK [vexxhost.containers.containerd : Enable and start service] *************** 2026-04-18 17:37:24.458862 | controller | Saturday 18 April 2026 17:37:24 +0000 (0:00:01.642) 0:00:28.935 ******** 2026-04-18 17:37:25.218310 | controller | changed: [controller] 2026-04-18 17:37:25.218386 | controller | 2026-04-18 17:37:25.218399 | controller | TASK [vexxhost.kubernetes.kubernetes_upgrade_check : Retrieve the "kubeadm-config" ConfigMap] *** 2026-04-18 17:37:25.218502 | controller | Saturday 18 April 2026 17:37:25 +0000 (0:00:00.759) 0:00:29.695 ******** 2026-04-18 17:37:25.888932 | controller | [ERROR]: Task failed: Module failed: Failed to import the required Python library (kubernetes) on np0000167516's Python /usr/bin/python3.13. 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-18 17:37:25.888978 | controller | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/kubernetes_upgrade_check/tasks/main.yml:16:3 2026-04-18 17:37:25.888989 | controller | 2026-04-18 17:37:25.888998 | controller | 14 2026-04-18 17:37:25.889006 | controller | 15 --- 2026-04-18 17:37:25.889014 | controller | 16 - name: Retrieve the "kubeadm-config" ConfigMap 2026-04-18 17:37:25.889022 | controller | ^ column 3 2026-04-18 17:37:25.889029 | controller | 2026-04-18 17:37:25.889049 | controller | fatal: [controller]: FAILED! => {"changed": false, "msg": "Failed to import the required Python library (kubernetes) on np0000167516's Python /usr/bin/python3.13. 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-18 17:37:25.899445 | controller | ...ignoring 2026-04-18 17:37:25.899747 | controller | 2026-04-18 17:37:25.900032 | controller | TASK [vexxhost.kubernetes.kubernetes_upgrade_check : Parse the ClusterConfiguration] *** 2026-04-18 17:37:25.900291 | controller | Saturday 18 April 2026 17:37:25 +0000 (0:00:00.680) 0:00:30.375 ******** 2026-04-18 17:37:25.943151 | controller | skipping: [controller] 2026-04-18 17:37:25.943184 | controller | 2026-04-18 17:37:25.943321 | controller | TASK [vexxhost.kubernetes.kubernetes_upgrade_check : Retrieve the current Kubernetes version] *** 2026-04-18 17:37:25.943417 | controller | Saturday 18 April 2026 17:37:25 +0000 (0:00:00.042) 0:00:30.418 ******** 2026-04-18 17:37:25.982943 | controller | skipping: [controller] 2026-04-18 17:37:25.983078 | controller | 2026-04-18 17:37:25.983335 | controller | TASK [vexxhost.kubernetes.kubernetes_upgrade_check : Extract major, minor, and patch versions] *** 2026-04-18 17:37:25.983485 | controller | Saturday 18 April 2026 17:37:25 +0000 (0:00:00.040) 0:00:30.459 ******** 2026-04-18 17:37:26.031351 | controller | skipping: [controller] 2026-04-18 17:37:26.031391 | controller | 2026-04-18 17:37:26.031398 | controller | TASK [vexxhost.kubernetes.kubernetes_upgrade_check : Fail if we're jumping more than one minor version] *** 2026-04-18 17:37:26.031404 | controller | Saturday 18 April 2026 17:37:26 +0000 (0:00:00.045) 0:00:30.504 ******** 2026-04-18 17:37:26.075125 | controller | skipping: [controller] 2026-04-18 17:37:26.075230 | controller | 2026-04-18 17:37:26.075368 | controller | TASK [vexxhost.kubernetes.kubernetes_upgrade_check : Set fact if we need to upgrade] *** 2026-04-18 17:37:26.075496 | controller | Saturday 18 April 2026 17:37:26 +0000 (0:00:00.044) 0:00:30.549 ******** 2026-04-18 17:37:26.119472 | controller | skipping: [controller] 2026-04-18 17:37:26.119506 | controller | 2026-04-18 17:37:26.119626 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-18 17:37:26.119714 | controller | Saturday 18 April 2026 17:37:26 +0000 (0:00:00.046) 0:00:30.596 ******** 2026-04-18 17:37:26.462921 | controller | ok: [controller] 2026-04-18 17:37:26.462994 | controller | 2026-04-18 17:37:26.463004 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-18 17:37:26.463101 | controller | Saturday 18 April 2026 17:37:26 +0000 (0:00:00.343) 0:00:30.939 ******** 2026-04-18 17:37:26.518846 | controller | ok: [controller] => { 2026-04-18 17:37:26.518876 | controller | "msg": "https://dl.k8s.io/release/v1.34.0/bin/linux/amd64/kubeadm" 2026-04-18 17:37:26.518979 | controller | } 2026-04-18 17:37:26.519054 | controller | 2026-04-18 17:37:26.519144 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-18 17:37:26.522141 | controller | Saturday 18 April 2026 17:37:26 +0000 (0:00:00.053) 0:00:30.993 ******** 2026-04-18 17:37:42.322858 | controller | changed: [controller] 2026-04-18 17:37:42.323046 | controller | 2026-04-18 17:37:42.323251 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-18 17:37:42.323448 | controller | Saturday 18 April 2026 17:37:42 +0000 (0:00:15.806) 0:00:46.799 ******** 2026-04-18 17:37:42.368591 | controller | skipping: [controller] 2026-04-18 17:37:42.368751 | controller | 2026-04-18 17:37:42.368946 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-18 17:37:42.369137 | controller | Saturday 18 April 2026 17:37:42 +0000 (0:00:00.046) 0:00:46.845 ******** 2026-04-18 17:37:42.684450 | controller | ok: [controller] 2026-04-18 17:37:42.684578 | controller | 2026-04-18 17:37:42.684786 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-18 17:37:42.684976 | controller | Saturday 18 April 2026 17:37:42 +0000 (0:00:00.315) 0:00:47.161 ******** 2026-04-18 17:37:42.741741 | controller | ok: [controller] => { 2026-04-18 17:37:42.741900 | controller | "msg": "https://dl.k8s.io/release/v1.34.0/bin/linux/amd64/kubectl" 2026-04-18 17:37:42.742072 | controller | } 2026-04-18 17:37:42.742240 | controller | 2026-04-18 17:37:42.742430 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-18 17:37:42.742657 | controller | Saturday 18 April 2026 17:37:42 +0000 (0:00:00.057) 0:00:47.218 ******** 2026-04-18 17:37:53.827671 | controller | changed: [controller] 2026-04-18 17:37:53.827728 | controller | 2026-04-18 17:37:53.827740 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-18 17:37:53.827750 | controller | Saturday 18 April 2026 17:37:53 +0000 (0:00:11.084) 0:00:58.303 ******** 2026-04-18 17:37:53.874742 | controller | skipping: [controller] 2026-04-18 17:37:53.874816 | controller | 2026-04-18 17:37:53.874826 | controller | TASK [vexxhost.containers.containerd : Install SELinux packages] *************** 2026-04-18 17:37:53.874968 | controller | Saturday 18 April 2026 17:37:53 +0000 (0:00:00.045) 0:00:58.348 ******** 2026-04-18 17:37:53.915069 | controller | skipping: [controller] 2026-04-18 17:37:53.915149 | controller | 2026-04-18 17:37:53.915237 | controller | TASK [vexxhost.containers.containerd : Set SELinux to permissive at runtime] *** 2026-04-18 17:37:53.915328 | controller | Saturday 18 April 2026 17:37:53 +0000 (0:00:00.039) 0:00:58.388 ******** 2026-04-18 17:37:53.947147 | controller | skipping: [controller] 2026-04-18 17:37:53.947259 | controller | 2026-04-18 17:37:53.947380 | controller | TASK [vexxhost.containers.containerd : Persist SELinux permissive mode] ******** 2026-04-18 17:37:53.947493 | controller | Saturday 18 April 2026 17:37:53 +0000 (0:00:00.035) 0:00:58.423 ******** 2026-04-18 17:37:53.980590 | controller | skipping: [controller] 2026-04-18 17:37:53.980666 | controller | 2026-04-18 17:37:53.980829 | controller | TASK [vexxhost.containers.containerd : Install AppArmor packages] ************** 2026-04-18 17:37:53.980955 | controller | Saturday 18 April 2026 17:37:53 +0000 (0:00:00.033) 0:00:58.457 ******** 2026-04-18 17:37:54.951669 | controller | ok: [controller] 2026-04-18 17:37:54.951725 | controller | 2026-04-18 17:37:54.951790 | controller | TASK [vexxhost.containers.containerd : Create systemd service file for containerd] *** 2026-04-18 17:37:54.951889 | controller | Saturday 18 April 2026 17:37:54 +0000 (0:00:00.971) 0:00:59.428 ******** 2026-04-18 17:37:55.636078 | controller | ok: [controller] 2026-04-18 17:37:55.636136 | controller | 2026-04-18 17:37:55.636249 | controller | TASK [vexxhost.containers.containerd : Create folders for configuration] ******* 2026-04-18 17:37:55.636357 | controller | Saturday 18 April 2026 17:37:55 +0000 (0:00:00.684) 0:01:00.112 ******** 2026-04-18 17:37:57.111099 | controller | ok: [controller] => (item={'path': '/etc/containerd'}) 2026-04-18 17:37:57.111157 | controller | ok: [controller] => (item={'path': '/var/lib/containerd', 'mode': '0o700'}) 2026-04-18 17:37:57.111171 | controller | ok: [controller] => (item={'path': '/run/containerd', 'mode': '0o711'}) 2026-04-18 17:37:57.111338 | controller | ok: [controller] => (item={'path': '/run/containerd/io.containerd.grpc.v1.cri', 'mode': '0o700'}) 2026-04-18 17:37:57.111367 | controller | ok: [controller] => (item={'path': '/run/containerd/io.containerd.sandbox.controller.v1.shim', 'mode': '0o700'}) 2026-04-18 17:37:57.111466 | controller | 2026-04-18 17:37:57.111555 | controller | TASK [vexxhost.containers.containerd : Create containerd config file] ********** 2026-04-18 17:37:57.111645 | controller | Saturday 18 April 2026 17:37:57 +0000 (0:00:01.473) 0:01:01.586 ******** 2026-04-18 17:37:57.906608 | controller | ok: [controller] 2026-04-18 17:37:57.906633 | controller | 2026-04-18 17:37:57.906637 | controller | TASK [vexxhost.containers.containerd : Force any restarts if necessary] ******** 2026-04-18 17:37:57.906641 | controller | Saturday 18 April 2026 17:37:57 +0000 (0:00:00.790) 0:01:02.376 ******** 2026-04-18 17:37:57.906644 | controller | 2026-04-18 17:37:57.906648 | controller | TASK [vexxhost.containers.containerd : Enable and start service] *************** 2026-04-18 17:37:57.906651 | controller | Saturday 18 April 2026 17:37:57 +0000 (0:00:00.004) 0:01:02.381 ******** 2026-04-18 17:37:58.399050 | controller | ok: [controller] 2026-04-18 17:37:58.399119 | controller | 2026-04-18 17:37:58.399132 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-18 17:37:58.399234 | controller | Saturday 18 April 2026 17:37:58 +0000 (0:00:00.491) 0:01:02.873 ******** 2026-04-18 17:37:58.705666 | controller | ok: [controller] 2026-04-18 17:37:58.705731 | controller | 2026-04-18 17:37:58.705832 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-18 17:37:58.705968 | controller | Saturday 18 April 2026 17:37:58 +0000 (0:00:00.309) 0:01:03.182 ******** 2026-04-18 17:37:58.777959 | controller | ok: [controller] => { 2026-04-18 17:37:58.777992 | controller | "msg": "https://github.com/kubernetes-sigs/cri-tools/releases/download/v1.35.0/crictl-v1.35.0-linux-amd64.tar.gz" 2026-04-18 17:37:58.778104 | controller | } 2026-04-18 17:37:58.778182 | controller | 2026-04-18 17:37:58.778274 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-18 17:37:58.778416 | controller | Saturday 18 April 2026 17:37:58 +0000 (0:00:00.072) 0:01:03.254 ******** 2026-04-18 17:38:06.073900 | controller | changed: [controller] 2026-04-18 17:38:06.073965 | controller | 2026-04-18 17:38:06.073979 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-18 17:38:06.074082 | controller | Saturday 18 April 2026 17:38:06 +0000 (0:00:07.295) 0:01:10.550 ******** 2026-04-18 17:38:07.734150 | controller | changed: [controller] 2026-04-18 17:38:07.734194 | controller | 2026-04-18 17:38:07.734203 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-18 17:38:07.734213 | controller | Saturday 18 April 2026 17:38:07 +0000 (0:00:01.659) 0:01:12.210 ******** 2026-04-18 17:38:07.806172 | controller | ok: [controller] => { 2026-04-18 17:38:07.806214 | controller | "msg": "https://github.com/kubernetes-sigs/cri-tools/releases/download/v1.35.0/critest-v1.35.0-linux-amd64.tar.gz" 2026-04-18 17:38:07.806324 | controller | } 2026-04-18 17:38:07.806404 | controller | 2026-04-18 17:38:07.806610 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-18 17:38:07.806636 | controller | Saturday 18 April 2026 17:38:07 +0000 (0:00:00.072) 0:01:12.283 ******** 2026-04-18 17:38:14.998389 | controller | changed: [controller] 2026-04-18 17:38:14.998469 | controller | 2026-04-18 17:38:14.998479 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-18 17:38:14.998598 | controller | Saturday 18 April 2026 17:38:14 +0000 (0:00:07.192) 0:01:19.475 ******** 2026-04-18 17:38:16.679000 | controller | changed: [controller] 2026-04-18 17:38:16.679052 | controller | 2026-04-18 17:38:16.679126 | controller | TASK [vexxhost.containers.cri_tools : Create crictl config] ******************** 2026-04-18 17:38:16.679213 | controller | Saturday 18 April 2026 17:38:16 +0000 (0:00:01.679) 0:01:21.154 ******** 2026-04-18 17:38:17.357494 | controller | changed: [controller] 2026-04-18 17:38:17.357548 | controller | 2026-04-18 17:38:17.357597 | controller | TASK [vexxhost.containers.directory : Create directory (/opt/cni/bin)] ********* 2026-04-18 17:38:17.357708 | controller | Saturday 18 April 2026 17:38:17 +0000 (0:00:00.679) 0:01:21.834 ******** 2026-04-18 17:38:17.668717 | controller | changed: [controller] 2026-04-18 17:38:17.668767 | controller | 2026-04-18 17:38:17.668837 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-18 17:38:17.668923 | controller | Saturday 18 April 2026 17:38:17 +0000 (0:00:00.311) 0:01:22.145 ******** 2026-04-18 17:38:17.983046 | controller | ok: [controller] 2026-04-18 17:38:17.983090 | controller | 2026-04-18 17:38:17.983163 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-18 17:38:17.983251 | controller | Saturday 18 April 2026 17:38:17 +0000 (0:00:00.312) 0:01:22.458 ******** 2026-04-18 17:38:18.045219 | controller | ok: [controller] => { 2026-04-18 17:38:18.045279 | controller | "msg": "https://github.com/containernetworking/plugins/releases/download/v1.9.0/cni-plugins-linux-amd64-v1.9.0.tgz" 2026-04-18 17:38:18.045372 | controller | } 2026-04-18 17:38:18.045452 | controller | 2026-04-18 17:38:18.045546 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-18 17:38:18.045635 | controller | Saturday 18 April 2026 17:38:18 +0000 (0:00:00.063) 0:01:22.522 ******** 2026-04-18 17:38:50.290739 | controller | [ERROR]: Task failed: Module failed: Request failed 2026-04-18 17:38:50.290812 | controller | Origin: /home/zuul/.ansible/collections/ansible_collections/vexxhost/containers/roles/download_artifact/tasks/main.yml:19:3 2026-04-18 17:38:50.290960 | controller | 2026-04-18 17:38:50.291143 | controller | 17 msg: "{{ download_artifact_url }}" 2026-04-18 17:38:50.291317 | controller | 18 2026-04-18 17:38:50.291570 | controller | 19 - name: Download item 2026-04-18 17:38:50.291857 | controller | ^ column 3 2026-04-18 17:38:50.294729 | controller | 2026-04-18 17:38:50.295106 | controller | fatal: [controller]: 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-18 17:38:50.298401 | controller | FAILED - RETRYING: [controller]: Download item (4 retries left). 2026-04-18 17:38:50.298462 | controller | FAILED - RETRYING: [controller]: Download item (3 retries left). 2026-04-18 17:38:50.298561 | controller | FAILED - RETRYING: [controller]: Download item (2 retries left). 2026-04-18 17:38:50.298661 | controller | FAILED - RETRYING: [controller]: Download item (1 retries left). 2026-04-18 17:38:50.298768 | controller | 2026-04-18 17:38:50.298885 | controller | PLAY RECAP ********************************************************************* 2026-04-18 17:38:50.299044 | controller | controller : ok=52 changed=19 unreachable=0 failed=1 skipped=15 rescued=0 ignored=2 2026-04-18 17:38:50.299140 | controller | 2026-04-18 17:38:50.299250 | controller | 2026-04-18 17:38:50.299375 | controller | TASKS RECAP ******************************************************************** 2026-04-18 17:38:50.299502 | controller | Saturday 18 April 2026 17:38:50 +0000 (0:00:32.254) 0:01:54.776 ******** 2026-04-18 17:38:50.299618 | controller | =============================================================================== 2026-04-18 17:38:50.299747 | controller | vexxhost.containers.download_artifact : Download item ------------------ 32.25s 2026-04-18 17:38:50.299870 | controller | vexxhost.containers.download_artifact : Download item ------------------ 15.81s 2026-04-18 17:38:50.299993 | controller | vexxhost.containers.download_artifact : Download item ------------------ 11.08s 2026-04-18 17:38:50.300118 | controller | vexxhost.containers.download_artifact : Download item ------------------- 7.30s 2026-04-18 17:38:50.300241 | controller | vexxhost.containers.download_artifact : Download item ------------------- 7.19s 2026-04-18 17:38:50.300366 | controller | vexxhost.containers.containerd : Install AppArmor packages -------------- 5.56s 2026-04-18 17:38:50.300489 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 3.16s 2026-04-18 17:38:50.300609 | controller | Gathering Facts --------------------------------------------------------- 2.27s 2026-04-18 17:38:50.300731 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.68s 2026-04-18 17:38:50.300879 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.66s 2026-04-18 17:38:50.301017 | controller | vexxhost.kubernetes.kubelet : Reload systemd ---------------------------- 1.64s 2026-04-18 17:38:50.301139 | controller | Install Debian packages ------------------------------------------------- 1.60s 2026-04-18 17:38:50.301259 | controller | vexxhost.containers.containerd : Create folders for configuration ------- 1.47s 2026-04-18 17:38:50.301381 | controller | vexxhost.containers.containerd : Create folders for configuration ------- 1.44s 2026-04-18 17:38:50.301505 | controller | vexxhost.kubernetes.kube_vip : Uninstall legacy HA stack ---------------- 1.40s 2026-04-18 17:38:50.301628 | controller | vexxhost.containers.containerd : Install AppArmor packages -------------- 0.97s 2026-04-18 17:38:50.301751 | controller | vexxhost.containers.package : Update state for tar ---------------------- 0.97s 2026-04-18 17:38:50.301874 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.96s 2026-04-18 17:38:50.301999 | controller | vexxhost.kubernetes.kube_vip : Switch API server to run on port 6443 ---- 0.95s 2026-04-18 17:38:50.302123 | controller | vexxhost.kubernetes.kube_vip : Upload Kubernetes manifest --------------- 0.94s 2026-04-18 17:38:50.516155 | controller | CRITICAL Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.Bs5j.cluster-api/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/inventory.yaml /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/cluster-api/prepare.yml 2026-04-18 17:38:50.516324 | controller | ERROR [cluster-api > prepare] Executed: Failed 2026-04-18 17:38:50.516487 | controller | ERROR Ansible return code was 2, command was: ansible-playbook --inventory /home/zuul/.ansible/tmp/molecule.Bs5j.cluster-api/inventory --skip-tags molecule-notest,notest --inventory=/home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/inventory.yaml /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/cluster-api/prepare.yml 2026-04-18 17:38:54.180997 | controller | ERROR 2026-04-18 17:38:59.989107 | controller | { 2026-04-18 17:38:59.989252 | controller | "delta": "0:02:14.689958", 2026-04-18 17:38:59.989360 | controller | "end": "2026-04-18 17:38:50.604228", 2026-04-18 17:38:59.989430 | controller | "msg": "non-zero return code", 2026-04-18 17:38:59.989515 | controller | "rc": 2, 2026-04-18 17:38:59.989590 | controller | "start": "2026-04-18 17:36:35.914270" 2026-04-18 17:38:59.989793 | controller | } failure 2026-04-18 17:39:00.003330 | 2026-04-18 17:39:00.003422 | PLAY RECAP 2026-04-18 17:39:00.003470 | controller | ok: 2 changed: 2 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-04-18 17:39:00.003493 | 2026-04-18 17:39:00.123517 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-18 17:39:00.127710 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-04-18 17:39:00.713628 | 2026-04-18 17:39:07.899166 | PLAY [all] 2026-04-18 17:39:07.917477 | 2026-04-18 17:39:07.917577 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-04-18 17:39:17.854037 | controller | changed 2026-04-18 17:39:22.796436 | 2026-04-18 17:39:22.796585 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-04-18 17:39:23.186154 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-18 17:39:23.186265 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-18 17:39:23.195059 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-18 17:39:23.199320 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-18 17:39:23.245330 | controller | E0418 17:39:23.244924 3069 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:23.245387 | controller | E0418 17:39:23.245231 3069 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:23.247066 | controller | E0418 17:39:23.247045 3069 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:23.247432 | controller | E0418 17:39:23.247412 3069 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:23.248932 | controller | E0418 17:39:23.248916 3069 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:23.248977 | controller | The connection to the server localhost:8080 was refused - did you specify the right host or port? 2026-04-18 17:39:23.251980 | controller | E0418 17:39:23.251887 3073 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:23.252842 | controller | E0418 17:39:23.252806 3073 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:23.254711 | controller | E0418 17:39:23.254667 3073 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:23.255268 | controller | E0418 17:39:23.255210 3073 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:23.257063 | controller | E0418 17:39:23.256998 3073 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:23.257104 | controller | The connection to the server localhost:8080 was refused - did you specify the right host or port? 2026-04-18 17:39:23.262440 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-18 17:39:23.267121 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-18 17:39:23.313317 | controller | E0418 17:39:23.313158 3094 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:23.313889 | controller | E0418 17:39:23.313837 3094 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:23.316098 | controller | E0418 17:39:23.315212 3094 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:23.316132 | controller | E0418 17:39:23.315465 3094 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:23.317034 | controller | E0418 17:39:23.316959 3094 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:23.317057 | controller | The connection to the server localhost:8080 was refused - did you specify the right host or port? 2026-04-18 17:39:23.321010 | controller | E0418 17:39:23.320916 3101 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:23.321723 | controller | E0418 17:39:23.321684 3101 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:23.323613 | controller | E0418 17:39:23.323289 3101 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:23.324154 | controller | E0418 17:39:23.324110 3101 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:23.325766 | controller | E0418 17:39:23.325722 3101 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:23.325805 | controller | The connection to the server localhost:8080 was refused - did you specify the right host or port? 2026-04-18 17:39:23.327912 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-18 17:39:23.389077 | controller | E0418 17:39:23.388917 3117 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:23.390004 | controller | E0418 17:39:23.389959 3117 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:23.390722 | controller | E0418 17:39:23.390667 3117 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:23.392390 | controller | E0418 17:39:23.392352 3117 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:23.393159 | controller | E0418 17:39:23.393119 3117 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:23.394367 | controller | The connection to the server localhost:8080 was refused - did you specify the right host or port? 2026-04-18 17:39:25.270898 | controller | ok: Runtime: 0:00:00.227495 2026-04-18 17:39:25.275568 | 2026-04-18 17:39:25.275691 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-04-18 17:39:25.536633 | controller | changed 2026-04-18 17:39:25.545271 | 2026-04-18 17:39:25.545391 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-04-18 17:39:25.791836 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-18 17:39:25.791901 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-18 17:39:25.792177 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-18 17:39:25.855587 | controller | E0418 17:39:25.855432 3150 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:25.856609 | controller | E0418 17:39:25.856456 3150 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:25.857556 | controller | E0418 17:39:25.857498 3150 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:25.858437 | controller | E0418 17:39:25.858382 3150 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:25.860372 | controller | E0418 17:39:25.860326 3150 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:25.860416 | controller | The connection to the server localhost:8080 was refused - did you specify the right host or port? 2026-04-18 17:39:26.076414 | controller | ok: Runtime: 0:00:00.084567 2026-04-18 17:39:26.081732 | 2026-04-18 17:39:26.081801 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-04-18 17:39:26.724794 | controller | changed: 2026-04-18 17:39:26.724954 | controller | created directory /var/lib/zuul/builds/4acbcb7c976b408e9eb0c99e57524dac/work/logs/controller 2026-04-18 17:39:26.725001 | controller | cd+++++++++ objects/ 2026-04-18 17:39:26.725026 | controller | cd+++++++++ objects/cluster/ 2026-04-18 17:39:26.725049 | controller | cd+++++++++ objects/namespaced/ 2026-04-18 17:39:26.752556 | 2026-04-18 17:39:26.752664 | TASK [gather-pod-logs : creating directory for pod logs] 2026-04-18 17:39:26.990375 | controller | changed 2026-04-18 17:39:38.021321 | 2026-04-18 17:39:38.021446 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-04-18 17:39:38.258442 | controller | changed 2026-04-18 17:39:38.264207 | 2026-04-18 17:39:38.264275 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-04-18 17:39:38.559534 | controller | E0418 17:39:38.559351 3205 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:38.561138 | controller | E0418 17:39:38.560406 3205 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:38.561168 | controller | E0418 17:39:38.561044 3205 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:38.563154 | controller | E0418 17:39:38.563118 3205 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:38.564101 | controller | E0418 17:39:38.564065 3205 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:38.565358 | controller | The connection to the server localhost:8080 was refused - did you specify the right host or port? 2026-04-18 17:39:41.164263 | controller | ok: Runtime: 0:00:00.077003 2026-04-18 17:39:41.169931 | 2026-04-18 17:39:41.170008 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-04-18 17:39:46.283392 | controller | changed: 2026-04-18 17:39:46.283577 | controller | cd+++++++++ pod-logs/ 2026-04-18 17:39:46.283616 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-04-18 17:39:46.293017 | 2026-04-18 17:39:46.293135 | LOOP [helm-release-status : creating directory for helm release status] 2026-04-18 17:39:46.531293 | controller | changed: "values" 2026-04-18 17:39:46.732010 | controller | changed: "releases" 2026-04-18 17:39:51.117828 | 2026-04-18 17:39:51.117959 | TASK [helm-release-status : Gather get release status for helm charts] 2026-04-18 17:39:51.431324 | controller | E0418 17:39:51.431077 3255 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:51.432388 | controller | E0418 17:39:51.432284 3255 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:51.433096 | controller | E0418 17:39:51.433021 3255 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:51.434764 | controller | E0418 17:39:51.434703 3255 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:51.435412 | controller | E0418 17:39:51.435356 3255 memcache.go:265] "Unhandled Error" err="couldn't get current server API group list: Get \"http://localhost:8080/api?timeout=32s\": dial tcp [::1]:8080: connect: connection refused" 2026-04-18 17:39:51.436571 | controller | The connection to the server localhost:8080 was refused - did you specify the right host or port? 2026-04-18 17:39:54.857036 | controller | ok: Runtime: 0:00:00.080887 2026-04-18 17:39:54.862179 | 2026-04-18 17:39:54.862245 | TASK [helm-release-status : Downloads logs to executor] 2026-04-18 17:39:58.221189 | controller | changed: 2026-04-18 17:39:58.221370 | controller | cd+++++++++ helm/ 2026-04-18 17:39:58.221405 | controller | cd+++++++++ helm/releases/ 2026-04-18 17:39:58.221442 | controller | cd+++++++++ helm/values/ 2026-04-18 17:39:58.226514 | 2026-04-18 17:39:58.226574 | PLAY RECAP 2026-04-18 17:39:58.226626 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-18 17:39:58.226649 | 2026-04-18 17:39:58.340675 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-04-18 17:39:58.345831 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-18 17:39:59.711422 | 2026-04-18 17:39:59.711539 | PLAY [all] 2026-04-18 17:39:59.721245 | 2026-04-18 17:39:59.721320 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-18 17:39:59.765638 | controller | skipping: Conditional result was False 2026-04-18 17:39:59.775188 | 2026-04-18 17:39:59.775265 | TASK [fetch-output : Set log path for single node] 2026-04-18 17:39:59.816093 | controller | ok 2026-04-18 17:39:59.821009 | 2026-04-18 17:39:59.821075 | LOOP [fetch-output : Ensure local output dirs] 2026-04-18 17:40:00.202422 | controller -> localhost | ok: "/var/lib/zuul/builds/4acbcb7c976b408e9eb0c99e57524dac/work/logs" 2026-04-18 17:40:00.415285 | controller -> localhost | changed: "/var/lib/zuul/builds/4acbcb7c976b408e9eb0c99e57524dac/work/artifacts" 2026-04-18 17:40:00.633617 | controller -> localhost | changed: "/var/lib/zuul/builds/4acbcb7c976b408e9eb0c99e57524dac/work/docs" 2026-04-18 17:40:00.647213 | 2026-04-18 17:40:00.647364 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-18 17:40:01.331446 | controller | changed: .d..t...... ./ 2026-04-18 17:40:01.331670 | controller | changed: All items complete 2026-04-18 17:40:01.331708 | 2026-04-18 17:40:02.997993 | controller | changed: .d..t...... ./ 2026-04-18 17:40:03.486807 | controller | changed: .d..t...... ./ 2026-04-18 17:40:03.498587 | 2026-04-18 17:40:03.498732 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-18 17:40:03.946497 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.007689 2026-04-18 17:40:04.178304 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007383 2026-04-18 17:40:04.191218 | 2026-04-18 17:40:04.191374 | PLAY [all] 2026-04-18 17:40:04.196806 | 2026-04-18 17:40:04.196872 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-18 17:40:04.938945 | controller | changed 2026-04-18 17:40:04.944404 | 2026-04-18 17:40:04.944453 | PLAY RECAP 2026-04-18 17:40:04.944494 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-18 17:40:04.944515 | 2026-04-18 17:40:05.047739 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-18 17:40:05.051174 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-18 17:40:05.624109 | 2026-04-18 17:40:05.624231 | PLAY [localhost] 2026-04-18 17:40:05.634434 | 2026-04-18 17:40:05.634528 | TASK [Generate Zuul manifest] 2026-04-18 17:40:05.655765 | localhost | ok 2026-04-18 17:40:05.674390 | 2026-04-18 17:40:05.674484 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-18 17:40:06.002211 | localhost | changed 2026-04-18 17:40:06.014961 | 2026-04-18 17:40:06.015074 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-18 17:40:06.179322 | localhost | ok 2026-04-18 17:40:07.982606 | 2026-04-18 17:40:07.982713 | TASK [Upload logs] 2026-04-18 17:40:08.002089 | localhost | ok 2026-04-18 17:40:08.061843 | 2026-04-18 17:40:08.061962 | TASK [Set zuul-log-path fact] 2026-04-18 17:40:08.082708 | localhost | ok 2026-04-18 17:40:08.095530 | 2026-04-18 17:40:08.095600 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-18 17:40:08.138635 | localhost | ok 2026-04-18 17:40:08.147412 | 2026-04-18 17:40:08.147478 | TASK [upload-logs : Create log directories] 2026-04-18 17:40:08.560830 | localhost | changed 2026-04-18 17:40:08.565636 | 2026-04-18 17:40:08.565706 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-18 17:40:08.992883 | localhost -> localhost | ok: Runtime: 0:00:00.005592 2026-04-18 17:40:08.998758 | 2026-04-18 17:40:08.998823 | TASK [upload-logs : Upload logs to log server] 2026-04-18 17:40:10.309001 | localhost | Output suppressed because no_log was given 2026-04-18 17:40:10.391961 | 2026-04-18 17:40:10.392085 | LOOP [upload-logs : Compress console log and json output] 2026-04-18 17:40:10.448827 | localhost | skipping: Conditional result was False 2026-04-18 17:40:10.460261 | localhost | skipping: Conditional result was False 2026-04-18 17:40:10.476124 | 2026-04-18 17:40:10.476281 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-18 17:40:10.518265 | localhost | skipping: Conditional result was False 2026-04-18 17:40:10.518522 | 2026-04-18 17:40:10.522978 | localhost | skipping: Conditional result was False 2026-04-18 17:40:10.534172 | 2026-04-18 17:40:10.534352 | LOOP [upload-logs : Upload console log and json output]