2026-03-16 18:28:25.305471 | Job console starting... 2026-03-16 18:28:25.316038 | Updating repositories 2026-03-16 18:28:25.480401 | Preparing job workspace 2026-03-16 18:28:30.605855 | Running Ansible setup... 2026-03-16 18:28:35.582147 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-03-16 18:28:36.219916 | 2026-03-16 18:28:36.220096 | PLAY [localhost] 2026-03-16 18:28:36.230170 | 2026-03-16 18:28:36.230288 | TASK [Gathering Facts] 2026-03-16 18:28:37.265270 | localhost | ok 2026-03-16 18:28:37.301516 | 2026-03-16 18:28:37.301684 | TASK [Setup log path fact] 2026-03-16 18:28:37.325122 | localhost | ok 2026-03-16 18:28:37.345517 | 2026-03-16 18:28:37.345741 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-16 18:28:37.375142 | localhost | ok 2026-03-16 18:28:37.382763 | 2026-03-16 18:28:37.382827 | TASK [emit-job-header : Print job information] 2026-03-16 18:28:37.421147 | # Job Information 2026-03-16 18:28:37.421300 | Ansible Version: 2.15.12 2026-03-16 18:28:37.421333 | Job: ansible-test-sanity-docker-milestone 2026-03-16 18:28:37.421355 | Pipeline: third-party-check 2026-03-16 18:28:37.421374 | Executor: ze02.softwarefactory-project.io 2026-03-16 18:28:37.421463 | Triggered by: https://github.com/openshift/community.okd/pull/274 2026-03-16 18:28:37.421496 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/52d/ansible/52d7f078c25545058137ccc7cdad04a8/ 2026-03-16 18:28:37.421517 | Event ID: d09f04b0-2162-11f1-88b4-9de1352b0e9b 2026-03-16 18:28:37.425177 | 2026-03-16 18:28:37.425238 | LOOP [emit-job-header : Print node information] 2026-03-16 18:28:37.528111 | localhost | ok: 2026-03-16 18:28:37.528304 | localhost | # Node Information 2026-03-16 18:28:37.528341 | localhost | Inventory Hostname: controller 2026-03-16 18:28:37.528364 | localhost | Hostname: np0005649098 2026-03-16 18:28:37.528409 | localhost | Username: zuul 2026-03-16 18:28:37.528446 | localhost | Distro: Fedora 37 2026-03-16 18:28:37.528476 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2026-03-16 18:28:37.528505 | localhost | Region: ca-ymq-1 2026-03-16 18:28:37.528528 | localhost | Label: ansible-fedora-37-1vcpu 2026-03-16 18:28:37.528572 | localhost | Product Name: OpenStack Nova 2026-03-16 18:28:37.528610 | localhost | Interface IP: 199.204.45.244 2026-03-16 18:28:37.541856 | 2026-03-16 18:28:37.542006 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-16 18:28:37.955468 | localhost -> localhost | changed 2026-03-16 18:28:37.961351 | 2026-03-16 18:28:37.961438 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-16 18:28:38.822257 | localhost -> localhost | changed 2026-03-16 18:28:38.845597 | 2026-03-16 18:28:38.845814 | PLAY [all:!appliance*] 2026-03-16 18:28:38.862839 | 2026-03-16 18:28:38.862901 | TASK [include_role : start-zuul-console] 2026-03-16 18:28:38.882759 | controller | ok 2026-03-16 18:28:38.895397 | 2026-03-16 18:28:38.895462 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-16 18:28:39.351981 | controller | ok 2026-03-16 18:28:39.376528 | 2026-03-16 18:28:39.376738 | TASK [use-our-mirror : Retrieve the IP address] 2026-03-16 18:28:41.374006 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2026-03-16 18:28:41.391155 | 2026-03-16 18:28:41.391336 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2026-03-16 18:28:41.942584 | controller | skipping: Conditional result was False 2026-03-16 18:28:41.949365 | 2026-03-16 18:28:41.949454 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2026-03-16 18:28:41.973634 | controller | skipping: Conditional result was False 2026-03-16 18:28:41.980443 | 2026-03-16 18:28:41.980516 | TASK [use-our-mirror : Create the podman configuration directory] 2026-03-16 18:28:42.014136 | controller | skipping: Conditional result was False 2026-03-16 18:28:42.020583 | 2026-03-16 18:28:42.020654 | TASK [use-our-mirror : Copy the podman configuration] 2026-03-16 18:28:42.044779 | controller | skipping: Conditional result was False 2026-03-16 18:28:42.052255 | 2026-03-16 18:28:42.052350 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2026-03-16 18:28:42.086492 | controller | skipping: Conditional result was False 2026-03-16 18:28:42.092998 | 2026-03-16 18:28:42.093083 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2026-03-16 18:28:42.128082 | controller | skipping: Conditional result was False 2026-03-16 18:28:42.159729 | 2026-03-16 18:28:42.159861 | TASK [Disable Fedora Modular] 2026-03-16 18:28:42.415877 | controller | changed 2026-03-16 18:28:42.424957 | 2026-03-16 18:28:42.425071 | TASK [Enable EPEL] 2026-03-16 18:28:42.451234 | controller | skipping: Conditional result was False 2026-03-16 18:28:42.467334 | 2026-03-16 18:28:42.467513 | TASK [Register the RHEL node] 2026-03-16 18:28:43.033035 | 2026-03-16 18:28:43.033366 | TASK [Show the subscription-manager status] 2026-03-16 18:28:43.616490 | controller | skipping: Conditional result was False 2026-03-16 18:28:43.623351 | 2026-03-16 18:28:43.623425 | TASK [Enable EPEL on RHEL] 2026-03-16 18:28:44.155755 | controller | skipping: Conditional result was False 2026-03-16 18:28:44.168505 | 2026-03-16 18:28:44.168639 | TASK [Install git and tox] 2026-03-16 18:30:18.093352 | controller | changed 2026-03-16 18:30:18.106803 | 2026-03-16 18:30:18.106962 | TASK [include_role : prepare-workspace] 2026-03-16 18:30:18.135215 | controller | ok 2026-03-16 18:30:18.169864 | 2026-03-16 18:30:18.169998 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-16 18:30:18.425306 | controller | ok 2026-03-16 18:30:18.434362 | 2026-03-16 18:30:18.434453 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-16 18:30:30.440725 | controller | Output suppressed because no_log was given 2026-03-16 18:30:30.453346 | 2026-03-16 18:30:30.453455 | TASK [include_role : prepare-workspace-openshift] 2026-03-16 18:30:30.482327 | controller | skipping: Conditional result was False 2026-03-16 18:30:30.514630 | 2026-03-16 18:30:30.514778 | PLAY [all:!appliance] 2026-03-16 18:30:30.534597 | 2026-03-16 18:30:30.534711 | TASK [Run add-build-sshkey role (RSA)] 2026-03-16 18:30:30.563914 | controller | ok 2026-03-16 18:30:30.580214 | 2026-03-16 18:30:30.580332 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-16 18:30:30.840189 | controller -> localhost | ok 2026-03-16 18:30:30.854997 | 2026-03-16 18:30:30.855193 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-16 18:30:30.883973 | controller | ok 2026-03-16 18:30:30.913897 | controller | included: /var/lib/zuul/builds/52d7f078c25545058137ccc7cdad04a8/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-16 18:30:30.923456 | 2026-03-16 18:30:30.923588 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-16 18:30:31.407522 | controller -> localhost | Generating public/private rsa key pair. 2026-03-16 18:30:31.407829 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/52d7f078c25545058137ccc7cdad04a8/work/52d7f078c25545058137ccc7cdad04a8_id_rsa. 2026-03-16 18:30:31.407866 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/52d7f078c25545058137ccc7cdad04a8/work/52d7f078c25545058137ccc7cdad04a8_id_rsa.pub. 2026-03-16 18:30:31.407891 | controller -> localhost | The key fingerprint is: 2026-03-16 18:30:31.407915 | controller -> localhost | SHA256:Pjqe81GMmt2L4iCCxcaGXsXbm4QwmTuc4cvdHibnUXo zuul-build-sshkey 2026-03-16 18:30:31.407941 | controller -> localhost | The key's randomart image is: 2026-03-16 18:30:31.407965 | controller -> localhost | +---[RSA 2048]----+ 2026-03-16 18:30:31.407988 | controller -> localhost | | | 2026-03-16 18:30:31.408012 | controller -> localhost | | + | 2026-03-16 18:30:31.408035 | controller -> localhost | | * o | 2026-03-16 18:30:31.408058 | controller -> localhost | | +o B + o | 2026-03-16 18:30:31.408080 | controller -> localhost | |. *B o oS.o | 2026-03-16 18:30:31.408121 | controller -> localhost | |o+o + o==o | 2026-03-16 18:30:31.408151 | controller -> localhost | |o..o.ooX=E. | 2026-03-16 18:30:31.408175 | controller -> localhost | | . . .Xo++ . | 2026-03-16 18:30:31.408198 | controller -> localhost | | o=Bo . | 2026-03-16 18:30:31.408224 | controller -> localhost | +----[SHA256]-----+ 2026-03-16 18:30:31.408282 | controller -> localhost | ok: Runtime: 0:00:00.152420 2026-03-16 18:30:31.417584 | 2026-03-16 18:30:31.417714 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-16 18:30:31.439423 | controller | ok 2026-03-16 18:30:31.452347 | controller | included: /var/lib/zuul/builds/52d7f078c25545058137ccc7cdad04a8/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-16 18:30:31.462293 | 2026-03-16 18:30:31.462406 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-16 18:30:31.486760 | controller | skipping: Conditional result was False 2026-03-16 18:30:31.496643 | 2026-03-16 18:30:31.496810 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-16 18:30:31.935575 | controller | changed 2026-03-16 18:30:31.948699 | 2026-03-16 18:30:31.948883 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-16 18:30:32.195643 | controller | ok 2026-03-16 18:30:32.209604 | 2026-03-16 18:30:32.209864 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-16 18:30:32.874442 | controller | changed 2026-03-16 18:30:32.880034 | 2026-03-16 18:30:32.880098 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-16 18:30:33.540942 | controller | changed 2026-03-16 18:30:33.554062 | 2026-03-16 18:30:33.554204 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-16 18:30:33.581350 | controller | skipping: Conditional result was False 2026-03-16 18:30:33.597393 | 2026-03-16 18:30:33.597545 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-16 18:30:34.053199 | controller -> localhost | changed 2026-03-16 18:30:34.066829 | 2026-03-16 18:30:34.066919 | TASK [add-build-sshkey : Add back temp key] 2026-03-16 18:30:34.401251 | controller -> localhost | Identity added: /var/lib/zuul/builds/52d7f078c25545058137ccc7cdad04a8/work/52d7f078c25545058137ccc7cdad04a8_id_rsa (zuul-build-sshkey) 2026-03-16 18:30:34.401614 | controller -> localhost | ok: Runtime: 0:00:00.009781 2026-03-16 18:30:34.415594 | 2026-03-16 18:30:34.415769 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-16 18:30:34.772717 | controller | ok 2026-03-16 18:30:34.786800 | 2026-03-16 18:30:34.786958 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-16 18:30:34.814792 | controller | skipping: Conditional result was False 2026-03-16 18:30:34.831826 | 2026-03-16 18:30:34.831927 | TASK [Run add-build-sshkey role (ECDSA)] 2026-03-16 18:30:34.863549 | controller | ok 2026-03-16 18:30:34.886437 | 2026-03-16 18:30:34.886571 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-16 18:30:35.167105 | controller -> localhost | ok 2026-03-16 18:30:35.174040 | 2026-03-16 18:30:35.174134 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-16 18:30:35.209454 | controller | ok 2026-03-16 18:30:35.224348 | controller | included: /var/lib/zuul/builds/52d7f078c25545058137ccc7cdad04a8/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-16 18:30:35.232600 | 2026-03-16 18:30:35.232714 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-16 18:30:35.583848 | controller -> localhost | Generating public/private ecdsa key pair. 2026-03-16 18:30:35.584104 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/52d7f078c25545058137ccc7cdad04a8/work/52d7f078c25545058137ccc7cdad04a8_id_ecdsa. 2026-03-16 18:30:35.584135 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/52d7f078c25545058137ccc7cdad04a8/work/52d7f078c25545058137ccc7cdad04a8_id_ecdsa.pub. 2026-03-16 18:30:35.584166 | controller -> localhost | The key fingerprint is: 2026-03-16 18:30:35.584187 | controller -> localhost | SHA256:W2iDY9UCQdUeQ5syO+TdsN8zkS93rkwAC5ByAvwWEjQ zuul-build-sshkey 2026-03-16 18:30:35.584209 | controller -> localhost | The key's randomart image is: 2026-03-16 18:30:35.584230 | controller -> localhost | +---[ECDSA 521]---+ 2026-03-16 18:30:35.584249 | controller -> localhost | | oEo .=+.o. | 2026-03-16 18:30:35.584267 | controller -> localhost | | o.+ oo .+o | 2026-03-16 18:30:35.584284 | controller -> localhost | | o = B.*o | 2026-03-16 18:30:35.584302 | controller -> localhost | | o = O.* . | 2026-03-16 18:30:35.584319 | controller -> localhost | | . + S = o o | 2026-03-16 18:30:35.584336 | controller -> localhost | | . o = . o o | 2026-03-16 18:30:35.584353 | controller -> localhost | | . . * +| 2026-03-16 18:30:35.584369 | controller -> localhost | | o *.| 2026-03-16 18:30:35.584386 | controller -> localhost | | o..| 2026-03-16 18:30:35.584403 | controller -> localhost | +----[SHA256]-----+ 2026-03-16 18:30:35.584454 | controller -> localhost | ok: Runtime: 0:00:00.015138 2026-03-16 18:30:35.591845 | 2026-03-16 18:30:35.591913 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-16 18:30:35.634219 | controller | ok 2026-03-16 18:30:35.646181 | controller | included: /var/lib/zuul/builds/52d7f078c25545058137ccc7cdad04a8/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-16 18:30:35.659367 | 2026-03-16 18:30:35.659466 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-16 18:30:35.695939 | controller | skipping: Conditional result was False 2026-03-16 18:30:35.704847 | 2026-03-16 18:30:35.704937 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-16 18:30:36.002647 | controller | changed 2026-03-16 18:30:36.017630 | 2026-03-16 18:30:36.017876 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-16 18:30:36.277485 | controller | ok 2026-03-16 18:30:36.291262 | 2026-03-16 18:30:36.291423 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-16 18:30:36.942970 | controller | changed 2026-03-16 18:30:36.955355 | 2026-03-16 18:30:36.955497 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-16 18:30:37.645384 | controller | changed 2026-03-16 18:30:37.687736 | 2026-03-16 18:30:37.687864 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-16 18:30:37.712597 | controller | skipping: Conditional result was False 2026-03-16 18:30:37.719553 | 2026-03-16 18:30:37.719639 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-16 18:30:38.009713 | controller -> localhost | changed 2026-03-16 18:30:38.037875 | 2026-03-16 18:30:38.038118 | TASK [add-build-sshkey : Add back temp key] 2026-03-16 18:30:38.351570 | controller -> localhost | Identity added: /var/lib/zuul/builds/52d7f078c25545058137ccc7cdad04a8/work/52d7f078c25545058137ccc7cdad04a8_id_ecdsa (zuul-build-sshkey) 2026-03-16 18:30:38.351888 | controller -> localhost | ok: Runtime: 0:00:00.007356 2026-03-16 18:30:38.361025 | 2026-03-16 18:30:38.361116 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-16 18:30:38.570608 | controller | ok 2026-03-16 18:30:38.576040 | 2026-03-16 18:30:38.576107 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-16 18:30:38.611047 | controller | skipping: Conditional result was False 2026-03-16 18:30:38.622818 | 2026-03-16 18:30:38.622906 | TASK [include_role : remove-zuul-sshkey] 2026-03-16 18:30:38.648344 | controller | skipping: Conditional result was False 2026-03-16 18:30:38.655876 | 2026-03-16 18:30:38.655972 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-16 18:30:38.892150 | controller | ok: "logs" 2026-03-16 18:30:38.892860 | controller | ok: All items complete 2026-03-16 18:30:38.892963 | 2026-03-16 18:30:39.079588 | controller | ok: "artifacts" 2026-03-16 18:30:39.269253 | controller | ok: "docs" 2026-03-16 18:30:39.277997 | 2026-03-16 18:30:39.278130 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-16 18:30:39.506861 | controller | changed: "logs" 2026-03-16 18:30:39.698917 | controller | changed: "artifacts" 2026-03-16 18:30:39.910145 | controller | changed: "docs" 2026-03-16 18:30:39.969089 | 2026-03-16 18:30:39.969216 | PLAY RECAP 2026-03-16 18:30:39.969272 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2026-03-16 18:30:39.969307 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-16 18:30:39.969332 | 2026-03-16 18:30:40.081790 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-03-16 18:30:40.084248 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-03-16 18:30:40.690867 | 2026-03-16 18:30:40.690980 | PLAY [all] 2026-03-16 18:30:40.712504 | 2026-03-16 18:30:40.712604 | TASK [Install binary dependencies] 2026-03-16 18:30:40.782633 | controller | ok 2026-03-16 18:30:40.802450 | 2026-03-16 18:30:40.802549 | TASK [bindep : Include find tasks] 2026-03-16 18:30:40.844449 | controller | ok 2026-03-16 18:30:40.853378 | controller | included: /var/lib/zuul/builds/52d7f078c25545058137ccc7cdad04a8/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-03-16 18:30:40.861277 | 2026-03-16 18:30:40.861377 | TASK [bindep : Look for bindep.txt] 2026-03-16 18:30:41.224377 | controller | ok 2026-03-16 18:30:41.236976 | 2026-03-16 18:30:41.237121 | TASK [bindep : Define bindep_file fact] 2026-03-16 18:30:41.263742 | controller | skipping: Conditional result was False 2026-03-16 18:30:41.277729 | 2026-03-16 18:30:41.277887 | TASK [bindep : Look for other-requirements.txt] 2026-03-16 18:30:41.509906 | controller | ok 2026-03-16 18:30:41.523911 | 2026-03-16 18:30:41.524861 | TASK [bindep : Define bindep_file fact] 2026-03-16 18:30:41.563832 | controller | skipping: Conditional result was False 2026-03-16 18:30:41.578493 | 2026-03-16 18:30:41.578726 | TASK [bindep : Look for bindep fallback file] 2026-03-16 18:30:41.616893 | controller | skipping: Conditional result was False 2026-03-16 18:30:41.633897 | 2026-03-16 18:30:41.634073 | TASK [bindep : Define bindep_file fact] 2026-03-16 18:30:41.671408 | controller | skipping: Conditional result was False 2026-03-16 18:30:41.680126 | 2026-03-16 18:30:41.680220 | TASK [bindep : Include bindep tasks] 2026-03-16 18:30:41.704999 | controller | skipping: Conditional result was False 2026-03-16 18:30:41.714918 | 2026-03-16 18:30:41.715035 | TASK [bindep : Include install tasks] 2026-03-16 18:30:41.740434 | controller | skipping: Conditional result was False 2026-03-16 18:30:41.749094 | 2026-03-16 18:30:41.749195 | LOOP [bindep : Include package tasks] 2026-03-16 18:30:41.806761 | 2026-03-16 18:30:41.806923 | TASK [Run test-setup role] 2026-03-16 18:30:41.827229 | controller | ok 2026-03-16 18:30:41.844532 | 2026-03-16 18:30:41.844611 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-03-16 18:30:42.058779 | controller | ok 2026-03-16 18:30:42.067465 | 2026-03-16 18:30:42.067554 | TASK [test-setup : Run tools/test-setup.sh] 2026-03-16 18:30:42.615348 | controller | skipping: Conditional result was False 2026-03-16 18:30:42.651983 | 2026-03-16 18:30:42.652092 | PLAY RECAP 2026-03-16 18:30:42.652252 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-03-16 18:30:42.652299 | 2026-03-16 18:30:42.753931 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-03-16 18:30:42.755821 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-03-16 18:30:43.407329 | 2026-03-16 18:30:43.407454 | PLAY [controller] 2026-03-16 18:30:43.428030 | 2026-03-16 18:30:43.428135 | TASK [Create the /root directory] 2026-03-16 18:30:43.841070 | controller | ok 2026-03-16 18:30:43.854214 | 2026-03-16 18:30:43.854370 | TASK [Install glibc-langpack-en] 2026-03-16 18:30:47.907567 | controller | ok: Nothing to do 2026-03-16 18:30:47.920514 | 2026-03-16 18:30:47.920657 | TASK [Ensure controller directory exists] 2026-03-16 18:30:48.167055 | controller | changed 2026-03-16 18:30:48.181364 | 2026-03-16 18:30:48.181556 | TASK [Install container runtime] 2026-03-16 18:30:48.237731 | controller | ok 2026-03-16 18:30:48.288343 | 2026-03-16 18:30:48.288481 | LOOP [ensure-podman : Find distribution installation] 2026-03-16 18:30:48.322941 | controller | ok: "/var/lib/zuul/builds/52d7f078c25545058137ccc7cdad04a8/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml" 2026-03-16 18:30:48.341760 | controller | included: /var/lib/zuul/builds/52d7f078c25545058137ccc7cdad04a8/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml 2026-03-16 18:30:48.360105 | 2026-03-16 18:30:48.360321 | TASK [ensure-podman : Install podman (RedHat)] 2026-03-16 18:31:57.896840 | controller | changed 2026-03-16 18:31:57.908465 | 2026-03-16 18:31:57.908696 | TASK [ensure-podman : Fetch podman version] 2026-03-16 18:31:58.432622 | controller | Client: Podman Engine 2026-03-16 18:31:58.456649 | controller | Version: 4.6.2 2026-03-16 18:31:58.456721 | controller | API Version: 4.6.2 2026-03-16 18:31:58.456814 | controller | Go Version: go1.19.12 2026-03-16 18:31:58.456836 | controller | Built: Mon Aug 28 19:38:31 2023 2026-03-16 18:31:58.456844 | controller | OS/Arch: linux/amd64 2026-03-16 18:31:58.954033 | controller | ok: Runtime: 0:00:00.171127 2026-03-16 18:31:58.968268 | 2026-03-16 18:31:58.968412 | TASK [ensure-podman : Print podman version installed] 2026-03-16 18:31:59.007627 | Podman version: Client: Podman Engine 2026-03-16 18:31:59.007912 | Version: 4.6.2 2026-03-16 18:31:59.007976 | API Version: 4.6.2 2026-03-16 18:31:59.008021 | Go Version: go1.19.12 2026-03-16 18:31:59.008061 | Built: Mon Aug 28 19:38:31 2023 2026-03-16 18:31:59.008103 | OS/Arch: linux/amd64 2026-03-16 18:31:59.021576 | 2026-03-16 18:31:59.021792 | TASK [ensure-podman : Validate podman engine] 2026-03-16 18:31:59.568903 | controller | skipping: Conditional result was False 2026-03-16 18:31:59.583168 | 2026-03-16 18:31:59.583258 | TASK [ensure-podman : Set up docker compatability socket] 2026-03-16 18:31:59.607930 | controller | skipping: Conditional result was False 2026-03-16 18:31:59.637081 | 2026-03-16 18:31:59.637311 | TASK [Ensure python3.8 is present] 2026-03-16 18:31:59.666864 | controller | skipping: Conditional result was False 2026-03-16 18:31:59.680615 | 2026-03-16 18:31:59.680775 | TASK [Run our-ensure-python role (Fedora only for now)] 2026-03-16 18:31:59.709792 | controller | ok 2026-03-16 18:31:59.734794 | 2026-03-16 18:31:59.734896 | TASK [our-ensure-python : Install the right Python version (rpm)] 2026-03-16 18:32:01.197371 | controller | ok: Nothing to do 2026-03-16 18:32:01.216102 | 2026-03-16 18:32:01.216258 | TASK [our-ensure-python : Also install python3-devel] 2026-03-16 18:32:11.413582 | controller | changed 2026-03-16 18:32:11.424928 | 2026-03-16 18:32:11.424998 | TASK [Run ensure-virtualenv role] 2026-03-16 18:32:11.443811 | controller | ok 2026-03-16 18:32:11.463964 | 2026-03-16 18:32:11.464046 | TASK [ensure-virtualenv : Check if virtualenv is installed] 2026-03-16 18:32:12.225006 | controller | /usr/bin/virtualenv 2026-03-16 18:32:12.573102 | controller | ok: Runtime: 0:00:00.005201 2026-03-16 18:32:12.588317 | 2026-03-16 18:32:12.588495 | LOOP [ensure-virtualenv : Install virtualenv package] 2026-03-16 18:32:12.611640 | controller | skipping: Conditional result was False 2026-03-16 18:32:12.611962 | controller | ok: All items complete 2026-03-16 18:32:12.611992 | 2026-03-16 18:32:12.641020 | 2026-03-16 18:32:12.641224 | TASK [Find the full path of the Python interpreter] 2026-03-16 18:32:12.868784 | controller | /usr/bin/python3 2026-03-16 18:32:13.189336 | controller | ok 2026-03-16 18:32:13.197644 | 2026-03-16 18:32:13.197748 | TASK [Create virtualenv for ansible-test with a specific interpreter] 2026-03-16 18:32:13.972771 | controller | created virtual environment CPython3.11.0.final.0-64 in 426ms 2026-03-16 18:32:13.988335 | controller | creator CPython3Posix(dest=/home/zuul/venv, clear=False, no_vcs_ignore=False, global=False) 2026-03-16 18:32:13.988370 | 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-16 18:32:13.988379 | controller | added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1 2026-03-16 18:32:13.988393 | controller | activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator 2026-03-16 18:32:14.269764 | controller | changed 2026-03-16 18:32:14.279052 | 2026-03-16 18:32:14.279197 | TASK [Set selinux package] 2026-03-16 18:32:14.308707 | controller | ok 2026-03-16 18:32:14.322023 | 2026-03-16 18:32:14.322206 | TASK [Set selinux package (Fedora)] 2026-03-16 18:32:14.368204 | controller | ok 2026-03-16 18:32:14.378427 | 2026-03-16 18:32:14.378589 | TASK [Install selinux into virtualenv] 2026-03-16 18:32:51.814474 | controller | Collecting selinux-please-lie-to-me 2026-03-16 18:33:04.159337 | controller | Downloading selinux_please_lie_to_me-1.0.1-py2.py3-none-any.whl (3.8 kB) 2026-03-16 18:33:04.479092 | controller | Collecting setuptools<50.0.0 2026-03-16 18:33:04.484140 | controller | Downloading setuptools-49.6.0-py3-none-any.whl (803 kB) 2026-03-16 18:33:04.533908 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 803.3/803.3 kB 17.9 MB/s eta 0:00:00 2026-03-16 18:33:04.618184 | controller | Installing collected packages: setuptools, selinux-please-lie-to-me 2026-03-16 18:33:04.618284 | controller | Attempting uninstall: setuptools 2026-03-16 18:33:04.621330 | controller | Found existing installation: setuptools 62.6.0 2026-03-16 18:33:04.682677 | controller | Uninstalling setuptools-62.6.0: 2026-03-16 18:33:04.691208 | controller | Successfully uninstalled setuptools-62.6.0 2026-03-16 18:33:05.109074 | controller | Successfully installed selinux-please-lie-to-me-1.0.1 setuptools-49.6.0 2026-03-16 18:33:16.539602 | controller | 2026-03-16 18:33:16.620577 | controller | [notice] A new release of pip available: 22.2.2 -> 26.0.1 2026-03-16 18:33:16.620621 | controller | [notice] To update, run: python -m pip install --upgrade pip 2026-03-16 18:33:16.965254 | controller | ok: Runtime: 0:01:02.031800 2026-03-16 18:33:16.980854 | 2026-03-16 18:33:16.981000 | TASK [Install pytest-forked into virtualenv] 2026-03-16 18:33:28.778875 | controller | Collecting pytest-forked 2026-03-16 18:33:53.057332 | controller | Downloading pytest_forked-1.6.0-py3-none-any.whl (4.9 kB) 2026-03-16 18:33:53.104860 | controller | Collecting py 2026-03-16 18:33:53.108693 | controller | Downloading py-1.11.0-py2.py3-none-any.whl (98 kB) 2026-03-16 18:33:53.129541 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.7/98.7 kB 5.3 MB/s eta 0:00:00 2026-03-16 18:33:53.238420 | controller | Collecting pytest>=3.10 2026-03-16 18:33:53.242196 | controller | Downloading pytest-9.0.2-py3-none-any.whl (374 kB) 2026-03-16 18:33:53.256938 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 374.8/374.8 kB 29.5 MB/s eta 0:00:00 2026-03-16 18:33:53.313292 | controller | Collecting iniconfig>=1.0.1 2026-03-16 18:33:53.317003 | controller | Downloading iniconfig-2.3.0-py3-none-any.whl (7.5 kB) 2026-03-16 18:33:53.371434 | controller | Collecting packaging>=22 2026-03-16 18:33:53.374786 | controller | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-03-16 18:33:53.380303 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 19.7 MB/s eta 0:00:00 2026-03-16 18:33:53.413206 | controller | Collecting pluggy<2,>=1.5 2026-03-16 18:33:53.416750 | controller | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-03-16 18:33:53.465254 | controller | Collecting pygments>=2.7.2 2026-03-16 18:33:53.468579 | controller | Downloading pygments-2.19.2-py3-none-any.whl (1.2 MB) 2026-03-16 18:33:53.488936 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.2/1.2 MB 68.8 MB/s eta 0:00:00 2026-03-16 18:33:53.558669 | controller | Installing collected packages: pygments, py, pluggy, packaging, iniconfig, pytest, pytest-forked 2026-03-16 18:33:54.598421 | 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-16 18:33:54.607036 | controller | 2026-03-16 18:33:54.672342 | controller | [notice] A new release of pip available: 22.2.2 -> 26.0.1 2026-03-16 18:33:54.672398 | controller | [notice] To update, run: python -m pip install --upgrade pip 2026-03-16 18:33:55.062166 | controller | ok: Runtime: 0:00:37.440745 2026-03-16 18:33:55.076340 | 2026-03-16 18:33:55.076532 | TASK [Update pip] 2026-03-16 18:33:55.607499 | controller | Requirement already satisfied: pip in ./venv/lib/python3.11/site-packages (22.2.2) 2026-03-16 18:34:05.443798 | controller | Collecting pip 2026-03-16 18:34:17.632336 | controller | Downloading pip-26.0.1-py3-none-any.whl (1.8 MB) 2026-03-16 18:34:17.758902 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.8/1.8 MB 14.6 MB/s eta 0:00:00 2026-03-16 18:34:17.822558 | controller | Installing collected packages: pip 2026-03-16 18:34:17.822810 | controller | Attempting uninstall: pip 2026-03-16 18:34:17.825120 | controller | Found existing installation: pip 22.2.2 2026-03-16 18:34:17.960000 | controller | Uninstalling pip-22.2.2: 2026-03-16 18:34:17.974952 | controller | Successfully uninstalled pip-22.2.2 2026-03-16 18:34:18.778087 | controller | Successfully installed pip-26.0.1 2026-03-16 18:34:19.144913 | controller | ok: Runtime: 0:00:23.551999 2026-03-16 18:34:19.158565 | 2026-03-16 18:34:19.158794 | TASK [Ensure pip temp directory exists in /var/tmp] 2026-03-16 18:34:19.385417 | controller | changed 2026-03-16 18:34:19.424202 | 2026-03-16 18:34:19.424342 | TASK [Install ansible into virtualenv] 2026-03-16 18:34:19.959160 | controller | Processing ./src/github.com/ansible/ansible 2026-03-16 18:34:19.961675 | controller | Installing build dependencies: started 2026-03-16 18:35:09.204587 | controller | Installing build dependencies: finished with status 'done' 2026-03-16 18:35:09.205723 | controller | Getting requirements to build wheel: started 2026-03-16 18:35:09.925189 | controller | Getting requirements to build wheel: finished with status 'done' 2026-03-16 18:35:09.925968 | controller | Preparing metadata (pyproject.toml): started 2026-03-16 18:35:10.384518 | controller | Preparing metadata (pyproject.toml): finished with status 'done' 2026-03-16 18:35:10.389333 | 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-16 18:35:10.394067 | controller | ERROR: Package 'ansible-core' requires a different Python: 3.11.0 not in '>=3.12' 2026-03-16 18:35:10.497693 | controller | ERROR 2026-03-16 18:35:10.497989 | controller | { 2026-03-16 18:35:10.498054 | controller | "delta": "0:00:50.782840", 2026-03-16 18:35:10.498097 | controller | "end": "2026-03-16 18:35:10.456166", 2026-03-16 18:35:10.498137 | controller | "msg": "non-zero return code", 2026-03-16 18:35:10.498192 | controller | "rc": 1, 2026-03-16 18:35:10.498231 | controller | "start": "2026-03-16 18:34:19.673326" 2026-03-16 18:35:10.498267 | controller | } failure 2026-03-16 18:35:10.501046 | 2026-03-16 18:35:10.501146 | PLAY RECAP 2026-03-16 18:35:10.501231 | controller | ok: 18 changed: 10 unreachable: 0 failed: 1 skipped: 4 rescued: 0 ignored: 0 2026-03-16 18:35:10.501276 | 2026-03-16 18:35:10.623656 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-03-16 18:35:10.625527 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-16 18:35:11.249569 | 2026-03-16 18:35:11.249711 | PLAY [all] 2026-03-16 18:35:11.271562 | 2026-03-16 18:35:11.271707 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-03-16 18:35:11.526163 | controller | changed: non-zero return code 2026-03-16 18:35:11.532255 | 2026-03-16 18:35:11.532366 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-03-16 18:35:11.557168 | controller | skipping: Conditional result was False 2026-03-16 18:35:11.566842 | 2026-03-16 18:35:11.566962 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-03-16 18:35:11.602276 | 2026-03-16 18:35:11.602463 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-03-16 18:35:11.647127 | 2026-03-16 18:35:11.647371 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-03-16 18:35:11.670247 | controller | skipping: Conditional result was False 2026-03-16 18:35:11.679919 | 2026-03-16 18:35:11.680035 | LOOP [fetch-subunit-output : Generate subunit file] 2026-03-16 18:35:11.709873 | 2026-03-16 18:35:11.710027 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-03-16 18:35:11.723730 | controller | skipping: Conditional result was False 2026-03-16 18:35:11.732755 | 2026-03-16 18:35:11.732896 | TASK [fetch-subunit-output : Remove the temporary file] 2026-03-16 18:35:11.748327 | controller | skipping: Conditional result was False 2026-03-16 18:35:11.755518 | 2026-03-16 18:35:11.755625 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-03-16 18:35:11.769112 | controller | skipping: Conditional result was False 2026-03-16 18:35:11.806251 | 2026-03-16 18:35:11.806334 | PLAY RECAP 2026-03-16 18:35:11.806377 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-03-16 18:35:11.806397 | 2026-03-16 18:35:11.903505 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-16 18:35:11.905188 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2026-03-16 18:35:12.537090 | 2026-03-16 18:35:12.537204 | PLAY [all:!appliance*] 2026-03-16 18:35:12.571863 | 2026-03-16 18:35:12.571997 | TASK [unregister the node] 2026-03-16 18:35:13.104284 | controller | skipping: Conditional result was False 2026-03-16 18:35:13.116717 | 2026-03-16 18:35:13.116907 | TASK [include_role : fetch-output] 2026-03-16 18:35:13.155697 | controller | ok 2026-03-16 18:35:13.193484 | 2026-03-16 18:35:13.193626 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-16 18:35:13.239273 | controller | skipping: Conditional result was False 2026-03-16 18:35:13.254770 | 2026-03-16 18:35:13.255152 | TASK [fetch-output : Set log path for single node] 2026-03-16 18:35:13.311015 | controller | ok 2026-03-16 18:35:13.321394 | 2026-03-16 18:35:13.321540 | LOOP [fetch-output : Ensure local output dirs] 2026-03-16 18:35:13.746544 | controller -> localhost | ok: "/var/lib/zuul/builds/52d7f078c25545058137ccc7cdad04a8/work/logs" 2026-03-16 18:35:13.970935 | controller -> localhost | changed: "/var/lib/zuul/builds/52d7f078c25545058137ccc7cdad04a8/work/artifacts" 2026-03-16 18:35:14.217578 | controller -> localhost | changed: "/var/lib/zuul/builds/52d7f078c25545058137ccc7cdad04a8/work/docs" 2026-03-16 18:35:14.234826 | 2026-03-16 18:35:14.234948 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-16 18:35:14.872748 | controller | changed: 2026-03-16 18:35:14.872946 | controller | .d..t...... ./ 2026-03-16 18:35:14.872974 | controller | cd+++++++++ controller/ 2026-03-16 18:35:14.873006 | controller | changed: All items complete 2026-03-16 18:35:14.873026 | 2026-03-16 18:35:15.297971 | controller | changed: .d..t...... ./ 2026-03-16 18:35:15.762226 | controller | changed: .d..t...... ./ 2026-03-16 18:35:15.788101 | 2026-03-16 18:35:15.788305 | TASK [include_role : fetch-output-openshift] 2026-03-16 18:35:15.803830 | controller | skipping: Conditional result was False 2026-03-16 18:35:15.813983 | 2026-03-16 18:35:15.814085 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-16 18:35:16.285282 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.012682 2026-03-16 18:35:16.536807 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.008242 2026-03-16 18:35:16.584693 | 2026-03-16 18:35:16.584825 | PLAY [localhost] 2026-03-16 18:35:16.598851 | 2026-03-16 18:35:16.598954 | TASK [Run Zuul manifest role] 2026-03-16 18:35:16.617220 | localhost | ok 2026-03-16 18:35:16.632320 | 2026-03-16 18:35:16.632434 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-16 18:35:17.000758 | localhost | changed 2026-03-16 18:35:17.008983 | 2026-03-16 18:35:17.009127 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-16 18:35:17.062049 | localhost | ok 2026-03-16 18:35:17.074654 | 2026-03-16 18:35:17.074768 | TASK [Set zuul-log-path fact] 2026-03-16 18:35:17.100791 | localhost | ok 2026-03-16 18:35:17.117818 | 2026-03-16 18:35:17.117902 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-16 18:35:17.156694 | localhost | ok 2026-03-16 18:35:17.176328 | 2026-03-16 18:35:17.176533 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)] 2026-03-16 18:35:17.207066 | localhost | ok: 2026-03-16 18:35:17.207223 | localhost | { 2026-03-16 18:35:17.207246 | localhost | "auth": { 2026-03-16 18:35:17.207270 | localhost | "password": "IonWCwcuOFib&&<}wp^:[2G/", 2026-03-16 18:35:17.207287 | localhost | "username": "9LF91O0RK7JU" 2026-03-16 18:35:17.207303 | localhost | }, 2026-03-16 18:35:17.207319 | localhost | "profile": "rackspace", 2026-03-16 18:35:17.207334 | localhost | "region_name": "ORD" 2026-03-16 18:35:17.207349 | localhost | } 2026-03-16 18:35:17.207375 | localhost | changed: All items complete 2026-03-16 18:35:17.207394 | 2026-03-16 18:35:17.225018 | 2026-03-16 18:35:17.225197 | TASK [Run upload-logs-failover role (S3 then Swift)] 2026-03-16 18:35:17.259171 | localhost | Output suppressed because no_log was given 2026-03-16 18:35:17.273450 | 2026-03-16 18:35:17.273543 | TASK [upload-logs-failover : Initialize control vars] 2026-03-16 18:35:17.328773 | localhost | ok 2026-03-16 18:35:17.332968 | 2026-03-16 18:35:17.333035 | LOOP [upload-logs-failover : Perform log upload] 2026-03-16 18:35:17.371150 | localhost | Output suppressed because no_log was given 2026-03-16 18:35:17.377460 | localhost | included: /var/lib/zuul/builds/52d7f078c25545058137ccc7cdad04a8/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml 2026-03-16 18:35:17.383924 | 2026-03-16 18:35:17.383992 | LOOP [upload-logs-failover : Unpack vars for swift upload] 2026-03-16 18:35:17.483415 | localhost | Output suppressed because no_log was given 2026-03-16 18:35:17.490725 | 2026-03-16 18:35:17.490834 | TASK [Upload logs to swift] 2026-03-16 18:35:17.513441 | localhost | ok 2026-03-16 18:35:17.548049 | 2026-03-16 18:35:17.548139 | TASK [Set zuul-log-path fact] 2026-03-16 18:35:17.582538 | localhost | skipping: Conditional result was False 2026-03-16 18:35:17.587542 | 2026-03-16 18:35:17.587609 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2026-03-16 18:35:17.875644 | localhost -> localhost | ok: Runtime: 0:00:00.013788 2026-03-16 18:35:17.880738 | 2026-03-16 18:35:17.880812 | TASK [upload-logs-swift : Upload logs to swift]