2026-03-03 00:20:59.166521 | Job console starting... 2026-03-03 00:20:59.175581 | Updating repositories 2026-03-03 00:20:59.314637 | Preparing job workspace 2026-03-03 00:21:02.686066 | Running Ansible setup... 2026-03-03 00:21:07.557489 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-03-03 00:21:08.212773 | 2026-03-03 00:21:08.212924 | PLAY [localhost] 2026-03-03 00:21:08.222556 | 2026-03-03 00:21:08.222636 | TASK [Gathering Facts] 2026-03-03 00:21:09.234009 | localhost | ok 2026-03-03 00:21:09.263922 | 2026-03-03 00:21:09.264028 | TASK [Setup log path fact] 2026-03-03 00:21:09.285211 | localhost | ok 2026-03-03 00:21:09.301762 | 2026-03-03 00:21:09.301852 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-03 00:21:09.341505 | localhost | ok 2026-03-03 00:21:09.352052 | 2026-03-03 00:21:09.352141 | TASK [emit-job-header : Print job information] 2026-03-03 00:21:09.403934 | # Job Information 2026-03-03 00:21:09.404122 | Ansible Version: 2.15.12 2026-03-03 00:21:09.404169 | Job: ansible-test-sanity-docker-milestone 2026-03-03 00:21:09.404200 | Pipeline: periodic 2026-03-03 00:21:09.404225 | Executor: ze04.softwarefactory-project.io 2026-03-03 00:21:09.404251 | Triggered by: https://github.com/ansible-collections/ansible.network 2026-03-03 00:21:09.404281 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/cb3/ansible/cb31d80ad15e4d78bdac4fdea5eb9864/ 2026-03-03 00:21:09.404306 | Event ID: c6f296bc1fe348df9801fd052b877527 2026-03-03 00:21:09.409643 | 2026-03-03 00:21:09.409765 | LOOP [emit-job-header : Print node information] 2026-03-03 00:21:09.520195 | localhost | ok: 2026-03-03 00:21:09.520350 | localhost | # Node Information 2026-03-03 00:21:09.520377 | localhost | Inventory Hostname: controller 2026-03-03 00:21:09.520397 | localhost | Hostname: np0005636100 2026-03-03 00:21:09.520417 | localhost | Username: zuul 2026-03-03 00:21:09.520437 | localhost | Distro: Fedora 37 2026-03-03 00:21:09.520456 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2026-03-03 00:21:09.520473 | localhost | Region: ca-ymq-1 2026-03-03 00:21:09.520490 | localhost | Label: ansible-fedora-37-1vcpu 2026-03-03 00:21:09.520507 | localhost | Product Name: OpenStack Nova 2026-03-03 00:21:09.520523 | localhost | Interface IP: 199.204.45.67 2026-03-03 00:21:09.551897 | 2026-03-03 00:21:09.552221 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-03 00:21:10.031948 | localhost -> localhost | changed 2026-03-03 00:21:10.046374 | 2026-03-03 00:21:10.046531 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-03 00:21:10.943629 | localhost -> localhost | changed 2026-03-03 00:21:10.966234 | 2026-03-03 00:21:10.966314 | PLAY [all:!appliance*] 2026-03-03 00:21:10.984394 | 2026-03-03 00:21:10.984473 | TASK [include_role : start-zuul-console] 2026-03-03 00:21:11.007089 | controller | ok 2026-03-03 00:21:11.025625 | 2026-03-03 00:21:11.025742 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-03 00:21:11.431820 | controller | ok 2026-03-03 00:21:11.457939 | 2026-03-03 00:21:11.458125 | TASK [use-our-mirror : Retrieve the IP address] 2026-03-03 00:21:12.313922 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2026-03-03 00:21:12.328871 | 2026-03-03 00:21:12.329006 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2026-03-03 00:21:12.883943 | controller | skipping: Conditional result was False 2026-03-03 00:21:12.901570 | 2026-03-03 00:21:12.901824 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2026-03-03 00:21:12.941430 | controller | skipping: Conditional result was False 2026-03-03 00:21:12.958091 | 2026-03-03 00:21:12.958258 | TASK [use-our-mirror : Create the podman configuration directory] 2026-03-03 00:21:12.988488 | controller | skipping: Conditional result was False 2026-03-03 00:21:13.002664 | 2026-03-03 00:21:13.002899 | TASK [use-our-mirror : Copy the podman configuration] 2026-03-03 00:21:13.040735 | controller | skipping: Conditional result was False 2026-03-03 00:21:13.054341 | 2026-03-03 00:21:13.054453 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2026-03-03 00:21:13.080935 | controller | skipping: Conditional result was False 2026-03-03 00:21:13.090304 | 2026-03-03 00:21:13.090413 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2026-03-03 00:21:13.116325 | controller | skipping: Conditional result was False 2026-03-03 00:21:13.134400 | 2026-03-03 00:21:13.134516 | TASK [Disable Fedora Modular] 2026-03-03 00:21:13.387364 | controller | changed 2026-03-03 00:21:13.400139 | 2026-03-03 00:21:13.400268 | TASK [Enable EPEL] 2026-03-03 00:21:13.428284 | controller | skipping: Conditional result was False 2026-03-03 00:21:13.442169 | 2026-03-03 00:21:13.442323 | TASK [Register the RHEL node] 2026-03-03 00:21:14.007201 | 2026-03-03 00:21:14.007493 | TASK [Show the subscription-manager status] 2026-03-03 00:21:14.594034 | controller | skipping: Conditional result was False 2026-03-03 00:21:14.603450 | 2026-03-03 00:21:14.603548 | TASK [Enable EPEL on RHEL] 2026-03-03 00:21:15.140067 | controller | skipping: Conditional result was False 2026-03-03 00:21:15.155568 | 2026-03-03 00:21:15.155743 | TASK [Install git and tox] 2026-03-03 00:22:36.472875 | controller | changed 2026-03-03 00:22:36.479809 | 2026-03-03 00:22:36.479885 | TASK [include_role : prepare-workspace] 2026-03-03 00:22:36.501728 | controller | ok 2026-03-03 00:22:36.526441 | 2026-03-03 00:22:36.526637 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-03 00:22:36.749903 | controller | ok 2026-03-03 00:22:36.756769 | 2026-03-03 00:22:36.756840 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-03 00:22:48.842422 | controller | Output suppressed because no_log was given 2026-03-03 00:22:48.852317 | 2026-03-03 00:22:48.852389 | TASK [include_role : prepare-workspace-openshift] 2026-03-03 00:22:48.876314 | controller | skipping: Conditional result was False 2026-03-03 00:22:48.922858 | 2026-03-03 00:22:48.922940 | PLAY [all:!appliance] 2026-03-03 00:22:48.938539 | 2026-03-03 00:22:48.938610 | TASK [Run add-build-sshkey role (RSA)] 2026-03-03 00:22:48.968148 | controller | ok 2026-03-03 00:22:48.982893 | 2026-03-03 00:22:48.982978 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-03 00:22:49.210241 | controller -> localhost | ok 2026-03-03 00:22:49.216636 | 2026-03-03 00:22:49.216745 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-03 00:22:49.255830 | controller | ok 2026-03-03 00:22:49.269904 | controller | included: /var/lib/zuul/builds/cb31d80ad15e4d78bdac4fdea5eb9864/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-03 00:22:49.275729 | 2026-03-03 00:22:49.275792 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-03 00:22:49.745264 | controller -> localhost | Generating public/private rsa key pair. 2026-03-03 00:22:49.745501 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/cb31d80ad15e4d78bdac4fdea5eb9864/work/cb31d80ad15e4d78bdac4fdea5eb9864_id_rsa. 2026-03-03 00:22:49.745543 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/cb31d80ad15e4d78bdac4fdea5eb9864/work/cb31d80ad15e4d78bdac4fdea5eb9864_id_rsa.pub. 2026-03-03 00:22:49.745573 | controller -> localhost | The key fingerprint is: 2026-03-03 00:22:49.745602 | controller -> localhost | SHA256:Hvxm08VVk/fhUZmJlejs6ApvLWIJLVZ5pLPtcMF4Ydg zuul-build-sshkey 2026-03-03 00:22:49.745633 | controller -> localhost | The key's randomart image is: 2026-03-03 00:22:49.745660 | controller -> localhost | +---[RSA 2048]----+ 2026-03-03 00:22:49.745726 | controller -> localhost | | o +oX| 2026-03-03 00:22:49.745756 | controller -> localhost | | . E o O+| 2026-03-03 00:22:49.745783 | controller -> localhost | | B . o . *| 2026-03-03 00:22:49.745810 | controller -> localhost | | B = + o.| 2026-03-03 00:22:49.745835 | controller -> localhost | | o S . o o | 2026-03-03 00:22:49.745891 | controller -> localhost | | + = = o o | 2026-03-03 00:22:49.745923 | controller -> localhost | | . o.* B . | 2026-03-03 00:22:49.745954 | controller -> localhost | | +o* + | 2026-03-03 00:22:49.745980 | controller -> localhost | | . ooo | 2026-03-03 00:22:49.746010 | controller -> localhost | +----[SHA256]-----+ 2026-03-03 00:22:49.746075 | controller -> localhost | ok: Runtime: 0:00:00.035533 2026-03-03 00:22:49.755273 | 2026-03-03 00:22:49.755390 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-03 00:22:49.789188 | controller | ok 2026-03-03 00:22:49.803862 | controller | included: /var/lib/zuul/builds/cb31d80ad15e4d78bdac4fdea5eb9864/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-03 00:22:49.817344 | 2026-03-03 00:22:49.817462 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-03 00:22:49.833100 | controller | skipping: Conditional result was False 2026-03-03 00:22:49.839897 | 2026-03-03 00:22:49.839990 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-03 00:22:50.295560 | controller | changed 2026-03-03 00:22:50.305277 | 2026-03-03 00:22:50.305402 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-03 00:22:50.523017 | controller | ok 2026-03-03 00:22:50.536262 | 2026-03-03 00:22:50.536380 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-03 00:22:51.168422 | controller | changed 2026-03-03 00:22:51.181732 | 2026-03-03 00:22:51.181874 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-03 00:22:51.818406 | controller | changed 2026-03-03 00:22:51.831577 | 2026-03-03 00:22:51.831763 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-03 00:22:51.858350 | controller | skipping: Conditional result was False 2026-03-03 00:22:51.873880 | 2026-03-03 00:22:51.874049 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-03 00:22:52.310812 | controller -> localhost | changed 2026-03-03 00:22:52.339035 | 2026-03-03 00:22:52.339213 | TASK [add-build-sshkey : Add back temp key] 2026-03-03 00:22:52.644019 | controller -> localhost | Identity added: /var/lib/zuul/builds/cb31d80ad15e4d78bdac4fdea5eb9864/work/cb31d80ad15e4d78bdac4fdea5eb9864_id_rsa (zuul-build-sshkey) 2026-03-03 00:22:52.644272 | controller -> localhost | ok: Runtime: 0:00:00.007975 2026-03-03 00:22:52.651824 | 2026-03-03 00:22:52.651908 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-03 00:22:52.995287 | controller | ok 2026-03-03 00:22:53.009310 | 2026-03-03 00:22:53.009472 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-03 00:22:53.048504 | controller | skipping: Conditional result was False 2026-03-03 00:22:53.074864 | 2026-03-03 00:22:53.075007 | TASK [Run add-build-sshkey role (ECDSA)] 2026-03-03 00:22:53.115140 | controller | ok 2026-03-03 00:22:53.147227 | 2026-03-03 00:22:53.147404 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-03 00:22:53.447962 | controller -> localhost | ok 2026-03-03 00:22:53.457360 | 2026-03-03 00:22:53.457445 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-03 00:22:53.483238 | controller | ok 2026-03-03 00:22:53.498856 | controller | included: /var/lib/zuul/builds/cb31d80ad15e4d78bdac4fdea5eb9864/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-03 00:22:53.507767 | 2026-03-03 00:22:53.507852 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-03 00:22:53.809806 | controller -> localhost | Generating public/private ecdsa key pair. 2026-03-03 00:22:53.810190 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/cb31d80ad15e4d78bdac4fdea5eb9864/work/cb31d80ad15e4d78bdac4fdea5eb9864_id_ecdsa. 2026-03-03 00:22:53.810251 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/cb31d80ad15e4d78bdac4fdea5eb9864/work/cb31d80ad15e4d78bdac4fdea5eb9864_id_ecdsa.pub. 2026-03-03 00:22:53.810311 | controller -> localhost | The key fingerprint is: 2026-03-03 00:22:53.810354 | controller -> localhost | SHA256:fjTFd4jRdlDOnhTmU8Po+Lless6pNO+liv5UleYYAwA zuul-build-sshkey 2026-03-03 00:22:53.810397 | controller -> localhost | The key's randomart image is: 2026-03-03 00:22:53.810436 | controller -> localhost | +---[ECDSA 521]---+ 2026-03-03 00:22:53.810474 | controller -> localhost | | E......+*o| 2026-03-03 00:22:53.810511 | controller -> localhost | | ..+==*| 2026-03-03 00:22:53.810547 | controller -> localhost | | *+oO+| 2026-03-03 00:22:53.810582 | controller -> localhost | | o oOoo| 2026-03-03 00:22:53.810617 | controller -> localhost | | S o .o.o.| 2026-03-03 00:22:53.810652 | controller -> localhost | | . . ..o | 2026-03-03 00:22:53.810724 | controller -> localhost | | . .+ ..o | 2026-03-03 00:22:53.810764 | controller -> localhost | | .+ +.B | 2026-03-03 00:22:53.810799 | controller -> localhost | | .o.+*X | 2026-03-03 00:22:53.810835 | controller -> localhost | +----[SHA256]-----+ 2026-03-03 00:22:53.810934 | controller -> localhost | ok: Runtime: 0:00:00.007302 2026-03-03 00:22:53.825815 | 2026-03-03 00:22:53.825994 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-03 00:22:53.854793 | controller | ok 2026-03-03 00:22:53.873096 | controller | included: /var/lib/zuul/builds/cb31d80ad15e4d78bdac4fdea5eb9864/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-03 00:22:53.885839 | 2026-03-03 00:22:53.885940 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-03 00:22:53.911075 | controller | skipping: Conditional result was False 2026-03-03 00:22:53.928050 | 2026-03-03 00:22:53.928259 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-03 00:22:54.223993 | controller | changed 2026-03-03 00:22:54.240855 | 2026-03-03 00:22:54.241087 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-03 00:22:54.487789 | controller | ok 2026-03-03 00:22:54.505165 | 2026-03-03 00:22:54.505341 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-03 00:22:55.211024 | controller | changed 2026-03-03 00:22:55.224972 | 2026-03-03 00:22:55.225145 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-03 00:22:55.891240 | controller | changed 2026-03-03 00:22:55.906591 | 2026-03-03 00:22:55.906806 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-03 00:22:55.943937 | controller | skipping: Conditional result was False 2026-03-03 00:22:55.958040 | 2026-03-03 00:22:55.958203 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-03 00:22:56.250804 | controller -> localhost | changed 2026-03-03 00:22:56.281094 | 2026-03-03 00:22:56.281270 | TASK [add-build-sshkey : Add back temp key] 2026-03-03 00:22:56.534107 | controller -> localhost | Identity added: /var/lib/zuul/builds/cb31d80ad15e4d78bdac4fdea5eb9864/work/cb31d80ad15e4d78bdac4fdea5eb9864_id_ecdsa (zuul-build-sshkey) 2026-03-03 00:22:56.534461 | controller -> localhost | ok: Runtime: 0:00:00.006934 2026-03-03 00:22:56.549230 | 2026-03-03 00:22:56.549391 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-03 00:22:56.800608 | controller | ok 2026-03-03 00:22:56.806781 | 2026-03-03 00:22:56.806860 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-03 00:22:56.831109 | controller | skipping: Conditional result was False 2026-03-03 00:22:56.842818 | 2026-03-03 00:22:56.842913 | TASK [include_role : remove-zuul-sshkey] 2026-03-03 00:22:56.866755 | controller | skipping: Conditional result was False 2026-03-03 00:22:56.873375 | 2026-03-03 00:22:56.873451 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-03 00:22:57.102822 | controller | ok: "logs" 2026-03-03 00:22:57.103263 | controller | ok: All items complete 2026-03-03 00:22:57.103325 | 2026-03-03 00:22:57.293816 | controller | ok: "artifacts" 2026-03-03 00:22:57.490282 | controller | ok: "docs" 2026-03-03 00:22:57.505984 | 2026-03-03 00:22:57.506117 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-03 00:22:57.768620 | controller | changed: "logs" 2026-03-03 00:22:57.974120 | controller | changed: "artifacts" 2026-03-03 00:22:58.187224 | controller | changed: "docs" 2026-03-03 00:22:58.234152 | 2026-03-03 00:22:58.234283 | PLAY RECAP 2026-03-03 00:22:58.234344 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2026-03-03 00:22:58.234380 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-03 00:22:58.234406 | 2026-03-03 00:22:58.350757 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-03-03 00:22:58.352396 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-03-03 00:22:59.015602 | 2026-03-03 00:22:59.015804 | PLAY [all] 2026-03-03 00:22:59.041188 | 2026-03-03 00:22:59.041311 | TASK [Install binary dependencies] 2026-03-03 00:22:59.112191 | controller | ok 2026-03-03 00:22:59.133798 | 2026-03-03 00:22:59.133950 | TASK [bindep : Include find tasks] 2026-03-03 00:22:59.177073 | controller | ok 2026-03-03 00:22:59.189583 | controller | included: /var/lib/zuul/builds/cb31d80ad15e4d78bdac4fdea5eb9864/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-03-03 00:22:59.199584 | 2026-03-03 00:22:59.199707 | TASK [bindep : Look for bindep.txt] 2026-03-03 00:22:59.600402 | controller | ok 2026-03-03 00:22:59.607054 | 2026-03-03 00:22:59.607126 | TASK [bindep : Define bindep_file fact] 2026-03-03 00:22:59.632734 | controller | skipping: Conditional result was False 2026-03-03 00:22:59.639777 | 2026-03-03 00:22:59.639887 | TASK [bindep : Look for other-requirements.txt] 2026-03-03 00:22:59.870872 | controller | ok 2026-03-03 00:22:59.885287 | 2026-03-03 00:22:59.885438 | TASK [bindep : Define bindep_file fact] 2026-03-03 00:22:59.922800 | controller | skipping: Conditional result was False 2026-03-03 00:22:59.938443 | 2026-03-03 00:22:59.938598 | TASK [bindep : Look for bindep fallback file] 2026-03-03 00:22:59.977221 | controller | skipping: Conditional result was False 2026-03-03 00:22:59.993577 | 2026-03-03 00:22:59.993766 | TASK [bindep : Define bindep_file fact] 2026-03-03 00:23:00.031751 | controller | skipping: Conditional result was False 2026-03-03 00:23:00.047486 | 2026-03-03 00:23:00.047863 | TASK [bindep : Include bindep tasks] 2026-03-03 00:23:00.085308 | controller | skipping: Conditional result was False 2026-03-03 00:23:00.099629 | 2026-03-03 00:23:00.099797 | TASK [bindep : Include install tasks] 2026-03-03 00:23:00.126662 | controller | skipping: Conditional result was False 2026-03-03 00:23:00.140823 | 2026-03-03 00:23:00.140968 | LOOP [bindep : Include package tasks] 2026-03-03 00:23:00.225394 | 2026-03-03 00:23:00.225868 | TASK [Run test-setup role] 2026-03-03 00:23:00.259353 | controller | ok 2026-03-03 00:23:00.288142 | 2026-03-03 00:23:00.288254 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-03-03 00:23:00.521213 | controller | ok 2026-03-03 00:23:00.535548 | 2026-03-03 00:23:00.535857 | TASK [test-setup : Run tools/test-setup.sh] 2026-03-03 00:23:30.610639 | [Zuul] Log Stream did not terminate 2026-03-03 00:23:30.610990 | controller | skipping: Conditional result was False 2026-03-03 00:23:30.646006 | 2026-03-03 00:23:30.646136 | PLAY RECAP 2026-03-03 00:23:30.646192 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-03-03 00:23:30.646231 | 2026-03-03 00:23:30.769965 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-03-03 00:23:30.771763 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-03-03 00:23:31.401407 | 2026-03-03 00:23:31.401599 | PLAY [controller] 2026-03-03 00:23:31.422638 | 2026-03-03 00:23:31.422778 | TASK [Create the /root directory] 2026-03-03 00:25:43.790298 | controller | ERROR 2026-03-03 00:25:43.790532 | controller | { 2026-03-03 00:25:43.790579 | controller | "msg": "Timeout (32s) waiting for privilege escalation prompt: " 2026-03-03 00:25:43.790617 | controller | } failure 2026-03-03 00:25:43.791792 | 2026-03-03 00:25:43.791846 | PLAY RECAP 2026-03-03 00:25:43.791897 | controller | ok: 0 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-03-03 00:25:43.791928 | 2026-03-03 00:25:43.894519 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-03-03 00:25:43.896586 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-03 00:25:44.522034 | 2026-03-03 00:25:44.522158 | PLAY [all] 2026-03-03 00:25:44.544470 | 2026-03-03 00:25:44.544600 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-03-03 00:28:00.876643 | controller | changed: non-zero return code 2026-03-03 00:28:00.883591 | 2026-03-03 00:28:00.883724 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-03-03 00:28:00.899601 | controller | skipping: Conditional result was False 2026-03-03 00:28:00.907110 | 2026-03-03 00:28:00.907202 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-03-03 00:28:00.928190 | 2026-03-03 00:28:00.928345 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-03-03 00:28:00.948247 | 2026-03-03 00:28:00.948410 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-03-03 00:28:00.961793 | controller | skipping: Conditional result was False 2026-03-03 00:28:00.968464 | 2026-03-03 00:28:00.968555 | LOOP [fetch-subunit-output : Generate subunit file] 2026-03-03 00:28:00.988254 | 2026-03-03 00:28:00.988414 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-03-03 00:28:01.001634 | controller | skipping: Conditional result was False 2026-03-03 00:28:01.009307 | 2026-03-03 00:28:01.009398 | TASK [fetch-subunit-output : Remove the temporary file] 2026-03-03 00:28:01.022792 | controller | skipping: Conditional result was False 2026-03-03 00:28:01.029165 | 2026-03-03 00:28:01.029272 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-03-03 00:28:01.042617 | controller | skipping: Conditional result was False 2026-03-03 00:28:01.069850 | 2026-03-03 00:28:01.069949 | PLAY RECAP 2026-03-03 00:28:01.069992 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-03-03 00:28:01.070019 | 2026-03-03 00:28:01.177292 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-03 00:28:01.179386 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2026-03-03 00:28:01.733161 | 2026-03-03 00:28:01.733284 | PLAY [all:!appliance*] 2026-03-03 00:28:01.756095 | 2026-03-03 00:28:01.756233 | TASK [unregister the node] 2026-03-03 00:28:02.287092 | controller | skipping: Conditional result was False 2026-03-03 00:28:02.301103 | 2026-03-03 00:28:02.301281 | TASK [include_role : fetch-output] 2026-03-03 00:28:02.361341 | controller | ok 2026-03-03 00:28:02.401227 | 2026-03-03 00:28:02.401349 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-03 00:28:02.477465 | controller | skipping: Conditional result was False 2026-03-03 00:28:02.486059 | 2026-03-03 00:28:02.486172 | TASK [fetch-output : Set log path for single node] 2026-03-03 00:28:02.528865 | controller | ok 2026-03-03 00:28:02.536544 | 2026-03-03 00:28:02.536650 | LOOP [fetch-output : Ensure local output dirs] 2026-03-03 00:28:02.992900 | controller -> localhost | ok: "/var/lib/zuul/builds/cb31d80ad15e4d78bdac4fdea5eb9864/work/logs" 2026-03-03 00:28:03.273416 | controller -> localhost | changed: "/var/lib/zuul/builds/cb31d80ad15e4d78bdac4fdea5eb9864/work/artifacts" 2026-03-03 00:28:03.532137 | controller -> localhost | changed: "/var/lib/zuul/builds/cb31d80ad15e4d78bdac4fdea5eb9864/work/docs" 2026-03-03 00:28:03.548665 | 2026-03-03 00:28:03.548807 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-03 00:28:04.269447 | controller | changed: .d..t...... ./ 2026-03-03 00:28:04.269735 | controller | changed: All items complete 2026-03-03 00:28:04.269798 | 2026-03-03 00:28:04.825479 | controller | changed: .d..t...... ./ 2026-03-03 00:28:05.356471 | controller | changed: .d..t...... ./ 2026-03-03 00:28:05.395161 | 2026-03-03 00:28:05.395328 | TASK [include_role : fetch-output-openshift] 2026-03-03 00:28:05.422301 | controller | skipping: Conditional result was False 2026-03-03 00:28:05.438283 | 2026-03-03 00:28:05.438382 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-03 00:28:05.463868 | controller | skipping: Conditional result was False 2026-03-03 00:28:05.472850 | controller | skipping: Conditional result was False 2026-03-03 00:28:05.510334 | 2026-03-03 00:28:05.510432 | PLAY [localhost] 2026-03-03 00:28:05.522559 | 2026-03-03 00:28:05.522730 | TASK [Run Zuul manifest role] 2026-03-03 00:28:05.540358 | localhost | ok 2026-03-03 00:28:05.555133 | 2026-03-03 00:28:05.555241 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-03 00:28:05.978779 | localhost | changed 2026-03-03 00:28:05.990178 | 2026-03-03 00:28:05.990323 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-03 00:28:06.029295 | localhost | ok 2026-03-03 00:28:06.049907 | 2026-03-03 00:28:06.050052 | TASK [Set zuul-log-path fact] 2026-03-03 00:28:06.073245 | localhost | ok 2026-03-03 00:28:06.097368 | 2026-03-03 00:28:06.097510 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-03 00:28:06.128465 | localhost | ok 2026-03-03 00:28:06.140104 | 2026-03-03 00:28:06.140205 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)] 2026-03-03 00:28:06.177138 | localhost | ok: 2026-03-03 00:28:06.178042 | localhost | { 2026-03-03 00:28:06.178135 | localhost | "auth": { 2026-03-03 00:28:06.178186 | localhost | "password": "IonWCwcuOFib&&<}wp^:[2G/", 2026-03-03 00:28:06.178226 | localhost | "username": "9LF91O0RK7JU" 2026-03-03 00:28:06.178283 | localhost | }, 2026-03-03 00:28:06.178326 | localhost | "profile": "rackspace", 2026-03-03 00:28:06.178367 | localhost | "project_name": "1251317", 2026-03-03 00:28:06.178405 | localhost | "region_name": "DFW" 2026-03-03 00:28:06.178442 | localhost | } 2026-03-03 00:28:06.178501 | 2026-03-03 00:28:06.194583 | 2026-03-03 00:28:06.194752 | TASK [Run upload-logs-failover role (S3 then Swift)] 2026-03-03 00:28:06.215509 | localhost | Output suppressed because no_log was given 2026-03-03 00:28:06.232671 | 2026-03-03 00:28:06.232791 | TASK [upload-logs-failover : Initialize control vars] 2026-03-03 00:28:06.263669 | localhost | ok 2026-03-03 00:28:06.270186 | 2026-03-03 00:28:06.270273 | LOOP [upload-logs-failover : Perform log upload] 2026-03-03 00:28:06.362797 | localhost | Output suppressed because no_log was given 2026-03-03 00:28:06.371930 | localhost | included: /var/lib/zuul/builds/cb31d80ad15e4d78bdac4fdea5eb9864/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml 2026-03-03 00:28:06.378746 | 2026-03-03 00:28:06.378818 | LOOP [upload-logs-failover : Unpack vars for swift upload] 2026-03-03 00:28:06.480551 | localhost | Output suppressed because no_log was given 2026-03-03 00:28:06.493395 | 2026-03-03 00:28:06.493751 | TASK [Upload logs to swift] 2026-03-03 00:28:06.526043 | localhost | ok 2026-03-03 00:28:06.554797 | 2026-03-03 00:28:06.554925 | TASK [Set zuul-log-path fact] 2026-03-03 00:28:06.591396 | localhost | skipping: Conditional result was False 2026-03-03 00:28:06.602971 | 2026-03-03 00:28:06.603121 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2026-03-03 00:28:06.997122 | localhost -> localhost | ok: Runtime: 0:00:00.007046 2026-03-03 00:28:07.002824 | 2026-03-03 00:28:07.002895 | TASK [upload-logs-swift : Upload logs to swift]