2026-03-06 02:02:26.798223 | Job console starting 2026-03-06 02:02:26.805925 | Updating git repos 2026-03-06 02:02:26.857320 | Cloning repos into workspace 2026-03-06 02:02:26.916854 | Restoring repo states 2026-03-06 02:02:26.962418 | Merging changes 2026-03-06 02:02:27.618464 | Checking out repos 2026-03-06 02:02:27.913831 | Preparing playbooks 2026-03-06 02:02:29.267125 | Running Ansible setup 2026-03-06 02:02:34.619995 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-06 02:02:35.221219 | 2026-03-06 02:02:35.221332 | PLAY [localhost] 2026-03-06 02:02:35.228232 | 2026-03-06 02:02:35.228302 | TASK [Gathering Facts] 2026-03-06 02:02:36.382277 | localhost | ok 2026-03-06 02:02:36.395829 | 2026-03-06 02:02:36.395909 | TASK [Setup log path fact] 2026-03-06 02:02:36.412483 | localhost | ok 2026-03-06 02:02:36.423236 | 2026-03-06 02:02:36.451792 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-06 02:02:36.486401 | localhost | ok 2026-03-06 02:02:36.495526 | 2026-03-06 02:02:36.495621 | TASK [emit-job-header : Print job information] 2026-03-06 02:02:36.538384 | # Job Information 2026-03-06 02:02:36.538622 | Ansible Version: 2.16.16 2026-03-06 02:02:36.538720 | Job: ansible-collection-kubernetes-molecule-upload-helm-chart 2026-03-06 02:02:36.538756 | Pipeline: check 2026-03-06 02:02:36.538784 | Executor: 0a8996d2b663 2026-03-06 02:02:36.538811 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/235 2026-03-06 02:02:36.538841 | Event ID: 62655ae0-1900-11f1-9569-19afb6ddb422 2026-03-06 02:02:36.544047 | 2026-03-06 02:02:36.544266 | LOOP [emit-job-header : Print node information] 2026-03-06 02:02:36.636605 | localhost | ok: 2026-03-06 02:02:36.636830 | localhost | # Node Information 2026-03-06 02:02:36.636872 | localhost | Inventory Hostname: controller 2026-03-06 02:02:36.636904 | localhost | Hostname: np0000158028 2026-03-06 02:02:36.636945 | localhost | Username: zuul 2026-03-06 02:02:36.636997 | localhost | Distro: Debian 13.3 2026-03-06 02:02:36.637028 | localhost | Provider: yul1 2026-03-06 02:02:36.637056 | localhost | Region: ca-ymq-1 2026-03-06 02:02:36.637083 | localhost | Label: debian-trixie 2026-03-06 02:02:36.637110 | localhost | Product Name: OpenStack Nova 2026-03-06 02:02:36.637138 | localhost | Interface IP: 199.204.45.233 2026-03-06 02:02:36.649880 | 2026-03-06 02:02:36.650237 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-06 02:02:37.030257 | localhost -> localhost | changed 2026-03-06 02:02:37.039977 | 2026-03-06 02:02:37.040068 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-06 02:02:37.873457 | localhost -> localhost | changed 2026-03-06 02:02:37.882756 | 2026-03-06 02:02:37.882833 | PLAY [all] 2026-03-06 02:02:37.890481 | 2026-03-06 02:02:37.890542 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-06 02:02:38.106243 | controller -> localhost | ok 2026-03-06 02:02:38.114111 | 2026-03-06 02:02:38.114199 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-06 02:02:38.145467 | controller | ok 2026-03-06 02:02:38.159060 | controller | included: /var/lib/zuul/builds/c8031db44c8948ac9e1b874209a976be/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-06 02:02:38.163509 | 2026-03-06 02:02:38.163568 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-06 02:02:38.967909 | controller -> localhost | Generating public/private rsa key pair. 2026-03-06 02:02:38.968139 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/c8031db44c8948ac9e1b874209a976be/work/c8031db44c8948ac9e1b874209a976be_id_rsa 2026-03-06 02:02:38.968183 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/c8031db44c8948ac9e1b874209a976be/work/c8031db44c8948ac9e1b874209a976be_id_rsa.pub 2026-03-06 02:02:38.968218 | controller -> localhost | The key fingerprint is: 2026-03-06 02:02:38.968249 | controller -> localhost | SHA256:8s8ODTaRMZyKy62YA7s8VSqBiPstGfo84FqA3uw63XU zuul-build-sshkey 2026-03-06 02:02:38.968293 | controller -> localhost | The key's randomart image is: 2026-03-06 02:02:38.968325 | controller -> localhost | +---[RSA 3072]----+ 2026-03-06 02:02:38.968362 | controller -> localhost | | .o. | 2026-03-06 02:02:38.968393 | controller -> localhost | | o+ | 2026-03-06 02:02:38.968423 | controller -> localhost | |+ . .o | 2026-03-06 02:02:38.968453 | controller -> localhost | |=. ... . | 2026-03-06 02:02:38.968482 | controller -> localhost | |o...oo. S | 2026-03-06 02:02:38.968528 | controller -> localhost | |=o+oo .= E | 2026-03-06 02:02:38.968559 | controller -> localhost | |.B=O... + . | 2026-03-06 02:02:38.968588 | controller -> localhost | |+*X.o. + | 2026-03-06 02:02:38.968622 | controller -> localhost | |+=*= .+ | 2026-03-06 02:02:38.968652 | controller -> localhost | +----[SHA256]-----+ 2026-03-06 02:02:38.968714 | controller -> localhost | ok: Runtime: 0:00:00.433039 2026-03-06 02:02:38.974816 | 2026-03-06 02:02:38.974899 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-06 02:02:38.995339 | controller | ok 2026-03-06 02:02:39.005023 | controller | included: /var/lib/zuul/builds/c8031db44c8948ac9e1b874209a976be/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-06 02:02:39.025701 | 2026-03-06 02:02:39.025761 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-06 02:02:39.048263 | controller | skipping: Conditional result was False 2026-03-06 02:02:39.057122 | 2026-03-06 02:02:39.057214 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-06 02:02:39.566448 | controller | changed 2026-03-06 02:02:39.571988 | 2026-03-06 02:02:39.572048 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-06 02:02:39.780584 | controller | ok 2026-03-06 02:02:39.784557 | 2026-03-06 02:02:39.784619 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-06 02:02:40.300782 | controller | changed 2026-03-06 02:02:40.307016 | 2026-03-06 02:02:40.307082 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-06 02:02:40.823591 | controller | changed 2026-03-06 02:02:40.830515 | 2026-03-06 02:02:40.830579 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-06 02:02:40.853853 | controller | skipping: Conditional result was False 2026-03-06 02:02:40.865512 | 2026-03-06 02:02:40.865760 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-06 02:02:41.273771 | controller -> localhost | changed 2026-03-06 02:02:41.287663 | 2026-03-06 02:02:41.287771 | TASK [add-build-sshkey : Add back temp key] 2026-03-06 02:02:41.542857 | controller -> localhost | Identity added: /var/lib/zuul/builds/c8031db44c8948ac9e1b874209a976be/work/c8031db44c8948ac9e1b874209a976be_id_rsa (zuul-build-sshkey) 2026-03-06 02:02:41.543054 | controller -> localhost | ok: Runtime: 0:00:00.010077 2026-03-06 02:02:41.546979 | 2026-03-06 02:02:41.547041 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-06 02:02:41.911026 | controller | ok 2026-03-06 02:02:41.917335 | 2026-03-06 02:02:41.917441 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-06 02:02:41.951161 | controller | skipping: Conditional result was False 2026-03-06 02:02:41.964592 | 2026-03-06 02:02:41.964694 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-06 02:02:42.314614 | controller | ok 2026-03-06 02:02:42.324948 | 2026-03-06 02:02:42.325236 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-06 02:02:43.459296 | controller | Output suppressed because no_log was given 2026-03-06 02:02:43.677836 | 2026-03-06 02:02:43.680470 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-06 02:02:43.894237 | controller | ok: "logs" 2026-03-06 02:02:43.894433 | controller | ok: All items complete 2026-03-06 02:02:43.894467 | 2026-03-06 02:02:44.073581 | controller | ok: "artifacts" 2026-03-06 02:02:44.250421 | controller | ok: "docs" 2026-03-06 02:02:44.388043 | 2026-03-06 02:02:44.502765 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-06 02:02:44.707593 | controller | changed: "logs" 2026-03-06 02:02:44.884514 | controller | changed: "artifacts" 2026-03-06 02:02:45.071555 | controller | changed: "docs" 2026-03-06 02:02:45.089978 | 2026-03-06 02:02:45.090139 | PLAY RECAP 2026-03-06 02:02:45.090204 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-03-06 02:02:45.090242 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-06 02:02:45.090270 | 2026-03-06 02:02:45.230386 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-06 02:02:45.238108 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-06 02:02:45.801491 | 2026-03-06 02:02:45.801614 | PLAY [all] 2026-03-06 02:02:45.811616 | 2026-03-06 02:02:45.811696 | TASK [setup-uv : Extract archive] 2026-03-06 02:02:49.258894 | controller | changed 2026-03-06 02:02:49.265206 | 2026-03-06 02:02:49.265305 | TASK [setup-uv : Print version] 2026-03-06 02:02:50.373640 | controller | uv 0.8.13 2026-03-06 02:02:49.818258 | controller | ok: Runtime: 0:00:00.014437 2026-03-06 02:02:49.825102 | 2026-03-06 02:02:49.825180 | PLAY RECAP 2026-03-06 02:02:49.825245 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-06 02:02:49.825280 | 2026-03-06 02:02:49.935308 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-06 02:02:49.937476 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-06 02:02:50.473055 | 2026-03-06 02:02:50.473171 | PLAY [all] 2026-03-06 02:02:50.482569 | 2026-03-06 02:02:50.482662 | TASK [Copy inventory file for Zuul] 2026-03-06 02:02:51.423518 | controller | changed 2026-03-06 02:02:51.429878 | 2026-03-06 02:02:51.429993 | TASK [Switch "ansible_host" to private IP] 2026-03-06 02:02:51.746092 | controller | changed: 1 replacements made 2026-03-06 02:02:51.801512 | 2026-03-06 02:02:51.801783 | TASK [Run Molecule scenario] 2026-03-06 02:02:52.948836 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-03-06 02:02:52.948948 | controller | Creating virtual environment at: .venv 2026-03-06 02:02:53.794654 | controller | Downloading pygments (1.2MiB) 2026-03-06 02:02:53.795082 | controller | Downloading cryptography (4.3MiB) 2026-03-06 02:02:53.800046 | controller | Downloading ansible-core (2.3MiB) 2026-03-06 02:02:54.050090 | controller | Downloading cryptography 2026-03-06 02:02:54.056997 | controller | Downloading pygments 2026-03-06 02:02:54.193213 | controller | Downloading ansible-core 2026-03-06 02:02:54.237710 | controller | Installed 36 packages in 43ms 2026-03-06 02:02:54.889783 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-03-06 02:02:54.889877 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-03-06 02:02:55.740278 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-03-06 02:02:55.740361 | controller | INFO default scenario not found, disabling shared state. 2026-03-06 02:02:55.740405 | controller | INFO [upload-helm-chart > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-03-06 02:02:55.740499 | controller | INFO [upload-helm-chart > prerun] Performing prerun with role_name_check=0... 2026-03-06 02:03:29.547150 | controller | INFO [upload-helm-chart > dependency] Executing 2026-03-06 02:03:29.547291 | controller | WARNING [upload-helm-chart > dependency] Missing roles requirements file: requirements.yml 2026-03-06 02:03:29.547480 | controller | WARNING [upload-helm-chart > dependency] Missing collections requirements file: collections.yml 2026-03-06 02:03:29.547594 | controller | WARNING [upload-helm-chart > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-03-06 02:03:29.552853 | controller | INFO [upload-helm-chart > cleanup] Executing 2026-03-06 02:03:29.553149 | controller | WARNING [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-06 02:03:29.558479 | controller | INFO [upload-helm-chart > destroy] Executing 2026-03-06 02:03:29.558519 | controller | WARNING [upload-helm-chart > destroy] Skipping, '--destroy=never' requested. 2026-03-06 02:03:29.558598 | controller | INFO [upload-helm-chart > destroy] Executed: Successful 2026-03-06 02:03:29.563921 | controller | INFO [upload-helm-chart > syntax] Executing 2026-03-06 02:03:30.430025 | controller | 2026-03-06 02:03:30.430052 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/upload-helm-chart/converge.yml 2026-03-06 02:03:30.487712 | controller | INFO [upload-helm-chart > syntax] Executed: Successful 2026-03-06 02:03:30.499240 | controller | INFO [upload-helm-chart > create] Executing 2026-03-06 02:03:30.500664 | controller | WARNING [upload-helm-chart > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-06 02:03:30.506078 | controller | INFO [upload-helm-chart > prepare] Executing 2026-03-06 02:03:30.506349 | controller | WARNING [upload-helm-chart > prepare] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-06 02:03:30.511570 | controller | INFO [upload-helm-chart > converge] Executing 2026-03-06 02:03:31.364983 | controller | 2026-03-06 02:03:31.365006 | controller | PLAY [Converge] **************************************************************** 2026-03-06 02:03:31.365011 | controller | 2026-03-06 02:03:31.365014 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-06 02:03:31.365019 | controller | Friday 06 March 2026 02:03:31 +0000 (0:00:00.029) 0:00:00.029 ********** 2026-03-06 02:03:32.616259 | 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-06 02:03:32.621937 | controller | ok: [controller] 2026-03-06 02:03:32.622164 | controller | 2026-03-06 02:03:32.622380 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-03-06 02:03:32.622599 | controller | Friday 06 March 2026 02:03:32 +0000 (0:00:01.258) 0:00:01.287 ********** 2026-03-06 02:03:32.707125 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller 2026-03-06 02:03:32.707240 | controller | 2026-03-06 02:03:32.707470 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] *************** 2026-03-06 02:03:32.707663 | controller | Friday 06 March 2026 02:03:32 +0000 (0:00:00.086) 0:00:01.373 ********** 2026-03-06 02:03:33.408193 | controller | changed: [controller] 2026-03-06 02:03:33.408217 | controller | 2026-03-06 02:03:33.408221 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-03-06 02:03:33.408225 | controller | Friday 06 March 2026 02:03:33 +0000 (0:00:00.698) 0:00:02.072 ********** 2026-03-06 02:03:33.451409 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller 2026-03-06 02:03:33.451638 | controller | 2026-03-06 02:03:33.451877 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] ********** 2026-03-06 02:03:33.452072 | controller | Friday 06 March 2026 02:03:33 +0000 (0:00:00.045) 0:00:02.118 ********** 2026-03-06 02:03:33.846262 | controller | changed: [controller] 2026-03-06 02:03:33.846429 | controller | 2026-03-06 02:03:33.846653 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] *** 2026-03-06 02:03:33.846852 | controller | Friday 06 March 2026 02:03:33 +0000 (0:00:00.394) 0:00:02.512 ********** 2026-03-06 02:03:34.932211 | controller | changed: [controller] 2026-03-06 02:03:34.932358 | controller | 2026-03-06 02:03:34.932522 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] ********** 2026-03-06 02:03:34.932647 | controller | Friday 06 March 2026 02:03:34 +0000 (0:00:01.081) 0:00:03.594 ********** 2026-03-06 02:03:35.326030 | controller | ok: [controller] 2026-03-06 02:03:35.326063 | controller | 2026-03-06 02:03:35.326070 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] *** 2026-03-06 02:03:35.326075 | controller | Friday 06 March 2026 02:03:35 +0000 (0:00:00.395) 0:00:03.990 ********** 2026-03-06 02:03:35.386403 | controller | skipping: [controller] 2026-03-06 02:03:35.386576 | controller | 2026-03-06 02:03:35.386756 | controller | PLAY RECAP ********************************************************************* 2026-03-06 02:03:35.386970 | controller | controller : ok=7 changed=3 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-03-06 02:03:35.387147 | controller | 2026-03-06 02:03:35.387319 | controller | 2026-03-06 02:03:35.387512 | controller | TASKS RECAP ******************************************************************** 2026-03-06 02:03:35.387699 | controller | Friday 06 March 2026 02:03:35 +0000 (0:00:00.063) 0:00:04.053 ********** 2026-03-06 02:03:35.387884 | controller | =============================================================================== 2026-03-06 02:03:35.388071 | controller | Gathering Facts --------------------------------------------------------- 1.26s 2026-03-06 02:03:35.388270 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.08s 2026-03-06 02:03:35.388467 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.70s 2026-03-06 02:03:35.388663 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.40s 2026-03-06 02:03:35.388848 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.39s 2026-03-06 02:03:35.389049 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.09s 2026-03-06 02:03:35.389247 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.06s 2026-03-06 02:03:35.389482 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s 2026-03-06 02:03:35.513307 | controller | INFO [upload-helm-chart > converge] Executed: Successful 2026-03-06 02:03:35.524821 | controller | INFO [upload-helm-chart > idempotence] Executing 2026-03-06 02:03:36.338674 | controller | 2026-03-06 02:03:36.338907 | controller | PLAY [Converge] **************************************************************** 2026-03-06 02:03:36.339160 | controller | 2026-03-06 02:03:36.339368 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-06 02:03:36.339569 | controller | Friday 06 March 2026 02:03:36 +0000 (0:00:00.010) 0:00:00.010 ********** 2026-03-06 02:03:37.413054 | 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-06 02:03:37.418074 | controller | ok: [controller] 2026-03-06 02:03:37.418252 | controller | 2026-03-06 02:03:37.418452 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-03-06 02:03:37.418642 | controller | Friday 06 March 2026 02:03:37 +0000 (0:00:01.079) 0:00:01.090 ********** 2026-03-06 02:03:37.488927 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller 2026-03-06 02:03:37.489104 | controller | 2026-03-06 02:03:37.489335 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] *************** 2026-03-06 02:03:37.489536 | controller | Friday 06 March 2026 02:03:37 +0000 (0:00:00.070) 0:00:01.161 ********** 2026-03-06 02:03:38.229788 | controller | ok: [controller] 2026-03-06 02:03:38.229844 | controller | 2026-03-06 02:03:38.230063 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-03-06 02:03:38.230175 | controller | Friday 06 March 2026 02:03:38 +0000 (0:00:00.740) 0:00:01.901 ********** 2026-03-06 02:03:38.274742 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller 2026-03-06 02:03:38.274912 | controller | 2026-03-06 02:03:38.275109 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] ********** 2026-03-06 02:03:38.275301 | controller | Friday 06 March 2026 02:03:38 +0000 (0:00:00.045) 0:00:01.946 ********** 2026-03-06 02:03:38.682048 | controller | ok: [controller] 2026-03-06 02:03:38.682191 | controller | 2026-03-06 02:03:38.682398 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] *** 2026-03-06 02:03:38.682590 | controller | Friday 06 March 2026 02:03:38 +0000 (0:00:00.406) 0:00:02.353 ********** 2026-03-06 02:03:39.751999 | controller | ok: [controller] 2026-03-06 02:03:39.752053 | controller | 2026-03-06 02:03:39.752233 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] ********** 2026-03-06 02:03:39.752334 | controller | Friday 06 March 2026 02:03:39 +0000 (0:00:01.070) 0:00:03.423 ********** 2026-03-06 02:03:40.135489 | controller | ok: [controller] 2026-03-06 02:03:40.135581 | controller | 2026-03-06 02:03:40.135729 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] *** 2026-03-06 02:03:40.135853 | controller | Friday 06 March 2026 02:03:40 +0000 (0:00:00.383) 0:00:03.807 ********** 2026-03-06 02:03:40.180347 | controller | skipping: [controller] 2026-03-06 02:03:40.180519 | controller | 2026-03-06 02:03:40.180701 | controller | PLAY RECAP ********************************************************************* 2026-03-06 02:03:40.180897 | controller | controller : ok=7 changed=0 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-03-06 02:03:40.181055 | controller | 2026-03-06 02:03:40.181210 | controller | 2026-03-06 02:03:40.181345 | controller | TASKS RECAP ******************************************************************** 2026-03-06 02:03:40.181463 | controller | Friday 06 March 2026 02:03:40 +0000 (0:00:00.045) 0:00:03.853 ********** 2026-03-06 02:03:40.181573 | controller | =============================================================================== 2026-03-06 02:03:40.181691 | controller | Gathering Facts --------------------------------------------------------- 1.08s 2026-03-06 02:03:40.181815 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.07s 2026-03-06 02:03:40.181932 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.74s 2026-03-06 02:03:40.182082 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.41s 2026-03-06 02:03:40.182201 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.38s 2026-03-06 02:03:40.182327 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.07s 2026-03-06 02:03:40.182449 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.05s 2026-03-06 02:03:40.182570 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s 2026-03-06 02:03:40.290609 | controller | INFO [upload-helm-chart > idempotence] Executed: Successful 2026-03-06 02:03:40.298885 | controller | INFO [upload-helm-chart > side_effect] Executing 2026-03-06 02:03:41.152894 | controller | 2026-03-06 02:03:41.153031 | controller | PLAY [Side effect] ************************************************************* 2026-03-06 02:03:41.153203 | controller | 2026-03-06 02:03:41.153397 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-06 02:03:41.153588 | controller | Friday 06 March 2026 02:03:41 +0000 (0:00:00.011) 0:00:00.011 ********** 2026-03-06 02:03:42.208615 | 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-06 02:03:42.214776 | controller | ok: [controller] 2026-03-06 02:03:42.214806 | controller | 2026-03-06 02:03:42.214975 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-03-06 02:03:42.215033 | controller | Friday 06 March 2026 02:03:42 +0000 (0:00:01.062) 0:00:01.073 ********** 2026-03-06 02:03:42.291083 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller 2026-03-06 02:03:42.291135 | controller | 2026-03-06 02:03:42.291154 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] *************** 2026-03-06 02:03:42.291286 | controller | Friday 06 March 2026 02:03:42 +0000 (0:00:00.076) 0:00:01.150 ********** 2026-03-06 02:03:42.998034 | controller | changed: [controller] 2026-03-06 02:03:42.998242 | controller | 2026-03-06 02:03:42.998420 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-03-06 02:03:42.998614 | controller | Friday 06 March 2026 02:03:42 +0000 (0:00:00.706) 0:00:01.856 ********** 2026-03-06 02:03:43.042381 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller 2026-03-06 02:03:43.042496 | controller | 2026-03-06 02:03:43.042746 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] ********** 2026-03-06 02:03:43.042888 | controller | Friday 06 March 2026 02:03:43 +0000 (0:00:00.045) 0:00:01.901 ********** 2026-03-06 02:03:43.449849 | controller | ok: [controller] 2026-03-06 02:03:43.449884 | controller | 2026-03-06 02:03:43.449890 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] *** 2026-03-06 02:03:43.449895 | controller | Friday 06 March 2026 02:03:43 +0000 (0:00:00.405) 0:00:02.307 ********** 2026-03-06 02:03:44.553346 | controller | ok: [controller] 2026-03-06 02:03:44.553402 | controller | 2026-03-06 02:03:44.553415 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] ********** 2026-03-06 02:03:44.553517 | controller | Friday 06 March 2026 02:03:44 +0000 (0:00:01.104) 0:00:03.411 ********** 2026-03-06 02:03:44.933793 | controller | ok: [controller] 2026-03-06 02:03:44.933848 | controller | 2026-03-06 02:03:44.933919 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] *** 2026-03-06 02:03:44.934078 | controller | Friday 06 March 2026 02:03:44 +0000 (0:00:00.380) 0:00:03.792 ********** 2026-03-06 02:03:45.253694 | controller | changed: [controller] => (item=/file) 2026-03-06 02:03:45.253734 | controller | 2026-03-06 02:03:45.253744 | controller | PLAY RECAP ********************************************************************* 2026-03-06 02:03:45.253753 | controller | controller : ok=8 changed=2 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-06 02:03:45.253760 | controller | 2026-03-06 02:03:45.253768 | controller | 2026-03-06 02:03:45.253775 | controller | TASKS RECAP ******************************************************************** 2026-03-06 02:03:45.253796 | controller | Friday 06 March 2026 02:03:45 +0000 (0:00:00.313) 0:00:04.105 ********** 2026-03-06 02:03:45.253804 | controller | =============================================================================== 2026-03-06 02:03:45.253811 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.10s 2026-03-06 02:03:45.253819 | controller | Gathering Facts --------------------------------------------------------- 1.06s 2026-03-06 02:03:45.253826 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.71s 2026-03-06 02:03:45.253834 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.41s 2026-03-06 02:03:45.253841 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.38s 2026-03-06 02:03:45.253849 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.31s 2026-03-06 02:03:45.253857 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.08s 2026-03-06 02:03:45.253864 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s 2026-03-06 02:03:45.351757 | controller | INFO [upload-helm-chart > side_effect] Executed: Successful 2026-03-06 02:03:45.361424 | controller | INFO [upload-helm-chart > verify] Executing 2026-03-06 02:03:46.158921 | controller | 2026-03-06 02:03:46.159206 | controller | PLAY [Verify] ****************************************************************** 2026-03-06 02:03:46.159438 | controller | 2026-03-06 02:03:46.159685 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-06 02:03:46.159978 | controller | Friday 06 March 2026 02:03:46 +0000 (0:00:00.010) 0:00:00.010 ********** 2026-03-06 02:03:47.263010 | 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-06 02:03:47.270285 | controller | ok: [controller] 2026-03-06 02:03:47.270534 | controller | 2026-03-06 02:03:47.270785 | controller | TASK [Stat file 1] ************************************************************* 2026-03-06 02:03:47.271034 | controller | Friday 06 March 2026 02:03:47 +0000 (0:00:01.110) 0:00:01.120 ********** 2026-03-06 02:03:47.669613 | controller | ok: [controller] 2026-03-06 02:03:47.669927 | controller | 2026-03-06 02:03:47.670247 | controller | TASK [Stat file 2] ************************************************************* 2026-03-06 02:03:47.670510 | controller | Friday 06 March 2026 02:03:47 +0000 (0:00:00.398) 0:00:01.519 ********** 2026-03-06 02:03:47.950660 | controller | ok: [controller] 2026-03-06 02:03:47.950955 | controller | 2026-03-06 02:03:47.951218 | controller | TASK [Stat removed file 1] ***************************************************** 2026-03-06 02:03:47.951479 | controller | Friday 06 March 2026 02:03:47 +0000 (0:00:00.281) 0:00:01.800 ********** 2026-03-06 02:03:48.226075 | controller | ok: [controller] 2026-03-06 02:03:48.226396 | controller | 2026-03-06 02:03:48.226660 | controller | TASK [Stat removed file 2] ***************************************************** 2026-03-06 02:03:48.226941 | controller | Friday 06 March 2026 02:03:48 +0000 (0:00:00.275) 0:00:02.076 ********** 2026-03-06 02:03:48.515301 | controller | ok: [controller] 2026-03-06 02:03:48.515605 | controller | 2026-03-06 02:03:48.515877 | controller | TASK [ansible.builtin.assert] ************************************************** 2026-03-06 02:03:48.516137 | controller | Friday 06 March 2026 02:03:48 +0000 (0:00:00.289) 0:00:02.365 ********** 2026-03-06 02:03:48.546106 | controller | ok: [controller] => { 2026-03-06 02:03:48.546410 | controller | "changed": false, 2026-03-06 02:03:48.546668 | controller | "msg": "All assertions passed" 2026-03-06 02:03:48.546913 | controller | } 2026-03-06 02:03:48.547143 | controller | 2026-03-06 02:03:48.547387 | controller | PLAY RECAP ********************************************************************* 2026-03-06 02:03:48.547657 | controller | controller : ok=6 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-06 02:03:48.547887 | controller | 2026-03-06 02:03:48.548133 | controller | 2026-03-06 02:03:48.548379 | controller | TASKS RECAP ******************************************************************** 2026-03-06 02:03:48.548627 | controller | Friday 06 March 2026 02:03:48 +0000 (0:00:00.031) 0:00:02.397 ********** 2026-03-06 02:03:48.548863 | controller | =============================================================================== 2026-03-06 02:03:48.549106 | controller | Gathering Facts --------------------------------------------------------- 1.11s 2026-03-06 02:03:48.549348 | controller | Stat file 1 ------------------------------------------------------------- 0.40s 2026-03-06 02:03:48.549592 | controller | Stat removed file 2 ----------------------------------------------------- 0.29s 2026-03-06 02:03:48.549870 | controller | Stat file 2 ------------------------------------------------------------- 0.28s 2026-03-06 02:03:48.550170 | controller | Stat removed file 1 ----------------------------------------------------- 0.28s 2026-03-06 02:03:48.550474 | controller | ansible.builtin.assert -------------------------------------------------- 0.03s 2026-03-06 02:03:48.648821 | controller | INFO [upload-helm-chart > verify] Executed: Successful 2026-03-06 02:03:48.659687 | controller | INFO [upload-helm-chart > cleanup] Executing 2026-03-06 02:03:48.660163 | controller | WARNING [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-06 02:03:48.666403 | controller | INFO [upload-helm-chart > destroy] Executing 2026-03-06 02:03:48.666513 | controller | WARNING [upload-helm-chart > destroy] Skipping, '--destroy=never' requested. 2026-03-06 02:03:48.666630 | controller | INFO [upload-helm-chart > destroy] Executed: Successful 2026-03-06 02:03:48.666928 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-03-06 02:03:48.495509 | controller | ok: Runtime: 0:00:55.882453 2026-03-06 02:03:48.500589 | 2026-03-06 02:03:48.500661 | PLAY RECAP 2026-03-06 02:03:48.500727 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-06 02:03:48.500758 | 2026-03-06 02:03:48.648747 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-06 02:03:48.654816 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-06 02:03:49.198819 | 2026-03-06 02:03:49.198952 | PLAY [all] 2026-03-06 02:03:49.209018 | 2026-03-06 02:03:49.209091 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-06 02:03:49.254480 | controller | skipping: Conditional result was False 2026-03-06 02:03:49.262296 | 2026-03-06 02:03:49.262421 | TASK [fetch-output : Set log path for single node] 2026-03-06 02:03:49.306849 | controller | ok 2026-03-06 02:03:49.312288 | 2026-03-06 02:03:49.312397 | LOOP [fetch-output : Ensure local output dirs] 2026-03-06 02:03:49.694798 | controller -> localhost | ok: "/var/lib/zuul/builds/c8031db44c8948ac9e1b874209a976be/work/logs" 2026-03-06 02:03:49.924581 | controller -> localhost | changed: "/var/lib/zuul/builds/c8031db44c8948ac9e1b874209a976be/work/artifacts" 2026-03-06 02:03:50.135789 | controller -> localhost | changed: "/var/lib/zuul/builds/c8031db44c8948ac9e1b874209a976be/work/docs" 2026-03-06 02:03:50.149847 | 2026-03-06 02:03:50.149988 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-06 02:03:50.825600 | controller | ok 2026-03-06 02:03:50.826011 | controller | changed: All items complete 2026-03-06 02:03:50.826137 | 2026-03-06 02:03:51.305812 | controller | changed: .d..t...... ./ 2026-03-06 02:03:51.794324 | controller | changed: .d..t...... ./ 2026-03-06 02:03:51.809717 | 2026-03-06 02:03:51.809848 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-06 02:03:52.192081 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.006960 2026-03-06 02:03:52.410469 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.006411 2026-03-06 02:03:52.424176 | 2026-03-06 02:03:52.424304 | PLAY [all] 2026-03-06 02:03:52.430859 | 2026-03-06 02:03:52.430943 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-06 02:03:52.867791 | controller | changed 2026-03-06 02:03:52.874197 | 2026-03-06 02:03:52.874256 | PLAY RECAP 2026-03-06 02:03:52.874314 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-06 02:03:52.874352 | 2026-03-06 02:03:53.017576 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-06 02:03:53.020134 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-06 02:03:53.594616 | 2026-03-06 02:03:53.594765 | PLAY [localhost] 2026-03-06 02:03:53.605044 | 2026-03-06 02:03:53.605117 | TASK [Generate Zuul manifest] 2026-03-06 02:03:53.628370 | localhost | ok 2026-03-06 02:03:53.646860 | 2026-03-06 02:03:53.646941 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-06 02:03:53.974383 | localhost | changed 2026-03-06 02:03:53.984759 | 2026-03-06 02:03:53.984838 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-06 02:03:54.016839 | localhost | ok 2026-03-06 02:03:54.025912 | 2026-03-06 02:03:54.025977 | TASK [Upload logs] 2026-03-06 02:03:54.045262 | localhost | ok 2026-03-06 02:03:54.106788 | 2026-03-06 02:03:54.106903 | TASK [Set zuul-log-path fact] 2026-03-06 02:03:54.127871 | localhost | ok 2026-03-06 02:03:54.139626 | 2026-03-06 02:03:54.139691 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-06 02:03:54.172841 | localhost | ok 2026-03-06 02:03:54.181569 | 2026-03-06 02:03:54.181631 | TASK [upload-logs : Create log directories] 2026-03-06 02:03:54.599524 | localhost | changed 2026-03-06 02:03:54.606643 | 2026-03-06 02:03:54.606747 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-06 02:03:54.993828 | localhost -> localhost | ok: Runtime: 0:00:00.005631 2026-03-06 02:03:55.000235 | 2026-03-06 02:03:55.000305 | TASK [upload-logs : Upload logs to log server] 2026-03-06 02:03:55.467165 | localhost | Output suppressed because no_log was given 2026-03-06 02:03:55.472075 | 2026-03-06 02:03:55.472164 | LOOP [upload-logs : Compress console log and json output] 2026-03-06 02:03:55.519266 | localhost | skipping: Conditional result was False 2026-03-06 02:03:55.525934 | localhost | skipping: Conditional result was False 2026-03-06 02:03:55.539446 | 2026-03-06 02:03:55.539637 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-06 02:03:55.584301 | localhost | skipping: Conditional result was False 2026-03-06 02:03:55.584761 | 2026-03-06 02:03:55.588351 | localhost | skipping: Conditional result was False 2026-03-06 02:03:55.604986 | 2026-03-06 02:03:55.605221 | LOOP [upload-logs : Upload console log and json output]