2026-03-16 14:42:46.300943 | Job console starting... 2026-03-16 14:42:46.314014 | Updating repositories 2026-03-16 14:42:46.446587 | Preparing job workspace 2026-03-16 14:42:51.232468 | Running Ansible setup... 2026-03-16 14:42:55.698591 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-03-16 14:42:56.369501 | 2026-03-16 14:42:56.369637 | PLAY [localhost] 2026-03-16 14:42:56.384332 | 2026-03-16 14:42:56.384423 | TASK [Gathering Facts] 2026-03-16 14:42:57.338897 | localhost | ok 2026-03-16 14:42:57.368843 | 2026-03-16 14:42:57.369086 | TASK [Setup log path fact] 2026-03-16 14:42:57.398336 | localhost | ok 2026-03-16 14:42:57.411229 | 2026-03-16 14:42:57.411297 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-16 14:42:57.439790 | localhost | ok 2026-03-16 14:42:57.447423 | 2026-03-16 14:42:57.447490 | TASK [emit-job-header : Print job information] 2026-03-16 14:42:57.485966 | # Job Information 2026-03-16 14:42:57.486080 | Ansible Version: 2.15.12 2026-03-16 14:42:57.486111 | Job: ansible-test-sanity-docker-devel 2026-03-16 14:42:57.486131 | Pipeline: third-party-check 2026-03-16 14:42:57.486148 | Executor: ze02.softwarefactory-project.io 2026-03-16 14:42:57.486165 | Triggered by: https://github.com/openshift/community.okd/pull/274 2026-03-16 14:42:57.486186 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/01c/ansible/01c390b64bd6460c8325f3e8f6836aae/ 2026-03-16 14:42:57.486204 | Event ID: 80cacb30-2145-11f1-9acb-93a73f8f7e40 2026-03-16 14:42:57.489947 | 2026-03-16 14:42:57.490009 | LOOP [emit-job-header : Print node information] 2026-03-16 14:42:57.620585 | localhost | ok: 2026-03-16 14:42:57.620846 | localhost | # Node Information 2026-03-16 14:42:57.620874 | localhost | Inventory Hostname: controller 2026-03-16 14:42:57.620896 | localhost | Hostname: np0005648483 2026-03-16 14:42:57.620915 | localhost | Username: zuul 2026-03-16 14:42:57.620938 | localhost | Distro: Fedora 37 2026-03-16 14:42:57.620956 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2026-03-16 14:42:57.620973 | localhost | Region: ca-ymq-1 2026-03-16 14:42:57.620988 | localhost | Label: ansible-fedora-37-1vcpu 2026-03-16 14:42:57.621004 | localhost | Product Name: OpenStack Nova 2026-03-16 14:42:57.621021 | localhost | Interface IP: 199.204.45.129 2026-03-16 14:42:57.632508 | 2026-03-16 14:42:57.632626 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-16 14:42:58.073951 | localhost -> localhost | changed 2026-03-16 14:42:58.079616 | 2026-03-16 14:42:58.079722 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-16 14:42:58.912224 | localhost -> localhost | changed 2026-03-16 14:42:58.931450 | 2026-03-16 14:42:58.931503 | PLAY [all:!appliance*] 2026-03-16 14:42:58.949165 | 2026-03-16 14:42:58.949282 | TASK [include_role : start-zuul-console] 2026-03-16 14:42:58.969247 | controller | ok 2026-03-16 14:42:58.982185 | 2026-03-16 14:42:58.982245 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-16 14:42:59.351217 | controller | ok 2026-03-16 14:42:59.375727 | 2026-03-16 14:42:59.375864 | TASK [use-our-mirror : Retrieve the IP address] 2026-03-16 14:43:22.118985 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2026-03-16 14:43:22.132495 | 2026-03-16 14:43:22.132630 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2026-03-16 14:43:22.714502 | controller | skipping: Conditional result was False 2026-03-16 14:43:22.729828 | 2026-03-16 14:43:22.729970 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2026-03-16 14:43:22.758921 | controller | skipping: Conditional result was False 2026-03-16 14:43:22.775381 | 2026-03-16 14:43:22.775523 | TASK [use-our-mirror : Create the podman configuration directory] 2026-03-16 14:43:22.802758 | controller | skipping: Conditional result was False 2026-03-16 14:43:22.818847 | 2026-03-16 14:43:22.818995 | TASK [use-our-mirror : Copy the podman configuration] 2026-03-16 14:43:22.845216 | controller | skipping: Conditional result was False 2026-03-16 14:43:22.862010 | 2026-03-16 14:43:22.862183 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2026-03-16 14:43:22.889183 | controller | skipping: Conditional result was False 2026-03-16 14:43:22.904015 | 2026-03-16 14:43:22.904163 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2026-03-16 14:43:22.930640 | controller | skipping: Conditional result was False 2026-03-16 14:43:22.959498 | 2026-03-16 14:43:22.959700 | TASK [Disable Fedora Modular] 2026-03-16 14:43:23.242942 | controller | changed 2026-03-16 14:43:23.256071 | 2026-03-16 14:43:23.256208 | TASK [Enable EPEL] 2026-03-16 14:43:23.284245 | controller | skipping: Conditional result was False 2026-03-16 14:43:23.298600 | 2026-03-16 14:43:23.298980 | TASK [Register the RHEL node] 2026-03-16 14:43:23.863122 | 2026-03-16 14:43:23.863410 | TASK [Show the subscription-manager status] 2026-03-16 14:43:24.422372 | controller | skipping: Conditional result was False 2026-03-16 14:43:24.431983 | 2026-03-16 14:43:24.432074 | TASK [Enable EPEL on RHEL] 2026-03-16 14:43:24.974588 | controller | skipping: Conditional result was False 2026-03-16 14:43:24.988749 | 2026-03-16 14:43:24.988898 | TASK [Install git and tox] 2026-03-16 14:44:33.571363 | controller | changed 2026-03-16 14:44:33.583700 | 2026-03-16 14:44:33.583781 | TASK [include_role : prepare-workspace] 2026-03-16 14:44:33.616285 | controller | ok 2026-03-16 14:44:33.671592 | 2026-03-16 14:44:33.671720 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-16 14:44:33.900042 | controller | ok 2026-03-16 14:44:33.913437 | 2026-03-16 14:44:33.913562 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-16 14:44:46.661494 | controller | Output suppressed because no_log was given 2026-03-16 14:44:46.686042 | 2026-03-16 14:44:46.686171 | TASK [include_role : prepare-workspace-openshift] 2026-03-16 14:44:46.705869 | controller | skipping: Conditional result was False 2026-03-16 14:44:46.736832 | 2026-03-16 14:44:46.736918 | PLAY [all:!appliance] 2026-03-16 14:44:46.758968 | 2026-03-16 14:44:46.759046 | TASK [Run add-build-sshkey role (RSA)] 2026-03-16 14:44:46.799432 | controller | ok 2026-03-16 14:44:46.814173 | 2026-03-16 14:44:46.814236 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-16 14:44:47.059342 | controller -> localhost | ok 2026-03-16 14:44:47.066061 | 2026-03-16 14:44:47.066261 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-16 14:44:47.096315 | controller | ok 2026-03-16 14:44:47.111780 | controller | included: /var/lib/zuul/builds/01c390b64bd6460c8325f3e8f6836aae/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-16 14:44:47.117514 | 2026-03-16 14:44:47.117572 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-16 14:44:47.644984 | controller -> localhost | Generating public/private rsa key pair. 2026-03-16 14:44:47.645320 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/01c390b64bd6460c8325f3e8f6836aae/work/01c390b64bd6460c8325f3e8f6836aae_id_rsa. 2026-03-16 14:44:47.645387 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/01c390b64bd6460c8325f3e8f6836aae/work/01c390b64bd6460c8325f3e8f6836aae_id_rsa.pub. 2026-03-16 14:44:47.645434 | controller -> localhost | The key fingerprint is: 2026-03-16 14:44:47.645477 | controller -> localhost | SHA256:LFNGdtZxhAvTMc1zy1NbdxfLjy2Vwy/HfyfOTS6+ghU zuul-build-sshkey 2026-03-16 14:44:47.645518 | controller -> localhost | The key's randomart image is: 2026-03-16 14:44:47.645559 | controller -> localhost | +---[RSA 2048]----+ 2026-03-16 14:44:47.645599 | controller -> localhost | | o oo+Bo..| 2026-03-16 14:44:47.645640 | controller -> localhost | | o oo +o* X| 2026-03-16 14:44:47.645715 | controller -> localhost | | o o ..OX| 2026-03-16 14:44:47.645758 | controller -> localhost | | + E X+| 2026-03-16 14:44:47.645797 | controller -> localhost | | o S .+ B| 2026-03-16 14:44:47.645850 | controller -> localhost | | o . +.| 2026-03-16 14:44:47.645895 | controller -> localhost | | o . =| 2026-03-16 14:44:47.645935 | controller -> localhost | | . .o.=o| 2026-03-16 14:44:47.645974 | controller -> localhost | | o=oo| 2026-03-16 14:44:47.646018 | controller -> localhost | +----[SHA256]-----+ 2026-03-16 14:44:47.646110 | controller -> localhost | ok: Runtime: 0:00:00.049214 2026-03-16 14:44:47.660756 | 2026-03-16 14:44:47.660888 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-16 14:44:47.690762 | controller | ok 2026-03-16 14:44:47.713285 | controller | included: /var/lib/zuul/builds/01c390b64bd6460c8325f3e8f6836aae/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-16 14:44:47.725846 | 2026-03-16 14:44:47.725926 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-16 14:44:47.740724 | controller | skipping: Conditional result was False 2026-03-16 14:44:47.750030 | 2026-03-16 14:44:47.750118 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-16 14:44:48.162091 | controller | changed 2026-03-16 14:44:48.175651 | 2026-03-16 14:44:48.175815 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-16 14:44:48.421525 | controller | ok 2026-03-16 14:44:48.469949 | 2026-03-16 14:44:48.470098 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-16 14:44:49.111015 | controller | changed 2026-03-16 14:44:49.123766 | 2026-03-16 14:44:49.123898 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-16 14:44:49.752936 | controller | changed 2026-03-16 14:44:49.767327 | 2026-03-16 14:44:49.767522 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-16 14:44:49.794963 | controller | skipping: Conditional result was False 2026-03-16 14:44:49.809926 | 2026-03-16 14:44:49.810069 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-16 14:44:50.177053 | controller -> localhost | changed 2026-03-16 14:44:50.201177 | 2026-03-16 14:44:50.201314 | TASK [add-build-sshkey : Add back temp key] 2026-03-16 14:44:50.471765 | controller -> localhost | Identity added: /var/lib/zuul/builds/01c390b64bd6460c8325f3e8f6836aae/work/01c390b64bd6460c8325f3e8f6836aae_id_rsa (zuul-build-sshkey) 2026-03-16 14:44:50.472175 | controller -> localhost | ok: Runtime: 0:00:00.013102 2026-03-16 14:44:50.485720 | 2026-03-16 14:44:50.485846 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-16 14:44:50.806816 | controller | ok 2026-03-16 14:44:50.812645 | 2026-03-16 14:44:50.812733 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-16 14:44:50.847417 | controller | skipping: Conditional result was False 2026-03-16 14:44:50.859172 | 2026-03-16 14:44:50.859233 | TASK [Run add-build-sshkey role (ECDSA)] 2026-03-16 14:44:50.889097 | controller | ok 2026-03-16 14:44:50.907130 | 2026-03-16 14:44:50.907191 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-16 14:44:51.155794 | controller -> localhost | ok 2026-03-16 14:44:51.162733 | 2026-03-16 14:44:51.162796 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-16 14:44:51.193491 | controller | ok 2026-03-16 14:44:51.204371 | controller | included: /var/lib/zuul/builds/01c390b64bd6460c8325f3e8f6836aae/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-16 14:44:51.211211 | 2026-03-16 14:44:51.211271 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-16 14:44:51.531713 | controller -> localhost | Generating public/private ecdsa key pair. 2026-03-16 14:44:51.532065 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/01c390b64bd6460c8325f3e8f6836aae/work/01c390b64bd6460c8325f3e8f6836aae_id_ecdsa. 2026-03-16 14:44:51.532127 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/01c390b64bd6460c8325f3e8f6836aae/work/01c390b64bd6460c8325f3e8f6836aae_id_ecdsa.pub. 2026-03-16 14:44:51.532188 | controller -> localhost | The key fingerprint is: 2026-03-16 14:44:51.532258 | controller -> localhost | SHA256:uq+BfgJYe4AnitAaN8ddJrE8ju6dsbcxOGW9HeGkHcE zuul-build-sshkey 2026-03-16 14:44:51.532302 | controller -> localhost | The key's randomart image is: 2026-03-16 14:44:51.532343 | controller -> localhost | +---[ECDSA 521]---+ 2026-03-16 14:44:51.532382 | controller -> localhost | | .. .. | 2026-03-16 14:44:51.532420 | controller -> localhost | | ...o E. | 2026-03-16 14:44:51.532458 | controller -> localhost | | o . .++ + | 2026-03-16 14:44:51.532495 | controller -> localhost | |= B oo.. . = o | 2026-03-16 14:44:51.532532 | controller -> localhost | |+O =. . S o + | 2026-03-16 14:44:51.532569 | controller -> localhost | |= o... = o . | 2026-03-16 14:44:51.532605 | controller -> localhost | | oo * o . . | 2026-03-16 14:44:51.532641 | controller -> localhost | | o...B.o | 2026-03-16 14:44:51.532719 | controller -> localhost | | oo*+o. | 2026-03-16 14:44:51.532762 | controller -> localhost | +----[SHA256]-----+ 2026-03-16 14:44:51.532862 | controller -> localhost | ok: Runtime: 0:00:00.014281 2026-03-16 14:44:51.546617 | 2026-03-16 14:44:51.546784 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-16 14:44:51.569473 | controller | ok 2026-03-16 14:44:51.576826 | controller | included: /var/lib/zuul/builds/01c390b64bd6460c8325f3e8f6836aae/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-16 14:44:51.585453 | 2026-03-16 14:44:51.585513 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-16 14:44:51.600077 | controller | skipping: Conditional result was False 2026-03-16 14:44:51.606799 | 2026-03-16 14:44:51.606860 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-16 14:44:51.865120 | controller | changed 2026-03-16 14:44:51.877378 | 2026-03-16 14:44:51.877516 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-16 14:44:52.109891 | controller | ok 2026-03-16 14:44:52.121944 | 2026-03-16 14:44:52.122030 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-16 14:44:52.744928 | controller | changed 2026-03-16 14:44:52.750748 | 2026-03-16 14:44:52.750811 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-16 14:44:53.359496 | controller | changed 2026-03-16 14:44:53.373558 | 2026-03-16 14:44:53.373745 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-16 14:44:53.411772 | controller | skipping: Conditional result was False 2026-03-16 14:44:53.434450 | 2026-03-16 14:44:53.434741 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-16 14:44:53.725650 | controller -> localhost | changed 2026-03-16 14:44:53.738081 | 2026-03-16 14:44:53.738148 | TASK [add-build-sshkey : Add back temp key] 2026-03-16 14:44:54.071829 | controller -> localhost | Identity added: /var/lib/zuul/builds/01c390b64bd6460c8325f3e8f6836aae/work/01c390b64bd6460c8325f3e8f6836aae_id_ecdsa (zuul-build-sshkey) 2026-03-16 14:44:54.072058 | controller -> localhost | ok: Runtime: 0:00:00.013343 2026-03-16 14:44:54.078489 | 2026-03-16 14:44:54.078546 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-16 14:44:54.290134 | controller | ok 2026-03-16 14:44:54.302026 | 2026-03-16 14:44:54.302156 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-16 14:44:54.338477 | controller | skipping: Conditional result was False 2026-03-16 14:44:54.364438 | 2026-03-16 14:44:54.364572 | TASK [include_role : remove-zuul-sshkey] 2026-03-16 14:44:54.391213 | controller | skipping: Conditional result was False 2026-03-16 14:44:54.404342 | 2026-03-16 14:44:54.404471 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-16 14:44:54.683083 | controller | ok: "logs" 2026-03-16 14:44:54.683607 | controller | ok: All items complete 2026-03-16 14:44:54.683717 | 2026-03-16 14:44:54.882632 | controller | ok: "artifacts" 2026-03-16 14:44:55.076946 | controller | ok: "docs" 2026-03-16 14:44:55.096658 | 2026-03-16 14:44:55.096778 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-16 14:44:55.351828 | controller | changed: "logs" 2026-03-16 14:44:55.575864 | controller | changed: "artifacts" 2026-03-16 14:44:55.775922 | controller | changed: "docs" 2026-03-16 14:44:55.831470 | 2026-03-16 14:44:55.831554 | PLAY RECAP 2026-03-16 14:44:55.831610 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2026-03-16 14:44:55.831645 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-16 14:44:55.831694 | 2026-03-16 14:44:55.945958 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-03-16 14:44:55.946802 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-03-16 14:44:56.564719 | 2026-03-16 14:44:56.564887 | PLAY [all] 2026-03-16 14:44:56.586732 | 2026-03-16 14:44:56.586821 | TASK [Install binary dependencies] 2026-03-16 14:44:56.656826 | controller | ok 2026-03-16 14:44:56.689922 | 2026-03-16 14:44:56.690032 | TASK [bindep : Include find tasks] 2026-03-16 14:44:56.720314 | controller | ok 2026-03-16 14:44:56.733657 | controller | included: /var/lib/zuul/builds/01c390b64bd6460c8325f3e8f6836aae/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-03-16 14:44:56.748058 | 2026-03-16 14:44:56.748198 | TASK [bindep : Look for bindep.txt] 2026-03-16 14:44:57.074933 | controller | ok 2026-03-16 14:44:57.087456 | 2026-03-16 14:44:57.087600 | TASK [bindep : Define bindep_file fact] 2026-03-16 14:44:57.115095 | controller | skipping: Conditional result was False 2026-03-16 14:44:57.128321 | 2026-03-16 14:44:57.128465 | TASK [bindep : Look for other-requirements.txt] 2026-03-16 14:44:57.362557 | controller | ok 2026-03-16 14:44:57.368360 | 2026-03-16 14:44:57.368427 | TASK [bindep : Define bindep_file fact] 2026-03-16 14:44:57.402631 | controller | skipping: Conditional result was False 2026-03-16 14:44:57.408728 | 2026-03-16 14:44:57.408793 | TASK [bindep : Look for bindep fallback file] 2026-03-16 14:44:57.452983 | controller | skipping: Conditional result was False 2026-03-16 14:44:57.463357 | 2026-03-16 14:44:57.463452 | TASK [bindep : Define bindep_file fact] 2026-03-16 14:44:57.498555 | controller | skipping: Conditional result was False 2026-03-16 14:44:57.506596 | 2026-03-16 14:44:57.506705 | TASK [bindep : Include bindep tasks] 2026-03-16 14:44:57.531292 | controller | skipping: Conditional result was False 2026-03-16 14:44:57.539763 | 2026-03-16 14:44:57.539849 | TASK [bindep : Include install tasks] 2026-03-16 14:44:57.564489 | controller | skipping: Conditional result was False 2026-03-16 14:44:57.573276 | 2026-03-16 14:44:57.573362 | LOOP [bindep : Include package tasks] 2026-03-16 14:44:57.652630 | 2026-03-16 14:44:57.653032 | TASK [Run test-setup role] 2026-03-16 14:44:57.683047 | controller | ok 2026-03-16 14:44:57.710361 | 2026-03-16 14:44:57.710447 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-03-16 14:44:57.920484 | controller | ok 2026-03-16 14:44:57.933254 | 2026-03-16 14:44:57.933384 | TASK [test-setup : Run tools/test-setup.sh] 2026-03-16 14:44:58.485144 | controller | skipping: Conditional result was False 2026-03-16 14:44:58.537729 | 2026-03-16 14:44:58.537900 | PLAY RECAP 2026-03-16 14:44:58.537984 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-03-16 14:44:58.538030 | 2026-03-16 14:44:58.647005 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-03-16 14:44:58.647913 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-03-16 14:44:59.200362 | 2026-03-16 14:44:59.200481 | PLAY [controller] 2026-03-16 14:44:59.220774 | 2026-03-16 14:44:59.220884 | TASK [Create the /root directory] 2026-03-16 14:44:59.612496 | controller | ok 2026-03-16 14:44:59.631182 | 2026-03-16 14:44:59.631340 | TASK [Install glibc-langpack-en] 2026-03-16 14:45:03.511127 | controller | ok: Nothing to do 2026-03-16 14:45:03.523388 | 2026-03-16 14:45:03.523523 | TASK [Ensure controller directory exists] 2026-03-16 14:45:03.748892 | controller | changed 2026-03-16 14:45:03.754423 | 2026-03-16 14:45:03.754487 | TASK [Install container runtime] 2026-03-16 14:45:03.810517 | controller | ok 2026-03-16 14:45:03.846885 | 2026-03-16 14:45:03.846970 | LOOP [ensure-podman : Find distribution installation] 2026-03-16 14:45:03.878230 | controller | ok: "/var/lib/zuul/builds/01c390b64bd6460c8325f3e8f6836aae/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml" 2026-03-16 14:45:03.887891 | controller | included: /var/lib/zuul/builds/01c390b64bd6460c8325f3e8f6836aae/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml 2026-03-16 14:45:03.896169 | 2026-03-16 14:45:03.896234 | TASK [ensure-podman : Install podman (RedHat)] 2026-03-16 14:46:11.756529 | controller | changed 2026-03-16 14:46:11.770855 | 2026-03-16 14:46:11.770988 | TASK [ensure-podman : Fetch podman version] 2026-03-16 14:46:12.293833 | controller | Client: Podman Engine 2026-03-16 14:46:12.318204 | controller | Version: 4.6.2 2026-03-16 14:46:12.318246 | controller | API Version: 4.6.2 2026-03-16 14:46:12.318260 | controller | Go Version: go1.19.12 2026-03-16 14:46:12.318286 | controller | Built: Mon Aug 28 19:38:31 2023 2026-03-16 14:46:12.318299 | controller | OS/Arch: linux/amd64 2026-03-16 14:46:12.821287 | controller | ok: Runtime: 0:00:00.171926 2026-03-16 14:46:12.835783 | 2026-03-16 14:46:12.835928 | TASK [ensure-podman : Print podman version installed] 2026-03-16 14:46:12.876878 | Podman version: Client: Podman Engine 2026-03-16 14:46:12.877216 | Version: 4.6.2 2026-03-16 14:46:12.877294 | API Version: 4.6.2 2026-03-16 14:46:12.877340 | Go Version: go1.19.12 2026-03-16 14:46:12.877380 | Built: Mon Aug 28 19:38:31 2023 2026-03-16 14:46:12.877419 | OS/Arch: linux/amd64 2026-03-16 14:46:12.890136 | 2026-03-16 14:46:12.890267 | TASK [ensure-podman : Validate podman engine] 2026-03-16 14:46:13.434052 | controller | skipping: Conditional result was False 2026-03-16 14:46:13.448359 | 2026-03-16 14:46:13.448494 | TASK [ensure-podman : Set up docker compatability socket] 2026-03-16 14:46:13.475648 | controller | skipping: Conditional result was False 2026-03-16 14:46:13.501151 | 2026-03-16 14:46:13.501286 | TASK [Ensure python3.8 is present] 2026-03-16 14:46:13.528012 | controller | skipping: Conditional result was False 2026-03-16 14:46:13.541146 | 2026-03-16 14:46:13.541273 | TASK [Run our-ensure-python role (Fedora only for now)] 2026-03-16 14:46:13.570532 | controller | ok 2026-03-16 14:46:13.602975 | 2026-03-16 14:46:13.603061 | TASK [our-ensure-python : Install the right Python version (rpm)] 2026-03-16 14:46:14.881462 | controller | ok: Nothing to do 2026-03-16 14:46:14.895975 | 2026-03-16 14:46:14.896106 | TASK [our-ensure-python : Also install python3-devel] 2026-03-16 14:46:26.538291 | controller | changed 2026-03-16 14:46:26.562449 | 2026-03-16 14:46:26.562583 | TASK [Run ensure-virtualenv role] 2026-03-16 14:46:26.592026 | controller | ok 2026-03-16 14:46:26.659946 | 2026-03-16 14:46:26.660076 | TASK [ensure-virtualenv : Check if virtualenv is installed] 2026-03-16 14:46:26.883435 | controller | /usr/bin/virtualenv 2026-03-16 14:46:27.192054 | controller | ok: Runtime: 0:00:00.004220 2026-03-16 14:46:27.204584 | 2026-03-16 14:46:27.204767 | LOOP [ensure-virtualenv : Install virtualenv package] 2026-03-16 14:46:27.237728 | controller | skipping: Conditional result was False 2026-03-16 14:46:27.238036 | controller | ok: All items complete 2026-03-16 14:46:27.238074 | 2026-03-16 14:46:27.267699 | 2026-03-16 14:46:27.267928 | TASK [Find the full path of the Python interpreter] 2026-03-16 14:46:27.483287 | controller | /usr/bin/python3 2026-03-16 14:46:27.815447 | controller | ok 2026-03-16 14:46:27.823125 | 2026-03-16 14:46:27.823208 | TASK [Create virtualenv for ansible-test with a specific interpreter] 2026-03-16 14:46:28.613327 | controller | created virtual environment CPython3.11.0.final.0-64 in 440ms 2026-03-16 14:46:28.644915 | controller | creator CPython3Posix(dest=/home/zuul/venv, clear=False, no_vcs_ignore=False, global=False) 2026-03-16 14:46:28.644958 | 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 14:46:28.644981 | controller | added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1 2026-03-16 14:46:28.644999 | controller | activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator 2026-03-16 14:46:28.863860 | controller | changed 2026-03-16 14:46:28.877298 | 2026-03-16 14:46:28.877425 | TASK [Set selinux package] 2026-03-16 14:46:28.917380 | controller | ok 2026-03-16 14:46:28.929064 | 2026-03-16 14:46:28.929191 | TASK [Set selinux package (Fedora)] 2026-03-16 14:46:28.978261 | controller | ok 2026-03-16 14:46:28.989620 | 2026-03-16 14:46:28.989800 | TASK [Install selinux into virtualenv] 2026-03-16 14:47:06.429148 | controller | Collecting selinux-please-lie-to-me 2026-03-16 14:47:18.663251 | controller | Downloading selinux_please_lie_to_me-1.0.1-py2.py3-none-any.whl (3.8 kB) 2026-03-16 14:47:18.999768 | controller | Collecting setuptools<50.0.0 2026-03-16 14:47:19.003840 | controller | Downloading setuptools-49.6.0-py3-none-any.whl (803 kB) 2026-03-16 14:47:19.036485 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 803.3/803.3 kB 27.0 MB/s eta 0:00:00 2026-03-16 14:47:19.121212 | controller | Installing collected packages: setuptools, selinux-please-lie-to-me 2026-03-16 14:47:19.121441 | controller | Attempting uninstall: setuptools 2026-03-16 14:47:19.123922 | controller | Found existing installation: setuptools 62.6.0 2026-03-16 14:47:19.193886 | controller | Uninstalling setuptools-62.6.0: 2026-03-16 14:47:19.202363 | controller | Successfully uninstalled setuptools-62.6.0 2026-03-16 14:47:19.540730 | controller | Successfully installed selinux-please-lie-to-me-1.0.1 setuptools-49.6.0 2026-03-16 14:47:34.898310 | controller | 2026-03-16 14:47:34.976404 | controller | [notice] A new release of pip available: 22.2.2 -> 26.0.1 2026-03-16 14:47:34.976445 | controller | [notice] To update, run: python -m pip install --upgrade pip 2026-03-16 14:47:35.118585 | controller | ok: Runtime: 0:01:05.769282 2026-03-16 14:47:35.137733 | 2026-03-16 14:47:35.137916 | TASK [Install pytest-forked into virtualenv] 2026-03-16 14:48:01.065947 | controller | Collecting pytest-forked 2026-03-16 14:48:13.316398 | controller | Downloading pytest_forked-1.6.0-py3-none-any.whl (4.9 kB) 2026-03-16 14:48:13.359880 | controller | Collecting py 2026-03-16 14:48:13.363587 | controller | Downloading py-1.11.0-py2.py3-none-any.whl (98 kB) 2026-03-16 14:48:13.383963 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.7/98.7 kB 5.2 MB/s eta 0:00:00 2026-03-16 14:48:13.492649 | controller | Collecting pytest>=3.10 2026-03-16 14:48:13.495797 | controller | Downloading pytest-9.0.2-py3-none-any.whl (374 kB) 2026-03-16 14:48:13.515180 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 374.8/374.8 kB 22.1 MB/s eta 0:00:00 2026-03-16 14:48:13.552120 | controller | Collecting iniconfig>=1.0.1 2026-03-16 14:48:13.555844 | controller | Downloading iniconfig-2.3.0-py3-none-any.whl (7.5 kB) 2026-03-16 14:48:13.602018 | controller | Collecting packaging>=22 2026-03-16 14:48:13.605017 | controller | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-03-16 14:48:13.611933 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 20.1 MB/s eta 0:00:00 2026-03-16 14:48:13.645256 | controller | Collecting pluggy<2,>=1.5 2026-03-16 14:48:13.648325 | controller | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-03-16 14:48:13.693670 | controller | Collecting pygments>=2.7.2 2026-03-16 14:48:13.696992 | controller | Downloading pygments-2.19.2-py3-none-any.whl (1.2 MB) 2026-03-16 14:48:13.716676 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.2/1.2 MB 68.9 MB/s eta 0:00:00 2026-03-16 14:48:13.786285 | controller | Installing collected packages: pygments, py, pluggy, packaging, iniconfig, pytest, pytest-forked 2026-03-16 14:48:14.815413 | 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 14:48:14.823875 | controller | 2026-03-16 14:48:14.892201 | controller | [notice] A new release of pip available: 22.2.2 -> 26.0.1 2026-03-16 14:48:14.892244 | controller | [notice] To update, run: python -m pip install --upgrade pip 2026-03-16 14:48:15.207003 | controller | ok: Runtime: 0:00:39.427228 2026-03-16 14:48:15.219626 | 2026-03-16 14:48:15.219790 | TASK [Update pip] 2026-03-16 14:48:15.782204 | controller | Requirement already satisfied: pip in ./venv/lib/python3.11/site-packages (22.2.2) 2026-03-16 14:48:49.570912 | controller | Collecting pip 2026-03-16 14:49:01.893921 | controller | Downloading pip-26.0.1-py3-none-any.whl (1.8 MB) 2026-03-16 14:49:01.951901 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.8/1.8 MB 32.9 MB/s eta 0:00:00 2026-03-16 14:49:02.017405 | controller | Installing collected packages: pip 2026-03-16 14:49:02.017504 | controller | Attempting uninstall: pip 2026-03-16 14:49:02.019664 | controller | Found existing installation: pip 22.2.2 2026-03-16 14:49:02.156513 | controller | Uninstalling pip-22.2.2: 2026-03-16 14:49:02.171150 | controller | Successfully uninstalled pip-22.2.2 2026-03-16 14:49:02.991471 | controller | Successfully installed pip-26.0.1 2026-03-16 14:49:03.323233 | controller | ok: Runtime: 0:00:47.579384 2026-03-16 14:49:03.336200 | 2026-03-16 14:49:03.336331 | TASK [Ensure pip temp directory exists in /var/tmp] 2026-03-16 14:49:03.559881 | controller | changed 2026-03-16 14:49:03.572411 | 2026-03-16 14:49:03.572549 | TASK [Install ansible into virtualenv] 2026-03-16 14:49:04.081718 | controller | Processing ./src/github.com/ansible/ansible 2026-03-16 14:49:04.084112 | controller | Installing build dependencies: started 2026-03-16 14:49:50.638120 | controller | Installing build dependencies: finished with status 'done' 2026-03-16 14:49:50.638715 | controller | Getting requirements to build wheel: started 2026-03-16 14:49:51.372444 | controller | Getting requirements to build wheel: finished with status 'done' 2026-03-16 14:49:51.373679 | controller | Preparing metadata (pyproject.toml): started 2026-03-16 14:49:51.844159 | controller | Preparing metadata (pyproject.toml): finished with status 'done' 2026-03-16 14:49:51.849236 | 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 14:49:51.854928 | controller | ERROR: Package 'ansible-core' requires a different Python: 3.11.0 not in '>=3.12' 2026-03-16 14:49:52.169783 | controller | ERROR 2026-03-16 14:49:52.170035 | controller | { 2026-03-16 14:49:52.170099 | controller | "delta": "0:00:48.116282", 2026-03-16 14:49:52.170142 | controller | "end": "2026-03-16 14:49:51.919232", 2026-03-16 14:49:52.170180 | controller | "msg": "non-zero return code", 2026-03-16 14:49:52.170241 | controller | "rc": 1, 2026-03-16 14:49:52.170280 | controller | "start": "2026-03-16 14:49:03.802950" 2026-03-16 14:49:52.170315 | controller | } failure 2026-03-16 14:49:52.173969 | 2026-03-16 14:49:52.174168 | PLAY RECAP 2026-03-16 14:49:52.174264 | controller | ok: 18 changed: 10 unreachable: 0 failed: 1 skipped: 4 rescued: 0 ignored: 0 2026-03-16 14:49:52.174309 | 2026-03-16 14:49:52.314805 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-03-16 14:49:52.317317 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-16 14:49:52.889840 | 2026-03-16 14:49:52.889993 | PLAY [all] 2026-03-16 14:49:52.911358 | 2026-03-16 14:49:52.911454 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-03-16 14:49:53.175518 | controller | changed: non-zero return code 2026-03-16 14:49:53.193621 | 2026-03-16 14:49:53.193929 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-03-16 14:49:53.212763 | controller | skipping: Conditional result was False 2026-03-16 14:49:53.226711 | 2026-03-16 14:49:53.226818 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-03-16 14:49:53.253894 | 2026-03-16 14:49:53.254068 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-03-16 14:49:53.287801 | 2026-03-16 14:49:53.288022 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-03-16 14:49:53.312571 | controller | skipping: Conditional result was False 2026-03-16 14:49:53.320103 | 2026-03-16 14:49:53.320170 | LOOP [fetch-subunit-output : Generate subunit file] 2026-03-16 14:49:53.353990 | 2026-03-16 14:49:53.354271 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-03-16 14:49:53.390240 | controller | skipping: Conditional result was False 2026-03-16 14:49:53.398895 | 2026-03-16 14:49:53.398983 | TASK [fetch-subunit-output : Remove the temporary file] 2026-03-16 14:49:53.414187 | controller | skipping: Conditional result was False 2026-03-16 14:49:53.421127 | 2026-03-16 14:49:53.421203 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-03-16 14:49:53.446545 | controller | skipping: Conditional result was False 2026-03-16 14:49:53.473324 | 2026-03-16 14:49:53.473373 | PLAY RECAP 2026-03-16 14:49:53.473417 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-03-16 14:49:53.473436 | 2026-03-16 14:49:53.566556 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-16 14:49:53.568844 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2026-03-16 14:49:54.145854 | 2026-03-16 14:49:54.145959 | PLAY [all:!appliance*] 2026-03-16 14:49:54.167121 | 2026-03-16 14:49:54.167203 | TASK [unregister the node] 2026-03-16 14:49:54.697659 | controller | skipping: Conditional result was False 2026-03-16 14:49:54.706120 | 2026-03-16 14:49:54.706224 | TASK [include_role : fetch-output] 2026-03-16 14:49:54.735330 | controller | ok 2026-03-16 14:49:54.754055 | 2026-03-16 14:49:54.754118 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-16 14:49:54.792622 | controller | skipping: Conditional result was False 2026-03-16 14:49:54.801294 | 2026-03-16 14:49:54.801398 | TASK [fetch-output : Set log path for single node] 2026-03-16 14:49:54.849191 | controller | ok 2026-03-16 14:49:54.869050 | 2026-03-16 14:49:54.869183 | LOOP [fetch-output : Ensure local output dirs] 2026-03-16 14:49:55.205859 | controller -> localhost | ok: "/var/lib/zuul/builds/01c390b64bd6460c8325f3e8f6836aae/work/logs" 2026-03-16 14:49:55.498311 | controller -> localhost | changed: "/var/lib/zuul/builds/01c390b64bd6460c8325f3e8f6836aae/work/artifacts" 2026-03-16 14:49:55.755902 | controller -> localhost | changed: "/var/lib/zuul/builds/01c390b64bd6460c8325f3e8f6836aae/work/docs" 2026-03-16 14:49:55.781274 | 2026-03-16 14:49:55.781380 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-16 14:49:56.342086 | controller | changed: 2026-03-16 14:49:56.342425 | controller | .d..t...... ./ 2026-03-16 14:49:56.342465 | controller | cd+++++++++ controller/ 2026-03-16 14:49:56.342510 | controller | changed: All items complete 2026-03-16 14:49:56.342531 | 2026-03-16 14:49:56.799221 | controller | changed: .d..t...... ./ 2026-03-16 14:49:57.279374 | controller | changed: .d..t...... ./ 2026-03-16 14:49:57.302187 | 2026-03-16 14:49:57.302302 | TASK [include_role : fetch-output-openshift] 2026-03-16 14:49:57.315811 | controller | skipping: Conditional result was False 2026-03-16 14:49:57.322691 | 2026-03-16 14:49:57.322755 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-16 14:49:57.715828 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.007280 2026-03-16 14:49:57.925580 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.010093 2026-03-16 14:49:57.962682 | 2026-03-16 14:49:57.962790 | PLAY [localhost] 2026-03-16 14:49:57.975755 | 2026-03-16 14:49:57.975813 | TASK [Run Zuul manifest role] 2026-03-16 14:49:57.994266 | localhost | ok 2026-03-16 14:49:58.007054 | 2026-03-16 14:49:58.007136 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-16 14:49:58.403079 | localhost | changed 2026-03-16 14:49:58.408495 | 2026-03-16 14:49:58.408584 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-16 14:49:58.448501 | localhost | ok 2026-03-16 14:49:58.457148 | 2026-03-16 14:49:58.457208 | TASK [Set zuul-log-path fact] 2026-03-16 14:49:58.474694 | localhost | ok 2026-03-16 14:49:58.487811 | 2026-03-16 14:49:58.487876 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-16 14:49:58.525334 | localhost | ok 2026-03-16 14:49:58.533501 | 2026-03-16 14:49:58.533563 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)] 2026-03-16 14:49:58.574629 | localhost | ok: 2026-03-16 14:49:58.575036 | localhost | { 2026-03-16 14:49:58.575091 | localhost | "auth": { 2026-03-16 14:49:58.575149 | localhost | "password": "IonWCwcuOFib&&<}wp^:[2G/", 2026-03-16 14:49:58.575189 | localhost | "username": "9LF91O0RK7JU" 2026-03-16 14:49:58.575254 | localhost | }, 2026-03-16 14:49:58.575303 | localhost | "profile": "rackspace", 2026-03-16 14:49:58.575351 | localhost | "region_name": "ORD" 2026-03-16 14:49:58.575399 | localhost | } 2026-03-16 14:49:58.575486 | localhost | changed: All items complete 2026-03-16 14:49:58.575542 | 2026-03-16 14:49:58.581761 | 2026-03-16 14:49:58.581829 | TASK [Run upload-logs-failover role (S3 then Swift)] 2026-03-16 14:49:58.598783 | localhost | Output suppressed because no_log was given 2026-03-16 14:49:58.613726 | 2026-03-16 14:49:58.613801 | TASK [upload-logs-failover : Initialize control vars] 2026-03-16 14:49:58.675107 | localhost | ok 2026-03-16 14:49:58.679246 | 2026-03-16 14:49:58.679305 | LOOP [upload-logs-failover : Perform log upload] 2026-03-16 14:49:58.713807 | localhost | Output suppressed because no_log was given 2026-03-16 14:49:58.720137 | localhost | included: /var/lib/zuul/builds/01c390b64bd6460c8325f3e8f6836aae/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml 2026-03-16 14:49:58.726954 | 2026-03-16 14:49:58.727021 | LOOP [upload-logs-failover : Unpack vars for swift upload] 2026-03-16 14:49:58.813940 | localhost | Output suppressed because no_log was given 2026-03-16 14:49:58.819329 | 2026-03-16 14:49:58.819395 | TASK [Upload logs to swift] 2026-03-16 14:49:58.839195 | localhost | ok 2026-03-16 14:49:58.865088 | 2026-03-16 14:49:58.865149 | TASK [Set zuul-log-path fact] 2026-03-16 14:49:58.899144 | localhost | skipping: Conditional result was False 2026-03-16 14:49:58.904348 | 2026-03-16 14:49:58.904413 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2026-03-16 14:49:59.172602 | localhost -> localhost | ok: Runtime: 0:00:00.005002 2026-03-16 14:49:59.178267 | 2026-03-16 14:49:59.178355 | TASK [upload-logs-swift : Upload logs to swift]