2026-01-08 00:22:35.800581 | Job console starting... 2026-01-08 00:22:35.823846 | Updating repositories 2026-01-08 00:22:35.944877 | Preparing job workspace 2026-01-08 00:22:39.785549 | Running Ansible setup... 2026-01-08 00:22:45.019929 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-01-08 00:22:45.722880 | 2026-01-08 00:22:45.723127 | PLAY [localhost] 2026-01-08 00:22:45.734035 | 2026-01-08 00:22:45.734198 | TASK [Gathering Facts] 2026-01-08 00:22:46.864229 | localhost | ok 2026-01-08 00:22:46.885195 | 2026-01-08 00:22:46.885457 | TASK [Setup log path fact] 2026-01-08 00:22:46.907067 | localhost | ok 2026-01-08 00:22:46.921584 | 2026-01-08 00:22:46.921728 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-08 00:22:46.963155 | localhost | ok 2026-01-08 00:22:46.972253 | 2026-01-08 00:22:46.972360 | TASK [emit-job-header : Print job information] 2026-01-08 00:22:47.015352 | # Job Information 2026-01-08 00:22:47.015617 | Ansible Version: 2.15.12 2026-01-08 00:22:47.015651 | Job: ansible-test-sanity-docker-stable-2.11 2026-01-08 00:22:47.015677 | Pipeline: periodic 2026-01-08 00:22:47.015695 | Executor: ze01.softwarefactory-project.io 2026-01-08 00:22:47.015714 | Triggered by: https://github.com/ansible-collections/ansible.network 2026-01-08 00:22:47.015735 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/9b4/ansible/9b4ca23afe4b491ab542086e71edb0da/ 2026-01-08 00:22:47.015759 | Event ID: d4752e8c0ffe4b90a8171373176f7c90 2026-01-08 00:22:47.020419 | 2026-01-08 00:22:47.020488 | LOOP [emit-job-header : Print node information] 2026-01-08 00:22:47.133596 | localhost | ok: 2026-01-08 00:22:47.133833 | localhost | # Node Information 2026-01-08 00:22:47.133861 | localhost | Inventory Hostname: controller 2026-01-08 00:22:47.133882 | localhost | Hostname: np0005577451 2026-01-08 00:22:47.133902 | localhost | Username: zuul 2026-01-08 00:22:47.133937 | localhost | Distro: Fedora 37 2026-01-08 00:22:47.133972 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2026-01-08 00:22:47.134000 | localhost | Region: ca-ymq-1 2026-01-08 00:22:47.134050 | localhost | Label: ansible-fedora-37-1vcpu 2026-01-08 00:22:47.134077 | localhost | Product Name: OpenStack Nova 2026-01-08 00:22:47.134104 | localhost | Interface IP: 162.253.55.62 2026-01-08 00:22:47.156960 | 2026-01-08 00:22:47.157254 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-08 00:22:47.615271 | localhost -> localhost | changed 2026-01-08 00:22:47.621566 | 2026-01-08 00:22:47.621645 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-08 00:22:48.584107 | localhost -> localhost | changed 2026-01-08 00:22:48.611011 | 2026-01-08 00:22:48.611203 | PLAY [all:!appliance*] 2026-01-08 00:22:48.628910 | 2026-01-08 00:22:48.629082 | TASK [include_role : start-zuul-console] 2026-01-08 00:22:48.649259 | controller | ok 2026-01-08 00:22:48.662962 | 2026-01-08 00:22:48.663094 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-08 00:22:49.019142 | controller | ok 2026-01-08 00:22:49.031982 | 2026-01-08 00:22:49.032129 | TASK [use-our-mirror : Retrieve the IP address] 2026-01-08 00:22:49.999136 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2026-01-08 00:22:50.018237 | 2026-01-08 00:22:50.018463 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2026-01-08 00:22:50.570499 | controller | skipping: Conditional result was False 2026-01-08 00:22:50.577521 | 2026-01-08 00:22:50.577684 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2026-01-08 00:22:50.601996 | controller | skipping: Conditional result was False 2026-01-08 00:22:50.609149 | 2026-01-08 00:22:50.609232 | TASK [use-our-mirror : Create the podman configuration directory] 2026-01-08 00:22:50.633572 | controller | skipping: Conditional result was False 2026-01-08 00:22:50.640228 | 2026-01-08 00:22:50.640307 | TASK [use-our-mirror : Copy the podman configuration] 2026-01-08 00:22:50.654853 | controller | skipping: Conditional result was False 2026-01-08 00:22:50.666664 | 2026-01-08 00:22:50.666795 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2026-01-08 00:22:50.692523 | controller | skipping: Conditional result was False 2026-01-08 00:22:50.703344 | 2026-01-08 00:22:50.703496 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2026-01-08 00:22:50.728446 | controller | skipping: Conditional result was False 2026-01-08 00:22:50.746610 | 2026-01-08 00:22:50.746788 | TASK [Disable Fedora Modular] 2026-01-08 00:22:50.995378 | controller | changed 2026-01-08 00:22:51.004268 | 2026-01-08 00:22:51.004379 | TASK [Enable EPEL] 2026-01-08 00:22:51.019712 | controller | skipping: Conditional result was False 2026-01-08 00:22:51.029904 | 2026-01-08 00:22:51.030115 | TASK [Register the RHEL node] 2026-01-08 00:22:51.588743 | 2026-01-08 00:22:51.589053 | TASK [Show the subscription-manager status] 2026-01-08 00:22:52.175542 | controller | skipping: Conditional result was False 2026-01-08 00:22:52.194865 | 2026-01-08 00:22:52.195142 | TASK [Enable EPEL on RHEL] 2026-01-08 00:22:52.760544 | controller | skipping: Conditional result was False 2026-01-08 00:22:52.774755 | 2026-01-08 00:22:52.775057 | TASK [Install git and tox] 2026-01-08 00:24:11.161864 | controller | changed 2026-01-08 00:24:11.177333 | 2026-01-08 00:24:11.177476 | TASK [include_role : prepare-workspace] 2026-01-08 00:24:11.207464 | controller | ok 2026-01-08 00:24:11.244882 | 2026-01-08 00:24:11.245069 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-01-08 00:24:11.473729 | controller | ok 2026-01-08 00:24:11.486192 | 2026-01-08 00:24:11.486358 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-01-08 00:24:23.727564 | controller | Output suppressed because no_log was given 2026-01-08 00:24:23.743094 | 2026-01-08 00:24:23.743228 | TASK [include_role : prepare-workspace-openshift] 2026-01-08 00:24:23.769102 | controller | skipping: Conditional result was False 2026-01-08 00:24:23.824430 | 2026-01-08 00:24:23.824544 | PLAY [all:!appliance] 2026-01-08 00:24:23.841636 | 2026-01-08 00:24:23.841766 | TASK [Run add-build-sshkey role (RSA)] 2026-01-08 00:24:23.861484 | controller | ok 2026-01-08 00:24:23.878144 | 2026-01-08 00:24:23.878240 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-08 00:24:24.117716 | controller -> localhost | ok 2026-01-08 00:24:24.127952 | 2026-01-08 00:24:24.128167 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-08 00:24:24.156004 | controller | ok 2026-01-08 00:24:24.177203 | controller | included: /var/lib/zuul/builds/9b4ca23afe4b491ab542086e71edb0da/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-08 00:24:24.187458 | 2026-01-08 00:24:24.187585 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-08 00:24:24.834396 | controller -> localhost | Generating public/private rsa key pair. 2026-01-08 00:24:24.834856 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/9b4ca23afe4b491ab542086e71edb0da/work/9b4ca23afe4b491ab542086e71edb0da_id_rsa. 2026-01-08 00:24:24.834925 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/9b4ca23afe4b491ab542086e71edb0da/work/9b4ca23afe4b491ab542086e71edb0da_id_rsa.pub. 2026-01-08 00:24:24.834977 | controller -> localhost | The key fingerprint is: 2026-01-08 00:24:24.835055 | controller -> localhost | SHA256:cF5aNzUTMhLjxB/dOMPJd9o++mogHktXUfBfvgwwzsg zuul-build-sshkey 2026-01-08 00:24:24.835110 | controller -> localhost | The key's randomart image is: 2026-01-08 00:24:24.835155 | controller -> localhost | +---[RSA 2048]----+ 2026-01-08 00:24:24.835198 | controller -> localhost | | .=.o=B* | 2026-01-08 00:24:24.835242 | controller -> localhost | | o.o.=Xo+| 2026-01-08 00:24:24.835285 | controller -> localhost | | . . ++o..Bo| 2026-01-08 00:24:24.835328 | controller -> localhost | | +.++.+o..+| 2026-01-08 00:24:24.835368 | controller -> localhost | | SE o.. .o| 2026-01-08 00:24:24.835429 | controller -> localhost | | + o o.o| 2026-01-08 00:24:24.835479 | controller -> localhost | | o = . .o.| 2026-01-08 00:24:24.835523 | controller -> localhost | | o o | 2026-01-08 00:24:24.835567 | controller -> localhost | | ..o. | 2026-01-08 00:24:24.835615 | controller -> localhost | +----[SHA256]-----+ 2026-01-08 00:24:24.835734 | controller -> localhost | ok: Runtime: 0:00:00.196332 2026-01-08 00:24:24.851565 | 2026-01-08 00:24:24.851749 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-08 00:24:24.892507 | controller | ok 2026-01-08 00:24:24.914566 | controller | included: /var/lib/zuul/builds/9b4ca23afe4b491ab542086e71edb0da/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-08 00:24:24.926978 | 2026-01-08 00:24:24.927143 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-08 00:24:24.952140 | controller | skipping: Conditional result was False 2026-01-08 00:24:24.968417 | 2026-01-08 00:24:24.968610 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-08 00:24:25.443472 | controller | changed 2026-01-08 00:24:25.451976 | 2026-01-08 00:24:25.452181 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-08 00:24:25.685650 | controller | ok 2026-01-08 00:24:25.691193 | 2026-01-08 00:24:25.691260 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-08 00:24:26.317941 | controller | changed 2026-01-08 00:24:26.327684 | 2026-01-08 00:24:26.327865 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-08 00:24:26.979606 | controller | changed 2026-01-08 00:24:26.992456 | 2026-01-08 00:24:26.992637 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-08 00:24:27.030739 | controller | skipping: Conditional result was False 2026-01-08 00:24:27.046423 | 2026-01-08 00:24:27.046598 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-08 00:24:27.546010 | controller -> localhost | changed 2026-01-08 00:24:27.585060 | 2026-01-08 00:24:27.585289 | TASK [add-build-sshkey : Add back temp key] 2026-01-08 00:24:27.987953 | controller -> localhost | Identity added: /var/lib/zuul/builds/9b4ca23afe4b491ab542086e71edb0da/work/9b4ca23afe4b491ab542086e71edb0da_id_rsa (zuul-build-sshkey) 2026-01-08 00:24:27.988271 | controller -> localhost | ok: Runtime: 0:00:00.010194 2026-01-08 00:24:27.995228 | 2026-01-08 00:24:27.995297 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-08 00:24:28.413984 | controller | ok 2026-01-08 00:24:28.427338 | 2026-01-08 00:24:28.427578 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-08 00:24:28.466543 | controller | skipping: Conditional result was False 2026-01-08 00:24:28.482755 | 2026-01-08 00:24:28.482912 | TASK [Run add-build-sshkey role (ECDSA)] 2026-01-08 00:24:28.519926 | controller | ok 2026-01-08 00:24:28.542644 | 2026-01-08 00:24:28.542831 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-08 00:24:28.814631 | controller -> localhost | ok 2026-01-08 00:24:28.821928 | 2026-01-08 00:24:28.822039 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-08 00:24:28.851694 | controller | ok 2026-01-08 00:24:28.862909 | controller | included: /var/lib/zuul/builds/9b4ca23afe4b491ab542086e71edb0da/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-08 00:24:28.868887 | 2026-01-08 00:24:28.868951 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-08 00:24:29.178303 | controller -> localhost | Generating public/private ecdsa key pair. 2026-01-08 00:24:29.178611 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/9b4ca23afe4b491ab542086e71edb0da/work/9b4ca23afe4b491ab542086e71edb0da_id_ecdsa. 2026-01-08 00:24:29.178647 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/9b4ca23afe4b491ab542086e71edb0da/work/9b4ca23afe4b491ab542086e71edb0da_id_ecdsa.pub. 2026-01-08 00:24:29.178680 | controller -> localhost | The key fingerprint is: 2026-01-08 00:24:29.178701 | controller -> localhost | SHA256:7SVAtKR/yNpWWkCsMVXcy+qrJZ0+qPrGsAcriccP6/U zuul-build-sshkey 2026-01-08 00:24:29.178720 | controller -> localhost | The key's randomart image is: 2026-01-08 00:24:29.178739 | controller -> localhost | +---[ECDSA 521]---+ 2026-01-08 00:24:29.178758 | controller -> localhost | | +*o.. | 2026-01-08 00:24:29.178776 | controller -> localhost | | o=... . | 2026-01-08 00:24:29.178793 | controller -> localhost | | .++ . . | 2026-01-08 00:24:29.178810 | controller -> localhost | | .o = o | 2026-01-08 00:24:29.178826 | controller -> localhost | | S *.. | 2026-01-08 00:24:29.178843 | controller -> localhost | | o o B.+ | 2026-01-08 00:24:29.178859 | controller -> localhost | | o...*. =o= | 2026-01-08 00:24:29.178875 | controller -> localhost | |. =+o.+..+o | 2026-01-08 00:24:29.178892 | controller -> localhost | | oooo=E...oo | 2026-01-08 00:24:29.178909 | controller -> localhost | +----[SHA256]-----+ 2026-01-08 00:24:29.178957 | controller -> localhost | ok: Runtime: 0:00:00.012997 2026-01-08 00:24:29.188403 | 2026-01-08 00:24:29.188536 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-08 00:24:29.222033 | controller | ok 2026-01-08 00:24:29.230664 | controller | included: /var/lib/zuul/builds/9b4ca23afe4b491ab542086e71edb0da/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-08 00:24:29.241040 | 2026-01-08 00:24:29.241137 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-08 00:24:29.257183 | controller | skipping: Conditional result was False 2026-01-08 00:24:29.265029 | 2026-01-08 00:24:29.265106 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-08 00:24:29.531495 | controller | changed 2026-01-08 00:24:29.541570 | 2026-01-08 00:24:29.541673 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-08 00:24:29.763371 | controller | ok 2026-01-08 00:24:29.776416 | 2026-01-08 00:24:29.776567 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-08 00:24:30.429195 | controller | changed 2026-01-08 00:24:30.443117 | 2026-01-08 00:24:30.443296 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-08 00:24:31.081366 | controller | changed 2026-01-08 00:24:31.095799 | 2026-01-08 00:24:31.095957 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-08 00:24:31.114490 | controller | skipping: Conditional result was False 2026-01-08 00:24:31.135480 | 2026-01-08 00:24:31.135747 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-08 00:24:31.401083 | controller -> localhost | changed 2026-01-08 00:24:31.428114 | 2026-01-08 00:24:31.428383 | TASK [add-build-sshkey : Add back temp key] 2026-01-08 00:24:31.798284 | controller -> localhost | Identity added: /var/lib/zuul/builds/9b4ca23afe4b491ab542086e71edb0da/work/9b4ca23afe4b491ab542086e71edb0da_id_ecdsa (zuul-build-sshkey) 2026-01-08 00:24:31.798535 | controller -> localhost | ok: Runtime: 0:00:00.011329 2026-01-08 00:24:31.834968 | 2026-01-08 00:24:31.835125 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-08 00:24:32.045293 | controller | ok 2026-01-08 00:24:32.057717 | 2026-01-08 00:24:32.057856 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-08 00:24:32.105285 | controller | skipping: Conditional result was False 2026-01-08 00:24:32.130972 | 2026-01-08 00:24:32.131151 | TASK [include_role : remove-zuul-sshkey] 2026-01-08 00:24:32.157815 | controller | skipping: Conditional result was False 2026-01-08 00:24:32.177606 | 2026-01-08 00:24:32.177786 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-01-08 00:24:32.433908 | controller | ok: "logs" 2026-01-08 00:24:32.434275 | controller | ok: All items complete 2026-01-08 00:24:32.434316 | 2026-01-08 00:24:32.622816 | controller | ok: "artifacts" 2026-01-08 00:24:32.808979 | controller | ok: "docs" 2026-01-08 00:24:32.820485 | 2026-01-08 00:24:32.820688 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-01-08 00:24:33.059736 | controller | changed: "logs" 2026-01-08 00:24:33.240116 | controller | changed: "artifacts" 2026-01-08 00:24:33.411992 | controller | changed: "docs" 2026-01-08 00:24:33.464924 | 2026-01-08 00:24:33.465079 | PLAY RECAP 2026-01-08 00:24:33.465146 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2026-01-08 00:24:33.465184 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-01-08 00:24:33.465212 | 2026-01-08 00:24:33.598026 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-01-08 00:24:33.599180 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-01-08 00:24:34.155969 | 2026-01-08 00:24:34.156114 | PLAY [all] 2026-01-08 00:24:34.177296 | 2026-01-08 00:24:34.177386 | TASK [Install binary dependencies] 2026-01-08 00:24:34.226820 | controller | ok 2026-01-08 00:24:34.246512 | 2026-01-08 00:24:34.246609 | TASK [bindep : Include find tasks] 2026-01-08 00:24:34.298981 | controller | ok 2026-01-08 00:24:34.310856 | controller | included: /var/lib/zuul/builds/9b4ca23afe4b491ab542086e71edb0da/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-01-08 00:24:34.320478 | 2026-01-08 00:24:34.320572 | TASK [bindep : Look for bindep.txt] 2026-01-08 00:24:34.695380 | controller | ok 2026-01-08 00:24:34.709783 | 2026-01-08 00:24:34.709951 | TASK [bindep : Define bindep_file fact] 2026-01-08 00:24:34.738818 | controller | skipping: Conditional result was False 2026-01-08 00:24:34.754762 | 2026-01-08 00:24:34.754943 | TASK [bindep : Look for other-requirements.txt] 2026-01-08 00:24:34.973177 | controller | ok 2026-01-08 00:24:34.980712 | 2026-01-08 00:24:34.980809 | TASK [bindep : Define bindep_file fact] 2026-01-08 00:24:35.011416 | controller | skipping: Conditional result was False 2026-01-08 00:24:35.020318 | 2026-01-08 00:24:35.020438 | TASK [bindep : Look for bindep fallback file] 2026-01-08 00:24:35.056007 | controller | skipping: Conditional result was False 2026-01-08 00:24:35.065427 | 2026-01-08 00:24:35.065554 | TASK [bindep : Define bindep_file fact] 2026-01-08 00:24:35.090552 | controller | skipping: Conditional result was False 2026-01-08 00:24:35.098768 | 2026-01-08 00:24:35.098883 | TASK [bindep : Include bindep tasks] 2026-01-08 00:24:35.123783 | controller | skipping: Conditional result was False 2026-01-08 00:24:35.133371 | 2026-01-08 00:24:35.133503 | TASK [bindep : Include install tasks] 2026-01-08 00:24:35.159748 | controller | skipping: Conditional result was False 2026-01-08 00:24:35.166181 | 2026-01-08 00:24:35.166255 | LOOP [bindep : Include package tasks] 2026-01-08 00:24:35.225747 | 2026-01-08 00:24:35.225963 | TASK [Run test-setup role] 2026-01-08 00:24:35.249802 | controller | ok 2026-01-08 00:24:35.274718 | 2026-01-08 00:24:35.274864 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-01-08 00:24:35.488447 | controller | ok 2026-01-08 00:24:35.496723 | 2026-01-08 00:24:35.496863 | TASK [test-setup : Run tools/test-setup.sh] 2026-01-08 00:24:36.040198 | controller | skipping: Conditional result was False 2026-01-08 00:24:36.077375 | 2026-01-08 00:24:36.077502 | PLAY RECAP 2026-01-08 00:24:36.077561 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-01-08 00:24:36.077610 | 2026-01-08 00:24:36.196201 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-01-08 00:24:36.197191 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-01-08 00:24:36.795842 | 2026-01-08 00:24:36.795992 | PLAY [controller] 2026-01-08 00:24:36.817371 | 2026-01-08 00:24:36.817518 | TASK [Create the /root directory] 2026-01-08 00:26:49.122960 | controller | ERROR 2026-01-08 00:26:49.123461 | controller | { 2026-01-08 00:26:49.123555 | controller | "msg": "Timeout (32s) waiting for privilege escalation prompt: " 2026-01-08 00:26:49.123640 | controller | } failure 2026-01-08 00:26:49.125705 | 2026-01-08 00:26:49.125803 | PLAY RECAP 2026-01-08 00:26:49.125881 | controller | ok: 0 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-01-08 00:26:49.125928 | 2026-01-08 00:26:49.255970 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-01-08 00:26:49.257107 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-01-08 00:26:49.826468 | 2026-01-08 00:26:49.826588 | PLAY [all] 2026-01-08 00:26:49.848069 | 2026-01-08 00:26:49.848206 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-01-08 00:30:19.641486 | controller | changed: non-zero return code 2026-01-08 00:30:19.647572 | 2026-01-08 00:30:19.647652 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-01-08 00:30:19.673738 | controller | skipping: Conditional result was False 2026-01-08 00:30:19.680785 | 2026-01-08 00:30:19.680968 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-01-08 00:30:19.714699 | 2026-01-08 00:30:19.714888 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-01-08 00:30:19.750080 | 2026-01-08 00:30:19.750271 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-01-08 00:30:19.776400 | controller | skipping: Conditional result was False 2026-01-08 00:30:19.784867 | 2026-01-08 00:30:19.784988 | LOOP [fetch-subunit-output : Generate subunit file] 2026-01-08 00:30:19.818805 | 2026-01-08 00:30:19.819033 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-01-08 00:30:19.845304 | controller | skipping: Conditional result was False 2026-01-08 00:30:19.852903 | 2026-01-08 00:30:19.853112 | TASK [fetch-subunit-output : Remove the temporary file] 2026-01-08 00:30:19.869681 | controller | skipping: Conditional result was False 2026-01-08 00:30:19.877741 | 2026-01-08 00:30:19.877913 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-01-08 00:30:19.895277 | controller | skipping: Conditional result was False 2026-01-08 00:30:19.933524 | 2026-01-08 00:30:19.933670 | PLAY RECAP 2026-01-08 00:30:19.933720 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-01-08 00:30:19.933742 | 2026-01-08 00:30:20.088249 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-01-08 00:30:20.089722 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2026-01-08 00:30:20.677505 | 2026-01-08 00:30:20.677623 | PLAY [all:!appliance*] 2026-01-08 00:30:20.704689 | 2026-01-08 00:30:20.704877 | TASK [unregister the node] 2026-01-08 00:30:21.252614 | controller | skipping: Conditional result was False 2026-01-08 00:30:21.265270 | 2026-01-08 00:30:21.265483 | TASK [include_role : fetch-output] 2026-01-08 00:30:21.326773 | controller | ok 2026-01-08 00:30:21.367006 | 2026-01-08 00:30:21.367187 | TASK [fetch-output : Set log path for multiple nodes] 2026-01-08 00:30:21.433880 | controller | skipping: Conditional result was False 2026-01-08 00:30:21.443202 | 2026-01-08 00:30:21.443386 | TASK [fetch-output : Set log path for single node] 2026-01-08 00:30:21.522977 | controller | ok 2026-01-08 00:30:21.537054 | 2026-01-08 00:30:21.537235 | LOOP [fetch-output : Ensure local output dirs] 2026-01-08 00:30:22.001573 | controller -> localhost | ok: "/var/lib/zuul/builds/9b4ca23afe4b491ab542086e71edb0da/work/logs" 2026-01-08 00:30:22.230445 | controller -> localhost | changed: "/var/lib/zuul/builds/9b4ca23afe4b491ab542086e71edb0da/work/artifacts" 2026-01-08 00:30:22.470789 | controller -> localhost | changed: "/var/lib/zuul/builds/9b4ca23afe4b491ab542086e71edb0da/work/docs" 2026-01-08 00:30:22.481835 | 2026-01-08 00:30:22.481957 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-01-08 00:30:23.182864 | controller | ok 2026-01-08 00:30:23.183233 | controller | changed: All items complete 2026-01-08 00:30:23.183274 | 2026-01-08 00:30:23.652590 | controller | changed: .d..t...... ./ 2026-01-08 00:30:24.162907 | controller | changed: .d..t...... ./ 2026-01-08 00:30:24.190659 | 2026-01-08 00:30:24.190795 | TASK [include_role : fetch-output-openshift] 2026-01-08 00:30:24.218894 | controller | skipping: Conditional result was False 2026-01-08 00:30:24.233239 | 2026-01-08 00:30:24.233397 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-01-08 00:30:24.283079 | controller | skipping: Conditional result was False 2026-01-08 00:30:24.295833 | controller | skipping: Conditional result was False 2026-01-08 00:30:24.356823 | 2026-01-08 00:30:24.356927 | PLAY [localhost] 2026-01-08 00:30:24.375153 | 2026-01-08 00:30:24.375239 | TASK [Run Zuul manifest role] 2026-01-08 00:30:24.402074 | localhost | ok 2026-01-08 00:30:24.424338 | 2026-01-08 00:30:24.424490 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-01-08 00:30:24.823506 | localhost | changed 2026-01-08 00:30:24.828894 | 2026-01-08 00:30:24.828993 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-01-08 00:30:24.870054 | localhost | ok 2026-01-08 00:30:24.878808 | 2026-01-08 00:30:24.879274 | TASK [Set zuul-log-path fact] 2026-01-08 00:30:24.900851 | localhost | ok 2026-01-08 00:30:24.916675 | 2026-01-08 00:30:24.916818 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-08 00:30:24.957558 | localhost | ok 2026-01-08 00:30:24.966592 | 2026-01-08 00:30:24.966710 | LOOP [Run upload-logs-swift role] 2026-01-08 00:30:25.014797 | localhost | Output suppressed because no_log was given 2026-01-08 00:30:25.049863 | 2026-01-08 00:30:25.050112 | TASK [Set zuul-log-path fact] 2026-01-08 00:30:25.087474 | localhost | skipping: Conditional result was False 2026-01-08 00:30:25.096890 | 2026-01-08 00:30:25.097040 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2026-01-08 00:30:25.576083 | localhost -> localhost | ok: Runtime: 0:00:00.008476 2026-01-08 00:30:25.623897 | 2026-01-08 00:30:25.624105 | TASK [upload-logs-swift : Upload logs to swift]