2025-11-09 18:26:24.683274 | Job console starting... 2025-11-09 18:26:24.694873 | Updating repositories 2025-11-09 18:26:24.729332 | Preparing job workspace 2025-11-09 18:26:28.654802 | Running Ansible setup... 2025-11-09 18:26:33.509790 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2025-11-09 18:26:34.138624 | 2025-11-09 18:26:34.138759 | PLAY [localhost] 2025-11-09 18:26:34.147234 | 2025-11-09 18:26:34.147349 | TASK [Gathering Facts] 2025-11-09 18:26:35.202856 | localhost | ok 2025-11-09 18:26:35.232603 | 2025-11-09 18:26:35.232818 | TASK [Setup log path fact] 2025-11-09 18:26:35.257443 | localhost | ok 2025-11-09 18:26:35.277549 | 2025-11-09 18:26:35.277712 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-09 18:26:35.320743 | localhost | ok 2025-11-09 18:26:35.335998 | 2025-11-09 18:26:35.336425 | TASK [emit-job-header : Print job information] 2025-11-09 18:26:35.369488 | # Job Information 2025-11-09 18:26:35.369698 | Ansible Version: 2.15.12 2025-11-09 18:26:35.369745 | Job: ansible-galaxy-importer 2025-11-09 18:26:35.369777 | Pipeline: third-party-check 2025-11-09 18:26:35.369869 | Executor: ze01.softwarefactory-project.io 2025-11-09 18:26:35.369900 | Triggered by: https://github.com/ansible-collections/community.windows/pull/656 2025-11-09 18:26:35.369932 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/f1d/ansible/f1d2a2f06c8145369af1284c5b133cb6/ 2025-11-09 18:26:35.369961 | Event ID: aa233c80-bd98-11f0-858e-f782c38d61d3 2025-11-09 18:26:35.375699 | 2025-11-09 18:26:35.375794 | LOOP [emit-job-header : Print node information] 2025-11-09 18:26:35.472149 | localhost | ok: 2025-11-09 18:26:35.472488 | localhost | # Node Information 2025-11-09 18:26:35.472548 | localhost | Inventory Hostname: controller 2025-11-09 18:26:35.472591 | localhost | Hostname: np0005516088 2025-11-09 18:26:35.472634 | localhost | Username: zuul 2025-11-09 18:26:35.472679 | localhost | Distro: Fedora 37 2025-11-09 18:26:35.472719 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2025-11-09 18:26:35.472759 | localhost | Region: ca-ymq-1 2025-11-09 18:26:35.472796 | localhost | Label: ansible-fedora-37-1vcpu 2025-11-09 18:26:35.472832 | localhost | Product Name: OpenStack Nova 2025-11-09 18:26:35.472868 | localhost | Interface IP: 199.204.45.216 2025-11-09 18:26:35.492461 | 2025-11-09 18:26:35.492662 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-09 18:26:35.859685 | localhost -> localhost | changed 2025-11-09 18:26:35.872292 | 2025-11-09 18:26:35.872579 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-09 18:26:36.791207 | localhost -> localhost | changed 2025-11-09 18:26:36.841229 | 2025-11-09 18:26:36.841339 | PLAY [all:!appliance*] 2025-11-09 18:26:36.864911 | 2025-11-09 18:26:36.865075 | TASK [include_role : start-zuul-console] 2025-11-09 18:26:36.886856 | controller | ok 2025-11-09 18:26:36.907244 | 2025-11-09 18:26:36.907367 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-09 18:26:37.272498 | controller | ok 2025-11-09 18:26:37.299329 | 2025-11-09 18:26:37.299507 | TASK [use-our-mirror : Retrieve the IP address] 2025-11-09 18:26:38.472990 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2025-11-09 18:26:38.483055 | 2025-11-09 18:26:38.483185 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2025-11-09 18:26:39.018533 | controller | skipping: Conditional result was False 2025-11-09 18:26:39.034170 | 2025-11-09 18:26:39.034374 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2025-11-09 18:26:39.051923 | controller | skipping: Conditional result was False 2025-11-09 18:26:39.068781 | 2025-11-09 18:26:39.068996 | TASK [use-our-mirror : Create the podman configuration directory] 2025-11-09 18:26:39.086405 | controller | skipping: Conditional result was False 2025-11-09 18:26:39.105855 | 2025-11-09 18:26:39.106177 | TASK [use-our-mirror : Copy the podman configuration] 2025-11-09 18:26:39.124844 | controller | skipping: Conditional result was False 2025-11-09 18:26:39.138576 | 2025-11-09 18:26:39.138743 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2025-11-09 18:26:39.166779 | controller | skipping: Conditional result was False 2025-11-09 18:26:39.184100 | 2025-11-09 18:26:39.184319 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2025-11-09 18:26:39.220940 | controller | skipping: Conditional result was False 2025-11-09 18:26:39.237898 | 2025-11-09 18:26:39.238076 | TASK [Disable Fedora Modular] 2025-11-09 18:26:39.479798 | controller | changed 2025-11-09 18:26:39.492747 | 2025-11-09 18:26:39.492920 | TASK [Enable EPEL] 2025-11-09 18:26:39.520417 | controller | skipping: Conditional result was False 2025-11-09 18:26:39.533888 | 2025-11-09 18:26:39.534111 | TASK [Register the RHEL node] 2025-11-09 18:26:40.092056 | 2025-11-09 18:26:40.092298 | TASK [Show the subscription-manager status] 2025-11-09 18:26:40.665497 | controller | skipping: Conditional result was False 2025-11-09 18:26:40.680148 | 2025-11-09 18:26:40.680316 | TASK [Enable EPEL on RHEL] 2025-11-09 18:26:41.236251 | controller | skipping: Conditional result was False 2025-11-09 18:26:41.244630 | 2025-11-09 18:26:41.244755 | TASK [Install git and tox] 2025-11-09 18:28:00.387322 | controller | changed 2025-11-09 18:28:00.401196 | 2025-11-09 18:28:00.401334 | TASK [include_role : prepare-workspace] 2025-11-09 18:28:00.439342 | controller | ok 2025-11-09 18:28:00.475120 | 2025-11-09 18:28:00.475251 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-11-09 18:28:00.747594 | controller | ok 2025-11-09 18:28:00.761155 | 2025-11-09 18:28:00.761294 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-11-09 18:28:02.412295 | controller | Output suppressed because no_log was given 2025-11-09 18:28:02.430623 | 2025-11-09 18:28:02.430717 | TASK [include_role : prepare-workspace-openshift] 2025-11-09 18:28:02.456425 | controller | skipping: Conditional result was False 2025-11-09 18:28:02.492775 | 2025-11-09 18:28:02.492878 | PLAY [all:!appliance] 2025-11-09 18:28:02.515683 | 2025-11-09 18:28:02.515774 | TASK [Run add-build-sshkey role (RSA)] 2025-11-09 18:28:02.545213 | controller | ok 2025-11-09 18:28:02.560094 | 2025-11-09 18:28:02.560158 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-09 18:28:02.797646 | controller -> localhost | ok 2025-11-09 18:28:02.805588 | 2025-11-09 18:28:02.805708 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-09 18:28:02.839904 | controller | ok 2025-11-09 18:28:02.858082 | controller | included: /var/lib/zuul/builds/f1d2a2f06c8145369af1284c5b133cb6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-09 18:28:02.864149 | 2025-11-09 18:28:02.864210 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-09 18:28:03.373901 | controller -> localhost | Generating public/private rsa key pair. 2025-11-09 18:28:03.375415 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/f1d2a2f06c8145369af1284c5b133cb6/work/f1d2a2f06c8145369af1284c5b133cb6_id_rsa. 2025-11-09 18:28:03.375456 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/f1d2a2f06c8145369af1284c5b133cb6/work/f1d2a2f06c8145369af1284c5b133cb6_id_rsa.pub. 2025-11-09 18:28:03.375480 | controller -> localhost | The key fingerprint is: 2025-11-09 18:28:03.375501 | controller -> localhost | SHA256:FzUUTK4BuIsun31kbAcg5Elqd4uzGg75TnxWLFdFS0g zuul-build-sshkey 2025-11-09 18:28:03.375520 | controller -> localhost | The key's randomart image is: 2025-11-09 18:28:03.375539 | controller -> localhost | +---[RSA 2048]----+ 2025-11-09 18:28:03.375557 | controller -> localhost | | .o oEo++*. | 2025-11-09 18:28:03.375577 | controller -> localhost | | +..o .+ +.. | 2025-11-09 18:28:03.375596 | controller -> localhost | | o +..o. + . | 2025-11-09 18:28:03.375614 | controller -> localhost | | . . +.o. + | 2025-11-09 18:28:03.375631 | controller -> localhost | | +.=oS.o | 2025-11-09 18:28:03.375673 | controller -> localhost | | o .*. =.. | 2025-11-09 18:28:03.375716 | controller -> localhost | |o +.+ + . | 2025-11-09 18:28:03.375739 | controller -> localhost | | =.=.o . | 2025-11-09 18:28:03.375759 | controller -> localhost | | .=oo .. | 2025-11-09 18:28:03.375780 | controller -> localhost | +----[SHA256]-----+ 2025-11-09 18:28:03.375826 | controller -> localhost | ok: Runtime: 0:00:00.092614 2025-11-09 18:28:03.417674 | 2025-11-09 18:28:03.417792 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-09 18:28:03.446875 | controller | ok 2025-11-09 18:28:03.456470 | controller | included: /var/lib/zuul/builds/f1d2a2f06c8145369af1284c5b133cb6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-09 18:28:03.465158 | 2025-11-09 18:28:03.465222 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-09 18:28:03.489172 | controller | skipping: Conditional result was False 2025-11-09 18:28:03.496058 | 2025-11-09 18:28:03.496133 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-09 18:28:03.897667 | controller | changed 2025-11-09 18:28:03.905842 | 2025-11-09 18:28:03.905944 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-09 18:28:04.135168 | controller | ok 2025-11-09 18:28:04.147543 | 2025-11-09 18:28:04.147675 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-09 18:28:04.795112 | controller | changed 2025-11-09 18:28:04.801553 | 2025-11-09 18:28:04.801615 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-09 18:28:05.402824 | controller | changed 2025-11-09 18:28:05.412289 | 2025-11-09 18:28:05.412387 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-09 18:28:05.437816 | controller | skipping: Conditional result was False 2025-11-09 18:28:05.446981 | 2025-11-09 18:28:05.447099 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-09 18:28:05.800596 | controller -> localhost | changed 2025-11-09 18:28:05.818679 | 2025-11-09 18:28:05.818824 | TASK [add-build-sshkey : Add back temp key] 2025-11-09 18:28:06.060066 | controller -> localhost | Identity added: /var/lib/zuul/builds/f1d2a2f06c8145369af1284c5b133cb6/work/f1d2a2f06c8145369af1284c5b133cb6_id_rsa (zuul-build-sshkey) 2025-11-09 18:28:06.060389 | controller -> localhost | ok: Runtime: 0:00:00.009717 2025-11-09 18:28:06.069969 | 2025-11-09 18:28:06.070126 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-09 18:28:06.360755 | controller | ok 2025-11-09 18:28:06.368535 | 2025-11-09 18:28:06.368622 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-09 18:28:06.394101 | controller | skipping: Conditional result was False 2025-11-09 18:28:06.421357 | 2025-11-09 18:28:06.421459 | TASK [Run add-build-sshkey role (ECDSA)] 2025-11-09 18:28:06.444808 | controller | ok 2025-11-09 18:28:06.468359 | 2025-11-09 18:28:06.468472 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-09 18:28:06.696574 | controller -> localhost | ok 2025-11-09 18:28:06.702816 | 2025-11-09 18:28:06.702875 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-09 18:28:06.732759 | controller | ok 2025-11-09 18:28:06.743100 | controller | included: /var/lib/zuul/builds/f1d2a2f06c8145369af1284c5b133cb6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-09 18:28:06.748852 | 2025-11-09 18:28:06.748911 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-09 18:28:07.067671 | controller -> localhost | Generating public/private ecdsa key pair. 2025-11-09 18:28:07.067906 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/f1d2a2f06c8145369af1284c5b133cb6/work/f1d2a2f06c8145369af1284c5b133cb6_id_ecdsa. 2025-11-09 18:28:07.067945 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/f1d2a2f06c8145369af1284c5b133cb6/work/f1d2a2f06c8145369af1284c5b133cb6_id_ecdsa.pub. 2025-11-09 18:28:07.067983 | controller -> localhost | The key fingerprint is: 2025-11-09 18:28:07.068010 | controller -> localhost | SHA256:ZjiTLcMoG8TGJ+siCMaumY2sQlTz7E8bx320ixm93KM zuul-build-sshkey 2025-11-09 18:28:07.068069 | controller -> localhost | The key's randomart image is: 2025-11-09 18:28:07.068096 | controller -> localhost | +---[ECDSA 521]---+ 2025-11-09 18:28:07.068120 | controller -> localhost | | | 2025-11-09 18:28:07.068144 | controller -> localhost | | o o | 2025-11-09 18:28:07.068167 | controller -> localhost | | B = | 2025-11-09 18:28:07.068191 | controller -> localhost | |.+ + = + . | 2025-11-09 18:28:07.068214 | controller -> localhost | |oo+ o O S . o . | 2025-11-09 18:28:07.068237 | controller -> localhost | |=o + . X o o + | 2025-11-09 18:28:07.068263 | controller -> localhost | |=.o o + * + | 2025-11-09 18:28:07.068288 | controller -> localhost | |=* o o + o | 2025-11-09 18:28:07.068311 | controller -> localhost | |O.. E. .| 2025-11-09 18:28:07.068333 | controller -> localhost | +----[SHA256]-----+ 2025-11-09 18:28:07.068389 | controller -> localhost | ok: Runtime: 0:00:00.015570 2025-11-09 18:28:07.077316 | 2025-11-09 18:28:07.077399 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-09 18:28:07.110311 | controller | ok 2025-11-09 18:28:07.121449 | controller | included: /var/lib/zuul/builds/f1d2a2f06c8145369af1284c5b133cb6/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-09 18:28:07.133330 | 2025-11-09 18:28:07.133410 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-09 18:28:07.158443 | controller | skipping: Conditional result was False 2025-11-09 18:28:07.167424 | 2025-11-09 18:28:07.167509 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-09 18:28:07.449628 | controller | changed 2025-11-09 18:28:07.461809 | 2025-11-09 18:28:07.461941 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-09 18:28:07.688685 | controller | ok 2025-11-09 18:28:07.695242 | 2025-11-09 18:28:07.695306 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-09 18:28:08.321736 | controller | changed 2025-11-09 18:28:08.335052 | 2025-11-09 18:28:08.335224 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-09 18:28:08.974854 | controller | changed 2025-11-09 18:28:08.988910 | 2025-11-09 18:28:08.989069 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-09 18:28:09.016044 | controller | skipping: Conditional result was False 2025-11-09 18:28:09.030088 | 2025-11-09 18:28:09.030230 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-09 18:28:09.281784 | controller -> localhost | changed 2025-11-09 18:28:09.306648 | 2025-11-09 18:28:09.306792 | TASK [add-build-sshkey : Add back temp key] 2025-11-09 18:28:09.621403 | controller -> localhost | Identity added: /var/lib/zuul/builds/f1d2a2f06c8145369af1284c5b133cb6/work/f1d2a2f06c8145369af1284c5b133cb6_id_ecdsa (zuul-build-sshkey) 2025-11-09 18:28:09.621980 | controller -> localhost | ok: Runtime: 0:00:00.014363 2025-11-09 18:28:09.646505 | 2025-11-09 18:28:09.646682 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-09 18:28:09.859301 | controller | ok 2025-11-09 18:28:09.871502 | 2025-11-09 18:28:09.871794 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-09 18:28:09.909472 | controller | skipping: Conditional result was False 2025-11-09 18:28:09.934912 | 2025-11-09 18:28:09.935075 | TASK [include_role : remove-zuul-sshkey] 2025-11-09 18:28:09.961654 | controller | skipping: Conditional result was False 2025-11-09 18:28:09.979888 | 2025-11-09 18:28:09.980095 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2025-11-09 18:28:10.217075 | controller | ok: "logs" 2025-11-09 18:28:10.217425 | controller | ok: All items complete 2025-11-09 18:28:10.217521 | 2025-11-09 18:28:10.430248 | controller | ok: "artifacts" 2025-11-09 18:28:10.625400 | controller | ok: "docs" 2025-11-09 18:28:10.650870 | 2025-11-09 18:28:10.651128 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2025-11-09 18:28:10.895157 | controller | changed: "logs" 2025-11-09 18:28:11.094744 | controller | changed: "artifacts" 2025-11-09 18:28:11.288923 | controller | changed: "docs" 2025-11-09 18:28:11.372492 | 2025-11-09 18:28:11.372617 | PLAY RECAP 2025-11-09 18:28:11.372673 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2025-11-09 18:28:11.372759 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-11-09 18:28:11.372787 | 2025-11-09 18:28:11.489348 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2025-11-09 18:28:11.490170 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master] 2025-11-09 18:28:12.052325 | 2025-11-09 18:28:12.052437 | PLAY [all] 2025-11-09 18:28:12.072911 | 2025-11-09 18:28:12.073076 | TASK [Setup ensure-tox role] 2025-11-09 18:28:12.095787 | controller | ok 2025-11-09 18:28:12.119564 | 2025-11-09 18:28:12.119718 | TASK [Install pip] 2025-11-09 18:28:12.140052 | controller | ok 2025-11-09 18:28:12.162556 | 2025-11-09 18:28:12.162660 | TASK [ensure-pip : Check if pip is installed] 2025-11-09 18:28:12.540418 | controller | /usr/bin/pip3 2025-11-09 18:28:12.553755 | controller | /usr/bin/python3: No module named wheel 2025-11-09 18:28:12.694392 | controller | ok: Runtime: 0:00:00.022172 2025-11-09 18:28:12.702833 | 2025-11-09 18:28:12.702932 | LOOP [ensure-pip : Install pip from packages] 2025-11-09 18:28:12.750373 | controller | ok: "/var/lib/zuul/builds/f1d2a2f06c8145369af1284c5b133cb6/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml" 2025-11-09 18:28:12.771986 | controller | included: /var/lib/zuul/builds/f1d2a2f06c8145369af1284c5b133cb6/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml 2025-11-09 18:28:12.786243 | 2025-11-09 18:28:12.786403 | TASK [ensure-pip : Install Python 3 pip] 2025-11-09 18:28:17.589580 | controller | changed 2025-11-09 18:28:17.602080 | 2025-11-09 18:28:17.602216 | TASK [ensure-pip : Check for EPEL repository] 2025-11-09 18:28:17.628605 | controller | skipping: Conditional result was False 2025-11-09 18:28:17.643000 | 2025-11-09 18:28:17.643191 | TASK [ensure-pip : Fail with instructions when EPEL is not installed] 2025-11-09 18:28:17.670373 | controller | skipping: Conditional result was False 2025-11-09 18:28:17.684280 | 2025-11-09 18:28:17.684435 | TASK [ensure-pip : Install Python 2 pip] 2025-11-09 18:28:17.710520 | controller | skipping: Conditional result was False 2025-11-09 18:28:17.723876 | 2025-11-09 18:28:17.724052 | TASK [ensure-pip : Ensure setuptools] 2025-11-09 18:28:17.750473 | controller | skipping: Conditional result was False 2025-11-09 18:28:17.764637 | 2025-11-09 18:28:17.764797 | TASK [ensure-pip : Check for ensurepip module] 2025-11-09 18:28:18.313564 | controller | skipping: Conditional result was False 2025-11-09 18:28:18.319822 | 2025-11-09 18:28:18.319886 | TASK [ensure-pip : Ensure python3-venv] 2025-11-09 18:28:18.343511 | controller | skipping: Conditional result was False 2025-11-09 18:28:18.349423 | 2025-11-09 18:28:18.349499 | TASK [ensure-pip : Install pip from source] 2025-11-09 18:28:18.372422 | controller | skipping: Conditional result was False 2025-11-09 18:28:18.378645 | 2025-11-09 18:28:18.378709 | TASK [ensure-pip : Probe for venv python full path] 2025-11-09 18:28:18.694281 | controller | /usr/bin/python3 2025-11-09 18:28:18.910148 | controller | ok: Runtime: 0:00:00.003193 2025-11-09 18:28:18.959433 | 2025-11-09 18:28:18.959602 | TASK [ensure-pip : Set host default] 2025-11-09 18:28:19.038066 | controller | ok 2025-11-09 18:28:19.049638 | 2025-11-09 18:28:19.049817 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2025-11-09 18:28:19.120811 | controller | ok 2025-11-09 18:28:19.143367 | 2025-11-09 18:28:19.143540 | TASK [ensure-tox : Check if tox is installed] 2025-11-09 18:28:19.412285 | controller | /usr/bin/tox 2025-11-09 18:28:19.695608 | controller | ok: Runtime: 0:00:00.003143 2025-11-09 18:28:19.708750 | 2025-11-09 18:28:19.708930 | TASK [ensure-tox : Export preinstalled tox_exectuable] 2025-11-09 18:28:19.759839 | controller | ok 2025-11-09 18:28:19.772109 | 2025-11-09 18:28:19.772260 | TASK [ensure-tox : Create local venv] 2025-11-09 18:28:20.321099 | controller | skipping: Conditional result was False 2025-11-09 18:28:20.335510 | 2025-11-09 18:28:20.335733 | TASK [ensure-tox : Install tox to local venv] 2025-11-09 18:28:20.899764 | controller | skipping: Conditional result was False 2025-11-09 18:28:20.913910 | 2025-11-09 18:28:20.914142 | TASK [ensure-tox : Export installed tox_executable path] 2025-11-09 18:28:20.940571 | controller | skipping: Conditional result was False 2025-11-09 18:28:20.953695 | 2025-11-09 18:28:20.953883 | TASK [ensure-tox : Output tox version] 2025-11-09 18:28:21.340876 | controller | 3.28.0 imported from /usr/lib/python3.11/site-packages/tox/__init__.py 2025-11-09 18:28:21.508423 | controller | ok: Runtime: 0:00:00.147943 2025-11-09 18:28:21.521418 | 2025-11-09 18:28:21.521584 | TASK [ensure-tox : Make global symlink] 2025-11-09 18:28:21.548052 | controller | skipping: Conditional result was False 2025-11-09 18:28:21.571430 | 2025-11-09 18:28:21.571598 | TASK [Setup tox role] 2025-11-09 18:28:21.600243 | controller | ok 2025-11-09 18:28:21.648509 | 2025-11-09 18:28:21.648648 | TASK [tox : Check to see if the constraints file exists] 2025-11-09 18:28:21.683699 | controller | skipping: Conditional result was False 2025-11-09 18:28:21.696092 | 2025-11-09 18:28:21.696233 | TASK [tox : Fail if constraints file is missing] 2025-11-09 18:28:21.732205 | controller | skipping: Conditional result was False 2025-11-09 18:28:21.745326 | 2025-11-09 18:28:21.745514 | TASK [tox : Record file location] 2025-11-09 18:28:21.782046 | controller | skipping: Conditional result was False 2025-11-09 18:28:21.794634 | 2025-11-09 18:28:21.794798 | TASK [tox : Install tox siblings] 2025-11-09 18:28:21.820807 | controller | skipping: Conditional result was False 2025-11-09 18:28:21.833910 | 2025-11-09 18:28:21.834108 | TASK [tox : Emit tox command] 2025-11-09 18:28:21.895851 | /usr/bin/tox -evenv -vv --notest 2025-11-09 18:28:21.907145 | 2025-11-09 18:28:21.907280 | TASK [tox : Run tox] 2025-11-09 18:28:22.286875 | controller | using tox.ini: /home/zuul/src/github.com/ansible-network/releases/tox.ini (pid 2295) 2025-11-09 18:28:22.293961 | controller | using tox-3.28.0 from /usr/lib/python3.11/site-packages/tox/__init__.py (pid 2295) 2025-11-09 18:28:22.315354 | controller | skipping sdist step 2025-11-09 18:28:22.315373 | controller | venv uses /usr/bin/python3 2025-11-09 18:28:22.315390 | controller | venv start: getenv /home/zuul/src/github.com/ansible-network/releases/.tox/venv 2025-11-09 18:28:22.315563 | controller | venv cannot reuse: no previous config /home/zuul/src/github.com/ansible-network/releases/.tox/venv/.tox-config1 2025-11-09 18:28:22.315576 | controller | venv create: /home/zuul/src/github.com/ansible-network/releases/.tox/venv 2025-11-09 18:28:22.315584 | 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 18:28:22.315593 | controller | [2303] /home/zuul/src/github.com/ansible-network/releases/.tox$ /usr/bin/python3 -m virtualenv --no-download --python /usr/bin/python3 venv 2025-11-09 18:28:22.846605 | controller | created virtual environment CPython3.11.0.final.0-64 in 450ms 2025-11-09 18:28:22.864169 | 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 18:28:22.864202 | 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 18:28:22.864213 | controller | added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1 2025-11-09 18:28:22.864218 | controller | activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator 2025-11-09 18:28:22.864230 | 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 18:28:22.864583 | 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 18:28:22.864599 | controller | [2311] /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 18:28:24.212500 | controller | Collecting ruamel.yaml 2025-11-09 18:28:24.254529 | controller | Downloading ruamel.yaml-0.18.16-py3-none-any.whl (119 kB) 2025-11-09 18:28:24.275752 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 119.9/119.9 kB 6.4 MB/s eta 0:00:00 2025-11-09 18:28:24.326249 | controller | Collecting pbr 2025-11-09 18:28:24.330796 | controller | Downloading pbr-7.0.3-py2.py3-none-any.whl (131 kB) 2025-11-09 18:28:24.341465 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 131.9/131.9 kB 15.4 MB/s eta 0:00:00 2025-11-09 18:28:24.377123 | controller | Collecting tweepy 2025-11-09 18:28:24.381572 | controller | Downloading tweepy-4.16.0-py3-none-any.whl (98 kB) 2025-11-09 18:28:24.393436 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.8/98.8 kB 12.6 MB/s eta 0:00:00 2025-11-09 18:28:24.437520 | controller | Collecting galaxy-importer 2025-11-09 18:28:24.445372 | controller | Downloading galaxy_importer-0.4.34-py3-none-any.whl (64 kB) 2025-11-09 18:28:24.453767 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 64.8/64.8 kB 8.9 MB/s eta 0:00:00 2025-11-09 18:28:24.503805 | controller | Collecting flake8 2025-11-09 18:28:24.509714 | controller | Downloading flake8-7.3.0-py2.py3-none-any.whl (57 kB) 2025-11-09 18:28:24.517897 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 57.9/57.9 kB 8.0 MB/s eta 0:00:00 2025-11-09 18:28:24.615597 | controller | Collecting ruamel.yaml.clib>=0.2.7 2025-11-09 18:28:24.619712 | controller | Downloading ruamel.yaml.clib-0.2.14-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (738 kB) 2025-11-09 18:28:24.634751 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 738.1/738.1 kB 59.7 MB/s eta 0:00:00 2025-11-09 18:28:24.640039 | 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-11-09 18:28:24.686170 | controller | Collecting oauthlib<4,>=3.2.0 2025-11-09 18:28:24.689201 | controller | Downloading oauthlib-3.3.1-py3-none-any.whl (160 kB) 2025-11-09 18:28:24.700049 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 160.1/160.1 kB 21.2 MB/s eta 0:00:00 2025-11-09 18:28:24.762294 | controller | Collecting requests<3,>=2.27.0 2025-11-09 18:28:24.765568 | controller | Downloading requests-2.32.5-py3-none-any.whl (64 kB) 2025-11-09 18:28:24.774086 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 64.7/64.7 kB 8.8 MB/s eta 0:00:00 2025-11-09 18:28:24.809389 | controller | Collecting requests-oauthlib<3,>=1.2.0 2025-11-09 18:28:24.812940 | controller | Downloading requests_oauthlib-2.0.0-py2.py3-none-any.whl (24 kB) 2025-11-09 18:28:24.974002 | controller | Collecting ansible-core 2025-11-09 18:28:24.978822 | controller | Downloading ansible_core-2.19.4-py3-none-any.whl (2.4 MB) 2025-11-09 18:28:25.010136 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.4/2.4 MB 83.4 MB/s eta 0:00:00 2025-11-09 18:28:25.071599 | controller | Collecting ansible-builder<4.0,>=1.2.0 2025-11-09 18:28:25.076569 | controller | Downloading ansible_builder-3.1.1-py3-none-any.whl (46 kB) 2025-11-09 18:28:25.085492 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 46.5/46.5 kB 5.5 MB/s eta 0:00:00 2025-11-09 18:28:25.215733 | controller | Collecting ansible-lint<=25.8.2,>=6.2.2 2025-11-09 18:28:25.221484 | controller | Downloading ansible_lint-25.8.2-py3-none-any.whl (328 kB) 2025-11-09 18:28:25.233512 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 328.7/328.7 kB 34.7 MB/s eta 0:00:00 2025-11-09 18:28:25.273329 | controller | Collecting attrs<23,>=21.4.0 2025-11-09 18:28:25.277450 | controller | Downloading attrs-22.2.0-py3-none-any.whl (60 kB) 2025-11-09 18:28:25.285847 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 60.0/60.0 kB 7.9 MB/s eta 0:00:00 2025-11-09 18:28:25.410362 | controller | Collecting nh3<3,>=0.2.18 2025-11-09 18:28:25.414937 | controller | Downloading nh3-0.3.2-cp38-abi3-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (797 kB) 2025-11-09 18:28:25.428759 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 797.2/797.2 kB 70.2 MB/s eta 0:00:00 2025-11-09 18:28:25.448965 | controller | Collecting flake8 2025-11-09 18:28:25.453479 | controller | Downloading flake8-6.1.0-py2.py3-none-any.whl (58 kB) 2025-11-09 18:28:25.461681 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 58.3/58.3 kB 7.5 MB/s eta 0:00:00 2025-11-09 18:28:25.503757 | controller | Collecting markdown<4,>=3.3.4 2025-11-09 18:28:25.510712 | controller | Downloading markdown-3.10-py3-none-any.whl (107 kB) 2025-11-09 18:28:25.520390 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 107.7/107.7 kB 13.8 MB/s eta 0:00:00 2025-11-09 18:28:25.647674 | controller | Collecting pyyaml<7,>=5.4.1 2025-11-09 18:28:25.653432 | 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-11-09 18:28:25.667030 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 806.6/806.6 kB 74.5 MB/s eta 0:00:00 2025-11-09 18:28:25.718865 | controller | Collecting semantic-version<3,>=2.9.0 2025-11-09 18:28:25.723796 | controller | Downloading semantic_version-2.10.0-py2.py3-none-any.whl (15 kB) 2025-11-09 18:28:25.772434 | controller | Collecting packaging<25.0,>=23.2 2025-11-09 18:28:25.777358 | controller | Downloading packaging-24.2-py3-none-any.whl (65 kB) 2025-11-09 18:28:25.785427 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 65.5/65.5 kB 9.1 MB/s eta 0:00:00 2025-11-09 18:28:25.814085 | controller | Collecting mccabe<0.8.0,>=0.7.0 2025-11-09 18:28:25.819774 | controller | Downloading mccabe-0.7.0-py2.py3-none-any.whl (7.3 kB) 2025-11-09 18:28:25.854031 | controller | Collecting pycodestyle<2.12.0,>=2.11.0 2025-11-09 18:28:25.858476 | controller | Downloading pycodestyle-2.11.1-py2.py3-none-any.whl (31 kB) 2025-11-09 18:28:25.909067 | controller | Collecting pyflakes<3.2.0,>=3.1.0 2025-11-09 18:28:25.914317 | controller | Downloading pyflakes-3.1.0-py2.py3-none-any.whl (62 kB) 2025-11-09 18:28:25.922781 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 62.6/62.6 kB 8.5 MB/s eta 0:00:00 2025-11-09 18:28:25.966058 | controller | Collecting bindep 2025-11-09 18:33:00.655121 | [Zuul] Log Stream did not terminate 2025-11-09 18:33:00.655454 | controller | ERROR 2025-11-09 18:33:00.655620 | controller | { 2025-11-09 18:33:00.655692 | controller | "msg": "Data could not be sent to remote host \"199.204.45.216\". Make sure this host can be reached over ssh: ssh: connect to host 199.204.45.216 port 22: No route to host\r\n", 2025-11-09 18:33:00.655752 | controller | "unreachable": true 2025-11-09 18:33:00.655794 | controller | } unreachable 2025-11-09 18:33:00.657948 | 2025-11-09 18:33:00.658087 | PLAY RECAP 2025-11-09 18:33:00.658174 | controller | ok: 10 changed: 5 unreachable: 1 failed: 0 skipped: 15 rescued: 0 ignored: 0 2025-11-09 18:33:00.658220 | 2025-11-09 18:33:00.775950 | PRE-RUN END RESULT_UNREACHABLE: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master] 2025-11-09 18:33:00.776984 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2025-11-09 18:33:01.369119 | 2025-11-09 18:33:01.369243 | PLAY [all:!appliance*] 2025-11-09 18:33:01.391692 | 2025-11-09 18:33:01.391825 | TASK [unregister the node] 2025-11-09 18:33:04.041684 | [controller] Waiting on logger 2025-11-09 18:33:26.654845 | controller | skipping: Conditional result was False 2025-11-09 18:33:26.669330 | 2025-11-09 18:33:26.669549 | TASK [include_role : fetch-output] 2025-11-09 18:33:26.711566 | controller | ok 2025-11-09 18:33:26.753094 | 2025-11-09 18:33:26.753231 | TASK [fetch-output : Set log path for multiple nodes] 2025-11-09 18:33:26.809785 | controller | skipping: Conditional result was False 2025-11-09 18:33:26.825481 | 2025-11-09 18:33:26.825633 | TASK [fetch-output : Set log path for single node] 2025-11-09 18:33:26.873916 | controller | ok 2025-11-09 18:33:26.886783 | 2025-11-09 18:33:26.886982 | LOOP [fetch-output : Ensure local output dirs] 2025-11-09 18:33:27.346473 | controller -> localhost | ok: "/var/lib/zuul/builds/f1d2a2f06c8145369af1284c5b133cb6/work/logs" 2025-11-09 18:33:27.635733 | controller -> localhost | changed: "/var/lib/zuul/builds/f1d2a2f06c8145369af1284c5b133cb6/work/artifacts" 2025-11-09 18:33:27.954279 | controller -> localhost | changed: "/var/lib/zuul/builds/f1d2a2f06c8145369af1284c5b133cb6/work/docs" 2025-11-09 18:33:27.980761 | 2025-11-09 18:33:27.980987 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-11-09 18:33:28.754473 | controller | changed: .d..t...... ./ 2025-11-09 18:33:28.754878 | controller | changed: All items complete 2025-11-09 18:33:28.754934 | 2025-11-09 18:33:29.297688 | controller | changed: .d..t...... ./ 2025-11-09 18:33:29.832287 | controller | changed: .d..t...... ./ 2025-11-09 18:33:29.861226 | 2025-11-09 18:33:29.861454 | TASK [include_role : fetch-output-openshift] 2025-11-09 18:33:29.887871 | controller | skipping: Conditional result was False 2025-11-09 18:33:29.898323 | 2025-11-09 18:33:29.898435 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2025-11-09 18:33:30.380639 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.007373 2025-11-09 18:33:30.606078 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.013468 2025-11-09 18:33:30.668143 | 2025-11-09 18:33:30.668284 | PLAY [localhost] 2025-11-09 18:33:30.687663 | 2025-11-09 18:33:30.687757 | TASK [Run Zuul manifest role] 2025-11-09 18:33:30.709131 | localhost | ok 2025-11-09 18:33:30.728712 | 2025-11-09 18:33:30.728815 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-11-09 18:33:31.161543 | localhost | changed 2025-11-09 18:33:31.171219 | 2025-11-09 18:33:31.171348 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-11-09 18:33:31.206459 | localhost | ok 2025-11-09 18:33:31.223589 | 2025-11-09 18:33:31.223707 | TASK [Set zuul-log-path fact] 2025-11-09 18:33:31.249786 | localhost | ok 2025-11-09 18:33:31.272881 | 2025-11-09 18:33:31.272971 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-09 18:33:31.303443 | localhost | ok 2025-11-09 18:33:31.314972 | 2025-11-09 18:33:31.315122 | LOOP [Run upload-logs-swift role] 2025-11-09 18:33:31.353388 | localhost | Output suppressed because no_log was given 2025-11-09 18:33:31.390911 | 2025-11-09 18:33:31.391069 | TASK [Set zuul-log-path fact] 2025-11-09 18:33:31.447327 | localhost | skipping: Conditional result was False 2025-11-09 18:33:31.495524 | 2025-11-09 18:33:31.495673 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2025-11-09 18:33:31.745798 | localhost -> localhost | ok: Runtime: 0:00:00.005233 2025-11-09 18:33:31.756561 | 2025-11-09 18:33:31.756687 | TASK [upload-logs-swift : Upload logs to swift]