2026-03-17 20:41:47.932802 | Job console starting 2026-03-17 20:41:47.942331 | Updating git repos 2026-03-17 20:41:47.997237 | Cloning repos into workspace 2026-03-17 20:41:48.061512 | Restoring repo states 2026-03-17 20:41:48.096814 | Merging changes 2026-03-17 20:41:49.084824 | Checking out repos 2026-03-17 20:41:49.132762 | Preparing playbooks 2026-03-17 20:41:52.922504 | Running Ansible setup 2026-03-17 20:41:57.712044 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-17 20:41:58.441185 | 2026-03-17 20:41:58.441348 | PLAY [localhost] 2026-03-17 20:41:58.457673 | 2026-03-17 20:41:58.457839 | TASK [Gathering Facts] 2026-03-17 20:41:59.607226 | localhost | ok 2026-03-17 20:41:59.624172 | 2026-03-17 20:41:59.624309 | TASK [Setup log path fact] 2026-03-17 20:41:59.644338 | localhost | ok 2026-03-17 20:41:59.657430 | 2026-03-17 20:41:59.657567 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-17 20:41:59.687705 | localhost | ok 2026-03-17 20:41:59.696432 | 2026-03-17 20:41:59.696513 | TASK [emit-job-header : Print job information] 2026-03-17 20:41:59.737203 | # Job Information 2026-03-17 20:41:59.737402 | Ansible Version: 2.16.16 2026-03-17 20:41:59.737449 | Job: ansible-collection-kubernetes-molecule-helm 2026-03-17 20:41:59.737483 | Pipeline: check 2026-03-17 20:41:59.737513 | Executor: 0a8996d2b663 2026-03-17 20:41:59.737542 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/241 2026-03-17 20:41:59.737575 | Event ID: 98997b10-2241-11f1-82f6-5260d3b98859 2026-03-17 20:41:59.741526 | 2026-03-17 20:41:59.741613 | LOOP [emit-job-header : Print node information] 2026-03-17 20:41:59.834422 | localhost | ok: 2026-03-17 20:41:59.835458 | localhost | # Node Information 2026-03-17 20:41:59.835623 | localhost | Inventory Hostname: controller 2026-03-17 20:41:59.835699 | localhost | Hostname: np0000159651 2026-03-17 20:41:59.835746 | localhost | Username: zuul 2026-03-17 20:41:59.835799 | localhost | Distro: Debian 13.3 2026-03-17 20:41:59.835843 | localhost | Provider: yul1 2026-03-17 20:41:59.835885 | localhost | Region: ca-ymq-1 2026-03-17 20:41:59.835925 | localhost | Label: debian-trixie 2026-03-17 20:41:59.835965 | localhost | Product Name: OpenStack Nova 2026-03-17 20:41:59.836004 | localhost | Interface IP: 199.19.213.104 2026-03-17 20:41:59.856115 | 2026-03-17 20:41:59.856269 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-17 20:42:00.639935 | localhost -> localhost | changed 2026-03-17 20:42:00.647333 | 2026-03-17 20:42:00.647408 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-17 20:42:02.972575 | localhost -> localhost | changed 2026-03-17 20:42:02.994914 | 2026-03-17 20:42:02.995033 | PLAY [all] 2026-03-17 20:42:03.002144 | 2026-03-17 20:42:03.002221 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-17 20:42:03.236239 | controller -> localhost | ok 2026-03-17 20:42:03.248085 | 2026-03-17 20:42:03.248154 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-17 20:42:03.280084 | controller | ok 2026-03-17 20:42:03.295029 | controller | included: /var/lib/zuul/builds/07e63558b9714575b96ec78b12061117/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-17 20:42:03.299807 | 2026-03-17 20:42:03.299886 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-17 20:42:05.172996 | controller -> localhost | Generating public/private rsa key pair. 2026-03-17 20:42:05.173191 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/07e63558b9714575b96ec78b12061117/work/07e63558b9714575b96ec78b12061117_id_rsa 2026-03-17 20:42:05.173222 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/07e63558b9714575b96ec78b12061117/work/07e63558b9714575b96ec78b12061117_id_rsa.pub 2026-03-17 20:42:05.173245 | controller -> localhost | The key fingerprint is: 2026-03-17 20:42:05.173267 | controller -> localhost | SHA256:k6tXxPG8Ou8N56MSIaujwf6QoRewP6vhnzyI552Rw10 zuul-build-sshkey 2026-03-17 20:42:05.173301 | controller -> localhost | The key's randomart image is: 2026-03-17 20:42:05.173324 | controller -> localhost | +---[RSA 3072]----+ 2026-03-17 20:42:05.173352 | controller -> localhost | | | 2026-03-17 20:42:05.173373 | controller -> localhost | | . | 2026-03-17 20:42:05.173394 | controller -> localhost | | . . + | 2026-03-17 20:42:05.173415 | controller -> localhost | | o ..+ o | 2026-03-17 20:42:05.173436 | controller -> localhost | | . o E+ . . | 2026-03-17 20:42:05.173456 | controller -> localhost | | = * ..oo . | 2026-03-17 20:42:05.173476 | controller -> localhost | | .o.& .... o. . | 2026-03-17 20:42:05.173496 | controller -> localhost | |..o*.Xo.. + =. | 2026-03-17 20:42:05.173519 | controller -> localhost | | o+oX+oo =+.o. | 2026-03-17 20:42:05.173538 | controller -> localhost | +----[SHA256]-----+ 2026-03-17 20:42:05.173600 | controller -> localhost | ok: Runtime: 0:00:01.188726 2026-03-17 20:42:05.178059 | 2026-03-17 20:42:05.178143 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-17 20:42:05.209418 | controller | ok 2026-03-17 20:42:05.219595 | controller | included: /var/lib/zuul/builds/07e63558b9714575b96ec78b12061117/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-17 20:42:05.229446 | 2026-03-17 20:42:05.239072 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-17 20:42:05.263884 | controller | skipping: Conditional result was False 2026-03-17 20:42:05.272871 | 2026-03-17 20:42:05.273055 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-17 20:42:05.850010 | controller | changed 2026-03-17 20:42:05.936277 | 2026-03-17 20:42:05.964218 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-17 20:42:06.188880 | controller | ok 2026-03-17 20:42:06.207811 | 2026-03-17 20:42:06.216756 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-17 20:42:06.761402 | controller | changed 2026-03-17 20:42:06.768314 | 2026-03-17 20:42:06.768601 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-17 20:42:07.329333 | controller | changed 2026-03-17 20:42:07.336264 | 2026-03-17 20:42:07.376218 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-17 20:42:07.402688 | controller | skipping: Conditional result was False 2026-03-17 20:42:07.412648 | 2026-03-17 20:42:07.412756 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-17 20:42:07.863626 | controller -> localhost | changed 2026-03-17 20:42:07.875316 | 2026-03-17 20:42:07.875557 | TASK [add-build-sshkey : Add back temp key] 2026-03-17 20:42:08.318836 | controller -> localhost | Identity added: /var/lib/zuul/builds/07e63558b9714575b96ec78b12061117/work/07e63558b9714575b96ec78b12061117_id_rsa (zuul-build-sshkey) 2026-03-17 20:42:08.319074 | controller -> localhost | ok: Runtime: 0:00:00.018502 2026-03-17 20:42:08.323384 | 2026-03-17 20:42:08.323449 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-17 20:42:08.688463 | controller | ok 2026-03-17 20:42:08.692394 | 2026-03-17 20:42:08.692461 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-17 20:42:08.719015 | controller | skipping: Conditional result was False 2026-03-17 20:42:08.732068 | 2026-03-17 20:42:08.732191 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-17 20:42:09.127575 | controller | ok 2026-03-17 20:42:09.140455 | 2026-03-17 20:42:09.140589 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-17 20:42:10.359445 | controller | Output suppressed because no_log was given 2026-03-17 20:42:10.367624 | 2026-03-17 20:42:10.370607 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-17 20:42:10.631038 | controller | ok: "logs" 2026-03-17 20:42:10.659675 | controller | ok: All items complete 2026-03-17 20:42:10.659901 | 2026-03-17 20:42:10.824631 | controller | ok: "artifacts" 2026-03-17 20:42:11.025022 | controller | ok: "docs" 2026-03-17 20:42:11.046006 | 2026-03-17 20:42:11.052566 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-17 20:42:11.261526 | controller | changed: "logs" 2026-03-17 20:42:11.459363 | controller | changed: "artifacts" 2026-03-17 20:42:11.646831 | controller | changed: "docs" 2026-03-17 20:42:11.694611 | 2026-03-17 20:42:11.722985 | PLAY RECAP 2026-03-17 20:42:11.723189 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-03-17 20:42:11.723236 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-17 20:42:11.723269 | 2026-03-17 20:42:11.935906 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-17 20:42:11.937900 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-17 20:42:12.576398 | 2026-03-17 20:42:12.576590 | PLAY [all] 2026-03-17 20:42:12.587352 | 2026-03-17 20:42:12.587446 | TASK [setup-uv : Extract archive] 2026-03-17 20:42:15.028647 | controller | changed 2026-03-17 20:42:15.034908 | 2026-03-17 20:42:15.035031 | TASK [setup-uv : Print version] 2026-03-17 20:42:15.434928 | controller | uv 0.8.13 2026-03-17 20:42:15.664676 | controller | ok: Runtime: 0:00:00.014165 2026-03-17 20:42:15.671740 | 2026-03-17 20:42:15.671908 | PLAY RECAP 2026-03-17 20:42:15.671967 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-17 20:42:15.671992 | 2026-03-17 20:42:15.884982 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-17 20:42:15.887474 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-17 20:42:16.530147 | 2026-03-17 20:42:16.530364 | PLAY [all] 2026-03-17 20:42:16.544447 | 2026-03-17 20:42:16.544615 | TASK [Update apt cache] 2026-03-17 20:42:21.838181 | controller | ok 2026-03-17 20:42:21.844234 | 2026-03-17 20:42:21.844339 | TASK [Install "jq" for log collection] 2026-03-17 20:42:24.459986 | controller | changed 2026-03-17 20:42:24.462137 | 2026-03-17 20:42:24.462188 | PLAY RECAP 2026-03-17 20:42:24.462235 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-17 20:42:24.462257 | 2026-03-17 20:42:24.607562 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-17 20:42:24.609441 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-17 20:42:25.247621 | 2026-03-17 20:42:25.589974 | PLAY [all] 2026-03-17 20:42:25.604843 | 2026-03-17 20:42:25.605054 | TASK [Copy inventory file for Zuul] 2026-03-17 20:42:26.647172 | controller | changed 2026-03-17 20:42:26.656056 | 2026-03-17 20:42:26.656249 | TASK [Switch "ansible_host" to private IP] 2026-03-17 20:42:26.995782 | controller | changed: 1 replacements made 2026-03-17 20:42:27.002168 | 2026-03-17 20:42:27.002267 | TASK [Run Molecule scenario] 2026-03-17 20:42:27.470663 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-03-17 20:42:27.470788 | controller | Creating virtual environment at: .venv 2026-03-17 20:42:27.739137 | controller | Downloading pygments (1.2MiB) 2026-03-17 20:42:27.740985 | controller | Downloading cryptography (4.3MiB) 2026-03-17 20:42:27.927483 | controller | Downloading cryptography 2026-03-17 20:42:27.962489 | controller | Downloading pygments 2026-03-17 20:42:28.101578 | controller | Downloading ansible-core (2.3MiB) 2026-03-17 20:42:28.389716 | controller | Downloading ansible-core 2026-03-17 20:42:28.435668 | controller | Installed 36 packages in 45ms 2026-03-17 20:42:29.138121 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-03-17 20:42:29.138174 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-03-17 20:42:30.013988 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-03-17 20:42:30.014029 | controller | INFO default scenario not found, disabling shared state. 2026-03-17 20:42:30.014194 | controller | INFO [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-03-17 20:42:30.014289 | controller | INFO [helm > prerun] Performing prerun with role_name_check=0... 2026-03-17 20:42:47.658589 | controller | INFO [helm > dependency] Executing 2026-03-17 20:42:47.658672 | controller | WARNING [helm > dependency] Missing roles requirements file: requirements.yml 2026-03-17 20:42:47.658763 | controller | WARNING [helm > dependency] Missing collections requirements file: collections.yml 2026-03-17 20:42:47.658917 | controller | WARNING [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-03-17 20:42:47.664984 | controller | INFO [helm > cleanup] Executing 2026-03-17 20:42:47.665294 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-17 20:42:47.671767 | controller | INFO [helm > destroy] Executing 2026-03-17 20:42:47.671794 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-17 20:42:47.671906 | controller | INFO [helm > destroy] Executed: Successful 2026-03-17 20:42:47.678414 | controller | INFO [helm > syntax] Executing 2026-03-17 20:42:48.655734 | controller | 2026-03-17 20:42:48.655930 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml 2026-03-17 20:42:48.729737 | controller | INFO [helm > syntax] Executed: Successful 2026-03-17 20:42:48.740922 | controller | INFO [helm > create] Executing 2026-03-17 20:42:48.743976 | controller | WARNING [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-17 20:42:48.751235 | controller | INFO [helm > prepare] Executing 2026-03-17 20:42:49.648713 | controller | 2026-03-17 20:42:49.648787 | controller | PLAY [Prepare] ***************************************************************** 2026-03-17 20:42:49.648920 | controller | 2026-03-17 20:42:49.649044 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-17 20:42:49.649185 | controller | Tuesday 17 March 2026 20:42:49 +0000 (0:00:00.028) 0:00:00.028 ********* 2026-03-17 20:42:52.032178 | 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-17 20:42:52.035886 | controller | ok: [controller] 2026-03-17 20:42:52.036007 | controller | 2026-03-17 20:42:52.036137 | controller | TASK [Install Debian packages] ************************************************* 2026-03-17 20:42:52.036270 | controller | Tuesday 17 March 2026 20:42:52 +0000 (0:00:02.387) 0:00:02.416 ********* 2026-03-17 20:42:53.561647 | controller | ok: [controller] 2026-03-17 20:42:53.561696 | controller | 2026-03-17 20:42:53.561826 | controller | PLAY RECAP ********************************************************************* 2026-03-17 20:42:53.562051 | controller | controller : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-17 20:42:53.562223 | controller | 2026-03-17 20:42:53.562455 | controller | 2026-03-17 20:42:53.562649 | controller | TASKS RECAP ******************************************************************** 2026-03-17 20:42:53.562842 | controller | Tuesday 17 March 2026 20:42:53 +0000 (0:00:01.522) 0:00:03.939 ********* 2026-03-17 20:42:53.563016 | controller | =============================================================================== 2026-03-17 20:42:53.563200 | controller | Gathering Facts --------------------------------------------------------- 2.39s 2026-03-17 20:42:53.563385 | controller | Install Debian packages ------------------------------------------------- 1.52s 2026-03-17 20:42:53.646638 | controller | INFO [helm > prepare] Executed: Successful 2026-03-17 20:42:53.656616 | controller | INFO [helm > converge] Executing 2026-03-17 20:42:54.594886 | controller | 2026-03-17 20:42:54.594947 | controller | PLAY [Converge] **************************************************************** 2026-03-17 20:42:54.594954 | controller | 2026-03-17 20:42:54.594961 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-17 20:42:54.594974 | controller | Tuesday 17 March 2026 20:42:54 +0000 (0:00:00.012) 0:00:00.012 ********* 2026-03-17 20:42:55.725867 | 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-17 20:42:55.731365 | controller | ok: [controller] 2026-03-17 20:42:55.731564 | controller | 2026-03-17 20:42:55.731787 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-17 20:42:55.732032 | controller | Tuesday 17 March 2026 20:42:55 +0000 (0:00:01.136) 0:00:01.149 ********* 2026-03-17 20:42:56.265435 | controller | ok: [controller] 2026-03-17 20:42:56.265482 | controller | 2026-03-17 20:42:56.265591 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-17 20:42:56.265729 | controller | Tuesday 17 March 2026 20:42:56 +0000 (0:00:00.533) 0:00:01.682 ********* 2026-03-17 20:42:57.374395 | controller | ok: [controller] 2026-03-17 20:42:57.374511 | controller | 2026-03-17 20:42:57.374737 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-17 20:42:57.374949 | controller | Tuesday 17 March 2026 20:42:57 +0000 (0:00:01.106) 0:00:02.789 ********* 2026-03-17 20:42:57.788989 | controller | changed: [controller] 2026-03-17 20:42:57.789129 | controller | 2026-03-17 20:42:57.789411 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-17 20:42:57.789675 | controller | Tuesday 17 March 2026 20:42:57 +0000 (0:00:00.417) 0:00:03.206 ********* 2026-03-17 20:42:57.825473 | controller | ok: [controller] => { 2026-03-17 20:42:57.825587 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-17 20:42:57.825783 | controller | } 2026-03-17 20:42:57.825985 | controller | 2026-03-17 20:42:57.826211 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-17 20:42:57.826453 | controller | Tuesday 17 March 2026 20:42:57 +0000 (0:00:00.036) 0:00:03.243 ********* 2026-03-17 20:42:58.685774 | 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-17 20:42:58.694856 | controller | changed: [controller] 2026-03-17 20:42:58.695071 | controller | 2026-03-17 20:42:58.695332 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-17 20:42:58.695711 | controller | Tuesday 17 March 2026 20:42:58 +0000 (0:00:00.869) 0:00:04.112 ********* 2026-03-17 20:43:00.771105 | controller | changed: [controller] 2026-03-17 20:43:00.771132 | controller | 2026-03-17 20:43:00.771137 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-17 20:43:00.771141 | controller | Tuesday 17 March 2026 20:43:00 +0000 (0:00:02.075) 0:00:06.187 ********* 2026-03-17 20:43:01.290624 | controller | ok: [controller] 2026-03-17 20:43:01.290708 | controller | 2026-03-17 20:43:01.290809 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-17 20:43:01.290903 | controller | Tuesday 17 March 2026 20:43:01 +0000 (0:00:00.520) 0:00:06.708 ********* 2026-03-17 20:43:01.700531 | controller | changed: [controller] 2026-03-17 20:43:01.700563 | controller | 2026-03-17 20:43:01.700570 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-17 20:43:01.700574 | controller | Tuesday 17 March 2026 20:43:01 +0000 (0:00:00.406) 0:00:07.114 ********* 2026-03-17 20:43:02.179594 | controller | ok: [controller] 2026-03-17 20:43:02.179902 | controller | 2026-03-17 20:43:02.180256 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-17 20:43:02.180590 | controller | Tuesday 17 March 2026 20:43:02 +0000 (0:00:00.482) 0:00:07.597 ********* 2026-03-17 20:43:02.491447 | controller | changed: [controller] 2026-03-17 20:43:02.491543 | controller | 2026-03-17 20:43:02.491733 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-17 20:43:02.491910 | controller | Tuesday 17 March 2026 20:43:02 +0000 (0:00:00.310) 0:00:07.907 ********* 2026-03-17 20:43:02.782302 | controller | ok: [controller] 2026-03-17 20:43:02.782372 | controller | 2026-03-17 20:43:02.782509 | controller | TASK [Install plugin] ********************************************************** 2026-03-17 20:43:02.782643 | controller | Tuesday 17 March 2026 20:43:02 +0000 (0:00:00.292) 0:00:08.200 ********* 2026-03-17 20:43:02.840275 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-17 20:43:02.840344 | controller | 2026-03-17 20:43:02.840459 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-17 20:43:02.840574 | controller | Tuesday 17 March 2026 20:43:02 +0000 (0:00:00.058) 0:00:08.258 ********* 2026-03-17 20:43:02.885053 | controller | ok: [controller] => { 2026-03-17 20:43:02.885155 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-17 20:43:02.885288 | controller | } 2026-03-17 20:43:02.885406 | controller | 2026-03-17 20:43:02.885542 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-17 20:43:02.885677 | controller | Tuesday 17 March 2026 20:43:02 +0000 (0:00:00.042) 0:00:08.301 ********* 2026-03-17 20:43:05.699351 | controller | changed: [controller] 2026-03-17 20:43:05.699410 | controller | 2026-03-17 20:43:05.699567 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-17 20:43:05.699721 | controller | Tuesday 17 March 2026 20:43:05 +0000 (0:00:02.815) 0:00:11.117 ********* 2026-03-17 20:43:07.865056 | controller | changed: [controller] 2026-03-17 20:43:07.865136 | controller | 2026-03-17 20:43:07.865220 | controller | PLAY RECAP ********************************************************************* 2026-03-17 20:43:07.865365 | controller | controller : ok=16 changed=7 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-17 20:43:07.865471 | controller | 2026-03-17 20:43:07.865590 | controller | 2026-03-17 20:43:07.865697 | controller | TASKS RECAP ******************************************************************** 2026-03-17 20:43:07.865815 | controller | Tuesday 17 March 2026 20:43:07 +0000 (0:00:02.163) 0:00:13.280 ********* 2026-03-17 20:43:07.865922 | controller | =============================================================================== 2026-03-17 20:43:07.866014 | controller | vexxhost.containers.download_artifact : Download item ------------------- 2.82s 2026-03-17 20:43:07.866120 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.16s 2026-03-17 20:43:07.866213 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.08s 2026-03-17 20:43:07.866315 | controller | Gathering Facts --------------------------------------------------------- 1.14s 2026-03-17 20:43:07.866430 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.11s 2026-03-17 20:43:07.866543 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.87s 2026-03-17 20:43:07.866639 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.53s 2026-03-17 20:43:07.867484 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.52s 2026-03-17 20:43:07.867525 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.48s 2026-03-17 20:43:07.867530 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.42s 2026-03-17 20:43:07.867543 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.41s 2026-03-17 20:43:07.867546 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.31s 2026-03-17 20:43:07.867551 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.29s 2026-03-17 20:43:07.867555 | controller | Install plugin ---------------------------------------------------------- 0.06s 2026-03-17 20:43:07.867558 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s 2026-03-17 20:43:07.867562 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s 2026-03-17 20:43:08.008644 | controller | INFO [helm > converge] Executed: Successful 2026-03-17 20:43:08.017805 | controller | INFO [helm > idempotence] Executing 2026-03-17 20:43:08.896270 | controller | 2026-03-17 20:43:08.896637 | controller | PLAY [Converge] **************************************************************** 2026-03-17 20:43:08.896879 | controller | 2026-03-17 20:43:08.897130 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-17 20:43:08.897383 | controller | Tuesday 17 March 2026 20:43:08 +0000 (0:00:00.012) 0:00:00.012 ********* 2026-03-17 20:43:10.052610 | 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-17 20:43:10.061774 | controller | ok: [controller] 2026-03-17 20:43:10.061799 | controller | 2026-03-17 20:43:10.061808 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-17 20:43:10.061816 | controller | Tuesday 17 March 2026 20:43:10 +0000 (0:00:01.160) 0:00:01.173 ********* 2026-03-17 20:43:10.528919 | controller | ok: [controller] 2026-03-17 20:43:10.528968 | controller | 2026-03-17 20:43:10.529150 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-17 20:43:10.529161 | controller | Tuesday 17 March 2026 20:43:10 +0000 (0:00:00.469) 0:00:01.643 ********* 2026-03-17 20:43:11.692809 | controller | ok: [controller] 2026-03-17 20:43:11.692867 | controller | 2026-03-17 20:43:11.692953 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-17 20:43:11.693049 | controller | Tuesday 17 March 2026 20:43:11 +0000 (0:00:01.165) 0:00:02.809 ********* 2026-03-17 20:43:12.168445 | controller | ok: [controller] 2026-03-17 20:43:12.168557 | controller | 2026-03-17 20:43:12.168565 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-17 20:43:12.168665 | controller | Tuesday 17 March 2026 20:43:12 +0000 (0:00:00.472) 0:00:03.282 ********* 2026-03-17 20:43:12.206380 | controller | ok: [controller] => { 2026-03-17 20:43:12.206590 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-17 20:43:12.206807 | controller | } 2026-03-17 20:43:12.206989 | controller | 2026-03-17 20:43:12.207188 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-17 20:43:12.207459 | controller | Tuesday 17 March 2026 20:43:12 +0000 (0:00:00.040) 0:00:03.322 ********* 2026-03-17 20:43:12.781798 | controller | ok: [controller] 2026-03-17 20:43:12.781869 | controller | 2026-03-17 20:43:12.782023 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-17 20:43:12.782170 | controller | Tuesday 17 March 2026 20:43:12 +0000 (0:00:00.575) 0:00:03.898 ********* 2026-03-17 20:43:14.524952 | controller | ok: [controller] 2026-03-17 20:43:14.525001 | controller | 2026-03-17 20:43:14.525100 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-17 20:43:14.525191 | controller | Tuesday 17 March 2026 20:43:14 +0000 (0:00:01.740) 0:00:05.638 ********* 2026-03-17 20:43:15.052866 | controller | ok: [controller] 2026-03-17 20:43:15.052931 | controller | 2026-03-17 20:43:15.053021 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-17 20:43:15.053121 | controller | Tuesday 17 March 2026 20:43:15 +0000 (0:00:00.530) 0:00:06.169 ********* 2026-03-17 20:43:15.484691 | controller | ok: [controller] 2026-03-17 20:43:15.484757 | controller | 2026-03-17 20:43:15.484909 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-17 20:43:15.485039 | controller | Tuesday 17 March 2026 20:43:15 +0000 (0:00:00.431) 0:00:06.600 ********* 2026-03-17 20:43:15.959876 | controller | ok: [controller] 2026-03-17 20:43:15.960133 | controller | 2026-03-17 20:43:15.960391 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-17 20:43:15.960693 | controller | Tuesday 17 March 2026 20:43:15 +0000 (0:00:00.474) 0:00:07.075 ********* 2026-03-17 20:43:16.257109 | controller | ok: [controller] 2026-03-17 20:43:16.257178 | controller | 2026-03-17 20:43:16.257329 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-17 20:43:16.257448 | controller | Tuesday 17 March 2026 20:43:16 +0000 (0:00:00.295) 0:00:07.370 ********* 2026-03-17 20:43:16.558050 | controller | ok: [controller] 2026-03-17 20:43:16.558101 | controller | 2026-03-17 20:43:16.558112 | controller | TASK [Install plugin] ********************************************************** 2026-03-17 20:43:16.558121 | controller | Tuesday 17 March 2026 20:43:16 +0000 (0:00:00.300) 0:00:07.671 ********* 2026-03-17 20:43:16.604971 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-17 20:43:16.605076 | controller | 2026-03-17 20:43:16.605102 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-17 20:43:16.605122 | controller | Tuesday 17 March 2026 20:43:16 +0000 (0:00:00.049) 0:00:07.720 ********* 2026-03-17 20:43:16.643557 | controller | ok: [controller] => { 2026-03-17 20:43:16.643670 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-17 20:43:16.643679 | controller | } 2026-03-17 20:43:16.643733 | controller | 2026-03-17 20:43:16.643825 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-17 20:43:16.643947 | controller | Tuesday 17 March 2026 20:43:16 +0000 (0:00:00.039) 0:00:07.760 ********* 2026-03-17 20:43:17.065343 | controller | ok: [controller] 2026-03-17 20:43:17.065381 | controller | 2026-03-17 20:43:17.065387 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-17 20:43:17.065392 | controller | Tuesday 17 March 2026 20:43:17 +0000 (0:00:00.417) 0:00:08.177 ********* 2026-03-17 20:43:18.755770 | controller | ok: [controller] 2026-03-17 20:43:18.756080 | controller | 2026-03-17 20:43:18.756393 | controller | PLAY RECAP ********************************************************************* 2026-03-17 20:43:18.756810 | controller | controller : ok=16 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-17 20:43:18.757058 | controller | 2026-03-17 20:43:18.757286 | controller | 2026-03-17 20:43:18.757578 | controller | TASKS RECAP ******************************************************************** 2026-03-17 20:43:18.757842 | controller | Tuesday 17 March 2026 20:43:18 +0000 (0:00:01.695) 0:00:09.872 ********* 2026-03-17 20:43:18.758079 | controller | =============================================================================== 2026-03-17 20:43:18.758328 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.74s 2026-03-17 20:43:18.758611 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.70s 2026-03-17 20:43:18.758870 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.17s 2026-03-17 20:43:18.759173 | controller | Gathering Facts --------------------------------------------------------- 1.16s 2026-03-17 20:43:18.759420 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.58s 2026-03-17 20:43:18.759699 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.53s 2026-03-17 20:43:18.759974 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.48s 2026-03-17 20:43:18.760228 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.47s 2026-03-17 20:43:18.760504 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.47s 2026-03-17 20:43:18.760830 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.43s 2026-03-17 20:43:18.761117 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.42s 2026-03-17 20:43:18.761381 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.30s 2026-03-17 20:43:18.761635 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.30s 2026-03-17 20:43:18.761893 | controller | Install plugin ---------------------------------------------------------- 0.05s 2026-03-17 20:43:18.762177 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s 2026-03-17 20:43:18.762423 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s 2026-03-17 20:43:18.866420 | controller | INFO [helm > idempotence] Executed: Successful 2026-03-17 20:43:18.874889 | controller | INFO [helm > side_effect] Executing 2026-03-17 20:43:18.875268 | controller | WARNING [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-17 20:43:18.882881 | controller | INFO [helm > verify] Executing 2026-03-17 20:43:19.831270 | controller | 2026-03-17 20:43:19.831492 | controller | PLAY [Verify] ****************************************************************** 2026-03-17 20:43:19.831676 | controller | 2026-03-17 20:43:19.831874 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-17 20:43:19.832070 | controller | Tuesday 17 March 2026 20:43:19 +0000 (0:00:00.009) 0:00:00.009 ********* 2026-03-17 20:43:20.973088 | 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-17 20:43:20.978584 | controller | ok: [controller] 2026-03-17 20:43:20.978681 | controller | 2026-03-17 20:43:20.978803 | controller | TASK [Get the current Helm version] ******************************************** 2026-03-17 20:43:20.978910 | controller | Tuesday 17 March 2026 20:43:20 +0000 (0:00:01.147) 0:00:01.157 ********* 2026-03-17 20:43:21.460442 | controller | changed: [controller] 2026-03-17 20:43:21.460506 | controller | 2026-03-17 20:43:21.460559 | controller | TASK [Assert Helm version] ***************************************************** 2026-03-17 20:43:21.460646 | controller | Tuesday 17 March 2026 20:43:21 +0000 (0:00:00.481) 0:00:01.639 ********* 2026-03-17 20:43:21.495923 | controller | ok: [controller] => { 2026-03-17 20:43:21.496051 | controller | "changed": false, 2026-03-17 20:43:21.496246 | controller | "msg": "All assertions passed" 2026-03-17 20:43:21.496434 | controller | } 2026-03-17 20:43:21.496681 | controller | 2026-03-17 20:43:21.496868 | controller | PLAY RECAP ********************************************************************* 2026-03-17 20:43:21.497073 | controller | controller : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-17 20:43:21.497315 | controller | 2026-03-17 20:43:21.497572 | controller | 2026-03-17 20:43:21.497773 | controller | TASKS RECAP ******************************************************************** 2026-03-17 20:43:21.497985 | controller | Tuesday 17 March 2026 20:43:21 +0000 (0:00:00.035) 0:00:01.675 ********* 2026-03-17 20:43:21.498212 | controller | =============================================================================== 2026-03-17 20:43:21.498343 | controller | Gathering Facts --------------------------------------------------------- 1.15s 2026-03-17 20:43:21.498468 | controller | Get the current Helm version -------------------------------------------- 0.48s 2026-03-17 20:43:21.498587 | controller | Assert Helm version ----------------------------------------------------- 0.04s 2026-03-17 20:43:21.600058 | controller | INFO [helm > verify] Executed: Successful 2026-03-17 20:43:21.609968 | controller | INFO [helm > cleanup] Executing 2026-03-17 20:43:21.610333 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-17 20:43:21.615630 | controller | INFO [helm > destroy] Executing 2026-03-17 20:43:21.615672 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-17 20:43:21.615742 | controller | INFO [helm > destroy] Executed: Successful 2026-03-17 20:43:21.616025 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-03-17 20:43:22.112197 | controller | ok: Runtime: 0:00:54.290931 2026-03-17 20:43:22.118490 | 2026-03-17 20:43:22.118590 | PLAY RECAP 2026-03-17 20:43:22.118671 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-17 20:43:22.118706 | 2026-03-17 20:43:22.259454 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-17 20:43:22.262366 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-17 20:43:23.090353 | 2026-03-17 20:43:23.094228 | PLAY [all] 2026-03-17 20:43:23.108640 | 2026-03-17 20:43:23.108751 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-03-17 20:43:23.577221 | controller | changed 2026-03-17 20:43:23.582998 | 2026-03-17 20:43:23.583145 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-03-17 20:43:23.989451 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-17 20:43:23.989896 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-17 20:43:23.998945 | controller | environment: line 1: kubectl: command not found 2026-03-17 20:43:24.000697 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-17 20:43:24.004513 | controller | environment: line 1: kubectl: command not found 2026-03-17 20:43:24.004800 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-17 20:43:24.005023 | controller | environment: line 1: kubectl: command not found 2026-03-17 20:43:24.006514 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-17 20:43:24.009178 | controller | environment: line 1: kubectl: command not found 2026-03-17 20:43:24.011195 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-17 20:43:24.012635 | controller | environment: line 1: kubectl: command not found 2026-03-17 20:43:24.013735 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-17 20:43:24.111226 | controller | ok: Runtime: 0:00:00.038363 2026-03-17 20:43:24.118437 | 2026-03-17 20:43:24.118534 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-03-17 20:43:24.363962 | controller | changed 2026-03-17 20:43:24.374819 | 2026-03-17 20:43:24.375001 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-03-17 20:43:24.636227 | controller | environment: line 5: kubectl: command not found 2026-03-17 20:43:24.636781 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-17 20:43:24.637217 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-17 20:43:24.637477 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-17 20:43:24.914654 | controller | ok: Runtime: 0:00:00.011458 2026-03-17 20:43:24.920188 | 2026-03-17 20:43:24.920279 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-03-17 20:43:25.665137 | controller | changed: 2026-03-17 20:43:25.666249 | controller | created directory /var/lib/zuul/builds/07e63558b9714575b96ec78b12061117/work/logs/controller 2026-03-17 20:43:25.666316 | controller | cd+++++++++ objects/ 2026-03-17 20:43:25.666404 | controller | cd+++++++++ objects/cluster/ 2026-03-17 20:43:25.666444 | controller | cd+++++++++ objects/namespaced/ 2026-03-17 20:43:25.684499 | 2026-03-17 20:43:25.684750 | TASK [gather-pod-logs : creating directory for pod logs] 2026-03-17 20:43:25.915883 | controller | changed 2026-03-17 20:43:26.229611 | 2026-03-17 20:43:26.229771 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-03-17 20:43:26.472531 | controller | changed 2026-03-17 20:43:26.477476 | 2026-03-17 20:43:26.477581 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-03-17 20:43:26.771715 | controller | environment: line 3: kubectl: command not found 2026-03-17 20:43:27.266327 | controller | ok: Runtime: 0:00:00.011456 2026-03-17 20:43:27.271037 | 2026-03-17 20:43:27.271114 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-03-17 20:43:27.854519 | controller | changed: 2026-03-17 20:43:27.854691 | controller | cd+++++++++ pod-logs/ 2026-03-17 20:43:27.854722 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-03-17 20:43:27.862202 | 2026-03-17 20:43:27.862326 | LOOP [helm-release-status : creating directory for helm release status] 2026-03-17 20:43:28.108629 | controller | changed: "values" 2026-03-17 20:43:28.324459 | controller | changed: "releases" 2026-03-17 20:43:28.335498 | 2026-03-17 20:43:28.335903 | TASK [helm-release-status : Gather get release status for helm charts] 2026-03-17 20:43:28.588672 | controller | /bin/bash: line 3: kubectl: command not found 2026-03-17 20:43:28.871579 | controller | ok: Runtime: 0:00:00.007936 2026-03-17 20:43:28.878037 | 2026-03-17 20:43:28.878212 | TASK [helm-release-status : Downloads logs to executor] 2026-03-17 20:43:29.469424 | controller | changed: 2026-03-17 20:43:29.469748 | controller | cd+++++++++ helm/ 2026-03-17 20:43:29.469817 | controller | cd+++++++++ helm/releases/ 2026-03-17 20:43:29.469871 | controller | cd+++++++++ helm/values/ 2026-03-17 20:43:29.475580 | 2026-03-17 20:43:29.475636 | PLAY RECAP 2026-03-17 20:43:29.475684 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-17 20:43:29.475706 | 2026-03-17 20:43:29.686994 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-17 20:43:29.688998 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-17 20:43:30.725590 | 2026-03-17 20:43:30.725811 | PLAY [all] 2026-03-17 20:43:30.743399 | 2026-03-17 20:43:30.743694 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-17 20:43:30.790949 | controller | skipping: Conditional result was False 2026-03-17 20:43:30.798926 | 2026-03-17 20:43:30.799036 | TASK [fetch-output : Set log path for single node] 2026-03-17 20:43:30.839167 | controller | ok 2026-03-17 20:43:30.846089 | 2026-03-17 20:43:30.846256 | LOOP [fetch-output : Ensure local output dirs] 2026-03-17 20:43:31.317243 | controller -> localhost | ok: "/var/lib/zuul/builds/07e63558b9714575b96ec78b12061117/work/logs" 2026-03-17 20:43:31.568403 | controller -> localhost | changed: "/var/lib/zuul/builds/07e63558b9714575b96ec78b12061117/work/artifacts" 2026-03-17 20:43:31.785307 | controller -> localhost | changed: "/var/lib/zuul/builds/07e63558b9714575b96ec78b12061117/work/docs" 2026-03-17 20:43:31.796696 | 2026-03-17 20:43:31.801664 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-17 20:43:32.499120 | controller | changed: .d..t...... ./ 2026-03-17 20:43:32.499410 | controller | changed: All items complete 2026-03-17 20:43:32.499451 | 2026-03-17 20:43:33.033266 | controller | changed: .d..t...... ./ 2026-03-17 20:43:33.526675 | controller | changed: .d..t...... ./ 2026-03-17 20:43:33.553623 | 2026-03-17 20:43:33.553778 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-17 20:43:43.455850 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:09.447187 2026-03-17 20:43:43.720762 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007570 2026-03-17 20:43:43.731320 | 2026-03-17 20:43:43.731457 | PLAY [all] 2026-03-17 20:43:43.741816 | 2026-03-17 20:43:43.741951 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-17 20:43:44.268720 | controller | changed 2026-03-17 20:43:44.918592 | 2026-03-17 20:43:44.918691 | PLAY RECAP 2026-03-17 20:43:44.918752 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-17 20:43:44.918783 | 2026-03-17 20:43:45.070790 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-17 20:43:45.072399 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-17 20:43:45.759690 | 2026-03-17 20:43:45.759904 | PLAY [localhost] 2026-03-17 20:43:45.772028 | 2026-03-17 20:43:45.772160 | TASK [Generate Zuul manifest] 2026-03-17 20:43:45.794839 | localhost | ok 2026-03-17 20:43:45.813733 | 2026-03-17 20:43:45.813835 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-17 20:43:46.162579 | localhost | changed 2026-03-17 20:43:46.176772 | 2026-03-17 20:43:46.176927 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-17 20:43:46.475845 | localhost | ok 2026-03-17 20:43:46.482405 | 2026-03-17 20:43:46.482486 | TASK [Upload logs] 2026-03-17 20:43:46.501329 | localhost | ok 2026-03-17 20:43:46.563699 | 2026-03-17 20:43:46.563843 | TASK [Set zuul-log-path fact] 2026-03-17 20:43:46.586689 | localhost | ok 2026-03-17 20:43:46.600796 | 2026-03-17 20:43:46.600872 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-17 20:43:46.633426 | localhost | ok 2026-03-17 20:43:46.646513 | 2026-03-17 20:43:46.646761 | TASK [upload-logs : Create log directories] 2026-03-17 20:43:47.148042 | localhost | changed 2026-03-17 20:43:47.156837 | 2026-03-17 20:43:47.157075 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-17 20:43:47.610870 | localhost -> localhost | ok: Runtime: 0:00:00.005588 2026-03-17 20:43:47.618143 | 2026-03-17 20:43:47.618563 | TASK [upload-logs : Upload logs to log server] 2026-03-17 20:43:48.125189 | localhost | Output suppressed because no_log was given 2026-03-17 20:43:48.129741 | 2026-03-17 20:43:48.129815 | LOOP [upload-logs : Compress console log and json output] 2026-03-17 20:43:48.180407 | localhost | skipping: Conditional result was False 2026-03-17 20:43:48.188322 | localhost | skipping: Conditional result was False 2026-03-17 20:43:48.201809 | 2026-03-17 20:43:48.201966 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-17 20:43:48.249065 | localhost | skipping: Conditional result was False 2026-03-17 20:43:48.249470 | 2026-03-17 20:43:48.253826 | localhost | skipping: Conditional result was False 2026-03-17 20:43:48.267347 | 2026-03-17 20:43:48.267534 | LOOP [upload-logs : Upload console log and json output]