2026-02-28 00:15:44.801599 | Job console starting...
2026-02-28 00:15:44.814610 | Updating repositories
2026-02-28 00:15:44.990831 | Preparing job workspace
2026-02-28 00:15:48.903074 | Running Ansible setup...
2026-02-28 00:15:53.699878 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2026-02-28 00:15:54.409043 | 
2026-02-28 00:15:54.409224 | PLAY [localhost]
2026-02-28 00:15:54.419130 | 
2026-02-28 00:15:54.419226 | TASK [Gathering Facts]
2026-02-28 00:15:55.507094 | localhost | ok
2026-02-28 00:15:55.531661 | 
2026-02-28 00:15:55.531883 | TASK [Setup log path fact]
2026-02-28 00:15:55.555576 | localhost | ok
2026-02-28 00:15:55.575784 | 
2026-02-28 00:15:55.575975 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-02-28 00:15:55.607380 | localhost | ok
2026-02-28 00:15:55.616130 | 
2026-02-28 00:15:55.616219 | TASK [emit-job-header : Print job information]
2026-02-28 00:15:55.657214 | # Job Information
2026-02-28 00:15:55.657417 | Ansible Version: 2.15.12
2026-02-28 00:15:55.657450 | Job: ansible-test-sanity-docker-devel
2026-02-28 00:15:55.657473 | Pipeline: periodic
2026-02-28 00:15:55.657492 | Executor: ze01.softwarefactory-project.io
2026-02-28 00:15:55.657510 | Triggered by: https://github.com/ansible-collections/ansible.network
2026-02-28 00:15:55.657531 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/fb1/ansible/fb16b8320c954b40addaa14d41afac57/
2026-02-28 00:15:55.657549 | Event ID: 2ec722b134c44e47b6e2008fb7cdb67f
2026-02-28 00:15:55.661281 | 
2026-02-28 00:15:55.661346 | LOOP [emit-job-header : Print node information]
2026-02-28 00:15:55.772920 | localhost | ok:
2026-02-28 00:15:55.773285 | localhost | # Node Information
2026-02-28 00:15:55.773323 | localhost | Inventory Hostname: controller
2026-02-28 00:15:55.773344 | localhost | Hostname: np0005633742
2026-02-28 00:15:55.773363 | localhost | Username: zuul
2026-02-28 00:15:55.773387 | localhost | Distro: Fedora 37
2026-02-28 00:15:55.773407 | localhost | Provider: ansible-vexxhost-ca-ymq-1
2026-02-28 00:15:55.773425 | localhost | Region: ca-ymq-1
2026-02-28 00:15:55.773442 | localhost | Label: ansible-fedora-37-1vcpu
2026-02-28 00:15:55.773458 | localhost | Product Name: OpenStack Nova
2026-02-28 00:15:55.773475 | localhost | Interface IP: 199.204.45.155
2026-02-28 00:15:55.792618 | 
2026-02-28 00:15:55.792807 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-02-28 00:15:56.231085 | localhost -> localhost | changed
2026-02-28 00:15:56.237736 | 
2026-02-28 00:15:56.237850 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-02-28 00:15:57.251476 | localhost -> localhost | changed
2026-02-28 00:15:57.298451 | 
2026-02-28 00:15:57.298673 | PLAY [all:!appliance*]
2026-02-28 00:15:57.323953 | 
2026-02-28 00:15:57.324127 | TASK [include_role : start-zuul-console]
2026-02-28 00:15:57.348644 | controller | ok
2026-02-28 00:15:57.369210 | 
2026-02-28 00:15:57.369336 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-02-28 00:15:57.782952 | controller | ok
2026-02-28 00:15:57.802216 | 
2026-02-28 00:15:57.802393 | TASK [use-our-mirror : Retrieve the IP address]
2026-02-28 00:15:58.825968 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found
2026-02-28 00:15:58.841396 | 
2026-02-28 00:15:58.841550 | TASK [use-our-mirror : Ensure the registry service is running on the mirror]
2026-02-28 00:15:59.392253 | controller | skipping: Conditional result was False
2026-02-28 00:15:59.406855 | 
2026-02-28 00:15:59.407109 | TASK [use-our-mirror : Write the IP in /etc/hosts]
2026-02-28 00:15:59.436632 | controller | skipping: Conditional result was False
2026-02-28 00:15:59.449215 | 
2026-02-28 00:15:59.449407 | TASK [use-our-mirror : Create the podman configuration directory]
2026-02-28 00:15:59.475769 | controller | skipping: Conditional result was False
2026-02-28 00:15:59.486614 | 
2026-02-28 00:15:59.486808 | TASK [use-our-mirror : Copy the podman configuration]
2026-02-28 00:15:59.513273 | controller | skipping: Conditional result was False
2026-02-28 00:15:59.521712 | 
2026-02-28 00:15:59.521919 | TASK [use-our-mirror : Copy the Yum configuration (main)]
2026-02-28 00:15:59.547321 | controller | skipping: Conditional result was False
2026-02-28 00:15:59.558046 | 
2026-02-28 00:15:59.558246 | TASK [use-our-mirror : Copy the Yum configuration (update)]
2026-02-28 00:15:59.584580 | controller | skipping: Conditional result was False
2026-02-28 00:15:59.604316 | 
2026-02-28 00:15:59.604514 | TASK [Disable Fedora Modular]
2026-02-28 00:15:59.864674 | controller | changed
2026-02-28 00:15:59.871636 | 
2026-02-28 00:15:59.871737 | TASK [Enable EPEL]
2026-02-28 00:15:59.886848 | controller | skipping: Conditional result was False
2026-02-28 00:15:59.895079 | 
2026-02-28 00:15:59.895198 | TASK [Register the RHEL node]
2026-02-28 00:16:00.447810 | 
2026-02-28 00:16:00.448285 | TASK [Show the subscription-manager status]
2026-02-28 00:16:01.053245 | controller | skipping: Conditional result was False
2026-02-28 00:16:01.063970 | 
2026-02-28 00:16:01.064131 | TASK [Enable EPEL on RHEL]
2026-02-28 00:16:01.612987 | controller | skipping: Conditional result was False
2026-02-28 00:16:01.629624 | 
2026-02-28 00:16:01.629811 | TASK [Install git and tox]
2026-02-28 00:17:20.532890 | controller | changed
2026-02-28 00:17:20.547739 | 
2026-02-28 00:17:20.547887 | TASK [include_role : prepare-workspace]
2026-02-28 00:17:20.590686 | controller | ok
2026-02-28 00:17:20.630206 | 
2026-02-28 00:17:20.630386 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-02-28 00:17:20.884600 | controller | ok
2026-02-28 00:17:20.891752 | 
2026-02-28 00:17:20.891822 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-02-28 00:17:33.915318 | controller | Output suppressed because no_log was given
2026-02-28 00:17:33.966811 | 
2026-02-28 00:17:33.966950 | TASK [include_role : prepare-workspace-openshift]
2026-02-28 00:17:33.992633 | controller | skipping: Conditional result was False
2026-02-28 00:17:34.018886 | 
2026-02-28 00:17:34.018972 | PLAY [all:!appliance]
2026-02-28 00:17:34.036763 | 
2026-02-28 00:17:34.036891 | TASK [Run add-build-sshkey role (RSA)]
2026-02-28 00:17:34.070297 | controller | ok
2026-02-28 00:17:34.087397 | 
2026-02-28 00:17:34.087548 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-02-28 00:17:34.370802 | controller -> localhost | ok
2026-02-28 00:17:34.390102 | 
2026-02-28 00:17:34.390335 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-02-28 00:17:34.439150 | controller | ok
2026-02-28 00:17:34.460307 | controller | included: /var/lib/zuul/builds/fb16b8320c954b40addaa14d41afac57/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-02-28 00:17:34.467422 | 
2026-02-28 00:17:34.467524 | TASK [add-build-sshkey : Create Temp SSH key]
2026-02-28 00:17:34.943425 | controller -> localhost | Generating public/private rsa key pair.
2026-02-28 00:17:34.943695 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/fb16b8320c954b40addaa14d41afac57/work/fb16b8320c954b40addaa14d41afac57_id_rsa.
2026-02-28 00:17:34.943735 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/fb16b8320c954b40addaa14d41afac57/work/fb16b8320c954b40addaa14d41afac57_id_rsa.pub.
2026-02-28 00:17:34.943764 | controller -> localhost | The key fingerprint is:
2026-02-28 00:17:34.943792 | controller -> localhost | SHA256:Hi/+4d/n+zDgqhOS5o2AJDY4ax5YgMd9akG/EBKg3eQ zuul-build-sshkey
2026-02-28 00:17:34.943819 | controller -> localhost | The key's randomart image is:
2026-02-28 00:17:34.943846 | controller -> localhost | +---[RSA 2048]----+
2026-02-28 00:17:34.943872 | controller -> localhost | |ooo++            |
2026-02-28 00:17:34.943899 | controller -> localhost | |+.o=oo.          |
2026-02-28 00:17:34.943925 | controller -> localhost | |oo. E+.          |
2026-02-28 00:17:34.943951 | controller -> localhost | |+oo o. .         |
2026-02-28 00:17:34.943977 | controller -> localhost | |o*.o  ..S   .    |
2026-02-28 00:17:34.944039 | controller -> localhost | |oo. . +..o . .   |
2026-02-28 00:17:34.944080 | controller -> localhost | |o .  + +o.o . o  |
2026-02-28 00:17:34.944110 | controller -> localhost | | .    o.oo o . o.|
2026-02-28 00:17:34.944137 | controller -> localhost | |        o++.. .+=|
2026-02-28 00:17:34.944167 | controller -> localhost | +----[SHA256]-----+
2026-02-28 00:17:34.944228 | controller -> localhost | ok: Runtime: 0:00:00.032105
2026-02-28 00:17:34.954706 | 
2026-02-28 00:17:34.954865 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-02-28 00:17:34.994271 | controller | ok
2026-02-28 00:17:35.008727 | controller | included: /var/lib/zuul/builds/fb16b8320c954b40addaa14d41afac57/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-02-28 00:17:35.023500 | 
2026-02-28 00:17:35.023640 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-02-28 00:17:35.050758 | controller | skipping: Conditional result was False
2026-02-28 00:17:35.060968 | 
2026-02-28 00:17:35.061123 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-02-28 00:17:35.527595 | controller | changed
2026-02-28 00:17:35.537702 | 
2026-02-28 00:17:35.537842 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-02-28 00:17:35.763820 | controller | ok
2026-02-28 00:17:35.774959 | 
2026-02-28 00:17:35.775163 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-02-28 00:17:36.397491 | controller | changed
2026-02-28 00:17:36.408224 | 
2026-02-28 00:17:36.408415 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-02-28 00:17:37.067093 | controller | changed
2026-02-28 00:17:37.084312 | 
2026-02-28 00:17:37.084579 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-02-28 00:17:37.113151 | controller | skipping: Conditional result was False
2026-02-28 00:17:37.123597 | 
2026-02-28 00:17:37.123704 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-02-28 00:17:37.570772 | controller -> localhost | changed
2026-02-28 00:17:37.604638 | 
2026-02-28 00:17:37.605067 | TASK [add-build-sshkey : Add back temp key]
2026-02-28 00:17:38.002714 | controller -> localhost | Identity added: /var/lib/zuul/builds/fb16b8320c954b40addaa14d41afac57/work/fb16b8320c954b40addaa14d41afac57_id_rsa (zuul-build-sshkey)
2026-02-28 00:17:38.003341 | controller -> localhost | ok: Runtime: 0:00:00.017782
2026-02-28 00:17:38.022769 | 
2026-02-28 00:17:38.022953 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-02-28 00:17:38.384222 | controller | ok
2026-02-28 00:17:38.395510 | 
2026-02-28 00:17:38.395863 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-02-28 00:17:38.424659 | controller | skipping: Conditional result was False
2026-02-28 00:17:38.448779 | 
2026-02-28 00:17:38.448959 | TASK [Run add-build-sshkey role (ECDSA)]
2026-02-28 00:17:38.481665 | controller | ok
2026-02-28 00:17:38.510731 | 
2026-02-28 00:17:38.510899 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-02-28 00:17:38.815196 | controller -> localhost | ok
2026-02-28 00:17:38.823883 | 
2026-02-28 00:17:38.824033 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-02-28 00:17:38.857521 | controller | ok
2026-02-28 00:17:38.871776 | controller | included: /var/lib/zuul/builds/fb16b8320c954b40addaa14d41afac57/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-02-28 00:17:38.880968 | 
2026-02-28 00:17:38.881310 | TASK [add-build-sshkey : Create Temp SSH key]
2026-02-28 00:17:39.215100 | controller -> localhost | Generating public/private ecdsa key pair.
2026-02-28 00:17:39.215585 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/fb16b8320c954b40addaa14d41afac57/work/fb16b8320c954b40addaa14d41afac57_id_ecdsa.
2026-02-28 00:17:39.215652 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/fb16b8320c954b40addaa14d41afac57/work/fb16b8320c954b40addaa14d41afac57_id_ecdsa.pub.
2026-02-28 00:17:39.215717 | controller -> localhost | The key fingerprint is:
2026-02-28 00:17:39.215764 | controller -> localhost | SHA256:NGTO2PqWj80S/4T9AdURSJ3p028seusbPe/8ZAVVMPw zuul-build-sshkey
2026-02-28 00:17:39.215812 | controller -> localhost | The key's randomart image is:
2026-02-28 00:17:39.215853 | controller -> localhost | +---[ECDSA 521]---+
2026-02-28 00:17:39.215927 | controller -> localhost | |        o   .o=+B|
2026-02-28 00:17:39.215972 | controller -> localhost | |       B     ..B.|
2026-02-28 00:17:39.216043 | controller -> localhost | |      . *     +.o|
2026-02-28 00:17:39.216095 | controller -> localhost | |       o .   . +E|
2026-02-28 00:17:39.216135 | controller -> localhost | |      . S   .  .+|
2026-02-28 00:17:39.216175 | controller -> localhost | |       ... o ...=|
2026-02-28 00:17:39.216213 | controller -> localhost | |        +o. o.o++|
2026-02-28 00:17:39.216252 | controller -> localhost | |       ..=.....*o|
2026-02-28 00:17:39.216290 | controller -> localhost | |        ..+..o=+*|
2026-02-28 00:17:39.216327 | controller -> localhost | +----[SHA256]-----+
2026-02-28 00:17:39.216425 | controller -> localhost | ok: Runtime: 0:00:00.009897
2026-02-28 00:17:39.229073 | 
2026-02-28 00:17:39.229271 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-02-28 00:17:39.263914 | controller | ok
2026-02-28 00:17:39.272881 | controller | included: /var/lib/zuul/builds/fb16b8320c954b40addaa14d41afac57/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-02-28 00:17:39.282845 | 
2026-02-28 00:17:39.282977 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-02-28 00:17:39.308239 | controller | skipping: Conditional result was False
2026-02-28 00:17:39.316524 | 
2026-02-28 00:17:39.316639 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-02-28 00:17:39.611424 | controller | changed
2026-02-28 00:17:39.625466 | 
2026-02-28 00:17:39.625651 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-02-28 00:17:39.873771 | controller | ok
2026-02-28 00:17:39.888816 | 
2026-02-28 00:17:39.888985 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-02-28 00:17:40.556851 | controller | changed
2026-02-28 00:17:40.570407 | 
2026-02-28 00:17:40.570559 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-02-28 00:17:41.194118 | controller | changed
2026-02-28 00:17:41.207747 | 
2026-02-28 00:17:41.207930 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-02-28 00:17:41.245596 | controller | skipping: Conditional result was False
2026-02-28 00:17:41.261789 | 
2026-02-28 00:17:41.261982 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-02-28 00:17:41.613817 | controller -> localhost | changed
2026-02-28 00:17:41.629064 | 
2026-02-28 00:17:41.629217 | TASK [add-build-sshkey : Add back temp key]
2026-02-28 00:17:41.980904 | controller -> localhost | Identity added: /var/lib/zuul/builds/fb16b8320c954b40addaa14d41afac57/work/fb16b8320c954b40addaa14d41afac57_id_ecdsa (zuul-build-sshkey)
2026-02-28 00:17:41.981281 | controller -> localhost | ok: Runtime: 0:00:00.010785
2026-02-28 00:17:41.988631 | 
2026-02-28 00:17:41.988709 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-02-28 00:17:42.200749 | controller | ok
2026-02-28 00:17:42.213576 | 
2026-02-28 00:17:42.213764 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-02-28 00:17:42.241499 | controller | skipping: Conditional result was False
2026-02-28 00:17:42.267767 | 
2026-02-28 00:17:42.267945 | TASK [include_role : remove-zuul-sshkey]
2026-02-28 00:17:42.285128 | controller | skipping: Conditional result was False
2026-02-28 00:17:42.295877 | 
2026-02-28 00:17:42.296058 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-02-28 00:17:42.526371 | controller | ok: "logs"
2026-02-28 00:17:42.527071 | controller | ok: All items complete
2026-02-28 00:17:42.527157 | 
2026-02-28 00:17:42.719563 | controller | ok: "artifacts"
2026-02-28 00:17:42.922681 | controller | ok: "docs"
2026-02-28 00:17:42.938712 | 
2026-02-28 00:17:42.939278 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-02-28 00:17:43.195438 | controller | changed: "logs"
2026-02-28 00:17:43.387513 | controller | changed: "artifacts"
2026-02-28 00:17:43.589001 | controller | changed: "docs"
2026-02-28 00:17:43.627695 | 
2026-02-28 00:17:43.627846 | PLAY RECAP
2026-02-28 00:17:43.627903 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0
2026-02-28 00:17:43.627938 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-02-28 00:17:43.627963 | 
2026-02-28 00:17:43.774766 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2026-02-28 00:17:43.776288 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2026-02-28 00:17:44.435386 | 
2026-02-28 00:17:44.435561 | PLAY [all]
2026-02-28 00:17:44.463803 | 
2026-02-28 00:17:44.463997 | TASK [Install binary dependencies]
2026-02-28 00:17:44.558754 | controller | ok
2026-02-28 00:17:44.581318 | 
2026-02-28 00:17:44.581548 | TASK [bindep : Include find tasks]
2026-02-28 00:17:44.611720 | controller | ok
2026-02-28 00:17:44.620126 | controller | included: /var/lib/zuul/builds/fb16b8320c954b40addaa14d41afac57/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml
2026-02-28 00:17:44.626666 | 
2026-02-28 00:17:44.626732 | TASK [bindep : Look for bindep.txt]
2026-02-28 00:17:45.005263 | controller | ok
2026-02-28 00:17:45.020994 | 
2026-02-28 00:17:45.021356 | TASK [bindep : Define bindep_file fact]
2026-02-28 00:17:45.038988 | controller | skipping: Conditional result was False
2026-02-28 00:17:45.049494 | 
2026-02-28 00:17:45.050002 | TASK [bindep : Look for other-requirements.txt]
2026-02-28 00:17:45.284715 | controller | ok
2026-02-28 00:17:45.299324 | 
2026-02-28 00:17:45.299539 | TASK [bindep : Define bindep_file fact]
2026-02-28 00:17:45.338008 | controller | skipping: Conditional result was False
2026-02-28 00:17:45.354811 | 
2026-02-28 00:17:45.355078 | TASK [bindep : Look for bindep fallback file]
2026-02-28 00:17:45.404791 | controller | skipping: Conditional result was False
2026-02-28 00:17:45.416064 | 
2026-02-28 00:17:45.416183 | TASK [bindep : Define bindep_file fact]
2026-02-28 00:17:45.452126 | controller | skipping: Conditional result was False
2026-02-28 00:17:45.462165 | 
2026-02-28 00:17:45.462268 | TASK [bindep : Include bindep tasks]
2026-02-28 00:17:45.488680 | controller | skipping: Conditional result was False
2026-02-28 00:17:45.497567 | 
2026-02-28 00:17:45.498127 | TASK [bindep : Include install tasks]
2026-02-28 00:17:45.526356 | controller | skipping: Conditional result was False
2026-02-28 00:17:45.535681 | 
2026-02-28 00:17:45.535866 | LOOP [bindep : Include package tasks]
2026-02-28 00:17:45.595455 | 
2026-02-28 00:17:45.595671 | TASK [Run test-setup role]
2026-02-28 00:17:45.620468 | controller | ok
2026-02-28 00:17:45.642515 | 
2026-02-28 00:17:45.642698 | TASK [test-setup : Check if project's tools/test-setup.sh exists]
2026-02-28 00:17:45.862405 | controller | ok
2026-02-28 00:17:45.872494 | 
2026-02-28 00:17:45.872652 | TASK [test-setup : Run tools/test-setup.sh]
2026-02-28 00:17:46.419417 | controller | skipping: Conditional result was False
2026-02-28 00:17:46.480934 | 
2026-02-28 00:17:46.481101 | PLAY RECAP
2026-02-28 00:17:46.481194 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2026-02-28 00:17:46.481247 | 
2026-02-28 00:17:46.626939 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2026-02-28 00:17:46.629780 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master]
2026-02-28 00:17:47.295354 | 
2026-02-28 00:17:47.295531 | PLAY [controller]
2026-02-28 00:17:47.317627 | 
2026-02-28 00:17:47.317793 | TASK [Create the /root directory]
2026-02-28 00:19:59.687938 | controller | ERROR
2026-02-28 00:19:59.688232 | controller | {
2026-02-28 00:19:59.688284 | controller |   "msg": "Timeout (32s) waiting for privilege escalation prompt: "
2026-02-28 00:19:59.688325 | controller | }
failure
2026-02-28 00:19:59.689409 | 
2026-02-28 00:19:59.689467 | PLAY RECAP
2026-02-28 00:19:59.689519 | controller | ok: 0 changed: 0 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0
2026-02-28 00:19:59.689542 | 
2026-02-28 00:19:59.798225 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master]
2026-02-28 00:19:59.799292 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2026-02-28 00:20:00.385091 | 
2026-02-28 00:20:00.385231 | PLAY [all]
2026-02-28 00:20:00.408409 | 
2026-02-28 00:20:00.408562 | TASK [fetch-subunit-output : Find stestr or testr executable]
2026-02-28 00:22:48.122262 | controller | changed: non-zero return code
2026-02-28 00:22:48.136810 | 
2026-02-28 00:22:48.137292 | TASK [fetch-subunit-output : Get the list of directories with subunit files]
2026-02-28 00:22:48.166765 | controller | skipping: Conditional result was False
2026-02-28 00:22:48.177192 | 
2026-02-28 00:22:48.177329 | LOOP [fetch-subunit-output : Find any inflight partial subunit files]
2026-02-28 00:22:48.214880 | 
2026-02-28 00:22:48.215159 | LOOP [fetch-subunit-output : Copy any inflight subunit files]
2026-02-28 00:22:48.264620 | 
2026-02-28 00:22:48.264890 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream]
2026-02-28 00:22:48.292208 | controller | skipping: Conditional result was False
2026-02-28 00:22:48.302366 | 
2026-02-28 00:22:48.302480 | LOOP [fetch-subunit-output : Generate subunit file]
2026-02-28 00:22:48.338892 | 
2026-02-28 00:22:48.339145 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory]
2026-02-28 00:22:48.364988 | controller | skipping: Conditional result was False
2026-02-28 00:22:48.376228 | 
2026-02-28 00:22:48.376365 | TASK [fetch-subunit-output : Remove the temporary file]
2026-02-28 00:22:48.402195 | controller | skipping: Conditional result was False
2026-02-28 00:22:48.410972 | 
2026-02-28 00:22:48.411090 | TASK [fetch-subunit-output : Process and fetch subunit results]
2026-02-28 00:22:48.437449 | controller | skipping: Conditional result was False
2026-02-28 00:22:48.476942 | 
2026-02-28 00:22:48.477150 | PLAY RECAP
2026-02-28 00:22:48.477216 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2026-02-28 00:22:48.477247 | 
2026-02-28 00:22:48.585762 | POST-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2026-02-28 00:22:48.586866 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master]
2026-02-28 00:22:49.294915 | 
2026-02-28 00:22:49.295094 | PLAY [all:!appliance*]
2026-02-28 00:22:49.320009 | 
2026-02-28 00:22:49.320241 | TASK [unregister the node]
2026-02-28 00:22:49.853263 | controller | skipping: Conditional result was False
2026-02-28 00:22:49.859759 | 
2026-02-28 00:22:49.859869 | TASK [include_role : fetch-output]
2026-02-28 00:22:49.892306 | controller | ok
2026-02-28 00:22:49.915952 | 
2026-02-28 00:22:49.916133 | TASK [fetch-output : Set log path for multiple nodes]
2026-02-28 00:22:49.982300 | controller | skipping: Conditional result was False
2026-02-28 00:22:49.989387 | 
2026-02-28 00:22:49.989517 | TASK [fetch-output : Set log path for single node]
2026-02-28 00:22:50.031365 | controller | ok
2026-02-28 00:22:50.036975 | 
2026-02-28 00:22:50.037119 | LOOP [fetch-output : Ensure local output dirs]
2026-02-28 00:22:50.466119 | controller -> localhost | ok: "/var/lib/zuul/builds/fb16b8320c954b40addaa14d41afac57/work/logs"
2026-02-28 00:22:50.709216 | controller -> localhost | changed: "/var/lib/zuul/builds/fb16b8320c954b40addaa14d41afac57/work/artifacts"
2026-02-28 00:22:50.973852 | controller -> localhost | changed: "/var/lib/zuul/builds/fb16b8320c954b40addaa14d41afac57/work/docs"
2026-02-28 00:22:50.990732 | 
2026-02-28 00:22:50.990865 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-02-28 00:22:51.710012 | controller | ok
2026-02-28 00:22:51.710416 | controller | changed: All items complete
2026-02-28 00:22:51.710478 | 
2026-02-28 00:22:52.262150 | controller | changed: .d..t...... ./
2026-02-28 00:22:52.837805 | controller | changed: .d..t...... ./
2026-02-28 00:22:52.866718 | 
2026-02-28 00:22:52.866996 | TASK [include_role : fetch-output-openshift]
2026-02-28 00:22:52.884920 | controller | skipping: Conditional result was False
2026-02-28 00:22:52.900631 | 
2026-02-28 00:22:52.900784 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-02-28 00:22:52.936064 | controller | skipping: Conditional result was False
2026-02-28 00:22:52.944068 | controller | skipping: Conditional result was False
2026-02-28 00:22:53.003921 | 
2026-02-28 00:22:53.004097 | PLAY [localhost]
2026-02-28 00:22:53.021654 | 
2026-02-28 00:22:53.021757 | TASK [Run Zuul manifest role]
2026-02-28 00:22:53.044518 | localhost | ok
2026-02-28 00:22:53.068699 | 
2026-02-28 00:22:53.068880 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-02-28 00:22:53.501489 | localhost | changed
2026-02-28 00:22:53.509723 | 
2026-02-28 00:22:53.509954 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-02-28 00:22:53.554922 | localhost | ok
2026-02-28 00:22:53.567651 | 
2026-02-28 00:22:53.567773 | TASK [Set zuul-log-path fact]
2026-02-28 00:22:53.590482 | localhost | ok
2026-02-28 00:22:53.614464 | 
2026-02-28 00:22:53.614650 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-02-28 00:22:53.648234 | localhost | ok
2026-02-28 00:22:53.660565 | 
2026-02-28 00:22:53.660681 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)]
2026-02-28 00:22:53.696512 | localhost | ok:
2026-02-28 00:22:53.696905 | localhost | {
2026-02-28 00:22:53.697003 | localhost |   "auth": {
2026-02-28 00:22:53.697111 | localhost |     "password": "IonWCwcuOFib&&<}wp^:[2G/",
2026-02-28 00:22:53.697155 | localhost |     "username": "9LF91O0RK7JU"
2026-02-28 00:22:53.697203 | localhost |   },
2026-02-28 00:22:53.697242 | localhost |   "profile": "rackspace",
2026-02-28 00:22:53.697278 | localhost |   "project_name": "1251317",
2026-02-28 00:22:53.697314 | localhost |   "region_name": "DFW"
2026-02-28 00:22:53.697349 | localhost | }
2026-02-28 00:22:53.697399 | 
2026-02-28 00:22:53.704627 | 
2026-02-28 00:22:53.704775 | TASK [Run upload-logs-failover role (S3 then Swift)]
2026-02-28 00:22:53.730868 | localhost | Output suppressed because no_log was given
2026-02-28 00:22:53.758429 | 
2026-02-28 00:22:53.758601 | TASK [upload-logs-failover : Initialize control vars]
2026-02-28 00:22:53.792063 | localhost | ok
2026-02-28 00:22:53.839216 | 
2026-02-28 00:22:53.839366 | LOOP [upload-logs-failover : Perform log upload]
2026-02-28 00:22:53.866839 | localhost | Output suppressed because no_log was given
2026-02-28 00:22:53.876663 | localhost | included: /var/lib/zuul/builds/fb16b8320c954b40addaa14d41afac57/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml
2026-02-28 00:22:53.884861 | 
2026-02-28 00:22:53.884965 | LOOP [upload-logs-failover : Unpack vars for swift upload]
2026-02-28 00:22:53.962087 | localhost | Output suppressed because no_log was given
2026-02-28 00:22:53.969990 | 
2026-02-28 00:22:53.970144 | TASK [Upload logs to swift]
2026-02-28 00:22:53.992967 | localhost | ok
2026-02-28 00:22:54.028750 | 
2026-02-28 00:22:54.028893 | TASK [Set zuul-log-path fact]
2026-02-28 00:22:54.064214 | localhost | skipping: Conditional result was False
2026-02-28 00:22:54.069814 | 
2026-02-28 00:22:54.069891 | TASK [upload-logs-swift : Ensure logs are readable before uploading]
2026-02-28 00:22:54.524496 | localhost -> localhost | ok: Runtime: 0:00:00.005596
2026-02-28 00:22:54.537280 | 
2026-02-28 00:22:54.537476 | TASK [upload-logs-swift : Upload logs to swift]