2026-02-25 16:52:27.431935 | Job console starting... 2026-02-25 16:52:27.446734 | Updating repositories 2026-02-25 16:52:27.655932 | Preparing job workspace 2026-02-25 16:52:32.181154 | Running Ansible setup... 2026-02-25 16:52:40.279550 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-02-25 16:52:40.880083 | 2026-02-25 16:52:40.880227 | PLAY [localhost] 2026-02-25 16:52:40.889343 | 2026-02-25 16:52:40.889412 | TASK [Gathering Facts] 2026-02-25 16:52:41.928628 | localhost | ok 2026-02-25 16:52:41.943664 | 2026-02-25 16:52:41.943911 | TASK [Setup log path fact] 2026-02-25 16:52:41.967637 | localhost | ok 2026-02-25 16:52:41.979976 | 2026-02-25 16:52:41.980044 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-25 16:52:42.006898 | localhost | ok 2026-02-25 16:52:42.014608 | 2026-02-25 16:52:42.014672 | TASK [emit-job-header : Print job information] 2026-02-25 16:52:42.042370 | # Job Information 2026-02-25 16:52:42.042487 | Ansible Version: 2.15.12 2026-02-25 16:52:42.042517 | Job: ansible-test-sanity-docker-devel 2026-02-25 16:52:42.042538 | Pipeline: third-party-check 2026-02-25 16:52:42.042556 | Executor: ze04.softwarefactory-project.io 2026-02-25 16:52:42.042574 | Triggered by: https://github.com/openshift/community.okd/pull/272 2026-02-25 16:52:42.042595 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/607/ansible/6070d8c6e22e4993a368bb777295138c/ 2026-02-25 16:52:42.042614 | Event ID: 657357c0-1269-11f1-8d30-d43cda43898a 2026-02-25 16:52:42.046791 | 2026-02-25 16:52:42.046860 | LOOP [emit-job-header : Print node information] 2026-02-25 16:52:42.141856 | localhost | ok: 2026-02-25 16:52:42.142128 | localhost | # Node Information 2026-02-25 16:52:42.142159 | localhost | Inventory Hostname: controller 2026-02-25 16:52:42.142179 | localhost | Hostname: np0005629765 2026-02-25 16:52:42.142197 | localhost | Username: zuul 2026-02-25 16:52:42.142217 | localhost | Distro: Fedora 37 2026-02-25 16:52:42.142234 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2026-02-25 16:52:42.142251 | localhost | Region: ca-ymq-1 2026-02-25 16:52:42.142267 | localhost | Label: ansible-fedora-37-1vcpu 2026-02-25 16:52:42.142283 | localhost | Product Name: OpenStack Nova 2026-02-25 16:52:42.142299 | localhost | Interface IP: 199.19.213.138 2026-02-25 16:52:42.159771 | 2026-02-25 16:52:42.159842 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-25 16:52:42.529841 | localhost -> localhost | changed 2026-02-25 16:52:42.535435 | 2026-02-25 16:52:42.535515 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-25 16:52:43.376161 | localhost -> localhost | changed 2026-02-25 16:52:43.395351 | 2026-02-25 16:52:43.395406 | PLAY [all:!appliance*] 2026-02-25 16:52:43.411286 | 2026-02-25 16:52:43.411348 | TASK [include_role : start-zuul-console] 2026-02-25 16:52:43.431818 | controller | ok 2026-02-25 16:52:43.444533 | 2026-02-25 16:52:43.444599 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-02-25 16:52:43.880196 | controller | ok 2026-02-25 16:52:43.917286 | 2026-02-25 16:52:43.917450 | TASK [use-our-mirror : Retrieve the IP address] 2026-02-25 16:52:44.789838 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2026-02-25 16:52:44.798860 | 2026-02-25 16:52:44.798961 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2026-02-25 16:52:45.335440 | controller | skipping: Conditional result was False 2026-02-25 16:52:45.343251 | 2026-02-25 16:52:45.343456 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2026-02-25 16:52:45.378736 | controller | skipping: Conditional result was False 2026-02-25 16:52:45.385358 | 2026-02-25 16:52:45.385435 | TASK [use-our-mirror : Create the podman configuration directory] 2026-02-25 16:52:45.423006 | controller | skipping: Conditional result was False 2026-02-25 16:52:45.429882 | 2026-02-25 16:52:45.429984 | TASK [use-our-mirror : Copy the podman configuration] 2026-02-25 16:52:45.458434 | controller | skipping: Conditional result was False 2026-02-25 16:52:45.464993 | 2026-02-25 16:52:45.465073 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2026-02-25 16:52:45.479853 | controller | skipping: Conditional result was False 2026-02-25 16:52:45.488705 | 2026-02-25 16:52:45.488831 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2026-02-25 16:52:45.503868 | controller | skipping: Conditional result was False 2026-02-25 16:52:45.515786 | 2026-02-25 16:52:45.515878 | TASK [Disable Fedora Modular] 2026-02-25 16:52:45.795724 | controller | changed 2026-02-25 16:52:45.808159 | 2026-02-25 16:52:45.808289 | TASK [Enable EPEL] 2026-02-25 16:52:45.836296 | controller | skipping: Conditional result was False 2026-02-25 16:52:45.851100 | 2026-02-25 16:52:45.851236 | TASK [Register the RHEL node] 2026-02-25 16:52:46.414960 | 2026-02-25 16:52:46.415251 | TASK [Show the subscription-manager status] 2026-02-25 16:52:47.010211 | controller | skipping: Conditional result was False 2026-02-25 16:52:47.017218 | 2026-02-25 16:52:47.017286 | TASK [Enable EPEL on RHEL] 2026-02-25 16:52:47.581348 | controller | skipping: Conditional result was False 2026-02-25 16:52:47.595003 | 2026-02-25 16:52:47.595147 | TASK [Install git and tox] 2026-02-25 16:54:19.798157 | controller | changed 2026-02-25 16:54:19.812869 | 2026-02-25 16:54:19.813003 | TASK [include_role : prepare-workspace] 2026-02-25 16:54:19.864398 | controller | ok 2026-02-25 16:54:19.902406 | 2026-02-25 16:54:19.902501 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-02-25 16:54:20.177586 | controller | ok 2026-02-25 16:54:20.198810 | 2026-02-25 16:54:20.198968 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-02-25 16:54:33.459370 | controller | Output suppressed because no_log was given 2026-02-25 16:54:33.475642 | 2026-02-25 16:54:33.475758 | TASK [include_role : prepare-workspace-openshift] 2026-02-25 16:54:33.507413 | controller | skipping: Conditional result was False 2026-02-25 16:54:33.578389 | 2026-02-25 16:54:33.578485 | PLAY [all:!appliance] 2026-02-25 16:54:33.594437 | 2026-02-25 16:54:33.594505 | TASK [Run add-build-sshkey role (RSA)] 2026-02-25 16:54:33.625634 | controller | ok 2026-02-25 16:54:33.641983 | 2026-02-25 16:54:33.642054 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-25 16:54:33.914131 | controller -> localhost | ok 2026-02-25 16:54:33.928537 | 2026-02-25 16:54:33.928734 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-25 16:54:33.952881 | controller | ok 2026-02-25 16:54:33.973511 | controller | included: /var/lib/zuul/builds/6070d8c6e22e4993a368bb777295138c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-25 16:54:33.981635 | 2026-02-25 16:54:33.981747 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-25 16:54:34.545307 | controller -> localhost | Generating public/private rsa key pair. 2026-02-25 16:54:34.545555 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/6070d8c6e22e4993a368bb777295138c/work/6070d8c6e22e4993a368bb777295138c_id_rsa. 2026-02-25 16:54:34.545585 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/6070d8c6e22e4993a368bb777295138c/work/6070d8c6e22e4993a368bb777295138c_id_rsa.pub. 2026-02-25 16:54:34.545606 | controller -> localhost | The key fingerprint is: 2026-02-25 16:54:34.545626 | controller -> localhost | SHA256:tZs2tFM3oA7+T1picVo74Rc4xOXKBbRaiYL+j3hyX2k zuul-build-sshkey 2026-02-25 16:54:34.545645 | controller -> localhost | The key's randomart image is: 2026-02-25 16:54:34.545665 | controller -> localhost | +---[RSA 2048]----+ 2026-02-25 16:54:34.545713 | controller -> localhost | | .o . | 2026-02-25 16:54:34.545736 | controller -> localhost | | . o * | 2026-02-25 16:54:34.545755 | controller -> localhost | | . . o B o | 2026-02-25 16:54:34.545773 | controller -> localhost | | . o B = | 2026-02-25 16:54:34.545791 | controller -> localhost | | . S * X + | 2026-02-25 16:54:34.545819 | controller -> localhost | | o + @ * o | 2026-02-25 16:54:34.545842 | controller -> localhost | | o % E . | 2026-02-25 16:54:34.545863 | controller -> localhost | | ..o* X o | 2026-02-25 16:54:34.545882 | controller -> localhost | | .+..=.. | 2026-02-25 16:54:34.545902 | controller -> localhost | +----[SHA256]-----+ 2026-02-25 16:54:34.545956 | controller -> localhost | ok: Runtime: 0:00:00.168460 2026-02-25 16:54:34.552778 | 2026-02-25 16:54:34.552842 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-25 16:54:34.585158 | controller | ok 2026-02-25 16:54:34.596216 | controller | included: /var/lib/zuul/builds/6070d8c6e22e4993a368bb777295138c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-25 16:54:34.608459 | 2026-02-25 16:54:34.608532 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-25 16:54:34.634074 | controller | skipping: Conditional result was False 2026-02-25 16:54:34.640381 | 2026-02-25 16:54:34.640444 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-25 16:54:35.156760 | controller | changed 2026-02-25 16:54:35.163867 | 2026-02-25 16:54:35.163959 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-25 16:54:35.398716 | controller | ok 2026-02-25 16:54:35.408959 | 2026-02-25 16:54:35.409108 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-25 16:54:36.078126 | controller | changed 2026-02-25 16:54:36.097239 | 2026-02-25 16:54:36.097360 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-25 16:54:36.752860 | controller | changed 2026-02-25 16:54:36.760716 | 2026-02-25 16:54:36.760788 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-25 16:54:36.787009 | controller | skipping: Conditional result was False 2026-02-25 16:54:36.798976 | 2026-02-25 16:54:36.799083 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-25 16:54:37.200219 | controller -> localhost | changed 2026-02-25 16:54:37.217419 | 2026-02-25 16:54:37.217521 | TASK [add-build-sshkey : Add back temp key] 2026-02-25 16:54:37.507800 | controller -> localhost | Identity added: /var/lib/zuul/builds/6070d8c6e22e4993a368bb777295138c/work/6070d8c6e22e4993a368bb777295138c_id_rsa (zuul-build-sshkey) 2026-02-25 16:54:37.508136 | controller -> localhost | ok: Runtime: 0:00:00.008485 2026-02-25 16:54:37.516858 | 2026-02-25 16:54:37.516947 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-25 16:54:37.888308 | controller | ok 2026-02-25 16:54:37.900872 | 2026-02-25 16:54:37.901014 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-25 16:54:37.946577 | controller | skipping: Conditional result was False 2026-02-25 16:54:37.970133 | 2026-02-25 16:54:37.970298 | TASK [Run add-build-sshkey role (ECDSA)] 2026-02-25 16:54:38.017413 | controller | ok 2026-02-25 16:54:38.037549 | 2026-02-25 16:54:38.037710 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-25 16:54:38.278142 | controller -> localhost | ok 2026-02-25 16:54:38.291984 | 2026-02-25 16:54:38.292117 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-25 16:54:38.321470 | controller | ok 2026-02-25 16:54:38.341784 | controller | included: /var/lib/zuul/builds/6070d8c6e22e4993a368bb777295138c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-25 16:54:38.352222 | 2026-02-25 16:54:38.352316 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-25 16:54:38.678060 | controller -> localhost | Generating public/private ecdsa key pair. 2026-02-25 16:54:38.678451 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/6070d8c6e22e4993a368bb777295138c/work/6070d8c6e22e4993a368bb777295138c_id_ecdsa. 2026-02-25 16:54:38.678513 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/6070d8c6e22e4993a368bb777295138c/work/6070d8c6e22e4993a368bb777295138c_id_ecdsa.pub. 2026-02-25 16:54:38.678577 | controller -> localhost | The key fingerprint is: 2026-02-25 16:54:38.678621 | controller -> localhost | SHA256:6X6nmm4taCeS1WokSwz6yD3uOpkpIsl+zTBUAPtSYVQ zuul-build-sshkey 2026-02-25 16:54:38.678662 | controller -> localhost | The key's randomart image is: 2026-02-25 16:54:38.678749 | controller -> localhost | +---[ECDSA 521]---+ 2026-02-25 16:54:38.678792 | controller -> localhost | | .o=oE | 2026-02-25 16:54:38.678830 | controller -> localhost | | o .. | 2026-02-25 16:54:38.678868 | controller -> localhost | | . .. | 2026-02-25 16:54:38.678906 | controller -> localhost | | +. . | 2026-02-25 16:54:38.678943 | controller -> localhost | | o.+ .S | 2026-02-25 16:54:38.678981 | controller -> localhost | |. .o+ o.. | 2026-02-25 16:54:38.679017 | controller -> localhost | |o+=.=* o.. | 2026-02-25 16:54:38.679054 | controller -> localhost | |*B.++o*.+.o . | 2026-02-25 16:54:38.679091 | controller -> localhost | |=o*o.+ ==+.o | 2026-02-25 16:54:38.679128 | controller -> localhost | +----[SHA256]-----+ 2026-02-25 16:54:38.679282 | controller -> localhost | ok: Runtime: 0:00:00.017748 2026-02-25 16:54:38.697490 | 2026-02-25 16:54:38.697632 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-25 16:54:38.739461 | controller | ok 2026-02-25 16:54:38.755056 | controller | included: /var/lib/zuul/builds/6070d8c6e22e4993a368bb777295138c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-25 16:54:38.767328 | 2026-02-25 16:54:38.767428 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-25 16:54:38.792815 | controller | skipping: Conditional result was False 2026-02-25 16:54:38.801638 | 2026-02-25 16:54:38.801757 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-25 16:54:39.096337 | controller | changed 2026-02-25 16:54:39.109097 | 2026-02-25 16:54:39.109239 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-25 16:54:39.337135 | controller | ok 2026-02-25 16:54:39.343109 | 2026-02-25 16:54:39.343177 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-25 16:54:40.006845 | controller | changed 2026-02-25 16:54:40.014762 | 2026-02-25 16:54:40.014832 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-25 16:54:40.663800 | controller | changed 2026-02-25 16:54:40.693591 | 2026-02-25 16:54:40.693758 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-25 16:54:40.730139 | controller | skipping: Conditional result was False 2026-02-25 16:54:40.739443 | 2026-02-25 16:54:40.739542 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-25 16:54:41.039882 | controller -> localhost | changed 2026-02-25 16:54:41.146799 | 2026-02-25 16:54:41.146999 | TASK [add-build-sshkey : Add back temp key] 2026-02-25 16:54:41.469707 | controller -> localhost | Identity added: /var/lib/zuul/builds/6070d8c6e22e4993a368bb777295138c/work/6070d8c6e22e4993a368bb777295138c_id_ecdsa (zuul-build-sshkey) 2026-02-25 16:54:41.469950 | controller -> localhost | ok: Runtime: 0:00:00.010004 2026-02-25 16:54:41.476978 | 2026-02-25 16:54:41.477046 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-25 16:54:41.721031 | controller | ok 2026-02-25 16:54:41.727558 | 2026-02-25 16:54:41.727632 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-25 16:54:41.751940 | controller | skipping: Conditional result was False 2026-02-25 16:54:41.767051 | 2026-02-25 16:54:41.767217 | TASK [include_role : remove-zuul-sshkey] 2026-02-25 16:54:41.804395 | controller | skipping: Conditional result was False 2026-02-25 16:54:41.827475 | 2026-02-25 16:54:41.827618 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-02-25 16:54:42.150843 | controller | ok: "logs" 2026-02-25 16:54:42.151133 | controller | ok: All items complete 2026-02-25 16:54:42.151166 | 2026-02-25 16:54:42.376402 | controller | ok: "artifacts" 2026-02-25 16:54:42.571354 | controller | ok: "docs" 2026-02-25 16:54:42.580624 | 2026-02-25 16:54:42.580793 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-02-25 16:54:42.864489 | controller | changed: "logs" 2026-02-25 16:54:43.101198 | controller | changed: "artifacts" 2026-02-25 16:54:43.323591 | controller | changed: "docs" 2026-02-25 16:54:43.375504 | 2026-02-25 16:54:43.375665 | PLAY RECAP 2026-02-25 16:54:43.375773 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2026-02-25 16:54:43.375815 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-25 16:54:43.375842 | 2026-02-25 16:54:43.514844 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-02-25 16:54:43.516090 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-25 16:54:44.092665 | 2026-02-25 16:54:44.092806 | PLAY [all] 2026-02-25 16:54:44.116087 | 2026-02-25 16:54:44.116206 | TASK [Install binary dependencies] 2026-02-25 16:54:44.180580 | controller | ok 2026-02-25 16:54:44.209630 | 2026-02-25 16:54:44.209766 | TASK [bindep : Include find tasks] 2026-02-25 16:54:44.244371 | controller | ok 2026-02-25 16:54:44.255786 | controller | included: /var/lib/zuul/builds/6070d8c6e22e4993a368bb777295138c/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-02-25 16:54:44.264538 | 2026-02-25 16:54:44.264625 | TASK [bindep : Look for bindep.txt] 2026-02-25 16:54:44.640490 | controller | ok 2026-02-25 16:54:44.654216 | 2026-02-25 16:54:44.654393 | TASK [bindep : Define bindep_file fact] 2026-02-25 16:54:44.684373 | controller | skipping: Conditional result was False 2026-02-25 16:54:44.698227 | 2026-02-25 16:54:44.698398 | TASK [bindep : Look for other-requirements.txt] 2026-02-25 16:54:44.937688 | controller | ok 2026-02-25 16:54:44.943334 | 2026-02-25 16:54:44.943406 | TASK [bindep : Define bindep_file fact] 2026-02-25 16:54:44.977418 | controller | skipping: Conditional result was False 2026-02-25 16:54:44.984199 | 2026-02-25 16:54:44.984295 | TASK [bindep : Look for bindep fallback file] 2026-02-25 16:54:45.018022 | controller | skipping: Conditional result was False 2026-02-25 16:54:45.025845 | 2026-02-25 16:54:45.025952 | TASK [bindep : Define bindep_file fact] 2026-02-25 16:54:45.049754 | controller | skipping: Conditional result was False 2026-02-25 16:54:45.056113 | 2026-02-25 16:54:45.056182 | TASK [bindep : Include bindep tasks] 2026-02-25 16:54:45.079626 | controller | skipping: Conditional result was False 2026-02-25 16:54:45.086187 | 2026-02-25 16:54:45.086276 | TASK [bindep : Include install tasks] 2026-02-25 16:54:45.109761 | controller | skipping: Conditional result was False 2026-02-25 16:54:45.116291 | 2026-02-25 16:54:45.116380 | LOOP [bindep : Include package tasks] 2026-02-25 16:54:45.172167 | 2026-02-25 16:54:45.172410 | TASK [Run test-setup role] 2026-02-25 16:54:45.196719 | controller | ok 2026-02-25 16:54:45.214228 | 2026-02-25 16:54:45.214331 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-02-25 16:54:45.437418 | controller | ok 2026-02-25 16:54:45.447160 | 2026-02-25 16:54:45.447230 | TASK [test-setup : Run tools/test-setup.sh] 2026-02-25 16:54:46.012879 | controller | skipping: Conditional result was False 2026-02-25 16:54:46.070433 | 2026-02-25 16:54:46.070577 | PLAY RECAP 2026-02-25 16:54:46.070635 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-25 16:54:46.070662 | 2026-02-25 16:54:46.194841 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-25 16:54:46.196555 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-02-25 16:54:46.805497 | 2026-02-25 16:54:46.805651 | PLAY [controller] 2026-02-25 16:54:46.826074 | 2026-02-25 16:54:46.826173 | TASK [Create the /root directory] 2026-02-25 16:54:47.234412 | controller | ok 2026-02-25 16:54:47.247051 | 2026-02-25 16:54:47.247176 | TASK [Install glibc-langpack-en] 2026-02-25 16:54:51.572944 | controller | ok: Nothing to do 2026-02-25 16:54:51.578463 | 2026-02-25 16:54:51.578525 | TASK [Ensure controller directory exists] 2026-02-25 16:54:51.852176 | controller | changed 2026-02-25 16:54:51.864621 | 2026-02-25 16:54:51.864804 | TASK [Install container runtime] 2026-02-25 16:54:51.954536 | controller | ok 2026-02-25 16:54:52.010039 | 2026-02-25 16:54:52.010198 | LOOP [ensure-podman : Find distribution installation] 2026-02-25 16:54:52.040492 | controller | ok: "/var/lib/zuul/builds/6070d8c6e22e4993a368bb777295138c/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml" 2026-02-25 16:54:52.055267 | controller | included: /var/lib/zuul/builds/6070d8c6e22e4993a368bb777295138c/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml 2026-02-25 16:54:52.064435 | 2026-02-25 16:54:52.064526 | TASK [ensure-podman : Install podman (RedHat)] 2026-02-25 16:56:02.110301 | controller | changed 2026-02-25 16:56:02.124343 | 2026-02-25 16:56:02.124512 | TASK [ensure-podman : Fetch podman version] 2026-02-25 16:56:03.359469 | controller | Client: Podman Engine 2026-02-25 16:56:03.359690 | controller | Version: 4.6.2 2026-02-25 16:56:03.359777 | controller | API Version: 4.6.2 2026-02-25 16:56:03.359866 | controller | Go Version: go1.19.12 2026-02-25 16:56:03.359988 | controller | Built: Mon Aug 28 19:38:31 2023 2026-02-25 16:56:03.360068 | controller | OS/Arch: linux/amd64 2026-02-25 16:56:03.687593 | controller | ok: Runtime: 0:00:00.862217 2026-02-25 16:56:03.696348 | 2026-02-25 16:56:03.696454 | TASK [ensure-podman : Print podman version installed] 2026-02-25 16:56:03.728890 | Podman version: Client: Podman Engine 2026-02-25 16:56:03.729076 | Version: 4.6.2 2026-02-25 16:56:03.729103 | API Version: 4.6.2 2026-02-25 16:56:03.729123 | Go Version: go1.19.12 2026-02-25 16:56:03.729141 | Built: Mon Aug 28 19:38:31 2023 2026-02-25 16:56:03.729162 | OS/Arch: linux/amd64 2026-02-25 16:56:03.737182 | 2026-02-25 16:56:03.737265 | TASK [ensure-podman : Validate podman engine] 2026-02-25 16:56:04.277886 | controller | skipping: Conditional result was False 2026-02-25 16:56:04.291495 | 2026-02-25 16:56:04.291639 | TASK [ensure-podman : Set up docker compatability socket] 2026-02-25 16:56:04.317707 | controller | skipping: Conditional result was False 2026-02-25 16:56:04.335856 | 2026-02-25 16:56:04.335962 | TASK [Ensure python3.8 is present] 2026-02-25 16:56:04.351466 | controller | skipping: Conditional result was False 2026-02-25 16:56:04.361977 | 2026-02-25 16:56:04.362067 | TASK [Run our-ensure-python role (Fedora only for now)] 2026-02-25 16:56:04.384865 | controller | ok 2026-02-25 16:56:04.408301 | 2026-02-25 16:56:04.408439 | TASK [our-ensure-python : Install the right Python version (rpm)] 2026-02-25 16:56:05.897250 | controller | ok: Nothing to do 2026-02-25 16:56:05.909948 | 2026-02-25 16:56:05.910082 | TASK [our-ensure-python : Also install python3-devel] 2026-02-25 16:56:18.365353 | controller | changed 2026-02-25 16:56:18.390075 | 2026-02-25 16:56:18.390211 | TASK [Run ensure-virtualenv role] 2026-02-25 16:56:18.418779 | controller | ok 2026-02-25 16:56:18.456056 | 2026-02-25 16:56:18.456151 | TASK [ensure-virtualenv : Check if virtualenv is installed] 2026-02-25 16:56:18.777067 | controller | /usr/bin/virtualenv 2026-02-25 16:56:19.056855 | controller | ok: Runtime: 0:00:00.006644 2026-02-25 16:56:19.071395 | 2026-02-25 16:56:19.071537 | LOOP [ensure-virtualenv : Install virtualenv package] 2026-02-25 16:56:19.108304 | controller | skipping: Conditional result was False 2026-02-25 16:56:19.108907 | controller | ok: All items complete 2026-02-25 16:56:19.108979 | 2026-02-25 16:56:19.146429 | 2026-02-25 16:56:19.146644 | TASK [Find the full path of the Python interpreter] 2026-02-25 16:56:19.392574 | controller | /usr/bin/python3 2026-02-25 16:56:19.695474 | controller | ok 2026-02-25 16:56:19.708374 | 2026-02-25 16:56:19.708512 | TASK [Create virtualenv for ansible-test with a specific interpreter] 2026-02-25 16:56:20.615993 | controller | created virtual environment CPython3.11.0.final.0-64 in 494ms 2026-02-25 16:56:20.647204 | controller | creator CPython3Posix(dest=/home/zuul/venv, clear=False, no_vcs_ignore=False, global=False) 2026-02-25 16:56:20.647791 | 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 16:56:20.647806 | controller | added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1 2026-02-25 16:56:20.647820 | controller | activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator 2026-02-25 16:56:20.763741 | controller | changed 2026-02-25 16:56:20.777282 | 2026-02-25 16:56:20.777425 | TASK [Set selinux package] 2026-02-25 16:56:20.817147 | controller | ok 2026-02-25 16:56:20.828832 | 2026-02-25 16:56:20.828970 | TASK [Set selinux package (Fedora)] 2026-02-25 16:56:20.880374 | controller | ok 2026-02-25 16:56:20.893326 | 2026-02-25 16:56:20.894239 | TASK [Install selinux into virtualenv] 2026-02-25 16:56:46.554587 | controller | Collecting selinux-please-lie-to-me 2026-02-25 16:56:58.795563 | controller | Downloading selinux_please_lie_to_me-1.0.1-py2.py3-none-any.whl (3.8 kB) 2026-02-25 16:56:59.349028 | controller | Collecting setuptools<50.0.0 2026-02-25 16:56:59.354153 | controller | Downloading setuptools-49.6.0-py3-none-any.whl (803 kB) 2026-02-25 16:56:59.494613 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 803.3/803.3 kB 6.0 MB/s eta 0:00:00 2026-02-25 16:56:59.594953 | controller | Installing collected packages: setuptools, selinux-please-lie-to-me 2026-02-25 16:56:59.595195 | controller | Attempting uninstall: setuptools 2026-02-25 16:56:59.598189 | controller | Found existing installation: setuptools 62.6.0 2026-02-25 16:56:59.667877 | controller | Uninstalling setuptools-62.6.0: 2026-02-25 16:56:59.676516 | controller | Successfully uninstalled setuptools-62.6.0 2026-02-25 16:57:00.095891 | controller | Successfully installed selinux-please-lie-to-me-1.0.1 setuptools-49.6.0 2026-02-25 16:57:11.187541 | controller | 2026-02-25 16:57:11.297184 | controller | [notice] A new release of pip available: 22.2.2 -> 26.0.1 2026-02-25 16:57:11.297401 | controller | [notice] To update, run: python -m pip install --upgrade pip 2026-02-25 16:57:11.467897 | controller | ok: Runtime: 0:00:50.138182 2026-02-25 16:57:11.480252 | 2026-02-25 16:57:11.480380 | TASK [Install pytest-forked into virtualenv] 2026-02-25 16:57:23.411673 | controller | Collecting pytest-forked 2026-02-25 16:57:33.608996 | controller | Downloading pytest_forked-1.6.0-py3-none-any.whl (4.9 kB) 2026-02-25 16:57:33.658769 | controller | Collecting py 2026-02-25 16:57:33.664165 | controller | Downloading py-1.11.0-py2.py3-none-any.whl (98 kB) 2026-02-25 16:57:33.684863 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.7/98.7 kB 5.4 MB/s eta 0:00:00 2026-02-25 16:57:33.803813 | controller | Collecting pytest>=3.10 2026-02-25 16:57:33.808126 | controller | Downloading pytest-9.0.2-py3-none-any.whl (374 kB) 2026-02-25 16:57:33.822897 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 374.8/374.8 kB 32.5 MB/s eta 0:00:00 2026-02-25 16:57:33.867964 | controller | Collecting iniconfig>=1.0.1 2026-02-25 16:57:33.872197 | controller | Downloading iniconfig-2.3.0-py3-none-any.whl (7.5 kB) 2026-02-25 16:57:33.919428 | controller | Collecting packaging>=22 2026-02-25 16:57:33.922816 | controller | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-02-25 16:57:33.928776 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 19.3 MB/s eta 0:00:00 2026-02-25 16:57:33.960366 | controller | Collecting pluggy<2,>=1.5 2026-02-25 16:57:33.963362 | controller | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-02-25 16:57:34.010920 | controller | Collecting pygments>=2.7.2 2026-02-25 16:57:34.015104 | controller | Downloading pygments-2.19.2-py3-none-any.whl (1.2 MB) 2026-02-25 16:57:34.036329 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.2/1.2 MB 67.0 MB/s eta 0:00:00 2026-02-25 16:57:34.122700 | controller | Installing collected packages: pygments, py, pluggy, packaging, iniconfig, pytest, pytest-forked 2026-02-25 16:57:35.335906 | 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 16:57:35.347416 | controller | 2026-02-25 16:57:35.437259 | controller | [notice] A new release of pip available: 22.2.2 -> 26.0.1 2026-02-25 16:57:35.437307 | controller | [notice] To update, run: python -m pip install --upgrade pip 2026-02-25 16:57:35.551526 | controller | ok: Runtime: 0:00:23.699983 2026-02-25 16:57:35.559724 | 2026-02-25 16:57:35.559805 | TASK [Update pip] 2026-02-25 16:57:36.111138 | controller | Requirement already satisfied: pip in ./venv/lib/python3.11/site-packages (22.2.2) 2026-02-25 16:57:48.923373 | controller | Collecting pip 2026-02-25 16:58:01.251265 | controller | Downloading pip-26.0.1-py3-none-any.whl (1.8 MB) 2026-02-25 16:58:01.325712 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.8/1.8 MB 26.8 MB/s eta 0:00:00 2026-02-25 16:58:01.395528 | controller | Installing collected packages: pip 2026-02-25 16:58:01.395674 | controller | Attempting uninstall: pip 2026-02-25 16:58:01.398907 | controller | Found existing installation: pip 22.2.2 2026-02-25 16:58:01.543393 | controller | Uninstalling pip-22.2.2: 2026-02-25 16:58:01.558638 | controller | Successfully uninstalled pip-22.2.2 2026-02-25 16:58:02.412274 | controller | Successfully installed pip-26.0.1 2026-02-25 16:58:02.617279 | controller | ok: Runtime: 0:00:26.692587 2026-02-25 16:58:02.625986 | 2026-02-25 16:58:02.626078 | TASK [Ensure pip temp directory exists in /var/tmp] 2026-02-25 16:58:02.859632 | controller | changed 2026-02-25 16:58:02.872866 | 2026-02-25 16:58:02.873013 | TASK [Install ansible into virtualenv] 2026-02-25 16:58:03.474315 | controller | Processing ./src/github.com/ansible/ansible 2026-02-25 16:58:03.476933 | controller | Installing build dependencies: started 2026-02-25 16:58:27.635868 | controller | Installing build dependencies: finished with status 'done' 2026-02-25 16:58:27.637055 | controller | Getting requirements to build wheel: started 2026-02-25 16:58:28.463172 | controller | Getting requirements to build wheel: finished with status 'done' 2026-02-25 16:58:28.464934 | controller | Preparing metadata (pyproject.toml): started 2026-02-25 16:58:29.040929 | controller | Preparing metadata (pyproject.toml): finished with status 'done' 2026-02-25 16:58:29.046837 | 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 16:58:29.051157 | controller | ERROR: Package 'ansible-core' requires a different Python: 3.11.0 not in '>=3.12' 2026-02-25 16:58:29.430414 | controller | ERROR 2026-02-25 16:58:29.430661 | controller | { 2026-02-25 16:58:29.430709 | controller | "delta": "0:00:26.013134", 2026-02-25 16:58:29.430745 | controller | "end": "2026-02-25 16:58:29.133030", 2026-02-25 16:58:29.430764 | controller | "msg": "non-zero return code", 2026-02-25 16:58:29.430791 | controller | "rc": 1, 2026-02-25 16:58:29.430807 | controller | "start": "2026-02-25 16:58:03.119896" 2026-02-25 16:58:29.430822 | controller | } failure 2026-02-25 16:58:29.432791 | 2026-02-25 16:58:29.432840 | PLAY RECAP 2026-02-25 16:58:29.432881 | controller | ok: 18 changed: 10 unreachable: 0 failed: 1 skipped: 4 rescued: 0 ignored: 0 2026-02-25 16:58:29.432901 | 2026-02-25 16:58:29.584639 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-02-25 16:58:29.586769 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-25 16:58:30.159732 | 2026-02-25 16:58:30.159847 | PLAY [all] 2026-02-25 16:58:30.183192 | 2026-02-25 16:58:30.183299 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-02-25 16:58:30.428271 | controller | changed: non-zero return code 2026-02-25 16:58:30.438267 | 2026-02-25 16:58:30.438371 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-02-25 16:58:30.462865 | controller | skipping: Conditional result was False 2026-02-25 16:58:30.471081 | 2026-02-25 16:58:30.471175 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-02-25 16:58:30.510000 | 2026-02-25 16:58:30.510245 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-02-25 16:58:30.560610 | 2026-02-25 16:58:30.561008 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-02-25 16:58:30.578408 | controller | skipping: Conditional result was False 2026-02-25 16:58:30.594845 | 2026-02-25 16:58:30.594992 | LOOP [fetch-subunit-output : Generate subunit file] 2026-02-25 16:58:30.621356 | 2026-02-25 16:58:30.621525 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-02-25 16:58:30.646621 | controller | skipping: Conditional result was False 2026-02-25 16:58:30.655827 | 2026-02-25 16:58:30.655915 | TASK [fetch-subunit-output : Remove the temporary file] 2026-02-25 16:58:30.681229 | controller | skipping: Conditional result was False 2026-02-25 16:58:30.689460 | 2026-02-25 16:58:30.689547 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-02-25 16:58:30.714744 | controller | skipping: Conditional result was False 2026-02-25 16:58:30.750614 | 2026-02-25 16:58:30.750721 | PLAY RECAP 2026-02-25 16:58:30.750778 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-25 16:58:30.750806 | 2026-02-25 16:58:30.857935 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-25 16:58:30.859760 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2026-02-25 16:58:31.514792 | 2026-02-25 16:58:31.514908 | PLAY [all:!appliance*] 2026-02-25 16:58:31.535790 | 2026-02-25 16:58:31.535876 | TASK [unregister the node] 2026-02-25 16:58:32.068831 | controller | skipping: Conditional result was False 2026-02-25 16:58:32.076810 | 2026-02-25 16:58:32.076940 | TASK [include_role : fetch-output] 2026-02-25 16:58:32.138138 | controller | ok 2026-02-25 16:58:32.179754 | 2026-02-25 16:58:32.179925 | TASK [fetch-output : Set log path for multiple nodes] 2026-02-25 16:58:32.247191 | controller | skipping: Conditional result was False 2026-02-25 16:58:32.256811 | 2026-02-25 16:58:32.256916 | TASK [fetch-output : Set log path for single node] 2026-02-25 16:58:32.301166 | controller | ok 2026-02-25 16:58:32.309523 | 2026-02-25 16:58:32.309614 | LOOP [fetch-output : Ensure local output dirs] 2026-02-25 16:58:32.737589 | controller -> localhost | ok: "/var/lib/zuul/builds/6070d8c6e22e4993a368bb777295138c/work/logs" 2026-02-25 16:58:33.014014 | controller -> localhost | changed: "/var/lib/zuul/builds/6070d8c6e22e4993a368bb777295138c/work/artifacts" 2026-02-25 16:58:33.256270 | controller -> localhost | changed: "/var/lib/zuul/builds/6070d8c6e22e4993a368bb777295138c/work/docs" 2026-02-25 16:58:33.279737 | 2026-02-25 16:58:33.279901 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-25 16:58:33.988599 | controller | changed: 2026-02-25 16:58:33.988971 | controller | .d..t...... ./ 2026-02-25 16:58:33.989029 | controller | cd+++++++++ controller/ 2026-02-25 16:58:33.989113 | controller | changed: All items complete 2026-02-25 16:58:33.989177 | 2026-02-25 16:58:34.449653 | controller | changed: .d..t...... ./ 2026-02-25 16:58:35.017089 | controller | changed: .d..t...... ./ 2026-02-25 16:58:35.049413 | 2026-02-25 16:58:35.049516 | TASK [include_role : fetch-output-openshift] 2026-02-25 16:58:35.075411 | controller | skipping: Conditional result was False 2026-02-25 16:58:35.084174 | 2026-02-25 16:58:35.084270 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-02-25 16:58:35.510918 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.007763 2026-02-25 16:58:35.731180 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.010155 2026-02-25 16:58:35.772660 | 2026-02-25 16:58:35.773024 | PLAY [localhost] 2026-02-25 16:58:35.819047 | 2026-02-25 16:58:35.819178 | TASK [Run Zuul manifest role] 2026-02-25 16:58:35.837925 | localhost | ok 2026-02-25 16:58:35.852110 | 2026-02-25 16:58:35.852208 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-25 16:58:36.205022 | localhost | changed 2026-02-25 16:58:36.209853 | 2026-02-25 16:58:36.209920 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-25 16:58:36.249978 | localhost | ok 2026-02-25 16:58:36.258409 | 2026-02-25 16:58:36.258493 | TASK [Set zuul-log-path fact] 2026-02-25 16:58:36.289429 | localhost | ok 2026-02-25 16:58:36.302748 | 2026-02-25 16:58:36.302813 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-25 16:58:36.343016 | localhost | ok 2026-02-25 16:58:36.351198 | 2026-02-25 16:58:36.351262 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)] 2026-02-25 16:58:36.387884 | localhost | ok: 2026-02-25 16:58:36.388078 | localhost | { 2026-02-25 16:58:36.388111 | localhost | "auth": { 2026-02-25 16:58:36.388139 | localhost | "password": "IonWCwcuOFib&&<}wp^:[2G/", 2026-02-25 16:58:36.388163 | localhost | "username": "9LF91O0RK7JU" 2026-02-25 16:58:36.388187 | localhost | }, 2026-02-25 16:58:36.388208 | localhost | "profile": "rackspace", 2026-02-25 16:58:36.388229 | localhost | "project_name": "1251317", 2026-02-25 16:58:36.388251 | localhost | "region_name": "DFW" 2026-02-25 16:58:36.388272 | localhost | } 2026-02-25 16:58:36.388310 | localhost | changed: All items complete 2026-02-25 16:58:36.388339 | 2026-02-25 16:58:36.399962 | 2026-02-25 16:58:36.400081 | TASK [Run upload-logs-failover role (S3 then Swift)] 2026-02-25 16:58:36.418786 | localhost | Output suppressed because no_log was given 2026-02-25 16:58:36.432766 | 2026-02-25 16:58:36.432844 | TASK [upload-logs-failover : Initialize control vars] 2026-02-25 16:58:36.505601 | localhost | ok 2026-02-25 16:58:36.509861 | 2026-02-25 16:58:36.509985 | LOOP [upload-logs-failover : Perform log upload] 2026-02-25 16:58:36.535190 | localhost | Output suppressed because no_log was given 2026-02-25 16:58:36.543620 | localhost | included: /var/lib/zuul/builds/6070d8c6e22e4993a368bb777295138c/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml 2026-02-25 16:58:36.551305 | 2026-02-25 16:58:36.551382 | LOOP [upload-logs-failover : Unpack vars for swift upload] 2026-02-25 16:58:36.637969 | localhost | Output suppressed because no_log was given 2026-02-25 16:58:36.646788 | 2026-02-25 16:58:36.646890 | TASK [Upload logs to swift] 2026-02-25 16:58:36.670312 | localhost | ok 2026-02-25 16:58:36.705958 | 2026-02-25 16:58:36.706082 | TASK [Set zuul-log-path fact] 2026-02-25 16:58:36.741394 | localhost | skipping: Conditional result was False 2026-02-25 16:58:36.747864 | 2026-02-25 16:58:36.747941 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2026-02-25 16:58:37.067946 | localhost -> localhost | ok: Runtime: 0:00:00.011351 2026-02-25 16:58:37.083558 | 2026-02-25 16:58:37.083667 | TASK [upload-logs-swift : Upload logs to swift]