2026-02-27 00:07:41.504514 | Job console starting...
2026-02-27 00:07:41.517812 | Updating repositories
2026-02-27 00:07:42.637063 | Preparing job workspace
2026-02-27 00:07:46.805490 | Running Ansible setup...
2026-02-27 00:07:51.500167 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2026-02-27 00:07:52.195484 | 
2026-02-27 00:07:52.195615 | PLAY [localhost]
2026-02-27 00:07:52.205836 | 
2026-02-27 00:07:52.205942 | TASK [Gathering Facts]
2026-02-27 00:07:53.208614 | localhost | ok
2026-02-27 00:07:53.224675 | 
2026-02-27 00:07:53.224811 | TASK [Setup log path fact]
2026-02-27 00:07:53.246517 | localhost | ok
2026-02-27 00:07:53.275532 | 
2026-02-27 00:07:53.275680 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-02-27 00:07:53.323809 | localhost | ok
2026-02-27 00:07:53.342683 | 
2026-02-27 00:07:53.348113 | TASK [emit-job-header : Print job information]
2026-02-27 00:07:53.386273 | # Job Information
2026-02-27 00:07:53.386465 | Ansible Version: 2.15.12
2026-02-27 00:07:53.386512 | Job: ansible-test-sanity-docker-stable-2.12
2026-02-27 00:07:53.386541 | Pipeline: periodic
2026-02-27 00:07:53.386568 | Executor: ze03.softwarefactory-project.io
2026-02-27 00:07:53.386598 | Triggered by: https://github.com/ansible-collections/ansible.network
2026-02-27 00:07:53.386636 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/467/ansible/467e574421e54f91b1117937732869ad/
2026-02-27 00:07:53.386669 | Event ID: c66414a510e648d9aec75995eff050a1
2026-02-27 00:07:53.392220 | 
2026-02-27 00:07:53.392337 | LOOP [emit-job-header : Print node information]
2026-02-27 00:07:53.530654 | localhost | ok:
2026-02-27 00:07:53.530915 | localhost | # Node Information
2026-02-27 00:07:53.530961 | localhost | Inventory Hostname: controller
2026-02-27 00:07:53.531177 | localhost | Hostname: np0005632236
2026-02-27 00:07:53.531221 | localhost | Username: zuul
2026-02-27 00:07:53.531253 | localhost | Distro: Fedora 37
2026-02-27 00:07:53.531338 | localhost | Provider: ansible-vexxhost-ca-ymq-1
2026-02-27 00:07:53.531375 | localhost | Region: ca-ymq-1
2026-02-27 00:07:53.531402 | localhost | Label: ansible-fedora-37-1vcpu
2026-02-27 00:07:53.531429 | localhost | Product Name: OpenStack Nova
2026-02-27 00:07:53.531455 | localhost | Interface IP: 199.204.45.115
2026-02-27 00:07:53.550151 | 
2026-02-27 00:07:53.550274 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2026-02-27 00:07:54.097471 | localhost -> localhost | changed
2026-02-27 00:07:54.103572 | 
2026-02-27 00:07:54.103674 | TASK [log-inventory : Copy ansible inventory to logs dir]
2026-02-27 00:07:55.070444 | localhost -> localhost | changed
2026-02-27 00:07:55.090939 | 
2026-02-27 00:07:55.091010 | PLAY [all:!appliance*]
2026-02-27 00:07:55.110098 | 
2026-02-27 00:07:55.110196 | TASK [include_role : start-zuul-console]
2026-02-27 00:07:55.144166 | controller | ok
2026-02-27 00:07:55.160563 | 
2026-02-27 00:07:55.160651 | TASK [start-zuul-console : Start zuul_console daemon.]
2026-02-27 00:07:55.539719 | controller | ok
2026-02-27 00:07:55.554438 | 
2026-02-27 00:07:55.554542 | TASK [use-our-mirror : Retrieve the IP address]
2026-02-27 00:07:56.335271 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found
2026-02-27 00:07:56.345474 | 
2026-02-27 00:07:56.345626 | TASK [use-our-mirror : Ensure the registry service is running on the mirror]
2026-02-27 00:07:56.891425 | controller | skipping: Conditional result was False
2026-02-27 00:07:56.902913 | 
2026-02-27 00:07:56.903107 | TASK [use-our-mirror : Write the IP in /etc/hosts]
2026-02-27 00:07:56.928780 | controller | skipping: Conditional result was False
2026-02-27 00:07:56.941335 | 
2026-02-27 00:07:56.941619 | TASK [use-our-mirror : Create the podman configuration directory]
2026-02-27 00:07:56.968190 | controller | skipping: Conditional result was False
2026-02-27 00:07:56.977410 | 
2026-02-27 00:07:56.977573 | TASK [use-our-mirror : Copy the podman configuration]
2026-02-27 00:07:57.002564 | controller | skipping: Conditional result was False
2026-02-27 00:07:57.009319 | 
2026-02-27 00:07:57.009433 | TASK [use-our-mirror : Copy the Yum configuration (main)]
2026-02-27 00:07:57.023562 | controller | skipping: Conditional result was False
2026-02-27 00:07:57.031844 | 
2026-02-27 00:07:57.031978 | TASK [use-our-mirror : Copy the Yum configuration (update)]
2026-02-27 00:07:57.059622 | controller | skipping: Conditional result was False
2026-02-27 00:07:57.072638 | 
2026-02-27 00:07:57.072714 | TASK [Disable Fedora Modular]
2026-02-27 00:07:57.326567 | controller | changed
2026-02-27 00:07:57.332260 | 
2026-02-27 00:07:57.332323 | TASK [Enable EPEL]
2026-02-27 00:07:57.356169 | controller | skipping: Conditional result was False
2026-02-27 00:07:57.363166 | 
2026-02-27 00:07:57.363234 | TASK [Register the RHEL node]
2026-02-27 00:07:57.910199 | 
2026-02-27 00:07:57.910811 | TASK [Show the subscription-manager status]
2026-02-27 00:07:58.502221 | controller | skipping: Conditional result was False
2026-02-27 00:07:58.513245 | 
2026-02-27 00:07:58.513371 | TASK [Enable EPEL on RHEL]
2026-02-27 00:07:59.063555 | controller | skipping: Conditional result was False
2026-02-27 00:07:59.072600 | 
2026-02-27 00:07:59.073142 | TASK [Install git and tox]
2026-02-27 00:09:29.720453 | controller | changed
2026-02-27 00:09:29.735980 | 
2026-02-27 00:09:29.736116 | TASK [include_role : prepare-workspace]
2026-02-27 00:09:29.777095 | controller | ok
2026-02-27 00:09:29.815016 | 
2026-02-27 00:09:29.815148 | TASK [prepare-workspace : Start zuul_console daemon.]
2026-02-27 00:09:30.067035 | controller | ok
2026-02-27 00:09:30.082354 | 
2026-02-27 00:09:30.082514 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2026-02-27 00:15:15.457823 | controller | Output suppressed because no_log was given
2026-02-27 00:15:15.469087 | 
2026-02-27 00:15:15.469174 | TASK [include_role : prepare-workspace-openshift]
2026-02-27 00:15:15.486266 | controller | skipping: Conditional result was False
2026-02-27 00:15:15.536562 | 
2026-02-27 00:15:15.536670 | PLAY [all:!appliance]
2026-02-27 00:15:15.559765 | 
2026-02-27 00:15:15.559919 | TASK [Run add-build-sshkey role (RSA)]
2026-02-27 00:15:15.590922 | controller | ok
2026-02-27 00:15:15.607465 | 
2026-02-27 00:15:15.607549 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-02-27 00:15:15.835659 | controller -> localhost | ok
2026-02-27 00:15:15.842550 | 
2026-02-27 00:15:15.842649 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-02-27 00:15:15.872193 | controller | ok
2026-02-27 00:15:15.887174 | controller | included: /var/lib/zuul/builds/467e574421e54f91b1117937732869ad/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-02-27 00:15:15.893387 | 
2026-02-27 00:15:15.893458 | TASK [add-build-sshkey : Create Temp SSH key]
2026-02-27 00:15:16.336686 | controller -> localhost | Generating public/private rsa key pair.
2026-02-27 00:15:16.336965 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/467e574421e54f91b1117937732869ad/work/467e574421e54f91b1117937732869ad_id_rsa.
2026-02-27 00:15:16.337004 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/467e574421e54f91b1117937732869ad/work/467e574421e54f91b1117937732869ad_id_rsa.pub.
2026-02-27 00:15:16.337033 | controller -> localhost | The key fingerprint is:
2026-02-27 00:15:16.337058 | controller -> localhost | SHA256:AuxtmQjuEif3c8AzZrQ2V6CTzo0DaRqo7ZObD/PXoDw zuul-build-sshkey
2026-02-27 00:15:16.337083 | controller -> localhost | The key's randomart image is:
2026-02-27 00:15:16.337108 | controller -> localhost | +---[RSA 2048]----+
2026-02-27 00:15:16.337131 | controller -> localhost | |      .          |
2026-02-27 00:15:16.337155 | controller -> localhost | |.  o o .         |
2026-02-27 00:15:16.337179 | controller -> localhost | |o = B   .        |
2026-02-27 00:15:16.337201 | controller -> localhost | |.* O O +         |
2026-02-27 00:15:16.337225 | controller -> localhost | |= = ^ O S        |
2026-02-27 00:15:16.337256 | controller -> localhost | | B * O..         |
2026-02-27 00:15:16.337285 | controller -> localhost | |. B.o..o         |
2026-02-27 00:15:16.337309 | controller -> localhost | | . BEo. .        |
2026-02-27 00:15:16.337332 | controller -> localhost | |  o.oo           |
2026-02-27 00:15:16.337360 | controller -> localhost | +----[SHA256]-----+
2026-02-27 00:15:16.337421 | controller -> localhost | ok: Runtime: 0:00:00.059962
2026-02-27 00:15:16.347414 | 
2026-02-27 00:15:16.347491 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-02-27 00:15:16.380444 | controller | ok
2026-02-27 00:15:16.396839 | controller | included: /var/lib/zuul/builds/467e574421e54f91b1117937732869ad/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-02-27 00:15:16.407166 | 
2026-02-27 00:15:16.407235 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-02-27 00:15:16.431937 | controller | skipping: Conditional result was False
2026-02-27 00:15:16.439683 | 
2026-02-27 00:15:16.439804 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-02-27 00:15:17.091082 | controller | changed
2026-02-27 00:15:17.099904 | 
2026-02-27 00:15:17.100011 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-02-27 00:15:17.338863 | controller | ok
2026-02-27 00:15:17.345218 | 
2026-02-27 00:15:17.345310 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-02-27 00:15:18.004998 | controller | changed
2026-02-27 00:15:18.014132 | 
2026-02-27 00:15:18.014228 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-02-27 00:15:18.618639 | controller | changed
2026-02-27 00:15:18.627541 | 
2026-02-27 00:15:18.627640 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-02-27 00:15:18.654244 | controller | skipping: Conditional result was False
2026-02-27 00:15:18.663443 | 
2026-02-27 00:15:18.663534 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-02-27 00:15:19.037291 | controller -> localhost | changed
2026-02-27 00:15:19.053911 | 
2026-02-27 00:15:19.054044 | TASK [add-build-sshkey : Add back temp key]
2026-02-27 00:15:19.345525 | controller -> localhost | Identity added: /var/lib/zuul/builds/467e574421e54f91b1117937732869ad/work/467e574421e54f91b1117937732869ad_id_rsa (zuul-build-sshkey)
2026-02-27 00:15:19.345805 | controller -> localhost | ok: Runtime: 0:00:00.011324
2026-02-27 00:15:19.358942 | 
2026-02-27 00:15:19.359054 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-02-27 00:15:19.724499 | controller | ok
2026-02-27 00:15:19.733867 | 
2026-02-27 00:15:19.733971 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-02-27 00:15:19.772692 | controller | skipping: Conditional result was False
2026-02-27 00:15:19.794831 | 
2026-02-27 00:15:19.794985 | TASK [Run add-build-sshkey role (ECDSA)]
2026-02-27 00:15:19.832910 | controller | ok
2026-02-27 00:15:19.862361 | 
2026-02-27 00:15:19.862530 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2026-02-27 00:15:20.165573 | controller -> localhost | ok
2026-02-27 00:15:20.183408 | 
2026-02-27 00:15:20.183591 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2026-02-27 00:15:20.222686 | controller | ok
2026-02-27 00:15:20.234129 | controller | included: /var/lib/zuul/builds/467e574421e54f91b1117937732869ad/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2026-02-27 00:15:20.240681 | 
2026-02-27 00:15:20.240786 | TASK [add-build-sshkey : Create Temp SSH key]
2026-02-27 00:15:20.560989 | controller -> localhost | Generating public/private ecdsa key pair.
2026-02-27 00:15:20.561255 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/467e574421e54f91b1117937732869ad/work/467e574421e54f91b1117937732869ad_id_ecdsa.
2026-02-27 00:15:20.561292 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/467e574421e54f91b1117937732869ad/work/467e574421e54f91b1117937732869ad_id_ecdsa.pub.
2026-02-27 00:15:20.561327 | controller -> localhost | The key fingerprint is:
2026-02-27 00:15:20.561347 | controller -> localhost | SHA256:AoR0IyA8DQxpqTWh86okjKpGK4smTheOlAMIvbHlADQ zuul-build-sshkey
2026-02-27 00:15:20.561367 | controller -> localhost | The key's randomart image is:
2026-02-27 00:15:20.561386 | controller -> localhost | +---[ECDSA 521]---+
2026-02-27 00:15:20.561405 | controller -> localhost | |@EBo+            |
2026-02-27 00:15:20.561429 | controller -> localhost | |=BO=..           |
2026-02-27 00:15:20.561453 | controller -> localhost | |B..O.            |
2026-02-27 00:15:20.561471 | controller -> localhost | |oo+ ..           |
2026-02-27 00:15:20.561488 | controller -> localhost | | +..  . S        |
2026-02-27 00:15:20.561505 | controller -> localhost | |+o+ .  .         |
2026-02-27 00:15:20.561521 | controller -> localhost | |==.o             |
2026-02-27 00:15:20.561538 | controller -> localhost | |X+.              |
2026-02-27 00:15:20.561554 | controller -> localhost | |&o               |
2026-02-27 00:15:20.561570 | controller -> localhost | +----[SHA256]-----+
2026-02-27 00:15:20.561621 | controller -> localhost | ok: Runtime: 0:00:00.018582
2026-02-27 00:15:20.572094 | 
2026-02-27 00:15:20.572170 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2026-02-27 00:15:20.603018 | controller | ok
2026-02-27 00:15:20.612088 | controller | included: /var/lib/zuul/builds/467e574421e54f91b1117937732869ad/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2026-02-27 00:15:20.621208 | 
2026-02-27 00:15:20.621275 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2026-02-27 00:15:20.645826 | controller | skipping: Conditional result was False
2026-02-27 00:15:20.653260 | 
2026-02-27 00:15:20.653330 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2026-02-27 00:15:20.932702 | controller | changed
2026-02-27 00:15:20.950263 | 
2026-02-27 00:15:20.951194 | TASK [add-build-sshkey : Make sure user has a .ssh]
2026-02-27 00:15:21.207025 | controller | ok
2026-02-27 00:15:21.214146 | 
2026-02-27 00:15:21.214225 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2026-02-27 00:15:21.861592 | controller | changed
2026-02-27 00:15:21.868819 | 
2026-02-27 00:15:21.868909 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2026-02-27 00:15:22.505184 | controller | changed
2026-02-27 00:15:22.555016 | 
2026-02-27 00:15:22.555142 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2026-02-27 00:15:22.592279 | controller | skipping: Conditional result was False
2026-02-27 00:15:22.599082 | 
2026-02-27 00:15:22.599152 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2026-02-27 00:15:22.951760 | controller -> localhost | changed
2026-02-27 00:15:22.970849 | 
2026-02-27 00:15:22.970971 | TASK [add-build-sshkey : Add back temp key]
2026-02-27 00:15:23.281950 | controller -> localhost | Identity added: /var/lib/zuul/builds/467e574421e54f91b1117937732869ad/work/467e574421e54f91b1117937732869ad_id_ecdsa (zuul-build-sshkey)
2026-02-27 00:15:23.282203 | controller -> localhost | ok: Runtime: 0:00:00.007320
2026-02-27 00:15:23.289214 | 
2026-02-27 00:15:23.289286 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2026-02-27 00:15:23.496796 | controller | ok
2026-02-27 00:15:23.503660 | 
2026-02-27 00:15:23.503780 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2026-02-27 00:15:23.538573 | controller | skipping: Conditional result was False
2026-02-27 00:15:23.551238 | 
2026-02-27 00:15:23.551329 | TASK [include_role : remove-zuul-sshkey]
2026-02-27 00:15:23.580353 | controller | skipping: Conditional result was False
2026-02-27 00:15:23.588687 | 
2026-02-27 00:15:23.588828 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2026-02-27 00:15:23.834117 | controller | ok: "logs"
2026-02-27 00:15:23.834402 | controller | ok: All items complete
2026-02-27 00:15:23.834436 | 
2026-02-27 00:15:24.032240 | controller | ok: "artifacts"
2026-02-27 00:15:24.226966 | controller | ok: "docs"
2026-02-27 00:15:24.237624 | 
2026-02-27 00:15:24.237769 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2026-02-27 00:15:24.524544 | controller | changed: "logs"
2026-02-27 00:15:24.725820 | controller | changed: "artifacts"
2026-02-27 00:15:24.932210 | controller | changed: "docs"
2026-02-27 00:15:24.969336 | 
2026-02-27 00:15:24.969430 | PLAY RECAP
2026-02-27 00:15:24.969473 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0
2026-02-27 00:15:24.969499 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-02-27 00:15:24.969518 | 
2026-02-27 00:15:25.111141 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2026-02-27 00:15:25.112154 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2026-02-27 00:15:25.764756 | 
2026-02-27 00:15:25.764905 | PLAY [all]
2026-02-27 00:15:25.793387 | 
2026-02-27 00:15:25.793548 | TASK [Install binary dependencies]
2026-02-27 00:15:25.854575 | controller | ok
2026-02-27 00:15:25.875380 | 
2026-02-27 00:15:25.875555 | TASK [bindep : Include find tasks]
2026-02-27 00:15:25.916369 | controller | ok
2026-02-27 00:15:25.924700 | controller | included: /var/lib/zuul/builds/467e574421e54f91b1117937732869ad/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml
2026-02-27 00:15:25.933436 | 
2026-02-27 00:15:25.933584 | TASK [bindep : Look for bindep.txt]
2026-02-27 00:15:26.488700 | controller | ok
2026-02-27 00:15:26.495232 | 
2026-02-27 00:15:26.495373 | TASK [bindep : Define bindep_file fact]
2026-02-27 00:15:26.520702 | controller | skipping: Conditional result was False
2026-02-27 00:15:26.530591 | 
2026-02-27 00:15:26.530774 | TASK [bindep : Look for other-requirements.txt]
2026-02-27 00:15:26.749122 | controller | ok
2026-02-27 00:15:26.755029 | 
2026-02-27 00:15:26.755208 | TASK [bindep : Define bindep_file fact]
2026-02-27 00:15:26.780906 | controller | skipping: Conditional result was False
2026-02-27 00:15:26.792532 | 
2026-02-27 00:15:26.792668 | TASK [bindep : Look for bindep fallback file]
2026-02-27 00:15:26.829706 | controller | skipping: Conditional result was False
2026-02-27 00:15:26.840183 | 
2026-02-27 00:15:26.840317 | TASK [bindep : Define bindep_file fact]
2026-02-27 00:15:26.864808 | controller | skipping: Conditional result was False
2026-02-27 00:15:26.872123 | 
2026-02-27 00:15:26.872241 | TASK [bindep : Include bindep tasks]
2026-02-27 00:15:26.896967 | controller | skipping: Conditional result was False
2026-02-27 00:15:26.905384 | 
2026-02-27 00:15:26.905520 | TASK [bindep : Include install tasks]
2026-02-27 00:15:26.932552 | controller | skipping: Conditional result was False
2026-02-27 00:15:26.950761 | 
2026-02-27 00:15:26.950892 | LOOP [bindep : Include package tasks]
2026-02-27 00:15:27.025328 | 
2026-02-27 00:15:27.025553 | TASK [Run test-setup role]
2026-02-27 00:15:27.052222 | controller | ok
2026-02-27 00:15:27.096783 | 
2026-02-27 00:15:27.096949 | TASK [test-setup : Check if project's tools/test-setup.sh exists]
2026-02-27 00:15:27.304219 | controller | ok
2026-02-27 00:15:27.311513 | 
2026-02-27 00:15:27.311637 | TASK [test-setup : Run tools/test-setup.sh]
2026-02-27 00:15:27.861411 | controller | skipping: Conditional result was False
2026-02-27 00:15:27.891560 | 
2026-02-27 00:15:27.891657 | PLAY RECAP
2026-02-27 00:15:27.891698 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0
2026-02-27 00:15:27.891720 | 
2026-02-27 00:15:28.048259 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master]
2026-02-27 00:15:28.049449 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master]
2026-02-27 00:15:28.849765 | 
2026-02-27 00:15:28.849932 | PLAY [controller]
2026-02-27 00:15:28.879353 | 
2026-02-27 00:15:28.879538 | TASK [Create the /root directory]
2026-02-27 00:15:29.467702 | controller | ok
2026-02-27 00:15:29.478523 | 
2026-02-27 00:15:29.478661 | TASK [Install glibc-langpack-en]
2026-02-27 00:15:33.482756 | controller | ok: Nothing to do
2026-02-27 00:15:33.490868 | 
2026-02-27 00:15:33.491374 | TASK [Ensure controller directory exists]
2026-02-27 00:15:33.696996 | controller | changed
2026-02-27 00:15:33.702926 | 
2026-02-27 00:15:33.702990 | TASK [Install container runtime]
2026-02-27 00:15:33.748984 | controller | ok
2026-02-27 00:15:33.791299 | 
2026-02-27 00:15:33.791445 | LOOP [ensure-podman : Find distribution installation]
2026-02-27 00:15:33.829719 | controller | ok: "/var/lib/zuul/builds/467e574421e54f91b1117937732869ad/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml"
2026-02-27 00:15:33.846000 | controller | included: /var/lib/zuul/builds/467e574421e54f91b1117937732869ad/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml
2026-02-27 00:15:33.859298 | 
2026-02-27 00:15:33.859444 | TASK [ensure-podman : Install podman (RedHat)]
2026-02-27 00:16:42.288066 | controller | changed
2026-02-27 00:16:42.302365 | 
2026-02-27 00:16:42.302509 | TASK [ensure-podman : Fetch podman version]
2026-02-27 00:16:42.867606 | controller | Client:       Podman Engine
2026-02-27 00:16:42.895189 | controller | Version:      4.6.2
2026-02-27 00:16:42.895230 | controller | API Version:  4.6.2
2026-02-27 00:16:42.895236 | controller | Go Version:   go1.19.12
2026-02-27 00:16:42.895250 | controller | Built:        Mon Aug 28 19:38:31 2023
2026-02-27 00:16:42.895256 | controller | OS/Arch:      linux/amd64
2026-02-27 00:16:43.356344 | controller | ok: Runtime: 0:00:00.195026
2026-02-27 00:16:43.364916 | 
2026-02-27 00:16:43.365006 | TASK [ensure-podman : Print podman version installed]
2026-02-27 00:16:43.395292 | Podman version: Client:       Podman Engine
2026-02-27 00:16:43.395469 | Version:      4.6.2
2026-02-27 00:16:43.395498 | API Version:  4.6.2
2026-02-27 00:16:43.395518 | Go Version:   go1.19.12
2026-02-27 00:16:43.395536 | Built:        Mon Aug 28 19:38:31 2023
2026-02-27 00:16:43.395558 | OS/Arch:      linux/amd64
2026-02-27 00:16:43.401938 | 
2026-02-27 00:16:43.402013 | TASK [ensure-podman : Validate podman engine]
2026-02-27 00:16:43.935507 | controller | skipping: Conditional result was False
2026-02-27 00:16:43.942420 | 
2026-02-27 00:16:43.942744 | TASK [ensure-podman : Set up docker compatability socket]
2026-02-27 00:16:43.967305 | controller | skipping: Conditional result was False
2026-02-27 00:16:43.979409 | 
2026-02-27 00:16:43.979528 | TASK [Ensure python3.8 is present]
2026-02-27 00:16:43.993829 | controller | skipping: Conditional result was False
2026-02-27 00:16:44.010416 | 
2026-02-27 00:16:44.010555 | TASK [Run our-ensure-python role (Fedora only for now)]
2026-02-27 00:16:44.037828 | controller | ok
2026-02-27 00:16:44.067465 | 
2026-02-27 00:16:44.067648 | TASK [our-ensure-python : Install the right Python version (rpm)]
2026-02-27 00:16:45.749103 | controller | ok: Nothing to do
2026-02-27 00:16:45.763269 | 
2026-02-27 00:16:45.763406 | TASK [our-ensure-python : Also install python3-devel]
2026-02-27 00:21:08.982935 | controller | ERROR
2026-02-27 00:21:08.983141 | controller | {
2026-02-27 00:21:08.983173 | controller |   "msg": "Data could not be sent to remote host \"199.204.45.115\". Make sure this host can be reached over ssh: ssh: connect to host 199.204.45.115 port 22: No route to host\r\n",
2026-02-27 00:21:08.983198 | controller |   "unreachable": true
2026-02-27 00:21:08.983220 | controller | }
unreachable
2026-02-27 00:21:08.984578 | 
2026-02-27 00:21:08.984626 | PLAY RECAP
2026-02-27 00:21:08.984670 | controller | ok: 8 changed: 3 unreachable: 1 failed: 0 skipped: 3 rescued: 0 ignored: 0
2026-02-27 00:21:08.984695 | 
2026-02-27 00:21:09.147408 | PRE-RUN END RESULT_UNREACHABLE: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master]
2026-02-27 00:21:09.148458 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2026-02-27 00:21:09.766849 | 
2026-02-27 00:21:09.766994 | PLAY [all]
2026-02-27 00:21:09.790251 | 
2026-02-27 00:21:09.790406 | TASK [fetch-subunit-output : Find stestr or testr executable]
2026-02-27 00:21:36.802707 | controller | ERROR
2026-02-27 00:21:36.802983 | controller | {
2026-02-27 00:21:36.803038 | controller |   "msg": "Failed to connect to the host via ssh: ssh: connect to host 199.204.45.115 port 22: No route to host",
2026-02-27 00:21:36.803082 | controller |   "unreachable": true
2026-02-27 00:21:36.803147 | controller | }
unreachable
2026-02-27 00:21:36.806252 | 
2026-02-27 00:21:36.806320 | PLAY RECAP
2026-02-27 00:21:36.806379 | controller | ok: 0 changed: 0 unreachable: 1 failed: 0 skipped: 0 rescued: 0 ignored: 0
2026-02-27 00:21:36.806409 | 
2026-02-27 00:21:36.962169 | POST-RUN END RESULT_UNREACHABLE: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master]
2026-02-27 00:21:36.963349 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master]
2026-02-27 00:21:37.556494 | 
2026-02-27 00:21:37.556643 | PLAY [all:!appliance*]
2026-02-27 00:21:37.585596 | 
2026-02-27 00:21:37.585716 | TASK [unregister the node]
2026-02-27 00:21:42.624948 | controller | skipping: Conditional result was False
2026-02-27 00:21:42.638467 | 
2026-02-27 00:21:42.638653 | TASK [include_role : fetch-output]
2026-02-27 00:21:42.688404 | controller | ok
2026-02-27 00:21:42.726403 | 
2026-02-27 00:21:42.726533 | TASK [fetch-output : Set log path for multiple nodes]
2026-02-27 00:21:42.802698 | controller | skipping: Conditional result was False
2026-02-27 00:21:42.816935 | 
2026-02-27 00:21:42.817097 | TASK [fetch-output : Set log path for single node]
2026-02-27 00:21:42.866825 | controller | ok
2026-02-27 00:21:42.880371 | 
2026-02-27 00:21:42.880527 | LOOP [fetch-output : Ensure local output dirs]
2026-02-27 00:21:43.354884 | controller -> localhost | ok: "/var/lib/zuul/builds/467e574421e54f91b1117937732869ad/work/logs"
2026-02-27 00:21:43.646057 | controller -> localhost | changed: "/var/lib/zuul/builds/467e574421e54f91b1117937732869ad/work/artifacts"
2026-02-27 00:21:43.940193 | controller -> localhost | changed: "/var/lib/zuul/builds/467e574421e54f91b1117937732869ad/work/docs"
2026-02-27 00:21:43.957477 | 
2026-02-27 00:21:43.957624 | LOOP [fetch-output : Collect logs, artifacts and docs]
2026-02-27 00:21:49.911790 | controller | changed:
2026-02-27 00:21:49.911997 | controller | .d..t...... ./
2026-02-27 00:21:49.912025 | controller | cd+++++++++ controller/
2026-02-27 00:21:49.912061 | controller | changed: All items complete
2026-02-27 00:21:49.912082 | 
2026-02-27 00:21:50.420312 | controller | changed: .d..t...... ./
2026-02-27 00:21:50.933897 | controller | changed: .d..t...... ./
2026-02-27 00:21:50.950645 | 
2026-02-27 00:21:50.950849 | TASK [include_role : fetch-output-openshift]
2026-02-27 00:21:50.980394 | controller | skipping: Conditional result was False
2026-02-27 00:21:50.990937 | 
2026-02-27 00:21:50.991060 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2026-02-27 00:21:51.038319 | controller | skipping: Conditional result was False
2026-02-27 00:21:51.051976 | controller | skipping: Conditional result was False
2026-02-27 00:21:51.109583 | 
2026-02-27 00:21:51.109753 | PLAY [localhost]
2026-02-27 00:21:51.129802 | 
2026-02-27 00:21:51.129925 | TASK [Run Zuul manifest role]
2026-02-27 00:21:51.148625 | localhost | ok
2026-02-27 00:21:51.162193 | 
2026-02-27 00:21:51.162324 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2026-02-27 00:21:51.585577 | localhost | changed
2026-02-27 00:21:51.597563 | 
2026-02-27 00:21:51.597814 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2026-02-27 00:21:51.646891 | localhost | ok
2026-02-27 00:21:51.709567 | 
2026-02-27 00:21:51.709754 | TASK [Set zuul-log-path fact]
2026-02-27 00:21:51.730275 | localhost | ok
2026-02-27 00:21:51.743885 | 
2026-02-27 00:21:51.744026 | TASK [set-zuul-log-path-fact : Set log path for a build]
2026-02-27 00:21:51.783257 | localhost | ok
2026-02-27 00:21:51.791373 | 
2026-02-27 00:21:51.791484 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)]
2026-02-27 00:21:51.836697 | localhost | ok:
2026-02-27 00:21:51.836999 | localhost | {
2026-02-27 00:21:51.837054 | localhost |   "auth": {
2026-02-27 00:21:51.837101 | localhost |     "password": "IonWCwcuOFib&&<}wp^:[2G/",
2026-02-27 00:21:51.837141 | localhost |     "username": "9LF91O0RK7JU"
2026-02-27 00:21:51.837178 | localhost |   },
2026-02-27 00:21:51.837214 | localhost |   "profile": "rackspace",
2026-02-27 00:21:51.837250 | localhost |   "region_name": "ORD"
2026-02-27 00:21:51.837284 | localhost | }
2026-02-27 00:21:51.837332 | 
2026-02-27 00:21:51.849083 | 
2026-02-27 00:21:51.849294 | TASK [Run upload-logs-failover role (S3 then Swift)]
2026-02-27 00:21:51.884984 | localhost | Output suppressed because no_log was given
2026-02-27 00:21:51.915496 | 
2026-02-27 00:21:51.915764 | TASK [upload-logs-failover : Initialize control vars]
2026-02-27 00:21:51.958923 | localhost | ok
2026-02-27 00:21:51.966073 | 
2026-02-27 00:21:51.966470 | LOOP [upload-logs-failover : Perform log upload]
2026-02-27 00:21:52.015585 | localhost | Output suppressed because no_log was given
2026-02-27 00:21:52.026950 | localhost | included: /var/lib/zuul/builds/467e574421e54f91b1117937732869ad/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml
2026-02-27 00:21:52.034865 | 
2026-02-27 00:21:52.035021 | LOOP [upload-logs-failover : Unpack vars for swift upload]
2026-02-27 00:21:52.146615 | localhost | Output suppressed because no_log was given
2026-02-27 00:21:52.155445 | 
2026-02-27 00:21:52.155617 | TASK [Upload logs to swift]
2026-02-27 00:21:52.185924 | localhost | ok
2026-02-27 00:21:52.220091 | 
2026-02-27 00:21:52.220241 | TASK [Set zuul-log-path fact]
2026-02-27 00:21:52.265805 | localhost | skipping: Conditional result was False
2026-02-27 00:21:52.274255 | 
2026-02-27 00:21:52.274623 | TASK [upload-logs-swift : Ensure logs are readable before uploading]
2026-02-27 00:21:52.824389 | localhost -> localhost | ok: Runtime: 0:00:00.010666
2026-02-27 00:21:52.830054 | 
2026-02-27 00:21:52.830150 | TASK [upload-logs-swift : Upload logs to swift]