2026-02-27 00:07:48.473818 | Job console starting... 2026-02-27 00:07:48.491894 | Updating repositories 2026-02-27 00:07:48.808837 | Preparing job workspace 2026-02-27 00:07:57.304311 | Running Ansible setup... 2026-02-27 00:08:02.549736 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-02-27 00:08:03.153427 | 2026-02-27 00:08:03.153566 | PLAY [localhost] 2026-02-27 00:08:03.161781 | 2026-02-27 00:08:03.161854 | TASK [Gathering Facts] 2026-02-27 00:08:04.176469 | localhost | ok 2026-02-27 00:08:04.198411 | 2026-02-27 00:08:04.198564 | TASK [Setup log path fact] 2026-02-27 00:08:04.220283 | localhost | ok 2026-02-27 00:08:04.233031 | 2026-02-27 00:08:04.233110 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-27 00:08:04.272874 | localhost | ok 2026-02-27 00:08:04.284561 | 2026-02-27 00:08:04.284675 | TASK [emit-job-header : Print job information] 2026-02-27 00:08:04.326372 | # Job Information 2026-02-27 00:08:04.326562 | Ansible Version: 2.15.12 2026-02-27 00:08:04.326607 | Job: ansible-test-sanity-docker-stable-2.9 2026-02-27 00:08:04.326638 | Pipeline: periodic 2026-02-27 00:08:04.326665 | Executor: ze01.softwarefactory-project.io 2026-02-27 00:08:04.326692 | Triggered by: https://github.com/ansible-collections/ansible.network 2026-02-27 00:08:04.326722 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/65c/ansible/65c7f4e6aec44463961c51426bd92407/ 2026-02-27 00:08:04.326751 | Event ID: c66414a510e648d9aec75995eff050a1 2026-02-27 00:08:04.332572 | 2026-02-27 00:08:04.332809 | LOOP [emit-job-header : Print node information] 2026-02-27 00:08:04.450419 | localhost | ok: 2026-02-27 00:08:04.450790 | localhost | # Node Information 2026-02-27 00:08:04.450835 | localhost | Inventory Hostname: controller 2026-02-27 00:08:04.450861 | localhost | Hostname: np0005632233 2026-02-27 00:08:04.450885 | localhost | Username: zuul 2026-02-27 00:08:04.450911 | localhost | Distro: Fedora 37 2026-02-27 00:08:04.450934 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2026-02-27 00:08:04.450955 | localhost | Region: ca-ymq-1 2026-02-27 00:08:04.450975 | localhost | Label: ansible-fedora-37-1vcpu 2026-02-27 00:08:04.450995 | localhost | Product Name: OpenStack Nova 2026-02-27 00:08:04.451044 | localhost | Interface IP: 199.204.45.109 2026-02-27 00:08:04.478561 | 2026-02-27 00:08:04.478749 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-27 00:08:04.883639 | localhost -> localhost | changed 2026-02-27 00:08:04.891331 | 2026-02-27 00:08:04.891435 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-27 00:08:05.842565 | localhost -> localhost | changed 2026-02-27 00:08:05.862780 | 2026-02-27 00:08:05.862867 | PLAY [all:!appliance*] 2026-02-27 00:08:05.879119 | 2026-02-27 00:08:05.879224 | TASK [include_role : start-zuul-console] 2026-02-27 00:08:05.899247 | controller | ok 2026-02-27 00:08:05.913695 | 2026-02-27 00:08:05.913784 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-02-27 00:08:06.305718 | controller | ok 2026-02-27 00:08:06.329879 | 2026-02-27 00:08:06.330060 | TASK [use-our-mirror : Retrieve the IP address] 2026-02-27 00:08:07.312784 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2026-02-27 00:08:07.328457 | 2026-02-27 00:08:07.328613 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2026-02-27 00:08:07.879506 | controller | skipping: Conditional result was False 2026-02-27 00:08:07.895287 | 2026-02-27 00:08:07.895503 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2026-02-27 00:08:07.925113 | controller | skipping: Conditional result was False 2026-02-27 00:08:07.943366 | 2026-02-27 00:08:07.943564 | TASK [use-our-mirror : Create the podman configuration directory] 2026-02-27 00:08:07.970997 | controller | skipping: Conditional result was False 2026-02-27 00:08:07.985116 | 2026-02-27 00:08:07.985274 | TASK [use-our-mirror : Copy the podman configuration] 2026-02-27 00:08:08.012395 | controller | skipping: Conditional result was False 2026-02-27 00:08:08.026366 | 2026-02-27 00:08:08.026518 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2026-02-27 00:08:08.053891 | controller | skipping: Conditional result was False 2026-02-27 00:08:08.064172 | 2026-02-27 00:08:08.064303 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2026-02-27 00:08:08.091782 | controller | skipping: Conditional result was False 2026-02-27 00:08:08.121624 | 2026-02-27 00:08:08.121791 | TASK [Disable Fedora Modular] 2026-02-27 00:08:08.397248 | controller | changed 2026-02-27 00:08:08.410774 | 2026-02-27 00:08:08.410914 | TASK [Enable EPEL] 2026-02-27 00:08:08.439520 | controller | skipping: Conditional result was False 2026-02-27 00:08:08.454010 | 2026-02-27 00:08:08.454189 | TASK [Register the RHEL node] 2026-02-27 00:08:09.023605 | 2026-02-27 00:08:09.023915 | TASK [Show the subscription-manager status] 2026-02-27 00:08:09.617105 | controller | skipping: Conditional result was False 2026-02-27 00:08:09.630467 | 2026-02-27 00:08:09.630560 | TASK [Enable EPEL on RHEL] 2026-02-27 00:08:10.172057 | controller | skipping: Conditional result was False 2026-02-27 00:08:10.185414 | 2026-02-27 00:08:10.185601 | TASK [Install git and tox] 2026-02-27 00:09:33.225829 | controller | changed 2026-02-27 00:09:33.241176 | 2026-02-27 00:09:33.241361 | TASK [include_role : prepare-workspace] 2026-02-27 00:09:33.285722 | controller | ok 2026-02-27 00:09:33.322932 | 2026-02-27 00:09:33.323126 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-02-27 00:09:33.570499 | controller | ok 2026-02-27 00:09:33.584357 | 2026-02-27 00:09:33.584486 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-02-27 00:15:26.385036 | controller | Output suppressed because no_log was given 2026-02-27 00:15:26.395057 | 2026-02-27 00:15:26.395123 | TASK [include_role : prepare-workspace-openshift] 2026-02-27 00:15:26.425218 | controller | skipping: Conditional result was False 2026-02-27 00:15:26.451799 | 2026-02-27 00:15:26.451905 | PLAY [all:!appliance] 2026-02-27 00:15:26.467764 | 2026-02-27 00:15:26.467834 | TASK [Run add-build-sshkey role (RSA)] 2026-02-27 00:15:26.487732 | controller | ok 2026-02-27 00:15:26.509528 | 2026-02-27 00:15:26.509791 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-27 00:15:26.759042 | controller -> localhost | ok 2026-02-27 00:15:26.766794 | 2026-02-27 00:15:26.766872 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-27 00:15:26.796460 | controller | ok 2026-02-27 00:15:26.817470 | controller | included: /var/lib/zuul/builds/65c7f4e6aec44463961c51426bd92407/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-27 00:15:26.826209 | 2026-02-27 00:15:26.826306 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-27 00:15:27.311296 | controller -> localhost | Generating public/private rsa key pair. 2026-02-27 00:15:27.311526 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/65c7f4e6aec44463961c51426bd92407/work/65c7f4e6aec44463961c51426bd92407_id_rsa. 2026-02-27 00:15:27.311555 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/65c7f4e6aec44463961c51426bd92407/work/65c7f4e6aec44463961c51426bd92407_id_rsa.pub. 2026-02-27 00:15:27.311576 | controller -> localhost | The key fingerprint is: 2026-02-27 00:15:27.311595 | controller -> localhost | SHA256:3wyFx6snsisNghh72eKjn40pWF1OlCvGvq6SkqVhoPg zuul-build-sshkey 2026-02-27 00:15:27.311614 | controller -> localhost | The key's randomart image is: 2026-02-27 00:15:27.311633 | controller -> localhost | +---[RSA 2048]----+ 2026-02-27 00:15:27.311650 | controller -> localhost | | . | 2026-02-27 00:15:27.311669 | controller -> localhost | | o o | 2026-02-27 00:15:27.311687 | controller -> localhost | | . . . . + | 2026-02-27 00:15:27.311705 | controller -> localhost | |o + + o . | 2026-02-27 00:15:27.311721 | controller -> localhost | |++ B = S . . | 2026-02-27 00:15:27.311749 | controller -> localhost | |*.B = o . = | 2026-02-27 00:15:27.311772 | controller -> localhost | |o@ . o o. + + | 2026-02-27 00:15:27.311792 | controller -> localhost | |O E=. . .o o | 2026-02-27 00:15:27.311811 | controller -> localhost | |o=*+o .o. | 2026-02-27 00:15:27.311831 | controller -> localhost | +----[SHA256]-----+ 2026-02-27 00:15:27.311880 | controller -> localhost | ok: Runtime: 0:00:00.043710 2026-02-27 00:15:27.318936 | 2026-02-27 00:15:27.319000 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-27 00:15:27.349958 | controller | ok 2026-02-27 00:15:27.377360 | controller | included: /var/lib/zuul/builds/65c7f4e6aec44463961c51426bd92407/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-27 00:15:27.387269 | 2026-02-27 00:15:27.387344 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-27 00:15:27.411644 | controller | skipping: Conditional result was False 2026-02-27 00:15:27.418543 | 2026-02-27 00:15:27.418619 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-27 00:15:28.101236 | controller | changed 2026-02-27 00:15:28.107791 | 2026-02-27 00:15:28.107875 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-27 00:15:28.337266 | controller | ok 2026-02-27 00:15:28.349106 | 2026-02-27 00:15:28.349242 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-27 00:15:28.989426 | controller | changed 2026-02-27 00:15:28.998146 | 2026-02-27 00:15:28.998240 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-27 00:15:29.651266 | controller | changed 2026-02-27 00:15:29.665377 | 2026-02-27 00:15:29.665546 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-27 00:15:29.704522 | controller | skipping: Conditional result was False 2026-02-27 00:15:29.711407 | 2026-02-27 00:15:29.711495 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-27 00:15:30.289185 | controller -> localhost | changed 2026-02-27 00:15:30.302895 | 2026-02-27 00:15:30.303032 | TASK [add-build-sshkey : Add back temp key] 2026-02-27 00:15:30.638245 | controller -> localhost | Identity added: /var/lib/zuul/builds/65c7f4e6aec44463961c51426bd92407/work/65c7f4e6aec44463961c51426bd92407_id_rsa (zuul-build-sshkey) 2026-02-27 00:15:30.638584 | controller -> localhost | ok: Runtime: 0:00:00.037181 2026-02-27 00:15:30.661194 | 2026-02-27 00:15:30.661360 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-27 00:15:31.052609 | controller | ok 2026-02-27 00:15:31.061210 | 2026-02-27 00:15:31.061327 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-27 00:15:31.097746 | controller | skipping: Conditional result was False 2026-02-27 00:15:31.175892 | 2026-02-27 00:15:31.176051 | TASK [Run add-build-sshkey role (ECDSA)] 2026-02-27 00:15:31.212415 | controller | ok 2026-02-27 00:15:31.241920 | 2026-02-27 00:15:31.242062 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-27 00:15:31.579175 | controller -> localhost | ok 2026-02-27 00:15:31.587045 | 2026-02-27 00:15:31.587123 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-27 00:15:31.634056 | controller | ok 2026-02-27 00:15:31.645464 | controller | included: /var/lib/zuul/builds/65c7f4e6aec44463961c51426bd92407/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-27 00:15:31.651853 | 2026-02-27 00:15:31.651915 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-27 00:15:32.104153 | controller -> localhost | Generating public/private ecdsa key pair. 2026-02-27 00:15:32.104389 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/65c7f4e6aec44463961c51426bd92407/work/65c7f4e6aec44463961c51426bd92407_id_ecdsa. 2026-02-27 00:15:32.104417 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/65c7f4e6aec44463961c51426bd92407/work/65c7f4e6aec44463961c51426bd92407_id_ecdsa.pub. 2026-02-27 00:15:32.104446 | controller -> localhost | The key fingerprint is: 2026-02-27 00:15:32.104467 | controller -> localhost | SHA256:ZHq6z0FmRSYmMqUecowWsC7vHw+cNfo2C1tRs4G9PTU zuul-build-sshkey 2026-02-27 00:15:32.104488 | controller -> localhost | The key's randomart image is: 2026-02-27 00:15:32.104506 | controller -> localhost | +---[ECDSA 521]---+ 2026-02-27 00:15:32.104524 | controller -> localhost | |... o.o o o | 2026-02-27 00:15:32.104542 | controller -> localhost | | . + + = + | 2026-02-27 00:15:32.104559 | controller -> localhost | |. + = . B . E | 2026-02-27 00:15:32.104576 | controller -> localhost | |.. + . = B . . | 2026-02-27 00:15:32.104593 | controller -> localhost | |.. . = S o | 2026-02-27 00:15:32.104610 | controller -> localhost | |.. . + O . | 2026-02-27 00:15:32.104627 | controller -> localhost | | . B o . | 2026-02-27 00:15:32.104644 | controller -> localhost | | . Ooo . | 2026-02-27 00:15:32.104661 | controller -> localhost | | ..o.=+o | 2026-02-27 00:15:32.104677 | controller -> localhost | +----[SHA256]-----+ 2026-02-27 00:15:32.104732 | controller -> localhost | ok: Runtime: 0:00:00.025586 2026-02-27 00:15:32.112143 | 2026-02-27 00:15:32.112226 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-27 00:15:32.165225 | controller | ok 2026-02-27 00:15:32.188366 | controller | included: /var/lib/zuul/builds/65c7f4e6aec44463961c51426bd92407/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-27 00:15:32.215809 | 2026-02-27 00:15:32.215905 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-27 00:15:32.245485 | controller | skipping: Conditional result was False 2026-02-27 00:15:32.255605 | 2026-02-27 00:15:32.255955 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-27 00:15:32.537133 | controller | changed 2026-02-27 00:15:32.546928 | 2026-02-27 00:15:32.547056 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-27 00:15:32.809259 | controller | ok 2026-02-27 00:15:32.823738 | 2026-02-27 00:15:32.823914 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-27 00:15:33.455820 | controller | changed 2026-02-27 00:15:33.467553 | 2026-02-27 00:15:33.467672 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-27 00:15:34.133968 | controller | changed 2026-02-27 00:15:34.154081 | 2026-02-27 00:15:34.154233 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-27 00:15:34.180580 | controller | skipping: Conditional result was False 2026-02-27 00:15:34.200194 | 2026-02-27 00:15:34.200321 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-27 00:15:34.478544 | controller -> localhost | changed 2026-02-27 00:15:34.492624 | 2026-02-27 00:15:34.492732 | TASK [add-build-sshkey : Add back temp key] 2026-02-27 00:15:34.761493 | controller -> localhost | Identity added: /var/lib/zuul/builds/65c7f4e6aec44463961c51426bd92407/work/65c7f4e6aec44463961c51426bd92407_id_ecdsa (zuul-build-sshkey) 2026-02-27 00:15:34.761713 | controller -> localhost | ok: Runtime: 0:00:00.012786 2026-02-27 00:15:34.769368 | 2026-02-27 00:15:34.769434 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-27 00:15:35.561214 | controller | ok 2026-02-27 00:15:35.570352 | 2026-02-27 00:15:35.570455 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-27 00:15:35.600535 | controller | skipping: Conditional result was False 2026-02-27 00:15:35.623183 | 2026-02-27 00:15:35.623300 | TASK [include_role : remove-zuul-sshkey] 2026-02-27 00:15:35.637534 | controller | skipping: Conditional result was False 2026-02-27 00:15:35.646691 | 2026-02-27 00:15:35.646791 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-02-27 00:15:35.917299 | controller | ok: "logs" 2026-02-27 00:15:35.917534 | controller | ok: All items complete 2026-02-27 00:15:35.917561 | 2026-02-27 00:15:36.106713 | controller | ok: "artifacts" 2026-02-27 00:15:36.297280 | controller | ok: "docs" 2026-02-27 00:15:36.313315 | 2026-02-27 00:15:36.313437 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-02-27 00:15:36.546533 | controller | changed: "logs" 2026-02-27 00:15:36.767292 | controller | changed: "artifacts" 2026-02-27 00:15:36.985905 | controller | changed: "docs" 2026-02-27 00:15:37.038065 | 2026-02-27 00:15:37.038160 | PLAY RECAP 2026-02-27 00:15:37.038203 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2026-02-27 00:15:37.038231 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-27 00:15:37.038250 | 2026-02-27 00:15:37.146647 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-02-27 00:15:37.147535 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-27 00:15:37.738888 | 2026-02-27 00:15:37.739000 | PLAY [all] 2026-02-27 00:15:37.762262 | 2026-02-27 00:15:37.762357 | TASK [Install binary dependencies] 2026-02-27 00:15:37.822699 | controller | ok 2026-02-27 00:15:37.844490 | 2026-02-27 00:15:37.844597 | TASK [bindep : Include find tasks] 2026-02-27 00:15:37.874473 | controller | ok 2026-02-27 00:15:37.882584 | controller | included: /var/lib/zuul/builds/65c7f4e6aec44463961c51426bd92407/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-02-27 00:15:37.889731 | 2026-02-27 00:15:37.889796 | TASK [bindep : Look for bindep.txt] 2026-02-27 00:15:38.545827 | controller | ok 2026-02-27 00:15:38.551874 | 2026-02-27 00:15:38.551940 | TASK [bindep : Define bindep_file fact] 2026-02-27 00:15:38.566491 | controller | skipping: Conditional result was False 2026-02-27 00:15:38.577721 | 2026-02-27 00:15:38.577795 | TASK [bindep : Look for other-requirements.txt] 2026-02-27 00:15:38.791777 | controller | ok 2026-02-27 00:15:38.799725 | 2026-02-27 00:15:38.799823 | TASK [bindep : Define bindep_file fact] 2026-02-27 00:15:38.835272 | controller | skipping: Conditional result was False 2026-02-27 00:15:38.843883 | 2026-02-27 00:15:38.843977 | TASK [bindep : Look for bindep fallback file] 2026-02-27 00:15:38.879352 | controller | skipping: Conditional result was False 2026-02-27 00:15:38.886208 | 2026-02-27 00:15:38.886274 | TASK [bindep : Define bindep_file fact] 2026-02-27 00:15:38.909764 | controller | skipping: Conditional result was False 2026-02-27 00:15:38.915932 | 2026-02-27 00:15:38.916003 | TASK [bindep : Include bindep tasks] 2026-02-27 00:15:38.953862 | controller | skipping: Conditional result was False 2026-02-27 00:15:38.962320 | 2026-02-27 00:15:38.962435 | TASK [bindep : Include install tasks] 2026-02-27 00:15:38.998539 | controller | skipping: Conditional result was False 2026-02-27 00:15:39.007297 | 2026-02-27 00:15:39.007466 | LOOP [bindep : Include package tasks] 2026-02-27 00:15:39.078435 | 2026-02-27 00:15:39.078780 | TASK [Run test-setup role] 2026-02-27 00:15:39.106890 | controller | ok 2026-02-27 00:15:39.135053 | 2026-02-27 00:15:39.135279 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-02-27 00:15:39.353256 | controller | ok 2026-02-27 00:15:39.367950 | 2026-02-27 00:15:39.368136 | TASK [test-setup : Run tools/test-setup.sh] 2026-02-27 00:15:39.914871 | controller | skipping: Conditional result was False 2026-02-27 00:15:39.954890 | 2026-02-27 00:15:39.955010 | PLAY RECAP 2026-02-27 00:15:39.955084 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-27 00:15:39.955115 | 2026-02-27 00:15:40.143508 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-27 00:15:40.144729 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-02-27 00:15:40.771814 | 2026-02-27 00:15:40.771936 | PLAY [controller] 2026-02-27 00:15:40.792532 | 2026-02-27 00:15:40.792659 | TASK [Create the /root directory] 2026-02-27 00:15:41.371073 | controller | ok 2026-02-27 00:15:41.385822 | 2026-02-27 00:15:41.385985 | TASK [Install glibc-langpack-en] 2026-02-27 00:15:45.282196 | controller | ok: Nothing to do 2026-02-27 00:15:45.300263 | 2026-02-27 00:15:45.300414 | TASK [Ensure controller directory exists] 2026-02-27 00:15:45.515699 | controller | changed 2026-02-27 00:15:45.521824 | 2026-02-27 00:15:45.521906 | TASK [Install container runtime] 2026-02-27 00:15:45.583759 | controller | ok 2026-02-27 00:15:45.632525 | 2026-02-27 00:15:45.632687 | LOOP [ensure-docker : Gather variables for each operating system] 2026-02-27 00:15:45.676744 | controller | ok: "/var/lib/zuul/builds/65c7f4e6aec44463961c51426bd92407/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/vars/fedora.yaml" 2026-02-27 00:15:45.684984 | 2026-02-27 00:15:45.685143 | TASK [ensure-docker : Sanity check for distro selection] 2026-02-27 00:15:45.710063 | controller | skipping: Conditional result was False 2026-02-27 00:15:45.716493 | 2026-02-27 00:15:45.716570 | TASK [ensure-docker : Sanity check for distro install] 2026-02-27 00:15:45.740728 | controller | skipping: Conditional result was False 2026-02-27 00:15:45.747424 | 2026-02-27 00:15:45.747548 | TASK [ensure-docker : Sanity check for upstream install] 2026-02-27 00:15:45.771995 | controller | skipping: Conditional result was False 2026-02-27 00:15:45.779484 | 2026-02-27 00:15:45.779552 | TASK [ensure-docker : Sanity check for upstream install mirrors] 2026-02-27 00:15:45.803768 | controller | skipping: Conditional result was False 2026-02-27 00:15:45.811418 | 2026-02-27 00:15:45.811492 | TASK [ensure-docker : Include tasks for docker install] 2026-02-27 00:15:45.841468 | controller | ok 2026-02-27 00:15:45.850478 | controller | included: /var/lib/zuul/builds/65c7f4e6aec44463961c51426bd92407/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/tasks/docker-upstream.yaml 2026-02-27 00:15:45.858785 | 2026-02-27 00:15:45.858867 | TASK [ensure-docker : Not Implemented] 2026-02-27 00:15:45.873310 | controller | skipping: Conditional result was False 2026-02-27 00:15:45.880246 | 2026-02-27 00:15:45.880321 | TASK [Set up docker mirrors] 2026-02-27 00:15:45.899112 | controller | ok 2026-02-27 00:15:45.920082 | 2026-02-27 00:15:45.920166 | TASK [use-docker-mirror : Set docker_mirror fact from mirror_info] 2026-02-27 00:15:45.947774 | controller | skipping: Conditional result was False 2026-02-27 00:15:45.955930 | 2026-02-27 00:15:45.956040 | TASK [use-docker-mirror : Set docker_mirror fact from zuul_site_mirror_info] 2026-02-27 00:15:45.991413 | controller | skipping: Conditional result was False 2026-02-27 00:15:46.000806 | 2026-02-27 00:15:46.000897 | TASK [use-docker-mirror : Set docker_mirror fact] 2026-02-27 00:15:46.036895 | controller | skipping: Conditional result was False 2026-02-27 00:15:46.045783 | 2026-02-27 00:15:46.045874 | TASK [use-docker-mirror : Set up docker mirrors] 2026-02-27 00:15:46.071009 | controller | skipping: Conditional result was False 2026-02-27 00:15:46.088048 | 2026-02-27 00:15:46.088138 | TASK [Add all repositories] 2026-02-27 00:15:46.110251 | controller | ok 2026-02-27 00:15:46.142842 | 2026-02-27 00:15:46.142960 | LOOP [ensure-package-repositories : Install repositories] 2026-02-27 00:15:46.170848 | controller | ok: "/var/lib/zuul/builds/65c7f4e6aec44463961c51426bd92407/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-package-repositories/tasks/RedHat.yaml" 2026-02-27 00:15:46.171222 | controller | ok: All items complete 2026-02-27 00:15:46.171260 | 2026-02-27 00:15:46.217322 | controller | included: /var/lib/zuul/builds/65c7f4e6aec44463961c51426bd92407/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-package-repositories/tasks/RedHat.yaml 2026-02-27 00:15:46.223811 | 2026-02-27 00:15:46.223870 | TASK [ensure-package-repositories : Create GPG key temp directory] 2026-02-27 00:15:46.546185 | controller | changed 2026-02-27 00:15:46.560537 | 2026-02-27 00:15:46.560674 | LOOP [ensure-package-repositories : Upload GPG keys] 2026-02-27 00:15:47.528560 | controller | changed: 2026-02-27 00:15:47.528893 | controller | { 2026-02-27 00:15:47.529047 | 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-02-27 00:15:47.529144 | controller | } 2026-02-27 00:15:47.548967 | 2026-02-27 00:15:47.549281 | LOOP [ensure-package-repositories : Import GPG keys] 2026-02-27 00:15:48.163818 | controller | changed: 2026-02-27 00:15:48.164294 | controller | { 2026-02-27 00:15:48.164365 | 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-02-27 00:15:48.164416 | controller | } 2026-02-27 00:15:48.164475 | controller | changed: All items complete 2026-02-27 00:15:48.164517 | 2026-02-27 00:15:48.188336 | 2026-02-27 00:15:48.188570 | TASK [ensure-package-repositories : Remove GPG temp directory] 2026-02-27 00:15:48.423275 | controller | changed 2026-02-27 00:15:48.437941 | 2026-02-27 00:15:48.438105 | LOOP [ensure-package-repositories : Add repositories] 2026-02-27 00:15:48.851534 | controller | changed: 2026-02-27 00:15:48.851829 | controller | { 2026-02-27 00:15:48.851894 | controller | "baseurl": "https://download.docker.com/linux/fedora/$releasever/$basearch/stable", 2026-02-27 00:15:48.851954 | controller | "description": "Docker CE Stable - $basearch", 2026-02-27 00:15:48.851996 | controller | "gpgcheck": true, 2026-02-27 00:15:48.852076 | controller | "name": "docker-ce-stable" 2026-02-27 00:15:48.852117 | controller | } 2026-02-27 00:15:48.885832 | 2026-02-27 00:15:48.886071 | TASK [ensure-docker : Install pre-reqs] 2026-02-27 00:15:51.282431 | controller | ok: Nothing to do 2026-02-27 00:15:51.297754 | 2026-02-27 00:15:51.297899 | TASK [ensure-docker : Remove packages] 2026-02-27 00:15:52.639834 | controller | ok: Nothing to do 2026-02-27 00:15:52.648155 | 2026-02-27 00:15:52.648242 | TASK [ensure-docker : Install upstream docker using package] 2026-02-27 00:16:37.813155 | controller | changed 2026-02-27 00:16:37.821700 | 2026-02-27 00:16:37.821818 | TASK [ensure-docker : Setup docker] 2026-02-27 00:16:37.862087 | controller | ok 2026-02-27 00:16:37.875190 | controller | included: /var/lib/zuul/builds/65c7f4e6aec44463961c51426bd92407/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-docker/tasks/docker-setup.yaml 2026-02-27 00:16:37.889846 | 2026-02-27 00:16:37.890002 | TASK [ensure-docker : Ensure "docker" group exists] 2026-02-27 00:16:38.253458 | controller | ok 2026-02-27 00:16:38.268645 | 2026-02-27 00:16:38.268909 | TASK [ensure-docker : Add user to docker group] 2026-02-27 00:16:38.828192 | controller | changed 2026-02-27 00:16:38.835358 | 2026-02-27 00:16:38.835420 | TASK [Update docker daemon proxy configuration] 2026-02-27 00:16:38.872929 | controller | skipping: Conditional result was False 2026-02-27 00:16:38.885393 | 2026-02-27 00:16:38.885583 | TASK [Lower default MTU] 2026-02-27 00:16:38.914059 | controller | skipping: Conditional result was False 2026-02-27 00:16:38.925771 | 2026-02-27 00:16:38.925971 | TASK [ensure-docker : Get the status of the docket.socket unit] 2026-02-27 00:16:39.341555 | controller | inactive 2026-02-27 00:16:39.502235 | controller | ok: Runtime: 0:00:00.013508 2026-02-27 00:16:39.514712 | 2026-02-27 00:16:39.514883 | TASK [ensure-docker : Get the status of the docket unit] 2026-02-27 00:16:39.785469 | controller | inactive 2026-02-27 00:16:40.060656 | controller | ok: Runtime: 0:00:00.009523 2026-02-27 00:16:40.071263 | 2026-02-27 00:16:40.071390 | TASK [ensure-docker : Restart docker] 2026-02-27 00:16:40.115859 | Trigger a Docker restart 2026-02-27 00:16:40.124287 | 2026-02-27 00:16:40.124436 | TASK [ensure-docker : Reset ssh connection to pick up docker group] 2026-02-27 00:16:40.162501 | 2026-02-27 00:16:40.162657 | TASK [ensure-docker : Install docker-compose] 2026-02-27 00:16:40.178823 | controller | skipping: Conditional result was False 2026-02-27 00:16:40.190348 | 2026-02-27 00:16:40.190530 | TASK [ensure-docker : Flush handlers before role exit] 2026-02-27 00:16:40.205395 | 2026-02-27 00:16:40.205572 | TASK [ensure-docker : Stop docker.socket to avoid any conflict] 2026-02-27 00:16:41.395168 | controller | changed 2026-02-27 00:16:41.413048 | 2026-02-27 00:16:41.413202 | TASK [ensure-docker : Assure docker service is running] 2026-02-27 00:16:43.447292 | controller | changed 2026-02-27 00:16:43.463913 | 2026-02-27 00:16:43.464080 | TASK [ensure-docker : Assure docker.socket service is running] 2026-02-27 00:16:44.443945 | controller | ok 2026-02-27 00:16:44.457119 | 2026-02-27 00:16:44.457218 | TASK [ensure-docker : Correct group ownership on docker sock] 2026-02-27 00:16:45.053744 | controller | ok 2026-02-27 00:16:45.067812 | 2026-02-27 00:16:45.067960 | TASK [ensure-docker : Validate ability to talk with docker] 2026-02-27 00:16:45.629124 | controller | CONTAINER ID IMAGE COMMAND CREATED STATUS PORTS NAMES 2026-02-27 00:16:46.118843 | controller | ok: Runtime: 0:00:00.045785 2026-02-27 00:16:46.134802 | 2026-02-27 00:16:46.134978 | TASK [ensure-docker : Get version details] 2026-02-27 00:16:46.805617 | controller | Client: Docker Engine - Community 2026-02-27 00:16:46.807222 | controller | Version: 24.0.7 2026-02-27 00:16:46.807262 | controller | API version: 1.43 2026-02-27 00:16:46.807269 | controller | Go version: go1.20.10 2026-02-27 00:16:46.807284 | controller | Git commit: afdd53b 2026-02-27 00:16:46.807290 | controller | Built: Thu Oct 26 09:09:39 2023 2026-02-27 00:16:46.807295 | controller | OS/Arch: linux/amd64 2026-02-27 00:16:46.807301 | controller | Context: default 2026-02-27 00:16:46.807308 | controller | 2026-02-27 00:16:46.807313 | controller | Server: Docker Engine - Community 2026-02-27 00:16:46.807317 | controller | Engine: 2026-02-27 00:16:46.807322 | controller | Version: 24.0.7 2026-02-27 00:16:46.807326 | controller | API version: 1.43 (minimum version 1.12) 2026-02-27 00:16:46.807330 | controller | Go version: go1.20.10 2026-02-27 00:16:46.807335 | controller | Git commit: 311b9ff 2026-02-27 00:16:46.807339 | controller | Built: Thu Oct 26 09:08:11 2023 2026-02-27 00:16:46.807343 | controller | OS/Arch: linux/amd64 2026-02-27 00:16:46.807348 | controller | Experimental: false 2026-02-27 00:16:46.807352 | controller | containerd: 2026-02-27 00:16:46.807357 | controller | Version: 1.6.25 2026-02-27 00:16:46.807361 | controller | GitCommit: d8f198a4ed8892c764191ef7b3b06d8a2eeb5c7f 2026-02-27 00:16:46.807365 | controller | runc: 2026-02-27 00:16:46.807369 | controller | Version: 1.1.10 2026-02-27 00:16:46.807374 | controller | GitCommit: v1.1.10-0-g18a0cb0 2026-02-27 00:16:46.807389 | controller | docker-init: 2026-02-27 00:16:46.807394 | controller | Version: 0.19.0 2026-02-27 00:16:46.807399 | controller | GitCommit: de40ad0 2026-02-27 00:16:47.195750 | controller | ok: Runtime: 0:00:00.093812 2026-02-27 00:16:47.204668 | 2026-02-27 00:16:47.204767 | TASK [ensure-docker : Dump installed docker details] 2026-02-27 00:16:47.245438 | {'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': '2026-02-27 00:16:46.713874', 'end': '2026-02-27 00:16:46.807686', 'delta': '0:00:00.093812', 'msg': '', 'zuul_log_id': 'fa163ec2-ffbe-8589-a043-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} 2026-02-27 00:16:47.251319 | 2026-02-27 00:16:47.251382 | TASK [Use buildset registry] 2026-02-27 00:16:47.277917 | controller | skipping: Conditional result was False 2026-02-27 00:16:47.289937 | 2026-02-27 00:16:47.290004 | TASK [Ensure python3.8 is present] 2026-02-27 00:16:47.304073 | controller | skipping: Conditional result was False 2026-02-27 00:16:47.311700 | 2026-02-27 00:16:47.311804 | TASK [Run our-ensure-python role (Fedora only for now)] 2026-02-27 00:16:47.354955 | controller | ok 2026-02-27 00:16:47.375140 | 2026-02-27 00:16:47.375248 | TASK [our-ensure-python : Install the right Python version (rpm)] 2026-02-27 00:16:49.608191 | controller | ok: Nothing to do 2026-02-27 00:16:49.614102 | 2026-02-27 00:16:49.614169 | TASK [our-ensure-python : Also install python3-devel] 2026-02-27 00:21:37.277731 | controller | ERROR 2026-02-27 00:21:37.277939 | controller | { 2026-02-27 00:21:37.277977 | controller | "msg": "Data could not be sent to remote host \"199.204.45.109\". Make sure this host can be reached over ssh: ssh: connect to host 199.204.45.109 port 22: No route to host\r\n", 2026-02-27 00:21:37.278009 | controller | "unreachable": true 2026-02-27 00:21:37.278086 | controller | } unreachable 2026-02-27 00:21:37.279852 | 2026-02-27 00:21:37.279908 | PLAY RECAP 2026-02-27 00:21:37.279956 | controller | ok: 28 changed: 14 unreachable: 1 failed: 0 skipped: 14 rescued: 0 ignored: 0 2026-02-27 00:21:37.279981 | 2026-02-27 00:21:37.410167 | PRE-RUN END RESULT_UNREACHABLE: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-02-27 00:21:37.411169 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-27 00:21:38.042740 | 2026-02-27 00:21:38.042857 | PLAY [all] 2026-02-27 00:21:38.066370 | 2026-02-27 00:21:38.066524 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-02-27 00:21:58.124277 | controller | changed: non-zero return code 2026-02-27 00:21:58.139702 | 2026-02-27 00:21:58.139885 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-02-27 00:21:58.165899 | controller | skipping: Conditional result was False 2026-02-27 00:21:58.175202 | 2026-02-27 00:21:58.175345 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-02-27 00:21:58.212170 | 2026-02-27 00:21:58.212383 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-02-27 00:21:58.248866 | 2026-02-27 00:21:58.249285 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-02-27 00:21:58.276813 | controller | skipping: Conditional result was False 2026-02-27 00:21:58.285992 | 2026-02-27 00:21:58.286131 | LOOP [fetch-subunit-output : Generate subunit file] 2026-02-27 00:21:58.319557 | 2026-02-27 00:21:58.319743 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-02-27 00:21:58.345241 | controller | skipping: Conditional result was False 2026-02-27 00:21:58.352681 | 2026-02-27 00:21:58.352753 | TASK [fetch-subunit-output : Remove the temporary file] 2026-02-27 00:21:58.376711 | controller | skipping: Conditional result was False 2026-02-27 00:21:58.383011 | 2026-02-27 00:21:58.383097 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-02-27 00:21:58.407129 | controller | skipping: Conditional result was False 2026-02-27 00:21:58.467883 | 2026-02-27 00:21:58.468000 | PLAY RECAP 2026-02-27 00:21:58.468084 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-27 00:21:58.468111 | 2026-02-27 00:21:58.591826 | POST-RUN END RESULT_UNREACHABLE: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-27 00:21:58.594702 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2026-02-27 00:21:59.225324 | 2026-02-27 00:21:59.225449 | PLAY [all:!appliance*] 2026-02-27 00:21:59.249640 | 2026-02-27 00:21:59.249775 | TASK [unregister the node] 2026-02-27 00:21:59.785731 | controller | skipping: Conditional result was False 2026-02-27 00:21:59.794300 | 2026-02-27 00:21:59.794425 | TASK [include_role : fetch-output] 2026-02-27 00:21:59.857544 | controller | ok 2026-02-27 00:21:59.886746 | 2026-02-27 00:21:59.886873 | TASK [fetch-output : Set log path for multiple nodes] 2026-02-27 00:21:59.952852 | controller | skipping: Conditional result was False 2026-02-27 00:21:59.961176 | 2026-02-27 00:21:59.961266 | TASK [fetch-output : Set log path for single node] 2026-02-27 00:21:59.993198 | controller | ok 2026-02-27 00:22:00.000663 | 2026-02-27 00:22:00.000741 | LOOP [fetch-output : Ensure local output dirs] 2026-02-27 00:22:00.444613 | controller -> localhost | ok: "/var/lib/zuul/builds/65c7f4e6aec44463961c51426bd92407/work/logs" 2026-02-27 00:22:00.710177 | controller -> localhost | changed: "/var/lib/zuul/builds/65c7f4e6aec44463961c51426bd92407/work/artifacts" 2026-02-27 00:22:00.974101 | controller -> localhost | changed: "/var/lib/zuul/builds/65c7f4e6aec44463961c51426bd92407/work/docs" 2026-02-27 00:22:00.983512 | 2026-02-27 00:22:00.983642 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-27 00:22:01.632512 | controller | changed: 2026-02-27 00:22:01.632705 | controller | .d..t...... ./ 2026-02-27 00:22:01.632732 | controller | cd+++++++++ controller/ 2026-02-27 00:22:01.632765 | controller | changed: All items complete 2026-02-27 00:22:01.632784 | 2026-02-27 00:22:02.116452 | controller | changed: .d..t...... ./ 2026-02-27 00:22:02.625040 | controller | changed: .d..t...... ./ 2026-02-27 00:22:02.648455 | 2026-02-27 00:22:02.648612 | TASK [include_role : fetch-output-openshift] 2026-02-27 00:22:02.674308 | controller | skipping: Conditional result was False 2026-02-27 00:22:02.683920 | 2026-02-27 00:22:02.684123 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-02-27 00:22:02.730108 | controller | skipping: Conditional result was False 2026-02-27 00:22:02.740749 | controller | skipping: Conditional result was False 2026-02-27 00:22:02.792990 | 2026-02-27 00:22:02.793145 | PLAY [localhost] 2026-02-27 00:22:02.810964 | 2026-02-27 00:22:02.811192 | TASK [Run Zuul manifest role] 2026-02-27 00:22:02.832944 | localhost | ok 2026-02-27 00:22:02.853419 | 2026-02-27 00:22:02.853578 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-27 00:22:03.284826 | localhost | changed 2026-02-27 00:22:03.291544 | 2026-02-27 00:22:03.291635 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-27 00:22:03.326515 | localhost | ok 2026-02-27 00:22:03.335822 | 2026-02-27 00:22:03.335905 | TASK [Set zuul-log-path fact] 2026-02-27 00:22:03.361943 | localhost | ok 2026-02-27 00:22:03.381671 | 2026-02-27 00:22:03.381788 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-27 00:22:03.433293 | localhost | ok 2026-02-27 00:22:03.441949 | 2026-02-27 00:22:03.442032 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)] 2026-02-27 00:22:03.468761 | localhost | ok: 2026-02-27 00:22:03.469052 | localhost | { 2026-02-27 00:22:03.469092 | localhost | "auth": { 2026-02-27 00:22:03.469121 | localhost | "password": "IonWCwcuOFib&&<}wp^:[2G/", 2026-02-27 00:22:03.469146 | localhost | "username": "9LF91O0RK7JU" 2026-02-27 00:22:03.469169 | localhost | }, 2026-02-27 00:22:03.469192 | localhost | "profile": "rackspace", 2026-02-27 00:22:03.469214 | localhost | "region_name": "IAD" 2026-02-27 00:22:03.469235 | localhost | } 2026-02-27 00:22:03.469270 | 2026-02-27 00:22:03.482107 | 2026-02-27 00:22:03.482216 | TASK [Run upload-logs-failover role (S3 then Swift)] 2026-02-27 00:22:03.501111 | localhost | Output suppressed because no_log was given 2026-02-27 00:22:03.515095 | 2026-02-27 00:22:03.515187 | TASK [upload-logs-failover : Initialize control vars] 2026-02-27 00:22:03.533927 | localhost | ok 2026-02-27 00:22:03.538881 | 2026-02-27 00:22:03.539100 | LOOP [upload-logs-failover : Perform log upload] 2026-02-27 00:22:03.563352 | localhost | Output suppressed because no_log was given 2026-02-27 00:22:03.599912 | localhost | included: /var/lib/zuul/builds/65c7f4e6aec44463961c51426bd92407/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml 2026-02-27 00:22:03.606405 | 2026-02-27 00:22:03.606471 | LOOP [upload-logs-failover : Unpack vars for swift upload] 2026-02-27 00:22:03.706150 | localhost | Output suppressed because no_log was given 2026-02-27 00:22:03.714627 | 2026-02-27 00:22:03.714734 | TASK [Upload logs to swift] 2026-02-27 00:22:03.747234 | localhost | ok 2026-02-27 00:22:03.789529 | 2026-02-27 00:22:03.789647 | TASK [Set zuul-log-path fact] 2026-02-27 00:22:03.826303 | localhost | skipping: Conditional result was False 2026-02-27 00:22:03.832440 | 2026-02-27 00:22:03.832523 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2026-02-27 00:22:04.263953 | localhost -> localhost | ok: Runtime: 0:00:00.008777 2026-02-27 00:22:04.269669 | 2026-02-27 00:22:04.269757 | TASK [upload-logs-swift : Upload logs to swift]