2026-03-31 00:35:36.823988 | Job console starting 2026-03-31 00:35:37.084064 | Updating git repos 2026-03-31 00:35:37.217590 | Cloning repos into workspace 2026-03-31 00:35:39.017048 | Restoring repo states 2026-03-31 00:35:39.030344 | Merging changes 2026-03-31 00:35:40.483222 | Checking out repos 2026-03-31 00:35:41.323757 | Preparing playbooks 2026-03-31 00:35:56.197084 | Running Ansible setup 2026-03-31 00:36:01.089811 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-31 00:36:01.704066 | 2026-03-31 00:36:01.704196 | PLAY [localhost] 2026-03-31 00:36:01.715144 | 2026-03-31 00:36:01.715214 | TASK [Gathering Facts] 2026-03-31 00:36:02.663453 | localhost | ok 2026-03-31 00:36:02.676388 | 2026-03-31 00:36:02.676524 | TASK [Setup log path fact] 2026-03-31 00:36:02.706452 | localhost | ok 2026-03-31 00:36:02.722729 | 2026-03-31 00:36:02.722875 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-31 00:36:02.753526 | localhost | ok 2026-03-31 00:36:02.763271 | 2026-03-31 00:36:02.763447 | TASK [emit-job-header : Print job information] 2026-03-31 00:36:02.817622 | # Job Information 2026-03-31 00:36:02.817814 | Ansible Version: 2.16.16 2026-03-31 00:36:02.817851 | Job: ansible-collection-kubernetes-molecule-helm 2026-03-31 00:36:02.817876 | Pipeline: check 2026-03-31 00:36:02.817897 | Executor: 0a8996d2b663 2026-03-31 00:36:02.817919 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/250 2026-03-31 00:36:02.818020 | Event ID: 63b23d80-2c99-11f1-91bb-e9154a7a48cc 2026-03-31 00:36:02.841072 | 2026-03-31 00:36:02.841752 | LOOP [emit-job-header : Print node information] 2026-03-31 00:36:03.034600 | localhost | ok: 2026-03-31 00:36:03.034810 | localhost | # Node Information 2026-03-31 00:36:03.034840 | localhost | Inventory Hostname: controller 2026-03-31 00:36:03.034863 | localhost | Hostname: np0000161809 2026-03-31 00:36:03.034884 | localhost | Username: zuul 2026-03-31 00:36:03.034907 | localhost | Distro: Debian 13.4 2026-03-31 00:36:03.034927 | localhost | Provider: yul1 2026-03-31 00:36:03.034948 | localhost | Region: ca-ymq-1 2026-03-31 00:36:03.034966 | localhost | Label: debian-trixie 2026-03-31 00:36:03.034987 | localhost | Product Name: OpenStack Nova 2026-03-31 00:36:03.035006 | localhost | Interface IP: 199.204.45.30 2026-03-31 00:36:03.046737 | 2026-03-31 00:36:03.046890 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-31 00:36:03.459128 | localhost -> localhost | changed 2026-03-31 00:36:03.464600 | 2026-03-31 00:36:03.464700 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-31 00:36:04.378619 | localhost -> localhost | changed 2026-03-31 00:36:04.388614 | 2026-03-31 00:36:04.388693 | PLAY [all] 2026-03-31 00:36:04.396684 | 2026-03-31 00:36:04.396750 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-31 00:36:04.623422 | controller -> localhost | ok 2026-03-31 00:36:04.630223 | 2026-03-31 00:36:04.630296 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-31 00:36:04.661172 | controller | ok 2026-03-31 00:36:04.678780 | controller | included: /var/lib/zuul/builds/c1bb0dfa20d248ea8bc54cc5333e06c5/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-31 00:36:04.685143 | 2026-03-31 00:36:04.685206 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-31 00:36:05.814829 | controller -> localhost | Generating public/private rsa key pair. 2026-03-31 00:36:05.815039 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/c1bb0dfa20d248ea8bc54cc5333e06c5/work/c1bb0dfa20d248ea8bc54cc5333e06c5_id_rsa 2026-03-31 00:36:05.815071 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/c1bb0dfa20d248ea8bc54cc5333e06c5/work/c1bb0dfa20d248ea8bc54cc5333e06c5_id_rsa.pub 2026-03-31 00:36:05.815094 | controller -> localhost | The key fingerprint is: 2026-03-31 00:36:05.815116 | controller -> localhost | SHA256:CKv2jvDz5VLQPfZ8od1gotEUU6mIk78oSNV0MK06MaE zuul-build-sshkey 2026-03-31 00:36:05.815155 | controller -> localhost | The key's randomart image is: 2026-03-31 00:36:05.815176 | controller -> localhost | +---[RSA 3072]----+ 2026-03-31 00:36:05.815204 | controller -> localhost | | oo oo.. | 2026-03-31 00:36:05.815228 | controller -> localhost | | . ..o ... | 2026-03-31 00:36:05.815248 | controller -> localhost | | ..= * + . | 2026-03-31 00:36:05.815269 | controller -> localhost | | E =oB.* + + | 2026-03-31 00:36:05.815293 | controller -> localhost | | ..=.+S* = + | 2026-03-31 00:36:05.815316 | controller -> localhost | | ..o . o + o . | 2026-03-31 00:36:05.815336 | controller -> localhost | |..o. o.. . . | 2026-03-31 00:36:05.815356 | controller -> localhost | | +oooo. . | 2026-03-31 00:36:05.815379 | controller -> localhost | | o++o. | 2026-03-31 00:36:05.815400 | controller -> localhost | +----[SHA256]-----+ 2026-03-31 00:36:05.815463 | controller -> localhost | ok: Runtime: 0:00:00.671135 2026-03-31 00:36:05.819831 | 2026-03-31 00:36:05.819897 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-31 00:36:05.852369 | controller | ok 2026-03-31 00:36:05.862258 | controller | included: /var/lib/zuul/builds/c1bb0dfa20d248ea8bc54cc5333e06c5/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-31 00:36:05.870459 | 2026-03-31 00:36:05.870562 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-31 00:36:05.894998 | controller | skipping: Conditional result was False 2026-03-31 00:36:05.900281 | 2026-03-31 00:36:05.900400 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-31 00:36:06.452527 | controller | changed 2026-03-31 00:36:06.457825 | 2026-03-31 00:36:06.457886 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-31 00:36:06.671348 | controller | ok 2026-03-31 00:36:06.676573 | 2026-03-31 00:36:06.676640 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-31 00:36:07.200601 | controller | changed 2026-03-31 00:36:07.208259 | 2026-03-31 00:36:07.208357 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-31 00:36:07.743226 | controller | changed 2026-03-31 00:36:07.753244 | 2026-03-31 00:36:07.753384 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-31 00:36:07.778444 | controller | skipping: Conditional result was False 2026-03-31 00:36:07.785315 | 2026-03-31 00:36:07.785450 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-31 00:36:08.198804 | controller -> localhost | changed 2026-03-31 00:36:08.210531 | 2026-03-31 00:36:08.210668 | TASK [add-build-sshkey : Add back temp key] 2026-03-31 00:36:08.508349 | controller -> localhost | Identity added: /var/lib/zuul/builds/c1bb0dfa20d248ea8bc54cc5333e06c5/work/c1bb0dfa20d248ea8bc54cc5333e06c5_id_rsa (zuul-build-sshkey) 2026-03-31 00:36:08.508565 | controller -> localhost | ok: Runtime: 0:00:00.015124 2026-03-31 00:36:08.513203 | 2026-03-31 00:36:08.513265 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-31 00:36:08.897869 | controller | ok 2026-03-31 00:36:08.903432 | 2026-03-31 00:36:08.903521 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-31 00:36:08.927841 | controller | skipping: Conditional result was False 2026-03-31 00:36:08.940370 | 2026-03-31 00:36:08.940507 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-31 00:36:09.362739 | controller | ok 2026-03-31 00:36:09.369500 | 2026-03-31 00:36:09.369572 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-31 00:36:10.381781 | controller | Output suppressed because no_log was given 2026-03-31 00:36:10.452351 | 2026-03-31 00:36:10.452462 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-31 00:36:10.669289 | controller | ok: "logs" 2026-03-31 00:36:10.669596 | controller | ok: All items complete 2026-03-31 00:36:10.669639 | 2026-03-31 00:36:10.851001 | controller | ok: "artifacts" 2026-03-31 00:36:11.022254 | controller | ok: "docs" 2026-03-31 00:36:11.043303 | 2026-03-31 00:36:11.052177 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-31 00:36:11.263863 | controller | changed: "logs" 2026-03-31 00:36:11.441924 | controller | changed: "artifacts" 2026-03-31 00:36:11.626975 | controller | changed: "docs" 2026-03-31 00:36:11.637697 | 2026-03-31 00:36:11.637826 | PLAY RECAP 2026-03-31 00:36:11.637876 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-03-31 00:36:11.637906 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-31 00:36:11.637929 | 2026-03-31 00:36:11.819404 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-31 00:36:11.822259 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-31 00:36:12.444145 | 2026-03-31 00:36:12.444324 | PLAY [all] 2026-03-31 00:36:12.456475 | 2026-03-31 00:36:12.456576 | TASK [setup-uv : Extract archive] 2026-03-31 00:36:15.867214 | controller | changed 2026-03-31 00:36:16.019903 | 2026-03-31 00:36:16.020047 | TASK [setup-uv : Print version] 2026-03-31 00:36:16.425347 | controller | uv 0.8.13 2026-03-31 00:36:16.557315 | controller | ok: Runtime: 0:00:00.015151 2026-03-31 00:36:16.571724 | 2026-03-31 00:36:16.571790 | PLAY RECAP 2026-03-31 00:36:16.571835 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-31 00:36:16.571859 | 2026-03-31 00:36:16.730269 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-31 00:36:16.731758 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-31 00:36:17.379570 | 2026-03-31 00:36:17.379713 | PLAY [all] 2026-03-31 00:36:17.390262 | 2026-03-31 00:36:17.390376 | TASK [Update apt cache] 2026-03-31 00:36:21.959226 | controller | ok 2026-03-31 00:36:21.964316 | 2026-03-31 00:36:21.964395 | TASK [Disable firewalld] 2026-03-31 00:36:21.989037 | controller | skipping: Conditional result was False 2026-03-31 00:36:21.993553 | 2026-03-31 00:36:21.993625 | TASK [Install "jq" for log collection] 2026-03-31 00:36:23.960608 | controller | changed 2026-03-31 00:36:23.962332 | 2026-03-31 00:36:23.962376 | PLAY RECAP 2026-03-31 00:36:23.962420 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-31 00:36:23.962442 | 2026-03-31 00:36:24.101100 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-31 00:36:24.102517 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-31 00:36:24.709632 | 2026-03-31 00:36:24.709780 | PLAY [all] 2026-03-31 00:36:24.720113 | 2026-03-31 00:36:24.720209 | TASK [Copy inventory file for Zuul] 2026-03-31 00:36:25.695450 | controller | changed 2026-03-31 00:36:25.702676 | 2026-03-31 00:36:25.702753 | TASK [Switch "ansible_host" to private IP] 2026-03-31 00:36:26.018798 | controller | changed: 1 replacements made 2026-03-31 00:36:26.024651 | 2026-03-31 00:36:26.024732 | TASK [Run Molecule scenario] 2026-03-31 00:36:26.489614 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-03-31 00:36:26.489719 | controller | Creating virtual environment at: .venv 2026-03-31 00:36:26.541682 | controller | Downloading ansible-core (2.3MiB) 2026-03-31 00:36:26.542400 | controller | Downloading cryptography (4.3MiB) 2026-03-31 00:36:26.547284 | controller | Downloading pygments (1.2MiB) 2026-03-31 00:36:26.705938 | controller | Downloading cryptography 2026-03-31 00:36:26.752976 | controller | Downloading pygments 2026-03-31 00:36:26.935168 | controller | Downloading ansible-core 2026-03-31 00:36:26.982237 | controller | Installed 36 packages in 46ms 2026-03-31 00:36:27.633933 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-03-31 00:36:27.634002 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-03-31 00:36:28.503850 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-03-31 00:36:28.503909 | controller | INFO default scenario not found, disabling shared state. 2026-03-31 00:36:28.503929 | controller | INFO [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-03-31 00:36:28.504013 | controller | INFO [helm > prerun] Performing prerun with role_name_check=0... 2026-03-31 00:36:45.205618 | controller | INFO [helm > dependency] Executing 2026-03-31 00:36:45.205831 | controller | WARNING [helm > dependency] Missing roles requirements file: requirements.yml 2026-03-31 00:36:45.206092 | controller | WARNING [helm > dependency] Missing collections requirements file: collections.yml 2026-03-31 00:36:45.206244 | controller | WARNING [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-03-31 00:36:45.213921 | controller | INFO [helm > cleanup] Executing 2026-03-31 00:36:45.214285 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-31 00:36:45.219571 | controller | INFO [helm > destroy] Executing 2026-03-31 00:36:45.219694 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-31 00:36:45.219749 | controller | INFO [helm > destroy] Executed: Successful 2026-03-31 00:36:45.224963 | controller | INFO [helm > syntax] Executing 2026-03-31 00:36:46.115690 | controller | 2026-03-31 00:36:46.115724 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml 2026-03-31 00:36:46.178225 | controller | INFO [helm > syntax] Executed: Successful 2026-03-31 00:36:46.190428 | controller | INFO [helm > create] Executing 2026-03-31 00:36:46.191960 | controller | WARNING [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-31 00:36:46.197264 | controller | INFO [helm > prepare] Executing 2026-03-31 00:36:47.041046 | controller | 2026-03-31 00:36:47.041129 | controller | PLAY [Prepare] ***************************************************************** 2026-03-31 00:36:47.041139 | controller | 2026-03-31 00:36:47.041145 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-31 00:36:47.041154 | controller | Tuesday 31 March 2026 00:36:47 +0000 (0:00:00.030) 0:00:00.030 ********* 2026-03-31 00:36:48.323805 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-31 00:36:48.327674 | controller | ok: [controller] 2026-03-31 00:36:48.327708 | controller | 2026-03-31 00:36:48.327812 | controller | TASK [Install Debian packages] ************************************************* 2026-03-31 00:36:48.327903 | controller | Tuesday 31 March 2026 00:36:48 +0000 (0:00:01.290) 0:00:01.320 ********* 2026-03-31 00:36:49.705392 | controller | ok: [controller] 2026-03-31 00:36:49.705484 | controller | 2026-03-31 00:36:49.705494 | controller | PLAY RECAP ********************************************************************* 2026-03-31 00:36:49.705506 | controller | controller : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-31 00:36:49.705514 | controller | 2026-03-31 00:36:49.705525 | controller | 2026-03-31 00:36:49.705775 | controller | TASKS RECAP ******************************************************************** 2026-03-31 00:36:49.705927 | controller | Tuesday 31 March 2026 00:36:49 +0000 (0:00:01.376) 0:00:02.697 ********* 2026-03-31 00:36:49.706101 | controller | =============================================================================== 2026-03-31 00:36:49.706287 | controller | Install Debian packages ------------------------------------------------- 1.38s 2026-03-31 00:36:49.706474 | controller | Gathering Facts --------------------------------------------------------- 1.29s 2026-03-31 00:36:49.798278 | controller | INFO [helm > prepare] Executed: Successful 2026-03-31 00:36:49.808112 | controller | INFO [helm > converge] Executing 2026-03-31 00:36:50.618712 | controller | 2026-03-31 00:36:50.618859 | controller | PLAY [Converge] **************************************************************** 2026-03-31 00:36:50.619032 | controller | 2026-03-31 00:36:50.619231 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-31 00:36:50.619419 | controller | Tuesday 31 March 2026 00:36:50 +0000 (0:00:00.012) 0:00:00.012 ********* 2026-03-31 00:36:51.678466 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-31 00:36:51.684290 | controller | ok: [controller] 2026-03-31 00:36:51.684485 | controller | 2026-03-31 00:36:51.684690 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-31 00:36:51.684893 | controller | Tuesday 31 March 2026 00:36:51 +0000 (0:00:01.065) 0:00:01.078 ********* 2026-03-31 00:36:52.178981 | controller | ok: [controller] 2026-03-31 00:36:52.179114 | controller | 2026-03-31 00:36:52.179319 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-31 00:36:52.179520 | controller | Tuesday 31 March 2026 00:36:52 +0000 (0:00:00.494) 0:00:01.572 ********* 2026-03-31 00:36:53.142379 | controller | ok: [controller] 2026-03-31 00:36:53.143024 | controller | 2026-03-31 00:36:53.143049 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-31 00:36:53.143060 | controller | Tuesday 31 March 2026 00:36:53 +0000 (0:00:00.963) 0:00:02.535 ********* 2026-03-31 00:36:53.553547 | controller | changed: [controller] 2026-03-31 00:36:53.553672 | controller | 2026-03-31 00:36:53.553931 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-31 00:36:53.554132 | controller | Tuesday 31 March 2026 00:36:53 +0000 (0:00:00.411) 0:00:02.946 ********* 2026-03-31 00:36:53.598018 | controller | ok: [controller] => { 2026-03-31 00:36:53.598168 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-31 00:36:53.598401 | controller | } 2026-03-31 00:36:53.598521 | controller | 2026-03-31 00:36:53.598766 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-31 00:36:53.598897 | controller | Tuesday 31 March 2026 00:36:53 +0000 (0:00:00.044) 0:00:02.991 ********* 2026-03-31 00:36:54.675704 | controller | [WARNING]: Module remote_tmp /root/.ansible/tmp did not exist and was created with a mode of 0700, this may cause issues when running as another user. To avoid this, create the remote_tmp dir with the correct permissions manually 2026-03-31 00:36:54.681953 | controller | changed: [controller] 2026-03-31 00:36:54.682141 | controller | 2026-03-31 00:36:54.682342 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-31 00:36:54.682534 | controller | Tuesday 31 March 2026 00:36:54 +0000 (0:00:01.084) 0:00:04.075 ********* 2026-03-31 00:36:56.672048 | controller | changed: [controller] 2026-03-31 00:36:56.672100 | controller | 2026-03-31 00:36:56.672179 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-31 00:36:56.672265 | controller | Tuesday 31 March 2026 00:36:56 +0000 (0:00:01.988) 0:00:06.064 ********* 2026-03-31 00:36:57.155802 | controller | ok: [controller] 2026-03-31 00:36:57.155851 | controller | 2026-03-31 00:36:57.155915 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-31 00:36:57.156007 | controller | Tuesday 31 March 2026 00:36:57 +0000 (0:00:00.483) 0:00:06.548 ********* 2026-03-31 00:36:57.560106 | controller | changed: [controller] 2026-03-31 00:36:57.560188 | controller | 2026-03-31 00:36:57.560311 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-31 00:36:57.560432 | controller | Tuesday 31 March 2026 00:36:57 +0000 (0:00:00.401) 0:00:06.950 ********* 2026-03-31 00:36:57.998504 | controller | ok: [controller] 2026-03-31 00:36:57.998674 | controller | 2026-03-31 00:36:57.998947 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-31 00:36:57.999681 | controller | Tuesday 31 March 2026 00:36:57 +0000 (0:00:00.441) 0:00:07.391 ********* 2026-03-31 00:36:58.289211 | controller | changed: [controller] 2026-03-31 00:36:58.289249 | controller | 2026-03-31 00:36:58.289259 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-31 00:36:58.289267 | controller | Tuesday 31 March 2026 00:36:58 +0000 (0:00:00.290) 0:00:07.681 ********* 2026-03-31 00:36:58.575943 | controller | ok: [controller] 2026-03-31 00:36:58.576213 | controller | 2026-03-31 00:36:58.576467 | controller | TASK [Install plugin] ********************************************************** 2026-03-31 00:36:58.576715 | controller | Tuesday 31 March 2026 00:36:58 +0000 (0:00:00.287) 0:00:07.969 ********* 2026-03-31 00:36:58.625566 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-31 00:36:58.625813 | controller | 2026-03-31 00:36:58.626082 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-31 00:36:58.626327 | controller | Tuesday 31 March 2026 00:36:58 +0000 (0:00:00.050) 0:00:08.019 ********* 2026-03-31 00:36:58.671036 | controller | ok: [controller] => { 2026-03-31 00:36:58.671343 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-31 00:36:58.671597 | controller | } 2026-03-31 00:36:58.671886 | controller | 2026-03-31 00:36:58.672151 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-31 00:36:58.672417 | controller | Tuesday 31 March 2026 00:36:58 +0000 (0:00:00.044) 0:00:08.064 ********* 2026-03-31 00:36:59.763920 | controller | changed: [controller] 2026-03-31 00:36:59.764229 | controller | 2026-03-31 00:36:59.764507 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-31 00:36:59.764766 | controller | Tuesday 31 March 2026 00:36:59 +0000 (0:00:01.092) 0:00:09.156 ********* 2026-03-31 00:37:02.814950 | controller | changed: [controller] 2026-03-31 00:37:02.815290 | controller | 2026-03-31 00:37:02.815661 | controller | PLAY RECAP ********************************************************************* 2026-03-31 00:37:02.815971 | controller | controller : ok=16 changed=7 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-31 00:37:02.816273 | controller | 2026-03-31 00:37:02.816601 | controller | 2026-03-31 00:37:02.816885 | controller | TASKS RECAP ******************************************************************** 2026-03-31 00:37:02.817238 | controller | Tuesday 31 March 2026 00:37:02 +0000 (0:00:03.051) 0:00:12.209 ********* 2026-03-31 00:37:02.817623 | controller | =============================================================================== 2026-03-31 00:37:02.817915 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 3.05s 2026-03-31 00:37:02.818200 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.99s 2026-03-31 00:37:02.818514 | controller | vexxhost.containers.download_artifact : Download item ------------------- 1.09s 2026-03-31 00:37:02.818723 | controller | vexxhost.containers.download_artifact : Download item ------------------- 1.08s 2026-03-31 00:37:02.818886 | controller | Gathering Facts --------------------------------------------------------- 1.07s 2026-03-31 00:37:02.819047 | controller | vexxhost.containers.package : Update state for tar ---------------------- 0.96s 2026-03-31 00:37:02.819242 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.49s 2026-03-31 00:37:02.819419 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.48s 2026-03-31 00:37:02.819607 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.44s 2026-03-31 00:37:02.819836 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.41s 2026-03-31 00:37:02.820037 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.40s 2026-03-31 00:37:02.820223 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.29s 2026-03-31 00:37:02.820395 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.29s 2026-03-31 00:37:02.820553 | controller | Install plugin ---------------------------------------------------------- 0.05s 2026-03-31 00:37:02.820768 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s 2026-03-31 00:37:02.820931 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s 2026-03-31 00:37:02.906549 | controller | INFO [helm > converge] Executed: Successful 2026-03-31 00:37:02.916801 | controller | INFO [helm > idempotence] Executing 2026-03-31 00:37:03.742951 | controller | 2026-03-31 00:37:03.743341 | controller | PLAY [Converge] **************************************************************** 2026-03-31 00:37:03.743671 | controller | 2026-03-31 00:37:03.743951 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-31 00:37:03.744233 | controller | Tuesday 31 March 2026 00:37:03 +0000 (0:00:00.012) 0:00:00.012 ********* 2026-03-31 00:37:04.792091 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-31 00:37:04.797229 | controller | ok: [controller] 2026-03-31 00:37:04.797332 | controller | 2026-03-31 00:37:04.797454 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-31 00:37:04.797590 | controller | Tuesday 31 March 2026 00:37:04 +0000 (0:00:01.053) 0:00:01.066 ********* 2026-03-31 00:37:05.207579 | controller | ok: [controller] 2026-03-31 00:37:05.207679 | controller | 2026-03-31 00:37:05.207800 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-31 00:37:05.207911 | controller | Tuesday 31 March 2026 00:37:05 +0000 (0:00:00.410) 0:00:01.476 ********* 2026-03-31 00:37:06.149322 | controller | ok: [controller] 2026-03-31 00:37:06.149356 | controller | 2026-03-31 00:37:06.149362 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-31 00:37:06.149367 | controller | Tuesday 31 March 2026 00:37:06 +0000 (0:00:00.940) 0:00:02.417 ********* 2026-03-31 00:37:06.556249 | controller | ok: [controller] 2026-03-31 00:37:06.556441 | controller | 2026-03-31 00:37:06.556660 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-31 00:37:06.556855 | controller | Tuesday 31 March 2026 00:37:06 +0000 (0:00:00.408) 0:00:02.825 ********* 2026-03-31 00:37:06.601515 | controller | ok: [controller] => { 2026-03-31 00:37:06.601676 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-31 00:37:06.601909 | controller | } 2026-03-31 00:37:06.602039 | controller | 2026-03-31 00:37:06.602286 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-31 00:37:06.602419 | controller | Tuesday 31 March 2026 00:37:06 +0000 (0:00:00.044) 0:00:02.870 ********* 2026-03-31 00:37:07.119483 | controller | ok: [controller] 2026-03-31 00:37:07.119608 | controller | 2026-03-31 00:37:07.119878 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-31 00:37:07.120074 | controller | Tuesday 31 March 2026 00:37:07 +0000 (0:00:00.518) 0:00:03.388 ********* 2026-03-31 00:37:09.807782 | controller | ok: [controller] 2026-03-31 00:37:09.807936 | controller | 2026-03-31 00:37:09.808143 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-31 00:37:09.808340 | controller | Tuesday 31 March 2026 00:37:09 +0000 (0:00:02.688) 0:00:06.076 ********* 2026-03-31 00:37:10.316896 | controller | ok: [controller] 2026-03-31 00:37:10.317107 | controller | 2026-03-31 00:37:10.317383 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-31 00:37:10.317627 | controller | Tuesday 31 March 2026 00:37:10 +0000 (0:00:00.509) 0:00:06.585 ********* 2026-03-31 00:37:10.710157 | controller | ok: [controller] 2026-03-31 00:37:10.710310 | controller | 2026-03-31 00:37:10.710640 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-31 00:37:10.710912 | controller | Tuesday 31 March 2026 00:37:10 +0000 (0:00:00.393) 0:00:06.979 ********* 2026-03-31 00:37:11.146475 | controller | ok: [controller] 2026-03-31 00:37:11.146501 | controller | 2026-03-31 00:37:11.146507 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-31 00:37:11.146513 | controller | Tuesday 31 March 2026 00:37:11 +0000 (0:00:00.434) 0:00:07.413 ********* 2026-03-31 00:37:11.432733 | controller | ok: [controller] 2026-03-31 00:37:11.432924 | controller | 2026-03-31 00:37:11.433162 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-31 00:37:11.433363 | controller | Tuesday 31 March 2026 00:37:11 +0000 (0:00:00.287) 0:00:07.701 ********* 2026-03-31 00:37:11.724095 | controller | ok: [controller] 2026-03-31 00:37:11.724185 | controller | 2026-03-31 00:37:11.724321 | controller | TASK [Install plugin] ********************************************************** 2026-03-31 00:37:11.724463 | controller | Tuesday 31 March 2026 00:37:11 +0000 (0:00:00.288) 0:00:07.990 ********* 2026-03-31 00:37:11.770734 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-31 00:37:11.770928 | controller | 2026-03-31 00:37:11.771123 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-31 00:37:11.771313 | controller | Tuesday 31 March 2026 00:37:11 +0000 (0:00:00.048) 0:00:08.039 ********* 2026-03-31 00:37:11.817679 | controller | ok: [controller] => { 2026-03-31 00:37:11.817889 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-31 00:37:11.818052 | controller | } 2026-03-31 00:37:11.818218 | controller | 2026-03-31 00:37:11.818412 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-31 00:37:11.818600 | controller | Tuesday 31 March 2026 00:37:11 +0000 (0:00:00.046) 0:00:08.086 ********* 2026-03-31 00:37:12.241905 | controller | ok: [controller] 2026-03-31 00:37:12.241948 | controller | 2026-03-31 00:37:12.241958 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-31 00:37:12.241966 | controller | Tuesday 31 March 2026 00:37:12 +0000 (0:00:00.423) 0:00:08.509 ********* 2026-03-31 00:37:13.815046 | controller | ok: [controller] 2026-03-31 00:37:13.815319 | controller | 2026-03-31 00:37:13.815567 | controller | PLAY RECAP ********************************************************************* 2026-03-31 00:37:13.815866 | controller | controller : ok=16 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-31 00:37:13.816094 | controller | 2026-03-31 00:37:13.816314 | controller | 2026-03-31 00:37:13.816552 | controller | TASKS RECAP ******************************************************************** 2026-03-31 00:37:13.816799 | controller | Tuesday 31 March 2026 00:37:13 +0000 (0:00:01.574) 0:00:10.084 ********* 2026-03-31 00:37:13.817030 | controller | =============================================================================== 2026-03-31 00:37:13.817274 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.69s 2026-03-31 00:37:13.817515 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.57s 2026-03-31 00:37:13.817753 | controller | Gathering Facts --------------------------------------------------------- 1.05s 2026-03-31 00:37:13.817994 | controller | vexxhost.containers.package : Update state for tar ---------------------- 0.94s 2026-03-31 00:37:13.818268 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.52s 2026-03-31 00:37:13.818515 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.51s 2026-03-31 00:37:13.818762 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.43s 2026-03-31 00:37:13.819005 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.42s 2026-03-31 00:37:13.819248 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.41s 2026-03-31 00:37:13.819491 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.41s 2026-03-31 00:37:13.819781 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.39s 2026-03-31 00:37:13.820040 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.29s 2026-03-31 00:37:13.820294 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.29s 2026-03-31 00:37:13.820534 | controller | Install plugin ---------------------------------------------------------- 0.05s 2026-03-31 00:37:13.820777 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-31 00:37:13.821020 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s 2026-03-31 00:37:13.901307 | controller | INFO [helm > idempotence] Executed: Successful 2026-03-31 00:37:13.912120 | controller | INFO [helm > side_effect] Executing 2026-03-31 00:37:13.912389 | controller | WARNING [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-31 00:37:13.917643 | controller | INFO [helm > verify] Executing 2026-03-31 00:37:14.728228 | controller | 2026-03-31 00:37:14.728441 | controller | PLAY [Verify] ****************************************************************** 2026-03-31 00:37:14.728582 | controller | 2026-03-31 00:37:14.728821 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-31 00:37:14.729038 | controller | Tuesday 31 March 2026 00:37:14 +0000 (0:00:00.009) 0:00:00.009 ********* 2026-03-31 00:37:17.754406 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-31 00:37:17.760547 | controller | ok: [controller] 2026-03-31 00:37:17.760636 | controller | 2026-03-31 00:37:17.760733 | controller | TASK [Get the current Helm version] ******************************************** 2026-03-31 00:37:17.760828 | controller | Tuesday 31 March 2026 00:37:17 +0000 (0:00:03.032) 0:00:03.042 ********* 2026-03-31 00:37:18.192043 | controller | changed: [controller] 2026-03-31 00:37:18.192083 | controller | 2026-03-31 00:37:18.192181 | controller | TASK [Assert Helm version] ***************************************************** 2026-03-31 00:37:18.192271 | controller | Tuesday 31 March 2026 00:37:18 +0000 (0:00:00.429) 0:00:03.471 ********* 2026-03-31 00:37:18.221759 | controller | ok: [controller] => { 2026-03-31 00:37:18.221964 | controller | "changed": false, 2026-03-31 00:37:18.222160 | controller | "msg": "All assertions passed" 2026-03-31 00:37:18.222346 | controller | } 2026-03-31 00:37:18.222518 | controller | 2026-03-31 00:37:18.222704 | controller | PLAY RECAP ********************************************************************* 2026-03-31 00:37:18.222914 | controller | controller : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-31 00:37:18.223079 | controller | 2026-03-31 00:37:18.223803 | controller | 2026-03-31 00:37:18.223835 | controller | TASKS RECAP ******************************************************************** 2026-03-31 00:37:18.223849 | controller | Tuesday 31 March 2026 00:37:18 +0000 (0:00:00.032) 0:00:03.503 ********* 2026-03-31 00:37:18.223994 | controller | =============================================================================== 2026-03-31 00:37:18.224245 | controller | Gathering Facts --------------------------------------------------------- 3.03s 2026-03-31 00:37:18.224473 | controller | Get the current Helm version -------------------------------------------- 0.43s 2026-03-31 00:37:18.224705 | controller | Assert Helm version ----------------------------------------------------- 0.03s 2026-03-31 00:37:18.318829 | controller | INFO [helm > verify] Executed: Successful 2026-03-31 00:37:18.329571 | controller | INFO [helm > cleanup] Executing 2026-03-31 00:37:18.329841 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-31 00:37:18.335190 | controller | INFO [helm > destroy] Executing 2026-03-31 00:37:18.335260 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-31 00:37:18.335302 | controller | INFO [helm > destroy] Executed: Successful 2026-03-31 00:37:18.335562 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-03-31 00:37:18.589932 | controller | ok: Runtime: 0:00:51.981504 2026-03-31 00:37:18.594997 | 2026-03-31 00:37:18.595061 | PLAY RECAP 2026-03-31 00:37:18.595121 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-31 00:37:18.595153 | 2026-03-31 00:37:18.734525 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-31 00:37:18.737483 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-31 00:37:19.318522 | 2026-03-31 00:37:19.318723 | PLAY [all] 2026-03-31 00:37:19.329985 | 2026-03-31 00:37:19.330064 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-03-31 00:37:19.726268 | controller | changed 2026-03-31 00:37:19.732020 | 2026-03-31 00:37:19.732125 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-03-31 00:37:20.127566 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-31 00:37:20.127703 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-31 00:37:20.134257 | controller | environment: line 1: kubectl: command not found 2026-03-31 00:37:20.135616 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-31 00:37:20.137111 | controller | environment: line 1: kubectl: command not found 2026-03-31 00:37:20.138975 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-31 00:37:20.140697 | controller | environment: line 1: kubectl: command not found 2026-03-31 00:37:20.142484 | controller | environment: line 1: kubectl: command not found 2026-03-31 00:37:20.142591 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-31 00:37:20.143450 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-31 00:37:20.146322 | controller | environment: line 1: kubectl: command not found 2026-03-31 00:37:20.147659 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-31 00:37:20.262720 | controller | ok: Runtime: 0:00:00.032816 2026-03-31 00:37:20.269323 | 2026-03-31 00:37:20.269418 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-03-31 00:37:20.495040 | controller | changed 2026-03-31 00:37:20.501171 | 2026-03-31 00:37:20.501262 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-03-31 00:37:20.733151 | controller | environment: line 5: kubectl: command not found 2026-03-31 00:37:20.734226 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-31 00:37:20.734566 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-31 00:37:20.735503 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-31 00:37:21.031372 | controller | ok: Runtime: 0:00:00.012186 2026-03-31 00:37:21.038746 | 2026-03-31 00:37:21.038869 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-03-31 00:37:21.750402 | controller | changed: 2026-03-31 00:37:21.750601 | controller | created directory /var/lib/zuul/builds/c1bb0dfa20d248ea8bc54cc5333e06c5/work/logs/controller 2026-03-31 00:37:21.750644 | controller | cd+++++++++ objects/ 2026-03-31 00:37:21.750677 | controller | cd+++++++++ objects/cluster/ 2026-03-31 00:37:21.750708 | controller | cd+++++++++ objects/namespaced/ 2026-03-31 00:37:21.762087 | 2026-03-31 00:37:21.762223 | TASK [gather-pod-logs : creating directory for pod logs] 2026-03-31 00:37:21.996549 | controller | changed 2026-03-31 00:37:22.002315 | 2026-03-31 00:37:22.002417 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-03-31 00:37:22.227680 | controller | changed 2026-03-31 00:37:22.233317 | 2026-03-31 00:37:22.233417 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-03-31 00:37:22.468965 | controller | environment: line 3: kubectl: command not found 2026-03-31 00:37:22.764299 | controller | ok: Runtime: 0:00:00.012271 2026-03-31 00:37:22.771360 | 2026-03-31 00:37:22.771425 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-03-31 00:37:23.310323 | controller | changed: 2026-03-31 00:37:23.310502 | controller | cd+++++++++ pod-logs/ 2026-03-31 00:37:23.310543 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-03-31 00:37:23.320573 | 2026-03-31 00:37:23.320757 | LOOP [helm-release-status : creating directory for helm release status] 2026-03-31 00:37:23.558985 | controller | changed: "values" 2026-03-31 00:37:23.754025 | controller | changed: "releases" 2026-03-31 00:37:23.766690 | 2026-03-31 00:37:23.766883 | TASK [helm-release-status : Gather get release status for helm charts] 2026-03-31 00:37:24.001298 | controller | /bin/bash: line 3: kubectl: command not found 2026-03-31 00:37:24.298699 | controller | ok: Runtime: 0:00:00.008170 2026-03-31 00:37:24.304235 | 2026-03-31 00:37:24.304322 | TASK [helm-release-status : Downloads logs to executor] 2026-03-31 00:37:24.823176 | controller | changed: 2026-03-31 00:37:24.823368 | controller | cd+++++++++ helm/ 2026-03-31 00:37:24.823407 | controller | cd+++++++++ helm/releases/ 2026-03-31 00:37:24.823439 | controller | cd+++++++++ helm/values/ 2026-03-31 00:37:24.829599 | 2026-03-31 00:37:24.829668 | PLAY RECAP 2026-03-31 00:37:24.829727 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-31 00:37:24.829757 | 2026-03-31 00:37:24.942533 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-31 00:37:24.945428 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-31 00:37:25.519372 | 2026-03-31 00:37:25.519543 | PLAY [all] 2026-03-31 00:37:25.534332 | 2026-03-31 00:37:25.534520 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-31 00:37:25.579962 | controller | skipping: Conditional result was False 2026-03-31 00:37:25.587948 | 2026-03-31 00:37:25.588141 | TASK [fetch-output : Set log path for single node] 2026-03-31 00:37:25.628870 | controller | ok 2026-03-31 00:37:25.634551 | 2026-03-31 00:37:25.634656 | LOOP [fetch-output : Ensure local output dirs] 2026-03-31 00:37:26.027222 | controller -> localhost | ok: "/var/lib/zuul/builds/c1bb0dfa20d248ea8bc54cc5333e06c5/work/logs" 2026-03-31 00:37:26.264748 | controller -> localhost | changed: "/var/lib/zuul/builds/c1bb0dfa20d248ea8bc54cc5333e06c5/work/artifacts" 2026-03-31 00:37:26.480390 | controller -> localhost | changed: "/var/lib/zuul/builds/c1bb0dfa20d248ea8bc54cc5333e06c5/work/docs" 2026-03-31 00:37:26.500853 | 2026-03-31 00:37:26.501064 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-31 00:37:27.149561 | controller | changed: .d..t...... ./ 2026-03-31 00:37:27.149935 | controller | changed: All items complete 2026-03-31 00:37:27.150002 | 2026-03-31 00:37:27.627539 | controller | changed: .d..t...... ./ 2026-03-31 00:37:28.108769 | controller | changed: .d..t...... ./ 2026-03-31 00:37:28.120677 | 2026-03-31 00:37:28.120829 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-31 00:37:28.564339 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.008220 2026-03-31 00:37:28.790937 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.009087 2026-03-31 00:37:28.810857 | 2026-03-31 00:37:28.811001 | PLAY [all] 2026-03-31 00:37:28.817510 | 2026-03-31 00:37:28.817591 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-31 00:37:29.261329 | controller | changed 2026-03-31 00:37:29.266114 | 2026-03-31 00:37:29.266184 | PLAY RECAP 2026-03-31 00:37:29.266244 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-31 00:37:29.266274 | 2026-03-31 00:37:29.377205 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-31 00:37:29.380194 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-31 00:37:29.965702 | 2026-03-31 00:37:29.965898 | PLAY [localhost] 2026-03-31 00:37:29.978770 | 2026-03-31 00:37:29.978908 | TASK [Generate Zuul manifest] 2026-03-31 00:37:29.998161 | localhost | ok 2026-03-31 00:37:30.016966 | 2026-03-31 00:37:30.017051 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-31 00:37:30.341596 | localhost | changed 2026-03-31 00:37:30.352811 | 2026-03-31 00:37:30.352906 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-31 00:37:30.384438 | localhost | ok 2026-03-31 00:37:30.394043 | 2026-03-31 00:37:30.394135 | TASK [Upload logs] 2026-03-31 00:37:30.413706 | localhost | ok 2026-03-31 00:37:30.474863 | 2026-03-31 00:37:30.476203 | TASK [Set zuul-log-path fact] 2026-03-31 00:37:30.498953 | localhost | ok 2026-03-31 00:37:30.513122 | 2026-03-31 00:37:30.513193 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-31 00:37:30.544931 | localhost | ok 2026-03-31 00:37:30.553779 | 2026-03-31 00:37:30.553866 | TASK [upload-logs : Create log directories] 2026-03-31 00:37:30.988945 | localhost | changed 2026-03-31 00:37:30.994930 | 2026-03-31 00:37:30.995007 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-31 00:37:31.391439 | localhost -> localhost | ok: Runtime: 0:00:00.005718 2026-03-31 00:37:31.399220 | 2026-03-31 00:37:31.399314 | TASK [upload-logs : Upload logs to log server] 2026-03-31 00:37:31.877213 | localhost | Output suppressed because no_log was given 2026-03-31 00:37:31.883313 | 2026-03-31 00:37:31.883430 | LOOP [upload-logs : Compress console log and json output] 2026-03-31 00:37:31.931892 | localhost | skipping: Conditional result was False 2026-03-31 00:37:31.940364 | localhost | skipping: Conditional result was False 2026-03-31 00:37:31.954333 | 2026-03-31 00:37:31.954530 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-31 00:37:32.003755 | localhost | skipping: Conditional result was False 2026-03-31 00:37:32.004259 | 2026-03-31 00:37:32.008009 | localhost | skipping: Conditional result was False 2026-03-31 00:37:32.021832 | 2026-03-31 00:37:32.022087 | LOOP [upload-logs : Upload console log and json output]