2026-03-17 20:42:10.170103 | Job console starting 2026-03-17 20:42:10.201241 | Updating git repos 2026-03-17 20:42:10.260644 | Cloning repos into workspace 2026-03-17 20:42:10.377020 | Restoring repo states 2026-03-17 20:42:10.398637 | Merging changes 2026-03-17 20:42:11.429441 | Checking out repos 2026-03-17 20:42:11.587030 | Preparing playbooks 2026-03-17 20:42:16.547540 | Running Ansible setup 2026-03-17 20:42:20.723425 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-17 20:42:21.391546 | 2026-03-17 20:42:21.424899 | PLAY [localhost] 2026-03-17 20:42:21.442644 | 2026-03-17 20:42:21.442865 | TASK [Gathering Facts] 2026-03-17 20:42:22.358214 | localhost | ok 2026-03-17 20:42:22.365173 | 2026-03-17 20:42:22.365259 | TASK [Setup log path fact] 2026-03-17 20:42:22.388951 | localhost | ok 2026-03-17 20:42:22.401305 | 2026-03-17 20:42:22.401395 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-17 20:42:22.434406 | localhost | ok 2026-03-17 20:42:22.443525 | 2026-03-17 20:42:22.443651 | TASK [emit-job-header : Print job information] 2026-03-17 20:42:22.482671 | # Job Information 2026-03-17 20:42:22.482854 | Ansible Version: 2.16.16 2026-03-17 20:42:22.482888 | Job: ansible-collection-kubernetes-molecule-helm 2026-03-17 20:42:22.482912 | Pipeline: check 2026-03-17 20:42:22.482933 | Executor: 0a8996d2b663 2026-03-17 20:42:22.482953 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/238 2026-03-17 20:42:22.482976 | Event ID: 97475890-2241-11f1-9ad1-c4dcb8267916 2026-03-17 20:42:22.486014 | 2026-03-17 20:42:22.486086 | LOOP [emit-job-header : Print node information] 2026-03-17 20:42:22.581869 | localhost | ok: 2026-03-17 20:42:22.582108 | localhost | # Node Information 2026-03-17 20:42:22.582152 | localhost | Inventory Hostname: controller 2026-03-17 20:42:22.582186 | localhost | Hostname: np0000159640 2026-03-17 20:42:22.582216 | localhost | Username: zuul 2026-03-17 20:42:22.582250 | localhost | Distro: Debian 13.3 2026-03-17 20:42:22.582281 | localhost | Provider: yul1 2026-03-17 20:42:22.582432 | localhost | Region: ca-ymq-1 2026-03-17 20:42:22.582589 | localhost | Label: debian-trixie 2026-03-17 20:42:22.582623 | localhost | Product Name: OpenStack Nova 2026-03-17 20:42:22.582652 | localhost | Interface IP: 199.19.213.217 2026-03-17 20:42:22.590657 | 2026-03-17 20:42:22.590811 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-17 20:42:23.035720 | localhost -> localhost | changed 2026-03-17 20:42:23.044500 | 2026-03-17 20:42:23.044629 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-17 20:42:24.251514 | localhost -> localhost | changed 2026-03-17 20:42:24.258591 | 2026-03-17 20:42:24.258651 | PLAY [all] 2026-03-17 20:42:24.265457 | 2026-03-17 20:42:24.265523 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-17 20:42:24.502139 | controller -> localhost | ok 2026-03-17 20:42:24.508742 | 2026-03-17 20:42:24.508823 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-17 20:42:24.539834 | controller | ok 2026-03-17 20:42:24.558296 | controller | included: /var/lib/zuul/builds/93b0a6c6330e43b29962cbbccbae9e4e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-17 20:42:24.565711 | 2026-03-17 20:42:24.565853 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-17 20:42:25.952084 | controller -> localhost | Generating public/private rsa key pair. 2026-03-17 20:42:25.952285 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/93b0a6c6330e43b29962cbbccbae9e4e/work/93b0a6c6330e43b29962cbbccbae9e4e_id_rsa 2026-03-17 20:42:25.952330 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/93b0a6c6330e43b29962cbbccbae9e4e/work/93b0a6c6330e43b29962cbbccbae9e4e_id_rsa.pub 2026-03-17 20:42:25.952364 | controller -> localhost | The key fingerprint is: 2026-03-17 20:42:25.952396 | controller -> localhost | SHA256:dmDMMZBak5Ild2a8A5WOf58VTfFGyj7dthqeYWYKmO0 zuul-build-sshkey 2026-03-17 20:42:25.952443 | controller -> localhost | The key's randomart image is: 2026-03-17 20:42:25.952476 | controller -> localhost | +---[RSA 3072]----+ 2026-03-17 20:42:25.952510 | controller -> localhost | | .o+*B. .o| 2026-03-17 20:42:25.952542 | controller -> localhost | | oo**oo . oo| 2026-03-17 20:42:25.952573 | controller -> localhost | | + ==. ooo| 2026-03-17 20:42:25.952603 | controller -> localhost | | . ..+. ..oo| 2026-03-17 20:42:25.952633 | controller -> localhost | | .S.. o.+| 2026-03-17 20:42:25.952662 | controller -> localhost | | .=.. .o.| 2026-03-17 20:42:25.952691 | controller -> localhost | | o + . O . | 2026-03-17 20:42:25.952721 | controller -> localhost | | . . O = | 2026-03-17 20:42:25.952754 | controller -> localhost | | E . + | 2026-03-17 20:42:25.952784 | controller -> localhost | +----[SHA256]-----+ 2026-03-17 20:42:25.952845 | controller -> localhost | ok: Runtime: 0:00:00.881790 2026-03-17 20:42:25.959058 | 2026-03-17 20:42:25.959150 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-17 20:42:25.987806 | controller | ok 2026-03-17 20:42:25.995569 | controller | included: /var/lib/zuul/builds/93b0a6c6330e43b29962cbbccbae9e4e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-17 20:42:26.009272 | 2026-03-17 20:42:26.009473 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-17 20:42:26.035742 | controller | skipping: Conditional result was False 2026-03-17 20:42:26.044671 | 2026-03-17 20:42:26.044816 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-17 20:42:26.623098 | controller | changed 2026-03-17 20:42:26.627979 | 2026-03-17 20:42:26.628052 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-17 20:42:26.843513 | controller | ok 2026-03-17 20:42:26.850006 | 2026-03-17 20:42:26.850137 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-17 20:42:27.396465 | controller | changed 2026-03-17 20:42:27.500370 | 2026-03-17 20:42:27.500780 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-17 20:42:28.392382 | controller | changed 2026-03-17 20:42:28.617177 | 2026-03-17 20:42:28.617287 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-17 20:42:28.643220 | controller | skipping: Conditional result was False 2026-03-17 20:42:28.658101 | 2026-03-17 20:42:28.658266 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-17 20:42:29.079839 | controller -> localhost | changed 2026-03-17 20:42:29.089657 | 2026-03-17 20:42:29.089818 | TASK [add-build-sshkey : Add back temp key] 2026-03-17 20:42:30.006774 | controller -> localhost | Identity added: /var/lib/zuul/builds/93b0a6c6330e43b29962cbbccbae9e4e/work/93b0a6c6330e43b29962cbbccbae9e4e_id_rsa (zuul-build-sshkey) 2026-03-17 20:42:30.007063 | controller -> localhost | ok: Runtime: 0:00:00.019577 2026-03-17 20:42:30.013112 | 2026-03-17 20:42:30.013197 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-17 20:42:30.390021 | controller | ok 2026-03-17 20:42:30.396788 | 2026-03-17 20:42:30.396913 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-17 20:42:30.427089 | controller | skipping: Conditional result was False 2026-03-17 20:42:30.445238 | 2026-03-17 20:42:30.445417 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-17 20:42:30.842682 | controller | ok 2026-03-17 20:42:30.849508 | 2026-03-17 20:42:30.849650 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-17 20:42:31.972095 | controller | Output suppressed because no_log was given 2026-03-17 20:42:32.321740 | 2026-03-17 20:42:32.321868 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-17 20:42:32.567788 | controller | ok: "logs" 2026-03-17 20:42:32.568092 | controller | ok: All items complete 2026-03-17 20:42:32.568129 | 2026-03-17 20:42:32.759463 | controller | ok: "artifacts" 2026-03-17 20:42:32.963785 | controller | ok: "docs" 2026-03-17 20:42:32.973740 | 2026-03-17 20:42:32.973947 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-17 20:42:33.189957 | controller | changed: "logs" 2026-03-17 20:42:33.369566 | controller | changed: "artifacts" 2026-03-17 20:42:33.589113 | controller | changed: "docs" 2026-03-17 20:42:33.604393 | 2026-03-17 20:42:33.604550 | PLAY RECAP 2026-03-17 20:42:33.604606 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-03-17 20:42:33.604636 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-17 20:42:33.604656 | 2026-03-17 20:42:33.819993 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-17 20:42:33.822448 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-17 20:42:34.480402 | 2026-03-17 20:42:34.480572 | PLAY [all] 2026-03-17 20:42:34.492897 | 2026-03-17 20:42:34.493081 | TASK [setup-uv : Extract archive] 2026-03-17 20:42:36.948889 | controller | changed 2026-03-17 20:42:36.960509 | 2026-03-17 20:42:36.960763 | TASK [setup-uv : Print version] 2026-03-17 20:42:37.353794 | controller | uv 0.8.13 2026-03-17 20:42:37.495466 | controller | ok: Runtime: 0:00:00.014604 2026-03-17 20:42:37.500755 | 2026-03-17 20:42:37.500806 | PLAY RECAP 2026-03-17 20:42:37.500853 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-17 20:42:37.500877 | 2026-03-17 20:42:37.622977 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-17 20:42:37.624870 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-17 20:42:38.290359 | 2026-03-17 20:42:38.290536 | PLAY [all] 2026-03-17 20:42:38.301245 | 2026-03-17 20:42:38.301334 | TASK [Update apt cache] 2026-03-17 20:42:42.868702 | controller | ok 2026-03-17 20:42:42.875546 | 2026-03-17 20:42:42.875642 | TASK [Install "jq" for log collection] 2026-03-17 20:42:45.045818 | controller | changed 2026-03-17 20:42:45.048292 | 2026-03-17 20:42:45.048350 | PLAY RECAP 2026-03-17 20:42:45.048397 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-17 20:42:45.048422 | 2026-03-17 20:42:45.205702 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-17 20:42:45.626462 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-17 20:42:46.337529 | 2026-03-17 20:42:46.337681 | PLAY [all] 2026-03-17 20:42:46.351925 | 2026-03-17 20:42:46.352084 | TASK [Copy inventory file for Zuul] 2026-03-17 20:42:47.518810 | controller | changed 2026-03-17 20:42:47.525898 | 2026-03-17 20:42:47.526022 | TASK [Switch "ansible_host" to private IP] 2026-03-17 20:42:48.783285 | controller | changed: 1 replacements made 2026-03-17 20:42:48.831497 | 2026-03-17 20:42:48.831714 | TASK [Run Molecule scenario] 2026-03-17 20:42:49.354997 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-03-17 20:42:49.355088 | controller | Creating virtual environment at: .venv 2026-03-17 20:42:49.817379 | controller | Downloading pygments (1.2MiB) 2026-03-17 20:42:49.819496 | controller | Downloading cryptography (4.3MiB) 2026-03-17 20:42:49.822023 | controller | Downloading ansible-core (2.3MiB) 2026-03-17 20:42:52.720290 | controller | Downloading pygments 2026-03-17 20:42:52.946552 | controller | Downloading ansible-core 2026-03-17 20:42:53.141732 | controller | Downloading cryptography 2026-03-17 20:42:53.187505 | controller | Installed 36 packages in 44ms 2026-03-17 20:42:53.862529 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-03-17 20:42:53.862559 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-03-17 20:42:54.753705 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-03-17 20:42:54.753825 | controller | INFO default scenario not found, disabling shared state. 2026-03-17 20:42:54.754039 | controller | INFO [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-03-17 20:42:54.754155 | controller | INFO [helm > prerun] Performing prerun with role_name_check=0... 2026-03-17 20:43:17.703225 | controller | INFO [helm > dependency] Executing 2026-03-17 20:43:17.703523 | controller | WARNING [helm > dependency] Missing roles requirements file: requirements.yml 2026-03-17 20:43:17.703744 | controller | WARNING [helm > dependency] Missing collections requirements file: collections.yml 2026-03-17 20:43:17.703885 | controller | WARNING [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-03-17 20:43:17.709431 | controller | INFO [helm > cleanup] Executing 2026-03-17 20:43:17.709799 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-17 20:43:17.715126 | controller | INFO [helm > destroy] Executing 2026-03-17 20:43:17.715245 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-17 20:43:17.715331 | controller | INFO [helm > destroy] Executed: Successful 2026-03-17 20:43:17.720724 | controller | INFO [helm > syntax] Executing 2026-03-17 20:43:18.632006 | controller | 2026-03-17 20:43:18.632398 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml 2026-03-17 20:43:18.714673 | controller | INFO [helm > syntax] Executed: Successful 2026-03-17 20:43:18.724937 | controller | INFO [helm > create] Executing 2026-03-17 20:43:18.726511 | controller | WARNING [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-17 20:43:18.732004 | controller | INFO [helm > prepare] Executing 2026-03-17 20:43:19.619882 | controller | 2026-03-17 20:43:19.620250 | controller | PLAY [Prepare] ***************************************************************** 2026-03-17 20:43:19.620578 | controller | 2026-03-17 20:43:19.620843 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-17 20:43:19.621175 | controller | Tuesday 17 March 2026 20:43:19 +0000 (0:00:00.028) 0:00:00.028 ********* 2026-03-17 20:43:20.970207 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-17 20:43:20.976193 | controller | ok: [controller] 2026-03-17 20:43:20.976214 | controller | 2026-03-17 20:43:20.976223 | controller | TASK [Install Debian packages] ************************************************* 2026-03-17 20:43:20.976232 | controller | Tuesday 17 March 2026 20:43:20 +0000 (0:00:01.356) 0:00:01.385 ********* 2026-03-17 20:43:22.454358 | controller | ok: [controller] 2026-03-17 20:43:22.454705 | controller | 2026-03-17 20:43:22.454997 | controller | PLAY RECAP ********************************************************************* 2026-03-17 20:43:22.455325 | controller | controller : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-17 20:43:22.455943 | controller | 2026-03-17 20:43:22.456244 | controller | 2026-03-17 20:43:22.456606 | controller | TASKS RECAP ******************************************************************** 2026-03-17 20:43:22.456927 | controller | Tuesday 17 March 2026 20:43:22 +0000 (0:00:01.478) 0:00:02.863 ********* 2026-03-17 20:43:22.457186 | controller | =============================================================================== 2026-03-17 20:43:22.457458 | controller | Install Debian packages ------------------------------------------------- 1.48s 2026-03-17 20:43:22.457723 | controller | Gathering Facts --------------------------------------------------------- 1.36s 2026-03-17 20:43:22.577263 | controller | INFO [helm > prepare] Executed: Successful 2026-03-17 20:43:22.587491 | controller | INFO [helm > converge] Executing 2026-03-17 20:43:23.472178 | controller | 2026-03-17 20:43:23.472234 | controller | PLAY [Converge] **************************************************************** 2026-03-17 20:43:23.472243 | controller | 2026-03-17 20:43:23.472252 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-17 20:43:23.472261 | controller | Tuesday 17 March 2026 20:43:23 +0000 (0:00:00.013) 0:00:00.013 ********* 2026-03-17 20:43:24.557012 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-17 20:43:24.563110 | controller | ok: [controller] 2026-03-17 20:43:24.563374 | controller | 2026-03-17 20:43:24.563636 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-17 20:43:24.563888 | controller | Tuesday 17 March 2026 20:43:24 +0000 (0:00:01.091) 0:00:01.105 ********* 2026-03-17 20:43:25.076609 | controller | ok: [controller] 2026-03-17 20:43:25.077012 | controller | 2026-03-17 20:43:25.077387 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-17 20:43:25.077753 | controller | Tuesday 17 March 2026 20:43:25 +0000 (0:00:00.512) 0:00:01.618 ********* 2026-03-17 20:43:26.324575 | controller | ok: [controller] 2026-03-17 20:43:26.324942 | controller | 2026-03-17 20:43:26.325226 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-17 20:43:26.325595 | controller | Tuesday 17 March 2026 20:43:26 +0000 (0:00:01.248) 0:00:02.866 ********* 2026-03-17 20:43:26.785589 | controller | changed: [controller] 2026-03-17 20:43:26.785890 | controller | 2026-03-17 20:43:26.786183 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-17 20:43:26.786539 | controller | Tuesday 17 March 2026 20:43:26 +0000 (0:00:00.460) 0:00:03.327 ********* 2026-03-17 20:43:26.839729 | controller | ok: [controller] => { 2026-03-17 20:43:26.840069 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-17 20:43:26.840325 | controller | } 2026-03-17 20:43:26.840603 | controller | 2026-03-17 20:43:26.840861 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-17 20:43:26.841135 | controller | Tuesday 17 March 2026 20:43:26 +0000 (0:00:00.053) 0:00:03.380 ********* 2026-03-17 20:43:27.759681 | controller | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created with a mode of 0700, this may cause issues when running as another user. To avoid this, create the remote_tmp dir with the correct permissions manually 2026-03-17 20:43:27.771050 | controller | changed: [controller] 2026-03-17 20:43:27.771073 | controller | 2026-03-17 20:43:27.771082 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-17 20:43:27.771090 | controller | Tuesday 17 March 2026 20:43:27 +0000 (0:00:00.931) 0:00:04.312 ********* 2026-03-17 20:43:29.861250 | controller | changed: [controller] 2026-03-17 20:43:29.861285 | controller | 2026-03-17 20:43:29.861289 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-17 20:43:29.861293 | controller | Tuesday 17 March 2026 20:43:29 +0000 (0:00:02.088) 0:00:06.401 ********* 2026-03-17 20:43:30.380919 | controller | ok: [controller] 2026-03-17 20:43:30.381124 | controller | 2026-03-17 20:43:30.381307 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-17 20:43:30.384889 | controller | Tuesday 17 March 2026 20:43:30 +0000 (0:00:00.521) 0:00:06.922 ********* 2026-03-17 20:43:30.878686 | controller | changed: [controller] 2026-03-17 20:43:30.878987 | controller | 2026-03-17 20:43:30.879259 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-17 20:43:30.879521 | controller | Tuesday 17 March 2026 20:43:30 +0000 (0:00:00.497) 0:00:07.420 ********* 2026-03-17 20:43:31.408401 | controller | ok: [controller] 2026-03-17 20:43:31.408747 | controller | 2026-03-17 20:43:31.409036 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-17 20:43:31.409293 | controller | Tuesday 17 March 2026 20:43:31 +0000 (0:00:00.529) 0:00:07.949 ********* 2026-03-17 20:43:31.742500 | controller | changed: [controller] 2026-03-17 20:43:31.742796 | controller | 2026-03-17 20:43:31.743149 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-17 20:43:31.743452 | controller | Tuesday 17 March 2026 20:43:31 +0000 (0:00:00.333) 0:00:08.283 ********* 2026-03-17 20:43:32.091115 | controller | ok: [controller] 2026-03-17 20:43:32.091412 | controller | 2026-03-17 20:43:32.091770 | controller | TASK [Install plugin] ********************************************************** 2026-03-17 20:43:32.092033 | controller | Tuesday 17 March 2026 20:43:32 +0000 (0:00:00.349) 0:00:08.632 ********* 2026-03-17 20:43:32.155832 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-17 20:43:32.156172 | controller | 2026-03-17 20:43:32.156443 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-17 20:43:32.156779 | controller | Tuesday 17 March 2026 20:43:32 +0000 (0:00:00.064) 0:00:08.697 ********* 2026-03-17 20:43:32.201678 | controller | ok: [controller] => { 2026-03-17 20:43:32.202037 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-17 20:43:32.202301 | controller | } 2026-03-17 20:43:32.202545 | controller | 2026-03-17 20:43:32.202816 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-17 20:43:32.203107 | controller | Tuesday 17 March 2026 20:43:32 +0000 (0:00:00.045) 0:00:08.743 ********* 2026-03-17 20:43:35.045590 | controller | changed: [controller] 2026-03-17 20:43:35.045892 | controller | 2026-03-17 20:43:35.046159 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-17 20:43:35.046417 | controller | Tuesday 17 March 2026 20:43:35 +0000 (0:00:02.843) 0:00:11.587 ********* 2026-03-17 20:43:37.158921 | controller | changed: [controller] 2026-03-17 20:43:37.158956 | controller | 2026-03-17 20:43:37.158960 | controller | PLAY RECAP ********************************************************************* 2026-03-17 20:43:37.158965 | controller | controller : ok=16 changed=7 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-17 20:43:37.158969 | controller | 2026-03-17 20:43:37.158973 | controller | 2026-03-17 20:43:37.158976 | controller | TASKS RECAP ******************************************************************** 2026-03-17 20:43:37.158980 | controller | Tuesday 17 March 2026 20:43:37 +0000 (0:00:02.109) 0:00:13.696 ********* 2026-03-17 20:43:37.158984 | controller | =============================================================================== 2026-03-17 20:43:37.158987 | controller | vexxhost.containers.download_artifact : Download item ------------------- 2.84s 2026-03-17 20:43:37.158990 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.11s 2026-03-17 20:43:37.158994 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.09s 2026-03-17 20:43:37.158997 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.25s 2026-03-17 20:43:37.159000 | controller | Gathering Facts --------------------------------------------------------- 1.09s 2026-03-17 20:43:37.159003 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.93s 2026-03-17 20:43:37.159007 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.53s 2026-03-17 20:43:37.159010 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.52s 2026-03-17 20:43:37.159013 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.51s 2026-03-17 20:43:37.159017 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.50s 2026-03-17 20:43:37.159029 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.46s 2026-03-17 20:43:37.159033 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.35s 2026-03-17 20:43:37.159036 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.33s 2026-03-17 20:43:37.159039 | controller | Install plugin ---------------------------------------------------------- 0.06s 2026-03-17 20:43:37.159043 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-17 20:43:37.159046 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-17 20:43:37.289349 | controller | INFO [helm > converge] Executed: Successful 2026-03-17 20:43:37.295463 | controller | INFO [helm > idempotence] Executing 2026-03-17 20:43:38.223852 | controller | 2026-03-17 20:43:38.224187 | controller | PLAY [Converge] **************************************************************** 2026-03-17 20:43:38.224427 | controller | 2026-03-17 20:43:38.224826 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-17 20:43:38.225086 | controller | Tuesday 17 March 2026 20:43:38 +0000 (0:00:00.013) 0:00:00.013 ********* 2026-03-17 20:43:39.328877 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-17 20:43:39.336450 | controller | ok: [controller] 2026-03-17 20:43:39.336488 | controller | 2026-03-17 20:43:39.336494 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-17 20:43:39.336499 | controller | Tuesday 17 March 2026 20:43:39 +0000 (0:00:01.112) 0:00:01.126 ********* 2026-03-17 20:43:39.789654 | controller | ok: [controller] 2026-03-17 20:43:39.789727 | controller | 2026-03-17 20:43:39.789806 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-17 20:43:39.789937 | controller | Tuesday 17 March 2026 20:43:39 +0000 (0:00:00.453) 0:00:01.579 ********* 2026-03-17 20:43:40.942070 | controller | ok: [controller] 2026-03-17 20:43:40.942127 | controller | 2026-03-17 20:43:40.944506 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-17 20:43:40.944525 | controller | Tuesday 17 March 2026 20:43:40 +0000 (0:00:01.152) 0:00:02.732 ********* 2026-03-17 20:43:41.385402 | controller | ok: [controller] 2026-03-17 20:43:41.385436 | controller | 2026-03-17 20:43:41.385443 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-17 20:43:41.385448 | controller | Tuesday 17 March 2026 20:43:41 +0000 (0:00:00.440) 0:00:03.172 ********* 2026-03-17 20:43:41.431696 | controller | ok: [controller] => { 2026-03-17 20:43:41.431829 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-17 20:43:41.431957 | controller | } 2026-03-17 20:43:41.432119 | controller | 2026-03-17 20:43:41.432416 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-17 20:43:41.432450 | controller | Tuesday 17 March 2026 20:43:41 +0000 (0:00:00.048) 0:00:03.221 ********* 2026-03-17 20:43:41.961048 | controller | ok: [controller] 2026-03-17 20:43:41.961113 | controller | 2026-03-17 20:43:41.961212 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-17 20:43:41.961303 | controller | Tuesday 17 March 2026 20:43:41 +0000 (0:00:00.525) 0:00:03.747 ********* 2026-03-17 20:43:43.716174 | controller | ok: [controller] 2026-03-17 20:43:43.716225 | controller | 2026-03-17 20:43:43.716286 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-17 20:43:43.716372 | controller | Tuesday 17 March 2026 20:43:43 +0000 (0:00:01.759) 0:00:05.506 ********* 2026-03-17 20:43:44.265200 | controller | ok: [controller] 2026-03-17 20:43:44.265259 | controller | 2026-03-17 20:43:44.265269 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-17 20:43:44.265447 | controller | Tuesday 17 March 2026 20:43:44 +0000 (0:00:00.548) 0:00:06.055 ********* 2026-03-17 20:43:44.707865 | controller | ok: [controller] 2026-03-17 20:43:44.707921 | controller | 2026-03-17 20:43:44.708039 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-17 20:43:44.708168 | controller | Tuesday 17 March 2026 20:43:44 +0000 (0:00:00.442) 0:00:06.497 ********* 2026-03-17 20:43:45.163351 | controller | ok: [controller] 2026-03-17 20:43:45.163412 | controller | 2026-03-17 20:43:45.163469 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-17 20:43:45.163609 | controller | Tuesday 17 March 2026 20:43:45 +0000 (0:00:00.454) 0:00:06.952 ********* 2026-03-17 20:43:45.472964 | controller | ok: [controller] 2026-03-17 20:43:45.473092 | controller | 2026-03-17 20:43:45.473287 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-17 20:43:45.473425 | controller | Tuesday 17 March 2026 20:43:45 +0000 (0:00:00.309) 0:00:07.262 ********* 2026-03-17 20:43:45.785541 | controller | ok: [controller] 2026-03-17 20:43:45.785585 | controller | 2026-03-17 20:43:45.785591 | controller | TASK [Install plugin] ********************************************************** 2026-03-17 20:43:45.785596 | controller | Tuesday 17 March 2026 20:43:45 +0000 (0:00:00.309) 0:00:07.571 ********* 2026-03-17 20:43:45.841024 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-17 20:43:45.843290 | controller | 2026-03-17 20:43:45.843309 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-17 20:43:45.843318 | controller | Tuesday 17 March 2026 20:43:45 +0000 (0:00:00.056) 0:00:07.628 ********* 2026-03-17 20:43:45.892594 | controller | ok: [controller] => { 2026-03-17 20:43:45.892691 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-17 20:43:45.892700 | controller | } 2026-03-17 20:43:45.892781 | controller | 2026-03-17 20:43:45.892873 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-17 20:43:45.892964 | controller | Tuesday 17 March 2026 20:43:45 +0000 (0:00:00.051) 0:00:07.679 ********* 2026-03-17 20:43:46.345591 | controller | ok: [controller] 2026-03-17 20:43:46.345658 | controller | 2026-03-17 20:43:46.345672 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-17 20:43:46.345758 | controller | Tuesday 17 March 2026 20:43:46 +0000 (0:00:00.455) 0:00:08.135 ********* 2026-03-17 20:43:48.037945 | controller | ok: [controller] 2026-03-17 20:43:48.037997 | controller | 2026-03-17 20:43:48.038148 | controller | PLAY RECAP ********************************************************************* 2026-03-17 20:43:48.038285 | controller | controller : ok=16 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-17 20:43:48.038398 | controller | 2026-03-17 20:43:48.038515 | controller | 2026-03-17 20:43:48.038629 | controller | TASKS RECAP ******************************************************************** 2026-03-17 20:43:48.038762 | controller | Tuesday 17 March 2026 20:43:48 +0000 (0:00:01.693) 0:00:09.828 ********* 2026-03-17 20:43:48.038884 | controller | =============================================================================== 2026-03-17 20:43:48.039013 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.76s 2026-03-17 20:43:48.039137 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.69s 2026-03-17 20:43:48.039256 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.15s 2026-03-17 20:43:48.040553 | controller | Gathering Facts --------------------------------------------------------- 1.11s 2026-03-17 20:43:48.040593 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.55s 2026-03-17 20:43:48.040600 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.53s 2026-03-17 20:43:48.040605 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.46s 2026-03-17 20:43:48.040609 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.45s 2026-03-17 20:43:48.040615 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.45s 2026-03-17 20:43:48.040620 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.44s 2026-03-17 20:43:48.040637 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.44s 2026-03-17 20:43:48.040641 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.31s 2026-03-17 20:43:48.040646 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.31s 2026-03-17 20:43:48.040807 | controller | Install plugin ---------------------------------------------------------- 0.06s 2026-03-17 20:43:48.040987 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-17 20:43:48.041115 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-17 20:43:48.163297 | controller | INFO [helm > idempotence] Executed: Successful 2026-03-17 20:43:48.175200 | controller | INFO [helm > side_effect] Executing 2026-03-17 20:43:48.175586 | controller | WARNING [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-17 20:43:48.189640 | controller | INFO [helm > verify] Executing 2026-03-17 20:43:49.086069 | controller | 2026-03-17 20:43:49.086441 | controller | PLAY [Verify] ****************************************************************** 2026-03-17 20:43:49.086714 | controller | 2026-03-17 20:43:49.086991 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-17 20:43:49.087290 | controller | Tuesday 17 March 2026 20:43:49 +0000 (0:00:00.010) 0:00:00.010 ********* 2026-03-17 20:43:50.198424 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-17 20:43:50.209181 | controller | ok: [controller] 2026-03-17 20:43:50.209307 | controller | 2026-03-17 20:43:50.209445 | controller | TASK [Get the current Helm version] ******************************************** 2026-03-17 20:43:50.209578 | controller | Tuesday 17 March 2026 20:43:50 +0000 (0:00:01.119) 0:00:01.130 ********* 2026-03-17 20:43:50.668767 | controller | changed: [controller] 2026-03-17 20:43:50.668831 | controller | 2026-03-17 20:43:50.668958 | controller | TASK [Assert Helm version] ***************************************************** 2026-03-17 20:43:50.669094 | controller | Tuesday 17 March 2026 20:43:50 +0000 (0:00:00.463) 0:00:01.593 ********* 2026-03-17 20:43:50.704208 | controller | ok: [controller] => { 2026-03-17 20:43:50.704543 | controller | "changed": false, 2026-03-17 20:43:50.707089 | controller | "msg": "All assertions passed" 2026-03-17 20:43:50.707133 | controller | } 2026-03-17 20:43:50.707142 | controller | 2026-03-17 20:43:50.707151 | controller | PLAY RECAP ********************************************************************* 2026-03-17 20:43:50.707159 | controller | controller : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-17 20:43:50.707167 | controller | 2026-03-17 20:43:50.707174 | controller | 2026-03-17 20:43:50.707182 | controller | TASKS RECAP ******************************************************************** 2026-03-17 20:43:50.707189 | controller | Tuesday 17 March 2026 20:43:50 +0000 (0:00:00.035) 0:00:01.629 ********* 2026-03-17 20:43:50.707197 | controller | =============================================================================== 2026-03-17 20:43:50.707203 | controller | Gathering Facts --------------------------------------------------------- 1.12s 2026-03-17 20:43:50.707210 | controller | Get the current Helm version -------------------------------------------- 0.46s 2026-03-17 20:43:50.707217 | controller | Assert Helm version ----------------------------------------------------- 0.04s 2026-03-17 20:43:50.831512 | controller | INFO [helm > verify] Executed: Successful 2026-03-17 20:43:50.844568 | controller | INFO [helm > cleanup] Executing 2026-03-17 20:43:50.845311 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-17 20:43:50.853681 | controller | INFO [helm > destroy] Executing 2026-03-17 20:43:50.853780 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-17 20:43:50.853867 | controller | INFO [helm > destroy] Executed: Successful 2026-03-17 20:43:50.854245 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-03-17 20:43:51.464588 | controller | ok: Runtime: 0:01:01.681617 2026-03-17 20:43:51.470251 | 2026-03-17 20:43:51.470375 | PLAY RECAP 2026-03-17 20:43:51.470442 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-17 20:43:51.470473 | 2026-03-17 20:43:51.586234 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-17 20:43:51.588315 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-17 20:43:52.219198 | 2026-03-17 20:43:52.219348 | PLAY [all] 2026-03-17 20:43:52.230598 | 2026-03-17 20:43:52.230726 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-03-17 20:43:52.643061 | controller | changed 2026-03-17 20:43:52.648620 | 2026-03-17 20:43:52.648716 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-03-17 20:43:53.037623 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-17 20:43:53.038132 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-17 20:43:53.045707 | controller | environment: line 1: kubectl: command not found 2026-03-17 20:43:53.048306 | controller | environment: line 1: kubectl: command not found 2026-03-17 20:43:53.048336 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-17 20:43:53.049704 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-17 20:43:53.051881 | controller | environment: line 1: kubectl: command not found 2026-03-17 20:43:53.053631 | controller | environment: line 1: kubectl: command not found 2026-03-17 20:43:53.054245 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-17 20:43:53.054745 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-17 20:43:53.057700 | controller | environment: line 1: kubectl: command not found 2026-03-17 20:43:53.059075 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-17 20:43:53.178454 | controller | ok: Runtime: 0:00:00.032367 2026-03-17 20:43:53.188001 | 2026-03-17 20:43:53.188182 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-03-17 20:43:53.423624 | controller | changed 2026-03-17 20:43:53.428886 | 2026-03-17 20:43:53.429006 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-03-17 20:43:53.665736 | controller | environment: line 5: kubectl: command not found 2026-03-17 20:43:53.666494 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-17 20:43:53.666815 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-17 20:43:53.667143 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-17 20:43:53.954269 | controller | ok: Runtime: 0:00:00.013492 2026-03-17 20:43:53.961668 | 2026-03-17 20:43:53.961775 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-03-17 20:43:55.617936 | controller | changed: 2026-03-17 20:43:55.618417 | controller | created directory /var/lib/zuul/builds/93b0a6c6330e43b29962cbbccbae9e4e/work/logs/controller 2026-03-17 20:43:55.618453 | controller | cd+++++++++ objects/ 2026-03-17 20:43:55.618647 | controller | cd+++++++++ objects/cluster/ 2026-03-17 20:43:55.618680 | controller | cd+++++++++ objects/namespaced/ 2026-03-17 20:43:55.626866 | 2026-03-17 20:43:55.626937 | TASK [gather-pod-logs : creating directory for pod logs] 2026-03-17 20:43:55.871641 | controller | changed 2026-03-17 20:43:55.878126 | 2026-03-17 20:43:55.878226 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-03-17 20:43:56.125025 | controller | changed 2026-03-17 20:43:56.130571 | 2026-03-17 20:43:56.130641 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-03-17 20:43:56.402437 | controller | environment: line 3: kubectl: command not found 2026-03-17 20:43:56.675577 | controller | ok: Runtime: 0:00:00.015999 2026-03-17 20:43:56.681179 | 2026-03-17 20:43:56.681269 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-03-17 20:43:57.245207 | controller | changed: 2026-03-17 20:43:57.245395 | controller | cd+++++++++ pod-logs/ 2026-03-17 20:43:57.245424 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-03-17 20:43:57.252322 | 2026-03-17 20:43:57.252391 | LOOP [helm-release-status : creating directory for helm release status] 2026-03-17 20:43:57.499606 | controller | changed: "values" 2026-03-17 20:43:57.709891 | controller | changed: "releases" 2026-03-17 20:43:57.729795 | 2026-03-17 20:43:57.730010 | TASK [helm-release-status : Gather get release status for helm charts] 2026-03-17 20:43:57.992279 | controller | /bin/bash: line 3: kubectl: command not found 2026-03-17 20:43:58.263421 | controller | ok: Runtime: 0:00:00.007776 2026-03-17 20:43:58.269020 | 2026-03-17 20:43:58.269135 | TASK [helm-release-status : Downloads logs to executor] 2026-03-17 20:43:58.802692 | controller | changed: 2026-03-17 20:43:58.802858 | controller | cd+++++++++ helm/ 2026-03-17 20:43:58.802886 | controller | cd+++++++++ helm/releases/ 2026-03-17 20:43:58.802909 | controller | cd+++++++++ helm/values/ 2026-03-17 20:43:58.808247 | 2026-03-17 20:43:58.808316 | PLAY RECAP 2026-03-17 20:43:58.808373 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-17 20:43:58.808403 | 2026-03-17 20:43:58.942562 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-17 20:43:58.945620 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-17 20:43:59.613974 | 2026-03-17 20:43:59.614182 | PLAY [all] 2026-03-17 20:43:59.626482 | 2026-03-17 20:43:59.626632 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-17 20:43:59.672651 | controller | skipping: Conditional result was False 2026-03-17 20:43:59.680862 | 2026-03-17 20:43:59.681039 | TASK [fetch-output : Set log path for single node] 2026-03-17 20:43:59.725760 | controller | ok 2026-03-17 20:43:59.731862 | 2026-03-17 20:43:59.731990 | LOOP [fetch-output : Ensure local output dirs] 2026-03-17 20:44:01.250419 | controller -> localhost | ok: "/var/lib/zuul/builds/93b0a6c6330e43b29962cbbccbae9e4e/work/logs" 2026-03-17 20:44:01.494140 | controller -> localhost | changed: "/var/lib/zuul/builds/93b0a6c6330e43b29962cbbccbae9e4e/work/artifacts" 2026-03-17 20:44:01.716875 | controller -> localhost | changed: "/var/lib/zuul/builds/93b0a6c6330e43b29962cbbccbae9e4e/work/docs" 2026-03-17 20:44:01.733583 | 2026-03-17 20:44:01.733912 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-17 20:44:02.413154 | controller | changed: .d..t...... ./ 2026-03-17 20:44:02.413434 | controller | changed: All items complete 2026-03-17 20:44:02.413475 | 2026-03-17 20:44:02.961989 | controller | changed: .d..t...... ./ 2026-03-17 20:44:03.474919 | controller | changed: .d..t...... ./ 2026-03-17 20:44:03.498229 | 2026-03-17 20:44:03.498426 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-17 20:44:04.050749 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.013266 2026-03-17 20:44:04.330477 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.006636 2026-03-17 20:44:04.347612 | 2026-03-17 20:44:04.347745 | PLAY [all] 2026-03-17 20:44:04.353870 | 2026-03-17 20:44:04.353932 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-17 20:44:04.917015 | controller | changed 2026-03-17 20:44:06.280174 | 2026-03-17 20:44:06.280305 | PLAY RECAP 2026-03-17 20:44:06.280395 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-17 20:44:06.280442 | 2026-03-17 20:44:06.481002 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-17 20:44:06.484053 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-17 20:44:07.111533 | 2026-03-17 20:44:07.111686 | PLAY [localhost] 2026-03-17 20:44:07.122206 | 2026-03-17 20:44:07.122287 | TASK [Generate Zuul manifest] 2026-03-17 20:44:07.144355 | localhost | ok 2026-03-17 20:44:07.164053 | 2026-03-17 20:44:07.164145 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-17 20:44:07.504307 | localhost | changed 2026-03-17 20:44:07.517577 | 2026-03-17 20:44:07.517654 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-17 20:44:07.600407 | localhost | ok 2026-03-17 20:44:07.609366 | 2026-03-17 20:44:07.609454 | TASK [Upload logs] 2026-03-17 20:44:07.628208 | localhost | ok 2026-03-17 20:44:07.691910 | 2026-03-17 20:44:07.692045 | TASK [Set zuul-log-path fact] 2026-03-17 20:44:07.712791 | localhost | ok 2026-03-17 20:44:07.726092 | 2026-03-17 20:44:07.726166 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-17 20:44:07.758283 | localhost | ok 2026-03-17 20:44:07.767486 | 2026-03-17 20:44:07.767575 | TASK [upload-logs : Create log directories] 2026-03-17 20:44:08.181625 | localhost | changed 2026-03-17 20:44:08.188297 | 2026-03-17 20:44:08.188401 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-17 20:44:08.606068 | localhost -> localhost | ok: Runtime: 0:00:00.006022 2026-03-17 20:44:08.613167 | 2026-03-17 20:44:08.613266 | TASK [upload-logs : Upload logs to log server] 2026-03-17 20:44:09.129231 | localhost | Output suppressed because no_log was given 2026-03-17 20:44:09.135081 | 2026-03-17 20:44:09.135151 | LOOP [upload-logs : Compress console log and json output] 2026-03-17 20:44:09.181876 | localhost | skipping: Conditional result was False 2026-03-17 20:44:09.189512 | localhost | skipping: Conditional result was False 2026-03-17 20:44:09.200447 | 2026-03-17 20:44:09.200568 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-17 20:44:09.255074 | localhost | skipping: Conditional result was False 2026-03-17 20:44:09.255489 | 2026-03-17 20:44:09.262087 | localhost | skipping: Conditional result was False 2026-03-17 20:44:09.275600 | 2026-03-17 20:44:09.275785 | LOOP [upload-logs : Upload console log and json output]