2026-02-26 00:30:11.642751 | Job console starting... 2026-02-26 00:30:11.653390 | Updating repositories 2026-02-26 00:30:11.878722 | Preparing job workspace 2026-02-26 00:30:16.026476 | Running Ansible setup... 2026-02-26 00:30:21.241353 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-02-26 00:30:21.970642 | 2026-02-26 00:30:21.970836 | PLAY [localhost] 2026-02-26 00:30:21.980486 | 2026-02-26 00:30:21.980577 | TASK [Gathering Facts] 2026-02-26 00:30:23.111239 | localhost | ok 2026-02-26 00:30:23.129975 | 2026-02-26 00:30:23.130156 | TASK [Setup log path fact] 2026-02-26 00:30:23.153340 | localhost | ok 2026-02-26 00:30:23.177360 | 2026-02-26 00:30:23.177592 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-26 00:30:23.212353 | localhost | ok 2026-02-26 00:30:23.235464 | 2026-02-26 00:30:23.236076 | TASK [emit-job-header : Print job information] 2026-02-26 00:30:23.289320 | # Job Information 2026-02-26 00:30:23.289568 | Ansible Version: 2.15.12 2026-02-26 00:30:23.289603 | Job: ansible-test-sanity-docker-stable-2.11 2026-02-26 00:30:23.289631 | Pipeline: periodic 2026-02-26 00:30:23.289650 | Executor: ze02.softwarefactory-project.io 2026-02-26 00:30:23.289688 | Triggered by: https://github.com/ansible-collections/ansible.network 2026-02-26 00:30:23.289716 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/197/ansible/1970d37b6362449cad7f79e33e919f60/ 2026-02-26 00:30:23.289737 | Event ID: 2adb30751d3546bcab5e20cd6f839642 2026-02-26 00:30:23.294086 | 2026-02-26 00:30:23.294154 | LOOP [emit-job-header : Print node information] 2026-02-26 00:30:23.411395 | localhost | ok: 2026-02-26 00:30:23.411654 | localhost | # Node Information 2026-02-26 00:30:23.411700 | localhost | Inventory Hostname: controller 2026-02-26 00:30:23.411721 | localhost | Hostname: np0005630882 2026-02-26 00:30:23.411740 | localhost | Username: zuul 2026-02-26 00:30:23.411765 | localhost | Distro: Fedora 37 2026-02-26 00:30:23.411784 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2026-02-26 00:30:23.411801 | localhost | Region: ca-ymq-1 2026-02-26 00:30:23.411817 | localhost | Label: ansible-fedora-37-1vcpu 2026-02-26 00:30:23.411834 | localhost | Product Name: OpenStack Nova 2026-02-26 00:30:23.411850 | localhost | Interface IP: 162.253.55.74 2026-02-26 00:30:23.426055 | 2026-02-26 00:30:23.426252 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-26 00:30:23.866492 | localhost -> localhost | changed 2026-02-26 00:30:23.897133 | 2026-02-26 00:30:23.897380 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-26 00:30:24.861229 | localhost -> localhost | changed 2026-02-26 00:30:24.901971 | 2026-02-26 00:30:24.902092 | PLAY [all:!appliance*] 2026-02-26 00:30:24.928004 | 2026-02-26 00:30:24.928162 | TASK [include_role : start-zuul-console] 2026-02-26 00:30:24.954093 | controller | ok 2026-02-26 00:30:24.977005 | 2026-02-26 00:30:24.977137 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-02-26 00:30:25.380522 | controller | ok 2026-02-26 00:30:25.394563 | 2026-02-26 00:30:25.394805 | TASK [use-our-mirror : Retrieve the IP address] 2026-02-26 00:30:26.577019 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2026-02-26 00:30:26.586365 | 2026-02-26 00:30:26.586596 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2026-02-26 00:30:27.125915 | controller | skipping: Conditional result was False 2026-02-26 00:30:27.134008 | 2026-02-26 00:30:27.134241 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2026-02-26 00:30:27.169563 | controller | skipping: Conditional result was False 2026-02-26 00:30:27.178005 | 2026-02-26 00:30:27.178173 | TASK [use-our-mirror : Create the podman configuration directory] 2026-02-26 00:30:27.214409 | controller | skipping: Conditional result was False 2026-02-26 00:30:27.222741 | 2026-02-26 00:30:27.222932 | TASK [use-our-mirror : Copy the podman configuration] 2026-02-26 00:30:27.259756 | controller | skipping: Conditional result was False 2026-02-26 00:30:27.277402 | 2026-02-26 00:30:27.277614 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2026-02-26 00:30:27.316464 | controller | skipping: Conditional result was False 2026-02-26 00:30:27.332475 | 2026-02-26 00:30:27.332657 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2026-02-26 00:30:27.372429 | controller | skipping: Conditional result was False 2026-02-26 00:30:27.392862 | 2026-02-26 00:30:27.393058 | TASK [Disable Fedora Modular] 2026-02-26 00:30:27.676244 | controller | changed 2026-02-26 00:30:27.697874 | 2026-02-26 00:30:27.698109 | TASK [Enable EPEL] 2026-02-26 00:30:27.726742 | controller | skipping: Conditional result was False 2026-02-26 00:30:27.737910 | 2026-02-26 00:30:27.738118 | TASK [Register the RHEL node] 2026-02-26 00:30:28.318623 | 2026-02-26 00:30:28.319016 | TASK [Show the subscription-manager status] 2026-02-26 00:30:28.929186 | controller | skipping: Conditional result was False 2026-02-26 00:30:28.940613 | 2026-02-26 00:30:28.940789 | TASK [Enable EPEL on RHEL] 2026-02-26 00:30:29.490576 | controller | skipping: Conditional result was False 2026-02-26 00:30:29.505530 | 2026-02-26 00:30:29.505730 | TASK [Install git and tox] 2026-02-26 00:31:51.626953 | controller | changed 2026-02-26 00:31:51.641104 | 2026-02-26 00:31:51.641238 | TASK [include_role : prepare-workspace] 2026-02-26 00:31:51.682883 | controller | ok 2026-02-26 00:31:51.718820 | 2026-02-26 00:31:51.718980 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-02-26 00:31:51.962314 | controller | ok 2026-02-26 00:31:51.979256 | 2026-02-26 00:31:51.979451 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-02-26 00:32:04.469646 | controller | Output suppressed because no_log was given 2026-02-26 00:32:04.487851 | 2026-02-26 00:32:04.488008 | TASK [include_role : prepare-workspace-openshift] 2026-02-26 00:32:04.518533 | controller | skipping: Conditional result was False 2026-02-26 00:32:04.605325 | 2026-02-26 00:32:04.605487 | PLAY [all:!appliance] 2026-02-26 00:32:04.643097 | 2026-02-26 00:32:04.643322 | TASK [Run add-build-sshkey role (RSA)] 2026-02-26 00:32:04.678596 | controller | ok 2026-02-26 00:32:04.702094 | 2026-02-26 00:32:04.702268 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-26 00:32:05.009155 | controller -> localhost | ok 2026-02-26 00:32:05.024481 | 2026-02-26 00:32:05.024761 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-26 00:32:05.071808 | controller | ok 2026-02-26 00:32:05.097029 | controller | included: /var/lib/zuul/builds/1970d37b6362449cad7f79e33e919f60/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-26 00:32:05.107170 | 2026-02-26 00:32:05.107309 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-26 00:32:05.686305 | controller -> localhost | Generating public/private rsa key pair. 2026-02-26 00:32:05.686778 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/1970d37b6362449cad7f79e33e919f60/work/1970d37b6362449cad7f79e33e919f60_id_rsa. 2026-02-26 00:32:05.686867 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/1970d37b6362449cad7f79e33e919f60/work/1970d37b6362449cad7f79e33e919f60_id_rsa.pub. 2026-02-26 00:32:05.686918 | controller -> localhost | The key fingerprint is: 2026-02-26 00:32:05.686962 | controller -> localhost | SHA256:+3EFQMh8wSV4f09lq2i2kdt6sFCL8EClVKzRS40Hho8 zuul-build-sshkey 2026-02-26 00:32:05.687014 | controller -> localhost | The key's randomart image is: 2026-02-26 00:32:05.687068 | controller -> localhost | +---[RSA 2048]----+ 2026-02-26 00:32:05.687169 | controller -> localhost | | +*XOo. | 2026-02-26 00:32:05.687218 | controller -> localhost | | .+B=+= o| 2026-02-26 00:32:05.687259 | controller -> localhost | | ..*oo.. .o| 2026-02-26 00:32:05.687299 | controller -> localhost | | E o ......| 2026-02-26 00:32:05.687337 | controller -> localhost | | S o +.oo | 2026-02-26 00:32:05.687394 | controller -> localhost | | = O o .| 2026-02-26 00:32:05.687446 | controller -> localhost | | . = O | 2026-02-26 00:32:05.687488 | controller -> localhost | | . * o | 2026-02-26 00:32:05.687563 | controller -> localhost | | ..o | 2026-02-26 00:32:05.687610 | controller -> localhost | +----[SHA256]-----+ 2026-02-26 00:32:05.687749 | controller -> localhost | ok: Runtime: 0:00:00.033613 2026-02-26 00:32:05.707163 | 2026-02-26 00:32:05.707268 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-26 00:32:05.740681 | controller | ok 2026-02-26 00:32:05.755845 | controller | included: /var/lib/zuul/builds/1970d37b6362449cad7f79e33e919f60/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-26 00:32:05.768718 | 2026-02-26 00:32:05.768806 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-26 00:32:05.794169 | controller | skipping: Conditional result was False 2026-02-26 00:32:05.806035 | 2026-02-26 00:32:05.806137 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-26 00:32:06.313251 | controller | changed 2026-02-26 00:32:06.319147 | 2026-02-26 00:32:06.319214 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-26 00:32:06.555660 | controller | ok 2026-02-26 00:32:06.569885 | 2026-02-26 00:32:06.570118 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-26 00:32:07.216613 | controller | changed 2026-02-26 00:32:07.223276 | 2026-02-26 00:32:07.223397 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-26 00:32:07.820806 | controller | changed 2026-02-26 00:32:07.829782 | 2026-02-26 00:32:07.829908 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-26 00:32:07.855613 | controller | skipping: Conditional result was False 2026-02-26 00:32:07.870437 | 2026-02-26 00:32:07.870699 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-26 00:32:08.297104 | controller -> localhost | changed 2026-02-26 00:32:08.317577 | 2026-02-26 00:32:08.317815 | TASK [add-build-sshkey : Add back temp key] 2026-02-26 00:32:08.681773 | controller -> localhost | Identity added: /var/lib/zuul/builds/1970d37b6362449cad7f79e33e919f60/work/1970d37b6362449cad7f79e33e919f60_id_rsa (zuul-build-sshkey) 2026-02-26 00:32:08.682137 | controller -> localhost | ok: Runtime: 0:00:00.009595 2026-02-26 00:32:08.694116 | 2026-02-26 00:32:08.694219 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-26 00:32:09.061815 | controller | ok 2026-02-26 00:32:09.071584 | 2026-02-26 00:32:09.071780 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-26 00:32:09.108461 | controller | skipping: Conditional result was False 2026-02-26 00:32:09.122415 | 2026-02-26 00:32:09.122535 | TASK [Run add-build-sshkey role (ECDSA)] 2026-02-26 00:32:09.154569 | controller | ok 2026-02-26 00:32:09.178540 | 2026-02-26 00:32:09.178727 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-26 00:32:09.470289 | controller -> localhost | ok 2026-02-26 00:32:09.488853 | 2026-02-26 00:32:09.489067 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-26 00:32:09.535841 | controller | ok 2026-02-26 00:32:09.560291 | controller | included: /var/lib/zuul/builds/1970d37b6362449cad7f79e33e919f60/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-26 00:32:09.569788 | 2026-02-26 00:32:09.569902 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-26 00:32:09.924365 | controller -> localhost | Generating public/private ecdsa key pair. 2026-02-26 00:32:09.924743 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/1970d37b6362449cad7f79e33e919f60/work/1970d37b6362449cad7f79e33e919f60_id_ecdsa. 2026-02-26 00:32:09.924807 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/1970d37b6362449cad7f79e33e919f60/work/1970d37b6362449cad7f79e33e919f60_id_ecdsa.pub. 2026-02-26 00:32:09.924868 | controller -> localhost | The key fingerprint is: 2026-02-26 00:32:09.924916 | controller -> localhost | SHA256:WP5gT2GpiK7tQRW6IJ6os2aQtHxn6bGnTSLxxfEklEE zuul-build-sshkey 2026-02-26 00:32:09.924957 | controller -> localhost | The key's randomart image is: 2026-02-26 00:32:09.924997 | controller -> localhost | +---[ECDSA 521]---+ 2026-02-26 00:32:09.925064 | controller -> localhost | | oEo | 2026-02-26 00:32:09.925107 | controller -> localhost | | ..o . | 2026-02-26 00:32:09.925145 | controller -> localhost | |. . . .o..+ | 2026-02-26 00:32:09.925182 | controller -> localhost | |oo.. +.==o . | 2026-02-26 00:32:09.925219 | controller -> localhost | |++..+ +oS.. | 2026-02-26 00:32:09.925255 | controller -> localhost | |+o +o=.. = | 2026-02-26 00:32:09.925291 | controller -> localhost | |+ ..*oo. o | 2026-02-26 00:32:09.925327 | controller -> localhost | | = o.++. | 2026-02-26 00:32:09.925362 | controller -> localhost | |+ ..o.o. | 2026-02-26 00:32:09.925398 | controller -> localhost | +----[SHA256]-----+ 2026-02-26 00:32:09.925490 | controller -> localhost | ok: Runtime: 0:00:00.016503 2026-02-26 00:32:09.941441 | 2026-02-26 00:32:09.941588 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-26 00:32:09.984767 | controller | ok 2026-02-26 00:32:10.003155 | controller | included: /var/lib/zuul/builds/1970d37b6362449cad7f79e33e919f60/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-26 00:32:10.015692 | 2026-02-26 00:32:10.015784 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-26 00:32:10.042198 | controller | skipping: Conditional result was False 2026-02-26 00:32:10.053935 | 2026-02-26 00:32:10.054129 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-26 00:32:10.373217 | controller | changed 2026-02-26 00:32:10.387752 | 2026-02-26 00:32:10.387887 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-26 00:32:10.643197 | controller | ok 2026-02-26 00:32:10.652399 | 2026-02-26 00:32:10.652530 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-26 00:32:11.343230 | controller | changed 2026-02-26 00:32:11.360118 | 2026-02-26 00:32:11.360360 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-26 00:32:12.014727 | controller | changed 2026-02-26 00:32:12.024932 | 2026-02-26 00:32:12.025131 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-26 00:32:12.065506 | controller | skipping: Conditional result was False 2026-02-26 00:32:12.076939 | 2026-02-26 00:32:12.077139 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-26 00:32:12.359833 | controller -> localhost | changed 2026-02-26 00:32:12.372735 | 2026-02-26 00:32:12.372811 | TASK [add-build-sshkey : Add back temp key] 2026-02-26 00:32:12.761050 | controller -> localhost | Identity added: /var/lib/zuul/builds/1970d37b6362449cad7f79e33e919f60/work/1970d37b6362449cad7f79e33e919f60_id_ecdsa (zuul-build-sshkey) 2026-02-26 00:32:12.761582 | controller -> localhost | ok: Runtime: 0:00:00.008048 2026-02-26 00:32:12.842643 | 2026-02-26 00:32:12.842822 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-26 00:37:14.570856 | controller | ok 2026-02-26 00:37:14.579394 | 2026-02-26 00:37:14.579497 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-26 00:37:14.605624 | controller | skipping: Conditional result was False 2026-02-26 00:37:14.623460 | 2026-02-26 00:37:14.623569 | TASK [include_role : remove-zuul-sshkey] 2026-02-26 00:37:14.649569 | controller | skipping: Conditional result was False 2026-02-26 00:37:14.660991 | 2026-02-26 00:37:14.661093 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-02-26 00:37:14.909822 | controller | ok: "logs" 2026-02-26 00:37:14.910270 | controller | ok: All items complete 2026-02-26 00:37:14.910330 | 2026-02-26 00:37:15.113231 | controller | ok: "artifacts" 2026-02-26 00:37:15.306059 | controller | ok: "docs" 2026-02-26 00:37:15.327033 | 2026-02-26 00:37:15.327282 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-02-26 00:37:15.560584 | controller | changed: "logs" 2026-02-26 00:37:15.764648 | controller | changed: "artifacts" 2026-02-26 00:37:15.966438 | controller | changed: "docs" 2026-02-26 00:37:16.033999 | 2026-02-26 00:37:16.034163 | PLAY RECAP 2026-02-26 00:37:16.034229 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2026-02-26 00:37:16.034265 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-26 00:37:16.034291 | 2026-02-26 00:37:16.169515 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-02-26 00:37:16.171752 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-26 00:37:16.831549 | 2026-02-26 00:37:16.831700 | PLAY [all] 2026-02-26 00:37:16.853780 | 2026-02-26 00:37:16.853879 | TASK [Install binary dependencies] 2026-02-26 00:37:16.934256 | controller | ok 2026-02-26 00:37:16.954243 | 2026-02-26 00:37:16.954401 | TASK [bindep : Include find tasks] 2026-02-26 00:37:16.994436 | controller | ok 2026-02-26 00:37:17.002496 | controller | included: /var/lib/zuul/builds/1970d37b6362449cad7f79e33e919f60/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-02-26 00:37:17.008854 | 2026-02-26 00:37:17.008920 | TASK [bindep : Look for bindep.txt] 2026-02-26 00:37:17.580780 | controller | ok 2026-02-26 00:37:17.595043 | 2026-02-26 00:37:17.595207 | TASK [bindep : Define bindep_file fact] 2026-02-26 00:37:17.623826 | controller | skipping: Conditional result was False 2026-02-26 00:37:17.639765 | 2026-02-26 00:37:17.639953 | TASK [bindep : Look for other-requirements.txt] 2026-02-26 00:37:17.875767 | controller | ok 2026-02-26 00:37:17.889632 | 2026-02-26 00:37:17.889857 | TASK [bindep : Define bindep_file fact] 2026-02-26 00:37:17.916720 | controller | skipping: Conditional result was False 2026-02-26 00:37:17.931586 | 2026-02-26 00:37:17.931833 | TASK [bindep : Look for bindep fallback file] 2026-02-26 00:37:17.970103 | controller | skipping: Conditional result was False 2026-02-26 00:37:17.986009 | 2026-02-26 00:37:17.986215 | TASK [bindep : Define bindep_file fact] 2026-02-26 00:37:18.024219 | controller | skipping: Conditional result was False 2026-02-26 00:37:18.038260 | 2026-02-26 00:37:18.038455 | TASK [bindep : Include bindep tasks] 2026-02-26 00:37:18.076896 | controller | skipping: Conditional result was False 2026-02-26 00:37:18.083794 | 2026-02-26 00:37:18.083859 | TASK [bindep : Include install tasks] 2026-02-26 00:37:18.129278 | controller | skipping: Conditional result was False 2026-02-26 00:37:18.135999 | 2026-02-26 00:37:18.136062 | LOOP [bindep : Include package tasks] 2026-02-26 00:37:18.214502 | 2026-02-26 00:37:18.214702 | TASK [Run test-setup role] 2026-02-26 00:37:18.235593 | controller | ok 2026-02-26 00:37:18.252894 | 2026-02-26 00:37:18.253050 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-02-26 00:37:18.463590 | controller | ok 2026-02-26 00:37:18.477091 | 2026-02-26 00:37:18.477373 | TASK [test-setup : Run tools/test-setup.sh] 2026-02-26 00:37:19.027241 | controller | skipping: Conditional result was False 2026-02-26 00:37:19.064000 | 2026-02-26 00:37:19.064085 | PLAY RECAP 2026-02-26 00:37:19.064142 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-26 00:37:19.064170 | 2026-02-26 00:37:19.169912 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-26 00:37:19.171760 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-02-26 00:37:19.795973 | 2026-02-26 00:37:19.796139 | PLAY [controller] 2026-02-26 00:37:19.817037 | 2026-02-26 00:37:19.817165 | TASK [Create the /root directory] 2026-02-26 00:37:20.405996 | controller | ok 2026-02-26 00:37:20.418660 | 2026-02-26 00:37:20.418838 | TASK [Install glibc-langpack-en] 2026-02-26 00:37:24.374771 | controller | ok: Nothing to do 2026-02-26 00:37:24.387837 | 2026-02-26 00:37:24.388037 | TASK [Ensure controller directory exists] 2026-02-26 00:37:24.595632 | controller | changed 2026-02-26 00:37:24.601264 | 2026-02-26 00:37:24.601327 | TASK [Install container runtime] 2026-02-26 00:37:24.671474 | controller | ok 2026-02-26 00:37:24.712970 | 2026-02-26 00:37:24.713113 | LOOP [ensure-docker : Gather variables for each operating system] 2026-02-26 00:37:24.770491 | controller | ok: "/var/lib/zuul/builds/1970d37b6362449cad7f79e33e919f60/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/vars/fedora.yaml" 2026-02-26 00:37:24.785270 | 2026-02-26 00:37:24.785365 | TASK [ensure-docker : Sanity check for distro selection] 2026-02-26 00:37:24.810660 | controller | skipping: Conditional result was False 2026-02-26 00:37:24.817023 | 2026-02-26 00:37:24.817143 | TASK [ensure-docker : Sanity check for distro install] 2026-02-26 00:37:24.842421 | controller | skipping: Conditional result was False 2026-02-26 00:37:24.856299 | 2026-02-26 00:37:24.856509 | TASK [ensure-docker : Sanity check for upstream install] 2026-02-26 00:37:24.895259 | controller | skipping: Conditional result was False 2026-02-26 00:37:24.909726 | 2026-02-26 00:37:24.909951 | TASK [ensure-docker : Sanity check for upstream install mirrors] 2026-02-26 00:37:24.948003 | controller | skipping: Conditional result was False 2026-02-26 00:37:24.958991 | 2026-02-26 00:37:24.959114 | TASK [ensure-docker : Include tasks for docker install] 2026-02-26 00:37:24.991408 | controller | ok 2026-02-26 00:37:25.000044 | controller | included: /var/lib/zuul/builds/1970d37b6362449cad7f79e33e919f60/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/tasks/docker-upstream.yaml 2026-02-26 00:37:25.008105 | 2026-02-26 00:37:25.008173 | TASK [ensure-docker : Not Implemented] 2026-02-26 00:37:25.033101 | controller | skipping: Conditional result was False 2026-02-26 00:37:25.040846 | 2026-02-26 00:37:25.040937 | TASK [Set up docker mirrors] 2026-02-26 00:37:25.063727 | controller | ok 2026-02-26 00:37:25.090584 | 2026-02-26 00:37:25.090690 | TASK [use-docker-mirror : Set docker_mirror fact from mirror_info] 2026-02-26 00:37:25.125707 | controller | skipping: Conditional result was False 2026-02-26 00:37:25.132576 | 2026-02-26 00:37:25.132650 | TASK [use-docker-mirror : Set docker_mirror fact from zuul_site_mirror_info] 2026-02-26 00:37:25.167694 | controller | skipping: Conditional result was False 2026-02-26 00:37:25.181074 | 2026-02-26 00:37:25.181231 | TASK [use-docker-mirror : Set docker_mirror fact] 2026-02-26 00:37:25.218192 | controller | skipping: Conditional result was False 2026-02-26 00:37:25.224336 | 2026-02-26 00:37:25.224399 | TASK [use-docker-mirror : Set up docker mirrors] 2026-02-26 00:37:25.258909 | controller | skipping: Conditional result was False 2026-02-26 00:37:25.278352 | 2026-02-26 00:37:25.278656 | TASK [Add all repositories] 2026-02-26 00:37:25.307364 | controller | ok 2026-02-26 00:37:25.341979 | 2026-02-26 00:37:25.342175 | LOOP [ensure-package-repositories : Install repositories] 2026-02-26 00:37:25.378618 | controller | ok: "/var/lib/zuul/builds/1970d37b6362449cad7f79e33e919f60/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-package-repositories/tasks/RedHat.yaml" 2026-02-26 00:37:25.379472 | controller | ok: All items complete 2026-02-26 00:37:25.379511 | 2026-02-26 00:37:25.456205 | controller | included: /var/lib/zuul/builds/1970d37b6362449cad7f79e33e919f60/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-package-repositories/tasks/RedHat.yaml 2026-02-26 00:37:25.464653 | 2026-02-26 00:37:25.464886 | TASK [ensure-package-repositories : Create GPG key temp directory] 2026-02-26 00:37:25.810573 | controller | changed 2026-02-26 00:37:25.821381 | 2026-02-26 00:37:25.821586 | LOOP [ensure-package-repositories : Upload GPG keys] 2026-02-26 00:37:26.816502 | controller | changed: 2026-02-26 00:37:26.816893 | controller | { 2026-02-26 00:37:26.816951 | controller | "data": "-----BEGIN PGP PUBLIC KEY BLOCK-----\n\nmQINBFit5IEBEADDt86QpYKz5flnCsOyZ/fk3WwBKxfDjwHf/GIflo+4GWAXS7wJ\n1PSzPsvSDATV10J44i5WQzh99q+lZvFCVRFiNhRmlmcXG+rk1QmDh3fsCCj9Q/yP\nw8jn3Hx0zDtz8PIB/18ReftYJzUo34COLiHn8WiY20uGCF2pjdPgfxE+K454c4G7\ngKFqVUFYgPug2CS0quaBB5b0rpFUdzTeI5RCStd27nHCpuSDCvRYAfdv+4Y1yiVh\nKKdoe3Smj+RnXeVMgDxtH9FJibZ3DK7WnMN2yeob6VqXox+FvKYJCCLkbQgQmE50\nuVK0uN71A1mQDcTRKQ2q3fFGlMTqJbbzr3LwnCBE6hV0a36t+DABtZTmz5O69xdJ\nWGdBeePCnWVqtDb/BdEYz7hPKskcZBarygCCe2Xi7sZieoFZuq6ltPoCsdfEdfbO\n+VBVKJnExqNZCcFUTEnbH4CldWROOzMS8BGUlkGpa59Sl1t0QcmWlw1EbkeMQNrN\nspdR8lobcdNS9bpAJQqSHRZh3cAM9mA3Yq/bssUS/P2quRXLjJ9mIv3dky9C3udM\n+q2unvnbNpPtIUly76FJ3s8g8sHeOnmYcKqNGqHq2Q3kMdA2eIbI0MqfOIo2+Xk0\nrNt3ctq3g+cQiorcN3rdHPsTRSAcp+NCz1QF9TwXYtH1XV24A6QMO0+CZwARAQAB\ntCtEb2NrZXIgUmVsZWFzZSAoQ0UgcnBtKSA8ZG9ja2VyQGRvY2tlci5jb20+iQI3\nBBMBCgAhBQJYrep4AhsvBQsJCAcDBRUKCQgLBRYCAwEAAh4BAheAAAoJEMUv62ti\nHp816C0P/iP+1uhSa6Qq3TIc5sIFE5JHxOO6y0R97cUdAmCbEqBiJHUPNQDQaaRG\nVYBm0K013Q1gcJeUJvS32gthmIvhkstw7KTodwOM8Kl11CCqZ07NPFef1b2SaJ7l\nTYpyUsT9+e343ph+O4C1oUQw6flaAJe+8ATCmI/4KxfhIjD2a/Q1voR5tUIxfexC\n/LZTx05gyf2mAgEWlRm/cGTStNfqDN1uoKMlV+WFuB1j2oTUuO1/dr8mL+FgZAM3\nntWFo9gQCllNV9ahYOON2gkoZoNuPUnHsf4Bj6BQJnIXbAhMk9H2sZzwUi9bgObZ\nXO8+OrP4D4B9kCAKqqaQqA+O46LzO2vhN74lm/Fy6PumHuviqDBdN+HgtRPMUuao\nxnuVJSvBu9sPdgT/pR1N9u/KnfAnnLtR6g+fx4mWz+ts/riB/KRHzXd+44jGKZra\nIhTMfniguMJNsyEOO0AN8Tqcl0eRBxcOArcri7xu8HFvvl+e+ILymu4buusbYEVL\nGBkYP5YMmScfKn+jnDVN4mWoN1Bq2yMhMGx6PA3hOvzPNsUoYy2BwDxNZyflzuAi\ng59mgJm2NXtzNbSRJbMamKpQ69mzLWGdFNsRd4aH7PT7uPAURaf7B5BVp3UyjERW\n5alSGnBqsZmvlRnVH5BDUhYsWZMPRQS9rRr4iGW0l+TH+O2VJ8aQ\n=0Zqq\n-----END PGP PUBLIC KEY BLOCK-----\n" 2026-02-26 00:37:26.816999 | controller | } 2026-02-26 00:37:26.846247 | 2026-02-26 00:37:26.846551 | LOOP [ensure-package-repositories : Import GPG keys] 2026-02-26 00:37:27.542458 | controller | changed: 2026-02-26 00:37:27.542731 | controller | { 2026-02-26 00:37:27.542767 | controller | "data": "-----BEGIN PGP PUBLIC KEY BLOCK-----\n\nmQINBFit5IEBEADDt86QpYKz5flnCsOyZ/fk3WwBKxfDjwHf/GIflo+4GWAXS7wJ\n1PSzPsvSDATV10J44i5WQzh99q+lZvFCVRFiNhRmlmcXG+rk1QmDh3fsCCj9Q/yP\nw8jn3Hx0zDtz8PIB/18ReftYJzUo34COLiHn8WiY20uGCF2pjdPgfxE+K454c4G7\ngKFqVUFYgPug2CS0quaBB5b0rpFUdzTeI5RCStd27nHCpuSDCvRYAfdv+4Y1yiVh\nKKdoe3Smj+RnXeVMgDxtH9FJibZ3DK7WnMN2yeob6VqXox+FvKYJCCLkbQgQmE50\nuVK0uN71A1mQDcTRKQ2q3fFGlMTqJbbzr3LwnCBE6hV0a36t+DABtZTmz5O69xdJ\nWGdBeePCnWVqtDb/BdEYz7hPKskcZBarygCCe2Xi7sZieoFZuq6ltPoCsdfEdfbO\n+VBVKJnExqNZCcFUTEnbH4CldWROOzMS8BGUlkGpa59Sl1t0QcmWlw1EbkeMQNrN\nspdR8lobcdNS9bpAJQqSHRZh3cAM9mA3Yq/bssUS/P2quRXLjJ9mIv3dky9C3udM\n+q2unvnbNpPtIUly76FJ3s8g8sHeOnmYcKqNGqHq2Q3kMdA2eIbI0MqfOIo2+Xk0\nrNt3ctq3g+cQiorcN3rdHPsTRSAcp+NCz1QF9TwXYtH1XV24A6QMO0+CZwARAQAB\ntCtEb2NrZXIgUmVsZWFzZSAoQ0UgcnBtKSA8ZG9ja2VyQGRvY2tlci5jb20+iQI3\nBBMBCgAhBQJYrep4AhsvBQsJCAcDBRUKCQgLBRYCAwEAAh4BAheAAAoJEMUv62ti\nHp816C0P/iP+1uhSa6Qq3TIc5sIFE5JHxOO6y0R97cUdAmCbEqBiJHUPNQDQaaRG\nVYBm0K013Q1gcJeUJvS32gthmIvhkstw7KTodwOM8Kl11CCqZ07NPFef1b2SaJ7l\nTYpyUsT9+e343ph+O4C1oUQw6flaAJe+8ATCmI/4KxfhIjD2a/Q1voR5tUIxfexC\n/LZTx05gyf2mAgEWlRm/cGTStNfqDN1uoKMlV+WFuB1j2oTUuO1/dr8mL+FgZAM3\nntWFo9gQCllNV9ahYOON2gkoZoNuPUnHsf4Bj6BQJnIXbAhMk9H2sZzwUi9bgObZ\nXO8+OrP4D4B9kCAKqqaQqA+O46LzO2vhN74lm/Fy6PumHuviqDBdN+HgtRPMUuao\nxnuVJSvBu9sPdgT/pR1N9u/KnfAnnLtR6g+fx4mWz+ts/riB/KRHzXd+44jGKZra\nIhTMfniguMJNsyEOO0AN8Tqcl0eRBxcOArcri7xu8HFvvl+e+ILymu4buusbYEVL\nGBkYP5YMmScfKn+jnDVN4mWoN1Bq2yMhMGx6PA3hOvzPNsUoYy2BwDxNZyflzuAi\ng59mgJm2NXtzNbSRJbMamKpQ69mzLWGdFNsRd4aH7PT7uPAURaf7B5BVp3UyjERW\n5alSGnBqsZmvlRnVH5BDUhYsWZMPRQS9rRr4iGW0l+TH+O2VJ8aQ\n=0Zqq\n-----END PGP PUBLIC KEY BLOCK-----\n" 2026-02-26 00:37:27.542813 | controller | } 2026-02-26 00:37:27.542853 | controller | changed: All items complete 2026-02-26 00:37:27.542879 | 2026-02-26 00:37:27.568152 | 2026-02-26 00:37:27.568426 | TASK [ensure-package-repositories : Remove GPG temp directory] 2026-02-26 00:37:27.814553 | controller | changed 2026-02-26 00:37:27.829358 | 2026-02-26 00:37:27.829569 | LOOP [ensure-package-repositories : Add repositories] 2026-02-26 00:37:28.196184 | controller | changed: 2026-02-26 00:37:28.196901 | controller | { 2026-02-26 00:37:28.196975 | controller | "baseurl": "https://download.docker.com/linux/fedora/$releasever/$basearch/stable", 2026-02-26 00:37:28.197018 | controller | "description": "Docker CE Stable - $basearch", 2026-02-26 00:37:28.197060 | controller | "gpgcheck": true, 2026-02-26 00:37:28.197111 | controller | "name": "docker-ce-stable" 2026-02-26 00:37:28.197165 | controller | } 2026-02-26 00:37:28.235862 | 2026-02-26 00:37:28.236127 | TASK [ensure-docker : Install pre-reqs] 2026-02-26 00:37:30.706354 | controller | ok: Nothing to do 2026-02-26 00:37:30.720178 | 2026-02-26 00:37:30.720436 | TASK [ensure-docker : Remove packages] 2026-02-26 00:37:32.056233 | controller | ok: Nothing to do 2026-02-26 00:37:32.071528 | 2026-02-26 00:37:32.071725 | TASK [ensure-docker : Install upstream docker using package] 2026-02-26 00:38:24.368250 | controller | changed 2026-02-26 00:38:24.378225 | 2026-02-26 00:38:24.378393 | TASK [ensure-docker : Setup docker] 2026-02-26 00:38:24.414522 | controller | ok 2026-02-26 00:38:24.446026 | controller | included: /var/lib/zuul/builds/1970d37b6362449cad7f79e33e919f60/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/tasks/docker-setup.yaml 2026-02-26 00:38:24.463855 | 2026-02-26 00:38:24.463995 | TASK [ensure-docker : Ensure "docker" group exists] 2026-02-26 00:38:24.887319 | controller | ok 2026-02-26 00:38:24.896488 | 2026-02-26 00:38:24.896630 | TASK [ensure-docker : Add user to docker group] 2026-02-26 00:38:25.462739 | controller | changed 2026-02-26 00:38:25.473829 | 2026-02-26 00:38:25.474162 | TASK [Update docker daemon proxy configuration] 2026-02-26 00:38:25.524560 | controller | skipping: Conditional result was False 2026-02-26 00:38:25.537078 | 2026-02-26 00:38:25.537255 | TASK [Lower default MTU] 2026-02-26 00:38:25.564549 | controller | skipping: Conditional result was False 2026-02-26 00:38:25.573360 | 2026-02-26 00:38:25.573442 | TASK [ensure-docker : Get the status of the docket.socket unit] 2026-02-26 00:38:25.966570 | controller | inactive 2026-02-26 00:38:26.109036 | controller | ok: Runtime: 0:00:00.014289 2026-02-26 00:38:26.117844 | 2026-02-26 00:38:26.117948 | TASK [ensure-docker : Get the status of the docket unit] 2026-02-26 00:38:26.354934 | controller | inactive 2026-02-26 00:38:26.652712 | controller | ok: Runtime: 0:00:00.011226 2026-02-26 00:38:26.660129 | 2026-02-26 00:38:26.660211 | TASK [ensure-docker : Restart docker] 2026-02-26 00:38:26.712932 | Trigger a Docker restart 2026-02-26 00:38:26.719525 | 2026-02-26 00:38:26.719614 | TASK [ensure-docker : Reset ssh connection to pick up docker group] 2026-02-26 00:38:26.756510 | 2026-02-26 00:38:26.756646 | TASK [ensure-docker : Install docker-compose] 2026-02-26 00:38:26.782371 | controller | skipping: Conditional result was False 2026-02-26 00:38:26.790522 | 2026-02-26 00:38:26.790630 | TASK [ensure-docker : Flush handlers before role exit] 2026-02-26 00:38:26.802732 | 2026-02-26 00:38:26.802849 | TASK [ensure-docker : Stop docker.socket to avoid any conflict] 2026-02-26 00:38:27.999032 | controller | changed 2026-02-26 00:38:28.021802 | 2026-02-26 00:38:28.021964 | TASK [ensure-docker : Assure docker service is running] 2026-02-26 00:38:29.751585 | controller | changed 2026-02-26 00:38:29.772780 | 2026-02-26 00:38:29.773006 | TASK [ensure-docker : Assure docker.socket service is running] 2026-02-26 00:38:30.754261 | controller | ok 2026-02-26 00:38:30.773294 | 2026-02-26 00:38:30.773487 | TASK [ensure-docker : Correct group ownership on docker sock] 2026-02-26 00:38:31.359709 | controller | ok 2026-02-26 00:38:31.373216 | 2026-02-26 00:38:31.373381 | TASK [ensure-docker : Validate ability to talk with docker] 2026-02-26 00:38:31.975778 | controller | CONTAINER ID IMAGE COMMAND CREATED STATUS PORTS NAMES 2026-02-26 00:38:32.429909 | controller | ok: Runtime: 0:00:00.039849 2026-02-26 00:38:32.443458 | 2026-02-26 00:38:32.443605 | TASK [ensure-docker : Get version details] 2026-02-26 00:38:33.070245 | controller | Client: Docker Engine - Community 2026-02-26 00:38:33.070294 | controller | Version: 24.0.7 2026-02-26 00:38:33.070321 | controller | API version: 1.43 2026-02-26 00:38:33.070328 | controller | Go version: go1.20.10 2026-02-26 00:38:33.070339 | controller | Git commit: afdd53b 2026-02-26 00:38:33.070345 | controller | Built: Thu Oct 26 09:09:39 2023 2026-02-26 00:38:33.070350 | controller | OS/Arch: linux/amd64 2026-02-26 00:38:33.070355 | controller | Context: default 2026-02-26 00:38:33.070361 | controller | 2026-02-26 00:38:33.070366 | controller | Server: Docker Engine - Community 2026-02-26 00:38:33.070379 | controller | Engine: 2026-02-26 00:38:33.070386 | controller | Version: 24.0.7 2026-02-26 00:38:33.070410 | controller | API version: 1.43 (minimum version 1.12) 2026-02-26 00:38:33.070416 | controller | Go version: go1.20.10 2026-02-26 00:38:33.070420 | controller | Git commit: 311b9ff 2026-02-26 00:38:33.070424 | controller | Built: Thu Oct 26 09:08:11 2023 2026-02-26 00:38:33.070428 | controller | OS/Arch: linux/amd64 2026-02-26 00:38:33.070432 | controller | Experimental: false 2026-02-26 00:38:33.070436 | controller | containerd: 2026-02-26 00:38:33.070446 | controller | Version: 1.6.25 2026-02-26 00:38:33.070450 | controller | GitCommit: d8f198a4ed8892c764191ef7b3b06d8a2eeb5c7f 2026-02-26 00:38:33.070454 | controller | runc: 2026-02-26 00:38:33.070458 | controller | Version: 1.1.10 2026-02-26 00:38:33.070463 | controller | GitCommit: v1.1.10-0-g18a0cb0 2026-02-26 00:38:33.070477 | controller | docker-init: 2026-02-26 00:38:33.070483 | controller | Version: 0.19.0 2026-02-26 00:38:33.071739 | controller | GitCommit: de40ad0 2026-02-26 00:38:33.506822 | controller | ok: Runtime: 0:00:00.079916 2026-02-26 00:38:33.515817 | 2026-02-26 00:38:33.516007 | TASK [ensure-docker : Dump installed docker details] 2026-02-26 00:38:33.552505 | {'changed': True, 'stdout': 'Client: Docker Engine - Community\n Version: 24.0.7\n API version: 1.43\n Go version: go1.20.10\n Git commit: afdd53b\n Built: Thu Oct 26 09:09:39 2023\n OS/Arch: linux/amd64\n Context: default\n\nServer: Docker Engine - Community\n Engine:\n Version: 24.0.7\n API version: 1.43 (minimum version 1.12)\n Go version: go1.20.10\n Git commit: 311b9ff\n Built: Thu Oct 26 09:08:11 2023\n OS/Arch: linux/amd64\n Experimental: false\n containerd:\n Version: 1.6.25\n GitCommit: d8f198a4ed8892c764191ef7b3b06d8a2eeb5c7f\n runc:\n Version: 1.1.10\n GitCommit: v1.1.10-0-g18a0cb0\n docker-init:\n Version: 0.19.0\n GitCommit: de40ad0', 'stderr': '', 'rc': 0, 'cmd': ['docker', 'version'], 'start': '2026-02-26 00:38:32.992104', 'end': '2026-02-26 00:38:33.072020', 'delta': '0:00:00.079916', 'msg': '', 'zuul_log_id': 'fa163efc-24cc-220a-d16d-000000000061-1-controller', 'stdout_lines': ['Client: Docker Engine - Community', ' Version: 24.0.7', ' API version: 1.43', ' Go version: go1.20.10', ' Git commit: afdd53b', ' Built: Thu Oct 26 09:09:39 2023', ' OS/Arch: linux/amd64', ' Context: default', '', 'Server: Docker Engine - Community', ' Engine:', ' Version: 24.0.7', ' API version: 1.43 (minimum version 1.12)', ' Go version: go1.20.10', ' Git commit: 311b9ff', ' Built: Thu Oct 26 09:08:11 2023', ' OS/Arch: linux/amd64', ' Experimental: false', ' containerd:', ' Version: 1.6.25', ' GitCommit: d8f198a4ed8892c764191ef7b3b06d8a2eeb5c7f', ' runc:', ' Version: 1.1.10', ' GitCommit: v1.1.10-0-g18a0cb0', ' docker-init:', ' Version: 0.19.0', ' GitCommit: de40ad0'], 'stderr_lines': [], 'failed': False} 2026-02-26 00:38:33.563187 | 2026-02-26 00:38:33.563367 | TASK [Use buildset registry] 2026-02-26 00:38:33.581917 | controller | skipping: Conditional result was False 2026-02-26 00:38:33.602785 | 2026-02-26 00:38:33.602985 | TASK [Ensure python3.8 is present] 2026-02-26 00:38:33.621339 | controller | skipping: Conditional result was False 2026-02-26 00:38:33.632641 | 2026-02-26 00:38:33.632894 | TASK [Run our-ensure-python role (Fedora only for now)] 2026-02-26 00:38:33.659562 | controller | ok 2026-02-26 00:38:33.684196 | 2026-02-26 00:38:33.684382 | TASK [our-ensure-python : Install the right Python version (rpm)] 2026-02-26 00:38:35.752398 | controller | ok: Nothing to do 2026-02-26 00:38:35.762340 | 2026-02-26 00:38:35.762503 | TASK [our-ensure-python : Also install python3-devel] 2026-02-26 00:38:47.156003 | controller | changed 2026-02-26 00:38:47.171691 | 2026-02-26 00:38:47.171863 | TASK [Run ensure-virtualenv role] 2026-02-26 00:38:47.195723 | controller | ok 2026-02-26 00:38:47.225560 | 2026-02-26 00:38:47.225733 | TASK [ensure-virtualenv : Check if virtualenv is installed] 2026-02-26 00:38:47.442115 | controller | /usr/bin/virtualenv 2026-02-26 00:38:47.759805 | controller | ok: Runtime: 0:00:00.005141 2026-02-26 00:38:47.773307 | 2026-02-26 00:38:47.773460 | LOOP [ensure-virtualenv : Install virtualenv package] 2026-02-26 00:38:47.798815 | controller | skipping: Conditional result was False 2026-02-26 00:38:47.799113 | controller | changed: All items complete 2026-02-26 00:38:47.799141 | 2026-02-26 00:38:47.828374 | 2026-02-26 00:38:47.828595 | TASK [Find the full path of the Python interpreter] 2026-02-26 00:38:48.065106 | controller | /usr/bin/python3.9 2026-02-26 00:38:48.375958 | controller | ok 2026-02-26 00:38:48.388640 | 2026-02-26 00:38:48.388824 | TASK [Create virtualenv for ansible-test with a specific interpreter] 2026-02-26 00:38:49.950144 | controller | created virtual environment CPython3.9.18.final.0-64 in 790ms 2026-02-26 00:38:49.982112 | controller | creator CPython3Posix(dest=/home/zuul/venv, clear=False, no_vcs_ignore=False, global=False) 2026-02-26 00:38:49.982135 | controller | seeder FromAppData(extra_search_dir=/usr/share/python-wheels,download=False, pip=bundle, setuptools=bundle, wheel=bundle, via=copy, app_data_dir=/home/zuul/.local/share/virtualenv) 2026-02-26 00:38:49.982145 | controller | added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1 2026-02-26 00:38:49.982159 | controller | activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator 2026-02-26 00:38:50.451542 | controller | changed 2026-02-26 00:38:50.465969 | 2026-02-26 00:38:50.466177 | TASK [Set selinux package] 2026-02-26 00:38:50.507240 | controller | ok 2026-02-26 00:38:50.519601 | 2026-02-26 00:38:50.519757 | TASK [Set selinux package (Fedora)] 2026-02-26 00:38:50.581231 | controller | ok 2026-02-26 00:38:50.592905 | 2026-02-26 00:38:50.593033 | TASK [Install selinux into virtualenv] 2026-02-26 00:38:53.499543 | controller | Collecting selinux-please-lie-to-me 2026-02-26 00:38:53.640899 | controller | Downloading selinux_please_lie_to_me-1.0.1-py2.py3-none-any.whl (3.8 kB) 2026-02-26 00:38:54.422944 | controller | Collecting setuptools<50.0.0 2026-02-26 00:38:54.460051 | controller | Downloading setuptools-49.6.0-py3-none-any.whl (803 kB) 2026-02-26 00:38:54.592783 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 803.3/803.3 kB 6.5 MB/s eta 0:00:00 2026-02-26 00:38:54.761899 | controller | Installing collected packages: setuptools, selinux-please-lie-to-me 2026-02-26 00:38:54.764020 | controller | Attempting uninstall: setuptools 2026-02-26 00:38:54.764822 | controller | Found existing installation: setuptools 62.6.0 2026-02-26 00:38:54.992497 | controller | Uninstalling setuptools-62.6.0: 2026-02-26 00:38:55.023490 | controller | Successfully uninstalled setuptools-62.6.0 2026-02-26 00:38:55.518893 | controller | Successfully installed selinux-please-lie-to-me-1.0.1 setuptools-49.6.0 2026-02-26 00:38:55.841495 | controller | 2026-02-26 00:38:56.055190 | controller | [notice] A new release of pip available: 22.2.2 -> 26.0.1 2026-02-26 00:38:56.055226 | controller | [notice] To update, run: /home/zuul/venv/bin/python -m pip install --upgrade pip 2026-02-26 00:38:56.151183 | controller | ok: Runtime: 0:00:04.939235 2026-02-26 00:38:56.165316 | 2026-02-26 00:38:56.165535 | TASK [Install pytest-forked into virtualenv] 2026-02-26 00:38:57.109086 | controller | Collecting pytest-forked 2026-02-26 00:38:57.222422 | controller | Downloading pytest_forked-1.6.0-py3-none-any.whl (4.9 kB) 2026-02-26 00:38:57.279048 | controller | Collecting py 2026-02-26 00:38:57.307535 | controller | Downloading py-1.11.0-py2.py3-none-any.whl (98 kB) 2026-02-26 00:38:57.352759 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.7/98.7 kB 2.3 MB/s eta 0:00:00 2026-02-26 00:38:57.542510 | controller | Collecting pytest>=3.10 2026-02-26 00:38:57.565539 | controller | Downloading pytest-8.4.2-py3-none-any.whl (365 kB) 2026-02-26 00:38:57.606269 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 365.8/365.8 kB 9.5 MB/s eta 0:00:00 2026-02-26 00:38:57.666942 | controller | Collecting exceptiongroup>=1 2026-02-26 00:38:57.691146 | controller | Downloading exceptiongroup-1.3.1-py3-none-any.whl (16 kB) 2026-02-26 00:38:57.764467 | controller | Collecting packaging>=20 2026-02-26 00:38:57.792451 | controller | Downloading packaging-26.0-py3-none-any.whl (74 kB) 2026-02-26 00:38:57.800701 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 74.4/74.4 kB 9.8 MB/s eta 0:00:00 2026-02-26 00:38:57.851222 | controller | Collecting tomli>=1 2026-02-26 00:38:57.875355 | controller | Downloading tomli-2.4.0-py3-none-any.whl (14 kB) 2026-02-26 00:38:58.008653 | controller | Collecting pygments>=2.7.2 2026-02-26 00:38:58.036099 | controller | Downloading pygments-2.19.2-py3-none-any.whl (1.2 MB) 2026-02-26 00:38:58.079190 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.2/1.2 MB 30.7 MB/s eta 0:00:00 2026-02-26 00:38:58.161276 | controller | Collecting pluggy<2,>=1.5 2026-02-26 00:38:58.185727 | controller | Downloading pluggy-1.6.0-py3-none-any.whl (20 kB) 2026-02-26 00:38:58.211045 | controller | Collecting iniconfig>=1 2026-02-26 00:38:58.233519 | controller | Downloading iniconfig-2.1.0-py3-none-any.whl (6.0 kB) 2026-02-26 00:38:58.351911 | controller | Collecting typing-extensions>=4.6.0 2026-02-26 00:38:58.375594 | controller | Downloading typing_extensions-4.15.0-py3-none-any.whl (44 kB) 2026-02-26 00:38:58.382216 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 44.6/44.6 kB 12.1 MB/s eta 0:00:00 2026-02-26 00:38:58.587399 | controller | Installing collected packages: typing-extensions, tomli, pygments, py, pluggy, packaging, iniconfig, exceptiongroup, pytest, pytest-forked 2026-02-26 00:39:00.902033 | controller | Successfully installed exceptiongroup-1.3.1 iniconfig-2.1.0 packaging-26.0 pluggy-1.6.0 py-1.11.0 pygments-2.19.2 pytest-8.4.2 pytest-forked-1.6.0 tomli-2.4.0 typing-extensions-4.15.0 2026-02-26 00:39:00.906196 | controller | 2026-02-26 00:39:00.974251 | controller | [notice] A new release of pip available: 22.2.2 -> 26.0.1 2026-02-26 00:39:00.974294 | controller | [notice] To update, run: /home/zuul/venv/bin/python -m pip install --upgrade pip 2026-02-26 00:39:01.232025 | controller | ok: Runtime: 0:00:04.448690 2026-02-26 00:39:01.246360 | 2026-02-26 00:39:01.246524 | TASK [Update pip] 2026-02-26 00:39:02.947980 | controller | Requirement already satisfied: pip in ./venv/lib/python3.9/site-packages (22.2.2) 2026-02-26 00:39:03.343877 | controller | Collecting pip 2026-02-26 00:39:03.472302 | controller | Downloading pip-26.0.1-py3-none-any.whl (1.8 MB) 2026-02-26 00:39:03.619873 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.8/1.8 MB 12.4 MB/s eta 0:00:00 2026-02-26 00:39:03.680991 | controller | Installing collected packages: pip 2026-02-26 00:39:04.141598 | controller | Attempting uninstall: pip 2026-02-26 00:39:04.141618 | controller | Found existing installation: pip 22.2.2 2026-02-26 00:39:04.141635 | controller | Uninstalling pip-22.2.2: 2026-02-26 00:39:04.195486 | controller | Successfully uninstalled pip-22.2.2 2026-02-26 00:39:06.339871 | controller | Successfully installed pip-26.0.1 2026-02-26 00:39:06.842547 | controller | ok: Runtime: 0:00:04.564856 2026-02-26 00:39:06.848959 | 2026-02-26 00:39:06.849023 | TASK [Ensure pip temp directory exists in /var/tmp] 2026-02-26 00:39:07.313614 | controller | changed 2026-02-26 00:39:07.326037 | 2026-02-26 00:39:07.326176 | TASK [Install ansible into virtualenv] 2026-02-26 00:39:08.897493 | controller | Processing ./src/github.com/ansible/ansible 2026-02-26 00:39:08.908652 | controller | Installing build dependencies: started 2026-02-26 00:39:11.192875 | controller | Installing build dependencies: finished with status 'done' 2026-02-26 00:39:11.193750 | controller | Getting requirements to build wheel: started 2026-02-26 00:39:11.820017 | controller | Getting requirements to build wheel: finished with status 'done' 2026-02-26 00:39:11.821124 | controller | Preparing metadata (pyproject.toml): started 2026-02-26 00:39:12.266517 | controller | Preparing metadata (pyproject.toml): finished with status 'done' 2026-02-26 00:39:12.344883 | controller | Collecting jinja2 (from ansible-core==2.11.12.post0) 2026-02-26 00:39:12.449212 | controller | Downloading jinja2-3.1.6-py3-none-any.whl.metadata (2.9 kB) 2026-02-26 00:39:12.531200 | controller | Collecting PyYAML (from ansible-core==2.11.12.post0) 2026-02-26 00:39:12.557884 | controller | Downloading pyyaml-6.0.3-cp39-cp39-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl.metadata (2.4 kB) 2026-02-26 00:39:12.856570 | controller | Collecting cryptography (from ansible-core==2.11.12.post0) 2026-02-26 00:39:12.882466 | controller | Downloading cryptography-46.0.5-cp38-abi3-manylinux_2_34_x86_64.whl.metadata (5.7 kB) 2026-02-26 00:39:12.902086 | controller | Requirement already satisfied: packaging in ./venv/lib/python3.9/site-packages (from ansible-core==2.11.12.post0) (26.0) 2026-02-26 00:39:12.925997 | controller | Collecting resolvelib<0.6.0,>=0.5.3 (from ansible-core==2.11.12.post0) 2026-02-26 00:39:12.952133 | controller | Downloading resolvelib-0.5.4-py2.py3-none-any.whl.metadata (3.7 kB) 2026-02-26 00:39:13.131613 | controller | Collecting cffi>=2.0.0 (from cryptography->ansible-core==2.11.12.post0) 2026-02-26 00:39:13.158745 | controller | Downloading cffi-2.0.0-cp39-cp39-manylinux2014_x86_64.manylinux_2_17_x86_64.whl.metadata (2.6 kB) 2026-02-26 00:39:13.169704 | controller | Requirement already satisfied: typing-extensions>=4.13.2 in ./venv/lib/python3.9/site-packages (from cryptography->ansible-core==2.11.12.post0) (4.15.0) 2026-02-26 00:39:13.188675 | controller | Collecting pycparser (from cffi>=2.0.0->cryptography->ansible-core==2.11.12.post0) 2026-02-26 00:39:13.215949 | controller | Downloading pycparser-2.23-py3-none-any.whl.metadata (993 bytes) 2026-02-26 00:39:13.310559 | controller | Collecting MarkupSafe>=2.0 (from jinja2->ansible-core==2.11.12.post0) 2026-02-26 00:39:13.340136 | controller | Downloading markupsafe-3.0.3-cp39-cp39-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl.metadata (2.7 kB) 2026-02-26 00:39:13.381662 | controller | Downloading resolvelib-0.5.4-py2.py3-none-any.whl (12 kB) 2026-02-26 00:39:13.423759 | controller | Downloading cryptography-46.0.5-cp38-abi3-manylinux_2_34_x86_64.whl (4.5 MB) 2026-02-26 00:39:13.611366 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.5/4.5 MB 33.2 MB/s 0:00:00 2026-02-26 00:39:13.644108 | controller | Downloading cffi-2.0.0-cp39-cp39-manylinux2014_x86_64.manylinux_2_17_x86_64.whl (216 kB) 2026-02-26 00:39:13.688792 | controller | Downloading jinja2-3.1.6-py3-none-any.whl (134 kB) 2026-02-26 00:39:13.724915 | controller | Downloading markupsafe-3.0.3-cp39-cp39-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (20 kB) 2026-02-26 00:39:13.763773 | controller | Downloading pycparser-2.23-py3-none-any.whl (118 kB) 2026-02-26 00:39:13.806982 | controller | Downloading pyyaml-6.0.3-cp39-cp39-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (750 kB) 2026-02-26 00:39:13.831086 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 750.8/750.8 kB 27.2 MB/s 0:00:00 2026-02-26 00:39:13.845773 | controller | Building wheels for collected packages: ansible-core 2026-02-26 00:39:13.846670 | controller | Building wheel for ansible-core (pyproject.toml): started 2026-02-26 00:39:15.389072 | controller | Building wheel for ansible-core (pyproject.toml): finished with status 'done' 2026-02-26 00:39:15.391580 | controller | Created wheel for ansible-core: filename=ansible_core-2.11.12.post0-py3-none-any.whl size=1961250 sha256=6097f0a79b87668d279d41f5ef821a2fab9bc8200b30a06296553e979b0d4277 2026-02-26 00:39:15.391759 | controller | Stored in directory: /var/tmp/ansible-test-pip/pip-ephem-wheel-cache-tce5xqe5/wheels/0f/a0/93/ab85b739e1eb1e0467171316f13571c14efdf87e0d5d44a33e 2026-02-26 00:39:15.400615 | controller | Successfully built ansible-core 2026-02-26 00:39:15.431870 | controller | Installing collected packages: resolvelib, PyYAML, pycparser, MarkupSafe, jinja2, cffi, cryptography, ansible-core 2026-02-26 00:39:16.973517 | controller | 2026-02-26 00:39:16.976235 | controller | Successfully installed MarkupSafe-3.0.3 PyYAML-6.0.3 ansible-core-2.11.12.post0 cffi-2.0.0 cryptography-46.0.5 jinja2-3.1.6 pycparser-2.23 resolvelib-0.5.4 2026-02-26 00:39:17.389974 | controller | ok: Runtime: 0:00:09.151677 2026-02-26 00:39:17.404249 | 2026-02-26 00:39:17.404401 | TASK [Setup download-artifact-fork role] 2026-02-26 00:39:17.436770 | controller | ok 2026-02-26 00:39:17.472201 | 2026-02-26 00:39:17.472347 | TASK [download-artifact-fork : Parse inventory response] 2026-02-26 00:39:17.527476 | controller | ok 2026-02-26 00:39:17.537966 | 2026-02-26 00:39:17.538153 | TASK [download-artifact-fork : Fetch info from Zuul API] 2026-02-26 00:39:17.575051 | controller | skipping: Conditional result was False 2026-02-26 00:39:17.590790 | 2026-02-26 00:39:17.591037 | TASK [download-artifact-fork : Parse build response] 2026-02-26 00:39:17.630408 | controller | skipping: Conditional result was False 2026-02-26 00:39:17.642416 | 2026-02-26 00:39:17.642608 | TASK [download-artifact-fork : Ensure artifacts directory exists] 2026-02-26 00:39:17.872564 | controller | changed 2026-02-26 00:39:17.880683 | 2026-02-26 00:39:17.880794 | LOOP [download-artifact-fork : Download archive by type] 2026-02-26 00:39:17.922381 | controller | skipping: Conditional result was False 2026-02-26 00:39:17.922811 | 2026-02-26 00:44:05.435686 | controller | ERROR: Item: {'branch': 'main', 'job': 'build-ansible-collection', 'metadata': {'type': 'ansible_collection', 'version': '5.0.0'}, 'name': 'ansible.network', 'project': 'ansible-collections/ansible.network', 'url': 'https://118c11da91095f79916d-f61db552e254be53f052d53baea54a2b.ssl.cf1.rackcdn.com/ansible/9741c0f3dfa94d9b857d4614f51c009d/artifacts/ansible-network-5.0.0.tar.gz'} 2026-02-26 00:44:05.436081 | controller | { 2026-02-26 00:44:05.436162 | controller | "ansible_loop_var": "artifact", 2026-02-26 00:44:05.436205 | controller | "artifact": { 2026-02-26 00:44:05.436241 | controller | "branch": "main", 2026-02-26 00:44:05.436277 | controller | "job": "build-ansible-collection", 2026-02-26 00:44:05.436311 | controller | "metadata": { 2026-02-26 00:44:05.436345 | controller | "type": "ansible_collection", 2026-02-26 00:44:05.436378 | controller | "version": "5.0.0" 2026-02-26 00:44:05.436411 | controller | }, 2026-02-26 00:44:05.436444 | controller | "name": "ansible.network", 2026-02-26 00:44:05.436476 | controller | "project": "ansible-collections/ansible.network", 2026-02-26 00:44:05.436510 | controller | "url": "https://118c11da91095f79916d-f61db552e254be53f052d53baea54a2b.ssl.cf1.rackcdn.com/ansible/9741c0f3dfa94d9b857d4614f51c009d/artifacts/ansible-network-5.0.0.tar.gz" 2026-02-26 00:44:05.436551 | controller | }, 2026-02-26 00:44:05.436586 | controller | "msg": "Failed to connect to the host via ssh: ssh: connect to host 162.253.55.74 port 22: No route to host", 2026-02-26 00:44:05.436619 | controller | "unreachable": true 2026-02-26 00:44:05.436653 | controller | } unreachable 2026-02-26 00:44:05.442760 | 2026-02-26 00:44:05.442889 | PLAY RECAP 2026-02-26 00:44:05.442984 | controller | ok: 41 changed: 23 unreachable: 1 failed: 0 skipped: 17 rescued: 0 ignored: 0 2026-02-26 00:44:05.443028 | 2026-02-26 00:44:05.665399 | PRE-RUN END RESULT_UNREACHABLE: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-02-26 00:44:05.667388 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-26 00:44:06.267280 | 2026-02-26 00:44:06.267408 | PLAY [all] 2026-02-26 00:44:06.289196 | 2026-02-26 00:44:06.289354 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-02-26 00:44:19.126394 | controller | changed: non-zero return code 2026-02-26 00:44:19.140243 | 2026-02-26 00:44:19.140411 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-02-26 00:44:19.167454 | controller | skipping: Conditional result was False 2026-02-26 00:44:19.180563 | 2026-02-26 00:44:19.180767 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-02-26 00:44:19.223506 | 2026-02-26 00:44:19.223801 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-02-26 00:44:19.275734 | 2026-02-26 00:44:19.276009 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-02-26 00:44:19.304348 | controller | skipping: Conditional result was False 2026-02-26 00:44:19.319801 | 2026-02-26 00:44:19.319955 | LOOP [fetch-subunit-output : Generate subunit file] 2026-02-26 00:44:19.364569 | 2026-02-26 00:44:19.364863 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-02-26 00:44:19.392378 | controller | skipping: Conditional result was False 2026-02-26 00:44:19.405784 | 2026-02-26 00:44:19.405928 | TASK [fetch-subunit-output : Remove the temporary file] 2026-02-26 00:44:19.433548 | controller | skipping: Conditional result was False 2026-02-26 00:44:19.447108 | 2026-02-26 00:44:19.447250 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-02-26 00:44:19.475071 | controller | skipping: Conditional result was False 2026-02-26 00:44:19.523716 | 2026-02-26 00:44:19.523797 | PLAY RECAP 2026-02-26 00:44:19.523854 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-26 00:44:19.523881 | 2026-02-26 00:44:19.639327 | POST-RUN END RESULT_UNREACHABLE: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-26 00:44:19.640406 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2026-02-26 00:44:20.269558 | 2026-02-26 00:44:20.269722 | PLAY [all:!appliance*] 2026-02-26 00:44:20.292338 | 2026-02-26 00:44:20.292439 | TASK [unregister the node] 2026-02-26 00:44:20.824845 | controller | skipping: Conditional result was False 2026-02-26 00:44:20.838540 | 2026-02-26 00:44:20.838734 | TASK [include_role : fetch-output] 2026-02-26 00:44:20.898972 | controller | ok 2026-02-26 00:44:20.936847 | 2026-02-26 00:44:20.936952 | TASK [fetch-output : Set log path for multiple nodes] 2026-02-26 00:44:21.013500 | controller | skipping: Conditional result was False 2026-02-26 00:44:21.026797 | 2026-02-26 00:44:21.026940 | TASK [fetch-output : Set log path for single node] 2026-02-26 00:44:21.078258 | controller | ok 2026-02-26 00:44:21.090655 | 2026-02-26 00:44:21.090823 | LOOP [fetch-output : Ensure local output dirs] 2026-02-26 00:44:21.562521 | controller -> localhost | ok: "/var/lib/zuul/builds/1970d37b6362449cad7f79e33e919f60/work/logs" 2026-02-26 00:44:21.799581 | controller -> localhost | changed: "/var/lib/zuul/builds/1970d37b6362449cad7f79e33e919f60/work/artifacts" 2026-02-26 00:44:22.058163 | controller -> localhost | changed: "/var/lib/zuul/builds/1970d37b6362449cad7f79e33e919f60/work/docs" 2026-02-26 00:44:22.074457 | 2026-02-26 00:44:22.074599 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-26 00:44:22.797637 | controller | changed: 2026-02-26 00:44:22.797936 | controller | .d..t...... ./ 2026-02-26 00:44:22.797975 | controller | cd+++++++++ controller/ 2026-02-26 00:44:22.798020 | controller | changed: All items complete 2026-02-26 00:44:22.798048 | 2026-02-26 00:44:23.326279 | controller | changed: .d..t...... ./ 2026-02-26 00:44:23.843758 | controller | changed: .d..t...... ./ 2026-02-26 00:44:23.863336 | 2026-02-26 00:44:23.863477 | TASK [include_role : fetch-output-openshift] 2026-02-26 00:44:23.888767 | controller | skipping: Conditional result was False 2026-02-26 00:44:23.895954 | 2026-02-26 00:44:23.896022 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-02-26 00:44:23.941550 | controller | skipping: Conditional result was False 2026-02-26 00:44:23.953204 | controller | skipping: Conditional result was False 2026-02-26 00:44:23.991900 | 2026-02-26 00:44:23.992020 | PLAY [localhost] 2026-02-26 00:44:24.004707 | 2026-02-26 00:44:24.004771 | TASK [Run Zuul manifest role] 2026-02-26 00:44:24.026551 | localhost | ok 2026-02-26 00:44:24.046791 | 2026-02-26 00:44:24.046919 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-26 00:44:24.447645 | localhost | changed 2026-02-26 00:44:24.452328 | 2026-02-26 00:44:24.452391 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-26 00:44:24.482092 | localhost | ok 2026-02-26 00:44:24.490241 | 2026-02-26 00:44:24.490302 | TASK [Set zuul-log-path fact] 2026-02-26 00:44:24.509312 | localhost | ok 2026-02-26 00:44:24.523395 | 2026-02-26 00:44:24.523462 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-26 00:44:24.552480 | localhost | ok 2026-02-26 00:44:24.561214 | 2026-02-26 00:44:24.561273 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)] 2026-02-26 00:44:24.601539 | localhost | ok: 2026-02-26 00:44:24.602025 | localhost | { 2026-02-26 00:44:24.602086 | localhost | "auth": { 2026-02-26 00:44:24.602131 | localhost | "password": "IonWCwcuOFib&&<}wp^:[2G/", 2026-02-26 00:44:24.602169 | localhost | "username": "9LF91O0RK7JU" 2026-02-26 00:44:24.602207 | localhost | }, 2026-02-26 00:44:24.602243 | localhost | "profile": "rackspace", 2026-02-26 00:44:24.602279 | localhost | "region_name": "ORD" 2026-02-26 00:44:24.602314 | localhost | } 2026-02-26 00:44:24.602371 | 2026-02-26 00:44:24.613888 | 2026-02-26 00:44:24.613997 | TASK [Run upload-logs-failover role (S3 then Swift)] 2026-02-26 00:44:24.633392 | localhost | Output suppressed because no_log was given 2026-02-26 00:44:24.646006 | 2026-02-26 00:44:24.646088 | TASK [upload-logs-failover : Initialize control vars] 2026-02-26 00:44:24.677119 | localhost | ok 2026-02-26 00:44:24.681750 | 2026-02-26 00:44:24.681822 | LOOP [upload-logs-failover : Perform log upload] 2026-02-26 00:44:24.727574 | localhost | Output suppressed because no_log was given 2026-02-26 00:44:24.780790 | localhost | included: /var/lib/zuul/builds/1970d37b6362449cad7f79e33e919f60/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml 2026-02-26 00:44:24.788120 | 2026-02-26 00:44:24.788192 | LOOP [upload-logs-failover : Unpack vars for swift upload] 2026-02-26 00:44:24.906106 | localhost | Output suppressed because no_log was given 2026-02-26 00:44:24.915607 | 2026-02-26 00:44:24.915752 | TASK [Upload logs to swift] 2026-02-26 00:44:24.940693 | localhost | ok 2026-02-26 00:44:24.982394 | 2026-02-26 00:44:24.982523 | TASK [Set zuul-log-path fact] 2026-02-26 00:44:25.028439 | localhost | skipping: Conditional result was False 2026-02-26 00:44:25.033761 | 2026-02-26 00:44:25.033828 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2026-02-26 00:44:25.444081 | localhost -> localhost | ok: Runtime: 0:00:00.009290 2026-02-26 00:44:25.450552 | 2026-02-26 00:44:25.450646 | TASK [upload-logs-swift : Upload logs to swift]