2026-03-02 00:21:40.073820 | Job console starting...
2026-03-02 00:21:40.084077 | Updating repositories
2026-03-02 00:21:40.241880 | Preparing job workspace
2026-03-02 00:21:44.366928 | Running Ansible setup...
2026-03-02 00:21:49.721642 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2026-03-02 00:21:50.333416 | 
2026-03-02 00:21:50.333550 | PLAY [localhost]
2026-03-02 00:21:50.341906 | 
2026-03-02 00:21:50.341990 | TASK [Gathering Facts]
2026-03-02 00:21:51.335234 | localhost | ok
2026-03-02 00:21:51.356136 | 
2026-03-02 00:21:51.356296 | TASK [Setup log path fact]
2026-03-02 00:21:51.376882 | localhost | ok
2026-03-02 00:21:51.395349 | 
2026-03-02 00:21:51.395467 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-02 00:21:51.425460 | localhost | ok
2026-03-02 00:21:51.436398 | 
2026-03-02 00:21:51.436518 | TASK [emit-job-header : Print job information]
2026-03-02 00:21:51.479734 | # Job Information
2026-03-02 00:21:51.480042 | Ansible Version: 2.15.12
2026-03-02 00:21:51.480129 | Job: ansible-test-sanity-docker-stable-2.12
2026-03-02 00:21:51.480183 | Pipeline: periodic
2026-03-02 00:21:51.480231 | Executor: ze01.softwarefactory-project.io
2026-03-02 00:21:51.480275 | Triggered by: https://github.com/ansible-collections/ansible.network
2026-03-02 00:21:51.480326 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/163/ansible/16365dee7ce048c2a9a0b99a391c0963/
2026-03-02 00:21:51.480372 | Event ID: 2eb49f0a79aa4455b1e117a286c05c7e
2026-03-02 00:21:51.489659 | 
2026-03-02 00:21:51.489802 | LOOP [emit-job-header : Print node information]
2026-03-02 00:21:51.605396 | localhost | ok:
2026-03-02 00:21:51.605625 | localhost | # Node Information
2026-03-02 00:21:51.605661 | localhost | Inventory Hostname: controller
2026-03-02 00:21:51.605689 | localhost | Hostname: np0005634902
2026-03-02 00:21:51.605715 | localhost | Username: zuul
2026-03-02 00:21:51.605741 | localhost | Distro: Fedora 37
2026-03-02 00:21:51.605768 | localhost | Provider: ansible-vexxhost-ca-ymq-1
2026-03-02 00:21:51.605793 | localhost | Region: ca-ymq-1
2026-03-02 00:21:51.605815 | localhost | Label: ansible-fedora-37-1vcpu
2026-03-02 00:21:51.605838 | localhost | Product Name: OpenStack Nova
2026-03-02 00:21:51.605863 | localhost | Interface IP: 162.253.55.74
2026-03-02 00:21:51.620675 | 
2026-03-02 00:21:51.620772 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-03-02 00:21:52.062172 | localhost -> localhost | changed
2026-03-02 00:21:52.069682 | 
2026-03-02 00:21:52.069815 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-03-02 00:21:52.893186 | localhost -> localhost | changed
2026-03-02 00:21:52.915032 | 
2026-03-02 00:21:52.915181 | PLAY [all:!appliance*]
2026-03-02 00:21:52.932145 | 
2026-03-02 00:21:52.932254 | TASK [include_role : start-zuul-console]
2026-03-02 00:21:52.951274 | controller | ok
2026-03-02 00:21:52.965130 | 
2026-03-02 00:21:52.965239 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-03-02 00:21:53.347914 | controller | ok
2026-03-02 00:21:53.377129 | 
2026-03-02 00:21:53.377335 | TASK [use-our-mirror : Retrieve the IP address]
2026-03-02 00:21:54.327573 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found
2026-03-02 00:21:54.342970 | 
2026-03-02 00:21:54.343189 | TASK [use-our-mirror : Ensure the registry service is running on the mirror]
2026-03-02 00:21:54.894318 | controller | skipping: Conditional result was False
2026-03-02 00:21:54.901363 | 
2026-03-02 00:21:54.901465 | TASK [use-our-mirror : Write the IP in /etc/hosts]
2026-03-02 00:21:54.925925 | controller | skipping: Conditional result was False
2026-03-02 00:21:54.942447 | 
2026-03-02 00:21:54.942623 | TASK [use-our-mirror : Create the podman configuration directory]
2026-03-02 00:21:54.970736 | controller | skipping: Conditional result was False
2026-03-02 00:21:54.988426 | 
2026-03-02 00:21:54.988681 | TASK [use-our-mirror : Copy the podman configuration]
2026-03-02 00:21:55.026318 | controller | skipping: Conditional result was False
2026-03-02 00:21:55.035140 | 
2026-03-02 00:21:55.035270 | TASK [use-our-mirror : Copy the Yum configuration (main)]
2026-03-02 00:21:55.070282 | controller | skipping: Conditional result was False
2026-03-02 00:21:55.079089 | 
2026-03-02 00:21:55.079226 | TASK [use-our-mirror : Copy the Yum configuration (update)]
2026-03-02 00:21:55.114324 | controller | skipping: Conditional result was False
2026-03-02 00:21:55.131240 | 
2026-03-02 00:21:55.131489 | TASK [Disable Fedora Modular]
2026-03-02 00:21:55.384495 | controller | changed
2026-03-02 00:21:55.398183 | 
2026-03-02 00:21:55.398324 | TASK [Enable EPEL]
2026-03-02 00:21:55.426225 | controller | skipping: Conditional result was False
2026-03-02 00:21:55.439795 | 
2026-03-02 00:21:55.439954 | TASK [Register the RHEL node]
2026-03-02 00:21:55.998280 | 
2026-03-02 00:21:55.998453 | TASK [Show the subscription-manager status]
2026-03-02 00:21:56.561236 | controller | skipping: Conditional result was False
2026-03-02 00:21:56.574509 | 
2026-03-02 00:21:56.574671 | TASK [Enable EPEL on RHEL]
2026-03-02 00:21:57.134045 | controller | skipping: Conditional result was False
2026-03-02 00:21:57.141383 | 
2026-03-02 00:21:57.141454 | TASK [Install git and tox]
2026-03-02 00:23:13.652928 | controller | changed
2026-03-02 00:23:13.669996 | 
2026-03-02 00:23:13.670218 | TASK [include_role : prepare-workspace]
2026-03-02 00:23:13.701686 | controller | ok
2026-03-02 00:23:13.724082 | 
2026-03-02 00:23:13.724181 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-03-02 00:23:13.951272 | controller | ok
2026-03-02 00:23:13.960518 | 
2026-03-02 00:23:13.960611 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-03-02 00:23:27.281706 | controller | Output suppressed because no_log was given
2026-03-02 00:23:27.294299 | 
2026-03-02 00:23:27.294396 | TASK [include_role : prepare-workspace-openshift]
2026-03-02 00:23:27.330707 | controller | skipping: Conditional result was False
2026-03-02 00:23:27.357211 | 
2026-03-02 00:23:27.357336 | PLAY [all:!appliance]
2026-03-02 00:23:27.373963 | 
2026-03-02 00:23:27.374128 | TASK [Run add-build-sshkey role (RSA)]
2026-03-02 00:23:27.406899 | controller | ok
2026-03-02 00:23:27.441919 | 
2026-03-02 00:23:27.442216 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-03-02 00:23:27.747292 | controller -> localhost | ok
2026-03-02 00:23:27.764371 | 
2026-03-02 00:23:27.764556 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-03-02 00:23:27.808948 | controller | ok
2026-03-02 00:23:27.833455 | controller | included: /var/lib/zuul/builds/16365dee7ce048c2a9a0b99a391c0963/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-03-02 00:23:27.843087 | 
2026-03-02 00:23:27.843179 | TASK [add-build-sshkey : Create Temp SSH key]
2026-03-02 00:23:28.396085 | controller -> localhost | Generating public/private rsa key pair.
2026-03-02 00:23:28.396359 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/16365dee7ce048c2a9a0b99a391c0963/work/16365dee7ce048c2a9a0b99a391c0963_id_rsa.
2026-03-02 00:23:28.396392 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/16365dee7ce048c2a9a0b99a391c0963/work/16365dee7ce048c2a9a0b99a391c0963_id_rsa.pub.
2026-03-02 00:23:28.396415 | controller -> localhost | The key fingerprint is:
2026-03-02 00:23:28.396436 | controller -> localhost | SHA256:PMjR+4ftS6GiZnBh8ir5h1Fk7yU6BEY6Fc4mh0o1kgI zuul-build-sshkey
2026-03-02 00:23:28.396457 | controller -> localhost | The key's randomart image is:
2026-03-02 00:23:28.396476 | controller -> localhost | +---[RSA 2048]----+
2026-03-02 00:23:28.396496 | controller -> localhost | |E..++.           |
2026-03-02 00:23:28.396515 | controller -> localhost | |..o*+ o.         |
2026-03-02 00:23:28.396533 | controller -> localhost | |..=.=+...        |
2026-03-02 00:23:28.396551 | controller -> localhost | |.. =..=+o..      |
2026-03-02 00:23:28.396569 | controller -> localhost | |.    *o+So  .    |
2026-03-02 00:23:28.396597 | controller -> localhost | |    o = .o + .   |
2026-03-02 00:23:28.396621 | controller -> localhost | |   . * .. + +    |
2026-03-02 00:23:28.396640 | controller -> localhost | |  o o +. . +     |
2026-03-02 00:23:28.396658 | controller -> localhost | |   o.+.     o.   |
2026-03-02 00:23:28.396680 | controller -> localhost | +----[SHA256]-----+
2026-03-02 00:23:28.396735 | controller -> localhost | ok: Runtime: 0:00:00.163101
2026-03-02 00:23:28.404317 | 
2026-03-02 00:23:28.404402 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-03-02 00:23:28.439377 | controller | ok
2026-03-02 00:23:28.456853 | controller | included: /var/lib/zuul/builds/16365dee7ce048c2a9a0b99a391c0963/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-03-02 00:23:28.470901 | 
2026-03-02 00:23:28.470996 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-03-02 00:23:28.496892 | controller | skipping: Conditional result was False
2026-03-02 00:23:28.504823 | 
2026-03-02 00:23:28.504900 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-03-02 00:23:29.019069 | controller | changed
2026-03-02 00:23:29.026365 | 
2026-03-02 00:23:29.026563 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-03-02 00:23:29.256696 | controller | ok
2026-03-02 00:23:29.264362 | 
2026-03-02 00:23:29.264579 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-03-02 00:23:29.907089 | controller | changed
2026-03-02 00:23:29.916304 | 
2026-03-02 00:23:29.916452 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-03-02 00:23:30.555129 | controller | changed
2026-03-02 00:23:30.568548 | 
2026-03-02 00:23:30.568695 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-03-02 00:23:30.600866 | controller | skipping: Conditional result was False
2026-03-02 00:23:30.617404 | 
2026-03-02 00:23:30.617582 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-03-02 00:23:31.064003 | controller -> localhost | changed
2026-03-02 00:23:31.076557 | 
2026-03-02 00:23:31.076632 | TASK [add-build-sshkey : Add back temp key]
2026-03-02 00:23:31.398540 | controller -> localhost | Identity added: /var/lib/zuul/builds/16365dee7ce048c2a9a0b99a391c0963/work/16365dee7ce048c2a9a0b99a391c0963_id_rsa (zuul-build-sshkey)
2026-03-02 00:23:31.398863 | controller -> localhost | ok: Runtime: 0:00:00.011956
2026-03-02 00:23:31.412616 | 
2026-03-02 00:23:31.412782 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-03-02 00:23:31.778443 | controller | ok
2026-03-02 00:23:31.790515 | 
2026-03-02 00:23:31.790668 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-03-02 00:23:31.828088 | controller | skipping: Conditional result was False
2026-03-02 00:23:31.868053 | 
2026-03-02 00:23:31.868471 | TASK [Run add-build-sshkey role (ECDSA)]
2026-03-02 00:23:31.908645 | controller | ok
2026-03-02 00:23:31.937103 | 
2026-03-02 00:23:31.937249 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-03-02 00:23:32.227690 | controller -> localhost | ok
2026-03-02 00:23:32.234628 | 
2026-03-02 00:23:32.234709 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-03-02 00:23:32.256283 | controller | ok
2026-03-02 00:23:32.267141 | controller | included: /var/lib/zuul/builds/16365dee7ce048c2a9a0b99a391c0963/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-03-02 00:23:32.273130 | 
2026-03-02 00:23:32.273198 | TASK [add-build-sshkey : Create Temp SSH key]
2026-03-02 00:23:32.531493 | controller -> localhost | Generating public/private ecdsa key pair.
2026-03-02 00:23:32.531664 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/16365dee7ce048c2a9a0b99a391c0963/work/16365dee7ce048c2a9a0b99a391c0963_id_ecdsa.
2026-03-02 00:23:32.531695 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/16365dee7ce048c2a9a0b99a391c0963/work/16365dee7ce048c2a9a0b99a391c0963_id_ecdsa.pub.
2026-03-02 00:23:32.531728 | controller -> localhost | The key fingerprint is:
2026-03-02 00:23:32.531751 | controller -> localhost | SHA256:v7pJdqj3NkIU5PwPdJfTRZLuJJuA/o4jUz12D3A2U3E zuul-build-sshkey
2026-03-02 00:23:32.531774 | controller -> localhost | The key's randomart image is:
2026-03-02 00:23:32.531793 | controller -> localhost | +---[ECDSA 521]---+
2026-03-02 00:23:32.531813 | controller -> localhost | |       ..     o+E|
2026-03-02 00:23:32.531832 | controller -> localhost | |       o.     o=.|
2026-03-02 00:23:32.531852 | controller -> localhost | |        oo. .o+ .|
2026-03-02 00:23:32.531872 | controller -> localhost | |        ooo.*.o. |
2026-03-02 00:23:32.531891 | controller -> localhost | |       oS.o= O   |
2026-03-02 00:23:32.531911 | controller -> localhost | |        +o+o= .  |
2026-03-02 00:23:32.531932 | controller -> localhost | |       o+ooo.o   |
2026-03-02 00:23:32.531951 | controller -> localhost | |      o++++.  .  |
2026-03-02 00:23:32.531970 | controller -> localhost | |      .+=O+.     |
2026-03-02 00:23:32.531989 | controller -> localhost | +----[SHA256]-----+
2026-03-02 00:23:32.532064 | controller -> localhost | ok: Runtime: 0:00:00.008756
2026-03-02 00:23:32.538809 | 
2026-03-02 00:23:32.538880 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-03-02 00:23:32.569039 | controller | ok
2026-03-02 00:23:32.577887 | controller | included: /var/lib/zuul/builds/16365dee7ce048c2a9a0b99a391c0963/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-03-02 00:23:32.587182 | 
2026-03-02 00:23:32.587274 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-03-02 00:23:32.611565 | controller | skipping: Conditional result was False
2026-03-02 00:23:32.618978 | 
2026-03-02 00:23:32.619099 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-03-02 00:23:32.888203 | controller | changed
2026-03-02 00:23:32.901227 | 
2026-03-02 00:23:32.901416 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-03-02 00:23:33.138205 | controller | ok
2026-03-02 00:23:33.153428 | 
2026-03-02 00:23:33.153604 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-03-02 00:23:33.816649 | controller | changed
2026-03-02 00:23:33.830293 | 
2026-03-02 00:23:33.830692 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-03-02 00:23:34.448878 | controller | changed
2026-03-02 00:23:34.494126 | 
2026-03-02 00:23:34.494281 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-03-02 00:23:34.530183 | controller | skipping: Conditional result was False
2026-03-02 00:23:34.540131 | 
2026-03-02 00:23:34.540247 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-03-02 00:23:34.814247 | controller -> localhost | changed
2026-03-02 00:23:34.839975 | 
2026-03-02 00:23:34.840158 | TASK [add-build-sshkey : Add back temp key]
2026-03-02 00:23:35.101337 | controller -> localhost | Identity added: /var/lib/zuul/builds/16365dee7ce048c2a9a0b99a391c0963/work/16365dee7ce048c2a9a0b99a391c0963_id_ecdsa (zuul-build-sshkey)
2026-03-02 00:23:35.101587 | controller -> localhost | ok: Runtime: 0:00:00.007805
2026-03-02 00:23:35.108492 | 
2026-03-02 00:23:35.108562 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-03-02 00:23:35.322139 | controller | ok
2026-03-02 00:23:35.336339 | 
2026-03-02 00:23:35.336499 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-03-02 00:23:35.373973 | controller | skipping: Conditional result was False
2026-03-02 00:23:35.400818 | 
2026-03-02 00:23:35.400950 | TASK [include_role : remove-zuul-sshkey]
2026-03-02 00:23:35.428374 | controller | skipping: Conditional result was False
2026-03-02 00:23:35.436931 | 
2026-03-02 00:23:35.437129 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-03-02 00:23:35.667279 | controller | ok: "logs"
2026-03-02 00:23:35.677077 | controller | ok: All items complete
2026-03-02 00:23:35.677217 | 
2026-03-02 00:23:35.884481 | controller | ok: "artifacts"
2026-03-02 00:23:36.069884 | controller | ok: "docs"
2026-03-02 00:23:36.094198 | 
2026-03-02 00:23:36.094393 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-03-02 00:23:36.333479 | controller | changed: "logs"
2026-03-02 00:23:36.562065 | controller | changed: "artifacts"
2026-03-02 00:23:36.772734 | controller | changed: "docs"
2026-03-02 00:23:36.834873 | 
2026-03-02 00:23:36.834997 | PLAY RECAP
2026-03-02 00:23:36.835079 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0
2026-03-02 00:23:36.835119 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-02 00:23:36.835145 | 
2026-03-02 00:23:36.953401 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2026-03-02 00:23:36.955140 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2026-03-02 00:23:37.530132 | 
2026-03-02 00:23:37.530239 | PLAY [all]
2026-03-02 00:23:37.552719 | 
2026-03-02 00:23:37.552812 | TASK [Install binary dependencies]
2026-03-02 00:23:37.635088 | controller | ok
2026-03-02 00:23:37.663729 | 
2026-03-02 00:23:37.663858 | TASK [bindep : Include find tasks]
2026-03-02 00:23:37.696331 | controller | ok
2026-03-02 00:23:37.707931 | controller | included: /var/lib/zuul/builds/16365dee7ce048c2a9a0b99a391c0963/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml
2026-03-02 00:23:37.717406 | 
2026-03-02 00:23:37.717501 | TASK [bindep : Look for bindep.txt]
2026-03-02 00:23:38.076267 | controller | ok
2026-03-02 00:23:38.081940 | 
2026-03-02 00:23:38.082005 | TASK [bindep : Define bindep_file fact]
2026-03-02 00:23:38.096164 | controller | skipping: Conditional result was False
2026-03-02 00:23:38.109892 | 
2026-03-02 00:23:38.110079 | TASK [bindep : Look for other-requirements.txt]
2026-03-02 00:23:38.332995 | controller | ok
2026-03-02 00:23:38.346144 | 
2026-03-02 00:23:38.346300 | TASK [bindep : Define bindep_file fact]
2026-03-02 00:23:38.383280 | controller | skipping: Conditional result was False
2026-03-02 00:23:38.397093 | 
2026-03-02 00:23:38.397257 | TASK [bindep : Look for bindep fallback file]
2026-03-02 00:23:38.434593 | controller | skipping: Conditional result was False
2026-03-02 00:23:38.450266 | 
2026-03-02 00:23:38.450428 | TASK [bindep : Define bindep_file fact]
2026-03-02 00:23:38.486827 | controller | skipping: Conditional result was False
2026-03-02 00:23:38.500825 | 
2026-03-02 00:23:38.500976 | TASK [bindep : Include bindep tasks]
2026-03-02 00:23:38.537341 | controller | skipping: Conditional result was False
2026-03-02 00:23:38.551088 | 
2026-03-02 00:23:38.551255 | TASK [bindep : Include install tasks]
2026-03-02 00:23:38.578204 | controller | skipping: Conditional result was False
2026-03-02 00:23:38.593484 | 
2026-03-02 00:23:38.593682 | LOOP [bindep : Include package tasks]
2026-03-02 00:23:38.663886 | 
2026-03-02 00:23:38.664182 | TASK [Run test-setup role]
2026-03-02 00:23:38.694959 | controller | ok
2026-03-02 00:23:38.725515 | 
2026-03-02 00:23:38.725645 | TASK [test-setup : Check if project's tools/test-setup.sh exists]
2026-03-02 00:23:38.951435 | controller | ok
2026-03-02 00:23:38.959480 | 
2026-03-02 00:23:38.959568 | TASK [test-setup : Run tools/test-setup.sh]
2026-03-02 00:23:39.499463 | controller | skipping: Conditional result was False
2026-03-02 00:23:39.556129 | 
2026-03-02 00:23:39.556300 | PLAY RECAP
2026-03-02 00:23:39.556362 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2026-03-02 00:23:39.556389 | 
2026-03-02 00:23:39.746829 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2026-03-02 00:23:39.748793 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master]
2026-03-02 00:23:40.365330 | 
2026-03-02 00:23:40.365500 | PLAY [controller]
2026-03-02 00:23:40.385405 | 
2026-03-02 00:23:40.385496 | TASK [Create the /root directory]
2026-03-02 00:25:52.679617 | controller | ERROR
2026-03-02 00:25:52.680054 | controller | {
2026-03-02 00:25:52.680168 | controller |   "msg": "Timeout (32s) waiting for privilege escalation prompt: "
2026-03-02 00:25:52.680248 | controller | }
failure
2026-03-02 00:25:52.682191 | 
2026-03-02 00:25:52.682305 | PLAY RECAP
2026-03-02 00:25:52.682397 | controller | ok: 0 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-03-02 00:25:52.682455 | 
2026-03-02 00:25:52.784306 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master]
2026-03-02 00:25:52.786300 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2026-03-02 00:25:53.420973 | 
2026-03-02 00:25:53.421123 | PLAY [all]
2026-03-02 00:25:53.443169 | 
2026-03-02 00:25:53.443314 | TASK [fetch-subunit-output : Find stestr or testr executable]
2026-03-02 00:29:43.807260 | controller | changed: non-zero return code
2026-03-02 00:29:43.820643 | 
2026-03-02 00:29:43.820846 | TASK [fetch-subunit-output : Get the list of directories with subunit files]
2026-03-02 00:29:43.848432 | controller | skipping: Conditional result was False
2026-03-02 00:29:43.862459 | 
2026-03-02 00:29:43.862657 | LOOP [fetch-subunit-output : Find any inflight partial subunit files]
2026-03-02 00:29:43.906134 | 
2026-03-02 00:29:43.906414 | LOOP [fetch-subunit-output : Copy any inflight subunit files]
2026-03-02 00:29:43.946113 | 
2026-03-02 00:29:43.946393 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream]
2026-03-02 00:29:43.972835 | controller | skipping: Conditional result was False
2026-03-02 00:29:43.987168 | 
2026-03-02 00:29:43.987318 | LOOP [fetch-subunit-output : Generate subunit file]
2026-03-02 00:29:44.028935 | 
2026-03-02 00:29:44.029416 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory]
2026-03-02 00:29:44.056246 | controller | skipping: Conditional result was False
2026-03-02 00:29:44.070269 | 
2026-03-02 00:29:44.070535 | TASK [fetch-subunit-output : Remove the temporary file]
2026-03-02 00:29:44.100349 | controller | skipping: Conditional result was False
2026-03-02 00:29:44.109698 | 
2026-03-02 00:29:44.109799 | TASK [fetch-subunit-output : Process and fetch subunit results]
2026-03-02 00:29:44.135629 | controller | skipping: Conditional result was False
2026-03-02 00:29:44.174476 | 
2026-03-02 00:29:44.174594 | PLAY RECAP
2026-03-02 00:29:44.174657 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2026-03-02 00:29:44.174693 | 
2026-03-02 00:29:44.312621 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2026-03-02 00:29:44.315065 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master]
2026-03-02 00:29:44.919406 | 
2026-03-02 00:29:44.919595 | PLAY [all:!appliance*]
2026-03-02 00:29:44.941729 | 
2026-03-02 00:29:44.941816 | TASK [unregister the node]
2026-03-02 00:29:45.472719 | controller | skipping: Conditional result was False
2026-03-02 00:29:45.486236 | 
2026-03-02 00:29:45.486406 | TASK [include_role : fetch-output]
2026-03-02 00:29:45.535103 | controller | ok
2026-03-02 00:29:45.577934 | 
2026-03-02 00:29:45.578141 | TASK [fetch-output : Set log path for multiple nodes]
2026-03-02 00:29:45.645276 | controller | skipping: Conditional result was False
2026-03-02 00:29:45.658137 | 
2026-03-02 00:29:45.658279 | TASK [fetch-output : Set log path for single node]
2026-03-02 00:29:45.708362 | controller | ok
2026-03-02 00:29:45.721229 | 
2026-03-02 00:29:45.721383 | LOOP [fetch-output : Ensure local output dirs]
2026-03-02 00:29:46.158109 | controller -> localhost | ok: "/var/lib/zuul/builds/16365dee7ce048c2a9a0b99a391c0963/work/logs"
2026-03-02 00:29:46.418499 | controller -> localhost | changed: "/var/lib/zuul/builds/16365dee7ce048c2a9a0b99a391c0963/work/artifacts"
2026-03-02 00:29:46.647662 | controller -> localhost | changed: "/var/lib/zuul/builds/16365dee7ce048c2a9a0b99a391c0963/work/docs"
2026-03-02 00:29:46.666049 | 
2026-03-02 00:29:46.666221 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-03-02 00:29:47.413344 | controller | ok
2026-03-02 00:29:47.413676 | controller | changed: All items complete
2026-03-02 00:29:47.413735 | 
2026-03-02 00:29:48.010252 | controller | changed: .d..t...... ./
2026-03-02 00:29:48.530057 | controller | changed: .d..t...... ./
2026-03-02 00:29:48.566872 | 
2026-03-02 00:29:48.567038 | TASK [include_role : fetch-output-openshift]
2026-03-02 00:29:48.593150 | controller | skipping: Conditional result was False
2026-03-02 00:29:48.604656 | 
2026-03-02 00:29:48.604769 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-03-02 00:29:48.636536 | controller | skipping: Conditional result was False
2026-03-02 00:29:48.648691 | controller | skipping: Conditional result was False
2026-03-02 00:29:48.696714 | 
2026-03-02 00:29:48.696938 | PLAY [localhost]
2026-03-02 00:29:48.720430 | 
2026-03-02 00:29:48.720543 | TASK [Run Zuul manifest role]
2026-03-02 00:29:48.742050 | localhost | ok
2026-03-02 00:29:48.758336 | 
2026-03-02 00:29:48.758470 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-03-02 00:29:49.148510 | localhost | changed
2026-03-02 00:29:49.158530 | 
2026-03-02 00:29:49.158655 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-03-02 00:29:49.194828 | localhost | ok
2026-03-02 00:29:49.212709 | 
2026-03-02 00:29:49.212826 | TASK [Set zuul-log-path fact]
2026-03-02 00:29:49.235445 | localhost | ok
2026-03-02 00:29:49.255455 | 
2026-03-02 00:29:49.255550 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-02 00:29:49.288916 | localhost | ok
2026-03-02 00:29:49.304683 | 
2026-03-02 00:29:49.304796 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)]
2026-03-02 00:29:49.336157 | localhost | ok:
2026-03-02 00:29:49.336425 | localhost | {
2026-03-02 00:29:49.336463 | localhost |   "auth": {
2026-03-02 00:29:49.336487 | localhost |     "password": "IonWCwcuOFib&&<}wp^:[2G/",
2026-03-02 00:29:49.336510 | localhost |     "username": "9LF91O0RK7JU"
2026-03-02 00:29:49.336542 | localhost |   },
2026-03-02 00:29:49.336565 | localhost |   "profile": "rackspace",
2026-03-02 00:29:49.336590 | localhost |   "region_name": "IAD"
2026-03-02 00:29:49.336612 | localhost | }
2026-03-02 00:29:49.336649 | 
2026-03-02 00:29:49.349581 | 
2026-03-02 00:29:49.349750 | TASK [Run upload-logs-failover role (S3 then Swift)]
2026-03-02 00:29:49.372187 | localhost | Output suppressed because no_log was given
2026-03-02 00:29:49.396166 | 
2026-03-02 00:29:49.396313 | TASK [upload-logs-failover : Initialize control vars]
2026-03-02 00:29:49.426101 | localhost | ok
2026-03-02 00:29:49.431091 | 
2026-03-02 00:29:49.431174 | LOOP [upload-logs-failover : Perform log upload]
2026-03-02 00:29:49.466710 | localhost | Output suppressed because no_log was given
2026-03-02 00:29:49.505756 | localhost | included: /var/lib/zuul/builds/16365dee7ce048c2a9a0b99a391c0963/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml
2026-03-02 00:29:49.515494 | 
2026-03-02 00:29:49.515618 | LOOP [upload-logs-failover : Unpack vars for swift upload]
2026-03-02 00:29:49.604222 | localhost | Output suppressed because no_log was given
2026-03-02 00:29:49.612961 | 
2026-03-02 00:29:49.613134 | TASK [Upload logs to swift]
2026-03-02 00:29:49.637202 | localhost | ok
2026-03-02 00:29:49.663544 | 
2026-03-02 00:29:49.663653 | TASK [Set zuul-log-path fact]
2026-03-02 00:29:49.687909 | localhost | skipping: Conditional result was False
2026-03-02 00:29:49.693559 | 
2026-03-02 00:29:49.693641 | TASK [upload-logs-swift : Ensure logs are readable before uploading]
2026-03-02 00:29:50.052588 | localhost -> localhost | ok: Runtime: 0:00:00.004591
2026-03-02 00:29:50.058058 | 
2026-03-02 00:29:50.058136 | TASK [upload-logs-swift : Upload logs to swift]