2026-05-20 21:18:58.194355 | Job console starting 2026-05-20 21:18:58.248223 | Updating git repos 2026-05-20 21:18:58.407185 | Cloning repos into workspace 2026-05-20 21:19:54.428624 | Restoring repo states 2026-05-20 21:19:54.447253 | Merging changes 2026-05-20 21:20:07.635211 | Checking out repos 2026-05-20 21:20:10.720615 | Preparing playbooks 2026-05-20 21:20:25.379310 | Running Ansible setup 2026-05-20 21:20:30.397636 | PRE-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-05-20 21:20:31.076150 | 2026-05-20 21:20:31.076298 | PLAY [localhost] 2026-05-20 21:20:31.083977 | 2026-05-20 21:20:31.084048 | TASK [Gathering Facts] 2026-05-20 21:20:31.962685 | localhost | ok 2026-05-20 21:20:31.972583 | 2026-05-20 21:20:31.972693 | TASK [Setup log path fact] 2026-05-20 21:20:31.996881 | localhost | ok 2026-05-20 21:20:32.013248 | 2026-05-20 21:20:32.013357 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-20 21:20:32.045583 | localhost | ok 2026-05-20 21:20:32.054739 | 2026-05-20 21:20:32.054868 | TASK [emit-job-header : Print job information] 2026-05-20 21:20:32.099079 | # Job Information 2026-05-20 21:20:32.099320 | Ansible Version: 2.16.18 2026-05-20 21:20:32.099378 | Job: ansible-collection-kubernetes-molecule-upload-helm-chart 2026-05-20 21:20:32.099413 | Pipeline: check 2026-05-20 21:20:32.099442 | Executor: 2d72f0692154 2026-05-20 21:20:32.099470 | Triggered by: https://github.com/vexxhost/ansible-collection-kubernetes/pull/275 2026-05-20 21:20:32.099502 | Event ID: 5bd91320-5491-11f1-9358-8e7f787ff787 2026-05-20 21:20:32.103580 | 2026-05-20 21:20:32.103678 | LOOP [emit-job-header : Print node information] 2026-05-20 21:20:32.188588 | localhost | ok: 2026-05-20 21:20:32.188775 | localhost | # Node Information 2026-05-20 21:20:32.188805 | localhost | Inventory Hostname: controller 2026-05-20 21:20:32.188827 | localhost | Hostname: np0000175523 2026-05-20 21:20:32.188848 | localhost | Username: zuul 2026-05-20 21:20:32.188870 | localhost | Distro: Debian 13.4 2026-05-20 21:20:32.188891 | localhost | Provider: yul1 2026-05-20 21:20:32.188910 | localhost | Region: ca-ymq-1 2026-05-20 21:20:32.188928 | localhost | Label: debian-trixie 2026-05-20 21:20:32.188948 | localhost | Product Name: OpenStack Nova 2026-05-20 21:20:32.189064 | localhost | Interface IP: 199.19.213.111 2026-05-20 21:20:32.199695 | 2026-05-20 21:20:32.199834 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-05-20 21:20:32.592018 | localhost -> localhost | changed 2026-05-20 21:20:32.600083 | 2026-05-20 21:20:32.600218 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-05-20 21:20:33.493551 | localhost -> localhost | changed 2026-05-20 21:20:33.500920 | 2026-05-20 21:20:33.501139 | PLAY [all] 2026-05-20 21:20:33.509461 | 2026-05-20 21:20:33.509558 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-05-20 21:20:33.757218 | controller -> localhost | ok 2026-05-20 21:20:33.762281 | 2026-05-20 21:20:33.762353 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-05-20 21:20:33.791878 | controller | ok 2026-05-20 21:20:33.806310 | controller | included: /var/lib/zuul/builds/f9b9a0efd86446f8aa15114a38f749c9/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-05-20 21:20:33.811002 | 2026-05-20 21:20:33.811066 | TASK [add-build-sshkey : Create Temp SSH key] 2026-05-20 21:20:34.923178 | controller -> localhost | Generating public/private rsa key pair. 2026-05-20 21:20:34.923399 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/f9b9a0efd86446f8aa15114a38f749c9/work/f9b9a0efd86446f8aa15114a38f749c9_id_rsa 2026-05-20 21:20:34.923442 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/f9b9a0efd86446f8aa15114a38f749c9/work/f9b9a0efd86446f8aa15114a38f749c9_id_rsa.pub 2026-05-20 21:20:34.923473 | controller -> localhost | The key fingerprint is: 2026-05-20 21:20:34.923528 | controller -> localhost | SHA256:jR5aGYW81iPJzXSPIvHlUzsl7DLYT6Ujf4rWI7pVWc8 zuul-build-sshkey 2026-05-20 21:20:34.923589 | controller -> localhost | The key's randomart image is: 2026-05-20 21:20:34.923624 | controller -> localhost | +---[RSA 3072]----+ 2026-05-20 21:20:34.923660 | controller -> localhost | | . .. . | 2026-05-20 21:20:34.923689 | controller -> localhost | | +.. o + o| 2026-05-20 21:20:34.923717 | controller -> localhost | | ..X * = *.| 2026-05-20 21:20:34.923744 | controller -> localhost | | B=O O O+.| 2026-05-20 21:20:34.923771 | controller -> localhost | | .So.o OooE| 2026-05-20 21:20:34.923798 | controller -> localhost | | + . .o .| 2026-05-20 21:20:34.923824 | controller -> localhost | | . . .o o | 2026-05-20 21:20:34.923851 | controller -> localhost | | .+ + | 2026-05-20 21:20:34.923882 | controller -> localhost | | o+ . . | 2026-05-20 21:20:34.923909 | controller -> localhost | +----[SHA256]-----+ 2026-05-20 21:20:34.923976 | controller -> localhost | ok: Runtime: 0:00:00.659194 2026-05-20 21:20:34.930189 | 2026-05-20 21:20:34.930257 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-05-20 21:20:34.974854 | controller | ok 2026-05-20 21:20:34.982825 | controller | included: /var/lib/zuul/builds/f9b9a0efd86446f8aa15114a38f749c9/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-05-20 21:20:34.989224 | 2026-05-20 21:20:34.989289 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-05-20 21:20:35.014174 | controller | skipping: Conditional result was False 2026-05-20 21:20:35.026823 | 2026-05-20 21:20:35.027092 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-05-20 21:20:35.593258 | controller | changed 2026-05-20 21:20:35.597418 | 2026-05-20 21:20:35.597485 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-05-20 21:20:35.832413 | controller | ok 2026-05-20 21:20:35.840596 | 2026-05-20 21:20:35.840792 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-05-20 21:20:36.441328 | controller | changed 2026-05-20 21:20:36.445375 | 2026-05-20 21:20:36.445445 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-05-20 21:20:36.996872 | controller | changed 2026-05-20 21:20:37.003065 | 2026-05-20 21:20:37.003165 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-05-20 21:20:37.018129 | controller | skipping: Conditional result was False 2026-05-20 21:20:37.024610 | 2026-05-20 21:20:37.024710 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-05-20 21:20:37.423169 | controller -> localhost | changed 2026-05-20 21:20:37.443657 | 2026-05-20 21:20:37.443756 | TASK [add-build-sshkey : Add back temp key] 2026-05-20 21:20:37.749487 | controller -> localhost | Identity added: /var/lib/zuul/builds/f9b9a0efd86446f8aa15114a38f749c9/work/f9b9a0efd86446f8aa15114a38f749c9_id_rsa (zuul-build-sshkey) 2026-05-20 21:20:37.749702 | controller -> localhost | ok: Runtime: 0:00:00.015853 2026-05-20 21:20:37.754011 | 2026-05-20 21:20:37.754079 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-05-20 21:20:38.098413 | controller | ok 2026-05-20 21:20:38.103164 | 2026-05-20 21:20:38.103235 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-05-20 21:20:38.131539 | controller | skipping: Conditional result was False 2026-05-20 21:20:38.141691 | 2026-05-20 21:20:38.141820 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-05-20 21:20:38.518412 | controller | ok 2026-05-20 21:20:38.524919 | 2026-05-20 21:20:38.525036 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-05-20 21:20:39.526073 | controller | Output suppressed because no_log was given 2026-05-20 21:20:39.536572 | 2026-05-20 21:20:39.536672 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-05-20 21:20:39.750522 | controller | ok: "logs" 2026-05-20 21:20:39.750780 | controller | ok: All items complete 2026-05-20 21:20:39.750820 | 2026-05-20 21:20:39.941380 | controller | ok: "artifacts" 2026-05-20 21:20:40.140566 | controller | ok: "docs" 2026-05-20 21:20:40.152498 | 2026-05-20 21:20:40.152650 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-05-20 21:20:40.383337 | controller | changed: "logs" 2026-05-20 21:20:40.568191 | controller | changed: "artifacts" 2026-05-20 21:20:40.759206 | controller | changed: "docs" 2026-05-20 21:20:40.770210 | 2026-05-20 21:20:40.770370 | PLAY RECAP 2026-05-20 21:20:40.770438 | controller | ok: 15 changed: 8 unreachable: 0 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-05-20 21:20:40.770476 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-20 21:20:40.770506 | 2026-05-20 21:20:40.962489 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/pre.yaml@main] 2026-05-20 21:20:40.963950 | PRE-RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-05-20 21:20:41.582001 | 2026-05-20 21:20:41.582138 | PLAY [all] 2026-05-20 21:20:41.592136 | 2026-05-20 21:20:41.592213 | TASK [setup-uv : Extract archive] 2026-05-20 21:20:44.065650 | controller | changed 2026-05-20 21:20:44.072190 | 2026-05-20 21:20:44.072346 | TASK [setup-uv : Print version] 2026-05-20 21:20:44.440980 | controller | uv 0.8.13 2026-05-20 21:20:44.600287 | controller | ok: Runtime: 0:00:00.012641 2026-05-20 21:20:44.612990 | 2026-05-20 21:20:44.613090 | TASK [Install Ansible collection siblings] 2026-05-20 21:20:45.031152 | controller | ok: 2026-05-20 21:20:45.031443 | controller | Skipping ansible.posix: no checked-out sibling 2026-05-20 21:20:45.031505 | controller | Skipping community.crypto: no checked-out sibling 2026-05-20 21:20:45.031554 | controller | Skipping community.general: no checked-out sibling 2026-05-20 21:20:45.031613 | controller | Skipping kubernetes.core: no checked-out sibling 2026-05-20 21:20:45.031656 | controller | Skipping vexxhost.containers: no checked-out sibling 2026-05-20 21:20:45.034502 | 2026-05-20 21:20:45.034565 | PLAY RECAP 2026-05-20 21:20:45.034638 | controller | ok: 3 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-20 21:20:45.034672 | 2026-05-20 21:20:45.183180 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/pre.yaml@main] 2026-05-20 21:20:45.184665 | PRE-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-05-20 21:20:45.821003 | 2026-05-20 21:20:45.821525 | PLAY [all] 2026-05-20 21:20:45.832637 | 2026-05-20 21:20:45.832738 | TASK [Update apt cache] 2026-05-20 21:20:50.598164 | controller | ok 2026-05-20 21:20:50.603750 | 2026-05-20 21:20:50.603869 | TASK [Disable firewalld] 2026-05-20 21:20:50.630414 | controller | skipping: Conditional result was False 2026-05-20 21:20:50.638851 | 2026-05-20 21:20:50.638946 | TASK [Install "jq" for log collection] 2026-05-20 21:20:52.738301 | controller | changed 2026-05-20 21:20:52.740928 | 2026-05-20 21:20:52.741018 | PLAY RECAP 2026-05-20 21:20:52.741085 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-20 21:20:52.741116 | 2026-05-20 21:20:52.871560 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/pre.yml@main] 2026-05-20 21:20:52.873642 | RUN START: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-05-20 21:20:53.439129 | 2026-05-20 21:20:53.439261 | PLAY [all] 2026-05-20 21:20:53.449062 | 2026-05-20 21:20:53.449139 | TASK [Copy inventory file for Zuul] 2026-05-20 21:20:54.418367 | controller | changed 2026-05-20 21:20:54.422745 | 2026-05-20 21:20:54.422822 | TASK [Switch "ansible_host" to private IP] 2026-05-20 21:20:54.781953 | controller | changed: 1 replacements made 2026-05-20 21:20:54.789150 | 2026-05-20 21:20:54.789220 | TASK [Run Molecule scenario] 2026-05-20 21:20:55.233974 | controller | Using CPython 3.13.5 interpreter at: /usr/bin/python3 2026-05-20 21:20:55.234047 | controller | Creating virtual environment at: .venv 2026-05-20 21:20:55.528400 | controller | Downloading pygments (1.2MiB) 2026-05-20 21:20:55.528665 | controller | Downloading cryptography (4.3MiB) 2026-05-20 21:20:55.530523 | controller | Downloading ansible-core (2.3MiB) 2026-05-20 21:20:55.697971 | controller | Downloading cryptography 2026-05-20 21:20:55.745239 | controller | Downloading pygments 2026-05-20 21:20:55.926927 | controller | Downloading ansible-core 2026-05-20 21:20:55.975274 | controller | Installed 36 packages in 47ms 2026-05-20 21:20:56.678357 | controller | INFO Collection 'vexxhost.kubernetes' detected. 2026-05-20 21:20:56.678420 | controller | INFO Scenarios will be used from 'extensions/molecule' 2026-05-20 21:20:57.523245 | controller | CRITICAL 'extensions/molecule/default/molecule.yml' glob failed. Exiting. 2026-05-20 21:20:57.523305 | controller | INFO default scenario not found, disabling shared state. 2026-05-20 21:20:57.523391 | controller | INFO [upload-helm-chart > discovery] scenario test matrix: dependency, cleanup, destroy, syntax, create, prepare, converge, idempotence, side_effect, verify, cleanup, destroy 2026-05-20 21:20:57.523478 | controller | INFO [upload-helm-chart > prerun] Performing prerun with role_name_check=0... 2026-05-20 21:21:16.516346 | controller | INFO [upload-helm-chart > dependency] Executing 2026-05-20 21:21:16.516441 | controller | WARNING [upload-helm-chart > dependency] Missing roles requirements file: requirements.yml 2026-05-20 21:21:16.516453 | controller | WARNING [upload-helm-chart > dependency] Missing collections requirements file: collections.yml 2026-05-20 21:21:16.516497 | controller | WARNING [upload-helm-chart > dependency] Executed: 2 missing (Remove from test_sequence to suppress) 2026-05-20 21:21:16.524059 | controller | INFO [upload-helm-chart > cleanup] Executing 2026-05-20 21:21:16.524364 | controller | WARNING [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-05-20 21:21:16.529788 | controller | INFO [upload-helm-chart > destroy] Executing 2026-05-20 21:21:16.529873 | controller | WARNING [upload-helm-chart > destroy] Skipping, '--destroy=never' requested. 2026-05-20 21:21:16.529972 | controller | INFO [upload-helm-chart > destroy] Executed: Successful 2026-05-20 21:21:16.535312 | controller | INFO [upload-helm-chart > syntax] Executing 2026-05-20 21:21:17.415638 | controller | 2026-05-20 21:21:17.415862 | controller | playbook: /home/zuul/src/github.com/vexxhost/ansible-collection-kubernetes/extensions/molecule/upload-helm-chart/converge.yml 2026-05-20 21:21:17.473803 | controller | INFO [upload-helm-chart > syntax] Executed: Successful 2026-05-20 21:21:17.485811 | controller | INFO [upload-helm-chart > create] Executing 2026-05-20 21:21:17.487886 | controller | WARNING [upload-helm-chart > create] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-05-20 21:21:17.494181 | controller | INFO [upload-helm-chart > prepare] Executing 2026-05-20 21:21:17.494507 | controller | WARNING [upload-helm-chart > prepare] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-05-20 21:21:17.499843 | controller | INFO [upload-helm-chart > converge] Executing 2026-05-20 21:21:18.357471 | controller | 2026-05-20 21:21:18.357683 | controller | PLAY [Converge] **************************************************************** 2026-05-20 21:21:18.358074 | controller | 2026-05-20 21:21:18.358296 | controller | TASK [Gathering Facts] ********************************************************* 2026-05-20 21:21:18.358583 | controller | Wednesday 20 May 2026 21:21:18 +0000 (0:00:00.037) 0:00:00.037 ********* 2026-05-20 21:21:19.668214 | 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-05-20 21:21:19.673849 | controller | ok: [controller] 2026-05-20 21:21:19.674028 | controller | 2026-05-20 21:21:19.674239 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-05-20 21:21:19.674463 | controller | Wednesday 20 May 2026 21:21:19 +0000 (0:00:01.317) 0:00:01.354 ********* 2026-05-20 21:21:19.762437 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller 2026-05-20 21:21:19.762601 | controller | 2026-05-20 21:21:19.762810 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] *************** 2026-05-20 21:21:19.763006 | controller | Wednesday 20 May 2026 21:21:19 +0000 (0:00:00.088) 0:00:01.443 ********* 2026-05-20 21:21:20.440622 | controller | changed: [controller] 2026-05-20 21:21:20.440789 | controller | 2026-05-20 21:21:20.441036 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-05-20 21:21:20.441224 | controller | Wednesday 20 May 2026 21:21:20 +0000 (0:00:00.678) 0:00:02.121 ********* 2026-05-20 21:21:20.478674 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller 2026-05-20 21:21:20.478843 | controller | 2026-05-20 21:21:20.479042 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] ********** 2026-05-20 21:21:20.479232 | controller | Wednesday 20 May 2026 21:21:20 +0000 (0:00:00.038) 0:00:02.159 ********* 2026-05-20 21:21:20.892580 | controller | changed: [controller] 2026-05-20 21:21:20.892705 | controller | 2026-05-20 21:21:20.892977 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] *** 2026-05-20 21:21:20.893213 | controller | Wednesday 20 May 2026 21:21:20 +0000 (0:00:00.413) 0:00:02.573 ********* 2026-05-20 21:21:21.985393 | controller | changed: [controller] 2026-05-20 21:21:21.985508 | controller | 2026-05-20 21:21:21.988586 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] ********** 2026-05-20 21:21:21.988605 | controller | Wednesday 20 May 2026 21:21:21 +0000 (0:00:01.090) 0:00:03.663 ********* 2026-05-20 21:21:22.407322 | controller | ok: [controller] 2026-05-20 21:21:22.407493 | controller | 2026-05-20 21:21:22.407726 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] *** 2026-05-20 21:21:22.407930 | controller | Wednesday 20 May 2026 21:21:22 +0000 (0:00:00.424) 0:00:04.087 ********* 2026-05-20 21:21:22.457608 | controller | skipping: [controller] 2026-05-20 21:21:22.457760 | controller | 2026-05-20 21:21:22.457958 | controller | PLAY RECAP ********************************************************************* 2026-05-20 21:21:22.458183 | controller | controller : ok=7 changed=3 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-05-20 21:21:22.458354 | controller | 2026-05-20 21:21:22.458520 | controller | 2026-05-20 21:21:22.458706 | controller | TASKS RECAP ******************************************************************** 2026-05-20 21:21:22.458908 | controller | Wednesday 20 May 2026 21:21:22 +0000 (0:00:00.051) 0:00:04.139 ********* 2026-05-20 21:21:22.459124 | controller | =============================================================================== 2026-05-20 21:21:22.459333 | controller | Gathering Facts --------------------------------------------------------- 1.32s 2026-05-20 21:21:22.459619 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.09s 2026-05-20 21:21:22.459869 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.68s 2026-05-20 21:21:22.460072 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.42s 2026-05-20 21:21:22.460256 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.41s 2026-05-20 21:21:22.460454 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.09s 2026-05-20 21:21:22.460651 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.05s 2026-05-20 21:21:22.460899 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.04s 2026-05-20 21:21:22.554398 | controller | INFO [upload-helm-chart > converge] Executed: Successful 2026-05-20 21:21:22.562511 | controller | INFO [upload-helm-chart > idempotence] Executing 2026-05-20 21:21:23.400994 | controller | 2026-05-20 21:21:23.401155 | controller | PLAY [Converge] **************************************************************** 2026-05-20 21:21:23.401361 | controller | 2026-05-20 21:21:23.401583 | controller | TASK [Gathering Facts] ********************************************************* 2026-05-20 21:21:23.401816 | controller | Wednesday 20 May 2026 21:21:23 +0000 (0:00:00.011) 0:00:00.011 ********* 2026-05-20 21:21:24.484512 | 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-05-20 21:21:24.490615 | controller | ok: [controller] 2026-05-20 21:21:24.490807 | controller | 2026-05-20 21:21:24.491026 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-05-20 21:21:24.491224 | controller | Wednesday 20 May 2026 21:21:24 +0000 (0:00:01.089) 0:00:01.101 ********* 2026-05-20 21:21:24.571384 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller 2026-05-20 21:21:24.571464 | controller | 2026-05-20 21:21:24.571654 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] *************** 2026-05-20 21:21:24.571847 | controller | Wednesday 20 May 2026 21:21:24 +0000 (0:00:00.080) 0:00:01.181 ********* 2026-05-20 21:21:25.289225 | controller | ok: [controller] 2026-05-20 21:21:25.289356 | controller | 2026-05-20 21:21:25.289594 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-05-20 21:21:25.289796 | controller | Wednesday 20 May 2026 21:21:25 +0000 (0:00:00.718) 0:00:01.899 ********* 2026-05-20 21:21:25.331468 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller 2026-05-20 21:21:25.331636 | controller | 2026-05-20 21:21:25.331846 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] ********** 2026-05-20 21:21:25.332044 | controller | Wednesday 20 May 2026 21:21:25 +0000 (0:00:00.042) 0:00:01.941 ********* 2026-05-20 21:21:25.737205 | controller | ok: [controller] 2026-05-20 21:21:25.737336 | controller | 2026-05-20 21:21:25.737561 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] *** 2026-05-20 21:21:25.737780 | controller | Wednesday 20 May 2026 21:21:25 +0000 (0:00:00.405) 0:00:02.347 ********* 2026-05-20 21:21:26.847266 | controller | ok: [controller] 2026-05-20 21:21:26.847301 | controller | 2026-05-20 21:21:26.847306 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] ********** 2026-05-20 21:21:26.847310 | controller | Wednesday 20 May 2026 21:21:26 +0000 (0:00:01.108) 0:00:03.455 ********* 2026-05-20 21:21:27.260989 | controller | ok: [controller] 2026-05-20 21:21:27.261159 | controller | 2026-05-20 21:21:27.261420 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] *** 2026-05-20 21:21:27.261628 | controller | Wednesday 20 May 2026 21:21:27 +0000 (0:00:00.414) 0:00:03.870 ********* 2026-05-20 21:21:27.302291 | controller | skipping: [controller] 2026-05-20 21:21:27.302442 | controller | 2026-05-20 21:21:27.302637 | controller | PLAY RECAP ********************************************************************* 2026-05-20 21:21:27.302874 | controller | controller : ok=7 changed=0 unreachable=0 failed=0 skipped=1 rescued=0 ignored=0 2026-05-20 21:21:27.303112 | controller | 2026-05-20 21:21:27.303284 | controller | 2026-05-20 21:21:27.303469 | controller | TASKS RECAP ******************************************************************** 2026-05-20 21:21:27.303660 | controller | Wednesday 20 May 2026 21:21:27 +0000 (0:00:00.042) 0:00:03.913 ********* 2026-05-20 21:21:27.303888 | controller | =============================================================================== 2026-05-20 21:21:27.304237 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.11s 2026-05-20 21:21:27.304471 | controller | Gathering Facts --------------------------------------------------------- 1.09s 2026-05-20 21:21:27.304834 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.72s 2026-05-20 21:21:27.305110 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.41s 2026-05-20 21:21:27.305382 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.41s 2026-05-20 21:21:27.305638 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.08s 2026-05-20 21:21:27.305849 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.04s 2026-05-20 21:21:27.306051 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.04s 2026-05-20 21:21:27.429381 | controller | INFO [upload-helm-chart > idempotence] Executed: Successful 2026-05-20 21:21:27.515941 | controller | INFO [upload-helm-chart > side_effect] Executing 2026-05-20 21:21:28.333840 | controller | 2026-05-20 21:21:28.333902 | controller | PLAY [Side effect] ************************************************************* 2026-05-20 21:21:28.334085 | controller | 2026-05-20 21:21:28.334273 | controller | TASK [Gathering Facts] ********************************************************* 2026-05-20 21:21:28.334465 | controller | Wednesday 20 May 2026 21:21:28 +0000 (0:00:00.010) 0:00:00.010 ********* 2026-05-20 21:21:29.431032 | 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-05-20 21:21:29.435777 | controller | ok: [controller] 2026-05-20 21:21:29.435845 | controller | 2026-05-20 21:21:29.435940 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-05-20 21:21:29.436031 | controller | Wednesday 20 May 2026 21:21:29 +0000 (0:00:01.102) 0:00:01.113 ********* 2026-05-20 21:21:29.509241 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/synchronize.yml for controller 2026-05-20 21:21:29.509374 | controller | 2026-05-20 21:21:29.509575 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload Helm chart] *************** 2026-05-20 21:21:29.509765 | controller | Wednesday 20 May 2026 21:21:29 +0000 (0:00:00.073) 0:00:01.186 ********* 2026-05-20 21:21:30.218278 | controller | changed: [controller] 2026-05-20 21:21:30.218436 | controller | 2026-05-20 21:21:30.218673 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks] *** 2026-05-20 21:21:30.218881 | controller | Wednesday 20 May 2026 21:21:30 +0000 (0:00:00.708) 0:00:01.895 ********* 2026-05-20 21:21:30.262090 | controller | included: /home/zuul/.ansible/collections/ansible_collections/vexxhost/kubernetes/roles/upload_helm_chart/tasks/copy.yml for controller 2026-05-20 21:21:30.262221 | controller | 2026-05-20 21:21:30.262444 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Ensure destination dir] ********** 2026-05-20 21:21:30.262639 | controller | Wednesday 20 May 2026 21:21:30 +0000 (0:00:00.044) 0:00:01.939 ********* 2026-05-20 21:21:30.686822 | controller | ok: [controller] 2026-05-20 21:21:30.686874 | controller | 2026-05-20 21:21:30.686883 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy] *** 2026-05-20 21:21:30.686892 | controller | Wednesday 20 May 2026 21:21:30 +0000 (0:00:00.421) 0:00:02.360 ********* 2026-05-20 21:21:31.805312 | controller | ok: [controller] 2026-05-20 21:21:31.805502 | controller | 2026-05-20 21:21:31.805679 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Find destination files] ********** 2026-05-20 21:21:31.805842 | controller | Wednesday 20 May 2026 21:21:31 +0000 (0:00:01.119) 0:00:03.480 ********* 2026-05-20 21:21:32.233323 | controller | ok: [controller] 2026-05-20 21:21:32.233374 | controller | 2026-05-20 21:21:32.233445 | controller | TASK [vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources] *** 2026-05-20 21:21:32.233568 | controller | Wednesday 20 May 2026 21:21:32 +0000 (0:00:00.426) 0:00:03.906 ********* 2026-05-20 21:21:32.552380 | controller | changed: [controller] => (item=/file) 2026-05-20 21:21:32.552416 | controller | 2026-05-20 21:21:32.552426 | controller | PLAY RECAP ********************************************************************* 2026-05-20 21:21:32.552435 | controller | controller : ok=8 changed=2 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-05-20 21:21:32.552442 | controller | 2026-05-20 21:21:32.552450 | controller | 2026-05-20 21:21:32.552457 | controller | TASKS RECAP ******************************************************************** 2026-05-20 21:21:32.552483 | controller | Wednesday 20 May 2026 21:21:32 +0000 (0:00:00.318) 0:00:04.225 ********* 2026-05-20 21:21:32.552490 | controller | =============================================================================== 2026-05-20 21:21:32.552497 | controller | vexxhost.kubernetes.upload_helm_chart : Upload helm chart with multi_copy --- 1.12s 2026-05-20 21:21:32.552505 | controller | Gathering Facts --------------------------------------------------------- 1.10s 2026-05-20 21:21:32.552512 | controller | vexxhost.kubernetes.upload_helm_chart : Upload Helm chart --------------- 0.71s 2026-05-20 21:21:32.552519 | controller | vexxhost.kubernetes.upload_helm_chart : Find destination files ---------- 0.43s 2026-05-20 21:21:32.552526 | controller | vexxhost.kubernetes.upload_helm_chart : Ensure destination dir ---------- 0.42s 2026-05-20 21:21:32.552534 | controller | vexxhost.kubernetes.upload_helm_chart : Delete any destination files not in the sources --- 0.32s 2026-05-20 21:21:32.552541 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.07s 2026-05-20 21:21:32.552549 | controller | vexxhost.kubernetes.upload_helm_chart : Include help chart upload method tasks --- 0.04s 2026-05-20 21:21:32.657675 | controller | INFO [upload-helm-chart > side_effect] Executed: Successful 2026-05-20 21:21:32.668968 | controller | INFO [upload-helm-chart > verify] Executing 2026-05-20 21:21:33.469994 | controller | 2026-05-20 21:21:33.470302 | controller | PLAY [Verify] ****************************************************************** 2026-05-20 21:21:33.470540 | controller | 2026-05-20 21:21:33.470789 | controller | TASK [Gathering Facts] ********************************************************* 2026-05-20 21:21:33.471069 | controller | Wednesday 20 May 2026 21:21:33 +0000 (0:00:00.009) 0:00:00.009 ********* 2026-05-20 21:21:34.491803 | 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-05-20 21:21:34.496590 | controller | ok: [controller] 2026-05-20 21:21:34.496802 | controller | 2026-05-20 21:21:34.496987 | controller | TASK [Stat file 1] ************************************************************* 2026-05-20 21:21:34.497222 | controller | Wednesday 20 May 2026 21:21:34 +0000 (0:00:01.026) 0:00:01.036 ********* 2026-05-20 21:21:34.917316 | controller | ok: [controller] 2026-05-20 21:21:34.917577 | controller | 2026-05-20 21:21:34.917828 | controller | TASK [Stat file 2] ************************************************************* 2026-05-20 21:21:34.918116 | controller | Wednesday 20 May 2026 21:21:34 +0000 (0:00:00.420) 0:00:01.456 ********* 2026-05-20 21:21:35.208677 | controller | ok: [controller] 2026-05-20 21:21:35.208701 | controller | 2026-05-20 21:21:35.208707 | controller | TASK [Stat removed file 1] ***************************************************** 2026-05-20 21:21:35.208712 | controller | Wednesday 20 May 2026 21:21:35 +0000 (0:00:00.289) 0:00:01.746 ********* 2026-05-20 21:21:35.489099 | controller | ok: [controller] 2026-05-20 21:21:35.489396 | controller | 2026-05-20 21:21:35.489667 | controller | TASK [Stat removed file 2] ***************************************************** 2026-05-20 21:21:35.489944 | controller | Wednesday 20 May 2026 21:21:35 +0000 (0:00:00.281) 0:00:02.028 ********* 2026-05-20 21:21:35.771577 | controller | ok: [controller] 2026-05-20 21:21:35.771597 | controller | 2026-05-20 21:21:35.771602 | controller | TASK [ansible.builtin.assert] ************************************************** 2026-05-20 21:21:35.771606 | controller | Wednesday 20 May 2026 21:21:35 +0000 (0:00:00.281) 0:00:02.309 ********* 2026-05-20 21:21:35.804420 | controller | ok: [controller] => { 2026-05-20 21:21:35.804441 | controller | "changed": false, 2026-05-20 21:21:35.804445 | controller | "msg": "All assertions passed" 2026-05-20 21:21:35.804449 | controller | } 2026-05-20 21:21:35.804453 | controller | 2026-05-20 21:21:35.804456 | controller | PLAY RECAP ********************************************************************* 2026-05-20 21:21:35.804461 | controller | controller : ok=6 changed=0 unreachable=0 failed=0 skipped=0 rescued=0 ignored=0 2026-05-20 21:21:35.804465 | controller | 2026-05-20 21:21:35.804475 | controller | 2026-05-20 21:21:35.804479 | controller | TASKS RECAP ******************************************************************** 2026-05-20 21:21:35.804482 | controller | Wednesday 20 May 2026 21:21:35 +0000 (0:00:00.028) 0:00:02.337 ********* 2026-05-20 21:21:35.804485 | controller | =============================================================================== 2026-05-20 21:21:35.804488 | controller | Gathering Facts --------------------------------------------------------- 1.03s 2026-05-20 21:21:35.804492 | controller | Stat file 1 ------------------------------------------------------------- 0.42s 2026-05-20 21:21:35.804495 | controller | Stat file 2 ------------------------------------------------------------- 0.29s 2026-05-20 21:21:35.804498 | controller | Stat removed file 1 ----------------------------------------------------- 0.28s 2026-05-20 21:21:35.804501 | controller | Stat removed file 2 ----------------------------------------------------- 0.28s 2026-05-20 21:21:35.804504 | controller | ansible.builtin.assert -------------------------------------------------- 0.03s 2026-05-20 21:21:35.879046 | controller | INFO [upload-helm-chart > verify] Executed: Successful 2026-05-20 21:21:35.885672 | controller | INFO [upload-helm-chart > cleanup] Executing 2026-05-20 21:21:35.886111 | controller | WARNING [upload-helm-chart > cleanup] Executed: Missing playbook (Remove from test_sequence to suppress) 2026-05-20 21:21:35.892502 | controller | INFO [upload-helm-chart > destroy] Executing 2026-05-20 21:21:35.892650 | controller | WARNING [upload-helm-chart > destroy] Skipping, '--destroy=never' requested. 2026-05-20 21:21:35.892790 | controller | INFO [upload-helm-chart > destroy] Executed: Successful 2026-05-20 21:21:35.893142 | controller | WARNING Molecule executed 1 scenario (1 missing files) 2026-05-20 21:21:36.356986 | controller | ok: Runtime: 0:00:40.811590 2026-05-20 21:21:36.363249 | 2026-05-20 21:21:36.363299 | PLAY RECAP 2026-05-20 21:21:36.363344 | controller | ok: 3 changed: 3 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-20 21:21:36.363366 | 2026-05-20 21:21:36.479311 | RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/zuul-jobs/playbooks/molecule/run.yaml@main] 2026-05-20 21:21:36.482579 | POST-RUN START: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-05-20 21:21:37.131873 | 2026-05-20 21:21:37.132019 | PLAY [all] 2026-05-20 21:21:37.142924 | 2026-05-20 21:21:37.142999 | TASK [describe-kubernetes-objects : creating directory for cluster scoped objects] 2026-05-20 21:21:37.549261 | controller | changed 2026-05-20 21:21:37.555112 | 2026-05-20 21:21:37.555192 | TASK [describe-kubernetes-objects : Gathering descriptions for cluster scoped objects] 2026-05-20 21:21:37.932438 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-05-20 21:21:37.933057 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-05-20 21:21:37.940255 | controller | environment: line 1: kubectl: command not found 2026-05-20 21:21:37.941104 | controller | environment: line 1: kubectl: command not found 2026-05-20 21:21:37.942279 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-05-20 21:21:37.943394 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-05-20 21:21:37.947076 | controller | environment: line 1: kubectl: command not found 2026-05-20 21:21:37.947342 | controller | environment: line 1: kubectl: command not found 2026-05-20 21:21:37.947984 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-05-20 21:21:37.949165 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-05-20 21:21:37.952543 | controller | environment: line 1: kubectl: command not found 2026-05-20 21:21:37.953930 | controller | xargs: warning: options --max-lines and --replace/-I/-i are mutually exclusive, ignoring previous --max-lines value 2026-05-20 21:21:38.083506 | controller | ok: Runtime: 0:00:00.030836 2026-05-20 21:21:38.090109 | 2026-05-20 21:21:38.090176 | TASK [describe-kubernetes-objects : creating directory for namespace scoped objects] 2026-05-20 21:21:38.323748 | controller | changed 2026-05-20 21:21:38.329206 | 2026-05-20 21:21:38.329301 | TASK [describe-kubernetes-objects : Gathering descriptions for namespace scoped objects] 2026-05-20 21:21:38.567066 | controller | environment: line 5: kubectl: command not found 2026-05-20 21:21:38.568772 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-05-20 21:21:38.569409 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-05-20 21:21:38.569639 | controller | xargs: warning: options --max-args and --replace/-I/-i are mutually exclusive, ignoring previous --max-args value 2026-05-20 21:21:38.867010 | controller | ok: Runtime: 0:00:00.012638 2026-05-20 21:21:38.872620 | 2026-05-20 21:21:38.872687 | TASK [describe-kubernetes-objects : Downloads logs to executor] 2026-05-20 21:21:39.555742 | controller | changed: 2026-05-20 21:21:39.555999 | controller | created directory /var/lib/zuul/builds/f9b9a0efd86446f8aa15114a38f749c9/work/logs/controller 2026-05-20 21:21:39.556066 | controller | cd+++++++++ objects/ 2026-05-20 21:21:39.556238 | controller | cd+++++++++ objects/cluster/ 2026-05-20 21:21:39.556295 | controller | cd+++++++++ objects/namespaced/ 2026-05-20 21:21:39.565718 | 2026-05-20 21:21:39.565798 | TASK [gather-pod-logs : creating directory for pod logs] 2026-05-20 21:21:39.812829 | controller | changed 2026-05-20 21:21:39.818703 | 2026-05-20 21:21:39.818799 | TASK [gather-pod-logs : creating directory for failed pod logs] 2026-05-20 21:21:40.056220 | controller | changed 2026-05-20 21:21:40.061777 | 2026-05-20 21:21:40.061863 | TASK [gather-pod-logs : retrieve all kubernetes logs, current and previous (if they exist)] 2026-05-20 21:21:40.297333 | controller | environment: line 3: kubectl: command not found 2026-05-20 21:21:40.592033 | controller | ok: Runtime: 0:00:00.015429 2026-05-20 21:21:40.597755 | 2026-05-20 21:21:40.597830 | TASK [gather-pod-logs : Downloads pod logs to executor] 2026-05-20 21:21:41.146620 | controller | changed: 2026-05-20 21:21:41.146841 | controller | cd+++++++++ pod-logs/ 2026-05-20 21:21:41.146880 | controller | cd+++++++++ pod-logs/failed-pods/ 2026-05-20 21:21:41.154417 | 2026-05-20 21:21:41.154488 | LOOP [helm-release-status : creating directory for helm release status] 2026-05-20 21:21:41.404169 | controller | changed: "values" 2026-05-20 21:21:41.626063 | controller | changed: "releases" 2026-05-20 21:21:41.646753 | 2026-05-20 21:21:41.646928 | TASK [helm-release-status : Gather get release status for helm charts] 2026-05-20 21:21:41.892716 | controller | /bin/bash: line 3: kubectl: command not found 2026-05-20 21:21:42.176695 | controller | ok: Runtime: 0:00:00.009615 2026-05-20 21:21:42.181052 | 2026-05-20 21:21:42.181122 | TASK [helm-release-status : Downloads logs to executor] 2026-05-20 21:21:42.718179 | controller | changed: 2026-05-20 21:21:42.718402 | controller | cd+++++++++ helm/ 2026-05-20 21:21:42.718443 | controller | cd+++++++++ helm/releases/ 2026-05-20 21:21:42.718479 | controller | cd+++++++++ helm/values/ 2026-05-20 21:21:42.725569 | 2026-05-20 21:21:42.725787 | PLAY RECAP 2026-05-20 21:21:42.725897 | controller | ok: 12 changed: 12 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-05-20 21:21:42.726516 | 2026-05-20 21:21:42.866132 | POST-RUN END RESULT_NORMAL: [untrusted : github.com/vexxhost/ansible-collection-kubernetes/test-playbooks/molecule/post.yml@main] 2026-05-20 21:21:42.869392 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-05-20 21:21:43.506622 | 2026-05-20 21:21:43.506782 | PLAY [all] 2026-05-20 21:21:43.517092 | 2026-05-20 21:21:43.517193 | TASK [fetch-output : Set log path for multiple nodes] 2026-05-20 21:21:43.562294 | controller | skipping: Conditional result was False 2026-05-20 21:21:43.566971 | 2026-05-20 21:21:43.567055 | TASK [fetch-output : Set log path for single node] 2026-05-20 21:21:43.605384 | controller | ok 2026-05-20 21:21:43.609291 | 2026-05-20 21:21:43.609364 | LOOP [fetch-output : Ensure local output dirs] 2026-05-20 21:21:44.008812 | controller -> localhost | ok: "/var/lib/zuul/builds/f9b9a0efd86446f8aa15114a38f749c9/work/logs" 2026-05-20 21:21:44.219075 | controller -> localhost | changed: "/var/lib/zuul/builds/f9b9a0efd86446f8aa15114a38f749c9/work/artifacts" 2026-05-20 21:21:44.427183 | controller -> localhost | changed: "/var/lib/zuul/builds/f9b9a0efd86446f8aa15114a38f749c9/work/docs" 2026-05-20 21:21:44.445070 | 2026-05-20 21:21:44.445203 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-05-20 21:21:45.146162 | controller | changed: .d..t...... ./ 2026-05-20 21:21:45.146545 | controller | changed: All items complete 2026-05-20 21:21:45.146631 | 2026-05-20 21:21:45.629618 | controller | changed: .d..t...... ./ 2026-05-20 21:21:46.118722 | controller | changed: .d..t...... ./ 2026-05-20 21:21:46.130016 | 2026-05-20 21:21:46.130150 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-05-20 21:21:46.610122 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.010132 2026-05-20 21:21:46.832651 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007416 2026-05-20 21:21:46.842905 | 2026-05-20 21:21:46.843049 | PLAY [all] 2026-05-20 21:21:46.848166 | 2026-05-20 21:21:46.848233 | TASK [remove-build-sshkey : Remove the build SSH key from all nodes] 2026-05-20 21:21:47.325639 | controller | changed 2026-05-20 21:21:47.331842 | 2026-05-20 21:21:47.331901 | PLAY RECAP 2026-05-20 21:21:47.331951 | controller | ok: 5 changed: 4 unreachable: 0 failed: 0 skipped: 1 rescued: 0 ignored: 0 2026-05-20 21:21:47.331972 | 2026-05-20 21:21:47.449716 | POST-RUN END RESULT_NORMAL: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post.yaml@main] 2026-05-20 21:21:47.451833 | POST-RUN START: [trusted : github.com/vexxhost/zuul-config/playbooks/base/post-logs.yaml@main] 2026-05-20 21:21:48.026464 | 2026-05-20 21:21:48.026609 | PLAY [localhost] 2026-05-20 21:21:48.036367 | 2026-05-20 21:21:48.036444 | TASK [Generate Zuul manifest] 2026-05-20 21:21:48.054005 | localhost | ok 2026-05-20 21:21:48.068315 | 2026-05-20 21:21:48.068410 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-05-20 21:21:48.483494 | localhost | changed 2026-05-20 21:21:48.497153 | 2026-05-20 21:21:48.497233 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-05-20 21:21:48.529076 | localhost | ok 2026-05-20 21:21:48.537374 | 2026-05-20 21:21:48.537438 | TASK [Upload logs] 2026-05-20 21:21:48.569004 | localhost | ok 2026-05-20 21:21:48.632557 | 2026-05-20 21:21:48.632702 | TASK [Set zuul-log-path fact] 2026-05-20 21:21:48.655936 | localhost | ok 2026-05-20 21:21:48.670569 | 2026-05-20 21:21:48.670638 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-05-20 21:21:48.702020 | localhost | ok 2026-05-20 21:21:48.711164 | 2026-05-20 21:21:48.711231 | TASK [upload-logs : Create log directories] 2026-05-20 21:21:49.118970 | localhost | changed 2026-05-20 21:21:49.125420 | 2026-05-20 21:21:49.125497 | TASK [upload-logs : Ensure logs are readable before uploading] 2026-05-20 21:21:49.543420 | localhost -> localhost | ok: Runtime: 0:00:00.005073 2026-05-20 21:21:49.550812 | 2026-05-20 21:21:49.550913 | TASK [upload-logs : Upload logs to log server] 2026-05-20 21:21:50.010458 | localhost | Output suppressed because no_log was given 2026-05-20 21:21:50.015620 | 2026-05-20 21:21:50.015685 | LOOP [upload-logs : Compress console log and json output] 2026-05-20 21:21:50.066021 | localhost | skipping: Conditional result was False 2026-05-20 21:21:50.126458 | localhost | skipping: Conditional result was False 2026-05-20 21:21:50.141366 | 2026-05-20 21:21:50.141525 | LOOP [upload-logs : Upload compressed console log and json output] 2026-05-20 21:21:50.187838 | localhost | skipping: Conditional result was False 2026-05-20 21:21:50.188278 | 2026-05-20 21:21:50.192255 | localhost | skipping: Conditional result was False 2026-05-20 21:21:50.209654 | 2026-05-20 21:21:50.209736 | LOOP [upload-logs : Upload console log and json output]