2026-03-04 00:22:39.323392 | Job console starting...
2026-03-04 00:22:39.333776 | Updating repositories
2026-03-04 00:22:39.467943 | Preparing job workspace
2026-03-04 00:22:43.464592 | Running Ansible setup...
2026-03-04 00:22:47.887858 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2026-03-04 00:22:48.498447 | 
2026-03-04 00:22:48.498579 | PLAY [localhost]
2026-03-04 00:22:48.507632 | 
2026-03-04 00:22:48.507731 | TASK [Gathering Facts]
2026-03-04 00:22:49.544601 | localhost | ok
2026-03-04 00:22:49.563639 | 
2026-03-04 00:22:49.563762 | TASK [Setup log path fact]
2026-03-04 00:22:49.588393 | localhost | ok
2026-03-04 00:22:49.611373 | 
2026-03-04 00:22:49.611518 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-04 00:22:49.642723 | localhost | ok
2026-03-04 00:22:49.655160 | 
2026-03-04 00:22:49.655305 | TASK [emit-job-header : Print job information]
2026-03-04 00:22:49.697929 | # Job Information
2026-03-04 00:22:49.698163 | Ansible Version: 2.15.12
2026-03-04 00:22:49.698230 | Job: ansible-test-sanity-docker-milestone
2026-03-04 00:22:49.698267 | Pipeline: periodic
2026-03-04 00:22:49.698296 | Executor: ze01.softwarefactory-project.io
2026-03-04 00:22:49.698323 | Triggered by: https://github.com/ansible-collections/ansible.network
2026-03-04 00:22:49.698355 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/856/ansible/856db99c032343c09b627721dd4f54ec/
2026-03-04 00:22:49.698382 | Event ID: 8d080478937447648ab6231966323d70
2026-03-04 00:22:49.703974 | 
2026-03-04 00:22:49.704094 | LOOP [emit-job-header : Print node information]
2026-03-04 00:22:49.816295 | localhost | ok:
2026-03-04 00:22:49.816548 | localhost | # Node Information
2026-03-04 00:22:49.816587 | localhost | Inventory Hostname: controller
2026-03-04 00:22:49.816616 | localhost | Hostname: np0005636989
2026-03-04 00:22:49.816644 | localhost | Username: zuul
2026-03-04 00:22:49.816680 | localhost | Distro: Fedora 37
2026-03-04 00:22:49.816710 | localhost | Provider: ansible-vexxhost-ca-ymq-1
2026-03-04 00:22:49.816736 | localhost | Region: ca-ymq-1
2026-03-04 00:22:49.816762 | localhost | Label: ansible-fedora-37-1vcpu
2026-03-04 00:22:49.816787 | localhost | Product Name: OpenStack Nova
2026-03-04 00:22:49.816813 | localhost | Interface IP: 162.253.55.209
2026-03-04 00:22:49.834044 | 
2026-03-04 00:22:49.834199 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-03-04 00:22:50.236764 | localhost -> localhost | changed
2026-03-04 00:22:50.243674 | 
2026-03-04 00:22:50.243766 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-03-04 00:22:51.158445 | localhost -> localhost | changed
2026-03-04 00:22:51.187074 | 
2026-03-04 00:22:51.187175 | PLAY [all:!appliance*]
2026-03-04 00:22:51.211404 | 
2026-03-04 00:22:51.211556 | TASK [include_role : start-zuul-console]
2026-03-04 00:22:51.236648 | controller | ok
2026-03-04 00:22:51.257875 | 
2026-03-04 00:22:51.258051 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-03-04 00:22:51.658763 | controller | ok
2026-03-04 00:22:51.673788 | 
2026-03-04 00:22:51.673937 | TASK [use-our-mirror : Retrieve the IP address]
2026-03-04 00:22:52.587890 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found
2026-03-04 00:22:52.597997 | 
2026-03-04 00:22:52.598120 | TASK [use-our-mirror : Ensure the registry service is running on the mirror]
2026-03-04 00:22:53.140703 | controller | skipping: Conditional result was False
2026-03-04 00:22:53.159627 | 
2026-03-04 00:22:53.159827 | TASK [use-our-mirror : Write the IP in /etc/hosts]
2026-03-04 00:22:53.187660 | controller | skipping: Conditional result was False
2026-03-04 00:22:53.198268 | 
2026-03-04 00:22:53.198418 | TASK [use-our-mirror : Create the podman configuration directory]
2026-03-04 00:22:53.224626 | controller | skipping: Conditional result was False
2026-03-04 00:22:53.234227 | 
2026-03-04 00:22:53.234387 | TASK [use-our-mirror : Copy the podman configuration]
2026-03-04 00:22:53.260479 | controller | skipping: Conditional result was False
2026-03-04 00:22:53.270946 | 
2026-03-04 00:22:53.271195 | TASK [use-our-mirror : Copy the Yum configuration (main)]
2026-03-04 00:22:53.298236 | controller | skipping: Conditional result was False
2026-03-04 00:22:53.309351 | 
2026-03-04 00:22:53.309545 | TASK [use-our-mirror : Copy the Yum configuration (update)]
2026-03-04 00:22:53.335681 | controller | skipping: Conditional result was False
2026-03-04 00:22:53.355068 | 
2026-03-04 00:22:53.355227 | TASK [Disable Fedora Modular]
2026-03-04 00:22:53.605448 | controller | changed
2026-03-04 00:22:53.614434 | 
2026-03-04 00:22:53.614555 | TASK [Enable EPEL]
2026-03-04 00:22:53.640154 | controller | skipping: Conditional result was False
2026-03-04 00:22:53.650068 | 
2026-03-04 00:22:53.650219 | TASK [Register the RHEL node]
2026-03-04 00:22:54.210082 | 
2026-03-04 00:22:54.210382 | TASK [Show the subscription-manager status]
2026-03-04 00:22:54.808360 | controller | skipping: Conditional result was False
2026-03-04 00:22:54.815820 | 
2026-03-04 00:22:54.815940 | TASK [Enable EPEL on RHEL]
2026-03-04 00:22:55.351436 | controller | skipping: Conditional result was False
2026-03-04 00:22:55.366311 | 
2026-03-04 00:22:55.366477 | TASK [Install git and tox]
2026-03-04 00:24:16.267036 | controller | changed
2026-03-04 00:24:16.279867 | 
2026-03-04 00:24:16.280034 | TASK [include_role : prepare-workspace]
2026-03-04 00:24:16.302475 | controller | ok
2026-03-04 00:24:16.325296 | 
2026-03-04 00:24:16.325427 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-03-04 00:24:16.557912 | controller | ok
2026-03-04 00:24:16.572202 | 
2026-03-04 00:24:16.572343 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-03-04 00:24:28.933070 | controller | Output suppressed because no_log was given
2026-03-04 00:24:28.944751 | 
2026-03-04 00:24:28.944847 | TASK [include_role : prepare-workspace-openshift]
2026-03-04 00:24:28.961986 | controller | skipping: Conditional result was False
2026-03-04 00:24:28.988701 | 
2026-03-04 00:24:28.988876 | PLAY [all:!appliance]
2026-03-04 00:24:29.007112 | 
2026-03-04 00:24:29.007216 | TASK [Run add-build-sshkey role (RSA)]
2026-03-04 00:24:29.038159 | controller | ok
2026-03-04 00:24:29.055858 | 
2026-03-04 00:24:29.055978 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-03-04 00:24:29.318402 | controller -> localhost | ok
2026-03-04 00:24:29.328377 | 
2026-03-04 00:24:29.328553 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-03-04 00:24:29.353080 | controller | ok
2026-03-04 00:24:29.374408 | controller | included: /var/lib/zuul/builds/856db99c032343c09b627721dd4f54ec/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-03-04 00:24:29.383637 | 
2026-03-04 00:24:29.383775 | TASK [add-build-sshkey : Create Temp SSH key]
2026-03-04 00:24:29.900684 | controller -> localhost | Generating public/private rsa key pair.
2026-03-04 00:24:29.900931 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/856db99c032343c09b627721dd4f54ec/work/856db99c032343c09b627721dd4f54ec_id_rsa.
2026-03-04 00:24:29.900970 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/856db99c032343c09b627721dd4f54ec/work/856db99c032343c09b627721dd4f54ec_id_rsa.pub.
2026-03-04 00:24:29.900993 | controller -> localhost | The key fingerprint is:
2026-03-04 00:24:29.901030 | controller -> localhost | SHA256:70rUO8JnxpRT5xKpjsCi3RoY44BxIHCsgB4+emJJYLM zuul-build-sshkey
2026-03-04 00:24:29.901057 | controller -> localhost | The key's randomart image is:
2026-03-04 00:24:29.901077 | controller -> localhost | +---[RSA 2048]----+
2026-03-04 00:24:29.901095 | controller -> localhost | |*..              |
2026-03-04 00:24:29.901114 | controller -> localhost | |=*.          .   |
2026-03-04 00:24:29.901131 | controller -> localhost | |B.=         + .  |
2026-03-04 00:24:29.901149 | controller -> localhost | |oE   .   . + +   |
2026-03-04 00:24:29.901166 | controller -> localhost | |= = . o S * . .  |
2026-03-04 00:24:29.901195 | controller -> localhost | |o=.* o + * o .   |
2026-03-04 00:24:29.901217 | controller -> localhost | |.o+ o . = X      |
2026-03-04 00:24:29.901237 | controller -> localhost | |     o . * .     |
2026-03-04 00:24:29.901255 | controller -> localhost | |    .   ...      |
2026-03-04 00:24:29.901277 | controller -> localhost | +----[SHA256]-----+
2026-03-04 00:24:29.901327 | controller -> localhost | ok: Runtime: 0:00:00.126343
2026-03-04 00:24:29.910134 | 
2026-03-04 00:24:29.910254 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-03-04 00:24:29.941358 | controller | ok
2026-03-04 00:24:29.957663 | controller | included: /var/lib/zuul/builds/856db99c032343c09b627721dd4f54ec/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-03-04 00:24:29.973897 | 
2026-03-04 00:24:29.974109 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-03-04 00:24:30.000518 | controller | skipping: Conditional result was False
2026-03-04 00:24:30.007654 | 
2026-03-04 00:24:30.007777 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-03-04 00:24:30.448045 | controller | changed
2026-03-04 00:24:30.455256 | 
2026-03-04 00:24:30.455368 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-03-04 00:24:30.680770 | controller | ok
2026-03-04 00:24:30.697307 | 
2026-03-04 00:24:30.697508 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-03-04 00:24:31.315096 | controller | changed
2026-03-04 00:24:31.325125 | 
2026-03-04 00:24:31.325221 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-03-04 00:24:31.941345 | controller | changed
2026-03-04 00:24:31.950658 | 
2026-03-04 00:24:31.950880 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-03-04 00:24:31.979291 | controller | skipping: Conditional result was False
2026-03-04 00:24:31.991793 | 
2026-03-04 00:24:31.992097 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-03-04 00:24:32.396854 | controller -> localhost | changed
2026-03-04 00:24:32.410905 | 
2026-03-04 00:24:32.411140 | TASK [add-build-sshkey : Add back temp key]
2026-03-04 00:24:32.681949 | controller -> localhost | Identity added: /var/lib/zuul/builds/856db99c032343c09b627721dd4f54ec/work/856db99c032343c09b627721dd4f54ec_id_rsa (zuul-build-sshkey)
2026-03-04 00:24:32.682371 | controller -> localhost | ok: Runtime: 0:00:00.013280
2026-03-04 00:24:32.696199 | 
2026-03-04 00:24:32.696390 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-03-04 00:24:33.059926 | controller | ok
2026-03-04 00:24:33.066788 | 
2026-03-04 00:24:33.066952 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-03-04 00:24:33.114840 | controller | skipping: Conditional result was False
2026-03-04 00:24:33.134314 | 
2026-03-04 00:24:33.134545 | TASK [Run add-build-sshkey role (ECDSA)]
2026-03-04 00:24:33.170085 | controller | ok
2026-03-04 00:24:33.189247 | 
2026-03-04 00:24:33.189453 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-03-04 00:24:33.451313 | controller -> localhost | ok
2026-03-04 00:24:33.461730 | 
2026-03-04 00:24:33.461833 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-03-04 00:24:33.496661 | controller | ok
2026-03-04 00:24:33.513096 | controller | included: /var/lib/zuul/builds/856db99c032343c09b627721dd4f54ec/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-03-04 00:24:33.522314 | 
2026-03-04 00:24:33.522420 | TASK [add-build-sshkey : Create Temp SSH key]
2026-03-04 00:24:33.793455 | controller -> localhost | Generating public/private ecdsa key pair.
2026-03-04 00:24:33.793706 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/856db99c032343c09b627721dd4f54ec/work/856db99c032343c09b627721dd4f54ec_id_ecdsa.
2026-03-04 00:24:33.793736 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/856db99c032343c09b627721dd4f54ec/work/856db99c032343c09b627721dd4f54ec_id_ecdsa.pub.
2026-03-04 00:24:33.793765 | controller -> localhost | The key fingerprint is:
2026-03-04 00:24:33.793785 | controller -> localhost | SHA256:FenDQuD/i/N0Gsk7I+X9l2TtpVAk4sdC9Y0wopAQDxU zuul-build-sshkey
2026-03-04 00:24:33.793805 | controller -> localhost | The key's randomart image is:
2026-03-04 00:24:33.793826 | controller -> localhost | +---[ECDSA 521]---+
2026-03-04 00:24:33.793844 | controller -> localhost | |    ++E+  oo+    |
2026-03-04 00:24:33.793862 | controller -> localhost | |     +....+o.+.o |
2026-03-04 00:24:33.793879 | controller -> localhost | |      o..=.o oo .|
2026-03-04 00:24:33.793896 | controller -> localhost | |       ...* o .  |
2026-03-04 00:24:33.793913 | controller -> localhost | |        S. + .  .|
2026-03-04 00:24:33.793929 | controller -> localhost | |         o...  oo|
2026-03-04 00:24:33.793946 | controller -> localhost | |         o*...ooo|
2026-03-04 00:24:33.793962 | controller -> localhost | |        oo+*. ..o|
2026-03-04 00:24:33.793978 | controller -> localhost | |        .+=o ... |
2026-03-04 00:24:33.793995 | controller -> localhost | +----[SHA256]-----+
2026-03-04 00:24:33.794070 | controller -> localhost | ok: Runtime: 0:00:00.008897
2026-03-04 00:24:33.800978 | 
2026-03-04 00:24:33.801124 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-03-04 00:24:33.830223 | controller | ok
2026-03-04 00:24:33.837778 | controller | included: /var/lib/zuul/builds/856db99c032343c09b627721dd4f54ec/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-03-04 00:24:33.848242 | 
2026-03-04 00:24:33.848357 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-03-04 00:24:33.883164 | controller | skipping: Conditional result was False
2026-03-04 00:24:33.892715 | 
2026-03-04 00:24:33.892813 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-03-04 00:24:34.170862 | controller | changed
2026-03-04 00:24:34.178623 | 
2026-03-04 00:24:34.178716 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-03-04 00:24:34.405280 | controller | ok
2026-03-04 00:24:34.414401 | 
2026-03-04 00:24:34.414514 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-03-04 00:24:35.039101 | controller | changed
2026-03-04 00:24:35.045312 | 
2026-03-04 00:24:35.045422 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-03-04 00:24:35.641691 | controller | changed
2026-03-04 00:24:35.657846 | 
2026-03-04 00:24:35.658060 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-03-04 00:24:35.675794 | controller | skipping: Conditional result was False
2026-03-04 00:24:35.733439 | 
2026-03-04 00:24:35.733588 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-03-04 00:24:36.067056 | controller -> localhost | changed
2026-03-04 00:24:36.081996 | 
2026-03-04 00:24:36.082148 | TASK [add-build-sshkey : Add back temp key]
2026-03-04 00:24:36.372636 | controller -> localhost | Identity added: /var/lib/zuul/builds/856db99c032343c09b627721dd4f54ec/work/856db99c032343c09b627721dd4f54ec_id_ecdsa (zuul-build-sshkey)
2026-03-04 00:24:36.372934 | controller -> localhost | ok: Runtime: 0:00:00.009084
2026-03-04 00:24:36.382568 | 
2026-03-04 00:24:36.382711 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-03-04 00:24:36.594749 | controller | ok
2026-03-04 00:24:36.611852 | 
2026-03-04 00:24:36.612089 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-03-04 00:24:36.639178 | controller | skipping: Conditional result was False
2026-03-04 00:24:36.669178 | 
2026-03-04 00:24:36.669372 | TASK [include_role : remove-zuul-sshkey]
2026-03-04 00:24:36.696143 | controller | skipping: Conditional result was False
2026-03-04 00:24:36.702733 | 
2026-03-04 00:24:36.702809 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-03-04 00:24:36.926538 | controller | ok: "logs"
2026-03-04 00:24:36.926858 | controller | ok: All items complete
2026-03-04 00:24:36.926897 | 
2026-03-04 00:24:37.123396 | controller | ok: "artifacts"
2026-03-04 00:24:37.311758 | controller | ok: "docs"
2026-03-04 00:24:37.327891 | 
2026-03-04 00:24:37.328087 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-03-04 00:24:37.563169 | controller | changed: "logs"
2026-03-04 00:24:37.758676 | controller | changed: "artifacts"
2026-03-04 00:24:37.944324 | controller | changed: "docs"
2026-03-04 00:24:38.009772 | 
2026-03-04 00:24:38.009932 | PLAY RECAP
2026-03-04 00:24:38.010043 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0
2026-03-04 00:24:38.010110 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-04 00:24:38.010152 | 
2026-03-04 00:24:38.148350 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2026-03-04 00:24:38.149496 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2026-03-04 00:24:38.778265 | 
2026-03-04 00:24:38.778456 | PLAY [all]
2026-03-04 00:24:38.802997 | 
2026-03-04 00:24:38.803157 | TASK [Install binary dependencies]
2026-03-04 00:24:38.892493 | controller | ok
2026-03-04 00:24:38.930260 | 
2026-03-04 00:24:38.930448 | TASK [bindep : Include find tasks]
2026-03-04 00:24:38.968431 | controller | ok
2026-03-04 00:24:38.983872 | controller | included: /var/lib/zuul/builds/856db99c032343c09b627721dd4f54ec/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml
2026-03-04 00:24:38.994095 | 
2026-03-04 00:24:38.994263 | TASK [bindep : Look for bindep.txt]
2026-03-04 00:24:39.367318 | controller | ok
2026-03-04 00:24:39.375569 | 
2026-03-04 00:24:39.375671 | TASK [bindep : Define bindep_file fact]
2026-03-04 00:24:39.400512 | controller | skipping: Conditional result was False
2026-03-04 00:24:39.410067 | 
2026-03-04 00:24:39.410184 | TASK [bindep : Look for other-requirements.txt]
2026-03-04 00:24:39.615037 | controller | ok
2026-03-04 00:24:39.620542 | 
2026-03-04 00:24:39.620620 | TASK [bindep : Define bindep_file fact]
2026-03-04 00:24:39.644756 | controller | skipping: Conditional result was False
2026-03-04 00:24:39.653917 | 
2026-03-04 00:24:39.654048 | TASK [bindep : Look for bindep fallback file]
2026-03-04 00:24:39.679104 | controller | skipping: Conditional result was False
2026-03-04 00:24:39.689345 | 
2026-03-04 00:24:39.689502 | TASK [bindep : Define bindep_file fact]
2026-03-04 00:24:39.714944 | controller | skipping: Conditional result was False
2026-03-04 00:24:39.724153 | 
2026-03-04 00:24:39.724288 | TASK [bindep : Include bindep tasks]
2026-03-04 00:24:39.749240 | controller | skipping: Conditional result was False
2026-03-04 00:24:39.755398 | 
2026-03-04 00:24:39.755491 | TASK [bindep : Include install tasks]
2026-03-04 00:24:39.779431 | controller | skipping: Conditional result was False
2026-03-04 00:24:39.785621 | 
2026-03-04 00:24:39.785701 | LOOP [bindep : Include package tasks]
2026-03-04 00:24:39.845997 | 
2026-03-04 00:24:39.846206 | TASK [Run test-setup role]
2026-03-04 00:24:39.867217 | controller | ok
2026-03-04 00:24:39.893304 | 
2026-03-04 00:24:39.893454 | TASK [test-setup : Check if project's tools/test-setup.sh exists]
2026-03-04 00:24:40.088677 | controller | ok
2026-03-04 00:24:40.096585 | 
2026-03-04 00:24:40.096744 | TASK [test-setup : Run tools/test-setup.sh]
2026-03-04 00:25:10.145221 | [Zuul] Log Stream did not terminate
2026-03-04 00:25:10.145566 | controller | skipping: Conditional result was False
2026-03-04 00:25:10.186393 | 
2026-03-04 00:25:10.186560 | PLAY RECAP
2026-03-04 00:25:10.186618 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2026-03-04 00:25:10.186648 | 
2026-03-04 00:25:10.304551 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2026-03-04 00:25:10.305555 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master]
2026-03-04 00:25:10.980248 | 
2026-03-04 00:25:10.980398 | PLAY [controller]
2026-03-04 00:25:11.003702 | 
2026-03-04 00:25:11.003850 | TASK [Create the /root directory]
2026-03-04 00:27:23.300980 | controller | ERROR
2026-03-04 00:27:23.301276 | controller | {
2026-03-04 00:27:23.301335 | controller |   "msg": "Timeout (32s) waiting for privilege escalation prompt: "
2026-03-04 00:27:23.301378 | controller | }
failure
2026-03-04 00:27:23.302746 | 
2026-03-04 00:27:23.302817 | PLAY RECAP
2026-03-04 00:27:23.302874 | controller | ok: 0 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-03-04 00:27:23.302908 | 
2026-03-04 00:27:23.415977 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master]
2026-03-04 00:27:23.417958 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2026-03-04 00:27:24.091560 | 
2026-03-04 00:27:24.091721 | PLAY [all]
2026-03-04 00:27:24.116309 | 
2026-03-04 00:27:24.116447 | TASK [fetch-subunit-output : Find stestr or testr executable]
2026-03-04 00:29:58.126955 | controller | changed: non-zero return code
2026-03-04 00:29:58.135553 | 
2026-03-04 00:29:58.135722 | TASK [fetch-subunit-output : Get the list of directories with subunit files]
2026-03-04 00:29:58.163276 | controller | skipping: Conditional result was False
2026-03-04 00:29:58.174272 | 
2026-03-04 00:29:58.174448 | LOOP [fetch-subunit-output : Find any inflight partial subunit files]
2026-03-04 00:29:58.226197 | 
2026-03-04 00:29:58.226388 | LOOP [fetch-subunit-output : Copy any inflight subunit files]
2026-03-04 00:29:58.259003 | 
2026-03-04 00:29:58.259182 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream]
2026-03-04 00:29:58.284225 | controller | skipping: Conditional result was False
2026-03-04 00:29:58.295006 | 
2026-03-04 00:29:58.295235 | LOOP [fetch-subunit-output : Generate subunit file]
2026-03-04 00:29:58.316956 | 
2026-03-04 00:29:58.317160 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory]
2026-03-04 00:29:58.331061 | controller | skipping: Conditional result was False
2026-03-04 00:29:58.338388 | 
2026-03-04 00:29:58.338499 | TASK [fetch-subunit-output : Remove the temporary file]
2026-03-04 00:29:58.352318 | controller | skipping: Conditional result was False
2026-03-04 00:29:58.359945 | 
2026-03-04 00:29:58.360088 | TASK [fetch-subunit-output : Process and fetch subunit results]
2026-03-04 00:29:58.374786 | controller | skipping: Conditional result was False
2026-03-04 00:29:58.412504 | 
2026-03-04 00:29:58.412641 | PLAY RECAP
2026-03-04 00:29:58.412695 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2026-03-04 00:29:58.412724 | 
2026-03-04 00:29:58.534572 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2026-03-04 00:29:58.535496 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master]
2026-03-04 00:29:59.186035 | 
2026-03-04 00:29:59.186202 | PLAY [all:!appliance*]
2026-03-04 00:29:59.215080 | 
2026-03-04 00:29:59.215254 | TASK [unregister the node]
2026-03-04 00:29:59.759547 | controller | skipping: Conditional result was False
2026-03-04 00:29:59.770489 | 
2026-03-04 00:29:59.770622 | TASK [include_role : fetch-output]
2026-03-04 00:29:59.814847 | controller | ok
2026-03-04 00:29:59.845542 | 
2026-03-04 00:29:59.845664 | TASK [fetch-output : Set log path for multiple nodes]
2026-03-04 00:29:59.901345 | controller | skipping: Conditional result was False
2026-03-04 00:29:59.908114 | 
2026-03-04 00:29:59.908238 | TASK [fetch-output : Set log path for single node]
2026-03-04 00:29:59.949252 | controller | ok
2026-03-04 00:29:59.954922 | 
2026-03-04 00:29:59.954991 | LOOP [fetch-output : Ensure local output dirs]
2026-03-04 00:30:00.442862 | controller -> localhost | ok: "/var/lib/zuul/builds/856db99c032343c09b627721dd4f54ec/work/logs"
2026-03-04 00:30:00.744486 | controller -> localhost | changed: "/var/lib/zuul/builds/856db99c032343c09b627721dd4f54ec/work/artifacts"
2026-03-04 00:30:01.060547 | controller -> localhost | changed: "/var/lib/zuul/builds/856db99c032343c09b627721dd4f54ec/work/docs"
2026-03-04 00:30:01.074389 | 
2026-03-04 00:30:01.074561 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-03-04 00:30:01.844670 | controller | changed: .d..t...... ./
2026-03-04 00:30:01.844914 | controller | changed: All items complete
2026-03-04 00:30:01.844940 | 
2026-03-04 00:30:02.353069 | controller | changed: .d..t...... ./
2026-03-04 00:30:02.879253 | controller | changed: .d..t...... ./
2026-03-04 00:30:02.904615 | 
2026-03-04 00:30:02.904776 | TASK [include_role : fetch-output-openshift]
2026-03-04 00:30:02.933976 | controller | skipping: Conditional result was False
2026-03-04 00:30:02.945180 | 
2026-03-04 00:30:02.945607 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-03-04 00:30:02.985172 | controller | skipping: Conditional result was False
2026-03-04 00:30:03.001160 | controller | skipping: Conditional result was False
2026-03-04 00:30:03.030401 | 
2026-03-04 00:30:03.030548 | PLAY [localhost]
2026-03-04 00:30:03.050501 | 
2026-03-04 00:30:03.050688 | TASK [Run Zuul manifest role]
2026-03-04 00:30:03.072630 | localhost | ok
2026-03-04 00:30:03.094699 | 
2026-03-04 00:30:03.094907 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-03-04 00:30:03.538883 | localhost | changed
2026-03-04 00:30:03.544112 | 
2026-03-04 00:30:03.544186 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-03-04 00:30:03.573604 | localhost | ok
2026-03-04 00:30:03.583425 | 
2026-03-04 00:30:03.583604 | TASK [Set zuul-log-path fact]
2026-03-04 00:30:03.602420 | localhost | ok
2026-03-04 00:30:03.616645 | 
2026-03-04 00:30:03.616764 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-04 00:30:03.646401 | localhost | ok
2026-03-04 00:30:03.654613 | 
2026-03-04 00:30:03.654691 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)]
2026-03-04 00:30:03.687862 | localhost | ok:
2026-03-04 00:30:03.688078 | localhost | {
2026-03-04 00:30:03.688106 | localhost |   "auth": {
2026-03-04 00:30:03.688124 | localhost |     "password": "IonWCwcuOFib&&<}wp^:[2G/",
2026-03-04 00:30:03.688142 | localhost |     "username": "9LF91O0RK7JU"
2026-03-04 00:30:03.688163 | localhost |   },
2026-03-04 00:30:03.688179 | localhost |   "profile": "rackspace",
2026-03-04 00:30:03.688195 | localhost |   "region_name": "ORD"
2026-03-04 00:30:03.688211 | localhost | }
2026-03-04 00:30:03.688235 | 
2026-03-04 00:30:03.695838 | 
2026-03-04 00:30:03.695932 | TASK [Run upload-logs-failover role (S3 then Swift)]
2026-03-04 00:30:03.715526 | localhost | Output suppressed because no_log was given
2026-03-04 00:30:03.727968 | 
2026-03-04 00:30:03.728059 | TASK [upload-logs-failover : Initialize control vars]
2026-03-04 00:30:03.756952 | localhost | ok
2026-03-04 00:30:03.761615 | 
2026-03-04 00:30:03.761677 | LOOP [upload-logs-failover : Perform log upload]
2026-03-04 00:30:03.829560 | localhost | Output suppressed because no_log was given
2026-03-04 00:30:03.835937 | localhost | included: /var/lib/zuul/builds/856db99c032343c09b627721dd4f54ec/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml
2026-03-04 00:30:03.842695 | 
2026-03-04 00:30:03.842767 | LOOP [upload-logs-failover : Unpack vars for swift upload]
2026-03-04 00:30:03.930198 | localhost | Output suppressed because no_log was given
2026-03-04 00:30:03.935350 | 
2026-03-04 00:30:03.935433 | TASK [Upload logs to swift]
2026-03-04 00:30:03.961781 | localhost | ok
2026-03-04 00:30:03.995258 | 
2026-03-04 00:30:03.995419 | TASK [Set zuul-log-path fact]
2026-03-04 00:30:04.023193 | localhost | skipping: Conditional result was False
2026-03-04 00:30:04.029427 | 
2026-03-04 00:30:04.029689 | TASK [upload-logs-swift : Ensure logs are readable before uploading]
2026-03-04 00:30:04.474907 | localhost -> localhost | ok: Runtime: 0:00:00.007540
2026-03-04 00:30:04.481257 | 
2026-03-04 00:30:04.481356 | TASK [upload-logs-swift : Upload logs to swift]