2026-03-25 08:53:37.797744 | Job console starting 2026-03-25 08:53:37.806521 | Updating git repos 2026-03-25 08:53:37.849638 | Cloning repos into workspace 2026-03-25 08:53:37.916626 | Restoring repo states 2026-03-25 08:53:37.931424 | Merging changes 2026-03-25 08:53:38.347758 | Checking out repos 2026-03-25 08:53:38.450290 | Preparing playbooks 2026-03-25 08:53:40.082132 | Running Ansible setup 2026-03-25 08:53:44.124856 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-25 08:53:44.722090 | 2026-03-25 08:53:44.722242 | PLAY [localhost] 2026-03-25 08:53:44.729878 | 2026-03-25 08:53:44.729954 | TASK [Gathering Facts] 2026-03-25 08:53:45.588929 | localhost | ok 2026-03-25 08:53:45.598690 | 2026-03-25 08:53:45.598904 | TASK [Setup log path fact] 2026-03-25 08:53:45.618707 | localhost | ok 2026-03-25 08:53:45.650238 | 2026-03-25 08:53:45.650437 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-25 08:53:45.687071 | localhost | ok 2026-03-25 08:53:45.695433 | 2026-03-25 08:53:45.695518 | TASK [emit-job-header : Print job information] 2026-03-25 08:53:45.736165 | # Job Information 2026-03-25 08:53:45.736334 | Ansible Version: 2.16.16 2026-03-25 08:53:45.736375 | Job: ansible-collection-kubernetes-molecule-helm 2026-03-25 08:53:45.736404 | Pipeline: check 2026-03-25 08:53:45.736429 | Executor: 0a8996d2b663 2026-03-25 08:53:45.736454 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/243 2026-03-25 08:53:45.736481 | Event ID: fb3c88c0-2827-11f1-9dbc-0dc8c89972c1 2026-03-25 08:53:45.740097 | 2026-03-25 08:53:45.740194 | LOOP [emit-job-header : Print node information] 2026-03-25 08:53:45.829580 | localhost | ok: 2026-03-25 08:53:45.829806 | localhost | # Node Information 2026-03-25 08:53:45.829849 | localhost | Inventory Hostname: controller 2026-03-25 08:53:45.829881 | localhost | Hostname: np0000160486 2026-03-25 08:53:45.829911 | localhost | Username: zuul 2026-03-25 08:53:45.829945 | localhost | Distro: Debian 13.4 2026-03-25 08:53:45.829976 | localhost | Provider: yul1 2026-03-25 08:53:45.830004 | localhost | Region: ca-ymq-1 2026-03-25 08:53:45.830032 | localhost | Label: debian-trixie 2026-03-25 08:53:45.830060 | localhost | Product Name: OpenStack Nova 2026-03-25 08:53:45.830088 | localhost | Interface IP: 199.204.45.6 2026-03-25 08:53:45.848829 | 2026-03-25 08:53:45.849055 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-25 08:53:46.602665 | localhost -> localhost | changed 2026-03-25 08:53:46.611732 | 2026-03-25 08:53:46.611826 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-25 08:53:47.512146 | localhost -> localhost | changed 2026-03-25 08:53:47.527805 | 2026-03-25 08:53:47.527914 | PLAY [all] 2026-03-25 08:53:47.535632 | 2026-03-25 08:53:47.535700 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-25 08:53:47.800689 | controller -> localhost | ok 2026-03-25 08:53:47.806771 | 2026-03-25 08:53:47.806851 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-25 08:53:47.839004 | controller | ok 2026-03-25 08:53:47.854305 | controller | included: /var/lib/zuul/builds/df477c264dee4def817c80dd8911dced/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-25 08:53:47.859666 | 2026-03-25 08:53:47.859729 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-25 08:53:48.701679 | controller -> localhost | Generating public/private rsa key pair. 2026-03-25 08:53:48.701863 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/df477c264dee4def817c80dd8911dced/work/df477c264dee4def817c80dd8911dced_id_rsa 2026-03-25 08:53:48.701894 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/df477c264dee4def817c80dd8911dced/work/df477c264dee4def817c80dd8911dced_id_rsa.pub 2026-03-25 08:53:48.701917 | controller -> localhost | The key fingerprint is: 2026-03-25 08:53:48.701938 | controller -> localhost | SHA256:WSDo3vv3D34qQ8kyGBMCGeZJcd+Q/Zx4sQ8Q1AoAbXU zuul-build-sshkey 2026-03-25 08:53:48.701977 | controller -> localhost | The key's randomart image is: 2026-03-25 08:53:48.701998 | controller -> localhost | +---[RSA 3072]----+ 2026-03-25 08:53:48.702025 | controller -> localhost | | BBo+++Eo | 2026-03-25 08:53:48.702047 | controller -> localhost | | +.o=.+=o.o | 2026-03-25 08:53:48.702067 | controller -> localhost | | oo ..o.*.+ | 2026-03-25 08:53:48.702088 | controller -> localhost | | . o ooB | 2026-03-25 08:53:48.702108 | controller -> localhost | | . . +So + | 2026-03-25 08:53:48.702128 | controller -> localhost | | . o o + . | 2026-03-25 08:53:48.702147 | controller -> localhost | | . + . | 2026-03-25 08:53:48.702167 | controller -> localhost | | . +. .. | 2026-03-25 08:53:48.702190 | controller -> localhost | | ... +++. | 2026-03-25 08:53:48.702210 | controller -> localhost | +----[SHA256]-----+ 2026-03-25 08:53:48.702257 | controller -> localhost | ok: Runtime: 0:00:00.367004 2026-03-25 08:53:48.706425 | 2026-03-25 08:53:48.706492 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-25 08:53:48.736343 | controller | ok 2026-03-25 08:53:48.745580 | controller | included: /var/lib/zuul/builds/df477c264dee4def817c80dd8911dced/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-25 08:53:48.753053 | 2026-03-25 08:53:48.753150 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-25 08:53:48.776873 | controller | skipping: Conditional result was False 2026-03-25 08:53:48.819429 | 2026-03-25 08:53:48.819576 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-25 08:53:49.411786 | controller | changed 2026-03-25 08:53:49.416231 | 2026-03-25 08:53:49.416312 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-25 08:53:49.639602 | controller | ok 2026-03-25 08:53:49.771467 | 2026-03-25 08:53:49.771583 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-25 08:53:50.296236 | controller | changed 2026-03-25 08:53:50.300597 | 2026-03-25 08:53:50.300696 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-25 08:53:50.826229 | controller | changed 2026-03-25 08:53:50.831752 | 2026-03-25 08:53:50.831856 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-25 08:53:50.856018 | controller | skipping: Conditional result was False 2026-03-25 08:53:50.864721 | 2026-03-25 08:53:50.864850 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-25 08:53:51.319174 | controller -> localhost | changed 2026-03-25 08:53:51.332336 | 2026-03-25 08:53:51.332482 | TASK [add-build-sshkey : Add back temp key] 2026-03-25 08:53:51.654846 | controller -> localhost | Identity added: /var/lib/zuul/builds/df477c264dee4def817c80dd8911dced/work/df477c264dee4def817c80dd8911dced_id_rsa (zuul-build-sshkey) 2026-03-25 08:53:51.655081 | controller -> localhost | ok: Runtime: 0:00:00.014220 2026-03-25 08:53:51.661318 | 2026-03-25 08:53:51.661460 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-25 08:53:52.009097 | controller | ok 2026-03-25 08:53:52.014334 | 2026-03-25 08:53:52.014402 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-25 08:53:52.038784 | controller | skipping: Conditional result was False 2026-03-25 08:53:52.052453 | 2026-03-25 08:53:52.052611 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-25 08:53:52.429063 | controller | ok 2026-03-25 08:53:52.666171 | 2026-03-25 08:53:52.666279 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-25 08:53:53.805961 | controller | Output suppressed because no_log was given 2026-03-25 08:53:53.812999 | 2026-03-25 08:53:53.813074 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-25 08:53:54.037320 | controller | ok: "logs" 2026-03-25 08:53:54.037947 | controller | ok: All items complete 2026-03-25 08:53:54.037978 | 2026-03-25 08:53:54.242279 | controller | ok: "artifacts" 2026-03-25 08:53:54.433151 | controller | ok: "docs" 2026-03-25 08:53:54.446212 | 2026-03-25 08:53:54.446380 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-25 08:53:54.670835 | controller | changed: "logs" 2026-03-25 08:53:54.857762 | controller | changed: "artifacts" 2026-03-25 08:53:55.069872 | controller | changed: "docs" 2026-03-25 08:53:55.091993 | 2026-03-25 08:53:55.092151 | PLAY RECAP 2026-03-25 08:53:55.092222 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-03-25 08:53:55.092270 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-25 08:53:55.092303 | 2026-03-25 08:53:55.243085 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-25 08:53:55.245257 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-25 08:53:55.853923 | 2026-03-25 08:53:55.854049 | PLAY [all] 2026-03-25 08:53:55.864684 | 2026-03-25 08:53:55.864852 | TASK [setup-uv : Extract archive] 2026-03-25 08:53:58.267934 | controller | changed 2026-03-25 08:53:58.276693 | 2026-03-25 08:53:58.276779 | TASK [setup-uv : Print version] 2026-03-25 08:53:58.703875 | controller | uv 0.8.13 2026-03-25 08:53:58.906732 | controller | ok: Runtime: 0:00:00.015108 2026-03-25 08:53:58.914668 | 2026-03-25 08:53:58.914727 | PLAY RECAP 2026-03-25 08:53:58.914774 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-25 08:53:58.914799 | 2026-03-25 08:53:59.054934 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-25 08:53:59.058100 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-25 08:53:59.603285 | 2026-03-25 08:53:59.603610 | PLAY [all] 2026-03-25 08:53:59.613350 | 2026-03-25 08:53:59.613423 | TASK [Update apt cache] 2026-03-25 08:54:04.205851 | controller | ok 2026-03-25 08:54:04.249060 | 2026-03-25 08:54:04.249222 | TASK [Disable firewalld] 2026-03-25 08:54:04.274399 | controller | skipping: Conditional result was False 2026-03-25 08:54:04.282792 | 2026-03-25 08:54:04.282925 | TASK [Install "jq" for log collection] 2026-03-25 08:54:06.534195 | controller | changed 2026-03-25 08:54:06.536365 | 2026-03-25 08:54:06.536436 | PLAY RECAP 2026-03-25 08:54:06.536499 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-25 08:54:06.536531 | 2026-03-25 08:54:06.701750 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-25 08:54:06.707310 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-25 08:54:07.304317 | 2026-03-25 08:54:07.304495 | PLAY [all] 2026-03-25 08:54:07.314488 | 2026-03-25 08:54:07.314687 | TASK [Copy inventory file for Zuul] 2026-03-25 08:54:08.300712 | controller | changed 2026-03-25 08:54:08.308507 | 2026-03-25 08:54:08.308615 | TASK [Switch "ansible_host" to private IP] 2026-03-25 08:54:08.625151 | controller | changed: 1 replacements made 2026-03-25 08:54:08.629902 | 2026-03-25 08:54:08.629973 | TASK [Run Molecule scenario] 2026-03-25 08:54:09.097040 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-03-25 08:54:09.097188 | controller | Creating virtual environment at: .venv 2026-03-25 08:54:09.353602 | controller | Downloading pygments (1.2MiB) 2026-03-25 08:54:09.356581 | controller | Downloading cryptography (4.3MiB) 2026-03-25 08:54:09.356846 | controller | Downloading ansible-core (2.3MiB) 2026-03-25 08:54:09.518568 | controller | Downloading cryptography 2026-03-25 08:54:09.574179 | controller | Downloading pygments 2026-03-25 08:54:09.739305 | controller | Downloading ansible-core 2026-03-25 08:54:09.794025 | controller | Installed 36 packages in 54ms 2026-03-25 08:54:10.491265 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-03-25 08:54:10.491353 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-03-25 08:54:11.399880 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-03-25 08:54:11.399947 | controller | INFO default scenario not found, disabling shared state. 2026-03-25 08:54:11.399959 | controller | INFO [helm > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-03-25 08:54:11.399979 | controller | INFO [helm > prerun] Performing prerun with role_name_check=0... 2026-03-25 08:54:26.693840 | controller | INFO [helm > dependency] Executing 2026-03-25 08:54:26.693908 | controller | WARNING [helm > dependency] Missing roles requirements file: requirements.yml 2026-03-25 08:54:26.693918 | controller | WARNING [helm > dependency] Missing collections requirements file: collections.yml 2026-03-25 08:54:26.693948 | controller | WARNING [helm > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-03-25 08:54:26.699172 | controller | INFO [helm > cleanup] Executing 2026-03-25 08:54:26.699496 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-25 08:54:26.704825 | controller | INFO [helm > destroy] Executing 2026-03-25 08:54:26.704849 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-25 08:54:26.704864 | controller | INFO [helm > destroy] Executed: Successful 2026-03-25 08:54:26.710163 | controller | INFO [helm > syntax] Executing 2026-03-25 08:54:27.622174 | controller | 2026-03-25 08:54:27.622360 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/helm/converge.yml 2026-03-25 08:54:27.680386 | controller | INFO [helm > syntax] Executed: Successful 2026-03-25 08:54:27.690748 | controller | INFO [helm > create] Executing 2026-03-25 08:54:27.692288 | controller | WARNING [helm > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-25 08:54:27.697659 | controller | INFO [helm > prepare] Executing 2026-03-25 08:54:28.534874 | controller | 2026-03-25 08:54:28.535046 | controller | PLAY [Prepare] ***************************************************************** 2026-03-25 08:54:28.535245 | controller | 2026-03-25 08:54:28.535465 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-25 08:54:28.535682 | controller | Wednesday 25 March 2026 08:54:28 +0000 (0:00:00.029) 0:00:00.029 ******* 2026-03-25 08:54:30.831875 | 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-25 08:54:30.836843 | controller | ok: [controller] 2026-03-25 08:54:30.837011 | controller | 2026-03-25 08:54:30.837204 | controller | TASK [Install Debian packages] ************************************************* 2026-03-25 08:54:30.837413 | controller | Wednesday 25 March 2026 08:54:30 +0000 (0:00:02.303) 0:00:02.332 ******* 2026-03-25 08:54:32.276263 | controller | ok: [controller] 2026-03-25 08:54:32.276397 | controller | 2026-03-25 08:54:32.276601 | controller | PLAY RECAP ********************************************************************* 2026-03-25 08:54:32.276819 | controller | controller : ok=2 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-25 08:54:32.276993 | controller | 2026-03-25 08:54:32.277166 | controller | 2026-03-25 08:54:32.277349 | controller | TASKS RECAP ******************************************************************** 2026-03-25 08:54:32.277547 | controller | Wednesday 25 March 2026 08:54:32 +0000 (0:00:01.439) 0:00:03.772 ******* 2026-03-25 08:54:32.277728 | controller | =============================================================================== 2026-03-25 08:54:32.277916 | controller | Gathering Facts --------------------------------------------------------- 2.30s 2026-03-25 08:54:32.278105 | controller | Install Debian packages ------------------------------------------------- 1.44s 2026-03-25 08:54:32.374383 | controller | INFO [helm > prepare] Executed: Successful 2026-03-25 08:54:32.385207 | controller | INFO [helm > converge] Executing 2026-03-25 08:54:33.228296 | controller | 2026-03-25 08:54:33.228418 | controller | PLAY [Converge] **************************************************************** 2026-03-25 08:54:33.228613 | controller | 2026-03-25 08:54:33.228856 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-25 08:54:33.229001 | controller | Wednesday 25 March 2026 08:54:33 +0000 (0:00:00.015) 0:00:00.015 ******* 2026-03-25 08:54:34.272095 | 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-25 08:54:34.279425 | controller | ok: [controller] 2026-03-25 08:54:34.279672 | controller | 2026-03-25 08:54:34.279931 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-25 08:54:34.280185 | controller | Wednesday 25 March 2026 08:54:34 +0000 (0:00:01.051) 0:00:01.066 ******* 2026-03-25 08:54:34.788732 | controller | ok: [controller] 2026-03-25 08:54:34.788795 | controller | 2026-03-25 08:54:34.789041 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-25 08:54:34.789311 | controller | Wednesday 25 March 2026 08:54:34 +0000 (0:00:00.509) 0:00:01.575 ******* 2026-03-25 08:54:35.843740 | controller | ok: [controller] 2026-03-25 08:54:35.843861 | controller | 2026-03-25 08:54:35.844078 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-25 08:54:35.844270 | controller | Wednesday 25 March 2026 08:54:35 +0000 (0:00:01.055) 0:00:02.630 ******* 2026-03-25 08:54:36.290437 | controller | changed: [controller] 2026-03-25 08:54:36.290513 | controller | 2026-03-25 08:54:36.290739 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-25 08:54:36.290973 | controller | Wednesday 25 March 2026 08:54:36 +0000 (0:00:00.446) 0:00:03.077 ******* 2026-03-25 08:54:36.329876 | controller | ok: [controller] => { 2026-03-25 08:54:36.330019 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-25 08:54:36.330204 | controller | } 2026-03-25 08:54:36.330377 | controller | 2026-03-25 08:54:36.330572 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-25 08:54:36.330763 | controller | Wednesday 25 March 2026 08:54:36 +0000 (0:00:00.039) 0:00:03.116 ******* 2026-03-25 08:54:37.593298 | 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-25 08:54:37.601922 | controller | changed: [controller] 2026-03-25 08:54:37.602099 | controller | 2026-03-25 08:54:37.602297 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-25 08:54:37.602487 | controller | Wednesday 25 March 2026 08:54:37 +0000 (0:00:01.272) 0:00:04.389 ******* 2026-03-25 08:54:39.643641 | controller | changed: [controller] 2026-03-25 08:54:39.643778 | controller | 2026-03-25 08:54:39.643994 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-25 08:54:39.644189 | controller | Wednesday 25 March 2026 08:54:39 +0000 (0:00:02.041) 0:00:06.430 ******* 2026-03-25 08:54:40.196066 | controller | ok: [controller] 2026-03-25 08:54:40.196202 | controller | 2026-03-25 08:54:40.196404 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-25 08:54:40.196596 | controller | Wednesday 25 March 2026 08:54:40 +0000 (0:00:00.552) 0:00:06.983 ******* 2026-03-25 08:54:40.607221 | controller | changed: [controller] 2026-03-25 08:54:40.607880 | controller | 2026-03-25 08:54:40.608128 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-25 08:54:40.608327 | controller | Wednesday 25 March 2026 08:54:40 +0000 (0:00:00.410) 0:00:07.393 ******* 2026-03-25 08:54:41.083514 | controller | ok: [controller] 2026-03-25 08:54:41.083588 | controller | 2026-03-25 08:54:41.083727 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-25 08:54:41.083853 | controller | Wednesday 25 March 2026 08:54:41 +0000 (0:00:00.468) 0:00:07.862 ******* 2026-03-25 08:54:41.382102 | controller | changed: [controller] 2026-03-25 08:54:41.382206 | controller | 2026-03-25 08:54:41.382436 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-25 08:54:41.382631 | controller | Wednesday 25 March 2026 08:54:41 +0000 (0:00:00.306) 0:00:08.168 ******* 2026-03-25 08:54:41.685805 | controller | ok: [controller] 2026-03-25 08:54:41.685985 | controller | 2026-03-25 08:54:41.686196 | controller | TASK [Install plugin] ********************************************************** 2026-03-25 08:54:41.686398 | controller | Wednesday 25 March 2026 08:54:41 +0000 (0:00:00.303) 0:00:08.472 ******* 2026-03-25 08:54:41.741676 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-25 08:54:41.741831 | controller | 2026-03-25 08:54:41.742020 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-25 08:54:41.742211 | controller | Wednesday 25 March 2026 08:54:41 +0000 (0:00:00.056) 0:00:08.528 ******* 2026-03-25 08:54:41.787582 | controller | ok: [controller] => { 2026-03-25 08:54:41.787767 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-25 08:54:41.787953 | controller | } 2026-03-25 08:54:41.788189 | controller | 2026-03-25 08:54:41.788390 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-25 08:54:41.788623 | controller | Wednesday 25 March 2026 08:54:41 +0000 (0:00:00.045) 0:00:08.574 ******* 2026-03-25 08:54:42.594180 | controller | changed: [controller] 2026-03-25 08:54:42.594386 | controller | 2026-03-25 08:54:42.594600 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-25 08:54:42.594914 | controller | Wednesday 25 March 2026 08:54:42 +0000 (0:00:00.805) 0:00:09.380 ******* 2026-03-25 08:54:44.727916 | controller | changed: [controller] 2026-03-25 08:54:44.727980 | controller | 2026-03-25 08:54:44.728091 | controller | PLAY RECAP ********************************************************************* 2026-03-25 08:54:44.728238 | controller | controller : ok=16 changed=7 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-25 08:54:44.728352 | controller | 2026-03-25 08:54:44.728469 | controller | 2026-03-25 08:54:44.728592 | controller | TASKS RECAP ******************************************************************** 2026-03-25 08:54:44.728710 | controller | Wednesday 25 March 2026 08:54:44 +0000 (0:00:02.134) 0:00:11.515 ******* 2026-03-25 08:54:44.728828 | controller | =============================================================================== 2026-03-25 08:54:44.728950 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.13s 2026-03-25 08:54:44.729075 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 2.04s 2026-03-25 08:54:44.729197 | controller | vexxhost.containers.download_artifact : Download item ------------------- 1.27s 2026-03-25 08:54:44.729319 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.06s 2026-03-25 08:54:44.729438 | controller | Gathering Facts --------------------------------------------------------- 1.05s 2026-03-25 08:54:44.729597 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.81s 2026-03-25 08:54:44.729730 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.55s 2026-03-25 08:54:44.729859 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.51s 2026-03-25 08:54:44.729976 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.47s 2026-03-25 08:54:44.730104 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.45s 2026-03-25 08:54:44.730299 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.41s 2026-03-25 08:54:44.730528 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.31s 2026-03-25 08:54:44.730735 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.30s 2026-03-25 08:54:44.731004 | controller | Install plugin ---------------------------------------------------------- 0.06s 2026-03-25 08:54:44.731216 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-25 08:54:44.731480 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.04s 2026-03-25 08:54:44.886975 | controller | INFO [helm > converge] Executed: Successful 2026-03-25 08:54:44.896337 | controller | INFO [helm > idempotence] Executing 2026-03-25 08:54:45.741866 | controller | 2026-03-25 08:54:45.742026 | controller | PLAY [Converge] **************************************************************** 2026-03-25 08:54:45.742236 | controller | 2026-03-25 08:54:45.742431 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-25 08:54:45.742628 | controller | Wednesday 25 March 2026 08:54:45 +0000 (0:00:00.013) 0:00:00.013 ******* 2026-03-25 08:54:46.807385 | 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-25 08:54:46.810935 | controller | ok: [controller] 2026-03-25 08:54:46.811020 | controller | 2026-03-25 08:54:46.811117 | controller | TASK [vexxhost.containers.forget_package : Forget package] ********************* 2026-03-25 08:54:46.811219 | controller | Wednesday 25 March 2026 08:54:46 +0000 (0:00:01.069) 0:00:01.082 ******* 2026-03-25 08:54:47.272971 | controller | ok: [controller] 2026-03-25 08:54:47.273044 | controller | 2026-03-25 08:54:47.273330 | controller | TASK [vexxhost.containers.package : Update state for tar] ********************** 2026-03-25 08:54:47.273534 | controller | Wednesday 25 March 2026 08:54:47 +0000 (0:00:00.461) 0:00:01.544 ******* 2026-03-25 08:54:48.423988 | controller | ok: [controller] 2026-03-25 08:54:48.424033 | controller | 2026-03-25 08:54:48.424043 | controller | TASK [vexxhost.containers.directory : Create directory (/var/lib/downloads)] *** 2026-03-25 08:54:48.424051 | controller | Wednesday 25 March 2026 08:54:48 +0000 (0:00:01.150) 0:00:02.694 ******* 2026-03-25 08:54:48.859326 | controller | ok: [controller] 2026-03-25 08:54:48.859514 | controller | 2026-03-25 08:54:48.859680 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-25 08:54:48.859881 | controller | Wednesday 25 March 2026 08:54:48 +0000 (0:00:00.433) 0:00:03.128 ******* 2026-03-25 08:54:48.903240 | controller | ok: [controller] => { 2026-03-25 08:54:48.903363 | controller | "msg": "https://get.helm.sh/helm-v3.11.2-linux-amd64.tar.gz" 2026-03-25 08:54:48.903486 | controller | } 2026-03-25 08:54:48.903603 | controller | 2026-03-25 08:54:48.903757 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-25 08:54:48.903920 | controller | Wednesday 25 March 2026 08:54:48 +0000 (0:00:00.046) 0:00:03.174 ******* 2026-03-25 08:54:49.431473 | controller | ok: [controller] 2026-03-25 08:54:49.431519 | controller | 2026-03-25 08:54:49.431655 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-25 08:54:49.431784 | controller | Wednesday 25 March 2026 08:54:49 +0000 (0:00:00.525) 0:00:03.700 ******* 2026-03-25 08:54:51.131604 | controller | ok: [controller] 2026-03-25 08:54:51.131675 | controller | 2026-03-25 08:54:51.131691 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm repository] *********************** 2026-03-25 08:54:51.131799 | controller | Wednesday 25 March 2026 08:54:51 +0000 (0:00:01.702) 0:00:05.403 ******* 2026-03-25 08:54:51.633821 | controller | ok: [controller] 2026-03-25 08:54:51.633906 | controller | 2026-03-25 08:54:51.634125 | controller | TASK [vexxhost.kubernetes.helm : Add bash autocomplete for helm] *************** 2026-03-25 08:54:51.634319 | controller | Wednesday 25 March 2026 08:54:51 +0000 (0:00:00.501) 0:00:05.904 ******* 2026-03-25 08:54:52.066443 | controller | ok: [controller] 2026-03-25 08:54:52.066528 | controller | 2026-03-25 08:54:52.066622 | controller | TASK [vexxhost.kubernetes.helm : Get Helm plugins dir] ************************* 2026-03-25 08:54:52.066757 | controller | Wednesday 25 March 2026 08:54:52 +0000 (0:00:00.433) 0:00:06.337 ******* 2026-03-25 08:54:52.514349 | controller | ok: [controller] 2026-03-25 08:54:52.514419 | controller | 2026-03-25 08:54:52.514548 | controller | TASK [vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist] *** 2026-03-25 08:54:52.514680 | controller | Wednesday 25 March 2026 08:54:52 +0000 (0:00:00.447) 0:00:06.785 ******* 2026-03-25 08:54:52.823461 | controller | ok: [controller] 2026-03-25 08:54:52.823544 | controller | 2026-03-25 08:54:52.823554 | controller | TASK [vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin] *** 2026-03-25 08:54:52.823656 | controller | Wednesday 25 March 2026 08:54:52 +0000 (0:00:00.305) 0:00:07.091 ******* 2026-03-25 08:54:53.119912 | controller | ok: [controller] 2026-03-25 08:54:53.119988 | controller | 2026-03-25 08:54:53.120072 | controller | TASK [Install plugin] ********************************************************** 2026-03-25 08:54:53.120194 | controller | Wednesday 25 March 2026 08:54:53 +0000 (0:00:00.299) 0:00:07.391 ******* 2026-03-25 08:54:53.171005 | controller | included: vexxhost.containers.download_artifact for controller 2026-03-25 08:54:53.171063 | controller | 2026-03-25 08:54:53.171123 | controller | TASK [vexxhost.containers.download_artifact : Starting download of file] ******* 2026-03-25 08:54:53.171226 | controller | Wednesday 25 March 2026 08:54:53 +0000 (0:00:00.051) 0:00:07.442 ******* 2026-03-25 08:54:53.226845 | controller | ok: [controller] => { 2026-03-25 08:54:53.226957 | controller | "msg": "https://github.com/databus23/helm-diff/releases/download/v3.8.1/helm-diff-linux-amd64.tgz" 2026-03-25 08:54:53.226967 | controller | } 2026-03-25 08:54:53.226980 | controller | 2026-03-25 08:54:53.227054 | controller | TASK [vexxhost.containers.download_artifact : Download item] ******************* 2026-03-25 08:54:53.227153 | controller | Wednesday 25 March 2026 08:54:53 +0000 (0:00:00.055) 0:00:07.498 ******* 2026-03-25 08:54:53.642729 | controller | ok: [controller] 2026-03-25 08:54:53.642780 | controller | 2026-03-25 08:54:53.642819 | controller | TASK [vexxhost.containers.download_artifact : Extract archive] ***************** 2026-03-25 08:54:53.642957 | controller | Wednesday 25 March 2026 08:54:53 +0000 (0:00:00.409) 0:00:07.907 ******* 2026-03-25 08:54:55.298964 | controller | ok: [controller] 2026-03-25 08:54:55.299009 | controller | 2026-03-25 08:54:55.299019 | controller | PLAY RECAP ********************************************************************* 2026-03-25 08:54:55.302913 | controller | controller : ok=16 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-25 08:54:55.302968 | controller | 2026-03-25 08:54:55.302978 | controller | 2026-03-25 08:54:55.302986 | controller | TASKS RECAP ******************************************************************** 2026-03-25 08:54:55.302995 | controller | Wednesday 25 March 2026 08:54:55 +0000 (0:00:01.663) 0:00:09.570 ******* 2026-03-25 08:54:55.303002 | controller | =============================================================================== 2026-03-25 08:54:55.303009 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.70s 2026-03-25 08:54:55.303017 | controller | vexxhost.containers.download_artifact : Extract archive ----------------- 1.66s 2026-03-25 08:54:55.303045 | controller | vexxhost.containers.package : Update state for tar ---------------------- 1.15s 2026-03-25 08:54:55.303052 | controller | Gathering Facts --------------------------------------------------------- 1.07s 2026-03-25 08:54:55.303059 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.53s 2026-03-25 08:54:55.303066 | controller | vexxhost.kubernetes.helm : Remove Helm repository ----------------------- 0.50s 2026-03-25 08:54:55.303073 | controller | vexxhost.containers.forget_package : Forget package --------------------- 0.46s 2026-03-25 08:54:55.303080 | controller | vexxhost.kubernetes.helm : Get Helm plugins dir ------------------------- 0.45s 2026-03-25 08:54:55.303089 | controller | vexxhost.containers.directory : Create directory (/var/lib/downloads) --- 0.43s 2026-03-25 08:54:55.303096 | controller | vexxhost.kubernetes.helm : Add bash autocomplete for helm --------------- 0.43s 2026-03-25 08:54:55.303117 | controller | vexxhost.containers.download_artifact : Download item ------------------- 0.41s 2026-03-25 08:54:55.303134 | controller | vexxhost.kubernetes.helm : Create Helm plugins directory if it does not exist --- 0.31s 2026-03-25 08:54:55.304035 | controller | vexxhost.kubernetes.helm : Remove Helm diff plugin installed by kubernetes.core.helm_plugin --- 0.30s 2026-03-25 08:54:55.304087 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.06s 2026-03-25 08:54:55.304095 | controller | Install plugin ---------------------------------------------------------- 0.05s 2026-03-25 08:54:55.304103 | controller | vexxhost.containers.download_artifact : Starting download of file ------- 0.05s 2026-03-25 08:54:55.443800 | controller | INFO [helm > idempotence] Executed: Successful 2026-03-25 08:54:55.454851 | controller | INFO [helm > side_effect] Executing 2026-03-25 08:54:55.455283 | controller | WARNING [helm > side_effect] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-25 08:54:55.485812 | controller | INFO [helm > verify] Executing 2026-03-25 08:54:56.295747 | controller | 2026-03-25 08:54:56.296177 | controller | PLAY [Verify] ****************************************************************** 2026-03-25 08:54:56.296509 | controller | 2026-03-25 08:54:56.296858 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-25 08:54:56.297230 | controller | Wednesday 25 March 2026 08:54:56 +0000 (0:00:00.009) 0:00:00.009 ******* 2026-03-25 08:54:57.379392 | 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-25 08:54:57.385236 | controller | ok: [controller] 2026-03-25 08:54:57.385352 | controller | 2026-03-25 08:54:57.385480 | controller | TASK [Get the current Helm version] ******************************************** 2026-03-25 08:54:57.385610 | controller | Wednesday 25 March 2026 08:54:57 +0000 (0:00:01.089) 0:00:01.099 ******* 2026-03-25 08:54:57.871252 | controller | changed: [controller] 2026-03-25 08:54:57.871335 | controller | 2026-03-25 08:54:57.871440 | controller | TASK [Assert Helm version] ***************************************************** 2026-03-25 08:54:57.871583 | controller | Wednesday 25 March 2026 08:54:57 +0000 (0:00:00.485) 0:00:01.584 ******* 2026-03-25 08:54:57.908121 | controller | ok: [controller] => { 2026-03-25 08:54:57.908353 | controller | "changed": false, 2026-03-25 08:54:57.908658 | controller | "msg": "All assertions passed" 2026-03-25 08:54:57.908892 | controller | } 2026-03-25 08:54:57.909123 | controller | 2026-03-25 08:54:57.909403 | controller | PLAY RECAP ********************************************************************* 2026-03-25 08:54:57.909697 | controller | controller : ok=3 changed=1 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-25 08:54:57.909930 | controller | 2026-03-25 08:54:57.910151 | controller | 2026-03-25 08:54:57.910397 | controller | TASKS RECAP ******************************************************************** 2026-03-25 08:54:57.910654 | controller | Wednesday 25 March 2026 08:54:57 +0000 (0:00:00.037) 0:00:01.622 ******* 2026-03-25 08:54:57.910942 | controller | =============================================================================== 2026-03-25 08:54:57.911301 | controller | Gathering Facts --------------------------------------------------------- 1.09s 2026-03-25 08:54:57.911449 | controller | Get the current Helm version -------------------------------------------- 0.49s 2026-03-25 08:54:57.911689 | controller | Assert Helm version ----------------------------------------------------- 0.04s 2026-03-25 08:54:58.030217 | controller | INFO [helm > verify] Executed: Successful 2026-03-25 08:54:58.036412 | controller | INFO [helm > cleanup] Executing 2026-03-25 08:54:58.036777 | controller | WARNING [helm > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-25 08:54:58.042080 | controller | INFO [helm > destroy] Executing 2026-03-25 08:54:58.042150 | controller | WARNING [helm > destroy] Skipping, '--destroy=never' requested. 2026-03-25 08:54:58.042203 | controller | INFO [helm > destroy] Executed: Successful 2026-03-25 08:54:58.042539 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-03-25 08:54:58.207593 | controller | ok: Runtime: 0:00:49.125551 2026-03-25 08:54:58.212855 | 2026-03-25 08:54:58.212921 | PLAY RECAP 2026-03-25 08:54:58.212997 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-25 08:54:58.213031 | 2026-03-25 08:54:58.334943 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-25 08:54:58.337776 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-25 08:54:58.925235 | 2026-03-25 08:54:58.925391 | PLAY [all] 2026-03-25 08:54:58.936819 | 2026-03-25 08:54:58.936931 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-03-25 08:54:59.335467 | controller | changed 2026-03-25 08:54:59.341252 | 2026-03-25 08:54:59.341356 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-03-25 08:54:59.732259 | controller | xargs: xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args valuewarning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-25 08:54:59.732368 | controller | 2026-03-25 08:54:59.740147 | controller | environment: line 1: kubectl: command not found 2026-03-25 08:54:59.742827 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-25 08:54:59.743240 | controller | environment: line 1: kubectl: command not found 2026-03-25 08:54:59.745195 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-25 08:54:59.747246 | controller | environment: line 1: kubectl: command not found 2026-03-25 08:54:59.749793 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-25 08:54:59.749948 | controller | environment: line 1: kubectl: command not found 2026-03-25 08:54:59.751892 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-25 08:54:59.755170 | controller | environment: line 1: kubectl: command not found 2026-03-25 08:54:59.756620 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-25 08:54:59.870121 | controller | ok: Runtime: 0:00:00.040273 2026-03-25 08:54:59.876348 | 2026-03-25 08:54:59.876436 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-03-25 08:55:00.110592 | controller | changed 2026-03-25 08:55:00.115717 | 2026-03-25 08:55:00.115795 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-03-25 08:55:00.358272 | controller | environment: line 5: kubectl: command not found 2026-03-25 08:55:00.359076 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-25 08:55:00.359877 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-25 08:55:00.360531 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-25 08:55:00.645373 | controller | ok: Runtime: 0:00:00.013656 2026-03-25 08:55:00.652859 | 2026-03-25 08:55:00.653000 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-03-25 08:55:01.384564 | controller | changed: 2026-03-25 08:55:01.384742 | controller | created directory /var/lib/zuul/builds/df477c264dee4def817c80dd8911dced/work/logs/controller 2026-03-25 08:55:01.384773 | controller | cd+++++++++ objects/ 2026-03-25 08:55:01.384796 | controller | cd+++++++++ objects/cluster/ 2026-03-25 08:55:01.384818 | controller | cd+++++++++ objects/namespaced/ 2026-03-25 08:55:01.393152 | 2026-03-25 08:55:01.393225 | TASK [gather-pod-logs : creating directory for pod logs] 2026-03-25 08:55:01.618359 | controller | changed 2026-03-25 08:55:01.624176 | 2026-03-25 08:55:01.624311 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-03-25 08:55:01.859060 | controller | changed 2026-03-25 08:55:01.864814 | 2026-03-25 08:55:01.864914 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-03-25 08:55:02.108251 | controller | environment: line 3: kubectl: command not found 2026-03-25 08:55:02.395821 | controller | ok: Runtime: 0:00:00.013831 2026-03-25 08:55:02.403995 | 2026-03-25 08:55:02.404082 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-03-25 08:55:02.932489 | controller | changed: 2026-03-25 08:55:02.932709 | controller | cd+++++++++ pod-logs/ 2026-03-25 08:55:02.932750 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-03-25 08:55:02.941465 | 2026-03-25 08:55:02.941528 | LOOP [helm-release-status : creating directory for helm release status] 2026-03-25 08:55:03.178414 | controller | changed: "values" 2026-03-25 08:55:03.398300 | controller | changed: "releases" 2026-03-25 08:55:03.416994 | 2026-03-25 08:55:03.417296 | TASK [helm-release-status : Gather get release status for helm charts] 2026-03-25 08:55:03.658006 | controller | /bin/bash: line 3: kubectl: command not found 2026-03-25 08:55:03.948676 | controller | ok: Runtime: 0:00:00.009337 2026-03-25 08:55:03.954677 | 2026-03-25 08:55:03.954766 | TASK [helm-release-status : Downloads logs to executor] 2026-03-25 08:55:04.495454 | controller | changed: 2026-03-25 08:55:04.495727 | controller | cd+++++++++ helm/ 2026-03-25 08:55:04.495791 | controller | cd+++++++++ helm/releases/ 2026-03-25 08:55:04.495847 | controller | cd+++++++++ helm/values/ 2026-03-25 08:55:04.502086 | 2026-03-25 08:55:04.502134 | PLAY RECAP 2026-03-25 08:55:04.502180 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-25 08:55:04.502203 | 2026-03-25 08:55:04.632853 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-25 08:55:04.635731 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-25 08:55:05.204890 | 2026-03-25 08:55:05.205048 | PLAY [all] 2026-03-25 08:55:05.216431 | 2026-03-25 08:55:05.216515 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-25 08:55:05.261892 | controller | skipping: Conditional result was False 2026-03-25 08:55:05.271800 | 2026-03-25 08:55:05.271882 | TASK [fetch-output : Set log path for single node] 2026-03-25 08:55:05.311738 | controller | ok 2026-03-25 08:55:05.317148 | 2026-03-25 08:55:05.317246 | LOOP [fetch-output : Ensure local output dirs] 2026-03-25 08:55:05.694172 | controller -> localhost | ok: "/var/lib/zuul/builds/df477c264dee4def817c80dd8911dced/work/logs" 2026-03-25 08:55:05.936537 | controller -> localhost | changed: "/var/lib/zuul/builds/df477c264dee4def817c80dd8911dced/work/artifacts" 2026-03-25 08:55:06.144673 | controller -> localhost | changed: "/var/lib/zuul/builds/df477c264dee4def817c80dd8911dced/work/docs" 2026-03-25 08:55:06.154241 | 2026-03-25 08:55:06.154447 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-25 08:55:06.831177 | controller | changed: .d..t...... ./ 2026-03-25 08:55:06.831434 | controller | changed: All items complete 2026-03-25 08:55:06.831481 | 2026-03-25 08:55:07.334190 | controller | changed: .d..t...... ./ 2026-03-25 08:55:07.814806 | controller | changed: .d..t...... ./ 2026-03-25 08:55:07.859585 | 2026-03-25 08:55:07.859733 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-25 08:55:08.266970 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.006728 2026-03-25 08:55:08.497901 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007157 2026-03-25 08:55:08.519099 | 2026-03-25 08:55:08.519241 | PLAY [all] 2026-03-25 08:55:08.524688 | 2026-03-25 08:55:08.524754 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-25 08:55:09.024924 | controller | changed 2026-03-25 08:55:09.031115 | 2026-03-25 08:55:09.031184 | PLAY RECAP 2026-03-25 08:55:09.031243 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-25 08:55:09.031276 | 2026-03-25 08:55:09.156598 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-25 08:55:09.158075 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-25 08:55:09.701052 | 2026-03-25 08:55:09.701179 | PLAY [localhost] 2026-03-25 08:55:09.710527 | 2026-03-25 08:55:09.710597 | TASK [Generate Zuul manifest] 2026-03-25 08:55:09.730893 | localhost | ok 2026-03-25 08:55:09.747787 | 2026-03-25 08:55:09.747866 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-25 08:55:10.053997 | localhost | changed 2026-03-25 08:55:10.065719 | 2026-03-25 08:55:10.065857 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-25 08:55:10.098074 | localhost | ok 2026-03-25 08:55:10.106624 | 2026-03-25 08:55:10.106712 | TASK [Upload logs] 2026-03-25 08:55:10.128237 | localhost | ok 2026-03-25 08:55:10.187108 | 2026-03-25 08:55:10.187290 | TASK [Set zuul-log-path fact] 2026-03-25 08:55:10.207333 | localhost | ok 2026-03-25 08:55:10.218519 | 2026-03-25 08:55:10.218587 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-25 08:55:10.250865 | localhost | ok 2026-03-25 08:55:10.261391 | 2026-03-25 08:55:10.261489 | TASK [upload-logs : Create log directories] 2026-03-25 08:55:10.667982 | localhost | changed 2026-03-25 08:55:10.674302 | 2026-03-25 08:55:10.674369 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-25 08:55:11.070682 | localhost -> localhost | ok: Runtime: 0:00:00.006287 2026-03-25 08:55:11.078455 | 2026-03-25 08:55:11.078544 | TASK [upload-logs : Upload logs to log server] 2026-03-25 08:55:11.546621 | localhost | Output suppressed because no_log was given 2026-03-25 08:55:11.551617 | 2026-03-25 08:55:11.551724 | LOOP [upload-logs : Compress console log and json output] 2026-03-25 08:55:11.599439 | localhost | skipping: Conditional result was False 2026-03-25 08:55:11.606793 | localhost | skipping: Conditional result was False 2026-03-25 08:55:11.619118 | 2026-03-25 08:55:11.619342 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-25 08:55:11.663625 | localhost | skipping: Conditional result was False 2026-03-25 08:55:11.664036 | 2026-03-25 08:55:11.667945 | localhost | skipping: Conditional result was False 2026-03-25 08:55:11.683815 | 2026-03-25 08:55:11.683997 | LOOP [upload-logs : Upload console log and json output]