2026-03-30 16:43:07.134448 | Job console starting 2026-03-30 16:43:07.163388 | Updating git repos 2026-03-30 16:43:07.266979 | Cloning repos into workspace 2026-03-30 16:43:07.340186 | Restoring repo states 2026-03-30 16:43:07.457377 | Merging changes 2026-03-30 16:43:08.577561 | Checking out repos 2026-03-30 16:43:09.415802 | Preparing playbooks 2026-03-30 16:43:15.919379 | Running Ansible setup 2026-03-30 16:43:19.938084 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-30 16:43:20.669294 | 2026-03-30 16:43:20.669519 | PLAY [localhost] 2026-03-30 16:43:20.678226 | 2026-03-30 16:43:20.678331 | TASK [Gathering Facts] 2026-03-30 16:43:21.718760 | localhost | ok 2026-03-30 16:43:21.725737 | 2026-03-30 16:43:21.725818 | TASK [Setup log path fact] 2026-03-30 16:43:21.745147 | localhost | ok 2026-03-30 16:43:21.762551 | 2026-03-30 16:43:21.762622 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-30 16:43:21.793090 | localhost | ok 2026-03-30 16:43:21.802354 | 2026-03-30 16:43:21.802453 | TASK [emit-job-header : Print job information] 2026-03-30 16:43:21.845320 | # Job Information 2026-03-30 16:43:21.845554 | Ansible Version: 2.16.16 2026-03-30 16:43:21.845617 | Job: ansible-collection-kubernetes-molecule-helm 2026-03-30 16:43:21.845663 | Pipeline: check 2026-03-30 16:43:21.845705 | Executor: 0a8996d2b663 2026-03-30 16:43:21.845747 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/250 2026-03-30 16:43:21.845796 | Event ID: 5ee09730-2c57-11f1-92de-481b07c2604f 2026-03-30 16:43:21.849298 | 2026-03-30 16:43:21.849372 | LOOP [emit-job-header : Print node information] 2026-03-30 16:43:21.939572 | localhost | ok: 2026-03-30 16:43:21.939781 | localhost | # Node Information 2026-03-30 16:43:21.939825 | localhost | Inventory Hostname: controller 2026-03-30 16:43:21.939860 | localhost | Hostname: np0000161302 2026-03-30 16:43:21.939893 | localhost | Username: zuul 2026-03-30 16:43:21.939927 | localhost | Distro: Debian 13.4 2026-03-30 16:43:21.939958 | localhost | Provider: yul1 2026-03-30 16:43:21.939988 | localhost | Region: ca-ymq-1 2026-03-30 16:43:21.940017 | localhost | Label: debian-trixie 2026-03-30 16:43:21.940046 | localhost | Product Name: OpenStack Nova 2026-03-30 16:43:21.940075 | localhost | Interface IP: 199.19.213.90 2026-03-30 16:43:21.951655 | 2026-03-30 16:43:21.951797 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-30 16:43:22.401951 | localhost -> localhost | changed 2026-03-30 16:43:22.434482 | 2026-03-30 16:43:22.434644 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-30 16:43:23.454148 | localhost -> localhost | changed 2026-03-30 16:43:23.465840 | 2026-03-30 16:43:23.465893 | PLAY [all] 2026-03-30 16:43:23.472867 | 2026-03-30 16:43:23.472943 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-30 16:43:23.723587 | controller -> localhost | ok 2026-03-30 16:43:23.730086 | 2026-03-30 16:43:23.730244 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-30 16:43:23.781330 | controller | ok 2026-03-30 16:43:23.798533 | controller | included: /var/lib/zuul/builds/6920d72abbd14877b348183f27eb5a3b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-30 16:43:23.803937 | 2026-03-30 16:43:23.804043 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-30 16:43:24.695036 | controller -> localhost | Generating public/private rsa key pair. 2026-03-30 16:43:24.695287 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/6920d72abbd14877b348183f27eb5a3b/work/6920d72abbd14877b348183f27eb5a3b_id_rsa 2026-03-30 16:43:24.699917 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/6920d72abbd14877b348183f27eb5a3b/work/6920d72abbd14877b348183f27eb5a3b_id_rsa.pub 2026-03-30 16:43:24.699966 | controller -> localhost | The key fingerprint is: 2026-03-30 16:43:24.700000 | controller -> localhost | SHA256:/pOjsbNNMMVMo9/9iHpoLIAnp+42XxhsVpGBBowbrTg zuul-build-sshkey 2026-03-30 16:43:24.700047 | controller -> localhost | The key's randomart image is: 2026-03-30 16:43:24.700079 | controller -> localhost | +---[RSA 3072]----+ 2026-03-30 16:43:24.700119 | controller -> localhost | | +.. .ooo | 2026-03-30 16:43:24.700151 | controller -> localhost | | o o o .* . | 2026-03-30 16:43:24.700181 | controller -> localhost | | . + . o + | 2026-03-30 16:43:24.700210 | controller -> localhost | |E o . . o . . | 2026-03-30 16:43:24.700239 | controller -> localhost | | . .= S . . . | 2026-03-30 16:43:24.700267 | controller -> localhost | | oo++ o . o | 2026-03-30 16:43:24.700294 | controller -> localhost | | =..+..o. . .| 2026-03-30 16:43:24.700322 | controller -> localhost | | + .o*B.. | 2026-03-30 16:43:24.700353 | controller -> localhost | | +oo. +*++ | 2026-03-30 16:43:24.700382 | controller -> localhost | +----[SHA256]-----+ 2026-03-30 16:43:24.700451 | controller -> localhost | ok: Runtime: 0:00:00.381071 2026-03-30 16:43:24.713864 | 2026-03-30 16:43:24.713954 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-30 16:43:24.744896 | controller | ok 2026-03-30 16:43:24.770937 | controller | included: /var/lib/zuul/builds/6920d72abbd14877b348183f27eb5a3b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-30 16:43:24.782688 | 2026-03-30 16:43:24.782752 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-30 16:43:24.808054 | controller | skipping: Conditional result was False 2026-03-30 16:43:24.816829 | 2026-03-30 16:43:24.817028 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-30 16:43:25.391010 | controller | changed 2026-03-30 16:43:25.402426 | 2026-03-30 16:43:25.402846 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-30 16:43:25.625567 | controller | ok 2026-03-30 16:43:25.629766 | 2026-03-30 16:43:25.629832 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-30 16:43:26.208822 | controller | changed 2026-03-30 16:43:26.212990 | 2026-03-30 16:43:26.213072 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-30 16:43:26.761607 | controller | changed 2026-03-30 16:43:26.769298 | 2026-03-30 16:43:26.769386 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-30 16:43:26.795103 | controller | skipping: Conditional result was False 2026-03-30 16:43:26.802387 | 2026-03-30 16:43:26.802458 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-30 16:43:27.224948 | controller -> localhost | changed 2026-03-30 16:43:27.238036 | 2026-03-30 16:43:27.238163 | TASK [add-build-sshkey : Add back temp key] 2026-03-30 16:43:27.550489 | controller -> localhost | Identity added: /var/lib/zuul/builds/6920d72abbd14877b348183f27eb5a3b/work/6920d72abbd14877b348183f27eb5a3b_id_rsa (zuul-build-sshkey) 2026-03-30 16:43:27.550713 | controller -> localhost | ok: Runtime: 0:00:00.044727 2026-03-30 16:43:27.554900 | 2026-03-30 16:43:27.554974 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-30 16:43:27.920802 | controller | ok 2026-03-30 16:43:27.926150 | 2026-03-30 16:43:27.926231 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-30 16:43:27.960999 | controller | skipping: Conditional result was False 2026-03-30 16:43:27.974163 | 2026-03-30 16:43:27.974315 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-30 16:43:28.363042 | controller | ok 2026-03-30 16:43:28.370337 | 2026-03-30 16:43:28.370601 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-30 16:43:29.442988 | controller | Output suppressed because no_log was given 2026-03-30 16:43:29.452436 | 2026-03-30 16:43:29.452505 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-30 16:43:29.682290 | controller | ok: "logs" 2026-03-30 16:43:29.682576 | controller | ok: All items complete 2026-03-30 16:43:29.682606 | 2026-03-30 16:43:29.876493 | controller | ok: "artifacts" 2026-03-30 16:43:30.080540 | controller | ok: "docs" 2026-03-30 16:43:30.100291 | 2026-03-30 16:43:30.100515 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-30 16:43:30.316151 | controller | changed: "logs" 2026-03-30 16:43:30.501026 | controller | changed: "artifacts" 2026-03-30 16:43:30.703182 | controller | changed: "docs" 2026-03-30 16:43:30.712671 | 2026-03-30 16:43:30.712804 | PLAY RECAP 2026-03-30 16:43:30.712855 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-03-30 16:43:30.712885 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-30 16:43:30.712908 | 2026-03-30 16:43:30.873053 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-30 16:43:30.874662 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-30 16:43:31.562492 | 2026-03-30 16:43:31.562669 | PLAY [all] 2026-03-30 16:43:31.581744 | 2026-03-30 16:43:31.581941 | TASK [setup-uv : Extract archive] 2026-03-30 16:43:35.025427 | controller | changed 2026-03-30 16:43:35.051214 | 2026-03-30 16:43:35.051457 | TASK [setup-uv : Print version] 2026-03-30 16:43:35.085839 | controller | uv 0.8.13 2026-03-30 16:43:35.593900 | controller | ok: Runtime: 0:00:00.015221 2026-03-30 16:43:35.601208 | 2026-03-30 16:43:35.601275 | PLAY RECAP 2026-03-30 16:43:35.601331 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-30 16:43:35.601355 | 2026-03-30 16:43:35.734316 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-30 16:43:35.735821 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-30 16:43:36.423546 | 2026-03-30 16:43:36.423723 | PLAY [all] 2026-03-30 16:43:36.434339 | 2026-03-30 16:43:36.434490 | TASK [Update apt cache] 2026-03-30 16:43:42.262049 | controller | ok 2026-03-30 16:43:42.268657 | 2026-03-30 16:43:42.268754 | TASK [Disable firewalld] 2026-03-30 16:43:42.293428 | controller | skipping: Conditional result was False 2026-03-30 16:43:42.298517 | 2026-03-30 16:43:42.298598 | TASK [Install "jq" for log collection] 2026-03-30 16:43:44.819899 | controller | changed 2026-03-30 16:43:44.822481 | 2026-03-30 16:43:44.822548 | PLAY RECAP 2026-03-30 16:43:44.822608 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-30 16:43:44.822639 | 2026-03-30 16:43:44.941140 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-30 16:43:44.943963 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-30 16:43:45.616058 | 2026-03-30 16:43:45.932631 | PLAY [all] 2026-03-30 16:43:45.954767 | 2026-03-30 16:43:45.954975 | TASK [Copy inventory file for Zuul] 2026-03-30 16:43:46.935103 | controller | changed 2026-03-30 16:43:46.942709 | 2026-03-30 16:43:46.942840 | TASK [Switch "ansible_host" to private IP] 2026-03-30 16:43:47.253062 | controller | changed: 1 replacements made 2026-03-30 16:43:47.259931 | 2026-03-30 16:43:47.260047 | TASK [Run Molecule scenario] 2026-03-30 16:43:47.324478 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-03-30 16:43:47.324612 | controller | Creating virtual environment at: .venv 2026-03-30 16:43:47.720057 | controller | Downloading pygments (1.2MiB) 2026-03-30 16:43:47.722388 | controller | Downloading ansible-core (2.3MiB) 2026-03-30 16:43:47.722809 | controller | Downloading cryptography (4.3MiB) 2026-03-30 16:43:47.971120 | controller | Downloading cryptography 2026-03-30 16:43:47.976165 | controller | Downloading pygments 2026-03-30 16:43:48.156662 | controller | Downloading ansible-core 2026-03-30 16:43:48.204512 | controller | Installed 36 packages in 46ms 2026-03-30 16:43:48.881372 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-03-30 16:43:48.881435 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-03-30 16:43:49.787918 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-03-30 16:43:49.787982 | controller | INFO default scenario not found, disabling shared state. 2026-03-30 16:43:49.788002 | controller | INFO [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-03-30 16:43:49.788011 | controller | INFO [helm > prerun] Performing prerun with role_name_check=0... 2026-03-30 16:48:03.594099 | controller | INFO [helm > dependency] Executing 2026-03-30 16:48:03.594223 | controller | WARNING [helm > dependency] Missing roles requirements file: requirements.yml 2026-03-30 16:48:03.594427 | controller | WARNING [helm > dependency] Missing collections requirements file: collections.yml 2026-03-30 16:48:03.594572 | controller | WARNING [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-03-30 16:48:03.599953 | controller | INFO [helm > cleanup] Executing 2026-03-30 16:48:03.600274 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-30 16:48:03.605663 | controller | INFO [helm > destroy] Executing 2026-03-30 16:48:03.605714 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-30 16:48:03.605804 | controller | INFO [helm > destroy] Executed: Successful 2026-03-30 16:48:03.611014 | controller | INFO [helm > syntax] Executing 2026-03-30 16:48:04.479161 | controller | 2026-03-30 16:48:04.479377 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml 2026-03-30 16:48:04.538858 | controller | INFO [helm > syntax] Executed: Successful 2026-03-30 16:48:04.548602 | controller | INFO [helm > create] Executing 2026-03-30 16:48:04.550188 | controller | WARNING [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-30 16:48:04.555621 | controller | INFO [helm > prepare] Executing 2026-03-30 16:48:05.410185 | controller | 2026-03-30 16:48:05.410413 | controller | PLAY [Prepare] ***************************************************************** 2026-03-30 16:48:05.410626 | controller | 2026-03-30 16:48:05.410853 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-30 16:48:05.411075 | controller | Monday 30 March 2026 16:48:05 +0000 (0:00:00.028) 0:00:00.028 ********** 2026-03-30 16:48:06.663016 | 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 16:48:06.669480 | controller | ok: [controller] 2026-03-30 16:48:06.669654 | controller | 2026-03-30 16:48:06.669864 | controller | TASK [Install Debian packages] ************************************************* 2026-03-30 16:48:06.670063 | controller | Monday 30 March 2026 16:48:06 +0000 (0:00:01.259) 0:00:01.288 ********** 2026-03-30 16:48:07.951797 | controller | ok: [controller] 2026-03-30 16:48:07.951966 | controller | 2026-03-30 16:48:07.952190 | controller | PLAY RECAP ********************************************************************* 2026-03-30 16:48:07.952433 | controller | controller : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-30 16:48:07.952631 | controller | 2026-03-30 16:48:07.952829 | controller | 2026-03-30 16:48:07.953068 | controller | TASKS RECAP ******************************************************************** 2026-03-30 16:48:07.953277 | controller | Monday 30 March 2026 16:48:07 +0000 (0:00:01.282) 0:00:02.571 ********** 2026-03-30 16:48:07.953462 | controller | =============================================================================== 2026-03-30 16:48:07.953648 | controller | Install Debian packages ------------------------------------------------- 1.28s 2026-03-30 16:48:07.953845 | controller | Gathering Facts --------------------------------------------------------- 1.26s 2026-03-30 16:48:08.042776 | controller | INFO [helm > prepare] Executed: Successful 2026-03-30 16:48:08.052898 | controller | INFO [helm > converge] Executing 2026-03-30 16:48:08.881931 | controller | 2026-03-30 16:48:08.882085 | controller | PLAY [Converge] **************************************************************** 2026-03-30 16:48:08.882269 | controller | 2026-03-30 16:48:08.882480 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-30 16:48:08.882683 | controller | Monday 30 March 2026 16:48:08 +0000 (0:00:00.012) 0:00:00.012 ********** 2026-03-30 16:48:10.921651 | 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 16:48:10.928281 | controller | ok: [controller] 2026-03-30 16:48:10.928391 | controller | 2026-03-30 16:48:10.928520 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-30 16:48:10.929047 | controller | Monday 30 March 2026 16:48:10 +0000 (0:00:02.046) 0:00:02.058 ********** 2026-03-30 16:48:11.436984 | controller | ok: [controller] 2026-03-30 16:48:11.437007 | controller | 2026-03-30 16:48:11.437011 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-30 16:48:11.437015 | controller | Monday 30 March 2026 16:48:11 +0000 (0:00:00.507) 0:00:02.566 ********** 2026-03-30 16:48:12.447558 | controller | ok: [controller] 2026-03-30 16:48:12.447697 | controller | 2026-03-30 16:48:12.447905 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-30 16:48:12.448096 | controller | Monday 30 March 2026 16:48:12 +0000 (0:00:01.011) 0:00:03.578 ********** 2026-03-30 16:48:12.872409 | controller | changed: [controller] 2026-03-30 16:48:12.872458 | controller | 2026-03-30 16:48:12.872468 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-30 16:48:12.872476 | controller | Monday 30 March 2026 16:48:12 +0000 (0:00:00.423) 0:00:04.001 ********** 2026-03-30 16:48:12.914564 | controller | ok: [controller] => { 2026-03-30 16:48:12.914784 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-30 16:48:12.914986 | controller | } 2026-03-30 16:48:12.915167 | controller | 2026-03-30 16:48:12.915407 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-30 16:48:12.915641 | controller | Monday 30 March 2026 16:48:12 +0000 (0:00:00.043) 0:00:04.045 ********** 2026-03-30 16:48:13.689030 | 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 16:48:13.697559 | controller | changed: [controller] 2026-03-30 16:48:13.697748 | controller | 2026-03-30 16:48:13.697974 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-30 16:48:13.698190 | controller | Monday 30 March 2026 16:48:13 +0000 (0:00:00.783) 0:00:04.828 ********** 2026-03-30 16:48:15.739639 | controller | changed: [controller] 2026-03-30 16:48:15.739793 | controller | 2026-03-30 16:48:15.740016 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-30 16:48:15.740318 | controller | Monday 30 March 2026 16:48:15 +0000 (0:00:02.042) 0:00:06.870 ********** 2026-03-30 16:48:16.269034 | controller | ok: [controller] 2026-03-30 16:48:16.269203 | controller | 2026-03-30 16:48:16.269419 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-30 16:48:16.269616 | controller | Monday 30 March 2026 16:48:16 +0000 (0:00:00.528) 0:00:07.399 ********** 2026-03-30 16:48:16.705769 | controller | changed: [controller] 2026-03-30 16:48:16.705870 | controller | 2026-03-30 16:48:16.706053 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-30 16:48:16.706243 | controller | Monday 30 March 2026 16:48:16 +0000 (0:00:00.436) 0:00:07.836 ********** 2026-03-30 16:48:17.173697 | controller | ok: [controller] 2026-03-30 16:48:17.173872 | controller | 2026-03-30 16:48:17.174144 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-30 16:48:17.174382 | controller | Monday 30 March 2026 16:48:17 +0000 (0:00:00.468) 0:00:08.304 ********** 2026-03-30 16:48:17.472499 | controller | changed: [controller] 2026-03-30 16:48:17.472659 | controller | 2026-03-30 16:48:17.472901 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-30 16:48:17.473191 | controller | Monday 30 March 2026 16:48:17 +0000 (0:00:00.298) 0:00:08.602 ********** 2026-03-30 16:48:17.772007 | controller | ok: [controller] 2026-03-30 16:48:17.772137 | controller | 2026-03-30 16:48:17.772372 | controller | TASK [Install plugin] ********************************************************** 2026-03-30 16:48:17.772579 | controller | Monday 30 March 2026 16:48:17 +0000 (0:00:00.299) 0:00:08.902 ********** 2026-03-30 16:48:17.825853 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-30 16:48:17.825995 | controller | 2026-03-30 16:48:17.826221 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-30 16:48:17.826439 | controller | Monday 30 March 2026 16:48:17 +0000 (0:00:00.053) 0:00:08.956 ********** 2026-03-30 16:48:17.872124 | controller | ok: [controller] => { 2026-03-30 16:48:17.872276 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-30 16:48:17.872422 | controller | } 2026-03-30 16:48:17.872554 | controller | 2026-03-30 16:48:17.872714 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-30 16:48:17.872868 | controller | Monday 30 March 2026 16:48:17 +0000 (0:00:00.046) 0:00:09.002 ********** 2026-03-30 16:48:18.686963 | controller | changed: [controller] 2026-03-30 16:48:18.686989 | controller | 2026-03-30 16:48:18.686993 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-30 16:48:18.686997 | controller | Monday 30 March 2026 16:48:18 +0000 (0:00:00.812) 0:00:09.814 ********** 2026-03-30 16:48:20.761131 | controller | changed: [controller] 2026-03-30 16:48:20.761219 | controller | 2026-03-30 16:48:20.761354 | controller | PLAY RECAP ********************************************************************* 2026-03-30 16:48:20.761507 | controller | controller : ok=16 changed=7 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-30 16:48:20.761633 | controller | 2026-03-30 16:48:20.761751 | controller | 2026-03-30 16:48:20.761865 | controller | TASKS RECAP ******************************************************************** 2026-03-30 16:48:20.761981 | controller | Monday 30 March 2026 16:48:20 +0000 (0:00:02.077) 0:00:11.892 ********** 2026-03-30 16:48:20.762096 | controller | =============================================================================== 2026-03-30 16:48:20.762218 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.08s 2026-03-30 16:48:20.762343 | controller | Gathering Facts --------------------------------------------------------- 2.05s 2026-03-30 16:48:20.762470 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.04s 2026-03-30 16:48:20.762581 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.01s 2026-03-30 16:48:20.762680 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.81s 2026-03-30 16:48:20.762798 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.78s 2026-03-30 16:48:20.762916 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.53s 2026-03-30 16:48:20.763303 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.51s 2026-03-30 16:48:20.763495 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.47s 2026-03-30 16:48:20.763673 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.44s 2026-03-30 16:48:20.763851 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.42s 2026-03-30 16:48:20.764041 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.30s 2026-03-30 16:48:20.764307 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.30s 2026-03-30 16:48:20.764472 | controller | Install plugin ---------------------------------------------------------- 0.05s 2026-03-30 16:48:20.764600 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-30 16:48:20.764746 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s 2026-03-30 16:48:20.859112 | controller | INFO [helm > converge] Executed: Successful 2026-03-30 16:48:20.867754 | controller | INFO [helm > idempotence] Executing 2026-03-30 16:48:21.739639 | controller | 2026-03-30 16:48:21.739886 | controller | PLAY [Converge] **************************************************************** 2026-03-30 16:48:21.740135 | controller | 2026-03-30 16:48:21.740381 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-30 16:48:21.740672 | controller | Monday 30 March 2026 16:48:21 +0000 (0:00:00.013) 0:00:00.013 ********** 2026-03-30 16:48:22.793423 | 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 16:48:22.800785 | controller | ok: [controller] 2026-03-30 16:48:22.801005 | controller | 2026-03-30 16:48:22.801253 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-30 16:48:22.801448 | controller | Monday 30 March 2026 16:48:22 +0000 (0:00:01.060) 0:00:01.074 ********** 2026-03-30 16:48:23.247030 | controller | ok: [controller] 2026-03-30 16:48:23.247053 | controller | 2026-03-30 16:48:23.247058 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-30 16:48:23.247061 | controller | Monday 30 March 2026 16:48:23 +0000 (0:00:00.444) 0:00:01.519 ********** 2026-03-30 16:48:24.260504 | controller | ok: [controller] 2026-03-30 16:48:24.260681 | controller | 2026-03-30 16:48:24.260837 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-30 16:48:24.261027 | controller | Monday 30 March 2026 16:48:24 +0000 (0:00:01.014) 0:00:02.534 ********** 2026-03-30 16:48:24.664555 | controller | ok: [controller] 2026-03-30 16:48:24.664605 | controller | 2026-03-30 16:48:24.664738 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-30 16:48:24.664864 | controller | Monday 30 March 2026 16:48:24 +0000 (0:00:00.401) 0:00:02.935 ********** 2026-03-30 16:48:24.708383 | controller | ok: [controller] => { 2026-03-30 16:48:24.708482 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-30 16:48:24.708572 | controller | } 2026-03-30 16:48:24.708656 | controller | 2026-03-30 16:48:24.708753 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-30 16:48:24.708837 | controller | Monday 30 March 2026 16:48:24 +0000 (0:00:00.046) 0:00:02.981 ********** 2026-03-30 16:48:25.218690 | controller | ok: [controller] 2026-03-30 16:48:25.218753 | controller | 2026-03-30 16:48:25.218896 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-30 16:48:25.219018 | controller | Monday 30 March 2026 16:48:25 +0000 (0:00:00.510) 0:00:03.492 ********** 2026-03-30 16:48:26.887296 | controller | ok: [controller] 2026-03-30 16:48:26.887349 | controller | 2026-03-30 16:48:26.887471 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-30 16:48:26.887586 | controller | Monday 30 March 2026 16:48:26 +0000 (0:00:01.666) 0:00:05.159 ********** 2026-03-30 16:48:27.429242 | controller | ok: [controller] 2026-03-30 16:48:27.429301 | controller | 2026-03-30 16:48:27.429478 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-30 16:48:27.429659 | controller | Monday 30 March 2026 16:48:27 +0000 (0:00:00.543) 0:00:05.703 ********** 2026-03-30 16:48:27.852052 | controller | ok: [controller] 2026-03-30 16:48:27.852104 | controller | 2026-03-30 16:48:27.852175 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-30 16:48:27.852276 | controller | Monday 30 March 2026 16:48:27 +0000 (0:00:00.420) 0:00:06.123 ********** 2026-03-30 16:48:28.310221 | controller | ok: [controller] 2026-03-30 16:48:28.310313 | controller | 2026-03-30 16:48:28.310464 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-30 16:48:28.310598 | controller | Monday 30 March 2026 16:48:28 +0000 (0:00:00.460) 0:00:06.583 ********** 2026-03-30 16:48:28.645198 | controller | ok: [controller] 2026-03-30 16:48:28.645303 | controller | 2026-03-30 16:48:28.645457 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-30 16:48:28.645584 | controller | Monday 30 March 2026 16:48:28 +0000 (0:00:00.335) 0:00:06.918 ********** 2026-03-30 16:48:28.946495 | controller | ok: [controller] 2026-03-30 16:48:28.948968 | controller | 2026-03-30 16:48:28.948985 | controller | TASK [Install plugin] ********************************************************** 2026-03-30 16:48:28.948994 | controller | Monday 30 March 2026 16:48:28 +0000 (0:00:00.301) 0:00:07.220 ********** 2026-03-30 16:48:29.005542 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-30 16:48:29.005562 | controller | 2026-03-30 16:48:29.005567 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-30 16:48:29.005570 | controller | Monday 30 March 2026 16:48:28 +0000 (0:00:00.056) 0:00:07.277 ********** 2026-03-30 16:48:29.049793 | controller | ok: [controller] => { 2026-03-30 16:48:29.050103 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-30 16:48:29.053494 | controller | } 2026-03-30 16:48:29.053504 | controller | 2026-03-30 16:48:29.053508 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-30 16:48:29.053511 | controller | Monday 30 March 2026 16:48:29 +0000 (0:00:00.045) 0:00:07.323 ********** 2026-03-30 16:48:29.484117 | controller | ok: [controller] 2026-03-30 16:48:29.484171 | controller | 2026-03-30 16:48:29.484299 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-30 16:48:29.484391 | controller | Monday 30 March 2026 16:48:29 +0000 (0:00:00.434) 0:00:07.757 ********** 2026-03-30 16:48:31.109005 | controller | ok: [controller] 2026-03-30 16:48:31.109032 | controller | 2026-03-30 16:48:31.109037 | controller | PLAY RECAP ********************************************************************* 2026-03-30 16:48:31.109042 | controller | controller : ok=16 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-30 16:48:31.109046 | controller | 2026-03-30 16:48:31.109050 | controller | 2026-03-30 16:48:31.109054 | controller | TASKS RECAP ******************************************************************** 2026-03-30 16:48:31.109058 | controller | Monday 30 March 2026 16:48:31 +0000 (0:00:01.623) 0:00:09.381 ********** 2026-03-30 16:48:31.109062 | controller | =============================================================================== 2026-03-30 16:48:31.109070 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.67s 2026-03-30 16:48:31.112130 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.62s 2026-03-30 16:48:31.112154 | controller | Gathering Facts --------------------------------------------------------- 1.06s 2026-03-30 16:48:31.112160 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.01s 2026-03-30 16:48:31.112164 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.54s 2026-03-30 16:48:31.112169 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.51s 2026-03-30 16:48:31.112174 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.46s 2026-03-30 16:48:31.112178 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.44s 2026-03-30 16:48:31.112184 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.43s 2026-03-30 16:48:31.112189 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.42s 2026-03-30 16:48:31.112202 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.40s 2026-03-30 16:48:31.112207 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.34s 2026-03-30 16:48:31.112212 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.30s 2026-03-30 16:48:31.112217 | controller | Install plugin ---------------------------------------------------------- 0.06s 2026-03-30 16:48:31.112221 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-30 16:48:31.112226 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-30 16:48:31.193887 | controller | INFO [helm > idempotence] Executed: Successful 2026-03-30 16:48:31.203087 | controller | INFO [helm > side_effect] Executing 2026-03-30 16:48:31.203585 | controller | WARNING [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-30 16:48:31.210475 | controller | INFO [helm > verify] Executing 2026-03-30 16:48:32.049215 | controller | 2026-03-30 16:48:32.049557 | controller | PLAY [Verify] ****************************************************************** 2026-03-30 16:48:32.049806 | controller | 2026-03-30 16:48:32.050106 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-30 16:48:32.050375 | controller | Monday 30 March 2026 16:48:32 +0000 (0:00:00.009) 0:00:00.009 ********** 2026-03-30 16:48:34.090943 | 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 16:48:34.097426 | controller | ok: [controller] 2026-03-30 16:48:34.097529 | controller | 2026-03-30 16:48:34.097647 | controller | TASK [Get the current Helm version] ******************************************** 2026-03-30 16:48:34.097750 | controller | Monday 30 March 2026 16:48:34 +0000 (0:00:02.048) 0:00:02.057 ********** 2026-03-30 16:48:34.533300 | controller | changed: [controller] 2026-03-30 16:48:34.533593 | controller | 2026-03-30 16:48:34.533762 | controller | TASK [Assert Helm version] ***************************************************** 2026-03-30 16:48:34.533946 | controller | Monday 30 March 2026 16:48:34 +0000 (0:00:00.435) 0:00:02.493 ********** 2026-03-30 16:48:34.560776 | controller | ok: [controller] => { 2026-03-30 16:48:34.560870 | controller | "changed": false, 2026-03-30 16:48:34.561111 | controller | "msg": "All assertions passed" 2026-03-30 16:48:34.561135 | controller | } 2026-03-30 16:48:34.561184 | controller | 2026-03-30 16:48:34.561311 | controller | PLAY RECAP ********************************************************************* 2026-03-30 16:48:34.561523 | controller | controller : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-30 16:48:34.561687 | controller | 2026-03-30 16:48:34.561911 | controller | 2026-03-30 16:48:34.562068 | controller | TASKS RECAP ******************************************************************** 2026-03-30 16:48:34.562262 | controller | Monday 30 March 2026 16:48:34 +0000 (0:00:00.028) 0:00:02.521 ********** 2026-03-30 16:48:34.562429 | controller | =============================================================================== 2026-03-30 16:48:34.562607 | controller | Gathering Facts --------------------------------------------------------- 2.05s 2026-03-30 16:48:34.562788 | controller | Get the current Helm version -------------------------------------------- 0.44s 2026-03-30 16:48:34.562966 | controller | Assert Helm version ----------------------------------------------------- 0.03s 2026-03-30 16:48:34.658730 | controller | INFO [helm > verify] Executed: Successful 2026-03-30 16:48:34.665336 | controller | INFO [helm > cleanup] Executing 2026-03-30 16:48:34.665679 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-30 16:48:34.673770 | controller | INFO [helm > destroy] Executing 2026-03-30 16:48:34.673887 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-30 16:48:34.673979 | controller | INFO [helm > destroy] Executed: Successful 2026-03-30 16:48:34.674298 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-03-30 16:48:35.230941 | controller | ok: Runtime: 0:04:47.503072 2026-03-30 16:48:36.076785 | 2026-03-30 16:48:36.076901 | PLAY RECAP 2026-03-30 16:48:36.076978 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-30 16:48:36.077006 | 2026-03-30 16:48:36.229317 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-30 16:48:36.232353 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-30 16:48:36.955367 | 2026-03-30 16:48:36.955534 | PLAY [all] 2026-03-30 16:48:36.967574 | 2026-03-30 16:48:36.967692 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-03-30 16:48:37.845085 | controller | changed 2026-03-30 16:48:37.852461 | 2026-03-30 16:48:37.852641 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-03-30 16:48:38.945671 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-30 16:48:38.945740 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-30 16:48:38.950820 | controller | environment: line 1: kubectl: command not found 2026-03-30 16:48:38.952287 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-30 16:48:38.953924 | controller | environment: line 1: kubectl: command not found 2026-03-30 16:48:38.956175 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-30 16:48:38.957389 | controller | environment: line 1: kubectl: command not found 2026-03-30 16:48:38.959581 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-30 16:48:38.961601 | controller | environment: line 1: kubectl: command not found 2026-03-30 16:48:38.961895 | controller | environment: line 1: kubectl: command not found 2026-03-30 16:48:38.962886 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-30 16:48:38.964108 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-30 16:48:39.561240 | controller | ok: Runtime: 0:00:00.029556 2026-03-30 16:48:39.567453 | 2026-03-30 16:48:39.570730 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-03-30 16:48:39.844714 | controller | changed 2026-03-30 16:48:39.849470 | 2026-03-30 16:48:39.849562 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-03-30 16:48:40.135654 | controller | environment: line 5: kubectl: command not found 2026-03-30 16:48:40.136989 | controller | xargs: xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args valuewarning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-30 16:48:40.137015 | controller | 2026-03-30 16:48:40.137122 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-30 16:48:40.378933 | controller | ok: Runtime: 0:00:00.010390 2026-03-30 16:48:40.389188 | 2026-03-30 16:48:40.389308 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-03-30 16:48:41.100620 | controller | changed: 2026-03-30 16:48:41.227620 | controller | created directory /var/lib/zuul/builds/6920d72abbd14877b348183f27eb5a3b/work/logs/controller 2026-03-30 16:48:41.227745 | controller | cd+++++++++ objects/ 2026-03-30 16:48:41.227774 | controller | cd+++++++++ objects/cluster/ 2026-03-30 16:48:41.227801 | controller | cd+++++++++ objects/namespaced/ 2026-03-30 16:48:41.238624 | 2026-03-30 16:48:41.238740 | TASK [gather-pod-logs : creating directory for pod logs] 2026-03-30 16:48:41.487651 | controller | changed 2026-03-30 16:48:41.493450 | 2026-03-30 16:48:41.493546 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-03-30 16:48:41.728609 | controller | changed 2026-03-30 16:48:41.734207 | 2026-03-30 16:48:41.734310 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-03-30 16:48:41.981352 | controller | environment: line 3: kubectl: command not found 2026-03-30 16:48:43.775893 | controller | ok: Runtime: 0:00:00.011800 2026-03-30 16:48:43.781457 | 2026-03-30 16:48:43.784124 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-03-30 16:48:44.367266 | controller | changed: 2026-03-30 16:48:44.414481 | controller | cd+++++++++ pod-logs/ 2026-03-30 16:48:44.414620 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-03-30 16:48:44.425110 | 2026-03-30 16:48:44.425359 | LOOP [helm-release-status : creating directory for helm release status] 2026-03-30 16:48:44.678577 | controller | changed: "values" 2026-03-30 16:48:44.877133 | controller | changed: "releases" 2026-03-30 16:48:44.901038 | 2026-03-30 16:48:44.906132 | TASK [helm-release-status : Gather get release status for helm charts] 2026-03-30 16:48:45.193052 | controller | /bin/bash: line 3: kubectl: command not found 2026-03-30 16:48:45.444853 | controller | ok: Runtime: 0:00:00.008231 2026-03-30 16:48:45.451585 | 2026-03-30 16:48:47.685955 | TASK [helm-release-status : Downloads logs to executor] 2026-03-30 16:48:48.694487 | controller | changed: 2026-03-30 16:48:48.694723 | controller | cd+++++++++ helm/ 2026-03-30 16:48:48.694758 | controller | cd+++++++++ helm/releases/ 2026-03-30 16:48:48.694788 | controller | cd+++++++++ helm/values/ 2026-03-30 16:48:48.706796 | 2026-03-30 16:48:48.706946 | PLAY RECAP 2026-03-30 16:48:48.707014 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-30 16:48:48.707047 | 2026-03-30 16:48:48.928743 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-30 16:48:48.931264 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-30 16:48:49.662587 | 2026-03-30 16:48:49.662834 | PLAY [all] 2026-03-30 16:48:49.677176 | 2026-03-30 16:48:49.677275 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-30 16:48:49.722705 | controller | skipping: Conditional result was False 2026-03-30 16:48:49.731211 | 2026-03-30 16:48:49.731331 | TASK [fetch-output : Set log path for single node] 2026-03-30 16:48:49.772250 | controller | ok 2026-03-30 16:48:49.777807 | 2026-03-30 16:48:49.777899 | LOOP [fetch-output : Ensure local output dirs] 2026-03-30 16:48:52.124243 | controller -> localhost | ok: "/var/lib/zuul/builds/6920d72abbd14877b348183f27eb5a3b/work/logs" 2026-03-30 16:48:52.450284 | controller -> localhost | changed: "/var/lib/zuul/builds/6920d72abbd14877b348183f27eb5a3b/work/artifacts" 2026-03-30 16:48:52.753392 | controller -> localhost | changed: "/var/lib/zuul/builds/6920d72abbd14877b348183f27eb5a3b/work/docs" 2026-03-30 16:48:52.779615 | 2026-03-30 16:48:52.779774 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-30 16:48:53.577814 | controller | changed: .d..t...... ./ 2026-03-30 16:48:53.578181 | controller | changed: All items complete 2026-03-30 16:48:53.578266 | 2026-03-30 16:48:54.150191 | controller | changed: .d..t...... ./ 2026-03-30 16:48:54.700707 | controller | changed: .d..t...... ./ 2026-03-30 16:48:54.717476 | 2026-03-30 16:48:54.717651 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-30 16:48:56.297944 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.563981 2026-03-30 16:48:56.649811 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.008617 2026-03-30 16:48:56.666988 | 2026-03-30 16:48:56.667140 | PLAY [all] 2026-03-30 16:48:56.679638 | 2026-03-30 16:48:56.679826 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-30 16:48:57.250242 | controller | changed 2026-03-30 16:48:57.258647 | 2026-03-30 16:48:57.258745 | PLAY RECAP 2026-03-30 16:48:57.258792 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-30 16:48:57.258817 | 2026-03-30 16:48:57.417691 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-30 16:48:57.477561 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-30 16:48:58.215380 | 2026-03-30 16:48:58.256713 | PLAY [localhost] 2026-03-30 16:48:58.277090 | 2026-03-30 16:48:58.351506 | TASK [Generate Zuul manifest] 2026-03-30 16:48:58.386073 | localhost | ok 2026-03-30 16:48:58.405178 | 2026-03-30 16:48:58.405329 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-30 16:48:58.830793 | localhost | changed 2026-03-30 16:48:58.846252 | 2026-03-30 16:48:58.846433 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-30 16:48:58.887568 | localhost | ok 2026-03-30 16:48:58.899311 | 2026-03-30 16:48:58.899516 | TASK [Upload logs] 2026-03-30 16:48:58.918118 | localhost | ok 2026-03-30 16:48:58.981122 | 2026-03-30 16:48:59.002606 | TASK [Set zuul-log-path fact] 2026-03-30 16:48:59.025258 | localhost | ok 2026-03-30 16:48:59.063894 | 2026-03-30 16:48:59.064035 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-30 16:48:59.094128 | localhost | ok 2026-03-30 16:48:59.103233 | 2026-03-30 16:48:59.103332 | TASK [upload-logs : Create log directories] 2026-03-30 16:48:59.828837 | localhost | changed 2026-03-30 16:48:59.873990 | 2026-03-30 16:48:59.874114 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-30 16:49:00.340500 | localhost -> localhost | ok: Runtime: 0:00:00.006234 2026-03-30 16:49:00.348317 | 2026-03-30 16:49:00.348443 | TASK [upload-logs : Upload logs to log server] 2026-03-30 16:49:01.661757 | localhost | Output suppressed because no_log was given 2026-03-30 16:49:01.667780 | 2026-03-30 16:49:01.667875 | LOOP [upload-logs : Compress console log and json output] 2026-03-30 16:49:01.727679 | localhost | skipping: Conditional result was False 2026-03-30 16:49:01.984543 | localhost | skipping: Conditional result was False 2026-03-30 16:49:01.998378 | 2026-03-30 16:49:01.998554 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-30 16:49:02.049774 | localhost | skipping: Conditional result was False 2026-03-30 16:49:02.050413 | 2026-03-30 16:49:02.056695 | localhost | skipping: Conditional result was False 2026-03-30 16:49:02.072753 | 2026-03-30 16:49:02.088335 | LOOP [upload-logs : Upload console log and json output]