2026-03-18 10:54:13.249752 | Job console starting 2026-03-18 10:54:13.399511 | Updating git repos 2026-03-18 10:54:13.452636 | Cloning repos into workspace 2026-03-18 10:54:14.208749 | Restoring repo states 2026-03-18 10:54:14.235951 | Merging changes 2026-03-18 10:54:15.033590 | Checking out repos 2026-03-18 10:54:15.282356 | Preparing playbooks 2026-03-18 10:54:17.962397 | Running Ansible setup 2026-03-18 10:54:23.037566 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-18 10:54:23.678518 | 2026-03-18 10:54:23.678645 | PLAY [localhost] 2026-03-18 10:54:23.686229 | 2026-03-18 10:54:23.686302 | TASK [Gathering Facts] 2026-03-18 10:54:24.625186 | localhost | ok 2026-03-18 10:54:24.637940 | 2026-03-18 10:54:24.638117 | TASK [Setup log path fact] 2026-03-18 10:54:24.660540 | localhost | ok 2026-03-18 10:54:24.675440 | 2026-03-18 10:54:24.675539 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-18 10:54:24.717246 | localhost | ok 2026-03-18 10:54:24.796632 | 2026-03-18 10:54:24.796787 | TASK [emit-job-header : Print job information] 2026-03-18 10:54:24.830118 | # Job Information 2026-03-18 10:54:24.830356 | Ansible Version: 2.16.16 2026-03-18 10:54:24.830405 | Job: ansible-collection-kubernetes-molecule-helm 2026-03-18 10:54:24.830437 | Pipeline: check 2026-03-18 10:54:24.830465 | Executor: 0a8996d2b663 2026-03-18 10:54:24.830494 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/238 2026-03-18 10:54:24.830526 | Event ID: a9bae240-22b8-11f1-9188-dc82f939f47c 2026-03-18 10:54:24.834711 | 2026-03-18 10:54:24.834811 | LOOP [emit-job-header : Print node information] 2026-03-18 10:54:24.937254 | localhost | ok: 2026-03-18 10:54:24.938068 | localhost | # Node Information 2026-03-18 10:54:24.938179 | localhost | Inventory Hostname: controller 2026-03-18 10:54:24.938217 | localhost | Hostname: np0000159815 2026-03-18 10:54:24.938251 | localhost | Username: zuul 2026-03-18 10:54:24.938284 | localhost | Distro: Debian 13.3 2026-03-18 10:54:24.938310 | localhost | Provider: yul1 2026-03-18 10:54:24.938336 | localhost | Region: ca-ymq-1 2026-03-18 10:54:24.938359 | localhost | Label: debian-trixie 2026-03-18 10:54:24.938385 | localhost | Product Name: OpenStack Nova 2026-03-18 10:54:24.938410 | localhost | Interface IP: 199.204.45.129 2026-03-18 10:54:24.955216 | 2026-03-18 10:54:25.000451 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-18 10:54:25.422578 | localhost -> localhost | changed 2026-03-18 10:54:25.427947 | 2026-03-18 10:54:25.428075 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-18 10:54:26.419584 | localhost -> localhost | changed 2026-03-18 10:54:26.432632 | 2026-03-18 10:54:26.432719 | PLAY [all] 2026-03-18 10:54:26.439787 | 2026-03-18 10:54:26.439860 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-18 10:54:26.670846 | controller -> localhost | ok 2026-03-18 10:54:26.676943 | 2026-03-18 10:54:26.677081 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-18 10:54:26.711323 | controller | ok 2026-03-18 10:54:26.723699 | controller | included: /var/lib/zuul/builds/2d49abfff569446c953c330c1de386a0/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-18 10:54:26.728276 | 2026-03-18 10:54:26.728336 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-18 10:54:28.022844 | controller -> localhost | Generating public/private rsa key pair. 2026-03-18 10:54:28.023056 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/2d49abfff569446c953c330c1de386a0/work/2d49abfff569446c953c330c1de386a0_id_rsa 2026-03-18 10:54:28.023091 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/2d49abfff569446c953c330c1de386a0/work/2d49abfff569446c953c330c1de386a0_id_rsa.pub 2026-03-18 10:54:28.023122 | controller -> localhost | The key fingerprint is: 2026-03-18 10:54:28.023145 | controller -> localhost | SHA256:eZTjgMa1XuHy/uvX3Bjr3FQRZ8uyB2qZroJF9k5mvSk zuul-build-sshkey 2026-03-18 10:54:28.023184 | controller -> localhost | The key's randomart image is: 2026-03-18 10:54:28.023209 | controller -> localhost | +---[RSA 3072]----+ 2026-03-18 10:54:28.023234 | controller -> localhost | | . . .o| 2026-03-18 10:54:28.023256 | controller -> localhost | | . o o o ..+| 2026-03-18 10:54:28.023276 | controller -> localhost | | + + * o + | 2026-03-18 10:54:28.023296 | controller -> localhost | | . + O .+ + .| 2026-03-18 10:54:28.023317 | controller -> localhost | | o S == . ..| 2026-03-18 10:54:28.023345 | controller -> localhost | | . Bo. o .| 2026-03-18 10:54:28.023376 | controller -> localhost | | o = ..o *o| 2026-03-18 10:54:28.023406 | controller -> localhost | | . . E.+ .+o+| 2026-03-18 10:54:28.023440 | controller -> localhost | | ....++o .| 2026-03-18 10:54:28.023472 | controller -> localhost | +----[SHA256]-----+ 2026-03-18 10:54:28.023549 | controller -> localhost | ok: Runtime: 0:00:00.816040 2026-03-18 10:54:28.035122 | 2026-03-18 10:54:28.035343 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-18 10:54:28.069447 | controller | ok 2026-03-18 10:54:28.080948 | controller | included: /var/lib/zuul/builds/2d49abfff569446c953c330c1de386a0/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-18 10:54:28.088557 | 2026-03-18 10:54:28.088631 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-18 10:54:28.113495 | controller | skipping: Conditional result was False 2026-03-18 10:54:28.123815 | 2026-03-18 10:54:28.123923 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-18 10:54:28.672430 | controller | changed 2026-03-18 10:54:28.676528 | 2026-03-18 10:54:28.676590 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-18 10:54:28.879479 | controller | ok 2026-03-18 10:54:28.886787 | 2026-03-18 10:54:28.886849 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-18 10:54:29.440654 | controller | changed 2026-03-18 10:54:29.447810 | 2026-03-18 10:54:29.447956 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-18 10:54:29.995215 | controller | changed 2026-03-18 10:54:30.002032 | 2026-03-18 10:54:30.002123 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-18 10:54:30.025447 | controller | skipping: Conditional result was False 2026-03-18 10:54:30.034609 | 2026-03-18 10:54:30.034712 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-18 10:54:30.410111 | controller -> localhost | changed 2026-03-18 10:54:30.422659 | 2026-03-18 10:54:30.422737 | TASK [add-build-sshkey : Add back temp key] 2026-03-18 10:54:30.717119 | controller -> localhost | Identity added: /var/lib/zuul/builds/2d49abfff569446c953c330c1de386a0/work/2d49abfff569446c953c330c1de386a0_id_rsa (zuul-build-sshkey) 2026-03-18 10:54:30.717361 | controller -> localhost | ok: Runtime: 0:00:00.036544 2026-03-18 10:54:30.722691 | 2026-03-18 10:54:30.722775 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-18 10:54:31.076114 | controller | ok 2026-03-18 10:54:31.079805 | 2026-03-18 10:54:31.079869 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-18 10:54:31.105385 | controller | skipping: Conditional result was False 2026-03-18 10:54:31.117931 | 2026-03-18 10:54:31.117996 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-18 10:54:31.483028 | controller | ok 2026-03-18 10:54:31.488632 | 2026-03-18 10:54:31.488700 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-18 10:54:32.612278 | controller | Output suppressed because no_log was given 2026-03-18 10:54:32.658804 | 2026-03-18 10:54:32.658939 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-18 10:54:32.878818 | controller | ok: "logs" 2026-03-18 10:54:32.879154 | controller | ok: All items complete 2026-03-18 10:54:32.879203 | 2026-03-18 10:54:33.064347 | controller | ok: "artifacts" 2026-03-18 10:54:33.250911 | controller | ok: "docs" 2026-03-18 10:54:33.258649 | 2026-03-18 10:54:33.258813 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-18 10:54:33.470530 | controller | changed: "logs" 2026-03-18 10:54:33.654450 | controller | changed: "artifacts" 2026-03-18 10:54:33.846315 | controller | changed: "docs" 2026-03-18 10:54:33.867147 | 2026-03-18 10:54:33.867327 | PLAY RECAP 2026-03-18 10:54:33.867411 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-03-18 10:54:33.867461 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-18 10:54:33.867500 | 2026-03-18 10:54:34.079044 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-18 10:54:34.082345 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-18 10:54:34.697982 | 2026-03-18 10:54:34.764432 | PLAY [all] 2026-03-18 10:54:34.781893 | 2026-03-18 10:54:34.782021 | TASK [setup-uv : Extract archive] 2026-03-18 10:54:37.217474 | controller | changed 2026-03-18 10:54:37.225408 | 2026-03-18 10:54:37.225523 | TASK [setup-uv : Print version] 2026-03-18 10:54:37.509559 | controller | uv 0.8.13 2026-03-18 10:54:37.751726 | controller | ok: Runtime: 0:00:00.013782 2026-03-18 10:54:37.759080 | 2026-03-18 10:54:37.759144 | PLAY RECAP 2026-03-18 10:54:37.759201 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-18 10:54:37.759235 | 2026-03-18 10:54:37.868821 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-18 10:54:37.870299 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-18 10:54:38.514655 | 2026-03-18 10:54:38.514923 | PLAY [all] 2026-03-18 10:54:38.529285 | 2026-03-18 10:54:38.529483 | TASK [Update apt cache] 2026-03-18 10:54:43.723803 | controller | ok 2026-03-18 10:54:43.729764 | 2026-03-18 10:54:43.729891 | TASK [Disable firewalld] 2026-03-18 10:54:43.756386 | controller | skipping: Conditional result was False 2026-03-18 10:54:43.764721 | 2026-03-18 10:54:43.764874 | TASK [Install "jq" for log collection] 2026-03-18 10:54:46.174933 | controller | changed 2026-03-18 10:54:46.177684 | 2026-03-18 10:54:46.177767 | PLAY RECAP 2026-03-18 10:54:46.177833 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-18 10:54:46.177866 | 2026-03-18 10:54:46.328829 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-18 10:54:46.330788 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-18 10:54:46.938357 | 2026-03-18 10:54:46.938537 | PLAY [all] 2026-03-18 10:54:46.949416 | 2026-03-18 10:54:46.949568 | TASK [Copy inventory file for Zuul] 2026-03-18 10:54:47.878251 | controller | changed 2026-03-18 10:54:47.885230 | 2026-03-18 10:54:47.885336 | TASK [Switch "ansible_host" to private IP] 2026-03-18 10:54:48.193380 | controller | changed: 1 replacements made 2026-03-18 10:54:48.199556 | 2026-03-18 10:54:48.199695 | TASK [Run Molecule scenario] 2026-03-18 10:54:48.686849 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-03-18 10:54:48.686958 | controller | Creating virtual environment at: .venv 2026-03-18 10:54:48.951829 | controller | Downloading pygments (1.2MiB) 2026-03-18 10:54:48.952160 | controller | Downloading ansible-core (2.3MiB) 2026-03-18 10:54:48.952999 | controller | Downloading cryptography (4.3MiB) 2026-03-18 10:54:49.114449 | controller | Downloading cryptography 2026-03-18 10:54:49.170273 | controller | Downloading pygments 2026-03-18 10:54:49.334442 | controller | Downloading ansible-core 2026-03-18 10:54:49.389523 | controller | Installed 36 packages in 54ms 2026-03-18 10:54:50.081350 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-03-18 10:54:50.081943 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-03-18 10:54:50.967585 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-03-18 10:54:50.967657 | controller | INFO default scenario not found, disabling shared state. 2026-03-18 10:54:50.967740 | controller | INFO [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-03-18 10:54:50.967813 | controller | INFO [helm > prerun] Performing prerun with role_name_check=0... 2026-03-18 10:55:05.826295 | controller | INFO [helm > dependency] Executing 2026-03-18 10:55:05.826390 | controller | WARNING [helm > dependency] Missing roles requirements file: requirements.yml 2026-03-18 10:55:05.826400 | controller | WARNING [helm > dependency] Missing collections requirements file: collections.yml 2026-03-18 10:55:05.826440 | controller | WARNING [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-03-18 10:55:05.831906 | controller | INFO [helm > cleanup] Executing 2026-03-18 10:55:05.832241 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-18 10:55:05.837521 | controller | INFO [helm > destroy] Executing 2026-03-18 10:55:05.837545 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-18 10:55:05.837596 | controller | INFO [helm > destroy] Executed: Successful 2026-03-18 10:55:05.843021 | controller | INFO [helm > syntax] Executing 2026-03-18 10:55:06.834808 | controller | 2026-03-18 10:55:06.834838 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml 2026-03-18 10:55:06.946143 | controller | INFO [helm > syntax] Executed: Successful 2026-03-18 10:55:06.959507 | controller | INFO [helm > create] Executing 2026-03-18 10:55:06.962678 | controller | WARNING [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-18 10:55:06.968519 | controller | INFO [helm > prepare] Executing 2026-03-18 10:55:07.924513 | controller | 2026-03-18 10:55:07.924599 | controller | PLAY [Prepare] ***************************************************************** 2026-03-18 10:55:07.924609 | controller | 2026-03-18 10:55:07.924617 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-18 10:55:07.924626 | controller | Wednesday 18 March 2026 10:55:07 +0000 (0:00:00.035) 0:00:00.035 ******* 2026-03-18 10:55:09.241294 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-18 10:55:09.248352 | controller | ok: [controller] 2026-03-18 10:55:09.248380 | controller | 2026-03-18 10:55:09.248390 | controller | TASK [Install Debian packages] ************************************************* 2026-03-18 10:55:09.248400 | controller | Wednesday 18 March 2026 10:55:09 +0000 (0:00:01.324) 0:00:01.359 ******* 2026-03-18 10:55:10.689018 | controller | ok: [controller] 2026-03-18 10:55:10.689421 | controller | 2026-03-18 10:55:10.689799 | controller | PLAY RECAP ********************************************************************* 2026-03-18 10:55:10.690194 | controller | controller : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-18 10:55:10.690535 | controller | 2026-03-18 10:55:10.690970 | controller | 2026-03-18 10:55:10.691339 | controller | TASKS RECAP ******************************************************************** 2026-03-18 10:55:10.691738 | controller | Wednesday 18 March 2026 10:55:10 +0000 (0:00:01.441) 0:00:02.801 ******* 2026-03-18 10:55:10.692082 | controller | =============================================================================== 2026-03-18 10:55:10.692442 | controller | Install Debian packages ------------------------------------------------- 1.44s 2026-03-18 10:55:10.692798 | controller | Gathering Facts --------------------------------------------------------- 1.32s 2026-03-18 10:55:10.827142 | controller | INFO [helm > prepare] Executed: Successful 2026-03-18 10:55:10.837928 | controller | INFO [helm > converge] Executing 2026-03-18 10:55:11.737000 | controller | 2026-03-18 10:55:11.737307 | controller | PLAY [Converge] **************************************************************** 2026-03-18 10:55:11.737542 | controller | 2026-03-18 10:55:11.737801 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-18 10:55:11.738052 | controller | Wednesday 18 March 2026 10:55:11 +0000 (0:00:00.012) 0:00:00.012 ******* 2026-03-18 10:55:12.902163 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-18 10:55:12.906651 | controller | ok: [controller] 2026-03-18 10:55:12.906784 | controller | 2026-03-18 10:55:12.906931 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-18 10:55:12.907061 | controller | Wednesday 18 March 2026 10:55:12 +0000 (0:00:01.169) 0:00:01.181 ******* 2026-03-18 10:55:13.446522 | controller | ok: [controller] 2026-03-18 10:55:13.446593 | controller | 2026-03-18 10:55:13.446604 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-18 10:55:13.446614 | controller | Wednesday 18 March 2026 10:55:13 +0000 (0:00:00.536) 0:00:01.717 ******* 2026-03-18 10:55:14.577024 | controller | ok: [controller] 2026-03-18 10:55:14.577195 | controller | 2026-03-18 10:55:14.577410 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-18 10:55:14.577656 | controller | Wednesday 18 March 2026 10:55:14 +0000 (0:00:01.133) 0:00:02.851 ******* 2026-03-18 10:55:15.041086 | controller | changed: [controller] 2026-03-18 10:55:15.041210 | controller | 2026-03-18 10:55:15.041430 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-18 10:55:15.041620 | controller | Wednesday 18 March 2026 10:55:15 +0000 (0:00:00.463) 0:00:03.315 ******* 2026-03-18 10:55:15.092318 | controller | ok: [controller] => { 2026-03-18 10:55:15.092568 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-18 10:55:15.092814 | controller | } 2026-03-18 10:55:15.093053 | controller | 2026-03-18 10:55:15.093319 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-18 10:55:15.093526 | controller | Wednesday 18 March 2026 10:55:15 +0000 (0:00:00.051) 0:00:03.367 ******* 2026-03-18 10:55:15.887835 | controller | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created with a mode of 0700, this may cause issues when running as another user. To avoid this, create the remote_tmp dir with the correct permissions manually 2026-03-18 10:55:15.898141 | controller | changed: [controller] 2026-03-18 10:55:15.898341 | controller | 2026-03-18 10:55:15.898563 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-18 10:55:15.898821 | controller | Wednesday 18 March 2026 10:55:15 +0000 (0:00:00.805) 0:00:04.173 ******* 2026-03-18 10:55:17.976346 | controller | changed: [controller] 2026-03-18 10:55:17.976485 | controller | 2026-03-18 10:55:17.976800 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-18 10:55:17.976880 | controller | Wednesday 18 March 2026 10:55:17 +0000 (0:00:02.077) 0:00:06.251 ******* 2026-03-18 10:55:18.483988 | controller | ok: [controller] 2026-03-18 10:55:18.484051 | controller | 2026-03-18 10:55:18.484179 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-18 10:55:18.484293 | controller | Wednesday 18 March 2026 10:55:18 +0000 (0:00:00.507) 0:00:06.758 ******* 2026-03-18 10:55:18.905034 | controller | changed: [controller] 2026-03-18 10:55:18.910953 | controller | 2026-03-18 10:55:18.912132 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-18 10:55:18.912243 | controller | Wednesday 18 March 2026 10:55:18 +0000 (0:00:00.420) 0:00:07.179 ******* 2026-03-18 10:55:19.373366 | controller | ok: [controller] 2026-03-18 10:55:19.373521 | controller | 2026-03-18 10:55:19.373750 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-18 10:55:19.373956 | controller | Wednesday 18 March 2026 10:55:19 +0000 (0:00:00.468) 0:00:07.648 ******* 2026-03-18 10:55:19.686449 | controller | changed: [controller] 2026-03-18 10:55:19.686512 | controller | 2026-03-18 10:55:19.686669 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-18 10:55:19.686847 | controller | Wednesday 18 March 2026 10:55:19 +0000 (0:00:00.313) 0:00:07.961 ******* 2026-03-18 10:55:20.007089 | controller | ok: [controller] 2026-03-18 10:55:20.007252 | controller | 2026-03-18 10:55:20.007470 | controller | TASK [Install plugin] ********************************************************** 2026-03-18 10:55:20.007674 | controller | Wednesday 18 March 2026 10:55:19 +0000 (0:00:00.320) 0:00:08.281 ******* 2026-03-18 10:55:20.063439 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-18 10:55:20.063594 | controller | 2026-03-18 10:55:20.063798 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-18 10:55:20.063992 | controller | Wednesday 18 March 2026 10:55:20 +0000 (0:00:00.057) 0:00:08.338 ******* 2026-03-18 10:55:20.113698 | controller | ok: [controller] => { 2026-03-18 10:55:20.113904 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-18 10:55:20.114087 | controller | } 2026-03-18 10:55:20.114263 | controller | 2026-03-18 10:55:20.114465 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-18 10:55:20.114658 | controller | Wednesday 18 March 2026 10:55:20 +0000 (0:00:00.049) 0:00:08.388 ******* 2026-03-18 10:55:20.877149 | controller | changed: [controller] 2026-03-18 10:55:20.877206 | controller | 2026-03-18 10:55:20.877243 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-18 10:55:20.877347 | controller | Wednesday 18 March 2026 10:55:20 +0000 (0:00:00.755) 0:00:09.144 ******* 2026-03-18 10:55:23.019319 | controller | changed: [controller] 2026-03-18 10:55:23.019367 | controller | 2026-03-18 10:55:23.019497 | controller | PLAY RECAP ********************************************************************* 2026-03-18 10:55:23.019626 | controller | controller : ok=16 changed=7 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-18 10:55:23.019737 | controller | 2026-03-18 10:55:23.019827 | controller | 2026-03-18 10:55:23.019905 | controller | TASKS RECAP ******************************************************************** 2026-03-18 10:55:23.022828 | controller | Wednesday 18 March 2026 10:55:23 +0000 (0:00:02.146) 0:00:11.290 ******* 2026-03-18 10:55:23.022859 | controller | =============================================================================== 2026-03-18 10:55:23.022863 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.15s 2026-03-18 10:55:23.022866 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.08s 2026-03-18 10:55:23.022870 | controller | Gathering Facts --------------------------------------------------------- 1.17s 2026-03-18 10:55:23.022873 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.13s 2026-03-18 10:55:23.022877 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.81s 2026-03-18 10:55:23.022880 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.76s 2026-03-18 10:55:23.022883 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.54s 2026-03-18 10:55:23.022886 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.51s 2026-03-18 10:55:23.022891 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.47s 2026-03-18 10:55:23.022894 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.46s 2026-03-18 10:55:23.022908 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.42s 2026-03-18 10:55:23.022912 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.32s 2026-03-18 10:55:23.022915 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.31s 2026-03-18 10:55:23.022919 | controller | Install plugin ---------------------------------------------------------- 0.06s 2026-03-18 10:55:23.022922 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-18 10:55:23.022925 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-18 10:55:23.138954 | controller | INFO [helm > converge] Executed: Successful 2026-03-18 10:55:23.146154 | controller | INFO [helm > idempotence] Executing 2026-03-18 10:55:24.006713 | controller | 2026-03-18 10:55:24.006915 | controller | PLAY [Converge] **************************************************************** 2026-03-18 10:55:24.007081 | controller | 2026-03-18 10:55:24.007272 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-18 10:55:24.007467 | controller | Wednesday 18 March 2026 10:55:24 +0000 (0:00:00.012) 0:00:00.012 ******* 2026-03-18 10:55:25.123433 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-18 10:55:25.128416 | controller | ok: [controller] 2026-03-18 10:55:25.128524 | controller | 2026-03-18 10:55:25.128656 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-18 10:55:25.128783 | controller | Wednesday 18 March 2026 10:55:25 +0000 (0:00:01.121) 0:00:01.134 ******* 2026-03-18 10:55:25.585526 | controller | ok: [controller] 2026-03-18 10:55:25.585619 | controller | 2026-03-18 10:55:25.585628 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-18 10:55:25.585696 | controller | Wednesday 18 March 2026 10:55:25 +0000 (0:00:00.457) 0:00:01.591 ******* 2026-03-18 10:55:26.642972 | controller | ok: [controller] 2026-03-18 10:55:26.643020 | controller | 2026-03-18 10:55:26.643233 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-18 10:55:26.643378 | controller | Wednesday 18 March 2026 10:55:26 +0000 (0:00:01.057) 0:00:02.648 ******* 2026-03-18 10:55:27.107373 | controller | ok: [controller] 2026-03-18 10:55:27.107416 | controller | 2026-03-18 10:55:27.107493 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-18 10:55:27.107605 | controller | Wednesday 18 March 2026 10:55:27 +0000 (0:00:00.461) 0:00:03.110 ******* 2026-03-18 10:55:27.158835 | controller | ok: [controller] => { 2026-03-18 10:55:27.158974 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-18 10:55:27.159093 | controller | } 2026-03-18 10:55:27.159254 | controller | 2026-03-18 10:55:27.159331 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-18 10:55:27.159461 | controller | Wednesday 18 March 2026 10:55:27 +0000 (0:00:00.054) 0:00:03.164 ******* 2026-03-18 10:55:27.695153 | controller | ok: [controller] 2026-03-18 10:55:27.695206 | controller | 2026-03-18 10:55:27.695367 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-18 10:55:27.695495 | controller | Wednesday 18 March 2026 10:55:27 +0000 (0:00:00.536) 0:00:03.700 ******* 2026-03-18 10:55:30.425270 | controller | ok: [controller] 2026-03-18 10:55:30.425322 | controller | 2026-03-18 10:55:30.425332 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-18 10:55:30.425341 | controller | Wednesday 18 March 2026 10:55:30 +0000 (0:00:02.728) 0:00:06.429 ******* 2026-03-18 10:55:30.963077 | controller | ok: [controller] 2026-03-18 10:55:30.963284 | controller | 2026-03-18 10:55:30.963469 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-18 10:55:30.963639 | controller | Wednesday 18 March 2026 10:55:30 +0000 (0:00:00.536) 0:00:06.965 ******* 2026-03-18 10:55:31.363496 | controller | ok: [controller] 2026-03-18 10:55:31.363837 | controller | 2026-03-18 10:55:31.364146 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-18 10:55:31.364422 | controller | Wednesday 18 March 2026 10:55:31 +0000 (0:00:00.401) 0:00:07.367 ******* 2026-03-18 10:55:31.875336 | controller | ok: [controller] 2026-03-18 10:55:31.875505 | controller | 2026-03-18 10:55:31.875641 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-18 10:55:31.875768 | controller | Wednesday 18 March 2026 10:55:31 +0000 (0:00:00.511) 0:00:07.878 ******* 2026-03-18 10:55:32.187355 | controller | ok: [controller] 2026-03-18 10:55:32.187478 | controller | 2026-03-18 10:55:32.187550 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-18 10:55:32.187723 | controller | Wednesday 18 March 2026 10:55:32 +0000 (0:00:00.311) 0:00:08.190 ******* 2026-03-18 10:55:32.511285 | controller | ok: [controller] 2026-03-18 10:55:32.511341 | controller | 2026-03-18 10:55:32.511416 | controller | TASK [Install plugin] ********************************************************** 2026-03-18 10:55:32.511523 | controller | Wednesday 18 March 2026 10:55:32 +0000 (0:00:00.323) 0:00:08.514 ******* 2026-03-18 10:55:32.566009 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-18 10:55:32.566047 | controller | 2026-03-18 10:55:32.566164 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-18 10:55:32.566283 | controller | Wednesday 18 March 2026 10:55:32 +0000 (0:00:00.057) 0:00:08.572 ******* 2026-03-18 10:55:32.628872 | controller | ok: [controller] => { 2026-03-18 10:55:32.628973 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-18 10:55:32.629051 | controller | } 2026-03-18 10:55:32.629126 | controller | 2026-03-18 10:55:32.629221 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-18 10:55:32.629300 | controller | Wednesday 18 March 2026 10:55:32 +0000 (0:00:00.062) 0:00:08.634 ******* 2026-03-18 10:55:33.091616 | controller | ok: [controller] 2026-03-18 10:55:33.091742 | controller | 2026-03-18 10:55:33.091756 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-18 10:55:33.091852 | controller | Wednesday 18 March 2026 10:55:33 +0000 (0:00:00.461) 0:00:09.095 ******* 2026-03-18 10:55:34.754791 | controller | ok: [controller] 2026-03-18 10:55:34.754841 | controller | 2026-03-18 10:55:34.754852 | controller | PLAY RECAP ********************************************************************* 2026-03-18 10:55:34.754861 | controller | controller : ok=16 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-18 10:55:34.754869 | controller | 2026-03-18 10:55:34.754877 | controller | 2026-03-18 10:55:34.754885 | controller | TASKS RECAP ******************************************************************** 2026-03-18 10:55:34.754893 | controller | Wednesday 18 March 2026 10:55:34 +0000 (0:00:01.662) 0:00:10.758 ******* 2026-03-18 10:55:34.754900 | controller | =============================================================================== 2026-03-18 10:55:34.754908 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.73s 2026-03-18 10:55:34.754915 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.66s 2026-03-18 10:55:34.754923 | controller | Gathering Facts --------------------------------------------------------- 1.12s 2026-03-18 10:55:34.754930 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.06s 2026-03-18 10:55:34.754938 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.54s 2026-03-18 10:55:34.754946 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.54s 2026-03-18 10:55:34.754953 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.51s 2026-03-18 10:55:34.754961 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.46s 2026-03-18 10:55:34.754970 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.46s 2026-03-18 10:55:34.754977 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.46s 2026-03-18 10:55:34.755003 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.40s 2026-03-18 10:55:34.755011 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.32s 2026-03-18 10:55:34.755019 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.31s 2026-03-18 10:55:34.755026 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.06s 2026-03-18 10:55:34.755034 | controller | Install plugin ---------------------------------------------------------- 0.06s 2026-03-18 10:55:34.755042 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-18 10:55:34.889748 | controller | INFO [helm > idempotence] Executed: Successful 2026-03-18 10:55:34.899735 | controller | INFO [helm > side_effect] Executing 2026-03-18 10:55:34.900117 | controller | WARNING [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-18 10:55:34.905650 | controller | INFO [helm > verify] Executing 2026-03-18 10:55:35.745290 | controller | 2026-03-18 10:55:35.745673 | controller | PLAY [Verify] ****************************************************************** 2026-03-18 10:55:35.745929 | controller | 2026-03-18 10:55:35.746198 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-18 10:55:35.746501 | controller | Wednesday 18 March 2026 10:55:35 +0000 (0:00:00.010) 0:00:00.010 ******* 2026-03-18 10:55:37.859029 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-18 10:55:37.865903 | controller | ok: [controller] 2026-03-18 10:55:37.866152 | controller | 2026-03-18 10:55:37.866444 | controller | TASK [Get the current Helm version] ******************************************** 2026-03-18 10:55:37.866698 | controller | Wednesday 18 March 2026 10:55:37 +0000 (0:00:02.120) 0:00:02.130 ******* 2026-03-18 10:55:38.333277 | controller | changed: [controller] 2026-03-18 10:55:38.333572 | controller | 2026-03-18 10:55:38.333915 | controller | TASK [Assert Helm version] ***************************************************** 2026-03-18 10:55:38.334287 | controller | Wednesday 18 March 2026 10:55:38 +0000 (0:00:00.467) 0:00:02.598 ******* 2026-03-18 10:55:38.365065 | controller | ok: [controller] => { 2026-03-18 10:55:38.365362 | controller | "changed": false, 2026-03-18 10:55:38.365625 | controller | "msg": "All assertions passed" 2026-03-18 10:55:38.365892 | controller | } 2026-03-18 10:55:38.366127 | controller | 2026-03-18 10:55:38.366375 | controller | PLAY RECAP ********************************************************************* 2026-03-18 10:55:38.366708 | controller | controller : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-18 10:55:38.366991 | controller | 2026-03-18 10:55:38.367223 | controller | 2026-03-18 10:55:38.367473 | controller | TASKS RECAP ******************************************************************** 2026-03-18 10:55:38.367726 | controller | Wednesday 18 March 2026 10:55:38 +0000 (0:00:00.032) 0:00:02.630 ******* 2026-03-18 10:55:38.367966 | controller | =============================================================================== 2026-03-18 10:55:38.368383 | controller | Gathering Facts --------------------------------------------------------- 2.12s 2026-03-18 10:55:38.368630 | controller | Get the current Helm version -------------------------------------------- 0.47s 2026-03-18 10:55:38.368875 | controller | Assert Helm version ----------------------------------------------------- 0.03s 2026-03-18 10:55:38.482925 | controller | INFO [helm > verify] Executed: Successful 2026-03-18 10:55:38.494400 | controller | INFO [helm > cleanup] Executing 2026-03-18 10:55:38.494995 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-18 10:55:38.500543 | controller | INFO [helm > destroy] Executing 2026-03-18 10:55:38.500669 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-18 10:55:38.500763 | controller | INFO [helm > destroy] Executed: Successful 2026-03-18 10:55:38.501083 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-03-18 10:55:38.754035 | controller | ok: Runtime: 0:00:49.977487 2026-03-18 10:55:38.767835 | 2026-03-18 10:55:38.767913 | PLAY RECAP 2026-03-18 10:55:38.767960 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-18 10:55:38.768241 | 2026-03-18 10:55:38.961794 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-18 10:55:38.963209 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-18 10:55:39.600296 | 2026-03-18 10:55:39.600436 | PLAY [all] 2026-03-18 10:55:39.611234 | 2026-03-18 10:55:39.611315 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-03-18 10:55:40.006771 | controller | changed 2026-03-18 10:55:40.013347 | 2026-03-18 10:55:40.013482 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-03-18 10:55:40.409572 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-18 10:55:40.409837 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-18 10:55:40.414621 | controller | environment: line 1: kubectl: command not found 2026-03-18 10:55:40.416960 | controller | environment: line 1: kubectl: command not found 2026-03-18 10:55:40.417301 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-18 10:55:40.418191 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-18 10:55:40.420399 | controller | environment: line 1: kubectl: command not found 2026-03-18 10:55:40.421582 | controller | environment: line 1: kubectl: command not found 2026-03-18 10:55:40.422398 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-18 10:55:40.423911 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-18 10:55:40.427154 | controller | environment: line 1: kubectl: command not found 2026-03-18 10:55:40.428327 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-18 10:55:40.541152 | controller | ok: Runtime: 0:00:00.033094 2026-03-18 10:55:40.545570 | 2026-03-18 10:55:40.545643 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-03-18 10:55:40.782075 | controller | changed 2026-03-18 10:55:40.788534 | 2026-03-18 10:55:40.788649 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-03-18 10:55:41.050290 | controller | environment: line 5: kubectl: command not found 2026-03-18 10:55:41.051631 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-18 10:55:41.051817 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-18 10:55:41.052035 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-18 10:55:41.323130 | controller | ok: Runtime: 0:00:00.013250 2026-03-18 10:55:41.331186 | 2026-03-18 10:55:41.331255 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-03-18 10:55:42.012645 | controller | changed: 2026-03-18 10:55:42.012854 | controller | created directory /var/lib/zuul/builds/2d49abfff569446c953c330c1de386a0/work/logs/controller 2026-03-18 10:55:42.012901 | controller | cd+++++++++ objects/ 2026-03-18 10:55:42.012936 | controller | cd+++++++++ objects/cluster/ 2026-03-18 10:55:42.013032 | controller | cd+++++++++ objects/namespaced/ 2026-03-18 10:55:42.025085 | 2026-03-18 10:55:42.025316 | TASK [gather-pod-logs : creating directory for pod logs] 2026-03-18 10:55:42.260851 | controller | changed 2026-03-18 10:55:42.463333 | 2026-03-18 10:55:42.463485 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-03-18 10:55:42.697342 | controller | changed 2026-03-18 10:55:42.701905 | 2026-03-18 10:55:42.702004 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-03-18 10:55:42.956841 | controller | environment: line 3: kubectl: command not found 2026-03-18 10:55:43.231342 | controller | ok: Runtime: 0:00:00.013435 2026-03-18 10:55:43.238906 | 2026-03-18 10:55:43.239033 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-03-18 10:55:44.161903 | controller | changed: 2026-03-18 10:55:44.162119 | controller | cd+++++++++ pod-logs/ 2026-03-18 10:55:44.162162 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-03-18 10:55:44.173796 | 2026-03-18 10:55:44.173964 | LOOP [helm-release-status : creating directory for helm release status] 2026-03-18 10:55:44.413670 | controller | changed: "values" 2026-03-18 10:55:44.635780 | controller | changed: "releases" 2026-03-18 10:55:44.646774 | 2026-03-18 10:55:44.646947 | TASK [helm-release-status : Gather get release status for helm charts] 2026-03-18 10:55:44.907459 | controller | /bin/bash: line 3: kubectl: command not found 2026-03-18 10:55:45.179124 | controller | ok: Runtime: 0:00:00.010227 2026-03-18 10:55:45.186031 | 2026-03-18 10:55:45.186182 | TASK [helm-release-status : Downloads logs to executor] 2026-03-18 10:55:45.706106 | controller | changed: 2026-03-18 10:55:45.706340 | controller | cd+++++++++ helm/ 2026-03-18 10:55:45.706378 | controller | cd+++++++++ helm/releases/ 2026-03-18 10:55:45.706410 | controller | cd+++++++++ helm/values/ 2026-03-18 10:55:45.712698 | 2026-03-18 10:55:45.712758 | PLAY RECAP 2026-03-18 10:55:45.712805 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-18 10:55:45.712826 | 2026-03-18 10:55:45.855613 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-18 10:55:45.857115 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-18 10:55:46.461038 | 2026-03-18 10:55:46.461250 | PLAY [all] 2026-03-18 10:55:46.473050 | 2026-03-18 10:55:46.473191 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-18 10:55:46.519435 | controller | skipping: Conditional result was False 2026-03-18 10:55:46.527453 | 2026-03-18 10:55:46.527641 | TASK [fetch-output : Set log path for single node] 2026-03-18 10:55:46.569797 | controller | ok 2026-03-18 10:55:46.575153 | 2026-03-18 10:55:46.575262 | LOOP [fetch-output : Ensure local output dirs] 2026-03-18 10:55:46.957481 | controller -> localhost | ok: "/var/lib/zuul/builds/2d49abfff569446c953c330c1de386a0/work/logs" 2026-03-18 10:55:47.182235 | controller -> localhost | changed: "/var/lib/zuul/builds/2d49abfff569446c953c330c1de386a0/work/artifacts" 2026-03-18 10:55:47.411486 | controller -> localhost | changed: "/var/lib/zuul/builds/2d49abfff569446c953c330c1de386a0/work/docs" 2026-03-18 10:55:47.424061 | 2026-03-18 10:55:47.424220 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-18 10:55:48.097560 | controller | changed: .d..t...... ./ 2026-03-18 10:55:48.097973 | controller | changed: All items complete 2026-03-18 10:55:48.098023 | 2026-03-18 10:55:48.607392 | controller | changed: .d..t...... ./ 2026-03-18 10:55:49.160403 | controller | changed: .d..t...... ./ 2026-03-18 10:55:49.183984 | 2026-03-18 10:55:49.184166 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-18 10:55:49.611177 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.008876 2026-03-18 10:55:49.867789 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.012403 2026-03-18 10:55:49.882470 | 2026-03-18 10:55:49.882629 | PLAY [all] 2026-03-18 10:55:49.889618 | 2026-03-18 10:55:49.889708 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-18 10:55:50.366648 | controller | changed 2026-03-18 10:55:50.373056 | 2026-03-18 10:55:50.373128 | PLAY RECAP 2026-03-18 10:55:50.373189 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-18 10:55:50.373225 | 2026-03-18 10:55:50.502788 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-18 10:55:50.504177 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-18 10:55:51.080579 | 2026-03-18 10:55:51.080727 | PLAY [localhost] 2026-03-18 10:55:51.091050 | 2026-03-18 10:55:51.091128 | TASK [Generate Zuul manifest] 2026-03-18 10:55:51.111538 | localhost | ok 2026-03-18 10:55:51.129229 | 2026-03-18 10:55:51.129316 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-18 10:55:51.475649 | localhost | changed 2026-03-18 10:55:51.488640 | 2026-03-18 10:55:51.488737 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-18 10:55:51.530810 | localhost | ok 2026-03-18 10:55:51.539421 | 2026-03-18 10:55:51.539495 | TASK [Upload logs] 2026-03-18 10:55:51.563096 | localhost | ok 2026-03-18 10:55:51.623986 | 2026-03-18 10:55:51.624152 | TASK [Set zuul-log-path fact] 2026-03-18 10:55:51.646827 | localhost | ok 2026-03-18 10:55:51.662272 | 2026-03-18 10:55:51.662344 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-18 10:55:51.695251 | localhost | ok 2026-03-18 10:55:51.704541 | 2026-03-18 10:55:51.704632 | TASK [upload-logs : Create log directories] 2026-03-18 10:55:52.122864 | localhost | changed 2026-03-18 10:55:52.129061 | 2026-03-18 10:55:52.129134 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-18 10:55:52.555071 | localhost -> localhost | ok: Runtime: 0:00:00.006404 2026-03-18 10:55:52.561854 | 2026-03-18 10:55:52.561946 | TASK [upload-logs : Upload logs to log server] 2026-03-18 10:55:53.036364 | localhost | Output suppressed because no_log was given 2026-03-18 10:55:53.041288 | 2026-03-18 10:55:53.041379 | LOOP [upload-logs : Compress console log and json output] 2026-03-18 10:55:53.094098 | localhost | skipping: Conditional result was False 2026-03-18 10:55:53.100880 | localhost | skipping: Conditional result was False 2026-03-18 10:55:53.118251 | 2026-03-18 10:55:53.118464 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-18 10:55:53.164229 | localhost | skipping: Conditional result was False 2026-03-18 10:55:53.164715 | 2026-03-18 10:55:53.167780 | localhost | skipping: Conditional result was False 2026-03-18 10:55:53.184798 | 2026-03-18 10:55:53.185027 | LOOP [upload-logs : Upload console log and json output]