2026-05-09 13:06:55.502472 | Job console starting 2026-05-09 13:06:55.547056 | Updating git repos 2026-05-09 13:06:55.601744 | Cloning repos into workspace 2026-05-09 13:06:56.007210 | Restoring repo states 2026-05-09 13:06:56.028609 | Merging changes 2026-05-09 13:06:57.191334 | Checking out repos 2026-05-09 13:06:57.735613 | Preparing playbooks 2026-05-09 13:07:08.478399 | Running Ansible setup 2026-05-09 13:07:12.402256 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-05-09 13:07:13.046925 | 2026-05-09 13:07:13.047055 | PLAY [localhost] 2026-05-09 13:07:13.055686 | 2026-05-09 13:07:13.055762 | TASK [Gathering Facts] 2026-05-09 13:07:14.028043 | localhost | ok 2026-05-09 13:07:14.038822 | 2026-05-09 13:07:14.038967 | TASK [Setup log path fact] 2026-05-09 13:07:14.078400 | localhost | ok 2026-05-09 13:07:14.094056 | 2026-05-09 13:07:14.094180 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-09 13:07:14.124131 | localhost | ok 2026-05-09 13:07:14.132442 | 2026-05-09 13:07:14.132548 | TASK [emit-job-header : Print job information] 2026-05-09 13:07:14.173419 | # Job Information 2026-05-09 13:07:14.173668 | Ansible Version: 2.16.18 2026-05-09 13:07:14.173737 | Job: ansible-collection-kubernetes-molecule-helm 2026-05-09 13:07:14.173786 | Pipeline: check 2026-05-09 13:07:14.173833 | Executor: 2d72f0692154 2026-05-09 13:07:14.173877 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/272 2026-05-09 13:07:14.173927 | Event ID: b77ec970-4ba6-11f1-8a7b-9de7472000d9 2026-05-09 13:07:14.178662 | 2026-05-09 13:07:14.178755 | LOOP [emit-job-header : Print node information] 2026-05-09 13:07:14.357119 | localhost | ok: 2026-05-09 13:07:14.357319 | localhost | # Node Information 2026-05-09 13:07:14.357349 | localhost | Inventory Hostname: controller 2026-05-09 13:07:14.357372 | localhost | Hostname: np0000173153 2026-05-09 13:07:14.357394 | localhost | Username: zuul 2026-05-09 13:07:14.357417 | localhost | Distro: Debian 13.4 2026-05-09 13:07:14.357438 | localhost | Provider: yul1 2026-05-09 13:07:14.357458 | localhost | Region: ca-ymq-1 2026-05-09 13:07:14.357477 | localhost | Label: debian-trixie 2026-05-09 13:07:14.357497 | localhost | Product Name: OpenStack Nova 2026-05-09 13:07:14.357516 | localhost | Interface IP: 199.204.45.250 2026-05-09 13:07:14.377889 | 2026-05-09 13:07:14.378178 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-09 13:07:14.790377 | localhost -> localhost | changed 2026-05-09 13:07:14.800812 | 2026-05-09 13:07:14.801001 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-09 13:07:15.856723 | localhost -> localhost | changed 2026-05-09 13:07:15.866105 | 2026-05-09 13:07:15.866197 | PLAY [all] 2026-05-09 13:07:15.873332 | 2026-05-09 13:07:15.873436 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-09 13:07:16.313771 | controller -> localhost | ok 2026-05-09 13:07:16.322481 | 2026-05-09 13:07:16.322629 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-09 13:07:16.364193 | controller | ok 2026-05-09 13:07:16.379422 | controller | included: /var/lib/zuul/builds/e288487918354deea172862eeae2f96e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-09 13:07:16.384174 | 2026-05-09 13:07:16.384245 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-09 13:07:18.241529 | controller -> localhost | Generating public/private rsa key pair. 2026-05-09 13:07:18.241762 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/e288487918354deea172862eeae2f96e/work/e288487918354deea172862eeae2f96e_id_rsa 2026-05-09 13:07:18.241796 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/e288487918354deea172862eeae2f96e/work/e288487918354deea172862eeae2f96e_id_rsa.pub 2026-05-09 13:07:18.241820 | controller -> localhost | The key fingerprint is: 2026-05-09 13:07:18.241843 | controller -> localhost | SHA256:Df/i/U9AMJjaZN37rqcsVVDXSKfee0xXMtFO3MvSjyk zuul-build-sshkey 2026-05-09 13:07:18.241883 | controller -> localhost | The key's randomart image is: 2026-05-09 13:07:18.241906 | controller -> localhost | +---[RSA 3072]----+ 2026-05-09 13:07:18.241935 | controller -> localhost | | +ooo=*| 2026-05-09 13:07:18.241959 | controller -> localhost | | = .o++B| 2026-05-09 13:07:18.241982 | controller -> localhost | | .= B=o| 2026-05-09 13:07:18.242004 | controller -> localhost | | .+. +.B+| 2026-05-09 13:07:18.242026 | controller -> localhost | | S o +==| 2026-05-09 13:07:18.242047 | controller -> localhost | | .E ++=| 2026-05-09 13:07:18.242069 | controller -> localhost | | . .o o+| 2026-05-09 13:07:18.242093 | controller -> localhost | | . o.. .+| 2026-05-09 13:07:18.242118 | controller -> localhost | | . .o==.| 2026-05-09 13:07:18.242140 | controller -> localhost | +----[SHA256]-----+ 2026-05-09 13:07:18.242196 | controller -> localhost | ok: Runtime: 0:00:01.080187 2026-05-09 13:07:18.247028 | 2026-05-09 13:07:18.247116 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-09 13:07:18.280759 | controller | ok 2026-05-09 13:07:18.292570 | controller | included: /var/lib/zuul/builds/e288487918354deea172862eeae2f96e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-09 13:07:18.300419 | 2026-05-09 13:07:18.300510 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-09 13:07:18.326243 | controller | skipping: Conditional result was False 2026-05-09 13:07:18.335269 | 2026-05-09 13:07:18.335419 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-09 13:07:18.908343 | controller | changed 2026-05-09 13:07:18.922144 | 2026-05-09 13:07:18.922236 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-09 13:07:19.123013 | controller | ok 2026-05-09 13:07:19.127568 | 2026-05-09 13:07:19.127633 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-09 13:07:19.734879 | controller | changed 2026-05-09 13:07:19.739680 | 2026-05-09 13:07:19.739751 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-09 13:07:20.300843 | controller | changed 2026-05-09 13:07:20.306466 | 2026-05-09 13:07:20.306555 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-09 13:07:20.330979 | controller | skipping: Conditional result was False 2026-05-09 13:07:20.338402 | 2026-05-09 13:07:20.338493 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-09 13:07:20.719213 | controller -> localhost | changed 2026-05-09 13:07:20.738643 | 2026-05-09 13:07:20.738737 | TASK [add-build-sshkey : Add back temp key] 2026-05-09 13:07:21.090408 | controller -> localhost | Identity added: /var/lib/zuul/builds/e288487918354deea172862eeae2f96e/work/e288487918354deea172862eeae2f96e_id_rsa (zuul-build-sshkey) 2026-05-09 13:07:21.090597 | controller -> localhost | ok: Runtime: 0:00:00.031106 2026-05-09 13:07:21.094551 | 2026-05-09 13:07:21.094612 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-09 13:07:21.443459 | controller | ok 2026-05-09 13:07:21.484146 | 2026-05-09 13:07:21.484340 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-09 13:07:21.509602 | controller | skipping: Conditional result was False 2026-05-09 13:07:21.521513 | 2026-05-09 13:07:21.521602 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-05-09 13:07:21.897759 | controller | ok 2026-05-09 13:07:21.904350 | 2026-05-09 13:07:21.904422 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-05-09 13:07:23.035697 | controller | Output suppressed because no_log was given 2026-05-09 13:07:23.043415 | 2026-05-09 13:07:23.043540 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-05-09 13:07:23.298187 | controller | ok: "logs" 2026-05-09 13:07:23.298482 | controller | ok: All items complete 2026-05-09 13:07:23.298526 | 2026-05-09 13:07:23.482677 | controller | ok: "artifacts" 2026-05-09 13:07:23.696639 | controller | ok: "docs" 2026-05-09 13:07:23.711806 | 2026-05-09 13:07:23.711882 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-05-09 13:07:23.927620 | controller | changed: "logs" 2026-05-09 13:07:24.124381 | controller | changed: "artifacts" 2026-05-09 13:07:24.334414 | controller | changed: "docs" 2026-05-09 13:07:25.000106 | 2026-05-09 13:07:25.000214 | PLAY RECAP 2026-05-09 13:07:25.000263 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-05-09 13:07:25.000294 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-09 13:07:25.000317 | 2026-05-09 13:07:25.157984 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-05-09 13:07:25.160291 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-05-09 13:07:25.871283 | 2026-05-09 13:07:25.871435 | PLAY [all] 2026-05-09 13:07:25.882826 | 2026-05-09 13:07:25.882937 | TASK [setup-uv : Extract archive] 2026-05-09 13:07:28.810920 | controller | changed 2026-05-09 13:07:28.817511 | 2026-05-09 13:07:28.817618 | TASK [setup-uv : Print version] 2026-05-09 13:07:29.286455 | controller | uv 0.8.13 2026-05-09 13:07:29.346010 | controller | ok: Runtime: 0:00:00.014385 2026-05-09 13:07:29.351492 | 2026-05-09 13:07:29.351568 | PLAY RECAP 2026-05-09 13:07:29.351630 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-09 13:07:29.351660 | 2026-05-09 13:07:29.480833 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-05-09 13:07:29.483033 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-05-09 13:07:30.106511 | 2026-05-09 13:07:30.263337 | PLAY [all] 2026-05-09 13:07:30.293946 | 2026-05-09 13:07:30.294118 | TASK [Update apt cache] 2026-05-09 13:07:35.199490 | controller | ok 2026-05-09 13:07:35.204018 | 2026-05-09 13:07:35.204167 | TASK [Disable firewalld] 2026-05-09 13:07:35.229116 | controller | skipping: Conditional result was False 2026-05-09 13:07:35.237574 | 2026-05-09 13:07:35.237766 | TASK [Install "jq" for log collection] 2026-05-09 13:07:37.344815 | controller | changed 2026-05-09 13:07:37.346669 | 2026-05-09 13:07:37.346714 | PLAY RECAP 2026-05-09 13:07:37.346998 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-09 13:07:37.347029 | 2026-05-09 13:07:37.540533 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-05-09 13:07:37.543243 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-05-09 13:07:38.181046 | 2026-05-09 13:07:38.181235 | PLAY [all] 2026-05-09 13:07:38.191138 | 2026-05-09 13:07:38.191304 | TASK [Copy inventory file for Zuul] 2026-05-09 13:07:39.210896 | controller | changed 2026-05-09 13:07:39.215330 | 2026-05-09 13:07:39.215455 | TASK [Switch "ansible_host" to private IP] 2026-05-09 13:07:39.582236 | controller | changed: 1 replacements made 2026-05-09 13:07:39.588403 | 2026-05-09 13:07:39.588497 | TASK [Run Molecule scenario] 2026-05-09 13:07:40.060221 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-05-09 13:07:40.060338 | controller | Creating virtual environment at: .venv 2026-05-09 13:07:40.329686 | controller | Downloading pygments (1.2MiB) 2026-05-09 13:07:40.329866 | controller | Downloading cryptography (4.3MiB) 2026-05-09 13:07:40.373954 | controller | Downloading ansible-core (2.3MiB) 2026-05-09 13:07:40.481413 | controller | Downloading cryptography 2026-05-09 13:07:40.542150 | controller | Downloading pygments 2026-05-09 13:07:40.688288 | controller | Downloading ansible-core 2026-05-09 13:07:40.731319 | controller | Installed 36 packages in 42ms 2026-05-09 13:07:41.396157 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-05-09 13:07:41.396203 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-05-09 13:07:42.261487 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-05-09 13:07:42.261549 | controller | INFO default scenario not found, disabling shared state. 2026-05-09 13:07:42.261748 | controller | INFO [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-05-09 13:07:42.261883 | controller | INFO [helm > prerun] Performing prerun with role_name_check=0... 2026-05-09 13:08:00.140456 | controller | INFO [helm > dependency] Executing 2026-05-09 13:08:00.140577 | controller | WARNING [helm > dependency] Missing roles requirements file: requirements.yml 2026-05-09 13:08:00.140862 | controller | WARNING [helm > dependency] Missing collections requirements file: collections.yml 2026-05-09 13:08:00.141055 | controller | WARNING [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-05-09 13:08:00.148503 | controller | INFO [helm > cleanup] Executing 2026-05-09 13:08:00.148814 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-05-09 13:08:00.154280 | controller | INFO [helm > destroy] Executing 2026-05-09 13:08:00.154323 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-05-09 13:08:00.154383 | controller | INFO [helm > destroy] Executed: Successful 2026-05-09 13:08:00.159606 | controller | INFO [helm > syntax] Executing 2026-05-09 13:08:01.044925 | controller | 2026-05-09 13:08:01.044953 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml 2026-05-09 13:08:01.109961 | controller | INFO [helm > syntax] Executed: Successful 2026-05-09 13:08:01.120595 | controller | INFO [helm > create] Executing 2026-05-09 13:08:01.122854 | controller | WARNING [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-05-09 13:08:01.128417 | controller | INFO [helm > prepare] Executing 2026-05-09 13:08:02.011408 | controller | 2026-05-09 13:08:02.011599 | controller | PLAY [Prepare] ***************************************************************** 2026-05-09 13:08:02.011786 | controller | 2026-05-09 13:08:02.011992 | controller | TASK [Gathering Facts] ********************************************************* 2026-05-09 13:08:02.012188 | controller | Saturday 09 May 2026 13:08:02 +0000 (0:00:00.035) 0:00:00.035 ********** 2026-05-09 13:08:03.275500 | 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-09 13:08:03.277575 | controller | ok: [controller] 2026-05-09 13:08:03.277685 | controller | 2026-05-09 13:08:03.277808 | controller | TASK [Install Debian packages] ************************************************* 2026-05-09 13:08:03.277930 | controller | Saturday 09 May 2026 13:08:03 +0000 (0:00:01.273) 0:00:01.308 ********** 2026-05-09 13:08:04.742206 | controller | ok: [controller] 2026-05-09 13:08:04.742363 | controller | 2026-05-09 13:08:04.742562 | controller | PLAY RECAP ********************************************************************* 2026-05-09 13:08:04.742772 | controller | controller : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-05-09 13:08:04.742929 | controller | 2026-05-09 13:08:04.743089 | controller | 2026-05-09 13:08:04.743262 | controller | TASKS RECAP ******************************************************************** 2026-05-09 13:08:04.743445 | controller | Saturday 09 May 2026 13:08:04 +0000 (0:00:01.464) 0:00:02.773 ********** 2026-05-09 13:08:04.743613 | controller | =============================================================================== 2026-05-09 13:08:04.743792 | controller | Install Debian packages ------------------------------------------------- 1.46s 2026-05-09 13:08:04.743969 | controller | Gathering Facts --------------------------------------------------------- 1.27s 2026-05-09 13:08:04.860030 | controller | INFO [helm > prepare] Executed: Successful 2026-05-09 13:08:04.867289 | controller | INFO [helm > converge] Executing 2026-05-09 13:08:05.735674 | controller | 2026-05-09 13:08:05.735730 | controller | PLAY [Converge] **************************************************************** 2026-05-09 13:08:05.735876 | controller | 2026-05-09 13:08:05.735993 | controller | TASK [Gathering Facts] ********************************************************* 2026-05-09 13:08:05.736128 | controller | Saturday 09 May 2026 13:08:05 +0000 (0:00:00.013) 0:00:00.013 ********** 2026-05-09 13:08:06.768632 | 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-09 13:08:06.775728 | controller | ok: [controller] 2026-05-09 13:08:06.775778 | controller | 2026-05-09 13:08:06.775871 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-05-09 13:08:06.775959 | controller | Saturday 09 May 2026 13:08:06 +0000 (0:00:01.040) 0:00:01.053 ********** 2026-05-09 13:08:07.320397 | controller | ok: [controller] 2026-05-09 13:08:07.320472 | controller | 2026-05-09 13:08:07.320600 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-05-09 13:08:07.320777 | controller | Saturday 09 May 2026 13:08:07 +0000 (0:00:00.544) 0:00:01.598 ********** 2026-05-09 13:08:08.443745 | controller | ok: [controller] 2026-05-09 13:08:08.443882 | controller | 2026-05-09 13:08:08.444090 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-05-09 13:08:08.444293 | controller | Saturday 09 May 2026 13:08:08 +0000 (0:00:01.122) 0:00:02.720 ********** 2026-05-09 13:08:08.892525 | controller | changed: [controller] 2026-05-09 13:08:08.892669 | controller | 2026-05-09 13:08:08.893029 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-05-09 13:08:08.893259 | controller | Saturday 09 May 2026 13:08:08 +0000 (0:00:00.449) 0:00:03.170 ********** 2026-05-09 13:08:08.937553 | controller | ok: [controller] => { 2026-05-09 13:08:08.937716 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-05-09 13:08:08.938000 | controller | } 2026-05-09 13:08:08.938124 | controller | 2026-05-09 13:08:08.938319 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-05-09 13:08:08.938516 | controller | Saturday 09 May 2026 13:08:08 +0000 (0:00:00.045) 0:00:03.215 ********** 2026-05-09 13:08:09.948930 | 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-09 13:08:09.958865 | controller | changed: [controller] 2026-05-09 13:08:09.959045 | controller | 2026-05-09 13:08:09.959317 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-05-09 13:08:09.959523 | controller | Saturday 09 May 2026 13:08:09 +0000 (0:00:01.021) 0:00:04.236 ********** 2026-05-09 13:08:11.943168 | controller | changed: [controller] 2026-05-09 13:08:11.943294 | controller | 2026-05-09 13:08:11.943473 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-05-09 13:08:11.943644 | controller | Saturday 09 May 2026 13:08:11 +0000 (0:00:01.983) 0:00:06.220 ********** 2026-05-09 13:08:12.446607 | controller | ok: [controller] 2026-05-09 13:08:12.446757 | controller | 2026-05-09 13:08:12.446969 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-05-09 13:08:12.447166 | controller | Saturday 09 May 2026 13:08:12 +0000 (0:00:00.503) 0:00:06.723 ********** 2026-05-09 13:08:12.867558 | controller | changed: [controller] 2026-05-09 13:08:12.867778 | controller | 2026-05-09 13:08:12.868061 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-05-09 13:08:12.868336 | controller | Saturday 09 May 2026 13:08:12 +0000 (0:00:00.420) 0:00:07.144 ********** 2026-05-09 13:08:13.359819 | controller | ok: [controller] 2026-05-09 13:08:13.359845 | controller | 2026-05-09 13:08:13.359852 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-05-09 13:08:13.359858 | controller | Saturday 09 May 2026 13:08:13 +0000 (0:00:00.491) 0:00:07.635 ********** 2026-05-09 13:08:13.647164 | controller | changed: [controller] 2026-05-09 13:08:13.647326 | controller | 2026-05-09 13:08:13.647556 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-05-09 13:08:13.647748 | controller | Saturday 09 May 2026 13:08:13 +0000 (0:00:00.288) 0:00:07.924 ********** 2026-05-09 13:08:13.978119 | controller | ok: [controller] 2026-05-09 13:08:13.978181 | controller | 2026-05-09 13:08:13.978275 | controller | TASK [Install plugin] ********************************************************** 2026-05-09 13:08:13.978361 | controller | Saturday 09 May 2026 13:08:13 +0000 (0:00:00.331) 0:00:08.255 ********** 2026-05-09 13:08:14.022516 | controller | included: vexxhost.containers.download_artifact for controller 2026-05-09 13:08:14.022605 | controller | 2026-05-09 13:08:14.022726 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-05-09 13:08:14.022834 | controller | Saturday 09 May 2026 13:08:14 +0000 (0:00:00.044) 0:00:08.300 ********** 2026-05-09 13:08:14.058357 | controller | ok: [controller] => { 2026-05-09 13:08:14.058627 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-05-09 13:08:14.058854 | controller | } 2026-05-09 13:08:14.059068 | controller | 2026-05-09 13:08:14.059310 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-05-09 13:08:14.059553 | controller | Saturday 09 May 2026 13:08:14 +0000 (0:00:00.035) 0:00:08.335 ********** 2026-05-09 13:08:14.803377 | controller | changed: [controller] 2026-05-09 13:08:14.803450 | controller | 2026-05-09 13:08:14.803561 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-05-09 13:08:14.803665 | controller | Saturday 09 May 2026 13:08:14 +0000 (0:00:00.745) 0:00:09.081 ********** 2026-05-09 13:08:16.882415 | controller | changed: [controller] 2026-05-09 13:08:16.882548 | controller | 2026-05-09 13:08:16.882731 | controller | PLAY RECAP ********************************************************************* 2026-05-09 13:08:16.883167 | controller | controller : ok=16 changed=7 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-05-09 13:08:16.883317 | controller | 2026-05-09 13:08:16.883456 | controller | 2026-05-09 13:08:16.883607 | controller | TASKS RECAP ******************************************************************** 2026-05-09 13:08:16.883772 | controller | Saturday 09 May 2026 13:08:16 +0000 (0:00:02.079) 0:00:11.160 ********** 2026-05-09 13:08:16.883923 | controller | =============================================================================== 2026-05-09 13:08:16.884085 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.08s 2026-05-09 13:08:16.884249 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.98s 2026-05-09 13:08:16.884415 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.12s 2026-05-09 13:08:16.884577 | controller | Gathering Facts --------------------------------------------------------- 1.04s 2026-05-09 13:08:16.884737 | controller | vexxhost.containers.download_artifact : Download item ------------------- 1.02s 2026-05-09 13:08:16.885180 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.75s 2026-05-09 13:08:16.885350 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.54s 2026-05-09 13:08:16.885513 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.50s 2026-05-09 13:08:16.885672 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.49s 2026-05-09 13:08:16.885836 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.45s 2026-05-09 13:08:16.885996 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.42s 2026-05-09 13:08:16.886163 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.33s 2026-05-09 13:08:16.886333 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.29s 2026-05-09 13:08:16.886492 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-05-09 13:08:16.886647 | controller | Install plugin ---------------------------------------------------------- 0.04s 2026-05-09 13:08:16.886865 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s 2026-05-09 13:08:16.997209 | controller | INFO [helm > converge] Executed: Successful 2026-05-09 13:08:17.006084 | controller | INFO [helm > idempotence] Executing 2026-05-09 13:08:17.926497 | controller | 2026-05-09 13:08:17.926596 | controller | PLAY [Converge] **************************************************************** 2026-05-09 13:08:17.926712 | controller | 2026-05-09 13:08:17.926852 | controller | TASK [Gathering Facts] ********************************************************* 2026-05-09 13:08:17.926974 | controller | Saturday 09 May 2026 13:08:17 +0000 (0:00:00.013) 0:00:00.013 ********** 2026-05-09 13:08:18.966011 | 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-09 13:08:18.973291 | controller | ok: [controller] 2026-05-09 13:08:18.973360 | controller | 2026-05-09 13:08:18.973455 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-05-09 13:08:18.973554 | controller | Saturday 09 May 2026 13:08:18 +0000 (0:00:01.044) 0:00:01.057 ********** 2026-05-09 13:08:19.422449 | controller | ok: [controller] 2026-05-09 13:08:19.422510 | controller | 2026-05-09 13:08:19.422521 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-05-09 13:08:19.422609 | controller | Saturday 09 May 2026 13:08:19 +0000 (0:00:00.451) 0:00:01.509 ********** 2026-05-09 13:08:20.361531 | controller | ok: [controller] 2026-05-09 13:08:20.361578 | controller | 2026-05-09 13:08:20.361682 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-05-09 13:08:20.361772 | controller | Saturday 09 May 2026 13:08:20 +0000 (0:00:00.939) 0:00:02.448 ********** 2026-05-09 13:08:20.783895 | controller | ok: [controller] 2026-05-09 13:08:20.783949 | controller | 2026-05-09 13:08:20.784052 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-05-09 13:08:20.784177 | controller | Saturday 09 May 2026 13:08:20 +0000 (0:00:00.422) 0:00:02.870 ********** 2026-05-09 13:08:20.831440 | controller | ok: [controller] => { 2026-05-09 13:08:20.831500 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-05-09 13:08:20.831596 | controller | } 2026-05-09 13:08:20.831625 | controller | 2026-05-09 13:08:20.831735 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-05-09 13:08:20.831832 | controller | Saturday 09 May 2026 13:08:20 +0000 (0:00:00.044) 0:00:02.915 ********** 2026-05-09 13:08:21.387877 | controller | ok: [controller] 2026-05-09 13:08:21.387903 | controller | 2026-05-09 13:08:21.387909 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-05-09 13:08:21.387915 | controller | Saturday 09 May 2026 13:08:21 +0000 (0:00:00.558) 0:00:03.473 ********** 2026-05-09 13:08:23.101044 | controller | ok: [controller] 2026-05-09 13:08:23.101167 | controller | 2026-05-09 13:08:23.101351 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-05-09 13:08:23.101520 | controller | Saturday 09 May 2026 13:08:23 +0000 (0:00:01.713) 0:00:05.187 ********** 2026-05-09 13:08:23.620958 | controller | ok: [controller] 2026-05-09 13:08:23.620988 | controller | 2026-05-09 13:08:23.620994 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-05-09 13:08:23.621000 | controller | Saturday 09 May 2026 13:08:23 +0000 (0:00:00.519) 0:00:05.706 ********** 2026-05-09 13:08:24.037631 | controller | ok: [controller] 2026-05-09 13:08:24.037655 | controller | 2026-05-09 13:08:24.037659 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-05-09 13:08:24.037663 | controller | Saturday 09 May 2026 13:08:24 +0000 (0:00:00.415) 0:00:06.121 ********** 2026-05-09 13:08:24.493721 | controller | ok: [controller] 2026-05-09 13:08:24.493747 | controller | 2026-05-09 13:08:24.493753 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-05-09 13:08:24.493759 | controller | Saturday 09 May 2026 13:08:24 +0000 (0:00:00.455) 0:00:06.577 ********** 2026-05-09 13:08:24.783935 | controller | ok: [controller] 2026-05-09 13:08:24.783958 | controller | 2026-05-09 13:08:24.783962 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-05-09 13:08:24.783966 | controller | Saturday 09 May 2026 13:08:24 +0000 (0:00:00.291) 0:00:06.869 ********** 2026-05-09 13:08:25.096809 | controller | ok: [controller] 2026-05-09 13:08:25.096896 | controller | 2026-05-09 13:08:25.097073 | controller | TASK [Install plugin] ********************************************************** 2026-05-09 13:08:25.097106 | controller | Saturday 09 May 2026 13:08:25 +0000 (0:00:00.314) 0:00:07.183 ********** 2026-05-09 13:08:25.151360 | controller | included: vexxhost.containers.download_artifact for controller 2026-05-09 13:08:25.151405 | controller | 2026-05-09 13:08:25.151495 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-05-09 13:08:25.151597 | controller | Saturday 09 May 2026 13:08:25 +0000 (0:00:00.052) 0:00:07.236 ********** 2026-05-09 13:08:25.194867 | controller | ok: [controller] => { 2026-05-09 13:08:25.195019 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-05-09 13:08:25.195141 | controller | } 2026-05-09 13:08:25.195263 | controller | 2026-05-09 13:08:25.195417 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-05-09 13:08:25.195555 | controller | Saturday 09 May 2026 13:08:25 +0000 (0:00:00.045) 0:00:07.281 ********** 2026-05-09 13:08:25.614060 | controller | ok: [controller] 2026-05-09 13:08:25.614089 | controller | 2026-05-09 13:08:25.614095 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-05-09 13:08:25.614105 | controller | Saturday 09 May 2026 13:08:25 +0000 (0:00:00.416) 0:00:07.698 ********** 2026-05-09 13:08:27.244374 | controller | ok: [controller] 2026-05-09 13:08:27.244408 | controller | 2026-05-09 13:08:27.244417 | controller | PLAY RECAP ********************************************************************* 2026-05-09 13:08:27.244426 | controller | controller : ok=16 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-05-09 13:08:27.244434 | controller | 2026-05-09 13:08:27.244442 | controller | 2026-05-09 13:08:27.244449 | controller | TASKS RECAP ******************************************************************** 2026-05-09 13:08:27.244457 | controller | Saturday 09 May 2026 13:08:27 +0000 (0:00:01.628) 0:00:09.326 ********** 2026-05-09 13:08:27.244464 | controller | =============================================================================== 2026-05-09 13:08:27.244471 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.71s 2026-05-09 13:08:27.244478 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.63s 2026-05-09 13:08:27.244486 | controller | Gathering Facts --------------------------------------------------------- 1.04s 2026-05-09 13:08:27.244493 | controller | vexxhost.containers.package : Update state for tar ---------------------- 0.94s 2026-05-09 13:08:27.244500 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.56s 2026-05-09 13:08:27.244507 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.52s 2026-05-09 13:08:27.244514 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.46s 2026-05-09 13:08:27.244521 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.45s 2026-05-09 13:08:27.244529 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.42s 2026-05-09 13:08:27.244536 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.42s 2026-05-09 13:08:27.244557 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.42s 2026-05-09 13:08:27.244564 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.31s 2026-05-09 13:08:27.244572 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.29s 2026-05-09 13:08:27.244579 | controller | Install plugin ---------------------------------------------------------- 0.05s 2026-05-09 13:08:27.244586 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-05-09 13:08:27.244593 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s 2026-05-09 13:08:27.323725 | controller | INFO [helm > idempotence] Executed: Successful 2026-05-09 13:08:27.334483 | controller | INFO [helm > side_effect] Executing 2026-05-09 13:08:27.334813 | controller | WARNING [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-05-09 13:08:27.340217 | controller | INFO [helm > verify] Executing 2026-05-09 13:08:28.193576 | controller | 2026-05-09 13:08:28.193885 | controller | PLAY [Verify] ****************************************************************** 2026-05-09 13:08:28.194128 | controller | 2026-05-09 13:08:28.194385 | controller | TASK [Gathering Facts] ********************************************************* 2026-05-09 13:08:28.194637 | controller | Saturday 09 May 2026 13:08:28 +0000 (0:00:00.010) 0:00:00.010 ********** 2026-05-09 13:08:29.281460 | 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-09 13:08:29.288361 | controller | ok: [controller] 2026-05-09 13:08:29.288498 | controller | 2026-05-09 13:08:29.288640 | controller | TASK [Get the current Helm version] ******************************************** 2026-05-09 13:08:29.288775 | controller | Saturday 09 May 2026 13:08:29 +0000 (0:00:01.095) 0:00:01.105 ********** 2026-05-09 13:08:29.727571 | controller | changed: [controller] 2026-05-09 13:08:29.727875 | controller | 2026-05-09 13:08:29.728148 | controller | TASK [Assert Helm version] ***************************************************** 2026-05-09 13:08:29.728407 | controller | Saturday 09 May 2026 13:08:29 +0000 (0:00:00.438) 0:00:01.544 ********** 2026-05-09 13:08:29.756274 | controller | ok: [controller] => { 2026-05-09 13:08:29.756632 | controller | "changed": false, 2026-05-09 13:08:29.756999 | controller | "msg": "All assertions passed" 2026-05-09 13:08:29.757270 | controller | } 2026-05-09 13:08:29.757634 | controller | 2026-05-09 13:08:29.757926 | controller | PLAY RECAP ********************************************************************* 2026-05-09 13:08:29.758204 | controller | controller : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-05-09 13:08:29.758494 | controller | 2026-05-09 13:08:29.758752 | controller | 2026-05-09 13:08:29.758999 | controller | TASKS RECAP ******************************************************************** 2026-05-09 13:08:29.759249 | controller | Saturday 09 May 2026 13:08:29 +0000 (0:00:00.029) 0:00:01.573 ********** 2026-05-09 13:08:29.759510 | controller | =============================================================================== 2026-05-09 13:08:29.759762 | controller | Gathering Facts --------------------------------------------------------- 1.10s 2026-05-09 13:08:29.760008 | controller | Get the current Helm version -------------------------------------------- 0.44s 2026-05-09 13:08:29.760250 | controller | Assert Helm version ----------------------------------------------------- 0.03s 2026-05-09 13:08:29.857876 | controller | INFO [helm > verify] Executed: Successful 2026-05-09 13:08:29.868207 | controller | INFO [helm > cleanup] Executing 2026-05-09 13:08:29.868659 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-05-09 13:08:29.876104 | controller | INFO [helm > destroy] Executing 2026-05-09 13:08:29.876227 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-05-09 13:08:29.876342 | controller | INFO [helm > destroy] Executed: Successful 2026-05-09 13:08:29.876711 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-05-09 13:08:30.165642 | controller | ok: Runtime: 0:00:49.968101 2026-05-09 13:08:30.174232 | 2026-05-09 13:08:30.174405 | PLAY RECAP 2026-05-09 13:08:30.174471 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-09 13:08:30.174502 | 2026-05-09 13:08:30.331359 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-05-09 13:08:30.334428 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-05-09 13:08:30.988392 | 2026-05-09 13:08:31.068724 | PLAY [all] 2026-05-09 13:08:31.085825 | 2026-05-09 13:08:31.085927 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-05-09 13:08:31.493828 | controller | changed 2026-05-09 13:08:31.499564 | 2026-05-09 13:08:31.499662 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-05-09 13:08:31.920580 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-05-09 13:08:31.921136 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-05-09 13:08:31.927161 | controller | environment: line 1: kubectl: command not found 2026-05-09 13:08:31.928618 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-05-09 13:08:31.930641 | controller | environment: line 1: kubectl: command not found 2026-05-09 13:08:31.931768 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-05-09 13:08:31.934925 | controller | environment: line 1: kubectl: command not found 2026-05-09 13:08:31.936453 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-05-09 13:08:31.937643 | controller | environment: line 1: kubectl: command not found 2026-05-09 13:08:31.939432 | controller | environment: line 1: kubectl: command not found 2026-05-09 13:08:31.939787 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-05-09 13:08:31.941529 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-05-09 13:08:32.034915 | controller | ok: Runtime: 0:00:00.033006 2026-05-09 13:08:32.040733 | 2026-05-09 13:08:32.040826 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-05-09 13:08:32.274933 | controller | changed 2026-05-09 13:08:32.280857 | 2026-05-09 13:08:32.281307 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-05-09 13:08:32.534207 | controller | environment: line 5: kubectl: command not found 2026-05-09 13:08:32.535308 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-05-09 13:08:32.535628 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-05-09 13:08:32.536365 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-05-09 13:08:32.807461 | controller | ok: Runtime: 0:00:00.012553 2026-05-09 13:08:32.815670 | 2026-05-09 13:08:32.815739 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-05-09 13:08:33.516555 | controller | changed: 2026-05-09 13:08:33.516766 | controller | created directory /var/lib/zuul/builds/e288487918354deea172862eeae2f96e/work/logs/controller 2026-05-09 13:08:33.516808 | controller | cd+++++++++ objects/ 2026-05-09 13:08:33.516838 | controller | cd+++++++++ objects/cluster/ 2026-05-09 13:08:33.516869 | controller | cd+++++++++ objects/namespaced/ 2026-05-09 13:08:33.526688 | 2026-05-09 13:08:33.526759 | TASK [gather-pod-logs : creating directory for pod logs] 2026-05-09 13:08:33.770649 | controller | changed 2026-05-09 13:08:33.774713 | 2026-05-09 13:08:33.774778 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-05-09 13:08:34.009265 | controller | changed 2026-05-09 13:08:34.014796 | 2026-05-09 13:08:34.014893 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-05-09 13:08:34.274936 | controller | environment: line 3: kubectl: command not found 2026-05-09 13:08:34.544128 | controller | ok: Runtime: 0:00:00.012243 2026-05-09 13:08:34.549931 | 2026-05-09 13:08:34.550023 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-05-09 13:08:35.088432 | controller | changed: 2026-05-09 13:08:35.088637 | controller | cd+++++++++ pod-logs/ 2026-05-09 13:08:35.088674 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-05-09 13:08:35.097699 | 2026-05-09 13:08:35.097764 | LOOP [helm-release-status : creating directory for helm release status] 2026-05-09 13:08:35.331263 | controller | changed: "values" 2026-05-09 13:08:35.550996 | controller | changed: "releases" 2026-05-09 13:08:35.569818 | 2026-05-09 13:08:35.570024 | TASK [helm-release-status : Gather get release status for helm charts] 2026-05-09 13:08:35.805082 | controller | /bin/bash: line 3: kubectl: command not found 2026-05-09 13:08:36.099998 | controller | ok: Runtime: 0:00:00.008837 2026-05-09 13:08:36.106156 | 2026-05-09 13:08:36.106219 | TASK [helm-release-status : Downloads logs to executor] 2026-05-09 13:08:36.630366 | controller | changed: 2026-05-09 13:08:36.630654 | controller | cd+++++++++ helm/ 2026-05-09 13:08:36.630696 | controller | cd+++++++++ helm/releases/ 2026-05-09 13:08:36.630728 | controller | cd+++++++++ helm/values/ 2026-05-09 13:08:36.636654 | 2026-05-09 13:08:36.636708 | PLAY RECAP 2026-05-09 13:08:36.636758 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-09 13:08:36.636780 | 2026-05-09 13:08:36.787299 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-05-09 13:08:36.788696 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-05-09 13:08:37.424268 | 2026-05-09 13:08:37.424703 | PLAY [all] 2026-05-09 13:08:37.435202 | 2026-05-09 13:08:37.435279 | TASK [fetch-output : Set log path for multiple nodes] 2026-05-09 13:08:37.480135 | controller | skipping: Conditional result was False 2026-05-09 13:08:37.484611 | 2026-05-09 13:08:37.484691 | TASK [fetch-output : Set log path for single node] 2026-05-09 13:08:37.524823 | controller | ok 2026-05-09 13:08:37.531127 | 2026-05-09 13:08:37.531222 | LOOP [fetch-output : Ensure local output dirs] 2026-05-09 13:08:37.962772 | controller -> localhost | ok: "/var/lib/zuul/builds/e288487918354deea172862eeae2f96e/work/logs" 2026-05-09 13:08:38.178467 | controller -> localhost | changed: "/var/lib/zuul/builds/e288487918354deea172862eeae2f96e/work/artifacts" 2026-05-09 13:08:38.397651 | controller -> localhost | changed: "/var/lib/zuul/builds/e288487918354deea172862eeae2f96e/work/docs" 2026-05-09 13:08:38.411841 | 2026-05-09 13:08:38.412047 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-09 13:08:39.094001 | controller | changed: .d..t...... ./ 2026-05-09 13:08:39.094210 | controller | changed: All items complete 2026-05-09 13:08:39.094238 | 2026-05-09 13:08:39.576696 | controller | changed: .d..t...... ./ 2026-05-09 13:08:40.050759 | controller | changed: .d..t...... ./ 2026-05-09 13:08:40.067169 | 2026-05-09 13:08:40.067333 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-09 13:08:40.533406 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.009308 2026-05-09 13:08:40.764210 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.008339 2026-05-09 13:08:40.787665 | 2026-05-09 13:08:40.787806 | PLAY [all] 2026-05-09 13:08:40.793359 | 2026-05-09 13:08:40.793467 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-09 13:08:41.278668 | controller | changed 2026-05-09 13:08:41.283131 | 2026-05-09 13:08:41.283181 | PLAY RECAP 2026-05-09 13:08:41.283228 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-09 13:08:41.283250 | 2026-05-09 13:08:41.401013 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-05-09 13:08:41.404300 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-09 13:08:41.974852 | 2026-05-09 13:08:41.975289 | PLAY [localhost] 2026-05-09 13:08:41.985217 | 2026-05-09 13:08:41.985288 | TASK [Generate Zuul manifest] 2026-05-09 13:08:42.006819 | localhost | ok 2026-05-09 13:08:42.023010 | 2026-05-09 13:08:42.023085 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-09 13:08:42.410631 | localhost | changed 2026-05-09 13:08:42.422303 | 2026-05-09 13:08:42.422396 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-09 13:08:42.453272 | localhost | ok 2026-05-09 13:08:42.462118 | 2026-05-09 13:08:42.462208 | TASK [Upload logs] 2026-05-09 13:08:42.483735 | localhost | ok 2026-05-09 13:08:42.543119 | 2026-05-09 13:08:42.543251 | TASK [Set zuul-log-path fact] 2026-05-09 13:08:42.565358 | localhost | ok 2026-05-09 13:08:42.578146 | 2026-05-09 13:08:42.578215 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-09 13:08:42.610409 | localhost | ok 2026-05-09 13:08:42.620599 | 2026-05-09 13:08:42.620668 | TASK [upload-logs : Create log directories] 2026-05-09 13:08:43.049568 | localhost | changed 2026-05-09 13:08:43.055898 | 2026-05-09 13:08:43.055964 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-09 13:08:43.474017 | localhost -> localhost | ok: Runtime: 0:00:00.005597 2026-05-09 13:08:43.479916 | 2026-05-09 13:08:43.479983 | TASK [upload-logs : Upload logs to log server] 2026-05-09 13:08:43.937075 | localhost | Output suppressed because no_log was given 2026-05-09 13:08:43.942178 | 2026-05-09 13:08:43.942274 | LOOP [upload-logs : Compress console log and json output] 2026-05-09 13:08:43.985715 | localhost | skipping: Conditional result was False 2026-05-09 13:08:44.033222 | localhost | skipping: Conditional result was False 2026-05-09 13:08:44.046014 | 2026-05-09 13:08:44.046151 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-09 13:08:44.088438 | localhost | skipping: Conditional result was False 2026-05-09 13:08:44.088738 | 2026-05-09 13:08:44.093031 | localhost | skipping: Conditional result was False 2026-05-09 13:08:44.109239 | 2026-05-09 13:08:44.109357 | LOOP [upload-logs : Upload console log and json output]