2026-02-25 00:14:39.373757 | Job console starting... 2026-02-25 00:14:39.384392 | Updating repositories 2026-02-25 00:14:39.497312 | Preparing job workspace 2026-02-25 00:14:43.467737 | Running Ansible setup... 2026-02-25 00:14:48.573629 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-02-25 00:14:49.388774 | 2026-02-25 00:14:49.388905 | PLAY [localhost] 2026-02-25 00:14:49.398629 | 2026-02-25 00:14:49.398775 | TASK [Gathering Facts] 2026-02-25 00:14:50.456113 | localhost | ok 2026-02-25 00:14:50.469604 | 2026-02-25 00:14:50.469756 | TASK [Setup log path fact] 2026-02-25 00:14:50.488784 | localhost | ok 2026-02-25 00:14:50.502253 | 2026-02-25 00:14:50.502340 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-25 00:14:50.530657 | localhost | ok 2026-02-25 00:14:50.538880 | 2026-02-25 00:14:50.538998 | TASK [emit-job-header : Print job information] 2026-02-25 00:14:50.589850 | # Job Information 2026-02-25 00:14:50.590049 | Ansible Version: 2.15.12 2026-02-25 00:14:50.590111 | Job: ansible-test-sanity-docker-devel 2026-02-25 00:14:50.590157 | Pipeline: periodic 2026-02-25 00:14:50.590197 | Executor: ze03.softwarefactory-project.io 2026-02-25 00:14:50.590238 | Triggered by: https://github.com/ansible-collections/ansible.network 2026-02-25 00:14:50.590284 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/68b/ansible/68b1e1a8fbba4d658204f14bf365030d/ 2026-02-25 00:14:50.590328 | Event ID: 79c881336d75451aa1b30c2394aae9ec 2026-02-25 00:14:50.596164 | 2026-02-25 00:14:50.596282 | LOOP [emit-job-header : Print node information] 2026-02-25 00:14:50.725185 | localhost | ok: 2026-02-25 00:14:50.725361 | localhost | # Node Information 2026-02-25 00:14:50.725397 | localhost | Inventory Hostname: controller 2026-02-25 00:14:50.725420 | localhost | Hostname: np0005628855 2026-02-25 00:14:50.725443 | localhost | Username: zuul 2026-02-25 00:14:50.725467 | localhost | Distro: Fedora 37 2026-02-25 00:14:50.725488 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2026-02-25 00:14:50.725507 | localhost | Region: ca-ymq-1 2026-02-25 00:14:50.725526 | localhost | Label: ansible-fedora-37-1vcpu 2026-02-25 00:14:50.725545 | localhost | Product Name: OpenStack Nova 2026-02-25 00:14:50.725564 | localhost | Interface IP: 162.253.55.36 2026-02-25 00:14:50.734013 | 2026-02-25 00:14:50.734133 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-25 00:14:51.169273 | localhost -> localhost | changed 2026-02-25 00:14:51.175677 | 2026-02-25 00:14:51.175784 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-25 00:14:52.071708 | localhost -> localhost | changed 2026-02-25 00:14:52.096420 | 2026-02-25 00:14:52.096535 | PLAY [all:!appliance*] 2026-02-25 00:14:52.114963 | 2026-02-25 00:14:52.115082 | TASK [include_role : start-zuul-console] 2026-02-25 00:14:52.134694 | controller | ok 2026-02-25 00:14:52.150793 | 2026-02-25 00:14:52.150903 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-02-25 00:14:52.544046 | controller | ok 2026-02-25 00:14:52.559928 | 2026-02-25 00:14:52.560051 | TASK [use-our-mirror : Retrieve the IP address] 2026-02-25 00:14:53.518980 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2026-02-25 00:14:53.537642 | 2026-02-25 00:14:53.537893 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2026-02-25 00:14:54.086251 | controller | skipping: Conditional result was False 2026-02-25 00:14:54.100496 | 2026-02-25 00:14:54.100658 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2026-02-25 00:14:54.138424 | controller | skipping: Conditional result was False 2026-02-25 00:14:54.147549 | 2026-02-25 00:14:54.147652 | TASK [use-our-mirror : Create the podman configuration directory] 2026-02-25 00:14:54.172441 | controller | skipping: Conditional result was False 2026-02-25 00:14:54.183639 | 2026-02-25 00:14:54.183875 | TASK [use-our-mirror : Copy the podman configuration] 2026-02-25 00:14:54.211652 | controller | skipping: Conditional result was False 2026-02-25 00:14:54.222880 | 2026-02-25 00:14:54.223028 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2026-02-25 00:14:54.249027 | controller | skipping: Conditional result was False 2026-02-25 00:14:54.261387 | 2026-02-25 00:14:54.261549 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2026-02-25 00:14:54.287410 | controller | skipping: Conditional result was False 2026-02-25 00:14:54.306199 | 2026-02-25 00:14:54.306334 | TASK [Disable Fedora Modular] 2026-02-25 00:14:54.535061 | controller | changed 2026-02-25 00:14:54.545267 | 2026-02-25 00:14:54.545396 | TASK [Enable EPEL] 2026-02-25 00:14:54.561058 | controller | skipping: Conditional result was False 2026-02-25 00:14:54.571683 | 2026-02-25 00:14:54.571833 | TASK [Register the RHEL node] 2026-02-25 00:14:55.124601 | 2026-02-25 00:14:55.124821 | TASK [Show the subscription-manager status] 2026-02-25 00:14:55.697566 | controller | skipping: Conditional result was False 2026-02-25 00:14:55.704275 | 2026-02-25 00:14:55.704360 | TASK [Enable EPEL on RHEL] 2026-02-25 00:14:56.240075 | controller | skipping: Conditional result was False 2026-02-25 00:14:56.247502 | 2026-02-25 00:14:56.247617 | TASK [Install git and tox] 2026-02-25 00:16:13.444636 | controller | changed 2026-02-25 00:16:13.452946 | 2026-02-25 00:16:13.453025 | TASK [include_role : prepare-workspace] 2026-02-25 00:16:13.504407 | controller | ok 2026-02-25 00:16:13.553285 | 2026-02-25 00:16:13.553401 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-02-25 00:16:13.827576 | controller | ok 2026-02-25 00:16:13.834670 | 2026-02-25 00:16:13.834762 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-02-25 00:16:30.918232 | controller | Output suppressed because no_log was given 2026-02-25 00:16:30.930019 | 2026-02-25 00:16:30.930253 | TASK [include_role : prepare-workspace-openshift] 2026-02-25 00:16:30.945519 | controller | skipping: Conditional result was False 2026-02-25 00:16:31.003120 | 2026-02-25 00:16:31.003245 | PLAY [all:!appliance] 2026-02-25 00:16:31.022337 | 2026-02-25 00:16:31.022458 | TASK [Run add-build-sshkey role (RSA)] 2026-02-25 00:16:31.053159 | controller | ok 2026-02-25 00:16:31.070522 | 2026-02-25 00:16:31.070648 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-25 00:16:31.299263 | controller -> localhost | ok 2026-02-25 00:16:31.313781 | 2026-02-25 00:16:31.313954 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-25 00:16:31.355438 | controller | ok 2026-02-25 00:16:31.380112 | controller | included: /var/lib/zuul/builds/68b1e1a8fbba4d658204f14bf365030d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-25 00:16:31.389018 | 2026-02-25 00:16:31.389125 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-25 00:16:31.872566 | controller -> localhost | Generating public/private rsa key pair. 2026-02-25 00:16:31.872789 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/68b1e1a8fbba4d658204f14bf365030d/work/68b1e1a8fbba4d658204f14bf365030d_id_rsa. 2026-02-25 00:16:31.872822 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/68b1e1a8fbba4d658204f14bf365030d/work/68b1e1a8fbba4d658204f14bf365030d_id_rsa.pub. 2026-02-25 00:16:31.872845 | controller -> localhost | The key fingerprint is: 2026-02-25 00:16:31.872866 | controller -> localhost | SHA256:bu74U3pWehTVG+ut4+qNTVCm50Qbn8DUDeQ48Sy8eiE zuul-build-sshkey 2026-02-25 00:16:31.872887 | controller -> localhost | The key's randomart image is: 2026-02-25 00:16:31.872908 | controller -> localhost | +---[RSA 2048]----+ 2026-02-25 00:16:31.872928 | controller -> localhost | | .o+o.| 2026-02-25 00:16:31.872949 | controller -> localhost | | .o*.oo| 2026-02-25 00:16:31.872969 | controller -> localhost | | =+O +| 2026-02-25 00:16:31.872994 | controller -> localhost | | .O.*.| 2026-02-25 00:16:31.873024 | controller -> localhost | | S E =.=.o| 2026-02-25 00:16:31.873072 | controller -> localhost | | . .oo* ..| 2026-02-25 00:16:31.873111 | controller -> localhost | | oo.+. o. | 2026-02-25 00:16:31.873136 | controller -> localhost | | +o +..=o | 2026-02-25 00:16:31.873157 | controller -> localhost | | .o++ o+o+. | 2026-02-25 00:16:31.873181 | controller -> localhost | +----[SHA256]-----+ 2026-02-25 00:16:31.873232 | controller -> localhost | ok: Runtime: 0:00:00.096446 2026-02-25 00:16:31.880509 | 2026-02-25 00:16:31.880613 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-25 00:16:31.910158 | controller | ok 2026-02-25 00:16:31.920522 | controller | included: /var/lib/zuul/builds/68b1e1a8fbba4d658204f14bf365030d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-25 00:16:31.929960 | 2026-02-25 00:16:31.930062 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-25 00:16:31.943882 | controller | skipping: Conditional result was False 2026-02-25 00:16:31.951638 | 2026-02-25 00:16:31.951756 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-25 00:16:32.398653 | controller | changed 2026-02-25 00:16:32.407279 | 2026-02-25 00:16:32.407406 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-25 00:16:32.641010 | controller | ok 2026-02-25 00:16:32.653386 | 2026-02-25 00:16:32.653551 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-25 00:16:33.297913 | controller | changed 2026-02-25 00:16:33.304173 | 2026-02-25 00:16:33.304260 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-25 00:16:33.873108 | controller | changed 2026-02-25 00:16:33.879528 | 2026-02-25 00:16:33.879607 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-25 00:16:33.906030 | controller | skipping: Conditional result was False 2026-02-25 00:16:33.922973 | 2026-02-25 00:16:33.923063 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-25 00:16:34.339894 | controller -> localhost | changed 2026-02-25 00:16:34.352340 | 2026-02-25 00:16:34.352475 | TASK [add-build-sshkey : Add back temp key] 2026-02-25 00:16:34.683387 | controller -> localhost | Identity added: /var/lib/zuul/builds/68b1e1a8fbba4d658204f14bf365030d/work/68b1e1a8fbba4d658204f14bf365030d_id_rsa (zuul-build-sshkey) 2026-02-25 00:16:34.683595 | controller -> localhost | ok: Runtime: 0:00:00.008187 2026-02-25 00:16:34.690778 | 2026-02-25 00:16:34.690896 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-25 00:16:35.041636 | controller | ok 2026-02-25 00:16:35.048977 | 2026-02-25 00:16:35.049056 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-25 00:16:35.084223 | controller | skipping: Conditional result was False 2026-02-25 00:16:35.097053 | 2026-02-25 00:16:35.097163 | TASK [Run add-build-sshkey role (ECDSA)] 2026-02-25 00:16:35.127361 | controller | ok 2026-02-25 00:16:35.147782 | 2026-02-25 00:16:35.147942 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-25 00:16:35.446089 | controller -> localhost | ok 2026-02-25 00:16:35.456979 | 2026-02-25 00:16:35.457132 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-25 00:16:35.513845 | controller | ok 2026-02-25 00:16:35.531389 | controller | included: /var/lib/zuul/builds/68b1e1a8fbba4d658204f14bf365030d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-25 00:16:35.541989 | 2026-02-25 00:16:35.542142 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-25 00:16:35.792122 | controller -> localhost | Generating public/private ecdsa key pair. 2026-02-25 00:16:35.792296 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/68b1e1a8fbba4d658204f14bf365030d/work/68b1e1a8fbba4d658204f14bf365030d_id_ecdsa. 2026-02-25 00:16:35.792324 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/68b1e1a8fbba4d658204f14bf365030d/work/68b1e1a8fbba4d658204f14bf365030d_id_ecdsa.pub. 2026-02-25 00:16:35.792355 | controller -> localhost | The key fingerprint is: 2026-02-25 00:16:35.792381 | controller -> localhost | SHA256:DIgkYVBqlAVGb+ndpqPMdc2fGZ9cGKZOoZuAC15Xkxc zuul-build-sshkey 2026-02-25 00:16:35.792406 | controller -> localhost | The key's randomart image is: 2026-02-25 00:16:35.792432 | controller -> localhost | +---[ECDSA 521]---+ 2026-02-25 00:16:35.792456 | controller -> localhost | |*O*. | 2026-02-25 00:16:35.792480 | controller -> localhost | |+=.... | 2026-02-25 00:16:35.792504 | controller -> localhost | |...+. . E | 2026-02-25 00:16:35.792528 | controller -> localhost | |. o . .o . . | 2026-02-25 00:16:35.792547 | controller -> localhost | | . . oS+ o o | 2026-02-25 00:16:35.792566 | controller -> localhost | | + + + + o | 2026-02-25 00:16:35.792584 | controller -> localhost | | . * + + + . . | 2026-02-25 00:16:35.792602 | controller -> localhost | | + = = . * * o | 2026-02-25 00:16:35.792619 | controller -> localhost | | = . o = + | 2026-02-25 00:16:35.792637 | controller -> localhost | +----[SHA256]-----+ 2026-02-25 00:16:35.792684 | controller -> localhost | ok: Runtime: 0:00:00.008049 2026-02-25 00:16:35.799814 | 2026-02-25 00:16:35.799927 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-25 00:16:35.825671 | controller | ok 2026-02-25 00:16:35.833617 | controller | included: /var/lib/zuul/builds/68b1e1a8fbba4d658204f14bf365030d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-25 00:16:35.843308 | 2026-02-25 00:16:35.843434 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-25 00:16:35.858055 | controller | skipping: Conditional result was False 2026-02-25 00:16:35.865361 | 2026-02-25 00:16:35.865470 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-25 00:16:36.133476 | controller | changed 2026-02-25 00:16:36.142275 | 2026-02-25 00:16:36.142391 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-25 00:16:36.368040 | controller | ok 2026-02-25 00:16:36.374487 | 2026-02-25 00:16:36.374606 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-25 00:16:36.970240 | controller | changed 2026-02-25 00:16:36.986089 | 2026-02-25 00:16:36.986253 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-25 00:16:37.580907 | controller | changed 2026-02-25 00:16:37.595534 | 2026-02-25 00:16:37.595781 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-25 00:16:37.614831 | controller | skipping: Conditional result was False 2026-02-25 00:16:37.630904 | 2026-02-25 00:16:37.631094 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-25 00:16:37.894836 | controller -> localhost | changed 2026-02-25 00:16:37.922364 | 2026-02-25 00:16:37.922555 | TASK [add-build-sshkey : Add back temp key] 2026-02-25 00:16:38.283247 | controller -> localhost | Identity added: /var/lib/zuul/builds/68b1e1a8fbba4d658204f14bf365030d/work/68b1e1a8fbba4d658204f14bf365030d_id_ecdsa (zuul-build-sshkey) 2026-02-25 00:16:38.283499 | controller -> localhost | ok: Runtime: 0:00:00.008803 2026-02-25 00:16:38.291453 | 2026-02-25 00:16:38.291562 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-25 00:16:38.550942 | controller | ok 2026-02-25 00:16:38.556651 | 2026-02-25 00:16:38.556760 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-25 00:16:38.581506 | controller | skipping: Conditional result was False 2026-02-25 00:16:38.593097 | 2026-02-25 00:16:38.593194 | TASK [include_role : remove-zuul-sshkey] 2026-02-25 00:16:38.637424 | controller | skipping: Conditional result was False 2026-02-25 00:16:38.644327 | 2026-02-25 00:16:38.644406 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-02-25 00:16:38.865667 | controller | ok: "logs" 2026-02-25 00:16:38.866839 | controller | ok: All items complete 2026-02-25 00:16:38.866956 | 2026-02-25 00:16:39.050054 | controller | ok: "artifacts" 2026-02-25 00:16:39.226448 | controller | ok: "docs" 2026-02-25 00:16:39.237922 | 2026-02-25 00:16:39.238072 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-02-25 00:16:39.448633 | controller | changed: "logs" 2026-02-25 00:16:39.644348 | controller | changed: "artifacts" 2026-02-25 00:16:39.832056 | controller | changed: "docs" 2026-02-25 00:16:39.883712 | 2026-02-25 00:16:39.883864 | PLAY RECAP 2026-02-25 00:16:39.883916 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2026-02-25 00:16:39.883944 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-25 00:16:39.883963 | 2026-02-25 00:16:40.033880 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-02-25 00:16:40.035267 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-25 00:16:40.709018 | 2026-02-25 00:16:40.709144 | PLAY [all] 2026-02-25 00:16:40.730903 | 2026-02-25 00:16:40.731010 | TASK [Install binary dependencies] 2026-02-25 00:16:40.780498 | controller | ok 2026-02-25 00:16:40.800052 | 2026-02-25 00:16:40.800216 | TASK [bindep : Include find tasks] 2026-02-25 00:16:40.829827 | controller | ok 2026-02-25 00:16:40.838219 | controller | included: /var/lib/zuul/builds/68b1e1a8fbba4d658204f14bf365030d/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-02-25 00:16:40.845359 | 2026-02-25 00:16:40.845480 | TASK [bindep : Look for bindep.txt] 2026-02-25 00:16:41.210766 | controller | ok 2026-02-25 00:16:41.225251 | 2026-02-25 00:16:41.225499 | TASK [bindep : Define bindep_file fact] 2026-02-25 00:16:41.242472 | controller | skipping: Conditional result was False 2026-02-25 00:16:41.252933 | 2026-02-25 00:16:41.253078 | TASK [bindep : Look for other-requirements.txt] 2026-02-25 00:16:41.468618 | controller | ok 2026-02-25 00:16:41.477576 | 2026-02-25 00:16:41.477690 | TASK [bindep : Define bindep_file fact] 2026-02-25 00:16:41.512974 | controller | skipping: Conditional result was False 2026-02-25 00:16:41.522634 | 2026-02-25 00:16:41.522807 | TASK [bindep : Look for bindep fallback file] 2026-02-25 00:16:41.548091 | controller | skipping: Conditional result was False 2026-02-25 00:16:41.559018 | 2026-02-25 00:16:41.559152 | TASK [bindep : Define bindep_file fact] 2026-02-25 00:16:41.584579 | controller | skipping: Conditional result was False 2026-02-25 00:16:41.594983 | 2026-02-25 00:16:41.595132 | TASK [bindep : Include bindep tasks] 2026-02-25 00:16:41.631064 | controller | skipping: Conditional result was False 2026-02-25 00:16:41.641440 | 2026-02-25 00:16:41.641577 | TASK [bindep : Include install tasks] 2026-02-25 00:16:41.667401 | controller | skipping: Conditional result was False 2026-02-25 00:16:41.678333 | 2026-02-25 00:16:41.678534 | LOOP [bindep : Include package tasks] 2026-02-25 00:16:41.751681 | 2026-02-25 00:16:41.751958 | TASK [Run test-setup role] 2026-02-25 00:16:41.779674 | controller | ok 2026-02-25 00:16:41.808063 | 2026-02-25 00:16:41.808224 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-02-25 00:16:42.012498 | controller | ok 2026-02-25 00:16:42.019602 | 2026-02-25 00:16:42.019714 | TASK [test-setup : Run tools/test-setup.sh] 2026-02-25 00:16:42.554903 | controller | skipping: Conditional result was False 2026-02-25 00:16:42.591800 | 2026-02-25 00:16:42.591931 | PLAY RECAP 2026-02-25 00:16:42.591987 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-25 00:16:42.592013 | 2026-02-25 00:16:42.723528 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-25 00:16:42.724719 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-02-25 00:16:43.471316 | 2026-02-25 00:16:43.471474 | PLAY [controller] 2026-02-25 00:16:43.493878 | 2026-02-25 00:16:43.494039 | TASK [Create the /root directory] 2026-02-25 00:16:43.913689 | controller | ok 2026-02-25 00:16:43.919957 | 2026-02-25 00:16:43.920081 | TASK [Install glibc-langpack-en] 2026-02-25 00:16:47.788695 | controller | ok: Nothing to do 2026-02-25 00:16:47.809265 | 2026-02-25 00:16:47.809431 | TASK [Ensure controller directory exists] 2026-02-25 00:16:48.018597 | controller | changed 2026-02-25 00:16:48.026546 | 2026-02-25 00:16:48.026700 | TASK [Install container runtime] 2026-02-25 00:16:48.085071 | controller | ok 2026-02-25 00:16:48.124256 | 2026-02-25 00:16:48.124407 | LOOP [ensure-podman : Find distribution installation] 2026-02-25 00:16:48.152527 | controller | ok: "/var/lib/zuul/builds/68b1e1a8fbba4d658204f14bf365030d/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml" 2026-02-25 00:16:48.169305 | controller | included: /var/lib/zuul/builds/68b1e1a8fbba4d658204f14bf365030d/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml 2026-02-25 00:16:48.179633 | 2026-02-25 00:16:48.179835 | TASK [ensure-podman : Install podman (RedHat)] 2026-02-25 00:17:53.161193 | controller | changed 2026-02-25 00:17:53.168277 | 2026-02-25 00:17:53.168378 | TASK [ensure-podman : Fetch podman version] 2026-02-25 00:17:53.729969 | controller | Client: Podman Engine 2026-02-25 00:17:53.756084 | controller | Version: 4.6.2 2026-02-25 00:17:53.756123 | controller | API Version: 4.6.2 2026-02-25 00:17:53.756131 | controller | Go Version: go1.19.12 2026-02-25 00:17:53.756148 | controller | Built: Mon Aug 28 19:38:31 2023 2026-02-25 00:17:53.756156 | controller | OS/Arch: linux/amd64 2026-02-25 00:17:54.204896 | controller | ok: Runtime: 0:00:00.193656 2026-02-25 00:17:54.222110 | 2026-02-25 00:17:54.222320 | TASK [ensure-podman : Print podman version installed] 2026-02-25 00:17:54.269101 | Podman version: Client: Podman Engine 2026-02-25 00:17:54.269304 | Version: 4.6.2 2026-02-25 00:17:54.269376 | API Version: 4.6.2 2026-02-25 00:17:54.269419 | Go Version: go1.19.12 2026-02-25 00:17:54.269456 | Built: Mon Aug 28 19:38:31 2023 2026-02-25 00:17:54.269494 | OS/Arch: linux/amd64 2026-02-25 00:17:54.278577 | 2026-02-25 00:17:54.278697 | TASK [ensure-podman : Validate podman engine] 2026-02-25 00:17:54.825305 | controller | skipping: Conditional result was False 2026-02-25 00:17:54.831963 | 2026-02-25 00:17:54.832041 | TASK [ensure-podman : Set up docker compatability socket] 2026-02-25 00:17:54.845848 | controller | skipping: Conditional result was False 2026-02-25 00:17:54.858828 | 2026-02-25 00:17:54.858929 | TASK [Ensure python3.8 is present] 2026-02-25 00:17:54.873477 | controller | skipping: Conditional result was False 2026-02-25 00:17:54.880691 | 2026-02-25 00:17:54.880793 | TASK [Run our-ensure-python role (Fedora only for now)] 2026-02-25 00:17:54.900892 | controller | ok 2026-02-25 00:17:54.922060 | 2026-02-25 00:17:54.922186 | TASK [our-ensure-python : Install the right Python version (rpm)] 2026-02-25 00:17:56.361803 | controller | ok: Nothing to do 2026-02-25 00:17:56.370206 | 2026-02-25 00:17:56.370350 | TASK [our-ensure-python : Also install python3-devel] 2026-02-25 00:18:07.100659 | controller | changed 2026-02-25 00:18:07.125426 | 2026-02-25 00:18:07.125616 | TASK [Run ensure-virtualenv role] 2026-02-25 00:18:07.156817 | controller | ok 2026-02-25 00:18:07.206454 | 2026-02-25 00:18:07.206599 | TASK [ensure-virtualenv : Check if virtualenv is installed] 2026-02-25 00:18:07.458348 | controller | /usr/bin/virtualenv 2026-02-25 00:18:07.775837 | controller | ok: Runtime: 0:00:00.005743 2026-02-25 00:18:07.782442 | 2026-02-25 00:18:07.782541 | LOOP [ensure-virtualenv : Install virtualenv package] 2026-02-25 00:18:07.820385 | controller | skipping: Conditional result was False 2026-02-25 00:18:07.820943 | controller | ok: All items complete 2026-02-25 00:18:07.821029 | 2026-02-25 00:18:07.857409 | 2026-02-25 00:18:07.857644 | TASK [Find the full path of the Python interpreter] 2026-02-25 00:18:08.084792 | controller | /usr/bin/python3 2026-02-25 00:18:08.409211 | controller | ok 2026-02-25 00:18:08.423411 | 2026-02-25 00:18:08.423620 | TASK [Create virtualenv for ansible-test with a specific interpreter] 2026-02-25 00:18:09.223264 | controller | created virtual environment CPython3.11.0.final.0-64 in 437ms 2026-02-25 00:18:09.244333 | controller | creator CPython3Posix(dest=/home/zuul/venv, clear=False, no_vcs_ignore=False, global=False) 2026-02-25 00:18:09.245286 | 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 00:18:09.245299 | controller | added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1 2026-02-25 00:18:09.245312 | controller | activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator 2026-02-25 00:18:09.483647 | controller | changed 2026-02-25 00:18:09.492649 | 2026-02-25 00:18:09.492762 | TASK [Set selinux package] 2026-02-25 00:18:09.531019 | controller | ok 2026-02-25 00:18:09.544913 | 2026-02-25 00:18:09.545144 | TASK [Set selinux package (Fedora)] 2026-02-25 00:18:09.597812 | controller | ok 2026-02-25 00:18:09.610638 | 2026-02-25 00:18:09.610851 | TASK [Install selinux into virtualenv] 2026-02-25 00:18:35.800118 | controller | Collecting selinux-please-lie-to-me 2026-02-25 00:18:50.792050 | controller | Downloading selinux_please_lie_to_me-1.0.1-py2.py3-none-any.whl (3.8 kB) 2026-02-25 00:18:52.046528 | controller | Collecting setuptools<50.0.0 2026-02-25 00:18:52.053741 | controller | Downloading setuptools-49.6.0-py3-none-any.whl (803 kB) 2026-02-25 00:18:53.077795 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 803.3/803.3 kB 980.6 kB/s eta 0:00:00 2026-02-25 00:18:53.161235 | controller | Installing collected packages: setuptools, selinux-please-lie-to-me 2026-02-25 00:18:53.161464 | controller | Attempting uninstall: setuptools 2026-02-25 00:18:53.163806 | controller | Found existing installation: setuptools 62.6.0 2026-02-25 00:18:53.224720 | controller | Uninstalling setuptools-62.6.0: 2026-02-25 00:18:53.233302 | controller | Successfully uninstalled setuptools-62.6.0 2026-02-25 00:18:56.208900 | controller | Successfully installed selinux-please-lie-to-me-1.0.1 setuptools-49.6.0 2026-02-25 00:19:13.975175 | controller | 2026-02-25 00:19:14.064324 | controller | [notice] A new release of pip available: 22.2.2 -> 26.0.1 2026-02-25 00:19:14.064367 | controller | [notice] To update, run: python -m pip install --upgrade pip 2026-02-25 00:19:14.220121 | controller | ok: Runtime: 0:01:04.209431 2026-02-25 00:19:14.231762 | 2026-02-25 00:19:14.231884 | TASK [Install pytest-forked into virtualenv] 2026-02-25 00:19:30.779000 | controller | Collecting pytest-forked 2026-02-25 00:19:42.495611 | controller | Downloading pytest_forked-1.6.0-py3-none-any.whl (4.9 kB) 2026-02-25 00:19:42.928614 | controller | Collecting py 2026-02-25 00:19:42.934724 | controller | Downloading py-1.11.0-py2.py3-none-any.whl (98 kB) 2026-02-25 00:19:43.273072 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.7/98.7 kB 266.5 kB/s eta 0:00:00 2026-02-25 00:19:44.007901 | controller | Collecting pytest>=3.10 2026-02-25 00:19:44.011655 | controller | Downloading pytest-9.0.2-py3-none-any.whl (374 kB) 2026-02-25 00:19:44.582394 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 374.8/374.8 kB 646.1 kB/s eta 0:00:00 2026-02-25 00:19:44.775443 | controller | Collecting iniconfig>=1.0.1 2026-02-25 00:19:44.782266 | controller | Downloading iniconfig-2.3.0-py3-none-any.whl (7.5 kB) 2026-02-25 00:19:45.221755 | controller | Collecting packaging>=22 2026-02-25 00:19:45.226341 | controller | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-02-25 00:19:45.565254 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 192.8 kB/s eta 0:00:00 2026-02-25 00:19:45.923092 | controller | Collecting pluggy<2,>=1.5 2026-02-25 00:19:45.927570 | controller | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-02-25 00:19:46.291135 | controller | Collecting pygments>=2.7.2 2026-02-25 00:19:46.296919 | controller | Downloading pygments-2.19.2-py3-none-any.whl (1.2 MB) 2026-02-25 00:19:46.730444 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.2/1.2 MB 2.8 MB/s eta 0:00:00 2026-02-25 00:19:46.810382 | controller | Installing collected packages: pygments, py, pluggy, packaging, iniconfig, pytest, pytest-forked 2026-02-25 00:19:54.075190 | 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 00:19:54.132940 | controller | 2026-02-25 00:19:54.205584 | controller | [notice] A new release of pip available: 22.2.2 -> 26.0.1 2026-02-25 00:19:54.205646 | controller | [notice] To update, run: python -m pip install --upgrade pip 2026-02-25 00:19:54.307901 | controller | ok: Runtime: 0:00:39.751160 2026-02-25 00:19:54.318092 | 2026-02-25 00:19:54.318223 | TASK [Update pip] 2026-02-25 00:19:54.838049 | controller | Requirement already satisfied: pip in ./venv/lib/python3.11/site-packages (22.2.2) 2026-02-25 00:20:07.569195 | controller | Collecting pip 2026-02-25 00:20:19.479672 | controller | Downloading pip-26.0.1-py3-none-any.whl (1.8 MB) 2026-02-25 00:20:20.065949 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.8/1.8 MB 3.1 MB/s eta 0:00:00 2026-02-25 00:20:20.150867 | controller | Installing collected packages: pip 2026-02-25 00:20:20.151055 | controller | Attempting uninstall: pip 2026-02-25 00:20:20.153530 | controller | Found existing installation: pip 22.2.2 2026-02-25 00:20:20.301218 | controller | Uninstalling pip-22.2.2: 2026-02-25 00:20:20.317335 | controller | Successfully uninstalled pip-22.2.2 2026-02-25 00:20:22.572556 | controller | Successfully installed pip-26.0.1 2026-02-25 00:20:22.905965 | controller | ok: Runtime: 0:00:28.137148 2026-02-25 00:20:22.918377 | 2026-02-25 00:20:22.918522 | TASK [Ensure pip temp directory exists in /var/tmp] 2026-02-25 00:20:23.128536 | controller | changed 2026-02-25 00:20:23.177895 | 2026-02-25 00:20:23.178064 | TASK [Install ansible into virtualenv] 2026-02-25 00:20:23.727567 | controller | Processing ./src/github.com/ansible/ansible 2026-02-25 00:20:23.729933 | controller | Installing build dependencies: started 2026-02-25 00:20:49.372997 | controller | Installing build dependencies: finished with status 'done' 2026-02-25 00:20:50.154369 | controller | Getting requirements to build wheel: started 2026-02-25 00:20:50.155055 | controller | Getting requirements to build wheel: finished with status 'done' 2026-02-25 00:20:50.155094 | controller | Preparing metadata (pyproject.toml): started 2026-02-25 00:20:50.630182 | controller | Preparing metadata (pyproject.toml): finished with status 'done' 2026-02-25 00:20:50.631586 | 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 00:20:50.634323 | controller | ERROR: Package 'ansible-core' requires a different Python: 3.11.0 not in '>=3.12' 2026-02-25 00:20:50.741571 | controller | ERROR 2026-02-25 00:20:50.741755 | controller | { 2026-02-25 00:20:50.741806 | controller | "delta": "0:00:27.311279", 2026-02-25 00:20:50.741838 | controller | "end": "2026-02-25 00:20:50.699464", 2026-02-25 00:20:50.741865 | controller | "msg": "non-zero return code", 2026-02-25 00:20:50.741904 | controller | "rc": 1, 2026-02-25 00:20:50.741930 | controller | "start": "2026-02-25 00:20:23.388185" 2026-02-25 00:20:50.741956 | controller | } failure 2026-02-25 00:20:50.743945 | 2026-02-25 00:20:50.744010 | PLAY RECAP 2026-02-25 00:20:50.744070 | controller | ok: 18 changed: 10 unreachable: 0 failed: 1 skipped: 4 rescued: 0 ignored: 0 2026-02-25 00:20:50.744104 | 2026-02-25 00:20:50.886856 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-02-25 00:20:50.889122 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-25 00:20:51.514045 | 2026-02-25 00:20:51.514174 | PLAY [all] 2026-02-25 00:20:51.538007 | 2026-02-25 00:20:51.538147 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-02-25 00:20:51.857008 | controller | changed: non-zero return code 2026-02-25 00:20:51.872491 | 2026-02-25 00:20:51.872718 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-02-25 00:20:51.900469 | controller | skipping: Conditional result was False 2026-02-25 00:20:51.915247 | 2026-02-25 00:20:51.915476 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-02-25 00:20:51.948333 | 2026-02-25 00:20:51.948612 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-02-25 00:20:51.984220 | 2026-02-25 00:20:51.984424 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-02-25 00:20:52.010215 | controller | skipping: Conditional result was False 2026-02-25 00:20:52.017658 | 2026-02-25 00:20:52.017764 | LOOP [fetch-subunit-output : Generate subunit file] 2026-02-25 00:20:52.055215 | 2026-02-25 00:20:52.055469 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-02-25 00:20:52.082520 | controller | skipping: Conditional result was False 2026-02-25 00:20:52.095458 | 2026-02-25 00:20:52.095607 | TASK [fetch-subunit-output : Remove the temporary file] 2026-02-25 00:20:52.123230 | controller | skipping: Conditional result was False 2026-02-25 00:20:52.136089 | 2026-02-25 00:20:52.136262 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-02-25 00:20:52.163089 | controller | skipping: Conditional result was False 2026-02-25 00:20:52.210397 | 2026-02-25 00:20:52.210506 | PLAY RECAP 2026-02-25 00:20:52.210566 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-25 00:20:52.210601 | 2026-02-25 00:20:52.305683 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-25 00:20:52.306516 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2026-02-25 00:20:52.916173 | 2026-02-25 00:20:52.916294 | PLAY [all:!appliance*] 2026-02-25 00:20:52.940135 | 2026-02-25 00:20:52.940266 | TASK [unregister the node] 2026-02-25 00:20:53.471143 | controller | skipping: Conditional result was False 2026-02-25 00:20:53.480051 | 2026-02-25 00:20:53.480183 | TASK [include_role : fetch-output] 2026-02-25 00:20:53.514598 | controller | ok 2026-02-25 00:20:53.548476 | 2026-02-25 00:20:53.548617 | TASK [fetch-output : Set log path for multiple nodes] 2026-02-25 00:20:53.604187 | controller | skipping: Conditional result was False 2026-02-25 00:20:53.614300 | 2026-02-25 00:20:53.614425 | TASK [fetch-output : Set log path for single node] 2026-02-25 00:20:53.659281 | controller | ok 2026-02-25 00:20:53.667367 | 2026-02-25 00:20:53.667580 | LOOP [fetch-output : Ensure local output dirs] 2026-02-25 00:20:54.064388 | controller -> localhost | ok: "/var/lib/zuul/builds/68b1e1a8fbba4d658204f14bf365030d/work/logs" 2026-02-25 00:20:54.289651 | controller -> localhost | changed: "/var/lib/zuul/builds/68b1e1a8fbba4d658204f14bf365030d/work/artifacts" 2026-02-25 00:20:54.543321 | controller -> localhost | changed: "/var/lib/zuul/builds/68b1e1a8fbba4d658204f14bf365030d/work/docs" 2026-02-25 00:20:54.558326 | 2026-02-25 00:20:54.558438 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-25 00:20:55.194847 | controller | changed: 2026-02-25 00:20:55.195224 | controller | .d..t...... ./ 2026-02-25 00:20:55.195292 | controller | cd+++++++++ controller/ 2026-02-25 00:20:55.195648 | controller | changed: All items complete 2026-02-25 00:20:55.195755 | 2026-02-25 00:20:55.697183 | controller | changed: .d..t...... ./ 2026-02-25 00:20:56.128469 | controller | changed: .d..t...... ./ 2026-02-25 00:20:56.149541 | 2026-02-25 00:20:56.149693 | TASK [include_role : fetch-output-openshift] 2026-02-25 00:20:56.163933 | controller | skipping: Conditional result was False 2026-02-25 00:20:56.171140 | 2026-02-25 00:20:56.171265 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-02-25 00:20:56.196066 | controller | skipping: Conditional result was False 2026-02-25 00:20:56.203954 | controller | skipping: Conditional result was False 2026-02-25 00:20:56.246392 | 2026-02-25 00:20:56.246503 | PLAY [localhost] 2026-02-25 00:20:56.259515 | 2026-02-25 00:20:56.259622 | TASK [Run Zuul manifest role] 2026-02-25 00:20:56.280111 | localhost | ok 2026-02-25 00:20:56.295536 | 2026-02-25 00:20:56.295672 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-25 00:20:56.723684 | localhost | changed 2026-02-25 00:20:56.728824 | 2026-02-25 00:20:56.728928 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-25 00:20:56.757606 | localhost | ok 2026-02-25 00:20:56.765707 | 2026-02-25 00:20:56.765811 | TASK [Set zuul-log-path fact] 2026-02-25 00:20:56.784509 | localhost | ok 2026-02-25 00:20:56.797668 | 2026-02-25 00:20:56.797816 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-25 00:20:56.829455 | localhost | ok 2026-02-25 00:20:56.840960 | 2026-02-25 00:20:56.841056 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)] 2026-02-25 00:20:56.868205 | localhost | ok: 2026-02-25 00:20:56.868362 | localhost | { 2026-02-25 00:20:56.868388 | localhost | "auth": { 2026-02-25 00:20:56.868409 | localhost | "password": "IonWCwcuOFib&&<}wp^:[2G/", 2026-02-25 00:20:56.868428 | localhost | "username": "9LF91O0RK7JU" 2026-02-25 00:20:56.868446 | localhost | }, 2026-02-25 00:20:56.868463 | localhost | "profile": "rackspace", 2026-02-25 00:20:56.868481 | localhost | "region_name": "IAD" 2026-02-25 00:20:56.868498 | localhost | } 2026-02-25 00:20:56.868522 | 2026-02-25 00:20:56.887955 | 2026-02-25 00:20:56.888144 | TASK [Run upload-logs-failover role (S3 then Swift)] 2026-02-25 00:20:56.916001 | localhost | Output suppressed because no_log was given 2026-02-25 00:20:56.939470 | 2026-02-25 00:20:56.939629 | TASK [upload-logs-failover : Initialize control vars] 2026-02-25 00:20:56.971949 | localhost | ok 2026-02-25 00:20:56.979174 | 2026-02-25 00:20:56.979317 | LOOP [upload-logs-failover : Perform log upload] 2026-02-25 00:20:57.016379 | localhost | Output suppressed because no_log was given 2026-02-25 00:20:57.051938 | localhost | included: /var/lib/zuul/builds/68b1e1a8fbba4d658204f14bf365030d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml 2026-02-25 00:20:57.058887 | 2026-02-25 00:20:57.058997 | LOOP [upload-logs-failover : Unpack vars for swift upload] 2026-02-25 00:20:57.145791 | localhost | Output suppressed because no_log was given 2026-02-25 00:20:57.152138 | 2026-02-25 00:20:57.152285 | TASK [Upload logs to swift] 2026-02-25 00:20:57.181415 | localhost | ok 2026-02-25 00:20:57.208765 | 2026-02-25 00:20:57.208944 | TASK [Set zuul-log-path fact] 2026-02-25 00:20:57.233074 | localhost | skipping: Conditional result was False 2026-02-25 00:20:57.238423 | 2026-02-25 00:20:57.238506 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2026-02-25 00:20:57.600459 | localhost -> localhost | ok: Runtime: 0:00:00.004614 2026-02-25 00:20:57.614010 | 2026-02-25 00:20:57.614216 | TASK [upload-logs-swift : Upload logs to swift]