2026-05-20 21:18:58.210704 | Job console starting 2026-05-20 21:18:58.280894 | Updating git repos 2026-05-20 21:18:58.442804 | Cloning repos into workspace 2026-05-20 21:19:54.429424 | Restoring repo states 2026-05-20 21:19:54.443185 | Merging changes 2026-05-20 21:20:07.635797 | Checking out repos 2026-05-20 21:20:11.603550 | Preparing playbooks 2026-05-20 21:20:25.175682 | Running Ansible setup 2026-05-20 21:20:29.065401 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-05-20 21:20:29.681890 | 2026-05-20 21:20:30.327739 | PLAY [localhost] 2026-05-20 21:20:30.342519 | 2026-05-20 21:20:30.342650 | TASK [Gathering Facts] 2026-05-20 21:20:31.262593 | localhost | ok 2026-05-20 21:20:31.269803 | 2026-05-20 21:20:31.269887 | TASK [Setup log path fact] 2026-05-20 21:20:31.290376 | localhost | ok 2026-05-20 21:20:31.303428 | 2026-05-20 21:20:31.303506 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-20 21:20:31.334432 | localhost | ok 2026-05-20 21:20:31.342792 | 2026-05-20 21:20:31.342882 | TASK [emit-job-header : Print job information] 2026-05-20 21:20:31.385588 | # Job Information 2026-05-20 21:20:31.385873 | Ansible Version: 2.16.18 2026-05-20 21:20:31.385952 | Job: ansible-collection-kubernetes-molecule-helm 2026-05-20 21:20:31.386007 | Pipeline: check 2026-05-20 21:20:31.386056 | Executor: 2d72f0692154 2026-05-20 21:20:31.386103 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/275 2026-05-20 21:20:31.386155 | Event ID: 5bd91320-5491-11f1-9358-8e7f787ff787 2026-05-20 21:20:31.390350 | 2026-05-20 21:20:31.390442 | LOOP [emit-job-header : Print node information] 2026-05-20 21:20:31.530954 | localhost | ok: 2026-05-20 21:20:31.531251 | localhost | # Node Information 2026-05-20 21:20:31.531317 | localhost | Inventory Hostname: controller 2026-05-20 21:20:31.531357 | localhost | Hostname: np0000175522 2026-05-20 21:20:31.531394 | localhost | Username: zuul 2026-05-20 21:20:31.531436 | localhost | Distro: Debian 13.4 2026-05-20 21:20:31.531471 | localhost | Provider: yul1 2026-05-20 21:20:31.531504 | localhost | Region: ca-ymq-1 2026-05-20 21:20:31.531537 | localhost | Label: debian-trixie 2026-05-20 21:20:31.531572 | localhost | Product Name: OpenStack Nova 2026-05-20 21:20:31.531618 | localhost | Interface IP: 199.19.213.236 2026-05-20 21:20:31.545681 | 2026-05-20 21:20:31.545975 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-20 21:20:31.936667 | localhost -> localhost | changed 2026-05-20 21:20:31.942391 | 2026-05-20 21:20:31.942549 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-20 21:20:32.886055 | localhost -> localhost | changed 2026-05-20 21:20:32.896464 | 2026-05-20 21:20:32.896544 | PLAY [all] 2026-05-20 21:20:32.903545 | 2026-05-20 21:20:32.903648 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-20 21:20:33.141648 | controller -> localhost | ok 2026-05-20 21:20:33.146948 | 2026-05-20 21:20:33.147027 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-20 21:20:33.176997 | controller | ok 2026-05-20 21:20:33.197615 | controller | included: /var/lib/zuul/builds/760b0f53df8e44989d65b8c5f61a98f6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-20 21:20:33.205163 | 2026-05-20 21:20:33.205329 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-20 21:20:34.809338 | controller -> localhost | Generating public/private rsa key pair. 2026-05-20 21:20:34.809538 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/760b0f53df8e44989d65b8c5f61a98f6/work/760b0f53df8e44989d65b8c5f61a98f6_id_rsa 2026-05-20 21:20:34.809570 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/760b0f53df8e44989d65b8c5f61a98f6/work/760b0f53df8e44989d65b8c5f61a98f6_id_rsa.pub 2026-05-20 21:20:34.809593 | controller -> localhost | The key fingerprint is: 2026-05-20 21:20:34.809615 | controller -> localhost | SHA256:EynGl2W4pAiatANQeT504ON2590VSBiKHLsoCoAI1fk zuul-build-sshkey 2026-05-20 21:20:34.809651 | controller -> localhost | The key's randomart image is: 2026-05-20 21:20:34.809672 | controller -> localhost | +---[RSA 3072]----+ 2026-05-20 21:20:34.809697 | controller -> localhost | |+ooo.o. .+o. | 2026-05-20 21:20:34.809719 | controller -> localhost | |=.o.=o.+o*.. . | 2026-05-20 21:20:34.809740 | controller -> localhost | |*o.=o+Bo*. . . | 2026-05-20 21:20:34.809760 | controller -> localhost | |+o .++E+.. . | 2026-05-20 21:20:34.809780 | controller -> localhost | |. o +.o S . | 2026-05-20 21:20:34.809800 | controller -> localhost | |.. o . o o . . | 2026-05-20 21:20:34.809819 | controller -> localhost | |. . . . | 2026-05-20 21:20:34.809839 | controller -> localhost | | | 2026-05-20 21:20:34.809862 | controller -> localhost | | | 2026-05-20 21:20:34.809882 | controller -> localhost | +----[SHA256]-----+ 2026-05-20 21:20:34.809937 | controller -> localhost | ok: Runtime: 0:00:01.120479 2026-05-20 21:20:34.814213 | 2026-05-20 21:20:34.814275 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-20 21:20:34.843769 | controller | ok 2026-05-20 21:20:34.854612 | controller | included: /var/lib/zuul/builds/760b0f53df8e44989d65b8c5f61a98f6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-20 21:20:34.861470 | 2026-05-20 21:20:34.861541 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-20 21:20:34.897581 | controller | skipping: Conditional result was False 2026-05-20 21:20:34.907663 | 2026-05-20 21:20:34.907815 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-20 21:20:35.542624 | controller | changed 2026-05-20 21:20:35.547224 | 2026-05-20 21:20:35.547289 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-20 21:20:35.763966 | controller | ok 2026-05-20 21:20:35.770344 | 2026-05-20 21:20:35.770438 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-20 21:20:36.326125 | controller | changed 2026-05-20 21:20:36.330252 | 2026-05-20 21:20:36.330317 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-20 21:20:36.873265 | controller | changed 2026-05-20 21:20:36.877735 | 2026-05-20 21:20:36.877798 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-20 21:20:36.903214 | controller | skipping: Conditional result was False 2026-05-20 21:20:36.912286 | 2026-05-20 21:20:36.912425 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-20 21:20:37.304324 | controller -> localhost | changed 2026-05-20 21:20:37.317973 | 2026-05-20 21:20:37.318193 | TASK [add-build-sshkey : Add back temp key] 2026-05-20 21:20:37.649274 | controller -> localhost | Identity added: /var/lib/zuul/builds/760b0f53df8e44989d65b8c5f61a98f6/work/760b0f53df8e44989d65b8c5f61a98f6_id_rsa (zuul-build-sshkey) 2026-05-20 21:20:37.649607 | controller -> localhost | ok: Runtime: 0:00:00.016284 2026-05-20 21:20:37.656066 | 2026-05-20 21:20:37.656134 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-20 21:20:38.001375 | controller | ok 2026-05-20 21:20:38.005301 | 2026-05-20 21:20:38.005365 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-20 21:20:38.029977 | controller | skipping: Conditional result was False 2026-05-20 21:20:38.038299 | 2026-05-20 21:20:38.038365 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-05-20 21:20:38.402300 | controller | ok 2026-05-20 21:20:38.409864 | 2026-05-20 21:20:38.409939 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-05-20 21:20:39.406037 | controller | Output suppressed because no_log was given 2026-05-20 21:20:39.422050 | 2026-05-20 21:20:39.422257 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-05-20 21:20:39.657920 | controller | ok: "logs" 2026-05-20 21:20:39.658273 | controller | ok: All items complete 2026-05-20 21:20:39.658314 | 2026-05-20 21:20:39.837031 | controller | ok: "artifacts" 2026-05-20 21:20:40.028501 | controller | ok: "docs" 2026-05-20 21:20:40.039289 | 2026-05-20 21:20:40.039435 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-05-20 21:20:40.268181 | controller | changed: "logs" 2026-05-20 21:20:40.458702 | controller | changed: "artifacts" 2026-05-20 21:20:40.639392 | controller | changed: "docs" 2026-05-20 21:20:40.661313 | 2026-05-20 21:20:40.661431 | PLAY RECAP 2026-05-20 21:20:40.661479 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-05-20 21:20:40.661507 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-20 21:20:40.661530 | 2026-05-20 21:20:40.855754 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-05-20 21:20:40.858846 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-05-20 21:20:41.514888 | 2026-05-20 21:20:41.515456 | PLAY [all] 2026-05-20 21:20:41.525680 | 2026-05-20 21:20:41.525780 | TASK [setup-uv : Extract archive] 2026-05-20 21:20:43.959373 | controller | changed 2026-05-20 21:20:43.965783 | 2026-05-20 21:20:43.965869 | TASK [setup-uv : Print version] 2026-05-20 21:20:44.326175 | controller | uv 0.8.13 2026-05-20 21:20:44.494202 | controller | ok: Runtime: 0:00:00.019961 2026-05-20 21:20:44.501773 | 2026-05-20 21:20:44.501848 | TASK [Install Ansible collection siblings] 2026-05-20 21:20:44.969224 | controller | ok: 2026-05-20 21:20:44.969479 | controller | Skipping ansible.posix: no checked-out sibling 2026-05-20 21:20:44.969520 | controller | Skipping community.crypto: no checked-out sibling 2026-05-20 21:20:44.969552 | controller | Skipping community.general: no checked-out sibling 2026-05-20 21:20:44.969582 | controller | Skipping kubernetes.core: no checked-out sibling 2026-05-20 21:20:44.969619 | controller | Skipping vexxhost.containers: no checked-out sibling 2026-05-20 21:20:44.972007 | 2026-05-20 21:20:44.972072 | PLAY RECAP 2026-05-20 21:20:44.972137 | controller | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-20 21:20:44.972169 | 2026-05-20 21:20:45.120483 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-05-20 21:20:45.123685 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-05-20 21:20:45.725087 | 2026-05-20 21:20:45.725251 | PLAY [all] 2026-05-20 21:20:45.735038 | 2026-05-20 21:20:45.735109 | TASK [Update apt cache] 2026-05-20 21:20:50.245389 | controller | ok 2026-05-20 21:20:50.251040 | 2026-05-20 21:20:50.251147 | TASK [Disable firewalld] 2026-05-20 21:20:50.268087 | controller | skipping: Conditional result was False 2026-05-20 21:20:50.275963 | 2026-05-20 21:20:50.276071 | TASK [Install "jq" for log collection] 2026-05-20 21:20:52.302180 | controller | changed 2026-05-20 21:20:52.304696 | 2026-05-20 21:20:52.304779 | PLAY RECAP 2026-05-20 21:20:52.304845 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-20 21:20:52.304878 | 2026-05-20 21:20:52.431671 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-05-20 21:20:52.434625 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-05-20 21:20:53.027297 | 2026-05-20 21:20:53.027425 | PLAY [all] 2026-05-20 21:20:53.037186 | 2026-05-20 21:20:53.037261 | TASK [Copy inventory file for Zuul] 2026-05-20 21:20:54.003983 | controller | changed 2026-05-20 21:20:54.010028 | 2026-05-20 21:20:54.010133 | TASK [Switch "ansible_host" to private IP] 2026-05-20 21:20:54.369631 | controller | changed: 1 replacements made 2026-05-20 21:20:54.374876 | 2026-05-20 21:20:54.374945 | TASK [Run Molecule scenario] 2026-05-20 21:20:54.814902 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-05-20 21:20:54.815016 | controller | Creating virtual environment at: .venv 2026-05-20 21:20:55.088586 | controller | Downloading pygments (1.2MiB) 2026-05-20 21:20:55.088791 | controller | Downloading ansible-core (2.3MiB) 2026-05-20 21:20:55.089864 | controller | Downloading cryptography (4.3MiB) 2026-05-20 21:20:55.262681 | controller | Downloading cryptography 2026-05-20 21:20:55.317245 | controller | Downloading pygments 2026-05-20 21:20:55.499432 | controller | Downloading ansible-core 2026-05-20 21:20:55.550026 | controller | Installed 36 packages in 49ms 2026-05-20 21:20:56.211691 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-05-20 21:20:56.211761 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-05-20 21:20:57.055280 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-05-20 21:20:57.055351 | controller | INFO default scenario not found, disabling shared state. 2026-05-20 21:20:57.055539 | controller | INFO [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-05-20 21:20:57.055642 | controller | INFO [helm > prerun] Performing prerun with role_name_check=0... 2026-05-20 21:21:14.160250 | controller | INFO [helm > dependency] Executing 2026-05-20 21:21:14.160324 | controller | WARNING [helm > dependency] Missing roles requirements file: requirements.yml 2026-05-20 21:21:14.160334 | controller | WARNING [helm > dependency] Missing collections requirements file: collections.yml 2026-05-20 21:21:14.160367 | controller | WARNING [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-05-20 21:21:14.166026 | controller | INFO [helm > cleanup] Executing 2026-05-20 21:21:14.166376 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-05-20 21:21:14.172057 | controller | INFO [helm > destroy] Executing 2026-05-20 21:21:14.172127 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-05-20 21:21:14.172247 | controller | INFO [helm > destroy] Executed: Successful 2026-05-20 21:21:14.177588 | controller | INFO [helm > syntax] Executing 2026-05-20 21:21:15.105134 | controller | 2026-05-20 21:21:15.105183 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml 2026-05-20 21:21:15.187464 | controller | INFO [helm > syntax] Executed: Successful 2026-05-20 21:21:15.196904 | controller | INFO [helm > create] Executing 2026-05-20 21:21:15.199125 | controller | WARNING [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-05-20 21:21:15.204677 | controller | INFO [helm > prepare] Executing 2026-05-20 21:21:16.075495 | controller | 2026-05-20 21:21:16.075603 | controller | PLAY [Prepare] ***************************************************************** 2026-05-20 21:21:16.075788 | controller | 2026-05-20 21:21:16.076013 | controller | TASK [Gathering Facts] ********************************************************* 2026-05-20 21:21:16.076219 | controller | Wednesday 20 May 2026 21:21:16 +0000 (0:00:00.031) 0:00:00.031 ********* 2026-05-20 21:21:18.364046 | 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-20 21:21:18.368948 | controller | ok: [controller] 2026-05-20 21:21:18.369058 | controller | 2026-05-20 21:21:18.369183 | controller | TASK [Install Debian packages] ************************************************* 2026-05-20 21:21:18.369310 | controller | Wednesday 20 May 2026 21:21:18 +0000 (0:00:02.294) 0:00:02.325 ********* 2026-05-20 21:21:19.808277 | controller | ok: [controller] 2026-05-20 21:21:19.808312 | controller | 2026-05-20 21:21:19.808317 | controller | PLAY RECAP ********************************************************************* 2026-05-20 21:21:19.808322 | controller | controller : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-05-20 21:21:19.808325 | controller | 2026-05-20 21:21:19.808328 | controller | 2026-05-20 21:21:19.808332 | controller | TASKS RECAP ******************************************************************** 2026-05-20 21:21:19.808348 | controller | Wednesday 20 May 2026 21:21:19 +0000 (0:00:01.432) 0:00:03.757 ********* 2026-05-20 21:21:19.808351 | controller | =============================================================================== 2026-05-20 21:21:19.808354 | controller | Gathering Facts --------------------------------------------------------- 2.29s 2026-05-20 21:21:19.808358 | controller | Install Debian packages ------------------------------------------------- 1.43s 2026-05-20 21:21:19.910259 | controller | INFO [helm > prepare] Executed: Successful 2026-05-20 21:21:19.917797 | controller | INFO [helm > converge] Executing 2026-05-20 21:21:20.741098 | controller | 2026-05-20 21:21:20.741146 | controller | PLAY [Converge] **************************************************************** 2026-05-20 21:21:20.741156 | controller | 2026-05-20 21:21:20.741165 | controller | TASK [Gathering Facts] ********************************************************* 2026-05-20 21:21:20.741172 | controller | Wednesday 20 May 2026 21:21:20 +0000 (0:00:00.013) 0:00:00.013 ********* 2026-05-20 21:21:21.861191 | 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-20 21:21:21.867298 | controller | ok: [controller] 2026-05-20 21:21:21.867321 | controller | 2026-05-20 21:21:21.867330 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-05-20 21:21:21.867338 | controller | Wednesday 20 May 2026 21:21:21 +0000 (0:00:01.126) 0:00:01.140 ********* 2026-05-20 21:21:22.352293 | controller | ok: [controller] 2026-05-20 21:21:22.352781 | controller | 2026-05-20 21:21:22.353049 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-05-20 21:21:22.353302 | controller | Wednesday 20 May 2026 21:21:22 +0000 (0:00:00.485) 0:00:01.625 ********* 2026-05-20 21:21:23.305339 | controller | ok: [controller] 2026-05-20 21:21:23.305766 | controller | 2026-05-20 21:21:23.306044 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-05-20 21:21:23.306299 | controller | Wednesday 20 May 2026 21:21:23 +0000 (0:00:00.953) 0:00:02.578 ********* 2026-05-20 21:21:23.730406 | controller | changed: [controller] 2026-05-20 21:21:23.730443 | controller | 2026-05-20 21:21:23.730456 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-05-20 21:21:23.730468 | controller | Wednesday 20 May 2026 21:21:23 +0000 (0:00:00.424) 0:00:03.003 ********* 2026-05-20 21:21:23.779054 | controller | ok: [controller] => { 2026-05-20 21:21:23.779430 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-05-20 21:21:23.779727 | controller | } 2026-05-20 21:21:23.780003 | controller | 2026-05-20 21:21:23.780366 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-05-20 21:21:23.780686 | controller | Wednesday 20 May 2026 21:21:23 +0000 (0:00:00.049) 0:00:03.052 ********* 2026-05-20 21:21:24.884125 | 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-20 21:21:24.893494 | controller | changed: [controller] 2026-05-20 21:21:24.893788 | controller | 2026-05-20 21:21:24.894063 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-05-20 21:21:24.894322 | controller | Wednesday 20 May 2026 21:21:24 +0000 (0:00:01.114) 0:00:04.167 ********* 2026-05-20 21:21:26.921017 | controller | changed: [controller] 2026-05-20 21:21:26.921061 | controller | 2026-05-20 21:21:26.921071 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-05-20 21:21:26.921079 | controller | Wednesday 20 May 2026 21:21:26 +0000 (0:00:02.026) 0:00:06.193 ********* 2026-05-20 21:21:27.428703 | controller | ok: [controller] 2026-05-20 21:21:27.428744 | controller | 2026-05-20 21:21:27.428754 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-05-20 21:21:27.428762 | controller | Wednesday 20 May 2026 21:21:27 +0000 (0:00:00.508) 0:00:06.701 ********* 2026-05-20 21:21:27.882371 | controller | changed: [controller] 2026-05-20 21:21:27.882683 | controller | 2026-05-20 21:21:27.882959 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-05-20 21:21:27.883281 | controller | Wednesday 20 May 2026 21:21:27 +0000 (0:00:00.454) 0:00:07.155 ********* 2026-05-20 21:21:28.322620 | controller | ok: [controller] 2026-05-20 21:21:28.322906 | controller | 2026-05-20 21:21:28.323182 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-05-20 21:21:28.323499 | controller | Wednesday 20 May 2026 21:21:28 +0000 (0:00:00.439) 0:00:07.595 ********* 2026-05-20 21:21:28.609110 | controller | changed: [controller] 2026-05-20 21:21:28.609157 | controller | 2026-05-20 21:21:28.609167 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-05-20 21:21:28.609175 | controller | Wednesday 20 May 2026 21:21:28 +0000 (0:00:00.286) 0:00:07.881 ********* 2026-05-20 21:21:28.911606 | controller | ok: [controller] 2026-05-20 21:21:28.911888 | controller | 2026-05-20 21:21:28.912173 | controller | TASK [Install plugin] ********************************************************** 2026-05-20 21:21:28.912450 | controller | Wednesday 20 May 2026 21:21:28 +0000 (0:00:00.302) 0:00:08.184 ********* 2026-05-20 21:21:28.966259 | controller | included: vexxhost.containers.download_artifact for controller 2026-05-20 21:21:28.966461 | controller | 2026-05-20 21:21:28.966630 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-05-20 21:21:28.966789 | controller | Wednesday 20 May 2026 21:21:28 +0000 (0:00:00.055) 0:00:08.239 ********* 2026-05-20 21:21:29.013619 | controller | ok: [controller] => { 2026-05-20 21:21:29.013836 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-05-20 21:21:29.013995 | controller | } 2026-05-20 21:21:29.014129 | controller | 2026-05-20 21:21:29.014284 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-05-20 21:21:29.014445 | controller | Wednesday 20 May 2026 21:21:29 +0000 (0:00:00.046) 0:00:08.286 ********* 2026-05-20 21:21:29.799685 | controller | changed: [controller] 2026-05-20 21:21:29.799979 | controller | 2026-05-20 21:21:29.800247 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-05-20 21:21:29.800502 | controller | Wednesday 20 May 2026 21:21:29 +0000 (0:00:00.785) 0:00:09.072 ********* 2026-05-20 21:21:31.892338 | controller | changed: [controller] 2026-05-20 21:21:31.892485 | controller | 2026-05-20 21:21:31.892607 | controller | PLAY RECAP ********************************************************************* 2026-05-20 21:21:31.892785 | controller | controller : ok=16 changed=7 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-05-20 21:21:31.892895 | controller | 2026-05-20 21:21:31.893004 | controller | 2026-05-20 21:21:31.893117 | controller | TASKS RECAP ******************************************************************** 2026-05-20 21:21:31.893232 | controller | Wednesday 20 May 2026 21:21:31 +0000 (0:00:02.094) 0:00:11.166 ********* 2026-05-20 21:21:31.893339 | controller | =============================================================================== 2026-05-20 21:21:31.893454 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.09s 2026-05-20 21:21:31.893569 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.03s 2026-05-20 21:21:31.893681 | controller | Gathering Facts --------------------------------------------------------- 1.13s 2026-05-20 21:21:31.893794 | controller | vexxhost.containers.download_artifact : Download item ------------------- 1.11s 2026-05-20 21:21:31.893908 | controller | vexxhost.containers.package : Update state for tar ---------------------- 0.95s 2026-05-20 21:21:31.894022 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.79s 2026-05-20 21:21:31.894134 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.51s 2026-05-20 21:21:31.894246 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.49s 2026-05-20 21:21:31.894359 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.45s 2026-05-20 21:21:31.894472 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.44s 2026-05-20 21:21:31.894597 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.42s 2026-05-20 21:21:31.894716 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.30s 2026-05-20 21:21:31.894832 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.29s 2026-05-20 21:21:31.894944 | controller | Install plugin ---------------------------------------------------------- 0.06s 2026-05-20 21:21:31.895056 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-05-20 21:21:31.895167 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-05-20 21:21:32.070322 | controller | INFO [helm > converge] Executed: Successful 2026-05-20 21:21:32.079766 | controller | INFO [helm > idempotence] Executing 2026-05-20 21:21:32.951143 | controller | 2026-05-20 21:21:32.952296 | controller | PLAY [Converge] **************************************************************** 2026-05-20 21:21:32.952320 | controller | 2026-05-20 21:21:32.952328 | controller | TASK [Gathering Facts] ********************************************************* 2026-05-20 21:21:32.952336 | controller | Wednesday 20 May 2026 21:21:32 +0000 (0:00:00.013) 0:00:00.013 ********* 2026-05-20 21:21:34.059976 | 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-20 21:21:34.065930 | controller | ok: [controller] 2026-05-20 21:21:34.066201 | controller | 2026-05-20 21:21:34.066517 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-05-20 21:21:34.066813 | controller | Wednesday 20 May 2026 21:21:34 +0000 (0:00:01.114) 0:00:01.127 ********* 2026-05-20 21:21:34.512921 | controller | ok: [controller] 2026-05-20 21:21:34.513228 | controller | 2026-05-20 21:21:34.513508 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-05-20 21:21:34.513772 | controller | Wednesday 20 May 2026 21:21:34 +0000 (0:00:00.446) 0:00:01.574 ********* 2026-05-20 21:21:35.508425 | controller | ok: [controller] 2026-05-20 21:21:35.508722 | controller | 2026-05-20 21:21:35.509061 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-05-20 21:21:35.509325 | controller | Wednesday 20 May 2026 21:21:35 +0000 (0:00:00.995) 0:00:02.570 ********* 2026-05-20 21:21:35.915911 | controller | ok: [controller] 2026-05-20 21:21:35.915957 | controller | 2026-05-20 21:21:35.916050 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-05-20 21:21:35.916134 | controller | Wednesday 20 May 2026 21:21:35 +0000 (0:00:00.405) 0:00:02.976 ********* 2026-05-20 21:21:35.956380 | controller | ok: [controller] => { 2026-05-20 21:21:35.956426 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-05-20 21:21:35.956542 | controller | } 2026-05-20 21:21:35.956594 | controller | 2026-05-20 21:21:35.956700 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-05-20 21:21:35.956786 | controller | Wednesday 20 May 2026 21:21:35 +0000 (0:00:00.042) 0:00:03.018 ********* 2026-05-20 21:21:36.489056 | controller | ok: [controller] 2026-05-20 21:21:36.489120 | controller | 2026-05-20 21:21:36.489312 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-05-20 21:21:36.489464 | controller | Wednesday 20 May 2026 21:21:36 +0000 (0:00:00.532) 0:00:03.550 ********* 2026-05-20 21:21:38.199527 | controller | ok: [controller] 2026-05-20 21:21:38.199586 | controller | 2026-05-20 21:21:38.199597 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-05-20 21:21:38.199606 | controller | Wednesday 20 May 2026 21:21:38 +0000 (0:00:01.709) 0:00:05.260 ********* 2026-05-20 21:21:38.731974 | controller | ok: [controller] 2026-05-20 21:21:38.732051 | controller | 2026-05-20 21:21:38.732061 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-05-20 21:21:38.732149 | controller | Wednesday 20 May 2026 21:21:38 +0000 (0:00:00.526) 0:00:05.786 ********* 2026-05-20 21:21:39.126276 | controller | ok: [controller] 2026-05-20 21:21:39.126350 | controller | 2026-05-20 21:21:39.126362 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-05-20 21:21:39.126452 | controller | Wednesday 20 May 2026 21:21:39 +0000 (0:00:00.401) 0:00:06.188 ********* 2026-05-20 21:21:39.599779 | controller | ok: [controller] 2026-05-20 21:21:39.599862 | controller | 2026-05-20 21:21:39.599946 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-05-20 21:21:39.600069 | controller | Wednesday 20 May 2026 21:21:39 +0000 (0:00:00.473) 0:00:06.661 ********* 2026-05-20 21:21:39.900514 | controller | ok: [controller] 2026-05-20 21:21:39.900544 | controller | 2026-05-20 21:21:39.900550 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-05-20 21:21:39.900555 | controller | Wednesday 20 May 2026 21:21:39 +0000 (0:00:00.300) 0:00:06.961 ********* 2026-05-20 21:21:40.196164 | controller | ok: [controller] 2026-05-20 21:21:40.196191 | controller | 2026-05-20 21:21:40.196195 | controller | TASK [Install plugin] ********************************************************** 2026-05-20 21:21:40.196199 | controller | Wednesday 20 May 2026 21:21:40 +0000 (0:00:00.294) 0:00:07.256 ********* 2026-05-20 21:21:40.247344 | controller | included: vexxhost.containers.download_artifact for controller 2026-05-20 21:21:40.247519 | controller | 2026-05-20 21:21:40.247641 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-05-20 21:21:40.247757 | controller | Wednesday 20 May 2026 21:21:40 +0000 (0:00:00.053) 0:00:07.309 ********* 2026-05-20 21:21:40.303209 | controller | ok: [controller] => { 2026-05-20 21:21:40.303300 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-05-20 21:21:40.303395 | controller | } 2026-05-20 21:21:40.303702 | controller | 2026-05-20 21:21:40.303731 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-05-20 21:21:40.303736 | controller | Wednesday 20 May 2026 21:21:40 +0000 (0:00:00.055) 0:00:07.365 ********* 2026-05-20 21:21:40.727923 | controller | ok: [controller] 2026-05-20 21:21:40.728062 | controller | 2026-05-20 21:21:40.728185 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-05-20 21:21:40.728298 | controller | Wednesday 20 May 2026 21:21:40 +0000 (0:00:00.420) 0:00:07.785 ********* 2026-05-20 21:21:42.367490 | controller | ok: [controller] 2026-05-20 21:21:42.367863 | controller | 2026-05-20 21:21:42.368175 | controller | PLAY RECAP ********************************************************************* 2026-05-20 21:21:42.368452 | controller | controller : ok=16 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-05-20 21:21:42.368744 | controller | 2026-05-20 21:21:42.369007 | controller | 2026-05-20 21:21:42.369323 | controller | TASKS RECAP ******************************************************************** 2026-05-20 21:21:42.369646 | controller | Wednesday 20 May 2026 21:21:42 +0000 (0:00:01.644) 0:00:09.429 ********* 2026-05-20 21:21:42.369918 | controller | =============================================================================== 2026-05-20 21:21:42.370168 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.71s 2026-05-20 21:21:42.370413 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.64s 2026-05-20 21:21:42.370818 | controller | Gathering Facts --------------------------------------------------------- 1.11s 2026-05-20 21:21:42.371086 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.00s 2026-05-20 21:21:42.371333 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.53s 2026-05-20 21:21:42.371576 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.53s 2026-05-20 21:21:42.371770 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.47s 2026-05-20 21:21:42.371936 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.45s 2026-05-20 21:21:42.372100 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.42s 2026-05-20 21:21:42.372264 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.41s 2026-05-20 21:21:42.372441 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.40s 2026-05-20 21:21:42.372658 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.30s 2026-05-20 21:21:42.372860 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.29s 2026-05-20 21:21:42.373027 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.06s 2026-05-20 21:21:42.373189 | controller | Install plugin ---------------------------------------------------------- 0.05s 2026-05-20 21:21:42.373352 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s 2026-05-20 21:21:42.474795 | controller | INFO [helm > idempotence] Executed: Successful 2026-05-20 21:21:42.486294 | controller | INFO [helm > side_effect] Executing 2026-05-20 21:21:42.486689 | controller | WARNING [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-05-20 21:21:42.492238 | controller | INFO [helm > verify] Executing 2026-05-20 21:21:43.332351 | controller | 2026-05-20 21:21:43.332478 | controller | PLAY [Verify] ****************************************************************** 2026-05-20 21:21:43.332741 | controller | 2026-05-20 21:21:43.332833 | controller | TASK [Gathering Facts] ********************************************************* 2026-05-20 21:21:43.333032 | controller | Wednesday 20 May 2026 21:21:43 +0000 (0:00:00.010) 0:00:00.010 ********* 2026-05-20 21:21:44.409706 | 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-20 21:21:44.416790 | controller | ok: [controller] 2026-05-20 21:21:44.416811 | controller | 2026-05-20 21:21:44.416820 | controller | TASK [Get the current Helm version] ******************************************** 2026-05-20 21:21:44.416828 | controller | Wednesday 20 May 2026 21:21:44 +0000 (0:00:01.084) 0:00:01.094 ********* 2026-05-20 21:21:44.866522 | controller | changed: [controller] 2026-05-20 21:21:44.866822 | controller | 2026-05-20 21:21:44.867096 | controller | TASK [Assert Helm version] ***************************************************** 2026-05-20 21:21:44.867351 | controller | Wednesday 20 May 2026 21:21:44 +0000 (0:00:00.449) 0:00:01.544 ********* 2026-05-20 21:21:44.897311 | controller | ok: [controller] => { 2026-05-20 21:21:44.897581 | controller | "changed": false, 2026-05-20 21:21:44.897839 | controller | "msg": "All assertions passed" 2026-05-20 21:21:44.898082 | controller | } 2026-05-20 21:21:44.898312 | controller | 2026-05-20 21:21:44.898556 | controller | PLAY RECAP ********************************************************************* 2026-05-20 21:21:44.898835 | controller | controller : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-05-20 21:21:44.899063 | controller | 2026-05-20 21:21:44.899286 | controller | 2026-05-20 21:21:44.899577 | controller | TASKS RECAP ******************************************************************** 2026-05-20 21:21:44.899827 | controller | Wednesday 20 May 2026 21:21:44 +0000 (0:00:00.031) 0:00:01.576 ********* 2026-05-20 21:21:44.900059 | controller | =============================================================================== 2026-05-20 21:21:44.900299 | controller | Gathering Facts --------------------------------------------------------- 1.08s 2026-05-20 21:21:44.900539 | controller | Get the current Helm version -------------------------------------------- 0.45s 2026-05-20 21:21:44.900779 | controller | Assert Helm version ----------------------------------------------------- 0.03s 2026-05-20 21:21:45.000337 | controller | INFO [helm > verify] Executed: Successful 2026-05-20 21:21:45.171141 | controller | INFO [helm > cleanup] Executing 2026-05-20 21:21:45.171909 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-05-20 21:21:45.186590 | controller | INFO [helm > destroy] Executing 2026-05-20 21:21:45.186725 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-05-20 21:21:45.186846 | controller | INFO [helm > destroy] Executed: Successful 2026-05-20 21:21:45.187337 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-05-20 21:21:45.474259 | controller | ok: Runtime: 0:00:50.545494 2026-05-20 21:21:45.480035 | 2026-05-20 21:21:45.480182 | PLAY RECAP 2026-05-20 21:21:45.480233 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-20 21:21:45.480256 | 2026-05-20 21:21:45.619954 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-05-20 21:21:45.623335 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-05-20 21:21:46.236167 | 2026-05-20 21:21:46.236322 | PLAY [all] 2026-05-20 21:21:46.248703 | 2026-05-20 21:21:46.248841 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-05-20 21:21:46.631920 | controller | changed 2026-05-20 21:21:46.638781 | 2026-05-20 21:21:46.638963 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-05-20 21:21:47.026049 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-05-20 21:21:47.026176 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-05-20 21:21:47.034973 | controller | environment: line 1: kubectl: command not found 2026-05-20 21:21:47.036381 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-05-20 21:21:47.036833 | controller | environment: line 1: kubectl: command not found 2026-05-20 21:21:47.038899 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-05-20 21:21:47.042441 | controller | environment: line 1: kubectl: command not found 2026-05-20 21:21:47.044763 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-05-20 21:21:47.045511 | controller | environment: line 1: kubectl: command not found 2026-05-20 21:21:47.047170 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-05-20 21:21:47.049060 | controller | environment: line 1: kubectl: command not found 2026-05-20 21:21:47.050157 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-05-20 21:21:47.172259 | controller | ok: Runtime: 0:00:00.040442 2026-05-20 21:21:47.178943 | 2026-05-20 21:21:47.179034 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-05-20 21:21:47.434483 | controller | changed 2026-05-20 21:21:47.440555 | 2026-05-20 21:21:47.440646 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-05-20 21:21:47.678399 | controller | environment: line 5: kubectl: command not found 2026-05-20 21:21:47.679147 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-05-20 21:21:47.679919 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-05-20 21:21:47.680470 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-05-20 21:21:47.973311 | controller | ok: Runtime: 0:00:00.014292 2026-05-20 21:21:47.980170 | 2026-05-20 21:21:47.980245 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-05-20 21:21:48.673237 | controller | changed: 2026-05-20 21:21:48.673426 | controller | created directory /var/lib/zuul/builds/760b0f53df8e44989d65b8c5f61a98f6/work/logs/controller 2026-05-20 21:21:48.673463 | controller | cd+++++++++ objects/ 2026-05-20 21:21:48.673487 | controller | cd+++++++++ objects/cluster/ 2026-05-20 21:21:48.673512 | controller | cd+++++++++ objects/namespaced/ 2026-05-20 21:21:48.681231 | 2026-05-20 21:21:48.681306 | TASK [gather-pod-logs : creating directory for pod logs] 2026-05-20 21:21:48.920190 | controller | changed 2026-05-20 21:21:48.924625 | 2026-05-20 21:21:48.924735 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-05-20 21:21:49.171625 | controller | changed 2026-05-20 21:21:49.176006 | 2026-05-20 21:21:49.176102 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-05-20 21:21:49.426368 | controller | environment: line 3: kubectl: command not found 2026-05-20 21:21:49.704055 | controller | ok: Runtime: 0:00:00.013365 2026-05-20 21:21:49.710221 | 2026-05-20 21:21:49.710320 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-05-20 21:21:50.250551 | controller | changed: 2026-05-20 21:21:50.250775 | controller | cd+++++++++ pod-logs/ 2026-05-20 21:21:50.250814 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-05-20 21:21:50.259834 | 2026-05-20 21:21:50.259905 | LOOP [helm-release-status : creating directory for helm release status] 2026-05-20 21:21:50.489449 | controller | changed: "values" 2026-05-20 21:21:50.694036 | controller | changed: "releases" 2026-05-20 21:21:50.711141 | 2026-05-20 21:21:50.711352 | TASK [helm-release-status : Gather get release status for helm charts] 2026-05-20 21:21:50.952192 | controller | /bin/bash: line 3: kubectl: command not found 2026-05-20 21:21:51.244474 | controller | ok: Runtime: 0:00:00.008954 2026-05-20 21:21:51.253593 | 2026-05-20 21:21:51.253728 | TASK [helm-release-status : Downloads logs to executor] 2026-05-20 21:21:51.790160 | controller | changed: 2026-05-20 21:21:51.791041 | controller | cd+++++++++ helm/ 2026-05-20 21:21:51.791097 | controller | cd+++++++++ helm/releases/ 2026-05-20 21:21:51.791143 | controller | cd+++++++++ helm/values/ 2026-05-20 21:21:51.799064 | 2026-05-20 21:21:51.799123 | PLAY RECAP 2026-05-20 21:21:51.799173 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-20 21:21:51.799197 | 2026-05-20 21:21:51.980286 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-05-20 21:21:51.985536 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-05-20 21:21:52.594690 | 2026-05-20 21:21:52.594833 | PLAY [all] 2026-05-20 21:21:52.605553 | 2026-05-20 21:21:52.605685 | TASK [fetch-output : Set log path for multiple nodes] 2026-05-20 21:21:52.651405 | controller | skipping: Conditional result was False 2026-05-20 21:21:52.660158 | 2026-05-20 21:21:52.660267 | TASK [fetch-output : Set log path for single node] 2026-05-20 21:21:52.701020 | controller | ok 2026-05-20 21:21:52.706045 | 2026-05-20 21:21:52.706144 | LOOP [fetch-output : Ensure local output dirs] 2026-05-20 21:21:53.131144 | controller -> localhost | ok: "/var/lib/zuul/builds/760b0f53df8e44989d65b8c5f61a98f6/work/logs" 2026-05-20 21:21:53.346296 | controller -> localhost | changed: "/var/lib/zuul/builds/760b0f53df8e44989d65b8c5f61a98f6/work/artifacts" 2026-05-20 21:21:53.565254 | controller -> localhost | changed: "/var/lib/zuul/builds/760b0f53df8e44989d65b8c5f61a98f6/work/docs" 2026-05-20 21:21:53.576892 | 2026-05-20 21:21:53.577125 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-20 21:21:54.247199 | controller | changed: .d..t...... ./ 2026-05-20 21:21:54.247508 | controller | changed: All items complete 2026-05-20 21:21:54.247565 | 2026-05-20 21:21:54.717505 | controller | changed: .d..t...... ./ 2026-05-20 21:21:55.214159 | controller | changed: .d..t...... ./ 2026-05-20 21:21:55.232458 | 2026-05-20 21:21:55.232624 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-20 21:21:55.636517 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.008216 2026-05-20 21:21:55.862091 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.008407 2026-05-20 21:21:55.882082 | 2026-05-20 21:21:55.882228 | PLAY [all] 2026-05-20 21:21:55.887157 | 2026-05-20 21:21:55.887222 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-20 21:21:56.379175 | controller | changed 2026-05-20 21:21:56.385997 | 2026-05-20 21:21:56.386049 | PLAY RECAP 2026-05-20 21:21:56.386096 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-20 21:21:56.386133 | 2026-05-20 21:21:56.513516 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-05-20 21:21:56.516446 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-20 21:21:57.102345 | 2026-05-20 21:21:57.102471 | PLAY [localhost] 2026-05-20 21:21:57.112426 | 2026-05-20 21:21:57.112497 | TASK [Generate Zuul manifest] 2026-05-20 21:21:57.134957 | localhost | ok 2026-05-20 21:21:57.153031 | 2026-05-20 21:21:57.153126 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-20 21:21:57.527526 | localhost | changed 2026-05-20 21:21:57.546566 | 2026-05-20 21:21:57.546850 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-20 21:21:57.581897 | localhost | ok 2026-05-20 21:21:57.589832 | 2026-05-20 21:21:57.589918 | TASK [Upload logs] 2026-05-20 21:21:57.614752 | localhost | ok 2026-05-20 21:21:57.679617 | 2026-05-20 21:21:57.679807 | TASK [Set zuul-log-path fact] 2026-05-20 21:21:57.701998 | localhost | ok 2026-05-20 21:21:57.714326 | 2026-05-20 21:21:57.714405 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-20 21:21:57.746296 | localhost | ok 2026-05-20 21:21:57.755350 | 2026-05-20 21:21:57.755418 | TASK [upload-logs : Create log directories] 2026-05-20 21:21:58.154692 | localhost | changed 2026-05-20 21:21:58.163028 | 2026-05-20 21:21:58.163118 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-20 21:21:58.572161 | localhost -> localhost | ok: Runtime: 0:00:00.005130 2026-05-20 21:21:58.577797 | 2026-05-20 21:21:58.577869 | TASK [upload-logs : Upload logs to log server] 2026-05-20 21:21:59.057166 | localhost | Output suppressed because no_log was given 2026-05-20 21:21:59.062872 | 2026-05-20 21:21:59.062947 | LOOP [upload-logs : Compress console log and json output] 2026-05-20 21:21:59.119627 | localhost | skipping: Conditional result was False 2026-05-20 21:21:59.173993 | localhost | skipping: Conditional result was False 2026-05-20 21:21:59.190269 | 2026-05-20 21:21:59.190435 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-20 21:21:59.235554 | localhost | skipping: Conditional result was False 2026-05-20 21:21:59.235959 | 2026-05-20 21:21:59.239464 | localhost | skipping: Conditional result was False 2026-05-20 21:21:59.256366 | 2026-05-20 21:21:59.256571 | LOOP [upload-logs : Upload console log and json output]