2026-02-25 16:59:51.783599 | Job console starting... 2026-02-25 16:59:51.796473 | Updating repositories 2026-02-25 16:59:51.946936 | Preparing job workspace 2026-02-25 16:59:56.324063 | Running Ansible setup... 2026-02-25 17:00:01.139334 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-02-25 17:00:01.684743 | 2026-02-25 17:00:01.684858 | PLAY [localhost] 2026-02-25 17:00:01.692941 | 2026-02-25 17:00:01.693008 | TASK [Gathering Facts] 2026-02-25 17:00:02.759513 | localhost | ok 2026-02-25 17:00:02.796026 | 2026-02-25 17:00:02.796181 | TASK [Setup log path fact] 2026-02-25 17:00:02.816405 | localhost | ok 2026-02-25 17:00:02.832900 | 2026-02-25 17:00:02.832992 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-25 17:00:02.872796 | localhost | ok 2026-02-25 17:00:02.882853 | 2026-02-25 17:00:02.882945 | TASK [emit-job-header : Print job information] 2026-02-25 17:00:02.936177 | # Job Information 2026-02-25 17:00:02.936430 | Ansible Version: 2.15.12 2026-02-25 17:00:02.936496 | Job: ansible-test-sanity-okd-downstream-milestone 2026-02-25 17:00:02.936543 | Pipeline: third-party-check 2026-02-25 17:00:02.936585 | Executor: ze02.softwarefactory-project.io 2026-02-25 17:00:02.936625 | Triggered by: https://github.com/openshift/community.okd/pull/272 2026-02-25 17:00:02.936704 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/264/ansible/26453a617dd5429c96f3e784c47c2a25/ 2026-02-25 17:00:02.936759 | Event ID: 657357c0-1269-11f1-8d30-d43cda43898a 2026-02-25 17:00:02.944531 | 2026-02-25 17:00:02.944832 | LOOP [emit-job-header : Print node information] 2026-02-25 17:00:03.064075 | localhost | ok: 2026-02-25 17:00:03.064291 | localhost | # Node Information 2026-02-25 17:00:03.064324 | localhost | Inventory Hostname: controller 2026-02-25 17:00:03.064344 | localhost | Hostname: np0005629787 2026-02-25 17:00:03.064371 | localhost | Username: zuul 2026-02-25 17:00:03.064409 | localhost | Distro: Fedora 37 2026-02-25 17:00:03.064431 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2026-02-25 17:00:03.064453 | localhost | Region: ca-ymq-1 2026-02-25 17:00:03.064475 | localhost | Label: ansible-fedora-37-1vcpu 2026-02-25 17:00:03.064497 | localhost | Product Name: OpenStack Nova 2026-02-25 17:00:03.064518 | localhost | Interface IP: 199.204.45.144 2026-02-25 17:00:03.091316 | 2026-02-25 17:00:03.091483 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-25 17:00:03.556807 | localhost -> localhost | changed 2026-02-25 17:00:03.562235 | 2026-02-25 17:00:03.562313 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-25 17:00:04.449122 | localhost -> localhost | changed 2026-02-25 17:00:04.469227 | 2026-02-25 17:00:04.469283 | PLAY [all:!appliance*] 2026-02-25 17:00:04.485210 | 2026-02-25 17:00:04.485274 | TASK [include_role : start-zuul-console] 2026-02-25 17:00:04.505822 | controller | ok 2026-02-25 17:00:04.519494 | 2026-02-25 17:00:04.519559 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-02-25 17:00:04.921082 | controller | ok 2026-02-25 17:00:04.944587 | 2026-02-25 17:00:04.944784 | TASK [use-our-mirror : Retrieve the IP address] 2026-02-25 17:00:06.095278 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2026-02-25 17:00:06.109086 | 2026-02-25 17:00:06.109223 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2026-02-25 17:00:06.658072 | controller | skipping: Conditional result was False 2026-02-25 17:00:06.671481 | 2026-02-25 17:00:06.671655 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2026-02-25 17:00:06.700092 | controller | skipping: Conditional result was False 2026-02-25 17:00:06.713932 | 2026-02-25 17:00:06.714076 | TASK [use-our-mirror : Create the podman configuration directory] 2026-02-25 17:00:06.741019 | controller | skipping: Conditional result was False 2026-02-25 17:00:06.754530 | 2026-02-25 17:00:06.754702 | TASK [use-our-mirror : Copy the podman configuration] 2026-02-25 17:00:06.781767 | controller | skipping: Conditional result was False 2026-02-25 17:00:06.795606 | 2026-02-25 17:00:06.795818 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2026-02-25 17:00:06.822998 | controller | skipping: Conditional result was False 2026-02-25 17:00:06.838253 | 2026-02-25 17:00:06.838395 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2026-02-25 17:00:06.865448 | controller | skipping: Conditional result was False 2026-02-25 17:00:06.889395 | 2026-02-25 17:00:06.889553 | TASK [Disable Fedora Modular] 2026-02-25 17:00:07.153724 | controller | changed 2026-02-25 17:00:07.167057 | 2026-02-25 17:00:07.167193 | TASK [Enable EPEL] 2026-02-25 17:00:07.194295 | controller | skipping: Conditional result was False 2026-02-25 17:00:07.209154 | 2026-02-25 17:00:07.209299 | TASK [Register the RHEL node] 2026-02-25 17:00:07.773009 | 2026-02-25 17:00:07.773286 | TASK [Show the subscription-manager status] 2026-02-25 17:00:08.352744 | controller | skipping: Conditional result was False 2026-02-25 17:00:08.366725 | 2026-02-25 17:00:08.366871 | TASK [Enable EPEL on RHEL] 2026-02-25 17:00:08.921535 | controller | skipping: Conditional result was False 2026-02-25 17:00:08.936112 | 2026-02-25 17:00:08.936284 | TASK [Install git and tox] 2026-02-25 17:01:49.466912 | controller | changed 2026-02-25 17:01:49.479882 | 2026-02-25 17:01:49.480011 | TASK [include_role : prepare-workspace] 2026-02-25 17:01:49.507620 | controller | ok 2026-02-25 17:01:49.527237 | 2026-02-25 17:01:49.527302 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-02-25 17:01:49.754485 | controller | ok 2026-02-25 17:01:49.769008 | 2026-02-25 17:01:49.769137 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-02-25 17:02:01.525441 | controller | Output suppressed because no_log was given 2026-02-25 17:02:01.546976 | 2026-02-25 17:02:01.547111 | TASK [include_role : prepare-workspace-openshift] 2026-02-25 17:02:01.574608 | controller | skipping: Conditional result was False 2026-02-25 17:02:01.663499 | 2026-02-25 17:02:01.663705 | PLAY [all:!appliance] 2026-02-25 17:02:01.698026 | 2026-02-25 17:02:01.698107 | TASK [Run add-build-sshkey role (RSA)] 2026-02-25 17:02:01.734813 | controller | ok 2026-02-25 17:02:01.761647 | 2026-02-25 17:02:01.761759 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-25 17:02:02.093036 | controller -> localhost | ok 2026-02-25 17:02:02.106515 | 2026-02-25 17:02:02.106656 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-25 17:02:02.146111 | controller | ok 2026-02-25 17:02:02.175537 | controller | included: /var/lib/zuul/builds/26453a617dd5429c96f3e784c47c2a25/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-25 17:02:02.185245 | 2026-02-25 17:02:02.185329 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-25 17:02:02.792250 | controller -> localhost | Generating public/private rsa key pair. 2026-02-25 17:02:02.792896 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/26453a617dd5429c96f3e784c47c2a25/work/26453a617dd5429c96f3e784c47c2a25_id_rsa. 2026-02-25 17:02:02.792982 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/26453a617dd5429c96f3e784c47c2a25/work/26453a617dd5429c96f3e784c47c2a25_id_rsa.pub. 2026-02-25 17:02:02.793035 | controller -> localhost | The key fingerprint is: 2026-02-25 17:02:02.793081 | controller -> localhost | SHA256:YRFFCUwwnqHSWa/uwF/ae1ib4nniD/C1/wPgNoT9s88 zuul-build-sshkey 2026-02-25 17:02:02.793134 | controller -> localhost | The key's randomart image is: 2026-02-25 17:02:02.793195 | controller -> localhost | +---[RSA 2048]----+ 2026-02-25 17:02:02.793269 | controller -> localhost | | =+==o. | 2026-02-25 17:02:02.793345 | controller -> localhost | | . = =... | 2026-02-25 17:02:02.793417 | controller -> localhost | | . + o +o | 2026-02-25 17:02:02.793492 | controller -> localhost | | . o..+ | 2026-02-25 17:02:02.793731 | controller -> localhost | | o So.o | 2026-02-25 17:02:02.793833 | controller -> localhost | | . . o .=.+ | 2026-02-25 17:02:02.793896 | controller -> localhost | | o . ++.+ + | 2026-02-25 17:02:02.793945 | controller -> localhost | | + ++o=.... | 2026-02-25 17:02:02.793990 | controller -> localhost | | +o*B. .oE. | 2026-02-25 17:02:02.794041 | controller -> localhost | +----[SHA256]-----+ 2026-02-25 17:02:02.794150 | controller -> localhost | ok: Runtime: 0:00:00.178152 2026-02-25 17:02:02.809421 | 2026-02-25 17:02:02.809565 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-25 17:02:02.849132 | controller | ok 2026-02-25 17:02:02.869578 | controller | included: /var/lib/zuul/builds/26453a617dd5429c96f3e784c47c2a25/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-25 17:02:02.881602 | 2026-02-25 17:02:02.881705 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-25 17:02:02.907451 | controller | skipping: Conditional result was False 2026-02-25 17:02:02.922534 | 2026-02-25 17:02:02.922698 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-25 17:02:03.370435 | controller | changed 2026-02-25 17:02:03.383450 | 2026-02-25 17:02:03.383591 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-25 17:02:03.617455 | controller | ok 2026-02-25 17:02:03.630905 | 2026-02-25 17:02:03.631068 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-25 17:02:04.335176 | controller | changed 2026-02-25 17:02:04.348306 | 2026-02-25 17:02:04.348461 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-25 17:02:05.069938 | controller | changed 2026-02-25 17:02:05.082604 | 2026-02-25 17:02:05.082802 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-25 17:02:05.110923 | controller | skipping: Conditional result was False 2026-02-25 17:02:05.126193 | 2026-02-25 17:02:05.126335 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-25 17:02:05.581732 | controller -> localhost | changed 2026-02-25 17:02:05.597080 | 2026-02-25 17:02:05.597174 | TASK [add-build-sshkey : Add back temp key] 2026-02-25 17:02:05.890827 | controller -> localhost | Identity added: /var/lib/zuul/builds/26453a617dd5429c96f3e784c47c2a25/work/26453a617dd5429c96f3e784c47c2a25_id_rsa (zuul-build-sshkey) 2026-02-25 17:02:05.891226 | controller -> localhost | ok: Runtime: 0:00:00.008071 2026-02-25 17:02:05.904979 | 2026-02-25 17:02:05.905118 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-25 17:02:06.245884 | controller | ok 2026-02-25 17:02:06.253138 | 2026-02-25 17:02:06.253223 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-25 17:02:06.278633 | controller | skipping: Conditional result was False 2026-02-25 17:02:06.303748 | 2026-02-25 17:02:06.303917 | TASK [Run add-build-sshkey role (ECDSA)] 2026-02-25 17:02:06.327240 | controller | ok 2026-02-25 17:02:06.348831 | 2026-02-25 17:02:06.348940 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-25 17:02:06.578730 | controller -> localhost | ok 2026-02-25 17:02:06.585083 | 2026-02-25 17:02:06.585158 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-25 17:02:06.605336 | controller | ok 2026-02-25 17:02:06.615977 | controller | included: /var/lib/zuul/builds/26453a617dd5429c96f3e784c47c2a25/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-25 17:02:06.621816 | 2026-02-25 17:02:06.621878 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-25 17:02:06.911638 | controller -> localhost | Generating public/private ecdsa key pair. 2026-02-25 17:02:06.911954 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/26453a617dd5429c96f3e784c47c2a25/work/26453a617dd5429c96f3e784c47c2a25_id_ecdsa. 2026-02-25 17:02:06.912011 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/26453a617dd5429c96f3e784c47c2a25/work/26453a617dd5429c96f3e784c47c2a25_id_ecdsa.pub. 2026-02-25 17:02:06.912068 | controller -> localhost | The key fingerprint is: 2026-02-25 17:02:06.912113 | controller -> localhost | SHA256:5nIzxoBLGZ4/GiAoJKbRqvEbiDu/94QyThhXCWa895I zuul-build-sshkey 2026-02-25 17:02:06.912157 | controller -> localhost | The key's randomart image is: 2026-02-25 17:02:06.912200 | controller -> localhost | +---[ECDSA 521]---+ 2026-02-25 17:02:06.912242 | controller -> localhost | | .+ | 2026-02-25 17:02:06.912284 | controller -> localhost | | +.. . | 2026-02-25 17:02:06.912324 | controller -> localhost | |oo..+ | 2026-02-25 17:02:06.912365 | controller -> localhost | |*o.o.= | 2026-02-25 17:02:06.912407 | controller -> localhost | |O o.*o. S | 2026-02-25 17:02:06.912447 | controller -> localhost | |+O oE+.= | 2026-02-25 17:02:06.912488 | controller -> localhost | |= * +.= B | 2026-02-25 17:02:06.912529 | controller -> localhost | |.+ =.+ = o | 2026-02-25 17:02:06.912570 | controller -> localhost | |.o=o... | 2026-02-25 17:02:06.912611 | controller -> localhost | +----[SHA256]-----+ 2026-02-25 17:02:06.912835 | controller -> localhost | ok: Runtime: 0:00:00.013701 2026-02-25 17:02:06.927082 | 2026-02-25 17:02:06.927199 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-25 17:02:06.967388 | controller | ok 2026-02-25 17:02:06.981209 | controller | included: /var/lib/zuul/builds/26453a617dd5429c96f3e784c47c2a25/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-25 17:02:06.993515 | 2026-02-25 17:02:06.993597 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-25 17:02:07.009122 | controller | skipping: Conditional result was False 2026-02-25 17:02:07.018354 | 2026-02-25 17:02:07.018460 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-25 17:02:07.299357 | controller | changed 2026-02-25 17:02:07.313592 | 2026-02-25 17:02:07.313792 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-25 17:02:07.569014 | controller | ok 2026-02-25 17:02:07.581975 | 2026-02-25 17:02:07.582159 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-25 17:02:08.264347 | controller | changed 2026-02-25 17:02:08.277417 | 2026-02-25 17:02:08.277560 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-25 17:02:08.955882 | controller | changed 2026-02-25 17:02:08.968696 | 2026-02-25 17:02:08.968835 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-25 17:02:08.997632 | controller | skipping: Conditional result was False 2026-02-25 17:02:09.013393 | 2026-02-25 17:02:09.013553 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-25 17:02:09.304817 | controller -> localhost | changed 2026-02-25 17:02:09.316448 | 2026-02-25 17:02:09.316514 | TASK [add-build-sshkey : Add back temp key] 2026-02-25 17:02:09.752963 | controller -> localhost | Identity added: /var/lib/zuul/builds/26453a617dd5429c96f3e784c47c2a25/work/26453a617dd5429c96f3e784c47c2a25_id_ecdsa (zuul-build-sshkey) 2026-02-25 17:02:09.753365 | controller -> localhost | ok: Runtime: 0:00:00.013441 2026-02-25 17:02:09.803915 | 2026-02-25 17:02:09.804057 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-25 17:02:10.025843 | controller | ok 2026-02-25 17:02:10.037948 | 2026-02-25 17:02:10.038085 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-25 17:02:10.075936 | controller | skipping: Conditional result was False 2026-02-25 17:02:10.101018 | 2026-02-25 17:02:10.101157 | TASK [include_role : remove-zuul-sshkey] 2026-02-25 17:02:10.129094 | controller | skipping: Conditional result was False 2026-02-25 17:02:10.144249 | 2026-02-25 17:02:10.144391 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-02-25 17:02:10.416546 | controller | ok: "logs" 2026-02-25 17:02:10.417059 | controller | ok: All items complete 2026-02-25 17:02:10.417120 | 2026-02-25 17:02:10.620829 | controller | ok: "artifacts" 2026-02-25 17:02:10.823380 | controller | ok: "docs" 2026-02-25 17:02:10.839086 | 2026-02-25 17:02:10.839414 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-02-25 17:02:11.091292 | controller | changed: "logs" 2026-02-25 17:02:11.282368 | controller | changed: "artifacts" 2026-02-25 17:02:11.474325 | controller | changed: "docs" 2026-02-25 17:02:11.530431 | 2026-02-25 17:02:11.530568 | PLAY RECAP 2026-02-25 17:02:11.530629 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2026-02-25 17:02:11.530695 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-25 17:02:11.530730 | 2026-02-25 17:02:11.651388 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-02-25 17:02:11.653289 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-25 17:02:12.236181 | 2026-02-25 17:02:12.236291 | PLAY [all] 2026-02-25 17:02:12.257424 | 2026-02-25 17:02:12.257511 | TASK [Install binary dependencies] 2026-02-25 17:02:12.329860 | controller | ok 2026-02-25 17:02:12.357331 | 2026-02-25 17:02:12.357445 | TASK [bindep : Include find tasks] 2026-02-25 17:02:12.400345 | controller | ok 2026-02-25 17:02:12.413087 | controller | included: /var/lib/zuul/builds/26453a617dd5429c96f3e784c47c2a25/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-02-25 17:02:12.421863 | 2026-02-25 17:02:12.421948 | TASK [bindep : Look for bindep.txt] 2026-02-25 17:02:12.797436 | controller | ok 2026-02-25 17:02:12.809604 | 2026-02-25 17:02:12.809804 | TASK [bindep : Define bindep_file fact] 2026-02-25 17:02:12.837049 | controller | skipping: Conditional result was False 2026-02-25 17:02:12.849374 | 2026-02-25 17:02:12.849512 | TASK [bindep : Look for other-requirements.txt] 2026-02-25 17:02:13.089987 | controller | ok 2026-02-25 17:02:13.101479 | 2026-02-25 17:02:13.101614 | TASK [bindep : Define bindep_file fact] 2026-02-25 17:02:13.138336 | controller | skipping: Conditional result was False 2026-02-25 17:02:13.151091 | 2026-02-25 17:02:13.151227 | TASK [bindep : Look for bindep fallback file] 2026-02-25 17:02:13.189718 | controller | skipping: Conditional result was False 2026-02-25 17:02:13.204438 | 2026-02-25 17:02:13.204582 | TASK [bindep : Define bindep_file fact] 2026-02-25 17:02:13.241346 | controller | skipping: Conditional result was False 2026-02-25 17:02:13.257212 | 2026-02-25 17:02:13.257444 | TASK [bindep : Include bindep tasks] 2026-02-25 17:02:13.296122 | controller | skipping: Conditional result was False 2026-02-25 17:02:13.310206 | 2026-02-25 17:02:13.310344 | TASK [bindep : Include install tasks] 2026-02-25 17:02:13.348227 | controller | skipping: Conditional result was False 2026-02-25 17:02:13.362197 | 2026-02-25 17:02:13.362350 | LOOP [bindep : Include package tasks] 2026-02-25 17:02:13.444919 | 2026-02-25 17:02:13.445226 | TASK [Run test-setup role] 2026-02-25 17:02:13.476046 | controller | ok 2026-02-25 17:02:13.504251 | 2026-02-25 17:02:13.504341 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-02-25 17:02:13.733292 | controller | ok 2026-02-25 17:02:13.744170 | 2026-02-25 17:02:13.744272 | TASK [test-setup : Run tools/test-setup.sh] 2026-02-25 17:02:14.280001 | controller | skipping: Conditional result was False 2026-02-25 17:02:14.332782 | 2026-02-25 17:02:14.332922 | PLAY RECAP 2026-02-25 17:02:14.332982 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-25 17:02:14.333012 | 2026-02-25 17:02:14.430825 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-25 17:02:14.431656 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-02-25 17:02:14.995287 | 2026-02-25 17:02:14.995392 | PLAY [controller] 2026-02-25 17:02:15.014968 | 2026-02-25 17:02:15.015039 | TASK [Create the /root directory] 2026-02-25 17:02:15.412212 | controller | ok 2026-02-25 17:02:15.424626 | 2026-02-25 17:02:15.424801 | TASK [Install glibc-langpack-en] 2026-02-25 17:02:19.339190 | controller | ok: Nothing to do 2026-02-25 17:02:19.351561 | 2026-02-25 17:02:19.351723 | TASK [Ensure controller directory exists] 2026-02-25 17:02:19.573219 | controller | changed 2026-02-25 17:02:19.585566 | 2026-02-25 17:02:19.585725 | TASK [Install container runtime] 2026-02-25 17:02:19.654957 | controller | ok 2026-02-25 17:02:19.711462 | 2026-02-25 17:02:19.711556 | LOOP [ensure-podman : Find distribution installation] 2026-02-25 17:02:19.756039 | controller | ok: "/var/lib/zuul/builds/26453a617dd5429c96f3e784c47c2a25/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml" 2026-02-25 17:02:19.769504 | controller | included: /var/lib/zuul/builds/26453a617dd5429c96f3e784c47c2a25/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml 2026-02-25 17:02:19.778261 | 2026-02-25 17:02:19.778346 | TASK [ensure-podman : Install podman (RedHat)] 2026-02-25 17:03:31.311962 | controller | changed 2026-02-25 17:03:31.318615 | 2026-02-25 17:03:31.318702 | TASK [ensure-podman : Fetch podman version] 2026-02-25 17:03:31.963331 | controller | Client: Podman Engine 2026-02-25 17:03:31.991181 | controller | Version: 4.6.2 2026-02-25 17:03:31.991219 | controller | API Version: 4.6.2 2026-02-25 17:03:31.991225 | controller | Go Version: go1.19.12 2026-02-25 17:03:31.991240 | controller | Built: Mon Aug 28 19:38:31 2023 2026-02-25 17:03:31.991246 | controller | OS/Arch: linux/amd64 2026-02-25 17:03:32.373848 | controller | ok: Runtime: 0:00:00.282920 2026-02-25 17:03:32.388787 | 2026-02-25 17:03:32.388937 | TASK [ensure-podman : Print podman version installed] 2026-02-25 17:03:32.438802 | Podman version: Client: Podman Engine 2026-02-25 17:03:32.439052 | Version: 4.6.2 2026-02-25 17:03:32.439112 | API Version: 4.6.2 2026-02-25 17:03:32.439155 | Go Version: go1.19.12 2026-02-25 17:03:32.439195 | Built: Mon Aug 28 19:38:31 2023 2026-02-25 17:03:32.439234 | OS/Arch: linux/amd64 2026-02-25 17:03:32.453650 | 2026-02-25 17:03:32.453895 | TASK [ensure-podman : Validate podman engine] 2026-02-25 17:03:33.002173 | controller | skipping: Conditional result was False 2026-02-25 17:03:33.016282 | 2026-02-25 17:03:33.016417 | TASK [ensure-podman : Set up docker compatability socket] 2026-02-25 17:03:33.043262 | controller | skipping: Conditional result was False 2026-02-25 17:03:33.068067 | 2026-02-25 17:03:33.068238 | TASK [Ensure python3.8 is present] 2026-02-25 17:03:33.095918 | controller | skipping: Conditional result was False 2026-02-25 17:03:33.109753 | 2026-02-25 17:03:33.109891 | TASK [Run our-ensure-python role (Fedora only for now)] 2026-02-25 17:03:33.140088 | controller | ok 2026-02-25 17:03:33.178234 | 2026-02-25 17:03:33.178349 | TASK [our-ensure-python : Install the right Python version (rpm)] 2026-02-25 17:03:34.714486 | controller | ok: Nothing to do 2026-02-25 17:03:34.731117 | 2026-02-25 17:03:34.731297 | TASK [our-ensure-python : Also install python3-devel] 2026-02-25 17:03:45.948637 | controller | changed 2026-02-25 17:03:45.973201 | 2026-02-25 17:03:45.973346 | TASK [Run ensure-virtualenv role] 2026-02-25 17:03:46.004113 | controller | ok 2026-02-25 17:03:46.051336 | 2026-02-25 17:03:46.051518 | TASK [ensure-virtualenv : Check if virtualenv is installed] 2026-02-25 17:03:46.306876 | controller | /usr/bin/virtualenv 2026-02-25 17:03:46.601882 | controller | ok: Runtime: 0:00:00.007243 2026-02-25 17:03:46.614765 | 2026-02-25 17:03:46.614904 | LOOP [ensure-virtualenv : Install virtualenv package] 2026-02-25 17:03:46.653513 | controller | skipping: Conditional result was False 2026-02-25 17:03:46.654023 | controller | ok: All items complete 2026-02-25 17:03:46.654086 | 2026-02-25 17:03:46.746046 | 2026-02-25 17:03:46.746220 | TASK [Find the full path of the Python interpreter] 2026-02-25 17:03:46.996942 | controller | /usr/bin/python3 2026-02-25 17:03:47.288249 | controller | ok 2026-02-25 17:03:47.301253 | 2026-02-25 17:03:47.301383 | TASK [Create virtualenv for ansible-test with a specific interpreter] 2026-02-25 17:03:48.166999 | controller | created virtual environment CPython3.11.0.final.0-64 in 432ms 2026-02-25 17:03:48.188052 | controller | creator CPython3Posix(dest=/home/zuul/venv, clear=False, no_vcs_ignore=False, global=False) 2026-02-25 17:03:48.188094 | 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-02-25 17:03:48.188149 | controller | added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1 2026-02-25 17:03:48.188164 | controller | activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator 2026-02-25 17:03:48.361602 | controller | changed 2026-02-25 17:03:48.375039 | 2026-02-25 17:03:48.375170 | TASK [Set selinux package] 2026-02-25 17:03:48.413601 | controller | ok 2026-02-25 17:03:48.425242 | 2026-02-25 17:03:48.425371 | TASK [Set selinux package (Fedora)] 2026-02-25 17:03:48.474757 | controller | ok 2026-02-25 17:03:48.486710 | 2026-02-25 17:03:48.486856 | TASK [Install selinux into virtualenv] 2026-02-25 17:04:02.126727 | controller | Collecting selinux-please-lie-to-me 2026-02-25 17:04:15.409241 | controller | Downloading selinux_please_lie_to_me-1.0.1-py2.py3-none-any.whl (3.8 kB) 2026-02-25 17:04:15.714954 | controller | Collecting setuptools<50.0.0 2026-02-25 17:04:15.793504 | controller | Downloading setuptools-49.6.0-py3-none-any.whl (803 kB) 2026-02-25 17:04:15.830097 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 803.3/803.3 kB 25.0 MB/s eta 0:00:00 2026-02-25 17:04:15.912022 | controller | Installing collected packages: setuptools, selinux-please-lie-to-me 2026-02-25 17:04:15.912257 | controller | Attempting uninstall: setuptools 2026-02-25 17:04:15.914762 | controller | Found existing installation: setuptools 62.6.0 2026-02-25 17:04:15.973511 | controller | Uninstalling setuptools-62.6.0: 2026-02-25 17:04:15.983165 | controller | Successfully uninstalled setuptools-62.6.0 2026-02-25 17:04:16.333454 | controller | Successfully installed selinux-please-lie-to-me-1.0.1 setuptools-49.6.0 2026-02-25 17:04:27.976925 | controller | 2026-02-25 17:04:28.441586 | controller | [notice] A new release of pip available: 22.2.2 -> 26.0.1 2026-02-25 17:04:28.441641 | controller | [notice] To update, run: python -m pip install --upgrade pip 2026-02-25 17:04:28.923425 | controller | ok: Runtime: 0:00:39.728898 2026-02-25 17:04:28.935489 | 2026-02-25 17:04:28.935619 | TASK [Install pytest-forked into virtualenv] 2026-02-25 17:04:39.190146 | controller | Collecting pytest-forked 2026-02-25 17:04:51.507818 | controller | Downloading pytest_forked-1.6.0-py3-none-any.whl (4.9 kB) 2026-02-25 17:04:51.567458 | controller | Collecting py 2026-02-25 17:04:51.571146 | controller | Downloading py-1.11.0-py2.py3-none-any.whl (98 kB) 2026-02-25 17:04:51.591609 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.7/98.7 kB 5.7 MB/s eta 0:00:00 2026-02-25 17:04:51.698723 | controller | Collecting pytest>=3.10 2026-02-25 17:04:51.702448 | controller | Downloading pytest-9.0.2-py3-none-any.whl (374 kB) 2026-02-25 17:04:51.719616 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 374.8/374.8 kB 26.3 MB/s eta 0:00:00 2026-02-25 17:04:51.761310 | controller | Collecting iniconfig>=1.0.1 2026-02-25 17:04:51.765872 | controller | Downloading iniconfig-2.3.0-py3-none-any.whl (7.5 kB) 2026-02-25 17:04:51.815939 | controller | Collecting packaging>=22 2026-02-25 17:04:51.819529 | controller | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-02-25 17:04:51.826078 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 18.7 MB/s eta 0:00:00 2026-02-25 17:04:51.857865 | controller | Collecting pluggy<2,>=1.5 2026-02-25 17:04:51.861079 | controller | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-02-25 17:04:51.911180 | controller | Collecting pygments>=2.7.2 2026-02-25 17:04:51.915403 | controller | Downloading pygments-2.19.2-py3-none-any.whl (1.2 MB) 2026-02-25 17:04:51.949624 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.2/1.2 MB 40.4 MB/s eta 0:00:00 2026-02-25 17:04:52.018366 | controller | Installing collected packages: pygments, py, pluggy, packaging, iniconfig, pytest, pytest-forked 2026-02-25 17:04:53.143947 | 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-02-25 17:04:53.154170 | controller | 2026-02-25 17:04:53.228455 | controller | [notice] A new release of pip available: 22.2.2 -> 26.0.1 2026-02-25 17:04:53.228655 | controller | [notice] To update, run: python -m pip install --upgrade pip 2026-02-25 17:04:53.499701 | controller | ok: Runtime: 0:00:24.053217 2026-02-25 17:04:53.512370 | 2026-02-25 17:04:53.512535 | TASK [Update pip] 2026-02-25 17:04:54.076147 | controller | Requirement already satisfied: pip in ./venv/lib/python3.11/site-packages (22.2.2) 2026-02-25 17:05:03.904376 | controller | Collecting pip 2026-02-25 17:05:17.295307 | controller | Downloading pip-26.0.1-py3-none-any.whl (1.8 MB) 2026-02-25 17:05:17.364094 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.8/1.8 MB 28.5 MB/s eta 0:00:00 2026-02-25 17:05:17.430170 | controller | Installing collected packages: pip 2026-02-25 17:05:17.430390 | controller | Attempting uninstall: pip 2026-02-25 17:05:17.432587 | controller | Found existing installation: pip 22.2.2 2026-02-25 17:05:17.572459 | controller | Uninstalling pip-22.2.2: 2026-02-25 17:05:17.587969 | controller | Successfully uninstalled pip-22.2.2 2026-02-25 17:05:18.421760 | controller | Successfully installed pip-26.0.1 2026-02-25 17:05:18.584091 | controller | ok: Runtime: 0:00:24.753260 2026-02-25 17:05:18.589983 | 2026-02-25 17:05:18.590044 | TASK [Ensure pip temp directory exists in /var/tmp] 2026-02-25 17:05:18.813025 | controller | changed 2026-02-25 17:05:18.819856 | 2026-02-25 17:05:18.819927 | TASK [Install ansible into virtualenv] 2026-02-25 17:05:19.386062 | controller | Processing ./src/github.com/ansible/ansible 2026-02-25 17:05:19.388586 | controller | Installing build dependencies: started 2026-02-25 17:05:44.720423 | controller | Installing build dependencies: finished with status 'done' 2026-02-25 17:05:44.722643 | controller | Getting requirements to build wheel: started 2026-02-25 17:05:45.495633 | controller | Getting requirements to build wheel: finished with status 'done' 2026-02-25 17:05:45.497308 | controller | Preparing metadata (pyproject.toml): started 2026-02-25 17:05:46.022367 | controller | Preparing metadata (pyproject.toml): finished with status 'done' 2026-02-25 17:05:46.029950 | 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-02-25 17:05:46.033152 | controller | ERROR: Package 'ansible-core' requires a different Python: 3.11.0 not in '>=3.12' 2026-02-25 17:05:46.430183 | controller | ERROR 2026-02-25 17:05:46.430561 | controller | { 2026-02-25 17:05:46.430629 | controller | "delta": "0:00:27.014285", 2026-02-25 17:05:46.430716 | controller | "end": "2026-02-25 17:05:46.113891", 2026-02-25 17:05:46.430760 | controller | "msg": "non-zero return code", 2026-02-25 17:05:46.430815 | controller | "rc": 1, 2026-02-25 17:05:46.430853 | controller | "start": "2026-02-25 17:05:19.099606" 2026-02-25 17:05:46.430888 | controller | } failure 2026-02-25 17:05:46.434223 | 2026-02-25 17:05:46.434329 | PLAY RECAP 2026-02-25 17:05:46.434431 | controller | ok: 18 changed: 10 unreachable: 0 failed: 1 skipped: 4 rescued: 0 ignored: 0 2026-02-25 17:05:46.434478 | 2026-02-25 17:05:46.576922 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-02-25 17:05:46.577972 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-25 17:05:47.222625 | 2026-02-25 17:05:47.222815 | PLAY [all] 2026-02-25 17:05:47.254250 | 2026-02-25 17:05:47.254494 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-02-25 17:05:47.537361 | controller | changed: non-zero return code 2026-02-25 17:05:47.550879 | 2026-02-25 17:05:47.551044 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-02-25 17:05:47.580319 | controller | skipping: Conditional result was False 2026-02-25 17:05:47.594265 | 2026-02-25 17:05:47.594414 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-02-25 17:05:47.629059 | 2026-02-25 17:05:47.629322 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-02-25 17:05:47.662073 | 2026-02-25 17:05:47.662334 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-02-25 17:05:47.680405 | controller | skipping: Conditional result was False 2026-02-25 17:05:47.692311 | 2026-02-25 17:05:47.692418 | LOOP [fetch-subunit-output : Generate subunit file] 2026-02-25 17:05:47.718424 | 2026-02-25 17:05:47.718605 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-02-25 17:05:47.735359 | controller | skipping: Conditional result was False 2026-02-25 17:05:47.744969 | 2026-02-25 17:05:47.745082 | TASK [fetch-subunit-output : Remove the temporary file] 2026-02-25 17:05:47.761876 | controller | skipping: Conditional result was False 2026-02-25 17:05:47.771321 | 2026-02-25 17:05:47.771412 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-02-25 17:05:47.788222 | controller | skipping: Conditional result was False 2026-02-25 17:05:47.825762 | 2026-02-25 17:05:47.825834 | PLAY RECAP 2026-02-25 17:05:47.825884 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-25 17:05:47.825903 | 2026-02-25 17:05:47.974891 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-25 17:05:47.976141 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2026-02-25 17:05:48.556409 | 2026-02-25 17:05:48.556533 | PLAY [all:!appliance*] 2026-02-25 17:05:48.578068 | 2026-02-25 17:05:48.578144 | TASK [unregister the node] 2026-02-25 17:05:49.110814 | controller | skipping: Conditional result was False 2026-02-25 17:05:49.123702 | 2026-02-25 17:05:49.123870 | TASK [include_role : fetch-output] 2026-02-25 17:05:49.178347 | controller | ok 2026-02-25 17:05:49.224087 | 2026-02-25 17:05:49.224203 | TASK [fetch-output : Set log path for multiple nodes] 2026-02-25 17:05:49.301924 | controller | skipping: Conditional result was False 2026-02-25 17:05:49.310969 | 2026-02-25 17:05:49.311062 | TASK [fetch-output : Set log path for single node] 2026-02-25 17:05:49.374726 | controller | ok 2026-02-25 17:05:49.382307 | 2026-02-25 17:05:49.382395 | LOOP [fetch-output : Ensure local output dirs] 2026-02-25 17:05:49.808589 | controller -> localhost | ok: "/var/lib/zuul/builds/26453a617dd5429c96f3e784c47c2a25/work/logs" 2026-02-25 17:05:50.058716 | controller -> localhost | changed: "/var/lib/zuul/builds/26453a617dd5429c96f3e784c47c2a25/work/artifacts" 2026-02-25 17:05:50.309049 | controller -> localhost | changed: "/var/lib/zuul/builds/26453a617dd5429c96f3e784c47c2a25/work/docs" 2026-02-25 17:05:50.338996 | 2026-02-25 17:05:50.339144 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-25 17:05:51.096379 | controller | changed: 2026-02-25 17:05:51.096853 | controller | .d..t...... ./ 2026-02-25 17:05:51.096917 | controller | cd+++++++++ controller/ 2026-02-25 17:05:51.096984 | controller | changed: All items complete 2026-02-25 17:05:51.097053 | 2026-02-25 17:05:51.638641 | controller | changed: .d..t...... ./ 2026-02-25 17:05:52.184219 | controller | changed: .d..t...... ./ 2026-02-25 17:05:52.220993 | 2026-02-25 17:05:52.221176 | TASK [include_role : fetch-output-openshift] 2026-02-25 17:05:52.247489 | controller | skipping: Conditional result was False 2026-02-25 17:05:52.261469 | 2026-02-25 17:05:52.261606 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-02-25 17:05:52.784044 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.014029 2026-02-25 17:05:53.060129 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.016225 2026-02-25 17:05:53.092245 | 2026-02-25 17:05:53.092412 | PLAY [localhost] 2026-02-25 17:05:53.106141 | 2026-02-25 17:05:53.106213 | TASK [Run Zuul manifest role] 2026-02-25 17:05:53.128000 | localhost | ok 2026-02-25 17:05:53.143074 | 2026-02-25 17:05:53.143144 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-25 17:05:53.631320 | localhost | changed 2026-02-25 17:05:53.643052 | 2026-02-25 17:05:53.643186 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-25 17:05:53.690227 | localhost | ok 2026-02-25 17:05:53.709854 | 2026-02-25 17:05:53.709996 | TASK [Set zuul-log-path fact] 2026-02-25 17:05:53.732586 | localhost | ok 2026-02-25 17:05:53.750842 | 2026-02-25 17:05:53.750924 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-25 17:05:53.798355 | localhost | ok 2026-02-25 17:05:53.817875 | 2026-02-25 17:05:53.818005 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)] 2026-02-25 17:05:53.864526 | localhost | ok: 2026-02-25 17:05:53.864944 | localhost | { 2026-02-25 17:05:53.864992 | localhost | "auth": { 2026-02-25 17:05:53.865035 | localhost | "password": "IonWCwcuOFib&&<}wp^:[2G/", 2026-02-25 17:05:53.865069 | localhost | "username": "9LF91O0RK7JU" 2026-02-25 17:05:53.865101 | localhost | }, 2026-02-25 17:05:53.865130 | localhost | "profile": "rackspace", 2026-02-25 17:05:53.865158 | localhost | "project_name": "1251317", 2026-02-25 17:05:53.865187 | localhost | "region_name": "DFW" 2026-02-25 17:05:53.865215 | localhost | } 2026-02-25 17:05:53.865327 | localhost | changed: All items complete 2026-02-25 17:05:53.865370 | 2026-02-25 17:05:53.874092 | 2026-02-25 17:05:53.874174 | TASK [Run upload-logs-failover role (S3 then Swift)] 2026-02-25 17:05:53.896045 | localhost | Output suppressed because no_log was given 2026-02-25 17:05:53.949410 | 2026-02-25 17:05:53.949585 | TASK [upload-logs-failover : Initialize control vars] 2026-02-25 17:05:53.979145 | localhost | ok 2026-02-25 17:05:53.983398 | 2026-02-25 17:05:53.983458 | LOOP [upload-logs-failover : Perform log upload] 2026-02-25 17:05:54.012976 | localhost | Output suppressed because no_log was given 2026-02-25 17:05:54.019749 | localhost | included: /var/lib/zuul/builds/26453a617dd5429c96f3e784c47c2a25/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml 2026-02-25 17:05:54.026334 | 2026-02-25 17:05:54.026400 | LOOP [upload-logs-failover : Unpack vars for swift upload] 2026-02-25 17:05:54.113168 | localhost | Output suppressed because no_log was given 2026-02-25 17:05:54.121287 | 2026-02-25 17:05:54.121435 | TASK [Upload logs to swift] 2026-02-25 17:05:54.156003 | localhost | ok 2026-02-25 17:05:54.205591 | 2026-02-25 17:05:54.206234 | TASK [Set zuul-log-path fact] 2026-02-25 17:05:54.251413 | localhost | skipping: Conditional result was False 2026-02-25 17:05:54.258039 | 2026-02-25 17:05:54.258124 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2026-02-25 17:05:54.598529 | localhost -> localhost | ok: Runtime: 0:00:00.009479 2026-02-25 17:05:54.610528 | 2026-02-25 17:05:54.610656 | TASK [upload-logs-swift : Upload logs to swift]