2026-05-14 01:00:50.340151 | Job console starting 2026-05-14 01:00:50.352792 | Updating git repos 2026-05-14 01:00:50.404169 | Cloning repos into workspace 2026-05-14 01:00:50.990852 | Restoring repo states 2026-05-14 01:00:51.020785 | Merging changes 2026-05-14 01:00:51.670733 | Checking out repos 2026-05-14 01:00:52.066670 | Preparing playbooks 2026-05-14 01:00:54.324950 | Running Ansible setup 2026-05-14 01:00:58.141591 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-05-14 01:00:58.788702 | 2026-05-14 01:00:58.788854 | PLAY [localhost] 2026-05-14 01:00:58.798184 | 2026-05-14 01:00:58.798278 | TASK [Gathering Facts] 2026-05-14 01:00:59.776087 | localhost | ok 2026-05-14 01:00:59.786780 | 2026-05-14 01:00:59.786890 | TASK [Setup log path fact] 2026-05-14 01:00:59.818882 | localhost | ok 2026-05-14 01:00:59.832138 | 2026-05-14 01:00:59.832205 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-14 01:00:59.860156 | localhost | ok 2026-05-14 01:00:59.867189 | 2026-05-14 01:00:59.867256 | TASK [emit-job-header : Print job information] 2026-05-14 01:00:59.908155 | # Job Information 2026-05-14 01:00:59.908364 | Ansible Version: 2.16.18 2026-05-14 01:00:59.908433 | Job: ansible-collection-kubernetes-molecule-helm 2026-05-14 01:00:59.908482 | Pipeline: check 2026-05-14 01:00:59.908527 | Executor: 2d72f0692154 2026-05-14 01:00:59.908571 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/274 2026-05-14 01:00:59.908620 | Event ID: 3b767700-4f30-11f1-8df5-f59037ac2d5f 2026-05-14 01:00:59.913254 | 2026-05-14 01:00:59.913323 | LOOP [emit-job-header : Print node information] 2026-05-14 01:01:00.001609 | localhost | ok: 2026-05-14 01:01:00.001888 | localhost | # Node Information 2026-05-14 01:01:00.001942 | localhost | Inventory Hostname: controller 2026-05-14 01:01:00.001987 | localhost | Hostname: np0000173958 2026-05-14 01:01:00.002024 | localhost | Username: zuul 2026-05-14 01:01:00.002064 | localhost | Distro: Debian 13.4 2026-05-14 01:01:00.002104 | localhost | Provider: yul1 2026-05-14 01:01:00.002140 | localhost | Region: ca-ymq-1 2026-05-14 01:01:00.002176 | localhost | Label: debian-trixie 2026-05-14 01:01:00.002211 | localhost | Product Name: OpenStack Nova 2026-05-14 01:01:00.002245 | localhost | Interface IP: 199.204.45.246 2026-05-14 01:01:00.013521 | 2026-05-14 01:01:00.013646 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-14 01:01:00.422604 | localhost -> localhost | changed 2026-05-14 01:01:00.428078 | 2026-05-14 01:01:00.428155 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-14 01:01:01.288575 | localhost -> localhost | changed 2026-05-14 01:01:01.299164 | 2026-05-14 01:01:01.299242 | PLAY [all] 2026-05-14 01:01:01.306053 | 2026-05-14 01:01:01.306126 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-14 01:01:01.553709 | controller -> localhost | ok 2026-05-14 01:01:01.561907 | 2026-05-14 01:01:01.562042 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-14 01:01:01.594485 | controller | ok 2026-05-14 01:01:01.609348 | controller | included: /var/lib/zuul/builds/e160d8f545d546cbaca397d6a54d9179/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-14 01:01:01.614471 | 2026-05-14 01:01:01.614537 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-14 01:01:02.858989 | controller -> localhost | Generating public/private rsa key pair. 2026-05-14 01:01:02.859149 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/e160d8f545d546cbaca397d6a54d9179/work/e160d8f545d546cbaca397d6a54d9179_id_rsa 2026-05-14 01:01:02.859199 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/e160d8f545d546cbaca397d6a54d9179/work/e160d8f545d546cbaca397d6a54d9179_id_rsa.pub 2026-05-14 01:01:02.859233 | controller -> localhost | The key fingerprint is: 2026-05-14 01:01:02.859256 | controller -> localhost | SHA256:MRdDdx79xLI7BK+fTk1SNMM5Y3fSgH5jdDNDy2pWPt0 zuul-build-sshkey 2026-05-14 01:01:02.859287 | controller -> localhost | The key's randomart image is: 2026-05-14 01:01:02.859309 | controller -> localhost | +---[RSA 3072]----+ 2026-05-14 01:01:02.859341 | controller -> localhost | | .+ ..*Oo| 2026-05-14 01:01:02.859364 | controller -> localhost | | +oo=%%| 2026-05-14 01:01:02.859385 | controller -> localhost | | o .. +oX@| 2026-05-14 01:01:02.859405 | controller -> localhost | | + . @.+| 2026-05-14 01:01:02.859425 | controller -> localhost | | S O.=E| 2026-05-14 01:01:02.859445 | controller -> localhost | | + o+.| 2026-05-14 01:01:02.859464 | controller -> localhost | | ..o.| 2026-05-14 01:01:02.859484 | controller -> localhost | | .o | 2026-05-14 01:01:02.859507 | controller -> localhost | | .. | 2026-05-14 01:01:02.859527 | controller -> localhost | +----[SHA256]-----+ 2026-05-14 01:01:02.859575 | controller -> localhost | ok: Runtime: 0:00:00.790943 2026-05-14 01:01:02.864899 | 2026-05-14 01:01:02.864977 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-14 01:01:02.897553 | controller | ok 2026-05-14 01:01:02.911769 | controller | included: /var/lib/zuul/builds/e160d8f545d546cbaca397d6a54d9179/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-14 01:01:02.918370 | 2026-05-14 01:01:02.918431 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-14 01:01:02.943430 | controller | skipping: Conditional result was False 2026-05-14 01:01:02.952537 | 2026-05-14 01:01:02.952602 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-14 01:01:03.493777 | controller | changed 2026-05-14 01:01:03.498681 | 2026-05-14 01:01:03.498747 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-14 01:01:03.705947 | controller | ok 2026-05-14 01:01:03.710397 | 2026-05-14 01:01:03.710467 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-14 01:01:04.229015 | controller | changed 2026-05-14 01:01:04.233840 | 2026-05-14 01:01:04.233909 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-14 01:01:04.772396 | controller | changed 2026-05-14 01:01:04.778327 | 2026-05-14 01:01:04.778413 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-14 01:01:04.808488 | controller | skipping: Conditional result was False 2026-05-14 01:01:04.815610 | 2026-05-14 01:01:04.815707 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-14 01:01:05.290530 | controller -> localhost | changed 2026-05-14 01:01:05.303495 | 2026-05-14 01:01:05.303593 | TASK [add-build-sshkey : Add back temp key] 2026-05-14 01:01:05.586177 | controller -> localhost | Identity added: /var/lib/zuul/builds/e160d8f545d546cbaca397d6a54d9179/work/e160d8f545d546cbaca397d6a54d9179_id_rsa (zuul-build-sshkey) 2026-05-14 01:01:05.587440 | controller -> localhost | ok: Runtime: 0:00:00.013088 2026-05-14 01:01:05.593086 | 2026-05-14 01:01:05.776000 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-14 01:01:06.114763 | controller | ok 2026-05-14 01:01:06.119752 | 2026-05-14 01:01:06.119825 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-14 01:01:06.145317 | controller | skipping: Conditional result was False 2026-05-14 01:01:06.165348 | 2026-05-14 01:01:06.165447 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-05-14 01:01:06.513113 | controller | ok 2026-05-14 01:01:06.520892 | 2026-05-14 01:01:06.520974 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-05-14 01:01:07.598855 | controller | Output suppressed because no_log was given 2026-05-14 01:01:07.683231 | 2026-05-14 01:01:07.683355 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-05-14 01:01:07.897597 | controller | ok: "logs" 2026-05-14 01:01:08.022707 | controller | ok: All items complete 2026-05-14 01:01:08.022949 | 2026-05-14 01:01:08.078121 | controller | ok: "artifacts" 2026-05-14 01:01:08.269317 | controller | ok: "docs" 2026-05-14 01:01:08.411146 | 2026-05-14 01:01:08.411296 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-05-14 01:01:08.627931 | controller | changed: "logs" 2026-05-14 01:01:08.811656 | controller | changed: "artifacts" 2026-05-14 01:01:08.992584 | controller | changed: "docs" 2026-05-14 01:01:09.169051 | 2026-05-14 01:01:09.169187 | PLAY RECAP 2026-05-14 01:01:09.169247 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-05-14 01:01:09.169283 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-14 01:01:09.169312 | 2026-05-14 01:01:09.332240 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-05-14 01:01:09.333807 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-05-14 01:01:09.910255 | 2026-05-14 01:01:09.910371 | PLAY [all] 2026-05-14 01:01:09.921099 | 2026-05-14 01:01:09.921174 | TASK [setup-uv : Extract archive] 2026-05-14 01:01:12.283901 | controller | changed 2026-05-14 01:01:12.290506 | 2026-05-14 01:01:12.290587 | TASK [setup-uv : Print version] 2026-05-14 01:01:12.461164 | controller | uv 0.8.13 2026-05-14 01:01:12.821935 | controller | ok: Runtime: 0:00:00.014671 2026-05-14 01:01:12.832761 | 2026-05-14 01:01:12.832808 | PLAY RECAP 2026-05-14 01:01:12.832852 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-14 01:01:12.832875 | 2026-05-14 01:01:13.000737 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-05-14 01:01:13.003286 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-05-14 01:01:13.674203 | 2026-05-14 01:01:13.674336 | PLAY [all] 2026-05-14 01:01:13.684573 | 2026-05-14 01:01:13.684648 | TASK [Update apt cache] 2026-05-14 01:01:18.254092 | controller | ok 2026-05-14 01:01:18.259166 | 2026-05-14 01:01:18.259258 | TASK [Disable firewalld] 2026-05-14 01:01:18.274357 | controller | skipping: Conditional result was False 2026-05-14 01:01:18.279797 | 2026-05-14 01:01:18.279883 | TASK [Install "jq" for log collection] 2026-05-14 01:01:20.323234 | controller | changed 2026-05-14 01:01:20.325432 | 2026-05-14 01:01:20.325501 | PLAY RECAP 2026-05-14 01:01:20.325560 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-14 01:01:20.325591 | 2026-05-14 01:01:20.451974 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-05-14 01:01:20.506708 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-05-14 01:01:21.180414 | 2026-05-14 01:01:21.180586 | PLAY [all] 2026-05-14 01:01:21.191790 | 2026-05-14 01:01:21.191916 | TASK [Copy inventory file for Zuul] 2026-05-14 01:01:22.113682 | controller | changed 2026-05-14 01:01:22.118743 | 2026-05-14 01:01:22.118817 | TASK [Switch "ansible_host" to private IP] 2026-05-14 01:01:22.474156 | controller | changed: 1 replacements made 2026-05-14 01:01:22.479976 | 2026-05-14 01:01:22.480047 | TASK [Run Molecule scenario] 2026-05-14 01:01:22.917445 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-05-14 01:01:22.917580 | controller | Creating virtual environment at: .venv 2026-05-14 01:01:23.677344 | controller | Downloading pygments (1.2MiB) 2026-05-14 01:01:23.680121 | controller | Downloading cryptography (4.3MiB) 2026-05-14 01:01:23.682272 | controller | Downloading ansible-core (2.3MiB) 2026-05-14 01:01:23.867853 | controller | Downloading cryptography 2026-05-14 01:01:23.905486 | controller | Downloading pygments 2026-05-14 01:01:24.069904 | controller | Downloading ansible-core 2026-05-14 01:01:24.119061 | controller | Installed 36 packages in 48ms 2026-05-14 01:01:24.787688 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-05-14 01:01:24.787762 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-05-14 01:01:25.670177 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-05-14 01:01:25.670237 | controller | INFO default scenario not found, disabling shared state. 2026-05-14 01:01:25.670259 | controller | INFO [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-05-14 01:01:25.670329 | controller | INFO [helm > prerun] Performing prerun with role_name_check=0... 2026-05-14 01:02:12.712069 | controller | INFO [helm > dependency] Executing 2026-05-14 01:02:12.712372 | controller | WARNING [helm > dependency] Missing roles requirements file: requirements.yml 2026-05-14 01:02:12.712610 | controller | WARNING [helm > dependency] Missing collections requirements file: collections.yml 2026-05-14 01:02:12.712786 | controller | WARNING [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-05-14 01:02:12.720334 | controller | INFO [helm > cleanup] Executing 2026-05-14 01:02:12.720627 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-05-14 01:02:12.726009 | controller | INFO [helm > destroy] Executing 2026-05-14 01:02:12.726071 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-05-14 01:02:12.726159 | controller | INFO [helm > destroy] Executed: Successful 2026-05-14 01:02:12.731561 | controller | INFO [helm > syntax] Executing 2026-05-14 01:02:13.626903 | controller | 2026-05-14 01:02:13.626950 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml 2026-05-14 01:02:13.685769 | controller | INFO [helm > syntax] Executed: Successful 2026-05-14 01:02:13.694275 | controller | INFO [helm > create] Executing 2026-05-14 01:02:13.696381 | controller | WARNING [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-05-14 01:02:13.702676 | controller | INFO [helm > prepare] Executing 2026-05-14 01:02:14.586235 | controller | 2026-05-14 01:02:14.586400 | controller | PLAY [Prepare] ***************************************************************** 2026-05-14 01:02:14.586584 | controller | 2026-05-14 01:02:14.586792 | controller | TASK [Gathering Facts] ********************************************************* 2026-05-14 01:02:14.586986 | controller | Thursday 14 May 2026 01:02:14 +0000 (0:00:00.028) 0:00:00.028 ********** 2026-05-14 01:02:15.869286 | 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-05-14 01:02:15.875633 | controller | ok: [controller] 2026-05-14 01:02:15.875785 | controller | 2026-05-14 01:02:15.875977 | controller | TASK [Install Debian packages] ************************************************* 2026-05-14 01:02:15.876236 | controller | Thursday 14 May 2026 01:02:15 +0000 (0:00:01.290) 0:00:01.318 ********** 2026-05-14 01:02:17.238201 | controller | ok: [controller] 2026-05-14 01:02:17.238383 | controller | 2026-05-14 01:02:17.238604 | controller | PLAY RECAP ********************************************************************* 2026-05-14 01:02:17.238822 | controller | controller : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-05-14 01:02:17.239004 | controller | 2026-05-14 01:02:17.239199 | controller | 2026-05-14 01:02:17.239391 | controller | TASKS RECAP ******************************************************************** 2026-05-14 01:02:17.239576 | controller | Thursday 14 May 2026 01:02:17 +0000 (0:00:01.362) 0:00:02.681 ********** 2026-05-14 01:02:17.239751 | controller | =============================================================================== 2026-05-14 01:02:17.239934 | controller | Install Debian packages ------------------------------------------------- 1.36s 2026-05-14 01:02:17.240120 | controller | Gathering Facts --------------------------------------------------------- 1.29s 2026-05-14 01:02:17.331833 | controller | INFO [helm > prepare] Executed: Successful 2026-05-14 01:02:17.344531 | controller | INFO [helm > converge] Executing 2026-05-14 01:02:18.188490 | controller | 2026-05-14 01:02:18.188694 | controller | PLAY [Converge] **************************************************************** 2026-05-14 01:02:18.188870 | controller | 2026-05-14 01:02:18.189067 | controller | TASK [Gathering Facts] ********************************************************* 2026-05-14 01:02:18.189314 | controller | Thursday 14 May 2026 01:02:18 +0000 (0:00:00.012) 0:00:00.012 ********** 2026-05-14 01:02:19.203920 | 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-05-14 01:02:19.210255 | controller | ok: [controller] 2026-05-14 01:02:19.210470 | controller | 2026-05-14 01:02:19.210732 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-05-14 01:02:19.210983 | controller | Thursday 14 May 2026 01:02:19 +0000 (0:00:01.021) 0:00:01.033 ********** 2026-05-14 01:02:19.698533 | controller | ok: [controller] 2026-05-14 01:02:19.698595 | controller | 2026-05-14 01:02:19.698743 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-05-14 01:02:19.698945 | controller | Thursday 14 May 2026 01:02:19 +0000 (0:00:00.488) 0:00:01.522 ********** 2026-05-14 01:02:20.816997 | controller | ok: [controller] 2026-05-14 01:02:20.817127 | controller | 2026-05-14 01:02:20.817332 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-05-14 01:02:20.817527 | controller | Thursday 14 May 2026 01:02:20 +0000 (0:00:01.118) 0:00:02.640 ********** 2026-05-14 01:02:21.267225 | controller | changed: [controller] 2026-05-14 01:02:21.267376 | controller | 2026-05-14 01:02:21.267583 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-05-14 01:02:21.267778 | controller | Thursday 14 May 2026 01:02:21 +0000 (0:00:00.450) 0:00:03.090 ********** 2026-05-14 01:02:21.311132 | controller | ok: [controller] => { 2026-05-14 01:02:21.311332 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-05-14 01:02:21.311519 | controller | } 2026-05-14 01:02:21.311694 | controller | 2026-05-14 01:02:21.311894 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-05-14 01:02:21.312087 | controller | Thursday 14 May 2026 01:02:21 +0000 (0:00:00.043) 0:00:03.134 ********** 2026-05-14 01:02:22.093599 | 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-05-14 01:02:22.103266 | controller | changed: [controller] 2026-05-14 01:02:22.103468 | controller | 2026-05-14 01:02:22.103679 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-05-14 01:02:22.103874 | controller | Thursday 14 May 2026 01:02:22 +0000 (0:00:00.792) 0:00:03.927 ********** 2026-05-14 01:02:24.090354 | controller | changed: [controller] 2026-05-14 01:02:24.090478 | controller | 2026-05-14 01:02:24.090701 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-05-14 01:02:24.090905 | controller | Thursday 14 May 2026 01:02:24 +0000 (0:00:01.985) 0:00:05.912 ********** 2026-05-14 01:02:24.610427 | controller | ok: [controller] 2026-05-14 01:02:24.610568 | controller | 2026-05-14 01:02:24.610811 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-05-14 01:02:24.610994 | controller | Thursday 14 May 2026 01:02:24 +0000 (0:00:00.520) 0:00:06.433 ********** 2026-05-14 01:02:25.017627 | controller | changed: [controller] 2026-05-14 01:02:25.017665 | controller | 2026-05-14 01:02:25.017784 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-05-14 01:02:25.017870 | controller | Thursday 14 May 2026 01:02:25 +0000 (0:00:00.406) 0:00:06.840 ********** 2026-05-14 01:02:25.483617 | controller | ok: [controller] 2026-05-14 01:02:25.483699 | controller | 2026-05-14 01:02:25.483841 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-05-14 01:02:25.483964 | controller | Thursday 14 May 2026 01:02:25 +0000 (0:00:00.466) 0:00:07.307 ********** 2026-05-14 01:02:25.777175 | controller | changed: [controller] 2026-05-14 01:02:25.777350 | controller | 2026-05-14 01:02:25.777730 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-05-14 01:02:25.777972 | controller | Thursday 14 May 2026 01:02:25 +0000 (0:00:00.293) 0:00:07.600 ********** 2026-05-14 01:02:26.075001 | controller | ok: [controller] 2026-05-14 01:02:26.075057 | controller | 2026-05-14 01:02:26.075193 | controller | TASK [Install plugin] ********************************************************** 2026-05-14 01:02:26.075311 | controller | Thursday 14 May 2026 01:02:26 +0000 (0:00:00.298) 0:00:07.898 ********** 2026-05-14 01:02:26.126707 | controller | included: vexxhost.containers.download_artifact for controller 2026-05-14 01:02:26.126876 | controller | 2026-05-14 01:02:26.127075 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-05-14 01:02:26.127266 | controller | Thursday 14 May 2026 01:02:26 +0000 (0:00:00.051) 0:00:07.950 ********** 2026-05-14 01:02:26.173868 | controller | ok: [controller] => { 2026-05-14 01:02:26.174075 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-05-14 01:02:26.174253 | controller | } 2026-05-14 01:02:26.174421 | controller | 2026-05-14 01:02:26.174614 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-05-14 01:02:26.174796 | controller | Thursday 14 May 2026 01:02:26 +0000 (0:00:00.046) 0:00:07.997 ********** 2026-05-14 01:02:27.215684 | controller | changed: [controller] 2026-05-14 01:02:27.215833 | controller | 2026-05-14 01:02:27.216054 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-05-14 01:02:27.216359 | controller | Thursday 14 May 2026 01:02:27 +0000 (0:00:01.041) 0:00:09.039 ********** 2026-05-14 01:02:29.293081 | controller | changed: [controller] 2026-05-14 01:02:29.293112 | controller | 2026-05-14 01:02:29.293118 | controller | PLAY RECAP ********************************************************************* 2026-05-14 01:02:29.293124 | controller | controller : ok=16 changed=7 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-05-14 01:02:29.293129 | controller | 2026-05-14 01:02:29.293134 | controller | 2026-05-14 01:02:29.293139 | controller | TASKS RECAP ******************************************************************** 2026-05-14 01:02:29.293143 | controller | Thursday 14 May 2026 01:02:29 +0000 (0:00:02.074) 0:00:11.113 ********** 2026-05-14 01:02:29.293148 | controller | =============================================================================== 2026-05-14 01:02:29.293152 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.07s 2026-05-14 01:02:29.293157 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.99s 2026-05-14 01:02:29.293161 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.12s 2026-05-14 01:02:29.293166 | controller | vexxhost.containers.download_artifact : Download item ------------------- 1.04s 2026-05-14 01:02:29.293170 | controller | Gathering Facts --------------------------------------------------------- 1.02s 2026-05-14 01:02:29.293175 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.79s 2026-05-14 01:02:29.293179 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.52s 2026-05-14 01:02:29.293184 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.49s 2026-05-14 01:02:29.293188 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.47s 2026-05-14 01:02:29.293193 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.45s 2026-05-14 01:02:29.293206 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.41s 2026-05-14 01:02:29.293211 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.30s 2026-05-14 01:02:29.293215 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.29s 2026-05-14 01:02:29.293220 | controller | Install plugin ---------------------------------------------------------- 0.05s 2026-05-14 01:02:29.293224 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-05-14 01:02:29.293229 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s 2026-05-14 01:02:29.394494 | controller | INFO [helm > converge] Executed: Successful 2026-05-14 01:02:29.402817 | controller | INFO [helm > idempotence] Executing 2026-05-14 01:02:30.248355 | controller | 2026-05-14 01:02:30.248708 | controller | PLAY [Converge] **************************************************************** 2026-05-14 01:02:30.248979 | controller | 2026-05-14 01:02:30.249268 | controller | TASK [Gathering Facts] ********************************************************* 2026-05-14 01:02:30.249559 | controller | Thursday 14 May 2026 01:02:30 +0000 (0:00:00.013) 0:00:00.013 ********** 2026-05-14 01:02:31.281034 | 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-05-14 01:02:31.286603 | controller | ok: [controller] 2026-05-14 01:02:31.286876 | controller | 2026-05-14 01:02:31.287154 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-05-14 01:02:31.287421 | controller | Thursday 14 May 2026 01:02:31 +0000 (0:00:01.038) 0:00:01.051 ********** 2026-05-14 01:02:31.716688 | controller | ok: [controller] 2026-05-14 01:02:31.717015 | controller | 2026-05-14 01:02:31.717307 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-05-14 01:02:31.717579 | controller | Thursday 14 May 2026 01:02:31 +0000 (0:00:00.429) 0:00:01.481 ********** 2026-05-14 01:02:32.692114 | controller | ok: [controller] 2026-05-14 01:02:32.692394 | controller | 2026-05-14 01:02:32.692661 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-05-14 01:02:32.692950 | controller | Thursday 14 May 2026 01:02:32 +0000 (0:00:00.975) 0:00:02.456 ********** 2026-05-14 01:02:33.117570 | controller | ok: [controller] 2026-05-14 01:02:33.117625 | controller | 2026-05-14 01:02:33.117639 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-05-14 01:02:33.117835 | controller | Thursday 14 May 2026 01:02:33 +0000 (0:00:00.425) 0:00:02.882 ********** 2026-05-14 01:02:33.166123 | controller | ok: [controller] => { 2026-05-14 01:02:33.166207 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-05-14 01:02:33.166292 | controller | } 2026-05-14 01:02:33.166376 | controller | 2026-05-14 01:02:33.166471 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-05-14 01:02:33.166552 | controller | Thursday 14 May 2026 01:02:33 +0000 (0:00:00.045) 0:00:02.927 ********** 2026-05-14 01:02:33.686517 | controller | ok: [controller] 2026-05-14 01:02:33.686588 | controller | 2026-05-14 01:02:33.686599 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-05-14 01:02:33.686704 | controller | Thursday 14 May 2026 01:02:33 +0000 (0:00:00.522) 0:00:03.450 ********** 2026-05-14 01:02:35.379638 | controller | ok: [controller] 2026-05-14 01:02:35.379703 | controller | 2026-05-14 01:02:35.379714 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-05-14 01:02:35.379723 | controller | Thursday 14 May 2026 01:02:35 +0000 (0:00:01.692) 0:00:05.143 ********** 2026-05-14 01:02:35.941322 | controller | ok: [controller] 2026-05-14 01:02:35.941405 | controller | 2026-05-14 01:02:35.941418 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-05-14 01:02:35.941521 | controller | Thursday 14 May 2026 01:02:35 +0000 (0:00:00.559) 0:00:05.702 ********** 2026-05-14 01:02:36.333372 | controller | ok: [controller] 2026-05-14 01:02:36.333435 | controller | 2026-05-14 01:02:36.333500 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-05-14 01:02:36.333592 | controller | Thursday 14 May 2026 01:02:36 +0000 (0:00:00.395) 0:00:06.098 ********** 2026-05-14 01:02:36.771927 | controller | ok: [controller] 2026-05-14 01:02:36.772009 | controller | 2026-05-14 01:02:36.772153 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-05-14 01:02:36.772274 | controller | Thursday 14 May 2026 01:02:36 +0000 (0:00:00.438) 0:00:06.536 ********** 2026-05-14 01:02:37.070844 | controller | ok: [controller] 2026-05-14 01:02:37.070900 | controller | 2026-05-14 01:02:37.071076 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-05-14 01:02:37.071256 | controller | Thursday 14 May 2026 01:02:37 +0000 (0:00:00.298) 0:00:06.835 ********** 2026-05-14 01:02:37.377118 | controller | ok: [controller] 2026-05-14 01:02:37.377166 | controller | 2026-05-14 01:02:37.377262 | controller | TASK [Install plugin] ********************************************************** 2026-05-14 01:02:37.377352 | controller | Thursday 14 May 2026 01:02:37 +0000 (0:00:00.306) 0:00:07.141 ********** 2026-05-14 01:02:37.432641 | controller | included: vexxhost.containers.download_artifact for controller 2026-05-14 01:02:37.432707 | controller | 2026-05-14 01:02:37.432793 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-05-14 01:02:37.432882 | controller | Thursday 14 May 2026 01:02:37 +0000 (0:00:00.053) 0:00:07.195 ********** 2026-05-14 01:02:37.476284 | controller | ok: [controller] => { 2026-05-14 01:02:37.476379 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-05-14 01:02:37.476449 | controller | } 2026-05-14 01:02:37.476528 | controller | 2026-05-14 01:02:37.476640 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-05-14 01:02:37.476700 | controller | Thursday 14 May 2026 01:02:37 +0000 (0:00:00.044) 0:00:07.240 ********** 2026-05-14 01:02:37.919857 | controller | ok: [controller] 2026-05-14 01:02:37.919912 | controller | 2026-05-14 01:02:37.920068 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-05-14 01:02:37.920198 | controller | Thursday 14 May 2026 01:02:37 +0000 (0:00:00.443) 0:00:07.684 ********** 2026-05-14 01:02:39.501760 | controller | ok: [controller] 2026-05-14 01:02:39.501807 | controller | 2026-05-14 01:02:39.501818 | controller | PLAY RECAP ********************************************************************* 2026-05-14 01:02:39.501830 | controller | controller : ok=16 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-05-14 01:02:39.501840 | controller | 2026-05-14 01:02:39.501849 | controller | 2026-05-14 01:02:39.501859 | controller | TASKS RECAP ******************************************************************** 2026-05-14 01:02:39.501869 | controller | Thursday 14 May 2026 01:02:39 +0000 (0:00:01.578) 0:00:09.262 ********** 2026-05-14 01:02:39.501878 | controller | =============================================================================== 2026-05-14 01:02:39.501887 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.69s 2026-05-14 01:02:39.501896 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.58s 2026-05-14 01:02:39.501905 | controller | Gathering Facts --------------------------------------------------------- 1.04s 2026-05-14 01:02:39.501914 | controller | vexxhost.containers.package : Update state for tar ---------------------- 0.98s 2026-05-14 01:02:39.501923 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.56s 2026-05-14 01:02:39.501931 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.52s 2026-05-14 01:02:39.501941 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.44s 2026-05-14 01:02:39.501949 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.44s 2026-05-14 01:02:39.501960 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.43s 2026-05-14 01:02:39.502314 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.43s 2026-05-14 01:02:39.502684 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.40s 2026-05-14 01:02:39.502998 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.31s 2026-05-14 01:02:39.503292 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.30s 2026-05-14 01:02:39.503577 | controller | Install plugin ---------------------------------------------------------- 0.05s 2026-05-14 01:02:39.503866 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-05-14 01:02:39.504122 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-05-14 01:02:39.595251 | controller | INFO [helm > idempotence] Executed: Successful 2026-05-14 01:02:39.606858 | controller | INFO [helm > side_effect] Executing 2026-05-14 01:02:39.607215 | controller | WARNING [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-05-14 01:02:39.612644 | controller | INFO [helm > verify] Executing 2026-05-14 01:02:40.421562 | controller | 2026-05-14 01:02:40.421935 | controller | PLAY [Verify] ****************************************************************** 2026-05-14 01:02:40.422168 | controller | 2026-05-14 01:02:40.422410 | controller | TASK [Gathering Facts] ********************************************************* 2026-05-14 01:02:40.422651 | controller | Thursday 14 May 2026 01:02:40 +0000 (0:00:00.009) 0:00:00.009 ********** 2026-05-14 01:02:41.443864 | 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-05-14 01:02:41.449801 | controller | ok: [controller] 2026-05-14 01:02:41.450061 | controller | 2026-05-14 01:02:41.450320 | controller | TASK [Get the current Helm version] ******************************************** 2026-05-14 01:02:41.450572 | controller | Thursday 14 May 2026 01:02:41 +0000 (0:00:01.028) 0:00:01.037 ********** 2026-05-14 01:02:41.880832 | controller | changed: [controller] 2026-05-14 01:02:41.881123 | controller | 2026-05-14 01:02:41.881497 | controller | TASK [Assert Helm version] ***************************************************** 2026-05-14 01:02:41.881914 | controller | Thursday 14 May 2026 01:02:41 +0000 (0:00:00.430) 0:00:01.468 ********** 2026-05-14 01:02:41.908797 | controller | ok: [controller] => { 2026-05-14 01:02:41.909079 | controller | "changed": false, 2026-05-14 01:02:41.909344 | controller | "msg": "All assertions passed" 2026-05-14 01:02:41.909597 | controller | } 2026-05-14 01:02:41.909906 | controller | 2026-05-14 01:02:41.910239 | controller | PLAY RECAP ********************************************************************* 2026-05-14 01:02:41.910520 | controller | controller : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-05-14 01:02:41.910760 | controller | 2026-05-14 01:02:41.910992 | controller | 2026-05-14 01:02:41.911243 | controller | TASKS RECAP ******************************************************************** 2026-05-14 01:02:41.911498 | controller | Thursday 14 May 2026 01:02:41 +0000 (0:00:00.028) 0:00:01.497 ********** 2026-05-14 01:02:41.911742 | controller | =============================================================================== 2026-05-14 01:02:41.912131 | controller | Gathering Facts --------------------------------------------------------- 1.03s 2026-05-14 01:02:41.912411 | controller | Get the current Helm version -------------------------------------------- 0.43s 2026-05-14 01:02:41.912659 | controller | Assert Helm version ----------------------------------------------------- 0.03s 2026-05-14 01:02:41.994179 | controller | INFO [helm > verify] Executed: Successful 2026-05-14 01:02:42.003881 | controller | INFO [helm > cleanup] Executing 2026-05-14 01:02:42.004317 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-05-14 01:02:42.011519 | controller | INFO [helm > destroy] Executing 2026-05-14 01:02:42.011614 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-05-14 01:02:42.011700 | controller | INFO [helm > destroy] Executed: Successful 2026-05-14 01:02:42.011995 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-05-14 01:02:42.528632 | controller | ok: Runtime: 0:01:19.269853 2026-05-14 01:02:42.533455 | 2026-05-14 01:02:42.533514 | PLAY RECAP 2026-05-14 01:02:42.533577 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-14 01:02:42.533629 | 2026-05-14 01:02:42.716086 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-05-14 01:02:42.717768 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-05-14 01:02:43.334062 | 2026-05-14 01:02:43.352882 | PLAY [all] 2026-05-14 01:02:43.374665 | 2026-05-14 01:02:43.374913 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-05-14 01:02:43.755623 | controller | changed 2026-05-14 01:02:43.762289 | 2026-05-14 01:02:43.762411 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-05-14 01:02:44.134382 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-05-14 01:02:44.134761 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-05-14 01:02:44.142111 | controller | environment: line 1: kubectl: command not found 2026-05-14 01:02:44.143041 | controller | environment: line 1: kubectl: command not found 2026-05-14 01:02:44.143435 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-05-14 01:02:44.144407 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-05-14 01:02:44.148193 | controller | environment: line 1: kubectl: command not found 2026-05-14 01:02:44.149441 | controller | environment: line 1: kubectl: command not found 2026-05-14 01:02:44.149597 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-05-14 01:02:44.151740 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-05-14 01:02:44.152909 | controller | environment: line 1: kubectl: command not found 2026-05-14 01:02:44.153696 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-05-14 01:02:44.298630 | controller | ok: Runtime: 0:00:00.031144 2026-05-14 01:02:44.307123 | 2026-05-14 01:02:44.307191 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-05-14 01:02:44.532490 | controller | changed 2026-05-14 01:02:44.536861 | 2026-05-14 01:02:44.536936 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-05-14 01:02:44.764510 | controller | environment: line 5: kubectl: command not found 2026-05-14 01:02:44.765863 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-05-14 01:02:44.766081 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-05-14 01:02:44.766176 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-05-14 01:02:45.065101 | controller | ok: Runtime: 0:00:00.012358 2026-05-14 01:02:45.072262 | 2026-05-14 01:02:45.072373 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-05-14 01:02:45.766226 | controller | changed: 2026-05-14 01:02:45.766438 | controller | created directory /var/lib/zuul/builds/e160d8f545d546cbaca397d6a54d9179/work/logs/controller 2026-05-14 01:02:45.766482 | controller | cd+++++++++ objects/ 2026-05-14 01:02:45.766513 | controller | cd+++++++++ objects/cluster/ 2026-05-14 01:02:45.766546 | controller | cd+++++++++ objects/namespaced/ 2026-05-14 01:02:45.776710 | 2026-05-14 01:02:45.776783 | TASK [gather-pod-logs : creating directory for pod logs] 2026-05-14 01:02:46.024426 | controller | changed 2026-05-14 01:02:46.028301 | 2026-05-14 01:02:46.028362 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-05-14 01:02:46.254541 | controller | changed 2026-05-14 01:02:46.260636 | 2026-05-14 01:02:46.260709 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-05-14 01:02:46.493726 | controller | environment: line 3: kubectl: command not found 2026-05-14 01:02:46.793301 | controller | ok: Runtime: 0:00:00.011410 2026-05-14 01:02:46.801380 | 2026-05-14 01:02:46.801446 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-05-14 01:02:47.348584 | controller | changed: 2026-05-14 01:02:47.348771 | controller | cd+++++++++ pod-logs/ 2026-05-14 01:02:47.348798 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-05-14 01:02:47.355911 | 2026-05-14 01:02:47.355974 | LOOP [helm-release-status : creating directory for helm release status] 2026-05-14 01:02:47.575877 | controller | changed: "values" 2026-05-14 01:02:47.772914 | controller | changed: "releases" 2026-05-14 01:02:47.783575 | 2026-05-14 01:02:47.783772 | TASK [helm-release-status : Gather get release status for helm charts] 2026-05-14 01:02:48.012341 | controller | /bin/bash: line 3: kubectl: command not found 2026-05-14 01:02:48.318500 | controller | ok: Runtime: 0:00:00.008415 2026-05-14 01:02:48.324719 | 2026-05-14 01:02:48.324808 | TASK [helm-release-status : Downloads logs to executor] 2026-05-14 01:02:48.896856 | controller | changed: 2026-05-14 01:02:48.898819 | controller | cd+++++++++ helm/ 2026-05-14 01:02:48.898864 | controller | cd+++++++++ helm/releases/ 2026-05-14 01:02:48.898897 | controller | cd+++++++++ helm/values/ 2026-05-14 01:02:48.905645 | 2026-05-14 01:02:48.905710 | PLAY RECAP 2026-05-14 01:02:48.905768 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-14 01:02:48.905799 | 2026-05-14 01:02:49.017948 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-05-14 01:02:49.137260 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-05-14 01:02:49.722314 | 2026-05-14 01:02:49.741082 | PLAY [all] 2026-05-14 01:02:49.750989 | 2026-05-14 01:02:49.751060 | TASK [fetch-output : Set log path for multiple nodes] 2026-05-14 01:02:49.798010 | controller | skipping: Conditional result was False 2026-05-14 01:02:49.807294 | 2026-05-14 01:02:49.807390 | TASK [fetch-output : Set log path for single node] 2026-05-14 01:02:49.850676 | controller | ok 2026-05-14 01:02:49.887577 | 2026-05-14 01:02:49.887719 | LOOP [fetch-output : Ensure local output dirs] 2026-05-14 01:02:50.390191 | controller -> localhost | ok: "/var/lib/zuul/builds/e160d8f545d546cbaca397d6a54d9179/work/logs" 2026-05-14 01:02:50.631552 | controller -> localhost | changed: "/var/lib/zuul/builds/e160d8f545d546cbaca397d6a54d9179/work/artifacts" 2026-05-14 01:02:50.861713 | controller -> localhost | changed: "/var/lib/zuul/builds/e160d8f545d546cbaca397d6a54d9179/work/docs" 2026-05-14 01:02:50.874286 | 2026-05-14 01:02:50.874381 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-14 01:02:51.552428 | controller | changed: .d..t...... ./ 2026-05-14 01:02:51.641083 | controller | changed: All items complete 2026-05-14 01:02:51.641183 | 2026-05-14 01:02:52.042596 | controller | changed: .d..t...... ./ 2026-05-14 01:02:52.530173 | controller | changed: .d..t...... ./ 2026-05-14 01:02:52.541340 | 2026-05-14 01:02:52.541410 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-14 01:02:52.957223 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.007289 2026-05-14 01:02:53.195872 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.009249 2026-05-14 01:02:53.205738 | 2026-05-14 01:02:53.205790 | PLAY [all] 2026-05-14 01:02:53.210910 | 2026-05-14 01:02:53.210981 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-14 01:02:53.668646 | controller | changed 2026-05-14 01:02:53.674753 | 2026-05-14 01:02:53.674819 | PLAY RECAP 2026-05-14 01:02:53.674879 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-14 01:02:53.674910 | 2026-05-14 01:02:53.793275 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-05-14 01:02:53.796090 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-14 01:02:54.391898 | 2026-05-14 01:02:54.392096 | PLAY [localhost] 2026-05-14 01:02:54.403243 | 2026-05-14 01:02:54.403345 | TASK [Generate Zuul manifest] 2026-05-14 01:02:54.425160 | localhost | ok 2026-05-14 01:02:54.443091 | 2026-05-14 01:02:54.443246 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-14 01:02:54.871377 | localhost | changed 2026-05-14 01:02:54.916661 | 2026-05-14 01:02:54.916858 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-14 01:02:54.959608 | localhost | ok 2026-05-14 01:02:54.966931 | 2026-05-14 01:02:54.967020 | TASK [Upload logs] 2026-05-14 01:02:54.990015 | localhost | ok 2026-05-14 01:02:55.052589 | 2026-05-14 01:02:55.052765 | TASK [Set zuul-log-path fact] 2026-05-14 01:02:55.077143 | localhost | ok 2026-05-14 01:02:55.112118 | 2026-05-14 01:02:55.112267 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-14 01:02:55.145131 | localhost | ok 2026-05-14 01:02:55.154524 | 2026-05-14 01:02:55.154664 | TASK [upload-logs : Create log directories] 2026-05-14 01:02:55.590373 | localhost | changed 2026-05-14 01:02:55.597740 | 2026-05-14 01:02:55.597821 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-14 01:02:56.003998 | localhost -> localhost | ok: Runtime: 0:00:00.006612 2026-05-14 01:02:56.011991 | 2026-05-14 01:02:56.012102 | TASK [upload-logs : Upload logs to log server] 2026-05-14 01:02:56.492707 | localhost | Output suppressed because no_log was given 2026-05-14 01:02:56.501337 | 2026-05-14 01:02:56.501600 | LOOP [upload-logs : Compress console log and json output] 2026-05-14 01:02:56.548754 | localhost | skipping: Conditional result was False 2026-05-14 01:02:56.608770 | localhost | skipping: Conditional result was False 2026-05-14 01:02:56.619950 | 2026-05-14 01:02:56.620136 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-14 01:02:56.666627 | localhost | skipping: Conditional result was False 2026-05-14 01:02:56.667211 | 2026-05-14 01:02:56.670825 | localhost | skipping: Conditional result was False 2026-05-14 01:02:56.687023 | 2026-05-14 01:02:56.687265 | LOOP [upload-logs : Upload console log and json output]