2026-04-13 14:59:38.281884 | Job console starting 2026-04-13 14:59:38.292415 | Updating git repos 2026-04-13 14:59:38.331306 | Cloning repos into workspace 2026-04-13 14:59:44.678159 | Restoring repo states 2026-04-13 14:59:44.692298 | Merging changes 2026-04-13 14:59:45.685812 | Checking out repos 2026-04-13 14:59:46.019990 | Preparing playbooks 2026-04-13 15:00:13.277134 | Running Ansible setup 2026-04-13 15:00:18.527377 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-13 15:00:19.196428 | 2026-04-13 15:00:19.196839 | PLAY [localhost] 2026-04-13 15:00:19.204996 | 2026-04-13 15:00:19.205094 | TASK [Gathering Facts] 2026-04-13 15:00:20.155235 | localhost | ok 2026-04-13 15:00:20.166399 | 2026-04-13 15:00:20.166536 | TASK [Setup log path fact] 2026-04-13 15:00:20.217356 | localhost | ok 2026-04-13 15:00:20.228021 | 2026-04-13 15:00:20.228160 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-13 15:00:20.258927 | localhost | ok 2026-04-13 15:00:20.267156 | 2026-04-13 15:00:20.267282 | TASK [emit-job-header : Print job information] 2026-04-13 15:00:20.305956 | # Job Information 2026-04-13 15:00:20.306134 | Ansible Version: 2.16.16 2026-04-13 15:00:20.306166 | Job: ansible-collection-kubernetes-molecule-helm 2026-04-13 15:00:20.306188 | Pipeline: check 2026-04-13 15:00:20.306209 | Executor: 0a8996d2b663 2026-04-13 15:00:20.306228 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/259 2026-04-13 15:00:20.306251 | Event ID: 3eebff30-3749-11f1-85e8-c06ee1d1e213 2026-04-13 15:00:20.309335 | 2026-04-13 15:00:20.309419 | LOOP [emit-job-header : Print node information] 2026-04-13 15:00:20.434652 | localhost | ok: 2026-04-13 15:00:20.434828 | localhost | # Node Information 2026-04-13 15:00:20.434858 | localhost | Inventory Hostname: controller 2026-04-13 15:00:20.434880 | localhost | Hostname: np0000165507 2026-04-13 15:00:20.434900 | localhost | Username: zuul 2026-04-13 15:00:20.434923 | localhost | Distro: Debian 13.4 2026-04-13 15:00:20.434942 | localhost | Provider: yul1 2026-04-13 15:00:20.434961 | localhost | Region: ca-ymq-1 2026-04-13 15:00:20.434986 | localhost | Label: debian-trixie 2026-04-13 15:00:20.435006 | localhost | Product Name: OpenStack Nova 2026-04-13 15:00:20.435024 | localhost | Interface IP: 199.19.213.66 2026-04-13 15:00:20.444863 | 2026-04-13 15:00:20.445005 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-13 15:00:21.083010 | localhost -> localhost | changed 2026-04-13 15:00:21.092927 | 2026-04-13 15:00:21.093036 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-13 15:00:21.971162 | localhost -> localhost | changed 2026-04-13 15:00:21.979123 | 2026-04-13 15:00:21.979248 | PLAY [all] 2026-04-13 15:00:21.993952 | 2026-04-13 15:00:21.994116 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-13 15:00:22.255840 | controller -> localhost | ok 2026-04-13 15:00:22.268365 | 2026-04-13 15:00:22.268482 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-13 15:00:22.299660 | controller | ok 2026-04-13 15:00:22.321314 | controller | included: /var/lib/zuul/builds/2211b5d7805b42b0aaddf469c743779e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-13 15:00:22.329715 | 2026-04-13 15:00:22.329820 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-13 15:00:23.112285 | controller -> localhost | Generating public/private rsa key pair. 2026-04-13 15:00:23.112516 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/2211b5d7805b42b0aaddf469c743779e/work/2211b5d7805b42b0aaddf469c743779e_id_rsa 2026-04-13 15:00:23.112564 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/2211b5d7805b42b0aaddf469c743779e/work/2211b5d7805b42b0aaddf469c743779e_id_rsa.pub 2026-04-13 15:00:23.112602 | controller -> localhost | The key fingerprint is: 2026-04-13 15:00:23.112637 | controller -> localhost | SHA256:VnJDx3C+9CUXuh4C88Mwz4BV9Z+l1am9U2DG/zeuXjg zuul-build-sshkey 2026-04-13 15:00:23.112681 | controller -> localhost | The key's randomart image is: 2026-04-13 15:00:23.112711 | controller -> localhost | +---[RSA 3072]----+ 2026-04-13 15:00:23.112745 | controller -> localhost | | .+++. . | 2026-04-13 15:00:23.112775 | controller -> localhost | | o. +..o +| 2026-04-13 15:00:23.112802 | controller -> localhost | | ..*+ o.*o*| 2026-04-13 15:00:23.112829 | controller -> localhost | | +@o =+O+| 2026-04-13 15:00:23.112856 | controller -> localhost | | S B.+oo+| 2026-04-13 15:00:23.112883 | controller -> localhost | | . + o +| 2026-04-13 15:00:23.112910 | controller -> localhost | | E =o| 2026-04-13 15:00:23.112936 | controller -> localhost | | + +| 2026-04-13 15:00:23.112993 | controller -> localhost | | .o.. | 2026-04-13 15:00:23.113023 | controller -> localhost | +----[SHA256]-----+ 2026-04-13 15:00:23.113092 | controller -> localhost | ok: Runtime: 0:00:00.350288 2026-04-13 15:00:23.118926 | 2026-04-13 15:00:23.118992 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-13 15:00:23.147044 | controller | ok 2026-04-13 15:00:23.158791 | controller | included: /var/lib/zuul/builds/2211b5d7805b42b0aaddf469c743779e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-13 15:00:23.171890 | 2026-04-13 15:00:23.172038 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-13 15:00:23.197787 | controller | skipping: Conditional result was False 2026-04-13 15:00:23.206472 | 2026-04-13 15:00:23.206614 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-13 15:00:23.764777 | controller | changed 2026-04-13 15:00:23.769177 | 2026-04-13 15:00:23.769258 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-13 15:00:23.991806 | controller | ok 2026-04-13 15:00:23.996043 | 2026-04-13 15:00:23.996108 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-13 15:00:24.547212 | controller | changed 2026-04-13 15:00:24.552979 | 2026-04-13 15:00:24.553068 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-13 15:00:25.135741 | controller | changed 2026-04-13 15:00:25.144115 | 2026-04-13 15:00:25.144308 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-13 15:00:25.170140 | controller | skipping: Conditional result was False 2026-04-13 15:00:25.177357 | 2026-04-13 15:00:25.177454 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-13 15:00:25.569180 | controller -> localhost | changed 2026-04-13 15:00:25.581113 | 2026-04-13 15:00:25.581473 | TASK [add-build-sshkey : Add back temp key] 2026-04-13 15:00:25.919506 | controller -> localhost | Identity added: /var/lib/zuul/builds/2211b5d7805b42b0aaddf469c743779e/work/2211b5d7805b42b0aaddf469c743779e_id_rsa (zuul-build-sshkey) 2026-04-13 15:00:25.919739 | controller -> localhost | ok: Runtime: 0:00:00.016162 2026-04-13 15:00:25.927951 | 2026-04-13 15:00:25.928544 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-13 15:00:26.307561 | controller | ok 2026-04-13 15:00:26.315970 | 2026-04-13 15:00:26.320731 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-13 15:00:26.357765 | controller | skipping: Conditional result was False 2026-04-13 15:00:26.375218 | 2026-04-13 15:00:26.375323 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-13 15:00:26.759014 | controller | ok 2026-04-13 15:00:26.764687 | 2026-04-13 15:00:26.764771 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-13 15:00:27.948165 | controller | Output suppressed because no_log was given 2026-04-13 15:00:27.956032 | 2026-04-13 15:00:27.956169 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-13 15:00:28.175951 | controller | ok: "logs" 2026-04-13 15:00:28.176238 | controller | ok: All items complete 2026-04-13 15:00:28.176281 | 2026-04-13 15:00:28.367230 | controller | ok: "artifacts" 2026-04-13 15:00:28.559519 | controller | ok: "docs" 2026-04-13 15:00:28.573205 | 2026-04-13 15:00:28.573378 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-13 15:00:28.809041 | controller | changed: "logs" 2026-04-13 15:00:29.000370 | controller | changed: "artifacts" 2026-04-13 15:00:29.211246 | controller | changed: "docs" 2026-04-13 15:00:29.228059 | 2026-04-13 15:00:29.228284 | PLAY RECAP 2026-04-13 15:00:29.228388 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-13 15:00:29.228451 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-13 15:00:29.228500 | 2026-04-13 15:00:29.406755 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-13 15:00:29.408201 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-13 15:00:30.074072 | 2026-04-13 15:00:30.074240 | PLAY [all] 2026-04-13 15:00:30.086751 | 2026-04-13 15:00:30.086854 | TASK [setup-uv : Extract archive] 2026-04-13 15:00:32.553202 | controller | changed 2026-04-13 15:00:32.558952 | 2026-04-13 15:00:32.559032 | TASK [setup-uv : Print version] 2026-04-13 15:00:32.346371 | controller | uv 0.8.13 2026-04-13 15:00:33.088364 | controller | ok: Runtime: 0:00:00.010847 2026-04-13 15:00:33.095883 | 2026-04-13 15:00:33.095934 | PLAY RECAP 2026-04-13 15:00:33.095981 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-13 15:00:33.096006 | 2026-04-13 15:00:33.198503 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-13 15:00:33.200151 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-04-13 15:00:33.818780 | 2026-04-13 15:00:33.818910 | PLAY [all] 2026-04-13 15:00:33.829195 | 2026-04-13 15:00:33.829269 | TASK [Update apt cache] 2026-04-13 15:00:40.303813 | controller | ok 2026-04-13 15:00:40.310811 | 2026-04-13 15:00:40.311016 | TASK [Disable firewalld] 2026-04-13 15:00:40.337244 | controller | skipping: Conditional result was False 2026-04-13 15:00:40.344211 | 2026-04-13 15:00:40.344309 | TASK [Install "jq" for log collection] 2026-04-13 15:00:43.445537 | controller | changed 2026-04-13 15:00:43.447473 | 2026-04-13 15:00:43.447519 | PLAY RECAP 2026-04-13 15:00:43.447562 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-13 15:00:43.447585 | 2026-04-13 15:00:43.554329 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-04-13 15:00:43.556664 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-13 15:00:44.159598 | 2026-04-13 15:00:44.159760 | PLAY [all] 2026-04-13 15:00:44.170499 | 2026-04-13 15:00:44.170608 | TASK [Copy inventory file for Zuul] 2026-04-13 15:00:45.216388 | controller | changed 2026-04-13 15:00:45.223215 | 2026-04-13 15:00:45.223320 | TASK [Switch "ansible_host" to private IP] 2026-04-13 15:00:45.536631 | controller | changed: 1 replacements made 2026-04-13 15:00:45.541287 | 2026-04-13 15:00:45.541376 | TASK [Run Molecule scenario] 2026-04-13 15:00:46.059297 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-04-13 15:00:46.059459 | controller | Creating virtual environment at: .venv 2026-04-13 15:00:47.314726 | controller | Downloading pygments (1.2MiB) 2026-04-13 15:00:47.314836 | controller | Downloading cryptography (4.3MiB) 2026-04-13 15:00:47.315147 | controller | Downloading ansible-core (2.3MiB) 2026-04-13 15:00:47.491482 | controller | Downloading cryptography 2026-04-13 15:00:47.552797 | controller | Downloading pygments 2026-04-13 15:00:47.717688 | controller | Downloading ansible-core 2026-04-13 15:00:47.811838 | controller | Installed 36 packages in 93ms 2026-04-13 15:00:48.581884 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-04-13 15:00:48.581960 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-04-13 15:00:49.597616 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-04-13 15:00:49.597681 | controller | INFO default scenario not found, disabling shared state. 2026-04-13 15:00:49.597773 | controller | INFO [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-04-13 15:00:49.597827 | controller | INFO [helm > prerun] Performing prerun with role_name_check=0... 2026-04-13 15:06:30.154575 | controller | INFO [helm > dependency] Executing 2026-04-13 15:06:30.154677 | controller | WARNING [helm > dependency] Missing roles requirements file: requirements.yml 2026-04-13 15:06:30.154882 | controller | WARNING [helm > dependency] Missing collections requirements file: collections.yml 2026-04-13 15:06:30.155000 | controller | WARNING [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-04-13 15:06:30.160572 | controller | INFO [helm > cleanup] Executing 2026-04-13 15:06:30.160892 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-13 15:06:30.166230 | controller | INFO [helm > destroy] Executing 2026-04-13 15:06:30.166324 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-04-13 15:06:30.166385 | controller | INFO [helm > destroy] Executed: Successful 2026-04-13 15:06:30.171603 | controller | INFO [helm > syntax] Executing 2026-04-13 15:06:31.074284 | controller | 2026-04-13 15:06:31.074312 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml 2026-04-13 15:06:31.136386 | controller | INFO [helm > syntax] Executed: Successful 2026-04-13 15:06:31.147301 | controller | INFO [helm > create] Executing 2026-04-13 15:06:31.148747 | controller | WARNING [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-13 15:06:31.154230 | controller | INFO [helm > prepare] Executing 2026-04-13 15:06:32.088969 | controller | 2026-04-13 15:06:32.088989 | controller | PLAY [Prepare] ***************************************************************** 2026-04-13 15:06:32.088994 | controller | 2026-04-13 15:06:32.088997 | controller | TASK [Gathering Facts] ********************************************************* 2026-04-13 15:06:32.089001 | controller | Monday 13 April 2026 15:06:32 +0000 (0:00:00.028) 0:00:00.028 ********** 2026-04-13 15:06:34.356028 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-04-13 15:06:34.362888 | controller | ok: [controller] 2026-04-13 15:06:34.363002 | controller | 2026-04-13 15:06:34.363139 | controller | TASK [Install Debian packages] ************************************************* 2026-04-13 15:06:34.363274 | controller | Monday 13 April 2026 15:06:34 +0000 (0:00:02.276) 0:00:02.304 ********** 2026-04-13 15:06:35.931634 | controller | ok: [controller] 2026-04-13 15:06:35.931804 | controller | 2026-04-13 15:06:35.932011 | controller | PLAY RECAP ********************************************************************* 2026-04-13 15:06:35.932242 | controller | controller : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-13 15:06:35.932412 | controller | 2026-04-13 15:06:35.932592 | controller | 2026-04-13 15:06:35.932767 | controller | TASKS RECAP ******************************************************************** 2026-04-13 15:06:35.932960 | controller | Monday 13 April 2026 15:06:35 +0000 (0:00:01.568) 0:00:03.873 ********** 2026-04-13 15:06:35.933141 | controller | =============================================================================== 2026-04-13 15:06:35.933332 | controller | Gathering Facts --------------------------------------------------------- 2.28s 2026-04-13 15:06:35.933506 | controller | Install Debian packages ------------------------------------------------- 1.57s 2026-04-13 15:06:36.040541 | controller | INFO [helm > prepare] Executed: Successful 2026-04-13 15:06:36.048509 | controller | INFO [helm > converge] Executing 2026-04-13 15:06:36.905874 | controller | 2026-04-13 15:06:36.906555 | controller | PLAY [Converge] **************************************************************** 2026-04-13 15:06:36.906568 | controller | 2026-04-13 15:06:36.906574 | controller | TASK [Gathering Facts] ********************************************************* 2026-04-13 15:06:36.906578 | controller | Monday 13 April 2026 15:06:36 +0000 (0:00:00.012) 0:00:00.012 ********** 2026-04-13 15:06:37.978446 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-04-13 15:06:37.983259 | controller | ok: [controller] 2026-04-13 15:06:37.983442 | controller | 2026-04-13 15:06:37.983642 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-13 15:06:37.983838 | controller | Monday 13 April 2026 15:06:37 +0000 (0:00:01.078) 0:00:01.090 ********** 2026-04-13 15:06:38.509344 | controller | ok: [controller] 2026-04-13 15:06:38.509395 | controller | 2026-04-13 15:06:38.509549 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-13 15:06:38.509695 | controller | Monday 13 April 2026 15:06:38 +0000 (0:00:00.524) 0:00:01.615 ********** 2026-04-13 15:06:39.562172 | controller | ok: [controller] 2026-04-13 15:06:39.562435 | controller | 2026-04-13 15:06:39.562733 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-04-13 15:06:39.563029 | controller | Monday 13 April 2026 15:06:39 +0000 (0:00:01.053) 0:00:02.669 ********** 2026-04-13 15:06:40.053084 | controller | changed: [controller] 2026-04-13 15:06:40.053176 | controller | 2026-04-13 15:06:40.053414 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-13 15:06:40.053682 | controller | Monday 13 April 2026 15:06:40 +0000 (0:00:00.491) 0:00:03.160 ********** 2026-04-13 15:06:40.101002 | controller | ok: [controller] => { 2026-04-13 15:06:40.101158 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-04-13 15:06:40.101342 | controller | } 2026-04-13 15:06:40.101517 | controller | 2026-04-13 15:06:40.101897 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-13 15:06:40.102094 | controller | Monday 13 April 2026 15:06:40 +0000 (0:00:00.047) 0:00:03.208 ********** 2026-04-13 15:06:40.897858 | controller | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created with a mode of 0700, this may cause issues when running as another user. To avoid this, create the remote_tmp dir with the correct permissions manually 2026-04-13 15:06:40.905373 | controller | changed: [controller] 2026-04-13 15:06:40.905488 | controller | 2026-04-13 15:06:40.905634 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-13 15:06:40.905761 | controller | Monday 13 April 2026 15:06:40 +0000 (0:00:00.804) 0:00:04.012 ********** 2026-04-13 15:06:43.032760 | controller | changed: [controller] 2026-04-13 15:06:43.032829 | controller | 2026-04-13 15:06:43.032982 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-04-13 15:06:43.033134 | controller | Monday 13 April 2026 15:06:43 +0000 (0:00:02.127) 0:00:06.139 ********** 2026-04-13 15:06:43.540686 | controller | ok: [controller] 2026-04-13 15:06:43.540772 | controller | 2026-04-13 15:06:43.540923 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-04-13 15:06:43.541098 | controller | Monday 13 April 2026 15:06:43 +0000 (0:00:00.505) 0:00:06.645 ********** 2026-04-13 15:06:43.938000 | controller | changed: [controller] 2026-04-13 15:06:43.938041 | controller | 2026-04-13 15:06:43.938046 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-04-13 15:06:43.938052 | controller | Monday 13 April 2026 15:06:43 +0000 (0:00:00.397) 0:00:07.042 ********** 2026-04-13 15:06:44.433673 | controller | ok: [controller] 2026-04-13 15:06:44.433855 | controller | 2026-04-13 15:06:44.434105 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-04-13 15:06:44.434422 | controller | Monday 13 April 2026 15:06:44 +0000 (0:00:00.498) 0:00:07.540 ********** 2026-04-13 15:06:44.766305 | controller | changed: [controller] 2026-04-13 15:06:44.766516 | controller | 2026-04-13 15:06:44.766772 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-04-13 15:06:44.767003 | controller | Monday 13 April 2026 15:06:44 +0000 (0:00:00.332) 0:00:07.873 ********** 2026-04-13 15:06:45.133165 | controller | ok: [controller] 2026-04-13 15:06:45.133221 | controller | 2026-04-13 15:06:45.133304 | controller | TASK [Install plugin] ********************************************************** 2026-04-13 15:06:45.133409 | controller | Monday 13 April 2026 15:06:45 +0000 (0:00:00.366) 0:00:08.240 ********** 2026-04-13 15:06:45.203602 | controller | included: vexxhost.containers.download_artifact for controller 2026-04-13 15:06:45.203645 | controller | 2026-04-13 15:06:45.203740 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-13 15:06:45.203837 | controller | Monday 13 April 2026 15:06:45 +0000 (0:00:00.070) 0:00:08.311 ********** 2026-04-13 15:06:45.255468 | controller | ok: [controller] => { 2026-04-13 15:06:45.255594 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-04-13 15:06:45.255724 | controller | } 2026-04-13 15:06:45.255850 | controller | 2026-04-13 15:06:45.255992 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-13 15:06:45.256132 | controller | Monday 13 April 2026 15:06:45 +0000 (0:00:00.051) 0:00:08.362 ********** 2026-04-13 15:06:46.026862 | controller | changed: [controller] 2026-04-13 15:06:46.026923 | controller | 2026-04-13 15:06:46.027092 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-13 15:06:46.027227 | controller | Monday 13 April 2026 15:06:46 +0000 (0:00:00.768) 0:00:09.131 ********** 2026-04-13 15:06:48.224611 | controller | changed: [controller] 2026-04-13 15:06:48.224672 | controller | 2026-04-13 15:06:48.224682 | controller | PLAY RECAP ********************************************************************* 2026-04-13 15:06:48.224693 | controller | controller : ok=16 changed=7 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-13 15:06:48.224839 | controller | 2026-04-13 15:06:48.225009 | controller | 2026-04-13 15:06:48.225218 | controller | TASKS RECAP ******************************************************************** 2026-04-13 15:06:48.225430 | controller | Monday 13 April 2026 15:06:48 +0000 (0:00:02.198) 0:00:11.329 ********** 2026-04-13 15:06:48.225624 | controller | =============================================================================== 2026-04-13 15:06:48.225877 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.20s 2026-04-13 15:06:48.226079 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.13s 2026-04-13 15:06:48.226352 | controller | Gathering Facts --------------------------------------------------------- 1.08s 2026-04-13 15:06:48.226598 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.05s 2026-04-13 15:06:48.226785 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.80s 2026-04-13 15:06:48.226983 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.77s 2026-04-13 15:06:48.227178 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.52s 2026-04-13 15:06:48.227379 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.51s 2026-04-13 15:06:48.227573 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.50s 2026-04-13 15:06:48.227761 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.49s 2026-04-13 15:06:48.227952 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.40s 2026-04-13 15:06:48.228172 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.37s 2026-04-13 15:06:48.228363 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.33s 2026-04-13 15:06:48.228549 | controller | Install plugin ---------------------------------------------------------- 0.07s 2026-04-13 15:06:48.228743 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-04-13 15:06:48.228956 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-04-13 15:06:48.387388 | controller | INFO [helm > converge] Executed: Successful 2026-04-13 15:06:48.396578 | controller | INFO [helm > idempotence] Executing 2026-04-13 15:06:49.329244 | controller | 2026-04-13 15:06:49.329405 | controller | PLAY [Converge] **************************************************************** 2026-04-13 15:06:49.329590 | controller | 2026-04-13 15:06:49.329793 | controller | TASK [Gathering Facts] ********************************************************* 2026-04-13 15:06:49.329997 | controller | Monday 13 April 2026 15:06:49 +0000 (0:00:00.014) 0:00:00.014 ********** 2026-04-13 15:06:50.509482 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-04-13 15:06:50.515653 | controller | ok: [controller] 2026-04-13 15:06:50.515755 | controller | 2026-04-13 15:06:50.515912 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-13 15:06:50.516059 | controller | Monday 13 April 2026 15:06:50 +0000 (0:00:01.186) 0:00:01.200 ********** 2026-04-13 15:06:51.034214 | controller | ok: [controller] 2026-04-13 15:06:51.034415 | controller | 2026-04-13 15:06:51.034601 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-13 15:06:51.034766 | controller | Monday 13 April 2026 15:06:51 +0000 (0:00:00.518) 0:00:01.718 ********** 2026-04-13 15:06:52.212725 | controller | ok: [controller] 2026-04-13 15:06:52.213017 | controller | 2026-04-13 15:06:52.213282 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-04-13 15:06:52.213535 | controller | Monday 13 April 2026 15:06:52 +0000 (0:00:01.178) 0:00:02.897 ********** 2026-04-13 15:06:52.646736 | controller | ok: [controller] 2026-04-13 15:06:52.646806 | controller | 2026-04-13 15:06:52.646820 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-13 15:06:52.646933 | controller | Monday 13 April 2026 15:06:52 +0000 (0:00:00.432) 0:00:03.329 ********** 2026-04-13 15:06:52.692380 | controller | ok: [controller] => { 2026-04-13 15:06:52.692436 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-04-13 15:06:52.692608 | controller | } 2026-04-13 15:06:52.692724 | controller | 2026-04-13 15:06:52.692859 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-13 15:06:52.693010 | controller | Monday 13 April 2026 15:06:52 +0000 (0:00:00.047) 0:00:03.376 ********** 2026-04-13 15:06:53.304805 | controller | ok: [controller] 2026-04-13 15:06:53.304877 | controller | 2026-04-13 15:06:53.305019 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-13 15:06:53.305207 | controller | Monday 13 April 2026 15:06:53 +0000 (0:00:00.612) 0:00:03.989 ********** 2026-04-13 15:06:55.051033 | controller | ok: [controller] 2026-04-13 15:06:55.051070 | controller | 2026-04-13 15:06:55.051076 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-04-13 15:06:55.051082 | controller | Monday 13 April 2026 15:06:55 +0000 (0:00:01.744) 0:00:05.733 ********** 2026-04-13 15:06:55.647439 | controller | ok: [controller] 2026-04-13 15:06:55.647507 | controller | 2026-04-13 15:06:55.647607 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-04-13 15:06:55.647739 | controller | Monday 13 April 2026 15:06:55 +0000 (0:00:00.598) 0:00:06.332 ********** 2026-04-13 15:06:56.128761 | controller | ok: [controller] 2026-04-13 15:06:56.128832 | controller | 2026-04-13 15:06:56.128966 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-04-13 15:06:56.129103 | controller | Monday 13 April 2026 15:06:56 +0000 (0:00:00.479) 0:00:06.811 ********** 2026-04-13 15:06:56.614971 | controller | ok: [controller] 2026-04-13 15:06:56.615006 | controller | 2026-04-13 15:06:56.615012 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-04-13 15:06:56.615018 | controller | Monday 13 April 2026 15:06:56 +0000 (0:00:00.484) 0:00:07.295 ********** 2026-04-13 15:06:56.928243 | controller | ok: [controller] 2026-04-13 15:06:56.928318 | controller | 2026-04-13 15:06:56.928610 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-04-13 15:06:56.928644 | controller | Monday 13 April 2026 15:06:56 +0000 (0:00:00.316) 0:00:07.612 ********** 2026-04-13 15:06:57.246837 | controller | ok: [controller] 2026-04-13 15:06:57.246914 | controller | 2026-04-13 15:06:57.246925 | controller | TASK [Install plugin] ********************************************************** 2026-04-13 15:06:57.247006 | controller | Monday 13 April 2026 15:06:57 +0000 (0:00:00.315) 0:00:07.928 ********** 2026-04-13 15:06:57.301518 | controller | included: vexxhost.containers.download_artifact for controller 2026-04-13 15:06:57.301598 | controller | 2026-04-13 15:06:57.301608 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-13 15:06:57.301676 | controller | Monday 13 April 2026 15:06:57 +0000 (0:00:00.058) 0:00:07.986 ********** 2026-04-13 15:06:57.354179 | controller | ok: [controller] => { 2026-04-13 15:06:57.354370 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-04-13 15:06:57.354427 | controller | } 2026-04-13 15:06:57.354855 | controller | 2026-04-13 15:06:57.354894 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-13 15:06:57.354901 | controller | Monday 13 April 2026 15:06:57 +0000 (0:00:00.052) 0:00:08.038 ********** 2026-04-13 15:06:57.837830 | controller | ok: [controller] 2026-04-13 15:06:57.837892 | controller | 2026-04-13 15:06:57.838036 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-13 15:06:57.838175 | controller | Monday 13 April 2026 15:06:57 +0000 (0:00:00.483) 0:00:08.522 ********** 2026-04-13 15:06:59.546322 | controller | ok: [controller] 2026-04-13 15:06:59.546365 | controller | 2026-04-13 15:06:59.546375 | controller | PLAY RECAP ********************************************************************* 2026-04-13 15:06:59.546384 | controller | controller : ok=16 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-13 15:06:59.546392 | controller | 2026-04-13 15:06:59.546400 | controller | 2026-04-13 15:06:59.546407 | controller | TASKS RECAP ******************************************************************** 2026-04-13 15:06:59.546415 | controller | Monday 13 April 2026 15:06:59 +0000 (0:00:01.706) 0:00:10.229 ********** 2026-04-13 15:06:59.546422 | controller | =============================================================================== 2026-04-13 15:06:59.546429 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.74s 2026-04-13 15:06:59.546436 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.71s 2026-04-13 15:06:59.546444 | controller | Gathering Facts --------------------------------------------------------- 1.19s 2026-04-13 15:06:59.546451 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.18s 2026-04-13 15:06:59.546635 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.61s 2026-04-13 15:06:59.546882 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.60s 2026-04-13 15:06:59.547121 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.52s 2026-04-13 15:06:59.547362 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.48s 2026-04-13 15:06:59.547662 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.48s 2026-04-13 15:06:59.547905 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.48s 2026-04-13 15:06:59.548158 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.43s 2026-04-13 15:06:59.548399 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.32s 2026-04-13 15:06:59.548746 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.32s 2026-04-13 15:06:59.548906 | controller | Install plugin ---------------------------------------------------------- 0.06s 2026-04-13 15:06:59.549067 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-04-13 15:06:59.549225 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-04-13 15:06:59.696631 | controller | INFO [helm > idempotence] Executed: Successful 2026-04-13 15:06:59.705833 | controller | INFO [helm > side_effect] Executing 2026-04-13 15:06:59.706382 | controller | WARNING [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-13 15:06:59.713013 | controller | INFO [helm > verify] Executing 2026-04-13 15:07:00.607726 | controller | 2026-04-13 15:07:00.608116 | controller | PLAY [Verify] ****************************************************************** 2026-04-13 15:07:00.608391 | controller | 2026-04-13 15:07:00.608659 | controller | TASK [Gathering Facts] ********************************************************* 2026-04-13 15:07:00.608956 | controller | Monday 13 April 2026 15:07:00 +0000 (0:00:00.012) 0:00:00.012 ********** 2026-04-13 15:07:01.716610 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-04-13 15:07:01.723902 | controller | ok: [controller] 2026-04-13 15:07:01.724107 | controller | 2026-04-13 15:07:01.724342 | controller | TASK [Get the current Helm version] ******************************************** 2026-04-13 15:07:01.724694 | controller | Monday 13 April 2026 15:07:01 +0000 (0:00:01.116) 0:00:01.128 ********** 2026-04-13 15:07:02.189838 | controller | changed: [controller] 2026-04-13 15:07:02.193087 | controller | 2026-04-13 15:07:02.193101 | controller | TASK [Assert Helm version] ***************************************************** 2026-04-13 15:07:02.193107 | controller | Monday 13 April 2026 15:07:02 +0000 (0:00:00.465) 0:00:01.593 ********** 2026-04-13 15:07:02.221845 | controller | ok: [controller] => { 2026-04-13 15:07:02.221871 | controller | "changed": false, 2026-04-13 15:07:02.221879 | controller | "msg": "All assertions passed" 2026-04-13 15:07:02.221888 | controller | } 2026-04-13 15:07:02.221896 | controller | 2026-04-13 15:07:02.221904 | controller | PLAY RECAP ********************************************************************* 2026-04-13 15:07:02.221913 | controller | controller : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-13 15:07:02.221921 | controller | 2026-04-13 15:07:02.221928 | controller | 2026-04-13 15:07:02.221936 | controller | TASKS RECAP ******************************************************************** 2026-04-13 15:07:02.221943 | controller | Monday 13 April 2026 15:07:02 +0000 (0:00:00.030) 0:00:01.624 ********** 2026-04-13 15:07:02.221951 | controller | =============================================================================== 2026-04-13 15:07:02.221958 | controller | Gathering Facts --------------------------------------------------------- 1.12s 2026-04-13 15:07:02.221965 | controller | Get the current Helm version -------------------------------------------- 0.47s 2026-04-13 15:07:02.221973 | controller | Assert Helm version ----------------------------------------------------- 0.03s 2026-04-13 15:07:02.356508 | controller | INFO [helm > verify] Executed: Successful 2026-04-13 15:07:02.363034 | controller | INFO [helm > cleanup] Executing 2026-04-13 15:07:02.363441 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-13 15:07:02.369119 | controller | INFO [helm > destroy] Executing 2026-04-13 15:07:02.369227 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-04-13 15:07:02.369317 | controller | INFO [helm > destroy] Executed: Successful 2026-04-13 15:07:02.369648 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-04-13 15:07:02.738101 | controller | ok: Runtime: 0:06:16.491561 2026-04-13 15:07:02.743343 | 2026-04-13 15:07:02.743431 | PLAY RECAP 2026-04-13 15:07:02.743497 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-13 15:07:02.743529 | 2026-04-13 15:07:02.885931 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-13 15:07:02.887836 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-04-13 15:07:03.505404 | 2026-04-13 15:07:03.505540 | PLAY [all] 2026-04-13 15:07:03.516433 | 2026-04-13 15:07:03.516561 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-04-13 15:07:03.933596 | controller | changed 2026-04-13 15:07:03.940020 | 2026-04-13 15:07:03.940170 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-04-13 15:07:04.341579 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-13 15:07:04.342014 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-13 15:07:04.348491 | controller | environment: line 1: kubectl: command not found 2026-04-13 15:07:04.350030 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-13 15:07:04.350799 | controller | environment: line 1: kubectl: command not found 2026-04-13 15:07:04.353943 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-13 15:07:04.353968 | controller | environment: line 1: kubectl: command not found 2026-04-13 15:07:04.355768 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-13 15:07:04.357197 | controller | environment: line 1: kubectl: command not found 2026-04-13 15:07:04.359032 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-13 15:07:04.361381 | controller | environment: line 1: kubectl: command not found 2026-04-13 15:07:04.363270 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-13 15:07:04.479591 | controller | ok: Runtime: 0:00:00.035514 2026-04-13 15:07:04.485685 | 2026-04-13 15:07:04.485796 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-04-13 15:07:04.735059 | controller | changed 2026-04-13 15:07:04.741167 | 2026-04-13 15:07:04.741279 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-04-13 15:07:04.985164 | controller | environment: line 5: kubectl: command not found 2026-04-13 15:07:04.986209 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-13 15:07:04.986838 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-13 15:07:04.986910 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-13 15:07:05.272181 | controller | ok: Runtime: 0:00:00.012384 2026-04-13 15:07:05.280343 | 2026-04-13 15:07:05.280438 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-04-13 15:07:05.969385 | controller | changed: 2026-04-13 15:07:05.969669 | controller | created directory /var/lib/zuul/builds/2211b5d7805b42b0aaddf469c743779e/work/logs/controller 2026-04-13 15:07:05.969729 | controller | cd+++++++++ objects/ 2026-04-13 15:07:05.969837 | controller | cd+++++++++ objects/cluster/ 2026-04-13 15:07:05.969892 | controller | cd+++++++++ objects/namespaced/ 2026-04-13 15:07:05.978229 | 2026-04-13 15:07:05.978305 | TASK [gather-pod-logs : creating directory for pod logs] 2026-04-13 15:07:06.235857 | controller | changed 2026-04-13 15:07:06.242505 | 2026-04-13 15:07:06.242576 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-04-13 15:07:06.490662 | controller | changed 2026-04-13 15:07:06.495460 | 2026-04-13 15:07:06.495540 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-04-13 15:07:06.737285 | controller | environment: line 3: kubectl: command not found 2026-04-13 15:07:07.026909 | controller | ok: Runtime: 0:00:00.012755 2026-04-13 15:07:07.033228 | 2026-04-13 15:07:07.033329 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-04-13 15:07:07.569871 | controller | changed: 2026-04-13 15:07:07.570097 | controller | cd+++++++++ pod-logs/ 2026-04-13 15:07:07.570144 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-04-13 15:07:07.580037 | 2026-04-13 15:07:07.580140 | LOOP [helm-release-status : creating directory for helm release status] 2026-04-13 15:07:07.826261 | controller | changed: "values" 2026-04-13 15:07:08.053571 | controller | changed: "releases" 2026-04-13 15:07:08.064155 | 2026-04-13 15:07:08.064313 | TASK [helm-release-status : Gather get release status for helm charts] 2026-04-13 15:07:08.313379 | controller | /bin/bash: line 3: kubectl: command not found 2026-04-13 15:07:08.596695 | controller | ok: Runtime: 0:00:00.008444 2026-04-13 15:07:08.604138 | 2026-04-13 15:07:08.604300 | TASK [helm-release-status : Downloads logs to executor] 2026-04-13 15:07:09.133703 | controller | changed: 2026-04-13 15:07:09.133901 | controller | cd+++++++++ helm/ 2026-04-13 15:07:09.133940 | controller | cd+++++++++ helm/releases/ 2026-04-13 15:07:09.133972 | controller | cd+++++++++ helm/values/ 2026-04-13 15:07:09.140143 | 2026-04-13 15:07:09.140218 | PLAY RECAP 2026-04-13 15:07:09.140277 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-13 15:07:09.140309 | 2026-04-13 15:07:09.285291 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-04-13 15:07:09.287924 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-13 15:07:09.895018 | 2026-04-13 15:07:09.895155 | PLAY [all] 2026-04-13 15:07:09.905455 | 2026-04-13 15:07:09.905544 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-13 15:07:09.950990 | controller | skipping: Conditional result was False 2026-04-13 15:07:09.959938 | 2026-04-13 15:07:09.960063 | TASK [fetch-output : Set log path for single node] 2026-04-13 15:07:10.003404 | controller | ok 2026-04-13 15:07:10.009770 | 2026-04-13 15:07:10.009907 | LOOP [fetch-output : Ensure local output dirs] 2026-04-13 15:07:10.440432 | controller -> localhost | ok: "/var/lib/zuul/builds/2211b5d7805b42b0aaddf469c743779e/work/logs" 2026-04-13 15:07:10.662371 | controller -> localhost | changed: "/var/lib/zuul/builds/2211b5d7805b42b0aaddf469c743779e/work/artifacts" 2026-04-13 15:07:10.901549 | controller -> localhost | changed: "/var/lib/zuul/builds/2211b5d7805b42b0aaddf469c743779e/work/docs" 2026-04-13 15:07:10.919380 | 2026-04-13 15:07:10.919518 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-13 15:07:11.602601 | controller | changed: .d..t...... ./ 2026-04-13 15:07:11.602991 | controller | changed: All items complete 2026-04-13 15:07:11.603040 | 2026-04-13 15:07:12.102932 | controller | changed: .d..t...... ./ 2026-04-13 15:07:12.634875 | controller | changed: .d..t...... ./ 2026-04-13 15:07:12.658250 | 2026-04-13 15:07:12.658358 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-13 15:07:13.137708 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.009620 2026-04-13 15:07:13.367510 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.008921 2026-04-13 15:07:13.383411 | 2026-04-13 15:07:13.383559 | PLAY [all] 2026-04-13 15:07:13.389911 | 2026-04-13 15:07:13.389993 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-13 15:07:13.909910 | controller | changed 2026-04-13 15:07:13.915156 | 2026-04-13 15:07:13.915232 | PLAY RECAP 2026-04-13 15:07:13.915281 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-13 15:07:13.915306 | 2026-04-13 15:07:14.093495 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-13 15:07:14.094999 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-13 15:07:14.754637 | 2026-04-13 15:07:14.754828 | PLAY [localhost] 2026-04-13 15:07:14.765598 | 2026-04-13 15:07:14.765717 | TASK [Generate Zuul manifest] 2026-04-13 15:07:14.788770 | localhost | ok 2026-04-13 15:07:14.807357 | 2026-04-13 15:07:14.807516 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-13 15:07:15.134978 | localhost | changed 2026-04-13 15:07:15.145867 | 2026-04-13 15:07:15.145963 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-13 15:07:15.179358 | localhost | ok 2026-04-13 15:07:15.190283 | 2026-04-13 15:07:15.190352 | TASK [Upload logs] 2026-04-13 15:07:15.213238 | localhost | ok 2026-04-13 15:07:15.285532 | 2026-04-13 15:07:15.285673 | TASK [Set zuul-log-path fact] 2026-04-13 15:07:15.307316 | localhost | ok 2026-04-13 15:07:15.326313 | 2026-04-13 15:07:15.326521 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-13 15:07:15.355349 | localhost | ok 2026-04-13 15:07:15.365074 | 2026-04-13 15:07:15.365190 | TASK [upload-logs : Create log directories] 2026-04-13 15:07:15.746281 | localhost | changed 2026-04-13 15:07:15.752091 | 2026-04-13 15:07:15.752173 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-13 15:07:16.156099 | localhost -> localhost | ok: Runtime: 0:00:00.006820 2026-04-13 15:07:16.161192 | 2026-04-13 15:07:16.161262 | TASK [upload-logs : Upload logs to log server] 2026-04-13 15:07:16.630440 | localhost | Output suppressed because no_log was given 2026-04-13 15:07:16.635808 | 2026-04-13 15:07:16.635876 | LOOP [upload-logs : Compress console log and json output] 2026-04-13 15:07:16.677351 | localhost | skipping: Conditional result was False 2026-04-13 15:07:16.685995 | localhost | skipping: Conditional result was False 2026-04-13 15:07:16.701149 | 2026-04-13 15:07:16.701363 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-13 15:07:16.753101 | localhost | skipping: Conditional result was False 2026-04-13 15:07:16.753610 | 2026-04-13 15:07:16.758085 | localhost | skipping: Conditional result was False 2026-04-13 15:07:16.774635 | 2026-04-13 15:07:16.774783 | LOOP [upload-logs : Upload console log and json output]