2026-03-16 16:11:38.019730 | Job console starting... 2026-03-16 16:11:38.033287 | Updating repositories 2026-03-16 16:11:38.181050 | Preparing job workspace 2026-03-16 16:11:42.866381 | Running Ansible setup... 2026-03-16 16:11:47.633043 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-03-16 16:11:48.314058 | 2026-03-16 16:11:48.314178 | PLAY [localhost] 2026-03-16 16:11:48.322626 | 2026-03-16 16:11:48.322707 | TASK [Gathering Facts] 2026-03-16 16:11:49.374838 | localhost | ok 2026-03-16 16:11:49.405713 | 2026-03-16 16:11:49.405931 | TASK [Setup log path fact] 2026-03-16 16:11:49.429226 | localhost | ok 2026-03-16 16:11:49.447838 | 2026-03-16 16:11:49.447987 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-16 16:11:49.489524 | localhost | ok 2026-03-16 16:11:49.507246 | 2026-03-16 16:11:49.507388 | TASK [emit-job-header : Print job information] 2026-03-16 16:11:49.559046 | # Job Information 2026-03-16 16:11:49.559233 | Ansible Version: 2.15.12 2026-03-16 16:11:49.559277 | Job: ansible-test-sanity-okd-downstream-devel 2026-03-16 16:11:49.559443 | Pipeline: third-party-check 2026-03-16 16:11:49.559473 | Executor: ze01.softwarefactory-project.io 2026-03-16 16:11:49.559501 | Triggered by: https://github.com/openshift/community.okd/pull/274 2026-03-16 16:11:49.559532 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/b45/ansible/b45de901ddc342b8953760df45db7850/ 2026-03-16 16:11:49.559561 | Event ID: cb44fe40-2151-11f1-85ca-bed5723f367f 2026-03-16 16:11:49.565141 | 2026-03-16 16:11:49.565243 | LOOP [emit-job-header : Print node information] 2026-03-16 16:11:49.703955 | localhost | ok: 2026-03-16 16:11:49.704334 | localhost | # Node Information 2026-03-16 16:11:49.704375 | localhost | Inventory Hostname: controller 2026-03-16 16:11:49.704397 | localhost | Hostname: np0005648643 2026-03-16 16:11:49.704417 | localhost | Username: zuul 2026-03-16 16:11:49.704440 | localhost | Distro: Fedora 37 2026-03-16 16:11:49.704458 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2026-03-16 16:11:49.704476 | localhost | Region: ca-ymq-1 2026-03-16 16:11:49.704494 | localhost | Label: ansible-fedora-37-1vcpu 2026-03-16 16:11:49.704510 | localhost | Product Name: OpenStack Nova 2026-03-16 16:11:49.704642 | localhost | Interface IP: 199.204.45.157 2026-03-16 16:11:49.728800 | 2026-03-16 16:11:49.728953 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-16 16:11:50.143154 | localhost -> localhost | changed 2026-03-16 16:11:50.154390 | 2026-03-16 16:11:50.154576 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-16 16:11:51.110512 | localhost -> localhost | changed 2026-03-16 16:11:51.151572 | 2026-03-16 16:11:51.151694 | PLAY [all:!appliance*] 2026-03-16 16:11:51.182323 | 2026-03-16 16:11:51.182415 | TASK [include_role : start-zuul-console] 2026-03-16 16:11:51.204523 | controller | ok 2026-03-16 16:11:51.222717 | 2026-03-16 16:11:51.222804 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-16 16:11:51.595511 | controller | ok 2026-03-16 16:11:51.619394 | 2026-03-16 16:11:51.619549 | TASK [use-our-mirror : Retrieve the IP address] 2026-03-16 16:12:13.914161 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2026-03-16 16:12:13.928605 | 2026-03-16 16:12:13.928746 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2026-03-16 16:12:14.493587 | controller | skipping: Conditional result was False 2026-03-16 16:12:14.508317 | 2026-03-16 16:12:14.508524 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2026-03-16 16:12:14.546357 | controller | skipping: Conditional result was False 2026-03-16 16:12:14.561639 | 2026-03-16 16:12:14.561814 | TASK [use-our-mirror : Create the podman configuration directory] 2026-03-16 16:12:14.599504 | controller | skipping: Conditional result was False 2026-03-16 16:12:14.614411 | 2026-03-16 16:12:14.614580 | TASK [use-our-mirror : Copy the podman configuration] 2026-03-16 16:12:14.641403 | controller | skipping: Conditional result was False 2026-03-16 16:12:14.655685 | 2026-03-16 16:12:14.655836 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2026-03-16 16:12:14.682652 | controller | skipping: Conditional result was False 2026-03-16 16:12:14.698011 | 2026-03-16 16:12:14.698217 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2026-03-16 16:12:14.725451 | controller | skipping: Conditional result was False 2026-03-16 16:12:14.738203 | 2026-03-16 16:12:14.738363 | TASK [Disable Fedora Modular] 2026-03-16 16:12:15.145635 | controller | changed 2026-03-16 16:12:15.158391 | 2026-03-16 16:12:15.158525 | TASK [Enable EPEL] 2026-03-16 16:12:15.185687 | controller | skipping: Conditional result was False 2026-03-16 16:12:15.201246 | 2026-03-16 16:12:15.201448 | TASK [Register the RHEL node] 2026-03-16 16:12:15.772636 | 2026-03-16 16:12:15.772907 | TASK [Show the subscription-manager status] 2026-03-16 16:12:16.343615 | controller | skipping: Conditional result was False 2026-03-16 16:12:16.357996 | 2026-03-16 16:12:16.358173 | TASK [Enable EPEL on RHEL] 2026-03-16 16:12:16.449676 | controller | skipping: Conditional result was False 2026-03-16 16:12:16.458767 | 2026-03-16 16:12:16.458878 | TASK [Install git and tox] 2026-03-16 16:13:11.208844 | controller | changed 2026-03-16 16:13:11.225157 | 2026-03-16 16:13:11.225347 | TASK [include_role : prepare-workspace] 2026-03-16 16:13:11.263190 | controller | ok 2026-03-16 16:13:11.299690 | 2026-03-16 16:13:11.299861 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-16 16:13:11.556957 | controller | ok 2026-03-16 16:13:11.564637 | 2026-03-16 16:13:11.564737 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-16 16:13:25.429763 | controller | Output suppressed because no_log was given 2026-03-16 16:13:25.445196 | 2026-03-16 16:13:25.445349 | TASK [include_role : prepare-workspace-openshift] 2026-03-16 16:13:25.484378 | controller | skipping: Conditional result was False 2026-03-16 16:13:25.508501 | 2026-03-16 16:13:25.508575 | PLAY [all:!appliance] 2026-03-16 16:13:25.525335 | 2026-03-16 16:13:25.525403 | TASK [Run add-build-sshkey role (RSA)] 2026-03-16 16:13:25.544516 | controller | ok 2026-03-16 16:13:25.560442 | 2026-03-16 16:13:25.560529 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-16 16:13:25.788952 | controller -> localhost | ok 2026-03-16 16:13:25.795623 | 2026-03-16 16:13:25.795691 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-16 16:13:25.815835 | controller | ok 2026-03-16 16:13:25.831294 | controller | included: /var/lib/zuul/builds/b45de901ddc342b8953760df45db7850/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-16 16:13:25.837539 | 2026-03-16 16:13:25.837603 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-16 16:13:26.350427 | controller -> localhost | Generating public/private rsa key pair. 2026-03-16 16:13:26.350667 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/b45de901ddc342b8953760df45db7850/work/b45de901ddc342b8953760df45db7850_id_rsa. 2026-03-16 16:13:26.350708 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/b45de901ddc342b8953760df45db7850/work/b45de901ddc342b8953760df45db7850_id_rsa.pub. 2026-03-16 16:13:26.350739 | controller -> localhost | The key fingerprint is: 2026-03-16 16:13:26.350767 | controller -> localhost | SHA256:SQ02PTTQ1UPZJEjMZoWNFXH3hsPPzueuncV3uoOavA8 zuul-build-sshkey 2026-03-16 16:13:26.350795 | controller -> localhost | The key's randomart image is: 2026-03-16 16:13:26.350821 | controller -> localhost | +---[RSA 2048]----+ 2026-03-16 16:13:26.350847 | controller -> localhost | | ==o=oXB*+| 2026-03-16 16:13:26.350874 | controller -> localhost | | . ++.O.=++| 2026-03-16 16:13:26.350899 | controller -> localhost | | . .+ +.o| 2026-03-16 16:13:26.350925 | controller -> localhost | | . . = | 2026-03-16 16:13:26.350949 | controller -> localhost | | S o| 2026-03-16 16:13:26.350984 | controller -> localhost | | + | 2026-03-16 16:13:26.351035 | controller -> localhost | | E . O| 2026-03-16 16:13:26.351072 | controller -> localhost | | . o. .+*| 2026-03-16 16:13:26.351100 | controller -> localhost | | =+. +*+| 2026-03-16 16:13:26.351129 | controller -> localhost | +----[SHA256]-----+ 2026-03-16 16:13:26.351192 | controller -> localhost | ok: Runtime: 0:00:00.108838 2026-03-16 16:13:26.360854 | 2026-03-16 16:13:26.360937 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-16 16:13:26.393900 | controller | ok 2026-03-16 16:13:26.408983 | controller | included: /var/lib/zuul/builds/b45de901ddc342b8953760df45db7850/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-16 16:13:26.420948 | 2026-03-16 16:13:26.421051 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-16 16:13:26.445639 | controller | skipping: Conditional result was False 2026-03-16 16:13:26.451599 | 2026-03-16 16:13:26.451659 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-16 16:13:26.933750 | controller | changed 2026-03-16 16:13:26.941964 | 2026-03-16 16:13:26.942101 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-16 16:13:27.173685 | controller | ok 2026-03-16 16:13:27.186545 | 2026-03-16 16:13:27.186705 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-16 16:13:27.786409 | controller | changed 2026-03-16 16:13:27.835666 | 2026-03-16 16:13:27.835825 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-16 16:13:28.543877 | controller | changed 2026-03-16 16:13:28.557182 | 2026-03-16 16:13:28.557346 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-16 16:13:28.583143 | controller | skipping: Conditional result was False 2026-03-16 16:13:28.593926 | 2026-03-16 16:13:28.594078 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-16 16:13:28.969154 | controller -> localhost | changed 2026-03-16 16:13:28.997941 | 2026-03-16 16:13:28.998170 | TASK [add-build-sshkey : Add back temp key] 2026-03-16 16:13:29.334228 | controller -> localhost | Identity added: /var/lib/zuul/builds/b45de901ddc342b8953760df45db7850/work/b45de901ddc342b8953760df45db7850_id_rsa (zuul-build-sshkey) 2026-03-16 16:13:29.334628 | controller -> localhost | ok: Runtime: 0:00:00.014065 2026-03-16 16:13:29.349975 | 2026-03-16 16:13:29.350279 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-16 16:13:29.693689 | controller | ok 2026-03-16 16:13:29.702126 | 2026-03-16 16:13:29.702239 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-16 16:13:29.739156 | controller | skipping: Conditional result was False 2026-03-16 16:13:29.767208 | 2026-03-16 16:13:29.767368 | TASK [Run add-build-sshkey role (ECDSA)] 2026-03-16 16:13:29.802767 | controller | ok 2026-03-16 16:13:29.829478 | 2026-03-16 16:13:29.829625 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-16 16:13:30.141075 | controller -> localhost | ok 2026-03-16 16:13:30.155708 | 2026-03-16 16:13:30.155847 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-16 16:13:30.198304 | controller | ok 2026-03-16 16:13:30.220898 | controller | included: /var/lib/zuul/builds/b45de901ddc342b8953760df45db7850/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-16 16:13:30.230157 | 2026-03-16 16:13:30.230241 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-16 16:13:30.582822 | controller -> localhost | Generating public/private ecdsa key pair. 2026-03-16 16:13:30.583355 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/b45de901ddc342b8953760df45db7850/work/b45de901ddc342b8953760df45db7850_id_ecdsa. 2026-03-16 16:13:30.583422 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/b45de901ddc342b8953760df45db7850/work/b45de901ddc342b8953760df45db7850_id_ecdsa.pub. 2026-03-16 16:13:30.583483 | controller -> localhost | The key fingerprint is: 2026-03-16 16:13:30.583527 | controller -> localhost | SHA256:gIEM16ZsPQfKhagan9mpkOlAzKwxtvlMq2tqZdYr2hA zuul-build-sshkey 2026-03-16 16:13:30.583599 | controller -> localhost | The key's randomart image is: 2026-03-16 16:13:30.583664 | controller -> localhost | +---[ECDSA 521]---+ 2026-03-16 16:13:30.583707 | controller -> localhost | |.+.+. | 2026-03-16 16:13:30.583746 | controller -> localhost | |..+ =o | 2026-03-16 16:13:30.583786 | controller -> localhost | |=o *... | 2026-03-16 16:13:30.583824 | controller -> localhost | |=** o .. | 2026-03-16 16:13:30.583861 | controller -> localhost | |=Eo+.+ S | 2026-03-16 16:13:30.583898 | controller -> localhost | |Bo==o. | 2026-03-16 16:13:30.583934 | controller -> localhost | |ooB.. . | 2026-03-16 16:13:30.583971 | controller -> localhost | | ++= . | 2026-03-16 16:13:30.584007 | controller -> localhost | |=++.. | 2026-03-16 16:13:30.584091 | controller -> localhost | +----[SHA256]-----+ 2026-03-16 16:13:30.584198 | controller -> localhost | ok: Runtime: 0:00:00.013825 2026-03-16 16:13:30.599464 | 2026-03-16 16:13:30.599652 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-16 16:13:30.638686 | controller | ok 2026-03-16 16:13:30.655782 | controller | included: /var/lib/zuul/builds/b45de901ddc342b8953760df45db7850/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-16 16:13:30.670540 | 2026-03-16 16:13:30.670622 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-16 16:13:30.695745 | controller | skipping: Conditional result was False 2026-03-16 16:13:30.711343 | 2026-03-16 16:13:30.711479 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-16 16:13:31.011124 | controller | changed 2026-03-16 16:13:31.029123 | 2026-03-16 16:13:31.029343 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-16 16:13:31.265323 | controller | ok 2026-03-16 16:13:31.281321 | 2026-03-16 16:13:31.281464 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-16 16:13:31.949782 | controller | changed 2026-03-16 16:13:31.957326 | 2026-03-16 16:13:31.957412 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-16 16:13:32.636677 | controller | changed 2026-03-16 16:13:32.651362 | 2026-03-16 16:13:32.651495 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-16 16:13:32.678493 | controller | skipping: Conditional result was False 2026-03-16 16:13:32.692962 | 2026-03-16 16:13:32.693139 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-16 16:13:32.996218 | controller -> localhost | changed 2026-03-16 16:13:33.021543 | 2026-03-16 16:13:33.022290 | TASK [add-build-sshkey : Add back temp key] 2026-03-16 16:13:33.380069 | controller -> localhost | Identity added: /var/lib/zuul/builds/b45de901ddc342b8953760df45db7850/work/b45de901ddc342b8953760df45db7850_id_ecdsa (zuul-build-sshkey) 2026-03-16 16:13:33.380427 | controller -> localhost | ok: Runtime: 0:00:00.040171 2026-03-16 16:13:33.392448 | 2026-03-16 16:13:33.392575 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-16 16:13:33.626823 | controller | ok 2026-03-16 16:13:33.639644 | 2026-03-16 16:13:33.639804 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-16 16:13:33.686855 | controller | skipping: Conditional result was False 2026-03-16 16:13:33.713591 | 2026-03-16 16:13:33.713764 | TASK [include_role : remove-zuul-sshkey] 2026-03-16 16:13:33.740656 | controller | skipping: Conditional result was False 2026-03-16 16:13:33.756823 | 2026-03-16 16:13:33.757011 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-16 16:13:34.025481 | controller | ok: "logs" 2026-03-16 16:13:34.025772 | controller | ok: All items complete 2026-03-16 16:13:34.025812 | 2026-03-16 16:13:34.229781 | controller | ok: "artifacts" 2026-03-16 16:13:34.409143 | controller | ok: "docs" 2026-03-16 16:13:34.420712 | 2026-03-16 16:13:34.420811 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-16 16:13:34.662971 | controller | changed: "logs" 2026-03-16 16:13:34.878682 | controller | changed: "artifacts" 2026-03-16 16:13:35.072713 | controller | changed: "docs" 2026-03-16 16:13:35.140553 | 2026-03-16 16:13:35.140663 | PLAY RECAP 2026-03-16 16:13:35.140718 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2026-03-16 16:13:35.140754 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-16 16:13:35.140780 | 2026-03-16 16:13:35.257675 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-03-16 16:13:35.259485 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-03-16 16:13:35.872126 | 2026-03-16 16:13:35.872241 | PLAY [all] 2026-03-16 16:13:35.894171 | 2026-03-16 16:13:35.894286 | TASK [Install binary dependencies] 2026-03-16 16:13:35.974432 | controller | ok 2026-03-16 16:13:35.995160 | 2026-03-16 16:13:35.995269 | TASK [bindep : Include find tasks] 2026-03-16 16:13:36.035141 | controller | ok 2026-03-16 16:13:36.043855 | controller | included: /var/lib/zuul/builds/b45de901ddc342b8953760df45db7850/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-03-16 16:13:36.050538 | 2026-03-16 16:13:36.050609 | TASK [bindep : Look for bindep.txt] 2026-03-16 16:13:36.424506 | controller | ok 2026-03-16 16:13:36.437177 | 2026-03-16 16:13:36.437323 | TASK [bindep : Define bindep_file fact] 2026-03-16 16:13:36.464680 | controller | skipping: Conditional result was False 2026-03-16 16:13:36.477676 | 2026-03-16 16:13:36.477816 | TASK [bindep : Look for other-requirements.txt] 2026-03-16 16:13:36.709474 | controller | ok 2026-03-16 16:13:36.721382 | 2026-03-16 16:13:36.721526 | TASK [bindep : Define bindep_file fact] 2026-03-16 16:13:36.758821 | controller | skipping: Conditional result was False 2026-03-16 16:13:36.772808 | 2026-03-16 16:13:36.772953 | TASK [bindep : Look for bindep fallback file] 2026-03-16 16:13:36.810219 | controller | skipping: Conditional result was False 2026-03-16 16:13:36.823612 | 2026-03-16 16:13:36.823777 | TASK [bindep : Define bindep_file fact] 2026-03-16 16:13:36.860888 | controller | skipping: Conditional result was False 2026-03-16 16:13:36.874062 | 2026-03-16 16:13:36.874196 | TASK [bindep : Include bindep tasks] 2026-03-16 16:13:36.911557 | controller | skipping: Conditional result was False 2026-03-16 16:13:36.925616 | 2026-03-16 16:13:36.925814 | TASK [bindep : Include install tasks] 2026-03-16 16:13:36.963442 | controller | skipping: Conditional result was False 2026-03-16 16:13:36.977515 | 2026-03-16 16:13:36.977673 | LOOP [bindep : Include package tasks] 2026-03-16 16:13:37.062487 | 2026-03-16 16:13:37.062782 | TASK [Run test-setup role] 2026-03-16 16:13:37.091775 | controller | ok 2026-03-16 16:13:37.125596 | 2026-03-16 16:13:37.125757 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-03-16 16:13:37.367169 | controller | ok 2026-03-16 16:13:37.380449 | 2026-03-16 16:13:37.380658 | TASK [test-setup : Run tools/test-setup.sh] 2026-03-16 16:13:37.931521 | controller | skipping: Conditional result was False 2026-03-16 16:13:37.992600 | 2026-03-16 16:13:37.992700 | PLAY RECAP 2026-03-16 16:13:37.992751 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-03-16 16:13:37.992780 | 2026-03-16 16:13:38.090894 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-03-16 16:13:38.091728 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-03-16 16:13:38.700312 | 2026-03-16 16:13:38.700460 | PLAY [controller] 2026-03-16 16:13:38.720888 | 2026-03-16 16:13:38.720989 | TASK [Create the /root directory] 2026-03-16 16:13:39.156200 | controller | ok 2026-03-16 16:13:39.162059 | 2026-03-16 16:13:39.162152 | TASK [Install glibc-langpack-en] 2026-03-16 16:13:43.176410 | controller | ok: Nothing to do 2026-03-16 16:13:43.190816 | 2026-03-16 16:13:43.190986 | TASK [Ensure controller directory exists] 2026-03-16 16:13:43.427716 | controller | changed 2026-03-16 16:13:43.438809 | 2026-03-16 16:13:43.438907 | TASK [Install container runtime] 2026-03-16 16:13:43.496712 | controller | ok 2026-03-16 16:13:43.558248 | 2026-03-16 16:13:43.558398 | LOOP [ensure-podman : Find distribution installation] 2026-03-16 16:13:43.583600 | controller | ok: "/var/lib/zuul/builds/b45de901ddc342b8953760df45db7850/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml" 2026-03-16 16:13:43.603180 | controller | included: /var/lib/zuul/builds/b45de901ddc342b8953760df45db7850/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml 2026-03-16 16:13:43.611659 | 2026-03-16 16:13:43.611737 | TASK [ensure-podman : Install podman (RedHat)] 2026-03-16 16:15:00.136250 | controller | changed 2026-03-16 16:15:00.153193 | 2026-03-16 16:15:00.153310 | TASK [ensure-podman : Fetch podman version] 2026-03-16 16:15:00.692857 | controller | Client: Podman Engine 2026-03-16 16:15:00.720039 | controller | Version: 4.6.2 2026-03-16 16:15:00.720091 | controller | API Version: 4.6.2 2026-03-16 16:15:00.720100 | controller | Go Version: go1.19.12 2026-03-16 16:15:00.720119 | controller | Built: Mon Aug 28 19:38:31 2023 2026-03-16 16:15:00.720127 | controller | OS/Arch: linux/amd64 2026-03-16 16:15:01.196855 | controller | ok: Runtime: 0:00:00.200634 2026-03-16 16:15:01.203515 | 2026-03-16 16:15:01.203579 | TASK [ensure-podman : Print podman version installed] 2026-03-16 16:15:01.232909 | Podman version: Client: Podman Engine 2026-03-16 16:15:01.233038 | Version: 4.6.2 2026-03-16 16:15:01.233070 | API Version: 4.6.2 2026-03-16 16:15:01.233091 | Go Version: go1.19.12 2026-03-16 16:15:01.233108 | Built: Mon Aug 28 19:38:31 2023 2026-03-16 16:15:01.233127 | OS/Arch: linux/amd64 2026-03-16 16:15:01.238626 | 2026-03-16 16:15:01.238683 | TASK [ensure-podman : Validate podman engine] 2026-03-16 16:15:01.768805 | controller | skipping: Conditional result was False 2026-03-16 16:15:01.782632 | 2026-03-16 16:15:01.782797 | TASK [ensure-podman : Set up docker compatability socket] 2026-03-16 16:15:01.810572 | controller | skipping: Conditional result was False 2026-03-16 16:15:01.840555 | 2026-03-16 16:15:01.840743 | TASK [Ensure python3.8 is present] 2026-03-16 16:15:01.868286 | controller | skipping: Conditional result was False 2026-03-16 16:15:01.877510 | 2026-03-16 16:15:01.877622 | TASK [Run our-ensure-python role (Fedora only for now)] 2026-03-16 16:15:01.902403 | controller | ok 2026-03-16 16:15:01.933117 | 2026-03-16 16:15:01.933260 | TASK [our-ensure-python : Install the right Python version (rpm)] 2026-03-16 16:15:03.573913 | controller | ok: Nothing to do 2026-03-16 16:15:03.585821 | 2026-03-16 16:15:03.585967 | TASK [our-ensure-python : Also install python3-devel] 2026-03-16 16:15:13.694313 | controller | changed 2026-03-16 16:15:13.723967 | 2026-03-16 16:15:13.724191 | TASK [Run ensure-virtualenv role] 2026-03-16 16:15:13.752893 | controller | ok 2026-03-16 16:15:13.797409 | 2026-03-16 16:15:13.797576 | TASK [ensure-virtualenv : Check if virtualenv is installed] 2026-03-16 16:15:14.073549 | controller | /usr/bin/virtualenv 2026-03-16 16:15:14.371385 | controller | ok: Runtime: 0:00:00.005070 2026-03-16 16:15:14.377699 | 2026-03-16 16:15:14.377802 | LOOP [ensure-virtualenv : Install virtualenv package] 2026-03-16 16:15:14.416457 | controller | skipping: Conditional result was False 2026-03-16 16:15:14.416716 | controller | ok: All items complete 2026-03-16 16:15:14.416743 | 2026-03-16 16:15:14.437904 | 2026-03-16 16:15:14.438071 | TASK [Find the full path of the Python interpreter] 2026-03-16 16:15:14.660264 | controller | /usr/bin/python3 2026-03-16 16:15:14.978959 | controller | ok 2026-03-16 16:15:14.994001 | 2026-03-16 16:15:14.994234 | TASK [Create virtualenv for ansible-test with a specific interpreter] 2026-03-16 16:15:15.825390 | controller | created virtual environment CPython3.11.0.final.0-64 in 468ms 2026-03-16 16:15:15.841093 | controller | creator CPython3Posix(dest=/home/zuul/venv, clear=False, no_vcs_ignore=False, global=False) 2026-03-16 16:15:15.841130 | 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 16:15:15.841139 | controller | added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1 2026-03-16 16:15:15.841153 | controller | activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator 2026-03-16 16:15:16.055482 | controller | changed 2026-03-16 16:15:16.073496 | 2026-03-16 16:15:16.073682 | TASK [Set selinux package] 2026-03-16 16:15:16.114690 | controller | ok 2026-03-16 16:15:16.127527 | 2026-03-16 16:15:16.127703 | TASK [Set selinux package (Fedora)] 2026-03-16 16:15:16.187537 | controller | ok 2026-03-16 16:15:16.198338 | 2026-03-16 16:15:16.198484 | TASK [Install selinux into virtualenv] 2026-03-16 16:15:53.841168 | controller | Collecting selinux-please-lie-to-me 2026-03-16 16:16:18.126507 | controller | Downloading selinux_please_lie_to_me-1.0.1-py2.py3-none-any.whl (3.8 kB) 2026-03-16 16:16:18.440865 | controller | Collecting setuptools<50.0.0 2026-03-16 16:16:18.446235 | controller | Downloading setuptools-49.6.0-py3-none-any.whl (803 kB) 2026-03-16 16:16:18.495940 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 803.3/803.3 kB 17.7 MB/s eta 0:00:00 2026-03-16 16:16:18.578092 | controller | Installing collected packages: setuptools, selinux-please-lie-to-me 2026-03-16 16:16:18.578333 | controller | Attempting uninstall: setuptools 2026-03-16 16:16:18.580795 | controller | Found existing installation: setuptools 62.6.0 2026-03-16 16:16:18.641025 | controller | Uninstalling setuptools-62.6.0: 2026-03-16 16:16:18.649260 | controller | Successfully uninstalled setuptools-62.6.0 2026-03-16 16:16:19.007881 | controller | Successfully installed selinux-please-lie-to-me-1.0.1 setuptools-49.6.0 2026-03-16 16:16:30.606352 | controller | 2026-03-16 16:16:30.703051 | controller | [notice] A new release of pip available: 22.2.2 -> 26.0.1 2026-03-16 16:16:30.703109 | controller | [notice] To update, run: python -m pip install --upgrade pip 2026-03-16 16:16:30.818887 | controller | ok: Runtime: 0:01:14.247330 2026-03-16 16:16:30.831718 | 2026-03-16 16:16:30.831854 | TASK [Install pytest-forked into virtualenv] 2026-03-16 16:16:42.741345 | controller | Collecting pytest-forked 2026-03-16 16:16:54.991254 | controller | Downloading pytest_forked-1.6.0-py3-none-any.whl (4.9 kB) 2026-03-16 16:16:55.034839 | controller | Collecting py 2026-03-16 16:16:55.038335 | controller | Downloading py-1.11.0-py2.py3-none-any.whl (98 kB) 2026-03-16 16:16:55.061104 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.7/98.7 kB 5.0 MB/s eta 0:00:00 2026-03-16 16:16:55.165274 | controller | Collecting pytest>=3.10 2026-03-16 16:16:55.168935 | controller | Downloading pytest-9.0.2-py3-none-any.whl (374 kB) 2026-03-16 16:16:55.185498 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 374.8/374.8 kB 26.7 MB/s eta 0:00:00 2026-03-16 16:16:55.227618 | controller | Collecting iniconfig>=1.0.1 2026-03-16 16:16:55.231660 | controller | Downloading iniconfig-2.3.0-py3-none-any.whl (7.5 kB) 2026-03-16 16:16:55.277438 | controller | Collecting packaging>=22 2026-03-16 16:16:55.280417 | controller | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-03-16 16:16:55.286392 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 19.9 MB/s eta 0:00:00 2026-03-16 16:16:55.317150 | controller | Collecting pluggy<2,>=1.5 2026-03-16 16:16:55.320601 | controller | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-03-16 16:16:55.370912 | controller | Collecting pygments>=2.7.2 2026-03-16 16:16:55.373989 | controller | Downloading pygments-2.19.2-py3-none-any.whl (1.2 MB) 2026-03-16 16:16:55.391390 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.2/1.2 MB 84.4 MB/s eta 0:00:00 2026-03-16 16:16:55.459486 | controller | Installing collected packages: pygments, py, pluggy, packaging, iniconfig, pytest, pytest-forked 2026-03-16 16:16:56.486230 | 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 16:16:56.494865 | controller | 2026-03-16 16:16:56.559441 | controller | [notice] A new release of pip available: 22.2.2 -> 26.0.1 2026-03-16 16:16:56.559481 | controller | [notice] To update, run: python -m pip install --upgrade pip 2026-03-16 16:16:56.899560 | controller | ok: Runtime: 0:00:25.473380 2026-03-16 16:16:56.912581 | 2026-03-16 16:16:56.912726 | TASK [Update pip] 2026-03-16 16:16:57.447081 | controller | Requirement already satisfied: pip in ./venv/lib/python3.11/site-packages (22.2.2) 2026-03-16 16:17:19.305758 | controller | Collecting pip 2026-03-16 16:18:19.394330 | controller | Downloading pip-26.0.1-py3-none-any.whl (1.8 MB) 2026-03-16 16:18:19.452234 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.8/1.8 MB 33.8 MB/s eta 0:00:00 2026-03-16 16:18:19.518268 | controller | Installing collected packages: pip 2026-03-16 16:18:19.518396 | controller | Attempting uninstall: pip 2026-03-16 16:18:19.520650 | controller | Found existing installation: pip 22.2.2 2026-03-16 16:18:19.665494 | controller | Uninstalling pip-22.2.2: 2026-03-16 16:18:19.680995 | controller | Successfully uninstalled pip-22.2.2 2026-03-16 16:18:20.537695 | controller | Successfully installed pip-26.0.1 2026-03-16 16:18:25.837128 | controller | ok: Runtime: 0:01:23.468884 2026-03-16 16:18:25.850387 | 2026-03-16 16:18:25.850516 | TASK [Ensure pip temp directory exists in /var/tmp] 2026-03-16 16:18:26.089952 | controller | changed 2026-03-16 16:18:26.104095 | 2026-03-16 16:18:26.104258 | TASK [Install ansible into virtualenv] 2026-03-16 16:18:26.634391 | controller | Processing ./src/github.com/ansible/ansible 2026-03-16 16:18:26.636877 | controller | Installing build dependencies: started 2026-03-16 16:19:27.305447 | controller | Installing build dependencies: still running... 2026-03-16 16:20:27.438699 | controller | Installing build dependencies: still running... 2026-03-16 16:20:27.820197 | controller | Installing build dependencies: finished with status 'done' 2026-03-16 16:20:27.820782 | controller | Getting requirements to build wheel: started 2026-03-16 16:20:28.593763 | controller | Getting requirements to build wheel: finished with status 'done' 2026-03-16 16:20:28.594651 | controller | Preparing metadata (pyproject.toml): started 2026-03-16 16:20:29.095530 | controller | Preparing metadata (pyproject.toml): finished with status 'done' 2026-03-16 16:20:29.097798 | 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 16:20:29.101124 | controller | ERROR: Package 'ansible-core' requires a different Python: 3.11.0 not in '>=3.12' 2026-03-16 16:20:29.225277 | controller | ERROR 2026-03-16 16:20:29.225666 | controller | { 2026-03-16 16:20:29.225779 | controller | "delta": "0:02:02.835653", 2026-03-16 16:20:29.225849 | controller | "end": "2026-03-16 16:20:29.174828", 2026-03-16 16:20:29.225909 | controller | "msg": "non-zero return code", 2026-03-16 16:20:29.225967 | controller | "rc": 1, 2026-03-16 16:20:29.226078 | controller | "start": "2026-03-16 16:18:26.339175" 2026-03-16 16:20:29.226143 | controller | } failure 2026-03-16 16:20:29.230288 | 2026-03-16 16:20:29.230468 | PLAY RECAP 2026-03-16 16:20:29.230596 | controller | ok: 18 changed: 10 unreachable: 0 failed: 1 skipped: 4 rescued: 0 ignored: 0 2026-03-16 16:20:29.230667 | 2026-03-16 16:20:29.376623 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-03-16 16:20:29.377618 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-16 16:20:29.998802 | 2026-03-16 16:20:29.998895 | PLAY [all] 2026-03-16 16:20:30.021341 | 2026-03-16 16:20:30.021473 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-03-16 16:20:30.273315 | controller | changed: non-zero return code 2026-03-16 16:20:30.279082 | 2026-03-16 16:20:30.279162 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-03-16 16:20:30.293224 | controller | skipping: Conditional result was False 2026-03-16 16:20:30.300212 | 2026-03-16 16:20:30.300310 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-03-16 16:20:30.321841 | 2026-03-16 16:20:30.322011 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-03-16 16:20:30.352885 | 2026-03-16 16:20:30.353064 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-03-16 16:20:30.377679 | controller | skipping: Conditional result was False 2026-03-16 16:20:30.385325 | 2026-03-16 16:20:30.385428 | LOOP [fetch-subunit-output : Generate subunit file] 2026-03-16 16:20:30.418316 | 2026-03-16 16:20:30.418526 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-03-16 16:20:30.434325 | controller | skipping: Conditional result was False 2026-03-16 16:20:30.447774 | 2026-03-16 16:20:30.447918 | TASK [fetch-subunit-output : Remove the temporary file] 2026-03-16 16:20:30.472973 | controller | skipping: Conditional result was False 2026-03-16 16:20:30.481856 | 2026-03-16 16:20:30.481950 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-03-16 16:20:30.506684 | controller | skipping: Conditional result was False 2026-03-16 16:20:30.545907 | 2026-03-16 16:20:30.546064 | PLAY RECAP 2026-03-16 16:20:30.546130 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-03-16 16:20:30.546161 | 2026-03-16 16:20:30.687678 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-16 16:20:30.689135 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2026-03-16 16:20:31.247890 | 2026-03-16 16:20:31.248002 | PLAY [all:!appliance*] 2026-03-16 16:20:31.270097 | 2026-03-16 16:20:31.270219 | TASK [unregister the node] 2026-03-16 16:20:31.801565 | controller | skipping: Conditional result was False 2026-03-16 16:20:31.810957 | 2026-03-16 16:20:31.811118 | TASK [include_role : fetch-output] 2026-03-16 16:20:31.843882 | controller | ok 2026-03-16 16:20:31.863259 | 2026-03-16 16:20:31.863352 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-16 16:20:31.918245 | controller | skipping: Conditional result was False 2026-03-16 16:20:31.925053 | 2026-03-16 16:20:31.925142 | TASK [fetch-output : Set log path for single node] 2026-03-16 16:20:31.974379 | controller | ok 2026-03-16 16:20:31.979987 | 2026-03-16 16:20:31.980076 | LOOP [fetch-output : Ensure local output dirs] 2026-03-16 16:20:32.440190 | controller -> localhost | ok: "/var/lib/zuul/builds/b45de901ddc342b8953760df45db7850/work/logs" 2026-03-16 16:20:32.656914 | controller -> localhost | changed: "/var/lib/zuul/builds/b45de901ddc342b8953760df45db7850/work/artifacts" 2026-03-16 16:20:32.921671 | controller -> localhost | changed: "/var/lib/zuul/builds/b45de901ddc342b8953760df45db7850/work/docs" 2026-03-16 16:20:32.936077 | 2026-03-16 16:20:32.936190 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-16 16:20:33.601261 | controller | changed: 2026-03-16 16:20:33.601461 | controller | .d..t...... ./ 2026-03-16 16:20:33.601504 | controller | cd+++++++++ controller/ 2026-03-16 16:20:33.601558 | controller | changed: All items complete 2026-03-16 16:20:33.601590 | 2026-03-16 16:20:34.062239 | controller | changed: .d..t...... ./ 2026-03-16 16:20:34.543316 | controller | changed: .d..t...... ./ 2026-03-16 16:20:34.576654 | 2026-03-16 16:20:34.576770 | TASK [include_role : fetch-output-openshift] 2026-03-16 16:20:34.601858 | controller | skipping: Conditional result was False 2026-03-16 16:20:34.614518 | 2026-03-16 16:20:34.614640 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-16 16:20:34.994220 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.008500 2026-03-16 16:20:35.210851 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007740 2026-03-16 16:20:35.246641 | 2026-03-16 16:20:35.246757 | PLAY [localhost] 2026-03-16 16:20:35.261959 | 2026-03-16 16:20:35.262082 | TASK [Run Zuul manifest role] 2026-03-16 16:20:35.279520 | localhost | ok 2026-03-16 16:20:35.293407 | 2026-03-16 16:20:35.293490 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-16 16:20:35.628289 | localhost | changed 2026-03-16 16:20:35.635062 | 2026-03-16 16:20:35.635193 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-16 16:20:35.666871 | localhost | ok 2026-03-16 16:20:35.678921 | 2026-03-16 16:20:35.679054 | TASK [Set zuul-log-path fact] 2026-03-16 16:20:35.702187 | localhost | ok 2026-03-16 16:20:35.723625 | 2026-03-16 16:20:35.723773 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-16 16:20:35.766764 | localhost | ok 2026-03-16 16:20:35.779611 | 2026-03-16 16:20:35.779732 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)] 2026-03-16 16:20:35.811988 | localhost | ok: 2026-03-16 16:20:35.812276 | localhost | { 2026-03-16 16:20:35.812311 | localhost | "auth": { 2026-03-16 16:20:35.812344 | localhost | "password": "IonWCwcuOFib&&<}wp^:[2G/", 2026-03-16 16:20:35.812370 | localhost | "username": "9LF91O0RK7JU" 2026-03-16 16:20:35.812393 | localhost | }, 2026-03-16 16:20:35.812416 | localhost | "profile": "rackspace", 2026-03-16 16:20:35.812439 | localhost | "region_name": "ORD" 2026-03-16 16:20:35.812460 | localhost | } 2026-03-16 16:20:35.812503 | localhost | changed: All items complete 2026-03-16 16:20:35.812530 | 2026-03-16 16:20:35.830149 | 2026-03-16 16:20:35.830347 | TASK [Run upload-logs-failover role (S3 then Swift)] 2026-03-16 16:20:35.856149 | localhost | Output suppressed because no_log was given 2026-03-16 16:20:35.875363 | 2026-03-16 16:20:35.875472 | TASK [upload-logs-failover : Initialize control vars] 2026-03-16 16:20:35.982597 | localhost | ok 2026-03-16 16:20:35.989602 | 2026-03-16 16:20:35.989717 | LOOP [upload-logs-failover : Perform log upload] 2026-03-16 16:20:36.014992 | localhost | Output suppressed because no_log was given 2026-03-16 16:20:36.021821 | localhost | included: /var/lib/zuul/builds/b45de901ddc342b8953760df45db7850/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml 2026-03-16 16:20:36.028787 | 2026-03-16 16:20:36.028866 | LOOP [upload-logs-failover : Unpack vars for swift upload] 2026-03-16 16:20:36.130175 | localhost | Output suppressed because no_log was given 2026-03-16 16:20:36.135206 | 2026-03-16 16:20:36.135284 | TASK [Upload logs to swift] 2026-03-16 16:20:36.164130 | localhost | ok 2026-03-16 16:20:36.189885 | 2026-03-16 16:20:36.189999 | TASK [Set zuul-log-path fact] 2026-03-16 16:20:36.214710 | localhost | skipping: Conditional result was False 2026-03-16 16:20:36.223059 | 2026-03-16 16:20:36.223158 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2026-03-16 16:20:36.543498 | localhost -> localhost | ok: Runtime: 0:00:00.004986 2026-03-16 16:20:36.556110 | 2026-03-16 16:20:36.556246 | TASK [upload-logs-swift : Upload logs to swift]