2026-03-11 00:14:13.872053 | Job console starting... 2026-03-11 00:14:13.884788 | Updating repositories 2026-03-11 00:14:14.000263 | Preparing job workspace 2026-03-11 00:14:17.765863 | Running Ansible setup... 2026-03-11 00:14:22.553378 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-03-11 00:14:23.198318 | 2026-03-11 00:14:23.198482 | PLAY [localhost] 2026-03-11 00:14:23.207647 | 2026-03-11 00:14:23.207774 | TASK [Gathering Facts] 2026-03-11 00:14:24.298231 | localhost | ok 2026-03-11 00:14:24.312721 | 2026-03-11 00:14:24.312836 | TASK [Setup log path fact] 2026-03-11 00:14:24.331414 | localhost | ok 2026-03-11 00:14:24.345037 | 2026-03-11 00:14:24.345123 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-11 00:14:24.366816 | localhost | ok 2026-03-11 00:14:24.378025 | 2026-03-11 00:14:24.378137 | TASK [emit-job-header : Print job information] 2026-03-11 00:14:24.408985 | # Job Information 2026-03-11 00:14:24.409165 | Ansible Version: 2.15.12 2026-03-11 00:14:24.409207 | Job: ansible-test-sanity-docker-milestone 2026-03-11 00:14:24.409238 | Pipeline: periodic 2026-03-11 00:14:24.409265 | Executor: ze04.softwarefactory-project.io 2026-03-11 00:14:24.409291 | Triggered by: https://github.com/ansible-collections/ansible.network 2026-03-11 00:14:24.409320 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/68d/ansible/68df7f3e05174dce93a8a8d24df40e64/ 2026-03-11 00:14:24.409347 | Event ID: 40713765c1114cc8a875c507b350dc3b 2026-03-11 00:14:24.414431 | 2026-03-11 00:14:24.414514 | LOOP [emit-job-header : Print node information] 2026-03-11 00:14:24.541856 | localhost | ok: 2026-03-11 00:14:24.542061 | localhost | # Node Information 2026-03-11 00:14:24.542089 | localhost | Inventory Hostname: controller 2026-03-11 00:14:24.542110 | localhost | Hostname: np0005643876 2026-03-11 00:14:24.542129 | localhost | Username: zuul 2026-03-11 00:14:24.542153 | localhost | Distro: Fedora 37 2026-03-11 00:14:24.542172 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2026-03-11 00:14:24.542190 | localhost | Region: ca-ymq-1 2026-03-11 00:14:24.542207 | localhost | Label: ansible-fedora-37-1vcpu 2026-03-11 00:14:24.542224 | localhost | Product Name: OpenStack Nova 2026-03-11 00:14:24.542241 | localhost | Interface IP: 199.204.45.235 2026-03-11 00:14:24.557038 | 2026-03-11 00:14:24.557152 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-11 00:14:24.969170 | localhost -> localhost | changed 2026-03-11 00:14:24.975149 | 2026-03-11 00:14:24.975239 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-11 00:14:25.812966 | localhost -> localhost | changed 2026-03-11 00:14:25.865944 | 2026-03-11 00:14:25.866201 | PLAY [all:!appliance*] 2026-03-11 00:14:25.904120 | 2026-03-11 00:14:25.904265 | TASK [include_role : start-zuul-console] 2026-03-11 00:14:25.928425 | controller | ok 2026-03-11 00:14:25.950445 | 2026-03-11 00:14:25.950581 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-11 00:14:26.324844 | controller | ok 2026-03-11 00:14:26.342077 | 2026-03-11 00:14:26.342175 | TASK [use-our-mirror : Retrieve the IP address] 2026-03-11 00:14:27.406583 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2026-03-11 00:14:27.416948 | 2026-03-11 00:14:27.417093 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2026-03-11 00:14:27.959051 | controller | skipping: Conditional result was False 2026-03-11 00:14:27.966036 | 2026-03-11 00:14:27.966131 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2026-03-11 00:14:27.990442 | controller | skipping: Conditional result was False 2026-03-11 00:14:27.998401 | 2026-03-11 00:14:27.998526 | TASK [use-our-mirror : Create the podman configuration directory] 2026-03-11 00:14:28.023139 | controller | skipping: Conditional result was False 2026-03-11 00:14:28.032051 | 2026-03-11 00:14:28.032175 | TASK [use-our-mirror : Copy the podman configuration] 2026-03-11 00:14:28.056397 | controller | skipping: Conditional result was False 2026-03-11 00:14:28.063115 | 2026-03-11 00:14:28.063234 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2026-03-11 00:14:28.077965 | controller | skipping: Conditional result was False 2026-03-11 00:14:28.084704 | 2026-03-11 00:14:28.084804 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2026-03-11 00:14:28.098937 | controller | skipping: Conditional result was False 2026-03-11 00:14:28.119693 | 2026-03-11 00:14:28.119849 | TASK [Disable Fedora Modular] 2026-03-11 00:14:28.374181 | controller | changed 2026-03-11 00:14:28.388479 | 2026-03-11 00:14:28.388669 | TASK [Enable EPEL] 2026-03-11 00:14:28.421196 | controller | skipping: Conditional result was False 2026-03-11 00:14:28.440736 | 2026-03-11 00:14:28.440871 | TASK [Register the RHEL node] 2026-03-11 00:14:29.001528 | 2026-03-11 00:14:29.001906 | TASK [Show the subscription-manager status] 2026-03-11 00:14:29.587761 | controller | skipping: Conditional result was False 2026-03-11 00:14:29.598226 | 2026-03-11 00:14:29.598352 | TASK [Enable EPEL on RHEL] 2026-03-11 00:14:30.148775 | controller | skipping: Conditional result was False 2026-03-11 00:14:30.157011 | 2026-03-11 00:14:30.157130 | TASK [Install git and tox] 2026-03-11 00:15:46.883561 | controller | changed 2026-03-11 00:15:46.895861 | 2026-03-11 00:15:46.895991 | TASK [include_role : prepare-workspace] 2026-03-11 00:15:46.926662 | controller | ok 2026-03-11 00:15:46.951126 | 2026-03-11 00:15:46.951235 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-11 00:15:47.193972 | controller | ok 2026-03-11 00:15:47.213648 | 2026-03-11 00:15:47.213999 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-11 00:16:02.200441 | controller | Output suppressed because no_log was given 2026-03-11 00:16:02.215070 | 2026-03-11 00:16:02.215191 | TASK [include_role : prepare-workspace-openshift] 2026-03-11 00:16:02.231519 | controller | skipping: Conditional result was False 2026-03-11 00:16:02.292556 | 2026-03-11 00:16:02.292644 | PLAY [all:!appliance] 2026-03-11 00:16:02.309863 | 2026-03-11 00:16:02.309946 | TASK [Run add-build-sshkey role (RSA)] 2026-03-11 00:16:02.343465 | controller | ok 2026-03-11 00:16:02.360396 | 2026-03-11 00:16:02.360529 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-11 00:16:02.611199 | controller -> localhost | ok 2026-03-11 00:16:02.618963 | 2026-03-11 00:16:02.619133 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-11 00:16:02.645466 | controller | ok 2026-03-11 00:16:02.667966 | controller | included: /var/lib/zuul/builds/68df7f3e05174dce93a8a8d24df40e64/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-11 00:16:02.677523 | 2026-03-11 00:16:02.677648 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-11 00:16:03.151206 | controller -> localhost | Generating public/private rsa key pair. 2026-03-11 00:16:03.151466 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/68df7f3e05174dce93a8a8d24df40e64/work/68df7f3e05174dce93a8a8d24df40e64_id_rsa. 2026-03-11 00:16:03.151509 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/68df7f3e05174dce93a8a8d24df40e64/work/68df7f3e05174dce93a8a8d24df40e64_id_rsa.pub. 2026-03-11 00:16:03.151541 | controller -> localhost | The key fingerprint is: 2026-03-11 00:16:03.151571 | controller -> localhost | SHA256:SuisDvrd5T+vlZVfbJtkFrWHEd7hse9CCRN9CVbRMvI zuul-build-sshkey 2026-03-11 00:16:03.151598 | controller -> localhost | The key's randomart image is: 2026-03-11 00:16:03.151625 | controller -> localhost | +---[RSA 2048]----+ 2026-03-11 00:16:03.151651 | controller -> localhost | | .+=*=| 2026-03-11 00:16:03.151703 | controller -> localhost | | oo==O| 2026-03-11 00:16:03.151738 | controller -> localhost | | oooOo| 2026-03-11 00:16:03.151766 | controller -> localhost | | . oE++| 2026-03-11 00:16:03.151791 | controller -> localhost | | . . S =+=| 2026-03-11 00:16:03.151826 | controller -> localhost | | o . . ++++| 2026-03-11 00:16:03.151859 | controller -> localhost | |. o . . o .oo| 2026-03-11 00:16:03.151888 | controller -> localhost | |.. o . o .. . | 2026-03-11 00:16:03.151915 | controller -> localhost | |.o+ . . ..o+. | 2026-03-11 00:16:03.151944 | controller -> localhost | +----[SHA256]-----+ 2026-03-11 00:16:03.152011 | controller -> localhost | ok: Runtime: 0:00:00.081660 2026-03-11 00:16:03.161706 | 2026-03-11 00:16:03.161804 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-11 00:16:03.196841 | controller | ok 2026-03-11 00:16:03.212707 | controller | included: /var/lib/zuul/builds/68df7f3e05174dce93a8a8d24df40e64/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-11 00:16:03.224801 | 2026-03-11 00:16:03.224898 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-11 00:16:03.249944 | controller | skipping: Conditional result was False 2026-03-11 00:16:03.258856 | 2026-03-11 00:16:03.259002 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-11 00:16:03.719069 | controller | changed 2026-03-11 00:16:03.728069 | 2026-03-11 00:16:03.728158 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-11 00:16:03.946342 | controller | ok 2026-03-11 00:16:03.957126 | 2026-03-11 00:16:03.957308 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-11 00:16:04.569325 | controller | changed 2026-03-11 00:16:04.575563 | 2026-03-11 00:16:04.575643 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-11 00:16:05.209470 | controller | changed 2026-03-11 00:16:05.216304 | 2026-03-11 00:16:05.216398 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-11 00:16:05.231780 | controller | skipping: Conditional result was False 2026-03-11 00:16:05.240196 | 2026-03-11 00:16:05.240313 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-11 00:16:05.667404 | controller -> localhost | changed 2026-03-11 00:16:05.682542 | 2026-03-11 00:16:05.682913 | TASK [add-build-sshkey : Add back temp key] 2026-03-11 00:16:05.984817 | controller -> localhost | Identity added: /var/lib/zuul/builds/68df7f3e05174dce93a8a8d24df40e64/work/68df7f3e05174dce93a8a8d24df40e64_id_rsa (zuul-build-sshkey) 2026-03-11 00:16:05.985076 | controller -> localhost | ok: Runtime: 0:00:00.007859 2026-03-11 00:16:05.992624 | 2026-03-11 00:16:05.992756 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-11 00:16:06.395473 | controller | ok 2026-03-11 00:16:06.401754 | 2026-03-11 00:16:06.401831 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-11 00:16:06.427130 | controller | skipping: Conditional result was False 2026-03-11 00:16:06.438885 | 2026-03-11 00:16:06.438962 | TASK [Run add-build-sshkey role (ECDSA)] 2026-03-11 00:16:06.459353 | controller | ok 2026-03-11 00:16:06.479348 | 2026-03-11 00:16:06.479474 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-11 00:16:06.738239 | controller -> localhost | ok 2026-03-11 00:16:06.745667 | 2026-03-11 00:16:06.745776 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-11 00:16:06.776443 | controller | ok 2026-03-11 00:16:06.787814 | controller | included: /var/lib/zuul/builds/68df7f3e05174dce93a8a8d24df40e64/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-11 00:16:06.795588 | 2026-03-11 00:16:06.795666 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-11 00:16:07.078104 | controller -> localhost | Generating public/private ecdsa key pair. 2026-03-11 00:16:07.078329 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/68df7f3e05174dce93a8a8d24df40e64/work/68df7f3e05174dce93a8a8d24df40e64_id_ecdsa. 2026-03-11 00:16:07.078360 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/68df7f3e05174dce93a8a8d24df40e64/work/68df7f3e05174dce93a8a8d24df40e64_id_ecdsa.pub. 2026-03-11 00:16:07.078390 | controller -> localhost | The key fingerprint is: 2026-03-11 00:16:07.078411 | controller -> localhost | SHA256:3brmLlQvqYBgahd4xh7UuwxLWgDYr7c9vt2lO9W8QgY zuul-build-sshkey 2026-03-11 00:16:07.078433 | controller -> localhost | The key's randomart image is: 2026-03-11 00:16:07.078454 | controller -> localhost | +---[ECDSA 521]---+ 2026-03-11 00:16:07.078476 | controller -> localhost | |+. . | 2026-03-11 00:16:07.078500 | controller -> localhost | |.... . | 2026-03-11 00:16:07.078521 | controller -> localhost | | =. . | 2026-03-11 00:16:07.078542 | controller -> localhost | | .oX.. .E. | 2026-03-11 00:16:07.078563 | controller -> localhost | | oBo*.. S..+.o | 2026-03-11 00:16:07.078584 | controller -> localhost | |.o.+oo. . o.= o | 2026-03-11 00:16:07.078604 | controller -> localhost | |. .. o o ..=. . | 2026-03-11 00:16:07.078624 | controller -> localhost | | . o.o.o+. . | 2026-03-11 00:16:07.078644 | controller -> localhost | | .oo.=Bo . | 2026-03-11 00:16:07.078664 | controller -> localhost | +----[SHA256]-----+ 2026-03-11 00:16:07.078907 | controller -> localhost | ok: Runtime: 0:00:00.013473 2026-03-11 00:16:07.087118 | 2026-03-11 00:16:07.087222 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-11 00:16:07.117997 | controller | ok 2026-03-11 00:16:07.126772 | controller | included: /var/lib/zuul/builds/68df7f3e05174dce93a8a8d24df40e64/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-11 00:16:07.137020 | 2026-03-11 00:16:07.137139 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-11 00:16:07.161817 | controller | skipping: Conditional result was False 2026-03-11 00:16:07.170353 | 2026-03-11 00:16:07.170478 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-11 00:16:07.459456 | controller | changed 2026-03-11 00:16:07.469766 | 2026-03-11 00:16:07.469902 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-11 00:16:07.712022 | controller | ok 2026-03-11 00:16:07.718090 | 2026-03-11 00:16:07.718167 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-11 00:16:08.373816 | controller | changed 2026-03-11 00:16:08.379572 | 2026-03-11 00:16:08.379640 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-11 00:16:08.990915 | controller | changed 2026-03-11 00:16:08.997759 | 2026-03-11 00:16:08.997863 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-11 00:16:09.014316 | controller | skipping: Conditional result was False 2026-03-11 00:16:09.022633 | 2026-03-11 00:16:09.022767 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-11 00:16:09.334521 | controller -> localhost | changed 2026-03-11 00:16:09.413471 | 2026-03-11 00:16:09.413630 | TASK [add-build-sshkey : Add back temp key] 2026-03-11 00:16:09.715426 | controller -> localhost | Identity added: /var/lib/zuul/builds/68df7f3e05174dce93a8a8d24df40e64/work/68df7f3e05174dce93a8a8d24df40e64_id_ecdsa (zuul-build-sshkey) 2026-03-11 00:16:09.715864 | controller -> localhost | ok: Runtime: 0:00:00.008904 2026-03-11 00:16:09.731595 | 2026-03-11 00:16:09.731784 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-11 00:16:09.945139 | controller | ok 2026-03-11 00:16:09.952012 | 2026-03-11 00:16:09.952126 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-11 00:16:09.977420 | controller | skipping: Conditional result was False 2026-03-11 00:16:09.991371 | 2026-03-11 00:16:09.991487 | TASK [include_role : remove-zuul-sshkey] 2026-03-11 00:16:10.017131 | controller | skipping: Conditional result was False 2026-03-11 00:16:10.027673 | 2026-03-11 00:16:10.027795 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-11 00:16:10.264320 | controller | ok: "logs" 2026-03-11 00:16:10.264666 | controller | ok: All items complete 2026-03-11 00:16:10.264761 | 2026-03-11 00:16:10.478857 | controller | ok: "artifacts" 2026-03-11 00:16:10.673503 | controller | ok: "docs" 2026-03-11 00:16:10.692607 | 2026-03-11 00:16:10.692872 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-11 00:16:10.945313 | controller | changed: "logs" 2026-03-11 00:16:11.143751 | controller | changed: "artifacts" 2026-03-11 00:16:11.342766 | controller | changed: "docs" 2026-03-11 00:16:11.380084 | 2026-03-11 00:16:11.380257 | PLAY RECAP 2026-03-11 00:16:11.380310 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2026-03-11 00:16:11.380337 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-11 00:16:11.380356 | 2026-03-11 00:16:11.558324 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-03-11 00:16:11.559963 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-03-11 00:16:12.164550 | 2026-03-11 00:16:12.164698 | PLAY [all] 2026-03-11 00:16:12.192548 | 2026-03-11 00:16:12.192716 | TASK [Install binary dependencies] 2026-03-11 00:16:12.244714 | controller | ok 2026-03-11 00:16:12.271743 | 2026-03-11 00:16:12.271890 | TASK [bindep : Include find tasks] 2026-03-11 00:16:12.302646 | controller | ok 2026-03-11 00:16:12.314484 | controller | included: /var/lib/zuul/builds/68df7f3e05174dce93a8a8d24df40e64/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-03-11 00:16:12.321560 | 2026-03-11 00:16:12.321642 | TASK [bindep : Look for bindep.txt] 2026-03-11 00:16:12.730359 | controller | ok 2026-03-11 00:16:12.736505 | 2026-03-11 00:16:12.736576 | TASK [bindep : Define bindep_file fact] 2026-03-11 00:16:12.750386 | controller | skipping: Conditional result was False 2026-03-11 00:16:12.759272 | 2026-03-11 00:16:12.759376 | TASK [bindep : Look for other-requirements.txt] 2026-03-11 00:16:12.974558 | controller | ok 2026-03-11 00:16:12.992452 | 2026-03-11 00:16:12.992734 | TASK [bindep : Define bindep_file fact] 2026-03-11 00:16:13.019235 | controller | skipping: Conditional result was False 2026-03-11 00:16:13.034464 | 2026-03-11 00:16:13.034633 | TASK [bindep : Look for bindep fallback file] 2026-03-11 00:16:13.072660 | controller | skipping: Conditional result was False 2026-03-11 00:16:13.081045 | 2026-03-11 00:16:13.081166 | TASK [bindep : Define bindep_file fact] 2026-03-11 00:16:13.106951 | controller | skipping: Conditional result was False 2026-03-11 00:16:13.117496 | 2026-03-11 00:16:13.117646 | TASK [bindep : Include bindep tasks] 2026-03-11 00:16:13.144613 | controller | skipping: Conditional result was False 2026-03-11 00:16:13.155023 | 2026-03-11 00:16:13.155178 | TASK [bindep : Include install tasks] 2026-03-11 00:16:13.182305 | controller | skipping: Conditional result was False 2026-03-11 00:16:13.192262 | 2026-03-11 00:16:13.192403 | LOOP [bindep : Include package tasks] 2026-03-11 00:16:13.259548 | 2026-03-11 00:16:13.259744 | TASK [Run test-setup role] 2026-03-11 00:16:13.280120 | controller | ok 2026-03-11 00:16:13.299111 | 2026-03-11 00:16:13.299212 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-03-11 00:16:13.522479 | controller | ok 2026-03-11 00:16:13.540296 | 2026-03-11 00:16:13.540516 | TASK [test-setup : Run tools/test-setup.sh] 2026-03-11 00:16:43.610056 | [Zuul] Log Stream did not terminate 2026-03-11 00:16:43.610268 | controller | skipping: Conditional result was False 2026-03-11 00:16:43.649036 | 2026-03-11 00:16:43.649219 | PLAY RECAP 2026-03-11 00:16:43.649282 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-03-11 00:16:43.649314 | 2026-03-11 00:16:43.818130 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-03-11 00:16:43.819451 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-03-11 00:16:44.455329 | 2026-03-11 00:16:44.455466 | PLAY [controller] 2026-03-11 00:16:44.477970 | 2026-03-11 00:16:44.478094 | TASK [Create the /root directory] 2026-03-11 00:18:56.783754 | controller | ERROR 2026-03-11 00:18:56.783996 | controller | { 2026-03-11 00:18:56.784039 | controller | "msg": "Timeout (32s) waiting for privilege escalation prompt: " 2026-03-11 00:18:56.784068 | controller | } failure 2026-03-11 00:18:56.786819 | 2026-03-11 00:18:56.786878 | PLAY RECAP 2026-03-11 00:18:56.786920 | controller | ok: 0 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-03-11 00:18:56.786942 | 2026-03-11 00:18:56.945473 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-03-11 00:18:56.947641 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-11 00:18:57.650513 | 2026-03-11 00:18:57.650654 | PLAY [all] 2026-03-11 00:18:57.675090 | 2026-03-11 00:18:57.675247 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-03-11 00:21:51.812327 | controller | changed: non-zero return code 2026-03-11 00:21:51.827386 | 2026-03-11 00:21:51.827615 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-03-11 00:21:51.857261 | controller | skipping: Conditional result was False 2026-03-11 00:21:51.877837 | 2026-03-11 00:21:51.878113 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-03-11 00:21:51.934715 | 2026-03-11 00:21:51.935032 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-03-11 00:21:51.983026 | 2026-03-11 00:21:51.983406 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-03-11 00:21:52.012823 | controller | skipping: Conditional result was False 2026-03-11 00:21:52.024327 | 2026-03-11 00:21:52.024470 | LOOP [fetch-subunit-output : Generate subunit file] 2026-03-11 00:21:52.061363 | 2026-03-11 00:21:52.061606 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-03-11 00:21:52.088416 | controller | skipping: Conditional result was False 2026-03-11 00:21:52.099233 | 2026-03-11 00:21:52.099355 | TASK [fetch-subunit-output : Remove the temporary file] 2026-03-11 00:21:52.126102 | controller | skipping: Conditional result was False 2026-03-11 00:21:52.139840 | 2026-03-11 00:21:52.140037 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-03-11 00:21:52.167416 | controller | skipping: Conditional result was False 2026-03-11 00:21:52.211866 | 2026-03-11 00:21:52.212060 | PLAY RECAP 2026-03-11 00:21:52.212117 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-03-11 00:21:52.212139 | 2026-03-11 00:21:52.406474 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-03-11 00:21:52.407852 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2026-03-11 00:21:53.047500 | 2026-03-11 00:21:53.047765 | PLAY [all:!appliance*] 2026-03-11 00:21:53.072012 | 2026-03-11 00:21:53.072211 | TASK [unregister the node] 2026-03-11 00:21:53.605883 | controller | skipping: Conditional result was False 2026-03-11 00:21:53.618360 | 2026-03-11 00:21:53.618717 | TASK [include_role : fetch-output] 2026-03-11 00:21:53.652040 | controller | ok 2026-03-11 00:21:53.684539 | 2026-03-11 00:21:53.684748 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-11 00:21:53.751858 | controller | skipping: Conditional result was False 2026-03-11 00:21:53.763332 | 2026-03-11 00:21:53.763553 | TASK [fetch-output : Set log path for single node] 2026-03-11 00:21:53.807347 | controller | ok 2026-03-11 00:21:53.813404 | 2026-03-11 00:21:53.813496 | LOOP [fetch-output : Ensure local output dirs] 2026-03-11 00:21:54.284775 | controller -> localhost | ok: "/var/lib/zuul/builds/68df7f3e05174dce93a8a8d24df40e64/work/logs" 2026-03-11 00:21:54.549955 | controller -> localhost | changed: "/var/lib/zuul/builds/68df7f3e05174dce93a8a8d24df40e64/work/artifacts" 2026-03-11 00:21:54.784458 | controller -> localhost | changed: "/var/lib/zuul/builds/68df7f3e05174dce93a8a8d24df40e64/work/docs" 2026-03-11 00:21:54.800812 | 2026-03-11 00:21:54.800922 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-11 00:21:55.570405 | controller | changed: .d..t...... ./ 2026-03-11 00:21:55.570886 | controller | changed: All items complete 2026-03-11 00:21:55.570940 | 2026-03-11 00:21:56.093895 | controller | changed: .d..t...... ./ 2026-03-11 00:21:56.600284 | controller | changed: .d..t...... ./ 2026-03-11 00:21:56.624072 | 2026-03-11 00:21:56.624386 | TASK [include_role : fetch-output-openshift] 2026-03-11 00:21:56.652830 | controller | skipping: Conditional result was False 2026-03-11 00:21:56.664498 | 2026-03-11 00:21:56.664624 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-11 00:21:56.701875 | controller | skipping: Conditional result was False 2026-03-11 00:21:56.711559 | controller | skipping: Conditional result was False 2026-03-11 00:21:56.746169 | 2026-03-11 00:21:56.746321 | PLAY [localhost] 2026-03-11 00:21:56.759201 | 2026-03-11 00:21:56.759338 | TASK [Run Zuul manifest role] 2026-03-11 00:21:56.778510 | localhost | ok 2026-03-11 00:21:56.806445 | 2026-03-11 00:21:56.806767 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-11 00:21:57.370935 | localhost | changed 2026-03-11 00:21:57.378637 | 2026-03-11 00:21:57.378767 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-11 00:21:57.422624 | localhost | ok 2026-03-11 00:21:57.435212 | 2026-03-11 00:21:57.435322 | TASK [Set zuul-log-path fact] 2026-03-11 00:21:57.457745 | localhost | ok 2026-03-11 00:21:57.481517 | 2026-03-11 00:21:57.481625 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-11 00:21:57.531185 | localhost | ok 2026-03-11 00:21:57.550655 | 2026-03-11 00:21:57.550854 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)] 2026-03-11 00:21:57.580074 | localhost | ok: 2026-03-11 00:21:57.580262 | localhost | { 2026-03-11 00:21:57.580287 | localhost | "auth": { 2026-03-11 00:21:57.580305 | localhost | "password": "IonWCwcuOFib&&<}wp^:[2G/", 2026-03-11 00:21:57.580322 | localhost | "username": "9LF91O0RK7JU" 2026-03-11 00:21:57.580341 | localhost | }, 2026-03-11 00:21:57.580357 | localhost | "profile": "rackspace", 2026-03-11 00:21:57.580373 | localhost | "region_name": "ORD" 2026-03-11 00:21:57.580389 | localhost | } 2026-03-11 00:21:57.580416 | 2026-03-11 00:21:57.594138 | 2026-03-11 00:21:57.594279 | TASK [Run upload-logs-failover role (S3 then Swift)] 2026-03-11 00:21:57.614096 | localhost | Output suppressed because no_log was given 2026-03-11 00:21:57.627924 | 2026-03-11 00:21:57.628072 | TASK [upload-logs-failover : Initialize control vars] 2026-03-11 00:21:57.658100 | localhost | ok 2026-03-11 00:21:57.664507 | 2026-03-11 00:21:57.664595 | LOOP [upload-logs-failover : Perform log upload] 2026-03-11 00:21:57.775417 | localhost | Output suppressed because no_log was given 2026-03-11 00:21:57.790778 | localhost | included: /var/lib/zuul/builds/68df7f3e05174dce93a8a8d24df40e64/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml 2026-03-11 00:21:57.808973 | 2026-03-11 00:21:57.809170 | LOOP [upload-logs-failover : Unpack vars for swift upload] 2026-03-11 00:21:57.920189 | localhost | Output suppressed because no_log was given 2026-03-11 00:21:57.926786 | 2026-03-11 00:21:57.926896 | TASK [Upload logs to swift] 2026-03-11 00:21:57.958876 | localhost | ok 2026-03-11 00:21:58.005845 | 2026-03-11 00:21:58.005994 | TASK [Set zuul-log-path fact] 2026-03-11 00:21:58.051712 | localhost | skipping: Conditional result was False 2026-03-11 00:21:58.057624 | 2026-03-11 00:21:58.057705 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2026-03-11 00:21:58.460639 | localhost -> localhost | ok: Runtime: 0:00:00.007844 2026-03-11 00:21:58.467702 | 2026-03-11 00:21:58.467812 | TASK [upload-logs-swift : Upload logs to swift]