2026-03-31 00:35:35.520596 | Job console starting 2026-03-31 00:35:35.653177 | Updating git repos 2026-03-31 00:35:35.698150 | Cloning repos into workspace 2026-03-31 00:35:36.023198 | Restoring repo states 2026-03-31 00:35:36.061303 | Merging changes 2026-03-31 00:35:37.202295 | Checking out repos 2026-03-31 00:35:37.888600 | Preparing playbooks 2026-03-31 00:35:55.365236 | Running Ansible setup 2026-03-31 00:35:59.957309 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-31 00:36:00.652608 | 2026-03-31 00:36:00.835130 | PLAY [localhost] 2026-03-31 00:36:00.850897 | 2026-03-31 00:36:00.851018 | TASK [Gathering Facts] 2026-03-31 00:36:01.747352 | localhost | ok 2026-03-31 00:36:01.762811 | 2026-03-31 00:36:01.762949 | TASK [Setup log path fact] 2026-03-31 00:36:01.783685 | localhost | ok 2026-03-31 00:36:01.797870 | 2026-03-31 00:36:01.797951 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-31 00:36:01.847747 | localhost | ok 2026-03-31 00:36:01.856298 | 2026-03-31 00:36:01.856383 | TASK [emit-job-header : Print job information] 2026-03-31 00:36:01.896601 | # Job Information 2026-03-31 00:36:01.896821 | Ansible Version: 2.16.16 2026-03-31 00:36:01.896875 | Job: ansible-collection-kubernetes-molecule-helm 2026-03-31 00:36:01.896909 | Pipeline: check 2026-03-31 00:36:01.897056 | Executor: 0a8996d2b663 2026-03-31 00:36:01.897102 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/249 2026-03-31 00:36:01.897137 | Event ID: 61500a90-2c99-11f1-8b8a-3f95ba85df2f 2026-03-31 00:36:01.901294 | 2026-03-31 00:36:01.992562 | LOOP [emit-job-header : Print node information] 2026-03-31 00:36:02.105062 | localhost | ok: 2026-03-31 00:36:02.105253 | localhost | # Node Information 2026-03-31 00:36:02.105286 | localhost | Inventory Hostname: controller 2026-03-31 00:36:02.105308 | localhost | Hostname: np0000161793 2026-03-31 00:36:02.105329 | localhost | Username: zuul 2026-03-31 00:36:02.105353 | localhost | Distro: Debian 13.4 2026-03-31 00:36:02.105374 | localhost | Provider: yul1 2026-03-31 00:36:02.105393 | localhost | Region: ca-ymq-1 2026-03-31 00:36:02.105413 | localhost | Label: debian-trixie 2026-03-31 00:36:02.105432 | localhost | Product Name: OpenStack Nova 2026-03-31 00:36:02.105451 | localhost | Interface IP: 199.204.45.227 2026-03-31 00:36:02.117138 | 2026-03-31 00:36:02.117316 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-31 00:36:02.589441 | localhost -> localhost | changed 2026-03-31 00:36:02.594429 | 2026-03-31 00:36:02.594524 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-31 00:36:03.623706 | localhost -> localhost | changed 2026-03-31 00:36:03.637224 | 2026-03-31 00:36:03.637468 | PLAY [all] 2026-03-31 00:36:03.646568 | 2026-03-31 00:36:03.646633 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-31 00:36:03.871559 | controller -> localhost | ok 2026-03-31 00:36:03.879344 | 2026-03-31 00:36:03.879422 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-31 00:36:03.918714 | controller | ok 2026-03-31 00:36:03.931778 | controller | included: /var/lib/zuul/builds/00b885b606db4d6ea45a4cdd89f86364/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-31 00:36:03.936414 | 2026-03-31 00:36:03.936475 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-31 00:36:04.764660 | controller -> localhost | Generating public/private rsa key pair. 2026-03-31 00:36:04.764910 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/00b885b606db4d6ea45a4cdd89f86364/work/00b885b606db4d6ea45a4cdd89f86364_id_rsa 2026-03-31 00:36:04.764981 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/00b885b606db4d6ea45a4cdd89f86364/work/00b885b606db4d6ea45a4cdd89f86364_id_rsa.pub 2026-03-31 00:36:04.765018 | controller -> localhost | The key fingerprint is: 2026-03-31 00:36:04.765051 | controller -> localhost | SHA256:z4L/R86ghWHxZZ9wYNYk4q5sh9q88Vrp/q1et2xT5Ko zuul-build-sshkey 2026-03-31 00:36:04.765101 | controller -> localhost | The key's randomart image is: 2026-03-31 00:36:04.765132 | controller -> localhost | +---[RSA 3072]----+ 2026-03-31 00:36:04.765168 | controller -> localhost | | . =+. | 2026-03-31 00:36:04.765200 | controller -> localhost | | .. ++.o | 2026-03-31 00:36:04.765230 | controller -> localhost | | o.o + . | 2026-03-31 00:36:04.765260 | controller -> localhost | | o.. o .| 2026-03-31 00:36:04.765290 | controller -> localhost | | .So. o | 2026-03-31 00:36:04.765319 | controller -> localhost | | o.=o.. o| 2026-03-31 00:36:04.765348 | controller -> localhost | | . Bo*= ..o| 2026-03-31 00:36:04.765378 | controller -> localhost | | *.B +oo+.| 2026-03-31 00:36:04.765415 | controller -> localhost | | . *==+Eooo.| 2026-03-31 00:36:04.765445 | controller -> localhost | +----[SHA256]-----+ 2026-03-31 00:36:04.765511 | controller -> localhost | ok: Runtime: 0:00:00.380010 2026-03-31 00:36:04.772293 | 2026-03-31 00:36:04.772392 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-31 00:36:04.812744 | controller | ok 2026-03-31 00:36:04.820542 | controller | included: /var/lib/zuul/builds/00b885b606db4d6ea45a4cdd89f86364/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-31 00:36:04.837520 | 2026-03-31 00:36:04.837718 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-31 00:36:04.854320 | controller | skipping: Conditional result was False 2026-03-31 00:36:04.861318 | 2026-03-31 00:36:04.861405 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-31 00:36:05.438042 | controller | changed 2026-03-31 00:36:05.443691 | 2026-03-31 00:36:05.443776 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-31 00:36:05.665922 | controller | ok 2026-03-31 00:36:05.672315 | 2026-03-31 00:36:05.672411 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-31 00:36:06.184807 | controller | changed 2026-03-31 00:36:06.190274 | 2026-03-31 00:36:06.190340 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-31 00:36:06.735061 | controller | changed 2026-03-31 00:36:06.742329 | 2026-03-31 00:36:06.742412 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-31 00:36:06.762280 | controller | skipping: Conditional result was False 2026-03-31 00:36:06.768194 | 2026-03-31 00:36:06.768280 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-31 00:36:07.145220 | controller -> localhost | changed 2026-03-31 00:36:07.153965 | 2026-03-31 00:36:07.154054 | TASK [add-build-sshkey : Add back temp key] 2026-03-31 00:36:07.429125 | controller -> localhost | Identity added: /var/lib/zuul/builds/00b885b606db4d6ea45a4cdd89f86364/work/00b885b606db4d6ea45a4cdd89f86364_id_rsa (zuul-build-sshkey) 2026-03-31 00:36:07.429334 | controller -> localhost | ok: Runtime: 0:00:00.011616 2026-03-31 00:36:07.433461 | 2026-03-31 00:36:07.433527 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-31 00:36:07.832352 | controller | ok 2026-03-31 00:36:07.836154 | 2026-03-31 00:36:07.836215 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-31 00:36:07.860944 | controller | skipping: Conditional result was False 2026-03-31 00:36:07.872305 | 2026-03-31 00:36:07.872371 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-31 00:36:08.223642 | controller | ok 2026-03-31 00:36:08.228561 | 2026-03-31 00:36:08.228625 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-31 00:36:09.268668 | controller | Output suppressed because no_log was given 2026-03-31 00:36:09.377444 | 2026-03-31 00:36:09.377576 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-31 00:36:09.636170 | controller | ok: "logs" 2026-03-31 00:36:09.636490 | controller | ok: All items complete 2026-03-31 00:36:09.636531 | 2026-03-31 00:36:09.813840 | controller | ok: "artifacts" 2026-03-31 00:36:10.008140 | controller | ok: "docs" 2026-03-31 00:36:10.025286 | 2026-03-31 00:36:10.025477 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-31 00:36:10.240911 | controller | changed: "logs" 2026-03-31 00:36:10.420156 | controller | changed: "artifacts" 2026-03-31 00:36:10.623468 | controller | changed: "docs" 2026-03-31 00:36:10.648442 | 2026-03-31 00:36:10.648600 | PLAY RECAP 2026-03-31 00:36:10.648652 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-03-31 00:36:10.648680 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-31 00:36:10.648702 | 2026-03-31 00:36:10.879398 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-31 00:36:10.880793 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-31 00:36:11.572078 | 2026-03-31 00:36:11.572720 | PLAY [all] 2026-03-31 00:36:11.595501 | 2026-03-31 00:36:11.595696 | TASK [setup-uv : Extract archive] 2026-03-31 00:36:14.157894 | controller | changed 2026-03-31 00:36:14.164770 | 2026-03-31 00:36:14.164850 | TASK [setup-uv : Print version] 2026-03-31 00:36:14.571886 | controller | uv 0.8.13 2026-03-31 00:36:14.695159 | controller | ok: Runtime: 0:00:00.013198 2026-03-31 00:36:14.704547 | 2026-03-31 00:36:14.704599 | PLAY RECAP 2026-03-31 00:36:14.704652 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-31 00:36:14.704676 | 2026-03-31 00:36:14.911928 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-31 00:36:14.914629 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-31 00:36:15.522269 | 2026-03-31 00:36:15.522430 | PLAY [all] 2026-03-31 00:36:15.533271 | 2026-03-31 00:36:15.533350 | TASK [Update apt cache] 2026-03-31 00:36:20.248678 | controller | ok 2026-03-31 00:36:20.254079 | 2026-03-31 00:36:20.254159 | TASK [Disable firewalld] 2026-03-31 00:36:20.279074 | controller | skipping: Conditional result was False 2026-03-31 00:36:20.287155 | 2026-03-31 00:36:20.287245 | TASK [Install "jq" for log collection] 2026-03-31 00:36:22.446540 | controller | changed 2026-03-31 00:36:22.449056 | 2026-03-31 00:36:22.449122 | PLAY RECAP 2026-03-31 00:36:22.449181 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-31 00:36:22.449210 | 2026-03-31 00:36:22.567670 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-31 00:36:22.570756 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-31 00:36:23.126793 | 2026-03-31 00:36:23.126924 | PLAY [all] 2026-03-31 00:36:23.136989 | 2026-03-31 00:36:23.137063 | TASK [Copy inventory file for Zuul] 2026-03-31 00:36:24.130636 | controller | changed 2026-03-31 00:36:24.138506 | 2026-03-31 00:36:24.138612 | TASK [Switch "ansible_host" to private IP] 2026-03-31 00:36:24.457860 | controller | changed: 1 replacements made 2026-03-31 00:36:24.464009 | 2026-03-31 00:36:24.464168 | TASK [Run Molecule scenario] 2026-03-31 00:36:24.941059 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-03-31 00:36:24.941175 | controller | Creating virtual environment at: .venv 2026-03-31 00:36:24.997335 | controller | Downloading ansible-core (2.3MiB) 2026-03-31 00:36:24.997903 | controller | Downloading cryptography (4.3MiB) 2026-03-31 00:36:25.001921 | controller | Downloading pygments (1.2MiB) 2026-03-31 00:36:25.167547 | controller | Downloading cryptography 2026-03-31 00:36:25.210793 | controller | Downloading pygments 2026-03-31 00:36:25.357099 | controller | Downloading ansible-core 2026-03-31 00:36:25.405743 | controller | Installed 36 packages in 48ms 2026-03-31 00:36:26.091903 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-03-31 00:36:26.091977 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-03-31 00:36:26.989517 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-03-31 00:36:26.989582 | controller | INFO default scenario not found, disabling shared state. 2026-03-31 00:36:26.989658 | controller | INFO [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-03-31 00:36:26.989743 | controller | INFO [helm > prerun] Performing prerun with role_name_check=0... 2026-03-31 00:36:44.614939 | controller | INFO [helm > dependency] Executing 2026-03-31 00:36:44.615036 | controller | WARNING [helm > dependency] Missing roles requirements file: requirements.yml 2026-03-31 00:36:44.615263 | controller | WARNING [helm > dependency] Missing collections requirements file: collections.yml 2026-03-31 00:36:44.615395 | controller | WARNING [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-03-31 00:36:44.620762 | controller | INFO [helm > cleanup] Executing 2026-03-31 00:36:44.621087 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-31 00:36:44.626327 | controller | INFO [helm > destroy] Executing 2026-03-31 00:36:44.626352 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-31 00:36:44.626366 | controller | INFO [helm > destroy] Executed: Successful 2026-03-31 00:36:44.631675 | controller | INFO [helm > syntax] Executing 2026-03-31 00:36:45.506788 | controller | 2026-03-31 00:36:45.507074 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml 2026-03-31 00:36:45.566808 | controller | INFO [helm > syntax] Executed: Successful 2026-03-31 00:36:45.578400 | controller | INFO [helm > create] Executing 2026-03-31 00:36:45.579887 | controller | WARNING [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-31 00:36:45.585725 | controller | INFO [helm > prepare] Executing 2026-03-31 00:36:46.447342 | controller | 2026-03-31 00:36:46.447403 | controller | PLAY [Prepare] ***************************************************************** 2026-03-31 00:36:46.447591 | controller | 2026-03-31 00:36:46.447829 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-31 00:36:46.448100 | controller | Tuesday 31 March 2026 00:36:46 +0000 (0:00:00.028) 0:00:00.028 ********* 2026-03-31 00:36:47.713536 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-31 00:36:47.720313 | controller | ok: [controller] 2026-03-31 00:36:47.720496 | controller | 2026-03-31 00:36:47.720787 | controller | TASK [Install Debian packages] ************************************************* 2026-03-31 00:36:47.721013 | controller | Tuesday 31 March 2026 00:36:47 +0000 (0:00:01.273) 0:00:01.302 ********* 2026-03-31 00:36:49.081058 | controller | ok: [controller] 2026-03-31 00:36:49.081213 | controller | 2026-03-31 00:36:49.081410 | controller | PLAY RECAP ********************************************************************* 2026-03-31 00:36:49.081702 | controller | controller : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-31 00:36:49.081900 | controller | 2026-03-31 00:36:49.082072 | controller | 2026-03-31 00:36:49.082266 | controller | TASKS RECAP ******************************************************************** 2026-03-31 00:36:49.082465 | controller | Tuesday 31 March 2026 00:36:49 +0000 (0:00:01.360) 0:00:02.663 ********* 2026-03-31 00:36:49.082644 | controller | =============================================================================== 2026-03-31 00:36:49.082827 | controller | Install Debian packages ------------------------------------------------- 1.36s 2026-03-31 00:36:49.083015 | controller | Gathering Facts --------------------------------------------------------- 1.27s 2026-03-31 00:36:49.175235 | controller | INFO [helm > prepare] Executed: Successful 2026-03-31 00:36:49.185149 | controller | INFO [helm > converge] Executing 2026-03-31 00:36:50.004361 | controller | 2026-03-31 00:36:50.004401 | controller | PLAY [Converge] **************************************************************** 2026-03-31 00:36:50.004552 | controller | 2026-03-31 00:36:50.004797 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-31 00:36:50.005003 | controller | Tuesday 31 March 2026 00:36:49 +0000 (0:00:00.012) 0:00:00.012 ********* 2026-03-31 00:36:52.083291 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-31 00:36:52.088111 | controller | ok: [controller] 2026-03-31 00:36:52.088184 | controller | 2026-03-31 00:36:52.088332 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-31 00:36:52.088469 | controller | Tuesday 31 March 2026 00:36:52 +0000 (0:00:02.084) 0:00:02.096 ********* 2026-03-31 00:36:52.571408 | controller | ok: [controller] 2026-03-31 00:36:52.571558 | controller | 2026-03-31 00:36:52.571764 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-31 00:36:52.571970 | controller | Tuesday 31 March 2026 00:36:52 +0000 (0:00:00.482) 0:00:02.578 ********* 2026-03-31 00:36:53.585233 | controller | ok: [controller] 2026-03-31 00:36:53.585379 | controller | 2026-03-31 00:36:53.585589 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-31 00:36:53.585783 | controller | Tuesday 31 March 2026 00:36:53 +0000 (0:00:01.013) 0:00:03.592 ********* 2026-03-31 00:36:54.024515 | controller | changed: [controller] 2026-03-31 00:36:54.024664 | controller | 2026-03-31 00:36:54.024864 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-31 00:36:54.025079 | controller | Tuesday 31 March 2026 00:36:54 +0000 (0:00:00.439) 0:00:04.032 ********* 2026-03-31 00:36:54.071298 | controller | ok: [controller] => { 2026-03-31 00:36:54.071499 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-31 00:36:54.071689 | controller | } 2026-03-31 00:36:54.071861 | controller | 2026-03-31 00:36:54.072057 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-31 00:36:54.072248 | controller | Tuesday 31 March 2026 00:36:54 +0000 (0:00:00.045) 0:00:04.078 ********* 2026-03-31 00:36:55.027811 | controller | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created with a mode of 0700, this may cause issues when running as another user. To avoid this, create the remote_tmp dir with the correct permissions manually 2026-03-31 00:36:55.037229 | controller | changed: [controller] 2026-03-31 00:36:55.037390 | controller | 2026-03-31 00:36:55.037585 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-31 00:36:55.037774 | controller | Tuesday 31 March 2026 00:36:55 +0000 (0:00:00.966) 0:00:05.045 ********* 2026-03-31 00:36:57.089763 | controller | changed: [controller] 2026-03-31 00:36:57.090115 | controller | 2026-03-31 00:36:57.090329 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-31 00:36:57.090530 | controller | Tuesday 31 March 2026 00:36:57 +0000 (0:00:02.052) 0:00:07.097 ********* 2026-03-31 00:36:57.590078 | controller | ok: [controller] 2026-03-31 00:36:57.590117 | controller | 2026-03-31 00:36:57.590251 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-31 00:36:57.590451 | controller | Tuesday 31 March 2026 00:36:57 +0000 (0:00:00.499) 0:00:07.597 ********* 2026-03-31 00:36:57.999157 | controller | changed: [controller] 2026-03-31 00:36:57.999302 | controller | 2026-03-31 00:36:57.999455 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-31 00:36:57.999590 | controller | Tuesday 31 March 2026 00:36:57 +0000 (0:00:00.409) 0:00:08.006 ********* 2026-03-31 00:36:58.479728 | controller | ok: [controller] 2026-03-31 00:36:58.479884 | controller | 2026-03-31 00:36:58.480118 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-31 00:36:58.480344 | controller | Tuesday 31 March 2026 00:36:58 +0000 (0:00:00.480) 0:00:08.487 ********* 2026-03-31 00:36:58.773278 | controller | changed: [controller] 2026-03-31 00:36:58.774489 | controller | 2026-03-31 00:36:58.774504 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-31 00:36:58.774514 | controller | Tuesday 31 March 2026 00:36:58 +0000 (0:00:00.293) 0:00:08.780 ********* 2026-03-31 00:36:59.063602 | controller | ok: [controller] 2026-03-31 00:36:59.063771 | controller | 2026-03-31 00:36:59.064006 | controller | TASK [Install plugin] ********************************************************** 2026-03-31 00:36:59.064222 | controller | Tuesday 31 March 2026 00:36:59 +0000 (0:00:00.290) 0:00:09.071 ********* 2026-03-31 00:36:59.115391 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-31 00:36:59.115543 | controller | 2026-03-31 00:36:59.115755 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-31 00:36:59.115947 | controller | Tuesday 31 March 2026 00:36:59 +0000 (0:00:00.052) 0:00:09.123 ********* 2026-03-31 00:36:59.159655 | controller | ok: [controller] => { 2026-03-31 00:36:59.159816 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-31 00:36:59.159999 | controller | } 2026-03-31 00:36:59.160170 | controller | 2026-03-31 00:36:59.160404 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-31 00:36:59.160566 | controller | Tuesday 31 March 2026 00:36:59 +0000 (0:00:00.043) 0:00:09.167 ********* 2026-03-31 00:36:59.967950 | controller | changed: [controller] 2026-03-31 00:36:59.968142 | controller | 2026-03-31 00:36:59.968367 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-31 00:36:59.968592 | controller | Tuesday 31 March 2026 00:36:59 +0000 (0:00:00.808) 0:00:09.975 ********* 2026-03-31 00:37:02.055168 | controller | changed: [controller] 2026-03-31 00:37:02.055206 | controller | 2026-03-31 00:37:02.055216 | controller | PLAY RECAP ********************************************************************* 2026-03-31 00:37:02.055226 | controller | controller : ok=16 changed=7 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-31 00:37:02.055234 | controller | 2026-03-31 00:37:02.055242 | controller | 2026-03-31 00:37:02.055249 | controller | TASKS RECAP ******************************************************************** 2026-03-31 00:37:02.055257 | controller | Tuesday 31 March 2026 00:37:02 +0000 (0:00:02.083) 0:00:12.059 ********* 2026-03-31 00:37:02.055264 | controller | =============================================================================== 2026-03-31 00:37:02.055272 | controller | Gathering Facts --------------------------------------------------------- 2.08s 2026-03-31 00:37:02.055279 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.08s 2026-03-31 00:37:02.055286 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.05s 2026-03-31 00:37:02.055293 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.01s 2026-03-31 00:37:02.055300 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.97s 2026-03-31 00:37:02.055307 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.81s 2026-03-31 00:37:02.055314 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.50s 2026-03-31 00:37:02.055321 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.48s 2026-03-31 00:37:02.055328 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.48s 2026-03-31 00:37:02.055335 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.44s 2026-03-31 00:37:02.055354 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.41s 2026-03-31 00:37:02.055361 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.29s 2026-03-31 00:37:02.055368 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.29s 2026-03-31 00:37:02.055375 | controller | Install plugin ---------------------------------------------------------- 0.05s 2026-03-31 00:37:02.055617 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-31 00:37:02.055869 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s 2026-03-31 00:37:02.162216 | controller | INFO [helm > converge] Executed: Successful 2026-03-31 00:37:02.171864 | controller | INFO [helm > idempotence] Executing 2026-03-31 00:37:02.983194 | controller | 2026-03-31 00:37:02.983526 | controller | PLAY [Converge] **************************************************************** 2026-03-31 00:37:02.983786 | controller | 2026-03-31 00:37:02.984074 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-31 00:37:02.984382 | controller | Tuesday 31 March 2026 00:37:02 +0000 (0:00:00.012) 0:00:00.012 ********* 2026-03-31 00:37:04.047511 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-31 00:37:04.053242 | controller | ok: [controller] 2026-03-31 00:37:04.053416 | controller | 2026-03-31 00:37:04.053590 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-31 00:37:04.053771 | controller | Tuesday 31 March 2026 00:37:04 +0000 (0:00:01.070) 0:00:01.082 ********* 2026-03-31 00:37:04.499235 | controller | ok: [controller] 2026-03-31 00:37:04.499539 | controller | 2026-03-31 00:37:04.499848 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-31 00:37:04.500115 | controller | Tuesday 31 March 2026 00:37:04 +0000 (0:00:00.445) 0:00:01.528 ********* 2026-03-31 00:37:06.493761 | controller | ok: [controller] 2026-03-31 00:37:06.494077 | controller | 2026-03-31 00:37:06.494427 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-31 00:37:06.494752 | controller | Tuesday 31 March 2026 00:37:06 +0000 (0:00:01.994) 0:00:03.522 ********* 2026-03-31 00:37:06.944800 | controller | ok: [controller] 2026-03-31 00:37:06.945106 | controller | 2026-03-31 00:37:06.945411 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-31 00:37:06.945697 | controller | Tuesday 31 March 2026 00:37:06 +0000 (0:00:00.451) 0:00:03.973 ********* 2026-03-31 00:37:06.990916 | controller | ok: [controller] => { 2026-03-31 00:37:06.991396 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-31 00:37:06.991759 | controller | } 2026-03-31 00:37:06.992033 | controller | 2026-03-31 00:37:06.992383 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-31 00:37:06.992700 | controller | Tuesday 31 March 2026 00:37:06 +0000 (0:00:00.046) 0:00:04.019 ********* 2026-03-31 00:37:07.522077 | controller | ok: [controller] 2026-03-31 00:37:07.522361 | controller | 2026-03-31 00:37:07.522629 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-31 00:37:07.522950 | controller | Tuesday 31 March 2026 00:37:07 +0000 (0:00:00.531) 0:00:04.550 ********* 2026-03-31 00:37:10.191506 | controller | ok: [controller] 2026-03-31 00:37:10.191557 | controller | 2026-03-31 00:37:10.191646 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-31 00:37:10.191734 | controller | Tuesday 31 March 2026 00:37:10 +0000 (0:00:02.667) 0:00:07.218 ********* 2026-03-31 00:37:10.708488 | controller | ok: [controller] 2026-03-31 00:37:10.708543 | controller | 2026-03-31 00:37:10.708654 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-31 00:37:10.708824 | controller | Tuesday 31 March 2026 00:37:10 +0000 (0:00:00.517) 0:00:07.736 ********* 2026-03-31 00:37:11.130593 | controller | ok: [controller] 2026-03-31 00:37:11.130653 | controller | 2026-03-31 00:37:11.130830 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-31 00:37:11.130958 | controller | Tuesday 31 March 2026 00:37:11 +0000 (0:00:00.422) 0:00:08.158 ********* 2026-03-31 00:37:11.582798 | controller | ok: [controller] 2026-03-31 00:37:11.582822 | controller | 2026-03-31 00:37:11.582826 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-31 00:37:11.582830 | controller | Tuesday 31 March 2026 00:37:11 +0000 (0:00:00.448) 0:00:08.607 ********* 2026-03-31 00:37:11.866416 | controller | ok: [controller] 2026-03-31 00:37:11.866439 | controller | 2026-03-31 00:37:11.866444 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-31 00:37:11.866447 | controller | Tuesday 31 March 2026 00:37:11 +0000 (0:00:00.286) 0:00:08.894 ********* 2026-03-31 00:37:12.151562 | controller | ok: [controller] 2026-03-31 00:37:12.151651 | controller | 2026-03-31 00:37:12.151777 | controller | TASK [Install plugin] ********************************************************** 2026-03-31 00:37:12.151900 | controller | Tuesday 31 March 2026 00:37:12 +0000 (0:00:00.286) 0:00:09.180 ********* 2026-03-31 00:37:12.207418 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-31 00:37:12.207483 | controller | 2026-03-31 00:37:12.207547 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-31 00:37:12.207641 | controller | Tuesday 31 March 2026 00:37:12 +0000 (0:00:00.055) 0:00:09.235 ********* 2026-03-31 00:37:12.248811 | controller | ok: [controller] => { 2026-03-31 00:37:12.248938 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-31 00:37:12.249033 | controller | } 2026-03-31 00:37:12.249142 | controller | 2026-03-31 00:37:12.249265 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-31 00:37:12.249600 | controller | Tuesday 31 March 2026 00:37:12 +0000 (0:00:00.042) 0:00:09.278 ********* 2026-03-31 00:37:12.665562 | controller | ok: [controller] 2026-03-31 00:37:12.665624 | controller | 2026-03-31 00:37:12.665637 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-31 00:37:12.665744 | controller | Tuesday 31 March 2026 00:37:12 +0000 (0:00:00.416) 0:00:09.694 ********* 2026-03-31 00:37:14.271514 | controller | ok: [controller] 2026-03-31 00:37:14.271572 | controller | 2026-03-31 00:37:14.271626 | controller | PLAY RECAP ********************************************************************* 2026-03-31 00:37:14.271720 | controller | controller : ok=16 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-31 00:37:14.271808 | controller | 2026-03-31 00:37:14.271877 | controller | 2026-03-31 00:37:14.273531 | controller | TASKS RECAP ******************************************************************** 2026-03-31 00:37:14.273557 | controller | Tuesday 31 March 2026 00:37:14 +0000 (0:00:01.602) 0:00:11.297 ********* 2026-03-31 00:37:14.273561 | controller | =============================================================================== 2026-03-31 00:37:14.273564 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.67s 2026-03-31 00:37:14.273568 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.99s 2026-03-31 00:37:14.273571 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.60s 2026-03-31 00:37:14.273574 | controller | Gathering Facts --------------------------------------------------------- 1.07s 2026-03-31 00:37:14.273578 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.53s 2026-03-31 00:37:14.273581 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.52s 2026-03-31 00:37:14.273584 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.45s 2026-03-31 00:37:14.273587 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.45s 2026-03-31 00:37:14.273591 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.45s 2026-03-31 00:37:14.273594 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.42s 2026-03-31 00:37:14.273604 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.42s 2026-03-31 00:37:14.273608 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.29s 2026-03-31 00:37:14.273611 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.29s 2026-03-31 00:37:14.273614 | controller | Install plugin ---------------------------------------------------------- 0.06s 2026-03-31 00:37:14.273618 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-31 00:37:14.273621 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s 2026-03-31 00:37:14.390088 | controller | INFO [helm > idempotence] Executed: Successful 2026-03-31 00:37:14.399795 | controller | INFO [helm > side_effect] Executing 2026-03-31 00:37:14.400141 | controller | WARNING [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-31 00:37:14.405420 | controller | INFO [helm > verify] Executing 2026-03-31 00:37:15.273269 | controller | 2026-03-31 00:37:15.273579 | controller | PLAY [Verify] ****************************************************************** 2026-03-31 00:37:15.273806 | controller | 2026-03-31 00:37:15.274049 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-31 00:37:15.274293 | controller | Tuesday 31 March 2026 00:37:15 +0000 (0:00:00.011) 0:00:00.011 ********* 2026-03-31 00:37:17.330252 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-31 00:37:17.335336 | controller | ok: [controller] 2026-03-31 00:37:17.335633 | controller | 2026-03-31 00:37:17.335965 | controller | TASK [Get the current Helm version] ******************************************** 2026-03-31 00:37:17.336248 | controller | Tuesday 31 March 2026 00:37:17 +0000 (0:00:02.062) 0:00:02.073 ********* 2026-03-31 00:37:17.779320 | controller | changed: [controller] 2026-03-31 00:37:17.779598 | controller | 2026-03-31 00:37:17.779894 | controller | TASK [Assert Helm version] ***************************************************** 2026-03-31 00:37:17.780150 | controller | Tuesday 31 March 2026 00:37:17 +0000 (0:00:00.443) 0:00:02.517 ********* 2026-03-31 00:37:17.808791 | controller | ok: [controller] => { 2026-03-31 00:37:17.809053 | controller | "changed": false, 2026-03-31 00:37:17.809299 | controller | "msg": "All assertions passed" 2026-03-31 00:37:17.809536 | controller | } 2026-03-31 00:37:17.809760 | controller | 2026-03-31 00:37:17.810001 | controller | PLAY RECAP ********************************************************************* 2026-03-31 00:37:17.810269 | controller | controller : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-31 00:37:17.810494 | controller | 2026-03-31 00:37:17.810716 | controller | 2026-03-31 00:37:17.810956 | controller | TASKS RECAP ******************************************************************** 2026-03-31 00:37:17.811246 | controller | Tuesday 31 March 2026 00:37:17 +0000 (0:00:00.030) 0:00:02.547 ********* 2026-03-31 00:37:17.811485 | controller | =============================================================================== 2026-03-31 00:37:17.811791 | controller | Gathering Facts --------------------------------------------------------- 2.06s 2026-03-31 00:37:17.812043 | controller | Get the current Helm version -------------------------------------------- 0.44s 2026-03-31 00:37:17.812284 | controller | Assert Helm version ----------------------------------------------------- 0.03s 2026-03-31 00:37:17.894702 | controller | INFO [helm > verify] Executed: Successful 2026-03-31 00:37:17.907241 | controller | INFO [helm > cleanup] Executing 2026-03-31 00:37:17.907783 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-31 00:37:17.913382 | controller | INFO [helm > destroy] Executing 2026-03-31 00:37:17.913458 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-31 00:37:17.913532 | controller | INFO [helm > destroy] Executed: Successful 2026-03-31 00:37:17.913789 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-03-31 00:37:18.038503 | controller | ok: Runtime: 0:00:53.130585 2026-03-31 00:37:18.043183 | 2026-03-31 00:37:18.043257 | PLAY RECAP 2026-03-31 00:37:18.043314 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-31 00:37:18.043343 | 2026-03-31 00:37:18.163121 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-31 00:37:18.166600 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-31 00:37:18.749232 | 2026-03-31 00:37:18.749901 | PLAY [all] 2026-03-31 00:37:18.764754 | 2026-03-31 00:37:18.764844 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-03-31 00:37:19.174108 | controller | changed 2026-03-31 00:37:19.179572 | 2026-03-31 00:37:19.179674 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-03-31 00:37:19.567980 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-31 00:37:19.568075 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-31 00:37:19.575987 | controller | environment: line 1: kubectl: command not found 2026-03-31 00:37:19.577893 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-31 00:37:19.577909 | controller | environment: line 1: kubectl: command not found 2026-03-31 00:37:19.578806 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-31 00:37:19.582056 | controller | environment: line 1: kubectl: command not found 2026-03-31 00:37:19.582772 | controller | environment: line 1: kubectl: command not found 2026-03-31 00:37:19.583491 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-31 00:37:19.584001 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-31 00:37:19.586938 | controller | environment: line 1: kubectl: command not found 2026-03-31 00:37:19.587782 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-31 00:37:19.709578 | controller | ok: Runtime: 0:00:00.031121 2026-03-31 00:37:19.716118 | 2026-03-31 00:37:19.716208 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-03-31 00:37:19.952662 | controller | changed 2026-03-31 00:37:19.958993 | 2026-03-31 00:37:19.959096 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-03-31 00:37:20.200412 | controller | environment: line 5: kubectl: command not found 2026-03-31 00:37:20.203232 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-31 00:37:20.203281 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-31 00:37:20.203863 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-31 00:37:20.490038 | controller | ok: Runtime: 0:00:00.012907 2026-03-31 00:37:20.498151 | 2026-03-31 00:37:20.498249 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-03-31 00:37:21.205547 | controller | changed: 2026-03-31 00:37:21.205774 | controller | created directory /var/lib/zuul/builds/00b885b606db4d6ea45a4cdd89f86364/work/logs/controller 2026-03-31 00:37:21.205818 | controller | cd+++++++++ objects/ 2026-03-31 00:37:21.205851 | controller | cd+++++++++ objects/cluster/ 2026-03-31 00:37:21.205883 | controller | cd+++++++++ objects/namespaced/ 2026-03-31 00:37:21.215681 | 2026-03-31 00:37:21.215748 | TASK [gather-pod-logs : creating directory for pod logs] 2026-03-31 00:37:21.452201 | controller | changed 2026-03-31 00:37:21.460212 | 2026-03-31 00:37:21.460306 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-03-31 00:37:21.705792 | controller | changed 2026-03-31 00:37:21.711572 | 2026-03-31 00:37:21.711674 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-03-31 00:37:21.968703 | controller | environment: line 3: kubectl: command not found 2026-03-31 00:37:22.252563 | controller | ok: Runtime: 0:00:00.014769 2026-03-31 00:37:22.258944 | 2026-03-31 00:37:22.259033 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-03-31 00:37:22.830120 | controller | changed: 2026-03-31 00:37:22.830339 | controller | cd+++++++++ pod-logs/ 2026-03-31 00:37:22.830378 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-03-31 00:37:22.840082 | 2026-03-31 00:37:22.840169 | LOOP [helm-release-status : creating directory for helm release status] 2026-03-31 00:37:23.086492 | controller | changed: "values" 2026-03-31 00:37:23.297217 | controller | changed: "releases" 2026-03-31 00:37:23.314284 | 2026-03-31 00:37:23.314431 | TASK [helm-release-status : Gather get release status for helm charts] 2026-03-31 00:37:23.552123 | controller | /bin/bash: line 3: kubectl: command not found 2026-03-31 00:37:23.842789 | controller | ok: Runtime: 0:00:00.009003 2026-03-31 00:37:23.849206 | 2026-03-31 00:37:23.849331 | TASK [helm-release-status : Downloads logs to executor] 2026-03-31 00:37:24.366252 | controller | changed: 2026-03-31 00:37:24.366493 | controller | cd+++++++++ helm/ 2026-03-31 00:37:24.366534 | controller | cd+++++++++ helm/releases/ 2026-03-31 00:37:24.366569 | controller | cd+++++++++ helm/values/ 2026-03-31 00:37:24.373239 | 2026-03-31 00:37:24.373315 | PLAY RECAP 2026-03-31 00:37:24.373382 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-31 00:37:24.373414 | 2026-03-31 00:37:24.533660 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-31 00:37:24.536368 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-31 00:37:25.137844 | 2026-03-31 00:37:25.137977 | PLAY [all] 2026-03-31 00:37:25.148361 | 2026-03-31 00:37:25.148442 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-31 00:37:25.194910 | controller | skipping: Conditional result was False 2026-03-31 00:37:25.204287 | 2026-03-31 00:37:25.204398 | TASK [fetch-output : Set log path for single node] 2026-03-31 00:37:25.247136 | controller | ok 2026-03-31 00:37:25.252447 | 2026-03-31 00:37:25.252555 | LOOP [fetch-output : Ensure local output dirs] 2026-03-31 00:37:25.647868 | controller -> localhost | ok: "/var/lib/zuul/builds/00b885b606db4d6ea45a4cdd89f86364/work/logs" 2026-03-31 00:37:25.851032 | controller -> localhost | changed: "/var/lib/zuul/builds/00b885b606db4d6ea45a4cdd89f86364/work/artifacts" 2026-03-31 00:37:26.062375 | controller -> localhost | changed: "/var/lib/zuul/builds/00b885b606db4d6ea45a4cdd89f86364/work/docs" 2026-03-31 00:37:26.075805 | 2026-03-31 00:37:26.075955 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-31 00:37:26.775086 | controller | changed: .d..t...... ./ 2026-03-31 00:37:26.775305 | controller | changed: All items complete 2026-03-31 00:37:26.775334 | 2026-03-31 00:37:27.268556 | controller | changed: .d..t...... ./ 2026-03-31 00:37:27.766365 | controller | changed: .d..t...... ./ 2026-03-31 00:37:27.793358 | 2026-03-31 00:37:27.793584 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-31 00:37:28.252798 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.007877 2026-03-31 00:37:28.474817 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007582 2026-03-31 00:37:28.485170 | 2026-03-31 00:37:28.485299 | PLAY [all] 2026-03-31 00:37:28.490492 | 2026-03-31 00:37:28.490558 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-31 00:37:28.959510 | controller | changed 2026-03-31 00:37:28.965846 | 2026-03-31 00:37:28.965901 | PLAY RECAP 2026-03-31 00:37:28.965952 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-31 00:37:28.965974 | 2026-03-31 00:37:29.087168 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-31 00:37:29.089872 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-31 00:37:29.723903 | 2026-03-31 00:37:29.724038 | PLAY [localhost] 2026-03-31 00:37:29.734746 | 2026-03-31 00:37:29.734820 | TASK [Generate Zuul manifest] 2026-03-31 00:37:29.756669 | localhost | ok 2026-03-31 00:37:29.775255 | 2026-03-31 00:37:29.775341 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-31 00:37:30.100131 | localhost | changed 2026-03-31 00:37:30.112863 | 2026-03-31 00:37:30.112950 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-31 00:37:30.144308 | localhost | ok 2026-03-31 00:37:30.151566 | 2026-03-31 00:37:30.151631 | TASK [Upload logs] 2026-03-31 00:37:30.175009 | localhost | ok 2026-03-31 00:37:30.233766 | 2026-03-31 00:37:30.233894 | TASK [Set zuul-log-path fact] 2026-03-31 00:37:30.254930 | localhost | ok 2026-03-31 00:37:30.269600 | 2026-03-31 00:37:30.269668 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-31 00:37:30.300244 | localhost | ok 2026-03-31 00:37:30.309149 | 2026-03-31 00:37:30.309238 | TASK [upload-logs : Create log directories] 2026-03-31 00:37:30.766987 | localhost | changed 2026-03-31 00:37:30.773930 | 2026-03-31 00:37:30.774025 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-31 00:37:31.180658 | localhost -> localhost | ok: Runtime: 0:00:00.006223 2026-03-31 00:37:31.186391 | 2026-03-31 00:37:31.186456 | TASK [upload-logs : Upload logs to log server] 2026-03-31 00:37:31.742890 | localhost | Output suppressed because no_log was given 2026-03-31 00:37:31.748231 | 2026-03-31 00:37:31.748323 | LOOP [upload-logs : Compress console log and json output] 2026-03-31 00:37:31.800046 | localhost | skipping: Conditional result was False 2026-03-31 00:37:31.809236 | localhost | skipping: Conditional result was False 2026-03-31 00:37:31.824753 | 2026-03-31 00:37:31.824996 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-31 00:37:31.874036 | localhost | skipping: Conditional result was False 2026-03-31 00:37:31.874835 | 2026-03-31 00:37:31.878395 | localhost | skipping: Conditional result was False 2026-03-31 00:37:31.890493 | 2026-03-31 00:37:31.890693 | LOOP [upload-logs : Upload console log and json output]