2026-03-25 07:23:32.430150 | Job console starting 2026-03-25 07:23:32.438215 | Updating git repos 2026-03-25 07:23:32.473701 | Cloning repos into workspace 2026-03-25 07:23:32.534942 | Restoring repo states 2026-03-25 07:23:32.548240 | Merging changes 2026-03-25 07:23:33.517946 | Checking out repos 2026-03-25 07:23:33.616809 | Preparing playbooks 2026-03-25 07:23:38.727438 | Running Ansible setup 2026-03-25 07:23:44.406999 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-25 07:23:45.020268 | 2026-03-25 07:23:45.020751 | PLAY [localhost] 2026-03-25 07:23:45.028581 | 2026-03-25 07:23:45.028652 | TASK [Gathering Facts] 2026-03-25 07:23:46.664106 | localhost | ok 2026-03-25 07:23:46.674699 | 2026-03-25 07:23:46.674811 | TASK [Setup log path fact] 2026-03-25 07:23:46.696256 | localhost | ok 2026-03-25 07:23:46.709695 | 2026-03-25 07:23:46.709773 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-25 07:23:46.736262 | localhost | ok 2026-03-25 07:23:46.743416 | 2026-03-25 07:23:46.743533 | TASK [emit-job-header : Print job information] 2026-03-25 07:23:46.794827 | # Job Information 2026-03-25 07:23:46.795471 | Ansible Version: 2.16.16 2026-03-25 07:23:46.795551 | Job: ansible-collection-kubernetes-molecule-helm 2026-03-25 07:23:46.795603 | Pipeline: check 2026-03-25 07:23:46.795662 | Executor: 0a8996d2b663 2026-03-25 07:23:46.795719 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/243 2026-03-25 07:23:46.795773 | Event ID: 84894060-27b4-11f1-8da7-b16e1b5bfc03 2026-03-25 07:23:46.801941 | 2026-03-25 07:23:46.802043 | LOOP [emit-job-header : Print node information] 2026-03-25 07:23:46.907437 | localhost | ok: 2026-03-25 07:23:46.907734 | localhost | # Node Information 2026-03-25 07:23:46.907783 | localhost | Inventory Hostname: controller 2026-03-25 07:23:46.907821 | localhost | Hostname: np0000160440 2026-03-25 07:23:46.907857 | localhost | Username: zuul 2026-03-25 07:23:46.907897 | localhost | Distro: Debian 13.4 2026-03-25 07:23:46.907931 | localhost | Provider: yul1 2026-03-25 07:23:46.907966 | localhost | Region: ca-ymq-1 2026-03-25 07:23:46.908001 | localhost | Label: debian-trixie 2026-03-25 07:23:46.908055 | localhost | Product Name: OpenStack Nova 2026-03-25 07:23:46.908096 | localhost | Interface IP: 199.19.213.152 2026-03-25 07:23:46.922809 | 2026-03-25 07:23:46.922965 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-25 07:23:47.352144 | localhost -> localhost | changed 2026-03-25 07:23:47.362438 | 2026-03-25 07:23:47.362596 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-25 07:23:49.308765 | localhost -> localhost | changed 2026-03-25 07:23:49.320536 | 2026-03-25 07:23:49.320691 | PLAY [all] 2026-03-25 07:23:49.327601 | 2026-03-25 07:23:49.327670 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-25 07:23:49.573654 | controller -> localhost | ok 2026-03-25 07:23:49.583324 | 2026-03-25 07:23:49.583430 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-25 07:23:49.615307 | controller | ok 2026-03-25 07:23:49.630089 | controller | included: /var/lib/zuul/builds/bcbbbb39a5cc4685a8f5739e0881ac68/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-25 07:23:52.791943 | 2026-03-25 07:23:52.792091 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-25 07:23:54.187359 | controller -> localhost | Generating public/private rsa key pair. 2026-03-25 07:23:54.187578 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/bcbbbb39a5cc4685a8f5739e0881ac68/work/bcbbbb39a5cc4685a8f5739e0881ac68_id_rsa 2026-03-25 07:23:54.187627 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/bcbbbb39a5cc4685a8f5739e0881ac68/work/bcbbbb39a5cc4685a8f5739e0881ac68_id_rsa.pub 2026-03-25 07:23:54.187661 | controller -> localhost | The key fingerprint is: 2026-03-25 07:23:54.187693 | controller -> localhost | SHA256:4N6hwgaGUgbsH3oo+ubgl2vKFb5vE1PI7AtCzUZrsCA zuul-build-sshkey 2026-03-25 07:23:54.187758 | controller -> localhost | The key's randomart image is: 2026-03-25 07:23:54.187806 | controller -> localhost | +---[RSA 3072]----+ 2026-03-25 07:23:54.187848 | controller -> localhost | |o | 2026-03-25 07:23:54.187880 | controller -> localhost | |E+ . | 2026-03-25 07:23:54.187910 | controller -> localhost | |+ O + o | 2026-03-25 07:23:54.187939 | controller -> localhost | | B B = o | 2026-03-25 07:23:54.187968 | controller -> localhost | |+ O.o o S | 2026-03-25 07:23:54.187996 | controller -> localhost | |o=.*.= o . | 2026-03-25 07:23:54.188023 | controller -> localhost | |+ oo* * . | 2026-03-25 07:23:54.188051 | controller -> localhost | |+.o=.= | 2026-03-25 07:23:54.188083 | controller -> localhost | | B*o+.. | 2026-03-25 07:23:54.188113 | controller -> localhost | +----[SHA256]-----+ 2026-03-25 07:23:54.188182 | controller -> localhost | ok: Runtime: 0:00:00.969440 2026-03-25 07:23:54.194593 | 2026-03-25 07:23:54.194692 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-25 07:23:54.224028 | controller | ok 2026-03-25 07:23:54.235994 | controller | included: /var/lib/zuul/builds/bcbbbb39a5cc4685a8f5739e0881ac68/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-25 07:23:54.244815 | 2026-03-25 07:23:54.244948 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-25 07:23:54.269395 | controller | skipping: Conditional result was False 2026-03-25 07:23:54.278500 | 2026-03-25 07:23:54.278702 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-25 07:23:54.822285 | controller | changed 2026-03-25 07:23:54.827473 | 2026-03-25 07:23:54.827565 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-25 07:23:55.041189 | controller | ok 2026-03-25 07:23:55.047040 | 2026-03-25 07:23:55.047139 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-25 07:23:55.595003 | controller | changed 2026-03-25 07:23:55.601789 | 2026-03-25 07:23:55.601870 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-25 07:23:56.143214 | controller | changed 2026-03-25 07:23:56.389567 | 2026-03-25 07:23:56.389701 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-25 07:23:56.413673 | controller | skipping: Conditional result was False 2026-03-25 07:23:56.420942 | 2026-03-25 07:23:56.421063 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-25 07:23:56.853460 | controller -> localhost | changed 2026-03-25 07:23:56.870409 | 2026-03-25 07:23:56.870534 | TASK [add-build-sshkey : Add back temp key] 2026-03-25 07:23:57.196689 | controller -> localhost | Identity added: /var/lib/zuul/builds/bcbbbb39a5cc4685a8f5739e0881ac68/work/bcbbbb39a5cc4685a8f5739e0881ac68_id_rsa (zuul-build-sshkey) 2026-03-25 07:23:57.197023 | controller -> localhost | ok: Runtime: 0:00:00.013876 2026-03-25 07:23:57.201385 | 2026-03-25 07:23:57.201450 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-25 07:23:57.566742 | controller | ok 2026-03-25 07:23:57.572372 | 2026-03-25 07:23:57.572472 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-25 07:23:57.597616 | controller | skipping: Conditional result was False 2026-03-25 07:23:57.610938 | 2026-03-25 07:23:57.611102 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-25 07:23:58.055951 | controller | ok 2026-03-25 07:23:58.063618 | 2026-03-25 07:23:58.063755 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-25 07:23:59.159081 | controller | Output suppressed because no_log was given 2026-03-25 07:23:59.169378 | 2026-03-25 07:23:59.169513 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-25 07:23:59.381449 | controller | ok: "logs" 2026-03-25 07:23:59.381825 | controller | ok: All items complete 2026-03-25 07:23:59.381875 | 2026-03-25 07:23:59.555643 | controller | ok: "artifacts" 2026-03-25 07:23:59.735752 | controller | ok: "docs" 2026-03-25 07:23:59.741753 | 2026-03-25 07:23:59.741872 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-25 07:23:59.960161 | controller | changed: "logs" 2026-03-25 07:24:00.143011 | controller | changed: "artifacts" 2026-03-25 07:24:02.627565 | controller | changed: "docs" 2026-03-25 07:24:02.640212 | 2026-03-25 07:24:02.640397 | PLAY RECAP 2026-03-25 07:24:02.640473 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-03-25 07:24:02.640515 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-25 07:24:02.640545 | 2026-03-25 07:24:02.816430 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-25 07:24:02.818174 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-25 07:24:03.424721 | 2026-03-25 07:24:03.424849 | PLAY [all] 2026-03-25 07:24:03.435224 | 2026-03-25 07:24:03.435315 | TASK [setup-uv : Extract archive] 2026-03-25 07:24:06.039289 | controller | changed 2026-03-25 07:24:06.047314 | 2026-03-25 07:24:06.047476 | TASK [setup-uv : Print version] 2026-03-25 07:24:06.440902 | controller | uv 0.8.13 2026-03-25 07:24:06.578501 | controller | ok: Runtime: 0:00:00.013872 2026-03-25 07:24:06.586522 | 2026-03-25 07:24:06.586631 | PLAY RECAP 2026-03-25 07:24:06.586695 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-25 07:24:06.586732 | 2026-03-25 07:24:06.759139 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-25 07:24:06.807485 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-25 07:24:07.484062 | 2026-03-25 07:24:07.484274 | PLAY [all] 2026-03-25 07:24:07.496870 | 2026-03-25 07:24:07.497129 | TASK [Update apt cache] 2026-03-25 07:24:12.600177 | controller | ok 2026-03-25 07:24:12.605857 | 2026-03-25 07:24:12.605950 | TASK [Disable firewalld] 2026-03-25 07:24:12.630111 | controller | skipping: Conditional result was False 2026-03-25 07:24:12.640419 | 2026-03-25 07:24:12.640612 | TASK [Install "jq" for log collection] 2026-03-25 07:24:15.059432 | controller | changed 2026-03-25 07:24:15.062440 | 2026-03-25 07:24:15.062517 | PLAY RECAP 2026-03-25 07:24:15.062583 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-25 07:24:15.062615 | 2026-03-25 07:24:15.191452 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-25 07:24:15.193012 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-25 07:24:15.869490 | 2026-03-25 07:24:15.869732 | PLAY [all] 2026-03-25 07:24:15.883007 | 2026-03-25 07:24:15.883202 | TASK [Copy inventory file for Zuul] 2026-03-25 07:24:16.916382 | controller | changed 2026-03-25 07:24:16.924378 | 2026-03-25 07:24:16.924579 | TASK [Switch "ansible_host" to private IP] 2026-03-25 07:24:17.234049 | controller | changed: 1 replacements made 2026-03-25 07:24:17.240139 | 2026-03-25 07:24:17.240259 | TASK [Run Molecule scenario] 2026-03-25 07:24:17.702240 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-03-25 07:24:17.702364 | controller | Creating virtual environment at: .venv 2026-03-25 07:24:18.111299 | controller | Downloading pygments (1.2MiB) 2026-03-25 07:24:18.111845 | controller | Downloading cryptography (4.3MiB) 2026-03-25 07:24:18.129723 | controller | Downloading ansible-core (2.3MiB) 2026-03-25 07:24:18.269168 | controller | Downloading cryptography 2026-03-25 07:24:18.327857 | controller | Downloading pygments 2026-03-25 07:24:18.528660 | controller | Downloading ansible-core 2026-03-25 07:24:18.575141 | controller | Installed 36 packages in 45ms 2026-03-25 07:24:19.251301 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-03-25 07:24:19.251378 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-03-25 07:24:20.127573 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-03-25 07:24:20.127644 | controller | INFO default scenario not found, disabling shared state. 2026-03-25 07:24:20.127672 | controller | INFO [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-03-25 07:24:20.127684 | controller | INFO [helm > prerun] Performing prerun with role_name_check=0... 2026-03-25 07:24:38.061986 | controller | INFO [helm > dependency] Executing 2026-03-25 07:24:38.062176 | controller | WARNING [helm > dependency] Missing roles requirements file: requirements.yml 2026-03-25 07:24:38.062455 | controller | WARNING [helm > dependency] Missing collections requirements file: collections.yml 2026-03-25 07:24:38.062648 | controller | WARNING [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-03-25 07:24:38.068441 | controller | INFO [helm > cleanup] Executing 2026-03-25 07:24:38.068767 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-25 07:24:38.074012 | controller | INFO [helm > destroy] Executing 2026-03-25 07:24:38.074096 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-25 07:24:38.074162 | controller | INFO [helm > destroy] Executed: Successful 2026-03-25 07:24:38.079411 | controller | INFO [helm > syntax] Executing 2026-03-25 07:24:39.004597 | controller | 2026-03-25 07:24:39.004627 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml 2026-03-25 07:24:39.083752 | controller | INFO [helm > syntax] Executed: Successful 2026-03-25 07:24:39.095326 | controller | INFO [helm > create] Executing 2026-03-25 07:24:39.096808 | controller | WARNING [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-25 07:24:39.102535 | controller | INFO [helm > prepare] Executing 2026-03-25 07:24:39.966658 | controller | 2026-03-25 07:24:39.966764 | controller | PLAY [Prepare] ***************************************************************** 2026-03-25 07:24:39.966963 | controller | 2026-03-25 07:24:39.967168 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-25 07:24:39.967370 | controller | Wednesday 25 March 2026 07:24:39 +0000 (0:00:00.029) 0:00:00.029 ******* 2026-03-25 07:24:41.189550 | 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-25 07:24:41.196403 | controller | ok: [controller] 2026-03-25 07:24:41.196622 | controller | 2026-03-25 07:24:41.196856 | controller | TASK [Install Debian packages] ************************************************* 2026-03-25 07:24:41.197061 | controller | Wednesday 25 March 2026 07:24:41 +0000 (0:00:01.230) 0:00:01.259 ******* 2026-03-25 07:24:42.578620 | controller | ok: [controller] 2026-03-25 07:24:42.578777 | controller | 2026-03-25 07:24:42.579034 | controller | PLAY RECAP ********************************************************************* 2026-03-25 07:24:42.579265 | controller | controller : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-25 07:24:42.579482 | controller | 2026-03-25 07:24:42.579658 | controller | 2026-03-25 07:24:42.579849 | controller | TASKS RECAP ******************************************************************** 2026-03-25 07:24:42.580072 | controller | Wednesday 25 March 2026 07:24:42 +0000 (0:00:01.382) 0:00:02.642 ******* 2026-03-25 07:24:42.580256 | controller | =============================================================================== 2026-03-25 07:24:42.580478 | controller | Install Debian packages ------------------------------------------------- 1.38s 2026-03-25 07:24:42.580714 | controller | Gathering Facts --------------------------------------------------------- 1.23s 2026-03-25 07:24:42.666724 | controller | INFO [helm > prepare] Executed: Successful 2026-03-25 07:24:42.677533 | controller | INFO [helm > converge] Executing 2026-03-25 07:24:43.504040 | controller | 2026-03-25 07:24:43.504401 | controller | PLAY [Converge] **************************************************************** 2026-03-25 07:24:43.504749 | controller | 2026-03-25 07:24:43.504992 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-25 07:24:43.505206 | controller | Wednesday 25 March 2026 07:24:43 +0000 (0:00:00.012) 0:00:00.012 ******* 2026-03-25 07:24:44.585371 | 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-25 07:24:44.590608 | controller | ok: [controller] 2026-03-25 07:24:44.590803 | controller | 2026-03-25 07:24:44.591023 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-25 07:24:44.591230 | controller | Wednesday 25 March 2026 07:24:44 +0000 (0:00:01.086) 0:00:01.099 ******* 2026-03-25 07:24:45.127000 | controller | ok: [controller] 2026-03-25 07:24:45.127113 | controller | 2026-03-25 07:24:45.127370 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-25 07:24:45.127582 | controller | Wednesday 25 March 2026 07:24:45 +0000 (0:00:00.536) 0:00:01.635 ******* 2026-03-25 07:24:46.156382 | controller | ok: [controller] 2026-03-25 07:24:46.156445 | controller | 2026-03-25 07:24:46.156481 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-25 07:24:46.156627 | controller | Wednesday 25 March 2026 07:24:46 +0000 (0:00:01.029) 0:00:02.664 ******* 2026-03-25 07:24:46.579827 | controller | changed: [controller] 2026-03-25 07:24:46.579878 | controller | 2026-03-25 07:24:46.580577 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-25 07:24:46.580606 | controller | Wednesday 25 March 2026 07:24:46 +0000 (0:00:00.420) 0:00:03.085 ******* 2026-03-25 07:24:46.620663 | controller | ok: [controller] => { 2026-03-25 07:24:46.620710 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-25 07:24:46.620719 | controller | } 2026-03-25 07:24:46.620727 | controller | 2026-03-25 07:24:46.620735 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-25 07:24:46.620751 | controller | Wednesday 25 March 2026 07:24:46 +0000 (0:00:00.042) 0:00:03.127 ******* 2026-03-25 07:24:47.696154 | 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-25 07:24:47.705285 | controller | changed: [controller] 2026-03-25 07:24:47.705468 | controller | 2026-03-25 07:24:47.705677 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-25 07:24:47.705872 | controller | Wednesday 25 March 2026 07:24:47 +0000 (0:00:01.086) 0:00:04.213 ******* 2026-03-25 07:24:49.677896 | controller | changed: [controller] 2026-03-25 07:24:49.678090 | controller | 2026-03-25 07:24:49.678305 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-25 07:24:49.678535 | controller | Wednesday 25 March 2026 07:24:49 +0000 (0:00:01.972) 0:00:06.186 ******* 2026-03-25 07:24:50.176459 | controller | ok: [controller] 2026-03-25 07:24:50.176483 | controller | 2026-03-25 07:24:50.176488 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-25 07:24:50.176491 | controller | Wednesday 25 March 2026 07:24:50 +0000 (0:00:00.494) 0:00:06.680 ******* 2026-03-25 07:24:50.582095 | controller | changed: [controller] 2026-03-25 07:24:50.582285 | controller | 2026-03-25 07:24:50.582524 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-25 07:24:50.582748 | controller | Wednesday 25 March 2026 07:24:50 +0000 (0:00:00.409) 0:00:07.090 ******* 2026-03-25 07:24:51.040605 | controller | ok: [controller] 2026-03-25 07:24:51.040635 | controller | 2026-03-25 07:24:51.040641 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-25 07:24:51.040646 | controller | Wednesday 25 March 2026 07:24:51 +0000 (0:00:00.454) 0:00:07.544 ******* 2026-03-25 07:24:51.341865 | controller | changed: [controller] 2026-03-25 07:24:51.342010 | controller | 2026-03-25 07:24:51.342231 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-25 07:24:51.342432 | controller | Wednesday 25 March 2026 07:24:51 +0000 (0:00:00.304) 0:00:07.849 ******* 2026-03-25 07:24:51.643019 | controller | ok: [controller] 2026-03-25 07:24:51.643204 | controller | 2026-03-25 07:24:51.643446 | controller | TASK [Install plugin] ********************************************************** 2026-03-25 07:24:51.643677 | controller | Wednesday 25 March 2026 07:24:51 +0000 (0:00:00.301) 0:00:08.151 ******* 2026-03-25 07:24:51.694954 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-25 07:24:51.695146 | controller | 2026-03-25 07:24:51.695437 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-25 07:24:51.695692 | controller | Wednesday 25 March 2026 07:24:51 +0000 (0:00:00.051) 0:00:08.203 ******* 2026-03-25 07:24:51.738764 | controller | ok: [controller] => { 2026-03-25 07:24:51.738921 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-25 07:24:51.739110 | controller | } 2026-03-25 07:24:51.739303 | controller | 2026-03-25 07:24:51.739497 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-25 07:24:51.739690 | controller | Wednesday 25 March 2026 07:24:51 +0000 (0:00:00.043) 0:00:08.246 ******* 2026-03-25 07:24:52.555211 | controller | changed: [controller] 2026-03-25 07:24:52.555375 | controller | 2026-03-25 07:24:52.555605 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-25 07:24:52.555875 | controller | Wednesday 25 March 2026 07:24:52 +0000 (0:00:00.816) 0:00:09.063 ******* 2026-03-25 07:24:54.605959 | controller | changed: [controller] 2026-03-25 07:24:54.606114 | controller | 2026-03-25 07:24:54.606343 | controller | PLAY RECAP ********************************************************************* 2026-03-25 07:24:54.606643 | controller | controller : ok=16 changed=7 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-25 07:24:54.606840 | controller | 2026-03-25 07:24:54.607029 | controller | 2026-03-25 07:24:54.607218 | controller | TASKS RECAP ******************************************************************** 2026-03-25 07:24:54.607414 | controller | Wednesday 25 March 2026 07:24:54 +0000 (0:00:02.051) 0:00:11.114 ******* 2026-03-25 07:24:54.607666 | controller | =============================================================================== 2026-03-25 07:24:54.607884 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.05s 2026-03-25 07:24:54.608078 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.97s 2026-03-25 07:24:54.608265 | controller | Gathering Facts --------------------------------------------------------- 1.09s 2026-03-25 07:24:54.608449 | controller | vexxhost.containers.download_artifact : Download item ------------------- 1.09s 2026-03-25 07:24:54.608767 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.03s 2026-03-25 07:24:54.608976 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.82s 2026-03-25 07:24:54.609172 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.54s 2026-03-25 07:24:54.609367 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.49s 2026-03-25 07:24:54.609561 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.45s 2026-03-25 07:24:54.609753 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.42s 2026-03-25 07:24:54.609937 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.41s 2026-03-25 07:24:54.610148 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.31s 2026-03-25 07:24:54.610336 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.30s 2026-03-25 07:24:54.610585 | controller | Install plugin ---------------------------------------------------------- 0.05s 2026-03-25 07:24:54.610778 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s 2026-03-25 07:24:54.610969 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s 2026-03-25 07:24:54.697342 | controller | INFO [helm > converge] Executed: Successful 2026-03-25 07:24:54.706877 | controller | INFO [helm > idempotence] Executing 2026-03-25 07:24:55.569650 | controller | 2026-03-25 07:24:55.569778 | controller | PLAY [Converge] **************************************************************** 2026-03-25 07:24:55.569987 | controller | 2026-03-25 07:24:55.570189 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-25 07:24:55.570390 | controller | Wednesday 25 March 2026 07:24:55 +0000 (0:00:00.012) 0:00:00.012 ******* 2026-03-25 07:24:57.614025 | 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-25 07:24:57.619154 | controller | ok: [controller] 2026-03-25 07:24:57.619318 | controller | 2026-03-25 07:24:57.619524 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-25 07:24:57.619721 | controller | Wednesday 25 March 2026 07:24:57 +0000 (0:00:02.049) 0:00:02.062 ******* 2026-03-25 07:24:58.063315 | controller | ok: [controller] 2026-03-25 07:24:58.063416 | controller | 2026-03-25 07:24:58.063427 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-25 07:24:58.063439 | controller | Wednesday 25 March 2026 07:24:58 +0000 (0:00:00.443) 0:00:02.506 ******* 2026-03-25 07:24:59.122727 | controller | ok: [controller] 2026-03-25 07:24:59.122812 | controller | 2026-03-25 07:24:59.122936 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-25 07:24:59.123089 | controller | Wednesday 25 March 2026 07:24:59 +0000 (0:00:01.058) 0:00:03.564 ******* 2026-03-25 07:24:59.545712 | controller | ok: [controller] 2026-03-25 07:24:59.545770 | controller | 2026-03-25 07:24:59.545925 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-25 07:24:59.546048 | controller | Wednesday 25 March 2026 07:24:59 +0000 (0:00:00.424) 0:00:03.988 ******* 2026-03-25 07:24:59.593678 | controller | ok: [controller] => { 2026-03-25 07:24:59.593789 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-25 07:24:59.593915 | controller | } 2026-03-25 07:24:59.594037 | controller | 2026-03-25 07:24:59.594176 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-25 07:24:59.594298 | controller | Wednesday 25 March 2026 07:24:59 +0000 (0:00:00.047) 0:00:04.036 ******* 2026-03-25 07:25:00.153252 | controller | ok: [controller] 2026-03-25 07:25:00.153290 | controller | 2026-03-25 07:25:00.153300 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-25 07:25:00.153308 | controller | Wednesday 25 March 2026 07:25:00 +0000 (0:00:00.558) 0:00:04.595 ******* 2026-03-25 07:25:01.856303 | controller | ok: [controller] 2026-03-25 07:25:01.856372 | controller | 2026-03-25 07:25:01.856486 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-25 07:25:01.856693 | controller | Wednesday 25 March 2026 07:25:01 +0000 (0:00:01.703) 0:00:06.299 ******* 2026-03-25 07:25:02.364577 | controller | ok: [controller] 2026-03-25 07:25:02.364640 | controller | 2026-03-25 07:25:02.364654 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-25 07:25:02.364784 | controller | Wednesday 25 March 2026 07:25:02 +0000 (0:00:00.508) 0:00:06.808 ******* 2026-03-25 07:25:02.770547 | controller | ok: [controller] 2026-03-25 07:25:02.770601 | controller | 2026-03-25 07:25:02.770609 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-25 07:25:02.770616 | controller | Wednesday 25 March 2026 07:25:02 +0000 (0:00:00.402) 0:00:07.210 ******* 2026-03-25 07:25:03.213121 | controller | ok: [controller] 2026-03-25 07:25:03.213178 | controller | 2026-03-25 07:25:03.213380 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-25 07:25:03.213551 | controller | Wednesday 25 March 2026 07:25:03 +0000 (0:00:00.444) 0:00:07.654 ******* 2026-03-25 07:25:03.511416 | controller | ok: [controller] 2026-03-25 07:25:03.511469 | controller | 2026-03-25 07:25:03.511640 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-25 07:25:03.511803 | controller | Wednesday 25 March 2026 07:25:03 +0000 (0:00:00.299) 0:00:07.954 ******* 2026-03-25 07:25:03.804754 | controller | ok: [controller] 2026-03-25 07:25:03.805877 | controller | 2026-03-25 07:25:03.805897 | controller | TASK [Install plugin] ********************************************************** 2026-03-25 07:25:03.805907 | controller | Wednesday 25 March 2026 07:25:03 +0000 (0:00:00.290) 0:00:08.244 ******* 2026-03-25 07:25:03.858062 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-25 07:25:03.858168 | controller | 2026-03-25 07:25:03.858288 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-25 07:25:03.858401 | controller | Wednesday 25 March 2026 07:25:03 +0000 (0:00:00.056) 0:00:08.301 ******* 2026-03-25 07:25:03.908125 | controller | ok: [controller] => { 2026-03-25 07:25:03.908271 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-25 07:25:03.908376 | controller | } 2026-03-25 07:25:03.908485 | controller | 2026-03-25 07:25:03.908653 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-25 07:25:03.908775 | controller | Wednesday 25 March 2026 07:25:03 +0000 (0:00:00.049) 0:00:08.351 ******* 2026-03-25 07:25:04.359860 | controller | ok: [controller] 2026-03-25 07:25:04.359897 | controller | 2026-03-25 07:25:04.360002 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-25 07:25:04.360100 | controller | Wednesday 25 March 2026 07:25:04 +0000 (0:00:00.451) 0:00:08.802 ******* 2026-03-25 07:25:06.017575 | controller | ok: [controller] 2026-03-25 07:25:06.017749 | controller | 2026-03-25 07:25:06.017966 | controller | PLAY RECAP ********************************************************************* 2026-03-25 07:25:06.018201 | controller | controller : ok=16 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-25 07:25:06.018396 | controller | 2026-03-25 07:25:06.018571 | controller | 2026-03-25 07:25:06.018777 | controller | TASKS RECAP ******************************************************************** 2026-03-25 07:25:06.018981 | controller | Wednesday 25 March 2026 07:25:06 +0000 (0:00:01.658) 0:00:10.461 ******* 2026-03-25 07:25:06.019169 | controller | =============================================================================== 2026-03-25 07:25:06.019371 | controller | Gathering Facts --------------------------------------------------------- 2.05s 2026-03-25 07:25:06.019569 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.70s 2026-03-25 07:25:06.019768 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.66s 2026-03-25 07:25:06.019967 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.06s 2026-03-25 07:25:06.020168 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.56s 2026-03-25 07:25:06.020373 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.51s 2026-03-25 07:25:06.020617 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.45s 2026-03-25 07:25:06.020820 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.44s 2026-03-25 07:25:06.021021 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.44s 2026-03-25 07:25:06.021273 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.42s 2026-03-25 07:25:06.021476 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.40s 2026-03-25 07:25:06.021685 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.30s 2026-03-25 07:25:06.021901 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.29s 2026-03-25 07:25:06.022101 | controller | Install plugin ---------------------------------------------------------- 0.06s 2026-03-25 07:25:06.022309 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-25 07:25:06.022564 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-25 07:25:06.203669 | controller | INFO [helm > idempotence] Executed: Successful 2026-03-25 07:25:06.213605 | controller | INFO [helm > side_effect] Executing 2026-03-25 07:25:06.213982 | controller | WARNING [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-25 07:25:06.221245 | controller | INFO [helm > verify] Executing 2026-03-25 07:25:07.039558 | controller | 2026-03-25 07:25:07.039767 | controller | PLAY [Verify] ****************************************************************** 2026-03-25 07:25:07.039952 | controller | 2026-03-25 07:25:07.040154 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-25 07:25:07.040348 | controller | Wednesday 25 March 2026 07:25:07 +0000 (0:00:00.009) 0:00:00.009 ******* 2026-03-25 07:25:08.179304 | 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-25 07:25:08.186343 | controller | ok: [controller] 2026-03-25 07:25:08.186638 | controller | 2026-03-25 07:25:08.186887 | controller | TASK [Get the current Helm version] ******************************************** 2026-03-25 07:25:08.187170 | controller | Wednesday 25 March 2026 07:25:08 +0000 (0:00:01.146) 0:00:01.155 ******* 2026-03-25 07:25:08.681404 | controller | changed: [controller] 2026-03-25 07:25:08.681478 | controller | 2026-03-25 07:25:08.681576 | controller | TASK [Assert Helm version] ***************************************************** 2026-03-25 07:25:08.681702 | controller | Wednesday 25 March 2026 07:25:08 +0000 (0:00:00.494) 0:00:01.650 ******* 2026-03-25 07:25:08.712871 | controller | ok: [controller] => { 2026-03-25 07:25:08.712933 | controller | "changed": false, 2026-03-25 07:25:08.713047 | controller | "msg": "All assertions passed" 2026-03-25 07:25:08.713176 | controller | } 2026-03-25 07:25:08.713274 | controller | 2026-03-25 07:25:08.713390 | controller | PLAY RECAP ********************************************************************* 2026-03-25 07:25:08.713530 | controller | controller : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-25 07:25:08.713627 | controller | 2026-03-25 07:25:08.713730 | controller | 2026-03-25 07:25:08.713847 | controller | TASKS RECAP ******************************************************************** 2026-03-25 07:25:08.713966 | controller | Wednesday 25 March 2026 07:25:08 +0000 (0:00:00.032) 0:00:01.683 ******* 2026-03-25 07:25:08.714077 | controller | =============================================================================== 2026-03-25 07:25:08.714201 | controller | Gathering Facts --------------------------------------------------------- 1.15s 2026-03-25 07:25:08.714313 | controller | Get the current Helm version -------------------------------------------- 0.49s 2026-03-25 07:25:08.714427 | controller | Assert Helm version ----------------------------------------------------- 0.03s 2026-03-25 07:25:08.840416 | controller | INFO [helm > verify] Executed: Successful 2026-03-25 07:25:08.848799 | controller | INFO [helm > cleanup] Executing 2026-03-25 07:25:08.849080 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-25 07:25:08.856445 | controller | INFO [helm > destroy] Executing 2026-03-25 07:25:08.856572 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-25 07:25:08.856678 | controller | INFO [helm > destroy] Executed: Successful 2026-03-25 07:25:08.857051 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-03-25 07:25:09.307887 | controller | ok: Runtime: 0:00:51.349940 2026-03-25 07:25:09.314098 | 2026-03-25 07:25:09.314205 | PLAY RECAP 2026-03-25 07:25:09.314265 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-25 07:25:09.314295 | 2026-03-25 07:25:09.550932 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-25 07:25:09.553588 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-25 07:25:10.237194 | 2026-03-25 07:25:10.237438 | PLAY [all] 2026-03-25 07:25:10.251750 | 2026-03-25 07:25:10.251969 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-03-25 07:25:10.644506 | controller | changed 2026-03-25 07:25:10.649153 | 2026-03-25 07:25:10.649237 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-03-25 07:25:11.068208 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-25 07:25:11.068304 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-25 07:25:11.075697 | controller | environment: line 1: kubectl: command not found 2026-03-25 07:25:11.076911 | controller | environment: line 1: kubectl: command not found 2026-03-25 07:25:11.078336 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-25 07:25:11.079147 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-25 07:25:11.082525 | controller | environment: line 1: kubectl: command not found 2026-03-25 07:25:11.083652 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-25 07:25:11.084174 | controller | environment: line 1: kubectl: command not found 2026-03-25 07:25:11.086546 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-25 07:25:11.087824 | controller | environment: line 1: kubectl: command not found 2026-03-25 07:25:11.089241 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-25 07:25:11.178939 | controller | ok: Runtime: 0:00:00.035163 2026-03-25 07:25:11.185855 | 2026-03-25 07:25:11.185962 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-03-25 07:25:11.428207 | controller | changed 2026-03-25 07:25:11.433691 | 2026-03-25 07:25:11.433867 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-03-25 07:25:11.697237 | controller | environment: line 5: kubectl: command not found 2026-03-25 07:25:11.698669 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-25 07:25:11.699089 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-25 07:25:11.699672 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-25 07:25:11.968295 | controller | ok: Runtime: 0:00:00.013054 2026-03-25 07:25:11.977240 | 2026-03-25 07:25:11.977396 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-03-25 07:25:12.643044 | controller | changed: 2026-03-25 07:25:12.643369 | controller | created directory /var/lib/zuul/builds/bcbbbb39a5cc4685a8f5739e0881ac68/work/logs/controller 2026-03-25 07:25:12.643417 | controller | cd+++++++++ objects/ 2026-03-25 07:25:12.643451 | controller | cd+++++++++ objects/cluster/ 2026-03-25 07:25:12.643487 | controller | cd+++++++++ objects/namespaced/ 2026-03-25 07:25:12.655575 | 2026-03-25 07:25:12.655851 | TASK [gather-pod-logs : creating directory for pod logs] 2026-03-25 07:25:12.909336 | controller | changed 2026-03-25 07:25:12.915509 | 2026-03-25 07:25:12.915753 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-03-25 07:25:13.153263 | controller | changed 2026-03-25 07:25:13.159050 | 2026-03-25 07:25:13.159157 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-03-25 07:25:13.406920 | controller | environment: line 3: kubectl: command not found 2026-03-25 07:25:13.702639 | controller | ok: Runtime: 0:00:00.013388 2026-03-25 07:25:13.711119 | 2026-03-25 07:25:13.711331 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-03-25 07:25:14.265279 | controller | changed: 2026-03-25 07:25:14.265539 | controller | cd+++++++++ pod-logs/ 2026-03-25 07:25:14.265579 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-03-25 07:25:14.277439 | 2026-03-25 07:25:14.277854 | LOOP [helm-release-status : creating directory for helm release status] 2026-03-25 07:25:14.523476 | controller | changed: "values" 2026-03-25 07:25:14.731060 | controller | changed: "releases" 2026-03-25 07:25:14.747031 | 2026-03-25 07:25:14.747279 | TASK [helm-release-status : Gather get release status for helm charts] 2026-03-25 07:25:15.009960 | controller | /bin/bash: line 3: kubectl: command not found 2026-03-25 07:25:15.344015 | controller | ok: Runtime: 0:00:00.008587 2026-03-25 07:25:15.349977 | 2026-03-25 07:25:15.350069 | TASK [helm-release-status : Downloads logs to executor] 2026-03-25 07:25:15.974169 | controller | changed: 2026-03-25 07:25:15.974368 | controller | cd+++++++++ helm/ 2026-03-25 07:25:15.974411 | controller | cd+++++++++ helm/releases/ 2026-03-25 07:25:15.974449 | controller | cd+++++++++ helm/values/ 2026-03-25 07:25:15.982742 | 2026-03-25 07:25:15.982923 | PLAY RECAP 2026-03-25 07:25:15.983003 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-25 07:25:15.983042 | 2026-03-25 07:25:16.196208 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-25 07:25:16.215533 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-25 07:25:16.835431 | 2026-03-25 07:25:16.835928 | PLAY [all] 2026-03-25 07:25:16.847608 | 2026-03-25 07:25:16.847767 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-25 07:25:16.893235 | controller | skipping: Conditional result was False 2026-03-25 07:25:16.904534 | 2026-03-25 07:25:16.904734 | TASK [fetch-output : Set log path for single node] 2026-03-25 07:25:16.945568 | controller | ok 2026-03-25 07:25:16.949204 | 2026-03-25 07:25:16.949277 | LOOP [fetch-output : Ensure local output dirs] 2026-03-25 07:25:17.462449 | controller -> localhost | ok: "/var/lib/zuul/builds/bcbbbb39a5cc4685a8f5739e0881ac68/work/logs" 2026-03-25 07:25:17.690751 | controller -> localhost | changed: "/var/lib/zuul/builds/bcbbbb39a5cc4685a8f5739e0881ac68/work/artifacts" 2026-03-25 07:25:17.910823 | controller -> localhost | changed: "/var/lib/zuul/builds/bcbbbb39a5cc4685a8f5739e0881ac68/work/docs" 2026-03-25 07:25:17.919840 | 2026-03-25 07:25:17.919922 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-25 07:25:18.790531 | controller | changed: .d..t...... ./ 2026-03-25 07:25:18.790793 | controller | changed: All items complete 2026-03-25 07:25:18.790839 | 2026-03-25 07:25:19.314015 | controller | changed: .d..t...... ./ 2026-03-25 07:25:19.881890 | controller | changed: .d..t...... ./ 2026-03-25 07:25:19.912591 | 2026-03-25 07:25:19.912739 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-25 07:25:20.415455 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.007359 2026-03-25 07:25:20.699349 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.006429 2026-03-25 07:25:20.714130 | 2026-03-25 07:25:20.714270 | PLAY [all] 2026-03-25 07:25:20.721701 | 2026-03-25 07:25:20.721825 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-25 07:25:21.190203 | controller | changed 2026-03-25 07:25:21.534047 | 2026-03-25 07:25:21.534161 | PLAY RECAP 2026-03-25 07:25:21.534228 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-25 07:25:21.534265 | 2026-03-25 07:25:21.666905 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-25 07:25:21.670614 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-25 07:25:22.277818 | 2026-03-25 07:25:22.317659 | PLAY [localhost] 2026-03-25 07:25:22.338350 | 2026-03-25 07:25:22.338735 | TASK [Generate Zuul manifest] 2026-03-25 07:25:22.366699 | localhost | ok 2026-03-25 07:25:22.386528 | 2026-03-25 07:25:22.386698 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-25 07:25:22.759983 | localhost | changed 2026-03-25 07:25:22.772410 | 2026-03-25 07:25:22.772514 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-25 07:25:23.034343 | localhost | ok 2026-03-25 07:25:23.044043 | 2026-03-25 07:25:23.044164 | TASK [Upload logs] 2026-03-25 07:25:23.061954 | localhost | ok 2026-03-25 07:25:23.128137 | 2026-03-25 07:25:23.128261 | TASK [Set zuul-log-path fact] 2026-03-25 07:25:23.145669 | localhost | ok 2026-03-25 07:25:23.157744 | 2026-03-25 07:25:23.157911 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-25 07:25:23.191827 | localhost | ok 2026-03-25 07:25:23.202037 | 2026-03-25 07:25:23.202198 | TASK [upload-logs : Create log directories] 2026-03-25 07:25:23.653650 | localhost | changed 2026-03-25 07:25:23.662040 | 2026-03-25 07:25:23.662254 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-25 07:25:24.145840 | localhost -> localhost | ok: Runtime: 0:00:00.005397 2026-03-25 07:25:24.153439 | 2026-03-25 07:25:24.153615 | TASK [upload-logs : Upload logs to log server] 2026-03-25 07:25:24.648063 | localhost | Output suppressed because no_log was given 2026-03-25 07:25:24.658627 | 2026-03-25 07:25:24.658857 | LOOP [upload-logs : Compress console log and json output] 2026-03-25 07:25:24.715851 | localhost | skipping: Conditional result was False 2026-03-25 07:25:24.724478 | localhost | skipping: Conditional result was False 2026-03-25 07:25:24.736752 | 2026-03-25 07:25:24.736999 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-25 07:25:24.785613 | localhost | skipping: Conditional result was False 2026-03-25 07:25:24.785914 | 2026-03-25 07:25:24.791920 | localhost | skipping: Conditional result was False 2026-03-25 07:25:24.806182 | 2026-03-25 07:25:24.806382 | LOOP [upload-logs : Upload console log and json output]