2026-02-24 16:31:31.293099 | Job console starting... 2026-02-24 16:31:31.305704 | Updating repositories 2026-02-24 16:31:31.480438 | Preparing job workspace 2026-02-24 16:31:36.544769 | Running Ansible setup... 2026-02-24 16:31:41.182294 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-02-24 16:31:41.774094 | 2026-02-24 16:31:41.774222 | PLAY [localhost] 2026-02-24 16:31:41.782924 | 2026-02-24 16:31:41.783008 | TASK [Gathering Facts] 2026-02-24 16:31:42.797103 | localhost | ok 2026-02-24 16:31:42.827316 | 2026-02-24 16:31:42.827511 | TASK [Setup log path fact] 2026-02-24 16:31:42.852132 | localhost | ok 2026-02-24 16:31:42.874174 | 2026-02-24 16:31:42.874326 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-24 16:31:42.918666 | localhost | ok 2026-02-24 16:31:42.935615 | 2026-02-24 16:31:42.935736 | TASK [emit-job-header : Print job information] 2026-02-24 16:31:43.001439 | # Job Information 2026-02-24 16:31:43.001768 | Ansible Version: 2.15.12 2026-02-24 16:31:43.001853 | Job: ansible-test-sanity-okd-downstream-devel 2026-02-24 16:31:43.001903 | Pipeline: third-party-check 2026-02-24 16:31:43.001945 | Executor: ze04.softwarefactory-project.io 2026-02-24 16:31:43.001988 | Triggered by: https://github.com/openshift/community.okd/pull/272 2026-02-24 16:31:43.002038 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/281/ansible/28184c65b83c4716a54742bc49541b77/ 2026-02-24 16:31:43.002081 | Event ID: 6a484e90-119c-11f1-8e1a-045502fe7026 2026-02-24 16:31:43.014545 | 2026-02-24 16:31:43.014644 | LOOP [emit-job-header : Print node information] 2026-02-24 16:31:43.143182 | localhost | ok: 2026-02-24 16:31:43.143454 | localhost | # Node Information 2026-02-24 16:31:43.143481 | localhost | Inventory Hostname: controller 2026-02-24 16:31:43.143501 | localhost | Hostname: np0005628408 2026-02-24 16:31:43.143520 | localhost | Username: zuul 2026-02-24 16:31:43.143540 | localhost | Distro: Fedora 37 2026-02-24 16:31:43.143558 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2026-02-24 16:31:43.143575 | localhost | Region: ca-ymq-1 2026-02-24 16:31:43.143592 | localhost | Label: ansible-fedora-37-1vcpu 2026-02-24 16:31:43.143608 | localhost | Product Name: OpenStack Nova 2026-02-24 16:31:43.143626 | localhost | Interface IP: 199.204.45.222 2026-02-24 16:31:43.171766 | 2026-02-24 16:31:43.171988 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-24 16:31:43.580573 | localhost -> localhost | changed 2026-02-24 16:31:43.593034 | 2026-02-24 16:31:43.593187 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-24 16:31:44.512760 | localhost -> localhost | changed 2026-02-24 16:31:44.557233 | 2026-02-24 16:31:44.557368 | PLAY [all:!appliance*] 2026-02-24 16:31:44.590570 | 2026-02-24 16:31:44.590668 | TASK [include_role : start-zuul-console] 2026-02-24 16:31:44.617055 | controller | ok 2026-02-24 16:31:44.637198 | 2026-02-24 16:31:44.637293 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-02-24 16:31:45.032061 | controller | ok 2026-02-24 16:31:45.057031 | 2026-02-24 16:31:45.057186 | TASK [use-our-mirror : Retrieve the IP address] 2026-02-24 16:32:07.624094 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2026-02-24 16:32:07.638434 | 2026-02-24 16:32:07.638574 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2026-02-24 16:32:08.189590 | controller | skipping: Conditional result was False 2026-02-24 16:32:08.201547 | 2026-02-24 16:32:08.201762 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2026-02-24 16:32:08.237951 | controller | skipping: Conditional result was False 2026-02-24 16:32:08.247368 | 2026-02-24 16:32:08.247437 | TASK [use-our-mirror : Create the podman configuration directory] 2026-02-24 16:32:08.272737 | controller | skipping: Conditional result was False 2026-02-24 16:32:08.279816 | 2026-02-24 16:32:08.279898 | TASK [use-our-mirror : Copy the podman configuration] 2026-02-24 16:32:08.305619 | controller | skipping: Conditional result was False 2026-02-24 16:32:08.312763 | 2026-02-24 16:32:08.312833 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2026-02-24 16:32:08.338471 | controller | skipping: Conditional result was False 2026-02-24 16:32:08.344873 | 2026-02-24 16:32:08.344942 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2026-02-24 16:32:08.369521 | controller | skipping: Conditional result was False 2026-02-24 16:32:08.382171 | 2026-02-24 16:32:08.382241 | TASK [Disable Fedora Modular] 2026-02-24 16:32:08.776458 | controller | changed 2026-02-24 16:32:08.790113 | 2026-02-24 16:32:08.790248 | TASK [Enable EPEL] 2026-02-24 16:32:08.818946 | controller | skipping: Conditional result was False 2026-02-24 16:32:08.833848 | 2026-02-24 16:32:08.834009 | TASK [Register the RHEL node] 2026-02-24 16:32:09.400215 | 2026-02-24 16:32:09.400505 | TASK [Show the subscription-manager status] 2026-02-24 16:32:09.955911 | controller | skipping: Conditional result was False 2026-02-24 16:32:09.970600 | 2026-02-24 16:32:09.970826 | TASK [Enable EPEL on RHEL] 2026-02-24 16:32:10.539068 | controller | skipping: Conditional result was False 2026-02-24 16:32:10.552270 | 2026-02-24 16:32:10.552407 | TASK [Install git and tox] 2026-02-24 16:32:52.365377 | controller | changed 2026-02-24 16:32:52.379072 | 2026-02-24 16:32:52.379203 | TASK [include_role : prepare-workspace] 2026-02-24 16:32:52.420231 | controller | ok 2026-02-24 16:32:52.456664 | 2026-02-24 16:32:52.456795 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-02-24 16:32:52.709386 | controller | ok 2026-02-24 16:32:52.723117 | 2026-02-24 16:32:52.723281 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-02-24 16:33:06.582647 | controller | Output suppressed because no_log was given 2026-02-24 16:33:06.625606 | 2026-02-24 16:33:06.625762 | TASK [include_role : prepare-workspace-openshift] 2026-02-24 16:33:06.660796 | controller | skipping: Conditional result was False 2026-02-24 16:33:06.684042 | 2026-02-24 16:33:06.684103 | PLAY [all:!appliance] 2026-02-24 16:33:06.700708 | 2026-02-24 16:33:06.700772 | TASK [Run add-build-sshkey role (RSA)] 2026-02-24 16:33:06.731533 | controller | ok 2026-02-24 16:33:06.746388 | 2026-02-24 16:33:06.746456 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-24 16:33:07.026611 | controller -> localhost | ok 2026-02-24 16:33:07.035177 | 2026-02-24 16:33:07.035256 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-24 16:33:07.068369 | controller | ok 2026-02-24 16:33:07.084248 | controller | included: /var/lib/zuul/builds/28184c65b83c4716a54742bc49541b77/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-24 16:33:07.090395 | 2026-02-24 16:33:07.090464 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-24 16:33:07.563892 | controller -> localhost | Generating public/private rsa key pair. 2026-02-24 16:33:07.564148 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/28184c65b83c4716a54742bc49541b77/work/28184c65b83c4716a54742bc49541b77_id_rsa. 2026-02-24 16:33:07.564178 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/28184c65b83c4716a54742bc49541b77/work/28184c65b83c4716a54742bc49541b77_id_rsa.pub. 2026-02-24 16:33:07.564199 | controller -> localhost | The key fingerprint is: 2026-02-24 16:33:07.564218 | controller -> localhost | SHA256:wmQpYS+59U5zpevWI4BGlYLgaPMVSqWnM2oXOdhA3o4 zuul-build-sshkey 2026-02-24 16:33:07.564237 | controller -> localhost | The key's randomart image is: 2026-02-24 16:33:07.564255 | controller -> localhost | +---[RSA 2048]----+ 2026-02-24 16:33:07.564273 | controller -> localhost | | ..o++ . | 2026-02-24 16:33:07.564291 | controller -> localhost | |ooo.++o.o | 2026-02-24 16:33:07.564309 | controller -> localhost | |.=.++o*o . | 2026-02-24 16:33:07.564326 | controller -> localhost | |. O =O.. o | 2026-02-24 16:33:07.564342 | controller -> localhost | | E @..o.S o | 2026-02-24 16:33:07.564370 | controller -> localhost | | . = o+.o . | 2026-02-24 16:33:07.564395 | controller -> localhost | | o . . .... | 2026-02-24 16:33:07.564416 | controller -> localhost | |. . .o o | 2026-02-24 16:33:07.564434 | controller -> localhost | | ... . | 2026-02-24 16:33:07.564454 | controller -> localhost | +----[SHA256]-----+ 2026-02-24 16:33:07.564511 | controller -> localhost | ok: Runtime: 0:00:00.123826 2026-02-24 16:33:07.572995 | 2026-02-24 16:33:07.573194 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-24 16:33:07.604622 | controller | ok 2026-02-24 16:33:07.615313 | controller | included: /var/lib/zuul/builds/28184c65b83c4716a54742bc49541b77/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-24 16:33:07.625166 | 2026-02-24 16:33:07.625251 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-24 16:33:07.650097 | controller | skipping: Conditional result was False 2026-02-24 16:33:07.657393 | 2026-02-24 16:33:07.657490 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-24 16:33:08.090950 | controller | changed 2026-02-24 16:33:08.097705 | 2026-02-24 16:33:08.097798 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-24 16:33:08.322855 | controller | ok 2026-02-24 16:33:08.329290 | 2026-02-24 16:33:08.329382 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-24 16:33:09.001066 | controller | changed 2026-02-24 16:33:09.016467 | 2026-02-24 16:33:09.016623 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-24 16:33:09.680036 | controller | changed 2026-02-24 16:33:09.693994 | 2026-02-24 16:33:09.694140 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-24 16:33:09.721527 | controller | skipping: Conditional result was False 2026-02-24 16:33:09.739309 | 2026-02-24 16:33:09.739513 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-24 16:33:10.210767 | controller -> localhost | changed 2026-02-24 16:33:10.235788 | 2026-02-24 16:33:10.235960 | TASK [add-build-sshkey : Add back temp key] 2026-02-24 16:33:10.516939 | controller -> localhost | Identity added: /var/lib/zuul/builds/28184c65b83c4716a54742bc49541b77/work/28184c65b83c4716a54742bc49541b77_id_rsa (zuul-build-sshkey) 2026-02-24 16:33:10.517209 | controller -> localhost | ok: Runtime: 0:00:00.014223 2026-02-24 16:33:10.526382 | 2026-02-24 16:33:10.526484 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-24 16:33:10.911015 | controller | ok 2026-02-24 16:33:10.924138 | 2026-02-24 16:33:10.924283 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-24 16:33:10.972757 | controller | skipping: Conditional result was False 2026-02-24 16:33:11.001169 | 2026-02-24 16:33:11.001332 | TASK [Run add-build-sshkey role (ECDSA)] 2026-02-24 16:33:11.038487 | controller | ok 2026-02-24 16:33:11.061436 | 2026-02-24 16:33:11.061528 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-24 16:33:11.352427 | controller -> localhost | ok 2026-02-24 16:33:11.362282 | 2026-02-24 16:33:11.362379 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-24 16:33:11.399298 | controller | ok 2026-02-24 16:33:11.414553 | controller | included: /var/lib/zuul/builds/28184c65b83c4716a54742bc49541b77/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-24 16:33:11.423214 | 2026-02-24 16:33:11.423300 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-24 16:33:11.755273 | controller -> localhost | Generating public/private ecdsa key pair. 2026-02-24 16:33:11.755500 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/28184c65b83c4716a54742bc49541b77/work/28184c65b83c4716a54742bc49541b77_id_ecdsa. 2026-02-24 16:33:11.755557 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/28184c65b83c4716a54742bc49541b77/work/28184c65b83c4716a54742bc49541b77_id_ecdsa.pub. 2026-02-24 16:33:11.755597 | controller -> localhost | The key fingerprint is: 2026-02-24 16:33:11.755624 | controller -> localhost | SHA256:pY83pYZPy5Gw3Vx2mZ/G7AKO7luNI1RIJfS292hkCkw zuul-build-sshkey 2026-02-24 16:33:11.755650 | controller -> localhost | The key's randomart image is: 2026-02-24 16:33:11.755693 | controller -> localhost | +---[ECDSA 521]---+ 2026-02-24 16:33:11.755726 | controller -> localhost | | .+.. | 2026-02-24 16:33:11.755752 | controller -> localhost | | . + | 2026-02-24 16:33:11.755776 | controller -> localhost | | E.+ | 2026-02-24 16:33:11.755799 | controller -> localhost | | ooo . o| 2026-02-24 16:33:11.755823 | controller -> localhost | | S+ ..+oo.| 2026-02-24 16:33:11.755846 | controller -> localhost | | .B.BBo=.o| 2026-02-24 16:33:11.755870 | controller -> localhost | | +.&=++ *.| 2026-02-24 16:33:11.755893 | controller -> localhost | | Bo=o.o | 2026-02-24 16:33:11.755916 | controller -> localhost | | o+= .. | 2026-02-24 16:33:11.755940 | controller -> localhost | +----[SHA256]-----+ 2026-02-24 16:33:11.756020 | controller -> localhost | ok: Runtime: 0:00:00.010930 2026-02-24 16:33:11.765300 | 2026-02-24 16:33:11.765387 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-24 16:33:11.798944 | controller | ok 2026-02-24 16:33:11.810358 | controller | included: /var/lib/zuul/builds/28184c65b83c4716a54742bc49541b77/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-24 16:33:11.822868 | 2026-02-24 16:33:11.823538 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-24 16:33:11.851002 | controller | skipping: Conditional result was False 2026-02-24 16:33:11.860337 | 2026-02-24 16:33:11.860618 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-24 16:33:12.127703 | controller | changed 2026-02-24 16:33:12.136207 | 2026-02-24 16:33:12.136298 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-24 16:33:12.363300 | controller | ok 2026-02-24 16:33:12.375956 | 2026-02-24 16:33:12.376149 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-24 16:33:13.001283 | controller | changed 2026-02-24 16:33:13.009753 | 2026-02-24 16:33:13.009854 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-24 16:33:13.630659 | controller | changed 2026-02-24 16:33:13.687100 | 2026-02-24 16:33:13.687271 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-24 16:33:13.714596 | controller | skipping: Conditional result was False 2026-02-24 16:33:13.724856 | 2026-02-24 16:33:13.724972 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-24 16:33:14.014242 | controller -> localhost | changed 2026-02-24 16:33:14.031122 | 2026-02-24 16:33:14.031209 | TASK [add-build-sshkey : Add back temp key] 2026-02-24 16:33:14.340811 | controller -> localhost | Identity added: /var/lib/zuul/builds/28184c65b83c4716a54742bc49541b77/work/28184c65b83c4716a54742bc49541b77_id_ecdsa (zuul-build-sshkey) 2026-02-24 16:33:14.341113 | controller -> localhost | ok: Runtime: 0:00:00.013652 2026-02-24 16:33:14.348358 | 2026-02-24 16:33:14.348432 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-24 16:33:14.553412 | controller | ok 2026-02-24 16:33:14.559021 | 2026-02-24 16:33:14.559095 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-24 16:33:14.594402 | controller | skipping: Conditional result was False 2026-02-24 16:33:14.606424 | 2026-02-24 16:33:14.606521 | TASK [include_role : remove-zuul-sshkey] 2026-02-24 16:33:14.631615 | controller | skipping: Conditional result was False 2026-02-24 16:33:14.638881 | 2026-02-24 16:33:14.638958 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-02-24 16:33:14.868140 | controller | ok: "logs" 2026-02-24 16:33:14.868418 | controller | ok: All items complete 2026-02-24 16:33:14.868447 | 2026-02-24 16:33:15.064968 | controller | ok: "artifacts" 2026-02-24 16:33:15.251182 | controller | ok: "docs" 2026-02-24 16:33:15.261885 | 2026-02-24 16:33:15.261988 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-02-24 16:33:15.508149 | controller | changed: "logs" 2026-02-24 16:33:15.700875 | controller | changed: "artifacts" 2026-02-24 16:33:15.898820 | controller | changed: "docs" 2026-02-24 16:33:15.956898 | 2026-02-24 16:33:15.957031 | PLAY RECAP 2026-02-24 16:33:15.957091 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2026-02-24 16:33:15.957127 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-24 16:33:15.957151 | 2026-02-24 16:33:16.093370 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-02-24 16:33:16.094713 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-24 16:33:16.647378 | 2026-02-24 16:33:16.647524 | PLAY [all] 2026-02-24 16:33:16.670094 | 2026-02-24 16:33:16.670212 | TASK [Install binary dependencies] 2026-02-24 16:33:16.744851 | controller | ok 2026-02-24 16:33:16.775273 | 2026-02-24 16:33:16.775433 | TASK [bindep : Include find tasks] 2026-02-24 16:33:16.809353 | controller | ok 2026-02-24 16:33:16.820879 | controller | included: /var/lib/zuul/builds/28184c65b83c4716a54742bc49541b77/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-02-24 16:33:16.829941 | 2026-02-24 16:33:16.830030 | TASK [bindep : Look for bindep.txt] 2026-02-24 16:33:17.163920 | controller | ok 2026-02-24 16:33:17.177430 | 2026-02-24 16:33:17.177615 | TASK [bindep : Define bindep_file fact] 2026-02-24 16:33:17.195530 | controller | skipping: Conditional result was False 2026-02-24 16:33:17.209300 | 2026-02-24 16:33:17.209489 | TASK [bindep : Look for other-requirements.txt] 2026-02-24 16:33:17.434752 | controller | ok 2026-02-24 16:33:17.447474 | 2026-02-24 16:33:17.447793 | TASK [bindep : Define bindep_file fact] 2026-02-24 16:33:17.476898 | controller | skipping: Conditional result was False 2026-02-24 16:33:17.490238 | 2026-02-24 16:33:17.490434 | TASK [bindep : Look for bindep fallback file] 2026-02-24 16:33:17.518541 | controller | skipping: Conditional result was False 2026-02-24 16:33:17.533184 | 2026-02-24 16:33:17.533384 | TASK [bindep : Define bindep_file fact] 2026-02-24 16:33:17.560889 | controller | skipping: Conditional result was False 2026-02-24 16:33:17.574279 | 2026-02-24 16:33:17.574479 | TASK [bindep : Include bindep tasks] 2026-02-24 16:33:17.603081 | controller | skipping: Conditional result was False 2026-02-24 16:33:17.618337 | 2026-02-24 16:33:17.618489 | TASK [bindep : Include install tasks] 2026-02-24 16:33:17.656922 | controller | skipping: Conditional result was False 2026-02-24 16:33:17.672336 | 2026-02-24 16:33:17.672533 | LOOP [bindep : Include package tasks] 2026-02-24 16:33:17.756784 | 2026-02-24 16:33:17.757192 | TASK [Run test-setup role] 2026-02-24 16:33:17.790579 | controller | ok 2026-02-24 16:33:17.818830 | 2026-02-24 16:33:17.818933 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-02-24 16:33:18.035650 | controller | ok 2026-02-24 16:33:18.044067 | 2026-02-24 16:33:18.044149 | TASK [test-setup : Run tools/test-setup.sh] 2026-02-24 16:33:18.585659 | controller | skipping: Conditional result was False 2026-02-24 16:33:18.613978 | 2026-02-24 16:33:18.614056 | PLAY RECAP 2026-02-24 16:33:18.614098 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-24 16:33:18.614118 | 2026-02-24 16:33:18.745888 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-24 16:33:18.748818 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-02-24 16:33:19.338416 | 2026-02-24 16:33:19.338552 | PLAY [controller] 2026-02-24 16:33:19.359169 | 2026-02-24 16:33:19.359251 | TASK [Create the /root directory] 2026-02-24 16:33:19.732810 | controller | ok 2026-02-24 16:33:19.744011 | 2026-02-24 16:33:19.744147 | TASK [Install glibc-langpack-en] 2026-02-24 16:33:23.676522 | controller | ok: Nothing to do 2026-02-24 16:33:23.691479 | 2026-02-24 16:33:23.691580 | TASK [Ensure controller directory exists] 2026-02-24 16:33:23.912456 | controller | changed 2026-02-24 16:33:23.924017 | 2026-02-24 16:33:23.924125 | TASK [Install container runtime] 2026-02-24 16:33:24.033118 | controller | ok 2026-02-24 16:33:24.092607 | 2026-02-24 16:33:24.093221 | LOOP [ensure-podman : Find distribution installation] 2026-02-24 16:33:24.135020 | controller | ok: "/var/lib/zuul/builds/28184c65b83c4716a54742bc49541b77/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml" 2026-02-24 16:33:24.151290 | controller | included: /var/lib/zuul/builds/28184c65b83c4716a54742bc49541b77/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml 2026-02-24 16:33:24.161985 | 2026-02-24 16:33:24.162081 | TASK [ensure-podman : Install podman (RedHat)] 2026-02-24 16:34:28.668943 | controller | changed 2026-02-24 16:34:28.682447 | 2026-02-24 16:34:28.682590 | TASK [ensure-podman : Fetch podman version] 2026-02-24 16:34:29.259667 | controller | Client: Podman Engine 2026-02-24 16:34:29.288764 | controller | Version: 4.6.2 2026-02-24 16:34:29.288791 | controller | API Version: 4.6.2 2026-02-24 16:34:29.288799 | controller | Go Version: go1.19.12 2026-02-24 16:34:29.288939 | controller | Built: Mon Aug 28 19:38:31 2023 2026-02-24 16:34:29.288950 | controller | OS/Arch: linux/amd64 2026-02-24 16:34:29.730274 | controller | ok: Runtime: 0:00:00.198316 2026-02-24 16:34:29.744621 | 2026-02-24 16:34:29.744822 | TASK [ensure-podman : Print podman version installed] 2026-02-24 16:34:29.795596 | Podman version: Client: Podman Engine 2026-02-24 16:34:29.795942 | Version: 4.6.2 2026-02-24 16:34:29.796009 | API Version: 4.6.2 2026-02-24 16:34:29.796055 | Go Version: go1.19.12 2026-02-24 16:34:29.796096 | Built: Mon Aug 28 19:38:31 2023 2026-02-24 16:34:29.796142 | OS/Arch: linux/amd64 2026-02-24 16:34:29.809995 | 2026-02-24 16:34:29.810135 | TASK [ensure-podman : Validate podman engine] 2026-02-24 16:34:30.357187 | controller | skipping: Conditional result was False 2026-02-24 16:34:30.372326 | 2026-02-24 16:34:30.372498 | TASK [ensure-podman : Set up docker compatability socket] 2026-02-24 16:34:30.390246 | controller | skipping: Conditional result was False 2026-02-24 16:34:30.415224 | 2026-02-24 16:34:30.415397 | TASK [Ensure python3.8 is present] 2026-02-24 16:34:30.432661 | controller | skipping: Conditional result was False 2026-02-24 16:34:30.445736 | 2026-02-24 16:34:30.445875 | TASK [Run our-ensure-python role (Fedora only for now)] 2026-02-24 16:34:30.476309 | controller | ok 2026-02-24 16:34:30.505791 | 2026-02-24 16:34:30.505891 | TASK [our-ensure-python : Install the right Python version (rpm)] 2026-02-24 16:34:31.865007 | controller | ok: Nothing to do 2026-02-24 16:34:31.879964 | 2026-02-24 16:34:31.880156 | TASK [our-ensure-python : Also install python3-devel] 2026-02-24 16:34:40.901363 | controller | changed 2026-02-24 16:34:40.926108 | 2026-02-24 16:34:40.926240 | TASK [Run ensure-virtualenv role] 2026-02-24 16:34:40.956282 | controller | ok 2026-02-24 16:34:40.992861 | 2026-02-24 16:34:40.992961 | TASK [ensure-virtualenv : Check if virtualenv is installed] 2026-02-24 16:34:41.256757 | controller | /usr/bin/virtualenv 2026-02-24 16:34:41.564496 | controller | ok: Runtime: 0:00:00.006575 2026-02-24 16:34:41.577636 | 2026-02-24 16:34:41.577838 | LOOP [ensure-virtualenv : Install virtualenv package] 2026-02-24 16:34:41.614995 | controller | skipping: Conditional result was False 2026-02-24 16:34:41.615471 | controller | ok: All items complete 2026-02-24 16:34:41.615531 | 2026-02-24 16:34:41.651488 | 2026-02-24 16:34:41.651708 | TASK [Find the full path of the Python interpreter] 2026-02-24 16:34:41.890475 | controller | /usr/bin/python3 2026-02-24 16:34:42.202401 | controller | ok 2026-02-24 16:34:42.215975 | 2026-02-24 16:34:42.216120 | TASK [Create virtualenv for ansible-test with a specific interpreter] 2026-02-24 16:34:43.201211 | controller | created virtual environment CPython3.11.0.final.0-64 in 550ms 2026-02-24 16:34:43.225702 | controller | creator CPython3Posix(dest=/home/zuul/venv, clear=False, no_vcs_ignore=False, global=False) 2026-02-24 16:34:43.225718 | 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-24 16:34:43.225728 | controller | added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1 2026-02-24 16:34:43.225740 | controller | activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator 2026-02-24 16:34:43.278157 | controller | changed 2026-02-24 16:34:43.292426 | 2026-02-24 16:34:43.292569 | TASK [Set selinux package] 2026-02-24 16:34:43.334373 | controller | ok 2026-02-24 16:34:43.347398 | 2026-02-24 16:34:43.347529 | TASK [Set selinux package (Fedora)] 2026-02-24 16:34:43.393231 | controller | ok 2026-02-24 16:34:43.400778 | 2026-02-24 16:34:43.400860 | TASK [Install selinux into virtualenv] 2026-02-24 16:34:56.952453 | controller | Collecting selinux-please-lie-to-me 2026-02-24 16:35:09.212453 | controller | Downloading selinux_please_lie_to_me-1.0.1-py2.py3-none-any.whl (3.8 kB) 2026-02-24 16:35:09.516302 | controller | Collecting setuptools<50.0.0 2026-02-24 16:35:09.520640 | controller | Downloading setuptools-49.6.0-py3-none-any.whl (803 kB) 2026-02-24 16:35:09.565678 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 803.3/803.3 kB 19.3 MB/s eta 0:00:00 2026-02-24 16:35:09.645281 | controller | Installing collected packages: setuptools, selinux-please-lie-to-me 2026-02-24 16:35:09.645491 | controller | Attempting uninstall: setuptools 2026-02-24 16:35:09.647874 | controller | Found existing installation: setuptools 62.6.0 2026-02-24 16:35:09.707296 | controller | Uninstalling setuptools-62.6.0: 2026-02-24 16:35:09.715158 | controller | Successfully uninstalled setuptools-62.6.0 2026-02-24 16:35:10.078602 | controller | Successfully installed selinux-please-lie-to-me-1.0.1 setuptools-49.6.0 2026-02-24 16:35:21.590426 | controller | 2026-02-24 16:35:21.667998 | controller | [notice] A new release of pip available: 22.2.2 -> 26.0.1 2026-02-24 16:35:21.668044 | controller | [notice] To update, run: python -m pip install --upgrade pip 2026-02-24 16:35:21.971824 | controller | ok: Runtime: 0:00:38.031276 2026-02-24 16:35:21.984181 | 2026-02-24 16:35:21.984307 | TASK [Install pytest-forked into virtualenv] 2026-02-24 16:35:33.833394 | controller | Collecting pytest-forked 2026-02-24 16:35:44.091898 | controller | Downloading pytest_forked-1.6.0-py3-none-any.whl (4.9 kB) 2026-02-24 16:35:44.135743 | controller | Collecting py 2026-02-24 16:35:44.138919 | controller | Downloading py-1.11.0-py2.py3-none-any.whl (98 kB) 2026-02-24 16:35:44.165517 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.7/98.7 kB 4.0 MB/s eta 0:00:00 2026-02-24 16:35:44.269999 | controller | Collecting pytest>=3.10 2026-02-24 16:35:44.274014 | controller | Downloading pytest-9.0.2-py3-none-any.whl (374 kB) 2026-02-24 16:35:44.293018 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 374.8/374.8 kB 22.9 MB/s eta 0:00:00 2026-02-24 16:35:44.334055 | controller | Collecting iniconfig>=1.0.1 2026-02-24 16:35:44.337469 | controller | Downloading iniconfig-2.3.0-py3-none-any.whl (7.5 kB) 2026-02-24 16:35:44.396168 | controller | Collecting packaging>=22 2026-02-24 16:35:44.400093 | controller | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-02-24 16:35:44.408257 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 11.6 MB/s eta 0:00:00 2026-02-24 16:35:44.441254 | controller | Collecting pluggy<2,>=1.5 2026-02-24 16:35:44.444579 | controller | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-02-24 16:35:44.494771 | controller | Collecting pygments>=2.7.2 2026-02-24 16:35:44.497972 | controller | Downloading pygments-2.19.2-py3-none-any.whl (1.2 MB) 2026-02-24 16:35:44.521085 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.2/1.2 MB 59.1 MB/s eta 0:00:00 2026-02-24 16:35:44.597814 | controller | Installing collected packages: pygments, py, pluggy, packaging, iniconfig, pytest, pytest-forked 2026-02-24 16:35:45.639916 | 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-24 16:35:45.648769 | controller | 2026-02-24 16:35:45.716681 | controller | [notice] A new release of pip available: 22.2.2 -> 26.0.1 2026-02-24 16:35:45.716722 | controller | [notice] To update, run: python -m pip install --upgrade pip 2026-02-24 16:35:46.051099 | controller | ok: Runtime: 0:00:23.490811 2026-02-24 16:35:46.065592 | 2026-02-24 16:35:46.065773 | TASK [Update pip] 2026-02-24 16:35:46.599202 | controller | Requirement already satisfied: pip in ./venv/lib/python3.11/site-packages (22.2.2) 2026-02-24 16:35:56.469913 | controller | Collecting pip 2026-02-24 16:36:08.794707 | controller | Downloading pip-26.0.1-py3-none-any.whl (1.8 MB) 2026-02-24 16:36:08.844732 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.8/1.8 MB 38.7 MB/s eta 0:00:00 2026-02-24 16:36:08.908367 | controller | Installing collected packages: pip 2026-02-24 16:36:08.908579 | controller | Attempting uninstall: pip 2026-02-24 16:36:08.910876 | controller | Found existing installation: pip 22.2.2 2026-02-24 16:36:09.048575 | controller | Uninstalling pip-22.2.2: 2026-02-24 16:36:09.063480 | controller | Successfully uninstalled pip-22.2.2 2026-02-24 16:36:09.860769 | controller | Successfully installed pip-26.0.1 2026-02-24 16:36:10.135412 | controller | ok: Runtime: 0:00:23.631881 2026-02-24 16:36:10.144812 | 2026-02-24 16:36:10.144904 | TASK [Ensure pip temp directory exists in /var/tmp] 2026-02-24 16:36:10.360639 | controller | changed 2026-02-24 16:36:10.374563 | 2026-02-24 16:36:10.374738 | TASK [Install ansible into virtualenv] 2026-02-24 16:36:10.879890 | controller | Processing ./src/github.com/ansible/ansible 2026-02-24 16:36:10.882288 | controller | Installing build dependencies: started 2026-02-24 16:36:36.102984 | controller | Installing build dependencies: finished with status 'done' 2026-02-24 16:36:36.103674 | controller | Getting requirements to build wheel: started 2026-02-24 16:36:36.852191 | controller | Getting requirements to build wheel: finished with status 'done' 2026-02-24 16:36:36.853061 | controller | Preparing metadata (pyproject.toml): started 2026-02-24 16:36:37.317668 | controller | Preparing metadata (pyproject.toml): finished with status 'done' 2026-02-24 16:36:37.322418 | 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-24 16:36:37.327337 | controller | ERROR: Package 'ansible-core' requires a different Python: 3.11.0 not in '>=3.12' 2026-02-24 16:36:37.438122 | controller | ERROR 2026-02-24 16:36:37.438415 | controller | { 2026-02-24 16:36:37.438479 | controller | "delta": "0:00:26.784062", 2026-02-24 16:36:37.438522 | controller | "end": "2026-02-24 16:36:37.388728", 2026-02-24 16:36:37.438560 | controller | "msg": "non-zero return code", 2026-02-24 16:36:37.438611 | controller | "rc": 1, 2026-02-24 16:36:37.438649 | controller | "start": "2026-02-24 16:36:10.604666" 2026-02-24 16:36:37.438722 | controller | } failure 2026-02-24 16:36:37.441311 | 2026-02-24 16:36:37.441408 | PLAY RECAP 2026-02-24 16:36:37.441622 | controller | ok: 18 changed: 10 unreachable: 0 failed: 1 skipped: 4 rescued: 0 ignored: 0 2026-02-24 16:36:37.441720 | 2026-02-24 16:36:37.588238 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-02-24 16:36:37.589202 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-24 16:36:38.197205 | 2026-02-24 16:36:38.197368 | PLAY [all] 2026-02-24 16:36:38.218849 | 2026-02-24 16:36:38.218929 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-02-24 16:36:38.468288 | controller | changed: non-zero return code 2026-02-24 16:36:38.480746 | 2026-02-24 16:36:38.480901 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-02-24 16:36:38.508250 | controller | skipping: Conditional result was False 2026-02-24 16:36:38.520799 | 2026-02-24 16:36:38.520941 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-02-24 16:36:38.561955 | 2026-02-24 16:36:38.562221 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-02-24 16:36:38.602233 | 2026-02-24 16:36:38.602472 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-02-24 16:36:38.629333 | controller | skipping: Conditional result was False 2026-02-24 16:36:38.644127 | 2026-02-24 16:36:38.644265 | LOOP [fetch-subunit-output : Generate subunit file] 2026-02-24 16:36:38.684214 | 2026-02-24 16:36:38.684461 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-02-24 16:36:38.712981 | controller | skipping: Conditional result was False 2026-02-24 16:36:38.726351 | 2026-02-24 16:36:38.726490 | TASK [fetch-subunit-output : Remove the temporary file] 2026-02-24 16:36:38.753269 | controller | skipping: Conditional result was False 2026-02-24 16:36:38.766131 | 2026-02-24 16:36:38.766262 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-02-24 16:36:38.793037 | controller | skipping: Conditional result was False 2026-02-24 16:36:38.840419 | 2026-02-24 16:36:38.840502 | PLAY RECAP 2026-02-24 16:36:38.840560 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-24 16:36:38.840595 | 2026-02-24 16:36:38.937112 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-24 16:36:38.938802 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2026-02-24 16:36:39.523644 | 2026-02-24 16:36:39.523800 | PLAY [all:!appliance*] 2026-02-24 16:36:39.544913 | 2026-02-24 16:36:39.545009 | TASK [unregister the node] 2026-02-24 16:36:40.075636 | controller | skipping: Conditional result was False 2026-02-24 16:36:40.084221 | 2026-02-24 16:36:40.084333 | TASK [include_role : fetch-output] 2026-02-24 16:36:40.127065 | controller | ok 2026-02-24 16:36:40.153047 | 2026-02-24 16:36:40.153140 | TASK [fetch-output : Set log path for multiple nodes] 2026-02-24 16:36:40.219415 | controller | skipping: Conditional result was False 2026-02-24 16:36:40.234851 | 2026-02-24 16:36:40.235023 | TASK [fetch-output : Set log path for single node] 2026-02-24 16:36:40.284956 | controller | ok 2026-02-24 16:36:40.294463 | 2026-02-24 16:36:40.294554 | LOOP [fetch-output : Ensure local output dirs] 2026-02-24 16:36:40.774122 | controller -> localhost | ok: "/var/lib/zuul/builds/28184c65b83c4716a54742bc49541b77/work/logs" 2026-02-24 16:36:41.015873 | controller -> localhost | changed: "/var/lib/zuul/builds/28184c65b83c4716a54742bc49541b77/work/artifacts" 2026-02-24 16:36:41.222357 | controller -> localhost | changed: "/var/lib/zuul/builds/28184c65b83c4716a54742bc49541b77/work/docs" 2026-02-24 16:36:41.236499 | 2026-02-24 16:36:41.236650 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-24 16:36:41.847970 | controller | changed: 2026-02-24 16:36:41.848715 | controller | .d..t...... ./ 2026-02-24 16:36:41.848802 | controller | cd+++++++++ controller/ 2026-02-24 16:36:41.848898 | controller | changed: All items complete 2026-02-24 16:36:41.848975 | 2026-02-24 16:36:42.400425 | controller | changed: .d..t...... ./ 2026-02-24 16:36:42.955100 | controller | changed: .d..t...... ./ 2026-02-24 16:36:42.985353 | 2026-02-24 16:36:42.985561 | TASK [include_role : fetch-output-openshift] 2026-02-24 16:36:43.013286 | controller | skipping: Conditional result was False 2026-02-24 16:36:43.027027 | 2026-02-24 16:36:43.027164 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-02-24 16:36:43.528802 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.013897 2026-02-24 16:36:43.836574 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.014257 2026-02-24 16:36:43.892798 | 2026-02-24 16:36:43.892916 | PLAY [localhost] 2026-02-24 16:36:43.909873 | 2026-02-24 16:36:43.909956 | TASK [Run Zuul manifest role] 2026-02-24 16:36:43.930007 | localhost | ok 2026-02-24 16:36:43.946789 | 2026-02-24 16:36:43.946887 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-24 16:36:44.398919 | localhost | changed 2026-02-24 16:36:44.409440 | 2026-02-24 16:36:44.409572 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-24 16:36:44.456193 | localhost | ok 2026-02-24 16:36:44.474991 | 2026-02-24 16:36:44.475116 | TASK [Set zuul-log-path fact] 2026-02-24 16:36:44.502272 | localhost | ok 2026-02-24 16:36:44.531669 | 2026-02-24 16:36:44.531846 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-24 16:36:44.574974 | localhost | ok 2026-02-24 16:36:44.586190 | 2026-02-24 16:36:44.586267 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)] 2026-02-24 16:36:44.630451 | localhost | ok: 2026-02-24 16:36:44.630772 | localhost | { 2026-02-24 16:36:44.630834 | localhost | "auth": { 2026-02-24 16:36:44.630884 | localhost | "password": "IonWCwcuOFib&&<}wp^:[2G/", 2026-02-24 16:36:44.630928 | localhost | "username": "9LF91O0RK7JU" 2026-02-24 16:36:44.630969 | localhost | }, 2026-02-24 16:36:44.631008 | localhost | "profile": "rackspace", 2026-02-24 16:36:44.631046 | localhost | "region_name": "ORD" 2026-02-24 16:36:44.631085 | localhost | } 2026-02-24 16:36:44.631143 | localhost | changed: All items complete 2026-02-24 16:36:44.631187 | 2026-02-24 16:36:44.638303 | 2026-02-24 16:36:44.638387 | TASK [Run upload-logs-failover role (S3 then Swift)] 2026-02-24 16:36:44.660088 | localhost | Output suppressed because no_log was given 2026-02-24 16:36:44.708615 | 2026-02-24 16:36:44.708749 | TASK [upload-logs-failover : Initialize control vars] 2026-02-24 16:36:44.738058 | localhost | ok 2026-02-24 16:36:44.742253 | 2026-02-24 16:36:44.742381 | LOOP [upload-logs-failover : Perform log upload] 2026-02-24 16:36:44.788555 | localhost | Output suppressed because no_log was given 2026-02-24 16:36:44.795487 | localhost | included: /var/lib/zuul/builds/28184c65b83c4716a54742bc49541b77/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml 2026-02-24 16:36:44.802027 | 2026-02-24 16:36:44.802094 | LOOP [upload-logs-failover : Unpack vars for swift upload] 2026-02-24 16:36:44.922565 | localhost | Output suppressed because no_log was given 2026-02-24 16:36:44.929343 | 2026-02-24 16:36:44.929416 | TASK [Upload logs to swift] 2026-02-24 16:36:44.963731 | localhost | ok 2026-02-24 16:36:45.004412 | 2026-02-24 16:36:45.004530 | TASK [Set zuul-log-path fact] 2026-02-24 16:36:45.040345 | localhost | skipping: Conditional result was False 2026-02-24 16:36:45.047381 | 2026-02-24 16:36:45.047469 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2026-02-24 16:36:45.379547 | localhost -> localhost | ok: Runtime: 0:00:00.008388 2026-02-24 16:36:45.391975 | 2026-02-24 16:36:45.392131 | TASK [upload-logs-swift : Upload logs to swift]