2025-11-09 21:15:15.660257 | Job console starting... 2025-11-09 21:15:15.670983 | Updating repositories 2025-11-09 21:15:15.715635 | Preparing job workspace 2025-11-09 21:15:19.643762 | Running Ansible setup... 2025-11-09 21:15:23.858458 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2025-11-09 21:15:24.432883 | 2025-11-09 21:15:24.433055 | PLAY [localhost] 2025-11-09 21:15:24.441009 | 2025-11-09 21:15:24.441092 | TASK [Gathering Facts] 2025-11-09 21:15:25.392184 | localhost | ok 2025-11-09 21:15:25.420912 | 2025-11-09 21:15:25.421114 | TASK [Setup log path fact] 2025-11-09 21:15:25.445232 | localhost | ok 2025-11-09 21:15:25.469662 | 2025-11-09 21:15:25.469745 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-09 21:15:25.502807 | localhost | ok 2025-11-09 21:15:25.518971 | 2025-11-09 21:15:25.519148 | TASK [emit-job-header : Print job information] 2025-11-09 21:15:25.572469 | # Job Information 2025-11-09 21:15:25.572685 | Ansible Version: 2.15.12 2025-11-09 21:15:25.572751 | Job: ansible-galaxy-importer 2025-11-09 21:15:25.572796 | Pipeline: third-party-check 2025-11-09 21:15:25.572835 | Executor: ze01.softwarefactory-project.io 2025-11-09 21:15:25.572875 | Triggered by: https://github.com/ansible-collections/community.libvirt/pull/226 2025-11-09 21:15:25.572919 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/38b/ansible/38b55fe4c957433a8bcfd8e43bc382c1/ 2025-11-09 21:15:25.572959 | Event ID: 23fd08f0-bdae-11f0-97bc-e8152e046fe5 2025-11-09 21:15:25.580966 | 2025-11-09 21:15:25.581122 | LOOP [emit-job-header : Print node information] 2025-11-09 21:15:25.703709 | localhost | ok: 2025-11-09 21:15:25.703989 | localhost | # Node Information 2025-11-09 21:15:25.704082 | localhost | Inventory Hostname: controller 2025-11-09 21:15:25.704128 | localhost | Hostname: np0005516119 2025-11-09 21:15:25.704169 | localhost | Username: zuul 2025-11-09 21:15:25.704213 | localhost | Distro: Fedora 37 2025-11-09 21:15:25.704251 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2025-11-09 21:15:25.704289 | localhost | Region: ca-ymq-1 2025-11-09 21:15:25.704325 | localhost | Label: ansible-fedora-37-1vcpu 2025-11-09 21:15:25.704361 | localhost | Product Name: OpenStack Nova 2025-11-09 21:15:25.704397 | localhost | Interface IP: 162.253.55.62 2025-11-09 21:15:25.724532 | 2025-11-09 21:15:25.724694 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-09 21:15:26.128586 | localhost -> localhost | changed 2025-11-09 21:15:26.139745 | 2025-11-09 21:15:26.139903 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-09 21:15:27.026904 | localhost -> localhost | changed 2025-11-09 21:15:27.067870 | 2025-11-09 21:15:27.067951 | PLAY [all:!appliance*] 2025-11-09 21:15:27.090077 | 2025-11-09 21:15:27.090179 | TASK [include_role : start-zuul-console] 2025-11-09 21:15:27.112532 | controller | ok 2025-11-09 21:15:27.131192 | 2025-11-09 21:15:27.131283 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-09 21:15:27.507698 | controller | ok 2025-11-09 21:15:27.531225 | 2025-11-09 21:15:27.531380 | TASK [use-our-mirror : Retrieve the IP address] 2025-11-09 21:15:28.874537 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2025-11-09 21:15:28.889175 | 2025-11-09 21:15:28.889323 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2025-11-09 21:15:29.440622 | controller | skipping: Conditional result was False 2025-11-09 21:15:29.449202 | 2025-11-09 21:15:29.449293 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2025-11-09 21:15:29.473787 | controller | skipping: Conditional result was False 2025-11-09 21:15:29.482378 | 2025-11-09 21:15:29.482466 | TASK [use-our-mirror : Create the podman configuration directory] 2025-11-09 21:15:29.506857 | controller | skipping: Conditional result was False 2025-11-09 21:15:29.515340 | 2025-11-09 21:15:29.515433 | TASK [use-our-mirror : Copy the podman configuration] 2025-11-09 21:15:29.539811 | controller | skipping: Conditional result was False 2025-11-09 21:15:29.548309 | 2025-11-09 21:15:29.548393 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2025-11-09 21:15:29.573466 | controller | skipping: Conditional result was False 2025-11-09 21:15:29.582935 | 2025-11-09 21:15:29.583038 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2025-11-09 21:15:29.607320 | controller | skipping: Conditional result was False 2025-11-09 21:15:29.621984 | 2025-11-09 21:15:29.622100 | TASK [Disable Fedora Modular] 2025-11-09 21:15:29.874813 | controller | changed 2025-11-09 21:15:29.888900 | 2025-11-09 21:15:29.889118 | TASK [Enable EPEL] 2025-11-09 21:15:29.919342 | controller | skipping: Conditional result was False 2025-11-09 21:15:29.936388 | 2025-11-09 21:15:29.936602 | TASK [Register the RHEL node] 2025-11-09 21:15:30.501240 | 2025-11-09 21:15:30.501522 | TASK [Show the subscription-manager status] 2025-11-09 21:15:31.085106 | controller | skipping: Conditional result was False 2025-11-09 21:15:31.091624 | 2025-11-09 21:15:31.091685 | TASK [Enable EPEL on RHEL] 2025-11-09 21:15:31.623163 | controller | skipping: Conditional result was False 2025-11-09 21:15:31.635775 | 2025-11-09 21:15:31.635917 | TASK [Install git and tox] 2025-11-09 21:16:54.957787 | controller | changed 2025-11-09 21:16:54.970576 | 2025-11-09 21:16:54.970699 | TASK [include_role : prepare-workspace] 2025-11-09 21:16:55.008862 | controller | ok 2025-11-09 21:16:55.048207 | 2025-11-09 21:16:55.048344 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-11-09 21:16:55.297459 | controller | ok 2025-11-09 21:16:55.310558 | 2025-11-09 21:16:55.310691 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-11-09 21:16:56.264197 | controller | Output suppressed because no_log was given 2025-11-09 21:16:56.285900 | 2025-11-09 21:16:56.286009 | TASK [include_role : prepare-workspace-openshift] 2025-11-09 21:16:56.311316 | controller | skipping: Conditional result was False 2025-11-09 21:16:56.343189 | 2025-11-09 21:16:56.343311 | PLAY [all:!appliance] 2025-11-09 21:16:56.368111 | 2025-11-09 21:16:56.368255 | TASK [Run add-build-sshkey role (RSA)] 2025-11-09 21:16:56.400141 | controller | ok 2025-11-09 21:16:56.420187 | 2025-11-09 21:16:56.420273 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-09 21:16:56.699000 | controller -> localhost | ok 2025-11-09 21:16:56.705521 | 2025-11-09 21:16:56.705582 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-09 21:16:56.737102 | controller | ok 2025-11-09 21:16:56.755163 | controller | included: /var/lib/zuul/builds/38b55fe4c957433a8bcfd8e43bc382c1/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-09 21:16:56.763052 | 2025-11-09 21:16:56.763132 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-09 21:16:57.296230 | controller -> localhost | Generating public/private rsa key pair. 2025-11-09 21:16:57.296426 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/38b55fe4c957433a8bcfd8e43bc382c1/work/38b55fe4c957433a8bcfd8e43bc382c1_id_rsa. 2025-11-09 21:16:57.296455 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/38b55fe4c957433a8bcfd8e43bc382c1/work/38b55fe4c957433a8bcfd8e43bc382c1_id_rsa.pub. 2025-11-09 21:16:57.296476 | controller -> localhost | The key fingerprint is: 2025-11-09 21:16:57.296496 | controller -> localhost | SHA256:uNukQ0nCyDr1bgnk6hjqJl2LLDzHgcHvR5oE4NhPr6k zuul-build-sshkey 2025-11-09 21:16:57.296515 | controller -> localhost | The key's randomart image is: 2025-11-09 21:16:57.296533 | controller -> localhost | +---[RSA 2048]----+ 2025-11-09 21:16:57.296551 | controller -> localhost | | | 2025-11-09 21:16:57.296570 | controller -> localhost | |. | 2025-11-09 21:16:57.296587 | controller -> localhost | |=o o | 2025-11-09 21:16:57.296605 | controller -> localhost | |.=* + .. | 2025-11-09 21:16:57.296623 | controller -> localhost | | ==+ +..S | 2025-11-09 21:16:57.296646 | controller -> localhost | |o.o++.+. | 2025-11-09 21:16:57.296668 | controller -> localhost | |o=+==*. . | 2025-11-09 21:16:57.296687 | controller -> localhost | |*=+*B..= | 2025-11-09 21:16:57.296705 | controller -> localhost | |B+Eo. o.. | 2025-11-09 21:16:57.296725 | controller -> localhost | +----[SHA256]-----+ 2025-11-09 21:16:57.296767 | controller -> localhost | ok: Runtime: 0:00:00.113199 2025-11-09 21:16:57.327932 | 2025-11-09 21:16:57.328066 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-09 21:16:57.357729 | controller | ok 2025-11-09 21:16:57.367053 | controller | included: /var/lib/zuul/builds/38b55fe4c957433a8bcfd8e43bc382c1/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-09 21:16:57.375467 | 2025-11-09 21:16:57.375527 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-09 21:16:57.399232 | controller | skipping: Conditional result was False 2025-11-09 21:16:57.405676 | 2025-11-09 21:16:57.405736 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-09 21:16:57.788794 | controller | changed 2025-11-09 21:16:57.800829 | 2025-11-09 21:16:57.800961 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-09 21:16:58.023448 | controller | ok 2025-11-09 21:16:58.035576 | 2025-11-09 21:16:58.035708 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-09 21:16:58.663668 | controller | changed 2025-11-09 21:16:58.677234 | 2025-11-09 21:16:58.677395 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-09 21:16:59.307416 | controller | changed 2025-11-09 21:16:59.320323 | 2025-11-09 21:16:59.320454 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-09 21:16:59.357054 | controller | skipping: Conditional result was False 2025-11-09 21:16:59.363136 | 2025-11-09 21:16:59.363210 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-09 21:16:59.736706 | controller -> localhost | changed 2025-11-09 21:16:59.766861 | 2025-11-09 21:16:59.767103 | TASK [add-build-sshkey : Add back temp key] 2025-11-09 21:17:00.102288 | controller -> localhost | Identity added: /var/lib/zuul/builds/38b55fe4c957433a8bcfd8e43bc382c1/work/38b55fe4c957433a8bcfd8e43bc382c1_id_rsa (zuul-build-sshkey) 2025-11-09 21:17:00.102648 | controller -> localhost | ok: Runtime: 0:00:00.013950 2025-11-09 21:17:00.116342 | 2025-11-09 21:17:00.116484 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-09 21:17:00.446512 | controller | ok 2025-11-09 21:17:00.454250 | 2025-11-09 21:17:00.454336 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-09 21:17:00.489872 | controller | skipping: Conditional result was False 2025-11-09 21:17:00.515248 | 2025-11-09 21:17:00.515379 | TASK [Run add-build-sshkey role (ECDSA)] 2025-11-09 21:17:00.553723 | controller | ok 2025-11-09 21:17:00.581885 | 2025-11-09 21:17:00.581987 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-09 21:17:00.862425 | controller -> localhost | ok 2025-11-09 21:17:00.876102 | 2025-11-09 21:17:00.876240 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-09 21:17:00.906297 | controller | ok 2025-11-09 21:17:00.928743 | controller | included: /var/lib/zuul/builds/38b55fe4c957433a8bcfd8e43bc382c1/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-09 21:17:00.938272 | 2025-11-09 21:17:00.938355 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-09 21:17:01.219351 | controller -> localhost | Generating public/private ecdsa key pair. 2025-11-09 21:17:01.219536 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/38b55fe4c957433a8bcfd8e43bc382c1/work/38b55fe4c957433a8bcfd8e43bc382c1_id_ecdsa. 2025-11-09 21:17:01.219574 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/38b55fe4c957433a8bcfd8e43bc382c1/work/38b55fe4c957433a8bcfd8e43bc382c1_id_ecdsa.pub. 2025-11-09 21:17:01.219604 | controller -> localhost | The key fingerprint is: 2025-11-09 21:17:01.219627 | controller -> localhost | SHA256:5BrkEACmLuZg97brHv5xmAvJUbOQTbkCO6xI/H+1S0M zuul-build-sshkey 2025-11-09 21:17:01.219649 | controller -> localhost | The key's randomart image is: 2025-11-09 21:17:01.219669 | controller -> localhost | +---[ECDSA 521]---+ 2025-11-09 21:17:01.219688 | controller -> localhost | |.o... .. | 2025-11-09 21:17:01.219706 | controller -> localhost | |o . .+. | 2025-11-09 21:17:01.219723 | controller -> localhost | |o . +o.+o | 2025-11-09 21:17:01.219742 | controller -> localhost | |.o + =o+o | 2025-11-09 21:17:01.219760 | controller -> localhost | |=+o...+.SE | 2025-11-09 21:17:01.219777 | controller -> localhost | |B...o oo+. | 2025-11-09 21:17:01.219795 | controller -> localhost | | . .B.+.+. | 2025-11-09 21:17:01.219813 | controller -> localhost | | o.+.=.. | 2025-11-09 21:17:01.219830 | controller -> localhost | | o*+o .. | 2025-11-09 21:17:01.219848 | controller -> localhost | +----[SHA256]-----+ 2025-11-09 21:17:01.219891 | controller -> localhost | ok: Runtime: 0:00:00.007810 2025-11-09 21:17:01.228466 | 2025-11-09 21:17:01.228529 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-09 21:17:01.256926 | controller | ok 2025-11-09 21:17:01.264028 | controller | included: /var/lib/zuul/builds/38b55fe4c957433a8bcfd8e43bc382c1/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-09 21:17:01.273088 | 2025-11-09 21:17:01.273148 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-09 21:17:01.296817 | controller | skipping: Conditional result was False 2025-11-09 21:17:01.302865 | 2025-11-09 21:17:01.302923 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-09 21:17:01.564970 | controller | changed 2025-11-09 21:17:01.570619 | 2025-11-09 21:17:01.570677 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-09 21:17:01.802008 | controller | ok 2025-11-09 21:17:01.817100 | 2025-11-09 21:17:01.817253 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-09 21:17:02.477560 | controller | changed 2025-11-09 21:17:02.490199 | 2025-11-09 21:17:02.490338 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-09 21:17:03.130418 | controller | changed 2025-11-09 21:17:03.144301 | 2025-11-09 21:17:03.144430 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-09 21:17:03.171318 | controller | skipping: Conditional result was False 2025-11-09 21:17:03.186095 | 2025-11-09 21:17:03.186257 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-09 21:17:03.470469 | controller -> localhost | changed 2025-11-09 21:17:03.495218 | 2025-11-09 21:17:03.495370 | TASK [add-build-sshkey : Add back temp key] 2025-11-09 21:17:03.830987 | controller -> localhost | Identity added: /var/lib/zuul/builds/38b55fe4c957433a8bcfd8e43bc382c1/work/38b55fe4c957433a8bcfd8e43bc382c1_id_ecdsa (zuul-build-sshkey) 2025-11-09 21:17:03.831468 | controller -> localhost | ok: Runtime: 0:00:00.012558 2025-11-09 21:17:03.845274 | 2025-11-09 21:17:03.845399 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-09 21:17:04.072873 | controller | ok 2025-11-09 21:17:04.084606 | 2025-11-09 21:17:04.084744 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-09 21:17:04.121893 | controller | skipping: Conditional result was False 2025-11-09 21:17:04.146655 | 2025-11-09 21:17:04.146789 | TASK [include_role : remove-zuul-sshkey] 2025-11-09 21:17:04.174085 | controller | skipping: Conditional result was False 2025-11-09 21:17:04.187885 | 2025-11-09 21:17:04.188058 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2025-11-09 21:17:04.431759 | controller | ok: "logs" 2025-11-09 21:17:04.432344 | controller | ok: All items complete 2025-11-09 21:17:04.432425 | 2025-11-09 21:17:04.622834 | controller | ok: "artifacts" 2025-11-09 21:17:04.812804 | controller | ok: "docs" 2025-11-09 21:17:04.829189 | 2025-11-09 21:17:04.829396 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2025-11-09 21:17:05.079948 | controller | changed: "logs" 2025-11-09 21:17:05.278216 | controller | changed: "artifacts" 2025-11-09 21:17:05.480187 | controller | changed: "docs" 2025-11-09 21:17:05.587536 | 2025-11-09 21:17:05.587656 | PLAY RECAP 2025-11-09 21:17:05.587708 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2025-11-09 21:17:05.587742 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-11-09 21:17:05.587767 | 2025-11-09 21:17:05.701420 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2025-11-09 21:17:05.702777 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master] 2025-11-09 21:17:06.251514 | 2025-11-09 21:17:06.251682 | PLAY [all] 2025-11-09 21:17:06.271434 | 2025-11-09 21:17:06.271503 | TASK [Setup ensure-tox role] 2025-11-09 21:17:06.290764 | controller | ok 2025-11-09 21:17:06.312942 | 2025-11-09 21:17:06.313035 | TASK [Install pip] 2025-11-09 21:17:06.331854 | controller | ok 2025-11-09 21:17:06.352233 | 2025-11-09 21:17:06.352297 | TASK [ensure-pip : Check if pip is installed] 2025-11-09 21:17:06.726063 | controller | /usr/bin/pip3 2025-11-09 21:17:06.738022 | controller | /usr/bin/python3: No module named wheel 2025-11-09 21:17:06.884841 | controller | ok: Runtime: 0:00:00.019856 2025-11-09 21:17:06.897188 | 2025-11-09 21:17:06.897320 | LOOP [ensure-pip : Install pip from packages] 2025-11-09 21:17:06.945004 | controller | ok: "/var/lib/zuul/builds/38b55fe4c957433a8bcfd8e43bc382c1/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml" 2025-11-09 21:17:06.962519 | controller | included: /var/lib/zuul/builds/38b55fe4c957433a8bcfd8e43bc382c1/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml 2025-11-09 21:17:06.982493 | 2025-11-09 21:17:06.982622 | TASK [ensure-pip : Install Python 3 pip] 2025-11-09 21:17:12.128358 | controller | changed 2025-11-09 21:17:12.141706 | 2025-11-09 21:17:12.141842 | TASK [ensure-pip : Check for EPEL repository] 2025-11-09 21:17:12.168637 | controller | skipping: Conditional result was False 2025-11-09 21:17:12.181823 | 2025-11-09 21:17:12.181964 | TASK [ensure-pip : Fail with instructions when EPEL is not installed] 2025-11-09 21:17:12.208971 | controller | skipping: Conditional result was False 2025-11-09 21:17:12.222886 | 2025-11-09 21:17:12.223081 | TASK [ensure-pip : Install Python 2 pip] 2025-11-09 21:17:12.249250 | controller | skipping: Conditional result was False 2025-11-09 21:17:12.262006 | 2025-11-09 21:17:12.262173 | TASK [ensure-pip : Ensure setuptools] 2025-11-09 21:17:12.288354 | controller | skipping: Conditional result was False 2025-11-09 21:17:12.304422 | 2025-11-09 21:17:12.304559 | TASK [ensure-pip : Check for ensurepip module] 2025-11-09 21:17:12.849445 | controller | skipping: Conditional result was False 2025-11-09 21:17:12.862446 | 2025-11-09 21:17:12.862593 | TASK [ensure-pip : Ensure python3-venv] 2025-11-09 21:17:12.888979 | controller | skipping: Conditional result was False 2025-11-09 21:17:12.902558 | 2025-11-09 21:17:12.902720 | TASK [ensure-pip : Install pip from source] 2025-11-09 21:17:12.928858 | controller | skipping: Conditional result was False 2025-11-09 21:17:12.941969 | 2025-11-09 21:17:12.942168 | TASK [ensure-pip : Probe for venv python full path] 2025-11-09 21:17:13.272905 | controller | /usr/bin/python3 2025-11-09 21:17:13.488959 | controller | ok: Runtime: 0:00:00.002925 2025-11-09 21:17:13.501604 | 2025-11-09 21:17:13.501730 | TASK [ensure-pip : Set host default] 2025-11-09 21:17:13.579315 | controller | ok 2025-11-09 21:17:13.590511 | 2025-11-09 21:17:13.590658 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2025-11-09 21:17:13.674954 | controller | ok 2025-11-09 21:17:13.698925 | 2025-11-09 21:17:13.699193 | TASK [ensure-tox : Check if tox is installed] 2025-11-09 21:17:13.937769 | controller | /usr/bin/tox 2025-11-09 21:17:14.255150 | controller | ok: Runtime: 0:00:00.003113 2025-11-09 21:17:14.268057 | 2025-11-09 21:17:14.268196 | TASK [ensure-tox : Export preinstalled tox_exectuable] 2025-11-09 21:17:14.318932 | controller | ok 2025-11-09 21:17:14.330297 | 2025-11-09 21:17:14.330433 | TASK [ensure-tox : Create local venv] 2025-11-09 21:17:14.877520 | controller | skipping: Conditional result was False 2025-11-09 21:17:14.892558 | 2025-11-09 21:17:14.892762 | TASK [ensure-tox : Install tox to local venv] 2025-11-09 21:17:15.476660 | controller | skipping: Conditional result was False 2025-11-09 21:17:15.490244 | 2025-11-09 21:17:15.490390 | TASK [ensure-tox : Export installed tox_executable path] 2025-11-09 21:17:15.516799 | controller | skipping: Conditional result was False 2025-11-09 21:17:15.529076 | 2025-11-09 21:17:15.529213 | TASK [ensure-tox : Output tox version] 2025-11-09 21:17:15.908435 | controller | 3.28.0 imported from /usr/lib/python3.11/site-packages/tox/__init__.py 2025-11-09 21:17:16.083561 | controller | ok: Runtime: 0:00:00.141041 2025-11-09 21:17:16.095404 | 2025-11-09 21:17:16.095535 | TASK [ensure-tox : Make global symlink] 2025-11-09 21:17:16.122213 | controller | skipping: Conditional result was False 2025-11-09 21:17:16.145093 | 2025-11-09 21:17:16.145225 | TASK [Setup tox role] 2025-11-09 21:17:16.173608 | controller | ok 2025-11-09 21:17:16.214451 | 2025-11-09 21:17:16.214540 | TASK [tox : Check to see if the constraints file exists] 2025-11-09 21:17:16.249476 | controller | skipping: Conditional result was False 2025-11-09 21:17:16.262322 | 2025-11-09 21:17:16.262463 | TASK [tox : Fail if constraints file is missing] 2025-11-09 21:17:16.299242 | controller | skipping: Conditional result was False 2025-11-09 21:17:16.311744 | 2025-11-09 21:17:16.311882 | TASK [tox : Record file location] 2025-11-09 21:17:16.348517 | controller | skipping: Conditional result was False 2025-11-09 21:17:16.361057 | 2025-11-09 21:17:16.361192 | TASK [tox : Install tox siblings] 2025-11-09 21:17:16.387876 | controller | skipping: Conditional result was False 2025-11-09 21:17:16.403671 | 2025-11-09 21:17:16.403806 | TASK [tox : Emit tox command] 2025-11-09 21:17:16.453144 | /usr/bin/tox -evenv -vv --notest 2025-11-09 21:17:16.465146 | 2025-11-09 21:17:16.465312 | TASK [tox : Run tox] 2025-11-09 21:17:16.838966 | controller | using tox.ini: /home/zuul/src/github.com/ansible-network/releases/tox.ini (pid 2276) 2025-11-09 21:17:16.845819 | controller | using tox-3.28.0 from /usr/lib/python3.11/site-packages/tox/__init__.py (pid 2276) 2025-11-09 21:17:16.866773 | controller | skipping sdist step 2025-11-09 21:17:16.866811 | controller | venv uses /usr/bin/python3 2025-11-09 21:17:16.866828 | controller | venv start: getenv /home/zuul/src/github.com/ansible-network/releases/.tox/venv 2025-11-09 21:17:16.866994 | controller | venv cannot reuse: no previous config /home/zuul/src/github.com/ansible-network/releases/.tox/venv/.tox-config1 2025-11-09 21:17:16.867006 | controller | venv create: /home/zuul/src/github.com/ansible-network/releases/.tox/venv 2025-11-09 21:17:16.867014 | 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-09 21:17:16.867023 | controller | [2284] /home/zuul/src/github.com/ansible-network/releases/.tox$ /usr/bin/python3 -m virtualenv --no-download --python /usr/bin/python3 venv 2025-11-09 21:17:17.371125 | controller | created virtual environment CPython3.11.0.final.0-64 in 426ms 2025-11-09 21:17:17.387186 | controller | creator CPython3Posix(dest=/home/zuul/src/github.com/ansible-network/releases/.tox/venv, clear=False, no_vcs_ignore=False, global=False) 2025-11-09 21:17:17.387216 | 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-09 21:17:17.387224 | controller | added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1 2025-11-09 21:17:17.387229 | controller | activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator 2025-11-09 21:17:17.387239 | 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-09 21:17:17.387474 | 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-09 21:17:17.387490 | controller | [2292] /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-09 21:21:55.734584 | [Zuul] Log Stream did not terminate 2025-11-09 21:21:55.734913 | controller | ERROR 2025-11-09 21:21:55.735112 | controller | { 2025-11-09 21:21:55.735179 | controller | "msg": "Data could not be sent to remote host \"162.253.55.62\". Make sure this host can be reached over ssh: ssh: connect to host 162.253.55.62 port 22: No route to host\r\n", 2025-11-09 21:21:55.735226 | controller | "unreachable": true 2025-11-09 21:21:55.735264 | controller | } unreachable 2025-11-09 21:21:55.737308 | 2025-11-09 21:21:55.737408 | PLAY RECAP 2025-11-09 21:21:55.737488 | controller | ok: 10 changed: 5 unreachable: 1 failed: 0 skipped: 15 rescued: 0 ignored: 0 2025-11-09 21:21:55.737532 | 2025-11-09 21:21:55.848606 | PRE-RUN END RESULT_UNREACHABLE: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master] 2025-11-09 21:21:55.850210 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2025-11-09 21:21:56.427616 | 2025-11-09 21:21:56.427721 | PLAY [all:!appliance*] 2025-11-09 21:21:56.448711 | 2025-11-09 21:21:56.448826 | TASK [unregister the node] 2025-11-09 21:21:58.922695 | [controller] Waiting on logger 2025-11-09 21:22:18.654206 | controller | skipping: Conditional result was False 2025-11-09 21:22:18.666749 | 2025-11-09 21:22:18.666932 | TASK [include_role : fetch-output] 2025-11-09 21:22:18.715104 | controller | ok 2025-11-09 21:22:18.751348 | 2025-11-09 21:22:18.751451 | TASK [fetch-output : Set log path for multiple nodes] 2025-11-09 21:22:18.816902 | controller | skipping: Conditional result was False 2025-11-09 21:22:18.825679 | 2025-11-09 21:22:18.825782 | TASK [fetch-output : Set log path for single node] 2025-11-09 21:22:18.878343 | controller | ok 2025-11-09 21:22:18.885745 | 2025-11-09 21:22:18.885835 | LOOP [fetch-output : Ensure local output dirs] 2025-11-09 21:22:19.313327 | controller -> localhost | ok: "/var/lib/zuul/builds/38b55fe4c957433a8bcfd8e43bc382c1/work/logs" 2025-11-09 21:22:19.536683 | controller -> localhost | changed: "/var/lib/zuul/builds/38b55fe4c957433a8bcfd8e43bc382c1/work/artifacts" 2025-11-09 21:22:19.804203 | controller -> localhost | changed: "/var/lib/zuul/builds/38b55fe4c957433a8bcfd8e43bc382c1/work/docs" 2025-11-09 21:22:19.820059 | 2025-11-09 21:22:19.820176 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-11-09 21:22:20.527871 | controller | ok 2025-11-09 21:22:20.528248 | controller | changed: All items complete 2025-11-09 21:22:20.528310 | 2025-11-09 21:22:21.046195 | controller | changed: .d..t...... ./ 2025-11-09 21:22:21.610749 | controller | changed: .d..t...... ./ 2025-11-09 21:22:21.640147 | 2025-11-09 21:22:21.640457 | TASK [include_role : fetch-output-openshift] 2025-11-09 21:22:21.669552 | controller | skipping: Conditional result was False 2025-11-09 21:22:21.686180 | 2025-11-09 21:22:21.686468 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2025-11-09 21:22:22.142159 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.013951 2025-11-09 21:22:22.396248 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.011399 2025-11-09 21:22:22.425397 | 2025-11-09 21:22:22.425498 | PLAY [localhost] 2025-11-09 21:22:22.437692 | 2025-11-09 21:22:22.437748 | TASK [Run Zuul manifest role] 2025-11-09 21:22:22.455934 | localhost | ok 2025-11-09 21:22:22.468178 | 2025-11-09 21:22:22.468241 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-11-09 21:22:22.888109 | localhost | changed 2025-11-09 21:22:22.897622 | 2025-11-09 21:22:22.897753 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-11-09 21:22:22.933006 | localhost | ok 2025-11-09 21:22:22.949857 | 2025-11-09 21:22:22.949981 | TASK [Set zuul-log-path fact] 2025-11-09 21:22:22.975949 | localhost | ok 2025-11-09 21:22:22.999468 | 2025-11-09 21:22:22.999550 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-09 21:22:23.043670 | localhost | ok 2025-11-09 21:22:23.061945 | 2025-11-09 21:22:23.062104 | LOOP [Run upload-logs-swift role] 2025-11-09 21:22:23.098544 | localhost | Output suppressed because no_log was given 2025-11-09 21:22:23.149936 | 2025-11-09 21:22:23.150107 | TASK [Set zuul-log-path fact] 2025-11-09 21:22:23.216354 | localhost | skipping: Conditional result was False 2025-11-09 21:22:23.265088 | 2025-11-09 21:22:23.265246 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2025-11-09 21:22:23.607421 | localhost -> localhost | ok: Runtime: 0:00:00.004913 2025-11-09 21:22:23.613363 | 2025-11-09 21:22:23.613427 | TASK [upload-logs-swift : Upload logs to swift]