2026-03-31 00:17:07.112716 | Job console starting 2026-03-31 00:17:07.123046 | Updating git repos 2026-03-31 00:17:07.247041 | Cloning repos into workspace 2026-03-31 00:17:07.302222 | Restoring repo states 2026-03-31 00:17:07.314049 | Merging changes 2026-03-31 00:17:07.884949 | Checking out repos 2026-03-31 00:17:08.082221 | Preparing playbooks 2026-03-31 00:17:11.080692 | Running Ansible setup 2026-03-31 00:17:14.832246 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-31 00:17:15.426480 | 2026-03-31 00:17:15.426619 | PLAY [localhost] 2026-03-31 00:17:15.434166 | 2026-03-31 00:17:15.434235 | TASK [Gathering Facts] 2026-03-31 00:17:16.348200 | localhost | ok 2026-03-31 00:17:16.355827 | 2026-03-31 00:17:16.355907 | TASK [Setup log path fact] 2026-03-31 00:17:16.389335 | localhost | ok 2026-03-31 00:17:16.402746 | 2026-03-31 00:17:16.402816 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-31 00:17:16.432273 | localhost | ok 2026-03-31 00:17:16.440711 | 2026-03-31 00:17:16.441226 | TASK [emit-job-header : Print job information] 2026-03-31 00:17:16.490885 | # Job Information 2026-03-31 00:17:16.491052 | Ansible Version: 2.16.16 2026-03-31 00:17:16.491086 | Job: ansible-collection-kubernetes-molecule-upload-helm-chart 2026-03-31 00:17:16.491109 | Pipeline: check 2026-03-31 00:17:16.491130 | Executor: 0a8996d2b663 2026-03-31 00:17:16.491150 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/256 2026-03-31 00:17:16.491174 | Event ID: d453e320-2c96-11f1-911f-48ee5da28f41 2026-03-31 00:17:16.495216 | 2026-03-31 00:17:16.495286 | LOOP [emit-job-header : Print node information] 2026-03-31 00:17:16.587708 | localhost | ok: 2026-03-31 00:17:16.587982 | localhost | # Node Information 2026-03-31 00:17:16.588034 | localhost | Inventory Hostname: controller 2026-03-31 00:17:16.588067 | localhost | Hostname: np0000161771 2026-03-31 00:17:16.588097 | localhost | Username: zuul 2026-03-31 00:17:16.588131 | localhost | Distro: Debian 13.4 2026-03-31 00:17:16.588161 | localhost | Provider: yul1 2026-03-31 00:17:16.588189 | localhost | Region: ca-ymq-1 2026-03-31 00:17:16.588216 | localhost | Label: debian-trixie 2026-03-31 00:17:16.588244 | localhost | Product Name: OpenStack Nova 2026-03-31 00:17:16.588271 | localhost | Interface IP: 162.253.55.62 2026-03-31 00:17:16.602101 | 2026-03-31 00:17:16.602227 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-31 00:17:16.993342 | localhost -> localhost | changed 2026-03-31 00:17:16.999351 | 2026-03-31 00:17:16.999427 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-31 00:17:17.932344 | localhost -> localhost | changed 2026-03-31 00:17:17.941777 | 2026-03-31 00:17:17.941853 | PLAY [all] 2026-03-31 00:17:17.950133 | 2026-03-31 00:17:17.950198 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-31 00:17:18.167695 | controller -> localhost | ok 2026-03-31 00:17:18.176192 | 2026-03-31 00:17:18.176258 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-31 00:17:18.204540 | controller | ok 2026-03-31 00:17:18.223822 | controller | included: /var/lib/zuul/builds/8d5512126d33406c9ae33e0a83f3cae6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-31 00:17:18.228434 | 2026-03-31 00:17:18.228498 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-31 00:17:20.376159 | controller -> localhost | Generating public/private rsa key pair. 2026-03-31 00:17:20.376469 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/8d5512126d33406c9ae33e0a83f3cae6/work/8d5512126d33406c9ae33e0a83f3cae6_id_rsa 2026-03-31 00:17:20.376527 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/8d5512126d33406c9ae33e0a83f3cae6/work/8d5512126d33406c9ae33e0a83f3cae6_id_rsa.pub 2026-03-31 00:17:20.376577 | controller -> localhost | The key fingerprint is: 2026-03-31 00:17:20.376613 | controller -> localhost | SHA256:VSCplFGe3yA3qj9spSeyEhj5j8rwMK7ziq1sl1bbuEY zuul-build-sshkey 2026-03-31 00:17:20.376661 | controller -> localhost | The key's randomart image is: 2026-03-31 00:17:20.376695 | controller -> localhost | +---[RSA 3072]----+ 2026-03-31 00:17:20.376736 | controller -> localhost | | .+o.... | 2026-03-31 00:17:20.376768 | controller -> localhost | | o..o . | 2026-03-31 00:17:20.376798 | controller -> localhost | | . . .+ = | 2026-03-31 00:17:20.376830 | controller -> localhost | | o . * + | 2026-03-31 00:17:20.376860 | controller -> localhost | | + S . . | 2026-03-31 00:17:20.376891 | controller -> localhost | | . oE . . | 2026-03-31 00:17:20.376920 | controller -> localhost | |+ ++=. o | 2026-03-31 00:17:20.376987 | controller -> localhost | |=O +o+oo* . | 2026-03-31 00:17:20.377035 | controller -> localhost | |BBO..oo+.+ | 2026-03-31 00:17:20.377068 | controller -> localhost | +----[SHA256]-----+ 2026-03-31 00:17:20.377140 | controller -> localhost | ok: Runtime: 0:00:01.738523 2026-03-31 00:17:20.384088 | 2026-03-31 00:17:20.384198 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-31 00:17:20.417593 | controller | ok 2026-03-31 00:17:20.428291 | controller | included: /var/lib/zuul/builds/8d5512126d33406c9ae33e0a83f3cae6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-31 00:17:20.436011 | 2026-03-31 00:17:20.436079 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-31 00:17:20.461033 | controller | skipping: Conditional result was False 2026-03-31 00:17:20.478508 | 2026-03-31 00:17:20.478677 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-31 00:17:21.152250 | controller | changed 2026-03-31 00:17:21.158448 | 2026-03-31 00:17:21.158510 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-31 00:17:21.363365 | controller | ok 2026-03-31 00:17:21.369719 | 2026-03-31 00:17:21.380487 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-31 00:17:21.943837 | controller | changed 2026-03-31 00:17:21.948025 | 2026-03-31 00:17:21.948094 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-31 00:17:22.467558 | controller | changed 2026-03-31 00:17:22.509031 | 2026-03-31 00:17:22.509184 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-31 00:17:22.536852 | controller | skipping: Conditional result was False 2026-03-31 00:17:22.545118 | 2026-03-31 00:17:22.545253 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-31 00:17:22.996821 | controller -> localhost | changed 2026-03-31 00:17:23.009516 | 2026-03-31 00:17:23.009590 | TASK [add-build-sshkey : Add back temp key] 2026-03-31 00:17:23.345638 | controller -> localhost | Identity added: /var/lib/zuul/builds/8d5512126d33406c9ae33e0a83f3cae6/work/8d5512126d33406c9ae33e0a83f3cae6_id_rsa (zuul-build-sshkey) 2026-03-31 00:17:23.346272 | controller -> localhost | ok: Runtime: 0:00:00.015276 2026-03-31 00:17:23.350375 | 2026-03-31 00:17:23.350435 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-31 00:17:23.717584 | controller | ok 2026-03-31 00:17:23.725943 | 2026-03-31 00:17:23.726083 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-31 00:17:23.751594 | controller | skipping: Conditional result was False 2026-03-31 00:17:23.768441 | 2026-03-31 00:17:23.768507 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-31 00:17:24.115467 | controller | ok 2026-03-31 00:17:24.121473 | 2026-03-31 00:17:24.121538 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-31 00:17:25.135670 | controller | Output suppressed because no_log was given 2026-03-31 00:17:25.142645 | 2026-03-31 00:17:25.142753 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-31 00:17:25.357144 | controller | ok: "logs" 2026-03-31 00:17:25.357441 | controller | ok: All items complete 2026-03-31 00:17:25.357499 | 2026-03-31 00:17:25.535714 | controller | ok: "artifacts" 2026-03-31 00:17:25.739788 | controller | ok: "docs" 2026-03-31 00:17:25.759567 | 2026-03-31 00:17:25.759751 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-31 00:17:25.968163 | controller | changed: "logs" 2026-03-31 00:17:26.162993 | controller | changed: "artifacts" 2026-03-31 00:17:26.351003 | controller | changed: "docs" 2026-03-31 00:17:26.363318 | 2026-03-31 00:17:26.363467 | PLAY RECAP 2026-03-31 00:17:26.363532 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-03-31 00:17:26.363572 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-31 00:17:26.363604 | 2026-03-31 00:17:26.509293 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-03-31 00:17:26.510710 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-31 00:17:27.105170 | 2026-03-31 00:17:27.105283 | PLAY [all] 2026-03-31 00:17:27.115399 | 2026-03-31 00:17:27.115475 | TASK [setup-uv : Extract archive] 2026-03-31 00:17:29.532898 | controller | changed 2026-03-31 00:17:29.539319 | 2026-03-31 00:17:29.539401 | TASK [setup-uv : Print version] 2026-03-31 00:17:29.947489 | controller | uv 0.8.13 2026-03-31 00:17:30.068634 | controller | ok: Runtime: 0:00:00.010413 2026-03-31 00:17:30.076616 | 2026-03-31 00:17:30.076689 | PLAY RECAP 2026-03-31 00:17:30.076750 | controller | ok: 2 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-31 00:17:30.076784 | 2026-03-31 00:17:30.226150 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-03-31 00:17:30.228769 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-31 00:17:30.833650 | 2026-03-31 00:17:30.833790 | PLAY [all] 2026-03-31 00:17:30.844102 | 2026-03-31 00:17:30.844187 | TASK [Update apt cache] 2026-03-31 00:17:35.519476 | controller | ok 2026-03-31 00:17:35.526476 | 2026-03-31 00:17:35.526582 | TASK [Disable firewalld] 2026-03-31 00:17:35.552881 | controller | skipping: Conditional result was False 2026-03-31 00:17:35.562012 | 2026-03-31 00:17:35.562363 | TASK [Install "jq" for log collection] 2026-03-31 00:17:37.745432 | controller | changed 2026-03-31 00:17:37.748327 | 2026-03-31 00:17:37.748398 | PLAY RECAP 2026-03-31 00:17:37.748478 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-31 00:17:37.748511 | 2026-03-31 00:17:37.881783 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-03-31 00:17:37.884453 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-31 00:17:38.449081 | 2026-03-31 00:17:38.449228 | PLAY [all] 2026-03-31 00:17:38.459161 | 2026-03-31 00:17:38.459234 | TASK [Copy inventory file for Zuul] 2026-03-31 00:17:39.403580 | controller | changed 2026-03-31 00:17:39.409316 | 2026-03-31 00:17:39.409394 | TASK [Switch "ansible_host" to private IP] 2026-03-31 00:17:39.692459 | controller | changed: 1 replacements made 2026-03-31 00:17:39.698718 | 2026-03-31 00:17:39.698813 | TASK [Run Molecule scenario] 2026-03-31 00:17:40.189909 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-03-31 00:17:40.190018 | controller | Creating virtual environment at: .venv 2026-03-31 00:17:40.721084 | controller | Downloading cryptography (4.3MiB) 2026-03-31 00:17:40.723005 | controller | Downloading pygments (1.2MiB) 2026-03-31 00:17:40.723182 | controller | Downloading ansible-core (2.3MiB) 2026-03-31 00:17:40.886183 | controller | Downloading cryptography 2026-03-31 00:17:40.939317 | controller | Downloading pygments 2026-03-31 00:17:41.150144 | controller | Downloading ansible-core 2026-03-31 00:17:41.199413 | controller | Installed 36 packages in 51ms 2026-03-31 00:17:41.894476 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-03-31 00:17:41.894560 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-03-31 00:17:42.769618 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-03-31 00:17:42.769699 | controller | INFO default scenario not found, disabling shared state. 2026-03-31 00:17:42.769723 | controller | INFO [upload-helm-chart > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-03-31 00:17:42.769815 | controller | INFO [upload-helm-chart > prerun] Performing prerun with role_name_check=0... 2026-03-31 00:18:00.642386 | controller | INFO [upload-helm-chart > dependency] Executing 2026-03-31 00:18:00.642479 | controller | WARNING [upload-helm-chart > dependency] Missing roles requirements file: requirements.yml 2026-03-31 00:18:00.642489 | controller | WARNING [upload-helm-chart > dependency] Missing collections requirements file: collections.yml 2026-03-31 00:18:00.642519 | controller | WARNING [upload-helm-chart > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-03-31 00:18:00.646589 | controller | INFO [upload-helm-chart > cleanup] Executing 2026-03-31 00:18:00.646953 | controller | WARNING [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-31 00:18:00.652792 | controller | INFO [upload-helm-chart > destroy] Executing 2026-03-31 00:18:00.652868 | controller | WARNING [upload-helm-chart > destroy] Skipping, '--destroy=never' requested. 2026-03-31 00:18:00.652939 | controller | INFO [upload-helm-chart > destroy] Executed: Successful 2026-03-31 00:18:00.658228 | controller | INFO [upload-helm-chart > syntax] Executing 2026-03-31 00:18:01.504518 | controller | 2026-03-31 00:18:01.504617 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/upload-helm-chart/converge.yml 2026-03-31 00:18:01.569554 | controller | INFO [upload-helm-chart > syntax] Executed: Successful 2026-03-31 00:18:01.580237 | controller | INFO [upload-helm-chart > create] Executing 2026-03-31 00:18:01.581800 | controller | WARNING [upload-helm-chart > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-31 00:18:01.587033 | controller | INFO [upload-helm-chart > prepare] Executing 2026-03-31 00:18:01.587309 | controller | WARNING [upload-helm-chart > prepare] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-31 00:18:01.592505 | controller | INFO [upload-helm-chart > converge] Executing 2026-03-31 00:18:02.455358 | controller | 2026-03-31 00:18:02.455417 | controller | PLAY [Converge] **************************************************************** 2026-03-31 00:18:02.455422 | controller | 2026-03-31 00:18:02.455426 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-31 00:18:02.455432 | controller | Tuesday 31 March 2026 00:18:02 +0000 (0:00:00.029) 0:00:00.029 ********* 2026-03-31 00:18:03.723052 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-31 00:18:03.729295 | controller | ok: [controller] 2026-03-31 00:18:03.729478 | controller | 2026-03-31 00:18:03.729682 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-03-31 00:18:03.729880 | controller | Tuesday 31 March 2026 00:18:03 +0000 (0:00:01.277) 0:00:01.307 ********* 2026-03-31 00:18:03.812123 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller 2026-03-31 00:18:03.812295 | controller | 2026-03-31 00:18:03.812495 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] *************** 2026-03-31 00:18:03.812684 | controller | Tuesday 31 March 2026 00:18:03 +0000 (0:00:00.082) 0:00:01.390 ********* 2026-03-31 00:18:04.539328 | controller | changed: [controller] 2026-03-31 00:18:04.539633 | controller | 2026-03-31 00:18:04.539867 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-03-31 00:18:04.540096 | controller | Tuesday 31 March 2026 00:18:04 +0000 (0:00:00.726) 0:00:02.116 ********* 2026-03-31 00:18:04.585210 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller 2026-03-31 00:18:04.585403 | controller | 2026-03-31 00:18:04.585618 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] ********** 2026-03-31 00:18:04.585844 | controller | Tuesday 31 March 2026 00:18:04 +0000 (0:00:00.046) 0:00:02.163 ********* 2026-03-31 00:18:05.056535 | controller | changed: [controller] 2026-03-31 00:18:05.056687 | controller | 2026-03-31 00:18:05.056909 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] *** 2026-03-31 00:18:05.057102 | controller | Tuesday 31 March 2026 00:18:05 +0000 (0:00:00.470) 0:00:02.633 ********* 2026-03-31 00:18:06.172137 | controller | changed: [controller] 2026-03-31 00:18:06.172222 | controller | 2026-03-31 00:18:06.172235 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] ********** 2026-03-31 00:18:06.172340 | controller | Tuesday 31 March 2026 00:18:06 +0000 (0:00:01.112) 0:00:03.746 ********* 2026-03-31 00:18:06.600789 | controller | ok: [controller] 2026-03-31 00:18:06.600902 | controller | 2026-03-31 00:18:06.601119 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] *** 2026-03-31 00:18:06.601309 | controller | Tuesday 31 March 2026 00:18:06 +0000 (0:00:00.431) 0:00:04.178 ********* 2026-03-31 00:18:06.653512 | controller | skipping: [controller] 2026-03-31 00:18:06.653657 | controller | 2026-03-31 00:18:06.653847 | controller | PLAY RECAP ********************************************************************* 2026-03-31 00:18:06.654076 | controller | controller : ok=7 changed=3 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-03-31 00:18:06.654232 | controller | 2026-03-31 00:18:06.654391 | controller | 2026-03-31 00:18:06.654563 | controller | TASKS RECAP ******************************************************************** 2026-03-31 00:18:06.654751 | controller | Tuesday 31 March 2026 00:18:06 +0000 (0:00:00.053) 0:00:04.231 ********* 2026-03-31 00:18:06.654925 | controller | =============================================================================== 2026-03-31 00:18:06.655108 | controller | Gathering Facts --------------------------------------------------------- 1.28s 2026-03-31 00:18:06.655301 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.11s 2026-03-31 00:18:06.655548 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.73s 2026-03-31 00:18:06.655804 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.47s 2026-03-31 00:18:06.655971 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.43s 2026-03-31 00:18:06.656164 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.08s 2026-03-31 00:18:06.656356 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.05s 2026-03-31 00:18:06.656547 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s 2026-03-31 00:18:06.758173 | controller | INFO [upload-helm-chart > converge] Executed: Successful 2026-03-31 00:18:06.766729 | controller | INFO [upload-helm-chart > idempotence] Executing 2026-03-31 00:18:07.581693 | controller | 2026-03-31 00:18:07.581858 | controller | PLAY [Converge] **************************************************************** 2026-03-31 00:18:07.582008 | controller | 2026-03-31 00:18:07.582203 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-31 00:18:07.582400 | controller | Tuesday 31 March 2026 00:18:07 +0000 (0:00:00.010) 0:00:00.010 ********* 2026-03-31 00:18:08.635090 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-31 00:18:08.640796 | controller | ok: [controller] 2026-03-31 00:18:08.640977 | controller | 2026-03-31 00:18:08.641188 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-03-31 00:18:08.641402 | controller | Tuesday 31 March 2026 00:18:08 +0000 (0:00:01.058) 0:00:01.069 ********* 2026-03-31 00:18:08.712686 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller 2026-03-31 00:18:08.712830 | controller | 2026-03-31 00:18:08.713037 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] *************** 2026-03-31 00:18:08.713239 | controller | Tuesday 31 March 2026 00:18:08 +0000 (0:00:00.071) 0:00:01.141 ********* 2026-03-31 00:18:09.441503 | controller | ok: [controller] 2026-03-31 00:18:09.441648 | controller | 2026-03-31 00:18:09.441882 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-03-31 00:18:09.442099 | controller | Tuesday 31 March 2026 00:18:09 +0000 (0:00:00.728) 0:00:01.869 ********* 2026-03-31 00:18:09.486560 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller 2026-03-31 00:18:09.486780 | controller | 2026-03-31 00:18:09.487018 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] ********** 2026-03-31 00:18:09.487220 | controller | Tuesday 31 March 2026 00:18:09 +0000 (0:00:00.045) 0:00:01.915 ********* 2026-03-31 00:18:09.896256 | controller | ok: [controller] 2026-03-31 00:18:09.896425 | controller | 2026-03-31 00:18:09.896669 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] *** 2026-03-31 00:18:09.896881 | controller | Tuesday 31 March 2026 00:18:09 +0000 (0:00:00.408) 0:00:02.324 ********* 2026-03-31 00:18:11.040080 | controller | ok: [controller] 2026-03-31 00:18:11.040236 | controller | 2026-03-31 00:18:11.040443 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] ********** 2026-03-31 00:18:11.040634 | controller | Tuesday 31 March 2026 00:18:11 +0000 (0:00:01.141) 0:00:03.465 ********* 2026-03-31 00:18:11.440504 | controller | ok: [controller] 2026-03-31 00:18:11.440542 | controller | 2026-03-31 00:18:11.440553 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] *** 2026-03-31 00:18:11.440560 | controller | Tuesday 31 March 2026 00:18:11 +0000 (0:00:00.402) 0:00:03.867 ********* 2026-03-31 00:18:11.483465 | controller | skipping: [controller] 2026-03-31 00:18:11.483512 | controller | 2026-03-31 00:18:11.483522 | controller | PLAY RECAP ********************************************************************* 2026-03-31 00:18:11.483662 | controller | controller : ok=7 changed=0 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-03-31 00:18:11.483829 | controller | 2026-03-31 00:18:11.483993 | controller | 2026-03-31 00:18:11.484176 | controller | TASKS RECAP ******************************************************************** 2026-03-31 00:18:11.484365 | controller | Tuesday 31 March 2026 00:18:11 +0000 (0:00:00.044) 0:00:03.912 ********* 2026-03-31 00:18:11.484531 | controller | =============================================================================== 2026-03-31 00:18:11.484734 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.14s 2026-03-31 00:18:11.484953 | controller | Gathering Facts --------------------------------------------------------- 1.06s 2026-03-31 00:18:11.485144 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.73s 2026-03-31 00:18:11.485331 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.41s 2026-03-31 00:18:11.485517 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.40s 2026-03-31 00:18:11.485708 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.07s 2026-03-31 00:18:11.485898 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.05s 2026-03-31 00:18:11.486089 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.04s 2026-03-31 00:18:11.645941 | controller | INFO [upload-helm-chart > idempotence] Executed: Successful 2026-03-31 00:18:11.656861 | controller | INFO [upload-helm-chart > side_effect] Executing 2026-03-31 00:18:12.459133 | controller | 2026-03-31 00:18:12.459301 | controller | PLAY [Side effect] ************************************************************* 2026-03-31 00:18:12.459519 | controller | 2026-03-31 00:18:12.459735 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-31 00:18:12.459939 | controller | Tuesday 31 March 2026 00:18:12 +0000 (0:00:00.010) 0:00:00.010 ********* 2026-03-31 00:18:14.539056 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-31 00:18:14.544215 | controller | ok: [controller] 2026-03-31 00:18:14.544423 | controller | 2026-03-31 00:18:14.544639 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-03-31 00:18:14.544837 | controller | Tuesday 31 March 2026 00:18:14 +0000 (0:00:02.084) 0:00:02.095 ********* 2026-03-31 00:18:14.620685 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller 2026-03-31 00:18:14.620838 | controller | 2026-03-31 00:18:14.621042 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] *************** 2026-03-31 00:18:14.621239 | controller | Tuesday 31 March 2026 00:18:14 +0000 (0:00:00.076) 0:00:02.172 ********* 2026-03-31 00:18:15.356036 | controller | changed: [controller] 2026-03-31 00:18:15.356276 | controller | 2026-03-31 00:18:15.356397 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-03-31 00:18:15.356586 | controller | Tuesday 31 March 2026 00:18:15 +0000 (0:00:00.734) 0:00:02.906 ********* 2026-03-31 00:18:15.398301 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller 2026-03-31 00:18:15.398332 | controller | 2026-03-31 00:18:15.398439 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] ********** 2026-03-31 00:18:15.398520 | controller | Tuesday 31 March 2026 00:18:15 +0000 (0:00:00.042) 0:00:02.949 ********* 2026-03-31 00:18:15.810706 | controller | ok: [controller] 2026-03-31 00:18:15.810748 | controller | 2026-03-31 00:18:15.810758 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] *** 2026-03-31 00:18:15.810767 | controller | Tuesday 31 March 2026 00:18:15 +0000 (0:00:00.409) 0:00:03.359 ********* 2026-03-31 00:18:16.876118 | controller | ok: [controller] 2026-03-31 00:18:16.876145 | controller | 2026-03-31 00:18:16.876149 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] ********** 2026-03-31 00:18:16.876154 | controller | Tuesday 31 March 2026 00:18:16 +0000 (0:00:01.061) 0:00:04.421 ********* 2026-03-31 00:18:17.276423 | controller | ok: [controller] 2026-03-31 00:18:17.276463 | controller | 2026-03-31 00:18:17.276470 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] *** 2026-03-31 00:18:17.276475 | controller | Tuesday 31 March 2026 00:18:17 +0000 (0:00:00.402) 0:00:04.823 ********* 2026-03-31 00:18:17.587521 | controller | changed: [controller] => (item=/file) 2026-03-31 00:18:17.587850 | controller | 2026-03-31 00:18:17.588111 | controller | PLAY RECAP ********************************************************************* 2026-03-31 00:18:17.588388 | controller | controller : ok=8 changed=2 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-31 00:18:17.588618 | controller | 2026-03-31 00:18:17.588857 | controller | 2026-03-31 00:18:17.589108 | controller | TASKS RECAP ******************************************************************** 2026-03-31 00:18:17.589382 | controller | Tuesday 31 March 2026 00:18:17 +0000 (0:00:00.315) 0:00:05.138 ********* 2026-03-31 00:18:17.589616 | controller | =============================================================================== 2026-03-31 00:18:17.589860 | controller | Gathering Facts --------------------------------------------------------- 2.08s 2026-03-31 00:18:17.590121 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.06s 2026-03-31 00:18:17.590374 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.73s 2026-03-31 00:18:17.590627 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.41s 2026-03-31 00:18:17.590876 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.40s 2026-03-31 00:18:17.591139 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.32s 2026-03-31 00:18:17.591434 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.08s 2026-03-31 00:18:17.591746 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.04s 2026-03-31 00:18:17.683067 | controller | INFO [upload-helm-chart > side_effect] Executed: Successful 2026-03-31 00:18:17.694174 | controller | INFO [upload-helm-chart > verify] Executing 2026-03-31 00:18:18.573390 | controller | 2026-03-31 00:18:18.573764 | controller | PLAY [Verify] ****************************************************************** 2026-03-31 00:18:18.574023 | controller | 2026-03-31 00:18:18.574321 | controller | TASK [Gathering Facts] ********************************************************* 2026-03-31 00:18:18.574659 | controller | Tuesday 31 March 2026 00:18:18 +0000 (0:00:00.010) 0:00:00.010 ********* 2026-03-31 00:18:19.635939 | controller | [WARNING]: Host 'controller' is using the discovered Python interpreter at '/usr/bin/python3.13', but future installation of another Python interpreter could cause a different interpreter to be discovered. See https://docs.ansible.com/ansible-core/2.20/reference_appendices/interpreter_discovery.html for more information. 2026-03-31 00:18:19.640723 | controller | ok: [controller] 2026-03-31 00:18:19.640978 | controller | 2026-03-31 00:18:19.641232 | controller | TASK [Stat file 1] ************************************************************* 2026-03-31 00:18:19.641607 | controller | Tuesday 31 March 2026 00:18:19 +0000 (0:00:01.067) 0:00:01.077 ********* 2026-03-31 00:18:20.030558 | controller | ok: [controller] 2026-03-31 00:18:20.030848 | controller | 2026-03-31 00:18:20.031129 | controller | TASK [Stat file 2] ************************************************************* 2026-03-31 00:18:20.031461 | controller | Tuesday 31 March 2026 00:18:20 +0000 (0:00:00.389) 0:00:01.467 ********* 2026-03-31 00:18:20.332383 | controller | ok: [controller] 2026-03-31 00:18:20.332417 | controller | 2026-03-31 00:18:20.332424 | controller | TASK [Stat removed file 1] ***************************************************** 2026-03-31 00:18:20.332430 | controller | Tuesday 31 March 2026 00:18:20 +0000 (0:00:00.298) 0:00:01.765 ********* 2026-03-31 00:18:20.618068 | controller | ok: [controller] 2026-03-31 00:18:20.618400 | controller | 2026-03-31 00:18:20.618814 | controller | TASK [Stat removed file 2] ***************************************************** 2026-03-31 00:18:20.619167 | controller | Tuesday 31 March 2026 00:18:20 +0000 (0:00:00.286) 0:00:02.052 ********* 2026-03-31 00:18:20.935058 | controller | ok: [controller] 2026-03-31 00:18:20.935405 | controller | 2026-03-31 00:18:20.935689 | controller | TASK [ansible.builtin.assert] ************************************************** 2026-03-31 00:18:20.937993 | controller | Tuesday 31 March 2026 00:18:20 +0000 (0:00:00.319) 0:00:02.371 ********* 2026-03-31 00:18:20.968166 | controller | ok: [controller] => { 2026-03-31 00:18:20.968342 | controller | "changed": false, 2026-03-31 00:18:20.968532 | controller | "msg": "All assertions passed" 2026-03-31 00:18:20.968711 | controller | } 2026-03-31 00:18:20.968885 | controller | 2026-03-31 00:18:20.969069 | controller | PLAY RECAP ********************************************************************* 2026-03-31 00:18:20.969267 | controller | controller : ok=6 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-03-31 00:18:20.970720 | controller | 2026-03-31 00:18:20.970756 | controller | 2026-03-31 00:18:20.970762 | controller | TASKS RECAP ******************************************************************** 2026-03-31 00:18:20.970768 | controller | Tuesday 31 March 2026 00:18:20 +0000 (0:00:00.030) 0:00:02.402 ********* 2026-03-31 00:18:20.970773 | controller | =============================================================================== 2026-03-31 00:18:20.970778 | controller | Gathering Facts --------------------------------------------------------- 1.07s 2026-03-31 00:18:20.970782 | controller | Stat file 1 ------------------------------------------------------------- 0.39s 2026-03-31 00:18:20.970787 | controller | Stat removed file 2 ----------------------------------------------------- 0.32s 2026-03-31 00:18:20.970792 | controller | Stat file 2 ------------------------------------------------------------- 0.30s 2026-03-31 00:18:20.970796 | controller | Stat removed file 1 ----------------------------------------------------- 0.29s 2026-03-31 00:18:20.970801 | controller | ansible.builtin.assert -------------------------------------------------- 0.03s 2026-03-31 00:18:21.062915 | controller | INFO [upload-helm-chart > verify] Executed: Successful 2026-03-31 00:18:21.074584 | controller | INFO [upload-helm-chart > cleanup] Executing 2026-03-31 00:18:21.074921 | controller | WARNING [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-03-31 00:18:21.080182 | controller | INFO [upload-helm-chart > destroy] Executing 2026-03-31 00:18:21.080273 | controller | WARNING [upload-helm-chart > destroy] Skipping, '--destroy=never' requested. 2026-03-31 00:18:21.080382 | controller | INFO [upload-helm-chart > destroy] Executed: Successful 2026-03-31 00:18:21.080666 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-03-31 00:18:21.258709 | controller | ok: Runtime: 0:00:41.059152 2026-03-31 00:18:21.263822 | 2026-03-31 00:18:21.263866 | PLAY RECAP 2026-03-31 00:18:21.263914 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-31 00:18:21.263935 | 2026-03-31 00:18:21.376774 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-03-31 00:18:21.379493 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-31 00:18:21.939350 | 2026-03-31 00:18:21.939485 | PLAY [all] 2026-03-31 00:18:21.950313 | 2026-03-31 00:18:21.950390 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-03-31 00:18:22.338759 | controller | changed 2026-03-31 00:18:22.343270 | 2026-03-31 00:18:22.343354 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-03-31 00:18:22.739765 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-31 00:18:22.739940 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-31 00:18:22.747295 | controller | environment: line 1: kubectl: command not found 2026-03-31 00:18:22.749627 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-31 00:18:22.750612 | controller | environment: line 1: kubectl: command not found 2026-03-31 00:18:22.753241 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-31 00:18:22.753256 | controller | environment: line 1: kubectl: command not found 2026-03-31 00:18:22.754620 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-31 00:18:22.757852 | controller | environment: line 1: kubectl: command not found 2026-03-31 00:18:22.759292 | controller | environment: line 1: kubectl: command not found 2026-03-31 00:18:22.759305 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-31 00:18:22.760393 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-03-31 00:18:22.873458 | controller | ok: Runtime: 0:00:00.036463 2026-03-31 00:18:22.881400 | 2026-03-31 00:18:22.881505 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-03-31 00:18:23.117906 | controller | changed 2026-03-31 00:18:23.122819 | 2026-03-31 00:18:23.122898 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-03-31 00:18:23.365343 | controller | environment: line 5: kubectl: command not found 2026-03-31 00:18:23.366434 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-31 00:18:23.366775 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-31 00:18:23.366897 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-03-31 00:18:23.651687 | controller | ok: Runtime: 0:00:00.014194 2026-03-31 00:18:23.660534 | 2026-03-31 00:18:23.660610 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-03-31 00:18:24.338497 | controller | changed: 2026-03-31 00:18:24.338752 | controller | created directory /var/lib/zuul/builds/8d5512126d33406c9ae33e0a83f3cae6/work/logs/controller 2026-03-31 00:18:24.338798 | controller | cd+++++++++ objects/ 2026-03-31 00:18:24.338830 | controller | cd+++++++++ objects/cluster/ 2026-03-31 00:18:24.338861 | controller | cd+++++++++ objects/namespaced/ 2026-03-31 00:18:24.348382 | 2026-03-31 00:18:24.348450 | TASK [gather-pod-logs : creating directory for pod logs] 2026-03-31 00:18:24.593547 | controller | changed 2026-03-31 00:18:24.598133 | 2026-03-31 00:18:24.598198 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-03-31 00:18:24.854223 | controller | changed 2026-03-31 00:18:24.859880 | 2026-03-31 00:18:24.870107 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-03-31 00:18:25.120521 | controller | environment: line 3: kubectl: command not found 2026-03-31 00:18:25.406258 | controller | ok: Runtime: 0:00:00.015574 2026-03-31 00:18:25.414091 | 2026-03-31 00:18:25.414159 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-03-31 00:18:25.975611 | controller | changed: 2026-03-31 00:18:25.975918 | controller | cd+++++++++ pod-logs/ 2026-03-31 00:18:25.975988 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-03-31 00:18:25.984347 | 2026-03-31 00:18:25.984418 | LOOP [helm-release-status : creating directory for helm release status] 2026-03-31 00:18:26.217256 | controller | changed: "values" 2026-03-31 00:18:26.421437 | controller | changed: "releases" 2026-03-31 00:18:26.438736 | 2026-03-31 00:18:26.438908 | TASK [helm-release-status : Gather get release status for helm charts] 2026-03-31 00:18:26.680487 | controller | /bin/bash: line 3: kubectl: command not found 2026-03-31 00:18:26.968864 | controller | ok: Runtime: 0:00:00.009062 2026-03-31 00:18:26.975881 | 2026-03-31 00:18:26.975972 | TASK [helm-release-status : Downloads logs to executor] 2026-03-31 00:18:27.486559 | controller | changed: 2026-03-31 00:18:27.486832 | controller | cd+++++++++ helm/ 2026-03-31 00:18:27.486894 | controller | cd+++++++++ helm/releases/ 2026-03-31 00:18:27.486946 | controller | cd+++++++++ helm/values/ 2026-03-31 00:18:27.495896 | 2026-03-31 00:18:27.495949 | PLAY RECAP 2026-03-31 00:18:27.495995 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-31 00:18:27.496018 | 2026-03-31 00:18:27.625740 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-03-31 00:18:27.627278 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-31 00:18:28.239787 | 2026-03-31 00:18:28.240010 | PLAY [all] 2026-03-31 00:18:28.253197 | 2026-03-31 00:18:28.253324 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-31 00:18:28.299660 | controller | skipping: Conditional result was False 2026-03-31 00:18:28.307471 | 2026-03-31 00:18:28.307582 | TASK [fetch-output : Set log path for single node] 2026-03-31 00:18:28.348164 | controller | ok 2026-03-31 00:18:28.353322 | 2026-03-31 00:18:28.353414 | LOOP [fetch-output : Ensure local output dirs] 2026-03-31 00:18:28.734435 | controller -> localhost | ok: "/var/lib/zuul/builds/8d5512126d33406c9ae33e0a83f3cae6/work/logs" 2026-03-31 00:18:28.927515 | controller -> localhost | changed: "/var/lib/zuul/builds/8d5512126d33406c9ae33e0a83f3cae6/work/artifacts" 2026-03-31 00:18:29.131597 | controller -> localhost | changed: "/var/lib/zuul/builds/8d5512126d33406c9ae33e0a83f3cae6/work/docs" 2026-03-31 00:18:29.146380 | 2026-03-31 00:18:29.146576 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-31 00:18:29.829198 | controller | changed: .d..t...... ./ 2026-03-31 00:18:29.829538 | controller | changed: All items complete 2026-03-31 00:18:29.829597 | 2026-03-31 00:18:30.320575 | controller | changed: .d..t...... ./ 2026-03-31 00:18:30.801925 | controller | changed: .d..t...... ./ 2026-03-31 00:18:30.820491 | 2026-03-31 00:18:30.820693 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-31 00:18:31.242604 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.008277 2026-03-31 00:18:31.458332 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007249 2026-03-31 00:18:31.477330 | 2026-03-31 00:18:31.477471 | PLAY [all] 2026-03-31 00:18:31.483286 | 2026-03-31 00:18:31.483350 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-03-31 00:18:31.942206 | controller | changed 2026-03-31 00:18:31.949479 | 2026-03-31 00:18:31.949531 | PLAY RECAP 2026-03-31 00:18:31.949579 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-03-31 00:18:31.949600 | 2026-03-31 00:18:32.084636 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-03-31 00:18:32.086435 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-03-31 00:18:32.648613 | 2026-03-31 00:18:32.648942 | PLAY [localhost] 2026-03-31 00:18:32.659125 | 2026-03-31 00:18:32.659193 | TASK [Generate Zuul manifest] 2026-03-31 00:18:32.678577 | localhost | ok 2026-03-31 00:18:32.696049 | 2026-03-31 00:18:32.696124 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-31 00:18:33.011955 | localhost | changed 2026-03-31 00:18:33.023667 | 2026-03-31 00:18:33.023742 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-31 00:18:33.055367 | localhost | ok 2026-03-31 00:18:33.064283 | 2026-03-31 00:18:33.064369 | TASK [Upload logs] 2026-03-31 00:18:33.087877 | localhost | ok 2026-03-31 00:18:33.168218 | 2026-03-31 00:18:33.168416 | TASK [Set zuul-log-path fact] 2026-03-31 00:18:33.191097 | localhost | ok 2026-03-31 00:18:33.204457 | 2026-03-31 00:18:33.204531 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-31 00:18:33.231617 | localhost | ok 2026-03-31 00:18:33.238380 | 2026-03-31 00:18:33.238449 | TASK [upload-logs : Create log directories] 2026-03-31 00:18:33.621341 | localhost | changed 2026-03-31 00:18:33.632694 | 2026-03-31 00:18:33.632886 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-03-31 00:18:34.053614 | localhost -> localhost | ok: Runtime: 0:00:00.006024 2026-03-31 00:18:34.060273 | 2026-03-31 00:18:34.060361 | TASK [upload-logs : Upload logs to log server] 2026-03-31 00:18:34.528234 | localhost | Output suppressed because no_log was given 2026-03-31 00:18:34.533892 | 2026-03-31 00:18:34.533961 | LOOP [upload-logs : Compress console log and json output] 2026-03-31 00:18:34.586367 | localhost | skipping: Conditional result was False 2026-03-31 00:18:34.593540 | localhost | skipping: Conditional result was False 2026-03-31 00:18:34.611445 | 2026-03-31 00:18:34.611632 | LOOP [upload-logs : Upload compressed console log and json output] 2026-03-31 00:18:34.656378 | localhost | skipping: Conditional result was False 2026-03-31 00:18:34.656743 | 2026-03-31 00:18:34.660896 | localhost | skipping: Conditional result was False 2026-03-31 00:18:34.677031 | 2026-03-31 00:18:34.677217 | LOOP [upload-logs : Upload console log and json output]