2026-04-17 10:28:26.965900 | Job console starting 2026-04-17 10:28:26.974506 | Updating git repos 2026-04-17 10:28:27.023947 | Cloning repos into workspace 2026-04-17 10:28:27.189762 | Restoring repo states 2026-04-17 10:28:27.203272 | Merging changes 2026-04-17 10:28:27.764777 | Checking out repos 2026-04-17 10:28:28.057915 | Preparing playbooks 2026-04-17 10:28:31.207080 | Running Ansible setup 2026-04-17 10:28:36.862366 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-17 10:28:37.570514 | 2026-04-17 10:28:37.570659 | PLAY [localhost] 2026-04-17 10:28:37.578421 | 2026-04-17 10:28:37.578493 | TASK [Gathering Facts] 2026-04-17 10:28:38.757965 | localhost | ok 2026-04-17 10:28:38.768819 | 2026-04-17 10:28:38.769043 | TASK [Setup log path fact] 2026-04-17 10:28:38.785533 | localhost | ok 2026-04-17 10:28:38.798504 | 2026-04-17 10:28:38.798578 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-17 10:28:38.829056 | localhost | ok 2026-04-17 10:28:38.839081 | 2026-04-17 10:28:38.839179 | TASK [emit-job-header : Print job information] 2026-04-17 10:28:38.890268 | # Job Information 2026-04-17 10:28:38.890446 | Ansible Version: 2.16.16 2026-04-17 10:28:38.890504 | Job: ansible-collection-kubernetes-molecule-helm 2026-04-17 10:28:38.890547 | Pipeline: check 2026-04-17 10:28:38.890586 | Executor: 0a8996d2b663 2026-04-17 10:28:38.890621 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/262 2026-04-17 10:28:38.890661 | Event ID: 0d80fed0-3a48-11f1-8755-44385fadf471 2026-04-17 10:28:38.894715 | 2026-04-17 10:28:38.894825 | LOOP [emit-job-header : Print node information] 2026-04-17 10:28:38.980769 | localhost | ok: 2026-04-17 10:28:38.981039 | localhost | # Node Information 2026-04-17 10:28:38.981103 | localhost | Inventory Hostname: controller 2026-04-17 10:28:38.981146 | localhost | Hostname: np0000167063 2026-04-17 10:28:38.981187 | localhost | Username: zuul 2026-04-17 10:28:38.981231 | localhost | Distro: Debian 13.4 2026-04-17 10:28:38.981273 | localhost | Provider: yul1 2026-04-17 10:28:38.981314 | localhost | Region: ca-ymq-1 2026-04-17 10:28:38.981421 | localhost | Label: debian-trixie 2026-04-17 10:28:38.981552 | localhost | Product Name: OpenStack Nova 2026-04-17 10:28:38.981608 | localhost | Interface IP: 199.204.45.95 2026-04-17 10:28:39.004622 | 2026-04-17 10:28:39.004823 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-17 10:28:39.648462 | localhost -> localhost | changed 2026-04-17 10:28:39.658843 | 2026-04-17 10:28:39.658985 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-17 10:28:40.584356 | localhost -> localhost | changed 2026-04-17 10:28:40.590241 | 2026-04-17 10:28:40.590295 | PLAY [all] 2026-04-17 10:28:40.597469 | 2026-04-17 10:28:40.597533 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-17 10:28:40.852917 | controller -> localhost | ok 2026-04-17 10:28:40.858879 | 2026-04-17 10:28:40.858957 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-17 10:28:40.886303 | controller | ok 2026-04-17 10:28:40.898560 | controller | included: /var/lib/zuul/builds/14d76d02c8f64459b2568ec1579ab802/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-17 10:28:40.903265 | 2026-04-17 10:28:40.903327 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-17 10:28:43.631649 | controller -> localhost | Generating public/private rsa key pair. 2026-04-17 10:28:43.631949 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/14d76d02c8f64459b2568ec1579ab802/work/14d76d02c8f64459b2568ec1579ab802_id_rsa 2026-04-17 10:28:43.632018 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/14d76d02c8f64459b2568ec1579ab802/work/14d76d02c8f64459b2568ec1579ab802_id_rsa.pub 2026-04-17 10:28:43.632070 | controller -> localhost | The key fingerprint is: 2026-04-17 10:28:43.632120 | controller -> localhost | SHA256:gCv395DNLDJqZQMY4IO1+fqQb4nmjkRjiQ0Xtne/pZs zuul-build-sshkey 2026-04-17 10:28:43.632190 | controller -> localhost | The key's randomart image is: 2026-04-17 10:28:43.632240 | controller -> localhost | +---[RSA 3072]----+ 2026-04-17 10:28:43.632298 | controller -> localhost | |..+ | 2026-04-17 10:28:43.632347 | controller -> localhost | |oo.= . | 2026-04-17 10:28:43.632394 | controller -> localhost | |oo=oo o | 2026-04-17 10:28:43.632441 | controller -> localhost | |.++o.o o | 2026-04-17 10:28:43.632487 | controller -> localhost | |.=o +. S . | 2026-04-17 10:28:43.632533 | controller -> localhost | |o .= .+ O | 2026-04-17 10:28:43.632579 | controller -> localhost | | .+. ++.B + | 2026-04-17 10:28:43.632626 | controller -> localhost | |..o++. + * | 2026-04-17 10:28:43.632679 | controller -> localhost | |.+oo+ E . | 2026-04-17 10:28:43.632726 | controller -> localhost | +----[SHA256]-----+ 2026-04-17 10:28:43.632830 | controller -> localhost | ok: Runtime: 0:00:02.303137 2026-04-17 10:28:43.637921 | 2026-04-17 10:28:43.637986 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-17 10:28:43.669959 | controller | ok 2026-04-17 10:28:43.681341 | controller | included: /var/lib/zuul/builds/14d76d02c8f64459b2568ec1579ab802/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-17 10:28:43.689575 | 2026-04-17 10:28:43.689643 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-17 10:28:43.714409 | controller | skipping: Conditional result was False 2026-04-17 10:28:43.721190 | 2026-04-17 10:28:43.721293 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-17 10:28:44.270176 | controller | changed 2026-04-17 10:28:44.274569 | 2026-04-17 10:28:44.274657 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-17 10:28:44.465410 | controller | ok 2026-04-17 10:28:44.469642 | 2026-04-17 10:28:44.469709 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-17 10:28:44.996120 | controller | changed 2026-04-17 10:28:45.000965 | 2026-04-17 10:28:45.001032 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-17 10:28:45.551613 | controller | changed 2026-04-17 10:28:45.558765 | 2026-04-17 10:28:45.558860 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-17 10:28:45.583329 | controller | skipping: Conditional result was False 2026-04-17 10:28:45.593637 | 2026-04-17 10:28:45.593708 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-17 10:28:45.951939 | controller -> localhost | changed 2026-04-17 10:28:45.965219 | 2026-04-17 10:28:45.965327 | TASK [add-build-sshkey : Add back temp key] 2026-04-17 10:28:46.227382 | controller -> localhost | Identity added: /var/lib/zuul/builds/14d76d02c8f64459b2568ec1579ab802/work/14d76d02c8f64459b2568ec1579ab802_id_rsa (zuul-build-sshkey) 2026-04-17 10:28:46.227631 | controller -> localhost | ok: Runtime: 0:00:00.013473 2026-04-17 10:28:46.233233 | 2026-04-17 10:28:46.233353 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-17 10:28:46.595858 | controller | ok 2026-04-17 10:28:46.599656 | 2026-04-17 10:28:46.599728 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-17 10:28:46.623824 | controller | skipping: Conditional result was False 2026-04-17 10:28:46.638487 | 2026-04-17 10:28:46.638586 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-17 10:28:46.992577 | controller | ok 2026-04-17 10:28:46.997811 | 2026-04-17 10:28:46.997900 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-17 10:28:48.044868 | controller | Output suppressed because no_log was given 2026-04-17 10:28:48.053842 | 2026-04-17 10:28:48.053933 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-17 10:28:48.263267 | controller | ok: "logs" 2026-04-17 10:28:48.263616 | controller | ok: All items complete 2026-04-17 10:28:48.263655 | 2026-04-17 10:28:48.444474 | controller | ok: "artifacts" 2026-04-17 10:28:48.629242 | controller | ok: "docs" 2026-04-17 10:28:48.649092 | 2026-04-17 10:28:48.649272 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-17 10:28:48.852305 | controller | changed: "logs" 2026-04-17 10:28:49.034125 | controller | changed: "artifacts" 2026-04-17 10:28:49.225141 | controller | changed: "docs" 2026-04-17 10:28:49.237875 | 2026-04-17 10:28:49.238030 | PLAY RECAP 2026-04-17 10:28:49.238098 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-17 10:28:49.238142 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-17 10:28:49.238175 | 2026-04-17 10:28:49.362740 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-17 10:28:49.364057 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-17 10:28:50.006668 | 2026-04-17 10:28:50.006794 | PLAY [all] 2026-04-17 10:28:50.016618 | 2026-04-17 10:28:50.016693 | TASK [setup-uv : Extract archive] 2026-04-17 10:28:52.423741 | controller | changed 2026-04-17 10:28:52.430537 | 2026-04-17 10:28:52.430634 | TASK [setup-uv : Print version] 2026-04-17 10:28:52.819237 | controller | uv 0.8.13 2026-04-17 10:28:52.961316 | controller | ok: Runtime: 0:00:00.013220 2026-04-17 10:28:52.969519 | 2026-04-17 10:28:52.969580 | PLAY RECAP 2026-04-17 10:28:52.969626 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-17 10:28:52.969650 | 2026-04-17 10:28:53.107068 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-17 10:28:53.110423 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-04-17 10:28:53.755266 | 2026-04-17 10:28:53.755442 | PLAY [all] 2026-04-17 10:28:53.766287 | 2026-04-17 10:28:53.766415 | TASK [Update apt cache] 2026-04-17 10:28:58.721915 | controller | ok 2026-04-17 10:28:58.726975 | 2026-04-17 10:28:58.727064 | TASK [Disable firewalld] 2026-04-17 10:28:58.752683 | controller | skipping: Conditional result was False 2026-04-17 10:28:58.762021 | 2026-04-17 10:28:58.762165 | TASK [Install "jq" for log collection] 2026-04-17 10:29:01.171510 | controller | changed 2026-04-17 10:29:01.174893 | 2026-04-17 10:29:01.174941 | PLAY RECAP 2026-04-17 10:29:01.174985 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-17 10:29:01.175007 | 2026-04-17 10:29:01.278738 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-04-17 10:29:01.451134 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-17 10:29:02.046222 | 2026-04-17 10:29:02.046448 | PLAY [all] 2026-04-17 10:29:02.060878 | 2026-04-17 10:29:02.061165 | TASK [Copy inventory file for Zuul] 2026-04-17 10:29:03.581613 | controller | changed 2026-04-17 10:29:03.588395 | 2026-04-17 10:29:03.588497 | TASK [Switch "ansible_host" to private IP] 2026-04-17 10:29:03.883795 | controller | changed: 1 replacements made 2026-04-17 10:29:03.889664 | 2026-04-17 10:29:03.889748 | TASK [Run Molecule scenario] 2026-04-17 10:29:04.321515 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-04-17 10:29:04.321633 | controller | Creating virtual environment at: .venv 2026-04-17 10:29:04.591138 | controller | Downloading ansible-core (2.3MiB) 2026-04-17 10:29:04.591348 | controller | Downloading cryptography (4.3MiB) 2026-04-17 10:29:04.591550 | controller | Downloading pygments (1.2MiB) 2026-04-17 10:29:04.756991 | controller | Downloading cryptography 2026-04-17 10:29:04.809447 | controller | Downloading pygments 2026-04-17 10:29:04.975418 | controller | Downloading ansible-core 2026-04-17 10:29:05.026763 | controller | Installed 36 packages in 50ms 2026-04-17 10:29:05.722148 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-04-17 10:29:05.722221 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-04-17 10:29:06.627029 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-04-17 10:29:06.627104 | controller | INFO default scenario not found, disabling shared state. 2026-04-17 10:29:06.627201 | controller | INFO [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-04-17 10:29:06.627270 | controller | INFO [helm > prerun] Performing prerun with role_name_check=0... 2026-04-17 10:29:21.827033 | controller | INFO [helm > dependency] Executing 2026-04-17 10:29:21.827174 | controller | WARNING [helm > dependency] Missing roles requirements file: requirements.yml 2026-04-17 10:29:21.827487 | controller | WARNING [helm > dependency] Missing collections requirements file: collections.yml 2026-04-17 10:29:21.827731 | controller | WARNING [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-04-17 10:29:21.835264 | controller | INFO [helm > cleanup] Executing 2026-04-17 10:29:21.835634 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-17 10:29:21.841379 | controller | INFO [helm > destroy] Executing 2026-04-17 10:29:21.841414 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-04-17 10:29:21.841515 | controller | INFO [helm > destroy] Executed: Successful 2026-04-17 10:29:21.846992 | controller | INFO [helm > syntax] Executing 2026-04-17 10:29:22.776847 | controller | 2026-04-17 10:29:22.777040 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml 2026-04-17 10:29:22.861418 | controller | INFO [helm > syntax] Executed: Successful 2026-04-17 10:29:22.872746 | controller | INFO [helm > create] Executing 2026-04-17 10:29:22.874166 | controller | WARNING [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-17 10:29:22.879419 | controller | INFO [helm > prepare] Executing 2026-04-17 10:29:23.728222 | controller | 2026-04-17 10:29:23.728300 | controller | PLAY [Prepare] ***************************************************************** 2026-04-17 10:29:23.728474 | controller | 2026-04-17 10:29:23.728720 | controller | TASK [Gathering Facts] ********************************************************* 2026-04-17 10:29:23.728918 | controller | Friday 17 April 2026 10:29:23 +0000 (0:00:00.029) 0:00:00.029 ********** 2026-04-17 10:29:26.082335 | 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-04-17 10:29:26.089470 | controller | ok: [controller] 2026-04-17 10:29:26.089634 | controller | 2026-04-17 10:29:26.089881 | controller | TASK [Install Debian packages] ************************************************* 2026-04-17 10:29:26.090137 | controller | Friday 17 April 2026 10:29:26 +0000 (0:00:02.361) 0:00:02.391 ********** 2026-04-17 10:29:27.523241 | controller | ok: [controller] 2026-04-17 10:29:27.523372 | controller | 2026-04-17 10:29:27.523559 | controller | PLAY RECAP ********************************************************************* 2026-04-17 10:29:27.523782 | controller | controller : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-17 10:29:27.523974 | controller | 2026-04-17 10:29:27.524207 | controller | 2026-04-17 10:29:27.524404 | controller | TASKS RECAP ******************************************************************** 2026-04-17 10:29:27.524653 | controller | Friday 17 April 2026 10:29:27 +0000 (0:00:01.434) 0:00:03.825 ********** 2026-04-17 10:29:27.524836 | controller | =============================================================================== 2026-04-17 10:29:27.525037 | controller | Gathering Facts --------------------------------------------------------- 2.36s 2026-04-17 10:29:27.525228 | controller | Install Debian packages ------------------------------------------------- 1.43s 2026-04-17 10:29:27.655209 | controller | INFO [helm > prepare] Executed: Successful 2026-04-17 10:29:27.663359 | controller | INFO [helm > converge] Executing 2026-04-17 10:29:28.562092 | controller | 2026-04-17 10:29:28.562160 | controller | PLAY [Converge] **************************************************************** 2026-04-17 10:29:28.562302 | controller | 2026-04-17 10:29:28.562468 | controller | TASK [Gathering Facts] ********************************************************* 2026-04-17 10:29:28.562805 | controller | Friday 17 April 2026 10:29:28 +0000 (0:00:00.016) 0:00:00.017 ********** 2026-04-17 10:29:30.650074 | 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-04-17 10:29:30.656830 | controller | ok: [controller] 2026-04-17 10:29:30.656948 | controller | 2026-04-17 10:29:30.657077 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-17 10:29:30.657204 | controller | Friday 17 April 2026 10:29:30 +0000 (0:00:02.096) 0:00:02.113 ********** 2026-04-17 10:29:31.178206 | controller | ok: [controller] 2026-04-17 10:29:31.178250 | controller | 2026-04-17 10:29:31.178361 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-17 10:29:31.178565 | controller | Friday 17 April 2026 10:29:31 +0000 (0:00:00.518) 0:00:02.632 ********** 2026-04-17 10:29:32.261593 | controller | ok: [controller] 2026-04-17 10:29:32.261750 | controller | 2026-04-17 10:29:32.262002 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-04-17 10:29:32.262201 | controller | Friday 17 April 2026 10:29:32 +0000 (0:00:01.084) 0:00:03.717 ********** 2026-04-17 10:29:32.691989 | controller | changed: [controller] 2026-04-17 10:29:32.692126 | controller | 2026-04-17 10:29:32.692355 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-17 10:29:32.692592 | controller | Friday 17 April 2026 10:29:32 +0000 (0:00:00.430) 0:00:04.148 ********** 2026-04-17 10:29:32.740640 | controller | ok: [controller] => { 2026-04-17 10:29:32.740825 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-04-17 10:29:32.741018 | controller | } 2026-04-17 10:29:32.741197 | controller | 2026-04-17 10:29:32.741395 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-17 10:29:32.741593 | controller | Friday 17 April 2026 10:29:32 +0000 (0:00:00.048) 0:00:04.196 ********** 2026-04-17 10:29:33.713427 | 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-04-17 10:29:33.723269 | controller | changed: [controller] 2026-04-17 10:29:33.723458 | controller | 2026-04-17 10:29:33.723668 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-17 10:29:33.723863 | controller | Friday 17 April 2026 10:29:33 +0000 (0:00:00.982) 0:00:05.179 ********** 2026-04-17 10:29:35.845310 | controller | changed: [controller] 2026-04-17 10:29:35.845388 | controller | 2026-04-17 10:29:35.845489 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-04-17 10:29:35.845617 | controller | Friday 17 April 2026 10:29:35 +0000 (0:00:02.119) 0:00:07.299 ********** 2026-04-17 10:29:36.388620 | controller | ok: [controller] 2026-04-17 10:29:36.388663 | controller | 2026-04-17 10:29:36.388674 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-04-17 10:29:36.388682 | controller | Friday 17 April 2026 10:29:36 +0000 (0:00:00.543) 0:00:07.842 ********** 2026-04-17 10:29:36.782581 | controller | changed: [controller] 2026-04-17 10:29:36.782736 | controller | 2026-04-17 10:29:36.782940 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-04-17 10:29:36.783133 | controller | Friday 17 April 2026 10:29:36 +0000 (0:00:00.395) 0:00:08.238 ********** 2026-04-17 10:29:37.256197 | controller | ok: [controller] 2026-04-17 10:29:37.256381 | controller | 2026-04-17 10:29:37.256701 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-04-17 10:29:37.256911 | controller | Friday 17 April 2026 10:29:37 +0000 (0:00:00.473) 0:00:08.711 ********** 2026-04-17 10:29:37.589216 | controller | changed: [controller] 2026-04-17 10:29:37.589287 | controller | 2026-04-17 10:29:37.589400 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-04-17 10:29:37.592515 | controller | Friday 17 April 2026 10:29:37 +0000 (0:00:00.331) 0:00:09.043 ********** 2026-04-17 10:29:37.894777 | controller | ok: [controller] 2026-04-17 10:29:37.894970 | controller | 2026-04-17 10:29:37.895209 | controller | TASK [Install plugin] ********************************************************** 2026-04-17 10:29:37.895427 | controller | Friday 17 April 2026 10:29:37 +0000 (0:00:00.307) 0:00:09.350 ********** 2026-04-17 10:29:37.954020 | controller | included: vexxhost.containers.download_artifact for controller 2026-04-17 10:29:37.954098 | controller | 2026-04-17 10:29:37.954242 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-17 10:29:37.954373 | controller | Friday 17 April 2026 10:29:37 +0000 (0:00:00.059) 0:00:09.409 ********** 2026-04-17 10:29:38.003862 | controller | ok: [controller] => { 2026-04-17 10:29:38.003986 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-04-17 10:29:38.004104 | controller | } 2026-04-17 10:29:38.004207 | controller | 2026-04-17 10:29:38.004333 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-17 10:29:38.004461 | controller | Friday 17 April 2026 10:29:38 +0000 (0:00:00.049) 0:00:09.459 ********** 2026-04-17 10:29:38.891595 | controller | changed: [controller] 2026-04-17 10:29:38.891766 | controller | 2026-04-17 10:29:38.891971 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-17 10:29:38.892169 | controller | Friday 17 April 2026 10:29:38 +0000 (0:00:00.887) 0:00:10.347 ********** 2026-04-17 10:29:41.057263 | controller | changed: [controller] 2026-04-17 10:29:41.057456 | controller | 2026-04-17 10:29:41.057622 | controller | PLAY RECAP ********************************************************************* 2026-04-17 10:29:41.057796 | controller | controller : ok=16 changed=7 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-17 10:29:41.057942 | controller | 2026-04-17 10:29:41.058083 | controller | 2026-04-17 10:29:41.058235 | controller | TASKS RECAP ******************************************************************** 2026-04-17 10:29:41.058394 | controller | Friday 17 April 2026 10:29:41 +0000 (0:00:02.166) 0:00:12.513 ********** 2026-04-17 10:29:41.058541 | controller | =============================================================================== 2026-04-17 10:29:41.058696 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.17s 2026-04-17 10:29:41.058852 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.12s 2026-04-17 10:29:41.059005 | controller | Gathering Facts --------------------------------------------------------- 2.10s 2026-04-17 10:29:41.059160 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.08s 2026-04-17 10:29:41.059313 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.98s 2026-04-17 10:29:41.059468 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.89s 2026-04-17 10:29:41.059622 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.54s 2026-04-17 10:29:41.059775 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.52s 2026-04-17 10:29:41.059929 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.47s 2026-04-17 10:29:41.060134 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.43s 2026-04-17 10:29:41.060309 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.40s 2026-04-17 10:29:41.060471 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.33s 2026-04-17 10:29:41.060701 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.31s 2026-04-17 10:29:41.060950 | controller | Install plugin ---------------------------------------------------------- 0.06s 2026-04-17 10:29:41.061199 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-04-17 10:29:41.061446 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-04-17 10:29:41.224881 | controller | INFO [helm > converge] Executed: Successful 2026-04-17 10:29:41.237273 | controller | INFO [helm > idempotence] Executing 2026-04-17 10:29:42.170752 | controller | 2026-04-17 10:29:42.171097 | controller | PLAY [Converge] **************************************************************** 2026-04-17 10:29:42.171355 | controller | 2026-04-17 10:29:42.171624 | controller | TASK [Gathering Facts] ********************************************************* 2026-04-17 10:29:42.171963 | controller | Friday 17 April 2026 10:29:42 +0000 (0:00:00.013) 0:00:00.013 ********** 2026-04-17 10:29:43.296028 | 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-04-17 10:29:43.302102 | controller | ok: [controller] 2026-04-17 10:29:43.302372 | controller | 2026-04-17 10:29:43.302698 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-17 10:29:43.303032 | controller | Friday 17 April 2026 10:29:43 +0000 (0:00:01.131) 0:00:01.145 ********** 2026-04-17 10:29:43.747934 | controller | ok: [controller] 2026-04-17 10:29:43.749337 | controller | 2026-04-17 10:29:43.749574 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-17 10:29:43.749785 | controller | Friday 17 April 2026 10:29:43 +0000 (0:00:00.445) 0:00:01.590 ********** 2026-04-17 10:29:45.061113 | controller | ok: [controller] 2026-04-17 10:29:45.061407 | controller | 2026-04-17 10:29:45.061685 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-04-17 10:29:45.061946 | controller | Friday 17 April 2026 10:29:45 +0000 (0:00:01.312) 0:00:02.903 ********** 2026-04-17 10:29:45.521156 | controller | ok: [controller] 2026-04-17 10:29:45.521218 | controller | 2026-04-17 10:29:45.521361 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-17 10:29:45.521488 | controller | Friday 17 April 2026 10:29:45 +0000 (0:00:00.458) 0:00:03.362 ********** 2026-04-17 10:29:45.572434 | controller | ok: [controller] => { 2026-04-17 10:29:45.572493 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-04-17 10:29:45.572583 | controller | } 2026-04-17 10:29:45.572954 | controller | 2026-04-17 10:29:45.572982 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-17 10:29:45.572987 | controller | Friday 17 April 2026 10:29:45 +0000 (0:00:00.052) 0:00:03.414 ********** 2026-04-17 10:29:46.125234 | controller | ok: [controller] 2026-04-17 10:29:46.125337 | controller | 2026-04-17 10:29:46.125347 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-17 10:29:46.125482 | controller | Friday 17 April 2026 10:29:46 +0000 (0:00:00.549) 0:00:03.963 ********** 2026-04-17 10:29:47.841866 | controller | ok: [controller] 2026-04-17 10:29:47.841957 | controller | 2026-04-17 10:29:47.842038 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-04-17 10:29:47.842156 | controller | Friday 17 April 2026 10:29:47 +0000 (0:00:01.720) 0:00:05.684 ********** 2026-04-17 10:29:48.391015 | controller | ok: [controller] 2026-04-17 10:29:48.391112 | controller | 2026-04-17 10:29:48.391258 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-04-17 10:29:48.391390 | controller | Friday 17 April 2026 10:29:48 +0000 (0:00:00.548) 0:00:06.233 ********** 2026-04-17 10:29:48.819491 | controller | ok: [controller] 2026-04-17 10:29:48.819558 | controller | 2026-04-17 10:29:48.819851 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-04-17 10:29:48.819884 | controller | Friday 17 April 2026 10:29:48 +0000 (0:00:00.427) 0:00:06.661 ********** 2026-04-17 10:29:49.321025 | controller | ok: [controller] 2026-04-17 10:29:49.321074 | controller | 2026-04-17 10:29:49.321173 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-04-17 10:29:49.321263 | controller | Friday 17 April 2026 10:29:49 +0000 (0:00:00.498) 0:00:07.159 ********** 2026-04-17 10:29:49.635569 | controller | ok: [controller] 2026-04-17 10:29:49.635618 | controller | 2026-04-17 10:29:49.635710 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-04-17 10:29:49.635798 | controller | Friday 17 April 2026 10:29:49 +0000 (0:00:00.318) 0:00:07.478 ********** 2026-04-17 10:29:49.955077 | controller | ok: [controller] 2026-04-17 10:29:49.955121 | controller | 2026-04-17 10:29:49.955127 | controller | TASK [Install plugin] ********************************************************** 2026-04-17 10:29:49.955132 | controller | Friday 17 April 2026 10:29:49 +0000 (0:00:00.309) 0:00:07.787 ********** 2026-04-17 10:29:50.008900 | controller | included: vexxhost.containers.download_artifact for controller 2026-04-17 10:29:50.008974 | controller | 2026-04-17 10:29:50.008988 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-17 10:29:50.009117 | controller | Friday 17 April 2026 10:29:50 +0000 (0:00:00.061) 0:00:07.849 ********** 2026-04-17 10:29:50.060155 | controller | ok: [controller] => { 2026-04-17 10:29:50.060259 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-04-17 10:29:50.060319 | controller | } 2026-04-17 10:29:50.060398 | controller | 2026-04-17 10:29:50.060492 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-17 10:29:50.060634 | controller | Friday 17 April 2026 10:29:50 +0000 (0:00:00.053) 0:00:07.902 ********** 2026-04-17 10:29:50.485400 | controller | ok: [controller] 2026-04-17 10:29:50.485431 | controller | 2026-04-17 10:29:50.485437 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-17 10:29:50.485443 | controller | Friday 17 April 2026 10:29:50 +0000 (0:00:00.423) 0:00:08.326 ********** 2026-04-17 10:29:52.158249 | controller | ok: [controller] 2026-04-17 10:29:52.158444 | controller | 2026-04-17 10:29:52.158605 | controller | PLAY RECAP ********************************************************************* 2026-04-17 10:29:52.158779 | controller | controller : ok=16 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-17 10:29:52.158925 | controller | 2026-04-17 10:29:52.159065 | controller | 2026-04-17 10:29:52.159220 | controller | TASKS RECAP ******************************************************************** 2026-04-17 10:29:52.159380 | controller | Friday 17 April 2026 10:29:52 +0000 (0:00:01.675) 0:00:10.001 ********** 2026-04-17 10:29:52.159527 | controller | =============================================================================== 2026-04-17 10:29:52.159681 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.72s 2026-04-17 10:29:52.159834 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.68s 2026-04-17 10:29:52.159986 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.31s 2026-04-17 10:29:52.160188 | controller | Gathering Facts --------------------------------------------------------- 1.13s 2026-04-17 10:29:52.160352 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.55s 2026-04-17 10:29:52.160513 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.55s 2026-04-17 10:29:52.160716 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.50s 2026-04-17 10:29:52.160892 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.46s 2026-04-17 10:29:52.161060 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.45s 2026-04-17 10:29:52.161219 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.43s 2026-04-17 10:29:52.161393 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.42s 2026-04-17 10:29:52.161561 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.32s 2026-04-17 10:29:52.161727 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.31s 2026-04-17 10:29:52.161883 | controller | Install plugin ---------------------------------------------------------- 0.06s 2026-04-17 10:29:52.162044 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-04-17 10:29:52.162209 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-04-17 10:29:52.300117 | controller | INFO [helm > idempotence] Executed: Successful 2026-04-17 10:29:52.310149 | controller | INFO [helm > side_effect] Executing 2026-04-17 10:29:52.310550 | controller | WARNING [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-17 10:29:52.317213 | controller | INFO [helm > verify] Executing 2026-04-17 10:29:53.185344 | controller | 2026-04-17 10:29:53.185678 | controller | PLAY [Verify] ****************************************************************** 2026-04-17 10:29:53.185923 | controller | 2026-04-17 10:29:53.186186 | controller | TASK [Gathering Facts] ********************************************************* 2026-04-17 10:29:53.186442 | controller | Friday 17 April 2026 10:29:53 +0000 (0:00:00.010) 0:00:00.010 ********** 2026-04-17 10:29:55.305484 | 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-04-17 10:29:55.312707 | controller | ok: [controller] 2026-04-17 10:29:55.312759 | controller | 2026-04-17 10:29:55.312767 | controller | TASK [Get the current Helm version] ******************************************** 2026-04-17 10:29:55.312947 | controller | Friday 17 April 2026 10:29:55 +0000 (0:00:02.127) 0:00:02.137 ********** 2026-04-17 10:29:55.768079 | controller | changed: [controller] 2026-04-17 10:29:55.768156 | controller | 2026-04-17 10:29:55.768497 | controller | TASK [Assert Helm version] ***************************************************** 2026-04-17 10:29:55.768779 | controller | Friday 17 April 2026 10:29:55 +0000 (0:00:00.455) 0:00:02.592 ********** 2026-04-17 10:29:55.800969 | controller | ok: [controller] => { 2026-04-17 10:29:55.801233 | controller | "changed": false, 2026-04-17 10:29:55.801452 | controller | "msg": "All assertions passed" 2026-04-17 10:29:55.801652 | controller | } 2026-04-17 10:29:55.801825 | controller | 2026-04-17 10:29:55.802053 | controller | PLAY RECAP ********************************************************************* 2026-04-17 10:29:55.802271 | controller | controller : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-17 10:29:55.802427 | controller | 2026-04-17 10:29:55.802594 | controller | 2026-04-17 10:29:55.802772 | controller | TASKS RECAP ******************************************************************** 2026-04-17 10:29:55.802977 | controller | Friday 17 April 2026 10:29:55 +0000 (0:00:00.033) 0:00:02.626 ********** 2026-04-17 10:29:55.803143 | controller | =============================================================================== 2026-04-17 10:29:55.803471 | controller | Gathering Facts --------------------------------------------------------- 2.13s 2026-04-17 10:29:55.803663 | controller | Get the current Helm version -------------------------------------------- 0.46s 2026-04-17 10:29:55.803841 | controller | Assert Helm version ----------------------------------------------------- 0.03s 2026-04-17 10:29:55.932079 | controller | INFO [helm > verify] Executed: Successful 2026-04-17 10:29:55.943007 | controller | INFO [helm > cleanup] Executing 2026-04-17 10:29:55.943340 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-17 10:29:55.949051 | controller | INFO [helm > destroy] Executing 2026-04-17 10:29:55.949118 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-04-17 10:29:55.949127 | controller | INFO [helm > destroy] Executed: Successful 2026-04-17 10:29:55.949412 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-04-17 10:29:56.460729 | controller | ok: Runtime: 0:00:51.805582 2026-04-17 10:29:56.465617 | 2026-04-17 10:29:56.465670 | PLAY RECAP 2026-04-17 10:29:56.465713 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-17 10:29:56.465734 | 2026-04-17 10:29:56.566318 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-17 10:29:56.569279 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-04-17 10:29:57.193029 | 2026-04-17 10:29:57.193165 | PLAY [all] 2026-04-17 10:29:57.204726 | 2026-04-17 10:29:57.204824 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-04-17 10:29:57.606448 | controller | changed 2026-04-17 10:29:57.612553 | 2026-04-17 10:29:57.612636 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-04-17 10:29:58.009110 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-17 10:29:58.009242 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-17 10:29:58.017080 | controller | environment: line 1: kubectl: command not found 2026-04-17 10:29:58.018511 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-17 10:29:58.021191 | controller | environment: line 1: kubectl: command not found 2026-04-17 10:29:58.023015 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-17 10:29:58.025190 | controller | environment: line 1: kubectl: command not found 2026-04-17 10:29:58.027142 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-17 10:29:58.027935 | controller | environment: line 1: kubectl: command not found 2026-04-17 10:29:58.031794 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-17 10:29:58.031968 | controller | environment: line 1: kubectl: command not found 2026-04-17 10:29:58.033223 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-17 10:29:58.141201 | controller | ok: Runtime: 0:00:00.040623 2026-04-17 10:29:58.147841 | 2026-04-17 10:29:58.147949 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-04-17 10:29:58.382500 | controller | changed 2026-04-17 10:29:58.388471 | 2026-04-17 10:29:58.388610 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-04-17 10:29:58.633944 | controller | environment: line 5: kubectl: command not found 2026-04-17 10:29:58.634645 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-17 10:29:58.635437 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-17 10:29:58.635732 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-17 10:29:58.920619 | controller | ok: Runtime: 0:00:00.014660 2026-04-17 10:29:58.927986 | 2026-04-17 10:29:58.928083 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-04-17 10:29:59.676337 | controller | changed: 2026-04-17 10:29:59.676609 | controller | created directory /var/lib/zuul/builds/14d76d02c8f64459b2568ec1579ab802/work/logs/controller 2026-04-17 10:29:59.676675 | controller | cd+++++++++ objects/ 2026-04-17 10:29:59.676726 | controller | cd+++++++++ objects/cluster/ 2026-04-17 10:29:59.676777 | controller | cd+++++++++ objects/namespaced/ 2026-04-17 10:29:59.685265 | 2026-04-17 10:29:59.685337 | TASK [gather-pod-logs : creating directory for pod logs] 2026-04-17 10:29:59.930897 | controller | changed 2026-04-17 10:29:59.935473 | 2026-04-17 10:29:59.935559 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-04-17 10:30:00.180690 | controller | changed 2026-04-17 10:30:00.186719 | 2026-04-17 10:30:00.186786 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-04-17 10:30:00.436616 | controller | environment: line 3: kubectl: command not found 2026-04-17 10:30:00.715243 | controller | ok: Runtime: 0:00:00.013042 2026-04-17 10:30:00.722565 | 2026-04-17 10:30:00.722735 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-04-17 10:30:01.287500 | controller | changed: 2026-04-17 10:30:01.287633 | controller | cd+++++++++ pod-logs/ 2026-04-17 10:30:01.287662 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-04-17 10:30:01.298159 | 2026-04-17 10:30:01.298228 | LOOP [helm-release-status : creating directory for helm release status] 2026-04-17 10:30:01.538752 | controller | changed: "values" 2026-04-17 10:30:01.752446 | controller | changed: "releases" 2026-04-17 10:30:01.770662 | 2026-04-17 10:30:01.770818 | TASK [helm-release-status : Gather get release status for helm charts] 2026-04-17 10:30:02.016428 | controller | /bin/bash: line 3: kubectl: command not found 2026-04-17 10:30:02.300680 | controller | ok: Runtime: 0:00:00.010208 2026-04-17 10:30:02.305241 | 2026-04-17 10:30:02.305319 | TASK [helm-release-status : Downloads logs to executor] 2026-04-17 10:30:02.842854 | controller | changed: 2026-04-17 10:30:02.843051 | controller | cd+++++++++ helm/ 2026-04-17 10:30:02.843092 | controller | cd+++++++++ helm/releases/ 2026-04-17 10:30:02.843124 | controller | cd+++++++++ helm/values/ 2026-04-17 10:30:02.849184 | 2026-04-17 10:30:02.849227 | PLAY RECAP 2026-04-17 10:30:02.849270 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-17 10:30:02.849292 | 2026-04-17 10:30:02.947599 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-04-17 10:30:02.949524 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-17 10:30:03.496429 | 2026-04-17 10:30:03.496556 | PLAY [all] 2026-04-17 10:30:03.506292 | 2026-04-17 10:30:03.506372 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-17 10:30:03.550761 | controller | skipping: Conditional result was False 2026-04-17 10:30:03.559506 | 2026-04-17 10:30:03.559608 | TASK [fetch-output : Set log path for single node] 2026-04-17 10:30:03.600941 | controller | ok 2026-04-17 10:30:03.606721 | 2026-04-17 10:30:03.606786 | LOOP [fetch-output : Ensure local output dirs] 2026-04-17 10:30:03.971979 | controller -> localhost | ok: "/var/lib/zuul/builds/14d76d02c8f64459b2568ec1579ab802/work/logs" 2026-04-17 10:30:04.176240 | controller -> localhost | changed: "/var/lib/zuul/builds/14d76d02c8f64459b2568ec1579ab802/work/artifacts" 2026-04-17 10:30:04.388346 | controller -> localhost | changed: "/var/lib/zuul/builds/14d76d02c8f64459b2568ec1579ab802/work/docs" 2026-04-17 10:30:04.407900 | 2026-04-17 10:30:04.408083 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-17 10:30:05.076640 | controller | changed: .d..t...... ./ 2026-04-17 10:30:05.076969 | controller | changed: All items complete 2026-04-17 10:30:05.077030 | 2026-04-17 10:30:05.575569 | controller | changed: .d..t...... ./ 2026-04-17 10:30:06.096866 | controller | changed: .d..t...... ./ 2026-04-17 10:30:06.108354 | 2026-04-17 10:30:06.108495 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-17 10:30:06.555597 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.006620 2026-04-17 10:30:06.810526 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.006884 2026-04-17 10:30:06.828777 | 2026-04-17 10:30:06.828906 | PLAY [all] 2026-04-17 10:30:06.834167 | 2026-04-17 10:30:06.834235 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-17 10:30:07.313719 | controller | changed 2026-04-17 10:30:07.319843 | 2026-04-17 10:30:07.319911 | PLAY RECAP 2026-04-17 10:30:07.319971 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-17 10:30:07.319996 | 2026-04-17 10:30:07.424046 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-17 10:30:07.426967 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-17 10:30:07.962794 | 2026-04-17 10:30:07.962916 | PLAY [localhost] 2026-04-17 10:30:07.972373 | 2026-04-17 10:30:07.972445 | TASK [Generate Zuul manifest] 2026-04-17 10:30:07.993319 | localhost | ok 2026-04-17 10:30:08.011583 | 2026-04-17 10:30:08.011668 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-17 10:30:08.326821 | localhost | changed 2026-04-17 10:30:08.341358 | 2026-04-17 10:30:08.341447 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-17 10:30:08.373837 | localhost | ok 2026-04-17 10:30:08.381771 | 2026-04-17 10:30:08.381835 | TASK [Upload logs] 2026-04-17 10:30:08.402070 | localhost | ok 2026-04-17 10:30:08.459032 | 2026-04-17 10:30:08.459156 | TASK [Set zuul-log-path fact] 2026-04-17 10:30:08.480992 | localhost | ok 2026-04-17 10:30:08.495350 | 2026-04-17 10:30:08.495418 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-17 10:30:08.528448 | localhost | ok 2026-04-17 10:30:08.537176 | 2026-04-17 10:30:08.537241 | TASK [upload-logs : Create log directories] 2026-04-17 10:30:08.944240 | localhost | changed 2026-04-17 10:30:08.949825 | 2026-04-17 10:30:08.949899 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-17 10:30:09.345015 | localhost -> localhost | ok: Runtime: 0:00:00.005108 2026-04-17 10:30:09.351647 | 2026-04-17 10:30:09.351743 | TASK [upload-logs : Upload logs to log server] 2026-04-17 10:30:09.847769 | localhost | Output suppressed because no_log was given 2026-04-17 10:30:09.852897 | 2026-04-17 10:30:09.853017 | LOOP [upload-logs : Compress console log and json output] 2026-04-17 10:30:09.899265 | localhost | skipping: Conditional result was False 2026-04-17 10:30:09.906772 | localhost | skipping: Conditional result was False 2026-04-17 10:30:09.915705 | 2026-04-17 10:30:09.915858 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-17 10:30:09.958563 | localhost | skipping: Conditional result was False 2026-04-17 10:30:09.958969 | 2026-04-17 10:30:09.963525 | localhost | skipping: Conditional result was False 2026-04-17 10:30:09.979339 | 2026-04-17 10:30:09.979565 | LOOP [upload-logs : Upload console log and json output]