2026-03-16 17:57:24.149172 | Job console starting... 2026-03-16 17:57:24.160029 | Updating repositories 2026-03-16 17:57:24.295887 | Preparing job workspace 2026-03-16 17:57:28.928105 | Running Ansible setup... 2026-03-16 17:57:33.705821 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-03-16 17:57:34.411641 | 2026-03-16 17:57:34.411859 | PLAY [localhost] 2026-03-16 17:57:34.422552 | 2026-03-16 17:57:34.422673 | TASK [Gathering Facts] 2026-03-16 17:57:35.496523 | localhost | ok 2026-03-16 17:57:35.513398 | 2026-03-16 17:57:35.513679 | TASK [Setup log path fact] 2026-03-16 17:57:35.544057 | localhost | ok 2026-03-16 17:57:35.559550 | 2026-03-16 17:57:35.559752 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-16 17:57:35.600563 | localhost | ok 2026-03-16 17:57:35.609088 | 2026-03-16 17:57:35.609255 | TASK [emit-job-header : Print job information] 2026-03-16 17:57:35.660257 | # Job Information 2026-03-16 17:57:35.660477 | Ansible Version: 2.15.12 2026-03-16 17:57:35.660508 | Job: ansible-test-sanity-okd-downstream-milestone 2026-03-16 17:57:35.660530 | Pipeline: third-party-check 2026-03-16 17:57:35.660549 | Executor: ze03.softwarefactory-project.io 2026-03-16 17:57:35.660567 | Triggered by: https://github.com/openshift/community.okd/pull/274 2026-03-16 17:57:35.660590 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/265/ansible/2650fceeb09449ca9e312131f93c599b/ 2026-03-16 17:57:35.660610 | Event ID: 97fd8f70-2160-11f1-9a53-01d63ae7a043 2026-03-16 17:57:35.664688 | 2026-03-16 17:57:35.664809 | LOOP [emit-job-header : Print node information] 2026-03-16 17:57:35.795641 | localhost | ok: 2026-03-16 17:57:35.795904 | localhost | # Node Information 2026-03-16 17:57:35.795942 | localhost | Inventory Hostname: controller 2026-03-16 17:57:35.795969 | localhost | Hostname: np0005649038 2026-03-16 17:57:35.795995 | localhost | Username: zuul 2026-03-16 17:57:35.796026 | localhost | Distro: Fedora 37 2026-03-16 17:57:35.796051 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2026-03-16 17:57:35.796075 | localhost | Region: ca-ymq-1 2026-03-16 17:57:35.796098 | localhost | Label: ansible-fedora-37-1vcpu 2026-03-16 17:57:35.796120 | localhost | Product Name: OpenStack Nova 2026-03-16 17:57:35.796144 | localhost | Interface IP: 199.19.213.166 2026-03-16 17:57:35.815104 | 2026-03-16 17:57:35.815283 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-16 17:57:36.282285 | localhost -> localhost | changed 2026-03-16 17:57:36.289365 | 2026-03-16 17:57:36.289452 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-16 17:57:37.141488 | localhost -> localhost | changed 2026-03-16 17:57:37.162907 | 2026-03-16 17:57:37.163056 | PLAY [all:!appliance*] 2026-03-16 17:57:37.180209 | 2026-03-16 17:57:37.180279 | TASK [include_role : start-zuul-console] 2026-03-16 17:57:37.223337 | controller | ok 2026-03-16 17:57:37.241241 | 2026-03-16 17:57:37.241397 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-16 17:57:37.675584 | controller | ok 2026-03-16 17:57:37.698452 | 2026-03-16 17:57:37.698604 | TASK [use-our-mirror : Retrieve the IP address] 2026-03-16 17:57:38.582487 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2026-03-16 17:57:38.593352 | 2026-03-16 17:57:38.593486 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2026-03-16 17:57:39.136262 | controller | skipping: Conditional result was False 2026-03-16 17:57:39.150202 | 2026-03-16 17:57:39.150346 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2026-03-16 17:57:39.186925 | controller | skipping: Conditional result was False 2026-03-16 17:57:39.200784 | 2026-03-16 17:57:39.200945 | TASK [use-our-mirror : Create the podman configuration directory] 2026-03-16 17:57:39.227559 | controller | skipping: Conditional result was False 2026-03-16 17:57:39.236827 | 2026-03-16 17:57:39.236921 | TASK [use-our-mirror : Copy the podman configuration] 2026-03-16 17:57:39.262769 | controller | skipping: Conditional result was False 2026-03-16 17:57:39.271818 | 2026-03-16 17:57:39.271925 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2026-03-16 17:57:39.298091 | controller | skipping: Conditional result was False 2026-03-16 17:57:39.309483 | 2026-03-16 17:57:39.309631 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2026-03-16 17:57:39.335382 | controller | skipping: Conditional result was False 2026-03-16 17:57:39.353650 | 2026-03-16 17:57:39.353829 | TASK [Disable Fedora Modular] 2026-03-16 17:57:39.613600 | controller | changed 2026-03-16 17:57:39.622130 | 2026-03-16 17:57:39.622241 | TASK [Enable EPEL] 2026-03-16 17:57:39.649879 | controller | skipping: Conditional result was False 2026-03-16 17:57:39.660580 | 2026-03-16 17:57:39.660778 | TASK [Register the RHEL node] 2026-03-16 17:57:40.220700 | 2026-03-16 17:57:40.221024 | TASK [Show the subscription-manager status] 2026-03-16 17:57:40.825022 | controller | skipping: Conditional result was False 2026-03-16 17:57:40.838644 | 2026-03-16 17:57:40.838815 | TASK [Enable EPEL on RHEL] 2026-03-16 17:57:41.395326 | controller | skipping: Conditional result was False 2026-03-16 17:57:41.409951 | 2026-03-16 17:57:41.410103 | TASK [Install git and tox] 2026-03-16 17:59:10.757815 | controller | changed 2026-03-16 17:59:10.772775 | 2026-03-16 17:59:10.772996 | TASK [include_role : prepare-workspace] 2026-03-16 17:59:10.812626 | controller | ok 2026-03-16 17:59:10.849376 | 2026-03-16 17:59:10.849529 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-16 17:59:11.101693 | controller | ok 2026-03-16 17:59:11.117273 | 2026-03-16 17:59:11.117414 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-16 17:59:23.657946 | controller | Output suppressed because no_log was given 2026-03-16 17:59:23.705010 | 2026-03-16 17:59:23.705157 | TASK [include_role : prepare-workspace-openshift] 2026-03-16 17:59:23.733935 | controller | skipping: Conditional result was False 2026-03-16 17:59:23.759783 | 2026-03-16 17:59:23.759890 | PLAY [all:!appliance] 2026-03-16 17:59:23.777751 | 2026-03-16 17:59:23.777855 | TASK [Run add-build-sshkey role (RSA)] 2026-03-16 17:59:23.809223 | controller | ok 2026-03-16 17:59:23.824552 | 2026-03-16 17:59:23.824629 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-16 17:59:24.094570 | controller -> localhost | ok 2026-03-16 17:59:24.131169 | 2026-03-16 17:59:24.131392 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-16 17:59:24.168094 | controller | ok 2026-03-16 17:59:24.183629 | controller | included: /var/lib/zuul/builds/2650fceeb09449ca9e312131f93c599b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-16 17:59:24.190121 | 2026-03-16 17:59:24.190215 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-16 17:59:24.818104 | controller -> localhost | Generating public/private rsa key pair. 2026-03-16 17:59:24.818521 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/2650fceeb09449ca9e312131f93c599b/work/2650fceeb09449ca9e312131f93c599b_id_rsa. 2026-03-16 17:59:24.818586 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/2650fceeb09449ca9e312131f93c599b/work/2650fceeb09449ca9e312131f93c599b_id_rsa.pub. 2026-03-16 17:59:24.818632 | controller -> localhost | The key fingerprint is: 2026-03-16 17:59:24.818674 | controller -> localhost | SHA256:75FLIZ/sETFuaa99yOWt5cAoFF7PpcmaTDgDdngxxCI zuul-build-sshkey 2026-03-16 17:59:24.818714 | controller -> localhost | The key's randomart image is: 2026-03-16 17:59:24.818799 | controller -> localhost | +---[RSA 2048]----+ 2026-03-16 17:59:24.818842 | controller -> localhost | | o+ | 2026-03-16 17:59:24.818883 | controller -> localhost | | E ...o | 2026-03-16 17:59:24.818922 | controller -> localhost | | .+.* . .| 2026-03-16 17:59:24.818960 | controller -> localhost | | . * B + + | 2026-03-16 17:59:24.818996 | controller -> localhost | | S & . * | 2026-03-16 17:59:24.819052 | controller -> localhost | | O @ =. | 2026-03-16 17:59:24.819142 | controller -> localhost | | @.*+o..| 2026-03-16 17:59:24.819187 | controller -> localhost | | + Bo o+.| 2026-03-16 17:59:24.819227 | controller -> localhost | | = .....| 2026-03-16 17:59:24.819273 | controller -> localhost | +----[SHA256]-----+ 2026-03-16 17:59:24.819375 | controller -> localhost | ok: Runtime: 0:00:00.151745 2026-03-16 17:59:24.835491 | 2026-03-16 17:59:24.835778 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-16 17:59:24.882695 | controller | ok 2026-03-16 17:59:24.896872 | controller | included: /var/lib/zuul/builds/2650fceeb09449ca9e312131f93c599b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-16 17:59:24.910270 | 2026-03-16 17:59:24.910533 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-16 17:59:24.938394 | controller | skipping: Conditional result was False 2026-03-16 17:59:24.948317 | 2026-03-16 17:59:24.948449 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-16 17:59:25.419818 | controller | changed 2026-03-16 17:59:25.427539 | 2026-03-16 17:59:25.427621 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-16 17:59:25.671390 | controller | ok 2026-03-16 17:59:25.680690 | 2026-03-16 17:59:25.680861 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-16 17:59:26.359372 | controller | changed 2026-03-16 17:59:26.372459 | 2026-03-16 17:59:26.372630 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-16 17:59:27.017014 | controller | changed 2026-03-16 17:59:27.031637 | 2026-03-16 17:59:27.031826 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-16 17:59:27.060467 | controller | skipping: Conditional result was False 2026-03-16 17:59:27.072880 | 2026-03-16 17:59:27.073340 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-16 17:59:27.541291 | controller -> localhost | changed 2026-03-16 17:59:27.556505 | 2026-03-16 17:59:27.556600 | TASK [add-build-sshkey : Add back temp key] 2026-03-16 17:59:27.861991 | controller -> localhost | Identity added: /var/lib/zuul/builds/2650fceeb09449ca9e312131f93c599b/work/2650fceeb09449ca9e312131f93c599b_id_rsa (zuul-build-sshkey) 2026-03-16 17:59:27.862573 | controller -> localhost | ok: Runtime: 0:00:00.014873 2026-03-16 17:59:27.877973 | 2026-03-16 17:59:27.878189 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-16 17:59:28.242998 | controller | ok 2026-03-16 17:59:28.267227 | 2026-03-16 17:59:28.267393 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-16 17:59:28.294106 | controller | skipping: Conditional result was False 2026-03-16 17:59:28.310386 | 2026-03-16 17:59:28.310517 | TASK [Run add-build-sshkey role (ECDSA)] 2026-03-16 17:59:28.340993 | controller | ok 2026-03-16 17:59:28.367561 | 2026-03-16 17:59:28.367696 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-16 17:59:28.709543 | controller -> localhost | ok 2026-03-16 17:59:28.721327 | 2026-03-16 17:59:28.721521 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-16 17:59:28.767623 | controller | ok 2026-03-16 17:59:28.779770 | controller | included: /var/lib/zuul/builds/2650fceeb09449ca9e312131f93c599b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-16 17:59:28.787462 | 2026-03-16 17:59:28.787539 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-16 17:59:29.211875 | controller -> localhost | Generating public/private ecdsa key pair. 2026-03-16 17:59:29.212197 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/2650fceeb09449ca9e312131f93c599b/work/2650fceeb09449ca9e312131f93c599b_id_ecdsa. 2026-03-16 17:59:29.212241 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/2650fceeb09449ca9e312131f93c599b/work/2650fceeb09449ca9e312131f93c599b_id_ecdsa.pub. 2026-03-16 17:59:29.212284 | controller -> localhost | The key fingerprint is: 2026-03-16 17:59:29.212313 | controller -> localhost | SHA256:AZOOjHekBgPVXdIIl81RLQZP6QgaANMBpAKNZIHwuSQ zuul-build-sshkey 2026-03-16 17:59:29.212342 | controller -> localhost | The key's randomart image is: 2026-03-16 17:59:29.212369 | controller -> localhost | +---[ECDSA 521]---+ 2026-03-16 17:59:29.212395 | controller -> localhost | |%&=+.o=O++oo | 2026-03-16 17:59:29.212420 | controller -> localhost | |*o=.o.B++o+ . | 2026-03-16 17:59:29.212445 | controller -> localhost | |E += B ..+.. | 2026-03-16 17:59:29.212470 | controller -> localhost | |.o..B o ... | 2026-03-16 17:59:29.212494 | controller -> localhost | | .o . S | 2026-03-16 17:59:29.212519 | controller -> localhost | | | 2026-03-16 17:59:29.212543 | controller -> localhost | | | 2026-03-16 17:59:29.212567 | controller -> localhost | | | 2026-03-16 17:59:29.212591 | controller -> localhost | | | 2026-03-16 17:59:29.212615 | controller -> localhost | +----[SHA256]-----+ 2026-03-16 17:59:29.212692 | controller -> localhost | ok: Runtime: 0:00:00.015683 2026-03-16 17:59:29.223684 | 2026-03-16 17:59:29.224953 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-16 17:59:29.256316 | controller | ok 2026-03-16 17:59:29.264003 | controller | included: /var/lib/zuul/builds/2650fceeb09449ca9e312131f93c599b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-16 17:59:29.273076 | 2026-03-16 17:59:29.273143 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-16 17:59:29.298278 | controller | skipping: Conditional result was False 2026-03-16 17:59:29.306953 | 2026-03-16 17:59:29.307035 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-16 17:59:29.590224 | controller | changed 2026-03-16 17:59:29.603177 | 2026-03-16 17:59:29.603309 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-16 17:59:29.822444 | controller | ok 2026-03-16 17:59:29.828302 | 2026-03-16 17:59:29.828369 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-16 17:59:30.514903 | controller | changed 2026-03-16 17:59:30.526670 | 2026-03-16 17:59:30.526799 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-16 17:59:31.179130 | controller | changed 2026-03-16 17:59:31.191687 | 2026-03-16 17:59:31.191863 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-16 17:59:31.218996 | controller | skipping: Conditional result was False 2026-03-16 17:59:31.233970 | 2026-03-16 17:59:31.234113 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-16 17:59:31.596124 | controller -> localhost | changed 2026-03-16 17:59:31.611067 | 2026-03-16 17:59:31.611304 | TASK [add-build-sshkey : Add back temp key] 2026-03-16 17:59:31.918288 | controller -> localhost | Identity added: /var/lib/zuul/builds/2650fceeb09449ca9e312131f93c599b/work/2650fceeb09449ca9e312131f93c599b_id_ecdsa (zuul-build-sshkey) 2026-03-16 17:59:31.918872 | controller -> localhost | ok: Runtime: 0:00:00.013153 2026-03-16 17:59:31.933020 | 2026-03-16 17:59:31.933152 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-16 17:59:32.159537 | controller | ok 2026-03-16 17:59:32.172807 | 2026-03-16 17:59:32.172942 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-16 17:59:32.222258 | controller | skipping: Conditional result was False 2026-03-16 17:59:32.251661 | 2026-03-16 17:59:32.251831 | TASK [include_role : remove-zuul-sshkey] 2026-03-16 17:59:32.290635 | controller | skipping: Conditional result was False 2026-03-16 17:59:32.300212 | 2026-03-16 17:59:32.300322 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-16 17:59:32.554373 | controller | ok: "logs" 2026-03-16 17:59:32.554696 | controller | ok: All items complete 2026-03-16 17:59:32.554734 | 2026-03-16 17:59:32.765376 | controller | ok: "artifacts" 2026-03-16 17:59:32.969882 | controller | ok: "docs" 2026-03-16 17:59:32.992955 | 2026-03-16 17:59:32.993197 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-16 17:59:33.254609 | controller | changed: "logs" 2026-03-16 17:59:33.454229 | controller | changed: "artifacts" 2026-03-16 17:59:33.650676 | controller | changed: "docs" 2026-03-16 17:59:33.680642 | 2026-03-16 17:59:33.680788 | PLAY RECAP 2026-03-16 17:59:33.680836 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2026-03-16 17:59:33.680861 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-16 17:59:33.680878 | 2026-03-16 17:59:33.808307 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-03-16 17:59:33.809212 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-03-16 17:59:34.424437 | 2026-03-16 17:59:34.424578 | PLAY [all] 2026-03-16 17:59:34.446039 | 2026-03-16 17:59:34.446133 | TASK [Install binary dependencies] 2026-03-16 17:59:34.541191 | controller | ok 2026-03-16 17:59:34.568030 | 2026-03-16 17:59:34.568176 | TASK [bindep : Include find tasks] 2026-03-16 17:59:34.608504 | controller | ok 2026-03-16 17:59:34.616512 | controller | included: /var/lib/zuul/builds/2650fceeb09449ca9e312131f93c599b/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-03-16 17:59:34.622893 | 2026-03-16 17:59:34.622957 | TASK [bindep : Look for bindep.txt] 2026-03-16 17:59:35.011644 | controller | ok 2026-03-16 17:59:35.019445 | 2026-03-16 17:59:35.019517 | TASK [bindep : Define bindep_file fact] 2026-03-16 17:59:35.045123 | controller | skipping: Conditional result was False 2026-03-16 17:59:35.052309 | 2026-03-16 17:59:35.052397 | TASK [bindep : Look for other-requirements.txt] 2026-03-16 17:59:35.298152 | controller | ok 2026-03-16 17:59:35.303662 | 2026-03-16 17:59:35.303757 | TASK [bindep : Define bindep_file fact] 2026-03-16 17:59:35.339570 | controller | skipping: Conditional result was False 2026-03-16 17:59:35.356463 | 2026-03-16 17:59:35.356672 | TASK [bindep : Look for bindep fallback file] 2026-03-16 17:59:35.395448 | controller | skipping: Conditional result was False 2026-03-16 17:59:35.417870 | 2026-03-16 17:59:35.418149 | TASK [bindep : Define bindep_file fact] 2026-03-16 17:59:35.446354 | controller | skipping: Conditional result was False 2026-03-16 17:59:35.456491 | 2026-03-16 17:59:35.456625 | TASK [bindep : Include bindep tasks] 2026-03-16 17:59:35.493060 | controller | skipping: Conditional result was False 2026-03-16 17:59:35.507629 | 2026-03-16 17:59:35.507851 | TASK [bindep : Include install tasks] 2026-03-16 17:59:35.546362 | controller | skipping: Conditional result was False 2026-03-16 17:59:35.565874 | 2026-03-16 17:59:35.566107 | LOOP [bindep : Include package tasks] 2026-03-16 17:59:35.673425 | 2026-03-16 17:59:35.673771 | TASK [Run test-setup role] 2026-03-16 17:59:35.707301 | controller | ok 2026-03-16 17:59:35.737182 | 2026-03-16 17:59:35.737453 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-03-16 17:59:35.967274 | controller | ok 2026-03-16 17:59:35.980651 | 2026-03-16 17:59:35.980857 | TASK [test-setup : Run tools/test-setup.sh] 2026-03-16 17:59:36.532287 | controller | skipping: Conditional result was False 2026-03-16 17:59:36.586412 | 2026-03-16 17:59:36.586537 | PLAY RECAP 2026-03-16 17:59:36.586591 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-03-16 17:59:36.586619 | 2026-03-16 17:59:36.701038 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-03-16 17:59:36.701971 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-03-16 17:59:37.295030 | 2026-03-16 17:59:37.295181 | PLAY [controller] 2026-03-16 17:59:37.317099 | 2026-03-16 17:59:37.317236 | TASK [Create the /root directory] 2026-03-16 17:59:37.733052 | controller | ok 2026-03-16 17:59:37.753668 | 2026-03-16 17:59:37.753935 | TASK [Install glibc-langpack-en] 2026-03-16 17:59:41.871942 | controller | ok: Nothing to do 2026-03-16 17:59:41.881415 | 2026-03-16 17:59:41.881556 | TASK [Ensure controller directory exists] 2026-03-16 17:59:42.113242 | controller | changed 2026-03-16 17:59:42.122345 | 2026-03-16 17:59:42.122460 | TASK [Install container runtime] 2026-03-16 17:59:42.201438 | controller | ok 2026-03-16 17:59:42.254701 | 2026-03-16 17:59:42.254900 | LOOP [ensure-podman : Find distribution installation] 2026-03-16 17:59:42.298312 | controller | ok: "/var/lib/zuul/builds/2650fceeb09449ca9e312131f93c599b/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml" 2026-03-16 17:59:42.313253 | controller | included: /var/lib/zuul/builds/2650fceeb09449ca9e312131f93c599b/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml 2026-03-16 17:59:42.320301 | 2026-03-16 17:59:42.320411 | TASK [ensure-podman : Install podman (RedHat)] 2026-03-16 18:01:06.570621 | controller | changed 2026-03-16 18:01:06.587179 | 2026-03-16 18:01:06.587534 | TASK [ensure-podman : Fetch podman version] 2026-03-16 18:01:07.176127 | controller | Client: Podman Engine 2026-03-16 18:01:07.176219 | controller | Version: 4.6.2 2026-03-16 18:01:07.176263 | controller | API Version: 4.6.2 2026-03-16 18:01:07.176304 | controller | Go Version: go1.19.12 2026-03-16 18:01:07.176357 | controller | Built: Mon Aug 28 19:38:31 2023 2026-03-16 18:01:07.176399 | controller | OS/Arch: linux/amd64 2026-03-16 18:01:07.634261 | controller | ok: Runtime: 0:00:00.230684 2026-03-16 18:01:07.648842 | 2026-03-16 18:01:07.649014 | TASK [ensure-podman : Print podman version installed] 2026-03-16 18:01:07.688340 | Podman version: Client: Podman Engine 2026-03-16 18:01:07.688636 | Version: 4.6.2 2026-03-16 18:01:07.688700 | API Version: 4.6.2 2026-03-16 18:01:07.688781 | Go Version: go1.19.12 2026-03-16 18:01:07.688827 | Built: Mon Aug 28 19:38:31 2023 2026-03-16 18:01:07.688868 | OS/Arch: linux/amd64 2026-03-16 18:01:07.701086 | 2026-03-16 18:01:07.701214 | TASK [ensure-podman : Validate podman engine] 2026-03-16 18:01:08.249517 | controller | skipping: Conditional result was False 2026-03-16 18:01:08.264133 | 2026-03-16 18:01:08.264290 | TASK [ensure-podman : Set up docker compatability socket] 2026-03-16 18:01:08.290989 | controller | skipping: Conditional result was False 2026-03-16 18:01:08.317047 | 2026-03-16 18:01:08.317247 | TASK [Ensure python3.8 is present] 2026-03-16 18:01:08.344709 | controller | skipping: Conditional result was False 2026-03-16 18:01:08.357529 | 2026-03-16 18:01:08.357664 | TASK [Run our-ensure-python role (Fedora only for now)] 2026-03-16 18:01:08.389108 | controller | ok 2026-03-16 18:01:08.419317 | 2026-03-16 18:01:08.419415 | TASK [our-ensure-python : Install the right Python version (rpm)] 2026-03-16 18:01:09.987860 | controller | ok: Nothing to do 2026-03-16 18:01:10.000874 | 2026-03-16 18:01:10.001022 | TASK [our-ensure-python : Also install python3-devel] 2026-03-16 18:01:22.286431 | controller | changed 2026-03-16 18:01:22.301946 | 2026-03-16 18:01:22.302257 | TASK [Run ensure-virtualenv role] 2026-03-16 18:01:22.329515 | controller | ok 2026-03-16 18:01:22.359030 | 2026-03-16 18:01:22.359165 | TASK [ensure-virtualenv : Check if virtualenv is installed] 2026-03-16 18:01:22.601878 | controller | /usr/bin/virtualenv 2026-03-16 18:01:22.917121 | controller | ok: Runtime: 0:00:00.005212 2026-03-16 18:01:22.931327 | 2026-03-16 18:01:22.931466 | LOOP [ensure-virtualenv : Install virtualenv package] 2026-03-16 18:01:22.970870 | controller | skipping: Conditional result was False 2026-03-16 18:01:22.971157 | controller | ok: All items complete 2026-03-16 18:01:22.971185 | 2026-03-16 18:01:23.004391 | 2026-03-16 18:01:23.004613 | TASK [Find the full path of the Python interpreter] 2026-03-16 18:01:23.248153 | controller | /usr/bin/python3 2026-03-16 18:01:23.553768 | controller | ok 2026-03-16 18:01:23.566386 | 2026-03-16 18:01:23.566532 | TASK [Create virtualenv for ansible-test with a specific interpreter] 2026-03-16 18:01:24.450192 | controller | created virtual environment CPython3.11.0.final.0-64 in 487ms 2026-03-16 18:01:24.465954 | controller | creator CPython3Posix(dest=/home/zuul/venv, clear=False, no_vcs_ignore=False, global=False) 2026-03-16 18:01:24.465992 | controller | seeder FromAppData(extra_search_dir=/usr/share/python-wheels,download=False, pip=bundle, setuptools=bundle, wheel=bundle, via=copy, app_data_dir=/home/zuul/.local/share/virtualenv) 2026-03-16 18:01:24.466002 | controller | added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1 2026-03-16 18:01:24.466016 | controller | activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator 2026-03-16 18:01:24.625190 | controller | changed 2026-03-16 18:01:24.632436 | 2026-03-16 18:01:24.632530 | TASK [Set selinux package] 2026-03-16 18:01:24.663582 | controller | ok 2026-03-16 18:01:24.668845 | 2026-03-16 18:01:24.668910 | TASK [Set selinux package (Fedora)] 2026-03-16 18:01:24.720600 | controller | ok 2026-03-16 18:01:24.726292 | 2026-03-16 18:01:24.726359 | TASK [Install selinux into virtualenv] 2026-03-16 18:01:50.236256 | controller | Collecting selinux-please-lie-to-me 2026-03-16 18:02:02.499736 | controller | Downloading selinux_please_lie_to_me-1.0.1-py2.py3-none-any.whl (3.8 kB) 2026-03-16 18:02:02.844346 | controller | Collecting setuptools<50.0.0 2026-03-16 18:02:02.857362 | controller | Downloading setuptools-49.6.0-py3-none-any.whl (803 kB) 2026-03-16 18:02:02.893352 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 803.3/803.3 kB 25.8 MB/s eta 0:00:00 2026-03-16 18:02:03.003439 | controller | Installing collected packages: setuptools, selinux-please-lie-to-me 2026-03-16 18:02:03.003741 | controller | Attempting uninstall: setuptools 2026-03-16 18:02:03.007250 | controller | Found existing installation: setuptools 62.6.0 2026-03-16 18:02:03.089435 | controller | Uninstalling setuptools-62.6.0: 2026-03-16 18:02:03.097928 | controller | Successfully uninstalled setuptools-62.6.0 2026-03-16 18:02:03.469234 | controller | Successfully installed selinux-please-lie-to-me-1.0.1 setuptools-49.6.0 2026-03-16 18:02:19.793551 | controller | 2026-03-16 18:02:19.879122 | controller | [notice] A new release of pip available: 22.2.2 -> 26.0.1 2026-03-16 18:02:19.879160 | controller | [notice] To update, run: python -m pip install --upgrade pip 2026-03-16 18:02:20.315616 | controller | ok: Runtime: 0:00:54.926306 2026-03-16 18:02:20.329266 | 2026-03-16 18:02:20.329810 | TASK [Install pytest-forked into virtualenv] 2026-03-16 18:02:33.264739 | controller | Collecting pytest-forked 2026-03-16 18:02:45.509572 | controller | Downloading pytest_forked-1.6.0-py3-none-any.whl (4.9 kB) 2026-03-16 18:02:45.561907 | controller | Collecting py 2026-03-16 18:02:45.565253 | controller | Downloading py-1.11.0-py2.py3-none-any.whl (98 kB) 2026-03-16 18:02:45.594315 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.7/98.7 kB 3.8 MB/s eta 0:00:00 2026-03-16 18:02:45.709431 | controller | Collecting pytest>=3.10 2026-03-16 18:02:45.713437 | controller | Downloading pytest-9.0.2-py3-none-any.whl (374 kB) 2026-03-16 18:02:45.731741 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 374.8/374.8 kB 24.2 MB/s eta 0:00:00 2026-03-16 18:02:45.774994 | controller | Collecting iniconfig>=1.0.1 2026-03-16 18:02:45.778626 | controller | Downloading iniconfig-2.3.0-py3-none-any.whl (7.5 kB) 2026-03-16 18:02:45.831761 | controller | Collecting packaging>=22 2026-03-16 18:02:45.836703 | controller | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-03-16 18:02:45.847542 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 8.6 MB/s eta 0:00:00 2026-03-16 18:02:45.882699 | controller | Collecting pluggy<2,>=1.5 2026-03-16 18:02:45.886287 | controller | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-03-16 18:02:45.937428 | controller | Collecting pygments>=2.7.2 2026-03-16 18:02:45.940552 | controller | Downloading pygments-2.19.2-py3-none-any.whl (1.2 MB) 2026-03-16 18:02:45.963152 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.2/1.2 MB 68.2 MB/s eta 0:00:00 2026-03-16 18:02:46.035889 | controller | Installing collected packages: pygments, py, pluggy, packaging, iniconfig, pytest, pytest-forked 2026-03-16 18:02:47.240904 | controller | Successfully installed iniconfig-2.3.0 packaging-26.0 pluggy-1.6.0 py-1.11.0 pygments-2.19.2 pytest-9.0.2 pytest-forked-1.6.0 2026-03-16 18:02:47.250744 | controller | 2026-03-16 18:02:47.329625 | controller | [notice] A new release of pip available: 22.2.2 -> 26.0.1 2026-03-16 18:02:47.329678 | controller | [notice] To update, run: python -m pip install --upgrade pip 2026-03-16 18:02:47.411690 | controller | ok: Runtime: 0:00:26.752927 2026-03-16 18:02:47.424466 | 2026-03-16 18:02:47.424593 | TASK [Update pip] 2026-03-16 18:02:47.989186 | controller | Requirement already satisfied: pip in ./venv/lib/python3.11/site-packages (22.2.2) 2026-03-16 18:02:57.881603 | controller | Collecting pip 2026-03-16 18:03:10.391626 | controller | Downloading pip-26.0.1-py3-none-any.whl (1.8 MB) 2026-03-16 18:03:11.547246 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.8/1.8 MB 1.5 MB/s eta 0:00:00 2026-03-16 18:03:11.614362 | controller | Installing collected packages: pip 2026-03-16 18:03:11.614598 | controller | Attempting uninstall: pip 2026-03-16 18:03:11.616888 | controller | Found existing installation: pip 22.2.2 2026-03-16 18:03:11.752368 | controller | Uninstalling pip-22.2.2: 2026-03-16 18:03:11.767531 | controller | Successfully uninstalled pip-22.2.2 2026-03-16 18:03:12.635355 | controller | Successfully installed pip-26.0.1 2026-03-16 18:03:12.996101 | controller | ok: Runtime: 0:00:25.053937 2026-03-16 18:03:13.009328 | 2026-03-16 18:03:13.009457 | TASK [Ensure pip temp directory exists in /var/tmp] 2026-03-16 18:03:13.263247 | controller | changed 2026-03-16 18:03:13.275483 | 2026-03-16 18:03:13.275614 | TASK [Install ansible into virtualenv] 2026-03-16 18:03:13.811880 | controller | Processing ./src/github.com/ansible/ansible 2026-03-16 18:03:13.814313 | controller | Installing build dependencies: started 2026-03-16 18:04:02.957259 | controller | Installing build dependencies: finished with status 'done' 2026-03-16 18:04:02.958078 | controller | Getting requirements to build wheel: started 2026-03-16 18:04:03.710912 | controller | Getting requirements to build wheel: finished with status 'done' 2026-03-16 18:04:03.712343 | controller | Preparing metadata (pyproject.toml): started 2026-03-16 18:04:04.207675 | controller | Preparing metadata (pyproject.toml): finished with status 'done' 2026-03-16 18:04:04.210599 | controller | INFO: pip is looking at multiple versions of ansible-core to determine which version is compatible with other requirements. This could take a while. 2026-03-16 18:04:04.213560 | controller | ERROR: Package 'ansible-core' requires a different Python: 3.11.0 not in '>=3.12' 2026-03-16 18:04:04.352343 | controller | ERROR 2026-03-16 18:04:04.352946 | controller | { 2026-03-16 18:04:04.352998 | controller | "delta": "0:00:50.773739", 2026-03-16 18:04:04.353026 | controller | "end": "2026-03-16 18:04:04.293093", 2026-03-16 18:04:04.353048 | controller | "msg": "non-zero return code", 2026-03-16 18:04:04.353084 | controller | "rc": 1, 2026-03-16 18:04:04.353109 | controller | "start": "2026-03-16 18:03:13.519354" 2026-03-16 18:04:04.353134 | controller | } failure 2026-03-16 18:04:04.355482 | 2026-03-16 18:04:04.355616 | PLAY RECAP 2026-03-16 18:04:04.355704 | controller | ok: 18 changed: 10 unreachable: 0 failed: 1 skipped: 4 rescued: 0 ignored: 0 2026-03-16 18:04:04.355792 | 2026-03-16 18:04:04.479121 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-03-16 18:04:04.480056 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-16 18:04:05.146893 | 2026-03-16 18:04:05.147051 | PLAY [all] 2026-03-16 18:04:05.171021 | 2026-03-16 18:04:05.171159 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-03-16 18:04:05.451245 | controller | changed: non-zero return code 2026-03-16 18:04:05.468017 | 2026-03-16 18:04:05.468320 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-03-16 18:04:05.489337 | controller | skipping: Conditional result was False 2026-03-16 18:04:05.502918 | 2026-03-16 18:04:05.503098 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-03-16 18:04:05.531682 | 2026-03-16 18:04:05.531897 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-03-16 18:04:05.568325 | 2026-03-16 18:04:05.568558 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-03-16 18:04:05.585384 | controller | skipping: Conditional result was False 2026-03-16 18:04:05.593432 | 2026-03-16 18:04:05.593509 | LOOP [fetch-subunit-output : Generate subunit file] 2026-03-16 18:04:05.616053 | 2026-03-16 18:04:05.616264 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-03-16 18:04:05.631883 | controller | skipping: Conditional result was False 2026-03-16 18:04:05.638556 | 2026-03-16 18:04:05.638630 | TASK [fetch-subunit-output : Remove the temporary file] 2026-03-16 18:04:05.652848 | controller | skipping: Conditional result was False 2026-03-16 18:04:05.659891 | 2026-03-16 18:04:05.659964 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-03-16 18:04:05.674962 | controller | skipping: Conditional result was False 2026-03-16 18:04:05.702558 | 2026-03-16 18:04:05.702624 | PLAY RECAP 2026-03-16 18:04:05.702669 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-03-16 18:04:05.702690 | 2026-03-16 18:04:05.888209 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-16 18:04:05.889945 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2026-03-16 18:04:06.486978 | 2026-03-16 18:04:06.487103 | PLAY [all:!appliance*] 2026-03-16 18:04:06.512600 | 2026-03-16 18:04:06.512775 | TASK [unregister the node] 2026-03-16 18:04:07.045263 | controller | skipping: Conditional result was False 2026-03-16 18:04:07.059428 | 2026-03-16 18:04:07.059711 | TASK [include_role : fetch-output] 2026-03-16 18:04:07.121356 | controller | ok 2026-03-16 18:04:07.161788 | 2026-03-16 18:04:07.162001 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-16 18:04:07.239309 | controller | skipping: Conditional result was False 2026-03-16 18:04:07.251636 | 2026-03-16 18:04:07.251865 | TASK [fetch-output : Set log path for single node] 2026-03-16 18:04:07.309480 | controller | ok 2026-03-16 18:04:07.317189 | 2026-03-16 18:04:07.317281 | LOOP [fetch-output : Ensure local output dirs] 2026-03-16 18:04:07.764087 | controller -> localhost | ok: "/var/lib/zuul/builds/2650fceeb09449ca9e312131f93c599b/work/logs" 2026-03-16 18:04:07.989081 | controller -> localhost | changed: "/var/lib/zuul/builds/2650fceeb09449ca9e312131f93c599b/work/artifacts" 2026-03-16 18:04:08.219797 | controller -> localhost | changed: "/var/lib/zuul/builds/2650fceeb09449ca9e312131f93c599b/work/docs" 2026-03-16 18:04:08.246094 | 2026-03-16 18:04:08.246339 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-16 18:04:09.002584 | controller | changed: 2026-03-16 18:04:09.003181 | controller | .d..t...... ./ 2026-03-16 18:04:09.003263 | controller | cd+++++++++ controller/ 2026-03-16 18:04:09.003350 | controller | changed: All items complete 2026-03-16 18:04:09.003416 | 2026-03-16 18:04:09.527242 | controller | changed: .d..t...... ./ 2026-03-16 18:04:09.959272 | controller | changed: .d..t...... ./ 2026-03-16 18:04:09.971874 | 2026-03-16 18:04:09.971946 | TASK [include_role : fetch-output-openshift] 2026-03-16 18:04:09.996810 | controller | skipping: Conditional result was False 2026-03-16 18:04:10.003378 | 2026-03-16 18:04:10.003444 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-16 18:04:10.439592 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.010066 2026-03-16 18:04:10.660844 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.009157 2026-03-16 18:04:10.729176 | 2026-03-16 18:04:10.729294 | PLAY [localhost] 2026-03-16 18:04:10.746831 | 2026-03-16 18:04:10.746969 | TASK [Run Zuul manifest role] 2026-03-16 18:04:10.766846 | localhost | ok 2026-03-16 18:04:10.784654 | 2026-03-16 18:04:10.784776 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-16 18:04:11.181540 | localhost | changed 2026-03-16 18:04:11.188524 | 2026-03-16 18:04:11.188615 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-16 18:04:11.220648 | localhost | ok 2026-03-16 18:04:11.233064 | 2026-03-16 18:04:11.233148 | TASK [Set zuul-log-path fact] 2026-03-16 18:04:11.254090 | localhost | ok 2026-03-16 18:04:11.274151 | 2026-03-16 18:04:11.274257 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-16 18:04:11.306568 | localhost | ok 2026-03-16 18:04:11.319220 | 2026-03-16 18:04:11.319367 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)] 2026-03-16 18:04:11.351860 | localhost | ok: 2026-03-16 18:04:11.352552 | localhost | { 2026-03-16 18:04:11.352580 | localhost | "auth": { 2026-03-16 18:04:11.352601 | localhost | "password": "IonWCwcuOFib&&<}wp^:[2G/", 2026-03-16 18:04:11.352618 | localhost | "username": "9LF91O0RK7JU" 2026-03-16 18:04:11.352635 | localhost | }, 2026-03-16 18:04:11.352651 | localhost | "profile": "rackspace", 2026-03-16 18:04:11.352667 | localhost | "region_name": "IAD" 2026-03-16 18:04:11.352682 | localhost | } 2026-03-16 18:04:11.352715 | localhost | changed: All items complete 2026-03-16 18:04:11.352754 | 2026-03-16 18:04:11.361496 | 2026-03-16 18:04:11.361594 | TASK [Run upload-logs-failover role (S3 then Swift)] 2026-03-16 18:04:11.383123 | localhost | Output suppressed because no_log was given 2026-03-16 18:04:11.402561 | 2026-03-16 18:04:11.402670 | TASK [upload-logs-failover : Initialize control vars] 2026-03-16 18:04:11.480622 | localhost | ok 2026-03-16 18:04:11.485037 | 2026-03-16 18:04:11.485103 | LOOP [upload-logs-failover : Perform log upload] 2026-03-16 18:04:11.522711 | localhost | Output suppressed because no_log was given 2026-03-16 18:04:11.532955 | localhost | included: /var/lib/zuul/builds/2650fceeb09449ca9e312131f93c599b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml 2026-03-16 18:04:11.542365 | 2026-03-16 18:04:11.542475 | LOOP [upload-logs-failover : Unpack vars for swift upload] 2026-03-16 18:04:11.641444 | localhost | Output suppressed because no_log was given 2026-03-16 18:04:11.655293 | 2026-03-16 18:04:11.655511 | TASK [Upload logs to swift] 2026-03-16 18:04:11.683651 | localhost | ok 2026-03-16 18:04:11.728948 | 2026-03-16 18:04:11.729104 | TASK [Set zuul-log-path fact] 2026-03-16 18:04:11.755010 | localhost | skipping: Conditional result was False 2026-03-16 18:04:11.762485 | 2026-03-16 18:04:11.762622 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2026-03-16 18:04:12.073004 | localhost -> localhost | ok: Runtime: 0:00:00.005776 2026-03-16 18:04:12.092239 | 2026-03-16 18:04:12.092526 | TASK [upload-logs-swift : Upload logs to swift]