2026-02-16 21:11:03.035127 | Job console starting 2026-02-16 21:11:03.046076 | Updating git repos 2026-02-16 21:11:03.086999 | Cloning repos into workspace 2026-02-16 21:11:03.168316 | Restoring repo states 2026-02-16 21:11:03.227410 | Merging changes 2026-02-16 21:11:03.960533 | Checking out repos 2026-02-16 21:11:04.506707 | Preparing playbooks 2026-02-16 21:11:06.118857 | Running Ansible setup 2026-02-16 21:11:09.690039 | PRE-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main] 2026-02-16 21:11:10.283874 | 2026-02-16 21:11:10.284008 | PLAY [localhost] 2026-02-16 21:11:10.291684 | 2026-02-16 21:11:10.291781 | TASK [Gathering Facts] 2026-02-16 21:11:11.178265 | localhost | ok 2026-02-16 21:11:11.194399 | 2026-02-16 21:11:11.194594 | TASK [Setup log path fact] 2026-02-16 21:11:11.226154 | localhost | ok 2026-02-16 21:11:11.250488 | 2026-02-16 21:11:11.250644 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-16 21:11:11.283910 | localhost | ok 2026-02-16 21:11:11.293796 | 2026-02-16 21:11:11.293893 | TASK [emit-job-header : Print job information] 2026-02-16 21:11:11.358974 | # Job Information 2026-02-16 21:11:11.359227 | Ansible Version: 2.16.15 2026-02-16 21:11:11.359280 | Job: ansible-collection-kubernetes-molecule-upload-helm-chart 2026-02-16 21:11:11.359319 | Pipeline: check 2026-02-16 21:11:11.359368 | Executor: 3a2793d2bd32 2026-02-16 21:11:11.359401 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/232 2026-02-16 21:11:11.359436 | Event ID: dd7fa8d0-0b7b-11f1-80a0-1b5177b5933d 2026-02-16 21:11:11.364996 | 2026-02-16 21:11:11.365105 | LOOP [emit-job-header : Print node information] 2026-02-16 21:11:11.517921 | localhost | ok: 2026-02-16 21:11:11.518129 | localhost | # Node Information 2026-02-16 21:11:11.518167 | localhost | Inventory Hostname: controller 2026-02-16 21:11:11.518190 | localhost | Hostname: np0000155829 2026-02-16 21:11:11.518210 | localhost | Username: zuul 2026-02-16 21:11:11.518233 | localhost | Distro: Debian 13.3 2026-02-16 21:11:11.518252 | localhost | Provider: yul1 2026-02-16 21:11:11.518271 | localhost | Region: ca-ymq-1 2026-02-16 21:11:11.518289 | localhost | Label: debian-trixie 2026-02-16 21:11:11.518308 | localhost | Product Name: OpenStack Nova 2026-02-16 21:11:11.518334 | localhost | Interface IP: 199.204.45.157 2026-02-16 21:11:11.529543 | 2026-02-16 21:11:11.529750 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-16 21:11:12.011651 | localhost -> localhost | changed 2026-02-16 21:11:12.025052 | 2026-02-16 21:11:12.025203 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-16 21:11:12.976378 | localhost -> localhost | changed 2026-02-16 21:11:12.982501 | 2026-02-16 21:11:12.982556 | PLAY [all] 2026-02-16 21:11:12.989062 | 2026-02-16 21:11:12.989125 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-16 21:11:13.215090 | controller -> localhost | ok 2026-02-16 21:11:13.223132 | 2026-02-16 21:11:13.223305 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-16 21:11:13.254944 | controller | ok 2026-02-16 21:11:13.270535 | controller | included: /var/lib/zuul/builds/dd24e736b5e24c2190d6d7707e92f63a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-16 21:11:13.276638 | 2026-02-16 21:11:13.276734 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-16 21:11:13.962911 | controller -> localhost | Generating public/private rsa key pair. 2026-02-16 21:11:13.963082 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/dd24e736b5e24c2190d6d7707e92f63a/work/dd24e736b5e24c2190d6d7707e92f63a_id_rsa 2026-02-16 21:11:13.963110 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/dd24e736b5e24c2190d6d7707e92f63a/work/dd24e736b5e24c2190d6d7707e92f63a_id_rsa.pub 2026-02-16 21:11:13.963132 | controller -> localhost | The key fingerprint is: 2026-02-16 21:11:13.963153 | controller -> localhost | SHA256:tCLqOcZNrWblQyz8MvrXFTkEZeerUmtQ/BCVT+GCEng zuul-build-sshkey 2026-02-16 21:11:13.963186 | controller -> localhost | The key's randomart image is: 2026-02-16 21:11:13.963207 | controller -> localhost | +---[RSA 3072]----+ 2026-02-16 21:11:13.963230 | controller -> localhost | | .oo+.o... | 2026-02-16 21:11:13.963252 | controller -> localhost | | . E+.=... | 2026-02-16 21:11:13.963272 | controller -> localhost | | .o.=.oo. | 2026-02-16 21:11:13.963291 | controller -> localhost | | . ++o o. | 2026-02-16 21:11:13.963311 | controller -> localhost | | ..o. S .oo | 2026-02-16 21:11:13.963330 | controller -> localhost | | .+.=. o.o | 2026-02-16 21:11:13.963349 | controller -> localhost | | ..o B ...+ | 2026-02-16 21:11:13.963368 | controller -> localhost | | .+.B = .o | 2026-02-16 21:11:13.963390 | controller -> localhost | | .+*.+ . | 2026-02-16 21:11:13.963409 | controller -> localhost | +----[SHA256]-----+ 2026-02-16 21:11:13.963453 | controller -> localhost | ok: Runtime: 0:00:00.286404 2026-02-16 21:11:13.967751 | 2026-02-16 21:11:13.967823 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-16 21:11:13.997575 | controller | ok 2026-02-16 21:11:14.008445 | controller | included: /var/lib/zuul/builds/dd24e736b5e24c2190d6d7707e92f63a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-16 21:11:14.015104 | 2026-02-16 21:11:14.015171 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-16 21:11:14.039678 | controller | skipping: Conditional result was False 2026-02-16 21:11:14.048577 | 2026-02-16 21:11:14.048723 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-16 21:11:14.606073 | controller | changed 2026-02-16 21:11:14.611564 | 2026-02-16 21:11:14.611626 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-16 21:11:14.821164 | controller | ok 2026-02-16 21:11:14.825217 | 2026-02-16 21:11:14.825278 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-16 21:11:15.333377 | controller | changed 2026-02-16 21:11:15.337441 | 2026-02-16 21:11:15.337504 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-16 21:11:15.857246 | controller | changed 2026-02-16 21:11:15.868905 | 2026-02-16 21:11:15.869033 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-16 21:11:15.894690 | controller | skipping: Conditional result was False 2026-02-16 21:11:15.904091 | 2026-02-16 21:11:15.904156 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-16 21:11:16.264533 | controller -> localhost | changed 2026-02-16 21:11:16.280024 | 2026-02-16 21:11:16.280191 | TASK [add-build-sshkey : Add back temp key] 2026-02-16 21:11:16.568837 | controller -> localhost | Identity added: /var/lib/zuul/builds/dd24e736b5e24c2190d6d7707e92f63a/work/dd24e736b5e24c2190d6d7707e92f63a_id_rsa (zuul-build-sshkey) 2026-02-16 21:11:16.569088 | controller -> localhost | ok: Runtime: 0:00:00.022476 2026-02-16 21:11:16.574559 | 2026-02-16 21:11:16.574624 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-16 21:11:16.909257 | controller | ok 2026-02-16 21:11:16.913182 | 2026-02-16 21:11:16.913243 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-16 21:11:16.938379 | controller | skipping: Conditional result was False 2026-02-16 21:11:16.946918 | 2026-02-16 21:11:16.946981 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-02-16 21:11:17.306110 | controller | ok 2026-02-16 21:11:17.316414 | 2026-02-16 21:11:17.316594 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-02-16 21:11:18.393449 | controller | Output suppressed because no_log was given 2026-02-16 21:11:18.411585 | 2026-02-16 21:11:18.411939 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-02-16 21:11:18.617514 | controller | ok: "logs" 2026-02-16 21:11:18.617820 | controller | ok: All items complete 2026-02-16 21:11:18.617873 | 2026-02-16 21:11:18.788015 | controller | ok: "artifacts" 2026-02-16 21:11:18.953133 | controller | ok: "docs" 2026-02-16 21:11:18.964467 | 2026-02-16 21:11:18.964647 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-02-16 21:11:19.167768 | controller | changed: "logs" 2026-02-16 21:11:19.346344 | controller | changed: "artifacts" 2026-02-16 21:11:19.520255 | controller | changed: "docs" 2026-02-16 21:11:19.528256 | 2026-02-16 21:11:19.528303 | PLAY RECAP 2026-02-16 21:11:19.528345 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-02-16 21:11:19.528373 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-16 21:11:19.528394 | 2026-02-16 21:11:19.702836 | PRE-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/pre.yaml@main] 2026-02-16 21:11:19.705787 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-02-16 21:11:20.304777 | 2026-02-16 21:11:20.305675 | PLAY [all] 2026-02-16 21:11:20.317062 | 2026-02-16 21:11:20.317140 | TASK [setup-uv : Extract archive] 2026-02-16 21:11:22.699042 | controller | changed 2026-02-16 21:11:22.704377 | 2026-02-16 21:11:22.704460 | TASK [setup-uv : Print version] 2026-02-16 21:11:23.109608 | controller | uv 0.8.13 2026-02-16 21:11:23.230746 | controller | ok: Runtime: 0:00:00.011931 2026-02-16 21:11:23.236121 | 2026-02-16 21:11:23.236174 | PLAY RECAP 2026-02-16 21:11:23.236222 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-16 21:11:23.236245 | 2026-02-16 21:11:23.366813 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-02-16 21:11:23.369579 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-02-16 21:11:23.964569 | 2026-02-16 21:11:23.964704 | PLAY [all] 2026-02-16 21:11:23.976975 | 2026-02-16 21:11:23.977052 | TASK [Copy inventory file for Zuul] 2026-02-16 21:11:24.967774 | controller | changed 2026-02-16 21:11:24.971966 | 2026-02-16 21:11:24.972054 | TASK [Switch "ansible_host" to private IP] 2026-02-16 21:11:25.268346 | controller | changed: 1 replacements made 2026-02-16 21:11:25.274347 | 2026-02-16 21:11:25.274445 | TASK [Run Molecule scenario] 2026-02-16 21:11:25.734996 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-02-16 21:11:25.735089 | controller | Creating virtual environment at: .venv 2026-02-16 21:11:25.775731 | controller | Downloading pygments (1.2MiB) 2026-02-16 21:11:25.784371 | controller | Downloading ansible-core (2.3MiB) 2026-02-16 21:11:25.787224 | controller | Downloading cryptography (4.3MiB) 2026-02-16 21:11:25.960756 | controller | Downloading cryptography 2026-02-16 21:11:26.001605 | controller | Downloading pygments 2026-02-16 21:11:26.081473 | controller | Downloading ansible-core 2026-02-16 21:11:26.130479 | controller | Installed 36 packages in 48ms 2026-02-16 21:11:26.795182 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-02-16 21:11:26.795208 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-02-16 21:11:27.521123 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-02-16 21:11:27.521229 | controller | INFO default scenario not found, disabling shared state. 2026-02-16 21:11:27.521423 | controller | INFO [upload-helm-chart > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-02-16 21:11:27.521526 | controller | INFO [upload-helm-chart > prerun] Performing prerun with role_name_check=0... 2026-02-16 21:11:42.975248 | controller | INFO [upload-helm-chart > dependency] Executing 2026-02-16 21:11:42.975535 | controller | WARNING [upload-helm-chart > dependency] Missing roles requirements file: requirements.yml 2026-02-16 21:11:42.975756 | controller | WARNING [upload-helm-chart > dependency] Missing collections requirements file: collections.yml 2026-02-16 21:11:42.975892 | controller | WARNING [upload-helm-chart > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-02-16 21:11:42.981281 | controller | INFO [upload-helm-chart > cleanup] Executing 2026-02-16 21:11:42.981605 | controller | WARNING [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-02-16 21:11:42.997555 | controller | INFO [upload-helm-chart > destroy] Executing 2026-02-16 21:11:42.997662 | controller | WARNING [upload-helm-chart > destroy] Skipping, '--destroy=never' requested. 2026-02-16 21:11:42.997750 | controller | INFO [upload-helm-chart > destroy] Executed: Successful 2026-02-16 21:11:43.024394 | controller | INFO [upload-helm-chart > syntax] Executing 2026-02-16 21:11:43.834792 | controller | 2026-02-16 21:11:43.835024 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/upload-helm-chart/converge.yml 2026-02-16 21:11:43.898141 | controller | INFO [upload-helm-chart > syntax] Executed: Successful 2026-02-16 21:11:43.908333 | controller | INFO [upload-helm-chart > create] Executing 2026-02-16 21:11:43.909796 | controller | WARNING [upload-helm-chart > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-02-16 21:11:43.915221 | controller | INFO [upload-helm-chart > prepare] Executing 2026-02-16 21:11:43.915540 | controller | WARNING [upload-helm-chart > prepare] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-02-16 21:11:43.920931 | controller | INFO [upload-helm-chart > converge] Executing 2026-02-16 21:11:44.724482 | controller | 2026-02-16 21:11:44.724804 | controller | PLAY [Converge] **************************************************************** 2026-02-16 21:11:44.725054 | controller | 2026-02-16 21:11:44.725318 | controller | TASK [Gathering Facts] ********************************************************* 2026-02-16 21:11:44.727396 | controller | Monday 16 February 2026 21:11:44 +0000 (0:00:00.029) 0:00:00.029 ******* 2026-02-16 21:11:45.878391 | 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-02-16 21:11:45.883487 | controller | ok: [controller] 2026-02-16 21:11:45.883658 | controller | 2026-02-16 21:11:45.883793 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-02-16 21:11:45.883916 | controller | Monday 16 February 2026 21:11:45 +0000 (0:00:01.158) 0:00:01.188 ******* 2026-02-16 21:11:45.965488 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller 2026-02-16 21:11:45.965829 | controller | 2026-02-16 21:11:45.966161 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] *************** 2026-02-16 21:11:45.966426 | controller | Monday 16 February 2026 21:11:45 +0000 (0:00:00.082) 0:00:01.270 ******* 2026-02-16 21:11:46.660626 | controller | changed: [controller] 2026-02-16 21:11:46.660916 | controller | 2026-02-16 21:11:46.661259 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-02-16 21:11:46.661539 | controller | Monday 16 February 2026 21:11:46 +0000 (0:00:00.695) 0:00:01.966 ******* 2026-02-16 21:11:46.700495 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller 2026-02-16 21:11:46.700780 | controller | 2026-02-16 21:11:46.701058 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] ********** 2026-02-16 21:11:46.701372 | controller | Monday 16 February 2026 21:11:46 +0000 (0:00:00.039) 0:00:02.006 ******* 2026-02-16 21:11:47.087195 | controller | changed: [controller] 2026-02-16 21:11:47.087238 | controller | 2026-02-16 21:11:47.087245 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] *** 2026-02-16 21:11:47.087252 | controller | Monday 16 February 2026 21:11:47 +0000 (0:00:00.384) 0:00:02.390 ******* 2026-02-16 21:11:48.210987 | controller | changed: [controller] 2026-02-16 21:11:48.211027 | controller | 2026-02-16 21:11:48.211257 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] ********** 2026-02-16 21:11:48.211301 | controller | Monday 16 February 2026 21:11:48 +0000 (0:00:01.125) 0:00:03.516 ******* 2026-02-16 21:11:48.578175 | controller | ok: [controller] 2026-02-16 21:11:48.578263 | controller | 2026-02-16 21:11:48.578404 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] *** 2026-02-16 21:11:48.578535 | controller | Monday 16 February 2026 21:11:48 +0000 (0:00:00.366) 0:00:03.883 ******* 2026-02-16 21:11:48.627362 | controller | skipping: [controller] 2026-02-16 21:11:48.627497 | controller | 2026-02-16 21:11:48.627704 | controller | PLAY RECAP ********************************************************************* 2026-02-16 21:11:48.627919 | controller | controller : ok=7 changed=3 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-02-16 21:11:48.628092 | controller | 2026-02-16 21:11:48.628257 | controller | 2026-02-16 21:11:48.628450 | controller | TASKS RECAP ******************************************************************** 2026-02-16 21:11:48.628643 | controller | Monday 16 February 2026 21:11:48 +0000 (0:00:00.050) 0:00:03.933 ******* 2026-02-16 21:11:48.628814 | controller | =============================================================================== 2026-02-16 21:11:48.628996 | controller | Gathering Facts --------------------------------------------------------- 1.16s 2026-02-16 21:11:48.629195 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.13s 2026-02-16 21:11:48.629388 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.70s 2026-02-16 21:11:48.629581 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.38s 2026-02-16 21:11:48.629764 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.37s 2026-02-16 21:11:48.629957 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.08s 2026-02-16 21:11:48.630154 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.05s 2026-02-16 21:11:48.630349 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.04s 2026-02-16 21:11:48.717653 | controller | INFO [upload-helm-chart > converge] Executed: Successful 2026-02-16 21:11:48.729224 | controller | INFO [upload-helm-chart > idempotence] Executing 2026-02-16 21:11:49.506597 | controller | 2026-02-16 21:11:49.507198 | controller | PLAY [Converge] **************************************************************** 2026-02-16 21:11:49.507405 | controller | 2026-02-16 21:11:49.507606 | controller | TASK [Gathering Facts] ********************************************************* 2026-02-16 21:11:49.507809 | controller | Monday 16 February 2026 21:11:49 +0000 (0:00:00.010) 0:00:00.010 ******* 2026-02-16 21:11:50.486361 | 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-02-16 21:11:50.494305 | controller | ok: [controller] 2026-02-16 21:11:50.494428 | controller | 2026-02-16 21:11:50.494565 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-02-16 21:11:50.494688 | controller | Monday 16 February 2026 21:11:50 +0000 (0:00:00.985) 0:00:00.995 ******* 2026-02-16 21:11:50.559814 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller 2026-02-16 21:11:50.559859 | controller | 2026-02-16 21:11:50.559961 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] *************** 2026-02-16 21:11:50.560047 | controller | Monday 16 February 2026 21:11:50 +0000 (0:00:00.068) 0:00:01.063 ******* 2026-02-16 21:11:51.212235 | controller | ok: [controller] 2026-02-16 21:11:51.214182 | controller | 2026-02-16 21:11:51.214193 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-02-16 21:11:51.214198 | controller | Monday 16 February 2026 21:11:51 +0000 (0:00:00.649) 0:00:01.713 ******* 2026-02-16 21:11:51.253020 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller 2026-02-16 21:11:51.253211 | controller | 2026-02-16 21:11:51.253418 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] ********** 2026-02-16 21:11:51.253615 | controller | Monday 16 February 2026 21:11:51 +0000 (0:00:00.043) 0:00:01.756 ******* 2026-02-16 21:11:51.651702 | controller | ok: [controller] 2026-02-16 21:11:51.651887 | controller | 2026-02-16 21:11:51.652063 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] *** 2026-02-16 21:11:51.652226 | controller | Monday 16 February 2026 21:11:51 +0000 (0:00:00.396) 0:00:02.152 ******* 2026-02-16 21:11:52.650722 | controller | ok: [controller] 2026-02-16 21:11:52.653178 | controller | 2026-02-16 21:11:52.653188 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] ********** 2026-02-16 21:11:52.653192 | controller | Monday 16 February 2026 21:11:52 +0000 (0:00:01.001) 0:00:03.154 ******* 2026-02-16 21:11:53.009099 | controller | ok: [controller] 2026-02-16 21:11:53.009274 | controller | 2026-02-16 21:11:53.009458 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] *** 2026-02-16 21:11:53.009623 | controller | Monday 16 February 2026 21:11:53 +0000 (0:00:00.358) 0:00:03.512 ******* 2026-02-16 21:11:53.046446 | controller | skipping: [controller] 2026-02-16 21:11:53.046461 | controller | 2026-02-16 21:11:53.046467 | controller | PLAY RECAP ********************************************************************* 2026-02-16 21:11:53.046472 | controller | controller : ok=7 changed=0 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-02-16 21:11:53.046477 | controller | 2026-02-16 21:11:53.046481 | controller | 2026-02-16 21:11:53.046486 | controller | TASKS RECAP ******************************************************************** 2026-02-16 21:11:53.046490 | controller | Monday 16 February 2026 21:11:53 +0000 (0:00:00.036) 0:00:03.548 ******* 2026-02-16 21:11:53.046495 | controller | =============================================================================== 2026-02-16 21:11:53.046500 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.00s 2026-02-16 21:11:53.046505 | controller | Gathering Facts --------------------------------------------------------- 0.99s 2026-02-16 21:11:53.046509 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.65s 2026-02-16 21:11:53.046513 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.40s 2026-02-16 21:11:53.046518 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.36s 2026-02-16 21:11:53.046528 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.07s 2026-02-16 21:11:53.046532 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.04s 2026-02-16 21:11:53.046537 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.04s 2026-02-16 21:11:53.131548 | controller | INFO [upload-helm-chart > idempotence] Executed: Successful 2026-02-16 21:11:53.137608 | controller | INFO [upload-helm-chart > side_effect] Executing 2026-02-16 21:11:53.909060 | controller | 2026-02-16 21:11:53.909372 | controller | PLAY [Side effect] ************************************************************* 2026-02-16 21:11:53.909608 | controller | 2026-02-16 21:11:53.909861 | controller | TASK [Gathering Facts] ********************************************************* 2026-02-16 21:11:53.910117 | controller | Monday 16 February 2026 21:11:53 +0000 (0:00:00.010) 0:00:00.010 ******* 2026-02-16 21:11:54.890339 | 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-02-16 21:11:54.898753 | controller | ok: [controller] 2026-02-16 21:11:54.898871 | controller | 2026-02-16 21:11:54.899005 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-02-16 21:11:54.899160 | controller | Monday 16 February 2026 21:11:54 +0000 (0:00:00.986) 0:00:00.997 ******* 2026-02-16 21:11:54.965309 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller 2026-02-16 21:11:54.965357 | controller | 2026-02-16 21:11:54.965442 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] *************** 2026-02-16 21:11:54.965527 | controller | Monday 16 February 2026 21:11:54 +0000 (0:00:00.069) 0:00:01.066 ******* 2026-02-16 21:11:55.626303 | controller | changed: [controller] 2026-02-16 21:11:55.626362 | controller | 2026-02-16 21:11:55.626465 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-02-16 21:11:55.626558 | controller | Monday 16 February 2026 21:11:55 +0000 (0:00:00.660) 0:00:01.727 ******* 2026-02-16 21:11:55.669491 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller 2026-02-16 21:11:55.669537 | controller | 2026-02-16 21:11:55.669640 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] ********** 2026-02-16 21:11:55.669728 | controller | Monday 16 February 2026 21:11:55 +0000 (0:00:00.043) 0:00:01.770 ******* 2026-02-16 21:11:56.053939 | controller | ok: [controller] 2026-02-16 21:11:56.053976 | controller | 2026-02-16 21:11:56.053982 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] *** 2026-02-16 21:11:56.053988 | controller | Monday 16 February 2026 21:11:56 +0000 (0:00:00.381) 0:00:02.151 ******* 2026-02-16 21:11:57.067135 | controller | ok: [controller] 2026-02-16 21:11:57.067216 | controller | 2026-02-16 21:11:57.067297 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] ********** 2026-02-16 21:11:57.067386 | controller | Monday 16 February 2026 21:11:57 +0000 (0:00:01.009) 0:00:03.161 ******* 2026-02-16 21:11:57.449247 | controller | ok: [controller] 2026-02-16 21:11:57.449387 | controller | 2026-02-16 21:11:57.449506 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] *** 2026-02-16 21:11:57.449641 | controller | Monday 16 February 2026 21:11:57 +0000 (0:00:00.388) 0:00:03.550 ******* 2026-02-16 21:11:57.748938 | controller | changed: [controller] => (item=/file) 2026-02-16 21:11:57.749015 | controller | 2026-02-16 21:11:57.749113 | controller | PLAY RECAP ********************************************************************* 2026-02-16 21:11:57.749211 | controller | controller : ok=8 changed=2 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-02-16 21:11:57.749284 | controller | 2026-02-16 21:11:57.749368 | controller | 2026-02-16 21:11:57.749445 | controller | TASKS RECAP ******************************************************************** 2026-02-16 21:11:57.749532 | controller | Monday 16 February 2026 21:11:57 +0000 (0:00:00.300) 0:00:03.850 ******* 2026-02-16 21:11:57.749613 | controller | =============================================================================== 2026-02-16 21:11:57.749703 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.01s 2026-02-16 21:11:57.749786 | controller | Gathering Facts --------------------------------------------------------- 0.99s 2026-02-16 21:11:57.749871 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.66s 2026-02-16 21:11:57.749958 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.39s 2026-02-16 21:11:57.750044 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.38s 2026-02-16 21:11:57.751143 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.30s 2026-02-16 21:11:57.751156 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.07s 2026-02-16 21:11:57.751161 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.04s 2026-02-16 21:11:57.842738 | controller | INFO [upload-helm-chart > side_effect] Executed: Successful 2026-02-16 21:11:57.853352 | controller | INFO [upload-helm-chart > verify] Executing 2026-02-16 21:11:58.638193 | controller | 2026-02-16 21:11:58.638394 | controller | PLAY [Verify] ****************************************************************** 2026-02-16 21:11:58.638568 | controller | 2026-02-16 21:11:58.638752 | controller | TASK [Gathering Facts] ********************************************************* 2026-02-16 21:11:58.638938 | controller | Monday 16 February 2026 21:11:58 +0000 (0:00:00.009) 0:00:00.009 ******* 2026-02-16 21:11:59.603877 | 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-02-16 21:11:59.608847 | controller | ok: [controller] 2026-02-16 21:11:59.608872 | controller | 2026-02-16 21:11:59.608877 | controller | TASK [Stat file 1] ************************************************************* 2026-02-16 21:11:59.608881 | controller | Monday 16 February 2026 21:11:59 +0000 (0:00:00.970) 0:00:00.980 ******* 2026-02-16 21:11:59.984244 | controller | ok: [controller] 2026-02-16 21:11:59.984433 | controller | 2026-02-16 21:11:59.984604 | controller | TASK [Stat file 2] ************************************************************* 2026-02-16 21:11:59.984769 | controller | Monday 16 February 2026 21:11:59 +0000 (0:00:00.374) 0:00:01.355 ******* 2026-02-16 21:12:00.249815 | controller | ok: [controller] 2026-02-16 21:12:00.249997 | controller | 2026-02-16 21:12:00.250174 | controller | TASK [Stat removed file 1] ***************************************************** 2026-02-16 21:12:00.250339 | controller | Monday 16 February 2026 21:12:00 +0000 (0:00:00.265) 0:00:01.621 ******* 2026-02-16 21:12:00.518888 | controller | ok: [controller] 2026-02-16 21:12:00.518914 | controller | 2026-02-16 21:12:00.518919 | controller | TASK [Stat removed file 2] ***************************************************** 2026-02-16 21:12:00.518934 | controller | Monday 16 February 2026 21:12:00 +0000 (0:00:00.265) 0:00:01.886 ******* 2026-02-16 21:12:00.784300 | controller | ok: [controller] 2026-02-16 21:12:00.784583 | controller | 2026-02-16 21:12:00.784856 | controller | TASK [ansible.builtin.assert] ************************************************** 2026-02-16 21:12:00.785121 | controller | Monday 16 February 2026 21:12:00 +0000 (0:00:00.269) 0:00:02.155 ******* 2026-02-16 21:12:00.813882 | controller | ok: [controller] => { 2026-02-16 21:12:00.814023 | controller | "changed": false, 2026-02-16 21:12:00.814138 | controller | "msg": "All assertions passed" 2026-02-16 21:12:00.814247 | controller | } 2026-02-16 21:12:00.814374 | controller | 2026-02-16 21:12:00.814486 | controller | PLAY RECAP ********************************************************************* 2026-02-16 21:12:00.814607 | controller | controller : ok=6 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-02-16 21:12:00.814715 | controller | 2026-02-16 21:12:00.814824 | controller | 2026-02-16 21:12:00.814933 | controller | TASKS RECAP ******************************************************************** 2026-02-16 21:12:00.815044 | controller | Monday 16 February 2026 21:12:00 +0000 (0:00:00.030) 0:00:02.185 ******* 2026-02-16 21:12:00.815175 | controller | =============================================================================== 2026-02-16 21:12:00.815287 | controller | Gathering Facts --------------------------------------------------------- 0.97s 2026-02-16 21:12:00.815396 | controller | Stat file 1 ------------------------------------------------------------- 0.37s 2026-02-16 21:12:00.815506 | controller | Stat removed file 2 ----------------------------------------------------- 0.27s 2026-02-16 21:12:00.815617 | controller | Stat file 2 ------------------------------------------------------------- 0.27s 2026-02-16 21:12:00.815725 | controller | Stat removed file 1 ----------------------------------------------------- 0.27s 2026-02-16 21:12:00.815833 | controller | ansible.builtin.assert -------------------------------------------------- 0.03s 2026-02-16 21:12:00.900595 | controller | INFO [upload-helm-chart > verify] Executed: Successful 2026-02-16 21:12:00.911038 | controller | INFO [upload-helm-chart > cleanup] Executing 2026-02-16 21:12:00.911525 | controller | WARNING [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-02-16 21:12:00.918911 | controller | INFO [upload-helm-chart > destroy] Executing 2026-02-16 21:12:00.919075 | controller | WARNING [upload-helm-chart > destroy] Skipping, '--destroy=never' requested. 2026-02-16 21:12:00.919254 | controller | INFO [upload-helm-chart > destroy] Executed: Successful 2026-02-16 21:12:00.919561 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-02-16 21:12:01.331913 | controller | ok: Runtime: 0:00:35.313650 2026-02-16 21:12:01.336496 | 2026-02-16 21:12:01.336569 | PLAY RECAP 2026-02-16 21:12:01.336634 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-16 21:12:01.336664 | 2026-02-16 21:12:01.495290 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-02-16 21:12:01.498223 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main] 2026-02-16 21:12:02.094256 | 2026-02-16 21:12:02.094433 | PLAY [all] 2026-02-16 21:12:02.104678 | 2026-02-16 21:12:02.104751 | TASK [fetch-output : Set log path for multiple nodes] 2026-02-16 21:12:02.150140 | controller | skipping: Conditional result was False 2026-02-16 21:12:02.155720 | 2026-02-16 21:12:02.155826 | TASK [fetch-output : Set log path for single node] 2026-02-16 21:12:02.198225 | controller | ok 2026-02-16 21:12:02.226000 | 2026-02-16 21:12:02.226280 | LOOP [fetch-output : Ensure local output dirs] 2026-02-16 21:12:02.664884 | controller -> localhost | ok: "/var/lib/zuul/builds/dd24e736b5e24c2190d6d7707e92f63a/work/logs" 2026-02-16 21:12:02.923543 | controller -> localhost | changed: "/var/lib/zuul/builds/dd24e736b5e24c2190d6d7707e92f63a/work/artifacts" 2026-02-16 21:12:03.182067 | controller -> localhost | changed: "/var/lib/zuul/builds/dd24e736b5e24c2190d6d7707e92f63a/work/docs" 2026-02-16 21:12:03.201507 | 2026-02-16 21:12:03.201658 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-16 21:12:03.848361 | controller | ok 2026-02-16 21:12:03.848715 | controller | changed: All items complete 2026-02-16 21:12:03.848780 | 2026-02-16 21:12:04.338675 | controller | changed: .d..t...... ./ 2026-02-16 21:12:04.812793 | controller | changed: .d..t...... ./ 2026-02-16 21:12:04.834400 | 2026-02-16 21:12:04.834586 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-02-16 21:12:05.299019 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.007250 2026-02-16 21:12:05.583863 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.009171 2026-02-16 21:12:05.606970 | 2026-02-16 21:12:05.656841 | PLAY [all] 2026-02-16 21:12:05.667844 | 2026-02-16 21:12:05.667925 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-02-16 21:12:06.144860 | controller | changed 2026-02-16 21:12:06.151476 | 2026-02-16 21:12:06.151527 | PLAY RECAP 2026-02-16 21:12:06.151575 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-02-16 21:12:06.151597 | 2026-02-16 21:12:06.262928 | POST-RUN END RESULT_NORMAL: [trusted : vexxhost.dev/zuul-config/playbooks/base/post.yaml@main] 2026-02-16 21:12:06.265841 | POST-RUN START: [trusted : vexxhost.dev/zuul-config/playbooks/base/post-logs.yaml@main] 2026-02-16 21:12:06.875886 | 2026-02-16 21:12:06.876037 | PLAY [localhost] 2026-02-16 21:12:06.886321 | 2026-02-16 21:12:06.886391 | TASK [Generate Zuul manifest] 2026-02-16 21:12:06.908460 | localhost | ok 2026-02-16 21:12:06.925040 | 2026-02-16 21:12:06.925124 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-16 21:12:07.233376 | localhost | changed 2026-02-16 21:12:07.246657 | 2026-02-16 21:12:07.246735 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-16 21:12:07.278056 | localhost | ok 2026-02-16 21:12:07.286751 | 2026-02-16 21:12:07.286816 | TASK [Upload logs] 2026-02-16 21:12:07.308257 | localhost | ok 2026-02-16 21:12:07.367557 | 2026-02-16 21:12:07.367658 | TASK [Set zuul-log-path fact] 2026-02-16 21:12:07.386750 | localhost | ok 2026-02-16 21:12:07.399579 | 2026-02-16 21:12:07.399648 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-16 21:12:07.432932 | localhost | ok 2026-02-16 21:12:07.441526 | 2026-02-16 21:12:07.441589 | TASK [upload-logs : Create log directories] 2026-02-16 21:12:07.855335 | localhost | changed 2026-02-16 21:12:07.860841 | 2026-02-16 21:12:07.860922 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-02-16 21:12:08.326858 | localhost -> localhost | ok: Runtime: 0:00:00.005597 2026-02-16 21:12:08.331852 | 2026-02-16 21:12:08.331915 | TASK [upload-logs : Upload logs to log server] 2026-02-16 21:12:08.804974 | localhost | Output suppressed because no_log was given 2026-02-16 21:12:08.809199 | 2026-02-16 21:12:08.809286 | LOOP [upload-logs : Compress console log and json output] 2026-02-16 21:12:08.856094 | localhost | skipping: Conditional result was False 2026-02-16 21:12:08.862978 | localhost | skipping: Conditional result was False 2026-02-16 21:12:08.875007 | 2026-02-16 21:12:08.875196 | LOOP [upload-logs : Upload compressed console log and json output] 2026-02-16 21:12:08.919961 | localhost | skipping: Conditional result was False 2026-02-16 21:12:08.920214 | 2026-02-16 21:12:08.923762 | localhost | skipping: Conditional result was False 2026-02-16 21:12:08.939321 | 2026-02-16 21:12:08.939468 | LOOP [upload-logs : Upload console log and json output]