2025-11-18 00:21:46.197167 | Job console starting... 2025-11-18 00:21:46.207392 | Updating repositories 2025-11-18 00:21:46.335530 | Preparing job workspace 2025-11-18 00:21:51.893719 | Running Ansible setup... 2025-11-18 00:21:56.830148 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2025-11-18 00:21:57.511549 | 2025-11-18 00:21:57.511718 | PLAY [localhost] 2025-11-18 00:21:57.520735 | 2025-11-18 00:21:57.520823 | TASK [Gathering Facts] 2025-11-18 00:21:58.437536 | localhost | ok 2025-11-18 00:21:58.475374 | 2025-11-18 00:21:58.475560 | TASK [Setup log path fact] 2025-11-18 00:21:58.504696 | localhost | ok 2025-11-18 00:21:58.519276 | 2025-11-18 00:21:58.519370 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-18 00:21:58.549859 | localhost | ok 2025-11-18 00:21:58.562787 | 2025-11-18 00:21:58.562890 | TASK [emit-job-header : Print job information] 2025-11-18 00:21:58.617127 | # Job Information 2025-11-18 00:21:58.617354 | Ansible Version: 2.15.12 2025-11-18 00:21:58.617414 | Job: ansible-test-sanity-docker-stable-2.9 2025-11-18 00:21:58.617457 | Pipeline: periodic 2025-11-18 00:21:58.617496 | Executor: ze04.softwarefactory-project.io 2025-11-18 00:21:58.617537 | Triggered by: https://github.com/ansible-collections/ansible.network 2025-11-18 00:21:58.617582 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/458/ansible/458aec53af5f4653b408e06ffee255f0/ 2025-11-18 00:21:58.617623 | Event ID: ce1d8018739b49068127d11881773b47 2025-11-18 00:21:58.622833 | 2025-11-18 00:21:58.622960 | LOOP [emit-job-header : Print node information] 2025-11-18 00:21:58.734205 | localhost | ok: 2025-11-18 00:21:58.734351 | localhost | # Node Information 2025-11-18 00:21:58.734378 | localhost | Inventory Hostname: controller 2025-11-18 00:21:58.734399 | localhost | Hostname: np0005525963 2025-11-18 00:21:58.734418 | localhost | Username: zuul 2025-11-18 00:21:58.734440 | localhost | Distro: Fedora 37 2025-11-18 00:21:58.734459 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2025-11-18 00:21:58.734477 | localhost | Region: ca-ymq-1 2025-11-18 00:21:58.734495 | localhost | Label: ansible-fedora-37-1vcpu 2025-11-18 00:21:58.734512 | localhost | Product Name: OpenStack Nova 2025-11-18 00:21:58.734530 | localhost | Interface IP: 162.253.55.195 2025-11-18 00:21:58.752555 | 2025-11-18 00:21:58.752743 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-18 00:21:59.128110 | localhost -> localhost | changed 2025-11-18 00:21:59.139566 | 2025-11-18 00:21:59.139754 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-18 00:22:00.043514 | localhost -> localhost | changed 2025-11-18 00:22:00.063659 | 2025-11-18 00:22:00.063761 | PLAY [all:!appliance*] 2025-11-18 00:22:00.084146 | 2025-11-18 00:22:00.084298 | TASK [include_role : start-zuul-console] 2025-11-18 00:22:00.103553 | controller | ok 2025-11-18 00:22:00.118025 | 2025-11-18 00:22:00.118136 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-18 00:22:00.488451 | controller | ok 2025-11-18 00:22:00.505839 | 2025-11-18 00:22:00.505980 | TASK [use-our-mirror : Retrieve the IP address] 2025-11-18 00:22:01.532281 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2025-11-18 00:22:01.542780 | 2025-11-18 00:22:01.542875 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2025-11-18 00:22:02.086887 | controller | skipping: Conditional result was False 2025-11-18 00:22:02.093804 | 2025-11-18 00:22:02.093932 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2025-11-18 00:22:02.118054 | controller | skipping: Conditional result was False 2025-11-18 00:22:02.124552 | 2025-11-18 00:22:02.124737 | TASK [use-our-mirror : Create the podman configuration directory] 2025-11-18 00:22:02.148734 | controller | skipping: Conditional result was False 2025-11-18 00:22:02.155504 | 2025-11-18 00:22:02.155624 | TASK [use-our-mirror : Copy the podman configuration] 2025-11-18 00:22:02.179623 | controller | skipping: Conditional result was False 2025-11-18 00:22:02.186417 | 2025-11-18 00:22:02.186521 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2025-11-18 00:22:02.210770 | controller | skipping: Conditional result was False 2025-11-18 00:22:02.217260 | 2025-11-18 00:22:02.217360 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2025-11-18 00:22:02.241338 | controller | skipping: Conditional result was False 2025-11-18 00:22:02.254150 | 2025-11-18 00:22:02.254262 | TASK [Disable Fedora Modular] 2025-11-18 00:22:02.488116 | controller | changed 2025-11-18 00:22:02.494495 | 2025-11-18 00:22:02.494597 | TASK [Enable EPEL] 2025-11-18 00:22:02.518887 | controller | skipping: Conditional result was False 2025-11-18 00:22:02.528058 | 2025-11-18 00:22:02.528189 | TASK [Register the RHEL node] 2025-11-18 00:22:03.084401 | 2025-11-18 00:22:03.084597 | TASK [Show the subscription-manager status] 2025-11-18 00:22:03.658304 | controller | skipping: Conditional result was False 2025-11-18 00:22:03.668876 | 2025-11-18 00:22:03.669024 | TASK [Enable EPEL on RHEL] 2025-11-18 00:22:04.215790 | controller | skipping: Conditional result was False 2025-11-18 00:22:04.242841 | 2025-11-18 00:22:04.243050 | TASK [Install git and tox] 2025-11-18 00:23:34.149473 | controller | changed 2025-11-18 00:23:34.165320 | 2025-11-18 00:23:34.165484 | TASK [include_role : prepare-workspace] 2025-11-18 00:23:34.197656 | controller | ok 2025-11-18 00:23:34.236553 | 2025-11-18 00:23:34.236714 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-11-18 00:23:34.462994 | controller | ok 2025-11-18 00:23:34.473023 | 2025-11-18 00:23:34.473143 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-11-18 00:29:27.998308 | controller | Output suppressed because no_log was given 2025-11-18 00:29:28.009967 | 2025-11-18 00:29:28.010094 | TASK [include_role : prepare-workspace-openshift] 2025-11-18 00:29:28.035032 | controller | skipping: Conditional result was False 2025-11-18 00:29:28.060212 | 2025-11-18 00:29:28.060294 | PLAY [all:!appliance] 2025-11-18 00:29:28.076769 | 2025-11-18 00:29:28.076846 | TASK [Run add-build-sshkey role (RSA)] 2025-11-18 00:29:28.097187 | controller | ok 2025-11-18 00:29:28.113877 | 2025-11-18 00:29:28.113979 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-18 00:29:28.332254 | controller -> localhost | ok 2025-11-18 00:29:28.339193 | 2025-11-18 00:29:28.339266 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-18 00:29:28.369577 | controller | ok 2025-11-18 00:29:28.385036 | controller | included: /var/lib/zuul/builds/458aec53af5f4653b408e06ffee255f0/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-18 00:29:28.392959 | 2025-11-18 00:29:28.393082 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-18 00:29:28.885405 | controller -> localhost | Generating public/private rsa key pair. 2025-11-18 00:29:28.885592 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/458aec53af5f4653b408e06ffee255f0/work/458aec53af5f4653b408e06ffee255f0_id_rsa. 2025-11-18 00:29:28.885626 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/458aec53af5f4653b408e06ffee255f0/work/458aec53af5f4653b408e06ffee255f0_id_rsa.pub. 2025-11-18 00:29:28.885651 | controller -> localhost | The key fingerprint is: 2025-11-18 00:29:28.885672 | controller -> localhost | SHA256:giyXzpRGiJslEyGd/EJGg2jVLTutFaeqJO8/zU5/zDs zuul-build-sshkey 2025-11-18 00:29:28.885729 | controller -> localhost | The key's randomart image is: 2025-11-18 00:29:28.885753 | controller -> localhost | +---[RSA 2048]----+ 2025-11-18 00:29:28.885778 | controller -> localhost | |=*+o. . | 2025-11-18 00:29:28.885803 | controller -> localhost | |++*o o o . | 2025-11-18 00:29:28.885827 | controller -> localhost | |=oo.. + + | 2025-11-18 00:29:28.885850 | controller -> localhost | | *.o.* + | 2025-11-18 00:29:28.885874 | controller -> localhost | |o ..O * S | 2025-11-18 00:29:28.885907 | controller -> localhost | | . O o . | 2025-11-18 00:29:28.885934 | controller -> localhost | | + + o. o | 2025-11-18 00:29:28.885960 | controller -> localhost | | o ..o. E | 2025-11-18 00:29:28.885986 | controller -> localhost | | ....o. ...o | 2025-11-18 00:29:28.886012 | controller -> localhost | +----[SHA256]-----+ 2025-11-18 00:29:28.886064 | controller -> localhost | ok: Runtime: 0:00:00.065514 2025-11-18 00:29:28.893348 | 2025-11-18 00:29:28.893425 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-18 00:29:28.923948 | controller | ok 2025-11-18 00:29:28.934643 | controller | included: /var/lib/zuul/builds/458aec53af5f4653b408e06ffee255f0/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-18 00:29:28.945987 | 2025-11-18 00:29:28.946095 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-18 00:29:28.970774 | controller | skipping: Conditional result was False 2025-11-18 00:29:28.978363 | 2025-11-18 00:29:28.978460 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-18 00:29:29.615125 | controller | changed 2025-11-18 00:29:29.630820 | 2025-11-18 00:29:29.630986 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-18 00:29:29.865568 | controller | ok 2025-11-18 00:29:29.881057 | 2025-11-18 00:29:29.881245 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-18 00:29:30.523172 | controller | changed 2025-11-18 00:29:30.536641 | 2025-11-18 00:29:30.536821 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-18 00:29:31.188998 | controller | changed 2025-11-18 00:29:31.196098 | 2025-11-18 00:29:31.196178 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-18 00:29:31.220559 | controller | skipping: Conditional result was False 2025-11-18 00:29:31.228521 | 2025-11-18 00:29:31.228621 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-18 00:29:31.691744 | controller -> localhost | changed 2025-11-18 00:29:31.703171 | 2025-11-18 00:29:31.703250 | TASK [add-build-sshkey : Add back temp key] 2025-11-18 00:29:31.978722 | controller -> localhost | Identity added: /var/lib/zuul/builds/458aec53af5f4653b408e06ffee255f0/work/458aec53af5f4653b408e06ffee255f0_id_rsa (zuul-build-sshkey) 2025-11-18 00:29:31.978979 | controller -> localhost | ok: Runtime: 0:00:00.022743 2025-11-18 00:29:31.986265 | 2025-11-18 00:29:31.986331 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-18 00:29:32.343963 | controller | ok 2025-11-18 00:29:32.349725 | 2025-11-18 00:29:32.349808 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-18 00:29:32.390005 | controller | skipping: Conditional result was False 2025-11-18 00:29:32.456111 | 2025-11-18 00:29:32.456246 | TASK [Run add-build-sshkey role (ECDSA)] 2025-11-18 00:29:32.487763 | controller | ok 2025-11-18 00:29:32.505629 | 2025-11-18 00:29:32.505743 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-18 00:29:32.755226 | controller -> localhost | ok 2025-11-18 00:29:32.767044 | 2025-11-18 00:29:32.767164 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-18 00:29:32.792989 | controller | ok 2025-11-18 00:29:32.806791 | controller | included: /var/lib/zuul/builds/458aec53af5f4653b408e06ffee255f0/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-18 00:29:32.815008 | 2025-11-18 00:29:32.815118 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-18 00:29:33.066949 | controller -> localhost | Generating public/private ecdsa key pair. 2025-11-18 00:29:33.067174 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/458aec53af5f4653b408e06ffee255f0/work/458aec53af5f4653b408e06ffee255f0_id_ecdsa. 2025-11-18 00:29:33.067206 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/458aec53af5f4653b408e06ffee255f0/work/458aec53af5f4653b408e06ffee255f0_id_ecdsa.pub. 2025-11-18 00:29:33.067237 | controller -> localhost | The key fingerprint is: 2025-11-18 00:29:33.067258 | controller -> localhost | SHA256:PzkXuUwSO7cIoS1vD/5FqZqzzsYn5T4g8DEqfJbGcp4 zuul-build-sshkey 2025-11-18 00:29:33.067278 | controller -> localhost | The key's randomart image is: 2025-11-18 00:29:33.067298 | controller -> localhost | +---[ECDSA 521]---+ 2025-11-18 00:29:33.067317 | controller -> localhost | | | 2025-11-18 00:29:33.067335 | controller -> localhost | | | 2025-11-18 00:29:33.067370 | controller -> localhost | | . . | 2025-11-18 00:29:33.067396 | controller -> localhost | | . oo . o o | 2025-11-18 00:29:33.067419 | controller -> localhost | | . . =ooS + B | 2025-11-18 00:29:33.067438 | controller -> localhost | | + O oo.o.@ + | 2025-11-18 00:29:33.067471 | controller -> localhost | | O . o++B * | 2025-11-18 00:29:33.067491 | controller -> localhost | | E +==+= | 2025-11-18 00:29:33.067510 | controller -> localhost | | oBB+. | 2025-11-18 00:29:33.067528 | controller -> localhost | +----[SHA256]-----+ 2025-11-18 00:29:33.067595 | controller -> localhost | ok: Runtime: 0:00:00.015916 2025-11-18 00:29:33.076067 | 2025-11-18 00:29:33.076149 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-18 00:29:33.115323 | controller | ok 2025-11-18 00:29:33.129115 | controller | included: /var/lib/zuul/builds/458aec53af5f4653b408e06ffee255f0/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-18 00:29:33.139862 | 2025-11-18 00:29:33.139939 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-18 00:29:33.165192 | controller | skipping: Conditional result was False 2025-11-18 00:29:33.180375 | 2025-11-18 00:29:33.180473 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-18 00:29:33.450004 | controller | changed 2025-11-18 00:29:33.465019 | 2025-11-18 00:29:33.465203 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-18 00:29:33.710231 | controller | ok 2025-11-18 00:29:33.717733 | 2025-11-18 00:29:33.717802 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-18 00:29:34.368715 | controller | changed 2025-11-18 00:29:34.376598 | 2025-11-18 00:29:34.376751 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-18 00:29:34.980552 | controller | changed 2025-11-18 00:29:34.987964 | 2025-11-18 00:29:34.988045 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-18 00:29:35.013074 | controller | skipping: Conditional result was False 2025-11-18 00:29:35.025314 | 2025-11-18 00:29:35.025442 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-18 00:29:35.337203 | controller -> localhost | changed 2025-11-18 00:29:35.351043 | 2025-11-18 00:29:35.351154 | TASK [add-build-sshkey : Add back temp key] 2025-11-18 00:29:35.619567 | controller -> localhost | Identity added: /var/lib/zuul/builds/458aec53af5f4653b408e06ffee255f0/work/458aec53af5f4653b408e06ffee255f0_id_ecdsa (zuul-build-sshkey) 2025-11-18 00:29:35.619823 | controller -> localhost | ok: Runtime: 0:00:00.008655 2025-11-18 00:29:35.627050 | 2025-11-18 00:29:35.627120 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-18 00:29:35.844424 | controller | ok 2025-11-18 00:29:35.858497 | 2025-11-18 00:29:35.858601 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-18 00:29:35.896959 | controller | skipping: Conditional result was False 2025-11-18 00:29:35.915497 | 2025-11-18 00:29:35.915644 | TASK [include_role : remove-zuul-sshkey] 2025-11-18 00:29:35.942938 | controller | skipping: Conditional result was False 2025-11-18 00:29:35.955277 | 2025-11-18 00:29:35.955413 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2025-11-18 00:29:36.203474 | controller | ok: "logs" 2025-11-18 00:29:36.203802 | controller | ok: All items complete 2025-11-18 00:29:36.203842 | 2025-11-18 00:29:36.408151 | controller | ok: "artifacts" 2025-11-18 00:29:36.604284 | controller | ok: "docs" 2025-11-18 00:29:36.627097 | 2025-11-18 00:29:36.627304 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2025-11-18 00:29:36.893167 | controller | changed: "logs" 2025-11-18 00:29:37.088110 | controller | changed: "artifacts" 2025-11-18 00:29:37.278553 | controller | changed: "docs" 2025-11-18 00:29:37.311091 | 2025-11-18 00:29:37.311204 | PLAY RECAP 2025-11-18 00:29:37.311252 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2025-11-18 00:29:37.311278 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-11-18 00:29:37.311296 | 2025-11-18 00:29:37.435962 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2025-11-18 00:29:37.437366 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2025-11-18 00:29:38.081426 | 2025-11-18 00:29:38.081548 | PLAY [all] 2025-11-18 00:29:38.103754 | 2025-11-18 00:29:38.103890 | TASK [Install binary dependencies] 2025-11-18 00:29:38.151053 | controller | ok 2025-11-18 00:29:38.169839 | 2025-11-18 00:29:38.169958 | TASK [bindep : Include find tasks] 2025-11-18 00:29:38.199334 | controller | ok 2025-11-18 00:29:38.206895 | controller | included: /var/lib/zuul/builds/458aec53af5f4653b408e06ffee255f0/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2025-11-18 00:29:38.212912 | 2025-11-18 00:29:38.212976 | TASK [bindep : Look for bindep.txt] 2025-11-18 00:29:38.741601 | controller | ok 2025-11-18 00:29:38.748224 | 2025-11-18 00:29:38.748339 | TASK [bindep : Define bindep_file fact] 2025-11-18 00:29:38.772881 | controller | skipping: Conditional result was False 2025-11-18 00:29:38.781667 | 2025-11-18 00:29:38.781844 | TASK [bindep : Look for other-requirements.txt] 2025-11-18 00:29:38.993611 | controller | ok 2025-11-18 00:29:39.005634 | 2025-11-18 00:29:39.005840 | TASK [bindep : Define bindep_file fact] 2025-11-18 00:29:39.042784 | controller | skipping: Conditional result was False 2025-11-18 00:29:39.052267 | 2025-11-18 00:29:39.052395 | TASK [bindep : Look for bindep fallback file] 2025-11-18 00:29:39.108449 | controller | skipping: Conditional result was False 2025-11-18 00:29:39.123072 | 2025-11-18 00:29:39.123250 | TASK [bindep : Define bindep_file fact] 2025-11-18 00:29:39.162579 | controller | skipping: Conditional result was False 2025-11-18 00:29:39.168534 | 2025-11-18 00:29:39.168603 | TASK [bindep : Include bindep tasks] 2025-11-18 00:29:39.196104 | controller | skipping: Conditional result was False 2025-11-18 00:29:39.211598 | 2025-11-18 00:29:39.211806 | TASK [bindep : Include install tasks] 2025-11-18 00:29:39.251858 | controller | skipping: Conditional result was False 2025-11-18 00:29:39.260091 | 2025-11-18 00:29:39.260168 | LOOP [bindep : Include package tasks] 2025-11-18 00:29:39.325992 | 2025-11-18 00:29:39.326161 | TASK [Run test-setup role] 2025-11-18 00:29:39.347605 | controller | ok 2025-11-18 00:29:39.379816 | 2025-11-18 00:29:39.379948 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2025-11-18 00:29:39.600126 | controller | ok 2025-11-18 00:29:39.613212 | 2025-11-18 00:29:39.613378 | TASK [test-setup : Run tools/test-setup.sh] 2025-11-18 00:29:40.159235 | controller | skipping: Conditional result was False 2025-11-18 00:29:40.197335 | 2025-11-18 00:29:40.197459 | PLAY RECAP 2025-11-18 00:29:40.197514 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2025-11-18 00:29:40.197542 | 2025-11-18 00:29:40.327395 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2025-11-18 00:29:40.329313 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2025-11-18 00:29:41.018031 | 2025-11-18 00:29:41.018154 | PLAY [controller] 2025-11-18 00:29:41.037606 | 2025-11-18 00:29:41.037709 | TASK [Create the /root directory] 2025-11-18 00:29:41.618033 | controller | ok 2025-11-18 00:29:41.628379 | 2025-11-18 00:29:41.628514 | TASK [Install glibc-langpack-en] 2025-11-18 00:29:45.560561 | controller | ok: Nothing to do 2025-11-18 00:29:45.568179 | 2025-11-18 00:29:45.568253 | TASK [Ensure controller directory exists] 2025-11-18 00:29:45.787610 | controller | changed 2025-11-18 00:29:45.799068 | 2025-11-18 00:29:45.799220 | TASK [Install container runtime] 2025-11-18 00:29:45.870457 | controller | ok 2025-11-18 00:29:45.933257 | 2025-11-18 00:29:45.933407 | LOOP [ensure-docker : Gather variables for each operating system] 2025-11-18 00:29:45.973479 | controller | ok: "/var/lib/zuul/builds/458aec53af5f4653b408e06ffee255f0/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/vars/fedora.yaml" 2025-11-18 00:29:45.987821 | 2025-11-18 00:29:45.987941 | TASK [ensure-docker : Sanity check for distro selection] 2025-11-18 00:29:46.012359 | controller | skipping: Conditional result was False 2025-11-18 00:29:46.018830 | 2025-11-18 00:29:46.018918 | TASK [ensure-docker : Sanity check for distro install] 2025-11-18 00:29:46.043144 | controller | skipping: Conditional result was False 2025-11-18 00:29:46.049805 | 2025-11-18 00:29:46.049884 | TASK [ensure-docker : Sanity check for upstream install] 2025-11-18 00:29:46.074204 | controller | skipping: Conditional result was False 2025-11-18 00:29:46.082987 | 2025-11-18 00:29:46.083098 | TASK [ensure-docker : Sanity check for upstream install mirrors] 2025-11-18 00:29:46.108671 | controller | skipping: Conditional result was False 2025-11-18 00:29:46.124190 | 2025-11-18 00:29:46.124365 | TASK [ensure-docker : Include tasks for docker install] 2025-11-18 00:29:46.158323 | controller | ok 2025-11-18 00:29:46.170613 | controller | included: /var/lib/zuul/builds/458aec53af5f4653b408e06ffee255f0/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/tasks/docker-upstream.yaml 2025-11-18 00:29:46.182274 | 2025-11-18 00:29:46.182362 | TASK [ensure-docker : Not Implemented] 2025-11-18 00:29:46.207800 | controller | skipping: Conditional result was False 2025-11-18 00:29:46.218232 | 2025-11-18 00:29:46.218372 | TASK [Set up docker mirrors] 2025-11-18 00:29:46.242454 | controller | ok 2025-11-18 00:29:46.267366 | 2025-11-18 00:29:46.267465 | TASK [use-docker-mirror : Set docker_mirror fact from mirror_info] 2025-11-18 00:29:46.301570 | controller | skipping: Conditional result was False 2025-11-18 00:29:46.307803 | 2025-11-18 00:29:46.307900 | TASK [use-docker-mirror : Set docker_mirror fact from zuul_site_mirror_info] 2025-11-18 00:29:46.341860 | controller | skipping: Conditional result was False 2025-11-18 00:29:46.348283 | 2025-11-18 00:29:46.348347 | TASK [use-docker-mirror : Set docker_mirror fact] 2025-11-18 00:29:46.382324 | controller | skipping: Conditional result was False 2025-11-18 00:29:46.388652 | 2025-11-18 00:29:46.388733 | TASK [use-docker-mirror : Set up docker mirrors] 2025-11-18 00:29:46.412582 | controller | skipping: Conditional result was False 2025-11-18 00:29:46.424775 | 2025-11-18 00:29:46.424847 | TASK [Add all repositories] 2025-11-18 00:29:46.443863 | controller | ok 2025-11-18 00:29:46.470353 | 2025-11-18 00:29:46.470439 | LOOP [ensure-package-repositories : Install repositories] 2025-11-18 00:29:46.507493 | controller | ok: "/var/lib/zuul/builds/458aec53af5f4653b408e06ffee255f0/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-package-repositories/tasks/RedHat.yaml" 2025-11-18 00:29:46.507737 | controller | ok: All items complete 2025-11-18 00:29:46.507780 | 2025-11-18 00:29:46.558932 | controller | included: /var/lib/zuul/builds/458aec53af5f4653b408e06ffee255f0/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-package-repositories/tasks/RedHat.yaml 2025-11-18 00:29:46.566398 | 2025-11-18 00:29:46.566469 | TASK [ensure-package-repositories : Create GPG key temp directory] 2025-11-18 00:29:46.912023 | controller | changed 2025-11-18 00:29:46.919056 | 2025-11-18 00:29:46.919119 | LOOP [ensure-package-repositories : Upload GPG keys] 2025-11-18 00:29:47.886402 | controller | changed: 2025-11-18 00:29:47.886568 | controller | { 2025-11-18 00:29:47.886594 | 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" 2025-11-18 00:29:47.886616 | controller | } 2025-11-18 00:29:47.896344 | 2025-11-18 00:29:47.896476 | LOOP [ensure-package-repositories : Import GPG keys] 2025-11-18 00:29:48.545163 | controller | changed: 2025-11-18 00:29:48.545353 | controller | { 2025-11-18 00:29:48.545380 | 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" 2025-11-18 00:29:48.545402 | controller | } 2025-11-18 00:29:48.545431 | controller | changed: All items complete 2025-11-18 00:29:48.545450 | 2025-11-18 00:29:48.568482 | 2025-11-18 00:29:48.569132 | TASK [ensure-package-repositories : Remove GPG temp directory] 2025-11-18 00:29:48.816396 | controller | changed 2025-11-18 00:29:48.822844 | 2025-11-18 00:29:48.822909 | LOOP [ensure-package-repositories : Add repositories] 2025-11-18 00:29:49.154965 | controller | changed: 2025-11-18 00:29:49.155125 | controller | { 2025-11-18 00:29:49.155150 | controller | "baseurl": "https://download.docker.com/linux/fedora/$releasever/$basearch/stable", 2025-11-18 00:29:49.155171 | controller | "description": "Docker CE Stable - $basearch", 2025-11-18 00:29:49.155188 | controller | "gpgcheck": true, 2025-11-18 00:29:49.155206 | controller | "name": "docker-ce-stable" 2025-11-18 00:29:49.155223 | controller | } 2025-11-18 00:29:49.173635 | 2025-11-18 00:29:49.173784 | TASK [ensure-docker : Install pre-reqs] 2025-11-18 00:29:51.558406 | controller | ok: Nothing to do 2025-11-18 00:29:51.571436 | 2025-11-18 00:29:51.571586 | TASK [ensure-docker : Remove packages] 2025-11-18 00:29:52.917438 | controller | ok: Nothing to do 2025-11-18 00:29:52.933572 | 2025-11-18 00:29:52.933748 | TASK [ensure-docker : Install upstream docker using package] 2025-11-18 00:30:39.280531 | controller | changed 2025-11-18 00:30:39.296558 | 2025-11-18 00:30:39.297003 | TASK [ensure-docker : Setup docker] 2025-11-18 00:30:39.322460 | controller | ok 2025-11-18 00:30:39.338628 | controller | included: /var/lib/zuul/builds/458aec53af5f4653b408e06ffee255f0/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/tasks/docker-setup.yaml 2025-11-18 00:30:39.357889 | 2025-11-18 00:30:39.358050 | TASK [ensure-docker : Ensure "docker" group exists] 2025-11-18 00:30:39.750068 | controller | ok 2025-11-18 00:30:39.766864 | 2025-11-18 00:30:39.767093 | TASK [ensure-docker : Add user to docker group] 2025-11-18 00:30:40.289936 | controller | changed 2025-11-18 00:30:40.311751 | 2025-11-18 00:30:40.311971 | TASK [Update docker daemon proxy configuration] 2025-11-18 00:30:40.342596 | controller | skipping: Conditional result was False 2025-11-18 00:30:40.352132 | 2025-11-18 00:30:40.352415 | TASK [Lower default MTU] 2025-11-18 00:30:40.378542 | controller | skipping: Conditional result was False 2025-11-18 00:30:40.389225 | 2025-11-18 00:30:40.389356 | TASK [ensure-docker : Get the status of the docket.socket unit] 2025-11-18 00:30:40.801648 | controller | inactive 2025-11-18 00:30:40.971429 | controller | ok: Runtime: 0:00:00.012667 2025-11-18 00:30:40.986411 | 2025-11-18 00:30:40.986568 | TASK [ensure-docker : Get the status of the docket unit] 2025-11-18 00:30:41.262292 | controller | inactive 2025-11-18 00:30:41.544961 | controller | ok: Runtime: 0:00:00.011954 2025-11-18 00:30:41.560527 | 2025-11-18 00:30:41.560743 | TASK [ensure-docker : Restart docker] 2025-11-18 00:30:41.612100 | Trigger a Docker restart 2025-11-18 00:30:41.625436 | 2025-11-18 00:30:41.625572 | TASK [ensure-docker : Reset ssh connection to pick up docker group] 2025-11-18 00:30:41.665099 | 2025-11-18 00:30:41.665228 | TASK [ensure-docker : Install docker-compose] 2025-11-18 00:30:41.681737 | controller | skipping: Conditional result was False 2025-11-18 00:30:41.692277 | 2025-11-18 00:30:41.692428 | TASK [ensure-docker : Flush handlers before role exit] 2025-11-18 00:30:41.707735 | 2025-11-18 00:30:41.707843 | TASK [ensure-docker : Stop docker.socket to avoid any conflict] 2025-11-18 00:30:43.035962 | controller | changed 2025-11-18 00:30:43.054205 | 2025-11-18 00:30:43.054351 | TASK [ensure-docker : Assure docker service is running] 2025-11-18 00:30:45.276169 | controller | changed 2025-11-18 00:30:45.290035 | 2025-11-18 00:30:45.290149 | TASK [ensure-docker : Assure docker.socket service is running] 2025-11-18 00:30:46.210720 | controller | ok 2025-11-18 00:30:46.229706 | 2025-11-18 00:30:46.229892 | TASK [ensure-docker : Correct group ownership on docker sock] 2025-11-18 00:30:46.826259 | controller | ok 2025-11-18 00:30:46.843540 | 2025-11-18 00:30:46.843915 | TASK [ensure-docker : Validate ability to talk with docker] 2025-11-18 00:30:47.274420 | controller | CONTAINER ID IMAGE COMMAND CREATED STATUS PORTS NAMES 2025-11-18 00:30:47.395239 | controller | ok: Runtime: 0:00:00.061351 2025-11-18 00:30:47.416759 | 2025-11-18 00:30:47.416889 | TASK [ensure-docker : Get version details] 2025-11-18 00:30:48.008010 | controller | Client: Docker Engine - Community 2025-11-18 00:30:48.009535 | controller | Version: 24.0.7 2025-11-18 00:30:48.009548 | controller | API version: 1.43 2025-11-18 00:30:48.009554 | controller | Go version: go1.20.10 2025-11-18 00:30:48.009565 | controller | Git commit: afdd53b 2025-11-18 00:30:48.009571 | controller | Built: Thu Oct 26 09:09:39 2023 2025-11-18 00:30:48.009576 | controller | OS/Arch: linux/amd64 2025-11-18 00:30:48.009581 | controller | Context: default 2025-11-18 00:30:48.009587 | controller | 2025-11-18 00:30:48.009592 | controller | Server: Docker Engine - Community 2025-11-18 00:30:48.009597 | controller | Engine: 2025-11-18 00:30:48.009601 | controller | Version: 24.0.7 2025-11-18 00:30:48.009605 | controller | API version: 1.43 (minimum version 1.12) 2025-11-18 00:30:48.009609 | controller | Go version: go1.20.10 2025-11-18 00:30:48.009613 | controller | Git commit: 311b9ff 2025-11-18 00:30:48.009617 | controller | Built: Thu Oct 26 09:08:11 2023 2025-11-18 00:30:48.009622 | controller | OS/Arch: linux/amd64 2025-11-18 00:30:48.009626 | controller | Experimental: false 2025-11-18 00:30:48.009630 | controller | containerd: 2025-11-18 00:30:48.009634 | controller | Version: 1.6.25 2025-11-18 00:30:48.009638 | controller | GitCommit: d8f198a4ed8892c764191ef7b3b06d8a2eeb5c7f 2025-11-18 00:30:48.009643 | controller | runc: 2025-11-18 00:30:48.009647 | controller | Version: 1.1.10 2025-11-18 00:30:48.009651 | controller | GitCommit: v1.1.10-0-g18a0cb0 2025-11-18 00:30:48.009657 | controller | docker-init: 2025-11-18 00:30:48.009661 | controller | Version: 0.19.0 2025-11-18 00:30:48.009665 | controller | GitCommit: de40ad0 2025-11-18 00:30:48.480276 | controller | ok: Runtime: 0:00:00.065128 2025-11-18 00:30:48.495115 | 2025-11-18 00:30:48.495269 | TASK [ensure-docker : Dump installed docker details] 2025-11-18 00:30:48.537335 | {'changed': True, 'stdout': 'Client: Docker Engine - Community\n Version: 24.0.7\n API version: 1.43\n Go version: go1.20.10\n Git commit: afdd53b\n Built: Thu Oct 26 09:09:39 2023\n OS/Arch: linux/amd64\n Context: default\n\nServer: Docker Engine - Community\n Engine:\n Version: 24.0.7\n API version: 1.43 (minimum version 1.12)\n Go version: go1.20.10\n Git commit: 311b9ff\n Built: Thu Oct 26 09:08:11 2023\n OS/Arch: linux/amd64\n Experimental: false\n containerd:\n Version: 1.6.25\n GitCommit: d8f198a4ed8892c764191ef7b3b06d8a2eeb5c7f\n runc:\n Version: 1.1.10\n GitCommit: v1.1.10-0-g18a0cb0\n docker-init:\n Version: 0.19.0\n GitCommit: de40ad0', 'stderr': '', 'rc': 0, 'cmd': ['docker', 'version'], 'start': '2025-11-18 00:30:47.944782', 'end': '2025-11-18 00:30:48.009910', 'delta': '0:00:00.065128', 'msg': '', 'zuul_log_id': 'fa163e3b-3c83-087a-6ae2-000000000061-1-controller', 'stdout_lines': ['Client: Docker Engine - Community', ' Version: 24.0.7', ' API version: 1.43', ' Go version: go1.20.10', ' Git commit: afdd53b', ' Built: Thu Oct 26 09:09:39 2023', ' OS/Arch: linux/amd64', ' Context: default', '', 'Server: Docker Engine - Community', ' Engine:', ' Version: 24.0.7', ' API version: 1.43 (minimum version 1.12)', ' Go version: go1.20.10', ' Git commit: 311b9ff', ' Built: Thu Oct 26 09:08:11 2023', ' OS/Arch: linux/amd64', ' Experimental: false', ' containerd:', ' Version: 1.6.25', ' GitCommit: d8f198a4ed8892c764191ef7b3b06d8a2eeb5c7f', ' runc:', ' Version: 1.1.10', ' GitCommit: v1.1.10-0-g18a0cb0', ' docker-init:', ' Version: 0.19.0', ' GitCommit: de40ad0'], 'stderr_lines': [], 'failed': False} 2025-11-18 00:30:48.550825 | 2025-11-18 00:30:48.550967 | TASK [Use buildset registry] 2025-11-18 00:30:48.579337 | controller | skipping: Conditional result was False 2025-11-18 00:30:48.605343 | 2025-11-18 00:30:48.605526 | TASK [Ensure python3.8 is present] 2025-11-18 00:30:48.633156 | controller | skipping: Conditional result was False 2025-11-18 00:30:48.642366 | 2025-11-18 00:30:48.642497 | TASK [Run our-ensure-python role (Fedora only for now)] 2025-11-18 00:30:48.667076 | controller | ok 2025-11-18 00:30:48.704011 | 2025-11-18 00:30:48.704161 | TASK [our-ensure-python : Install the right Python version (rpm)] 2025-11-18 00:30:50.759443 | controller | ok: Nothing to do 2025-11-18 00:30:50.773255 | 2025-11-18 00:30:50.773423 | TASK [our-ensure-python : Also install python3-devel] 2025-11-18 00:35:00.316348 | controller | ERROR 2025-11-18 00:35:00.316716 | controller | { 2025-11-18 00:35:00.316793 | controller | "msg": "Data could not be sent to remote host \"162.253.55.195\". Make sure this host can be reached over ssh: ssh: connect to host 162.253.55.195 port 22: No route to host\r\n", 2025-11-18 00:35:00.316849 | controller | "unreachable": true 2025-11-18 00:35:00.316887 | controller | } unreachable 2025-11-18 00:35:00.319818 | 2025-11-18 00:35:00.319982 | PLAY RECAP 2025-11-18 00:35:00.320068 | controller | ok: 28 changed: 14 unreachable: 1 failed: 0 skipped: 14 rescued: 0 ignored: 0 2025-11-18 00:35:00.320112 | 2025-11-18 00:35:00.499094 | PRE-RUN END RESULT_UNREACHABLE: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2025-11-18 00:35:00.500047 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2025-11-18 00:35:01.088012 | 2025-11-18 00:35:01.088126 | PLAY [all] 2025-11-18 00:35:01.112111 | 2025-11-18 00:35:01.112233 | TASK [fetch-subunit-output : Find stestr or testr executable] 2025-11-18 00:35:18.482997 | controller | ERROR 2025-11-18 00:35:18.483311 | controller | { 2025-11-18 00:35:18.483349 | controller | "msg": "Failed to connect to the host via ssh: ssh: connect to host 162.253.55.195 port 22: No route to host", 2025-11-18 00:35:18.483379 | controller | "unreachable": true 2025-11-18 00:35:18.483427 | controller | } unreachable 2025-11-18 00:35:18.485049 | 2025-11-18 00:35:18.485136 | PLAY RECAP 2025-11-18 00:35:18.485187 | controller | ok: 0 changed: 0 unreachable: 1 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-11-18 00:35:18.485210 | 2025-11-18 00:35:18.580597 | POST-RUN END RESULT_UNREACHABLE: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2025-11-18 00:35:18.581494 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2025-11-18 00:35:19.212486 | 2025-11-18 00:35:19.212705 | PLAY [all:!appliance*] 2025-11-18 00:35:19.235885 | 2025-11-18 00:35:19.236018 | TASK [unregister the node] 2025-11-18 00:35:22.312703 | [controller] Waiting on logger 2025-11-18 00:35:49.285412 | [Zuul] Log Stream did not terminate 2025-11-18 00:35:49.285730 | controller | skipping: Conditional result was False 2025-11-18 00:35:49.293598 | 2025-11-18 00:35:49.293749 | TASK [include_role : fetch-output] 2025-11-18 00:35:49.326009 | controller | ok 2025-11-18 00:35:49.352142 | 2025-11-18 00:35:49.352296 | TASK [fetch-output : Set log path for multiple nodes] 2025-11-18 00:35:49.409151 | controller | skipping: Conditional result was False 2025-11-18 00:35:49.415574 | 2025-11-18 00:35:49.415645 | TASK [fetch-output : Set log path for single node] 2025-11-18 00:35:49.445009 | controller | ok 2025-11-18 00:35:49.450250 | 2025-11-18 00:35:49.450311 | LOOP [fetch-output : Ensure local output dirs] 2025-11-18 00:35:49.854020 | controller -> localhost | ok: "/var/lib/zuul/builds/458aec53af5f4653b408e06ffee255f0/work/logs" 2025-11-18 00:35:50.126815 | controller -> localhost | changed: "/var/lib/zuul/builds/458aec53af5f4653b408e06ffee255f0/work/artifacts" 2025-11-18 00:35:50.388691 | controller -> localhost | changed: "/var/lib/zuul/builds/458aec53af5f4653b408e06ffee255f0/work/docs" 2025-11-18 00:35:50.417242 | 2025-11-18 00:35:50.417553 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-11-18 00:35:52.932040 | controller | changed: 2025-11-18 00:35:52.932625 | controller | .d..t...... ./ 2025-11-18 00:35:52.932750 | controller | cd+++++++++ controller/ 2025-11-18 00:35:52.933083 | controller | changed: All items complete 2025-11-18 00:35:52.933149 | 2025-11-18 00:35:53.573389 | controller | changed: .d..t...... ./ 2025-11-18 00:35:54.165070 | controller | changed: .d..t...... ./ 2025-11-18 00:35:54.199314 | 2025-11-18 00:35:54.199498 | TASK [include_role : fetch-output-openshift] 2025-11-18 00:35:54.225928 | controller | skipping: Conditional result was False 2025-11-18 00:35:54.235536 | 2025-11-18 00:35:54.235713 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2025-11-18 00:35:54.283588 | controller | skipping: Conditional result was False 2025-11-18 00:35:54.294656 | controller | skipping: Conditional result was False 2025-11-18 00:35:54.360060 | 2025-11-18 00:35:54.360192 | PLAY [localhost] 2025-11-18 00:35:54.378859 | 2025-11-18 00:35:54.379035 | TASK [Run Zuul manifest role] 2025-11-18 00:35:54.402029 | localhost | ok 2025-11-18 00:35:54.423890 | 2025-11-18 00:35:54.424052 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-11-18 00:35:54.868423 | localhost | changed 2025-11-18 00:35:54.879600 | 2025-11-18 00:35:54.879823 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-11-18 00:35:54.916797 | localhost | ok 2025-11-18 00:35:54.934871 | 2025-11-18 00:35:54.935040 | TASK [Set zuul-log-path fact] 2025-11-18 00:35:54.961398 | localhost | ok 2025-11-18 00:35:54.987625 | 2025-11-18 00:35:54.987790 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-18 00:35:55.020370 | localhost | ok 2025-11-18 00:35:55.032552 | 2025-11-18 00:35:55.032655 | LOOP [Run upload-logs-swift role] 2025-11-18 00:35:55.068809 | localhost | Output suppressed because no_log was given 2025-11-18 00:35:55.142839 | 2025-11-18 00:35:55.143007 | TASK [Set zuul-log-path fact] 2025-11-18 00:35:55.188854 | localhost | skipping: Conditional result was False 2025-11-18 00:35:55.195379 | 2025-11-18 00:35:55.195486 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2025-11-18 00:35:55.668811 | localhost -> localhost | ok: Runtime: 0:00:00.008134 2025-11-18 00:35:55.680504 | 2025-11-18 00:35:55.680648 | TASK [upload-logs-swift : Upload logs to swift]