2026-05-21 22:40:22.202536 | Job console starting 2026-05-21 22:40:22.216117 | Updating git repos 2026-05-21 22:40:22.303663 | Cloning repos into workspace 2026-05-21 22:40:22.433626 | Restoring repo states 2026-05-21 22:40:22.449295 | Merging changes 2026-05-21 22:40:23.105499 | Checking out repos 2026-05-21 22:40:23.340572 | Preparing playbooks 2026-05-21 22:40:25.940099 | Running Ansible setup 2026-05-21 22:40:29.646865 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-05-21 22:40:30.255602 | 2026-05-21 22:40:30.255786 | PLAY [localhost] 2026-05-21 22:40:30.264261 | 2026-05-21 22:40:30.264380 | TASK [Gathering Facts] 2026-05-21 22:40:31.183152 | localhost | ok 2026-05-21 22:40:31.196713 | 2026-05-21 22:40:31.196790 | TASK [Setup log path fact] 2026-05-21 22:40:31.220524 | localhost | ok 2026-05-21 22:40:31.234680 | 2026-05-21 22:40:31.234745 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-21 22:40:31.265142 | localhost | ok 2026-05-21 22:40:31.272857 | 2026-05-21 22:40:31.273003 | TASK [emit-job-header : Print job information] 2026-05-21 22:40:31.315372 | # Job Information 2026-05-21 22:40:31.315581 | Ansible Version: 2.16.18 2026-05-21 22:40:31.315651 | Job: ansible-collection-kubernetes-molecule-helm 2026-05-21 22:40:31.315701 | Pipeline: check 2026-05-21 22:40:31.315747 | Executor: 2d72f0692154 2026-05-21 22:40:31.315791 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/277 2026-05-21 22:40:31.315841 | Event ID: ebc414b0-5565-11f1-9d98-36ba500e19bf 2026-05-21 22:40:31.319640 | 2026-05-21 22:40:31.319724 | LOOP [emit-job-header : Print node information] 2026-05-21 22:40:31.405980 | localhost | ok: 2026-05-21 22:40:31.406319 | localhost | # Node Information 2026-05-21 22:40:31.406367 | localhost | Inventory Hostname: controller 2026-05-21 22:40:31.406400 | localhost | Hostname: np0000176008 2026-05-21 22:40:31.406443 | localhost | Username: zuul 2026-05-21 22:40:31.406476 | localhost | Distro: Debian 13.5 2026-05-21 22:40:31.406504 | localhost | Provider: yul1 2026-05-21 22:40:31.406531 | localhost | Region: ca-ymq-1 2026-05-21 22:40:31.406557 | localhost | Label: debian-trixie 2026-05-21 22:40:31.406584 | localhost | Product Name: OpenStack Nova 2026-05-21 22:40:31.406609 | localhost | Interface IP: 199.204.45.3 2026-05-21 22:40:31.429249 | 2026-05-21 22:40:31.429374 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-21 22:40:31.823955 | localhost -> localhost | changed 2026-05-21 22:40:31.838100 | 2026-05-21 22:40:31.838239 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-21 22:40:32.860340 | localhost -> localhost | changed 2026-05-21 22:40:32.867273 | 2026-05-21 22:40:32.867390 | PLAY [all] 2026-05-21 22:40:32.882822 | 2026-05-21 22:40:32.882970 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-21 22:40:33.141815 | controller -> localhost | ok 2026-05-21 22:40:33.148000 | 2026-05-21 22:40:33.148075 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-21 22:40:33.177517 | controller | ok 2026-05-21 22:40:33.204105 | controller | included: /var/lib/zuul/builds/576e727155df4c0bbbc05f9acedeec61/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-21 22:40:33.212748 | 2026-05-21 22:40:33.213173 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-21 22:40:34.113014 | controller -> localhost | Generating public/private rsa key pair. 2026-05-21 22:40:34.113206 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/576e727155df4c0bbbc05f9acedeec61/work/576e727155df4c0bbbc05f9acedeec61_id_rsa 2026-05-21 22:40:34.113238 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/576e727155df4c0bbbc05f9acedeec61/work/576e727155df4c0bbbc05f9acedeec61_id_rsa.pub 2026-05-21 22:40:34.113263 | controller -> localhost | The key fingerprint is: 2026-05-21 22:40:34.113286 | controller -> localhost | SHA256:DfmNUc8PySQur13nFbWVPhOiOP4NNlNqcA7YXOPyPKQ zuul-build-sshkey 2026-05-21 22:40:34.113396 | controller -> localhost | The key's randomart image is: 2026-05-21 22:40:34.113427 | controller -> localhost | +---[RSA 3072]----+ 2026-05-21 22:40:34.113456 | controller -> localhost | | o . +| 2026-05-21 22:40:34.113480 | controller -> localhost | | . = B ++| 2026-05-21 22:40:34.113501 | controller -> localhost | | * * + Oo.| 2026-05-21 22:40:34.113633 | controller -> localhost | | . % @ . *.| 2026-05-21 22:40:34.113684 | controller -> localhost | | S / = . *| 2026-05-21 22:40:34.113709 | controller -> localhost | | E # . o.| 2026-05-21 22:40:34.113729 | controller -> localhost | | = B .| 2026-05-21 22:40:34.113750 | controller -> localhost | | . . | 2026-05-21 22:40:34.113782 | controller -> localhost | | | 2026-05-21 22:40:34.113802 | controller -> localhost | +----[SHA256]-----+ 2026-05-21 22:40:34.113874 | controller -> localhost | ok: Runtime: 0:00:00.463482 2026-05-21 22:40:34.118173 | 2026-05-21 22:40:34.118236 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-21 22:40:34.150367 | controller | ok 2026-05-21 22:40:34.171732 | controller | included: /var/lib/zuul/builds/576e727155df4c0bbbc05f9acedeec61/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-21 22:40:34.178496 | 2026-05-21 22:40:34.274939 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-21 22:40:34.303226 | controller | skipping: Conditional result was False 2026-05-21 22:40:34.310666 | 2026-05-21 22:40:34.310751 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-21 22:40:34.903554 | controller | changed 2026-05-21 22:40:34.907646 | 2026-05-21 22:40:34.907713 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-21 22:40:35.128767 | controller | ok 2026-05-21 22:40:35.138756 | 2026-05-21 22:40:35.138822 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-21 22:40:35.708349 | controller | changed 2026-05-21 22:40:35.714412 | 2026-05-21 22:40:35.714508 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-21 22:40:36.241785 | controller | changed 2026-05-21 22:40:36.247412 | 2026-05-21 22:40:36.247489 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-21 22:40:36.273931 | controller | skipping: Conditional result was False 2026-05-21 22:40:36.280365 | 2026-05-21 22:40:36.280449 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-21 22:40:36.695613 | controller -> localhost | changed 2026-05-21 22:40:36.714167 | 2026-05-21 22:40:36.714249 | TASK [add-build-sshkey : Add back temp key] 2026-05-21 22:40:36.985015 | controller -> localhost | Identity added: /var/lib/zuul/builds/576e727155df4c0bbbc05f9acedeec61/work/576e727155df4c0bbbc05f9acedeec61_id_rsa (zuul-build-sshkey) 2026-05-21 22:40:36.985237 | controller -> localhost | ok: Runtime: 0:00:00.013235 2026-05-21 22:40:36.992927 | 2026-05-21 22:40:36.993191 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-21 22:40:37.325969 | controller | ok 2026-05-21 22:40:37.330975 | 2026-05-21 22:40:37.331060 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-21 22:40:37.357034 | controller | skipping: Conditional result was False 2026-05-21 22:40:37.368854 | 2026-05-21 22:40:37.368945 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-05-21 22:40:37.763820 | controller | ok 2026-05-21 22:40:37.770216 | 2026-05-21 22:40:37.770300 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-05-21 22:40:38.750961 | controller | Output suppressed because no_log was given 2026-05-21 22:40:38.760733 | 2026-05-21 22:40:38.760862 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-05-21 22:40:38.982089 | controller | ok: "logs" 2026-05-21 22:40:38.982349 | controller | ok: All items complete 2026-05-21 22:40:38.982378 | 2026-05-21 22:40:39.146125 | controller | ok: "artifacts" 2026-05-21 22:40:39.323091 | controller | ok: "docs" 2026-05-21 22:40:39.330566 | 2026-05-21 22:40:39.330735 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-05-21 22:40:39.539063 | controller | changed: "logs" 2026-05-21 22:40:39.731355 | controller | changed: "artifacts" 2026-05-21 22:40:39.910890 | controller | changed: "docs" 2026-05-21 22:40:39.923070 | 2026-05-21 22:40:39.923218 | PLAY RECAP 2026-05-21 22:40:39.923281 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-05-21 22:40:39.923321 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-21 22:40:39.923352 | 2026-05-21 22:40:40.094024 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-05-21 22:40:40.096921 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-05-21 22:40:40.719094 | 2026-05-21 22:40:40.719235 | PLAY [all] 2026-05-21 22:40:40.729747 | 2026-05-21 22:40:40.729824 | TASK [setup-uv : Extract archive] 2026-05-21 22:40:43.206817 | controller | changed 2026-05-21 22:40:43.212320 | 2026-05-21 22:40:43.212421 | TASK [setup-uv : Print version] 2026-05-21 22:40:42.954560 | controller | uv 0.8.13 2026-05-21 22:40:43.741474 | controller | ok: Runtime: 0:00:00.013240 2026-05-21 22:40:43.748687 | 2026-05-21 22:40:43.748756 | TASK [Install Ansible collection siblings] 2026-05-21 22:40:44.146209 | controller | ok: 2026-05-21 22:40:44.146431 | controller | Skipping ansible.posix: no checked-out sibling 2026-05-21 22:40:44.146462 | controller | Skipping community.crypto: no checked-out sibling 2026-05-21 22:40:44.146484 | controller | Skipping community.general: no checked-out sibling 2026-05-21 22:40:44.146504 | controller | Skipping kubernetes.core: no checked-out sibling 2026-05-21 22:40:44.146525 | controller | Skipping vexxhost.containers: no checked-out sibling 2026-05-21 22:40:44.148440 | 2026-05-21 22:40:44.148491 | PLAY RECAP 2026-05-21 22:40:44.148544 | controller | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-21 22:40:44.148567 | 2026-05-21 22:40:44.271503 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-05-21 22:40:44.274330 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-05-21 22:40:44.876898 | 2026-05-21 22:40:44.877155 | PLAY [all] 2026-05-21 22:40:44.888779 | 2026-05-21 22:40:44.888856 | TASK [Update apt cache] 2026-05-21 22:40:50.540844 | controller | ok 2026-05-21 22:40:50.547214 | 2026-05-21 22:40:50.547320 | TASK [Disable firewalld] 2026-05-21 22:40:50.572670 | controller | skipping: Conditional result was False 2026-05-21 22:40:50.578574 | 2026-05-21 22:40:50.578660 | TASK [Install "jq" for log collection] 2026-05-21 22:40:53.211355 | controller | changed 2026-05-21 22:40:53.214047 | 2026-05-21 22:40:53.214117 | PLAY RECAP 2026-05-21 22:40:53.214177 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-21 22:40:53.214208 | 2026-05-21 22:40:53.357990 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-05-21 22:40:53.360344 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-05-21 22:40:54.000800 | 2026-05-21 22:40:54.001295 | PLAY [all] 2026-05-21 22:40:54.011127 | 2026-05-21 22:40:54.011197 | TASK [Copy inventory file for Zuul] 2026-05-21 22:40:54.945356 | controller | changed 2026-05-21 22:40:54.951210 | 2026-05-21 22:40:54.951296 | TASK [Switch "ansible_host" to private IP] 2026-05-21 22:40:55.298803 | controller | changed: 1 replacements made 2026-05-21 22:40:55.307642 | 2026-05-21 22:40:55.307877 | TASK [Run Molecule scenario] 2026-05-21 22:40:55.141421 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-05-21 22:40:55.141525 | controller | Creating virtual environment at: .venv 2026-05-21 22:40:57.357219 | controller | Downloading cryptography (4.3MiB) 2026-05-21 22:40:57.357724 | controller | Downloading ansible-core (2.3MiB) 2026-05-21 22:40:57.357902 | controller | Downloading pygments (1.2MiB) 2026-05-21 22:40:57.534421 | controller | Downloading cryptography 2026-05-21 22:40:57.587629 | controller | Downloading pygments 2026-05-21 22:40:57.735360 | controller | Downloading ansible-core 2026-05-21 22:40:57.780979 | controller | Installed 36 packages in 44ms 2026-05-21 22:40:58.449504 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-05-21 22:40:58.449556 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-05-21 22:40:59.340566 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-05-21 22:40:59.340614 | controller | INFO default scenario not found, disabling shared state. 2026-05-21 22:40:59.340633 | controller | INFO [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-05-21 22:40:59.340642 | controller | INFO [helm > prerun] Performing prerun with role_name_check=0... 2026-05-21 22:45:10.869698 | controller | INFO [helm > dependency] Executing 2026-05-21 22:45:10.869754 | controller | WARNING [helm > dependency] Missing roles requirements file: requirements.yml 2026-05-21 22:45:10.869989 | controller | WARNING [helm > dependency] Missing collections requirements file: collections.yml 2026-05-21 22:45:10.870141 | controller | WARNING [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-05-21 22:45:10.876470 | controller | INFO [helm > cleanup] Executing 2026-05-21 22:45:10.876760 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-05-21 22:45:10.882087 | controller | INFO [helm > destroy] Executing 2026-05-21 22:45:10.882117 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-05-21 22:45:10.882183 | controller | INFO [helm > destroy] Executed: Successful 2026-05-21 22:45:10.887462 | controller | INFO [helm > syntax] Executing 2026-05-21 22:45:11.755158 | controller | 2026-05-21 22:45:11.755385 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml 2026-05-21 22:45:11.812007 | controller | INFO [helm > syntax] Executed: Successful 2026-05-21 22:45:11.821486 | controller | INFO [helm > create] Executing 2026-05-21 22:45:11.823529 | controller | WARNING [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-05-21 22:45:11.831139 | controller | INFO [helm > prepare] Executing 2026-05-21 22:45:12.678657 | controller | 2026-05-21 22:45:12.678820 | controller | PLAY [Prepare] ***************************************************************** 2026-05-21 22:45:12.679070 | controller | 2026-05-21 22:45:12.679274 | controller | TASK [Gathering Facts] ********************************************************* 2026-05-21 22:45:12.679474 | controller | Thursday 21 May 2026 22:45:12 +0000 (0:00:00.032) 0:00:00.032 ********** 2026-05-21 22:45:13.886143 | 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-21 22:45:13.892505 | controller | ok: [controller] 2026-05-21 22:45:13.892691 | controller | 2026-05-21 22:45:13.892975 | controller | TASK [Install Debian packages] ************************************************* 2026-05-21 22:45:13.893282 | controller | Thursday 21 May 2026 22:45:13 +0000 (0:00:01.214) 0:00:01.247 ********** 2026-05-21 22:45:15.200316 | controller | ok: [controller] 2026-05-21 22:45:15.202945 | controller | 2026-05-21 22:45:15.202988 | controller | PLAY RECAP ********************************************************************* 2026-05-21 22:45:15.202999 | controller | controller : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-05-21 22:45:15.203007 | controller | 2026-05-21 22:45:15.203015 | controller | 2026-05-21 22:45:15.203022 | controller | TASKS RECAP ******************************************************************** 2026-05-21 22:45:15.203044 | controller | Thursday 21 May 2026 22:45:15 +0000 (0:00:01.307) 0:00:02.554 ********** 2026-05-21 22:45:15.203052 | controller | =============================================================================== 2026-05-21 22:45:15.203058 | controller | Install Debian packages ------------------------------------------------- 1.31s 2026-05-21 22:45:15.203066 | controller | Gathering Facts --------------------------------------------------------- 1.21s 2026-05-21 22:45:15.281635 | controller | INFO [helm > prepare] Executed: Successful 2026-05-21 22:45:15.291407 | controller | INFO [helm > converge] Executing 2026-05-21 22:45:16.115287 | controller | 2026-05-21 22:45:16.115395 | controller | PLAY [Converge] **************************************************************** 2026-05-21 22:45:16.115580 | controller | 2026-05-21 22:45:16.115772 | controller | TASK [Gathering Facts] ********************************************************* 2026-05-21 22:45:16.115960 | controller | Thursday 21 May 2026 22:45:16 +0000 (0:00:00.013) 0:00:00.013 ********** 2026-05-21 22:45:17.138116 | 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-21 22:45:17.143336 | controller | ok: [controller] 2026-05-21 22:45:17.143499 | controller | 2026-05-21 22:45:17.143693 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-05-21 22:45:17.143878 | controller | Thursday 21 May 2026 22:45:17 +0000 (0:00:01.028) 0:00:01.041 ********** 2026-05-21 22:45:17.638885 | controller | ok: [controller] 2026-05-21 22:45:17.639026 | controller | 2026-05-21 22:45:17.639234 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-05-21 22:45:17.639422 | controller | Thursday 21 May 2026 22:45:17 +0000 (0:00:00.495) 0:00:01.536 ********** 2026-05-21 22:45:19.661243 | controller | ok: [controller] 2026-05-21 22:45:19.661297 | controller | 2026-05-21 22:45:19.661449 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-05-21 22:45:19.661580 | controller | Thursday 21 May 2026 22:45:19 +0000 (0:00:02.022) 0:00:03.558 ********** 2026-05-21 22:45:20.086139 | controller | changed: [controller] 2026-05-21 22:45:20.086338 | controller | 2026-05-21 22:45:20.086603 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-05-21 22:45:20.086931 | controller | Thursday 21 May 2026 22:45:20 +0000 (0:00:00.424) 0:00:03.983 ********** 2026-05-21 22:45:20.139301 | controller | ok: [controller] => { 2026-05-21 22:45:20.139341 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-05-21 22:45:20.139426 | controller | } 2026-05-21 22:45:20.139504 | controller | 2026-05-21 22:45:20.139600 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-05-21 22:45:20.139668 | controller | Thursday 21 May 2026 22:45:20 +0000 (0:00:00.051) 0:00:04.034 ********** 2026-05-21 22:45:20.854863 | 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-21 22:45:20.863944 | controller | changed: [controller] 2026-05-21 22:45:20.864097 | controller | 2026-05-21 22:45:20.864298 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-05-21 22:45:20.864491 | controller | Thursday 21 May 2026 22:45:20 +0000 (0:00:00.727) 0:00:04.761 ********** 2026-05-21 22:45:22.841290 | controller | changed: [controller] 2026-05-21 22:45:22.841313 | controller | 2026-05-21 22:45:22.841319 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-05-21 22:45:22.841324 | controller | Thursday 21 May 2026 22:45:22 +0000 (0:00:01.975) 0:00:06.736 ********** 2026-05-21 22:45:23.323283 | controller | ok: [controller] 2026-05-21 22:45:23.323465 | controller | 2026-05-21 22:45:23.323674 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-05-21 22:45:23.323871 | controller | Thursday 21 May 2026 22:45:23 +0000 (0:00:00.483) 0:00:07.220 ********** 2026-05-21 22:45:23.720150 | controller | changed: [controller] 2026-05-21 22:45:23.720282 | controller | 2026-05-21 22:45:23.720496 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-05-21 22:45:23.720693 | controller | Thursday 21 May 2026 22:45:23 +0000 (0:00:00.397) 0:00:07.617 ********** 2026-05-21 22:45:24.197643 | controller | ok: [controller] 2026-05-21 22:45:24.197739 | controller | 2026-05-21 22:45:24.197873 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-05-21 22:45:24.197995 | controller | Thursday 21 May 2026 22:45:24 +0000 (0:00:00.477) 0:00:08.095 ********** 2026-05-21 22:45:24.485352 | controller | changed: [controller] 2026-05-21 22:45:24.485754 | controller | 2026-05-21 22:45:24.486069 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-05-21 22:45:24.486281 | controller | Thursday 21 May 2026 22:45:24 +0000 (0:00:00.287) 0:00:08.382 ********** 2026-05-21 22:45:24.777607 | controller | ok: [controller] 2026-05-21 22:45:24.777767 | controller | 2026-05-21 22:45:24.777974 | controller | TASK [Install plugin] ********************************************************** 2026-05-21 22:45:24.778177 | controller | Thursday 21 May 2026 22:45:24 +0000 (0:00:00.292) 0:00:08.675 ********** 2026-05-21 22:45:24.826236 | controller | included: vexxhost.containers.download_artifact for controller 2026-05-21 22:45:24.826407 | controller | 2026-05-21 22:45:24.826612 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-05-21 22:45:24.827021 | controller | Thursday 21 May 2026 22:45:24 +0000 (0:00:00.049) 0:00:08.724 ********** 2026-05-21 22:45:24.872562 | controller | ok: [controller] => { 2026-05-21 22:45:24.872813 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-05-21 22:45:24.873041 | controller | } 2026-05-21 22:45:24.873256 | controller | 2026-05-21 22:45:24.873524 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-05-21 22:45:24.873795 | controller | Thursday 21 May 2026 22:45:24 +0000 (0:00:00.045) 0:00:08.769 ********** 2026-05-21 22:45:25.599382 | controller | changed: [controller] 2026-05-21 22:45:25.599433 | controller | 2026-05-21 22:45:25.599530 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-05-21 22:45:25.599621 | controller | Thursday 21 May 2026 22:45:25 +0000 (0:00:00.727) 0:00:09.496 ********** 2026-05-21 22:45:27.610451 | controller | changed: [controller] 2026-05-21 22:45:27.610605 | controller | 2026-05-21 22:45:27.610798 | controller | PLAY RECAP ********************************************************************* 2026-05-21 22:45:27.611053 | controller | controller : ok=16 changed=7 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-05-21 22:45:27.611227 | controller | 2026-05-21 22:45:27.611393 | controller | 2026-05-21 22:45:27.611578 | controller | TASKS RECAP ******************************************************************** 2026-05-21 22:45:27.611773 | controller | Thursday 21 May 2026 22:45:27 +0000 (0:00:02.011) 0:00:11.508 ********** 2026-05-21 22:45:27.611950 | controller | =============================================================================== 2026-05-21 22:45:27.612165 | controller | vexxhost.containers.package : Update state for tar ---------------------- 2.02s 2026-05-21 22:45:27.612351 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.01s 2026-05-21 22:45:27.612542 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.98s 2026-05-21 22:45:27.612723 | controller | Gathering Facts --------------------------------------------------------- 1.03s 2026-05-21 22:45:27.612908 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.73s 2026-05-21 22:45:27.613095 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.73s 2026-05-21 22:45:27.613280 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.50s 2026-05-21 22:45:27.613467 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.48s 2026-05-21 22:45:27.613654 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.48s 2026-05-21 22:45:27.613844 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.42s 2026-05-21 22:45:27.614033 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.40s 2026-05-21 22:45:27.614233 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.29s 2026-05-21 22:45:27.614430 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.29s 2026-05-21 22:45:27.614618 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-05-21 22:45:27.614803 | controller | Install plugin ---------------------------------------------------------- 0.05s 2026-05-21 22:45:27.615024 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-05-21 22:45:27.714487 | controller | INFO [helm > converge] Executed: Successful 2026-05-21 22:45:27.723954 | controller | INFO [helm > idempotence] Executing 2026-05-21 22:45:28.638032 | controller | 2026-05-21 22:45:28.638263 | controller | PLAY [Converge] **************************************************************** 2026-05-21 22:45:28.638523 | controller | 2026-05-21 22:45:28.638770 | controller | TASK [Gathering Facts] ********************************************************* 2026-05-21 22:45:28.639166 | controller | Thursday 21 May 2026 22:45:28 +0000 (0:00:00.014) 0:00:00.014 ********** 2026-05-21 22:45:30.698916 | 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-21 22:45:30.703136 | controller | ok: [controller] 2026-05-21 22:45:30.703320 | controller | 2026-05-21 22:45:30.703529 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-05-21 22:45:30.703814 | controller | Thursday 21 May 2026 22:45:30 +0000 (0:00:02.065) 0:00:02.079 ********** 2026-05-21 22:45:31.189119 | controller | ok: [controller] 2026-05-21 22:45:31.190928 | controller | 2026-05-21 22:45:31.190959 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-05-21 22:45:31.190967 | controller | Thursday 21 May 2026 22:45:31 +0000 (0:00:00.485) 0:00:02.565 ********** 2026-05-21 22:45:32.190360 | controller | ok: [controller] 2026-05-21 22:45:32.190398 | controller | 2026-05-21 22:45:32.190408 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-05-21 22:45:32.190416 | controller | Thursday 21 May 2026 22:45:32 +0000 (0:00:01.000) 0:00:03.565 ********** 2026-05-21 22:45:32.626538 | controller | ok: [controller] 2026-05-21 22:45:32.626583 | controller | 2026-05-21 22:45:32.626699 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-05-21 22:45:32.626824 | controller | Thursday 21 May 2026 22:45:32 +0000 (0:00:00.436) 0:00:04.002 ********** 2026-05-21 22:45:32.670923 | controller | ok: [controller] => { 2026-05-21 22:45:32.670967 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-05-21 22:45:32.670976 | controller | } 2026-05-21 22:45:32.670985 | controller | 2026-05-21 22:45:32.670994 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-05-21 22:45:32.671002 | controller | Thursday 21 May 2026 22:45:32 +0000 (0:00:00.043) 0:00:04.046 ********** 2026-05-21 22:45:33.211149 | controller | ok: [controller] 2026-05-21 22:45:33.211249 | controller | 2026-05-21 22:45:33.211382 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-05-21 22:45:33.211513 | controller | Thursday 21 May 2026 22:45:33 +0000 (0:00:00.538) 0:00:04.584 ********** 2026-05-21 22:45:34.987887 | controller | ok: [controller] 2026-05-21 22:45:34.987944 | controller | 2026-05-21 22:45:34.988022 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-05-21 22:45:34.988130 | controller | Thursday 21 May 2026 22:45:34 +0000 (0:00:01.779) 0:00:06.364 ********** 2026-05-21 22:45:35.491172 | controller | ok: [controller] 2026-05-21 22:45:35.491224 | controller | 2026-05-21 22:45:35.491316 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-05-21 22:45:35.491406 | controller | Thursday 21 May 2026 22:45:35 +0000 (0:00:00.501) 0:00:06.865 ********** 2026-05-21 22:45:35.891475 | controller | ok: [controller] 2026-05-21 22:45:35.891497 | controller | 2026-05-21 22:45:35.891503 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-05-21 22:45:35.891508 | controller | Thursday 21 May 2026 22:45:35 +0000 (0:00:00.401) 0:00:07.267 ********** 2026-05-21 22:45:36.335509 | controller | ok: [controller] 2026-05-21 22:45:36.335801 | controller | 2026-05-21 22:45:36.336094 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-05-21 22:45:36.336360 | controller | Thursday 21 May 2026 22:45:36 +0000 (0:00:00.441) 0:00:07.708 ********** 2026-05-21 22:45:36.642834 | controller | ok: [controller] 2026-05-21 22:45:36.642855 | controller | 2026-05-21 22:45:36.642860 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-05-21 22:45:36.642864 | controller | Thursday 21 May 2026 22:45:36 +0000 (0:00:00.307) 0:00:08.016 ********** 2026-05-21 22:45:36.931680 | controller | ok: [controller] 2026-05-21 22:45:36.931720 | controller | 2026-05-21 22:45:36.931807 | controller | TASK [Install plugin] ********************************************************** 2026-05-21 22:45:36.931896 | controller | Thursday 21 May 2026 22:45:36 +0000 (0:00:00.291) 0:00:08.308 ********** 2026-05-21 22:45:36.986052 | controller | included: vexxhost.containers.download_artifact for controller 2026-05-21 22:45:36.986088 | controller | 2026-05-21 22:45:36.986205 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-05-21 22:45:36.986338 | controller | Thursday 21 May 2026 22:45:36 +0000 (0:00:00.054) 0:00:08.362 ********** 2026-05-21 22:45:37.027339 | controller | ok: [controller] => { 2026-05-21 22:45:37.027425 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-05-21 22:45:37.027539 | controller | } 2026-05-21 22:45:37.027648 | controller | 2026-05-21 22:45:37.027780 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-05-21 22:45:37.027957 | controller | Thursday 21 May 2026 22:45:37 +0000 (0:00:00.041) 0:00:08.403 ********** 2026-05-21 22:45:37.455270 | controller | ok: [controller] 2026-05-21 22:45:37.455322 | controller | 2026-05-21 22:45:37.455477 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-05-21 22:45:37.455603 | controller | Thursday 21 May 2026 22:45:37 +0000 (0:00:00.426) 0:00:08.830 ********** 2026-05-21 22:45:39.091197 | controller | ok: [controller] 2026-05-21 22:45:39.091245 | controller | 2026-05-21 22:45:39.091386 | controller | PLAY RECAP ********************************************************************* 2026-05-21 22:45:39.091525 | controller | controller : ok=16 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-05-21 22:45:39.091639 | controller | 2026-05-21 22:45:39.093737 | controller | 2026-05-21 22:45:39.093757 | controller | TASKS RECAP ******************************************************************** 2026-05-21 22:45:39.093762 | controller | Thursday 21 May 2026 22:45:39 +0000 (0:00:01.637) 0:00:10.468 ********** 2026-05-21 22:45:39.093765 | controller | =============================================================================== 2026-05-21 22:45:39.093769 | controller | Gathering Facts --------------------------------------------------------- 2.07s 2026-05-21 22:45:39.093772 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.78s 2026-05-21 22:45:39.093775 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.64s 2026-05-21 22:45:39.093778 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.00s 2026-05-21 22:45:39.093781 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.54s 2026-05-21 22:45:39.093784 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.50s 2026-05-21 22:45:39.093788 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.49s 2026-05-21 22:45:39.093791 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.44s 2026-05-21 22:45:39.093795 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.44s 2026-05-21 22:45:39.093798 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.43s 2026-05-21 22:45:39.093807 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.40s 2026-05-21 22:45:39.093810 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.31s 2026-05-21 22:45:39.093814 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.29s 2026-05-21 22:45:39.093817 | controller | Install plugin ---------------------------------------------------------- 0.05s 2026-05-21 22:45:39.093820 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s 2026-05-21 22:45:39.093824 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s 2026-05-21 22:45:39.206721 | controller | INFO [helm > idempotence] Executed: Successful 2026-05-21 22:45:39.218378 | controller | INFO [helm > side_effect] Executing 2026-05-21 22:45:39.218727 | controller | WARNING [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-05-21 22:45:39.224164 | controller | INFO [helm > verify] Executing 2026-05-21 22:45:40.036796 | controller | 2026-05-21 22:45:40.037141 | controller | PLAY [Verify] ****************************************************************** 2026-05-21 22:45:40.037382 | controller | 2026-05-21 22:45:40.037634 | controller | TASK [Gathering Facts] ********************************************************* 2026-05-21 22:45:40.037886 | controller | Thursday 21 May 2026 22:45:40 +0000 (0:00:00.009) 0:00:00.009 ********** 2026-05-21 22:45:42.104822 | 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-21 22:45:42.112951 | controller | ok: [controller] 2026-05-21 22:45:42.113207 | controller | 2026-05-21 22:45:42.113479 | controller | TASK [Get the current Helm version] ******************************************** 2026-05-21 22:45:42.113764 | controller | Thursday 21 May 2026 22:45:42 +0000 (0:00:02.076) 0:00:02.086 ********** 2026-05-21 22:45:42.582928 | controller | changed: [controller] 2026-05-21 22:45:42.583261 | controller | 2026-05-21 22:45:42.583523 | controller | TASK [Assert Helm version] ***************************************************** 2026-05-21 22:45:42.583769 | controller | Thursday 21 May 2026 22:45:42 +0000 (0:00:00.469) 0:00:02.555 ********** 2026-05-21 22:45:42.613913 | controller | ok: [controller] => { 2026-05-21 22:45:42.614192 | controller | "changed": false, 2026-05-21 22:45:42.614454 | controller | "msg": "All assertions passed" 2026-05-21 22:45:42.614706 | controller | } 2026-05-21 22:45:42.614984 | controller | 2026-05-21 22:45:42.615271 | controller | PLAY RECAP ********************************************************************* 2026-05-21 22:45:42.615554 | controller | controller : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-05-21 22:45:42.615792 | controller | 2026-05-21 22:45:42.616026 | controller | 2026-05-21 22:45:42.616301 | controller | TASKS RECAP ******************************************************************** 2026-05-21 22:45:42.616568 | controller | Thursday 21 May 2026 22:45:42 +0000 (0:00:00.031) 0:00:02.587 ********** 2026-05-21 22:45:42.616815 | controller | =============================================================================== 2026-05-21 22:45:42.617072 | controller | Gathering Facts --------------------------------------------------------- 2.08s 2026-05-21 22:45:42.617325 | controller | Get the current Helm version -------------------------------------------- 0.47s 2026-05-21 22:45:42.617577 | controller | Assert Helm version ----------------------------------------------------- 0.03s 2026-05-21 22:45:42.729632 | controller | INFO [helm > verify] Executed: Successful 2026-05-21 22:45:42.740335 | controller | INFO [helm > cleanup] Executing 2026-05-21 22:45:42.740763 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-05-21 22:45:42.902143 | controller | INFO [helm > destroy] Executing 2026-05-21 22:45:42.902331 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-05-21 22:45:42.902497 | controller | INFO [helm > destroy] Executed: Successful 2026-05-21 22:45:42.903072 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-05-21 22:45:43.228115 | controller | ok: Runtime: 0:04:47.924056 2026-05-21 22:45:43.235319 | 2026-05-21 22:45:43.235371 | PLAY RECAP 2026-05-21 22:45:43.235417 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-21 22:45:43.235440 | 2026-05-21 22:45:43.355129 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-05-21 22:45:43.358452 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-05-21 22:45:43.974301 | 2026-05-21 22:45:43.974448 | PLAY [all] 2026-05-21 22:45:43.985496 | 2026-05-21 22:45:43.985582 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-05-21 22:45:44.362479 | controller | changed 2026-05-21 22:45:44.367472 | 2026-05-21 22:45:44.367577 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-05-21 22:45:44.768400 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-05-21 22:45:44.768526 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-05-21 22:45:44.776438 | controller | environment: line 1: kubectl: command not found 2026-05-21 22:45:44.778091 | controller | environment: line 1: kubectl: command not found 2026-05-21 22:45:44.778649 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-05-21 22:45:44.780139 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-05-21 22:45:44.784929 | controller | environment: line 1: kubectl: command not found 2026-05-21 22:45:44.786075 | controller | environment: line 1: kubectl: command not found 2026-05-21 22:45:44.787369 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-05-21 22:45:44.787436 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-05-21 22:45:44.790972 | controller | environment: line 1: kubectl: command not found 2026-05-21 22:45:44.793072 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-05-21 22:45:44.898728 | controller | ok: Runtime: 0:00:00.040530 2026-05-21 22:45:44.905578 | 2026-05-21 22:45:44.905669 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-05-21 22:45:45.148746 | controller | changed 2026-05-21 22:45:45.154481 | 2026-05-21 22:45:45.154566 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-05-21 22:45:45.402720 | controller | environment: line 5: kubectl: command not found 2026-05-21 22:45:45.404177 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-05-21 22:45:45.404386 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-05-21 22:45:45.404530 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-05-21 22:45:45.685426 | controller | ok: Runtime: 0:00:00.011923 2026-05-21 22:45:45.693119 | 2026-05-21 22:45:45.693187 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-05-21 22:45:46.307482 | controller | changed: 2026-05-21 22:45:46.307665 | controller | created directory /var/lib/zuul/builds/576e727155df4c0bbbc05f9acedeec61/work/logs/controller 2026-05-21 22:45:46.307696 | controller | cd+++++++++ objects/ 2026-05-21 22:45:46.307720 | controller | cd+++++++++ objects/cluster/ 2026-05-21 22:45:46.307744 | controller | cd+++++++++ objects/namespaced/ 2026-05-21 22:45:46.314731 | 2026-05-21 22:45:46.314796 | TASK [gather-pod-logs : creating directory for pod logs] 2026-05-21 22:45:46.552041 | controller | changed 2026-05-21 22:45:46.556754 | 2026-05-21 22:45:46.556821 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-05-21 22:45:46.778440 | controller | changed 2026-05-21 22:45:46.782825 | 2026-05-21 22:45:46.782905 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-05-21 22:45:47.016917 | controller | environment: line 3: kubectl: command not found 2026-05-21 22:45:47.355935 | controller | ok: Runtime: 0:00:00.010062 2026-05-21 22:45:47.361248 | 2026-05-21 22:45:47.361327 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-05-21 22:45:47.890458 | controller | changed: 2026-05-21 22:45:47.890670 | controller | cd+++++++++ pod-logs/ 2026-05-21 22:45:47.890709 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-05-21 22:45:47.900973 | 2026-05-21 22:45:47.901053 | LOOP [helm-release-status : creating directory for helm release status] 2026-05-21 22:45:48.133692 | controller | changed: "values" 2026-05-21 22:45:48.358804 | controller | changed: "releases" 2026-05-21 22:45:48.416690 | 2026-05-21 22:45:48.416867 | TASK [helm-release-status : Gather get release status for helm charts] 2026-05-21 22:45:48.681564 | controller | /bin/bash: line 3: kubectl: command not found 2026-05-21 22:45:48.952434 | controller | ok: Runtime: 0:00:00.006512 2026-05-21 22:45:48.958382 | 2026-05-21 22:45:48.958453 | TASK [helm-release-status : Downloads logs to executor] 2026-05-21 22:45:49.461071 | controller | changed: 2026-05-21 22:45:49.461324 | controller | cd+++++++++ helm/ 2026-05-21 22:45:49.461354 | controller | cd+++++++++ helm/releases/ 2026-05-21 22:45:49.461384 | controller | cd+++++++++ helm/values/ 2026-05-21 22:45:49.470419 | 2026-05-21 22:45:49.470599 | PLAY RECAP 2026-05-21 22:45:49.470704 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-21 22:45:49.470756 | 2026-05-21 22:45:49.620282 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-05-21 22:45:49.622362 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-05-21 22:45:50.226901 | 2026-05-21 22:45:50.247022 | PLAY [all] 2026-05-21 22:45:50.266993 | 2026-05-21 22:45:50.267400 | TASK [fetch-output : Set log path for multiple nodes] 2026-05-21 22:45:50.317362 | controller | skipping: Conditional result was False 2026-05-21 22:45:50.325915 | 2026-05-21 22:45:50.326078 | TASK [fetch-output : Set log path for single node] 2026-05-21 22:45:50.368419 | controller | ok 2026-05-21 22:45:50.376105 | 2026-05-21 22:45:50.376175 | LOOP [fetch-output : Ensure local output dirs] 2026-05-21 22:45:50.776237 | controller -> localhost | ok: "/var/lib/zuul/builds/576e727155df4c0bbbc05f9acedeec61/work/logs" 2026-05-21 22:45:51.374258 | controller -> localhost | changed: "/var/lib/zuul/builds/576e727155df4c0bbbc05f9acedeec61/work/artifacts" 2026-05-21 22:45:51.885722 | controller -> localhost | changed: "/var/lib/zuul/builds/576e727155df4c0bbbc05f9acedeec61/work/docs" 2026-05-21 22:45:51.904261 | 2026-05-21 22:45:51.904398 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-21 22:45:52.592028 | controller | changed: .d..t...... ./ 2026-05-21 22:45:52.592262 | controller | changed: All items complete 2026-05-21 22:45:52.592301 | 2026-05-21 22:45:53.040309 | controller | changed: .d..t...... ./ 2026-05-21 22:45:53.598205 | controller | changed: .d..t...... ./ 2026-05-21 22:45:53.622097 | 2026-05-21 22:45:53.622249 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-21 22:45:54.418707 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.005086 2026-05-21 22:45:55.001069 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.008775 2026-05-21 22:45:55.025364 | 2026-05-21 22:45:55.025497 | PLAY [all] 2026-05-21 22:45:55.032593 | 2026-05-21 22:45:55.032683 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-21 22:45:55.511062 | controller | changed 2026-05-21 22:45:55.517190 | 2026-05-21 22:45:55.517261 | PLAY RECAP 2026-05-21 22:45:55.517319 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-21 22:45:55.517349 | 2026-05-21 22:45:55.651965 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-05-21 22:45:55.654942 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-21 22:45:56.256997 | 2026-05-21 22:45:56.257151 | PLAY [localhost] 2026-05-21 22:45:56.267623 | 2026-05-21 22:45:56.267697 | TASK [Generate Zuul manifest] 2026-05-21 22:45:56.289629 | localhost | ok 2026-05-21 22:45:56.306210 | 2026-05-21 22:45:56.306292 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-21 22:45:56.857616 | localhost | changed 2026-05-21 22:45:56.870859 | 2026-05-21 22:45:56.870944 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-21 22:45:56.933638 | localhost | ok 2026-05-21 22:45:56.943287 | 2026-05-21 22:45:56.943379 | TASK [Upload logs] 2026-05-21 22:45:56.964848 | localhost | ok 2026-05-21 22:45:57.024160 | 2026-05-21 22:45:57.024315 | TASK [Set zuul-log-path fact] 2026-05-21 22:45:57.046333 | localhost | ok 2026-05-21 22:45:57.061383 | 2026-05-21 22:45:57.061448 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-21 22:45:57.093731 | localhost | ok 2026-05-21 22:45:57.102040 | 2026-05-21 22:45:57.102103 | TASK [upload-logs : Create log directories] 2026-05-21 22:45:57.602345 | localhost | changed 2026-05-21 22:45:57.609092 | 2026-05-21 22:45:57.609194 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-21 22:45:58.022247 | localhost -> localhost | ok: Runtime: 0:00:00.006193 2026-05-21 22:45:58.029769 | 2026-05-21 22:45:58.029865 | TASK [upload-logs : Upload logs to log server] 2026-05-21 22:45:58.620401 | localhost | Output suppressed because no_log was given 2026-05-21 22:45:58.658853 | 2026-05-21 22:45:58.658987 | LOOP [upload-logs : Compress console log and json output] 2026-05-21 22:45:58.711937 | localhost | skipping: Conditional result was False 2026-05-21 22:45:58.766245 | localhost | skipping: Conditional result was False 2026-05-21 22:45:58.784740 | 2026-05-21 22:45:58.784927 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-21 22:45:58.833710 | localhost | skipping: Conditional result was False 2026-05-21 22:45:58.834124 | 2026-05-21 22:45:58.837719 | localhost | skipping: Conditional result was False 2026-05-21 22:45:58.849319 | 2026-05-21 22:45:58.849465 | LOOP [upload-logs : Upload console log and json output]