2026-03-30 15:19:29.116949 | Job console starting 2026-03-30 15:19:29.143956 | Updating git repos 2026-03-30 15:19:29.202138 | Cloning repos into workspace 2026-03-30 15:19:29.267182 | Restoring repo states 2026-03-30 15:19:29.280883 | Merging changes 2026-03-30 15:19:30.317372 | Checking out repos 2026-03-30 15:19:30.449508 | Preparing playbooks 2026-03-30 15:19:34.762602 | Running Ansible setup 2026-03-30 15:19:38.599567 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-30 15:19:39.282018 | 2026-03-30 15:19:39.282199 | PLAY [localhost] 2026-03-30 15:19:39.292014 | 2026-03-30 15:19:39.292163 | TASK [Gathering Facts] 2026-03-30 15:19:40.497593 | localhost | ok 2026-03-30 15:19:40.509730 | 2026-03-30 15:19:40.509895 | TASK [Setup log path fact] 2026-03-30 15:19:40.531312 | localhost | ok 2026-03-30 15:19:40.544136 | 2026-03-30 15:19:40.544270 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-30 15:19:40.575534 | localhost | ok 2026-03-30 15:19:40.587182 | 2026-03-30 15:19:40.587354 | TASK [emit-job-header : Print job information] 2026-03-30 15:19:40.627800 | # Job Information 2026-03-30 15:19:40.628018 | Ansible Version: 2.16.16 2026-03-30 15:19:40.628078 | Job: ansible-collection-kubernetes-molecule-helm 2026-03-30 15:19:40.628118 | Pipeline: check 2026-03-30 15:19:40.628151 | Executor: 0a8996d2b663 2026-03-30 15:19:40.628181 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/247 2026-03-30 15:19:40.628216 | Event ID: a68e9ed0-2c4b-11f1-9a15-b38dc8686e9c 2026-03-30 15:19:40.632428 | 2026-03-30 15:19:40.632516 | LOOP [emit-job-header : Print node information] 2026-03-30 15:19:40.723024 | localhost | ok: 2026-03-30 15:19:40.723284 | localhost | # Node Information 2026-03-30 15:19:40.723331 | localhost | Inventory Hostname: controller 2026-03-30 15:19:40.723367 | localhost | Hostname: np0000161249 2026-03-30 15:19:40.723401 | localhost | Username: zuul 2026-03-30 15:19:40.723436 | localhost | Distro: Debian 13.4 2026-03-30 15:19:40.723468 | localhost | Provider: yul1 2026-03-30 15:19:40.723500 | localhost | Region: ca-ymq-1 2026-03-30 15:19:40.723532 | localhost | Label: debian-trixie 2026-03-30 15:19:40.723561 | localhost | Product Name: OpenStack Nova 2026-03-30 15:19:40.723592 | localhost | Interface IP: 199.204.45.95 2026-03-30 15:19:40.735081 | 2026-03-30 15:19:40.735275 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-30 15:19:41.146186 | localhost -> localhost | changed 2026-03-30 15:19:41.152455 | 2026-03-30 15:19:41.152538 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-30 15:19:42.077687 | localhost -> localhost | changed 2026-03-30 15:19:42.085197 | 2026-03-30 15:19:42.085305 | PLAY [all] 2026-03-30 15:19:42.093852 | 2026-03-30 15:19:42.093929 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-30 15:19:42.422644 | controller -> localhost | ok 2026-03-30 15:19:42.430783 | 2026-03-30 15:19:42.430891 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-30 15:19:42.461943 | controller | ok 2026-03-30 15:19:42.479489 | controller | included: /var/lib/zuul/builds/34d24a932b5b47b69041e5084ff399e2/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-30 15:19:42.486505 | 2026-03-30 15:19:42.486689 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-30 15:19:43.383917 | controller -> localhost | Generating public/private rsa key pair. 2026-03-30 15:19:43.384161 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/34d24a932b5b47b69041e5084ff399e2/work/34d24a932b5b47b69041e5084ff399e2_id_rsa 2026-03-30 15:19:43.384215 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/34d24a932b5b47b69041e5084ff399e2/work/34d24a932b5b47b69041e5084ff399e2_id_rsa.pub 2026-03-30 15:19:43.384256 | controller -> localhost | The key fingerprint is: 2026-03-30 15:19:43.384298 | controller -> localhost | SHA256:FDLtqr9zM5sQ2eKyOuvjIzV66pY/6IVxu68c5ftYWeU zuul-build-sshkey 2026-03-30 15:19:43.384354 | controller -> localhost | The key's randomart image is: 2026-03-30 15:19:43.384386 | controller -> localhost | +---[RSA 3072]----+ 2026-03-30 15:19:43.384426 | controller -> localhost | | o.. | 2026-03-30 15:19:43.384457 | controller -> localhost | | o.. | 2026-03-30 15:19:43.384487 | controller -> localhost | | .. . | 2026-03-30 15:19:43.384517 | controller -> localhost | | +. o | 2026-03-30 15:19:43.384717 | controller -> localhost | | . . .+.S. E | 2026-03-30 15:19:43.384761 | controller -> localhost | | * +..oo | 2026-03-30 15:19:43.384802 | controller -> localhost | | +o=.ooo | 2026-03-30 15:19:43.384862 | controller -> localhost | |o+B.+o=.+. | 2026-03-30 15:19:43.384909 | controller -> localhost | |=O*@==+=o+ | 2026-03-30 15:19:43.384969 | controller -> localhost | +----[SHA256]-----+ 2026-03-30 15:19:43.385069 | controller -> localhost | ok: Runtime: 0:00:00.454481 2026-03-30 15:19:43.393793 | 2026-03-30 15:19:43.393946 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-30 15:19:43.424163 | controller | ok 2026-03-30 15:19:43.435039 | controller | included: /var/lib/zuul/builds/34d24a932b5b47b69041e5084ff399e2/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-30 15:19:43.445989 | 2026-03-30 15:19:43.446110 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-30 15:19:43.480819 | controller | skipping: Conditional result was False 2026-03-30 15:19:43.487820 | 2026-03-30 15:19:43.487938 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-30 15:19:44.045379 | controller | changed 2026-03-30 15:19:44.050673 | 2026-03-30 15:19:44.050754 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-30 15:19:44.262498 | controller | ok 2026-03-30 15:19:44.267807 | 2026-03-30 15:19:44.267876 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-30 15:19:44.904827 | controller | changed 2026-03-30 15:19:44.910733 | 2026-03-30 15:19:44.910839 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-30 15:19:45.463562 | controller | changed 2026-03-30 15:19:45.471092 | 2026-03-30 15:19:45.471182 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-30 15:19:45.495181 | controller | skipping: Conditional result was False 2026-03-30 15:19:45.503960 | 2026-03-30 15:19:45.504082 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-30 15:19:45.870637 | controller -> localhost | changed 2026-03-30 15:19:45.883984 | 2026-03-30 15:19:45.884074 | TASK [add-build-sshkey : Add back temp key] 2026-03-30 15:19:46.187997 | controller -> localhost | Identity added: /var/lib/zuul/builds/34d24a932b5b47b69041e5084ff399e2/work/34d24a932b5b47b69041e5084ff399e2_id_rsa (zuul-build-sshkey) 2026-03-30 15:19:46.188358 | controller -> localhost | ok: Runtime: 0:00:00.016011 2026-03-30 15:19:46.194939 | 2026-03-30 15:19:46.195029 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-30 15:19:46.580703 | controller | ok 2026-03-30 15:19:46.587363 | 2026-03-30 15:19:46.587464 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-30 15:19:46.613322 | controller | skipping: Conditional result was False 2026-03-30 15:19:46.630136 | 2026-03-30 15:19:46.630305 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-30 15:19:47.029645 | controller | ok 2026-03-30 15:19:47.036529 | 2026-03-30 15:19:47.036627 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-30 15:19:48.114093 | controller | Output suppressed because no_log was given 2026-03-30 15:19:48.128405 | 2026-03-30 15:19:48.128518 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-30 15:19:48.346207 | controller | ok: "logs" 2026-03-30 15:19:48.347065 | controller | ok: All items complete 2026-03-30 15:19:48.347138 | 2026-03-30 15:19:48.530343 | controller | ok: "artifacts" 2026-03-30 15:19:48.715288 | controller | ok: "docs" 2026-03-30 15:19:48.737379 | 2026-03-30 15:19:48.737950 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-30 15:19:48.955778 | controller | changed: "logs" 2026-03-30 15:19:49.144467 | controller | changed: "artifacts" 2026-03-30 15:19:49.338511 | controller | changed: "docs" 2026-03-30 15:19:49.354210 | 2026-03-30 15:19:49.354381 | PLAY RECAP 2026-03-30 15:19:49.354452 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-03-30 15:19:49.354493 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-30 15:19:49.354525 | 2026-03-30 15:19:49.550776 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-30 15:19:49.553435 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-30 15:19:50.195399 | 2026-03-30 15:19:50.195548 | PLAY [all] 2026-03-30 15:19:50.206116 | 2026-03-30 15:19:50.206205 | TASK [setup-uv : Extract archive] 2026-03-30 15:19:52.677879 | controller | changed 2026-03-30 15:19:52.688346 | 2026-03-30 15:19:52.688525 | TASK [setup-uv : Print version] 2026-03-30 15:19:53.178312 | controller | uv 0.8.13 2026-03-30 15:19:53.227774 | controller | ok: Runtime: 0:00:00.017564 2026-03-30 15:19:53.232833 | 2026-03-30 15:19:53.232889 | PLAY RECAP 2026-03-30 15:19:53.232931 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-30 15:19:53.232972 | 2026-03-30 15:19:53.385311 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-30 15:19:53.387270 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-30 15:19:54.007380 | 2026-03-30 15:19:54.007517 | PLAY [all] 2026-03-30 15:19:54.017902 | 2026-03-30 15:19:54.017993 | TASK [Update apt cache] 2026-03-30 15:19:59.698955 | controller | ok 2026-03-30 15:19:59.707138 | 2026-03-30 15:19:59.707266 | TASK [Disable firewalld] 2026-03-30 15:19:59.732188 | controller | skipping: Conditional result was False 2026-03-30 15:19:59.742951 | 2026-03-30 15:19:59.743101 | TASK [Install "jq" for log collection] 2026-03-30 15:20:02.155375 | controller | changed 2026-03-30 15:20:02.158048 | 2026-03-30 15:20:02.158119 | PLAY RECAP 2026-03-30 15:20:02.158178 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-30 15:20:02.158209 | 2026-03-30 15:20:02.316453 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-30 15:20:02.319217 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-30 15:20:02.964485 | 2026-03-30 15:20:02.964621 | PLAY [all] 2026-03-30 15:20:02.974419 | 2026-03-30 15:20:02.974494 | TASK [Copy inventory file for Zuul] 2026-03-30 15:20:03.910314 | controller | changed 2026-03-30 15:20:03.918161 | 2026-03-30 15:20:03.918374 | TASK [Switch "ansible_host" to private IP] 2026-03-30 15:20:04.244274 | controller | changed: 1 replacements made 2026-03-30 15:20:04.250938 | 2026-03-30 15:20:04.251099 | TASK [Run Molecule scenario] 2026-03-30 15:20:04.793531 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-03-30 15:20:04.793705 | controller | Creating virtual environment at: .venv 2026-03-30 15:20:05.990605 | controller | Downloading cryptography (4.3MiB) 2026-03-30 15:20:05.991156 | controller | Downloading ansible-core (2.3MiB) 2026-03-30 15:20:05.991984 | controller | Downloading pygments (1.2MiB) 2026-03-30 15:20:06.146882 | controller | Downloading cryptography 2026-03-30 15:20:06.194573 | controller | Downloading pygments 2026-03-30 15:20:06.356510 | controller | Downloading ansible-core 2026-03-30 15:20:06.397910 | controller | Installed 36 packages in 40ms 2026-03-30 15:20:07.111351 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-03-30 15:20:07.111408 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-03-30 15:20:07.963290 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-03-30 15:20:07.963342 | controller | INFO default scenario not found, disabling shared state. 2026-03-30 15:20:07.963362 | controller | INFO [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-03-30 15:20:07.963463 | controller | INFO [helm > prerun] Performing prerun with role_name_check=0... 2026-03-30 15:29:14.177907 | controller | INFO [helm > dependency] Executing 2026-03-30 15:29:14.178013 | controller | WARNING [helm > dependency] Missing roles requirements file: requirements.yml 2026-03-30 15:29:14.178023 | controller | WARNING [helm > dependency] Missing collections requirements file: collections.yml 2026-03-30 15:29:14.178076 | controller | WARNING [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-03-30 15:29:14.182791 | controller | INFO [helm > cleanup] Executing 2026-03-30 15:29:14.183090 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-30 15:29:14.188404 | controller | INFO [helm > destroy] Executing 2026-03-30 15:29:14.188422 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-30 15:29:14.188517 | controller | INFO [helm > destroy] Executed: Successful 2026-03-30 15:29:14.193739 | controller | INFO [helm > syntax] Executing 2026-03-30 15:29:15.063610 | controller | 2026-03-30 15:29:15.063843 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml 2026-03-30 15:29:15.119034 | controller | INFO [helm > syntax] Executed: Successful 2026-03-30 15:29:15.128599 | controller | INFO [helm > create] Executing 2026-03-30 15:29:15.130662 | controller | WARNING [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-30 15:29:15.137108 | controller | INFO [helm > prepare] Executing 2026-03-30 15:29:15.955876 | controller | 2026-03-30 15:29:15.956059 | controller | PLAY [Prepare] ***************************************************************** 2026-03-30 15:29:15.956254 | controller | 2026-03-30 15:29:15.956523 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-30 15:29:15.956730 | controller | Monday 30 March 2026 15:29:15 +0000 (0:00:00.028) 0:00:00.028 ********** 2026-03-30 15:29:17.237943 | 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-03-30 15:29:17.243491 | controller | ok: [controller] 2026-03-30 15:29:17.243623 | controller | 2026-03-30 15:29:17.243818 | controller | TASK [Install Debian packages] ************************************************* 2026-03-30 15:29:17.244012 | controller | Monday 30 March 2026 15:29:17 +0000 (0:00:01.288) 0:00:01.316 ********** 2026-03-30 15:29:18.962424 | controller | ok: [controller] 2026-03-30 15:29:18.962546 | controller | 2026-03-30 15:29:18.962759 | controller | PLAY RECAP ********************************************************************* 2026-03-30 15:29:18.962973 | controller | controller : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-30 15:29:18.963144 | controller | 2026-03-30 15:29:18.963312 | controller | 2026-03-30 15:29:18.963495 | controller | TASKS RECAP ******************************************************************** 2026-03-30 15:29:18.963675 | controller | Monday 30 March 2026 15:29:18 +0000 (0:00:01.719) 0:00:03.035 ********** 2026-03-30 15:29:18.963849 | controller | =============================================================================== 2026-03-30 15:29:18.964033 | controller | Install Debian packages ------------------------------------------------- 1.72s 2026-03-30 15:29:18.964301 | controller | Gathering Facts --------------------------------------------------------- 1.29s 2026-03-30 15:29:19.058264 | controller | INFO [helm > prepare] Executed: Successful 2026-03-30 15:29:19.067799 | controller | INFO [helm > converge] Executing 2026-03-30 15:29:19.883820 | controller | 2026-03-30 15:29:19.884012 | controller | PLAY [Converge] **************************************************************** 2026-03-30 15:29:19.884219 | controller | 2026-03-30 15:29:19.884443 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-30 15:29:19.884628 | controller | Monday 30 March 2026 15:29:19 +0000 (0:00:00.012) 0:00:00.012 ********** 2026-03-30 15:29:20.963376 | 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-03-30 15:29:20.966455 | controller | ok: [controller] 2026-03-30 15:29:20.966564 | controller | 2026-03-30 15:29:20.966654 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-30 15:29:20.966742 | controller | Monday 30 March 2026 15:29:20 +0000 (0:00:01.082) 0:00:01.095 ********** 2026-03-30 15:29:21.458568 | controller | ok: [controller] 2026-03-30 15:29:21.458629 | controller | 2026-03-30 15:29:21.458639 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-30 15:29:21.458755 | controller | Monday 30 March 2026 15:29:21 +0000 (0:00:00.491) 0:00:01.587 ********** 2026-03-30 15:29:22.535273 | controller | ok: [controller] 2026-03-30 15:29:22.535396 | controller | 2026-03-30 15:29:22.535595 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-30 15:29:22.535787 | controller | Monday 30 March 2026 15:29:22 +0000 (0:00:01.076) 0:00:02.663 ********** 2026-03-30 15:29:22.952754 | controller | changed: [controller] 2026-03-30 15:29:22.952894 | controller | 2026-03-30 15:29:22.953092 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-30 15:29:22.953285 | controller | Monday 30 March 2026 15:29:22 +0000 (0:00:00.417) 0:00:03.081 ********** 2026-03-30 15:29:23.002711 | controller | ok: [controller] => { 2026-03-30 15:29:23.002904 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-30 15:29:23.003086 | controller | } 2026-03-30 15:29:23.003247 | controller | 2026-03-30 15:29:23.003438 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-30 15:29:23.003617 | controller | Monday 30 March 2026 15:29:22 +0000 (0:00:00.050) 0:00:03.131 ********** 2026-03-30 15:29:24.046776 | 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-03-30 15:29:24.056786 | controller | changed: [controller] 2026-03-30 15:29:24.056960 | controller | 2026-03-30 15:29:24.057164 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-30 15:29:24.057355 | controller | Monday 30 March 2026 15:29:24 +0000 (0:00:01.054) 0:00:04.185 ********** 2026-03-30 15:29:26.011145 | controller | changed: [controller] 2026-03-30 15:29:26.011268 | controller | 2026-03-30 15:29:26.011483 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-30 15:29:26.011661 | controller | Monday 30 March 2026 15:29:26 +0000 (0:00:01.953) 0:00:06.139 ********** 2026-03-30 15:29:26.500163 | controller | ok: [controller] 2026-03-30 15:29:26.500256 | controller | 2026-03-30 15:29:26.500517 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-30 15:29:26.500660 | controller | Monday 30 March 2026 15:29:26 +0000 (0:00:00.489) 0:00:06.628 ********** 2026-03-30 15:29:26.882989 | controller | changed: [controller] 2026-03-30 15:29:26.883098 | controller | 2026-03-30 15:29:26.883341 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-30 15:29:26.883482 | controller | Monday 30 March 2026 15:29:26 +0000 (0:00:00.382) 0:00:07.011 ********** 2026-03-30 15:29:27.362581 | controller | ok: [controller] 2026-03-30 15:29:27.362609 | controller | 2026-03-30 15:29:27.362615 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-30 15:29:27.362620 | controller | Monday 30 March 2026 15:29:27 +0000 (0:00:00.477) 0:00:07.488 ********** 2026-03-30 15:29:27.674266 | controller | changed: [controller] 2026-03-30 15:29:27.674430 | controller | 2026-03-30 15:29:27.674767 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-30 15:29:27.674957 | controller | Monday 30 March 2026 15:29:27 +0000 (0:00:00.313) 0:00:07.802 ********** 2026-03-30 15:29:27.968219 | controller | ok: [controller] 2026-03-30 15:29:27.968372 | controller | 2026-03-30 15:29:27.968567 | controller | TASK [Install plugin] ********************************************************** 2026-03-30 15:29:27.968757 | controller | Monday 30 March 2026 15:29:27 +0000 (0:00:00.293) 0:00:08.096 ********** 2026-03-30 15:29:28.021695 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-30 15:29:28.021848 | controller | 2026-03-30 15:29:28.022045 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-30 15:29:28.022270 | controller | Monday 30 March 2026 15:29:28 +0000 (0:00:00.054) 0:00:08.150 ********** 2026-03-30 15:29:28.072289 | controller | ok: [controller] => { 2026-03-30 15:29:28.072479 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-30 15:29:28.072657 | controller | } 2026-03-30 15:29:28.072821 | controller | 2026-03-30 15:29:28.073011 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-30 15:29:28.073197 | controller | Monday 30 March 2026 15:29:28 +0000 (0:00:00.050) 0:00:08.201 ********** 2026-03-30 15:29:29.516981 | controller | changed: [controller] 2026-03-30 15:29:29.517106 | controller | 2026-03-30 15:29:29.517302 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-30 15:29:29.517492 | controller | Monday 30 March 2026 15:29:29 +0000 (0:00:01.443) 0:00:09.644 ********** 2026-03-30 15:29:31.582643 | controller | changed: [controller] 2026-03-30 15:29:31.582683 | controller | 2026-03-30 15:29:31.582692 | controller | PLAY RECAP ********************************************************************* 2026-03-30 15:29:31.582703 | controller | controller : ok=16 changed=7 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-30 15:29:31.582710 | controller | 2026-03-30 15:29:31.582718 | controller | 2026-03-30 15:29:31.582725 | controller | TASKS RECAP ******************************************************************** 2026-03-30 15:29:31.582732 | controller | Monday 30 March 2026 15:29:31 +0000 (0:00:02.063) 0:00:11.708 ********** 2026-03-30 15:29:31.582739 | controller | =============================================================================== 2026-03-30 15:29:31.582746 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.06s 2026-03-30 15:29:31.582753 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.95s 2026-03-30 15:29:31.582760 | controller | vexxhost.containers.download_artifact : Download item ------------------- 1.44s 2026-03-30 15:29:31.582767 | controller | Gathering Facts --------------------------------------------------------- 1.08s 2026-03-30 15:29:31.582774 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.08s 2026-03-30 15:29:31.582781 | controller | vexxhost.containers.download_artifact : Download item ------------------- 1.05s 2026-03-30 15:29:31.582788 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.49s 2026-03-30 15:29:31.582795 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.49s 2026-03-30 15:29:31.582802 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.48s 2026-03-30 15:29:31.582809 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.42s 2026-03-30 15:29:31.582828 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.38s 2026-03-30 15:29:31.582835 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.31s 2026-03-30 15:29:31.582888 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.29s 2026-03-30 15:29:31.583137 | controller | Install plugin ---------------------------------------------------------- 0.05s 2026-03-30 15:29:31.583377 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-30 15:29:31.583686 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-30 15:29:31.673430 | controller | INFO [helm > converge] Executed: Successful 2026-03-30 15:29:31.682922 | controller | INFO [helm > idempotence] Executing 2026-03-30 15:29:32.514082 | controller | 2026-03-30 15:29:32.514377 | controller | PLAY [Converge] **************************************************************** 2026-03-30 15:29:32.514658 | controller | 2026-03-30 15:29:32.514910 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-30 15:29:32.515157 | controller | Monday 30 March 2026 15:29:32 +0000 (0:00:00.012) 0:00:00.012 ********** 2026-03-30 15:29:33.541378 | 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-03-30 15:29:33.545977 | controller | ok: [controller] 2026-03-30 15:29:33.546153 | controller | 2026-03-30 15:29:33.546403 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-30 15:29:33.546695 | controller | Monday 30 March 2026 15:29:33 +0000 (0:00:01.031) 0:00:01.044 ********** 2026-03-30 15:29:33.967285 | controller | ok: [controller] 2026-03-30 15:29:33.967537 | controller | 2026-03-30 15:29:33.967789 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-30 15:29:33.968034 | controller | Monday 30 March 2026 15:29:33 +0000 (0:00:00.421) 0:00:01.465 ********** 2026-03-30 15:29:35.033166 | controller | ok: [controller] 2026-03-30 15:29:35.033450 | controller | 2026-03-30 15:29:35.033710 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-30 15:29:35.033954 | controller | Monday 30 March 2026 15:29:35 +0000 (0:00:01.065) 0:00:02.530 ********** 2026-03-30 15:29:35.440023 | controller | ok: [controller] 2026-03-30 15:29:35.440289 | controller | 2026-03-30 15:29:35.440546 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-30 15:29:35.440789 | controller | Monday 30 March 2026 15:29:35 +0000 (0:00:00.407) 0:00:02.938 ********** 2026-03-30 15:29:35.488398 | controller | ok: [controller] => { 2026-03-30 15:29:35.488679 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-30 15:29:35.488918 | controller | } 2026-03-30 15:29:35.489140 | controller | 2026-03-30 15:29:35.489390 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-30 15:29:35.489634 | controller | Monday 30 March 2026 15:29:35 +0000 (0:00:00.048) 0:00:02.986 ********** 2026-03-30 15:29:36.025547 | controller | ok: [controller] 2026-03-30 15:29:36.025805 | controller | 2026-03-30 15:29:36.026055 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-30 15:29:36.026294 | controller | Monday 30 March 2026 15:29:36 +0000 (0:00:00.536) 0:00:03.522 ********** 2026-03-30 15:29:37.798241 | controller | ok: [controller] 2026-03-30 15:29:37.798729 | controller | 2026-03-30 15:29:37.798738 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-30 15:29:37.798743 | controller | Monday 30 March 2026 15:29:37 +0000 (0:00:01.763) 0:00:05.286 ********** 2026-03-30 15:29:38.294363 | controller | ok: [controller] 2026-03-30 15:29:38.294447 | controller | 2026-03-30 15:29:38.294456 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-30 15:29:38.294465 | controller | Monday 30 March 2026 15:29:38 +0000 (0:00:00.504) 0:00:05.790 ********** 2026-03-30 15:29:38.707506 | controller | ok: [controller] 2026-03-30 15:29:38.707829 | controller | 2026-03-30 15:29:38.708111 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-30 15:29:38.708378 | controller | Monday 30 March 2026 15:29:38 +0000 (0:00:00.413) 0:00:06.204 ********** 2026-03-30 15:29:39.143206 | controller | ok: [controller] 2026-03-30 15:29:39.143232 | controller | 2026-03-30 15:29:39.143238 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-30 15:29:39.143243 | controller | Monday 30 March 2026 15:29:39 +0000 (0:00:00.433) 0:00:06.637 ********** 2026-03-30 15:29:39.428621 | controller | ok: [controller] 2026-03-30 15:29:39.428920 | controller | 2026-03-30 15:29:39.429226 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-30 15:29:39.429660 | controller | Monday 30 March 2026 15:29:39 +0000 (0:00:00.288) 0:00:06.926 ********** 2026-03-30 15:29:39.715193 | controller | ok: [controller] 2026-03-30 15:29:39.715490 | controller | 2026-03-30 15:29:39.715753 | controller | TASK [Install plugin] ********************************************************** 2026-03-30 15:29:39.716002 | controller | Monday 30 March 2026 15:29:39 +0000 (0:00:00.286) 0:00:07.213 ********** 2026-03-30 15:29:39.759983 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-30 15:29:39.760232 | controller | 2026-03-30 15:29:39.760473 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-30 15:29:39.760706 | controller | Monday 30 March 2026 15:29:39 +0000 (0:00:00.044) 0:00:07.257 ********** 2026-03-30 15:29:39.804845 | controller | ok: [controller] => { 2026-03-30 15:29:39.805186 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-30 15:29:39.805453 | controller | } 2026-03-30 15:29:39.805692 | controller | 2026-03-30 15:29:39.805957 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-30 15:29:39.806214 | controller | Monday 30 March 2026 15:29:39 +0000 (0:00:00.044) 0:00:07.302 ********** 2026-03-30 15:29:40.217132 | controller | ok: [controller] 2026-03-30 15:29:40.217418 | controller | 2026-03-30 15:29:40.217689 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-30 15:29:40.217944 | controller | Monday 30 March 2026 15:29:40 +0000 (0:00:00.412) 0:00:07.714 ********** 2026-03-30 15:29:41.842119 | controller | ok: [controller] 2026-03-30 15:29:41.842160 | controller | 2026-03-30 15:29:41.842224 | controller | PLAY RECAP ********************************************************************* 2026-03-30 15:29:41.842313 | controller | controller : ok=16 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-30 15:29:41.842399 | controller | 2026-03-30 15:29:41.842467 | controller | 2026-03-30 15:29:41.842573 | controller | TASKS RECAP ******************************************************************** 2026-03-30 15:29:41.842671 | controller | Monday 30 March 2026 15:29:41 +0000 (0:00:01.626) 0:00:09.340 ********** 2026-03-30 15:29:41.842741 | controller | =============================================================================== 2026-03-30 15:29:41.842826 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.76s 2026-03-30 15:29:41.842909 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.63s 2026-03-30 15:29:41.842994 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.07s 2026-03-30 15:29:41.843075 | controller | Gathering Facts --------------------------------------------------------- 1.03s 2026-03-30 15:29:41.843159 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.54s 2026-03-30 15:29:41.843244 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.50s 2026-03-30 15:29:41.843328 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.43s 2026-03-30 15:29:41.843412 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.42s 2026-03-30 15:29:41.843497 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.41s 2026-03-30 15:29:41.843580 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.41s 2026-03-30 15:29:41.843665 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.41s 2026-03-30 15:29:41.843755 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.29s 2026-03-30 15:29:41.843845 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.29s 2026-03-30 15:29:41.843938 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-30 15:29:41.844134 | controller | Install plugin ---------------------------------------------------------- 0.04s 2026-03-30 15:29:41.844160 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s 2026-03-30 15:29:41.952329 | controller | INFO [helm > idempotence] Executed: Successful 2026-03-30 15:29:41.964903 | controller | INFO [helm > side_effect] Executing 2026-03-30 15:29:41.965406 | controller | WARNING [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-30 15:29:41.970628 | controller | INFO [helm > verify] Executing 2026-03-30 15:29:42.764228 | controller | 2026-03-30 15:29:42.764382 | controller | PLAY [Verify] ****************************************************************** 2026-03-30 15:29:42.764490 | controller | 2026-03-30 15:29:42.764606 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-30 15:29:42.764726 | controller | Monday 30 March 2026 15:29:42 +0000 (0:00:00.009) 0:00:00.009 ********** 2026-03-30 15:29:43.855081 | 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-03-30 15:29:43.861584 | controller | ok: [controller] 2026-03-30 15:29:43.861772 | controller | 2026-03-30 15:29:43.861971 | controller | TASK [Get the current Helm version] ******************************************** 2026-03-30 15:29:43.862205 | controller | Monday 30 March 2026 15:29:43 +0000 (0:00:01.097) 0:00:01.106 ********** 2026-03-30 15:29:44.306732 | controller | changed: [controller] 2026-03-30 15:29:44.306939 | controller | 2026-03-30 15:29:44.307247 | controller | TASK [Assert Helm version] ***************************************************** 2026-03-30 15:29:44.307502 | controller | Monday 30 March 2026 15:29:44 +0000 (0:00:00.444) 0:00:01.551 ********** 2026-03-30 15:29:44.339038 | controller | ok: [controller] => { 2026-03-30 15:29:44.339210 | controller | "changed": false, 2026-03-30 15:29:44.339409 | controller | "msg": "All assertions passed" 2026-03-30 15:29:44.339591 | controller | } 2026-03-30 15:29:44.339768 | controller | 2026-03-30 15:29:44.339947 | controller | PLAY RECAP ********************************************************************* 2026-03-30 15:29:44.340175 | controller | controller : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-30 15:29:44.340342 | controller | 2026-03-30 15:29:44.340506 | controller | 2026-03-30 15:29:44.340712 | controller | TASKS RECAP ******************************************************************** 2026-03-30 15:29:44.340998 | controller | Monday 30 March 2026 15:29:44 +0000 (0:00:00.033) 0:00:01.584 ********** 2026-03-30 15:29:44.341224 | controller | =============================================================================== 2026-03-30 15:29:44.341417 | controller | Gathering Facts --------------------------------------------------------- 1.10s 2026-03-30 15:29:44.341605 | controller | Get the current Helm version -------------------------------------------- 0.44s 2026-03-30 15:29:44.341789 | controller | Assert Helm version ----------------------------------------------------- 0.03s 2026-03-30 15:29:44.451862 | controller | INFO [helm > verify] Executed: Successful 2026-03-30 15:29:44.461881 | controller | INFO [helm > cleanup] Executing 2026-03-30 15:29:44.462342 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-30 15:29:44.467908 | controller | INFO [helm > destroy] Executing 2026-03-30 15:29:44.467953 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-30 15:29:44.468058 | controller | INFO [helm > destroy] Executed: Successful 2026-03-30 15:29:44.468384 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-03-30 15:29:44.954420 | controller | ok: Runtime: 0:09:39.860488 2026-03-30 15:29:44.958213 | 2026-03-30 15:29:44.958262 | PLAY RECAP 2026-03-30 15:29:44.958304 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-30 15:29:44.958324 | 2026-03-30 15:29:45.043992 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-30 15:29:45.046221 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-30 15:29:45.624525 | 2026-03-30 15:29:45.624651 | PLAY [all] 2026-03-30 15:29:45.635607 | 2026-03-30 15:29:45.635690 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-03-30 15:29:46.011616 | controller | changed 2026-03-30 15:29:46.017246 | 2026-03-30 15:29:46.017346 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-03-30 15:29:46.392319 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-30 15:29:46.392452 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-30 15:29:46.400349 | controller | environment: line 1: kubectl: command not found 2026-03-30 15:29:46.402234 | controller | environment: line 1: kubectl: command not found 2026-03-30 15:29:46.402547 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-30 15:29:46.404585 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-30 15:29:46.406628 | controller | environment: line 1: kubectl: command not found 2026-03-30 15:29:46.408754 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-30 15:29:46.410011 | controller | environment: line 1: kubectl: command not found 2026-03-30 15:29:46.412136 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-30 15:29:46.412580 | controller | environment: line 1: kubectl: command not found 2026-03-30 15:29:46.413762 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-30 15:29:46.548581 | controller | ok: Runtime: 0:00:00.035483 2026-03-30 15:29:46.553144 | 2026-03-30 15:29:46.553230 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-03-30 15:29:46.775335 | controller | changed 2026-03-30 15:29:46.781100 | 2026-03-30 15:29:46.781199 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-03-30 15:29:47.015683 | controller | environment: line 5: kubectl: command not found 2026-03-30 15:29:47.016650 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-30 15:29:47.017093 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-30 15:29:47.017408 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-30 15:29:47.308381 | controller | ok: Runtime: 0:00:00.012033 2026-03-30 15:29:47.317234 | 2026-03-30 15:29:47.317347 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-03-30 15:29:47.988347 | controller | changed: 2026-03-30 15:29:47.988680 | controller | created directory /var/lib/zuul/builds/34d24a932b5b47b69041e5084ff399e2/work/logs/controller 2026-03-30 15:29:47.988752 | controller | cd+++++++++ objects/ 2026-03-30 15:29:47.988802 | controller | cd+++++++++ objects/cluster/ 2026-03-30 15:29:47.988847 | controller | cd+++++++++ objects/namespaced/ 2026-03-30 15:29:47.998074 | 2026-03-30 15:29:47.998156 | TASK [gather-pod-logs : creating directory for pod logs] 2026-03-30 15:29:48.234033 | controller | changed 2026-03-30 15:29:48.237958 | 2026-03-30 15:29:48.238020 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-03-30 15:29:48.471917 | controller | changed 2026-03-30 15:29:48.477637 | 2026-03-30 15:29:48.477734 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-03-30 15:29:48.713054 | controller | environment: line 3: kubectl: command not found 2026-03-30 15:29:49.008787 | controller | ok: Runtime: 0:00:00.013245 2026-03-30 15:29:49.014925 | 2026-03-30 15:29:49.014987 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-03-30 15:29:49.541914 | controller | changed: 2026-03-30 15:29:49.542116 | controller | cd+++++++++ pod-logs/ 2026-03-30 15:29:49.542155 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-03-30 15:29:49.552232 | 2026-03-30 15:29:49.552322 | LOOP [helm-release-status : creating directory for helm release status] 2026-03-30 15:29:49.773126 | controller | changed: "values" 2026-03-30 15:29:49.970191 | controller | changed: "releases" 2026-03-30 15:29:49.986783 | 2026-03-30 15:29:49.986948 | TASK [helm-release-status : Gather get release status for helm charts] 2026-03-30 15:29:50.224054 | controller | /bin/bash: line 3: kubectl: command not found 2026-03-30 15:29:50.517175 | controller | ok: Runtime: 0:00:00.009130 2026-03-30 15:29:50.522439 | 2026-03-30 15:29:50.522523 | TASK [helm-release-status : Downloads logs to executor] 2026-03-30 15:29:51.030166 | controller | changed: 2026-03-30 15:29:51.030438 | controller | cd+++++++++ helm/ 2026-03-30 15:29:51.030500 | controller | cd+++++++++ helm/releases/ 2026-03-30 15:29:51.030554 | controller | cd+++++++++ helm/values/ 2026-03-30 15:29:51.036862 | 2026-03-30 15:29:51.036909 | PLAY RECAP 2026-03-30 15:29:51.036977 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-30 15:29:51.037002 | 2026-03-30 15:29:51.154539 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-30 15:29:51.156384 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-30 15:29:51.740434 | 2026-03-30 15:29:51.740561 | PLAY [all] 2026-03-30 15:29:51.751051 | 2026-03-30 15:29:51.751155 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-30 15:29:51.796198 | controller | skipping: Conditional result was False 2026-03-30 15:29:51.806028 | 2026-03-30 15:29:51.806192 | TASK [fetch-output : Set log path for single node] 2026-03-30 15:29:51.847064 | controller | ok 2026-03-30 15:29:51.852324 | 2026-03-30 15:29:51.852395 | LOOP [fetch-output : Ensure local output dirs] 2026-03-30 15:29:52.270614 | controller -> localhost | ok: "/var/lib/zuul/builds/34d24a932b5b47b69041e5084ff399e2/work/logs" 2026-03-30 15:29:52.470976 | controller -> localhost | changed: "/var/lib/zuul/builds/34d24a932b5b47b69041e5084ff399e2/work/artifacts" 2026-03-30 15:29:52.679176 | controller -> localhost | changed: "/var/lib/zuul/builds/34d24a932b5b47b69041e5084ff399e2/work/docs" 2026-03-30 15:29:52.700046 | 2026-03-30 15:29:52.700208 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-30 15:29:53.380171 | controller | changed: .d..t...... ./ 2026-03-30 15:29:53.380417 | controller | changed: All items complete 2026-03-30 15:29:53.380460 | 2026-03-30 15:29:53.883574 | controller | changed: .d..t...... ./ 2026-03-30 15:29:54.434948 | controller | changed: .d..t...... ./ 2026-03-30 15:29:54.460289 | 2026-03-30 15:29:54.460429 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-30 15:29:54.953781 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.006557 2026-03-30 15:29:55.173325 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.006781 2026-03-30 15:29:55.193497 | 2026-03-30 15:29:55.193604 | PLAY [all] 2026-03-30 15:29:55.198830 | 2026-03-30 15:29:55.198950 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-30 15:29:55.739835 | controller | changed 2026-03-30 15:29:55.746508 | 2026-03-30 15:29:55.746574 | PLAY RECAP 2026-03-30 15:29:55.746632 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-30 15:29:55.746665 | 2026-03-30 15:29:55.840097 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-30 15:29:55.841451 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-30 15:29:56.394271 | 2026-03-30 15:29:56.394388 | PLAY [localhost] 2026-03-30 15:29:56.403916 | 2026-03-30 15:29:56.403985 | TASK [Generate Zuul manifest] 2026-03-30 15:29:56.420422 | localhost | ok 2026-03-30 15:29:56.434584 | 2026-03-30 15:29:56.434659 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-30 15:29:56.769339 | localhost | changed 2026-03-30 15:29:56.783280 | 2026-03-30 15:29:56.783396 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-30 15:29:56.814963 | localhost | ok 2026-03-30 15:29:56.824237 | 2026-03-30 15:29:56.824317 | TASK [Upload logs] 2026-03-30 15:29:56.844719 | localhost | ok 2026-03-30 15:29:56.906627 | 2026-03-30 15:29:56.906764 | TASK [Set zuul-log-path fact] 2026-03-30 15:29:56.926361 | localhost | ok 2026-03-30 15:29:56.943238 | 2026-03-30 15:29:56.943371 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-30 15:29:56.975943 | localhost | ok 2026-03-30 15:29:56.983989 | 2026-03-30 15:29:56.984068 | TASK [upload-logs : Create log directories] 2026-03-30 15:29:57.359475 | localhost | changed 2026-03-30 15:29:57.365429 | 2026-03-30 15:29:57.365492 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-30 15:29:57.910287 | localhost -> localhost | ok: Runtime: 0:00:00.004986 2026-03-30 15:29:57.930117 | 2026-03-30 15:29:57.930300 | TASK [upload-logs : Upload logs to log server] 2026-03-30 15:29:58.499144 | localhost | Output suppressed because no_log was given 2026-03-30 15:29:58.504926 | 2026-03-30 15:29:58.505052 | LOOP [upload-logs : Compress console log and json output] 2026-03-30 15:29:58.544144 | localhost | skipping: Conditional result was False 2026-03-30 15:29:58.552043 | localhost | skipping: Conditional result was False 2026-03-30 15:29:58.570520 | 2026-03-30 15:29:58.582856 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-30 15:29:58.623783 | localhost | skipping: Conditional result was False 2026-03-30 15:29:58.624131 | 2026-03-30 15:29:58.627980 | localhost | skipping: Conditional result was False 2026-03-30 15:29:58.643696 | 2026-03-30 15:29:58.643785 | LOOP [upload-logs : Upload console log and json output]