2026-03-13 14:33:40.650226 | Job console starting... 2026-03-13 14:33:40.664943 | Updating repositories 2026-03-13 14:33:40.821382 | Preparing job workspace 2026-03-13 14:33:45.159338 | Running Ansible setup... 2026-03-13 14:33:53.527220 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-03-13 14:33:54.134208 | 2026-03-13 14:33:54.134314 | PLAY [localhost] 2026-03-13 14:33:54.142404 | 2026-03-13 14:33:54.142473 | TASK [Gathering Facts] 2026-03-13 14:33:55.164548 | localhost | ok 2026-03-13 14:33:55.193260 | 2026-03-13 14:33:55.193431 | TASK [Setup log path fact] 2026-03-13 14:33:55.215742 | localhost | ok 2026-03-13 14:33:55.232346 | 2026-03-13 14:33:55.232452 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-13 14:33:55.275151 | localhost | ok 2026-03-13 14:33:55.291798 | 2026-03-13 14:33:55.291898 | TASK [emit-job-header : Print job information] 2026-03-13 14:33:55.345520 | # Job Information 2026-03-13 14:33:55.345833 | Ansible Version: 2.15.12 2026-03-13 14:33:55.345905 | Job: ansible-test-sanity-docker-milestone 2026-03-13 14:33:55.345981 | Pipeline: third-party-check 2026-03-13 14:33:55.346025 | Executor: ze03.softwarefactory-project.io 2026-03-13 14:33:55.346064 | Triggered by: https://github.com/openshift/community.okd/pull/274 2026-03-13 14:33:55.346109 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/488/ansible/4881e7bd87a043f38d89b02eb667a4ef/ 2026-03-13 14:33:55.346151 | Event ID: ad06ee60-1ee6-11f1-9946-8e388cb57718 2026-03-13 14:33:55.354260 | 2026-03-13 14:33:55.354395 | LOOP [emit-job-header : Print node information] 2026-03-13 14:33:55.497326 | localhost | ok: 2026-03-13 14:33:55.497655 | localhost | # Node Information 2026-03-13 14:33:55.497689 | localhost | Inventory Hostname: controller 2026-03-13 14:33:55.497722 | localhost | Hostname: np0005646400 2026-03-13 14:33:55.497763 | localhost | Username: zuul 2026-03-13 14:33:55.497796 | localhost | Distro: Fedora 37 2026-03-13 14:33:55.497823 | localhost | Provider: ansible-vexxhost-ams1 2026-03-13 14:33:55.497845 | localhost | Region: ams1 2026-03-13 14:33:55.497873 | localhost | Label: ansible-fedora-37-1vcpu 2026-03-13 14:33:55.497891 | localhost | Product Name: OpenStack Nova 2026-03-13 14:33:55.497908 | localhost | Interface IP: 38.129.16.219 2026-03-13 14:33:55.523582 | 2026-03-13 14:33:55.523828 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-13 14:33:55.915617 | localhost -> localhost | changed 2026-03-13 14:33:55.941455 | 2026-03-13 14:33:55.941690 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-13 14:33:56.820988 | localhost -> localhost | changed 2026-03-13 14:33:56.862047 | 2026-03-13 14:33:56.862190 | PLAY [all:!appliance*] 2026-03-13 14:33:56.898501 | 2026-03-13 14:33:56.898637 | TASK [include_role : start-zuul-console] 2026-03-13 14:33:56.922123 | controller | ok 2026-03-13 14:33:56.939926 | 2026-03-13 14:33:56.940033 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-13 14:33:58.043633 | controller | ok 2026-03-13 14:33:58.068827 | 2026-03-13 14:33:58.069010 | TASK [use-our-mirror : Retrieve the IP address] 2026-03-13 14:34:00.199519 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2026-03-13 14:34:00.214705 | 2026-03-13 14:34:00.214910 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2026-03-13 14:34:00.597805 | controller | skipping: Conditional result was False 2026-03-13 14:34:00.611267 | 2026-03-13 14:34:00.611411 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2026-03-13 14:34:00.648290 | controller | skipping: Conditional result was False 2026-03-13 14:34:00.661142 | 2026-03-13 14:34:00.661281 | TASK [use-our-mirror : Create the podman configuration directory] 2026-03-13 14:34:00.698065 | controller | skipping: Conditional result was False 2026-03-13 14:34:00.711374 | 2026-03-13 14:34:00.711542 | TASK [use-our-mirror : Copy the podman configuration] 2026-03-13 14:34:00.748798 | controller | skipping: Conditional result was False 2026-03-13 14:34:00.762096 | 2026-03-13 14:34:00.762233 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2026-03-13 14:34:00.788990 | controller | skipping: Conditional result was False 2026-03-13 14:34:00.802717 | 2026-03-13 14:34:00.802893 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2026-03-13 14:34:00.839718 | controller | skipping: Conditional result was False 2026-03-13 14:34:00.864036 | 2026-03-13 14:34:00.864175 | TASK [Disable Fedora Modular] 2026-03-13 14:34:02.026100 | controller | changed 2026-03-13 14:34:02.038437 | 2026-03-13 14:34:02.038567 | TASK [Enable EPEL] 2026-03-13 14:34:02.065333 | controller | skipping: Conditional result was False 2026-03-13 14:34:02.078557 | 2026-03-13 14:34:02.078697 | TASK [Register the RHEL node] 2026-03-13 14:34:02.504313 | 2026-03-13 14:34:02.504506 | TASK [Show the subscription-manager status] 2026-03-13 14:34:02.892920 | controller | skipping: Conditional result was False 2026-03-13 14:34:02.901976 | 2026-03-13 14:34:02.902074 | TASK [Enable EPEL on RHEL] 2026-03-13 14:34:03.309110 | controller | skipping: Conditional result was False 2026-03-13 14:34:03.321690 | 2026-03-13 14:34:03.321985 | TASK [Install git and tox] 2026-03-13 14:36:10.144241 | controller | changed 2026-03-13 14:36:10.158226 | 2026-03-13 14:36:10.158353 | TASK [include_role : prepare-workspace] 2026-03-13 14:36:10.189393 | controller | ok 2026-03-13 14:36:10.225522 | 2026-03-13 14:36:10.225625 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-13 14:36:11.077406 | controller | ok 2026-03-13 14:36:11.092066 | 2026-03-13 14:36:11.092203 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-13 14:36:27.325945 | controller | Output suppressed because no_log was given 2026-03-13 14:36:27.339128 | 2026-03-13 14:36:27.339206 | TASK [include_role : prepare-workspace-openshift] 2026-03-13 14:36:27.357951 | controller | skipping: Conditional result was False 2026-03-13 14:36:27.387985 | 2026-03-13 14:36:27.388066 | PLAY [all:!appliance] 2026-03-13 14:36:27.407923 | 2026-03-13 14:36:27.407987 | TASK [Run add-build-sshkey role (RSA)] 2026-03-13 14:36:27.439639 | controller | ok 2026-03-13 14:36:27.460176 | 2026-03-13 14:36:27.460262 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-13 14:36:27.740967 | controller -> localhost | ok 2026-03-13 14:36:27.759660 | 2026-03-13 14:36:27.759894 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-13 14:36:27.792210 | controller | ok 2026-03-13 14:36:27.815721 | controller | included: /var/lib/zuul/builds/4881e7bd87a043f38d89b02eb667a4ef/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-13 14:36:27.825064 | 2026-03-13 14:36:27.825152 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-13 14:36:28.543721 | controller -> localhost | Generating public/private rsa key pair. 2026-03-13 14:36:28.543961 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/4881e7bd87a043f38d89b02eb667a4ef/work/4881e7bd87a043f38d89b02eb667a4ef_id_rsa. 2026-03-13 14:36:28.543992 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/4881e7bd87a043f38d89b02eb667a4ef/work/4881e7bd87a043f38d89b02eb667a4ef_id_rsa.pub. 2026-03-13 14:36:28.544013 | controller -> localhost | The key fingerprint is: 2026-03-13 14:36:28.544033 | controller -> localhost | SHA256:h8MQmML4TmHGKErOFFFpBcvhO9ZVplqfQEWdho9X+c8 zuul-build-sshkey 2026-03-13 14:36:28.544051 | controller -> localhost | The key's randomart image is: 2026-03-13 14:36:28.544071 | controller -> localhost | +---[RSA 2048]----+ 2026-03-13 14:36:28.544088 | controller -> localhost | | B++++..o=o . . | 2026-03-13 14:36:28.544107 | controller -> localhost | |+oXo= ..+. + o | 2026-03-13 14:36:28.544124 | controller -> localhost | |B+.* .= + . . | 2026-03-13 14:36:28.544141 | controller -> localhost | |.oo o +ooo.o . | 2026-03-13 14:36:28.544158 | controller -> localhost | | o + o Soo ..| 2026-03-13 14:36:28.544183 | controller -> localhost | | o . o E| 2026-03-13 14:36:28.544205 | controller -> localhost | | | 2026-03-13 14:36:28.544224 | controller -> localhost | | | 2026-03-13 14:36:28.544241 | controller -> localhost | | | 2026-03-13 14:36:28.544262 | controller -> localhost | +----[SHA256]-----+ 2026-03-13 14:36:28.544317 | controller -> localhost | ok: Runtime: 0:00:00.292508 2026-03-13 14:36:28.550821 | 2026-03-13 14:36:28.550887 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-13 14:36:28.573269 | controller | ok 2026-03-13 14:36:28.583294 | controller | included: /var/lib/zuul/builds/4881e7bd87a043f38d89b02eb667a4ef/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-13 14:36:28.592209 | 2026-03-13 14:36:28.592277 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-13 14:36:28.606272 | controller | skipping: Conditional result was False 2026-03-13 14:36:28.614491 | 2026-03-13 14:36:28.614594 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-13 14:36:29.715152 | controller | changed 2026-03-13 14:36:29.728346 | 2026-03-13 14:36:29.728499 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-13 14:36:30.401334 | controller | ok 2026-03-13 14:36:30.414404 | 2026-03-13 14:36:30.414540 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-13 14:36:33.508508 | controller | changed 2026-03-13 14:36:33.516356 | 2026-03-13 14:36:33.516443 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-13 14:36:36.613450 | controller | changed 2026-03-13 14:36:36.619076 | 2026-03-13 14:36:36.619136 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-13 14:36:36.642493 | controller | skipping: Conditional result was False 2026-03-13 14:36:36.649426 | 2026-03-13 14:36:36.649517 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-13 14:36:37.100909 | controller -> localhost | changed 2026-03-13 14:36:37.125411 | 2026-03-13 14:36:37.125589 | TASK [add-build-sshkey : Add back temp key] 2026-03-13 14:36:37.430285 | controller -> localhost | Identity added: /var/lib/zuul/builds/4881e7bd87a043f38d89b02eb667a4ef/work/4881e7bd87a043f38d89b02eb667a4ef_id_rsa (zuul-build-sshkey) 2026-03-13 14:36:37.430743 | controller -> localhost | ok: Runtime: 0:00:00.007321 2026-03-13 14:36:37.444456 | 2026-03-13 14:36:37.444589 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-13 14:36:38.342640 | controller | ok 2026-03-13 14:36:38.348606 | 2026-03-13 14:36:38.348701 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-13 14:36:38.384002 | controller | skipping: Conditional result was False 2026-03-13 14:36:38.396576 | 2026-03-13 14:36:38.396663 | TASK [Run add-build-sshkey role (ECDSA)] 2026-03-13 14:36:38.426956 | controller | ok 2026-03-13 14:36:38.443211 | 2026-03-13 14:36:38.443317 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-13 14:36:38.692305 | controller -> localhost | ok 2026-03-13 14:36:38.699287 | 2026-03-13 14:36:38.699390 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-13 14:36:38.720256 | controller | ok 2026-03-13 14:36:38.733115 | controller | included: /var/lib/zuul/builds/4881e7bd87a043f38d89b02eb667a4ef/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-13 14:36:38.739502 | 2026-03-13 14:36:38.739573 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-13 14:36:39.039032 | controller -> localhost | Generating public/private ecdsa key pair. 2026-03-13 14:36:39.039318 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/4881e7bd87a043f38d89b02eb667a4ef/work/4881e7bd87a043f38d89b02eb667a4ef_id_ecdsa. 2026-03-13 14:36:39.039358 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/4881e7bd87a043f38d89b02eb667a4ef/work/4881e7bd87a043f38d89b02eb667a4ef_id_ecdsa.pub. 2026-03-13 14:36:39.039402 | controller -> localhost | The key fingerprint is: 2026-03-13 14:36:39.039433 | controller -> localhost | SHA256:2BvgNq8X9IvdaeHVcqZTpzLz9vu2Fei6ZPg7OtwOD88 zuul-build-sshkey 2026-03-13 14:36:39.039461 | controller -> localhost | The key's randomart image is: 2026-03-13 14:36:39.039490 | controller -> localhost | +---[ECDSA 521]---+ 2026-03-13 14:36:39.039517 | controller -> localhost | | | 2026-03-13 14:36:39.039542 | controller -> localhost | | | 2026-03-13 14:36:39.039594 | controller -> localhost | | . | 2026-03-13 14:36:39.039627 | controller -> localhost | | . +. . | 2026-03-13 14:36:39.039659 | controller -> localhost | | =.S. . o | 2026-03-13 14:36:39.039686 | controller -> localhost | | . o.oo o o B| 2026-03-13 14:36:39.039712 | controller -> localhost | | +B.* = Bo| 2026-03-13 14:36:39.039760 | controller -> localhost | | .oo%oX = o| 2026-03-13 14:36:39.039784 | controller -> localhost | | .. .+E+*.**| 2026-03-13 14:36:39.039805 | controller -> localhost | +----[SHA256]-----+ 2026-03-13 14:36:39.039867 | controller -> localhost | ok: Runtime: 0:00:00.014001 2026-03-13 14:36:39.048339 | 2026-03-13 14:36:39.048405 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-13 14:36:39.080500 | controller | ok 2026-03-13 14:36:39.087917 | controller | included: /var/lib/zuul/builds/4881e7bd87a043f38d89b02eb667a4ef/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-13 14:36:39.097329 | 2026-03-13 14:36:39.097393 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-13 14:36:39.121197 | controller | skipping: Conditional result was False 2026-03-13 14:36:39.157078 | 2026-03-13 14:36:39.157203 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-13 14:36:40.079097 | controller | changed 2026-03-13 14:36:40.092061 | 2026-03-13 14:36:40.092194 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-13 14:36:40.763767 | controller | ok 2026-03-13 14:36:40.776190 | 2026-03-13 14:36:40.776321 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-13 14:36:43.866957 | controller | changed 2026-03-13 14:36:43.873056 | 2026-03-13 14:36:43.873118 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-13 14:36:46.986863 | controller | changed 2026-03-13 14:36:47.000491 | 2026-03-13 14:36:47.000601 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-13 14:36:47.036021 | controller | skipping: Conditional result was False 2026-03-13 14:36:47.044908 | 2026-03-13 14:36:47.045018 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-13 14:36:47.315282 | controller -> localhost | changed 2026-03-13 14:36:47.359581 | 2026-03-13 14:36:47.359699 | TASK [add-build-sshkey : Add back temp key] 2026-03-13 14:36:47.597495 | controller -> localhost | Identity added: /var/lib/zuul/builds/4881e7bd87a043f38d89b02eb667a4ef/work/4881e7bd87a043f38d89b02eb667a4ef_id_ecdsa (zuul-build-sshkey) 2026-03-13 14:36:47.597678 | controller -> localhost | ok: Runtime: 0:00:00.009261 2026-03-13 14:36:47.604152 | 2026-03-13 14:36:47.604211 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-13 14:36:48.290751 | controller | ok 2026-03-13 14:36:48.296150 | 2026-03-13 14:36:48.296210 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-13 14:36:48.330613 | controller | skipping: Conditional result was False 2026-03-13 14:36:48.342092 | 2026-03-13 14:36:48.342167 | TASK [include_role : remove-zuul-sshkey] 2026-03-13 14:36:48.366343 | controller | skipping: Conditional result was False 2026-03-13 14:36:48.374875 | 2026-03-13 14:36:48.374974 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-13 14:36:49.058575 | controller | ok: "logs" 2026-03-13 14:36:49.059261 | controller | ok: All items complete 2026-03-13 14:36:49.059338 | 2026-03-13 14:36:49.688812 | controller | ok: "artifacts" 2026-03-13 14:36:50.313558 | controller | ok: "docs" 2026-03-13 14:36:50.330449 | 2026-03-13 14:36:50.330537 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-13 14:36:51.017480 | controller | changed: "logs" 2026-03-13 14:36:51.652179 | controller | changed: "artifacts" 2026-03-13 14:36:52.285912 | controller | changed: "docs" 2026-03-13 14:36:52.344170 | 2026-03-13 14:36:52.344287 | PLAY RECAP 2026-03-13 14:36:52.344344 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2026-03-13 14:36:52.344381 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-13 14:36:52.344409 | 2026-03-13 14:36:52.469922 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-03-13 14:36:52.471635 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-03-13 14:36:53.094479 | 2026-03-13 14:36:53.094587 | PLAY [all] 2026-03-13 14:36:53.115778 | 2026-03-13 14:36:53.115877 | TASK [Install binary dependencies] 2026-03-13 14:36:53.175208 | controller | ok 2026-03-13 14:36:53.194176 | 2026-03-13 14:36:53.194292 | TASK [bindep : Include find tasks] 2026-03-13 14:36:53.223248 | controller | ok 2026-03-13 14:36:53.230779 | controller | included: /var/lib/zuul/builds/4881e7bd87a043f38d89b02eb667a4ef/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-03-13 14:36:53.237585 | 2026-03-13 14:36:53.237648 | TASK [bindep : Look for bindep.txt] 2026-03-13 14:36:54.182425 | controller | ok 2026-03-13 14:36:54.192645 | 2026-03-13 14:36:54.192808 | TASK [bindep : Define bindep_file fact] 2026-03-13 14:36:54.210591 | controller | skipping: Conditional result was False 2026-03-13 14:36:54.220619 | 2026-03-13 14:36:54.220760 | TASK [bindep : Look for other-requirements.txt] 2026-03-13 14:36:54.853925 | controller | ok 2026-03-13 14:36:54.867047 | 2026-03-13 14:36:54.867198 | TASK [bindep : Define bindep_file fact] 2026-03-13 14:36:54.894207 | controller | skipping: Conditional result was False 2026-03-13 14:36:54.906791 | 2026-03-13 14:36:54.906933 | TASK [bindep : Look for bindep fallback file] 2026-03-13 14:36:54.933772 | controller | skipping: Conditional result was False 2026-03-13 14:36:54.946097 | 2026-03-13 14:36:54.946246 | TASK [bindep : Define bindep_file fact] 2026-03-13 14:36:54.973040 | controller | skipping: Conditional result was False 2026-03-13 14:36:54.985965 | 2026-03-13 14:36:54.986096 | TASK [bindep : Include bindep tasks] 2026-03-13 14:36:55.013029 | controller | skipping: Conditional result was False 2026-03-13 14:36:55.025538 | 2026-03-13 14:36:55.025670 | TASK [bindep : Include install tasks] 2026-03-13 14:36:55.052395 | controller | skipping: Conditional result was False 2026-03-13 14:36:55.064861 | 2026-03-13 14:36:55.065004 | LOOP [bindep : Include package tasks] 2026-03-13 14:36:55.136997 | 2026-03-13 14:36:55.137228 | TASK [Run test-setup role] 2026-03-13 14:36:55.168305 | controller | ok 2026-03-13 14:36:55.199131 | 2026-03-13 14:36:55.199266 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-03-13 14:36:55.910330 | controller | ok 2026-03-13 14:36:55.923163 | 2026-03-13 14:36:55.923289 | TASK [test-setup : Run tools/test-setup.sh] 2026-03-13 14:36:56.313074 | controller | skipping: Conditional result was False 2026-03-13 14:36:56.367060 | 2026-03-13 14:36:56.367213 | PLAY RECAP 2026-03-13 14:36:56.367271 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-03-13 14:36:56.367300 | 2026-03-13 14:36:56.462406 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-03-13 14:36:56.463229 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-03-13 14:36:57.063301 | 2026-03-13 14:36:57.063515 | PLAY [controller] 2026-03-13 14:36:57.086979 | 2026-03-13 14:36:57.087133 | TASK [Create the /root directory] 2026-03-13 14:36:58.139204 | controller | ok 2026-03-13 14:36:58.147173 | 2026-03-13 14:36:58.147287 | TASK [Install glibc-langpack-en] 2026-03-13 14:37:06.167280 | controller | ok: Nothing to do 2026-03-13 14:37:06.179475 | 2026-03-13 14:37:06.179621 | TASK [Ensure controller directory exists] 2026-03-13 14:37:07.023612 | controller | changed 2026-03-13 14:37:07.036091 | 2026-03-13 14:37:07.036224 | TASK [Install container runtime] 2026-03-13 14:37:07.115819 | controller | ok 2026-03-13 14:37:07.175750 | 2026-03-13 14:37:07.175879 | LOOP [ensure-podman : Find distribution installation] 2026-03-13 14:37:07.218799 | controller | ok: "/var/lib/zuul/builds/4881e7bd87a043f38d89b02eb667a4ef/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml" 2026-03-13 14:37:07.235626 | controller | included: /var/lib/zuul/builds/4881e7bd87a043f38d89b02eb667a4ef/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml 2026-03-13 14:37:07.250364 | 2026-03-13 14:37:07.250531 | TASK [ensure-podman : Install podman (RedHat)] 2026-03-13 14:39:02.154497 | controller | changed 2026-03-13 14:39:02.168439 | 2026-03-13 14:39:02.168575 | TASK [ensure-podman : Fetch podman version] 2026-03-13 14:39:03.306729 | controller | Client: Podman Engine 2026-03-13 14:39:03.339004 | controller | Version: 4.6.2 2026-03-13 14:39:03.339056 | controller | API Version: 4.6.2 2026-03-13 14:39:03.339064 | controller | Go Version: go1.19.12 2026-03-13 14:39:03.339083 | controller | Built: Mon Aug 28 19:38:31 2023 2026-03-13 14:39:03.339091 | controller | OS/Arch: linux/amd64 2026-03-13 14:39:03.558220 | controller | ok: Runtime: 0:00:00.240506 2026-03-13 14:39:03.572517 | 2026-03-13 14:39:03.572673 | TASK [ensure-podman : Print podman version installed] 2026-03-13 14:39:03.612876 | Podman version: Client: Podman Engine 2026-03-13 14:39:03.613063 | Version: 4.6.2 2026-03-13 14:39:03.613103 | API Version: 4.6.2 2026-03-13 14:39:03.613132 | Go Version: go1.19.12 2026-03-13 14:39:03.613157 | Built: Mon Aug 28 19:38:31 2023 2026-03-13 14:39:03.613187 | OS/Arch: linux/amd64 2026-03-13 14:39:03.621092 | 2026-03-13 14:39:03.621173 | TASK [ensure-podman : Validate podman engine] 2026-03-13 14:39:03.993078 | controller | skipping: Conditional result was False 2026-03-13 14:39:04.006678 | 2026-03-13 14:39:04.006856 | TASK [ensure-podman : Set up docker compatability socket] 2026-03-13 14:39:04.023364 | controller | skipping: Conditional result was False 2026-03-13 14:39:04.050055 | 2026-03-13 14:39:04.050233 | TASK [Ensure python3.8 is present] 2026-03-13 14:39:04.077241 | controller | skipping: Conditional result was False 2026-03-13 14:39:04.089620 | 2026-03-13 14:39:04.089783 | TASK [Run our-ensure-python role (Fedora only for now)] 2026-03-13 14:39:04.118036 | controller | ok 2026-03-13 14:39:04.149934 | 2026-03-13 14:39:04.150071 | TASK [our-ensure-python : Install the right Python version (rpm)] 2026-03-13 14:39:07.611997 | controller | ok: Nothing to do 2026-03-13 14:39:07.624180 | 2026-03-13 14:39:07.624317 | TASK [our-ensure-python : Also install python3-devel] 2026-03-13 14:39:22.141143 | controller | changed 2026-03-13 14:39:22.166018 | 2026-03-13 14:39:22.166161 | TASK [Run ensure-virtualenv role] 2026-03-13 14:39:22.190343 | controller | ok 2026-03-13 14:39:22.218780 | 2026-03-13 14:39:22.218895 | TASK [ensure-virtualenv : Check if virtualenv is installed] 2026-03-13 14:39:22.984401 | controller | /usr/bin/virtualenv 2026-03-13 14:39:23.593324 | controller | ok: Runtime: 0:00:00.005173 2026-03-13 14:39:23.607266 | 2026-03-13 14:39:23.607453 | LOOP [ensure-virtualenv : Install virtualenv package] 2026-03-13 14:39:23.646065 | controller | skipping: Conditional result was False 2026-03-13 14:39:23.646694 | controller | ok: All items complete 2026-03-13 14:39:23.646831 | 2026-03-13 14:39:23.672595 | 2026-03-13 14:39:23.672751 | TASK [Find the full path of the Python interpreter] 2026-03-13 14:39:24.478270 | controller | /usr/bin/python3 2026-03-13 14:39:25.063628 | controller | ok 2026-03-13 14:39:25.075960 | 2026-03-13 14:39:25.076100 | TASK [Create virtualenv for ansible-test with a specific interpreter] 2026-03-13 14:39:26.934298 | controller | created virtual environment CPython3.11.0.final.0-64 in 866ms 2026-03-13 14:39:26.990650 | controller | creator CPython3Posix(dest=/home/zuul/venv, clear=False, no_vcs_ignore=False, global=False) 2026-03-13 14:39:26.990718 | 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-13 14:39:26.990736 | controller | added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1 2026-03-13 14:39:26.990757 | controller | activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator 2026-03-13 14:39:27.471704 | controller | changed 2026-03-13 14:39:27.485603 | 2026-03-13 14:39:27.485800 | TASK [Set selinux package] 2026-03-13 14:39:27.525687 | controller | ok 2026-03-13 14:39:27.537647 | 2026-03-13 14:39:27.537817 | TASK [Set selinux package (Fedora)] 2026-03-13 14:39:27.586944 | controller | ok 2026-03-13 14:39:27.598476 | 2026-03-13 14:39:27.598605 | TASK [Install selinux into virtualenv] 2026-03-13 14:39:30.598577 | controller | Collecting selinux-please-lie-to-me 2026-03-13 14:39:30.661805 | controller | Downloading selinux_please_lie_to_me-1.0.1-py2.py3-none-any.whl (3.8 kB) 2026-03-13 14:39:31.173485 | controller | Collecting setuptools<50.0.0 2026-03-13 14:39:31.179474 | controller | Downloading setuptools-49.6.0-py3-none-any.whl (803 kB) 2026-03-13 14:39:31.227132 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 803.3/803.3 kB 18.5 MB/s eta 0:00:00 2026-03-13 14:39:31.357136 | controller | Installing collected packages: setuptools, selinux-please-lie-to-me 2026-03-13 14:39:31.357491 | controller | Attempting uninstall: setuptools 2026-03-13 14:39:31.362169 | controller | Found existing installation: setuptools 62.6.0 2026-03-13 14:39:31.463120 | controller | Uninstalling setuptools-62.6.0: 2026-03-13 14:39:31.477026 | controller | Successfully uninstalled setuptools-62.6.0 2026-03-13 14:39:32.253219 | controller | Successfully installed selinux-please-lie-to-me-1.0.1 setuptools-49.6.0 2026-03-13 14:39:32.462123 | controller | 2026-03-13 14:39:32.743968 | controller | [notice] A new release of pip available: 22.2.2 -> 26.0.1 2026-03-13 14:39:32.744018 | controller | [notice] To update, run: python -m pip install --upgrade pip 2026-03-13 14:39:32.987988 | controller | ok: Runtime: 0:00:04.294530 2026-03-13 14:39:33.001503 | 2026-03-13 14:39:33.001661 | TASK [Install pytest-forked into virtualenv] 2026-03-13 14:39:34.509757 | controller | Collecting pytest-forked 2026-03-13 14:39:34.576465 | controller | Downloading pytest_forked-1.6.0-py3-none-any.whl (4.9 kB) 2026-03-13 14:39:34.651377 | controller | Collecting py 2026-03-13 14:39:34.659224 | controller | Downloading py-1.11.0-py2.py3-none-any.whl (98 kB) 2026-03-13 14:39:34.692847 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.7/98.7 kB 2.9 MB/s eta 0:00:00 2026-03-13 14:39:34.877967 | controller | Collecting pytest>=3.10 2026-03-13 14:39:34.886762 | controller | Downloading pytest-9.0.2-py3-none-any.whl (374 kB) 2026-03-13 14:39:34.904270 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 374.8/374.8 kB 28.4 MB/s eta 0:00:00 2026-03-13 14:39:34.965703 | controller | Collecting iniconfig>=1.0.1 2026-03-13 14:39:34.970733 | controller | Downloading iniconfig-2.3.0-py3-none-any.whl (7.5 kB) 2026-03-13 14:39:35.036055 | controller | Collecting packaging>=22 2026-03-13 14:39:35.040587 | controller | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-03-13 14:39:35.056694 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 6.7 MB/s eta 0:00:00 2026-03-13 14:39:35.102661 | controller | Collecting pluggy<2,>=1.5 2026-03-13 14:39:35.108932 | controller | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-03-13 14:39:35.183821 | controller | Collecting pygments>=2.7.2 2026-03-13 14:39:35.190054 | controller | Downloading pygments-2.19.2-py3-none-any.whl (1.2 MB) 2026-03-13 14:39:35.216818 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.2/1.2 MB 56.5 MB/s eta 0:00:00 2026-03-13 14:39:35.393107 | controller | Installing collected packages: pygments, py, pluggy, packaging, iniconfig, pytest, pytest-forked 2026-03-13 14:39:37.670653 | 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-13 14:39:37.685528 | controller | 2026-03-13 14:39:37.891916 | controller | [notice] A new release of pip available: 22.2.2 -> 26.0.1 2026-03-13 14:39:37.891970 | controller | [notice] To update, run: python -m pip install --upgrade pip 2026-03-13 14:39:38.419505 | controller | ok: Runtime: 0:00:04.054420 2026-03-13 14:39:38.432035 | 2026-03-13 14:39:38.432184 | TASK [Update pip] 2026-03-13 14:39:39.832747 | controller | Requirement already satisfied: pip in ./venv/lib/python3.11/site-packages (22.2.2) 2026-03-13 14:39:40.100676 | controller | Collecting pip 2026-03-13 14:39:40.190054 | controller | Downloading pip-26.0.1-py3-none-any.whl (1.8 MB) 2026-03-13 14:39:40.288570 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.8/1.8 MB 19.3 MB/s eta 0:00:00 2026-03-13 14:39:40.412152 | controller | Installing collected packages: pip 2026-03-13 14:39:40.412494 | controller | Attempting uninstall: pip 2026-03-13 14:39:40.418098 | controller | Found existing installation: pip 22.2.2 2026-03-13 14:39:40.651648 | controller | Uninstalling pip-22.2.2: 2026-03-13 14:39:40.681840 | controller | Successfully uninstalled pip-22.2.2 2026-03-13 14:39:42.661825 | controller | Successfully installed pip-26.0.1 2026-03-13 14:39:43.344387 | controller | ok: Runtime: 0:00:03.674121 2026-03-13 14:39:43.351046 | 2026-03-13 14:39:43.351148 | TASK [Ensure pip temp directory exists in /var/tmp] 2026-03-13 14:39:44.254377 | controller | changed 2026-03-13 14:39:44.266063 | 2026-03-13 14:39:44.266194 | TASK [Install ansible into virtualenv] 2026-03-13 14:39:45.504397 | controller | Processing ./src/github.com/ansible/ansible 2026-03-13 14:39:45.510309 | controller | Installing build dependencies: started 2026-03-13 14:39:47.463937 | controller | Installing build dependencies: finished with status 'done' 2026-03-13 14:39:48.964155 | controller | Getting requirements to build wheel: started 2026-03-13 14:39:48.964241 | controller | Getting requirements to build wheel: finished with status 'done' 2026-03-13 14:39:48.966684 | controller | Preparing metadata (pyproject.toml): started 2026-03-13 14:39:49.857267 | controller | Preparing metadata (pyproject.toml): finished with status 'done' 2026-03-13 14:39:49.858413 | 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-13 14:39:49.858438 | controller | ERROR: Package 'ansible-core' requires a different Python: 3.11.0 not in '>=3.12' 2026-03-13 14:39:50.170655 | controller | ERROR 2026-03-13 14:39:50.170981 | controller | { 2026-03-13 14:39:50.171043 | controller | "delta": "0:00:05.089509", 2026-03-13 14:39:50.171084 | controller | "end": "2026-03-13 14:39:50.024725", 2026-03-13 14:39:50.171119 | controller | "msg": "non-zero return code", 2026-03-13 14:39:50.171186 | controller | "rc": 1, 2026-03-13 14:39:50.171282 | controller | "start": "2026-03-13 14:39:44.935216" 2026-03-13 14:39:50.171379 | controller | } failure 2026-03-13 14:39:50.174477 | 2026-03-13 14:39:50.174579 | PLAY RECAP 2026-03-13 14:39:50.174683 | controller | ok: 18 changed: 10 unreachable: 0 failed: 1 skipped: 4 rescued: 0 ignored: 0 2026-03-13 14:39:50.174795 | 2026-03-13 14:39:50.321921 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-03-13 14:39:50.322941 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-13 14:39:50.859521 | 2026-03-13 14:39:50.859636 | PLAY [all] 2026-03-13 14:39:50.881687 | 2026-03-13 14:39:50.881825 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-03-13 14:39:52.823874 | controller | changed: non-zero return code 2026-03-13 14:39:52.836813 | 2026-03-13 14:39:52.836973 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-03-13 14:39:52.863522 | controller | skipping: Conditional result was False 2026-03-13 14:39:52.877127 | 2026-03-13 14:39:52.877271 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-03-13 14:39:52.917605 | 2026-03-13 14:39:52.917908 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-03-13 14:39:52.956576 | 2026-03-13 14:39:52.956861 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-03-13 14:39:52.982867 | controller | skipping: Conditional result was False 2026-03-13 14:39:52.996041 | 2026-03-13 14:39:52.996185 | LOOP [fetch-subunit-output : Generate subunit file] 2026-03-13 14:39:53.036807 | 2026-03-13 14:39:53.037134 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-03-13 14:39:53.063878 | controller | skipping: Conditional result was False 2026-03-13 14:39:53.076290 | 2026-03-13 14:39:53.076384 | TASK [fetch-subunit-output : Remove the temporary file] 2026-03-13 14:39:53.101205 | controller | skipping: Conditional result was False 2026-03-13 14:39:53.118161 | 2026-03-13 14:39:53.118308 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-03-13 14:39:53.145003 | controller | skipping: Conditional result was False 2026-03-13 14:39:53.191602 | 2026-03-13 14:39:53.191687 | PLAY RECAP 2026-03-13 14:39:53.191782 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-03-13 14:39:53.191819 | 2026-03-13 14:39:53.290588 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-13 14:39:53.292212 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2026-03-13 14:39:53.865640 | 2026-03-13 14:39:53.865778 | PLAY [all:!appliance*] 2026-03-13 14:39:53.887305 | 2026-03-13 14:39:53.887427 | TASK [unregister the node] 2026-03-13 14:39:54.257406 | controller | skipping: Conditional result was False 2026-03-13 14:39:54.270806 | 2026-03-13 14:39:54.270996 | TASK [include_role : fetch-output] 2026-03-13 14:39:54.315097 | controller | ok 2026-03-13 14:39:54.334525 | 2026-03-13 14:39:54.334605 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-13 14:39:54.399337 | controller | skipping: Conditional result was False 2026-03-13 14:39:54.414370 | 2026-03-13 14:39:54.414524 | TASK [fetch-output : Set log path for single node] 2026-03-13 14:39:54.474564 | controller | ok 2026-03-13 14:39:54.488420 | 2026-03-13 14:39:54.488570 | LOOP [fetch-output : Ensure local output dirs] 2026-03-13 14:39:54.935924 | controller -> localhost | ok: "/var/lib/zuul/builds/4881e7bd87a043f38d89b02eb667a4ef/work/logs" 2026-03-13 14:39:55.216025 | controller -> localhost | changed: "/var/lib/zuul/builds/4881e7bd87a043f38d89b02eb667a4ef/work/artifacts" 2026-03-13 14:39:55.466882 | controller -> localhost | changed: "/var/lib/zuul/builds/4881e7bd87a043f38d89b02eb667a4ef/work/docs" 2026-03-13 14:39:55.494110 | 2026-03-13 14:39:55.494265 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-13 14:39:57.749212 | controller | changed: 2026-03-13 14:39:57.749606 | controller | .d..t...... ./ 2026-03-13 14:39:57.749666 | controller | cd+++++++++ controller/ 2026-03-13 14:39:57.749764 | controller | changed: All items complete 2026-03-13 14:39:57.749821 | 2026-03-13 14:39:59.837537 | controller | changed: .d..t...... ./ 2026-03-13 14:40:01.939323 | controller | changed: .d..t...... ./ 2026-03-13 14:40:01.968586 | 2026-03-13 14:40:01.968889 | TASK [include_role : fetch-output-openshift] 2026-03-13 14:40:01.998078 | controller | skipping: Conditional result was False 2026-03-13 14:40:02.013720 | 2026-03-13 14:40:02.013907 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-13 14:40:02.492936 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.014083 2026-03-13 14:40:02.750115 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.013145 2026-03-13 14:40:02.780930 | 2026-03-13 14:40:02.781009 | PLAY [localhost] 2026-03-13 14:40:02.794017 | 2026-03-13 14:40:02.794080 | TASK [Run Zuul manifest role] 2026-03-13 14:40:02.813059 | localhost | ok 2026-03-13 14:40:02.825583 | 2026-03-13 14:40:02.825649 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-13 14:40:03.271294 | localhost | changed 2026-03-13 14:40:03.276056 | 2026-03-13 14:40:03.276120 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-13 14:40:03.316949 | localhost | ok 2026-03-13 14:40:03.367623 | 2026-03-13 14:40:03.367781 | TASK [Set zuul-log-path fact] 2026-03-13 14:40:03.390458 | localhost | ok 2026-03-13 14:40:03.408596 | 2026-03-13 14:40:03.408691 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-13 14:40:03.449939 | localhost | ok 2026-03-13 14:40:03.461252 | 2026-03-13 14:40:03.461340 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)] 2026-03-13 14:40:03.504692 | localhost | ok: 2026-03-13 14:40:03.505047 | localhost | { 2026-03-13 14:40:03.505108 | localhost | "auth": { 2026-03-13 14:40:03.505174 | localhost | "password": "IonWCwcuOFib&&<}wp^:[2G/", 2026-03-13 14:40:03.505229 | localhost | "username": "9LF91O0RK7JU" 2026-03-13 14:40:03.505269 | localhost | }, 2026-03-13 14:40:03.505305 | localhost | "profile": "rackspace", 2026-03-13 14:40:03.505340 | localhost | "region_name": "ORD" 2026-03-13 14:40:03.505374 | localhost | } 2026-03-13 14:40:03.505439 | localhost | changed: All items complete 2026-03-13 14:40:03.505485 | 2026-03-13 14:40:03.514218 | 2026-03-13 14:40:03.514352 | TASK [Run upload-logs-failover role (S3 then Swift)] 2026-03-13 14:40:03.534740 | localhost | Output suppressed because no_log was given 2026-03-13 14:40:03.552157 | 2026-03-13 14:40:03.552249 | TASK [upload-logs-failover : Initialize control vars] 2026-03-13 14:40:03.583126 | localhost | ok 2026-03-13 14:40:03.588845 | 2026-03-13 14:40:03.588926 | LOOP [upload-logs-failover : Perform log upload] 2026-03-13 14:40:03.624759 | localhost | Output suppressed because no_log was given 2026-03-13 14:40:03.633458 | localhost | included: /var/lib/zuul/builds/4881e7bd87a043f38d89b02eb667a4ef/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml 2026-03-13 14:40:03.642265 | 2026-03-13 14:40:03.642352 | LOOP [upload-logs-failover : Unpack vars for swift upload] 2026-03-13 14:40:03.729558 | localhost | Output suppressed because no_log was given 2026-03-13 14:40:03.742288 | 2026-03-13 14:40:03.742430 | TASK [Upload logs to swift] 2026-03-13 14:40:03.768999 | localhost | ok 2026-03-13 14:40:03.811475 | 2026-03-13 14:40:03.811567 | TASK [Set zuul-log-path fact] 2026-03-13 14:40:03.847121 | localhost | skipping: Conditional result was False 2026-03-13 14:40:03.857922 | 2026-03-13 14:40:03.858061 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2026-03-13 14:40:04.180524 | localhost -> localhost | ok: Runtime: 0:00:00.005459 2026-03-13 14:40:04.191722 | 2026-03-13 14:40:04.191909 | TASK [upload-logs-swift : Upload logs to swift]