2026-01-11 00:20:51.752893 | Job console starting... 2026-01-11 00:20:51.767311 | Updating repositories 2026-01-11 00:20:51.880136 | Preparing job workspace 2026-01-11 00:20:55.616124 | Running Ansible setup... 2026-01-11 00:21:00.235273 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-01-11 00:21:00.920071 | 2026-01-11 00:21:00.920237 | PLAY [localhost] 2026-01-11 00:21:00.929471 | 2026-01-11 00:21:00.929595 | TASK [Gathering Facts] 2026-01-11 00:21:01.905323 | localhost | ok 2026-01-11 00:21:01.930711 | 2026-01-11 00:21:01.930885 | TASK [Setup log path fact] 2026-01-11 00:21:01.949971 | localhost | ok 2026-01-11 00:21:01.964103 | 2026-01-11 00:21:01.964245 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-11 00:21:02.003135 | localhost | ok 2026-01-11 00:21:02.012510 | 2026-01-11 00:21:02.012623 | TASK [emit-job-header : Print job information] 2026-01-11 00:21:02.061924 | # Job Information 2026-01-11 00:21:02.062093 | Ansible Version: 2.15.12 2026-01-11 00:21:02.062125 | Job: ansible-test-sanity-docker-milestone 2026-01-11 00:21:02.062146 | Pipeline: periodic 2026-01-11 00:21:02.062165 | Executor: ze03.softwarefactory-project.io 2026-01-11 00:21:02.062183 | Triggered by: https://github.com/ansible-collections/ansible.network 2026-01-11 00:21:02.062204 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/a54/ansible/a54887fe685a4fdda08b2e171bc8dc7b/ 2026-01-11 00:21:02.062223 | Event ID: 732349a9225a4a0caafb47fd2fabe663 2026-01-11 00:21:02.066224 | 2026-01-11 00:21:02.066306 | LOOP [emit-job-header : Print node information] 2026-01-11 00:21:02.171662 | localhost | ok: 2026-01-11 00:21:02.172002 | localhost | # Node Information 2026-01-11 00:21:02.172061 | localhost | Inventory Hostname: controller 2026-01-11 00:21:02.172104 | localhost | Hostname: np0005581010 2026-01-11 00:21:02.172145 | localhost | Username: zuul 2026-01-11 00:21:02.172193 | localhost | Distro: Fedora 37 2026-01-11 00:21:02.172233 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2026-01-11 00:21:02.172270 | localhost | Region: ca-ymq-1 2026-01-11 00:21:02.172306 | localhost | Label: ansible-fedora-37-1vcpu 2026-01-11 00:21:02.172341 | localhost | Product Name: OpenStack Nova 2026-01-11 00:21:02.172376 | localhost | Interface IP: 162.253.55.43 2026-01-11 00:21:02.183350 | 2026-01-11 00:21:02.183446 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-11 00:21:02.639053 | localhost -> localhost | changed 2026-01-11 00:21:02.652299 | 2026-01-11 00:21:02.652473 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-11 00:21:03.530282 | localhost -> localhost | changed 2026-01-11 00:21:03.549532 | 2026-01-11 00:21:03.549633 | PLAY [all:!appliance*] 2026-01-11 00:21:03.566399 | 2026-01-11 00:21:03.566496 | TASK [include_role : start-zuul-console] 2026-01-11 00:21:03.588267 | controller | ok 2026-01-11 00:21:03.607588 | 2026-01-11 00:21:03.607684 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-11 00:21:04.012290 | controller | ok 2026-01-11 00:21:04.037319 | 2026-01-11 00:21:04.037490 | TASK [use-our-mirror : Retrieve the IP address] 2026-01-11 00:21:05.162209 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2026-01-11 00:21:05.178190 | 2026-01-11 00:21:05.178331 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2026-01-11 00:21:05.729562 | controller | skipping: Conditional result was False 2026-01-11 00:21:05.742941 | 2026-01-11 00:21:05.743105 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2026-01-11 00:21:05.770194 | controller | skipping: Conditional result was False 2026-01-11 00:21:05.783023 | 2026-01-11 00:21:05.783172 | TASK [use-our-mirror : Create the podman configuration directory] 2026-01-11 00:21:05.810861 | controller | skipping: Conditional result was False 2026-01-11 00:21:05.824793 | 2026-01-11 00:21:05.824943 | TASK [use-our-mirror : Copy the podman configuration] 2026-01-11 00:21:05.852842 | controller | skipping: Conditional result was False 2026-01-11 00:21:05.867002 | 2026-01-11 00:21:05.867148 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2026-01-11 00:21:05.896126 | controller | skipping: Conditional result was False 2026-01-11 00:21:05.912186 | 2026-01-11 00:21:05.912346 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2026-01-11 00:21:05.949670 | controller | skipping: Conditional result was False 2026-01-11 00:21:05.964673 | 2026-01-11 00:21:05.964816 | TASK [Disable Fedora Modular] 2026-01-11 00:21:06.210704 | controller | changed 2026-01-11 00:21:06.216625 | 2026-01-11 00:21:06.216689 | TASK [Enable EPEL] 2026-01-11 00:21:06.241433 | controller | skipping: Conditional result was False 2026-01-11 00:21:06.250471 | 2026-01-11 00:21:06.250581 | TASK [Register the RHEL node] 2026-01-11 00:21:06.809077 | 2026-01-11 00:21:06.809457 | TASK [Show the subscription-manager status] 2026-01-11 00:21:07.396576 | controller | skipping: Conditional result was False 2026-01-11 00:21:07.403205 | 2026-01-11 00:21:07.403284 | TASK [Enable EPEL on RHEL] 2026-01-11 00:21:07.935983 | controller | skipping: Conditional result was False 2026-01-11 00:21:07.954615 | 2026-01-11 00:21:07.954962 | TASK [Install git and tox] 2026-01-11 00:22:26.195764 | controller | changed 2026-01-11 00:22:26.205833 | 2026-01-11 00:22:26.205938 | TASK [include_role : prepare-workspace] 2026-01-11 00:22:26.241513 | controller | ok 2026-01-11 00:22:26.272170 | 2026-01-11 00:22:26.272358 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-01-11 00:22:26.549468 | controller | ok 2026-01-11 00:22:26.564906 | 2026-01-11 00:22:26.565091 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-01-11 00:22:39.179967 | controller | Output suppressed because no_log was given 2026-01-11 00:22:39.204243 | 2026-01-11 00:22:39.204355 | TASK [include_role : prepare-workspace-openshift] 2026-01-11 00:22:39.246960 | controller | skipping: Conditional result was False 2026-01-11 00:22:39.315675 | 2026-01-11 00:22:39.315820 | PLAY [all:!appliance] 2026-01-11 00:22:39.337560 | 2026-01-11 00:22:39.337639 | TASK [Run add-build-sshkey role (RSA)] 2026-01-11 00:22:39.369360 | controller | ok 2026-01-11 00:22:39.388920 | 2026-01-11 00:22:39.389020 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-11 00:22:39.679720 | controller -> localhost | ok 2026-01-11 00:22:39.695417 | 2026-01-11 00:22:39.695791 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-11 00:22:39.729599 | controller | ok 2026-01-11 00:22:39.754865 | controller | included: /var/lib/zuul/builds/a54887fe685a4fdda08b2e171bc8dc7b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-11 00:22:39.763216 | 2026-01-11 00:22:39.763300 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-11 00:22:40.269471 | controller -> localhost | Generating public/private rsa key pair. 2026-01-11 00:22:40.269699 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/a54887fe685a4fdda08b2e171bc8dc7b/work/a54887fe685a4fdda08b2e171bc8dc7b_id_rsa. 2026-01-11 00:22:40.269752 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/a54887fe685a4fdda08b2e171bc8dc7b/work/a54887fe685a4fdda08b2e171bc8dc7b_id_rsa.pub. 2026-01-11 00:22:40.269775 | controller -> localhost | The key fingerprint is: 2026-01-11 00:22:40.269795 | controller -> localhost | SHA256:z7o2WWYzmMN5wWctdiXVN6OuF5rsLMLemIdVdBb65TQ zuul-build-sshkey 2026-01-11 00:22:40.269814 | controller -> localhost | The key's randomart image is: 2026-01-11 00:22:40.269833 | controller -> localhost | +---[RSA 2048]----+ 2026-01-11 00:22:40.269850 | controller -> localhost | | ...o| 2026-01-11 00:22:40.269869 | controller -> localhost | | ..o.o+| 2026-01-11 00:22:40.269887 | controller -> localhost | | ...o..E+| 2026-01-11 00:22:40.269905 | controller -> localhost | | o.*.* .| 2026-01-11 00:22:40.269922 | controller -> localhost | | .S+.=.+ . | 2026-01-11 00:22:40.269948 | controller -> localhost | | *+B o | 2026-01-11 00:22:40.269972 | controller -> localhost | | . oB+o+ . | 2026-01-11 00:22:40.269994 | controller -> localhost | | +B+.= . | 2026-01-11 00:22:40.270011 | controller -> localhost | | .==+oo. | 2026-01-11 00:22:40.270032 | controller -> localhost | +----[SHA256]-----+ 2026-01-11 00:22:40.270081 | controller -> localhost | ok: Runtime: 0:00:00.104338 2026-01-11 00:22:40.276865 | 2026-01-11 00:22:40.276928 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-11 00:22:40.310247 | controller | ok 2026-01-11 00:22:40.324293 | controller | included: /var/lib/zuul/builds/a54887fe685a4fdda08b2e171bc8dc7b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-11 00:22:40.333644 | 2026-01-11 00:22:40.333776 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-11 00:22:40.368497 | controller | skipping: Conditional result was False 2026-01-11 00:22:40.378168 | 2026-01-11 00:22:40.378271 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-11 00:22:40.815232 | controller | changed 2026-01-11 00:22:40.821083 | 2026-01-11 00:22:40.821161 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-11 00:22:41.067858 | controller | ok 2026-01-11 00:22:41.081682 | 2026-01-11 00:22:41.081894 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-11 00:22:41.765392 | controller | changed 2026-01-11 00:22:41.778403 | 2026-01-11 00:22:41.778543 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-11 00:22:42.424021 | controller | changed 2026-01-11 00:22:42.430013 | 2026-01-11 00:22:42.430083 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-11 00:22:42.475268 | controller | skipping: Conditional result was False 2026-01-11 00:22:42.483074 | 2026-01-11 00:22:42.483153 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-11 00:22:42.914537 | controller -> localhost | changed 2026-01-11 00:22:42.926263 | 2026-01-11 00:22:42.926334 | TASK [add-build-sshkey : Add back temp key] 2026-01-11 00:22:43.247163 | controller -> localhost | Identity added: /var/lib/zuul/builds/a54887fe685a4fdda08b2e171bc8dc7b/work/a54887fe685a4fdda08b2e171bc8dc7b_id_rsa (zuul-build-sshkey) 2026-01-11 00:22:43.247614 | controller -> localhost | ok: Runtime: 0:00:00.014036 2026-01-11 00:22:43.264589 | 2026-01-11 00:22:43.264759 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-11 00:22:43.620604 | controller | ok 2026-01-11 00:22:43.632757 | 2026-01-11 00:22:43.632851 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-11 00:22:43.657687 | controller | skipping: Conditional result was False 2026-01-11 00:22:43.669912 | 2026-01-11 00:22:43.669987 | TASK [Run add-build-sshkey role (ECDSA)] 2026-01-11 00:22:43.690237 | controller | ok 2026-01-11 00:22:43.708888 | 2026-01-11 00:22:43.709038 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-11 00:22:43.988643 | controller -> localhost | ok 2026-01-11 00:22:43.998518 | 2026-01-11 00:22:43.998669 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-11 00:22:44.029689 | controller | ok 2026-01-11 00:22:44.040575 | controller | included: /var/lib/zuul/builds/a54887fe685a4fdda08b2e171bc8dc7b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-11 00:22:44.047293 | 2026-01-11 00:22:44.047359 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-11 00:22:44.326355 | controller -> localhost | Generating public/private ecdsa key pair. 2026-01-11 00:22:44.326660 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/a54887fe685a4fdda08b2e171bc8dc7b/work/a54887fe685a4fdda08b2e171bc8dc7b_id_ecdsa. 2026-01-11 00:22:44.326755 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/a54887fe685a4fdda08b2e171bc8dc7b/work/a54887fe685a4fdda08b2e171bc8dc7b_id_ecdsa.pub. 2026-01-11 00:22:44.326830 | controller -> localhost | The key fingerprint is: 2026-01-11 00:22:44.326879 | controller -> localhost | SHA256:6S92bu7GJwz6vl++YWToX5zCi8adGx44XI8eVnv3IEo zuul-build-sshkey 2026-01-11 00:22:44.326923 | controller -> localhost | The key's randomart image is: 2026-01-11 00:22:44.326964 | controller -> localhost | +---[ECDSA 521]---+ 2026-01-11 00:22:44.327005 | controller -> localhost | | | 2026-01-11 00:22:44.327046 | controller -> localhost | | | 2026-01-11 00:22:44.327084 | controller -> localhost | | | 2026-01-11 00:22:44.327123 | controller -> localhost | | . . | 2026-01-11 00:22:44.327162 | controller -> localhost | | S . + . | 2026-01-11 00:22:44.327207 | controller -> localhost | | ..o * = o | 2026-01-11 00:22:44.327264 | controller -> localhost | | ..=E.&.B o| 2026-01-11 00:22:44.327308 | controller -> localhost | | . ooX%+X oo| 2026-01-11 00:22:44.327347 | controller -> localhost | | ++%OoOo .| 2026-01-11 00:22:44.327384 | controller -> localhost | +----[SHA256]-----+ 2026-01-11 00:22:44.327525 | controller -> localhost | ok: Runtime: 0:00:00.010186 2026-01-11 00:22:44.344061 | 2026-01-11 00:22:44.344203 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-11 00:22:44.376230 | controller | ok 2026-01-11 00:22:44.392997 | controller | included: /var/lib/zuul/builds/a54887fe685a4fdda08b2e171bc8dc7b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-11 00:22:44.406922 | 2026-01-11 00:22:44.407013 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-11 00:22:44.423229 | controller | skipping: Conditional result was False 2026-01-11 00:22:44.433282 | 2026-01-11 00:22:44.433377 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-11 00:22:44.722499 | controller | changed 2026-01-11 00:22:44.728361 | 2026-01-11 00:22:44.728434 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-11 00:22:44.983525 | controller | ok 2026-01-11 00:22:44.996934 | 2026-01-11 00:22:44.997143 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-11 00:22:45.724374 | controller | changed 2026-01-11 00:22:45.737938 | 2026-01-11 00:22:45.738084 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-11 00:22:46.444652 | controller | changed 2026-01-11 00:22:46.458752 | 2026-01-11 00:22:46.458862 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-11 00:22:46.483691 | controller | skipping: Conditional result was False 2026-01-11 00:22:46.499758 | 2026-01-11 00:22:46.499918 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-11 00:22:46.783015 | controller -> localhost | changed 2026-01-11 00:22:46.828837 | 2026-01-11 00:22:46.828960 | TASK [add-build-sshkey : Add back temp key] 2026-01-11 00:22:47.119077 | controller -> localhost | Identity added: /var/lib/zuul/builds/a54887fe685a4fdda08b2e171bc8dc7b/work/a54887fe685a4fdda08b2e171bc8dc7b_id_ecdsa (zuul-build-sshkey) 2026-01-11 00:22:47.119334 | controller -> localhost | ok: Runtime: 0:00:00.010597 2026-01-11 00:22:47.126022 | 2026-01-11 00:22:47.126105 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-11 00:22:47.369767 | controller | ok 2026-01-11 00:22:47.381659 | 2026-01-11 00:22:47.381825 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-11 00:22:47.418687 | controller | skipping: Conditional result was False 2026-01-11 00:22:47.445669 | 2026-01-11 00:22:47.445924 | TASK [include_role : remove-zuul-sshkey] 2026-01-11 00:22:47.472783 | controller | skipping: Conditional result was False 2026-01-11 00:22:47.486295 | 2026-01-11 00:22:47.486446 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-01-11 00:22:47.734107 | controller | ok: "logs" 2026-01-11 00:22:47.734643 | controller | ok: All items complete 2026-01-11 00:22:47.734797 | 2026-01-11 00:22:47.963642 | controller | ok: "artifacts" 2026-01-11 00:22:48.181894 | controller | ok: "docs" 2026-01-11 00:22:48.204032 | 2026-01-11 00:22:48.204189 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-01-11 00:22:48.473754 | controller | changed: "logs" 2026-01-11 00:22:48.684500 | controller | changed: "artifacts" 2026-01-11 00:22:48.919263 | controller | changed: "docs" 2026-01-11 00:22:48.982317 | 2026-01-11 00:22:48.982449 | PLAY RECAP 2026-01-11 00:22:48.982509 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2026-01-11 00:22:48.982544 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-01-11 00:22:48.982567 | 2026-01-11 00:22:49.103472 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-01-11 00:22:49.105227 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-01-11 00:22:49.713687 | 2026-01-11 00:22:49.713830 | PLAY [all] 2026-01-11 00:22:49.735387 | 2026-01-11 00:22:49.735478 | TASK [Install binary dependencies] 2026-01-11 00:22:49.807070 | controller | ok 2026-01-11 00:22:49.833334 | 2026-01-11 00:22:49.833500 | TASK [bindep : Include find tasks] 2026-01-11 00:22:49.875700 | controller | ok 2026-01-11 00:22:49.885910 | controller | included: /var/lib/zuul/builds/a54887fe685a4fdda08b2e171bc8dc7b/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-01-11 00:22:49.894175 | 2026-01-11 00:22:49.894262 | TASK [bindep : Look for bindep.txt] 2026-01-11 00:22:50.308645 | controller | ok 2026-01-11 00:22:50.321084 | 2026-01-11 00:22:50.321256 | TASK [bindep : Define bindep_file fact] 2026-01-11 00:22:50.348974 | controller | skipping: Conditional result was False 2026-01-11 00:22:50.361911 | 2026-01-11 00:22:50.362066 | TASK [bindep : Look for other-requirements.txt] 2026-01-11 00:22:50.603846 | controller | ok 2026-01-11 00:22:50.615754 | 2026-01-11 00:22:50.615901 | TASK [bindep : Define bindep_file fact] 2026-01-11 00:22:50.655238 | controller | skipping: Conditional result was False 2026-01-11 00:22:50.671099 | 2026-01-11 00:22:50.671263 | TASK [bindep : Look for bindep fallback file] 2026-01-11 00:22:50.710632 | controller | skipping: Conditional result was False 2026-01-11 00:22:50.727991 | 2026-01-11 00:22:50.728172 | TASK [bindep : Define bindep_file fact] 2026-01-11 00:22:50.756680 | controller | skipping: Conditional result was False 2026-01-11 00:22:50.770950 | 2026-01-11 00:22:50.771106 | TASK [bindep : Include bindep tasks] 2026-01-11 00:22:50.809020 | controller | skipping: Conditional result was False 2026-01-11 00:22:50.823280 | 2026-01-11 00:22:50.823419 | TASK [bindep : Include install tasks] 2026-01-11 00:22:50.850761 | controller | skipping: Conditional result was False 2026-01-11 00:22:50.864941 | 2026-01-11 00:22:50.865094 | LOOP [bindep : Include package tasks] 2026-01-11 00:22:50.945509 | 2026-01-11 00:22:50.945812 | TASK [Run test-setup role] 2026-01-11 00:22:50.976289 | controller | ok 2026-01-11 00:22:51.005021 | 2026-01-11 00:22:51.005165 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-01-11 00:22:51.256999 | controller | ok 2026-01-11 00:22:51.269714 | 2026-01-11 00:22:51.269916 | TASK [test-setup : Run tools/test-setup.sh] 2026-01-11 00:22:51.823357 | controller | skipping: Conditional result was False 2026-01-11 00:22:51.876218 | 2026-01-11 00:22:51.876323 | PLAY RECAP 2026-01-11 00:22:51.876390 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-01-11 00:22:51.876424 | 2026-01-11 00:22:51.979396 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-01-11 00:22:51.980272 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-01-11 00:22:52.595308 | 2026-01-11 00:22:52.595468 | PLAY [controller] 2026-01-11 00:22:52.615267 | 2026-01-11 00:22:52.615343 | TASK [Create the /root directory] 2026-01-11 00:25:05.007313 | controller | ERROR 2026-01-11 00:25:05.007553 | controller | { 2026-01-11 00:25:05.007591 | controller | "msg": "Timeout (32s) waiting for privilege escalation prompt: " 2026-01-11 00:25:05.007618 | controller | } failure 2026-01-11 00:25:05.009341 | 2026-01-11 00:25:05.009390 | PLAY RECAP 2026-01-11 00:25:05.009427 | controller | ok: 0 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-01-11 00:25:05.009448 | 2026-01-11 00:25:05.106077 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-01-11 00:25:05.107317 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-01-11 00:25:05.688965 | 2026-01-11 00:25:05.689114 | PLAY [all] 2026-01-11 00:25:05.716563 | 2026-01-11 00:25:05.716696 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-01-11 00:27:53.918430 | controller | changed: non-zero return code 2026-01-11 00:27:53.927477 | 2026-01-11 00:27:53.927798 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-01-11 00:27:53.956810 | controller | skipping: Conditional result was False 2026-01-11 00:27:53.970388 | 2026-01-11 00:27:53.970556 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-01-11 00:27:54.013865 | 2026-01-11 00:27:54.014165 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-01-11 00:27:54.059587 | 2026-01-11 00:27:54.059942 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-01-11 00:27:54.088762 | controller | skipping: Conditional result was False 2026-01-11 00:27:54.105598 | 2026-01-11 00:27:54.105828 | LOOP [fetch-subunit-output : Generate subunit file] 2026-01-11 00:27:54.150410 | 2026-01-11 00:27:54.150714 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-01-11 00:27:54.179192 | controller | skipping: Conditional result was False 2026-01-11 00:27:54.193426 | 2026-01-11 00:27:54.193581 | TASK [fetch-subunit-output : Remove the temporary file] 2026-01-11 00:27:54.221699 | controller | skipping: Conditional result was False 2026-01-11 00:27:54.235785 | 2026-01-11 00:27:54.235958 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-01-11 00:27:54.263249 | controller | skipping: Conditional result was False 2026-01-11 00:27:54.310756 | 2026-01-11 00:27:54.310912 | PLAY RECAP 2026-01-11 00:27:54.310985 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-01-11 00:27:54.311015 | 2026-01-11 00:27:54.413442 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-01-11 00:27:54.414345 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2026-01-11 00:27:54.971264 | 2026-01-11 00:27:54.971381 | PLAY [all:!appliance*] 2026-01-11 00:27:54.993753 | 2026-01-11 00:27:54.993912 | TASK [unregister the node] 2026-01-11 00:27:55.528981 | controller | skipping: Conditional result was False 2026-01-11 00:27:55.543850 | 2026-01-11 00:27:55.544084 | TASK [include_role : fetch-output] 2026-01-11 00:27:55.594804 | controller | ok 2026-01-11 00:27:55.634873 | 2026-01-11 00:27:55.635017 | TASK [fetch-output : Set log path for multiple nodes] 2026-01-11 00:27:55.712432 | controller | skipping: Conditional result was False 2026-01-11 00:27:55.728610 | 2026-01-11 00:27:55.728847 | TASK [fetch-output : Set log path for single node] 2026-01-11 00:27:55.790879 | controller | ok 2026-01-11 00:27:55.804358 | 2026-01-11 00:27:55.804519 | LOOP [fetch-output : Ensure local output dirs] 2026-01-11 00:27:56.268695 | controller -> localhost | ok: "/var/lib/zuul/builds/a54887fe685a4fdda08b2e171bc8dc7b/work/logs" 2026-01-11 00:27:56.554911 | controller -> localhost | changed: "/var/lib/zuul/builds/a54887fe685a4fdda08b2e171bc8dc7b/work/artifacts" 2026-01-11 00:27:56.835087 | controller -> localhost | changed: "/var/lib/zuul/builds/a54887fe685a4fdda08b2e171bc8dc7b/work/docs" 2026-01-11 00:27:56.853025 | 2026-01-11 00:27:56.853093 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-01-11 00:27:57.639133 | controller | ok 2026-01-11 00:27:57.639551 | controller | changed: All items complete 2026-01-11 00:27:57.639615 | 2026-01-11 00:27:58.199570 | controller | changed: .d..t...... ./ 2026-01-11 00:27:58.761513 | controller | changed: .d..t...... ./ 2026-01-11 00:27:58.785256 | 2026-01-11 00:27:58.785532 | TASK [include_role : fetch-output-openshift] 2026-01-11 00:27:58.813776 | controller | skipping: Conditional result was False 2026-01-11 00:27:58.831663 | 2026-01-11 00:27:58.831939 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-01-11 00:27:58.886948 | controller | skipping: Conditional result was False 2026-01-11 00:27:58.899371 | controller | skipping: Conditional result was False 2026-01-11 00:27:58.947304 | 2026-01-11 00:27:58.947493 | PLAY [localhost] 2026-01-11 00:27:58.964914 | 2026-01-11 00:27:58.965014 | TASK [Run Zuul manifest role] 2026-01-11 00:27:58.988888 | localhost | ok 2026-01-11 00:27:59.009943 | 2026-01-11 00:27:59.010121 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-01-11 00:27:59.547763 | localhost | changed 2026-01-11 00:27:59.558666 | 2026-01-11 00:27:59.558906 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-01-11 00:27:59.595162 | localhost | ok 2026-01-11 00:27:59.606999 | 2026-01-11 00:27:59.607155 | TASK [Set zuul-log-path fact] 2026-01-11 00:27:59.630137 | localhost | ok 2026-01-11 00:27:59.650896 | 2026-01-11 00:27:59.651075 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-11 00:27:59.681586 | localhost | ok 2026-01-11 00:27:59.690330 | 2026-01-11 00:27:59.690411 | LOOP [Run upload-logs-swift role] 2026-01-11 00:27:59.726894 | localhost | Output suppressed because no_log was given 2026-01-11 00:27:59.753629 | 2026-01-11 00:27:59.753780 | TASK [Set zuul-log-path fact] 2026-01-11 00:27:59.780961 | localhost | skipping: Conditional result was False 2026-01-11 00:27:59.790988 | 2026-01-11 00:27:59.791136 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2026-01-11 00:28:00.225476 | localhost -> localhost | ok: Runtime: 0:00:00.014421 2026-01-11 00:28:00.236339 | 2026-01-11 00:28:00.236491 | TASK [upload-logs-swift : Upload logs to swift]