2025-11-28 06:55:44.928893 | Job console starting... 2025-11-28 06:55:44.944482 | Updating repositories 2025-11-28 06:55:44.980503 | Preparing job workspace 2025-11-28 06:55:48.600548 | Running Ansible setup... 2025-11-28 06:55:53.578896 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2025-11-28 06:55:54.257324 | 2025-11-28 06:55:54.257465 | PLAY [localhost] 2025-11-28 06:55:54.265876 | 2025-11-28 06:55:54.265942 | TASK [Gathering Facts] 2025-11-28 06:55:55.229794 | localhost | ok 2025-11-28 06:55:55.260732 | 2025-11-28 06:55:55.260907 | TASK [Setup log path fact] 2025-11-28 06:55:55.288339 | localhost | ok 2025-11-28 06:55:55.314851 | 2025-11-28 06:55:55.315008 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-28 06:55:55.349865 | localhost | ok 2025-11-28 06:55:55.360661 | 2025-11-28 06:55:55.360750 | TASK [emit-job-header : Print job information] 2025-11-28 06:55:55.392615 | # Job Information 2025-11-28 06:55:55.392871 | Ansible Version: 2.15.12 2025-11-28 06:55:55.392941 | Job: ansible-galaxy-importer 2025-11-28 06:55:55.392987 | Pipeline: gate 2025-11-28 06:55:55.393064 | Executor: ze01.softwarefactory-project.io 2025-11-28 06:55:55.393109 | Triggered by: https://github.com/ansible-collections/ansible.posix/pull/677 2025-11-28 06:55:55.393159 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/01c/ansible/01cfa52e075245cabf093ed0e4318ad4/ 2025-11-28 06:55:55.393202 | Event ID: 59479eb8-cc26-11f0-8109-3c88e73a1db8 2025-11-28 06:55:55.401134 | 2025-11-28 06:55:55.401292 | LOOP [emit-job-header : Print node information] 2025-11-28 06:55:55.495122 | localhost | ok: 2025-11-28 06:55:55.495319 | localhost | # Node Information 2025-11-28 06:55:55.495348 | localhost | Inventory Hostname: controller 2025-11-28 06:55:55.495368 | localhost | Hostname: np0005538552 2025-11-28 06:55:55.495388 | localhost | Username: zuul 2025-11-28 06:55:55.495408 | localhost | Distro: Fedora 37 2025-11-28 06:55:55.495426 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2025-11-28 06:55:55.495443 | localhost | Region: ca-ymq-1 2025-11-28 06:55:55.495460 | localhost | Label: ansible-fedora-37-1vcpu 2025-11-28 06:55:55.495477 | localhost | Product Name: OpenStack Nova 2025-11-28 06:55:55.495494 | localhost | Interface IP: 162.253.55.204 2025-11-28 06:55:55.505627 | 2025-11-28 06:55:55.505696 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-28 06:55:55.897927 | localhost -> localhost | changed 2025-11-28 06:55:55.903208 | 2025-11-28 06:55:55.903271 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-28 06:55:56.722378 | localhost -> localhost | changed 2025-11-28 06:55:56.781854 | 2025-11-28 06:55:56.782182 | PLAY [all:!appliance*] 2025-11-28 06:55:56.825177 | 2025-11-28 06:55:56.825279 | TASK [include_role : start-zuul-console] 2025-11-28 06:55:56.847259 | controller | ok 2025-11-28 06:55:56.865056 | 2025-11-28 06:55:56.865121 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-28 06:55:57.236616 | controller | ok 2025-11-28 06:55:57.260450 | 2025-11-28 06:55:57.260620 | TASK [use-our-mirror : Retrieve the IP address] 2025-11-28 06:55:59.010902 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2025-11-28 06:55:59.030985 | 2025-11-28 06:55:59.031171 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2025-11-28 06:55:59.578748 | controller | skipping: Conditional result was False 2025-11-28 06:55:59.592194 | 2025-11-28 06:55:59.592337 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2025-11-28 06:55:59.619978 | controller | skipping: Conditional result was False 2025-11-28 06:55:59.634164 | 2025-11-28 06:55:59.634308 | TASK [use-our-mirror : Create the podman configuration directory] 2025-11-28 06:55:59.662703 | controller | skipping: Conditional result was False 2025-11-28 06:55:59.675464 | 2025-11-28 06:55:59.675624 | TASK [use-our-mirror : Copy the podman configuration] 2025-11-28 06:55:59.701657 | controller | skipping: Conditional result was False 2025-11-28 06:55:59.715868 | 2025-11-28 06:55:59.716065 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2025-11-28 06:55:59.742418 | controller | skipping: Conditional result was False 2025-11-28 06:55:59.755888 | 2025-11-28 06:55:59.756082 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2025-11-28 06:55:59.782359 | controller | skipping: Conditional result was False 2025-11-28 06:55:59.805778 | 2025-11-28 06:55:59.805918 | TASK [Disable Fedora Modular] 2025-11-28 06:56:00.060484 | controller | changed 2025-11-28 06:56:00.066054 | 2025-11-28 06:56:00.066115 | TASK [Enable EPEL] 2025-11-28 06:56:00.089497 | controller | skipping: Conditional result was False 2025-11-28 06:56:00.099758 | 2025-11-28 06:56:00.099858 | TASK [Register the RHEL node] 2025-11-28 06:56:00.650237 | 2025-11-28 06:56:00.650524 | TASK [Show the subscription-manager status] 2025-11-28 06:56:01.231979 | controller | skipping: Conditional result was False 2025-11-28 06:56:01.245164 | 2025-11-28 06:56:01.245303 | TASK [Enable EPEL on RHEL] 2025-11-28 06:56:01.801172 | controller | skipping: Conditional result was False 2025-11-28 06:56:01.815147 | 2025-11-28 06:56:01.815342 | TASK [Install git and tox] 2025-11-28 06:57:23.443496 | controller | changed 2025-11-28 06:57:23.456828 | 2025-11-28 06:57:23.456971 | TASK [include_role : prepare-workspace] 2025-11-28 06:57:23.495661 | controller | ok 2025-11-28 06:57:23.533713 | 2025-11-28 06:57:23.533891 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-11-28 06:57:23.776412 | controller | ok 2025-11-28 06:57:23.790823 | 2025-11-28 06:57:23.790976 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-11-28 06:57:24.929997 | controller | Output suppressed because no_log was given 2025-11-28 06:57:24.951835 | 2025-11-28 06:57:24.951963 | TASK [include_role : prepare-workspace-openshift] 2025-11-28 06:57:24.979125 | controller | skipping: Conditional result was False 2025-11-28 06:57:25.020924 | 2025-11-28 06:57:25.021060 | PLAY [all:!appliance] 2025-11-28 06:57:25.041576 | 2025-11-28 06:57:25.041655 | TASK [Run add-build-sshkey role (RSA)] 2025-11-28 06:57:25.073679 | controller | ok 2025-11-28 06:57:25.093888 | 2025-11-28 06:57:25.093977 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-28 06:57:25.353606 | controller -> localhost | ok 2025-11-28 06:57:25.360100 | 2025-11-28 06:57:25.360167 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-28 06:57:25.390259 | controller | ok 2025-11-28 06:57:25.403587 | controller | included: /var/lib/zuul/builds/01cfa52e075245cabf093ed0e4318ad4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-28 06:57:25.434940 | 2025-11-28 06:57:25.435083 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-28 06:57:26.051272 | controller -> localhost | Generating public/private rsa key pair. 2025-11-28 06:57:26.051704 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/01cfa52e075245cabf093ed0e4318ad4/work/01cfa52e075245cabf093ed0e4318ad4_id_rsa. 2025-11-28 06:57:26.051770 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/01cfa52e075245cabf093ed0e4318ad4/work/01cfa52e075245cabf093ed0e4318ad4_id_rsa.pub. 2025-11-28 06:57:26.051817 | controller -> localhost | The key fingerprint is: 2025-11-28 06:57:26.051861 | controller -> localhost | SHA256:k3MwCADMTOtMzbxiYeMKS3rGaQYSXLbsjWZ60qYOkqw zuul-build-sshkey 2025-11-28 06:57:26.051903 | controller -> localhost | The key's randomart image is: 2025-11-28 06:57:26.051944 | controller -> localhost | +---[RSA 2048]----+ 2025-11-28 06:57:26.051983 | controller -> localhost | |*o.+. | 2025-11-28 06:57:26.052066 | controller -> localhost | |.+O .. . | 2025-11-28 06:57:26.052138 | controller -> localhost | |.B * . o | 2025-11-28 06:57:26.052181 | controller -> localhost | |*.+ + + | 2025-11-28 06:57:26.052219 | controller -> localhost | |+B * . S . | 2025-11-28 06:57:26.052281 | controller -> localhost | |O=*. + | 2025-11-28 06:57:26.052328 | controller -> localhost | |B+B+ | 2025-11-28 06:57:26.052371 | controller -> localhost | |+== | 2025-11-28 06:57:26.052410 | controller -> localhost | |Eo | 2025-11-28 06:57:26.052454 | controller -> localhost | +----[SHA256]-----+ 2025-11-28 06:57:26.052563 | controller -> localhost | ok: Runtime: 0:00:00.178574 2025-11-28 06:57:26.066274 | 2025-11-28 06:57:26.066405 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-28 06:57:26.106980 | controller | ok 2025-11-28 06:57:26.127751 | controller | included: /var/lib/zuul/builds/01cfa52e075245cabf093ed0e4318ad4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-28 06:57:26.140058 | 2025-11-28 06:57:26.140157 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-28 06:57:26.165644 | controller | skipping: Conditional result was False 2025-11-28 06:57:26.180879 | 2025-11-28 06:57:26.181010 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-28 06:57:26.580846 | controller | changed 2025-11-28 06:57:26.586528 | 2025-11-28 06:57:26.586587 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-28 06:57:26.816323 | controller | ok 2025-11-28 06:57:26.828584 | 2025-11-28 06:57:26.828715 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-28 06:57:27.478299 | controller | changed 2025-11-28 06:57:27.490469 | 2025-11-28 06:57:27.490594 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-28 06:57:28.131688 | controller | changed 2025-11-28 06:57:28.144805 | 2025-11-28 06:57:28.144938 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-28 06:57:28.173321 | controller | skipping: Conditional result was False 2025-11-28 06:57:28.189253 | 2025-11-28 06:57:28.189388 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-28 06:57:28.613743 | controller -> localhost | changed 2025-11-28 06:57:28.639179 | 2025-11-28 06:57:28.639361 | TASK [add-build-sshkey : Add back temp key] 2025-11-28 06:57:28.981809 | controller -> localhost | Identity added: /var/lib/zuul/builds/01cfa52e075245cabf093ed0e4318ad4/work/01cfa52e075245cabf093ed0e4318ad4_id_rsa (zuul-build-sshkey) 2025-11-28 06:57:28.982056 | controller -> localhost | ok: Runtime: 0:00:00.013015 2025-11-28 06:57:28.988628 | 2025-11-28 06:57:28.988700 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-28 06:57:29.310001 | controller | ok 2025-11-28 06:57:29.324557 | 2025-11-28 06:57:29.324690 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-28 06:57:29.362158 | controller | skipping: Conditional result was False 2025-11-28 06:57:29.387106 | 2025-11-28 06:57:29.387237 | TASK [Run add-build-sshkey role (ECDSA)] 2025-11-28 06:57:29.425552 | controller | ok 2025-11-28 06:57:29.455731 | 2025-11-28 06:57:29.455815 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-28 06:57:29.725811 | controller -> localhost | ok 2025-11-28 06:57:29.734043 | 2025-11-28 06:57:29.734108 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-28 06:57:29.764453 | controller | ok 2025-11-28 06:57:29.775457 | controller | included: /var/lib/zuul/builds/01cfa52e075245cabf093ed0e4318ad4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-28 06:57:29.781415 | 2025-11-28 06:57:29.781478 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-28 06:57:30.124572 | controller -> localhost | Generating public/private ecdsa key pair. 2025-11-28 06:57:30.124989 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/01cfa52e075245cabf093ed0e4318ad4/work/01cfa52e075245cabf093ed0e4318ad4_id_ecdsa. 2025-11-28 06:57:30.125135 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/01cfa52e075245cabf093ed0e4318ad4/work/01cfa52e075245cabf093ed0e4318ad4_id_ecdsa.pub. 2025-11-28 06:57:30.125199 | controller -> localhost | The key fingerprint is: 2025-11-28 06:57:30.125243 | controller -> localhost | SHA256:72eDsdVbaKibvqcWU3jujBhoP26Sp47jxcBhezOVnpY zuul-build-sshkey 2025-11-28 06:57:30.125284 | controller -> localhost | The key's randomart image is: 2025-11-28 06:57:30.125324 | controller -> localhost | +---[ECDSA 521]---+ 2025-11-28 06:57:30.125362 | controller -> localhost | | | 2025-11-28 06:57:30.125401 | controller -> localhost | | . | 2025-11-28 06:57:30.125438 | controller -> localhost | | o o . | 2025-11-28 06:57:30.125475 | controller -> localhost | | o o o o. o | 2025-11-28 06:57:30.125511 | controller -> localhost | | + +.E + o . | 2025-11-28 06:57:30.125548 | controller -> localhost | | +o+..+ + + .| 2025-11-28 06:57:30.125583 | controller -> localhost | | .oo o.% . o | 2025-11-28 06:57:30.125619 | controller -> localhost | | .oo *.*.B . | 2025-11-28 06:57:30.125654 | controller -> localhost | | .ooo*.+BB . | 2025-11-28 06:57:30.125691 | controller -> localhost | +----[SHA256]-----+ 2025-11-28 06:57:30.125801 | controller -> localhost | ok: Runtime: 0:00:00.015975 2025-11-28 06:57:30.140683 | 2025-11-28 06:57:30.140816 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-28 06:57:30.183191 | controller | ok 2025-11-28 06:57:30.202264 | controller | included: /var/lib/zuul/builds/01cfa52e075245cabf093ed0e4318ad4/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-28 06:57:30.215158 | 2025-11-28 06:57:30.215244 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-28 06:57:30.240991 | controller | skipping: Conditional result was False 2025-11-28 06:57:30.250520 | 2025-11-28 06:57:30.250610 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-28 06:57:30.532443 | controller | changed 2025-11-28 06:57:30.547048 | 2025-11-28 06:57:30.547177 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-28 06:57:30.791089 | controller | ok 2025-11-28 06:57:30.804102 | 2025-11-28 06:57:30.804248 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-28 06:57:31.475226 | controller | changed 2025-11-28 06:57:31.487732 | 2025-11-28 06:57:31.487862 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-28 06:57:32.131229 | controller | changed 2025-11-28 06:57:32.143926 | 2025-11-28 06:57:32.144088 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-28 06:57:32.171499 | controller | skipping: Conditional result was False 2025-11-28 06:57:32.185499 | 2025-11-28 06:57:32.185634 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-28 06:57:32.487277 | controller -> localhost | changed 2025-11-28 06:57:32.498343 | 2025-11-28 06:57:32.498404 | TASK [add-build-sshkey : Add back temp key] 2025-11-28 06:57:32.841938 | controller -> localhost | Identity added: /var/lib/zuul/builds/01cfa52e075245cabf093ed0e4318ad4/work/01cfa52e075245cabf093ed0e4318ad4_id_ecdsa (zuul-build-sshkey) 2025-11-28 06:57:32.842402 | controller -> localhost | ok: Runtime: 0:00:00.014487 2025-11-28 06:57:32.855861 | 2025-11-28 06:57:32.855990 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-28 06:57:33.079001 | controller | ok 2025-11-28 06:57:33.090808 | 2025-11-28 06:57:33.090939 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-28 06:57:33.128340 | controller | skipping: Conditional result was False 2025-11-28 06:57:33.153009 | 2025-11-28 06:57:33.153195 | TASK [include_role : remove-zuul-sshkey] 2025-11-28 06:57:33.179854 | controller | skipping: Conditional result was False 2025-11-28 06:57:33.195114 | 2025-11-28 06:57:33.195245 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2025-11-28 06:57:33.441555 | controller | ok: "logs" 2025-11-28 06:57:33.442115 | controller | ok: All items complete 2025-11-28 06:57:33.442187 | 2025-11-28 06:57:33.634160 | controller | ok: "artifacts" 2025-11-28 06:57:33.825289 | controller | ok: "docs" 2025-11-28 06:57:33.842453 | 2025-11-28 06:57:33.842640 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2025-11-28 06:57:34.093872 | controller | changed: "logs" 2025-11-28 06:57:34.341354 | controller | changed: "artifacts" 2025-11-28 06:57:34.481823 | controller | changed: "docs" 2025-11-28 06:57:34.537275 | 2025-11-28 06:57:34.537415 | PLAY RECAP 2025-11-28 06:57:34.537476 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2025-11-28 06:57:34.537511 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-11-28 06:57:34.537535 | 2025-11-28 06:57:34.647978 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2025-11-28 06:57:34.649533 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master] 2025-11-28 06:57:35.257460 | 2025-11-28 06:57:35.257604 | PLAY [all] 2025-11-28 06:57:35.277319 | 2025-11-28 06:57:35.277389 | TASK [Setup ensure-tox role] 2025-11-28 06:57:35.296566 | controller | ok 2025-11-28 06:57:35.318524 | 2025-11-28 06:57:35.318597 | TASK [Install pip] 2025-11-28 06:57:35.338259 | controller | ok 2025-11-28 06:57:35.358800 | 2025-11-28 06:57:35.358864 | TASK [ensure-pip : Check if pip is installed] 2025-11-28 06:57:35.749818 | controller | /usr/bin/pip3 2025-11-28 06:57:35.764758 | controller | /usr/bin/python3: No module named wheel 2025-11-28 06:57:35.889701 | controller | ok: Runtime: 0:00:00.022562 2025-11-28 06:57:35.901808 | 2025-11-28 06:57:35.901941 | LOOP [ensure-pip : Install pip from packages] 2025-11-28 06:57:35.952141 | controller | ok: "/var/lib/zuul/builds/01cfa52e075245cabf093ed0e4318ad4/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml" 2025-11-28 06:57:35.970905 | controller | included: /var/lib/zuul/builds/01cfa52e075245cabf093ed0e4318ad4/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml 2025-11-28 06:57:35.992132 | 2025-11-28 06:57:35.992258 | TASK [ensure-pip : Install Python 3 pip] 2025-11-28 06:57:41.000443 | controller | changed 2025-11-28 06:57:41.013140 | 2025-11-28 06:57:41.013275 | TASK [ensure-pip : Check for EPEL repository] 2025-11-28 06:57:41.039791 | controller | skipping: Conditional result was False 2025-11-28 06:57:41.053155 | 2025-11-28 06:57:41.053295 | TASK [ensure-pip : Fail with instructions when EPEL is not installed] 2025-11-28 06:57:41.080850 | controller | skipping: Conditional result was False 2025-11-28 06:57:41.094720 | 2025-11-28 06:57:41.094869 | TASK [ensure-pip : Install Python 2 pip] 2025-11-28 06:57:41.121107 | controller | skipping: Conditional result was False 2025-11-28 06:57:41.134226 | 2025-11-28 06:57:41.134371 | TASK [ensure-pip : Ensure setuptools] 2025-11-28 06:57:41.161287 | controller | skipping: Conditional result was False 2025-11-28 06:57:41.177187 | 2025-11-28 06:57:41.177330 | TASK [ensure-pip : Check for ensurepip module] 2025-11-28 06:57:41.724382 | controller | skipping: Conditional result was False 2025-11-28 06:57:41.737838 | 2025-11-28 06:57:41.738001 | TASK [ensure-pip : Ensure python3-venv] 2025-11-28 06:57:41.765144 | controller | skipping: Conditional result was False 2025-11-28 06:57:41.780652 | 2025-11-28 06:57:41.780884 | TASK [ensure-pip : Install pip from source] 2025-11-28 06:57:41.798825 | controller | skipping: Conditional result was False 2025-11-28 06:57:41.813318 | 2025-11-28 06:57:41.813520 | TASK [ensure-pip : Probe for venv python full path] 2025-11-28 06:57:42.107016 | controller | /usr/bin/python3 2025-11-28 06:57:42.363957 | controller | ok: Runtime: 0:00:00.003156 2025-11-28 06:57:42.376601 | 2025-11-28 06:57:42.376723 | TASK [ensure-pip : Set host default] 2025-11-28 06:57:42.455850 | controller | ok 2025-11-28 06:57:42.467656 | 2025-11-28 06:57:42.467802 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2025-11-28 06:57:42.539775 | controller | ok 2025-11-28 06:57:42.563823 | 2025-11-28 06:57:42.564000 | TASK [ensure-tox : Check if tox is installed] 2025-11-28 06:57:42.823452 | controller | /usr/bin/tox 2025-11-28 06:57:43.106489 | controller | ok: Runtime: 0:00:00.003276 2025-11-28 06:57:43.119401 | 2025-11-28 06:57:43.119538 | TASK [ensure-tox : Export preinstalled tox_exectuable] 2025-11-28 06:57:43.169426 | controller | ok 2025-11-28 06:57:43.180922 | 2025-11-28 06:57:43.181088 | TASK [ensure-tox : Create local venv] 2025-11-28 06:57:43.732751 | controller | skipping: Conditional result was False 2025-11-28 06:57:43.743688 | 2025-11-28 06:57:43.743897 | TASK [ensure-tox : Install tox to local venv] 2025-11-28 06:57:44.279011 | controller | skipping: Conditional result was False 2025-11-28 06:57:44.292734 | 2025-11-28 06:57:44.292903 | TASK [ensure-tox : Export installed tox_executable path] 2025-11-28 06:57:44.319613 | controller | skipping: Conditional result was False 2025-11-28 06:57:44.334848 | 2025-11-28 06:57:44.335072 | TASK [ensure-tox : Output tox version] 2025-11-28 06:57:44.721263 | controller | 3.28.0 imported from /usr/lib/python3.11/site-packages/tox/__init__.py 2025-11-28 06:57:44.892390 | controller | ok: Runtime: 0:00:00.142881 2025-11-28 06:57:44.904486 | 2025-11-28 06:57:44.904620 | TASK [ensure-tox : Make global symlink] 2025-11-28 06:57:44.931989 | controller | skipping: Conditional result was False 2025-11-28 06:57:44.955480 | 2025-11-28 06:57:44.955612 | TASK [Setup tox role] 2025-11-28 06:57:44.983994 | controller | ok 2025-11-28 06:57:45.028168 | 2025-11-28 06:57:45.028264 | TASK [tox : Check to see if the constraints file exists] 2025-11-28 06:57:45.052823 | controller | skipping: Conditional result was False 2025-11-28 06:57:45.060705 | 2025-11-28 06:57:45.060792 | TASK [tox : Fail if constraints file is missing] 2025-11-28 06:57:45.095583 | controller | skipping: Conditional result was False 2025-11-28 06:57:45.103608 | 2025-11-28 06:57:45.103697 | TASK [tox : Record file location] 2025-11-28 06:57:45.128213 | controller | skipping: Conditional result was False 2025-11-28 06:57:45.141643 | 2025-11-28 06:57:45.141931 | TASK [tox : Install tox siblings] 2025-11-28 06:57:45.158490 | controller | skipping: Conditional result was False 2025-11-28 06:57:45.173318 | 2025-11-28 06:57:45.173489 | TASK [tox : Emit tox command] 2025-11-28 06:57:45.225352 | /usr/bin/tox -evenv -vv --notest 2025-11-28 06:57:45.236695 | 2025-11-28 06:57:45.236831 | TASK [tox : Run tox] 2025-11-28 06:57:45.616571 | controller | using tox.ini: /home/zuul/src/github.com/ansible-network/releases/tox.ini (pid 2286) 2025-11-28 06:57:45.623639 | controller | using tox-3.28.0 from /usr/lib/python3.11/site-packages/tox/__init__.py (pid 2286) 2025-11-28 06:57:45.644838 | controller | skipping sdist step 2025-11-28 06:57:45.644878 | controller | venv uses /usr/bin/python3 2025-11-28 06:57:45.644895 | controller | venv start: getenv /home/zuul/src/github.com/ansible-network/releases/.tox/venv 2025-11-28 06:57:45.645059 | controller | venv cannot reuse: no previous config /home/zuul/src/github.com/ansible-network/releases/.tox/venv/.tox-config1 2025-11-28 06:57:45.645071 | controller | venv create: /home/zuul/src/github.com/ansible-network/releases/.tox/venv 2025-11-28 06:57:45.645079 | controller | setting PATH=/home/zuul/src/github.com/ansible-network/releases/.tox/venv/bin:/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin 2025-11-28 06:57:45.645088 | controller | [2294] /home/zuul/src/github.com/ansible-network/releases/.tox$ /usr/bin/python3 -m virtualenv --no-download --python /usr/bin/python3 venv 2025-11-28 06:57:46.135901 | controller | created virtual environment CPython3.11.0.final.0-64 in 411ms 2025-11-28 06:57:46.152792 | controller | creator CPython3Posix(dest=/home/zuul/src/github.com/ansible-network/releases/.tox/venv, clear=False, no_vcs_ignore=False, global=False) 2025-11-28 06:57:46.152821 | controller | seeder FromAppData(extra_search_dir=/usr/share/python-wheels,download=False, pip=bundle, setuptools=bundle, wheel=bundle, via=copy, app_data_dir=/home/zuul/.local/share/virtualenv) 2025-11-28 06:57:46.152830 | controller | added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1 2025-11-28 06:57:46.152835 | controller | activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator 2025-11-28 06:57:46.152845 | controller | venv installdeps: -r/home/zuul/src/github.com/ansible-network/releases/requirements.txt, -r/home/zuul/src/github.com/ansible-network/releases/test-requirements.txt 2025-11-28 06:57:46.153152 | controller | setting PATH=/home/zuul/src/github.com/ansible-network/releases/.tox/venv/bin:/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin 2025-11-28 06:57:46.153169 | controller | [2302] /home/zuul/src/github.com/ansible-network/releases$ /home/zuul/src/github.com/ansible-network/releases/.tox/venv/bin/pip install -r/home/zuul/src/github.com/ansible-network/releases/requirements.txt -r/home/zuul/src/github.com/ansible-network/releases/test-requirements.txt 2025-11-28 07:02:24.043868 | [Zuul] Log Stream did not terminate 2025-11-28 07:02:24.044910 | controller | ERROR 2025-11-28 07:02:24.045000 | controller | { 2025-11-28 07:02:24.045055 | controller | "msg": "Data could not be sent to remote host \"162.253.55.204\". Make sure this host can be reached over ssh: ssh: connect to host 162.253.55.204 port 22: No route to host\r\n", 2025-11-28 07:02:24.045076 | controller | "unreachable": true 2025-11-28 07:02:24.045094 | controller | } unreachable 2025-11-28 07:02:24.047331 | 2025-11-28 07:02:24.047379 | PLAY RECAP 2025-11-28 07:02:24.047418 | controller | ok: 10 changed: 5 unreachable: 1 failed: 0 skipped: 15 rescued: 0 ignored: 0 2025-11-28 07:02:24.047438 | 2025-11-28 07:02:24.167591 | PRE-RUN END RESULT_UNREACHABLE: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master] 2025-11-28 07:02:24.169201 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2025-11-28 07:02:24.748398 | 2025-11-28 07:02:24.748526 | PLAY [all:!appliance*] 2025-11-28 07:02:24.774956 | 2025-11-28 07:02:24.775083 | TASK [unregister the node] 2025-11-28 07:02:27.242203 | [controller] Waiting on logger 2025-11-28 07:02:46.691828 | controller | skipping: Conditional result was False 2025-11-28 07:02:46.700548 | 2025-11-28 07:02:46.700669 | TASK [include_role : fetch-output] 2025-11-28 07:02:46.745576 | controller | ok 2025-11-28 07:02:46.778471 | 2025-11-28 07:02:46.778617 | TASK [fetch-output : Set log path for multiple nodes] 2025-11-28 07:02:46.816711 | controller | skipping: Conditional result was False 2025-11-28 07:02:46.823949 | 2025-11-28 07:02:46.824058 | TASK [fetch-output : Set log path for single node] 2025-11-28 07:02:46.853866 | controller | ok 2025-11-28 07:02:46.859528 | 2025-11-28 07:02:46.859602 | LOOP [fetch-output : Ensure local output dirs] 2025-11-28 07:02:47.266519 | controller -> localhost | ok: "/var/lib/zuul/builds/01cfa52e075245cabf093ed0e4318ad4/work/logs" 2025-11-28 07:02:47.476410 | controller -> localhost | changed: "/var/lib/zuul/builds/01cfa52e075245cabf093ed0e4318ad4/work/artifacts" 2025-11-28 07:02:47.745183 | controller -> localhost | changed: "/var/lib/zuul/builds/01cfa52e075245cabf093ed0e4318ad4/work/docs" 2025-11-28 07:02:47.754385 | 2025-11-28 07:02:47.754509 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-11-28 07:02:48.490851 | controller | ok 2025-11-28 07:02:48.491270 | controller | changed: All items complete 2025-11-28 07:02:48.491311 | 2025-11-28 07:02:49.028241 | controller | changed: .d..t...... ./ 2025-11-28 07:02:49.592246 | controller | changed: .d..t...... ./ 2025-11-28 07:02:49.624043 | 2025-11-28 07:02:49.624138 | TASK [include_role : fetch-output-openshift] 2025-11-28 07:02:49.649469 | controller | skipping: Conditional result was False 2025-11-28 07:02:49.659543 | 2025-11-28 07:02:49.659653 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2025-11-28 07:02:50.180125 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.010763 2025-11-28 07:02:50.475180 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.015792 2025-11-28 07:02:50.531899 | 2025-11-28 07:02:50.532116 | PLAY [localhost] 2025-11-28 07:02:50.550010 | 2025-11-28 07:02:50.550127 | TASK [Run Zuul manifest role] 2025-11-28 07:02:50.573280 | localhost | ok 2025-11-28 07:02:50.592328 | 2025-11-28 07:02:50.592424 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-11-28 07:02:51.050911 | localhost | changed 2025-11-28 07:02:51.055627 | 2025-11-28 07:02:51.055689 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-11-28 07:02:51.086722 | localhost | ok 2025-11-28 07:02:51.095353 | 2025-11-28 07:02:51.095412 | TASK [Set zuul-log-path fact] 2025-11-28 07:02:51.113584 | localhost | ok 2025-11-28 07:02:51.131942 | 2025-11-28 07:02:51.132142 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-28 07:02:51.163093 | localhost | ok 2025-11-28 07:02:51.173527 | 2025-11-28 07:02:51.173605 | LOOP [Run upload-logs-swift role] 2025-11-28 07:02:51.209197 | localhost | Output suppressed because no_log was given 2025-11-28 07:02:51.256009 | 2025-11-28 07:02:51.256114 | TASK [Set zuul-log-path fact] 2025-11-28 07:02:51.280955 | localhost | skipping: Conditional result was False 2025-11-28 07:02:51.316530 | 2025-11-28 07:02:51.316703 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2025-11-28 07:02:51.658549 | localhost -> localhost | ok: Runtime: 0:00:00.009692 2025-11-28 07:02:51.665578 | 2025-11-28 07:02:51.665662 | TASK [upload-logs-swift : Upload logs to swift]