2026-03-16 16:20:29.949964 | Job console starting... 2026-03-16 16:20:29.959897 | Updating repositories 2026-03-16 16:20:30.077869 | Preparing job workspace 2026-03-16 16:20:34.670668 | Running Ansible setup... 2026-03-16 16:20:39.114155 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-03-16 16:20:39.766633 | 2026-03-16 16:20:39.766757 | PLAY [localhost] 2026-03-16 16:20:39.775699 | 2026-03-16 16:20:39.775789 | TASK [Gathering Facts] 2026-03-16 16:20:40.731598 | localhost | ok 2026-03-16 16:20:40.751614 | 2026-03-16 16:20:40.751767 | TASK [Setup log path fact] 2026-03-16 16:20:40.774098 | localhost | ok 2026-03-16 16:20:40.792635 | 2026-03-16 16:20:40.792937 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-16 16:20:40.833712 | localhost | ok 2026-03-16 16:20:40.845582 | 2026-03-16 16:20:40.845691 | TASK [emit-job-header : Print job information] 2026-03-16 16:20:40.898153 | # Job Information 2026-03-16 16:20:40.898352 | Ansible Version: 2.15.12 2026-03-16 16:20:40.898398 | Job: ansible-test-sanity-docker-devel 2026-03-16 16:20:40.898430 | Pipeline: third-party-check 2026-03-16 16:20:40.898458 | Executor: ze01.softwarefactory-project.io 2026-03-16 16:20:40.898485 | Triggered by: https://github.com/openshift/community.okd/pull/274 2026-03-16 16:20:40.898518 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/7e9/ansible/7e9a840097e641ae955948f54f574457/ 2026-03-16 16:20:40.898549 | Event ID: cb44fe40-2151-11f1-85ca-bed5723f367f 2026-03-16 16:20:40.904295 | 2026-03-16 16:20:40.904394 | LOOP [emit-job-header : Print node information] 2026-03-16 16:20:41.024680 | localhost | ok: 2026-03-16 16:20:41.025118 | localhost | # Node Information 2026-03-16 16:20:41.025196 | localhost | Inventory Hostname: controller 2026-03-16 16:20:41.025245 | localhost | Hostname: np0005648659 2026-03-16 16:20:41.025292 | localhost | Username: zuul 2026-03-16 16:20:41.025344 | localhost | Distro: Fedora 37 2026-03-16 16:20:41.025389 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2026-03-16 16:20:41.025431 | localhost | Region: ca-ymq-1 2026-03-16 16:20:41.025471 | localhost | Label: ansible-fedora-37-1vcpu 2026-03-16 16:20:41.025512 | localhost | Product Name: OpenStack Nova 2026-03-16 16:20:41.025553 | localhost | Interface IP: 199.204.45.33 2026-03-16 16:20:41.047430 | 2026-03-16 16:20:41.047689 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-16 16:20:41.448487 | localhost -> localhost | changed 2026-03-16 16:20:41.454554 | 2026-03-16 16:20:41.454667 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-16 16:20:42.389007 | localhost -> localhost | changed 2026-03-16 16:20:42.432898 | 2026-03-16 16:20:42.433075 | PLAY [all:!appliance*] 2026-03-16 16:20:42.464973 | 2026-03-16 16:20:42.465109 | TASK [include_role : start-zuul-console] 2026-03-16 16:20:42.489010 | controller | ok 2026-03-16 16:20:42.511712 | 2026-03-16 16:20:42.511871 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-16 16:20:42.876348 | controller | ok 2026-03-16 16:20:42.906623 | 2026-03-16 16:20:42.906894 | TASK [use-our-mirror : Retrieve the IP address] 2026-03-16 16:21:17.121434 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2026-03-16 16:21:17.134606 | 2026-03-16 16:21:17.134757 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2026-03-16 16:21:17.681302 | controller | skipping: Conditional result was False 2026-03-16 16:21:17.696670 | 2026-03-16 16:21:17.696870 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2026-03-16 16:21:17.724911 | controller | skipping: Conditional result was False 2026-03-16 16:21:17.740311 | 2026-03-16 16:21:17.740501 | TASK [use-our-mirror : Create the podman configuration directory] 2026-03-16 16:21:17.768418 | controller | skipping: Conditional result was False 2026-03-16 16:21:17.784055 | 2026-03-16 16:21:17.784203 | TASK [use-our-mirror : Copy the podman configuration] 2026-03-16 16:21:17.809734 | controller | skipping: Conditional result was False 2026-03-16 16:21:17.819527 | 2026-03-16 16:21:17.819663 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2026-03-16 16:21:17.844616 | controller | skipping: Conditional result was False 2026-03-16 16:21:17.852733 | 2026-03-16 16:21:17.852846 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2026-03-16 16:21:17.877881 | controller | skipping: Conditional result was False 2026-03-16 16:21:17.897191 | 2026-03-16 16:21:17.897358 | TASK [Disable Fedora Modular] 2026-03-16 16:21:18.266982 | controller | changed 2026-03-16 16:21:18.274951 | 2026-03-16 16:21:18.275076 | TASK [Enable EPEL] 2026-03-16 16:21:18.299967 | controller | skipping: Conditional result was False 2026-03-16 16:21:18.314238 | 2026-03-16 16:21:18.314395 | TASK [Register the RHEL node] 2026-03-16 16:21:18.879489 | 2026-03-16 16:21:18.879763 | TASK [Show the subscription-manager status] 2026-03-16 16:21:19.441144 | controller | skipping: Conditional result was False 2026-03-16 16:21:19.449930 | 2026-03-16 16:21:19.450089 | TASK [Enable EPEL on RHEL] 2026-03-16 16:21:19.997115 | controller | skipping: Conditional result was False 2026-03-16 16:21:20.011468 | 2026-03-16 16:21:20.011798 | TASK [Install git and tox] 2026-03-16 16:22:02.541793 | controller | changed 2026-03-16 16:22:02.547883 | 2026-03-16 16:22:02.547957 | TASK [include_role : prepare-workspace] 2026-03-16 16:22:02.622971 | controller | ok 2026-03-16 16:22:02.646109 | 2026-03-16 16:22:02.646251 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-16 16:22:02.893914 | controller | ok 2026-03-16 16:22:02.903866 | 2026-03-16 16:22:02.903988 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-16 16:22:15.334351 | controller | Output suppressed because no_log was given 2026-03-16 16:22:15.353051 | 2026-03-16 16:22:15.353179 | TASK [include_role : prepare-workspace-openshift] 2026-03-16 16:22:15.379186 | controller | skipping: Conditional result was False 2026-03-16 16:22:15.413223 | 2026-03-16 16:22:15.413332 | PLAY [all:!appliance] 2026-03-16 16:22:15.436625 | 2026-03-16 16:22:15.436725 | TASK [Run add-build-sshkey role (RSA)] 2026-03-16 16:22:15.483509 | controller | ok 2026-03-16 16:22:15.508620 | 2026-03-16 16:22:15.508766 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-16 16:22:15.780279 | controller -> localhost | ok 2026-03-16 16:22:15.786803 | 2026-03-16 16:22:15.786876 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-16 16:22:15.808854 | controller | ok 2026-03-16 16:22:15.822572 | controller | included: /var/lib/zuul/builds/7e9a840097e641ae955948f54f574457/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-16 16:22:15.828593 | 2026-03-16 16:22:15.828667 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-16 16:22:16.454219 | controller -> localhost | Generating public/private rsa key pair. 2026-03-16 16:22:16.454388 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/7e9a840097e641ae955948f54f574457/work/7e9a840097e641ae955948f54f574457_id_rsa. 2026-03-16 16:22:16.454419 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/7e9a840097e641ae955948f54f574457/work/7e9a840097e641ae955948f54f574457_id_rsa.pub. 2026-03-16 16:22:16.454442 | controller -> localhost | The key fingerprint is: 2026-03-16 16:22:16.454463 | controller -> localhost | SHA256:ETLe3mqtzk5FZpdADFoTldkfIAjhpCX/kUuKPQUw4yo zuul-build-sshkey 2026-03-16 16:22:16.454483 | controller -> localhost | The key's randomart image is: 2026-03-16 16:22:16.454503 | controller -> localhost | +---[RSA 2048]----+ 2026-03-16 16:22:16.454522 | controller -> localhost | | =.Oo*B=+.. | 2026-03-16 16:22:16.454541 | controller -> localhost | | . @ B.++o... | 2026-03-16 16:22:16.454559 | controller -> localhost | | o = B + o. . | 2026-03-16 16:22:16.454577 | controller -> localhost | | . o * O . . | 2026-03-16 16:22:16.454594 | controller -> localhost | |E . . + S o | 2026-03-16 16:22:16.454622 | controller -> localhost | | . . + | 2026-03-16 16:22:16.454648 | controller -> localhost | | + . | 2026-03-16 16:22:16.454669 | controller -> localhost | | + . | 2026-03-16 16:22:16.454688 | controller -> localhost | | o= | 2026-03-16 16:22:16.454708 | controller -> localhost | +----[SHA256]-----+ 2026-03-16 16:22:16.454753 | controller -> localhost | ok: Runtime: 0:00:00.236797 2026-03-16 16:22:16.461691 | 2026-03-16 16:22:16.461767 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-16 16:22:16.481932 | controller | ok 2026-03-16 16:22:16.492765 | controller | included: /var/lib/zuul/builds/7e9a840097e641ae955948f54f574457/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-16 16:22:16.502427 | 2026-03-16 16:22:16.502529 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-16 16:22:16.526608 | controller | skipping: Conditional result was False 2026-03-16 16:22:16.532908 | 2026-03-16 16:22:16.533002 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-16 16:22:16.995760 | controller | changed 2026-03-16 16:22:17.008238 | 2026-03-16 16:22:17.008414 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-16 16:22:17.301949 | controller | ok 2026-03-16 16:22:17.311068 | 2026-03-16 16:22:17.311192 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-16 16:22:17.933636 | controller | changed 2026-03-16 16:22:17.939479 | 2026-03-16 16:22:17.939578 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-16 16:22:18.568954 | controller | changed 2026-03-16 16:22:18.578144 | 2026-03-16 16:22:18.578604 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-16 16:22:18.615267 | controller | skipping: Conditional result was False 2026-03-16 16:22:18.623367 | 2026-03-16 16:22:18.623521 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-16 16:22:19.028564 | controller -> localhost | changed 2026-03-16 16:22:19.041581 | 2026-03-16 16:22:19.041699 | TASK [add-build-sshkey : Add back temp key] 2026-03-16 16:22:19.353451 | controller -> localhost | Identity added: /var/lib/zuul/builds/7e9a840097e641ae955948f54f574457/work/7e9a840097e641ae955948f54f574457_id_rsa (zuul-build-sshkey) 2026-03-16 16:22:19.353800 | controller -> localhost | ok: Runtime: 0:00:00.010945 2026-03-16 16:22:19.365947 | 2026-03-16 16:22:19.366140 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-16 16:22:19.697490 | controller | ok 2026-03-16 16:22:19.706468 | 2026-03-16 16:22:19.706565 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-16 16:22:19.752345 | controller | skipping: Conditional result was False 2026-03-16 16:22:19.769774 | 2026-03-16 16:22:19.769921 | TASK [Run add-build-sshkey role (ECDSA)] 2026-03-16 16:22:19.794262 | controller | ok 2026-03-16 16:22:19.820420 | 2026-03-16 16:22:19.820577 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-16 16:22:20.080937 | controller -> localhost | ok 2026-03-16 16:22:20.087666 | 2026-03-16 16:22:20.087741 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-16 16:22:20.127696 | controller | ok 2026-03-16 16:22:20.138768 | controller | included: /var/lib/zuul/builds/7e9a840097e641ae955948f54f574457/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-16 16:22:20.146687 | 2026-03-16 16:22:20.146822 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-16 16:22:20.479364 | controller -> localhost | Generating public/private ecdsa key pair. 2026-03-16 16:22:20.479683 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/7e9a840097e641ae955948f54f574457/work/7e9a840097e641ae955948f54f574457_id_ecdsa. 2026-03-16 16:22:20.479745 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/7e9a840097e641ae955948f54f574457/work/7e9a840097e641ae955948f54f574457_id_ecdsa.pub. 2026-03-16 16:22:20.479812 | controller -> localhost | The key fingerprint is: 2026-03-16 16:22:20.479857 | controller -> localhost | SHA256:CkoSdNXOMkJVIQD+UVmQgrUBcRqvz7NvEaHmfI+rCfw zuul-build-sshkey 2026-03-16 16:22:20.479900 | controller -> localhost | The key's randomart image is: 2026-03-16 16:22:20.479942 | controller -> localhost | +---[ECDSA 521]---+ 2026-03-16 16:22:20.479983 | controller -> localhost | | ***+*B+. | 2026-03-16 16:22:20.480061 | controller -> localhost | |o.*o++.. | 2026-03-16 16:22:20.480112 | controller -> localhost | |.o.+o + | 2026-03-16 16:22:20.480154 | controller -> localhost | | .o+.+ o | 2026-03-16 16:22:20.480193 | controller -> localhost | |..=.o + S | 2026-03-16 16:22:20.480231 | controller -> localhost | |.oo+ + . | 2026-03-16 16:22:20.480268 | controller -> localhost | | o.+. = | 2026-03-16 16:22:20.480306 | controller -> localhost | | o +o . | 2026-03-16 16:22:20.480343 | controller -> localhost | | E+o. | 2026-03-16 16:22:20.480381 | controller -> localhost | +----[SHA256]-----+ 2026-03-16 16:22:20.480465 | controller -> localhost | ok: Runtime: 0:00:00.008058 2026-03-16 16:22:20.494862 | 2026-03-16 16:22:20.494996 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-16 16:22:20.526803 | controller | ok 2026-03-16 16:22:20.534540 | controller | included: /var/lib/zuul/builds/7e9a840097e641ae955948f54f574457/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-16 16:22:20.544430 | 2026-03-16 16:22:20.544537 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-16 16:22:20.579088 | controller | skipping: Conditional result was False 2026-03-16 16:22:20.587574 | 2026-03-16 16:22:20.587677 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-16 16:22:20.907692 | controller | changed 2026-03-16 16:22:20.916696 | 2026-03-16 16:22:20.916826 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-16 16:22:21.150743 | controller | ok 2026-03-16 16:22:21.166968 | 2026-03-16 16:22:21.167204 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-16 16:22:21.787990 | controller | changed 2026-03-16 16:22:21.793616 | 2026-03-16 16:22:21.793687 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-16 16:22:22.403099 | controller | changed 2026-03-16 16:22:22.408885 | 2026-03-16 16:22:22.408946 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-16 16:22:22.433220 | controller | skipping: Conditional result was False 2026-03-16 16:22:22.446839 | 2026-03-16 16:22:22.446970 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-16 16:22:22.711311 | controller -> localhost | changed 2026-03-16 16:22:22.724806 | 2026-03-16 16:22:22.724925 | TASK [add-build-sshkey : Add back temp key] 2026-03-16 16:22:23.035718 | controller -> localhost | Identity added: /var/lib/zuul/builds/7e9a840097e641ae955948f54f574457/work/7e9a840097e641ae955948f54f574457_id_ecdsa (zuul-build-sshkey) 2026-03-16 16:22:23.036078 | controller -> localhost | ok: Runtime: 0:00:00.012760 2026-03-16 16:22:23.050430 | 2026-03-16 16:22:23.050568 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-16 16:22:23.257302 | controller | ok 2026-03-16 16:22:23.263823 | 2026-03-16 16:22:23.263928 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-16 16:22:23.287994 | controller | skipping: Conditional result was False 2026-03-16 16:22:23.304477 | 2026-03-16 16:22:23.304595 | TASK [include_role : remove-zuul-sshkey] 2026-03-16 16:22:23.318789 | controller | skipping: Conditional result was False 2026-03-16 16:22:23.326965 | 2026-03-16 16:22:23.327074 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-16 16:22:23.564355 | controller | ok: "logs" 2026-03-16 16:22:23.564635 | controller | ok: All items complete 2026-03-16 16:22:23.564670 | 2026-03-16 16:22:23.768962 | controller | ok: "artifacts" 2026-03-16 16:22:23.973894 | controller | ok: "docs" 2026-03-16 16:22:24.003339 | 2026-03-16 16:22:24.003546 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-16 16:22:24.726760 | controller | changed: "logs" 2026-03-16 16:22:24.923515 | controller | changed: "artifacts" 2026-03-16 16:22:25.130358 | controller | changed: "docs" 2026-03-16 16:22:25.194556 | 2026-03-16 16:22:25.194660 | PLAY RECAP 2026-03-16 16:22:25.194704 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2026-03-16 16:22:25.194733 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-16 16:22:25.194751 | 2026-03-16 16:22:25.357345 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-03-16 16:22:25.358227 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-03-16 16:22:26.051239 | 2026-03-16 16:22:26.051369 | PLAY [all] 2026-03-16 16:22:26.077390 | 2026-03-16 16:22:26.077483 | TASK [Install binary dependencies] 2026-03-16 16:22:26.138787 | controller | ok 2026-03-16 16:22:26.163585 | 2026-03-16 16:22:26.163724 | TASK [bindep : Include find tasks] 2026-03-16 16:22:26.193915 | controller | ok 2026-03-16 16:22:26.203043 | controller | included: /var/lib/zuul/builds/7e9a840097e641ae955948f54f574457/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-03-16 16:22:26.210032 | 2026-03-16 16:22:26.210095 | TASK [bindep : Look for bindep.txt] 2026-03-16 16:22:26.596655 | controller | ok 2026-03-16 16:22:26.611711 | 2026-03-16 16:22:26.611870 | TASK [bindep : Define bindep_file fact] 2026-03-16 16:22:26.658517 | controller | skipping: Conditional result was False 2026-03-16 16:22:26.675350 | 2026-03-16 16:22:26.675540 | TASK [bindep : Look for other-requirements.txt] 2026-03-16 16:22:26.906384 | controller | ok 2026-03-16 16:22:26.920688 | 2026-03-16 16:22:26.920847 | TASK [bindep : Define bindep_file fact] 2026-03-16 16:22:26.947446 | controller | skipping: Conditional result was False 2026-03-16 16:22:26.957964 | 2026-03-16 16:22:26.958120 | TASK [bindep : Look for bindep fallback file] 2026-03-16 16:22:26.994420 | controller | skipping: Conditional result was False 2026-03-16 16:22:27.004964 | 2026-03-16 16:22:27.005138 | TASK [bindep : Define bindep_file fact] 2026-03-16 16:22:27.040417 | controller | skipping: Conditional result was False 2026-03-16 16:22:27.047386 | 2026-03-16 16:22:27.047486 | TASK [bindep : Include bindep tasks] 2026-03-16 16:22:27.081578 | controller | skipping: Conditional result was False 2026-03-16 16:22:27.088690 | 2026-03-16 16:22:27.088851 | TASK [bindep : Include install tasks] 2026-03-16 16:22:27.113425 | controller | skipping: Conditional result was False 2026-03-16 16:22:27.120813 | 2026-03-16 16:22:27.120932 | LOOP [bindep : Include package tasks] 2026-03-16 16:22:27.186970 | 2026-03-16 16:22:27.187235 | TASK [Run test-setup role] 2026-03-16 16:22:27.210283 | controller | ok 2026-03-16 16:22:27.228007 | 2026-03-16 16:22:27.228152 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-03-16 16:22:27.435484 | controller | ok 2026-03-16 16:22:27.444721 | 2026-03-16 16:22:27.445582 | TASK [test-setup : Run tools/test-setup.sh] 2026-03-16 16:22:27.996624 | controller | skipping: Conditional result was False 2026-03-16 16:22:28.034764 | 2026-03-16 16:22:28.034889 | PLAY RECAP 2026-03-16 16:22:28.034944 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-03-16 16:22:28.034971 | 2026-03-16 16:22:28.144624 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-03-16 16:22:28.145676 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-03-16 16:22:28.804618 | 2026-03-16 16:22:28.804756 | PLAY [controller] 2026-03-16 16:22:28.826807 | 2026-03-16 16:22:28.826957 | TASK [Create the /root directory] 2026-03-16 16:22:29.235392 | controller | ok 2026-03-16 16:22:29.249689 | 2026-03-16 16:22:29.249814 | TASK [Install glibc-langpack-en] 2026-03-16 16:22:33.191063 | controller | ok: Nothing to do 2026-03-16 16:22:33.210339 | 2026-03-16 16:22:33.210801 | TASK [Ensure controller directory exists] 2026-03-16 16:22:33.452931 | controller | changed 2026-03-16 16:22:33.468619 | 2026-03-16 16:22:33.469080 | TASK [Install container runtime] 2026-03-16 16:22:33.531539 | controller | ok 2026-03-16 16:22:33.567825 | 2026-03-16 16:22:33.567926 | LOOP [ensure-podman : Find distribution installation] 2026-03-16 16:22:33.592379 | controller | ok: "/var/lib/zuul/builds/7e9a840097e641ae955948f54f574457/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml" 2026-03-16 16:22:33.599453 | controller | included: /var/lib/zuul/builds/7e9a840097e641ae955948f54f574457/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml 2026-03-16 16:22:33.611007 | 2026-03-16 16:22:33.611175 | TASK [ensure-podman : Install podman (RedHat)] 2026-03-16 16:23:38.792081 | controller | changed 2026-03-16 16:23:38.807343 | 2026-03-16 16:23:38.807497 | TASK [ensure-podman : Fetch podman version] 2026-03-16 16:23:39.341661 | controller | Client: Podman Engine 2026-03-16 16:23:39.371221 | controller | Version: 4.6.2 2026-03-16 16:23:39.371261 | controller | API Version: 4.6.2 2026-03-16 16:23:39.371269 | controller | Go Version: go1.19.12 2026-03-16 16:23:39.371287 | controller | Built: Mon Aug 28 19:38:31 2023 2026-03-16 16:23:39.371295 | controller | OS/Arch: linux/amd64 2026-03-16 16:23:39.856749 | controller | ok: Runtime: 0:00:00.193093 2026-03-16 16:23:39.872708 | 2026-03-16 16:23:39.872934 | TASK [ensure-podman : Print podman version installed] 2026-03-16 16:23:39.913822 | Podman version: Client: Podman Engine 2026-03-16 16:23:39.914154 | Version: 4.6.2 2026-03-16 16:23:39.914220 | API Version: 4.6.2 2026-03-16 16:23:39.914267 | Go Version: go1.19.12 2026-03-16 16:23:39.914308 | Built: Mon Aug 28 19:38:31 2023 2026-03-16 16:23:39.914350 | OS/Arch: linux/amd64 2026-03-16 16:23:39.927631 | 2026-03-16 16:23:39.927798 | TASK [ensure-podman : Validate podman engine] 2026-03-16 16:23:40.482276 | controller | skipping: Conditional result was False 2026-03-16 16:23:40.503227 | 2026-03-16 16:23:40.503448 | TASK [ensure-podman : Set up docker compatability socket] 2026-03-16 16:23:40.530313 | controller | skipping: Conditional result was False 2026-03-16 16:23:40.558318 | 2026-03-16 16:23:40.558570 | TASK [Ensure python3.8 is present] 2026-03-16 16:23:40.584853 | controller | skipping: Conditional result was False 2026-03-16 16:23:40.594735 | 2026-03-16 16:23:40.594836 | TASK [Run our-ensure-python role (Fedora only for now)] 2026-03-16 16:23:40.619439 | controller | ok 2026-03-16 16:23:40.647750 | 2026-03-16 16:23:40.647891 | TASK [our-ensure-python : Install the right Python version (rpm)] 2026-03-16 16:23:42.182562 | controller | ok: Nothing to do 2026-03-16 16:23:42.190501 | 2026-03-16 16:23:42.190603 | TASK [our-ensure-python : Also install python3-devel] 2026-03-16 16:23:51.563616 | controller | changed 2026-03-16 16:23:51.588475 | 2026-03-16 16:23:51.588674 | TASK [Run ensure-virtualenv role] 2026-03-16 16:23:51.612145 | controller | ok 2026-03-16 16:23:51.645688 | 2026-03-16 16:23:51.645833 | TASK [ensure-virtualenv : Check if virtualenv is installed] 2026-03-16 16:23:51.892407 | controller | /usr/bin/virtualenv 2026-03-16 16:23:52.211737 | controller | ok: Runtime: 0:00:00.004750 2026-03-16 16:23:52.218437 | 2026-03-16 16:23:52.218561 | LOOP [ensure-virtualenv : Install virtualenv package] 2026-03-16 16:23:52.261695 | controller | skipping: Conditional result was False 2026-03-16 16:23:52.262034 | controller | ok: All items complete 2026-03-16 16:23:52.262077 | 2026-03-16 16:23:52.282265 | 2026-03-16 16:23:52.282402 | TASK [Find the full path of the Python interpreter] 2026-03-16 16:23:52.496187 | controller | /usr/bin/python3 2026-03-16 16:23:52.814712 | controller | ok 2026-03-16 16:23:52.823586 | 2026-03-16 16:23:52.823766 | TASK [Create virtualenv for ansible-test with a specific interpreter] 2026-03-16 16:23:53.789746 | controller | created virtual environment CPython3.11.0.final.0-64 in 522ms 2026-03-16 16:23:53.821163 | controller | creator CPython3Posix(dest=/home/zuul/venv, clear=False, no_vcs_ignore=False, global=False) 2026-03-16 16:23:53.821417 | 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:23:53.821429 | controller | added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1 2026-03-16 16:23:53.821443 | controller | activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator 2026-03-16 16:23:53.876378 | controller | changed 2026-03-16 16:23:53.892844 | 2026-03-16 16:23:53.893075 | TASK [Set selinux package] 2026-03-16 16:23:53.934300 | controller | ok 2026-03-16 16:23:53.944744 | 2026-03-16 16:23:53.944893 | TASK [Set selinux package (Fedora)] 2026-03-16 16:23:53.990109 | controller | ok 2026-03-16 16:23:53.999948 | 2026-03-16 16:23:54.000079 | TASK [Install selinux into virtualenv] 2026-03-16 16:24:55.236795 | controller | Collecting selinux-please-lie-to-me 2026-03-16 16:25:43.438480 | controller | Downloading selinux_please_lie_to_me-1.0.1-py2.py3-none-any.whl (3.8 kB) 2026-03-16 16:25:43.766073 | controller | Collecting setuptools<50.0.0 2026-03-16 16:25:43.771344 | controller | Downloading setuptools-49.6.0-py3-none-any.whl (803 kB) 2026-03-16 16:25:43.808308 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 803.3/803.3 kB 26.1 MB/s eta 0:00:00 2026-03-16 16:25:43.892814 | controller | Installing collected packages: setuptools, selinux-please-lie-to-me 2026-03-16 16:25:43.893047 | controller | Attempting uninstall: setuptools 2026-03-16 16:25:43.895497 | controller | Found existing installation: setuptools 62.6.0 2026-03-16 16:25:43.956411 | controller | Uninstalling setuptools-62.6.0: 2026-03-16 16:25:43.964445 | controller | Successfully uninstalled setuptools-62.6.0 2026-03-16 16:25:44.309989 | controller | Successfully installed selinux-please-lie-to-me-1.0.1 setuptools-49.6.0 2026-03-16 16:25:55.807701 | controller | 2026-03-16 16:25:55.895180 | controller | [notice] A new release of pip available: 22.2.2 -> 26.0.1 2026-03-16 16:25:55.895235 | controller | [notice] To update, run: python -m pip install --upgrade pip 2026-03-16 16:25:56.108993 | controller | ok: Runtime: 0:02:01.693465 2026-03-16 16:25:56.121687 | 2026-03-16 16:25:56.121828 | TASK [Install pytest-forked into virtualenv] 2026-03-16 16:26:08.042340 | controller | Collecting pytest-forked 2026-03-16 16:26:20.293650 | controller | Downloading pytest_forked-1.6.0-py3-none-any.whl (4.9 kB) 2026-03-16 16:26:20.337071 | controller | Collecting py 2026-03-16 16:26:20.340272 | controller | Downloading py-1.11.0-py2.py3-none-any.whl (98 kB) 2026-03-16 16:26:20.360653 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.7/98.7 kB 5.4 MB/s eta 0:00:00 2026-03-16 16:26:20.466902 | controller | Collecting pytest>=3.10 2026-03-16 16:26:20.470922 | controller | Downloading pytest-9.0.2-py3-none-any.whl (374 kB) 2026-03-16 16:26:20.485006 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 374.8/374.8 kB 33.5 MB/s eta 0:00:00 2026-03-16 16:26:20.530761 | controller | Collecting iniconfig>=1.0.1 2026-03-16 16:26:20.535230 | controller | Downloading iniconfig-2.3.0-py3-none-any.whl (7.5 kB) 2026-03-16 16:26:20.582834 | controller | Collecting packaging>=22 2026-03-16 16:26:20.586899 | controller | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-03-16 16:26:20.592434 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 21.6 MB/s eta 0:00:00 2026-03-16 16:26:20.623647 | controller | Collecting pluggy<2,>=1.5 2026-03-16 16:26:20.627275 | controller | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-03-16 16:26:20.674216 | controller | Collecting pygments>=2.7.2 2026-03-16 16:26:20.678928 | controller | Downloading pygments-2.19.2-py3-none-any.whl (1.2 MB) 2026-03-16 16:26:20.697423 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.2/1.2 MB 77.9 MB/s eta 0:00:00 2026-03-16 16:26:20.770929 | controller | Installing collected packages: pygments, py, pluggy, packaging, iniconfig, pytest, pytest-forked 2026-03-16 16:26:21.896957 | 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:26:21.905599 | controller | 2026-03-16 16:26:21.977700 | controller | [notice] A new release of pip available: 22.2.2 -> 26.0.1 2026-03-16 16:26:21.977733 | controller | [notice] To update, run: python -m pip install --upgrade pip 2026-03-16 16:26:22.195362 | controller | ok: Runtime: 0:00:25.597287 2026-03-16 16:26:22.208273 | 2026-03-16 16:26:22.208416 | TASK [Update pip] 2026-03-16 16:26:22.751650 | controller | Requirement already satisfied: pip in ./venv/lib/python3.11/site-packages (22.2.2) 2026-03-16 16:26:56.549500 | controller | Collecting pip 2026-03-16 16:27:08.744186 | controller | Downloading pip-26.0.1-py3-none-any.whl (1.8 MB) 2026-03-16 16:27:08.794455 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.8/1.8 MB 39.1 MB/s eta 0:00:00 2026-03-16 16:27:08.862822 | controller | Installing collected packages: pip 2026-03-16 16:27:08.862974 | controller | Attempting uninstall: pip 2026-03-16 16:27:08.865132 | controller | Found existing installation: pip 22.2.2 2026-03-16 16:27:09.004199 | controller | Uninstalling pip-22.2.2: 2026-03-16 16:27:09.019033 | controller | Successfully uninstalled pip-22.2.2 2026-03-16 16:27:09.846353 | controller | Successfully installed pip-26.0.1 2026-03-16 16:27:10.286731 | controller | ok: Runtime: 0:00:47.467921 2026-03-16 16:27:10.299606 | 2026-03-16 16:27:10.299771 | TASK [Ensure pip temp directory exists in /var/tmp] 2026-03-16 16:27:10.533854 | controller | changed 2026-03-16 16:27:10.549161 | 2026-03-16 16:27:10.549324 | TASK [Install ansible into virtualenv] 2026-03-16 16:27:11.121455 | controller | Processing ./src/github.com/ansible/ansible 2026-03-16 16:27:11.123816 | controller | Installing build dependencies: started 2026-03-16 16:28:00.156918 | controller | Installing build dependencies: finished with status 'done' 2026-03-16 16:28:00.157457 | controller | Getting requirements to build wheel: started 2026-03-16 16:28:00.911967 | controller | Getting requirements to build wheel: finished with status 'done' 2026-03-16 16:28:00.912409 | controller | Preparing metadata (pyproject.toml): started 2026-03-16 16:28:01.379257 | controller | Preparing metadata (pyproject.toml): finished with status 'done' 2026-03-16 16:28:01.381454 | 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:28:01.383926 | controller | ERROR: Package 'ansible-core' requires a different Python: 3.11.0 not in '>=3.12' 2026-03-16 16:28:01.678955 | controller | ERROR 2026-03-16 16:28:01.679317 | controller | { 2026-03-16 16:28:01.679379 | controller | "delta": "0:00:50.598536", 2026-03-16 16:28:01.679420 | controller | "end": "2026-03-16 16:28:01.441739", 2026-03-16 16:28:01.679457 | controller | "msg": "non-zero return code", 2026-03-16 16:28:01.679511 | controller | "rc": 1, 2026-03-16 16:28:01.679547 | controller | "start": "2026-03-16 16:27:10.843203" 2026-03-16 16:28:01.679581 | controller | } failure 2026-03-16 16:28:01.682429 | 2026-03-16 16:28:01.682526 | PLAY RECAP 2026-03-16 16:28:01.682602 | controller | ok: 18 changed: 10 unreachable: 0 failed: 1 skipped: 4 rescued: 0 ignored: 0 2026-03-16 16:28:01.682644 | 2026-03-16 16:28:01.810936 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-03-16 16:28:01.812944 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-16 16:28:02.446823 | 2026-03-16 16:28:02.446932 | PLAY [all] 2026-03-16 16:28:02.469095 | 2026-03-16 16:28:02.469209 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-03-16 16:28:02.761941 | controller | changed: non-zero return code 2026-03-16 16:28:02.767857 | 2026-03-16 16:28:02.767930 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-03-16 16:28:02.792884 | controller | skipping: Conditional result was False 2026-03-16 16:28:02.807188 | 2026-03-16 16:28:02.807488 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-03-16 16:28:02.849796 | 2026-03-16 16:28:02.850115 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-03-16 16:28:02.890853 | 2026-03-16 16:28:02.891154 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-03-16 16:28:02.918611 | controller | skipping: Conditional result was False 2026-03-16 16:28:02.934161 | 2026-03-16 16:28:02.934349 | LOOP [fetch-subunit-output : Generate subunit file] 2026-03-16 16:28:02.973697 | 2026-03-16 16:28:02.973967 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-03-16 16:28:03.001182 | controller | skipping: Conditional result was False 2026-03-16 16:28:03.015104 | 2026-03-16 16:28:03.015261 | TASK [fetch-subunit-output : Remove the temporary file] 2026-03-16 16:28:03.042149 | controller | skipping: Conditional result was False 2026-03-16 16:28:03.055048 | 2026-03-16 16:28:03.055215 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-03-16 16:28:03.082241 | controller | skipping: Conditional result was False 2026-03-16 16:28:03.130873 | 2026-03-16 16:28:03.130993 | PLAY RECAP 2026-03-16 16:28:03.131073 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-03-16 16:28:03.131105 | 2026-03-16 16:28:03.246128 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-16 16:28:03.247907 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2026-03-16 16:28:03.872145 | 2026-03-16 16:28:03.872259 | PLAY [all:!appliance*] 2026-03-16 16:28:03.894382 | 2026-03-16 16:28:03.894496 | TASK [unregister the node] 2026-03-16 16:28:04.428877 | controller | skipping: Conditional result was False 2026-03-16 16:28:04.437645 | 2026-03-16 16:28:04.437787 | TASK [include_role : fetch-output] 2026-03-16 16:28:04.486538 | controller | ok 2026-03-16 16:28:04.523446 | 2026-03-16 16:28:04.523647 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-16 16:28:04.601184 | controller | skipping: Conditional result was False 2026-03-16 16:28:04.621282 | 2026-03-16 16:28:04.621520 | TASK [fetch-output : Set log path for single node] 2026-03-16 16:28:04.673102 | controller | ok 2026-03-16 16:28:04.685699 | 2026-03-16 16:28:04.685854 | LOOP [fetch-output : Ensure local output dirs] 2026-03-16 16:28:05.135372 | controller -> localhost | ok: "/var/lib/zuul/builds/7e9a840097e641ae955948f54f574457/work/logs" 2026-03-16 16:28:05.363096 | controller -> localhost | changed: "/var/lib/zuul/builds/7e9a840097e641ae955948f54f574457/work/artifacts" 2026-03-16 16:28:05.619598 | controller -> localhost | changed: "/var/lib/zuul/builds/7e9a840097e641ae955948f54f574457/work/docs" 2026-03-16 16:28:05.638803 | 2026-03-16 16:28:05.638914 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-16 16:28:06.343246 | controller | changed: 2026-03-16 16:28:06.343573 | controller | .d..t...... ./ 2026-03-16 16:28:06.343636 | controller | cd+++++++++ controller/ 2026-03-16 16:28:06.343709 | controller | changed: All items complete 2026-03-16 16:28:06.343755 | 2026-03-16 16:28:06.905822 | controller | changed: .d..t...... ./ 2026-03-16 16:28:07.474850 | controller | changed: .d..t...... ./ 2026-03-16 16:28:07.504207 | 2026-03-16 16:28:07.504469 | TASK [include_role : fetch-output-openshift] 2026-03-16 16:28:07.532493 | controller | skipping: Conditional result was False 2026-03-16 16:28:07.550371 | 2026-03-16 16:28:07.550606 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-16 16:28:08.033716 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.013541 2026-03-16 16:28:08.347794 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.014547 2026-03-16 16:28:08.383382 | 2026-03-16 16:28:08.383480 | PLAY [localhost] 2026-03-16 16:28:08.396705 | 2026-03-16 16:28:08.396841 | TASK [Run Zuul manifest role] 2026-03-16 16:28:08.418089 | localhost | ok 2026-03-16 16:28:08.431154 | 2026-03-16 16:28:08.431232 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-16 16:28:08.854327 | localhost | changed 2026-03-16 16:28:08.859372 | 2026-03-16 16:28:08.859457 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-16 16:28:08.900994 | localhost | ok 2026-03-16 16:28:08.909086 | 2026-03-16 16:28:08.909146 | TASK [Set zuul-log-path fact] 2026-03-16 16:28:08.928815 | localhost | ok 2026-03-16 16:28:08.941995 | 2026-03-16 16:28:08.942075 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-16 16:28:08.980623 | localhost | ok 2026-03-16 16:28:08.988872 | 2026-03-16 16:28:08.988936 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)] 2026-03-16 16:28:09.034213 | localhost | ok: 2026-03-16 16:28:09.034493 | localhost | { 2026-03-16 16:28:09.034550 | localhost | "auth": { 2026-03-16 16:28:09.034599 | localhost | "password": "IonWCwcuOFib&&<}wp^:[2G/", 2026-03-16 16:28:09.034639 | localhost | "username": "9LF91O0RK7JU" 2026-03-16 16:28:09.034678 | localhost | }, 2026-03-16 16:28:09.034716 | localhost | "profile": "rackspace", 2026-03-16 16:28:09.034870 | localhost | "region_name": "IAD" 2026-03-16 16:28:09.034923 | localhost | } 2026-03-16 16:28:09.034992 | localhost | changed: All items complete 2026-03-16 16:28:09.035076 | 2026-03-16 16:28:09.050105 | 2026-03-16 16:28:09.050216 | TASK [Run upload-logs-failover role (S3 then Swift)] 2026-03-16 16:28:09.071586 | localhost | Output suppressed because no_log was given 2026-03-16 16:28:09.135751 | 2026-03-16 16:28:09.135939 | TASK [upload-logs-failover : Initialize control vars] 2026-03-16 16:28:09.172839 | localhost | ok 2026-03-16 16:28:09.180733 | 2026-03-16 16:28:09.180842 | LOOP [upload-logs-failover : Perform log upload] 2026-03-16 16:28:09.228622 | localhost | Output suppressed because no_log was given 2026-03-16 16:28:09.242771 | localhost | included: /var/lib/zuul/builds/7e9a840097e641ae955948f54f574457/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml 2026-03-16 16:28:09.256647 | 2026-03-16 16:28:09.256809 | LOOP [upload-logs-failover : Unpack vars for swift upload] 2026-03-16 16:28:09.369415 | localhost | Output suppressed because no_log was given 2026-03-16 16:28:09.380710 | 2026-03-16 16:28:09.380870 | TASK [Upload logs to swift] 2026-03-16 16:28:09.417104 | localhost | ok 2026-03-16 16:28:09.465130 | 2026-03-16 16:28:09.465232 | TASK [Set zuul-log-path fact] 2026-03-16 16:28:09.500988 | localhost | skipping: Conditional result was False 2026-03-16 16:28:09.513636 | 2026-03-16 16:28:09.513803 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2026-03-16 16:28:09.887996 | localhost -> localhost | ok: Runtime: 0:00:00.008784 2026-03-16 16:28:09.899477 | 2026-03-16 16:28:09.899676 | TASK [upload-logs-swift : Upload logs to swift]