2026-03-12 00:06:49.656331 | Job console starting...
2026-03-12 00:06:49.665020 | Updating repositories
2026-03-12 00:06:49.839785 | Preparing job workspace
2026-03-12 00:06:53.616969 | Running Ansible setup...
2026-03-12 00:06:58.683143 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2026-03-12 00:06:59.428060 | 
2026-03-12 00:06:59.428262 | PLAY [localhost]
2026-03-12 00:06:59.437977 | 
2026-03-12 00:06:59.438055 | TASK [Gathering Facts]
2026-03-12 00:07:00.546334 | localhost | ok
2026-03-12 00:07:00.569196 | 
2026-03-12 00:07:00.569398 | TASK [Setup log path fact]
2026-03-12 00:07:00.588599 | localhost | ok
2026-03-12 00:07:00.602192 | 
2026-03-12 00:07:00.602269 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-12 00:07:00.632558 | localhost | ok
2026-03-12 00:07:00.641243 | 
2026-03-12 00:07:00.641319 | TASK [emit-job-header : Print job information]
2026-03-12 00:07:00.691564 | # Job Information
2026-03-12 00:07:00.691795 | Ansible Version: 2.15.12
2026-03-12 00:07:00.691832 | Job: ansible-test-sanity-docker-stable-2.10
2026-03-12 00:07:00.691855 | Pipeline: periodic
2026-03-12 00:07:00.691875 | Executor: ze04.softwarefactory-project.io
2026-03-12 00:07:00.691894 | Triggered by: https://github.com/ansible-collections/ansible.network
2026-03-12 00:07:00.691916 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/390/ansible/390b1d09ed1443d5b74be9009f2011f1/
2026-03-12 00:07:00.691936 | Event ID: 1521915404ba4f519e0765e96d83261c
2026-03-12 00:07:00.698073 | 
2026-03-12 00:07:00.698156 | LOOP [emit-job-header : Print node information]
2026-03-12 00:07:00.858830 | localhost | ok:
2026-03-12 00:07:00.859243 | localhost | # Node Information
2026-03-12 00:07:00.859362 | localhost | Inventory Hostname: controller
2026-03-12 00:07:00.859423 | localhost | Hostname: np0005644941
2026-03-12 00:07:00.859483 | localhost | Username: zuul
2026-03-12 00:07:00.859568 | localhost | Distro: Fedora 37
2026-03-12 00:07:00.859627 | localhost | Provider: ansible-vexxhost-ca-ymq-1
2026-03-12 00:07:00.859704 | localhost | Region: ca-ymq-1
2026-03-12 00:07:00.859756 | localhost | Label: ansible-fedora-37-1vcpu
2026-03-12 00:07:00.859813 | localhost | Product Name: OpenStack Nova
2026-03-12 00:07:00.859898 | localhost | Interface IP: 162.253.55.110
2026-03-12 00:07:00.882041 | 
2026-03-12 00:07:00.882257 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-03-12 00:07:01.370561 | localhost -> localhost | changed
2026-03-12 00:07:01.376194 | 
2026-03-12 00:07:01.376269 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-03-12 00:07:02.244244 | localhost -> localhost | changed
2026-03-12 00:07:02.263568 | 
2026-03-12 00:07:02.263648 | PLAY [all:!appliance*]
2026-03-12 00:07:02.279994 | 
2026-03-12 00:07:02.280142 | TASK [include_role : start-zuul-console]
2026-03-12 00:07:02.299588 | controller | ok
2026-03-12 00:07:02.314308 | 
2026-03-12 00:07:02.314404 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-03-12 00:07:02.774905 | controller | ok
2026-03-12 00:07:02.802400 | 
2026-03-12 00:07:02.802508 | TASK [use-our-mirror : Retrieve the IP address]
2026-03-12 00:07:04.288994 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found
2026-03-12 00:07:04.299771 | 
2026-03-12 00:07:04.299875 | TASK [use-our-mirror : Ensure the registry service is running on the mirror]
2026-03-12 00:07:04.841036 | controller | skipping: Conditional result was False
2026-03-12 00:07:04.852219 | 
2026-03-12 00:07:04.852360 | TASK [use-our-mirror : Write the IP in /etc/hosts]
2026-03-12 00:07:04.879202 | controller | skipping: Conditional result was False
2026-03-12 00:07:04.887411 | 
2026-03-12 00:07:04.887554 | TASK [use-our-mirror : Create the podman configuration directory]
2026-03-12 00:07:04.914496 | controller | skipping: Conditional result was False
2026-03-12 00:07:04.922745 | 
2026-03-12 00:07:04.922883 | TASK [use-our-mirror : Copy the podman configuration]
2026-03-12 00:07:04.963097 | controller | skipping: Conditional result was False
2026-03-12 00:07:04.970872 | 
2026-03-12 00:07:04.970999 | TASK [use-our-mirror : Copy the Yum configuration (main)]
2026-03-12 00:07:04.995762 | controller | skipping: Conditional result was False
2026-03-12 00:07:05.004378 | 
2026-03-12 00:07:05.004494 | TASK [use-our-mirror : Copy the Yum configuration (update)]
2026-03-12 00:07:05.039284 | controller | skipping: Conditional result was False
2026-03-12 00:07:05.057071 | 
2026-03-12 00:07:05.057187 | TASK [Disable Fedora Modular]
2026-03-12 00:07:05.346820 | controller | changed
2026-03-12 00:07:05.354435 | 
2026-03-12 00:07:05.354542 | TASK [Enable EPEL]
2026-03-12 00:07:05.388561 | controller | skipping: Conditional result was False
2026-03-12 00:07:05.395561 | 
2026-03-12 00:07:05.395650 | TASK [Register the RHEL node]
2026-03-12 00:07:05.951430 | 
2026-03-12 00:07:05.953145 | TASK [Show the subscription-manager status]
2026-03-12 00:07:06.539522 | controller | skipping: Conditional result was False
2026-03-12 00:07:06.558453 | 
2026-03-12 00:07:06.558624 | TASK [Enable EPEL on RHEL]
2026-03-12 00:07:07.112139 | controller | skipping: Conditional result was False
2026-03-12 00:07:07.118539 | 
2026-03-12 00:07:07.118624 | TASK [Install git and tox]
2026-03-12 00:08:38.457167 | controller | changed
2026-03-12 00:08:38.472619 | 
2026-03-12 00:08:38.472814 | TASK [include_role : prepare-workspace]
2026-03-12 00:08:38.513389 | controller | ok
2026-03-12 00:08:38.552654 | 
2026-03-12 00:08:38.552924 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-03-12 00:08:38.803970 | controller | ok
2026-03-12 00:08:38.819451 | 
2026-03-12 00:08:38.819595 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-03-12 00:15:00.445188 | controller | Output suppressed because no_log was given
2026-03-12 00:15:00.520665 | 
2026-03-12 00:15:00.520862 | TASK [include_role : prepare-workspace-openshift]
2026-03-12 00:15:00.540445 | controller | skipping: Conditional result was False
2026-03-12 00:15:00.581346 | 
2026-03-12 00:15:00.581478 | PLAY [all:!appliance]
2026-03-12 00:15:00.608482 | 
2026-03-12 00:15:00.608598 | TASK [Run add-build-sshkey role (RSA)]
2026-03-12 00:15:00.642438 | controller | ok
2026-03-12 00:15:00.674951 | 
2026-03-12 00:15:00.675104 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-03-12 00:15:00.976492 | controller -> localhost | ok
2026-03-12 00:15:00.994414 | 
2026-03-12 00:15:00.994604 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-03-12 00:15:01.037508 | controller | ok
2026-03-12 00:15:01.066091 | controller | included: /var/lib/zuul/builds/390b1d09ed1443d5b74be9009f2011f1/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-03-12 00:15:01.075289 | 
2026-03-12 00:15:01.075406 | TASK [add-build-sshkey : Create Temp SSH key]
2026-03-12 00:15:01.651935 | controller -> localhost | Generating public/private rsa key pair.
2026-03-12 00:15:01.652147 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/390b1d09ed1443d5b74be9009f2011f1/work/390b1d09ed1443d5b74be9009f2011f1_id_rsa.
2026-03-12 00:15:01.652176 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/390b1d09ed1443d5b74be9009f2011f1/work/390b1d09ed1443d5b74be9009f2011f1_id_rsa.pub.
2026-03-12 00:15:01.652197 | controller -> localhost | The key fingerprint is:
2026-03-12 00:15:01.652216 | controller -> localhost | SHA256:T+KpO+Okg2SdSI4NyS2plNr8fv49FL4llRnvLmhiAT8 zuul-build-sshkey
2026-03-12 00:15:01.652235 | controller -> localhost | The key's randomart image is:
2026-03-12 00:15:01.652253 | controller -> localhost | +---[RSA 2048]----+
2026-03-12 00:15:01.652270 | controller -> localhost | |                 |
2026-03-12 00:15:01.652288 | controller -> localhost | |            .    |
2026-03-12 00:15:01.652306 | controller -> localhost | |..+          =   |
2026-03-12 00:15:01.652323 | controller -> localhost | |o*..  .   . + .  |
2026-03-12 00:15:01.652340 | controller -> localhost | |+O.o . oS..o .   |
2026-03-12 00:15:01.652364 | controller -> localhost | |+ O o  .E=+ . .  |
2026-03-12 00:15:01.652385 | controller -> localhost | | o o  . o+.= .   |
2026-03-12 00:15:01.652403 | controller -> localhost | |  . oo+.o.= . .  |
2026-03-12 00:15:01.652421 | controller -> localhost | |   .o==*.o.. .   |
2026-03-12 00:15:01.652441 | controller -> localhost | +----[SHA256]-----+
2026-03-12 00:15:01.652489 | controller -> localhost | ok: Runtime: 0:00:00.090091
2026-03-12 00:15:01.659183 | 
2026-03-12 00:15:01.659249 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-03-12 00:15:01.691311 | controller | ok
2026-03-12 00:15:01.701115 | controller | included: /var/lib/zuul/builds/390b1d09ed1443d5b74be9009f2011f1/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-03-12 00:15:01.709884 | 
2026-03-12 00:15:01.709944 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-03-12 00:15:01.734074 | controller | skipping: Conditional result was False
2026-03-12 00:15:01.741297 | 
2026-03-12 00:15:01.741362 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-03-12 00:15:02.393658 | controller | changed
2026-03-12 00:15:02.401970 | 
2026-03-12 00:15:02.402045 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-03-12 00:15:02.641393 | controller | ok
2026-03-12 00:15:02.654309 | 
2026-03-12 00:15:02.654482 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-03-12 00:15:03.392803 | controller | changed
2026-03-12 00:15:03.399459 | 
2026-03-12 00:15:03.399613 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-03-12 00:15:04.072670 | controller | changed
2026-03-12 00:15:04.085858 | 
2026-03-12 00:15:04.086004 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-03-12 00:15:04.113326 | controller | skipping: Conditional result was False
2026-03-12 00:15:04.129842 | 
2026-03-12 00:15:04.130004 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-03-12 00:15:04.558099 | controller -> localhost | changed
2026-03-12 00:15:04.574964 | 
2026-03-12 00:15:04.575156 | TASK [add-build-sshkey : Add back temp key]
2026-03-12 00:15:04.846697 | controller -> localhost | Identity added: /var/lib/zuul/builds/390b1d09ed1443d5b74be9009f2011f1/work/390b1d09ed1443d5b74be9009f2011f1_id_rsa (zuul-build-sshkey)
2026-03-12 00:15:04.847001 | controller -> localhost | ok: Runtime: 0:00:00.007477
2026-03-12 00:15:04.854389 | 
2026-03-12 00:15:04.854504 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-03-12 00:15:05.273752 | controller | ok
2026-03-12 00:15:05.280070 | 
2026-03-12 00:15:05.280151 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-03-12 00:15:05.304837 | controller | skipping: Conditional result was False
2026-03-12 00:15:05.317351 | 
2026-03-12 00:15:05.317448 | TASK [Run add-build-sshkey role (ECDSA)]
2026-03-12 00:15:05.338594 | controller | ok
2026-03-12 00:15:05.356860 | 
2026-03-12 00:15:05.356976 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-03-12 00:15:05.575012 | controller -> localhost | ok
2026-03-12 00:15:05.583037 | 
2026-03-12 00:15:05.583153 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-03-12 00:15:05.607605 | controller | ok
2026-03-12 00:15:05.623122 | controller | included: /var/lib/zuul/builds/390b1d09ed1443d5b74be9009f2011f1/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-03-12 00:15:05.631082 | 
2026-03-12 00:15:05.631197 | TASK [add-build-sshkey : Create Temp SSH key]
2026-03-12 00:15:05.941069 | controller -> localhost | Generating public/private ecdsa key pair.
2026-03-12 00:15:05.941310 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/390b1d09ed1443d5b74be9009f2011f1/work/390b1d09ed1443d5b74be9009f2011f1_id_ecdsa.
2026-03-12 00:15:05.941349 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/390b1d09ed1443d5b74be9009f2011f1/work/390b1d09ed1443d5b74be9009f2011f1_id_ecdsa.pub.
2026-03-12 00:15:05.941385 | controller -> localhost | The key fingerprint is:
2026-03-12 00:15:05.941416 | controller -> localhost | SHA256:zyqoPrRwmQeS6BUZ2X8HpurfcMWWxMorG47qyet8XjU zuul-build-sshkey
2026-03-12 00:15:05.941445 | controller -> localhost | The key's randomart image is:
2026-03-12 00:15:05.941472 | controller -> localhost | +---[ECDSA 521]---+
2026-03-12 00:15:05.941498 | controller -> localhost | |   .=            |
2026-03-12 00:15:05.941524 | controller -> localhost | |   + .   o.      |
2026-03-12 00:15:05.941550 | controller -> localhost | |..  . . o .o     |
2026-03-12 00:15:05.941576 | controller -> localhost | |+ ..   o..+..    |
2026-03-12 00:15:05.941600 | controller -> localhost | |...+  . SE.=     |
2026-03-12 00:15:05.941625 | controller -> localhost | |..= ..  .o=      |
2026-03-12 00:15:05.941650 | controller -> localhost | | + o.. = oo      |
2026-03-12 00:15:05.941692 | controller -> localhost | |  = oo= B.       |
2026-03-12 00:15:05.941747 | controller -> localhost | | .=@=o.=..       |
2026-03-12 00:15:05.941777 | controller -> localhost | +----[SHA256]-----+
2026-03-12 00:15:05.941845 | controller -> localhost | ok: Runtime: 0:00:00.016477
2026-03-12 00:15:05.956146 | 
2026-03-12 00:15:05.956278 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-03-12 00:15:05.997172 | controller | ok
2026-03-12 00:15:06.013790 | controller | included: /var/lib/zuul/builds/390b1d09ed1443d5b74be9009f2011f1/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-03-12 00:15:06.034453 | 
2026-03-12 00:15:06.034567 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-03-12 00:15:06.067863 | controller | skipping: Conditional result was False
2026-03-12 00:15:06.074296 | 
2026-03-12 00:15:06.074390 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-03-12 00:15:06.385500 | controller | changed
2026-03-12 00:15:06.399949 | 
2026-03-12 00:15:06.400084 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-03-12 00:15:06.664151 | controller | ok
2026-03-12 00:15:06.675019 | 
2026-03-12 00:15:06.675119 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-03-12 00:15:07.403774 | controller | changed
2026-03-12 00:15:07.412055 | 
2026-03-12 00:15:07.412129 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-03-12 00:15:08.043800 | controller | changed
2026-03-12 00:15:08.052487 | 
2026-03-12 00:15:08.052557 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-03-12 00:15:08.066652 | controller | skipping: Conditional result was False
2026-03-12 00:15:08.107476 | 
2026-03-12 00:15:08.107616 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-03-12 00:15:08.336727 | controller -> localhost | changed
2026-03-12 00:15:08.349028 | 
2026-03-12 00:15:08.349106 | TASK [add-build-sshkey : Add back temp key]
2026-03-12 00:15:08.624311 | controller -> localhost | Identity added: /var/lib/zuul/builds/390b1d09ed1443d5b74be9009f2011f1/work/390b1d09ed1443d5b74be9009f2011f1_id_ecdsa (zuul-build-sshkey)
2026-03-12 00:15:08.624555 | controller -> localhost | ok: Runtime: 0:00:00.016671
2026-03-12 00:15:08.631398 | 
2026-03-12 00:15:08.631483 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-03-12 00:15:08.837596 | controller | ok
2026-03-12 00:15:08.845569 | 
2026-03-12 00:15:08.845701 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-03-12 00:15:08.870599 | controller | skipping: Conditional result was False
2026-03-12 00:15:08.891808 | 
2026-03-12 00:15:08.891951 | TASK [include_role : remove-zuul-sshkey]
2026-03-12 00:15:08.906898 | controller | skipping: Conditional result was False
2026-03-12 00:15:08.917277 | 
2026-03-12 00:15:08.917428 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-03-12 00:15:09.131845 | controller | ok: "logs"
2026-03-12 00:15:09.138545 | controller | ok: All items complete
2026-03-12 00:15:09.138712 | 
2026-03-12 00:15:09.318288 | controller | ok: "artifacts"
2026-03-12 00:15:09.517775 | controller | ok: "docs"
2026-03-12 00:15:09.533565 | 
2026-03-12 00:15:09.533695 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-03-12 00:15:09.804585 | controller | changed: "logs"
2026-03-12 00:15:10.032851 | controller | changed: "artifacts"
2026-03-12 00:15:10.246035 | controller | changed: "docs"
2026-03-12 00:15:10.299635 | 
2026-03-12 00:15:10.299756 | PLAY RECAP
2026-03-12 00:15:10.299802 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0
2026-03-12 00:15:10.299834 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-12 00:15:10.299854 | 
2026-03-12 00:15:10.428522 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2026-03-12 00:15:10.429466 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2026-03-12 00:15:11.092926 | 
2026-03-12 00:15:11.093100 | PLAY [all]
2026-03-12 00:15:11.117145 | 
2026-03-12 00:15:11.117268 | TASK [Install binary dependencies]
2026-03-12 00:15:11.167222 | controller | ok
2026-03-12 00:15:11.189316 | 
2026-03-12 00:15:11.189442 | TASK [bindep : Include find tasks]
2026-03-12 00:15:11.219235 | controller | ok
2026-03-12 00:15:11.229099 | controller | included: /var/lib/zuul/builds/390b1d09ed1443d5b74be9009f2011f1/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml
2026-03-12 00:15:11.235756 | 
2026-03-12 00:15:11.235861 | TASK [bindep : Look for bindep.txt]
2026-03-12 00:15:11.791107 | controller | ok
2026-03-12 00:15:11.797237 | 
2026-03-12 00:15:11.797344 | TASK [bindep : Define bindep_file fact]
2026-03-12 00:15:11.822109 | controller | skipping: Conditional result was False
2026-03-12 00:15:11.832091 | 
2026-03-12 00:15:11.832248 | TASK [bindep : Look for other-requirements.txt]
2026-03-12 00:15:12.050411 | controller | ok
2026-03-12 00:15:12.059570 | 
2026-03-12 00:15:12.059800 | TASK [bindep : Define bindep_file fact]
2026-03-12 00:15:12.085353 | controller | skipping: Conditional result was False
2026-03-12 00:15:12.092582 | 
2026-03-12 00:15:12.092742 | TASK [bindep : Look for bindep fallback file]
2026-03-12 00:15:12.117037 | controller | skipping: Conditional result was False
2026-03-12 00:15:12.124631 | 
2026-03-12 00:15:12.124789 | TASK [bindep : Define bindep_file fact]
2026-03-12 00:15:12.149886 | controller | skipping: Conditional result was False
2026-03-12 00:15:12.156858 | 
2026-03-12 00:15:12.156969 | TASK [bindep : Include bindep tasks]
2026-03-12 00:15:12.181174 | controller | skipping: Conditional result was False
2026-03-12 00:15:12.188009 | 
2026-03-12 00:15:12.188166 | TASK [bindep : Include install tasks]
2026-03-12 00:15:12.212220 | controller | skipping: Conditional result was False
2026-03-12 00:15:12.219129 | 
2026-03-12 00:15:12.219261 | LOOP [bindep : Include package tasks]
2026-03-12 00:15:12.317427 | 
2026-03-12 00:15:12.317608 | TASK [Run test-setup role]
2026-03-12 00:15:12.338720 | controller | ok
2026-03-12 00:15:12.357448 | 
2026-03-12 00:15:12.357563 | TASK [test-setup : Check if project's tools/test-setup.sh exists]
2026-03-12 00:15:12.568975 | controller | ok
2026-03-12 00:15:12.584262 | 
2026-03-12 00:15:12.584743 | TASK [test-setup : Run tools/test-setup.sh]
2026-03-12 00:15:13.138228 | controller | skipping: Conditional result was False
2026-03-12 00:15:13.179511 | 
2026-03-12 00:15:13.179603 | PLAY RECAP
2026-03-12 00:15:13.179658 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2026-03-12 00:15:13.179809 | 
2026-03-12 00:15:13.275419 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2026-03-12 00:15:13.276674 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master]
2026-03-12 00:15:13.929305 | 
2026-03-12 00:15:13.929443 | PLAY [controller]
2026-03-12 00:15:13.952308 | 
2026-03-12 00:15:13.952404 | TASK [Create the /root directory]
2026-03-12 00:15:14.546820 | controller | ok
2026-03-12 00:15:14.558178 | 
2026-03-12 00:15:14.558286 | TASK [Install glibc-langpack-en]
2026-03-12 00:15:18.654312 | controller | ok: Nothing to do
2026-03-12 00:15:18.670466 | 
2026-03-12 00:15:18.670629 | TASK [Ensure controller directory exists]
2026-03-12 00:15:18.886709 | controller | changed
2026-03-12 00:15:18.895803 | 
2026-03-12 00:15:18.896220 | TASK [Install container runtime]
2026-03-12 00:15:18.949864 | controller | ok
2026-03-12 00:15:18.996042 | 
2026-03-12 00:15:18.996186 | LOOP [ensure-docker : Gather variables for each operating system]
2026-03-12 00:15:19.038345 | controller | ok: "/var/lib/zuul/builds/390b1d09ed1443d5b74be9009f2011f1/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/vars/fedora.yaml"
2026-03-12 00:15:19.047872 | 
2026-03-12 00:15:19.047988 | TASK [ensure-docker : Sanity check for distro selection]
2026-03-12 00:15:19.072508 | controller | skipping: Conditional result was False
2026-03-12 00:15:19.078552 | 
2026-03-12 00:15:19.078634 | TASK [ensure-docker : Sanity check for distro install]
2026-03-12 00:15:19.102869 | controller | skipping: Conditional result was False
2026-03-12 00:15:19.111045 | 
2026-03-12 00:15:19.111158 | TASK [ensure-docker : Sanity check for upstream install]
2026-03-12 00:15:19.156090 | controller | skipping: Conditional result was False
2026-03-12 00:15:19.166264 | 
2026-03-12 00:15:19.166388 | TASK [ensure-docker : Sanity check for upstream install mirrors]
2026-03-12 00:15:19.196500 | controller | skipping: Conditional result was False
2026-03-12 00:15:19.206724 | 
2026-03-12 00:15:19.206828 | TASK [ensure-docker : Include tasks for docker install]
2026-03-12 00:15:19.233945 | controller | ok
2026-03-12 00:15:19.257097 | controller | included: /var/lib/zuul/builds/390b1d09ed1443d5b74be9009f2011f1/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/tasks/docker-upstream.yaml
2026-03-12 00:15:19.266759 | 
2026-03-12 00:15:19.266839 | TASK [ensure-docker : Not Implemented]
2026-03-12 00:15:19.281986 | controller | skipping: Conditional result was False
2026-03-12 00:15:19.289638 | 
2026-03-12 00:15:19.289726 | TASK [Set up docker mirrors]
2026-03-12 00:15:19.314888 | controller | ok
2026-03-12 00:15:19.334582 | 
2026-03-12 00:15:19.334659 | TASK [use-docker-mirror : Set docker_mirror fact from mirror_info]
2026-03-12 00:15:19.359495 | controller | skipping: Conditional result was False
2026-03-12 00:15:19.366561 | 
2026-03-12 00:15:19.366632 | TASK [use-docker-mirror : Set docker_mirror fact from zuul_site_mirror_info]
2026-03-12 00:15:19.391221 | controller | skipping: Conditional result was False
2026-03-12 00:15:19.402039 | 
2026-03-12 00:15:19.402155 | TASK [use-docker-mirror : Set docker_mirror fact]
2026-03-12 00:15:19.426699 | controller | skipping: Conditional result was False
2026-03-12 00:15:19.434244 | 
2026-03-12 00:15:19.434320 | TASK [use-docker-mirror : Set up docker mirrors]
2026-03-12 00:15:19.458879 | controller | skipping: Conditional result was False
2026-03-12 00:15:19.473366 | 
2026-03-12 00:15:19.473461 | TASK [Add all repositories]
2026-03-12 00:15:19.493383 | controller | ok
2026-03-12 00:15:19.517869 | 
2026-03-12 00:15:19.517949 | LOOP [ensure-package-repositories : Install repositories]
2026-03-12 00:15:19.550347 | controller | ok: "/var/lib/zuul/builds/390b1d09ed1443d5b74be9009f2011f1/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-package-repositories/tasks/RedHat.yaml"
2026-03-12 00:15:19.550611 | controller | ok: All items complete
2026-03-12 00:15:19.550640 | 
2026-03-12 00:15:19.593800 | controller | included: /var/lib/zuul/builds/390b1d09ed1443d5b74be9009f2011f1/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-package-repositories/tasks/RedHat.yaml
2026-03-12 00:15:19.600738 | 
2026-03-12 00:15:19.600804 | TASK [ensure-package-repositories : Create GPG key temp directory]
2026-03-12 00:15:19.952546 | controller | changed
2026-03-12 00:15:19.964909 | 
2026-03-12 00:15:19.965013 | LOOP [ensure-package-repositories : Upload GPG keys]
2026-03-12 00:15:20.920201 | controller | changed:
2026-03-12 00:15:20.922803 | controller | {
2026-03-12 00:15:20.922891 | controller |   "data": "-----BEGIN PGP PUBLIC KEY BLOCK-----\n\nmQINBFit5IEBEADDt86QpYKz5flnCsOyZ/fk3WwBKxfDjwHf/GIflo+4GWAXS7wJ\n1PSzPsvSDATV10J44i5WQzh99q+lZvFCVRFiNhRmlmcXG+rk1QmDh3fsCCj9Q/yP\nw8jn3Hx0zDtz8PIB/18ReftYJzUo34COLiHn8WiY20uGCF2pjdPgfxE+K454c4G7\ngKFqVUFYgPug2CS0quaBB5b0rpFUdzTeI5RCStd27nHCpuSDCvRYAfdv+4Y1yiVh\nKKdoe3Smj+RnXeVMgDxtH9FJibZ3DK7WnMN2yeob6VqXox+FvKYJCCLkbQgQmE50\nuVK0uN71A1mQDcTRKQ2q3fFGlMTqJbbzr3LwnCBE6hV0a36t+DABtZTmz5O69xdJ\nWGdBeePCnWVqtDb/BdEYz7hPKskcZBarygCCe2Xi7sZieoFZuq6ltPoCsdfEdfbO\n+VBVKJnExqNZCcFUTEnbH4CldWROOzMS8BGUlkGpa59Sl1t0QcmWlw1EbkeMQNrN\nspdR8lobcdNS9bpAJQqSHRZh3cAM9mA3Yq/bssUS/P2quRXLjJ9mIv3dky9C3udM\n+q2unvnbNpPtIUly76FJ3s8g8sHeOnmYcKqNGqHq2Q3kMdA2eIbI0MqfOIo2+Xk0\nrNt3ctq3g+cQiorcN3rdHPsTRSAcp+NCz1QF9TwXYtH1XV24A6QMO0+CZwARAQAB\ntCtEb2NrZXIgUmVsZWFzZSAoQ0UgcnBtKSA8ZG9ja2VyQGRvY2tlci5jb20+iQI3\nBBMBCgAhBQJYrep4AhsvBQsJCAcDBRUKCQgLBRYCAwEAAh4BAheAAAoJEMUv62ti\nHp816C0P/iP+1uhSa6Qq3TIc5sIFE5JHxOO6y0R97cUdAmCbEqBiJHUPNQDQaaRG\nVYBm0K013Q1gcJeUJvS32gthmIvhkstw7KTodwOM8Kl11CCqZ07NPFef1b2SaJ7l\nTYpyUsT9+e343ph+O4C1oUQw6flaAJe+8ATCmI/4KxfhIjD2a/Q1voR5tUIxfexC\n/LZTx05gyf2mAgEWlRm/cGTStNfqDN1uoKMlV+WFuB1j2oTUuO1/dr8mL+FgZAM3\nntWFo9gQCllNV9ahYOON2gkoZoNuPUnHsf4Bj6BQJnIXbAhMk9H2sZzwUi9bgObZ\nXO8+OrP4D4B9kCAKqqaQqA+O46LzO2vhN74lm/Fy6PumHuviqDBdN+HgtRPMUuao\nxnuVJSvBu9sPdgT/pR1N9u/KnfAnnLtR6g+fx4mWz+ts/riB/KRHzXd+44jGKZra\nIhTMfniguMJNsyEOO0AN8Tqcl0eRBxcOArcri7xu8HFvvl+e+ILymu4buusbYEVL\nGBkYP5YMmScfKn+jnDVN4mWoN1Bq2yMhMGx6PA3hOvzPNsUoYy2BwDxNZyflzuAi\ng59mgJm2NXtzNbSRJbMamKpQ69mzLWGdFNsRd4aH7PT7uPAURaf7B5BVp3UyjERW\n5alSGnBqsZmvlRnVH5BDUhYsWZMPRQS9rRr4iGW0l+TH+O2VJ8aQ\n=0Zqq\n-----END PGP PUBLIC KEY BLOCK-----\n"
2026-03-12 00:15:20.922942 | controller | }
2026-03-12 00:15:20.956114 | 
2026-03-12 00:15:20.956285 | LOOP [ensure-package-repositories : Import GPG keys]
2026-03-12 00:15:21.575537 | controller | changed:
2026-03-12 00:15:21.575775 | controller | {
2026-03-12 00:15:21.575805 | controller |   "data": "-----BEGIN PGP PUBLIC KEY BLOCK-----\n\nmQINBFit5IEBEADDt86QpYKz5flnCsOyZ/fk3WwBKxfDjwHf/GIflo+4GWAXS7wJ\n1PSzPsvSDATV10J44i5WQzh99q+lZvFCVRFiNhRmlmcXG+rk1QmDh3fsCCj9Q/yP\nw8jn3Hx0zDtz8PIB/18ReftYJzUo34COLiHn8WiY20uGCF2pjdPgfxE+K454c4G7\ngKFqVUFYgPug2CS0quaBB5b0rpFUdzTeI5RCStd27nHCpuSDCvRYAfdv+4Y1yiVh\nKKdoe3Smj+RnXeVMgDxtH9FJibZ3DK7WnMN2yeob6VqXox+FvKYJCCLkbQgQmE50\nuVK0uN71A1mQDcTRKQ2q3fFGlMTqJbbzr3LwnCBE6hV0a36t+DABtZTmz5O69xdJ\nWGdBeePCnWVqtDb/BdEYz7hPKskcZBarygCCe2Xi7sZieoFZuq6ltPoCsdfEdfbO\n+VBVKJnExqNZCcFUTEnbH4CldWROOzMS8BGUlkGpa59Sl1t0QcmWlw1EbkeMQNrN\nspdR8lobcdNS9bpAJQqSHRZh3cAM9mA3Yq/bssUS/P2quRXLjJ9mIv3dky9C3udM\n+q2unvnbNpPtIUly76FJ3s8g8sHeOnmYcKqNGqHq2Q3kMdA2eIbI0MqfOIo2+Xk0\nrNt3ctq3g+cQiorcN3rdHPsTRSAcp+NCz1QF9TwXYtH1XV24A6QMO0+CZwARAQAB\ntCtEb2NrZXIgUmVsZWFzZSAoQ0UgcnBtKSA8ZG9ja2VyQGRvY2tlci5jb20+iQI3\nBBMBCgAhBQJYrep4AhsvBQsJCAcDBRUKCQgLBRYCAwEAAh4BAheAAAoJEMUv62ti\nHp816C0P/iP+1uhSa6Qq3TIc5sIFE5JHxOO6y0R97cUdAmCbEqBiJHUPNQDQaaRG\nVYBm0K013Q1gcJeUJvS32gthmIvhkstw7KTodwOM8Kl11CCqZ07NPFef1b2SaJ7l\nTYpyUsT9+e343ph+O4C1oUQw6flaAJe+8ATCmI/4KxfhIjD2a/Q1voR5tUIxfexC\n/LZTx05gyf2mAgEWlRm/cGTStNfqDN1uoKMlV+WFuB1j2oTUuO1/dr8mL+FgZAM3\nntWFo9gQCllNV9ahYOON2gkoZoNuPUnHsf4Bj6BQJnIXbAhMk9H2sZzwUi9bgObZ\nXO8+OrP4D4B9kCAKqqaQqA+O46LzO2vhN74lm/Fy6PumHuviqDBdN+HgtRPMUuao\nxnuVJSvBu9sPdgT/pR1N9u/KnfAnnLtR6g+fx4mWz+ts/riB/KRHzXd+44jGKZra\nIhTMfniguMJNsyEOO0AN8Tqcl0eRBxcOArcri7xu8HFvvl+e+ILymu4buusbYEVL\nGBkYP5YMmScfKn+jnDVN4mWoN1Bq2yMhMGx6PA3hOvzPNsUoYy2BwDxNZyflzuAi\ng59mgJm2NXtzNbSRJbMamKpQ69mzLWGdFNsRd4aH7PT7uPAURaf7B5BVp3UyjERW\n5alSGnBqsZmvlRnVH5BDUhYsWZMPRQS9rRr4iGW0l+TH+O2VJ8aQ\n=0Zqq\n-----END PGP PUBLIC KEY BLOCK-----\n"
2026-03-12 00:15:21.575830 | controller | }
2026-03-12 00:15:21.575863 | controller | changed: All items complete
2026-03-12 00:15:21.575883 | 
2026-03-12 00:15:21.585157 | 
2026-03-12 00:15:21.585318 | TASK [ensure-package-repositories : Remove GPG temp directory]
2026-03-12 00:15:21.806979 | controller | changed
2026-03-12 00:15:21.814563 | 
2026-03-12 00:15:21.814668 | LOOP [ensure-package-repositories : Add repositories]
2026-03-12 00:15:22.149723 | controller | changed:
2026-03-12 00:15:22.149882 | controller | {
2026-03-12 00:15:22.149908 | controller |   "baseurl": "https://download.docker.com/linux/fedora/$releasever/$basearch/stable",
2026-03-12 00:15:22.149926 | controller |   "description": "Docker CE Stable - $basearch",
2026-03-12 00:15:22.149943 | controller |   "gpgcheck": true,
2026-03-12 00:15:22.149959 | controller |   "name": "docker-ce-stable"
2026-03-12 00:15:22.149975 | controller | }
2026-03-12 00:15:22.170834 | 
2026-03-12 00:15:22.170926 | TASK [ensure-docker : Install pre-reqs]
2026-03-12 00:15:24.701785 | controller | ok: Nothing to do
2026-03-12 00:15:24.707723 | 
2026-03-12 00:15:24.707797 | TASK [ensure-docker : Remove packages]
2026-03-12 00:15:26.064855 | controller | ok: Nothing to do
2026-03-12 00:15:26.072284 | 
2026-03-12 00:15:26.072390 | TASK [ensure-docker : Install upstream docker using package]
2026-03-12 00:20:04.823733 | controller | ERROR
2026-03-12 00:20:04.824290 | controller | {
2026-03-12 00:20:04.824327 | controller |   "msg": "Data could not be sent to remote host \"162.253.55.110\". Make sure this host can be reached over ssh: ssh: connect to host 162.253.55.110 port 22: No route to host\r\n",
2026-03-12 00:20:04.824375 | controller |   "unreachable": true
2026-03-12 00:20:04.824405 | controller | }
unreachable
2026-03-12 00:20:04.826806 | 
2026-03-12 00:20:04.826860 | PLAY RECAP
2026-03-12 00:20:04.826902 | controller | ok: 13 changed: 6 unreachable: 1 failed: 0 skipped: 9 rescued: 0 ignored: 0
2026-03-12 00:20:04.826923 | 
2026-03-12 00:20:04.965829 | PRE-RUN END RESULT_UNREACHABLE: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master]
2026-03-12 00:20:04.966887 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2026-03-12 00:20:05.601924 | 
2026-03-12 00:20:05.602064 | PLAY [all]
2026-03-12 00:20:05.625616 | 
2026-03-12 00:20:05.625770 | TASK [fetch-subunit-output : Find stestr or testr executable]
2026-03-12 00:20:32.259209 | controller | ERROR
2026-03-12 00:20:32.259489 | controller | {
2026-03-12 00:20:32.259541 | controller |   "msg": "Failed to connect to the host via ssh: ssh: connect to host 162.253.55.110 port 22: No route to host",
2026-03-12 00:20:32.259582 | controller |   "unreachable": true
2026-03-12 00:20:32.259860 | controller | }
unreachable
2026-03-12 00:20:32.280039 | 
2026-03-12 00:20:32.280452 | PLAY RECAP
2026-03-12 00:20:32.280611 | controller | ok: 0 changed: 0 unreachable: 1 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-03-12 00:20:32.280745 | 
2026-03-12 00:20:32.410290 | POST-RUN END RESULT_UNREACHABLE: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2026-03-12 00:20:32.411217 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master]
2026-03-12 00:20:33.058356 | 
2026-03-12 00:20:33.058484 | PLAY [all:!appliance*]
2026-03-12 00:20:33.080729 | 
2026-03-12 00:20:33.080833 | TASK [unregister the node]
2026-03-12 00:20:38.123849 | controller | skipping: Conditional result was False
2026-03-12 00:20:38.137269 | 
2026-03-12 00:20:38.137508 | TASK [include_role : fetch-output]
2026-03-12 00:20:38.190425 | controller | ok
2026-03-12 00:20:38.226402 | 
2026-03-12 00:20:38.226525 | TASK [fetch-output : Set log path for multiple nodes]
2026-03-12 00:20:38.271351 | controller | skipping: Conditional result was False
2026-03-12 00:20:38.280438 | 
2026-03-12 00:20:38.280816 | TASK [fetch-output : Set log path for single node]
2026-03-12 00:20:38.349528 | controller | ok
2026-03-12 00:20:38.358310 | 
2026-03-12 00:20:38.358400 | LOOP [fetch-output : Ensure local output dirs]
2026-03-12 00:20:38.757834 | controller -> localhost | ok: "/var/lib/zuul/builds/390b1d09ed1443d5b74be9009f2011f1/work/logs"
2026-03-12 00:20:38.992957 | controller -> localhost | changed: "/var/lib/zuul/builds/390b1d09ed1443d5b74be9009f2011f1/work/artifacts"
2026-03-12 00:20:39.237592 | controller -> localhost | changed: "/var/lib/zuul/builds/390b1d09ed1443d5b74be9009f2011f1/work/docs"
2026-03-12 00:20:39.248572 | 
2026-03-12 00:20:39.248711 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-03-12 00:20:57.836808 | controller | changed:
2026-03-12 00:20:57.837174 | controller | .d..t...... ./
2026-03-12 00:20:57.837238 | controller | cd+++++++++ controller/
2026-03-12 00:20:57.837304 | controller | changed: All items complete
2026-03-12 00:20:57.837348 | 
2026-03-12 00:20:58.441958 | controller | changed: .d..t...... ./
2026-03-12 00:20:59.015565 | controller | changed: .d..t...... ./
2026-03-12 00:20:59.050788 | 
2026-03-12 00:20:59.050929 | TASK [include_role : fetch-output-openshift]
2026-03-12 00:20:59.078067 | controller | skipping: Conditional result was False
2026-03-12 00:20:59.086382 | 
2026-03-12 00:20:59.086469 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-03-12 00:20:59.132588 | controller | skipping: Conditional result was False
2026-03-12 00:20:59.142267 | controller | skipping: Conditional result was False
2026-03-12 00:20:59.191125 | 
2026-03-12 00:20:59.191245 | PLAY [localhost]
2026-03-12 00:20:59.208379 | 
2026-03-12 00:20:59.208470 | TASK [Run Zuul manifest role]
2026-03-12 00:20:59.230158 | localhost | ok
2026-03-12 00:20:59.248225 | 
2026-03-12 00:20:59.248328 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-03-12 00:20:59.623626 | localhost | changed
2026-03-12 00:20:59.628470 | 
2026-03-12 00:20:59.628534 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-03-12 00:20:59.663244 | localhost | ok
2026-03-12 00:20:59.680610 | 
2026-03-12 00:20:59.680755 | TASK [Set zuul-log-path fact]
2026-03-12 00:20:59.701249 | localhost | ok
2026-03-12 00:20:59.715389 | 
2026-03-12 00:20:59.715490 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-03-12 00:20:59.747089 | localhost | ok
2026-03-12 00:20:59.759449 | 
2026-03-12 00:20:59.759568 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)]
2026-03-12 00:20:59.798752 | localhost | ok:
2026-03-12 00:20:59.799059 | localhost | {
2026-03-12 00:20:59.799097 | localhost |   "auth": {
2026-03-12 00:20:59.799129 | localhost |     "password": "IonWCwcuOFib&&<}wp^:[2G/",
2026-03-12 00:20:59.799153 | localhost |     "username": "9LF91O0RK7JU"
2026-03-12 00:20:59.799178 | localhost |   },
2026-03-12 00:20:59.799203 | localhost |   "profile": "rackspace",
2026-03-12 00:20:59.799226 | localhost |   "region_name": "ORD"
2026-03-12 00:20:59.799250 | localhost | }
2026-03-12 00:20:59.799289 | 
2026-03-12 00:20:59.817745 | 
2026-03-12 00:20:59.817922 | TASK [Run upload-logs-failover role (S3 then Swift)]
2026-03-12 00:20:59.844439 | localhost | Output suppressed because no_log was given
2026-03-12 00:20:59.869732 | 
2026-03-12 00:20:59.869883 | TASK [upload-logs-failover : Initialize control vars]
2026-03-12 00:20:59.902652 | localhost | ok
2026-03-12 00:20:59.909911 | 
2026-03-12 00:20:59.910010 | LOOP [upload-logs-failover : Perform log upload]
2026-03-12 00:20:59.938589 | localhost | Output suppressed because no_log was given
2026-03-12 00:20:59.948800 | localhost | included: /var/lib/zuul/builds/390b1d09ed1443d5b74be9009f2011f1/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml
2026-03-12 00:20:59.959275 | 
2026-03-12 00:20:59.959402 | LOOP [upload-logs-failover : Unpack vars for swift upload]
2026-03-12 00:21:00.048341 | localhost | Output suppressed because no_log was given
2026-03-12 00:21:00.060071 | 
2026-03-12 00:21:00.060230 | TASK [Upload logs to swift]
2026-03-12 00:21:00.092826 | localhost | ok
2026-03-12 00:21:00.128823 | 
2026-03-12 00:21:00.128954 | TASK [Set zuul-log-path fact]
2026-03-12 00:21:00.154036 | localhost | skipping: Conditional result was False
2026-03-12 00:21:00.161646 | 
2026-03-12 00:21:00.161801 | TASK [upload-logs-swift : Ensure logs are readable before uploading]
2026-03-12 00:21:00.577983 | localhost -> localhost | ok: Runtime: 0:00:00.011382
2026-03-12 00:21:00.585275 | 
2026-03-12 00:21:00.585378 | TASK [upload-logs-swift : Upload logs to swift]