2026-02-28 00:06:46.619981 | Job console starting...
2026-02-28 00:06:46.638353 | Updating repositories
2026-02-28 00:06:46.757755 | Preparing job workspace
2026-02-28 00:06:50.669371 | Running Ansible setup...
2026-02-28 00:06:55.675279 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2026-02-28 00:06:56.354362 | 
2026-02-28 00:06:56.354529 | PLAY [localhost]
2026-02-28 00:06:56.367325 | 
2026-02-28 00:06:56.367499 | TASK [Gathering Facts]
2026-02-28 00:06:57.366302 | localhost | ok
2026-02-28 00:06:57.386041 | 
2026-02-28 00:06:57.386193 | TASK [Setup log path fact]
2026-02-28 00:06:57.409987 | localhost | ok
2026-02-28 00:06:57.425215 | 
2026-02-28 00:06:57.425346 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-02-28 00:06:57.466385 | localhost | ok
2026-02-28 00:06:57.477244 | 
2026-02-28 00:06:57.477395 | TASK [emit-job-header : Print job information]
2026-02-28 00:06:57.529108 | # Job Information
2026-02-28 00:06:57.529301 | Ansible Version: 2.15.12
2026-02-28 00:06:57.529346 | Job: ansible-test-sanity-docker-devel
2026-02-28 00:06:57.529374 | Pipeline: periodic
2026-02-28 00:06:57.529395 | Executor: ze01.softwarefactory-project.io
2026-02-28 00:06:57.529416 | Triggered by: https://github.com/ansible-collections/ansible.network
2026-02-28 00:06:57.529441 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/0cb/ansible/0cbe18cb2161483e936434f5fe43e0fe/
2026-02-28 00:06:57.529463 | Event ID: 2ec722b134c44e47b6e2008fb7cdb67f
2026-02-28 00:06:57.535182 | 
2026-02-28 00:06:57.535260 | LOOP [emit-job-header : Print node information]
2026-02-28 00:06:57.653484 | localhost | ok:
2026-02-28 00:06:57.653749 | localhost | # Node Information
2026-02-28 00:06:57.653789 | localhost | Inventory Hostname: controller
2026-02-28 00:06:57.653820 | localhost | Hostname: np0005633713
2026-02-28 00:06:57.653850 | localhost | Username: zuul
2026-02-28 00:06:57.653881 | localhost | Distro: Fedora 37
2026-02-28 00:06:57.653910 | localhost | Provider: ansible-vexxhost-ca-ymq-1
2026-02-28 00:06:57.653938 | localhost | Region: ca-ymq-1
2026-02-28 00:06:57.653965 | localhost | Label: ansible-fedora-37-1vcpu
2026-02-28 00:06:57.653992 | localhost | Product Name: OpenStack Nova
2026-02-28 00:06:57.654199 | localhost | Interface IP: 162.253.55.36
2026-02-28 00:06:57.673639 | 
2026-02-28 00:06:57.673768 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-02-28 00:06:58.069607 | localhost -> localhost | changed
2026-02-28 00:06:58.078308 | 
2026-02-28 00:06:58.078422 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-02-28 00:06:58.971157 | localhost -> localhost | changed
2026-02-28 00:06:59.005666 | 
2026-02-28 00:06:59.005783 | PLAY [all:!appliance*]
2026-02-28 00:06:59.029925 | 
2026-02-28 00:06:59.030058 | TASK [include_role : start-zuul-console]
2026-02-28 00:06:59.050770 | controller | ok
2026-02-28 00:06:59.074127 | 
2026-02-28 00:06:59.074315 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-02-28 00:06:59.458294 | controller | ok
2026-02-28 00:06:59.482071 | 
2026-02-28 00:06:59.482258 | TASK [use-our-mirror : Retrieve the IP address]
2026-02-28 00:07:00.390887 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found
2026-02-28 00:07:00.398611 | 
2026-02-28 00:07:00.398749 | TASK [use-our-mirror : Ensure the registry service is running on the mirror]
2026-02-28 00:07:00.935092 | controller | skipping: Conditional result was False
2026-02-28 00:07:00.944818 | 
2026-02-28 00:07:00.944981 | TASK [use-our-mirror : Write the IP in /etc/hosts]
2026-02-28 00:07:00.972682 | controller | skipping: Conditional result was False
2026-02-28 00:07:00.981869 | 
2026-02-28 00:07:00.982045 | TASK [use-our-mirror : Create the podman configuration directory]
2026-02-28 00:07:01.009282 | controller | skipping: Conditional result was False
2026-02-28 00:07:01.018613 | 
2026-02-28 00:07:01.018758 | TASK [use-our-mirror : Copy the podman configuration]
2026-02-28 00:07:01.045702 | controller | skipping: Conditional result was False
2026-02-28 00:07:01.054598 | 
2026-02-28 00:07:01.054752 | TASK [use-our-mirror : Copy the Yum configuration (main)]
2026-02-28 00:07:01.082189 | controller | skipping: Conditional result was False
2026-02-28 00:07:01.091306 | 
2026-02-28 00:07:01.091444 | TASK [use-our-mirror : Copy the Yum configuration (update)]
2026-02-28 00:07:01.117851 | controller | skipping: Conditional result was False
2026-02-28 00:07:01.131402 | 
2026-02-28 00:07:01.131539 | TASK [Disable Fedora Modular]
2026-02-28 00:07:01.367545 | controller | changed
2026-02-28 00:07:01.373402 | 
2026-02-28 00:07:01.373522 | TASK [Enable EPEL]
2026-02-28 00:07:01.399617 | controller | skipping: Conditional result was False
2026-02-28 00:07:01.406298 | 
2026-02-28 00:07:01.406432 | TASK [Register the RHEL node]
2026-02-28 00:07:01.958498 | 
2026-02-28 00:07:01.958794 | TASK [Show the subscription-manager status]
2026-02-28 00:07:02.556109 | controller | skipping: Conditional result was False
2026-02-28 00:07:02.575250 | 
2026-02-28 00:07:02.575471 | TASK [Enable EPEL on RHEL]
2026-02-28 00:07:03.127879 | controller | skipping: Conditional result was False
2026-02-28 00:07:03.136488 | 
2026-02-28 00:07:03.136616 | TASK [Install git and tox]
2026-02-28 00:08:22.598573 | controller | changed
2026-02-28 00:08:22.607171 | 
2026-02-28 00:08:22.607266 | TASK [include_role : prepare-workspace]
2026-02-28 00:08:22.639425 | controller | ok
2026-02-28 00:08:22.669056 | 
2026-02-28 00:08:22.669230 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-02-28 00:08:22.928763 | controller | ok
2026-02-28 00:08:22.941185 | 
2026-02-28 00:08:22.941325 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-02-28 00:08:35.711936 | controller | Output suppressed because no_log was given
2026-02-28 00:08:35.762711 | 
2026-02-28 00:08:35.762834 | TASK [include_role : prepare-workspace-openshift]
2026-02-28 00:08:35.787190 | controller | skipping: Conditional result was False
2026-02-28 00:08:35.810899 | 
2026-02-28 00:08:35.810980 | PLAY [all:!appliance]
2026-02-28 00:08:35.829691 | 
2026-02-28 00:08:35.829809 | TASK [Run add-build-sshkey role (RSA)]
2026-02-28 00:08:35.861265 | controller | ok
2026-02-28 00:08:35.881635 | 
2026-02-28 00:08:35.881772 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-02-28 00:08:36.153466 | controller -> localhost | ok
2026-02-28 00:08:36.161498 | 
2026-02-28 00:08:36.161613 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-02-28 00:08:36.196181 | controller | ok
2026-02-28 00:08:36.220231 | controller | included: /var/lib/zuul/builds/0cbe18cb2161483e936434f5fe43e0fe/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-02-28 00:08:36.227528 | 
2026-02-28 00:08:36.227627 | TASK [add-build-sshkey : Create Temp SSH key]
2026-02-28 00:08:36.696818 | controller -> localhost | Generating public/private rsa key pair.
2026-02-28 00:08:36.697050 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/0cbe18cb2161483e936434f5fe43e0fe/work/0cbe18cb2161483e936434f5fe43e0fe_id_rsa.
2026-02-28 00:08:36.697085 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/0cbe18cb2161483e936434f5fe43e0fe/work/0cbe18cb2161483e936434f5fe43e0fe_id_rsa.pub.
2026-02-28 00:08:36.697109 | controller -> localhost | The key fingerprint is:
2026-02-28 00:08:36.697131 | controller -> localhost | SHA256:zhW4Zv9odsSinxyDUSg8GIzE1oErGxfJc5DbZYxskdg zuul-build-sshkey
2026-02-28 00:08:36.697151 | controller -> localhost | The key's randomart image is:
2026-02-28 00:08:36.697172 | controller -> localhost | +---[RSA 2048]----+
2026-02-28 00:08:36.697191 | controller -> localhost | | +o%+*           |
2026-02-28 00:08:36.697210 | controller -> localhost | |  % E++  o       |
2026-02-28 00:08:36.697230 | controller -> localhost | | . O.o+ o o      |
2026-02-28 00:08:36.697248 | controller -> localhost | |o + .  o o .     |
2026-02-28 00:08:36.697266 | controller -> localhost | | =      S ..     |
2026-02-28 00:08:36.697294 | controller -> localhost | |.      = =. o    |
2026-02-28 00:08:36.697322 | controller -> localhost | |        +.+o     |
2026-02-28 00:08:36.697347 | controller -> localhost | |        ..o*.    |
2026-02-28 00:08:36.697376 | controller -> localhost | |         +=..    |
2026-02-28 00:08:36.697405 | controller -> localhost | +----[SHA256]-----+
2026-02-28 00:08:36.697481 | controller -> localhost | ok: Runtime: 0:00:00.112685
2026-02-28 00:08:36.705002 | 
2026-02-28 00:08:36.705116 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-02-28 00:08:36.735748 | controller | ok
2026-02-28 00:08:36.750470 | controller | included: /var/lib/zuul/builds/0cbe18cb2161483e936434f5fe43e0fe/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-02-28 00:08:36.759867 | 
2026-02-28 00:08:36.759956 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-02-28 00:08:36.774046 | controller | skipping: Conditional result was False
2026-02-28 00:08:36.781092 | 
2026-02-28 00:08:36.781205 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-02-28 00:08:37.217592 | controller | changed
2026-02-28 00:08:37.237900 | 
2026-02-28 00:08:37.238071 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-02-28 00:08:37.480319 | controller | ok
2026-02-28 00:08:37.493612 | 
2026-02-28 00:08:37.493806 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-02-28 00:08:38.147536 | controller | changed
2026-02-28 00:08:38.158062 | 
2026-02-28 00:08:38.158247 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-02-28 00:08:38.798046 | controller | changed
2026-02-28 00:08:38.807326 | 
2026-02-28 00:08:38.807438 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-02-28 00:08:38.823583 | controller | skipping: Conditional result was False
2026-02-28 00:08:38.833902 | 
2026-02-28 00:08:38.834066 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-02-28 00:08:39.239397 | controller -> localhost | changed
2026-02-28 00:08:39.255364 | 
2026-02-28 00:08:39.255501 | TASK [add-build-sshkey : Add back temp key]
2026-02-28 00:08:39.505625 | controller -> localhost | Identity added: /var/lib/zuul/builds/0cbe18cb2161483e936434f5fe43e0fe/work/0cbe18cb2161483e936434f5fe43e0fe_id_rsa (zuul-build-sshkey)
2026-02-28 00:08:39.505978 | controller -> localhost | ok: Runtime: 0:00:00.008210
2026-02-28 00:08:39.521650 | 
2026-02-28 00:08:39.521784 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-02-28 00:08:39.862655 | controller | ok
2026-02-28 00:08:39.868685 | 
2026-02-28 00:08:39.868767 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-02-28 00:08:39.905527 | controller | skipping: Conditional result was False
2026-02-28 00:08:39.927732 | 
2026-02-28 00:08:39.927856 | TASK [Run add-build-sshkey role (ECDSA)]
2026-02-28 00:08:39.962982 | controller | ok
2026-02-28 00:08:39.988355 | 
2026-02-28 00:08:39.988521 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-02-28 00:08:40.238507 | controller -> localhost | ok
2026-02-28 00:08:40.245515 | 
2026-02-28 00:08:40.245639 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-02-28 00:08:40.267877 | controller | ok
2026-02-28 00:08:40.278954 | controller | included: /var/lib/zuul/builds/0cbe18cb2161483e936434f5fe43e0fe/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-02-28 00:08:40.285790 | 
2026-02-28 00:08:40.285863 | TASK [add-build-sshkey : Create Temp SSH key]
2026-02-28 00:08:40.576708 | controller -> localhost | Generating public/private ecdsa key pair.
2026-02-28 00:08:40.576933 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/0cbe18cb2161483e936434f5fe43e0fe/work/0cbe18cb2161483e936434f5fe43e0fe_id_ecdsa.
2026-02-28 00:08:40.576963 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/0cbe18cb2161483e936434f5fe43e0fe/work/0cbe18cb2161483e936434f5fe43e0fe_id_ecdsa.pub.
2026-02-28 00:08:40.576994 | controller -> localhost | The key fingerprint is:
2026-02-28 00:08:40.577036 | controller -> localhost | SHA256:nR0bBbW6A1iP3rGo3pYE364zpWnLufLqFmy3njAMyYY zuul-build-sshkey
2026-02-28 00:08:40.577066 | controller -> localhost | The key's randomart image is:
2026-02-28 00:08:40.577096 | controller -> localhost | +---[ECDSA 521]---+
2026-02-28 00:08:40.577125 | controller -> localhost | |            .oo  |
2026-02-28 00:08:40.577152 | controller -> localhost | |             . . |
2026-02-28 00:08:40.577173 | controller -> localhost | |          . o .  |
2026-02-28 00:08:40.577190 | controller -> localhost | |     o ..+ = =   |
2026-02-28 00:08:40.577208 | controller -> localhost | |    E =.So=.*    |
2026-02-28 00:08:40.577225 | controller -> localhost | |     . o+.++o+   |
2026-02-28 00:08:40.577242 | controller -> localhost | |       .++oB=    |
2026-02-28 00:08:40.577259 | controller -> localhost | |        o*Xo..   |
2026-02-28 00:08:40.577276 | controller -> localhost | |       +=B@*     |
2026-02-28 00:08:40.577294 | controller -> localhost | +----[SHA256]-----+
2026-02-28 00:08:40.577349 | controller -> localhost | ok: Runtime: 0:00:00.015986
2026-02-28 00:08:40.584813 | 
2026-02-28 00:08:40.584915 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-02-28 00:08:40.620546 | controller | ok
2026-02-28 00:08:40.629672 | controller | included: /var/lib/zuul/builds/0cbe18cb2161483e936434f5fe43e0fe/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-02-28 00:08:40.643227 | 
2026-02-28 00:08:40.643394 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-02-28 00:08:40.668264 | controller | skipping: Conditional result was False
2026-02-28 00:08:40.676204 | 
2026-02-28 00:08:40.676289 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-02-28 00:08:40.970518 | controller | changed
2026-02-28 00:08:40.984150 | 
2026-02-28 00:08:40.984326 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-02-28 00:08:41.231556 | controller | ok
2026-02-28 00:08:41.246550 | 
2026-02-28 00:08:41.246795 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-02-28 00:08:41.854360 | controller | changed
2026-02-28 00:08:41.860984 | 
2026-02-28 00:08:41.861079 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-02-28 00:08:42.421509 | controller | changed
2026-02-28 00:08:42.430137 | 
2026-02-28 00:08:42.430292 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-02-28 00:08:42.446071 | controller | skipping: Conditional result was False
2026-02-28 00:08:42.454670 | 
2026-02-28 00:08:42.454796 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-02-28 00:08:42.709389 | controller -> localhost | changed
2026-02-28 00:08:42.770365 | 
2026-02-28 00:08:42.770499 | TASK [add-build-sshkey : Add back temp key]
2026-02-28 00:08:43.029087 | controller -> localhost | Identity added: /var/lib/zuul/builds/0cbe18cb2161483e936434f5fe43e0fe/work/0cbe18cb2161483e936434f5fe43e0fe_id_ecdsa (zuul-build-sshkey)
2026-02-28 00:08:43.029323 | controller -> localhost | ok: Runtime: 0:00:00.010177
2026-02-28 00:08:43.036040 | 
2026-02-28 00:08:43.036138 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-02-28 00:08:43.229319 | controller | ok
2026-02-28 00:08:43.235504 | 
2026-02-28 00:08:43.235609 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-02-28 00:08:43.281195 | controller | skipping: Conditional result was False
2026-02-28 00:08:43.311828 | 
2026-02-28 00:08:43.312118 | TASK [include_role : remove-zuul-sshkey]
2026-02-28 00:08:43.328677 | controller | skipping: Conditional result was False
2026-02-28 00:08:43.340905 | 
2026-02-28 00:08:43.341105 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-02-28 00:08:43.568387 | controller | ok: "logs"
2026-02-28 00:08:43.568959 | controller | ok: All items complete
2026-02-28 00:08:43.569098 | 
2026-02-28 00:08:43.767585 | controller | ok: "artifacts"
2026-02-28 00:08:43.956965 | controller | ok: "docs"
2026-02-28 00:08:43.968483 | 
2026-02-28 00:08:43.968613 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-02-28 00:08:44.232271 | controller | changed: "logs"
2026-02-28 00:08:44.438910 | controller | changed: "artifacts"
2026-02-28 00:08:44.637354 | controller | changed: "docs"
2026-02-28 00:08:44.680734 | 
2026-02-28 00:08:44.680874 | PLAY RECAP
2026-02-28 00:08:44.680938 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0
2026-02-28 00:08:44.680977 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-02-28 00:08:44.681004 | 
2026-02-28 00:08:44.837853 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2026-02-28 00:08:44.838748 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2026-02-28 00:08:45.440934 | 
2026-02-28 00:08:45.441080 | PLAY [all]
2026-02-28 00:08:45.465127 | 
2026-02-28 00:08:45.465250 | TASK [Install binary dependencies]
2026-02-28 00:08:45.526176 | controller | ok
2026-02-28 00:08:45.546724 | 
2026-02-28 00:08:45.546848 | TASK [bindep : Include find tasks]
2026-02-28 00:08:45.577253 | controller | ok
2026-02-28 00:08:45.585676 | controller | included: /var/lib/zuul/builds/0cbe18cb2161483e936434f5fe43e0fe/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml
2026-02-28 00:08:45.592285 | 
2026-02-28 00:08:45.592374 | TASK [bindep : Look for bindep.txt]
2026-02-28 00:08:45.933240 | controller | ok
2026-02-28 00:08:45.943353 | 
2026-02-28 00:08:45.943516 | TASK [bindep : Define bindep_file fact]
2026-02-28 00:08:45.960660 | controller | skipping: Conditional result was False
2026-02-28 00:08:45.971886 | 
2026-02-28 00:08:45.972085 | TASK [bindep : Look for other-requirements.txt]
2026-02-28 00:08:46.187696 | controller | ok
2026-02-28 00:08:46.195271 | 
2026-02-28 00:08:46.195398 | TASK [bindep : Define bindep_file fact]
2026-02-28 00:08:46.232666 | controller | skipping: Conditional result was False
2026-02-28 00:08:46.242765 | 
2026-02-28 00:08:46.242872 | TASK [bindep : Look for bindep fallback file]
2026-02-28 00:08:46.279899 | controller | skipping: Conditional result was False
2026-02-28 00:08:46.291408 | 
2026-02-28 00:08:46.291578 | TASK [bindep : Define bindep_file fact]
2026-02-28 00:08:46.317319 | controller | skipping: Conditional result was False
2026-02-28 00:08:46.327468 | 
2026-02-28 00:08:46.327629 | TASK [bindep : Include bindep tasks]
2026-02-28 00:08:46.354193 | controller | skipping: Conditional result was False
2026-02-28 00:08:46.364118 | 
2026-02-28 00:08:46.364264 | TASK [bindep : Include install tasks]
2026-02-28 00:08:46.389579 | controller | skipping: Conditional result was False
2026-02-28 00:08:46.396801 | 
2026-02-28 00:08:46.396899 | LOOP [bindep : Include package tasks]
2026-02-28 00:08:46.454406 | 
2026-02-28 00:08:46.454597 | TASK [Run test-setup role]
2026-02-28 00:08:46.476127 | controller | ok
2026-02-28 00:08:46.493897 | 
2026-02-28 00:08:46.494039 | TASK [test-setup : Check if project's tools/test-setup.sh exists]
2026-02-28 00:08:46.713210 | controller | ok
2026-02-28 00:08:46.728167 | 
2026-02-28 00:08:46.728324 | TASK [test-setup : Run tools/test-setup.sh]
2026-02-28 00:08:47.282584 | controller | skipping: Conditional result was False
2026-02-28 00:08:47.341077 | 
2026-02-28 00:08:47.341200 | PLAY RECAP
2026-02-28 00:08:47.341257 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2026-02-28 00:08:47.341288 | 
2026-02-28 00:08:47.457223 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2026-02-28 00:08:47.458176 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master]
2026-02-28 00:08:48.078982 | 
2026-02-28 00:08:48.079167 | PLAY [controller]
2026-02-28 00:08:48.101208 | 
2026-02-28 00:08:48.101338 | TASK [Create the /root directory]
2026-02-28 00:11:00.394838 | controller | ERROR
2026-02-28 00:11:00.395303 | controller | {
2026-02-28 00:11:00.395361 | controller |   "msg": "Timeout (32s) waiting for privilege escalation prompt: "
2026-02-28 00:11:00.395399 | controller | }
failure
2026-02-28 00:11:00.396586 | 
2026-02-28 00:11:00.396646 | PLAY RECAP
2026-02-28 00:11:00.396708 | controller | ok: 0 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-02-28 00:11:00.396748 | 
2026-02-28 00:11:00.546958 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master]
2026-02-28 00:11:00.548373 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2026-02-28 00:11:01.254534 | 
2026-02-28 00:11:01.254718 | PLAY [all]
2026-02-28 00:11:01.294359 | 
2026-02-28 00:11:01.294563 | TASK [fetch-subunit-output : Find stestr or testr executable]
2026-02-28 00:15:02.052609 | controller | changed: non-zero return code
2026-02-28 00:15:02.061453 | 
2026-02-28 00:15:02.061583 | TASK [fetch-subunit-output : Get the list of directories with subunit files]
2026-02-28 00:15:02.090106 | controller | skipping: Conditional result was False
2026-02-28 00:15:02.100148 | 
2026-02-28 00:15:02.100283 | LOOP [fetch-subunit-output : Find any inflight partial subunit files]
2026-02-28 00:15:02.139588 | 
2026-02-28 00:15:02.139847 | LOOP [fetch-subunit-output : Copy any inflight subunit files]
2026-02-28 00:15:02.182389 | 
2026-02-28 00:15:02.182652 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream]
2026-02-28 00:15:02.209630 | controller | skipping: Conditional result was False
2026-02-28 00:15:02.220771 | 
2026-02-28 00:15:02.220910 | LOOP [fetch-subunit-output : Generate subunit file]
2026-02-28 00:15:02.258355 | 
2026-02-28 00:15:02.258589 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory]
2026-02-28 00:15:02.285203 | controller | skipping: Conditional result was False
2026-02-28 00:15:02.301357 | 
2026-02-28 00:15:02.301555 | TASK [fetch-subunit-output : Remove the temporary file]
2026-02-28 00:15:02.329655 | controller | skipping: Conditional result was False
2026-02-28 00:15:02.341619 | 
2026-02-28 00:15:02.341767 | TASK [fetch-subunit-output : Process and fetch subunit results]
2026-02-28 00:15:02.369098 | controller | skipping: Conditional result was False
2026-02-28 00:15:02.411324 | 
2026-02-28 00:15:02.411454 | PLAY RECAP
2026-02-28 00:15:02.411501 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2026-02-28 00:15:02.411521 | 
2026-02-28 00:15:02.541523 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2026-02-28 00:15:02.543771 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master]
2026-02-28 00:15:03.202950 | 
2026-02-28 00:15:03.203095 | PLAY [all:!appliance*]
2026-02-28 00:15:03.225439 | 
2026-02-28 00:15:03.225536 | TASK [unregister the node]
2026-02-28 00:15:03.761785 | controller | skipping: Conditional result was False
2026-02-28 00:15:03.776154 | 
2026-02-28 00:15:03.776345 | TASK [include_role : fetch-output]
2026-02-28 00:15:03.834940 | controller | ok
2026-02-28 00:15:03.864088 | 
2026-02-28 00:15:03.864248 | TASK [fetch-output : Set log path for multiple nodes]
2026-02-28 00:15:03.931370 | controller | skipping: Conditional result was False
2026-02-28 00:15:03.939981 | 
2026-02-28 00:15:03.940087 | TASK [fetch-output : Set log path for single node]
2026-02-28 00:15:03.992679 | controller | ok
2026-02-28 00:15:03.999096 | 
2026-02-28 00:15:03.999178 | LOOP [fetch-output : Ensure local output dirs]
2026-02-28 00:15:04.507244 | controller -> localhost | ok: "/var/lib/zuul/builds/0cbe18cb2161483e936434f5fe43e0fe/work/logs"
2026-02-28 00:15:04.807636 | controller -> localhost | changed: "/var/lib/zuul/builds/0cbe18cb2161483e936434f5fe43e0fe/work/artifacts"
2026-02-28 00:15:05.064807 | controller -> localhost | changed: "/var/lib/zuul/builds/0cbe18cb2161483e936434f5fe43e0fe/work/docs"
2026-02-28 00:15:05.087125 | 
2026-02-28 00:15:05.087434 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-02-28 00:15:05.886290 | controller | ok
2026-02-28 00:15:05.886692 | controller | changed: All items complete
2026-02-28 00:15:05.886747 | 
2026-02-28 00:15:06.449952 | controller | changed: .d..t...... ./
2026-02-28 00:15:07.037045 | controller | changed: .d..t...... ./
2026-02-28 00:15:07.059510 | 
2026-02-28 00:15:07.059610 | TASK [include_role : fetch-output-openshift]
2026-02-28 00:15:07.085743 | controller | skipping: Conditional result was False
2026-02-28 00:15:07.096526 | 
2026-02-28 00:15:07.096651 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-02-28 00:15:07.137990 | controller | skipping: Conditional result was False
2026-02-28 00:15:07.154323 | controller | skipping: Conditional result was False
2026-02-28 00:15:07.196118 | 
2026-02-28 00:15:07.196268 | PLAY [localhost]
2026-02-28 00:15:07.209125 | 
2026-02-28 00:15:07.209198 | TASK [Run Zuul manifest role]
2026-02-28 00:15:07.230403 | localhost | ok
2026-02-28 00:15:07.245179 | 
2026-02-28 00:15:07.245339 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-02-28 00:15:07.729822 | localhost | changed
2026-02-28 00:15:07.736427 | 
2026-02-28 00:15:07.736558 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-02-28 00:15:07.782092 | localhost | ok
2026-02-28 00:15:07.794379 | 
2026-02-28 00:15:07.794469 | TASK [Set zuul-log-path fact]
2026-02-28 00:15:07.819484 | localhost | ok
2026-02-28 00:15:07.841752 | 
2026-02-28 00:15:07.841932 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-02-28 00:15:07.884926 | localhost | ok
2026-02-28 00:15:07.893649 | 
2026-02-28 00:15:07.893726 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)]
2026-02-28 00:15:07.933537 | localhost | ok:
2026-02-28 00:15:07.933845 | localhost | {
2026-02-28 00:15:07.933903 | localhost |   "auth": {
2026-02-28 00:15:07.933945 | localhost |     "password": "IonWCwcuOFib&&<}wp^:[2G/",
2026-02-28 00:15:07.933986 | localhost |     "username": "9LF91O0RK7JU"
2026-02-28 00:15:07.934190 | localhost |   },
2026-02-28 00:15:07.934244 | localhost |   "profile": "rackspace",
2026-02-28 00:15:07.934285 | localhost |   "region_name": "ORD"
2026-02-28 00:15:07.934324 | localhost | }
2026-02-28 00:15:07.934403 | 
2026-02-28 00:15:07.948179 | 
2026-02-28 00:15:07.948361 | TASK [Run upload-logs-failover role (S3 then Swift)]
2026-02-28 00:15:07.968346 | localhost | Output suppressed because no_log was given
2026-02-28 00:15:07.982005 | 
2026-02-28 00:15:07.982140 | TASK [upload-logs-failover : Initialize control vars]
2026-02-28 00:15:08.018109 | localhost | ok
2026-02-28 00:15:08.075105 | 
2026-02-28 00:15:08.075308 | LOOP [upload-logs-failover : Perform log upload]
2026-02-28 00:15:08.121325 | localhost | Output suppressed because no_log was given
2026-02-28 00:15:08.128785 | localhost | included: /var/lib/zuul/builds/0cbe18cb2161483e936434f5fe43e0fe/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml
2026-02-28 00:15:08.137751 | 
2026-02-28 00:15:08.137963 | LOOP [upload-logs-failover : Unpack vars for swift upload]
2026-02-28 00:15:08.242683 | localhost | Output suppressed because no_log was given
2026-02-28 00:15:08.250741 | 
2026-02-28 00:15:08.250857 | TASK [Upload logs to swift]
2026-02-28 00:15:08.282244 | localhost | ok
2026-02-28 00:15:08.312704 | 
2026-02-28 00:15:08.312880 | TASK [Set zuul-log-path fact]
2026-02-28 00:15:08.351481 | localhost | skipping: Conditional result was False
2026-02-28 00:15:08.360816 | 
2026-02-28 00:15:08.360929 | TASK [upload-logs-swift : Ensure logs are readable before uploading]
2026-02-28 00:15:08.802220 | localhost -> localhost | ok: Runtime: 0:00:00.011789
2026-02-28 00:15:08.817110 | 
2026-02-28 00:15:08.817321 | TASK [upload-logs-swift : Upload logs to swift]