2025-12-11 17:04:31.160276 | Job console starting... 2025-12-11 17:04:31.175074 | Updating repositories 2025-12-11 17:04:31.214664 | Preparing job workspace 2025-12-11 17:04:34.884121 | Running Ansible setup... 2025-12-11 17:04:39.781700 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2025-12-11 17:04:40.377491 | 2025-12-11 17:04:40.377612 | PLAY [localhost] 2025-12-11 17:04:40.385705 | 2025-12-11 17:04:40.385772 | TASK [Gathering Facts] 2025-12-11 17:04:41.382402 | localhost | ok 2025-12-11 17:04:41.413238 | 2025-12-11 17:04:41.413407 | TASK [Setup log path fact] 2025-12-11 17:04:41.438708 | localhost | ok 2025-12-11 17:04:41.465621 | 2025-12-11 17:04:41.465722 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-11 17:04:41.486193 | localhost | ok 2025-12-11 17:04:41.497660 | 2025-12-11 17:04:41.497758 | TASK [emit-job-header : Print job information] 2025-12-11 17:04:41.548034 | # Job Information 2025-12-11 17:04:41.548198 | Ansible Version: 2.15.12 2025-12-11 17:04:41.548244 | Job: ansible-galaxy-importer 2025-12-11 17:04:41.548274 | Pipeline: gate 2025-12-11 17:04:41.548300 | Executor: ze01.softwarefactory-project.io 2025-12-11 17:04:41.548326 | Triggered by: https://github.com/ansible-collections/ansible.mcp/pull/29 2025-12-11 17:04:41.548379 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/cfe/ansible/cfef7a84736546f58131a1269bf5bb9d/ 2025-12-11 17:04:41.548409 | Event ID: d323f570-d6b1-11f0-9221-d35b1c758c8e 2025-12-11 17:04:41.553868 | 2025-12-11 17:04:41.553963 | LOOP [emit-job-header : Print node information] 2025-12-11 17:04:41.644818 | localhost | ok: 2025-12-11 17:04:41.645053 | localhost | # Node Information 2025-12-11 17:04:41.645085 | localhost | Inventory Hostname: controller 2025-12-11 17:04:41.645106 | localhost | Hostname: np0005555824 2025-12-11 17:04:41.645125 | localhost | Username: zuul 2025-12-11 17:04:41.645145 | localhost | Distro: Fedora 37 2025-12-11 17:04:41.645163 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2025-12-11 17:04:41.645180 | localhost | Region: ca-ymq-1 2025-12-11 17:04:41.645197 | localhost | Label: ansible-fedora-37-1vcpu 2025-12-11 17:04:41.645213 | localhost | Product Name: OpenStack Nova 2025-12-11 17:04:41.645229 | localhost | Interface IP: 162.253.55.206 2025-12-11 17:04:41.660813 | 2025-12-11 17:04:41.660909 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-12-11 17:04:42.103558 | localhost -> localhost | changed 2025-12-11 17:04:42.115579 | 2025-12-11 17:04:42.115722 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-12-11 17:04:43.071457 | localhost -> localhost | changed 2025-12-11 17:04:43.090864 | 2025-12-11 17:04:43.090926 | PLAY [all:!appliance*] 2025-12-11 17:04:43.107333 | 2025-12-11 17:04:43.107400 | TASK [include_role : start-zuul-console] 2025-12-11 17:04:43.130737 | controller | ok 2025-12-11 17:04:43.149279 | 2025-12-11 17:04:43.149391 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-12-11 17:04:43.552822 | controller | ok 2025-12-11 17:04:43.576758 | 2025-12-11 17:04:43.576896 | TASK [use-our-mirror : Retrieve the IP address] 2025-12-11 17:04:44.658522 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2025-12-11 17:04:44.673127 | 2025-12-11 17:04:44.673266 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2025-12-11 17:04:45.228796 | controller | skipping: Conditional result was False 2025-12-11 17:04:45.241976 | 2025-12-11 17:04:45.242147 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2025-12-11 17:04:45.258931 | controller | skipping: Conditional result was False 2025-12-11 17:04:45.272319 | 2025-12-11 17:04:45.272480 | TASK [use-our-mirror : Create the podman configuration directory] 2025-12-11 17:04:45.289106 | controller | skipping: Conditional result was False 2025-12-11 17:04:45.301802 | 2025-12-11 17:04:45.301936 | TASK [use-our-mirror : Copy the podman configuration] 2025-12-11 17:04:45.318253 | controller | skipping: Conditional result was False 2025-12-11 17:04:45.325790 | 2025-12-11 17:04:45.325923 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2025-12-11 17:04:45.350462 | controller | skipping: Conditional result was False 2025-12-11 17:04:45.356292 | 2025-12-11 17:04:45.356355 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2025-12-11 17:04:45.379764 | controller | skipping: Conditional result was False 2025-12-11 17:04:45.407099 | 2025-12-11 17:04:45.407236 | TASK [Disable Fedora Modular] 2025-12-11 17:04:45.647676 | controller | changed 2025-12-11 17:04:45.660544 | 2025-12-11 17:04:45.660679 | TASK [Enable EPEL] 2025-12-11 17:04:45.687056 | controller | skipping: Conditional result was False 2025-12-11 17:04:45.700344 | 2025-12-11 17:04:45.700478 | TASK [Register the RHEL node] 2025-12-11 17:04:46.262876 | 2025-12-11 17:04:46.263190 | TASK [Show the subscription-manager status] 2025-12-11 17:04:46.851405 | controller | skipping: Conditional result was False 2025-12-11 17:04:46.870881 | 2025-12-11 17:04:46.871139 | TASK [Enable EPEL on RHEL] 2025-12-11 17:04:47.437797 | controller | skipping: Conditional result was False 2025-12-11 17:04:47.450877 | 2025-12-11 17:04:47.451041 | TASK [Install git and tox] 2025-12-11 17:06:05.057407 | controller | changed 2025-12-11 17:06:05.071407 | 2025-12-11 17:06:05.071544 | TASK [include_role : prepare-workspace] 2025-12-11 17:06:05.114082 | controller | ok 2025-12-11 17:06:05.151096 | 2025-12-11 17:06:05.151190 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-12-11 17:06:05.405591 | controller | ok 2025-12-11 17:06:05.419323 | 2025-12-11 17:06:05.419458 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-12-11 17:06:06.387326 | controller | Output suppressed because no_log was given 2025-12-11 17:06:06.408719 | 2025-12-11 17:06:06.408847 | TASK [include_role : prepare-workspace-openshift] 2025-12-11 17:06:06.427535 | controller | skipping: Conditional result was False 2025-12-11 17:06:06.470303 | 2025-12-11 17:06:06.470443 | PLAY [all:!appliance] 2025-12-11 17:06:06.492128 | 2025-12-11 17:06:06.492234 | TASK [Run add-build-sshkey role (RSA)] 2025-12-11 17:06:06.524776 | controller | ok 2025-12-11 17:06:06.545337 | 2025-12-11 17:06:06.545431 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-11 17:06:06.806077 | controller -> localhost | ok 2025-12-11 17:06:06.820201 | 2025-12-11 17:06:06.820347 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-11 17:06:06.860460 | controller | ok 2025-12-11 17:06:06.889151 | controller | included: /var/lib/zuul/builds/cfef7a84736546f58131a1269bf5bb9d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-11 17:06:06.898432 | 2025-12-11 17:06:06.898537 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-11 17:06:07.370858 | controller -> localhost | Generating public/private rsa key pair. 2025-12-11 17:06:07.371121 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/cfef7a84736546f58131a1269bf5bb9d/work/cfef7a84736546f58131a1269bf5bb9d_id_rsa. 2025-12-11 17:06:07.371162 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/cfef7a84736546f58131a1269bf5bb9d/work/cfef7a84736546f58131a1269bf5bb9d_id_rsa.pub. 2025-12-11 17:06:07.371194 | controller -> localhost | The key fingerprint is: 2025-12-11 17:06:07.371223 | controller -> localhost | SHA256:1NXW9hrlAt85KxKGC7jPf7/JMFs3O3ceQ7ehVvO+MdM zuul-build-sshkey 2025-12-11 17:06:07.371254 | controller -> localhost | The key's randomart image is: 2025-12-11 17:06:07.371280 | controller -> localhost | +---[RSA 2048]----+ 2025-12-11 17:06:07.371305 | controller -> localhost | | .. . | 2025-12-11 17:06:07.371332 | controller -> localhost | | . .. o +| 2025-12-11 17:06:07.371360 | controller -> localhost | | . . o + =o| 2025-12-11 17:06:07.371387 | controller -> localhost | | . o . o +o+| 2025-12-11 17:06:07.371414 | controller -> localhost | | . S o . O+| 2025-12-11 17:06:07.371451 | controller -> localhost | | . . . .=.B| 2025-12-11 17:06:07.371477 | controller -> localhost | | o o.+.XE| 2025-12-11 17:06:07.371500 | controller -> localhost | | o .B oo@| 2025-12-11 17:06:07.371518 | controller -> localhost | | .....=.+B| 2025-12-11 17:06:07.371539 | controller -> localhost | +----[SHA256]-----+ 2025-12-11 17:06:07.371589 | controller -> localhost | ok: Runtime: 0:00:00.068065 2025-12-11 17:06:07.387639 | 2025-12-11 17:06:07.387719 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-11 17:06:07.408593 | controller | ok 2025-12-11 17:06:07.418597 | controller | included: /var/lib/zuul/builds/cfef7a84736546f58131a1269bf5bb9d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-11 17:06:07.456791 | 2025-12-11 17:06:07.456915 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-11 17:06:07.480910 | controller | skipping: Conditional result was False 2025-12-11 17:06:07.488712 | 2025-12-11 17:06:07.488779 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-11 17:06:07.875272 | controller | changed 2025-12-11 17:06:07.881194 | 2025-12-11 17:06:07.881275 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-11 17:06:08.084804 | controller | ok 2025-12-11 17:06:08.091201 | 2025-12-11 17:06:08.091266 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-11 17:06:08.685641 | controller | changed 2025-12-11 17:06:08.693610 | 2025-12-11 17:06:08.693700 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-11 17:06:09.304519 | controller | changed 2025-12-11 17:06:09.315889 | 2025-12-11 17:06:09.316040 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-11 17:06:09.339505 | controller | skipping: Conditional result was False 2025-12-11 17:06:09.347952 | 2025-12-11 17:06:09.348054 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-11 17:06:09.669490 | controller -> localhost | changed 2025-12-11 17:06:09.680809 | 2025-12-11 17:06:09.680875 | TASK [add-build-sshkey : Add back temp key] 2025-12-11 17:06:09.918487 | controller -> localhost | Identity added: /var/lib/zuul/builds/cfef7a84736546f58131a1269bf5bb9d/work/cfef7a84736546f58131a1269bf5bb9d_id_rsa (zuul-build-sshkey) 2025-12-11 17:06:09.918696 | controller -> localhost | ok: Runtime: 0:00:00.007288 2025-12-11 17:06:09.925529 | 2025-12-11 17:06:09.925591 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-11 17:06:10.232436 | controller | ok 2025-12-11 17:06:10.240568 | 2025-12-11 17:06:10.240651 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-11 17:06:10.277474 | controller | skipping: Conditional result was False 2025-12-11 17:06:10.290225 | 2025-12-11 17:06:10.290287 | TASK [Run add-build-sshkey role (ECDSA)] 2025-12-11 17:06:10.309052 | controller | ok 2025-12-11 17:06:10.329674 | 2025-12-11 17:06:10.329738 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-12-11 17:06:10.582167 | controller -> localhost | ok 2025-12-11 17:06:10.588903 | 2025-12-11 17:06:10.588970 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-12-11 17:06:10.608805 | controller | ok 2025-12-11 17:06:10.619310 | controller | included: /var/lib/zuul/builds/cfef7a84736546f58131a1269bf5bb9d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-12-11 17:06:10.625341 | 2025-12-11 17:06:10.625404 | TASK [add-build-sshkey : Create Temp SSH key] 2025-12-11 17:06:10.873520 | controller -> localhost | Generating public/private ecdsa key pair. 2025-12-11 17:06:10.874719 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/cfef7a84736546f58131a1269bf5bb9d/work/cfef7a84736546f58131a1269bf5bb9d_id_ecdsa. 2025-12-11 17:06:10.874752 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/cfef7a84736546f58131a1269bf5bb9d/work/cfef7a84736546f58131a1269bf5bb9d_id_ecdsa.pub. 2025-12-11 17:06:10.874781 | controller -> localhost | The key fingerprint is: 2025-12-11 17:06:10.874801 | controller -> localhost | SHA256:Rxjb6MPaK8QhijMkkPXojvDEVi3GcEQrxUCLwteHsLQ zuul-build-sshkey 2025-12-11 17:06:10.874819 | controller -> localhost | The key's randomart image is: 2025-12-11 17:06:10.874838 | controller -> localhost | +---[ECDSA 521]---+ 2025-12-11 17:06:10.874856 | controller -> localhost | | +=B= . | 2025-12-11 17:06:10.874873 | controller -> localhost | |+..O*o. * | 2025-12-11 17:06:10.874890 | controller -> localhost | |+.+EBo..+ o | 2025-12-11 17:06:10.874907 | controller -> localhost | |o+.+..oo . | 2025-12-11 17:06:10.874924 | controller -> localhost | |+.=. o .S . | 2025-12-11 17:06:10.874940 | controller -> localhost | |=*. oo o | 2025-12-11 17:06:10.874957 | controller -> localhost | |.oo .. . | 2025-12-11 17:06:10.874974 | controller -> localhost | | . . | 2025-12-11 17:06:10.874990 | controller -> localhost | | .. | 2025-12-11 17:06:10.875007 | controller -> localhost | +----[SHA256]-----+ 2025-12-11 17:06:10.875083 | controller -> localhost | ok: Runtime: 0:00:00.015423 2025-12-11 17:06:10.882876 | 2025-12-11 17:06:10.882944 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-12-11 17:06:10.915916 | controller | ok 2025-12-11 17:06:10.923613 | controller | included: /var/lib/zuul/builds/cfef7a84736546f58131a1269bf5bb9d/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-12-11 17:06:10.932418 | 2025-12-11 17:06:10.932488 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-12-11 17:06:10.946531 | controller | skipping: Conditional result was False 2025-12-11 17:06:10.953377 | 2025-12-11 17:06:10.953439 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-12-11 17:06:11.208158 | controller | changed 2025-12-11 17:06:11.215337 | 2025-12-11 17:06:11.215444 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-12-11 17:06:11.459467 | controller | ok 2025-12-11 17:06:11.478371 | 2025-12-11 17:06:11.478473 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-12-11 17:06:12.090653 | controller | changed 2025-12-11 17:06:12.099291 | 2025-12-11 17:06:12.099375 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-12-11 17:06:12.689002 | controller | changed 2025-12-11 17:06:12.701440 | 2025-12-11 17:06:12.701564 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-12-11 17:06:12.729366 | controller | skipping: Conditional result was False 2025-12-11 17:06:12.743300 | 2025-12-11 17:06:12.743429 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-12-11 17:06:13.076178 | controller -> localhost | changed 2025-12-11 17:06:13.093425 | 2025-12-11 17:06:13.093519 | TASK [add-build-sshkey : Add back temp key] 2025-12-11 17:06:13.382622 | controller -> localhost | Identity added: /var/lib/zuul/builds/cfef7a84736546f58131a1269bf5bb9d/work/cfef7a84736546f58131a1269bf5bb9d_id_ecdsa (zuul-build-sshkey) 2025-12-11 17:06:13.383314 | controller -> localhost | ok: Runtime: 0:00:00.014377 2025-12-11 17:06:13.397125 | 2025-12-11 17:06:13.397258 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-12-11 17:06:13.607949 | controller | ok 2025-12-11 17:06:13.615836 | 2025-12-11 17:06:13.615932 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-12-11 17:06:13.654653 | controller | skipping: Conditional result was False 2025-12-11 17:06:13.681316 | 2025-12-11 17:06:13.681505 | TASK [include_role : remove-zuul-sshkey] 2025-12-11 17:06:13.719943 | controller | skipping: Conditional result was False 2025-12-11 17:06:13.732394 | 2025-12-11 17:06:13.732540 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2025-12-11 17:06:13.970302 | controller | ok: "logs" 2025-12-11 17:06:13.970668 | controller | ok: All items complete 2025-12-11 17:06:13.970710 | 2025-12-11 17:06:14.171394 | controller | ok: "artifacts" 2025-12-11 17:06:14.369181 | controller | ok: "docs" 2025-12-11 17:06:14.394281 | 2025-12-11 17:06:14.394509 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2025-12-11 17:06:14.681724 | controller | changed: "logs" 2025-12-11 17:06:14.899910 | controller | changed: "artifacts" 2025-12-11 17:06:15.124530 | controller | changed: "docs" 2025-12-11 17:06:15.226037 | 2025-12-11 17:06:15.226197 | PLAY RECAP 2025-12-11 17:06:15.226247 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2025-12-11 17:06:15.226299 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-12-11 17:06:15.226319 | 2025-12-11 17:06:15.373483 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2025-12-11 17:06:15.374409 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master] 2025-12-11 17:06:16.004138 | 2025-12-11 17:06:16.004315 | PLAY [all] 2025-12-11 17:06:16.025663 | 2025-12-11 17:06:16.025754 | TASK [Setup ensure-tox role] 2025-12-11 17:06:16.057550 | controller | ok 2025-12-11 17:06:16.081109 | 2025-12-11 17:06:16.081199 | TASK [Install pip] 2025-12-11 17:06:16.101342 | controller | ok 2025-12-11 17:06:16.123238 | 2025-12-11 17:06:16.123326 | TASK [ensure-pip : Check if pip is installed] 2025-12-11 17:06:16.491758 | controller | /usr/bin/pip3 2025-12-11 17:06:16.507724 | controller | /usr/bin/python3: No module named wheel 2025-12-11 17:06:16.656652 | controller | ok: Runtime: 0:00:00.023788 2025-12-11 17:06:16.670535 | 2025-12-11 17:06:16.670681 | LOOP [ensure-pip : Install pip from packages] 2025-12-11 17:06:16.703346 | controller | ok: "/var/lib/zuul/builds/cfef7a84736546f58131a1269bf5bb9d/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml" 2025-12-11 17:06:16.729253 | controller | included: /var/lib/zuul/builds/cfef7a84736546f58131a1269bf5bb9d/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml 2025-12-11 17:06:16.750837 | 2025-12-11 17:06:16.750976 | TASK [ensure-pip : Install Python 3 pip] 2025-12-11 17:06:21.482114 | controller | changed 2025-12-11 17:06:21.494776 | 2025-12-11 17:06:21.494913 | TASK [ensure-pip : Check for EPEL repository] 2025-12-11 17:06:21.522269 | controller | skipping: Conditional result was False 2025-12-11 17:06:21.531030 | 2025-12-11 17:06:21.531124 | TASK [ensure-pip : Fail with instructions when EPEL is not installed] 2025-12-11 17:06:21.556968 | controller | skipping: Conditional result was False 2025-12-11 17:06:21.566006 | 2025-12-11 17:06:21.566123 | TASK [ensure-pip : Install Python 2 pip] 2025-12-11 17:06:21.591469 | controller | skipping: Conditional result was False 2025-12-11 17:06:21.601256 | 2025-12-11 17:06:21.601355 | TASK [ensure-pip : Ensure setuptools] 2025-12-11 17:06:21.626823 | controller | skipping: Conditional result was False 2025-12-11 17:06:21.635851 | 2025-12-11 17:06:21.635942 | TASK [ensure-pip : Check for ensurepip module] 2025-12-11 17:06:22.194165 | controller | skipping: Conditional result was False 2025-12-11 17:06:22.207681 | 2025-12-11 17:06:22.207931 | TASK [ensure-pip : Ensure python3-venv] 2025-12-11 17:06:22.235550 | controller | skipping: Conditional result was False 2025-12-11 17:06:22.251265 | 2025-12-11 17:06:22.251413 | TASK [ensure-pip : Install pip from source] 2025-12-11 17:06:22.278767 | controller | skipping: Conditional result was False 2025-12-11 17:06:22.292447 | 2025-12-11 17:06:22.292602 | TASK [ensure-pip : Probe for venv python full path] 2025-12-11 17:06:22.667319 | controller | /usr/bin/python3 2025-12-11 17:06:22.836674 | controller | ok: Runtime: 0:00:00.005982 2025-12-11 17:06:22.888088 | 2025-12-11 17:06:22.888275 | TASK [ensure-pip : Set host default] 2025-12-11 17:06:22.965826 | controller | ok 2025-12-11 17:06:22.977348 | 2025-12-11 17:06:22.977496 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2025-12-11 17:06:23.044112 | controller | ok 2025-12-11 17:06:23.061524 | 2025-12-11 17:06:23.061616 | TASK [ensure-tox : Check if tox is installed] 2025-12-11 17:06:23.294998 | controller | /usr/bin/tox 2025-12-11 17:06:23.603159 | controller | ok: Runtime: 0:00:00.002984 2025-12-11 17:06:23.615729 | 2025-12-11 17:06:23.615871 | TASK [ensure-tox : Export preinstalled tox_exectuable] 2025-12-11 17:06:23.662413 | controller | ok 2025-12-11 17:06:23.669656 | 2025-12-11 17:06:23.669746 | TASK [ensure-tox : Create local venv] 2025-12-11 17:06:24.207673 | controller | skipping: Conditional result was False 2025-12-11 17:06:24.231552 | 2025-12-11 17:06:24.231752 | TASK [ensure-tox : Install tox to local venv] 2025-12-11 17:06:24.775664 | controller | skipping: Conditional result was False 2025-12-11 17:06:24.784613 | 2025-12-11 17:06:24.784750 | TASK [ensure-tox : Export installed tox_executable path] 2025-12-11 17:06:24.841706 | controller | skipping: Conditional result was False 2025-12-11 17:06:24.848430 | 2025-12-11 17:06:24.848568 | TASK [ensure-tox : Output tox version] 2025-12-11 17:06:25.202345 | controller | 3.28.0 imported from /usr/lib/python3.11/site-packages/tox/__init__.py 2025-12-11 17:06:25.388997 | controller | ok: Runtime: 0:00:00.141578 2025-12-11 17:06:25.411668 | 2025-12-11 17:06:25.411927 | TASK [ensure-tox : Make global symlink] 2025-12-11 17:06:25.442921 | controller | skipping: Conditional result was False 2025-12-11 17:06:25.459594 | 2025-12-11 17:06:25.459719 | TASK [Setup tox role] 2025-12-11 17:06:25.489562 | controller | ok 2025-12-11 17:06:25.537886 | 2025-12-11 17:06:25.538067 | TASK [tox : Check to see if the constraints file exists] 2025-12-11 17:06:25.573083 | controller | skipping: Conditional result was False 2025-12-11 17:06:25.586040 | 2025-12-11 17:06:25.586156 | TASK [tox : Fail if constraints file is missing] 2025-12-11 17:06:25.612984 | controller | skipping: Conditional result was False 2025-12-11 17:06:25.623413 | 2025-12-11 17:06:25.623530 | TASK [tox : Record file location] 2025-12-11 17:06:25.648556 | controller | skipping: Conditional result was False 2025-12-11 17:06:25.657096 | 2025-12-11 17:06:25.657195 | TASK [tox : Install tox siblings] 2025-12-11 17:06:25.681538 | controller | skipping: Conditional result was False 2025-12-11 17:06:25.691830 | 2025-12-11 17:06:25.691939 | TASK [tox : Emit tox command] 2025-12-11 17:06:25.736247 | /usr/bin/tox -evenv -vv --notest 2025-12-11 17:06:25.743388 | 2025-12-11 17:06:25.743471 | TASK [tox : Run tox] 2025-12-11 17:06:26.083268 | controller | using tox.ini: /home/zuul/src/github.com/ansible-network/releases/tox.ini (pid 2278) 2025-12-11 17:06:26.090281 | controller | using tox-3.28.0 from /usr/lib/python3.11/site-packages/tox/__init__.py (pid 2278) 2025-12-11 17:06:26.111362 | controller | skipping sdist step 2025-12-11 17:06:26.111380 | controller | venv uses /usr/bin/python3 2025-12-11 17:06:26.111396 | controller | venv start: getenv /home/zuul/src/github.com/ansible-network/releases/.tox/venv 2025-12-11 17:06:26.111645 | controller | venv cannot reuse: no previous config /home/zuul/src/github.com/ansible-network/releases/.tox/venv/.tox-config1 2025-12-11 17:06:26.111658 | controller | venv create: /home/zuul/src/github.com/ansible-network/releases/.tox/venv 2025-12-11 17:06:26.111666 | 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-12-11 17:06:26.111674 | controller | [2286] /home/zuul/src/github.com/ansible-network/releases/.tox$ /usr/bin/python3 -m virtualenv --no-download --python /usr/bin/python3 venv 2025-12-11 17:06:26.619348 | controller | created virtual environment CPython3.11.0.final.0-64 in 429ms 2025-12-11 17:06:26.636111 | controller | creator CPython3Posix(dest=/home/zuul/src/github.com/ansible-network/releases/.tox/venv, clear=False, no_vcs_ignore=False, global=False) 2025-12-11 17:06:26.636139 | 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-12-11 17:06:26.636152 | controller | added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1 2025-12-11 17:06:26.636157 | controller | activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator 2025-12-11 17:06:26.636166 | 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-12-11 17:06:26.636404 | 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-12-11 17:06:26.636420 | controller | [2294] /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-12-11 17:06:27.994055 | controller | Collecting ruamel.yaml 2025-12-11 17:06:28.033876 | controller | Downloading ruamel.yaml-0.18.16-py3-none-any.whl (119 kB) 2025-12-11 17:06:28.061435 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 119.9/119.9 kB 4.6 MB/s eta 0:00:00 2025-12-11 17:06:28.110264 | controller | Collecting pbr 2025-12-11 17:06:28.114743 | controller | Downloading pbr-7.0.3-py2.py3-none-any.whl (131 kB) 2025-12-11 17:06:28.126194 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 131.9/131.9 kB 13.0 MB/s eta 0:00:00 2025-12-11 17:06:28.165788 | controller | Collecting tweepy 2025-12-11 17:06:28.170262 | controller | Downloading tweepy-4.16.0-py3-none-any.whl (98 kB) 2025-12-11 17:06:28.179366 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.8/98.8 kB 13.0 MB/s eta 0:00:00 2025-12-11 17:06:28.224001 | controller | Collecting galaxy-importer 2025-12-11 17:06:28.270360 | controller | Downloading galaxy_importer-0.4.36-py3-none-any.whl (64 kB) 2025-12-11 17:06:28.280617 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 64.9/64.9 kB 9.2 MB/s eta 0:00:00 2025-12-11 17:06:28.327125 | controller | Collecting flake8 2025-12-11 17:06:28.331175 | controller | Downloading flake8-7.3.0-py2.py3-none-any.whl (57 kB) 2025-12-11 17:06:28.339543 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 57.9/57.9 kB 7.3 MB/s eta 0:00:00 2025-12-11 17:06:28.441820 | controller | Collecting ruamel.yaml.clib>=0.2.7 2025-12-11 17:06:28.446260 | controller | Downloading ruamel_yaml_clib-0.2.15-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (777 kB) 2025-12-11 17:06:28.469571 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 777.6/777.6 kB 41.0 MB/s eta 0:00:00 2025-12-11 17:06:28.477104 | controller | Requirement already satisfied: setuptools in ./.tox/venv/lib/python3.11/site-packages (from pbr->-r /home/zuul/src/github.com/ansible-network/releases/requirements.txt (line 2)) (62.6.0) 2025-12-11 17:06:28.521353 | controller | Collecting oauthlib<4,>=3.2.0 2025-12-11 17:06:28.525002 | controller | Downloading oauthlib-3.3.1-py3-none-any.whl (160 kB) 2025-12-11 17:06:28.534831 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 160.1/160.1 kB 21.7 MB/s eta 0:00:00 2025-12-11 17:06:28.595344 | controller | Collecting requests<3,>=2.27.0 2025-12-11 17:06:28.598481 | controller | Downloading requests-2.32.5-py3-none-any.whl (64 kB) 2025-12-11 17:06:28.606480 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 64.7/64.7 kB 9.1 MB/s eta 0:00:00 2025-12-11 17:06:28.640906 | controller | Collecting requests-oauthlib<3,>=1.2.0 2025-12-11 17:06:28.644036 | controller | Downloading requests_oauthlib-2.0.0-py2.py3-none-any.whl (24 kB) 2025-12-11 17:06:28.793047 | controller | Collecting ansible-core 2025-12-11 17:06:28.797407 | controller | Downloading ansible_core-2.19.5-py3-none-any.whl (2.4 MB) 2025-12-11 17:06:28.831526 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.4/2.4 MB 79.9 MB/s eta 0:00:00 2025-12-11 17:06:28.873283 | controller | Collecting ansible-builder<4.0,>=1.2.0 2025-12-11 17:06:28.878113 | controller | Downloading ansible_builder-3.1.1-py3-none-any.whl (46 kB) 2025-12-11 17:06:28.885561 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 46.5/46.5 kB 7.2 MB/s eta 0:00:00 2025-12-11 17:06:29.003148 | controller | Collecting ansible-lint<=25.12.0,>=6.2.2 2025-12-11 17:06:29.007709 | controller | Downloading ansible_lint-25.12.0-py3-none-any.whl (323 kB) 2025-12-11 17:06:29.027233 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 323.0/323.0 kB 21.6 MB/s eta 0:00:00 2025-12-11 17:06:29.133230 | controller | Collecting attrs<23,>=21.4.0 2025-12-11 17:06:29.136666 | controller | Downloading attrs-22.2.0-py3-none-any.whl (60 kB) 2025-12-11 17:06:29.143763 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 60.0/60.0 kB 9.5 MB/s eta 0:00:00 2025-12-11 17:06:29.260442 | controller | Collecting nh3<3,>=0.2.18 2025-12-11 17:06:29.264099 | controller | Downloading nh3-0.3.2-cp38-abi3-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (797 kB) 2025-12-11 17:06:29.286549 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 797.2/797.2 kB 51.7 MB/s eta 0:00:00 2025-12-11 17:06:29.300105 | controller | Collecting flake8 2025-12-11 17:06:29.304036 | controller | Downloading flake8-6.1.0-py2.py3-none-any.whl (58 kB) 2025-12-11 17:06:29.311268 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 58.3/58.3 kB 9.5 MB/s eta 0:00:00 2025-12-11 17:06:29.351781 | controller | Collecting markdown<4,>=3.3.4 2025-12-11 17:06:29.354866 | controller | Downloading markdown-3.10-py3-none-any.whl (107 kB) 2025-12-11 17:06:29.362569 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 107.7/107.7 kB 17.2 MB/s eta 0:00:00 2025-12-11 17:06:29.483054 | controller | Collecting pyyaml<7,>=5.4.1 2025-12-11 17:06:29.486524 | controller | Downloading pyyaml-6.0.3-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (806 kB) 2025-12-11 17:06:29.505209 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 806.6/806.6 kB 54.0 MB/s eta 0:00:00 2025-12-11 17:06:29.549339 | controller | Collecting semantic-version<3,>=2.9.0 2025-12-11 17:06:29.552833 | controller | Downloading semantic_version-2.10.0-py2.py3-none-any.whl (15 kB) 2025-12-11 17:06:29.599327 | controller | Collecting packaging<25.0,>=23.2 2025-12-11 17:06:29.602739 | controller | Downloading packaging-24.2-py3-none-any.whl (65 kB) 2025-12-11 17:06:29.611367 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 65.5/65.5 kB 8.2 MB/s eta 0:00:00 2025-12-11 17:06:29.640452 | controller | Collecting mccabe<0.8.0,>=0.7.0 2025-12-11 17:06:29.643771 | controller | Downloading mccabe-0.7.0-py2.py3-none-any.whl (7.3 kB) 2025-12-11 17:06:29.673826 | controller | Collecting pycodestyle<2.12.0,>=2.11.0 2025-12-11 17:06:29.678261 | controller | Downloading pycodestyle-2.11.1-py2.py3-none-any.whl (31 kB) 2025-12-11 17:06:29.715582 | controller | Collecting pyflakes<3.2.0,>=3.1.0 2025-12-11 17:06:29.719695 | controller | Downloading pyflakes-3.1.0-py2.py3-none-any.whl (62 kB) 2025-12-11 17:06:29.728097 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 62.6/62.6 kB 7.9 MB/s eta 0:00:00 2025-12-11 17:06:29.756237 | controller | Collecting bindep 2025-12-11 17:06:29.760957 | controller | Downloading bindep-2.13.0-py3-none-any.whl (34 kB) 2025-12-11 17:06:29.817817 | controller | Collecting jsonschema 2025-12-11 17:06:29.820906 | controller | Downloading jsonschema-4.25.1-py3-none-any.whl (90 kB) 2025-12-11 17:06:29.828485 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 90.0/90.0 kB 15.1 MB/s eta 0:00:00 2025-12-11 17:06:29.895836 | controller | Collecting ansible-compat>=25.8.2 2025-12-11 17:06:29.900520 | controller | Downloading ansible_compat-25.12.0-py3-none-any.whl (27 kB) 2025-12-11 17:06:30.053190 | controller | Collecting black>=24.3.0 2025-12-11 17:06:30.058297 | controller | Downloading black-25.12.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (1.8 MB) 2025-12-11 17:06:30.123278 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.8/1.8 MB 28.0 MB/s eta 0:00:00 2025-12-11 17:06:30.406877 | controller | Collecting cffi>=1.15.1 2025-12-11 17:06:30.411129 | controller | Downloading cffi-2.0.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl (215 kB) 2025-12-11 17:06:30.421536 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 215.6/215.6 kB 27.0 MB/s eta 0:00:00 2025-12-11 17:11:36.278514 | controller | ERROR 2025-12-11 17:11:36.278657 | controller | { 2025-12-11 17:11:36.278685 | controller | "msg": "Data could not be sent to remote host \"162.253.55.206\". Make sure this host can be reached over ssh: ssh: connect to host 162.253.55.206 port 22: Connection timed out\r\n", 2025-12-11 17:11:36.278705 | controller | "unreachable": true 2025-12-11 17:11:36.278723 | controller | } unreachable 2025-12-11 17:11:36.280910 | 2025-12-11 17:11:36.280956 | PLAY RECAP 2025-12-11 17:11:36.280995 | controller | ok: 10 changed: 5 unreachable: 1 failed: 0 skipped: 15 rescued: 0 ignored: 0 2025-12-11 17:11:36.281033 | 2025-12-11 17:11:36.370362 | PRE-RUN END RESULT_UNREACHABLE: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master] 2025-12-11 17:11:36.372136 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2025-12-11 17:11:36.962647 | 2025-12-11 17:11:36.962757 | PLAY [all:!appliance*] 2025-12-11 17:11:37.000837 | 2025-12-11 17:11:37.000933 | TASK [unregister the node] 2025-12-11 17:11:37.530635 | controller | skipping: Conditional result was False 2025-12-11 17:11:37.542935 | 2025-12-11 17:11:37.543156 | TASK [include_role : fetch-output] 2025-12-11 17:11:37.592675 | controller | ok 2025-12-11 17:11:37.629445 | 2025-12-11 17:11:37.629582 | TASK [fetch-output : Set log path for multiple nodes] 2025-12-11 17:11:37.705244 | controller | skipping: Conditional result was False 2025-12-11 17:11:37.717749 | 2025-12-11 17:11:37.717893 | TASK [fetch-output : Set log path for single node] 2025-12-11 17:11:37.765922 | controller | ok 2025-12-11 17:11:37.777423 | 2025-12-11 17:11:37.777553 | LOOP [fetch-output : Ensure local output dirs] 2025-12-11 17:11:38.282948 | controller -> localhost | ok: "/var/lib/zuul/builds/cfef7a84736546f58131a1269bf5bb9d/work/logs" 2025-12-11 17:11:38.539224 | controller -> localhost | changed: "/var/lib/zuul/builds/cfef7a84736546f58131a1269bf5bb9d/work/artifacts" 2025-12-11 17:11:38.791665 | controller -> localhost | changed: "/var/lib/zuul/builds/cfef7a84736546f58131a1269bf5bb9d/work/docs" 2025-12-11 17:11:38.811760 | 2025-12-11 17:11:38.811957 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-12-11 17:11:39.467129 | controller | changed: .d..t...... ./ 2025-12-11 17:11:39.467386 | controller | changed: All items complete 2025-12-11 17:11:39.467425 | 2025-12-11 17:11:39.939189 | controller | changed: .d..t...... ./ 2025-12-11 17:11:40.470166 | controller | changed: .d..t...... ./ 2025-12-11 17:11:40.502801 | 2025-12-11 17:11:40.503002 | TASK [include_role : fetch-output-openshift] 2025-12-11 17:11:40.529929 | controller | skipping: Conditional result was False 2025-12-11 17:11:40.539967 | 2025-12-11 17:11:40.540106 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2025-12-11 17:11:40.990830 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.026224 2025-12-11 17:11:41.236796 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.020457 2025-12-11 17:11:41.271060 | 2025-12-11 17:11:41.271127 | PLAY [localhost] 2025-12-11 17:11:41.283336 | 2025-12-11 17:11:41.283393 | TASK [Run Zuul manifest role] 2025-12-11 17:11:41.302038 | localhost | ok 2025-12-11 17:11:41.315745 | 2025-12-11 17:11:41.315811 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-12-11 17:11:41.678346 | localhost | changed 2025-12-11 17:11:41.684073 | 2025-12-11 17:11:41.684137 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-12-11 17:11:41.735093 | localhost | ok 2025-12-11 17:11:41.746136 | 2025-12-11 17:11:41.746217 | TASK [Set zuul-log-path fact] 2025-12-11 17:11:41.769658 | localhost | ok 2025-12-11 17:11:41.787573 | 2025-12-11 17:11:41.787673 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-12-11 17:11:41.817642 | localhost | ok 2025-12-11 17:11:41.826011 | 2025-12-11 17:11:41.826109 | LOOP [Run upload-logs-swift role] 2025-12-11 17:11:41.866923 | localhost | Output suppressed because no_log was given 2025-12-11 17:11:41.890459 | 2025-12-11 17:11:41.890521 | TASK [Set zuul-log-path fact] 2025-12-11 17:11:41.916402 | localhost | skipping: Conditional result was False 2025-12-11 17:11:41.947294 | 2025-12-11 17:11:41.947420 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2025-12-11 17:11:42.205523 | localhost -> localhost | ok: Runtime: 0:00:00.005519 2025-12-11 17:11:42.210724 | 2025-12-11 17:11:42.210786 | TASK [upload-logs-swift : Upload logs to swift]