2026-03-16 16:20:47.260424 | Job console starting... 2026-03-16 16:20:47.271468 | Updating repositories 2026-03-16 16:20:47.419190 | Preparing job workspace 2026-03-16 16:20:57.063632 | Running Ansible setup... 2026-03-16 16:21:01.939787 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-03-16 16:21:02.492170 | 2026-03-16 16:21:02.492280 | PLAY [localhost] 2026-03-16 16:21:02.500558 | 2026-03-16 16:21:02.500628 | TASK [Gathering Facts] 2026-03-16 16:21:03.525588 | localhost | ok 2026-03-16 16:21:03.554819 | 2026-03-16 16:21:03.554974 | TASK [Setup log path fact] 2026-03-16 16:21:03.576642 | localhost | ok 2026-03-16 16:21:03.593183 | 2026-03-16 16:21:03.593270 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-16 16:21:03.622586 | localhost | ok 2026-03-16 16:21:03.632922 | 2026-03-16 16:21:03.633010 | TASK [emit-job-header : Print job information] 2026-03-16 16:21:03.672902 | # Job Information 2026-03-16 16:21:03.673046 | Ansible Version: 2.15.12 2026-03-16 16:21:03.673089 | Job: ansible-test-sanity-docker-milestone 2026-03-16 16:21:03.673117 | Pipeline: third-party-check 2026-03-16 16:21:03.673142 | Executor: ze02.softwarefactory-project.io 2026-03-16 16:21:03.673167 | Triggered by: https://github.com/openshift/community.okd/pull/274 2026-03-16 16:21:03.673195 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/c88/ansible/c883c075a9d2454d9a0fd70de73c1628/ 2026-03-16 16:21:03.673220 | Event ID: cb44fe40-2151-11f1-85ca-bed5723f367f 2026-03-16 16:21:03.678177 | 2026-03-16 16:21:03.678258 | LOOP [emit-job-header : Print node information] 2026-03-16 16:21:03.790424 | localhost | ok: 2026-03-16 16:21:03.790903 | localhost | # Node Information 2026-03-16 16:21:03.790967 | localhost | Inventory Hostname: controller 2026-03-16 16:21:03.791010 | localhost | Hostname: np0005648660 2026-03-16 16:21:03.791052 | localhost | Username: zuul 2026-03-16 16:21:03.791096 | localhost | Distro: Fedora 37 2026-03-16 16:21:03.791135 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2026-03-16 16:21:03.791173 | localhost | Region: ca-ymq-1 2026-03-16 16:21:03.791209 | localhost | Label: ansible-fedora-37-1vcpu 2026-03-16 16:21:03.791246 | localhost | Product Name: OpenStack Nova 2026-03-16 16:21:03.791283 | localhost | Interface IP: 199.19.213.196 2026-03-16 16:21:03.810879 | 2026-03-16 16:21:03.811037 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-16 16:21:04.214744 | localhost -> localhost | changed 2026-03-16 16:21:04.220508 | 2026-03-16 16:21:04.220575 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-16 16:21:05.072045 | localhost -> localhost | changed 2026-03-16 16:21:05.113475 | 2026-03-16 16:21:05.113598 | PLAY [all:!appliance*] 2026-03-16 16:21:05.143524 | 2026-03-16 16:21:05.143655 | TASK [include_role : start-zuul-console] 2026-03-16 16:21:05.166973 | controller | ok 2026-03-16 16:21:05.184561 | 2026-03-16 16:21:05.184649 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-16 16:21:05.601562 | controller | ok 2026-03-16 16:21:05.616199 | 2026-03-16 16:21:05.616284 | TASK [use-our-mirror : Retrieve the IP address] 2026-03-16 16:21:27.711729 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2026-03-16 16:21:27.725748 | 2026-03-16 16:21:27.725885 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2026-03-16 16:21:28.268718 | controller | skipping: Conditional result was False 2026-03-16 16:21:28.277835 | 2026-03-16 16:21:28.278010 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2026-03-16 16:21:28.303975 | controller | skipping: Conditional result was False 2026-03-16 16:21:28.319058 | 2026-03-16 16:21:28.319196 | TASK [use-our-mirror : Create the podman configuration directory] 2026-03-16 16:21:28.346524 | controller | skipping: Conditional result was False 2026-03-16 16:21:28.360986 | 2026-03-16 16:21:28.361189 | TASK [use-our-mirror : Copy the podman configuration] 2026-03-16 16:21:28.387898 | controller | skipping: Conditional result was False 2026-03-16 16:21:28.401357 | 2026-03-16 16:21:28.401497 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2026-03-16 16:21:28.428072 | controller | skipping: Conditional result was False 2026-03-16 16:21:28.441380 | 2026-03-16 16:21:28.441523 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2026-03-16 16:21:28.468056 | controller | skipping: Conditional result was False 2026-03-16 16:21:28.491902 | 2026-03-16 16:21:28.492034 | TASK [Disable Fedora Modular] 2026-03-16 16:21:28.819768 | controller | changed 2026-03-16 16:21:28.833472 | 2026-03-16 16:21:28.833607 | TASK [Enable EPEL] 2026-03-16 16:21:28.860840 | controller | skipping: Conditional result was False 2026-03-16 16:21:28.874885 | 2026-03-16 16:21:28.875029 | TASK [Register the RHEL node] 2026-03-16 16:21:29.439823 | 2026-03-16 16:21:29.440122 | TASK [Show the subscription-manager status] 2026-03-16 16:21:30.001808 | controller | skipping: Conditional result was False 2026-03-16 16:21:30.012546 | 2026-03-16 16:21:30.012637 | TASK [Enable EPEL on RHEL] 2026-03-16 16:21:30.075747 | controller | skipping: Conditional result was False 2026-03-16 16:21:30.084862 | 2026-03-16 16:21:30.084961 | TASK [Install git and tox] 2026-03-16 16:22:29.881176 | controller | changed 2026-03-16 16:22:29.894531 | 2026-03-16 16:22:29.894660 | TASK [include_role : prepare-workspace] 2026-03-16 16:22:29.923426 | controller | ok 2026-03-16 16:22:29.959119 | 2026-03-16 16:22:29.959211 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-16 16:22:30.248001 | controller | ok 2026-03-16 16:22:30.256525 | 2026-03-16 16:22:30.256605 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-16 16:22:42.875739 | controller | Output suppressed because no_log was given 2026-03-16 16:22:42.885878 | 2026-03-16 16:22:42.885939 | TASK [include_role : prepare-workspace-openshift] 2026-03-16 16:22:42.909683 | controller | skipping: Conditional result was False 2026-03-16 16:22:42.932509 | 2026-03-16 16:22:42.932581 | PLAY [all:!appliance] 2026-03-16 16:22:42.948019 | 2026-03-16 16:22:42.948083 | TASK [Run add-build-sshkey role (RSA)] 2026-03-16 16:22:42.977643 | controller | ok 2026-03-16 16:22:42.992744 | 2026-03-16 16:22:42.992810 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-16 16:22:43.240257 | controller -> localhost | ok 2026-03-16 16:22:43.246791 | 2026-03-16 16:22:43.246886 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-16 16:22:43.270923 | controller | ok 2026-03-16 16:22:43.284470 | controller | included: /var/lib/zuul/builds/c883c075a9d2454d9a0fd70de73c1628/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-16 16:22:43.290469 | 2026-03-16 16:22:43.290535 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-16 16:22:43.802990 | controller -> localhost | Generating public/private rsa key pair. 2026-03-16 16:22:43.803183 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/c883c075a9d2454d9a0fd70de73c1628/work/c883c075a9d2454d9a0fd70de73c1628_id_rsa. 2026-03-16 16:22:43.803212 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/c883c075a9d2454d9a0fd70de73c1628/work/c883c075a9d2454d9a0fd70de73c1628_id_rsa.pub. 2026-03-16 16:22:43.803234 | controller -> localhost | The key fingerprint is: 2026-03-16 16:22:43.803253 | controller -> localhost | SHA256:FKDmq+yTiqBq45pX25YEIYTFkzgRIlZd8jV7+ko0yAQ zuul-build-sshkey 2026-03-16 16:22:43.803274 | controller -> localhost | The key's randomart image is: 2026-03-16 16:22:43.803293 | controller -> localhost | +---[RSA 2048]----+ 2026-03-16 16:22:43.803311 | controller -> localhost | |=X+o.Eoo.o | 2026-03-16 16:22:43.803330 | controller -> localhost | |B = .o+ ..o | 2026-03-16 16:22:43.803348 | controller -> localhost | | . oo. o.. . | 2026-03-16 16:22:43.803366 | controller -> localhost | | o. o.. o | 2026-03-16 16:22:43.803384 | controller -> localhost | | .. oS+ | 2026-03-16 16:22:43.803411 | controller -> localhost | | ... . o | 2026-03-16 16:22:43.803434 | controller -> localhost | |. o.+ . . . | 2026-03-16 16:22:43.803455 | controller -> localhost | |+=+.. + . . | 2026-03-16 16:22:43.803473 | controller -> localhost | |%==. . . | 2026-03-16 16:22:43.803494 | controller -> localhost | +----[SHA256]-----+ 2026-03-16 16:22:43.803539 | controller -> localhost | ok: Runtime: 0:00:00.087801 2026-03-16 16:22:43.811540 | 2026-03-16 16:22:43.811609 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-16 16:22:43.850739 | controller | ok 2026-03-16 16:22:43.860976 | controller | included: /var/lib/zuul/builds/c883c075a9d2454d9a0fd70de73c1628/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-16 16:22:43.870041 | 2026-03-16 16:22:43.870103 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-16 16:22:43.894373 | controller | skipping: Conditional result was False 2026-03-16 16:22:43.901607 | 2026-03-16 16:22:43.901689 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-16 16:22:44.360504 | controller | changed 2026-03-16 16:22:44.366309 | 2026-03-16 16:22:44.366401 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-16 16:22:44.615747 | controller | ok 2026-03-16 16:22:44.621615 | 2026-03-16 16:22:44.621712 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-16 16:22:45.260867 | controller | changed 2026-03-16 16:22:45.297243 | 2026-03-16 16:22:45.297366 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-16 16:22:45.940376 | controller | changed 2026-03-16 16:22:45.953708 | 2026-03-16 16:22:45.953846 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-16 16:22:45.971508 | controller | skipping: Conditional result was False 2026-03-16 16:22:45.986450 | 2026-03-16 16:22:45.986607 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-16 16:22:46.368770 | controller -> localhost | changed 2026-03-16 16:22:46.380831 | 2026-03-16 16:22:46.380897 | TASK [add-build-sshkey : Add back temp key] 2026-03-16 16:22:46.659783 | controller -> localhost | Identity added: /var/lib/zuul/builds/c883c075a9d2454d9a0fd70de73c1628/work/c883c075a9d2454d9a0fd70de73c1628_id_rsa (zuul-build-sshkey) 2026-03-16 16:22:46.660124 | controller -> localhost | ok: Runtime: 0:00:00.013187 2026-03-16 16:22:46.668658 | 2026-03-16 16:22:46.668767 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-16 16:22:46.969930 | controller | ok 2026-03-16 16:22:46.982799 | 2026-03-16 16:22:46.983007 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-16 16:22:47.010785 | controller | skipping: Conditional result was False 2026-03-16 16:22:47.038777 | 2026-03-16 16:22:47.038956 | TASK [Run add-build-sshkey role (ECDSA)] 2026-03-16 16:22:47.063449 | controller | ok 2026-03-16 16:22:47.086225 | 2026-03-16 16:22:47.086320 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-16 16:22:47.314794 | controller -> localhost | ok 2026-03-16 16:22:47.328979 | 2026-03-16 16:22:47.329118 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-16 16:22:47.370996 | controller | ok 2026-03-16 16:22:47.390378 | controller | included: /var/lib/zuul/builds/c883c075a9d2454d9a0fd70de73c1628/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-16 16:22:47.398882 | 2026-03-16 16:22:47.398964 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-16 16:22:47.678459 | controller -> localhost | Generating public/private ecdsa key pair. 2026-03-16 16:22:47.678873 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/c883c075a9d2454d9a0fd70de73c1628/work/c883c075a9d2454d9a0fd70de73c1628_id_ecdsa. 2026-03-16 16:22:47.678939 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/c883c075a9d2454d9a0fd70de73c1628/work/c883c075a9d2454d9a0fd70de73c1628_id_ecdsa.pub. 2026-03-16 16:22:47.678997 | controller -> localhost | The key fingerprint is: 2026-03-16 16:22:47.679045 | controller -> localhost | SHA256:rMfBNMn6Xj9ABqOkA+SwHBYoPAFLj6z0kDkwhE2TgJM zuul-build-sshkey 2026-03-16 16:22:47.679088 | controller -> localhost | The key's randomart image is: 2026-03-16 16:22:47.679129 | controller -> localhost | +---[ECDSA 521]---+ 2026-03-16 16:22:47.679169 | controller -> localhost | |&&*. | 2026-03-16 16:22:47.679207 | controller -> localhost | |EOX. ..o. | 2026-03-16 16:22:47.679245 | controller -> localhost | |+@oo o .=o | 2026-03-16 16:22:47.679282 | controller -> localhost | |o + o .= .o | 2026-03-16 16:22:47.679319 | controller -> localhost | |. . .. So | 2026-03-16 16:22:47.679356 | controller -> localhost | | + .. | 2026-03-16 16:22:47.679393 | controller -> localhost | | . + .. | 2026-03-16 16:22:47.679428 | controller -> localhost | | o . .. | 2026-03-16 16:22:47.679464 | controller -> localhost | | . .. | 2026-03-16 16:22:47.679500 | controller -> localhost | +----[SHA256]-----+ 2026-03-16 16:22:47.679601 | controller -> localhost | ok: Runtime: 0:00:00.014842 2026-03-16 16:22:47.694244 | 2026-03-16 16:22:47.694381 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-16 16:22:47.729874 | controller | ok 2026-03-16 16:22:47.741847 | controller | included: /var/lib/zuul/builds/c883c075a9d2454d9a0fd70de73c1628/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-16 16:22:47.754097 | 2026-03-16 16:22:47.754181 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-16 16:22:47.778635 | controller | skipping: Conditional result was False 2026-03-16 16:22:47.784874 | 2026-03-16 16:22:47.784936 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-16 16:22:48.056186 | controller | changed 2026-03-16 16:22:48.072133 | 2026-03-16 16:22:48.072351 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-16 16:22:48.333836 | controller | ok 2026-03-16 16:22:48.346939 | 2026-03-16 16:22:48.347070 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-16 16:22:48.979088 | controller | changed 2026-03-16 16:22:48.993824 | 2026-03-16 16:22:48.993981 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-16 16:22:49.647761 | controller | changed 2026-03-16 16:22:49.661422 | 2026-03-16 16:22:49.661590 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-16 16:22:49.692391 | controller | skipping: Conditional result was False 2026-03-16 16:22:49.701073 | 2026-03-16 16:22:49.701167 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-16 16:22:49.952270 | controller -> localhost | changed 2026-03-16 16:22:49.975348 | 2026-03-16 16:22:49.975453 | TASK [add-build-sshkey : Add back temp key] 2026-03-16 16:22:50.266697 | controller -> localhost | Identity added: /var/lib/zuul/builds/c883c075a9d2454d9a0fd70de73c1628/work/c883c075a9d2454d9a0fd70de73c1628_id_ecdsa (zuul-build-sshkey) 2026-03-16 16:22:50.267080 | controller -> localhost | ok: Runtime: 0:00:00.013295 2026-03-16 16:22:50.282592 | 2026-03-16 16:22:50.282797 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-16 16:22:50.507022 | controller | ok 2026-03-16 16:22:50.519579 | 2026-03-16 16:22:50.519746 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-16 16:22:50.557756 | controller | skipping: Conditional result was False 2026-03-16 16:22:50.584347 | 2026-03-16 16:22:50.584501 | TASK [include_role : remove-zuul-sshkey] 2026-03-16 16:22:50.612051 | controller | skipping: Conditional result was False 2026-03-16 16:22:50.626086 | 2026-03-16 16:22:50.626229 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-16 16:22:50.889197 | controller | ok: "logs" 2026-03-16 16:22:50.889708 | controller | ok: All items complete 2026-03-16 16:22:50.889763 | 2026-03-16 16:22:51.097700 | controller | ok: "artifacts" 2026-03-16 16:22:51.300260 | controller | ok: "docs" 2026-03-16 16:22:51.325168 | 2026-03-16 16:22:51.325365 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-16 16:22:51.583049 | controller | changed: "logs" 2026-03-16 16:22:51.795515 | controller | changed: "artifacts" 2026-03-16 16:22:51.984476 | controller | changed: "docs" 2026-03-16 16:22:52.019180 | 2026-03-16 16:22:52.019304 | PLAY RECAP 2026-03-16 16:22:52.019345 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2026-03-16 16:22:52.019371 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-16 16:22:52.019389 | 2026-03-16 16:22:52.127731 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-03-16 16:22:52.129358 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-03-16 16:22:52.673478 | 2026-03-16 16:22:52.673645 | PLAY [all] 2026-03-16 16:22:52.696450 | 2026-03-16 16:22:52.696590 | TASK [Install binary dependencies] 2026-03-16 16:22:52.746811 | controller | ok 2026-03-16 16:22:52.766300 | 2026-03-16 16:22:52.766425 | TASK [bindep : Include find tasks] 2026-03-16 16:22:52.795492 | controller | ok 2026-03-16 16:22:52.803155 | controller | included: /var/lib/zuul/builds/c883c075a9d2454d9a0fd70de73c1628/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-03-16 16:22:52.809295 | 2026-03-16 16:22:52.809359 | TASK [bindep : Look for bindep.txt] 2026-03-16 16:22:53.180692 | controller | ok 2026-03-16 16:22:53.193793 | 2026-03-16 16:22:53.193959 | TASK [bindep : Define bindep_file fact] 2026-03-16 16:22:53.220719 | controller | skipping: Conditional result was False 2026-03-16 16:22:53.234256 | 2026-03-16 16:22:53.234419 | TASK [bindep : Look for other-requirements.txt] 2026-03-16 16:22:53.490824 | controller | ok 2026-03-16 16:22:53.500452 | 2026-03-16 16:22:53.500629 | TASK [bindep : Define bindep_file fact] 2026-03-16 16:22:53.531417 | controller | skipping: Conditional result was False 2026-03-16 16:22:53.547840 | 2026-03-16 16:22:53.548039 | TASK [bindep : Look for bindep fallback file] 2026-03-16 16:22:53.574816 | controller | skipping: Conditional result was False 2026-03-16 16:22:53.589908 | 2026-03-16 16:22:53.590108 | TASK [bindep : Define bindep_file fact] 2026-03-16 16:22:53.616913 | controller | skipping: Conditional result was False 2026-03-16 16:22:53.625556 | 2026-03-16 16:22:53.625660 | TASK [bindep : Include bindep tasks] 2026-03-16 16:22:53.650979 | controller | skipping: Conditional result was False 2026-03-16 16:22:53.659926 | 2026-03-16 16:22:53.660061 | TASK [bindep : Include install tasks] 2026-03-16 16:22:53.684641 | controller | skipping: Conditional result was False 2026-03-16 16:22:53.693381 | 2026-03-16 16:22:53.693476 | LOOP [bindep : Include package tasks] 2026-03-16 16:22:53.755840 | 2026-03-16 16:22:53.756039 | TASK [Run test-setup role] 2026-03-16 16:22:53.777852 | controller | ok 2026-03-16 16:22:53.802208 | 2026-03-16 16:22:53.802313 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-03-16 16:22:54.023080 | controller | ok 2026-03-16 16:22:54.037231 | 2026-03-16 16:22:54.037379 | TASK [test-setup : Run tools/test-setup.sh] 2026-03-16 16:22:54.590418 | controller | skipping: Conditional result was False 2026-03-16 16:22:54.646017 | 2026-03-16 16:22:54.646134 | PLAY RECAP 2026-03-16 16:22:54.646185 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-03-16 16:22:54.646212 | 2026-03-16 16:22:54.748928 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-03-16 16:22:54.750633 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-03-16 16:22:55.348418 | 2026-03-16 16:22:55.348539 | PLAY [controller] 2026-03-16 16:22:55.369769 | 2026-03-16 16:22:55.369962 | TASK [Create the /root directory] 2026-03-16 16:22:55.769776 | controller | ok 2026-03-16 16:22:55.778023 | 2026-03-16 16:22:55.778125 | TASK [Install glibc-langpack-en] 2026-03-16 16:22:59.752819 | controller | ok: Nothing to do 2026-03-16 16:22:59.765275 | 2026-03-16 16:22:59.765404 | TASK [Ensure controller directory exists] 2026-03-16 16:22:59.990388 | controller | changed 2026-03-16 16:23:00.003757 | 2026-03-16 16:23:00.003917 | TASK [Install container runtime] 2026-03-16 16:23:00.092711 | controller | ok 2026-03-16 16:23:00.154198 | 2026-03-16 16:23:00.154352 | LOOP [ensure-podman : Find distribution installation] 2026-03-16 16:23:00.199405 | controller | ok: "/var/lib/zuul/builds/c883c075a9d2454d9a0fd70de73c1628/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml" 2026-03-16 16:23:00.224831 | controller | included: /var/lib/zuul/builds/c883c075a9d2454d9a0fd70de73c1628/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml 2026-03-16 16:23:00.239217 | 2026-03-16 16:23:00.239356 | TASK [ensure-podman : Install podman (RedHat)] 2026-03-16 16:24:05.149167 | controller | changed 2026-03-16 16:24:05.162223 | 2026-03-16 16:24:05.162292 | TASK [ensure-podman : Fetch podman version] 2026-03-16 16:24:05.697533 | controller | Client: Podman Engine 2026-03-16 16:24:05.724676 | controller | Version: 4.6.2 2026-03-16 16:24:05.724719 | controller | API Version: 4.6.2 2026-03-16 16:24:05.724732 | controller | Go Version: go1.19.12 2026-03-16 16:24:05.724757 | controller | Built: Mon Aug 28 19:38:31 2023 2026-03-16 16:24:05.724770 | controller | OS/Arch: linux/amd64 2026-03-16 16:24:06.203255 | controller | ok: Runtime: 0:00:00.184912 2026-03-16 16:24:06.213368 | 2026-03-16 16:24:06.213467 | TASK [ensure-podman : Print podman version installed] 2026-03-16 16:24:06.264108 | Podman version: Client: Podman Engine 2026-03-16 16:24:06.264423 | Version: 4.6.2 2026-03-16 16:24:06.264485 | API Version: 4.6.2 2026-03-16 16:24:06.264529 | Go Version: go1.19.12 2026-03-16 16:24:06.264569 | Built: Mon Aug 28 19:38:31 2023 2026-03-16 16:24:06.264613 | OS/Arch: linux/amd64 2026-03-16 16:24:06.278216 | 2026-03-16 16:24:06.278410 | TASK [ensure-podman : Validate podman engine] 2026-03-16 16:24:06.835085 | controller | skipping: Conditional result was False 2026-03-16 16:24:06.849527 | 2026-03-16 16:24:06.849704 | TASK [ensure-podman : Set up docker compatability socket] 2026-03-16 16:24:06.880401 | controller | skipping: Conditional result was False 2026-03-16 16:24:06.908792 | 2026-03-16 16:24:06.908973 | TASK [Ensure python3.8 is present] 2026-03-16 16:24:06.936773 | controller | skipping: Conditional result was False 2026-03-16 16:24:06.952293 | 2026-03-16 16:24:06.952439 | TASK [Run our-ensure-python role (Fedora only for now)] 2026-03-16 16:24:06.995750 | controller | ok 2026-03-16 16:24:07.027751 | 2026-03-16 16:24:07.027849 | TASK [our-ensure-python : Install the right Python version (rpm)] 2026-03-16 16:24:08.458951 | controller | ok: Nothing to do 2026-03-16 16:24:08.471710 | 2026-03-16 16:24:08.471844 | TASK [our-ensure-python : Also install python3-devel] 2026-03-16 16:24:17.699651 | controller | changed 2026-03-16 16:24:17.721235 | 2026-03-16 16:24:17.721327 | TASK [Run ensure-virtualenv role] 2026-03-16 16:24:17.746111 | controller | ok 2026-03-16 16:24:17.776460 | 2026-03-16 16:24:17.776552 | TASK [ensure-virtualenv : Check if virtualenv is installed] 2026-03-16 16:24:18.032002 | controller | /usr/bin/virtualenv 2026-03-16 16:24:18.343110 | controller | ok: Runtime: 0:00:00.006594 2026-03-16 16:24:18.356435 | 2026-03-16 16:24:18.356745 | LOOP [ensure-virtualenv : Install virtualenv package] 2026-03-16 16:24:18.390952 | controller | skipping: Conditional result was False 2026-03-16 16:24:18.391312 | controller | ok: All items complete 2026-03-16 16:24:18.391340 | 2026-03-16 16:24:18.420029 | 2026-03-16 16:24:18.420263 | TASK [Find the full path of the Python interpreter] 2026-03-16 16:24:18.670881 | controller | /usr/bin/python3 2026-03-16 16:24:18.987612 | controller | ok 2026-03-16 16:24:18.993762 | 2026-03-16 16:24:18.993829 | TASK [Create virtualenv for ansible-test with a specific interpreter] 2026-03-16 16:24:19.810295 | controller | created virtual environment CPython3.11.0.final.0-64 in 500ms 2026-03-16 16:24:19.836249 | controller | creator CPython3Posix(dest=/home/zuul/venv, clear=False, no_vcs_ignore=False, global=False) 2026-03-16 16:24:19.836286 | 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 16:24:19.836297 | controller | added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1 2026-03-16 16:24:19.836311 | controller | activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator 2026-03-16 16:24:20.025599 | controller | changed 2026-03-16 16:24:20.034300 | 2026-03-16 16:24:20.034381 | TASK [Set selinux package] 2026-03-16 16:24:20.067957 | controller | ok 2026-03-16 16:24:20.075103 | 2026-03-16 16:24:20.075187 | TASK [Set selinux package (Fedora)] 2026-03-16 16:24:20.129169 | controller | ok 2026-03-16 16:24:20.137512 | 2026-03-16 16:24:20.137600 | TASK [Install selinux into virtualenv] 2026-03-16 16:25:21.437884 | controller | Collecting selinux-please-lie-to-me 2026-03-16 16:25:57.673109 | controller | Downloading selinux_please_lie_to_me-1.0.1-py2.py3-none-any.whl (3.8 kB) 2026-03-16 16:25:58.002436 | controller | Collecting setuptools<50.0.0 2026-03-16 16:25:58.007319 | controller | Downloading setuptools-49.6.0-py3-none-any.whl (803 kB) 2026-03-16 16:25:58.047509 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 803.3/803.3 kB 22.0 MB/s eta 0:00:00 2026-03-16 16:25:58.140591 | controller | Installing collected packages: setuptools, selinux-please-lie-to-me 2026-03-16 16:25:58.140704 | controller | Attempting uninstall: setuptools 2026-03-16 16:25:58.143089 | controller | Found existing installation: setuptools 62.6.0 2026-03-16 16:25:58.222528 | controller | Uninstalling setuptools-62.6.0: 2026-03-16 16:25:58.230735 | controller | Successfully uninstalled setuptools-62.6.0 2026-03-16 16:25:58.588703 | controller | Successfully installed selinux-please-lie-to-me-1.0.1 setuptools-49.6.0 2026-03-16 16:26:10.054327 | controller | 2026-03-16 16:26:10.142711 | controller | [notice] A new release of pip available: 22.2.2 -> 26.0.1 2026-03-16 16:26:10.142750 | controller | [notice] To update, run: python -m pip install --upgrade pip 2026-03-16 16:26:10.239976 | controller | ok: Runtime: 0:01:49.782101 2026-03-16 16:26:10.252403 | 2026-03-16 16:26:10.252528 | TASK [Install pytest-forked into virtualenv] 2026-03-16 16:26:22.312165 | controller | Collecting pytest-forked 2026-03-16 16:26:58.535776 | controller | Downloading pytest_forked-1.6.0-py3-none-any.whl (4.9 kB) 2026-03-16 16:26:58.582352 | controller | Collecting py 2026-03-16 16:26:58.586940 | controller | Downloading py-1.11.0-py2.py3-none-any.whl (98 kB) 2026-03-16 16:26:58.610575 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.7/98.7 kB 4.8 MB/s eta 0:00:00 2026-03-16 16:26:58.713748 | controller | Collecting pytest>=3.10 2026-03-16 16:26:58.717986 | controller | Downloading pytest-9.0.2-py3-none-any.whl (374 kB) 2026-03-16 16:26:58.732540 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 374.8/374.8 kB 34.4 MB/s eta 0:00:00 2026-03-16 16:26:58.770397 | controller | Collecting iniconfig>=1.0.1 2026-03-16 16:26:58.773922 | controller | Downloading iniconfig-2.3.0-py3-none-any.whl (7.5 kB) 2026-03-16 16:26:58.817391 | controller | Collecting packaging>=22 2026-03-16 16:26:58.821689 | controller | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-03-16 16:26:58.829867 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 12.0 MB/s eta 0:00:00 2026-03-16 16:26:58.860468 | controller | Collecting pluggy<2,>=1.5 2026-03-16 16:26:58.864432 | controller | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-03-16 16:26:58.911097 | controller | Collecting pygments>=2.7.2 2026-03-16 16:26:58.915216 | controller | Downloading pygments-2.19.2-py3-none-any.whl (1.2 MB) 2026-03-16 16:26:58.940529 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.2/1.2 MB 54.3 MB/s eta 0:00:00 2026-03-16 16:26:59.008124 | controller | Installing collected packages: pygments, py, pluggy, packaging, iniconfig, pytest, pytest-forked 2026-03-16 16:27:00.053812 | 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 16:27:00.062321 | controller | 2026-03-16 16:27:00.130089 | controller | [notice] A new release of pip available: 22.2.2 -> 26.0.1 2026-03-16 16:27:00.130113 | controller | [notice] To update, run: python -m pip install --upgrade pip 2026-03-16 16:27:00.333594 | controller | ok: Runtime: 0:00:49.641371 2026-03-16 16:27:00.341562 | 2026-03-16 16:27:00.341643 | TASK [Update pip] 2026-03-16 16:27:00.902801 | controller | Requirement already satisfied: pip in ./venv/lib/python3.11/site-packages (22.2.2) 2026-03-16 16:27:22.861716 | controller | Collecting pip 2026-03-16 16:27:47.112915 | controller | Downloading pip-26.0.1-py3-none-any.whl (1.8 MB) 2026-03-16 16:27:47.174064 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.8/1.8 MB 31.4 MB/s eta 0:00:00 2026-03-16 16:27:47.241333 | controller | Installing collected packages: pip 2026-03-16 16:27:47.241424 | controller | Attempting uninstall: pip 2026-03-16 16:27:47.243662 | controller | Found existing installation: pip 22.2.2 2026-03-16 16:27:47.386660 | controller | Uninstalling pip-22.2.2: 2026-03-16 16:27:47.401648 | controller | Successfully uninstalled pip-22.2.2 2026-03-16 16:27:48.211148 | controller | Successfully installed pip-26.0.1 2026-03-16 16:27:48.407399 | controller | ok: Runtime: 0:00:47.706165 2026-03-16 16:27:48.419713 | 2026-03-16 16:27:48.419838 | TASK [Ensure pip temp directory exists in /var/tmp] 2026-03-16 16:27:48.654524 | controller | changed 2026-03-16 16:27:48.667955 | 2026-03-16 16:27:48.668114 | TASK [Install ansible into virtualenv] 2026-03-16 16:27:49.218981 | controller | Processing ./src/github.com/ansible/ansible 2026-03-16 16:27:49.221348 | controller | Installing build dependencies: started 2026-03-16 16:28:12.009660 | controller | Installing build dependencies: finished with status 'done' 2026-03-16 16:28:12.010857 | controller | Getting requirements to build wheel: started 2026-03-16 16:28:12.739325 | controller | Getting requirements to build wheel: finished with status 'done' 2026-03-16 16:28:12.740607 | controller | Preparing metadata (pyproject.toml): started 2026-03-16 16:28:13.220842 | controller | Preparing metadata (pyproject.toml): finished with status 'done' 2026-03-16 16:28:13.223905 | 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 16:28:13.227310 | controller | ERROR: Package 'ansible-core' requires a different Python: 3.11.0 not in '>=3.12' 2026-03-16 16:28:13.772141 | controller | ERROR 2026-03-16 16:28:13.772315 | controller | { 2026-03-16 16:28:13.772344 | controller | "delta": "0:00:24.363223", 2026-03-16 16:28:13.772364 | controller | "end": "2026-03-16 16:28:13.306477", 2026-03-16 16:28:13.772382 | controller | "msg": "non-zero return code", 2026-03-16 16:28:13.772410 | controller | "rc": 1, 2026-03-16 16:28:13.772427 | controller | "start": "2026-03-16 16:27:48.943254" 2026-03-16 16:28:13.772443 | controller | } failure 2026-03-16 16:28:13.773893 | 2026-03-16 16:28:13.773938 | PLAY RECAP 2026-03-16 16:28:13.773978 | controller | ok: 18 changed: 10 unreachable: 0 failed: 1 skipped: 4 rescued: 0 ignored: 0 2026-03-16 16:28:13.773999 | 2026-03-16 16:28:13.870839 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-03-16 16:28:13.872749 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-16 16:28:14.428450 | 2026-03-16 16:28:14.428549 | PLAY [all] 2026-03-16 16:28:14.449897 | 2026-03-16 16:28:14.449978 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-03-16 16:28:14.700063 | controller | changed: non-zero return code 2026-03-16 16:28:14.711875 | 2026-03-16 16:28:14.711977 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-03-16 16:28:14.727418 | controller | skipping: Conditional result was False 2026-03-16 16:28:14.735324 | 2026-03-16 16:28:14.735414 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-03-16 16:28:14.758701 | 2026-03-16 16:28:14.758854 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-03-16 16:28:14.791460 | 2026-03-16 16:28:14.791614 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-03-16 16:28:14.816174 | controller | skipping: Conditional result was False 2026-03-16 16:28:14.825876 | 2026-03-16 16:28:14.825968 | LOOP [fetch-subunit-output : Generate subunit file] 2026-03-16 16:28:14.848396 | 2026-03-16 16:28:14.848554 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-03-16 16:28:14.862700 | controller | skipping: Conditional result was False 2026-03-16 16:28:14.870943 | 2026-03-16 16:28:14.871031 | TASK [fetch-subunit-output : Remove the temporary file] 2026-03-16 16:28:14.895323 | controller | skipping: Conditional result was False 2026-03-16 16:28:14.903123 | 2026-03-16 16:28:14.903206 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-03-16 16:28:14.917426 | controller | skipping: Conditional result was False 2026-03-16 16:28:14.952127 | 2026-03-16 16:28:14.952192 | PLAY RECAP 2026-03-16 16:28:14.952241 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-03-16 16:28:14.952269 | 2026-03-16 16:28:15.037041 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-16 16:28:15.037903 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2026-03-16 16:28:15.581001 | 2026-03-16 16:28:15.581106 | PLAY [all:!appliance*] 2026-03-16 16:28:15.601755 | 2026-03-16 16:28:15.601826 | TASK [unregister the node] 2026-03-16 16:28:16.133120 | controller | skipping: Conditional result was False 2026-03-16 16:28:16.139297 | 2026-03-16 16:28:16.139373 | TASK [include_role : fetch-output] 2026-03-16 16:28:16.180744 | controller | ok 2026-03-16 16:28:16.217916 | 2026-03-16 16:28:16.218144 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-16 16:28:16.263639 | controller | skipping: Conditional result was False 2026-03-16 16:28:16.277410 | 2026-03-16 16:28:16.277555 | TASK [fetch-output : Set log path for single node] 2026-03-16 16:28:16.329745 | controller | ok 2026-03-16 16:28:16.335428 | 2026-03-16 16:28:16.335491 | LOOP [fetch-output : Ensure local output dirs] 2026-03-16 16:28:16.800788 | controller -> localhost | ok: "/var/lib/zuul/builds/c883c075a9d2454d9a0fd70de73c1628/work/logs" 2026-03-16 16:28:17.019075 | controller -> localhost | changed: "/var/lib/zuul/builds/c883c075a9d2454d9a0fd70de73c1628/work/artifacts" 2026-03-16 16:28:17.219457 | controller -> localhost | changed: "/var/lib/zuul/builds/c883c075a9d2454d9a0fd70de73c1628/work/docs" 2026-03-16 16:28:17.234515 | 2026-03-16 16:28:17.234760 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-16 16:28:17.819986 | controller | changed: 2026-03-16 16:28:17.820187 | controller | .d..t...... ./ 2026-03-16 16:28:17.820215 | controller | cd+++++++++ controller/ 2026-03-16 16:28:17.820249 | controller | changed: All items complete 2026-03-16 16:28:17.820269 | 2026-03-16 16:28:18.236778 | controller | changed: .d..t...... ./ 2026-03-16 16:28:18.749413 | controller | changed: .d..t...... ./ 2026-03-16 16:28:18.768021 | 2026-03-16 16:28:18.768152 | TASK [include_role : fetch-output-openshift] 2026-03-16 16:28:18.782182 | controller | skipping: Conditional result was False 2026-03-16 16:28:18.789608 | 2026-03-16 16:28:18.789697 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-16 16:28:19.215256 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.012548 2026-03-16 16:28:19.496841 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007872 2026-03-16 16:28:19.529649 | 2026-03-16 16:28:19.529776 | PLAY [localhost] 2026-03-16 16:28:19.542450 | 2026-03-16 16:28:19.542511 | TASK [Run Zuul manifest role] 2026-03-16 16:28:19.561098 | localhost | ok 2026-03-16 16:28:19.574907 | 2026-03-16 16:28:19.574974 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-16 16:28:19.976016 | localhost | changed 2026-03-16 16:28:19.980707 | 2026-03-16 16:28:19.980770 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-16 16:28:20.018472 | localhost | ok 2026-03-16 16:28:20.027108 | 2026-03-16 16:28:20.027198 | TASK [Set zuul-log-path fact] 2026-03-16 16:28:20.051123 | localhost | ok 2026-03-16 16:28:20.064079 | 2026-03-16 16:28:20.064145 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-16 16:28:20.092377 | localhost | ok 2026-03-16 16:28:20.099871 | 2026-03-16 16:28:20.099928 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)] 2026-03-16 16:28:20.130101 | localhost | ok: 2026-03-16 16:28:20.130450 | localhost | { 2026-03-16 16:28:20.130491 | localhost | "auth": { 2026-03-16 16:28:20.130530 | localhost | "password": "IonWCwcuOFib&&<}wp^:[2G/", 2026-03-16 16:28:20.130557 | localhost | "username": "9LF91O0RK7JU" 2026-03-16 16:28:20.130581 | localhost | }, 2026-03-16 16:28:20.130605 | localhost | "profile": "rackspace", 2026-03-16 16:28:20.130627 | localhost | "region_name": "ORD" 2026-03-16 16:28:20.130648 | localhost | } 2026-03-16 16:28:20.130727 | localhost | changed: All items complete 2026-03-16 16:28:20.130759 | 2026-03-16 16:28:20.139116 | 2026-03-16 16:28:20.139197 | TASK [Run upload-logs-failover role (S3 then Swift)] 2026-03-16 16:28:20.156971 | localhost | Output suppressed because no_log was given 2026-03-16 16:28:20.170118 | 2026-03-16 16:28:20.170183 | TASK [upload-logs-failover : Initialize control vars] 2026-03-16 16:28:20.239349 | localhost | ok 2026-03-16 16:28:20.243479 | 2026-03-16 16:28:20.243539 | LOOP [upload-logs-failover : Perform log upload] 2026-03-16 16:28:20.278641 | localhost | Output suppressed because no_log was given 2026-03-16 16:28:20.285442 | localhost | included: /var/lib/zuul/builds/c883c075a9d2454d9a0fd70de73c1628/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml 2026-03-16 16:28:20.292251 | 2026-03-16 16:28:20.292317 | LOOP [upload-logs-failover : Unpack vars for swift upload] 2026-03-16 16:28:20.365042 | localhost | Output suppressed because no_log was given 2026-03-16 16:28:20.372108 | 2026-03-16 16:28:20.372199 | TASK [Upload logs to swift] 2026-03-16 16:28:20.392882 | localhost | ok 2026-03-16 16:28:20.425156 | 2026-03-16 16:28:20.425220 | TASK [Set zuul-log-path fact] 2026-03-16 16:28:20.459396 | localhost | skipping: Conditional result was False 2026-03-16 16:28:20.464409 | 2026-03-16 16:28:20.464471 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2026-03-16 16:28:20.764449 | localhost -> localhost | ok: Runtime: 0:00:00.011470 2026-03-16 16:28:20.776360 | 2026-03-16 16:28:20.776524 | TASK [upload-logs-swift : Upload logs to swift]