2026-02-23 12:20:24.483145 | Job console starting... 2026-02-23 12:20:24.494013 | Updating repositories 2026-02-23 12:20:24.615937 | Preparing job workspace 2026-02-23 12:20:29.529379 | Running Ansible setup... 2026-02-23 12:20:33.969520 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-02-23 12:20:34.537705 | 2026-02-23 12:20:34.537811 | PLAY [localhost] 2026-02-23 12:20:34.546084 | 2026-02-23 12:20:34.546151 | TASK [Gathering Facts] 2026-02-23 12:20:35.558926 | localhost | ok 2026-02-23 12:20:35.580411 | 2026-02-23 12:20:35.580585 | TASK [Setup log path fact] 2026-02-23 12:20:35.602256 | localhost | ok 2026-02-23 12:20:35.620816 | 2026-02-23 12:20:35.620988 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-23 12:20:35.662436 | localhost | ok 2026-02-23 12:20:35.674154 | 2026-02-23 12:20:35.674264 | TASK [emit-job-header : Print job information] 2026-02-23 12:20:35.724843 | # Job Information 2026-02-23 12:20:35.725008 | Ansible Version: 2.15.12 2026-02-23 12:20:35.725054 | Job: ansible-test-sanity-docker-stable-2.16 2026-02-23 12:20:35.725082 | Pipeline: third-party-check 2026-02-23 12:20:35.725108 | Executor: ze04.softwarefactory-project.io 2026-02-23 12:20:35.725133 | Triggered by: https://github.com/openshift/community.okd/pull/271 2026-02-23 12:20:35.725162 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/217/ansible/217e6533829049989b723f725f0b2a7b/ 2026-02-23 12:20:35.725188 | Event ID: fd12d5e0-10ae-11f1-842f-8d4499d7f95d 2026-02-23 12:20:35.730124 | 2026-02-23 12:20:35.730207 | LOOP [emit-job-header : Print node information] 2026-02-23 12:20:35.849045 | localhost | ok: 2026-02-23 12:20:35.849262 | localhost | # Node Information 2026-02-23 12:20:35.849292 | localhost | Inventory Hostname: controller 2026-02-23 12:20:35.849320 | localhost | Hostname: np0005626697 2026-02-23 12:20:35.849351 | localhost | Username: zuul 2026-02-23 12:20:35.849378 | localhost | Distro: Fedora 37 2026-02-23 12:20:35.849397 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2026-02-23 12:20:35.849416 | localhost | Region: ca-ymq-1 2026-02-23 12:20:35.849434 | localhost | Label: ansible-fedora-37-1vcpu 2026-02-23 12:20:35.849451 | localhost | Product Name: OpenStack Nova 2026-02-23 12:20:35.849469 | localhost | Interface IP: 162.253.55.49 2026-02-23 12:20:35.866793 | 2026-02-23 12:20:35.866922 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-23 12:20:36.278890 | localhost -> localhost | changed 2026-02-23 12:20:36.290731 | 2026-02-23 12:20:36.290909 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-23 12:20:37.240359 | localhost -> localhost | changed 2026-02-23 12:20:37.269022 | 2026-02-23 12:20:37.269188 | PLAY [all:!appliance*] 2026-02-23 12:20:37.292370 | 2026-02-23 12:20:37.292460 | TASK [include_role : start-zuul-console] 2026-02-23 12:20:37.317001 | controller | ok 2026-02-23 12:20:37.336193 | 2026-02-23 12:20:37.336283 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-02-23 12:20:37.719922 | controller | ok 2026-02-23 12:20:37.743251 | 2026-02-23 12:20:37.743392 | TASK [use-our-mirror : Retrieve the IP address] 2026-02-23 12:20:39.028102 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2026-02-23 12:20:39.043430 | 2026-02-23 12:20:39.043563 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2026-02-23 12:20:39.595764 | controller | skipping: Conditional result was False 2026-02-23 12:20:39.609416 | 2026-02-23 12:20:39.609569 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2026-02-23 12:20:39.646787 | controller | skipping: Conditional result was False 2026-02-23 12:20:39.660215 | 2026-02-23 12:20:39.660352 | TASK [use-our-mirror : Create the podman configuration directory] 2026-02-23 12:20:39.687241 | controller | skipping: Conditional result was False 2026-02-23 12:20:39.701395 | 2026-02-23 12:20:39.701542 | TASK [use-our-mirror : Copy the podman configuration] 2026-02-23 12:20:39.729193 | controller | skipping: Conditional result was False 2026-02-23 12:20:39.743556 | 2026-02-23 12:20:39.743733 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2026-02-23 12:20:39.771293 | controller | skipping: Conditional result was False 2026-02-23 12:20:39.789337 | 2026-02-23 12:20:39.789520 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2026-02-23 12:20:39.817464 | controller | skipping: Conditional result was False 2026-02-23 12:20:39.851573 | 2026-02-23 12:20:39.851753 | TASK [Disable Fedora Modular] 2026-02-23 12:20:40.130850 | controller | changed 2026-02-23 12:20:40.147570 | 2026-02-23 12:20:40.148460 | TASK [Enable EPEL] 2026-02-23 12:20:40.175523 | controller | skipping: Conditional result was False 2026-02-23 12:20:40.189928 | 2026-02-23 12:20:40.190070 | TASK [Register the RHEL node] 2026-02-23 12:20:40.755307 | 2026-02-23 12:20:40.755604 | TASK [Show the subscription-manager status] 2026-02-23 12:20:41.337917 | controller | skipping: Conditional result was False 2026-02-23 12:20:41.352273 | 2026-02-23 12:20:41.352406 | TASK [Enable EPEL on RHEL] 2026-02-23 12:20:41.905595 | controller | skipping: Conditional result was False 2026-02-23 12:20:41.913966 | 2026-02-23 12:20:41.914051 | TASK [Install git and tox] 2026-02-23 12:22:14.650733 | controller | changed 2026-02-23 12:22:14.664188 | 2026-02-23 12:22:14.664309 | TASK [include_role : prepare-workspace] 2026-02-23 12:22:14.700950 | controller | ok 2026-02-23 12:22:14.737617 | 2026-02-23 12:22:14.737736 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-02-23 12:22:14.996909 | controller | ok 2026-02-23 12:22:15.011135 | 2026-02-23 12:22:15.011273 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-02-23 12:28:02.341151 | controller | Output suppressed because no_log was given 2026-02-23 12:28:02.352092 | 2026-02-23 12:28:02.352182 | TASK [include_role : prepare-workspace-openshift] 2026-02-23 12:28:02.368557 | controller | skipping: Conditional result was False 2026-02-23 12:28:02.396875 | 2026-02-23 12:28:02.396973 | PLAY [all:!appliance] 2026-02-23 12:28:02.413631 | 2026-02-23 12:28:02.413768 | TASK [Run add-build-sshkey role (RSA)] 2026-02-23 12:28:02.432822 | controller | ok 2026-02-23 12:28:02.451510 | 2026-02-23 12:28:02.451621 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-23 12:28:02.679576 | controller -> localhost | ok 2026-02-23 12:28:02.686560 | 2026-02-23 12:28:02.686628 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-23 12:28:02.706628 | controller | ok 2026-02-23 12:28:02.725738 | controller | included: /var/lib/zuul/builds/217e6533829049989b723f725f0b2a7b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-23 12:28:02.731960 | 2026-02-23 12:28:02.732030 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-23 12:28:03.246522 | controller -> localhost | Generating public/private rsa key pair. 2026-02-23 12:28:03.246897 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/217e6533829049989b723f725f0b2a7b/work/217e6533829049989b723f725f0b2a7b_id_rsa. 2026-02-23 12:28:03.246965 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/217e6533829049989b723f725f0b2a7b/work/217e6533829049989b723f725f0b2a7b_id_rsa.pub. 2026-02-23 12:28:03.247013 | controller -> localhost | The key fingerprint is: 2026-02-23 12:28:03.247057 | controller -> localhost | SHA256:KQAdIFUepL294kjzTXi/M4eBSEXMSDN36vWIRI8zcfc zuul-build-sshkey 2026-02-23 12:28:03.247100 | controller -> localhost | The key's randomart image is: 2026-02-23 12:28:03.247141 | controller -> localhost | +---[RSA 2048]----+ 2026-02-23 12:28:03.247182 | controller -> localhost | |..+*O*= o . | 2026-02-23 12:28:03.247223 | controller -> localhost | | . =o*+B . . | 2026-02-23 12:28:03.247264 | controller -> localhost | | . +.* o E | 2026-02-23 12:28:03.247305 | controller -> localhost | | .* = + | 2026-02-23 12:28:03.247345 | controller -> localhost | | ...=.S . | 2026-02-23 12:28:03.247400 | controller -> localhost | | ...o. | 2026-02-23 12:28:03.247453 | controller -> localhost | | o o + o | 2026-02-23 12:28:03.247498 | controller -> localhost | | . = = .+ . | 2026-02-23 12:28:03.247540 | controller -> localhost | | . o . o= | 2026-02-23 12:28:03.247588 | controller -> localhost | +----[SHA256]-----+ 2026-02-23 12:28:03.247716 | controller -> localhost | ok: Runtime: 0:00:00.142432 2026-02-23 12:28:03.264159 | 2026-02-23 12:28:03.264244 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-23 12:28:03.297589 | controller | ok 2026-02-23 12:28:03.311196 | controller | included: /var/lib/zuul/builds/217e6533829049989b723f725f0b2a7b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-23 12:28:03.324196 | 2026-02-23 12:28:03.324286 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-23 12:28:03.349545 | controller | skipping: Conditional result was False 2026-02-23 12:28:03.359035 | 2026-02-23 12:28:03.359147 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-23 12:28:04.047744 | controller | changed 2026-02-23 12:28:04.064178 | 2026-02-23 12:28:04.064326 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-23 12:28:04.309354 | controller | ok 2026-02-23 12:28:04.326401 | 2026-02-23 12:28:04.326547 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-23 12:28:05.041353 | controller | changed 2026-02-23 12:28:05.053547 | 2026-02-23 12:28:05.053703 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-23 12:28:05.715852 | controller | changed 2026-02-23 12:28:05.727796 | 2026-02-23 12:28:05.727923 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-23 12:28:05.755729 | controller | skipping: Conditional result was False 2026-02-23 12:28:05.769893 | 2026-02-23 12:28:05.770036 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-23 12:28:06.220440 | controller -> localhost | changed 2026-02-23 12:28:06.245839 | 2026-02-23 12:28:06.245984 | TASK [add-build-sshkey : Add back temp key] 2026-02-23 12:28:06.584141 | controller -> localhost | Identity added: /var/lib/zuul/builds/217e6533829049989b723f725f0b2a7b/work/217e6533829049989b723f725f0b2a7b_id_rsa (zuul-build-sshkey) 2026-02-23 12:28:06.584652 | controller -> localhost | ok: Runtime: 0:00:00.013041 2026-02-23 12:28:06.599478 | 2026-02-23 12:28:06.599606 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-23 12:28:06.978432 | controller | ok 2026-02-23 12:28:06.984463 | 2026-02-23 12:28:06.984553 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-23 12:28:07.018982 | controller | skipping: Conditional result was False 2026-02-23 12:28:07.030369 | 2026-02-23 12:28:07.030455 | TASK [Run add-build-sshkey role (ECDSA)] 2026-02-23 12:28:07.060582 | controller | ok 2026-02-23 12:28:07.078695 | 2026-02-23 12:28:07.078830 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-23 12:28:07.327992 | controller -> localhost | ok 2026-02-23 12:28:07.337390 | 2026-02-23 12:28:07.337480 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-23 12:28:07.360469 | controller | ok 2026-02-23 12:28:07.377431 | controller | included: /var/lib/zuul/builds/217e6533829049989b723f725f0b2a7b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-23 12:28:07.386487 | 2026-02-23 12:28:07.386579 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-23 12:28:07.657121 | controller -> localhost | Generating public/private ecdsa key pair. 2026-02-23 12:28:07.657410 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/217e6533829049989b723f725f0b2a7b/work/217e6533829049989b723f725f0b2a7b_id_ecdsa. 2026-02-23 12:28:07.657472 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/217e6533829049989b723f725f0b2a7b/work/217e6533829049989b723f725f0b2a7b_id_ecdsa.pub. 2026-02-23 12:28:07.657535 | controller -> localhost | The key fingerprint is: 2026-02-23 12:28:07.657581 | controller -> localhost | SHA256:HNOSpCeytA2jlZZyfDYIefnr95Hq+h1FNQfe0jur3Sw zuul-build-sshkey 2026-02-23 12:28:07.657638 | controller -> localhost | The key's randomart image is: 2026-02-23 12:28:07.657731 | controller -> localhost | +---[ECDSA 521]---+ 2026-02-23 12:28:07.657778 | controller -> localhost | | .. . . +..| 2026-02-23 12:28:07.657820 | controller -> localhost | | .oo+ o o o = | 2026-02-23 12:28:07.657860 | controller -> localhost | | ..&.* * . . o o| 2026-02-23 12:28:07.657900 | controller -> localhost | | B X.= + . ..| 2026-02-23 12:28:07.657943 | controller -> localhost | | . o ..S . o | 2026-02-23 12:28:07.657989 | controller -> localhost | | . o o| 2026-02-23 12:28:07.658043 | controller -> localhost | | . + . | 2026-02-23 12:28:07.658087 | controller -> localhost | | . .o o E..| 2026-02-23 12:28:07.658132 | controller -> localhost | | .=+.o . oo| 2026-02-23 12:28:07.658174 | controller -> localhost | +----[SHA256]-----+ 2026-02-23 12:28:07.658272 | controller -> localhost | ok: Runtime: 0:00:00.014729 2026-02-23 12:28:07.673240 | 2026-02-23 12:28:07.673373 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-23 12:28:07.702211 | controller | ok 2026-02-23 12:28:07.717861 | controller | included: /var/lib/zuul/builds/217e6533829049989b723f725f0b2a7b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-23 12:28:07.730818 | 2026-02-23 12:28:07.730902 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-23 12:28:07.745561 | controller | skipping: Conditional result was False 2026-02-23 12:28:07.756303 | 2026-02-23 12:28:07.756429 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-23 12:28:08.032558 | controller | changed 2026-02-23 12:28:08.040904 | 2026-02-23 12:28:08.041023 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-23 12:28:08.266244 | controller | ok 2026-02-23 12:28:08.274145 | 2026-02-23 12:28:08.274225 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-23 12:28:08.974292 | controller | changed 2026-02-23 12:28:08.982347 | 2026-02-23 12:28:08.982429 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-23 12:28:09.610871 | controller | changed 2026-02-23 12:28:09.616805 | 2026-02-23 12:28:09.616867 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-23 12:28:09.641546 | controller | skipping: Conditional result was False 2026-02-23 12:28:09.648675 | 2026-02-23 12:28:09.648773 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-23 12:28:09.920575 | controller -> localhost | changed 2026-02-23 12:28:09.944886 | 2026-02-23 12:28:09.945277 | TASK [add-build-sshkey : Add back temp key] 2026-02-23 12:28:10.227475 | controller -> localhost | Identity added: /var/lib/zuul/builds/217e6533829049989b723f725f0b2a7b/work/217e6533829049989b723f725f0b2a7b_id_ecdsa (zuul-build-sshkey) 2026-02-23 12:28:10.227844 | controller -> localhost | ok: Runtime: 0:00:00.015313 2026-02-23 12:28:10.242527 | 2026-02-23 12:28:10.242667 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-23 12:28:10.477524 | controller | ok 2026-02-23 12:28:10.492322 | 2026-02-23 12:28:10.492473 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-23 12:28:10.531504 | controller | skipping: Conditional result was False 2026-02-23 12:28:10.563583 | 2026-02-23 12:28:10.563781 | TASK [include_role : remove-zuul-sshkey] 2026-02-23 12:28:10.580734 | controller | skipping: Conditional result was False 2026-02-23 12:28:10.591481 | 2026-02-23 12:28:10.591586 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-02-23 12:28:10.817742 | controller | ok: "logs" 2026-02-23 12:28:10.817996 | controller | ok: All items complete 2026-02-23 12:28:10.818025 | 2026-02-23 12:28:11.023609 | controller | ok: "artifacts" 2026-02-23 12:28:11.218698 | controller | ok: "docs" 2026-02-23 12:28:11.235747 | 2026-02-23 12:28:11.235864 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-02-23 12:28:11.466853 | controller | changed: "logs" 2026-02-23 12:28:11.701452 | controller | changed: "artifacts" 2026-02-23 12:28:11.919265 | controller | changed: "docs" 2026-02-23 12:28:11.985135 | 2026-02-23 12:28:11.985267 | PLAY RECAP 2026-02-23 12:28:11.985327 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2026-02-23 12:28:11.985366 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-23 12:28:11.985392 | 2026-02-23 12:28:12.117389 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-02-23 12:28:12.118320 | PRE-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-23 12:28:12.692769 | 2026-02-23 12:28:12.692887 | PLAY [all] 2026-02-23 12:28:12.716620 | 2026-02-23 12:28:12.716756 | TASK [Install binary dependencies] 2026-02-23 12:28:12.766757 | controller | ok 2026-02-23 12:28:12.788503 | 2026-02-23 12:28:12.788634 | TASK [bindep : Include find tasks] 2026-02-23 12:28:12.818558 | controller | ok 2026-02-23 12:28:12.827701 | controller | included: /var/lib/zuul/builds/217e6533829049989b723f725f0b2a7b/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-02-23 12:28:12.834734 | 2026-02-23 12:28:12.834809 | TASK [bindep : Look for bindep.txt] 2026-02-23 12:28:13.443563 | controller | ok 2026-02-23 12:28:13.450043 | 2026-02-23 12:28:13.450151 | TASK [bindep : Define bindep_file fact] 2026-02-23 12:28:13.474034 | controller | skipping: Conditional result was False 2026-02-23 12:28:13.480378 | 2026-02-23 12:28:13.480487 | TASK [bindep : Look for other-requirements.txt] 2026-02-23 12:28:13.741726 | controller | ok 2026-02-23 12:28:13.755896 | 2026-02-23 12:28:13.756093 | TASK [bindep : Define bindep_file fact] 2026-02-23 12:28:13.795376 | controller | skipping: Conditional result was False 2026-02-23 12:28:13.804603 | 2026-02-23 12:28:13.804751 | TASK [bindep : Look for bindep fallback file] 2026-02-23 12:28:13.850177 | controller | skipping: Conditional result was False 2026-02-23 12:28:13.857858 | 2026-02-23 12:28:13.857957 | TASK [bindep : Define bindep_file fact] 2026-02-23 12:28:13.883038 | controller | skipping: Conditional result was False 2026-02-23 12:28:13.888895 | 2026-02-23 12:28:13.888957 | TASK [bindep : Include bindep tasks] 2026-02-23 12:28:13.912670 | controller | skipping: Conditional result was False 2026-02-23 12:28:13.919389 | 2026-02-23 12:28:13.919474 | TASK [bindep : Include install tasks] 2026-02-23 12:28:13.943280 | controller | skipping: Conditional result was False 2026-02-23 12:28:13.949281 | 2026-02-23 12:28:13.949345 | LOOP [bindep : Include package tasks] 2026-02-23 12:28:14.004891 | 2026-02-23 12:28:14.005012 | TASK [Run test-setup role] 2026-02-23 12:28:14.024391 | controller | ok 2026-02-23 12:28:14.042321 | 2026-02-23 12:28:14.042396 | TASK [test-setup : Check if project's tools/test-setup.sh exists] 2026-02-23 12:28:14.262061 | controller | ok 2026-02-23 12:28:14.275996 | 2026-02-23 12:28:14.276133 | TASK [test-setup : Run tools/test-setup.sh] 2026-02-23 12:28:14.824056 | controller | skipping: Conditional result was False 2026-02-23 12:28:14.879190 | 2026-02-23 12:28:14.879364 | PLAY RECAP 2026-02-23 12:28:14.879423 | controller | ok: 4 changed: 0 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-23 12:28:14.879452 | 2026-02-23 12:28:14.978894 | PRE-RUN END RESULT_NORMAL: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/pre.yaml@master] 2026-02-23 12:28:14.980705 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-02-23 12:28:16.257540 | 2026-02-23 12:28:16.257664 | PLAY [controller] 2026-02-23 12:28:16.278386 | 2026-02-23 12:28:16.278502 | TASK [Create the /root directory] 2026-02-23 12:28:16.825725 | controller | ok 2026-02-23 12:28:16.831584 | 2026-02-23 12:28:16.831656 | TASK [Install glibc-langpack-en] 2026-02-23 12:28:20.762192 | controller | ok: Nothing to do 2026-02-23 12:28:20.767694 | 2026-02-23 12:28:20.767758 | TASK [Ensure controller directory exists] 2026-02-23 12:28:20.999598 | controller | changed 2026-02-23 12:28:21.005158 | 2026-02-23 12:28:21.005219 | TASK [Install container runtime] 2026-02-23 12:28:21.075119 | controller | ok 2026-02-23 12:28:21.109168 | 2026-02-23 12:28:21.109255 | LOOP [ensure-podman : Find distribution installation] 2026-02-23 12:28:21.138358 | controller | ok: "/var/lib/zuul/builds/217e6533829049989b723f725f0b2a7b/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml" 2026-02-23 12:28:21.150418 | controller | included: /var/lib/zuul/builds/217e6533829049989b723f725f0b2a7b/untrusted/project_0/opendev.org/zuul/zuul-jobs/roles/ensure-podman/tasks/RedHat.yaml 2026-02-23 12:28:21.156662 | 2026-02-23 12:28:21.156738 | TASK [ensure-podman : Install podman (RedHat)] 2026-02-23 12:29:26.917671 | controller | changed 2026-02-23 12:29:26.932582 | 2026-02-23 12:29:26.932758 | TASK [ensure-podman : Fetch podman version] 2026-02-23 12:29:27.495654 | controller | Client: Podman Engine 2026-02-23 12:29:27.517068 | controller | Version: 4.6.2 2026-02-23 12:29:27.517091 | controller | API Version: 4.6.2 2026-02-23 12:29:27.517099 | controller | Go Version: go1.19.12 2026-02-23 12:29:27.517117 | controller | Built: Mon Aug 28 19:38:31 2023 2026-02-23 12:29:27.517125 | controller | OS/Arch: linux/amd64 2026-02-23 12:29:27.986192 | controller | ok: Runtime: 0:00:00.201876 2026-02-23 12:29:28.008157 | 2026-02-23 12:29:28.008513 | TASK [ensure-podman : Print podman version installed] 2026-02-23 12:29:28.054884 | Podman version: Client: Podman Engine 2026-02-23 12:29:28.055234 | Version: 4.6.2 2026-02-23 12:29:28.055296 | API Version: 4.6.2 2026-02-23 12:29:28.055340 | Go Version: go1.19.12 2026-02-23 12:29:28.055379 | Built: Mon Aug 28 19:38:31 2023 2026-02-23 12:29:28.055423 | OS/Arch: linux/amd64 2026-02-23 12:29:28.067551 | 2026-02-23 12:29:28.067770 | TASK [ensure-podman : Validate podman engine] 2026-02-23 12:29:28.618575 | controller | skipping: Conditional result was False 2026-02-23 12:29:28.638107 | 2026-02-23 12:29:28.638453 | TASK [ensure-podman : Set up docker compatability socket] 2026-02-23 12:29:28.667736 | controller | skipping: Conditional result was False 2026-02-23 12:29:28.695290 | 2026-02-23 12:29:28.695537 | TASK [Ensure python3.8 is present] 2026-02-23 12:29:28.723770 | controller | skipping: Conditional result was False 2026-02-23 12:29:28.734879 | 2026-02-23 12:29:28.734998 | TASK [Run our-ensure-python role (Fedora only for now)] 2026-02-23 12:29:28.761748 | controller | ok 2026-02-23 12:29:28.791711 | 2026-02-23 12:29:28.791919 | TASK [our-ensure-python : Install the right Python version (rpm)] 2026-02-23 12:29:30.344239 | controller | ok: Nothing to do 2026-02-23 12:29:30.357080 | 2026-02-23 12:29:30.357214 | TASK [our-ensure-python : Also install python3-devel] 2026-02-23 12:34:02.599427 | controller | ERROR 2026-02-23 12:34:02.599872 | controller | { 2026-02-23 12:34:02.599956 | controller | "msg": "Data could not be sent to remote host \"162.253.55.49\". Make sure this host can be reached over ssh: ssh: connect to host 162.253.55.49 port 22: No route to host\r\n", 2026-02-23 12:34:02.600016 | controller | "unreachable": true 2026-02-23 12:34:02.600101 | controller | } unreachable 2026-02-23 12:34:02.602645 | 2026-02-23 12:34:02.602785 | PLAY RECAP 2026-02-23 12:34:02.602888 | controller | ok: 8 changed: 3 unreachable: 1 failed: 0 skipped: 3 rescued: 0 ignored: 0 2026-02-23 12:34:02.602952 | 2026-02-23 12:34:02.729670 | PRE-RUN END RESULT_UNREACHABLE: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-test-base/pre.yaml@master] 2026-02-23 12:34:02.730878 | POST-RUN START: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-23 12:34:03.318953 | 2026-02-23 12:34:03.319081 | PLAY [all] 2026-02-23 12:34:03.342389 | 2026-02-23 12:34:03.342520 | TASK [fetch-subunit-output : Find stestr or testr executable] 2026-02-23 12:34:33.651094 | controller | changed: non-zero return code 2026-02-23 12:34:33.657129 | 2026-02-23 12:34:33.657208 | TASK [fetch-subunit-output : Get the list of directories with subunit files] 2026-02-23 12:34:33.681777 | controller | skipping: Conditional result was False 2026-02-23 12:34:33.690793 | 2026-02-23 12:34:33.690917 | LOOP [fetch-subunit-output : Find any inflight partial subunit files] 2026-02-23 12:34:33.725648 | 2026-02-23 12:34:33.725857 | LOOP [fetch-subunit-output : Copy any inflight subunit files] 2026-02-23 12:34:33.760657 | 2026-02-23 12:34:33.760880 | TASK [fetch-subunit-output : Create a temporary file to store the subunit stream] 2026-02-23 12:34:33.787035 | controller | skipping: Conditional result was False 2026-02-23 12:34:33.796039 | 2026-02-23 12:34:33.796145 | LOOP [fetch-subunit-output : Generate subunit file] 2026-02-23 12:34:33.831430 | 2026-02-23 12:34:33.831648 | TASK [fetch-subunit-output : Copy the combined subunit file to the zuul work directory] 2026-02-23 12:34:33.847371 | controller | skipping: Conditional result was False 2026-02-23 12:34:33.856625 | 2026-02-23 12:34:33.856756 | TASK [fetch-subunit-output : Remove the temporary file] 2026-02-23 12:34:33.871822 | controller | skipping: Conditional result was False 2026-02-23 12:34:33.881261 | 2026-02-23 12:34:33.881368 | TASK [fetch-subunit-output : Process and fetch subunit results] 2026-02-23 12:34:33.896622 | controller | skipping: Conditional result was False 2026-02-23 12:34:33.934976 | 2026-02-23 12:34:33.935090 | PLAY RECAP 2026-02-23 12:34:33.935129 | controller | ok: 1 changed: 1 unreachable: 0 failed: 0 skipped: 8 rescued: 0 ignored: 0 2026-02-23 12:34:33.935150 | 2026-02-23 12:34:34.025339 | POST-RUN END RESULT_UNREACHABLE: [untrusted : opendev.org/zuul/zuul-jobs/playbooks/unittests/post.yaml@master] 2026-02-23 12:34:34.026774 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2026-02-23 12:34:34.634735 | 2026-02-23 12:34:34.634849 | PLAY [all:!appliance*] 2026-02-23 12:34:34.656604 | 2026-02-23 12:34:34.656710 | TASK [unregister the node] 2026-02-23 12:34:35.190646 | controller | skipping: Conditional result was False 2026-02-23 12:34:35.204591 | 2026-02-23 12:34:35.204855 | TASK [include_role : fetch-output] 2026-02-23 12:34:35.265359 | controller | ok 2026-02-23 12:34:35.311113 | 2026-02-23 12:34:35.311259 | TASK [fetch-output : Set log path for multiple nodes] 2026-02-23 12:34:35.387829 | controller | skipping: Conditional result was False 2026-02-23 12:34:35.402715 | 2026-02-23 12:34:35.402878 | TASK [fetch-output : Set log path for single node] 2026-02-23 12:34:35.453573 | controller | ok 2026-02-23 12:34:35.465556 | 2026-02-23 12:34:35.465731 | LOOP [fetch-output : Ensure local output dirs] 2026-02-23 12:34:35.896107 | controller -> localhost | ok: "/var/lib/zuul/builds/217e6533829049989b723f725f0b2a7b/work/logs" 2026-02-23 12:34:36.162244 | controller -> localhost | changed: "/var/lib/zuul/builds/217e6533829049989b723f725f0b2a7b/work/artifacts" 2026-02-23 12:34:36.434583 | controller -> localhost | changed: "/var/lib/zuul/builds/217e6533829049989b723f725f0b2a7b/work/docs" 2026-02-23 12:34:36.451106 | 2026-02-23 12:34:36.451233 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-23 12:34:37.131746 | controller | changed: 2026-02-23 12:34:37.133731 | controller | .d..t...... ./ 2026-02-23 12:34:37.133789 | controller | cd+++++++++ controller/ 2026-02-23 12:34:37.133837 | controller | changed: All items complete 2026-02-23 12:34:37.133867 | 2026-02-23 12:34:37.632717 | controller | changed: .d..t...... ./ 2026-02-23 12:34:38.149542 | controller | changed: .d..t...... ./ 2026-02-23 12:34:38.186939 | 2026-02-23 12:34:38.187138 | TASK [include_role : fetch-output-openshift] 2026-02-23 12:34:38.215535 | controller | skipping: Conditional result was False 2026-02-23 12:34:38.230332 | 2026-02-23 12:34:38.230509 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-02-23 12:34:38.721639 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.013939 2026-02-23 12:34:39.008762 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.011827 2026-02-23 12:34:39.039106 | 2026-02-23 12:34:39.039299 | PLAY [localhost] 2026-02-23 12:34:39.052218 | 2026-02-23 12:34:39.052280 | TASK [Run Zuul manifest role] 2026-02-23 12:34:39.072176 | localhost | ok 2026-02-23 12:34:39.086394 | 2026-02-23 12:34:39.086474 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-23 12:34:39.487636 | localhost | changed 2026-02-23 12:34:39.498486 | 2026-02-23 12:34:39.498629 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-23 12:34:39.546249 | localhost | ok 2026-02-23 12:34:39.570439 | 2026-02-23 12:34:39.570620 | TASK [Set zuul-log-path fact] 2026-02-23 12:34:39.593739 | localhost | ok 2026-02-23 12:34:39.612859 | 2026-02-23 12:34:39.612993 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-23 12:34:39.654607 | localhost | ok 2026-02-23 12:34:39.669119 | 2026-02-23 12:34:39.669274 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)] 2026-02-23 12:34:39.716936 | localhost | ok: 2026-02-23 12:34:39.717211 | localhost | { 2026-02-23 12:34:39.717267 | localhost | "auth": { 2026-02-23 12:34:39.717311 | localhost | "password": "IonWCwcuOFib&&<}wp^:[2G/", 2026-02-23 12:34:39.717349 | localhost | "username": "9LF91O0RK7JU" 2026-02-23 12:34:39.717385 | localhost | }, 2026-02-23 12:34:39.717421 | localhost | "profile": "rackspace", 2026-02-23 12:34:39.717456 | localhost | "region_name": "IAD" 2026-02-23 12:34:39.717491 | localhost | } 2026-02-23 12:34:39.717548 | localhost | changed: All items complete 2026-02-23 12:34:39.717590 | 2026-02-23 12:34:39.726173 | 2026-02-23 12:34:39.726320 | TASK [Run upload-logs-failover role (S3 then Swift)] 2026-02-23 12:34:39.748827 | localhost | Output suppressed because no_log was given 2026-02-23 12:34:39.768964 | 2026-02-23 12:34:39.769088 | TASK [upload-logs-failover : Initialize control vars] 2026-02-23 12:34:39.842805 | localhost | ok 2026-02-23 12:34:39.848842 | 2026-02-23 12:34:39.848927 | LOOP [upload-logs-failover : Perform log upload] 2026-02-23 12:34:39.886372 | localhost | Output suppressed because no_log was given 2026-02-23 12:34:39.896333 | localhost | included: /var/lib/zuul/builds/217e6533829049989b723f725f0b2a7b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml 2026-02-23 12:34:39.905934 | 2026-02-23 12:34:39.906029 | LOOP [upload-logs-failover : Unpack vars for swift upload] 2026-02-23 12:34:39.983091 | localhost | Output suppressed because no_log was given 2026-02-23 12:34:39.994895 | 2026-02-23 12:34:39.995040 | TASK [Upload logs to swift] 2026-02-23 12:34:40.024201 | localhost | ok 2026-02-23 12:34:40.069803 | 2026-02-23 12:34:40.069948 | TASK [Set zuul-log-path fact] 2026-02-23 12:34:40.105991 | localhost | skipping: Conditional result was False 2026-02-23 12:34:40.113441 | 2026-02-23 12:34:40.113534 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2026-02-23 12:34:40.434109 | localhost -> localhost | ok: Runtime: 0:00:00.005388 2026-02-23 12:34:40.439559 | 2026-02-23 12:34:40.439623 | TASK [upload-logs-swift : Upload logs to swift]