2026-03-17 16:07:24.188655 | Job console starting... 2026-03-17 16:07:24.201101 | Updating repositories 2026-03-17 16:07:24.372955 | Preparing job workspace 2026-03-17 16:07:29.005145 | Running Ansible setup... 2026-03-17 16:07:33.904808 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-03-17 16:07:34.510921 | 2026-03-17 16:07:34.511053 | PLAY [localhost] 2026-03-17 16:07:34.519467 | 2026-03-17 16:07:34.519536 | TASK [Gathering Facts] 2026-03-17 16:07:35.553719 | localhost | ok 2026-03-17 16:07:35.583196 | 2026-03-17 16:07:35.583370 | TASK [Setup log path fact] 2026-03-17 16:07:35.605768 | localhost | ok 2026-03-17 16:07:35.623103 | 2026-03-17 16:07:35.623242 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-17 16:07:35.652395 | localhost | ok 2026-03-17 16:07:35.660235 | 2026-03-17 16:07:35.660298 | TASK [emit-job-header : Print job information] 2026-03-17 16:07:35.698365 | # Job Information 2026-03-17 16:07:35.698526 | Ansible Version: 2.15.12 2026-03-17 16:07:35.698557 | Job: ansible-test-sanity-docker-milestone 2026-03-17 16:07:35.698578 | Pipeline: third-party-check 2026-03-17 16:07:35.698596 | Executor: ze01.softwarefactory-project.io 2026-03-17 16:07:35.698613 | Triggered by: https://github.com/openshift/community.okd/pull/274 2026-03-17 16:07:35.698633 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/bd3/ansible/bd3693ab0e78404295f305126a7cea0e/ 2026-03-17 16:07:35.698652 | Event ID: 0874b8b0-2219-11f1-856c-61ff2b8ebbaf 2026-03-17 16:07:35.702407 | 2026-03-17 16:07:35.702471 | LOOP [emit-job-header : Print node information] 2026-03-17 16:07:35.805608 | localhost | ok: 2026-03-17 16:07:35.805783 | localhost | # Node Information 2026-03-17 16:07:35.805822 | localhost | Inventory Hostname: controller 2026-03-17 16:07:35.805850 | localhost | Hostname: np0005649927 2026-03-17 16:07:35.805877 | localhost | Username: zuul 2026-03-17 16:07:35.805907 | localhost | Distro: Fedora 37 2026-03-17 16:07:35.805933 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2026-03-17 16:07:35.805958 | localhost | Region: ca-ymq-1 2026-03-17 16:07:35.805982 | localhost | Label: ansible-fedora-37-1vcpu 2026-03-17 16:07:35.806005 | localhost | Product Name: OpenStack Nova 2026-03-17 16:07:35.806056 | localhost | Interface IP: 199.19.213.17 2026-03-17 16:07:35.819900 | 2026-03-17 16:07:35.820002 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-17 16:07:36.209986 | localhost -> localhost | changed 2026-03-17 16:07:36.215253 | 2026-03-17 16:07:36.215316 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-17 16:07:37.123381 | localhost -> localhost | changed 2026-03-17 16:07:37.151993 | 2026-03-17 16:07:37.152232 | PLAY [all:!appliance*] 2026-03-17 16:07:37.170984 | 2026-03-17 16:07:37.171094 | TASK [include_role : start-zuul-console] 2026-03-17 16:07:37.190623 | controller | ok 2026-03-17 16:07:37.203967 | 2026-03-17 16:07:37.204049 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-17 16:07:37.547533 | controller | ok 2026-03-17 16:07:37.558199 | 2026-03-17 16:07:37.558333 | TASK [use-our-mirror : Retrieve the IP address] 2026-03-17 16:07:38.407075 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2026-03-17 16:07:38.413639 | 2026-03-17 16:07:38.413707 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2026-03-17 16:07:38.946242 | controller | skipping: Conditional result was False 2026-03-17 16:07:38.955112 | 2026-03-17 16:07:38.955227 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2026-03-17 16:07:38.990247 | controller | skipping: Conditional result was False 2026-03-17 16:07:38.999634 | 2026-03-17 16:07:38.999812 | TASK [use-our-mirror : Create the podman configuration directory] 2026-03-17 16:07:39.025131 | controller | skipping: Conditional result was False 2026-03-17 16:07:39.033161 | 2026-03-17 16:07:39.033417 | TASK [use-our-mirror : Copy the podman configuration] 2026-03-17 16:07:39.059545 | controller | skipping: Conditional result was False 2026-03-17 16:07:39.065863 | 2026-03-17 16:07:39.065931 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2026-03-17 16:07:39.089765 | controller | skipping: Conditional result was False 2026-03-17 16:07:39.097274 | 2026-03-17 16:07:39.097348 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2026-03-17 16:07:39.125863 | controller | skipping: Conditional result was False 2026-03-17 16:07:39.137219 | 2026-03-17 16:07:39.137288 | TASK [Disable Fedora Modular] 2026-03-17 16:07:39.400386 | controller | changed 2026-03-17 16:07:39.406478 | 2026-03-17 16:07:39.406549 | TASK [Enable EPEL] 2026-03-17 16:07:39.430920 | controller | skipping: Conditional result was False 2026-03-17 16:07:39.437384 | 2026-03-17 16:07:39.437446 | TASK [Register the RHEL node] 2026-03-17 16:07:39.982928 | 2026-03-17 16:07:39.983238 | TASK [Show the subscription-manager status] 2026-03-17 16:07:40.568746 | controller | skipping: Conditional result was False 2026-03-17 16:07:40.583554 | 2026-03-17 16:07:40.583708 | TASK [Enable EPEL on RHEL] 2026-03-17 16:07:41.144494 | controller | skipping: Conditional result was False 2026-03-17 16:07:41.158226 | 2026-03-17 16:07:41.158377 | TASK [Install git and tox] 2026-03-17 16:09:08.449065 | controller | changed 2026-03-17 16:09:08.463782 | 2026-03-17 16:09:08.463970 | TASK [include_role : prepare-workspace] 2026-03-17 16:09:08.508494 | controller | ok 2026-03-17 16:09:08.548655 | 2026-03-17 16:09:08.548864 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-17 16:09:08.825891 | controller | ok 2026-03-17 16:09:08.832238 | 2026-03-17 16:09:08.832297 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-17 16:09:21.163345 | controller | Output suppressed because no_log was given 2026-03-17 16:09:21.173271 | 2026-03-17 16:09:21.173330 | TASK [include_role : prepare-workspace-openshift] 2026-03-17 16:09:21.197743 | controller | skipping: Conditional result was False 2026-03-17 16:09:21.219791 | 2026-03-17 16:09:21.219844 | PLAY [all:!appliance] 2026-03-17 16:09:21.236762 | 2026-03-17 16:09:21.236847 | TASK [Run add-build-sshkey role (RSA)] 2026-03-17 16:09:21.266689 | controller | ok 2026-03-17 16:09:21.281305 | 2026-03-17 16:09:21.281366 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-17 16:09:21.508149 | controller -> localhost | ok 2026-03-17 16:09:21.514689 | 2026-03-17 16:09:21.514751 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-17 16:09:21.545273 | controller | ok 2026-03-17 16:09:21.559250 | controller | included: /var/lib/zuul/builds/bd3693ab0e78404295f305126a7cea0e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-17 16:09:21.564860 | 2026-03-17 16:09:21.564917 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-17 16:09:22.015938 | controller -> localhost | Generating public/private rsa key pair. 2026-03-17 16:09:22.016322 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/bd3693ab0e78404295f305126a7cea0e/work/bd3693ab0e78404295f305126a7cea0e_id_rsa. 2026-03-17 16:09:22.016388 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/bd3693ab0e78404295f305126a7cea0e/work/bd3693ab0e78404295f305126a7cea0e_id_rsa.pub. 2026-03-17 16:09:22.016437 | controller -> localhost | The key fingerprint is: 2026-03-17 16:09:22.016483 | controller -> localhost | SHA256:x+KJRpefKDAayXClXqXi3RPuijcZ1PetGnBFY/1G8Hc zuul-build-sshkey 2026-03-17 16:09:22.016526 | controller -> localhost | The key's randomart image is: 2026-03-17 16:09:22.016569 | controller -> localhost | +---[RSA 2048]----+ 2026-03-17 16:09:22.016611 | controller -> localhost | | . . +... | 2026-03-17 16:09:22.016654 | controller -> localhost | | o o o .... | 2026-03-17 16:09:22.016696 | controller -> localhost | |. + o.. . o. E| 2026-03-17 16:09:22.016737 | controller -> localhost | | * =.o...+ o..| 2026-03-17 16:09:22.016777 | controller -> localhost | | *.+ *.S.o. . | 2026-03-17 16:09:22.016834 | controller -> localhost | | o.= B *... | 2026-03-17 16:09:22.016884 | controller -> localhost | | . o= = o. | 2026-03-17 16:09:22.016932 | controller -> localhost | | .+o . .. | 2026-03-17 16:09:22.016974 | controller -> localhost | | .... .. | 2026-03-17 16:09:22.017053 | controller -> localhost | +----[SHA256]-----+ 2026-03-17 16:09:22.017163 | controller -> localhost | ok: Runtime: 0:00:00.096572 2026-03-17 16:09:22.031199 | 2026-03-17 16:09:22.031290 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-17 16:09:22.053730 | controller | ok 2026-03-17 16:09:22.067750 | controller | included: /var/lib/zuul/builds/bd3693ab0e78404295f305126a7cea0e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-17 16:09:22.080138 | 2026-03-17 16:09:22.080219 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-17 16:09:22.104893 | controller | skipping: Conditional result was False 2026-03-17 16:09:22.110934 | 2026-03-17 16:09:22.110993 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-17 16:09:22.545473 | controller | changed 2026-03-17 16:09:22.551166 | 2026-03-17 16:09:22.551224 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-17 16:09:22.762751 | controller | ok 2026-03-17 16:09:22.768344 | 2026-03-17 16:09:22.768403 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-17 16:09:23.393566 | controller | changed 2026-03-17 16:09:23.403713 | 2026-03-17 16:09:23.404049 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-17 16:09:24.065218 | controller | changed 2026-03-17 16:09:24.073442 | 2026-03-17 16:09:24.073588 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-17 16:09:24.110694 | controller | skipping: Conditional result was False 2026-03-17 16:09:24.120233 | 2026-03-17 16:09:24.120351 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-17 16:09:24.519290 | controller -> localhost | changed 2026-03-17 16:09:24.546579 | 2026-03-17 16:09:24.546752 | TASK [add-build-sshkey : Add back temp key] 2026-03-17 16:09:24.839511 | controller -> localhost | Identity added: /var/lib/zuul/builds/bd3693ab0e78404295f305126a7cea0e/work/bd3693ab0e78404295f305126a7cea0e_id_rsa (zuul-build-sshkey) 2026-03-17 16:09:24.839739 | controller -> localhost | ok: Runtime: 0:00:00.007649 2026-03-17 16:09:24.846140 | 2026-03-17 16:09:24.846201 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-17 16:09:25.179985 | controller | ok 2026-03-17 16:09:25.194343 | 2026-03-17 16:09:25.194482 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-17 16:09:25.234152 | controller | skipping: Conditional result was False 2026-03-17 16:09:25.250413 | 2026-03-17 16:09:25.250504 | TASK [Run add-build-sshkey role (ECDSA)] 2026-03-17 16:09:25.284655 | controller | ok 2026-03-17 16:09:25.307443 | 2026-03-17 16:09:25.307583 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-17 16:09:25.557420 | controller -> localhost | ok 2026-03-17 16:09:25.563931 | 2026-03-17 16:09:25.563998 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-17 16:09:25.584760 | controller | ok 2026-03-17 16:09:25.595733 | controller | included: /var/lib/zuul/builds/bd3693ab0e78404295f305126a7cea0e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-17 16:09:25.603141 | 2026-03-17 16:09:25.603213 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-17 16:09:25.904307 | controller -> localhost | Generating public/private ecdsa key pair. 2026-03-17 16:09:25.904705 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/bd3693ab0e78404295f305126a7cea0e/work/bd3693ab0e78404295f305126a7cea0e_id_ecdsa. 2026-03-17 16:09:25.904766 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/bd3693ab0e78404295f305126a7cea0e/work/bd3693ab0e78404295f305126a7cea0e_id_ecdsa.pub. 2026-03-17 16:09:25.904829 | controller -> localhost | The key fingerprint is: 2026-03-17 16:09:25.904885 | controller -> localhost | SHA256:8xxrdWpPMRNvk8mj08NzImbeyabqdTzLacG+QGhXFj8 zuul-build-sshkey 2026-03-17 16:09:25.904940 | controller -> localhost | The key's randomart image is: 2026-03-17 16:09:25.904983 | controller -> localhost | +---[ECDSA 521]---+ 2026-03-17 16:09:25.905065 | controller -> localhost | | . | 2026-03-17 16:09:25.905116 | controller -> localhost | | o | 2026-03-17 16:09:25.905156 | controller -> localhost | | +E.| 2026-03-17 16:09:25.905230 | controller -> localhost | | . o.o+| 2026-03-17 16:09:25.905276 | controller -> localhost | | S + +.=*o| 2026-03-17 16:09:25.905314 | controller -> localhost | | = * +*=o| 2026-03-17 16:09:25.905351 | controller -> localhost | | = O+**.| 2026-03-17 16:09:25.905388 | controller -> localhost | | . * X=*+| 2026-03-17 16:09:25.905425 | controller -> localhost | | .o.o+X. | 2026-03-17 16:09:25.905462 | controller -> localhost | +----[SHA256]-----+ 2026-03-17 16:09:25.905557 | controller -> localhost | ok: Runtime: 0:00:00.016367 2026-03-17 16:09:25.921981 | 2026-03-17 16:09:25.922178 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-17 16:09:25.947849 | controller | ok 2026-03-17 16:09:25.959923 | controller | included: /var/lib/zuul/builds/bd3693ab0e78404295f305126a7cea0e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-17 16:09:25.976119 | 2026-03-17 16:09:25.976291 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-17 16:09:25.991786 | controller | skipping: Conditional result was False 2026-03-17 16:09:25.999520 | 2026-03-17 16:09:25.999649 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-17 16:09:26.291915 | controller | changed 2026-03-17 16:09:26.306347 | 2026-03-17 16:09:26.306530 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-17 16:09:26.524917 | controller | ok 2026-03-17 16:09:26.538509 | 2026-03-17 16:09:26.538687 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-17 16:09:27.790551 | controller | changed 2026-03-17 16:09:27.799096 | 2026-03-17 16:09:27.799223 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-17 16:09:28.429658 | controller | changed 2026-03-17 16:09:28.475961 | 2026-03-17 16:09:28.476105 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-17 16:09:28.510850 | controller | skipping: Conditional result was False 2026-03-17 16:09:28.517276 | 2026-03-17 16:09:28.517343 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-17 16:09:28.797259 | controller -> localhost | changed 2026-03-17 16:09:28.815495 | 2026-03-17 16:09:28.815668 | TASK [add-build-sshkey : Add back temp key] 2026-03-17 16:09:29.124300 | controller -> localhost | Identity added: /var/lib/zuul/builds/bd3693ab0e78404295f305126a7cea0e/work/bd3693ab0e78404295f305126a7cea0e_id_ecdsa (zuul-build-sshkey) 2026-03-17 16:09:29.124649 | controller -> localhost | ok: Runtime: 0:00:00.009019 2026-03-17 16:09:29.142276 | 2026-03-17 16:09:29.142588 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-17 16:09:29.361912 | controller | ok 2026-03-17 16:09:29.375178 | 2026-03-17 16:09:29.375314 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-17 16:09:29.413235 | controller | skipping: Conditional result was False 2026-03-17 16:09:29.438792 | 2026-03-17 16:09:29.439094 | TASK [include_role : remove-zuul-sshkey] 2026-03-17 16:09:29.465923 | controller | skipping: Conditional result was False 2026-03-17 16:09:29.475813 | 2026-03-17 16:09:29.475914 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-17 16:09:29.717153 | controller | ok: "logs" 2026-03-17 16:09:29.717487 | controller | ok: All items complete 2026-03-17 16:09:29.717527 | 2026-03-17 16:09:29.903687 | controller | ok: "artifacts" 2026-03-17 16:09:30.116840 | controller | ok: "docs" 2026-03-17 16:09:30.126193 | 2026-03-17 16:09:30.126324 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-17 16:09:30.365590 | controller | changed: "logs" 2026-03-17 16:09:30.578380 | controller | changed: "artifacts" 2026-03-17 16:09:30.793636 | controller | changed: "docs" 2026-03-17 16:09:30.828489 | 2026-03-17 16:09:30.828604 | PLAY RECAP 2026-03-17 16:09:30.828647 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2026-03-17 16:09:30.828676 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-17 16:09:30.828699 | 2026-03-17 16:09:30.974217 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-03-17 16:09:30.975463 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-03-17 16:09:31.586161 | 2026-03-17 16:09:31.586296 | PLAY [all] 2026-03-17 16:09:31.608730 | 2026-03-17 16:09:31.608834 | TASK [Install binary dependencies] 2026-03-17 16:09:31.659229 | controller | ok 2026-03-17 16:09:31.678936 | 2026-03-17 16:09:31.679048 | TASK [bindep : Include find tasks] 2026-03-17 16:09:31.718917 | controller | ok 2026-03-17 16:09:31.726850 | controller | included: /var/lib/zuul/builds/bd3693ab0e78404295f305126a7cea0e/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-03-17 16:09:31.733374 | 2026-03-17 16:09:31.733442 | TASK [bindep : Look for bindep.txt] 2026-03-17 16:09:32.122893 | controller | ok 2026-03-17 16:09:32.138234 | 2026-03-17 16:09:32.138391 | TASK [bindep : Define bindep_file fact] 2026-03-17 16:09:32.155557 | controller | skipping: Conditional result was False 2026-03-17 16:09:32.177753 | 2026-03-17 16:09:32.178002 | TASK [bindep : Look for other-requirements.txt] 2026-03-17 16:09:32.393367 | controller | ok 2026-03-17 16:09:32.401846 | 2026-03-17 16:09:32.401999 | TASK [bindep : Define bindep_file fact] 2026-03-17 16:09:32.426845 | controller | skipping: Conditional result was False 2026-03-17 16:09:32.434080 | 2026-03-17 16:09:32.434169 | TASK [bindep : Look for bindep fallback file] 2026-03-17 16:09:32.458362 | controller | skipping: Conditional result was False 2026-03-17 16:09:32.466517 | 2026-03-17 16:09:32.466630 | TASK [bindep : Define bindep_file fact] 2026-03-17 16:09:32.492684 | controller | skipping: Conditional result was False 2026-03-17 16:09:32.499077 | 2026-03-17 16:09:32.499160 | TASK [bindep : Include bindep tasks] 2026-03-17 16:09:32.522931 | controller | skipping: Conditional result was False 2026-03-17 16:09:32.528813 | 2026-03-17 16:09:32.528886 | TASK [bindep : Include install tasks] 2026-03-17 16:09:32.552173 | controller | skipping: Conditional result was False 2026-03-17 16:09:32.558778 | 2026-03-17 16:09:32.558857 | LOOP [bindep : Include package tasks] 2026-03-17 16:09:32.613513 | 2026-03-17 16:09:32.613673 | TASK [Run test-setup role] 2026-03-17 16:09:32.633080 | controller | ok 2026-03-17 16:09:32.649033 | 2026-03-17 16:09:32.649118 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-03-17 16:09:32.853533 | controller | ok 2026-03-17 16:09:32.862069 | 2026-03-17 16:09:32.862169 | TASK [test-setup : Run tools/test-setup.sh] 2026-03-17 16:09:33.414069 | controller | skipping: Conditional result was False 2026-03-17 16:09:33.450409 | 2026-03-17 16:09:33.450521 | PLAY RECAP 2026-03-17 16:09:33.450574 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-03-17 16:09:33.450602 | 2026-03-17 16:09:33.563480 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-03-17 16:09:33.564397 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-03-17 16:09:34.132679 | 2026-03-17 16:09:34.132825 | PLAY [controller] 2026-03-17 16:09:34.153413 | 2026-03-17 16:09:34.153524 | TASK [Create the /root directory] 2026-03-17 16:09:34.551132 | controller | ok 2026-03-17 16:09:34.565147 | 2026-03-17 16:09:34.565341 | TASK [Install glibc-langpack-en] 2026-03-17 16:09:38.446309 | controller | ok: Nothing to do 2026-03-17 16:09:38.452136 | 2026-03-17 16:09:38.452205 | TASK [Ensure controller directory exists] 2026-03-17 16:09:38.663974 | controller | changed 2026-03-17 16:09:38.669951 | 2026-03-17 16:09:38.670033 | TASK [Install container runtime] 2026-03-17 16:09:38.729909 | controller | ok 2026-03-17 16:09:38.766469 | 2026-03-17 16:09:38.766586 | LOOP [ensure-podman : Find distribution installation] 2026-03-17 16:09:38.801591 | controller | ok: "/var/lib/zuul/builds/bd3693ab0e78404295f305126a7cea0e/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml" 2026-03-17 16:09:38.818931 | controller | included: /var/lib/zuul/builds/bd3693ab0e78404295f305126a7cea0e/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml 2026-03-17 16:09:38.825793 | 2026-03-17 16:09:38.825857 | TASK [ensure-podman : Install podman (RedHat)] 2026-03-17 16:10:44.264185 | controller | changed 2026-03-17 16:10:44.270495 | 2026-03-17 16:10:44.270558 | TASK [ensure-podman : Fetch podman version] 2026-03-17 16:10:44.809723 | controller | Client: Podman Engine 2026-03-17 16:10:44.841355 | controller | Version: 4.6.2 2026-03-17 16:10:44.841394 | controller | API Version: 4.6.2 2026-03-17 16:10:44.841401 | controller | Go Version: go1.19.12 2026-03-17 16:10:44.841418 | controller | Built: Mon Aug 28 19:38:31 2023 2026-03-17 16:10:44.841426 | controller | OS/Arch: linux/amd64 2026-03-17 16:10:45.302486 | controller | ok: Runtime: 0:00:00.192256 2026-03-17 16:10:45.317949 | 2026-03-17 16:10:45.318149 | TASK [ensure-podman : Print podman version installed] 2026-03-17 16:10:45.357616 | Podman version: Client: Podman Engine 2026-03-17 16:10:45.357862 | Version: 4.6.2 2026-03-17 16:10:45.357925 | API Version: 4.6.2 2026-03-17 16:10:45.357970 | Go Version: go1.19.12 2026-03-17 16:10:45.358010 | Built: Mon Aug 28 19:38:31 2023 2026-03-17 16:10:45.358092 | OS/Arch: linux/amd64 2026-03-17 16:10:45.371171 | 2026-03-17 16:10:45.371303 | TASK [ensure-podman : Validate podman engine] 2026-03-17 16:10:45.915078 | controller | skipping: Conditional result was False 2026-03-17 16:10:45.930493 | 2026-03-17 16:10:45.930666 | TASK [ensure-podman : Set up docker compatability socket] 2026-03-17 16:10:45.947933 | controller | skipping: Conditional result was False 2026-03-17 16:10:45.973495 | 2026-03-17 16:10:45.973691 | TASK [Ensure python3.8 is present] 2026-03-17 16:10:46.000141 | controller | skipping: Conditional result was False 2026-03-17 16:10:46.008546 | 2026-03-17 16:10:46.008658 | TASK [Run our-ensure-python role (Fedora only for now)] 2026-03-17 16:10:46.031790 | controller | ok 2026-03-17 16:10:46.067620 | 2026-03-17 16:10:46.067876 | TASK [our-ensure-python : Install the right Python version (rpm)] 2026-03-17 16:10:47.445291 | controller | ok: Nothing to do 2026-03-17 16:10:47.455815 | 2026-03-17 16:10:47.455955 | TASK [our-ensure-python : Also install python3-devel] 2026-03-17 16:10:56.244096 | controller | changed 2026-03-17 16:10:56.254936 | 2026-03-17 16:10:56.255012 | TASK [Run ensure-virtualenv role] 2026-03-17 16:10:56.284698 | controller | ok 2026-03-17 16:10:56.342834 | 2026-03-17 16:10:56.342986 | TASK [ensure-virtualenv : Check if virtualenv is installed] 2026-03-17 16:10:56.606011 | controller | /usr/bin/virtualenv 2026-03-17 16:10:56.921520 | controller | ok: Runtime: 0:00:00.005066 2026-03-17 16:10:56.930571 | 2026-03-17 16:10:56.930666 | LOOP [ensure-virtualenv : Install virtualenv package] 2026-03-17 16:10:56.956695 | controller | skipping: Conditional result was False 2026-03-17 16:10:56.956985 | controller | ok: All items complete 2026-03-17 16:10:56.957028 | 2026-03-17 16:10:56.982214 | 2026-03-17 16:10:56.982375 | TASK [Find the full path of the Python interpreter] 2026-03-17 16:10:57.222600 | controller | /usr/bin/python3 2026-03-17 16:10:57.523472 | controller | ok 2026-03-17 16:10:57.529473 | 2026-03-17 16:10:57.529554 | TASK [Create virtualenv for ansible-test with a specific interpreter] 2026-03-17 16:10:58.423665 | controller | created virtual environment CPython3.11.0.final.0-64 in 540ms 2026-03-17 16:10:58.453343 | controller | creator CPython3Posix(dest=/home/zuul/venv, clear=False, no_vcs_ignore=False, global=False) 2026-03-17 16:10:58.453380 | controller | seeder FromAppData(extra_search_dir=/usr/share/python-wheels,download=False, pip=bundle, setuptools=bundle, wheel=bundle, via=copy, app_data_dir=/home/zuul/.local/share/virtualenv) 2026-03-17 16:10:58.453391 | controller | added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1 2026-03-17 16:10:58.453404 | controller | activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator 2026-03-17 16:10:58.580899 | controller | changed 2026-03-17 16:10:58.594718 | 2026-03-17 16:10:58.594863 | TASK [Set selinux package] 2026-03-17 16:10:58.634277 | controller | ok 2026-03-17 16:10:58.645722 | 2026-03-17 16:10:58.645849 | TASK [Set selinux package (Fedora)] 2026-03-17 16:10:58.701624 | controller | ok 2026-03-17 16:10:58.713613 | 2026-03-17 16:10:58.713757 | TASK [Install selinux into virtualenv] 2026-03-17 16:11:24.217321 | controller | Collecting selinux-please-lie-to-me 2026-03-17 16:11:36.482247 | controller | Downloading selinux_please_lie_to_me-1.0.1-py2.py3-none-any.whl (3.8 kB) 2026-03-17 16:11:36.797551 | controller | Collecting setuptools<50.0.0 2026-03-17 16:11:36.802674 | controller | Downloading setuptools-49.6.0-py3-none-any.whl (803 kB) 2026-03-17 16:11:36.844482 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 803.3/803.3 kB 20.9 MB/s eta 0:00:00 2026-03-17 16:11:36.930766 | controller | Installing collected packages: setuptools, selinux-please-lie-to-me 2026-03-17 16:11:36.931004 | controller | Attempting uninstall: setuptools 2026-03-17 16:11:36.933477 | controller | Found existing installation: setuptools 62.6.0 2026-03-17 16:11:36.993646 | controller | Uninstalling setuptools-62.6.0: 2026-03-17 16:11:37.002277 | controller | Successfully uninstalled setuptools-62.6.0 2026-03-17 16:11:37.348809 | controller | Successfully installed selinux-please-lie-to-me-1.0.1 setuptools-49.6.0 2026-03-17 16:11:50.808678 | controller | 2026-03-17 16:11:50.918029 | controller | [notice] A new release of pip available: 22.2.2 -> 26.0.1 2026-03-17 16:11:50.918070 | controller | [notice] To update, run: python -m pip install --upgrade pip 2026-03-17 16:11:51.297984 | controller | ok: Runtime: 0:00:51.975638 2026-03-17 16:11:51.311967 | 2026-03-17 16:11:51.312199 | TASK [Install pytest-forked into virtualenv] 2026-03-17 16:12:16.197204 | controller | Collecting pytest-forked 2026-03-17 16:12:28.442644 | controller | Downloading pytest_forked-1.6.0-py3-none-any.whl (4.9 kB) 2026-03-17 16:12:28.491807 | controller | Collecting py 2026-03-17 16:12:28.497400 | controller | Downloading py-1.11.0-py2.py3-none-any.whl (98 kB) 2026-03-17 16:12:28.515087 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.7/98.7 kB 6.5 MB/s eta 0:00:00 2026-03-17 16:12:28.623701 | controller | Collecting pytest>=3.10 2026-03-17 16:12:28.626971 | controller | Downloading pytest-9.0.2-py3-none-any.whl (374 kB) 2026-03-17 16:12:28.658935 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 374.8/374.8 kB 13.3 MB/s eta 0:00:00 2026-03-17 16:12:28.697765 | controller | Collecting iniconfig>=1.0.1 2026-03-17 16:12:28.704018 | controller | Downloading iniconfig-2.3.0-py3-none-any.whl (7.5 kB) 2026-03-17 16:12:28.754730 | controller | Collecting packaging>=22 2026-03-17 16:12:28.758303 | controller | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-03-17 16:12:28.765376 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 13.8 MB/s eta 0:00:00 2026-03-17 16:12:28.795004 | controller | Collecting pluggy<2,>=1.5 2026-03-17 16:12:28.798310 | controller | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-03-17 16:12:28.848133 | controller | Collecting pygments>=2.7.2 2026-03-17 16:12:28.851253 | controller | Downloading pygments-2.19.2-py3-none-any.whl (1.2 MB) 2026-03-17 16:12:28.877733 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.2/1.2 MB 51.8 MB/s eta 0:00:00 2026-03-17 16:12:28.947514 | controller | Installing collected packages: pygments, py, pluggy, packaging, iniconfig, pytest, pytest-forked 2026-03-17 16:12:30.096616 | controller | Successfully installed iniconfig-2.3.0 packaging-26.0 pluggy-1.6.0 py-1.11.0 pygments-2.19.2 pytest-9.0.2 pytest-forked-1.6.0 2026-03-17 16:12:30.105496 | controller | 2026-03-17 16:12:30.177730 | controller | [notice] A new release of pip available: 22.2.2 -> 26.0.1 2026-03-17 16:12:30.177771 | controller | [notice] To update, run: python -m pip install --upgrade pip 2026-03-17 16:12:30.389235 | controller | ok: Runtime: 0:00:38.632606 2026-03-17 16:12:30.401860 | 2026-03-17 16:12:30.401982 | TASK [Update pip] 2026-03-17 16:12:30.971448 | controller | Requirement already satisfied: pip in ./venv/lib/python3.11/site-packages (22.2.2) 2026-03-17 16:12:52.772357 | controller | Collecting pip 2026-03-17 16:13:05.115905 | controller | Downloading pip-26.0.1-py3-none-any.whl (1.8 MB) 2026-03-17 16:13:05.180116 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.8/1.8 MB 33.1 MB/s eta 0:00:00 2026-03-17 16:13:05.244538 | controller | Installing collected packages: pip 2026-03-17 16:13:05.244666 | controller | Attempting uninstall: pip 2026-03-17 16:13:05.246812 | controller | Found existing installation: pip 22.2.2 2026-03-17 16:13:05.387252 | controller | Uninstalling pip-22.2.2: 2026-03-17 16:13:05.402997 | controller | Successfully uninstalled pip-22.2.2 2026-03-17 16:13:06.219979 | controller | Successfully installed pip-26.0.1 2026-03-17 16:13:06.508239 | controller | ok: Runtime: 0:00:35.624841 2026-03-17 16:13:06.521974 | 2026-03-17 16:13:06.522157 | TASK [Ensure pip temp directory exists in /var/tmp] 2026-03-17 16:13:06.766220 | controller | changed 2026-03-17 16:13:06.778130 | 2026-03-17 16:13:06.778382 | TASK [Install ansible into virtualenv] 2026-03-17 16:13:07.288218 | controller | Processing ./src/github.com/ansible/ansible 2026-03-17 16:13:07.290686 | controller | Installing build dependencies: started 2026-03-17 16:13:29.992540 | controller | Installing build dependencies: finished with status 'done' 2026-03-17 16:13:29.993251 | controller | Getting requirements to build wheel: started 2026-03-17 16:13:30.724115 | controller | Getting requirements to build wheel: finished with status 'done' 2026-03-17 16:13:30.724893 | controller | Preparing metadata (pyproject.toml): started 2026-03-17 16:13:31.253099 | controller | Preparing metadata (pyproject.toml): finished with status 'done' 2026-03-17 16:13:31.257950 | controller | INFO: pip is looking at multiple versions of ansible-core to determine which version is compatible with other requirements. This could take a while. 2026-03-17 16:13:31.261694 | controller | ERROR: Package 'ansible-core' requires a different Python: 3.11.0 not in '>=3.12' 2026-03-17 16:13:31.356402 | controller | ERROR 2026-03-17 16:13:31.356703 | controller | { 2026-03-17 16:13:31.356764 | controller | "delta": "0:00:24.315048", 2026-03-17 16:13:31.356805 | controller | "end": "2026-03-17 16:13:31.323147", 2026-03-17 16:13:31.356843 | controller | "msg": "non-zero return code", 2026-03-17 16:13:31.356893 | controller | "rc": 1, 2026-03-17 16:13:31.356929 | controller | "start": "2026-03-17 16:13:07.008099" 2026-03-17 16:13:31.356963 | controller | } failure 2026-03-17 16:13:31.359817 | 2026-03-17 16:13:31.359919 | PLAY RECAP 2026-03-17 16:13:31.360001 | controller | ok: 18 changed: 10 unreachable: 0 failed: 1 skipped: 4 rescued: 0 ignored: 0 2026-03-17 16:13:31.360079 | 2026-03-17 16:13:31.477464 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-03-17 16:13:31.479496 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-17 16:13:32.056829 | 2026-03-17 16:13:32.056981 | PLAY [all] 2026-03-17 16:13:32.079761 | 2026-03-17 16:13:32.079843 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-03-17 16:13:32.363636 | controller | changed: non-zero return code 2026-03-17 16:13:32.369586 | 2026-03-17 16:13:32.369659 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-03-17 16:13:32.383700 | controller | skipping: Conditional result was False 2026-03-17 16:13:32.389909 | 2026-03-17 16:13:32.389977 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-03-17 16:13:32.409701 | 2026-03-17 16:13:32.409850 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-03-17 16:13:32.429848 | 2026-03-17 16:13:32.429972 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-03-17 16:13:32.444255 | controller | skipping: Conditional result was False 2026-03-17 16:13:32.451736 | 2026-03-17 16:13:32.451804 | LOOP [fetch-subunit-output : Generate subunit file] 2026-03-17 16:13:32.470842 | 2026-03-17 16:13:32.470986 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-03-17 16:13:32.484554 | controller | skipping: Conditional result was False 2026-03-17 16:13:32.490802 | 2026-03-17 16:13:32.490866 | TASK [fetch-subunit-output : Remove the temporary file] 2026-03-17 16:13:32.505983 | controller | skipping: Conditional result was False 2026-03-17 16:13:32.512678 | 2026-03-17 16:13:32.512742 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-03-17 16:13:32.526763 | controller | skipping: Conditional result was False 2026-03-17 16:13:32.552684 | 2026-03-17 16:13:32.552741 | PLAY RECAP 2026-03-17 16:13:32.552781 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-03-17 16:13:32.552800 | 2026-03-17 16:13:32.643926 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-17 16:13:32.645578 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2026-03-17 16:13:33.236431 | 2026-03-17 16:13:33.236539 | PLAY [all:!appliance*] 2026-03-17 16:13:33.257554 | 2026-03-17 16:13:33.257632 | TASK [unregister the node] 2026-03-17 16:13:33.788590 | controller | skipping: Conditional result was False 2026-03-17 16:13:33.801781 | 2026-03-17 16:13:33.801950 | TASK [include_role : fetch-output] 2026-03-17 16:13:33.860555 | controller | ok 2026-03-17 16:13:33.890727 | 2026-03-17 16:13:33.890835 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-17 16:13:33.966501 | controller | skipping: Conditional result was False 2026-03-17 16:13:33.974487 | 2026-03-17 16:13:33.974576 | TASK [fetch-output : Set log path for single node] 2026-03-17 16:13:34.016381 | controller | ok 2026-03-17 16:13:34.023601 | 2026-03-17 16:13:34.023686 | LOOP [fetch-output : Ensure local output dirs] 2026-03-17 16:13:34.462649 | controller -> localhost | ok: "/var/lib/zuul/builds/bd3693ab0e78404295f305126a7cea0e/work/logs" 2026-03-17 16:13:34.716503 | controller -> localhost | changed: "/var/lib/zuul/builds/bd3693ab0e78404295f305126a7cea0e/work/artifacts" 2026-03-17 16:13:34.968900 | controller -> localhost | changed: "/var/lib/zuul/builds/bd3693ab0e78404295f305126a7cea0e/work/docs" 2026-03-17 16:13:34.981404 | 2026-03-17 16:13:34.981476 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-17 16:13:35.584959 | controller | changed: 2026-03-17 16:13:35.585371 | controller | .d..t...... ./ 2026-03-17 16:13:35.585437 | controller | cd+++++++++ controller/ 2026-03-17 16:13:35.585507 | controller | changed: All items complete 2026-03-17 16:13:35.585550 | 2026-03-17 16:13:36.087977 | controller | changed: .d..t...... ./ 2026-03-17 16:13:36.523661 | controller | changed: .d..t...... ./ 2026-03-17 16:13:36.556176 | 2026-03-17 16:13:36.556282 | TASK [include_role : fetch-output-openshift] 2026-03-17 16:13:36.581535 | controller | skipping: Conditional result was False 2026-03-17 16:13:36.594999 | 2026-03-17 16:13:36.595182 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-17 16:13:37.011352 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.013161 2026-03-17 16:13:37.254928 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.016694 2026-03-17 16:13:37.296234 | 2026-03-17 16:13:37.296354 | PLAY [localhost] 2026-03-17 16:13:37.308993 | 2026-03-17 16:13:37.309081 | TASK [Run Zuul manifest role] 2026-03-17 16:13:37.326405 | localhost | ok 2026-03-17 16:13:37.338835 | 2026-03-17 16:13:37.338923 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-17 16:13:37.691302 | localhost | changed 2026-03-17 16:13:37.696581 | 2026-03-17 16:13:37.696648 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-17 16:13:37.728825 | localhost | ok 2026-03-17 16:13:37.736924 | 2026-03-17 16:13:37.736989 | TASK [Set zuul-log-path fact] 2026-03-17 16:13:37.754982 | localhost | ok 2026-03-17 16:13:37.768641 | 2026-03-17 16:13:37.768714 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-17 16:13:37.796417 | localhost | ok 2026-03-17 16:13:37.804975 | 2026-03-17 16:13:37.805064 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)] 2026-03-17 16:13:37.843310 | localhost | ok: 2026-03-17 16:13:37.843828 | localhost | { 2026-03-17 16:13:37.843878 | localhost | "auth": { 2026-03-17 16:13:37.843907 | localhost | "password": "IonWCwcuOFib&&<}wp^:[2G/", 2026-03-17 16:13:37.843932 | localhost | "username": "9LF91O0RK7JU" 2026-03-17 16:13:37.843955 | localhost | }, 2026-03-17 16:13:37.843978 | localhost | "profile": "rackspace", 2026-03-17 16:13:37.844000 | localhost | "region_name": "ORD" 2026-03-17 16:13:37.844050 | localhost | } 2026-03-17 16:13:37.844098 | localhost | changed: All items complete 2026-03-17 16:13:37.844127 | 2026-03-17 16:13:37.856548 | 2026-03-17 16:13:37.856690 | TASK [Run upload-logs-failover role (S3 then Swift)] 2026-03-17 16:13:37.877338 | localhost | Output suppressed because no_log was given 2026-03-17 16:13:37.896345 | 2026-03-17 16:13:37.896436 | TASK [upload-logs-failover : Initialize control vars] 2026-03-17 16:13:37.956194 | localhost | ok 2026-03-17 16:13:37.960756 | 2026-03-17 16:13:37.960818 | LOOP [upload-logs-failover : Perform log upload] 2026-03-17 16:13:37.994814 | localhost | Output suppressed because no_log was given 2026-03-17 16:13:38.001410 | localhost | included: /var/lib/zuul/builds/bd3693ab0e78404295f305126a7cea0e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml 2026-03-17 16:13:38.007975 | 2026-03-17 16:13:38.008058 | LOOP [upload-logs-failover : Unpack vars for swift upload] 2026-03-17 16:13:38.093458 | localhost | Output suppressed because no_log was given 2026-03-17 16:13:38.099234 | 2026-03-17 16:13:38.099309 | TASK [Upload logs to swift] 2026-03-17 16:13:38.123436 | localhost | ok 2026-03-17 16:13:38.164492 | 2026-03-17 16:13:38.164602 | TASK [Set zuul-log-path fact] 2026-03-17 16:13:38.189318 | localhost | skipping: Conditional result was False 2026-03-17 16:13:38.196639 | 2026-03-17 16:13:38.196725 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2026-03-17 16:13:38.457542 | localhost -> localhost | ok: Runtime: 0:00:00.006908 2026-03-17 16:13:38.466699 | 2026-03-17 16:13:38.466914 | TASK [upload-logs-swift : Upload logs to swift]