2026-04-20 17:43:02.897838 | Job console starting 2026-04-20 17:43:02.909386 | Updating git repos 2026-04-20 17:43:02.967288 | Cloning repos into workspace 2026-04-20 17:43:03.096688 | Restoring repo states 2026-04-20 17:43:03.108318 | Merging changes 2026-04-20 17:43:03.987558 | Checking out repos 2026-04-20 17:43:04.468931 | Preparing playbooks 2026-04-20 17:43:07.075168 | Running Ansible setup 2026-04-20 17:43:11.043644 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-20 17:43:11.605793 | 2026-04-20 17:43:11.605907 | PLAY [localhost] 2026-04-20 17:43:11.613821 | 2026-04-20 17:43:11.613911 | TASK [Gathering Facts] 2026-04-20 17:43:12.535363 | localhost | ok 2026-04-20 17:43:12.545431 | 2026-04-20 17:43:12.545602 | TASK [Setup log path fact] 2026-04-20 17:43:12.566096 | localhost | ok 2026-04-20 17:43:12.580854 | 2026-04-20 17:43:12.581069 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-20 17:43:12.631988 | localhost | ok 2026-04-20 17:43:12.639372 | 2026-04-20 17:43:12.639498 | TASK [emit-job-header : Print job information] 2026-04-20 17:43:12.692341 | # Job Information 2026-04-20 17:43:12.692645 | Ansible Version: 2.16.16 2026-04-20 17:43:12.692718 | Job: ansible-collection-kubernetes-molecule-helm 2026-04-20 17:43:12.692768 | Pipeline: check 2026-04-20 17:43:12.692812 | Executor: 0a8996d2b663 2026-04-20 17:43:12.692856 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/265 2026-04-20 17:43:12.692905 | Event ID: 3a67ad50-3ce0-11f1-9d03-7d874ddeb959 2026-04-20 17:43:12.697896 | 2026-04-20 17:43:12.698083 | LOOP [emit-job-header : Print node information] 2026-04-20 17:43:12.787046 | localhost | ok: 2026-04-20 17:43:12.787432 | localhost | # Node Information 2026-04-20 17:43:12.787513 | localhost | Inventory Hostname: controller 2026-04-20 17:43:12.787564 | localhost | Hostname: np0000168540 2026-04-20 17:43:12.787608 | localhost | Username: zuul 2026-04-20 17:43:12.787659 | localhost | Distro: Debian 13.4 2026-04-20 17:43:12.787703 | localhost | Provider: yul1 2026-04-20 17:43:12.787746 | localhost | Region: ca-ymq-1 2026-04-20 17:43:12.787788 | localhost | Label: debian-trixie 2026-04-20 17:43:12.787830 | localhost | Product Name: OpenStack Nova 2026-04-20 17:43:12.787926 | localhost | Interface IP: 199.204.45.4 2026-04-20 17:43:12.808503 | 2026-04-20 17:43:12.808712 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-04-20 17:43:13.201947 | localhost -> localhost | changed 2026-04-20 17:43:13.207720 | 2026-04-20 17:43:13.207821 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-04-20 17:43:14.090832 | localhost -> localhost | changed 2026-04-20 17:43:14.097596 | 2026-04-20 17:43:14.097706 | PLAY [all] 2026-04-20 17:43:14.105770 | 2026-04-20 17:43:14.105846 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-04-20 17:43:14.323691 | controller -> localhost | ok 2026-04-20 17:43:14.330346 | 2026-04-20 17:43:14.330460 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-04-20 17:43:14.359595 | controller | ok 2026-04-20 17:43:14.372339 | controller | included: /var/lib/zuul/builds/dac3b002f2c74aa282cb5e4569bf69a3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-04-20 17:43:14.377041 | 2026-04-20 17:43:14.377106 | TASK [add-build-sshkey : Create Temp SSH key] 2026-04-20 17:43:15.704294 | controller -> localhost | Generating public/private rsa key pair. 2026-04-20 17:43:15.704564 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/dac3b002f2c74aa282cb5e4569bf69a3/work/dac3b002f2c74aa282cb5e4569bf69a3_id_rsa 2026-04-20 17:43:15.704636 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/dac3b002f2c74aa282cb5e4569bf69a3/work/dac3b002f2c74aa282cb5e4569bf69a3_id_rsa.pub 2026-04-20 17:43:15.704691 | controller -> localhost | The key fingerprint is: 2026-04-20 17:43:15.704743 | controller -> localhost | SHA256:RySReOs2MkQ6hMBBDOnSUph+yFvRzktwPuPL0ByIv70 zuul-build-sshkey 2026-04-20 17:43:15.704811 | controller -> localhost | The key's randomart image is: 2026-04-20 17:43:15.704862 | controller -> localhost | +---[RSA 3072]----+ 2026-04-20 17:43:15.704919 | controller -> localhost | |BB... .oo. | 2026-04-20 17:43:15.705074 | controller -> localhost | |+ooo.oo oo | 2026-04-20 17:43:15.705151 | controller -> localhost | |+oo.Oo . .. | 2026-04-20 17:43:15.705207 | controller -> localhost | |o*.+oO. .. | 2026-04-20 17:43:15.705257 | controller -> localhost | |..= =o=.S . | 2026-04-20 17:43:15.705306 | controller -> localhost | | . o =o +. | 2026-04-20 17:43:15.705352 | controller -> localhost | | = .+ . | 2026-04-20 17:43:15.705399 | controller -> localhost | | . + | 2026-04-20 17:43:15.705452 | controller -> localhost | | E. | 2026-04-20 17:43:15.705500 | controller -> localhost | +----[SHA256]-----+ 2026-04-20 17:43:15.705599 | controller -> localhost | ok: Runtime: 0:00:00.927079 2026-04-20 17:43:15.712362 | 2026-04-20 17:43:15.712426 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-04-20 17:43:15.742355 | controller | ok 2026-04-20 17:43:15.751859 | controller | included: /var/lib/zuul/builds/dac3b002f2c74aa282cb5e4569bf69a3/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-04-20 17:43:15.759240 | 2026-04-20 17:43:15.759310 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-04-20 17:43:15.783763 | controller | skipping: Conditional result was False 2026-04-20 17:43:15.793236 | 2026-04-20 17:43:15.793384 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-04-20 17:43:16.336358 | controller | changed 2026-04-20 17:43:16.340345 | 2026-04-20 17:43:16.340429 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-04-20 17:43:16.554525 | controller | ok 2026-04-20 17:43:16.562210 | 2026-04-20 17:43:16.562274 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-04-20 17:43:17.080760 | controller | changed 2026-04-20 17:43:17.087520 | 2026-04-20 17:43:17.087587 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-04-20 17:43:17.657021 | controller | changed 2026-04-20 17:43:17.664339 | 2026-04-20 17:43:17.664426 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-04-20 17:43:17.689514 | controller | skipping: Conditional result was False 2026-04-20 17:43:17.694173 | 2026-04-20 17:43:17.694239 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-04-20 17:43:18.073746 | controller -> localhost | changed 2026-04-20 17:43:18.085835 | 2026-04-20 17:43:18.085989 | TASK [add-build-sshkey : Add back temp key] 2026-04-20 17:43:18.381644 | controller -> localhost | Identity added: /var/lib/zuul/builds/dac3b002f2c74aa282cb5e4569bf69a3/work/dac3b002f2c74aa282cb5e4569bf69a3_id_rsa (zuul-build-sshkey) 2026-04-20 17:43:18.381898 | controller -> localhost | ok: Runtime: 0:00:00.012724 2026-04-20 17:43:18.387194 | 2026-04-20 17:43:18.387276 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-04-20 17:43:18.720175 | controller | ok 2026-04-20 17:43:18.727249 | 2026-04-20 17:43:18.727339 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-04-20 17:43:18.753837 | controller | skipping: Conditional result was False 2026-04-20 17:43:18.770332 | 2026-04-20 17:43:18.770439 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-04-20 17:43:19.113416 | controller | ok 2026-04-20 17:43:19.118304 | 2026-04-20 17:43:19.118369 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-04-20 17:43:20.166895 | controller | Output suppressed because no_log was given 2026-04-20 17:43:20.183756 | 2026-04-20 17:43:20.183887 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-04-20 17:43:20.416142 | controller | ok: "logs" 2026-04-20 17:43:20.416612 | controller | ok: All items complete 2026-04-20 17:43:20.416663 | 2026-04-20 17:43:20.612052 | controller | ok: "artifacts" 2026-04-20 17:43:20.811136 | controller | ok: "docs" 2026-04-20 17:43:20.830827 | 2026-04-20 17:43:20.831070 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-04-20 17:43:21.065972 | controller | changed: "logs" 2026-04-20 17:43:21.267809 | controller | changed: "artifacts" 2026-04-20 17:43:21.452539 | controller | changed: "docs" 2026-04-20 17:43:21.470584 | 2026-04-20 17:43:21.470691 | PLAY RECAP 2026-04-20 17:43:21.470753 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-04-20 17:43:21.470792 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-20 17:43:21.470844 | 2026-04-20 17:43:21.622699 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-04-20 17:43:21.624135 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-20 17:43:22.227419 | 2026-04-20 17:43:22.227575 | PLAY [all] 2026-04-20 17:43:22.238235 | 2026-04-20 17:43:22.238311 | TASK [setup-uv : Extract archive] 2026-04-20 17:43:24.645215 | controller | changed 2026-04-20 17:43:24.651312 | 2026-04-20 17:43:24.651400 | TASK [setup-uv : Print version] 2026-04-20 17:43:23.449542 | controller | uv 0.8.13 2026-04-20 17:43:25.181797 | controller | ok: Runtime: 0:00:00.018338 2026-04-20 17:43:25.189458 | 2026-04-20 17:43:25.189510 | PLAY RECAP 2026-04-20 17:43:25.189555 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-20 17:43:25.189581 | 2026-04-20 17:43:25.307057 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-04-20 17:43:25.309919 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-04-20 17:43:25.915589 | 2026-04-20 17:43:25.915851 | PLAY [all] 2026-04-20 17:43:25.928924 | 2026-04-20 17:43:25.929257 | TASK [Update apt cache] 2026-04-20 17:43:31.506069 | controller | ok 2026-04-20 17:43:31.510943 | 2026-04-20 17:43:31.511019 | TASK [Disable firewalld] 2026-04-20 17:43:31.534975 | controller | skipping: Conditional result was False 2026-04-20 17:43:31.539426 | 2026-04-20 17:43:31.539494 | TASK [Install "jq" for log collection] 2026-04-20 17:43:33.903895 | controller | changed 2026-04-20 17:43:33.906070 | 2026-04-20 17:43:33.906137 | PLAY RECAP 2026-04-20 17:43:33.906194 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-20 17:43:33.906225 | 2026-04-20 17:43:34.004823 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-04-20 17:43:34.007544 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-20 17:43:34.589515 | 2026-04-20 17:43:34.589684 | PLAY [all] 2026-04-20 17:43:34.600272 | 2026-04-20 17:43:34.600346 | TASK [Copy inventory file for Zuul] 2026-04-20 17:43:35.495096 | controller | changed 2026-04-20 17:43:35.502049 | 2026-04-20 17:43:35.502158 | TASK [Switch "ansible_host" to private IP] 2026-04-20 17:43:35.787731 | controller | changed: 1 replacements made 2026-04-20 17:43:35.794104 | 2026-04-20 17:43:35.794199 | TASK [Run Molecule scenario] 2026-04-20 17:43:34.631357 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-04-20 17:43:34.631511 | controller | Creating virtual environment at: .venv 2026-04-20 17:43:35.037822 | controller | Downloading ansible-core (2.3MiB) 2026-04-20 17:43:35.038536 | controller | Downloading cryptography (4.3MiB) 2026-04-20 17:43:35.043531 | controller | Downloading pygments (1.2MiB) 2026-04-20 17:43:35.234298 | controller | Downloading cryptography 2026-04-20 17:43:35.245039 | controller | Downloading pygments 2026-04-20 17:43:35.413798 | controller | Downloading ansible-core 2026-04-20 17:43:35.469791 | controller | Installed 36 packages in 55ms 2026-04-20 17:43:36.154804 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-04-20 17:43:36.154874 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-04-20 17:43:37.074635 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-04-20 17:43:37.074695 | controller | INFO default scenario not found, disabling shared state. 2026-04-20 17:43:37.074831 | controller | INFO [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-04-20 17:43:37.074952 | controller | INFO [helm > prerun] Performing prerun with role_name_check=0... 2026-04-20 17:50:25.629543 | controller | INFO [helm > dependency] Executing 2026-04-20 17:50:25.629739 | controller | WARNING [helm > dependency] Missing roles requirements file: requirements.yml 2026-04-20 17:50:25.630029 | controller | WARNING [helm > dependency] Missing collections requirements file: collections.yml 2026-04-20 17:50:25.630227 | controller | WARNING [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-04-20 17:50:25.635894 | controller | INFO [helm > cleanup] Executing 2026-04-20 17:50:25.636271 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-20 17:50:25.646707 | controller | INFO [helm > destroy] Executing 2026-04-20 17:50:25.646896 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-04-20 17:50:25.647043 | controller | INFO [helm > destroy] Executed: Successful 2026-04-20 17:50:25.655550 | controller | INFO [helm > syntax] Executing 2026-04-20 17:50:26.615998 | controller | 2026-04-20 17:50:26.616195 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml 2026-04-20 17:50:26.682185 | controller | INFO [helm > syntax] Executed: Successful 2026-04-20 17:50:26.693909 | controller | INFO [helm > create] Executing 2026-04-20 17:50:26.695381 | controller | WARNING [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-20 17:50:26.700774 | controller | INFO [helm > prepare] Executing 2026-04-20 17:50:27.566080 | controller | 2026-04-20 17:50:27.566216 | controller | PLAY [Prepare] ***************************************************************** 2026-04-20 17:50:27.566451 | controller | 2026-04-20 17:50:27.566605 | controller | TASK [Gathering Facts] ********************************************************* 2026-04-20 17:50:27.566850 | controller | Monday 20 April 2026 17:50:27 +0000 (0:00:00.031) 0:00:00.031 ********** 2026-04-20 17:50:28.846889 | 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-20 17:50:28.852501 | controller | ok: [controller] 2026-04-20 17:50:28.852575 | controller | 2026-04-20 17:50:28.852686 | controller | TASK [Install Debian packages] ************************************************* 2026-04-20 17:50:28.852793 | controller | Monday 20 April 2026 17:50:28 +0000 (0:00:01.287) 0:00:01.318 ********** 2026-04-20 17:50:30.970805 | controller | ok: [controller] 2026-04-20 17:50:30.971062 | controller | 2026-04-20 17:50:30.971364 | controller | PLAY RECAP ********************************************************************* 2026-04-20 17:50:30.971788 | controller | controller : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-20 17:50:30.972165 | controller | 2026-04-20 17:50:30.972329 | controller | 2026-04-20 17:50:30.972457 | controller | TASKS RECAP ******************************************************************** 2026-04-20 17:50:30.972592 | controller | Monday 20 April 2026 17:50:30 +0000 (0:00:02.117) 0:00:03.436 ********** 2026-04-20 17:50:30.972692 | controller | =============================================================================== 2026-04-20 17:50:30.972822 | controller | Install Debian packages ------------------------------------------------- 2.12s 2026-04-20 17:50:30.972940 | controller | Gathering Facts --------------------------------------------------------- 1.29s 2026-04-20 17:50:31.168492 | controller | INFO [helm > prepare] Executed: Successful 2026-04-20 17:50:31.180361 | controller | INFO [helm > converge] Executing 2026-04-20 17:50:32.058127 | controller | 2026-04-20 17:50:32.058337 | controller | PLAY [Converge] **************************************************************** 2026-04-20 17:50:32.058519 | controller | 2026-04-20 17:50:32.058730 | controller | TASK [Gathering Facts] ********************************************************* 2026-04-20 17:50:32.058929 | controller | Monday 20 April 2026 17:50:32 +0000 (0:00:00.012) 0:00:00.012 ********** 2026-04-20 17:50:34.245051 | 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-20 17:50:34.250140 | controller | ok: [controller] 2026-04-20 17:50:34.250258 | controller | 2026-04-20 17:50:34.250401 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-20 17:50:34.250529 | controller | Monday 20 April 2026 17:50:34 +0000 (0:00:02.191) 0:00:02.204 ********** 2026-04-20 17:50:34.873482 | controller | ok: [controller] 2026-04-20 17:50:34.873587 | controller | 2026-04-20 17:50:34.873823 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-20 17:50:34.874053 | controller | Monday 20 April 2026 17:50:34 +0000 (0:00:00.623) 0:00:02.827 ********** 2026-04-20 17:50:35.942338 | controller | ok: [controller] 2026-04-20 17:50:35.942452 | controller | 2026-04-20 17:50:35.942663 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-04-20 17:50:35.942894 | controller | Monday 20 April 2026 17:50:35 +0000 (0:00:01.068) 0:00:03.896 ********** 2026-04-20 17:50:36.362367 | controller | changed: [controller] 2026-04-20 17:50:36.362496 | controller | 2026-04-20 17:50:36.362714 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-20 17:50:36.362909 | controller | Monday 20 April 2026 17:50:36 +0000 (0:00:00.420) 0:00:04.316 ********** 2026-04-20 17:50:36.408009 | controller | ok: [controller] => { 2026-04-20 17:50:36.408258 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-04-20 17:50:36.408457 | controller | } 2026-04-20 17:50:36.408636 | controller | 2026-04-20 17:50:36.408843 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-20 17:50:36.409202 | controller | Monday 20 April 2026 17:50:36 +0000 (0:00:00.045) 0:00:04.362 ********** 2026-04-20 17:50:37.214127 | 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-20 17:50:37.225264 | controller | changed: [controller] 2026-04-20 17:50:37.225472 | controller | 2026-04-20 17:50:37.225722 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-20 17:50:37.225987 | controller | Monday 20 April 2026 17:50:37 +0000 (0:00:00.816) 0:00:05.178 ********** 2026-04-20 17:50:40.226963 | controller | changed: [controller] 2026-04-20 17:50:40.227002 | controller | 2026-04-20 17:50:40.227007 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-04-20 17:50:40.227010 | controller | Monday 20 April 2026 17:50:40 +0000 (0:00:03.000) 0:00:08.179 ********** 2026-04-20 17:50:40.746044 | controller | ok: [controller] 2026-04-20 17:50:40.746238 | controller | 2026-04-20 17:50:40.746468 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-04-20 17:50:40.746683 | controller | Monday 20 April 2026 17:50:40 +0000 (0:00:00.520) 0:00:08.699 ********** 2026-04-20 17:50:41.148927 | controller | changed: [controller] 2026-04-20 17:50:41.148977 | controller | 2026-04-20 17:50:41.149132 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-04-20 17:50:41.149258 | controller | Monday 20 April 2026 17:50:41 +0000 (0:00:00.402) 0:00:09.102 ********** 2026-04-20 17:50:41.628746 | controller | ok: [controller] 2026-04-20 17:50:41.628911 | controller | 2026-04-20 17:50:41.629138 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-04-20 17:50:41.629351 | controller | Monday 20 April 2026 17:50:41 +0000 (0:00:00.479) 0:00:09.582 ********** 2026-04-20 17:50:41.933771 | controller | changed: [controller] 2026-04-20 17:50:41.933918 | controller | 2026-04-20 17:50:41.934109 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-04-20 17:50:41.934300 | controller | Monday 20 April 2026 17:50:41 +0000 (0:00:00.305) 0:00:09.888 ********** 2026-04-20 17:50:42.244735 | controller | ok: [controller] 2026-04-20 17:50:42.244980 | controller | 2026-04-20 17:50:42.245232 | controller | TASK [Install plugin] ********************************************************** 2026-04-20 17:50:42.245460 | controller | Monday 20 April 2026 17:50:42 +0000 (0:00:00.309) 0:00:10.197 ********** 2026-04-20 17:50:42.299615 | controller | included: vexxhost.containers.download_artifact for controller 2026-04-20 17:50:42.299684 | controller | 2026-04-20 17:50:42.299948 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-20 17:50:42.300230 | controller | Monday 20 April 2026 17:50:42 +0000 (0:00:00.056) 0:00:10.253 ********** 2026-04-20 17:50:42.348589 | controller | ok: [controller] => { 2026-04-20 17:50:42.348765 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-04-20 17:50:42.348963 | controller | } 2026-04-20 17:50:42.349231 | controller | 2026-04-20 17:50:42.349389 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-20 17:50:42.349591 | controller | Monday 20 April 2026 17:50:42 +0000 (0:00:00.048) 0:00:10.302 ********** 2026-04-20 17:50:43.090369 | controller | changed: [controller] 2026-04-20 17:50:43.090405 | controller | 2026-04-20 17:50:43.090415 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-20 17:50:43.090423 | controller | Monday 20 April 2026 17:50:43 +0000 (0:00:00.741) 0:00:11.043 ********** 2026-04-20 17:50:46.112497 | controller | changed: [controller] 2026-04-20 17:50:46.112637 | controller | 2026-04-20 17:50:46.112770 | controller | PLAY RECAP ********************************************************************* 2026-04-20 17:50:46.112910 | controller | controller : ok=16 changed=7 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-20 17:50:46.113023 | controller | 2026-04-20 17:50:46.113101 | controller | 2026-04-20 17:50:46.114810 | controller | TASKS RECAP ******************************************************************** 2026-04-20 17:50:46.114837 | controller | Monday 20 April 2026 17:50:46 +0000 (0:00:03.019) 0:00:14.063 ********** 2026-04-20 17:50:46.114841 | controller | =============================================================================== 2026-04-20 17:50:46.114844 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 3.02s 2026-04-20 17:50:46.114848 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 3.00s 2026-04-20 17:50:46.114851 | controller | Gathering Facts --------------------------------------------------------- 2.19s 2026-04-20 17:50:46.114854 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.07s 2026-04-20 17:50:46.114857 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.82s 2026-04-20 17:50:46.114861 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.74s 2026-04-20 17:50:46.114864 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.62s 2026-04-20 17:50:46.114867 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.52s 2026-04-20 17:50:46.114871 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.48s 2026-04-20 17:50:46.114874 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.42s 2026-04-20 17:50:46.114888 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.40s 2026-04-20 17:50:46.114891 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.31s 2026-04-20 17:50:46.114895 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.31s 2026-04-20 17:50:46.114898 | controller | Install plugin ---------------------------------------------------------- 0.06s 2026-04-20 17:50:46.114901 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-04-20 17:50:46.114905 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-04-20 17:50:46.213339 | controller | INFO [helm > converge] Executed: Successful 2026-04-20 17:50:46.224358 | controller | INFO [helm > idempotence] Executing 2026-04-20 17:50:47.085704 | controller | 2026-04-20 17:50:47.086005 | controller | PLAY [Converge] **************************************************************** 2026-04-20 17:50:47.086232 | controller | 2026-04-20 17:50:47.086476 | controller | TASK [Gathering Facts] ********************************************************* 2026-04-20 17:50:47.086720 | controller | Monday 20 April 2026 17:50:47 +0000 (0:00:00.012) 0:00:00.012 ********** 2026-04-20 17:50:48.123400 | 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-20 17:50:48.128658 | controller | ok: [controller] 2026-04-20 17:50:48.128903 | controller | 2026-04-20 17:50:48.129158 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-04-20 17:50:48.129407 | controller | Monday 20 April 2026 17:50:48 +0000 (0:00:01.042) 0:00:01.055 ********** 2026-04-20 17:50:48.559567 | controller | ok: [controller] 2026-04-20 17:50:48.559905 | controller | 2026-04-20 17:50:48.560268 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-04-20 17:50:48.560575 | controller | Monday 20 April 2026 17:50:48 +0000 (0:00:00.430) 0:00:01.486 ********** 2026-04-20 17:50:49.588630 | controller | ok: [controller] 2026-04-20 17:50:49.588814 | controller | 2026-04-20 17:50:49.588983 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-04-20 17:50:49.589202 | controller | Monday 20 April 2026 17:50:49 +0000 (0:00:01.028) 0:00:02.515 ********** 2026-04-20 17:50:50.028310 | controller | ok: [controller] 2026-04-20 17:50:50.028365 | controller | 2026-04-20 17:50:50.028382 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-20 17:50:50.028512 | controller | Monday 20 April 2026 17:50:50 +0000 (0:00:00.439) 0:00:02.955 ********** 2026-04-20 17:50:50.075547 | controller | ok: [controller] => { 2026-04-20 17:50:50.075707 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-04-20 17:50:50.075837 | controller | } 2026-04-20 17:50:50.075952 | controller | 2026-04-20 17:50:50.076230 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-20 17:50:50.076275 | controller | Monday 20 April 2026 17:50:50 +0000 (0:00:00.047) 0:00:03.002 ********** 2026-04-20 17:50:50.603623 | controller | ok: [controller] 2026-04-20 17:50:50.603668 | controller | 2026-04-20 17:50:50.603681 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-20 17:50:50.603751 | controller | Monday 20 April 2026 17:50:50 +0000 (0:00:00.525) 0:00:03.528 ********** 2026-04-20 17:50:52.319590 | controller | ok: [controller] 2026-04-20 17:50:52.319644 | controller | 2026-04-20 17:50:52.319791 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-04-20 17:50:52.319914 | controller | Monday 20 April 2026 17:50:52 +0000 (0:00:01.717) 0:00:05.246 ********** 2026-04-20 17:50:52.855939 | controller | ok: [controller] 2026-04-20 17:50:52.856025 | controller | 2026-04-20 17:50:52.856337 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-04-20 17:50:52.856373 | controller | Monday 20 April 2026 17:50:52 +0000 (0:00:00.535) 0:00:05.782 ********** 2026-04-20 17:50:53.248514 | controller | ok: [controller] 2026-04-20 17:50:53.248566 | controller | 2026-04-20 17:50:53.248725 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-04-20 17:50:53.248886 | controller | Monday 20 April 2026 17:50:53 +0000 (0:00:00.391) 0:00:06.173 ********** 2026-04-20 17:50:53.747288 | controller | ok: [controller] 2026-04-20 17:50:53.747499 | controller | 2026-04-20 17:50:53.747838 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-04-20 17:50:53.748284 | controller | Monday 20 April 2026 17:50:53 +0000 (0:00:00.499) 0:00:06.673 ********** 2026-04-20 17:50:54.056602 | controller | ok: [controller] 2026-04-20 17:50:54.056695 | controller | 2026-04-20 17:50:54.056752 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-04-20 17:50:54.056890 | controller | Monday 20 April 2026 17:50:54 +0000 (0:00:00.308) 0:00:06.981 ********** 2026-04-20 17:50:54.356254 | controller | ok: [controller] 2026-04-20 17:50:54.356310 | controller | 2026-04-20 17:50:54.356361 | controller | TASK [Install plugin] ********************************************************** 2026-04-20 17:50:54.356463 | controller | Monday 20 April 2026 17:50:54 +0000 (0:00:00.301) 0:00:07.283 ********** 2026-04-20 17:50:54.412321 | controller | included: vexxhost.containers.download_artifact for controller 2026-04-20 17:50:54.412400 | controller | 2026-04-20 17:50:54.412486 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-04-20 17:50:54.412574 | controller | Monday 20 April 2026 17:50:54 +0000 (0:00:00.054) 0:00:07.337 ********** 2026-04-20 17:50:54.460444 | controller | ok: [controller] => { 2026-04-20 17:50:54.460595 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-04-20 17:50:54.460696 | controller | } 2026-04-20 17:50:54.460800 | controller | 2026-04-20 17:50:54.461094 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-04-20 17:50:54.461137 | controller | Monday 20 April 2026 17:50:54 +0000 (0:00:00.048) 0:00:07.386 ********** 2026-04-20 17:50:54.903838 | controller | ok: [controller] 2026-04-20 17:50:54.903932 | controller | 2026-04-20 17:50:54.903942 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-04-20 17:50:54.903957 | controller | Monday 20 April 2026 17:50:54 +0000 (0:00:00.444) 0:00:07.830 ********** 2026-04-20 17:50:57.516520 | controller | ok: [controller] 2026-04-20 17:50:57.516617 | controller | 2026-04-20 17:50:57.516739 | controller | PLAY RECAP ********************************************************************* 2026-04-20 17:50:57.516884 | controller | controller : ok=16 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-20 17:50:57.516987 | controller | 2026-04-20 17:50:57.517098 | controller | 2026-04-20 17:50:57.517335 | controller | TASKS RECAP ******************************************************************** 2026-04-20 17:50:57.517484 | controller | Monday 20 April 2026 17:50:57 +0000 (0:00:02.609) 0:00:10.440 ********** 2026-04-20 17:50:57.517603 | controller | =============================================================================== 2026-04-20 17:50:57.517727 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.61s 2026-04-20 17:50:57.517854 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.72s 2026-04-20 17:50:57.517973 | controller | Gathering Facts --------------------------------------------------------- 1.04s 2026-04-20 17:50:57.518093 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.03s 2026-04-20 17:50:57.518216 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.54s 2026-04-20 17:50:57.518321 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.53s 2026-04-20 17:50:57.518404 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.50s 2026-04-20 17:50:57.518487 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.44s 2026-04-20 17:50:57.518572 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.44s 2026-04-20 17:50:57.518654 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.43s 2026-04-20 17:50:57.518738 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.39s 2026-04-20 17:50:57.518828 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.31s 2026-04-20 17:50:57.518919 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.30s 2026-04-20 17:50:57.518999 | controller | Install plugin ---------------------------------------------------------- 0.05s 2026-04-20 17:50:57.519083 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-04-20 17:50:57.519166 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-04-20 17:50:57.604248 | controller | INFO [helm > idempotence] Executed: Successful 2026-04-20 17:50:57.607963 | controller | INFO [helm > side_effect] Executing 2026-04-20 17:50:57.608327 | controller | WARNING [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-20 17:50:57.613669 | controller | INFO [helm > verify] Executing 2026-04-20 17:50:58.409850 | controller | 2026-04-20 17:50:58.410080 | controller | PLAY [Verify] ****************************************************************** 2026-04-20 17:50:58.410307 | controller | 2026-04-20 17:50:58.410503 | controller | TASK [Gathering Facts] ********************************************************* 2026-04-20 17:50:58.410692 | controller | Monday 20 April 2026 17:50:58 +0000 (0:00:00.009) 0:00:00.009 ********** 2026-04-20 17:50:59.438120 | 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-20 17:50:59.446460 | controller | ok: [controller] 2026-04-20 17:50:59.446688 | controller | 2026-04-20 17:50:59.446952 | controller | TASK [Get the current Helm version] ******************************************** 2026-04-20 17:50:59.447107 | controller | Monday 20 April 2026 17:50:59 +0000 (0:00:01.033) 0:00:01.043 ********** 2026-04-20 17:50:59.894890 | controller | changed: [controller] 2026-04-20 17:50:59.895029 | controller | 2026-04-20 17:50:59.895230 | controller | TASK [Assert Helm version] ***************************************************** 2026-04-20 17:50:59.895464 | controller | Monday 20 April 2026 17:50:59 +0000 (0:00:00.449) 0:00:01.492 ********** 2026-04-20 17:50:59.922684 | controller | ok: [controller] => { 2026-04-20 17:50:59.922870 | controller | "changed": false, 2026-04-20 17:50:59.923058 | controller | "msg": "All assertions passed" 2026-04-20 17:50:59.923238 | controller | } 2026-04-20 17:50:59.923412 | controller | 2026-04-20 17:50:59.923593 | controller | PLAY RECAP ********************************************************************* 2026-04-20 17:50:59.923801 | controller | controller : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-04-20 17:50:59.923962 | controller | 2026-04-20 17:50:59.924167 | controller | 2026-04-20 17:50:59.924354 | controller | TASKS RECAP ******************************************************************** 2026-04-20 17:50:59.924542 | controller | Monday 20 April 2026 17:50:59 +0000 (0:00:00.029) 0:00:01.522 ********** 2026-04-20 17:50:59.924719 | controller | =============================================================================== 2026-04-20 17:50:59.924897 | controller | Gathering Facts --------------------------------------------------------- 1.03s 2026-04-20 17:50:59.925081 | controller | Get the current Helm version -------------------------------------------- 0.45s 2026-04-20 17:50:59.925361 | controller | Assert Helm version ----------------------------------------------------- 0.03s 2026-04-20 17:50:59.999251 | controller | INFO [helm > verify] Executed: Successful 2026-04-20 17:51:00.009784 | controller | INFO [helm > cleanup] Executing 2026-04-20 17:51:00.010214 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-04-20 17:51:00.016719 | controller | INFO [helm > destroy] Executing 2026-04-20 17:51:00.016740 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-04-20 17:51:00.016894 | controller | INFO [helm > destroy] Executed: Successful 2026-04-20 17:51:00.017159 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-04-20 17:51:00.240083 | controller | ok: Runtime: 0:07:25.534498 2026-04-20 17:51:00.248910 | 2026-04-20 17:51:00.249122 | PLAY RECAP 2026-04-20 17:51:00.249217 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-20 17:51:00.249269 | 2026-04-20 17:51:00.383828 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-04-20 17:51:00.386992 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-04-20 17:51:00.965516 | 2026-04-20 17:51:00.965641 | PLAY [all] 2026-04-20 17:51:00.976519 | 2026-04-20 17:51:00.976598 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-04-20 17:51:01.333044 | controller | changed 2026-04-20 17:51:01.338663 | 2026-04-20 17:51:01.338765 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-04-20 17:51:01.697747 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-20 17:51:01.698367 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-20 17:51:01.705881 | controller | environment: line 1: kubectl: command not found 2026-04-20 17:51:01.707346 | controller | environment: line 1: kubectl: command not found 2026-04-20 17:51:01.707387 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-20 17:51:01.709143 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-20 17:51:01.711651 | controller | environment: line 1: kubectl: command not found 2026-04-20 17:51:01.712976 | controller | environment: line 1: kubectl: command not found 2026-04-20 17:51:01.713010 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-20 17:51:01.714843 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-20 17:51:01.716825 | controller | environment: line 1: kubectl: command not found 2026-04-20 17:51:01.718706 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-04-20 17:51:01.870632 | controller | ok: Runtime: 0:00:00.032990 2026-04-20 17:51:01.877091 | 2026-04-20 17:51:01.877163 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-04-20 17:51:02.110624 | controller | changed 2026-04-20 17:51:02.116089 | 2026-04-20 17:51:02.116192 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-04-20 17:51:02.353277 | controller | environment: line 5: kubectl: command not found 2026-04-20 17:51:02.355040 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-20 17:51:02.355126 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-20 17:51:02.355261 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-04-20 17:51:02.645768 | controller | ok: Runtime: 0:00:00.014110 2026-04-20 17:51:02.652552 | 2026-04-20 17:51:02.652628 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-04-20 17:51:03.299145 | controller | changed: 2026-04-20 17:51:03.299325 | controller | created directory /var/lib/zuul/builds/dac3b002f2c74aa282cb5e4569bf69a3/work/logs/controller 2026-04-20 17:51:03.299365 | controller | cd+++++++++ objects/ 2026-04-20 17:51:03.299395 | controller | cd+++++++++ objects/cluster/ 2026-04-20 17:51:03.299425 | controller | cd+++++++++ objects/namespaced/ 2026-04-20 17:51:03.308491 | 2026-04-20 17:51:03.308575 | TASK [gather-pod-logs : creating directory for pod logs] 2026-04-20 17:51:03.541639 | controller | changed 2026-04-20 17:51:03.546027 | 2026-04-20 17:51:03.546090 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-04-20 17:51:03.799958 | controller | changed 2026-04-20 17:51:03.808671 | 2026-04-20 17:51:03.808814 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-04-20 17:51:04.058694 | controller | environment: line 3: kubectl: command not found 2026-04-20 17:51:04.339414 | controller | ok: Runtime: 0:00:00.012543 2026-04-20 17:51:04.345162 | 2026-04-20 17:51:04.345246 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-04-20 17:51:04.906511 | controller | changed: 2026-04-20 17:51:04.906754 | controller | cd+++++++++ pod-logs/ 2026-04-20 17:51:04.906796 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-04-20 17:51:04.916053 | 2026-04-20 17:51:04.916142 | LOOP [helm-release-status : creating directory for helm release status] 2026-04-20 17:51:05.159678 | controller | changed: "values" 2026-04-20 17:51:05.358016 | controller | changed: "releases" 2026-04-20 17:51:05.373237 | 2026-04-20 17:51:05.373328 | TASK [helm-release-status : Gather get release status for helm charts] 2026-04-20 17:51:05.606994 | controller | /bin/bash: line 3: kubectl: command not found 2026-04-20 17:51:05.904060 | controller | ok: Runtime: 0:00:00.008658 2026-04-20 17:51:05.908565 | 2026-04-20 17:51:05.908630 | TASK [helm-release-status : Downloads logs to executor] 2026-04-20 17:51:06.462031 | controller | changed: 2026-04-20 17:51:06.462227 | controller | cd+++++++++ helm/ 2026-04-20 17:51:06.462264 | controller | cd+++++++++ helm/releases/ 2026-04-20 17:51:06.462295 | controller | cd+++++++++ helm/values/ 2026-04-20 17:51:06.468116 | 2026-04-20 17:51:06.468184 | PLAY RECAP 2026-04-20 17:51:06.468239 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-04-20 17:51:06.468268 | 2026-04-20 17:51:06.575945 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-04-20 17:51:06.578789 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-20 17:51:07.157445 | 2026-04-20 17:51:07.157572 | PLAY [all] 2026-04-20 17:51:07.167573 | 2026-04-20 17:51:07.167670 | TASK [fetch-output : Set log path for multiple nodes] 2026-04-20 17:51:07.203683 | controller | skipping: Conditional result was False 2026-04-20 17:51:07.211959 | 2026-04-20 17:51:07.212067 | TASK [fetch-output : Set log path for single node] 2026-04-20 17:51:07.254145 | controller | ok 2026-04-20 17:51:07.262094 | 2026-04-20 17:51:07.262196 | LOOP [fetch-output : Ensure local output dirs] 2026-04-20 17:51:07.624031 | controller -> localhost | ok: "/var/lib/zuul/builds/dac3b002f2c74aa282cb5e4569bf69a3/work/logs" 2026-04-20 17:51:07.847156 | controller -> localhost | changed: "/var/lib/zuul/builds/dac3b002f2c74aa282cb5e4569bf69a3/work/artifacts" 2026-04-20 17:51:08.085973 | controller -> localhost | changed: "/var/lib/zuul/builds/dac3b002f2c74aa282cb5e4569bf69a3/work/docs" 2026-04-20 17:51:08.110175 | 2026-04-20 17:51:08.110367 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-04-20 17:51:08.737356 | controller | changed: .d..t...... ./ 2026-04-20 17:51:08.878851 | controller | changed: All items complete 2026-04-20 17:51:08.879038 | 2026-04-20 17:51:09.217048 | controller | changed: .d..t...... ./ 2026-04-20 17:51:09.706469 | controller | changed: .d..t...... ./ 2026-04-20 17:51:09.724012 | 2026-04-20 17:51:09.724158 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-04-20 17:51:10.146318 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.007680 2026-04-20 17:51:10.361680 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.008049 2026-04-20 17:51:10.378200 | 2026-04-20 17:51:10.378336 | PLAY [all] 2026-04-20 17:51:10.384770 | 2026-04-20 17:51:10.384853 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-04-20 17:51:10.819536 | controller | changed 2026-04-20 17:51:10.825894 | 2026-04-20 17:51:10.825942 | PLAY RECAP 2026-04-20 17:51:10.825988 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-04-20 17:51:10.826011 | 2026-04-20 17:51:10.929539 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-04-20 17:51:10.932097 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-04-20 17:51:11.460866 | 2026-04-20 17:51:11.461029 | PLAY [localhost] 2026-04-20 17:51:11.470619 | 2026-04-20 17:51:11.470690 | TASK [Generate Zuul manifest] 2026-04-20 17:51:11.488949 | localhost | ok 2026-04-20 17:51:11.506517 | 2026-04-20 17:51:11.506593 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-04-20 17:51:11.811329 | localhost | changed 2026-04-20 17:51:11.822178 | 2026-04-20 17:51:11.822256 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-04-20 17:51:11.852741 | localhost | ok 2026-04-20 17:51:11.861781 | 2026-04-20 17:51:11.861838 | TASK [Upload logs] 2026-04-20 17:51:11.880221 | localhost | ok 2026-04-20 17:51:11.944625 | 2026-04-20 17:51:11.944752 | TASK [Set zuul-log-path fact] 2026-04-20 17:51:11.965414 | localhost | ok 2026-04-20 17:51:11.978295 | 2026-04-20 17:51:11.978360 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-04-20 17:51:12.007919 | localhost | ok 2026-04-20 17:51:12.016771 | 2026-04-20 17:51:12.016879 | TASK [upload-logs : Create log directories] 2026-04-20 17:51:12.403390 | localhost | changed 2026-04-20 17:51:12.408705 | 2026-04-20 17:51:12.408771 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-04-20 17:51:12.816886 | localhost -> localhost | ok: Runtime: 0:00:00.005315 2026-04-20 17:51:12.822858 | 2026-04-20 17:51:12.822933 | TASK [upload-logs : Upload logs to log server] 2026-04-20 17:51:13.288514 | localhost | Output suppressed because no_log was given 2026-04-20 17:51:13.293248 | 2026-04-20 17:51:13.293336 | LOOP [upload-logs : Compress console log and json output] 2026-04-20 17:51:13.340499 | localhost | skipping: Conditional result was False 2026-04-20 17:51:13.347635 | localhost | skipping: Conditional result was False 2026-04-20 17:51:13.359981 | 2026-04-20 17:51:13.360264 | LOOP [upload-logs : Upload compressed console log and json output] 2026-04-20 17:51:13.408152 | localhost | skipping: Conditional result was False 2026-04-20 17:51:13.408511 | 2026-04-20 17:51:13.412669 | localhost | skipping: Conditional result was False 2026-04-20 17:51:13.424672 | 2026-04-20 17:51:13.424884 | LOOP [upload-logs : Upload console log and json output]