2026-01-15 16:37:29.509183 | Job console starting... 2026-01-15 16:37:29.521327 | Updating repositories 2026-01-15 16:37:29.588289 | Preparing job workspace 2026-01-15 16:37:33.645894 | Running Ansible setup... 2026-01-15 16:37:38.540227 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-01-15 16:37:39.189589 | 2026-01-15 16:37:39.189769 | PLAY [localhost] 2026-01-15 16:37:39.199096 | 2026-01-15 16:37:39.199198 | TASK [Gathering Facts] 2026-01-15 16:37:40.291799 | localhost | ok 2026-01-15 16:37:40.320488 | 2026-01-15 16:37:40.320746 | TASK [Setup log path fact] 2026-01-15 16:37:40.346767 | localhost | ok 2026-01-15 16:37:40.372099 | 2026-01-15 16:37:40.372232 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-15 16:37:40.413524 | localhost | ok 2026-01-15 16:37:40.424722 | 2026-01-15 16:37:40.424823 | TASK [emit-job-header : Print job information] 2026-01-15 16:37:40.475626 | # Job Information 2026-01-15 16:37:40.475885 | Ansible Version: 2.15.12 2026-01-15 16:37:40.475929 | Job: ansible-galaxy-importer 2026-01-15 16:37:40.475959 | Pipeline: gate 2026-01-15 16:37:40.475986 | Executor: ze02.softwarefactory-project.io 2026-01-15 16:37:40.476012 | Triggered by: https://github.com/ansible-collections/community.vmware/pull/2532 2026-01-15 16:37:40.476042 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/97b/ansible/97b70da4204b4fe382e6b1ae032686fe/ 2026-01-15 16:37:40.476070 | Event ID: 4aefe050-f22d-11f0-856c-619f70a824b5 2026-01-15 16:37:40.481594 | 2026-01-15 16:37:40.481705 | LOOP [emit-job-header : Print node information] 2026-01-15 16:37:40.602306 | localhost | ok: 2026-01-15 16:37:40.602624 | localhost | # Node Information 2026-01-15 16:37:40.602716 | localhost | Inventory Hostname: controller 2026-01-15 16:37:40.602761 | localhost | Hostname: np0005585127 2026-01-15 16:37:40.602802 | localhost | Username: zuul 2026-01-15 16:37:40.602847 | localhost | Distro: Fedora 37 2026-01-15 16:37:40.602886 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2026-01-15 16:37:40.602923 | localhost | Region: ca-ymq-1 2026-01-15 16:37:40.602959 | localhost | Label: ansible-fedora-37-1vcpu 2026-01-15 16:37:40.602995 | localhost | Product Name: OpenStack Nova 2026-01-15 16:37:40.603030 | localhost | Interface IP: 162.253.55.250 2026-01-15 16:37:40.627635 | 2026-01-15 16:37:40.627876 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-01-15 16:37:41.072874 | localhost -> localhost | changed 2026-01-15 16:37:41.085948 | 2026-01-15 16:37:41.086232 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-01-15 16:37:41.973384 | localhost -> localhost | changed 2026-01-15 16:37:42.016904 | 2026-01-15 16:37:42.017058 | PLAY [all:!appliance*] 2026-01-15 16:37:42.046338 | 2026-01-15 16:37:42.047217 | TASK [include_role : start-zuul-console] 2026-01-15 16:37:42.075476 | controller | ok 2026-01-15 16:37:42.100389 | 2026-01-15 16:37:42.100615 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-01-15 16:37:42.480948 | controller | ok 2026-01-15 16:37:42.495229 | 2026-01-15 16:37:42.495318 | TASK [use-our-mirror : Retrieve the IP address] 2026-01-15 16:37:43.545495 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2026-01-15 16:37:43.559821 | 2026-01-15 16:37:43.559973 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2026-01-15 16:37:44.111795 | controller | skipping: Conditional result was False 2026-01-15 16:37:44.129798 | 2026-01-15 16:37:44.129986 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2026-01-15 16:37:44.156933 | controller | skipping: Conditional result was False 2026-01-15 16:37:44.171644 | 2026-01-15 16:37:44.171849 | TASK [use-our-mirror : Create the podman configuration directory] 2026-01-15 16:37:44.200348 | controller | skipping: Conditional result was False 2026-01-15 16:37:44.213944 | 2026-01-15 16:37:44.214083 | TASK [use-our-mirror : Copy the podman configuration] 2026-01-15 16:37:44.240953 | controller | skipping: Conditional result was False 2026-01-15 16:37:44.254274 | 2026-01-15 16:37:44.254405 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2026-01-15 16:37:44.282164 | controller | skipping: Conditional result was False 2026-01-15 16:37:44.295925 | 2026-01-15 16:37:44.296097 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2026-01-15 16:37:44.323067 | controller | skipping: Conditional result was False 2026-01-15 16:37:44.348893 | 2026-01-15 16:37:44.349023 | TASK [Disable Fedora Modular] 2026-01-15 16:37:44.611214 | controller | changed 2026-01-15 16:37:44.624371 | 2026-01-15 16:37:44.624508 | TASK [Enable EPEL] 2026-01-15 16:37:44.652692 | controller | skipping: Conditional result was False 2026-01-15 16:37:44.666550 | 2026-01-15 16:37:44.666734 | TASK [Register the RHEL node] 2026-01-15 16:37:45.233161 | 2026-01-15 16:37:45.233466 | TASK [Show the subscription-manager status] 2026-01-15 16:37:45.827082 | controller | skipping: Conditional result was False 2026-01-15 16:37:45.842536 | 2026-01-15 16:37:45.842749 | TASK [Enable EPEL on RHEL] 2026-01-15 16:37:46.401779 | controller | skipping: Conditional result was False 2026-01-15 16:37:46.416308 | 2026-01-15 16:37:46.416454 | TASK [Install git and tox] 2026-01-15 16:39:05.320393 | controller | changed 2026-01-15 16:39:05.335993 | 2026-01-15 16:39:05.336175 | TASK [include_role : prepare-workspace] 2026-01-15 16:39:05.370880 | controller | ok 2026-01-15 16:39:05.403992 | 2026-01-15 16:39:05.404164 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-01-15 16:39:05.647353 | controller | ok 2026-01-15 16:39:05.660803 | 2026-01-15 16:39:05.660950 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-01-15 16:39:07.117946 | controller | Output suppressed because no_log was given 2026-01-15 16:39:07.140199 | 2026-01-15 16:39:07.140285 | TASK [include_role : prepare-workspace-openshift] 2026-01-15 16:39:07.166230 | controller | skipping: Conditional result was False 2026-01-15 16:39:07.198046 | 2026-01-15 16:39:07.198158 | PLAY [all:!appliance] 2026-01-15 16:39:07.219442 | 2026-01-15 16:39:07.219526 | TASK [Run add-build-sshkey role (RSA)] 2026-01-15 16:39:07.241505 | controller | ok 2026-01-15 16:39:07.256757 | 2026-01-15 16:39:07.256826 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-15 16:39:07.483756 | controller -> localhost | ok 2026-01-15 16:39:07.490636 | 2026-01-15 16:39:07.490740 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-15 16:39:07.511256 | controller | ok 2026-01-15 16:39:07.525216 | controller | included: /var/lib/zuul/builds/97b70da4204b4fe382e6b1ae032686fe/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-15 16:39:07.531057 | 2026-01-15 16:39:07.531117 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-15 16:39:08.074346 | controller -> localhost | Generating public/private rsa key pair. 2026-01-15 16:39:08.074565 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/97b70da4204b4fe382e6b1ae032686fe/work/97b70da4204b4fe382e6b1ae032686fe_id_rsa. 2026-01-15 16:39:08.074596 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/97b70da4204b4fe382e6b1ae032686fe/work/97b70da4204b4fe382e6b1ae032686fe_id_rsa.pub. 2026-01-15 16:39:08.074618 | controller -> localhost | The key fingerprint is: 2026-01-15 16:39:08.074637 | controller -> localhost | SHA256:IBhjiC/gyk5+Yn6egI9M9entCMNzbCkoctouvYq/3bE zuul-build-sshkey 2026-01-15 16:39:08.074658 | controller -> localhost | The key's randomart image is: 2026-01-15 16:39:08.074705 | controller -> localhost | +---[RSA 2048]----+ 2026-01-15 16:39:08.074733 | controller -> localhost | |..+ | 2026-01-15 16:39:08.074754 | controller -> localhost | |+. + | 2026-01-15 16:39:08.074772 | controller -> localhost | |o.. . . | 2026-01-15 16:39:08.074789 | controller -> localhost | |... . . | 2026-01-15 16:39:08.074807 | controller -> localhost | |o. . S | 2026-01-15 16:39:08.074833 | controller -> localhost | |oo+ o o | 2026-01-15 16:39:08.074855 | controller -> localhost | |B=.* B. | 2026-01-15 16:39:08.074874 | controller -> localhost | |B@o+X.oo | 2026-01-15 16:39:08.074891 | controller -> localhost | |BB%=.oEo | 2026-01-15 16:39:08.074911 | controller -> localhost | +----[SHA256]-----+ 2026-01-15 16:39:08.074960 | controller -> localhost | ok: Runtime: 0:00:00.111139 2026-01-15 16:39:08.112622 | 2026-01-15 16:39:08.112773 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-15 16:39:08.134292 | controller | ok 2026-01-15 16:39:08.144344 | controller | included: /var/lib/zuul/builds/97b70da4204b4fe382e6b1ae032686fe/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-15 16:39:08.153244 | 2026-01-15 16:39:08.153311 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-15 16:39:08.167415 | controller | skipping: Conditional result was False 2026-01-15 16:39:08.175200 | 2026-01-15 16:39:08.175274 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-15 16:39:08.546240 | controller | changed 2026-01-15 16:39:08.553950 | 2026-01-15 16:39:08.554032 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-15 16:39:08.784778 | controller | ok 2026-01-15 16:39:08.797166 | 2026-01-15 16:39:08.797300 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-15 16:39:09.458221 | controller | changed 2026-01-15 16:39:09.473225 | 2026-01-15 16:39:09.473405 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-15 16:39:10.144340 | controller | changed 2026-01-15 16:39:10.156878 | 2026-01-15 16:39:10.157006 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-15 16:39:10.184047 | controller | skipping: Conditional result was False 2026-01-15 16:39:10.199155 | 2026-01-15 16:39:10.199292 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-15 16:39:10.583754 | controller -> localhost | changed 2026-01-15 16:39:10.596322 | 2026-01-15 16:39:10.596388 | TASK [add-build-sshkey : Add back temp key] 2026-01-15 16:39:10.894413 | controller -> localhost | Identity added: /var/lib/zuul/builds/97b70da4204b4fe382e6b1ae032686fe/work/97b70da4204b4fe382e6b1ae032686fe_id_rsa (zuul-build-sshkey) 2026-01-15 16:39:10.894625 | controller -> localhost | ok: Runtime: 0:00:00.013035 2026-01-15 16:39:10.901277 | 2026-01-15 16:39:10.901337 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-15 16:39:11.234341 | controller | ok 2026-01-15 16:39:11.246180 | 2026-01-15 16:39:11.246311 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-15 16:39:11.284316 | controller | skipping: Conditional result was False 2026-01-15 16:39:11.310400 | 2026-01-15 16:39:11.310528 | TASK [Run add-build-sshkey role (ECDSA)] 2026-01-15 16:39:11.349758 | controller | ok 2026-01-15 16:39:11.379719 | 2026-01-15 16:39:11.379826 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-01-15 16:39:11.660021 | controller -> localhost | ok 2026-01-15 16:39:11.673803 | 2026-01-15 16:39:11.673937 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-01-15 16:39:11.723554 | controller | ok 2026-01-15 16:39:11.748936 | controller | included: /var/lib/zuul/builds/97b70da4204b4fe382e6b1ae032686fe/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-01-15 16:39:11.758211 | 2026-01-15 16:39:11.758294 | TASK [add-build-sshkey : Create Temp SSH key] 2026-01-15 16:39:12.111152 | controller -> localhost | Generating public/private ecdsa key pair. 2026-01-15 16:39:12.111582 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/97b70da4204b4fe382e6b1ae032686fe/work/97b70da4204b4fe382e6b1ae032686fe_id_ecdsa. 2026-01-15 16:39:12.111643 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/97b70da4204b4fe382e6b1ae032686fe/work/97b70da4204b4fe382e6b1ae032686fe_id_ecdsa.pub. 2026-01-15 16:39:12.111743 | controller -> localhost | The key fingerprint is: 2026-01-15 16:39:12.111791 | controller -> localhost | SHA256:sNSDygGiICPP4psU4uxN+jnhqL8GvgXkP1gsxQaXQDU zuul-build-sshkey 2026-01-15 16:39:12.111832 | controller -> localhost | The key's randomart image is: 2026-01-15 16:39:12.111871 | controller -> localhost | +---[ECDSA 521]---+ 2026-01-15 16:39:12.111911 | controller -> localhost | |B++E. | 2026-01-15 16:39:12.111948 | controller -> localhost | |==+o. o | 2026-01-15 16:39:12.111986 | controller -> localhost | |+oo+. + o | 2026-01-15 16:39:12.112022 | controller -> localhost | |B.=. + o . | 2026-01-15 16:39:12.112062 | controller -> localhost | | O +o . S | 2026-01-15 16:39:12.112098 | controller -> localhost | |+ %. | 2026-01-15 16:39:12.112134 | controller -> localhost | |.Bo=. | 2026-01-15 16:39:12.112170 | controller -> localhost | | o+oo | 2026-01-15 16:39:12.112205 | controller -> localhost | |o+++. | 2026-01-15 16:39:12.112241 | controller -> localhost | +----[SHA256]-----+ 2026-01-15 16:39:12.112347 | controller -> localhost | ok: Runtime: 0:00:00.017650 2026-01-15 16:39:12.126855 | 2026-01-15 16:39:12.126982 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-01-15 16:39:12.177081 | controller | ok 2026-01-15 16:39:12.193986 | controller | included: /var/lib/zuul/builds/97b70da4204b4fe382e6b1ae032686fe/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-01-15 16:39:12.210781 | 2026-01-15 16:39:12.210868 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-01-15 16:39:12.238240 | controller | skipping: Conditional result was False 2026-01-15 16:39:12.248227 | 2026-01-15 16:39:12.248348 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-01-15 16:39:12.553217 | controller | changed 2026-01-15 16:39:12.565635 | 2026-01-15 16:39:12.565801 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-01-15 16:39:12.799371 | controller | ok 2026-01-15 16:39:12.809120 | 2026-01-15 16:39:12.809217 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-01-15 16:39:13.482782 | controller | changed 2026-01-15 16:39:13.497003 | 2026-01-15 16:39:13.497146 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-01-15 16:39:14.150533 | controller | changed 2026-01-15 16:39:14.164363 | 2026-01-15 16:39:14.164492 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-01-15 16:39:14.192798 | controller | skipping: Conditional result was False 2026-01-15 16:39:14.208902 | 2026-01-15 16:39:14.209046 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-01-15 16:39:14.505444 | controller -> localhost | changed 2026-01-15 16:39:14.532045 | 2026-01-15 16:39:14.532189 | TASK [add-build-sshkey : Add back temp key] 2026-01-15 16:39:14.866258 | controller -> localhost | Identity added: /var/lib/zuul/builds/97b70da4204b4fe382e6b1ae032686fe/work/97b70da4204b4fe382e6b1ae032686fe_id_ecdsa (zuul-build-sshkey) 2026-01-15 16:39:14.866754 | controller -> localhost | ok: Runtime: 0:00:00.014198 2026-01-15 16:39:14.881414 | 2026-01-15 16:39:14.881562 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-01-15 16:39:15.090873 | controller | ok 2026-01-15 16:39:15.096240 | 2026-01-15 16:39:15.096312 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-01-15 16:39:15.121387 | controller | skipping: Conditional result was False 2026-01-15 16:39:15.132615 | 2026-01-15 16:39:15.132695 | TASK [include_role : remove-zuul-sshkey] 2026-01-15 16:39:15.146353 | controller | skipping: Conditional result was False 2026-01-15 16:39:15.153606 | 2026-01-15 16:39:15.153698 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-01-15 16:39:15.368746 | controller | ok: "logs" 2026-01-15 16:39:15.369236 | controller | ok: All items complete 2026-01-15 16:39:15.369296 | 2026-01-15 16:39:15.558712 | controller | ok: "artifacts" 2026-01-15 16:39:15.755270 | controller | ok: "docs" 2026-01-15 16:39:15.777996 | 2026-01-15 16:39:15.778395 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-01-15 16:39:16.031791 | controller | changed: "logs" 2026-01-15 16:39:16.215606 | controller | changed: "artifacts" 2026-01-15 16:39:16.399999 | controller | changed: "docs" 2026-01-15 16:39:16.491720 | 2026-01-15 16:39:16.491884 | PLAY RECAP 2026-01-15 16:39:16.491943 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2026-01-15 16:39:16.491979 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-01-15 16:39:16.492004 | 2026-01-15 16:39:16.623162 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-01-15 16:39:16.624495 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master] 2026-01-15 16:39:17.162570 | 2026-01-15 16:39:17.162761 | PLAY [all] 2026-01-15 16:39:17.183983 | 2026-01-15 16:39:17.184056 | TASK [Setup ensure-tox role] 2026-01-15 16:39:17.204988 | controller | ok 2026-01-15 16:39:17.228312 | 2026-01-15 16:39:17.228390 | TASK [Install pip] 2026-01-15 16:39:17.247067 | controller | ok 2026-01-15 16:39:17.268602 | 2026-01-15 16:39:17.268688 | TASK [ensure-pip : Check if pip is installed] 2026-01-15 16:39:17.661314 | controller | /usr/bin/pip3 2026-01-15 16:39:17.676841 | controller | /usr/bin/python3: No module named wheel 2026-01-15 16:39:17.800541 | controller | ok: Runtime: 0:00:00.023159 2026-01-15 16:39:17.813945 | 2026-01-15 16:39:17.814089 | LOOP [ensure-pip : Install pip from packages] 2026-01-15 16:39:17.865423 | controller | ok: "/var/lib/zuul/builds/97b70da4204b4fe382e6b1ae032686fe/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml" 2026-01-15 16:39:17.893709 | controller | included: /var/lib/zuul/builds/97b70da4204b4fe382e6b1ae032686fe/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml 2026-01-15 16:39:17.915533 | 2026-01-15 16:39:17.915715 | TASK [ensure-pip : Install Python 3 pip] 2026-01-15 16:39:22.776471 | controller | changed 2026-01-15 16:39:22.795717 | 2026-01-15 16:39:22.795923 | TASK [ensure-pip : Check for EPEL repository] 2026-01-15 16:39:22.815481 | controller | skipping: Conditional result was False 2026-01-15 16:39:22.831353 | 2026-01-15 16:39:22.831521 | TASK [ensure-pip : Fail with instructions when EPEL is not installed] 2026-01-15 16:39:22.860016 | controller | skipping: Conditional result was False 2026-01-15 16:39:22.874526 | 2026-01-15 16:39:22.874731 | TASK [ensure-pip : Install Python 2 pip] 2026-01-15 16:39:22.902092 | controller | skipping: Conditional result was False 2026-01-15 16:39:22.915707 | 2026-01-15 16:39:22.915898 | TASK [ensure-pip : Ensure setuptools] 2026-01-15 16:39:22.943729 | controller | skipping: Conditional result was False 2026-01-15 16:39:22.957598 | 2026-01-15 16:39:22.957768 | TASK [ensure-pip : Check for ensurepip module] 2026-01-15 16:39:23.506067 | controller | skipping: Conditional result was False 2026-01-15 16:39:23.520001 | 2026-01-15 16:39:23.520162 | TASK [ensure-pip : Ensure python3-venv] 2026-01-15 16:39:23.547327 | controller | skipping: Conditional result was False 2026-01-15 16:39:23.562182 | 2026-01-15 16:39:23.562321 | TASK [ensure-pip : Install pip from source] 2026-01-15 16:39:23.589776 | controller | skipping: Conditional result was False 2026-01-15 16:39:23.604096 | 2026-01-15 16:39:23.604232 | TASK [ensure-pip : Probe for venv python full path] 2026-01-15 16:39:23.986649 | controller | /usr/bin/python3 2026-01-15 16:39:24.152773 | controller | ok: Runtime: 0:00:00.006603 2026-01-15 16:39:24.186543 | 2026-01-15 16:39:24.186698 | TASK [ensure-pip : Set host default] 2026-01-15 16:39:24.238736 | controller | ok 2026-01-15 16:39:24.246189 | 2026-01-15 16:39:24.246287 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2026-01-15 16:39:24.301802 | controller | ok 2026-01-15 16:39:24.315611 | 2026-01-15 16:39:24.315720 | TASK [ensure-tox : Check if tox is installed] 2026-01-15 16:39:24.579247 | controller | /usr/bin/tox 2026-01-15 16:39:24.856080 | controller | ok: Runtime: 0:00:00.003170 2026-01-15 16:39:24.868079 | 2026-01-15 16:39:24.868208 | TASK [ensure-tox : Export preinstalled tox_exectuable] 2026-01-15 16:39:24.918292 | controller | ok 2026-01-15 16:39:24.929728 | 2026-01-15 16:39:24.929890 | TASK [ensure-tox : Create local venv] 2026-01-15 16:39:25.479125 | controller | skipping: Conditional result was False 2026-01-15 16:39:25.492309 | 2026-01-15 16:39:25.492448 | TASK [ensure-tox : Install tox to local venv] 2026-01-15 16:39:26.054134 | controller | skipping: Conditional result was False 2026-01-15 16:39:26.067581 | 2026-01-15 16:39:26.067777 | TASK [ensure-tox : Export installed tox_executable path] 2026-01-15 16:39:26.094623 | controller | skipping: Conditional result was False 2026-01-15 16:39:26.108748 | 2026-01-15 16:39:26.108909 | TASK [ensure-tox : Output tox version] 2026-01-15 16:39:26.491986 | controller | 3.28.0 imported from /usr/lib/python3.11/site-packages/tox/__init__.py 2026-01-15 16:39:26.723870 | controller | ok: Runtime: 0:00:00.137844 2026-01-15 16:39:26.736086 | 2026-01-15 16:39:26.736222 | TASK [ensure-tox : Make global symlink] 2026-01-15 16:39:26.763418 | controller | skipping: Conditional result was False 2026-01-15 16:39:26.787618 | 2026-01-15 16:39:26.787783 | TASK [Setup tox role] 2026-01-15 16:39:26.818253 | controller | ok 2026-01-15 16:39:26.862257 | 2026-01-15 16:39:26.862374 | TASK [tox : Check to see if the constraints file exists] 2026-01-15 16:39:26.898471 | controller | skipping: Conditional result was False 2026-01-15 16:39:26.911326 | 2026-01-15 16:39:26.911461 | TASK [tox : Fail if constraints file is missing] 2026-01-15 16:39:26.949017 | controller | skipping: Conditional result was False 2026-01-15 16:39:26.962557 | 2026-01-15 16:39:26.962722 | TASK [tox : Record file location] 2026-01-15 16:39:27.001273 | controller | skipping: Conditional result was False 2026-01-15 16:39:27.014524 | 2026-01-15 16:39:27.014659 | TASK [tox : Install tox siblings] 2026-01-15 16:39:27.042145 | controller | skipping: Conditional result was False 2026-01-15 16:39:27.057344 | 2026-01-15 16:39:27.057501 | TASK [tox : Emit tox command] 2026-01-15 16:39:27.121780 | /usr/bin/tox -evenv -vv --notest 2026-01-15 16:39:27.133210 | 2026-01-15 16:39:27.133349 | TASK [tox : Run tox] 2026-01-15 16:39:27.515922 | controller | using tox.ini: /home/zuul/src/github.com/ansible-network/releases/tox.ini (pid 2321) 2026-01-15 16:39:27.522930 | controller | using tox-3.28.0 from /usr/lib/python3.11/site-packages/tox/__init__.py (pid 2321) 2026-01-15 16:39:27.544745 | controller | skipping sdist step 2026-01-15 16:39:27.544762 | controller | venv uses /usr/bin/python3 2026-01-15 16:39:27.544779 | controller | venv start: getenv /home/zuul/src/github.com/ansible-network/releases/.tox/venv 2026-01-15 16:39:27.544945 | controller | venv cannot reuse: no previous config /home/zuul/src/github.com/ansible-network/releases/.tox/venv/.tox-config1 2026-01-15 16:39:27.544957 | controller | venv create: /home/zuul/src/github.com/ansible-network/releases/.tox/venv 2026-01-15 16:39:27.544966 | 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 2026-01-15 16:39:27.544975 | controller | [2329] /home/zuul/src/github.com/ansible-network/releases/.tox$ /usr/bin/python3 -m virtualenv --no-download --python /usr/bin/python3 venv 2026-01-15 16:39:28.056040 | controller | created virtual environment CPython3.11.0.final.0-64 in 430ms 2026-01-15 16:39:28.075681 | controller | creator CPython3Posix(dest=/home/zuul/src/github.com/ansible-network/releases/.tox/venv, clear=False, no_vcs_ignore=False, global=False) 2026-01-15 16:39:28.075709 | 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) 2026-01-15 16:39:28.075718 | controller | added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1 2026-01-15 16:39:28.075723 | controller | activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator 2026-01-15 16:39:28.075733 | 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 2026-01-15 16:39:28.076064 | 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 2026-01-15 16:39:28.076081 | controller | [2337] /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 2026-01-15 16:39:29.480262 | controller | Collecting ruamel.yaml 2026-01-15 16:39:29.520830 | controller | Downloading ruamel_yaml-0.19.1-py3-none-any.whl (118 kB) 2026-01-15 16:39:29.547221 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 118.1/118.1 kB 4.8 MB/s eta 0:00:00 2026-01-15 16:39:29.597187 | controller | Collecting pbr 2026-01-15 16:39:29.604910 | controller | Downloading pbr-7.0.3-py2.py3-none-any.whl (131 kB) 2026-01-15 16:39:29.615382 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 131.9/131.9 kB 20.9 MB/s eta 0:00:00 2026-01-15 16:39:29.654249 | controller | Collecting tweepy 2026-01-15 16:39:29.659204 | controller | Downloading tweepy-4.16.0-py3-none-any.whl (98 kB) 2026-01-15 16:39:29.666592 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.8/98.8 kB 16.6 MB/s eta 0:00:00 2026-01-15 16:39:29.714879 | controller | Collecting galaxy-importer 2026-01-15 16:39:29.719295 | controller | Downloading galaxy_importer-0.4.37-py3-none-any.whl (64 kB) 2026-01-15 16:39:29.729002 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 64.9/64.9 kB 7.1 MB/s eta 0:00:00 2026-01-15 16:39:29.783709 | controller | Collecting flake8 2026-01-15 16:39:29.787102 | controller | Downloading flake8-7.3.0-py2.py3-none-any.whl (57 kB) 2026-01-15 16:39:29.794740 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 57.9/57.9 kB 8.4 MB/s eta 0:00:00 2026-01-15 16:39:29.806873 | 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) 2026-01-15 16:39:29.846314 | controller | Collecting oauthlib<4,>=3.2.0 2026-01-15 16:39:29.850862 | controller | Downloading oauthlib-3.3.1-py3-none-any.whl (160 kB) 2026-01-15 16:39:29.859650 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 160.1/160.1 kB 25.3 MB/s eta 0:00:00 2026-01-15 16:39:29.924223 | controller | Collecting requests<3,>=2.27.0 2026-01-15 16:39:29.927374 | controller | Downloading requests-2.32.5-py3-none-any.whl (64 kB) 2026-01-15 16:39:29.934546 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 64.7/64.7 kB 10.1 MB/s eta 0:00:00 2026-01-15 16:39:29.970528 | controller | Collecting requests-oauthlib<3,>=1.2.0 2026-01-15 16:39:29.974279 | controller | Downloading requests_oauthlib-2.0.0-py2.py3-none-any.whl (24 kB) 2026-01-15 16:39:30.120150 | controller | Collecting ansible-core 2026-01-15 16:39:30.124896 | controller | Downloading ansible_core-2.19.5-py3-none-any.whl (2.4 MB) 2026-01-15 16:39:30.158300 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.4/2.4 MB 81.0 MB/s eta 0:00:00 2026-01-15 16:39:30.204436 | controller | Collecting ansible-builder<4.0,>=1.2.0 2026-01-15 16:39:30.210225 | controller | Downloading ansible_builder-3.1.1-py3-none-any.whl (46 kB) 2026-01-15 16:39:30.217769 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 46.5/46.5 kB 6.5 MB/s eta 0:00:00 2026-01-15 16:39:30.333956 | controller | Collecting ansible-lint<=26.1.0,>=6.2.2 2026-01-15 16:39:30.339017 | controller | Downloading ansible_lint-26.1.0-py3-none-any.whl (324 kB) 2026-01-15 16:39:30.349457 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 324.6/324.6 kB 39.9 MB/s eta 0:00:00 2026-01-15 16:39:30.383914 | controller | Collecting attrs<23,>=21.4.0 2026-01-15 16:39:30.387218 | controller | Downloading attrs-22.2.0-py3-none-any.whl (60 kB) 2026-01-15 16:39:30.392505 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 60.0/60.0 kB 16.6 MB/s eta 0:00:00 2026-01-15 16:39:30.488096 | controller | Collecting nh3<3,>=0.2.18 2026-01-15 16:39:30.492694 | controller | Downloading nh3-0.3.2-cp38-abi3-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (797 kB) 2026-01-15 16:39:30.509708 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 797.2/797.2 kB 54.7 MB/s eta 0:00:00 2026-01-15 16:39:30.525602 | controller | Collecting flake8 2026-01-15 16:39:30.529974 | controller | Downloading flake8-6.1.0-py2.py3-none-any.whl (58 kB) 2026-01-15 16:39:30.537043 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 58.3/58.3 kB 9.4 MB/s eta 0:00:00 2026-01-15 16:39:30.579759 | controller | Collecting markdown<4,>=3.3.4 2026-01-15 16:39:30.582860 | controller | Downloading markdown-3.10-py3-none-any.whl (107 kB) 2026-01-15 16:39:30.591220 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 107.7/107.7 kB 17.2 MB/s eta 0:00:00 2026-01-15 16:44:06.519919 | [Zuul] Log Stream did not terminate 2026-01-15 16:44:06.520200 | controller | ERROR 2026-01-15 16:44:06.520284 | controller | { 2026-01-15 16:44:06.520310 | controller | "msg": "Data could not be sent to remote host \"162.253.55.250\". Make sure this host can be reached over ssh: ssh: connect to host 162.253.55.250 port 22: No route to host\r\n", 2026-01-15 16:44:06.520331 | controller | "unreachable": true 2026-01-15 16:44:06.520348 | controller | } unreachable 2026-01-15 16:44:06.523531 | 2026-01-15 16:44:06.523587 | PLAY RECAP 2026-01-15 16:44:06.523634 | controller | ok: 10 changed: 5 unreachable: 1 failed: 0 skipped: 15 rescued: 0 ignored: 0 2026-01-15 16:44:06.523655 | 2026-01-15 16:44:06.688212 | PRE-RUN END RESULT_UNREACHABLE: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master] 2026-01-15 16:44:06.689284 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2026-01-15 16:44:07.333365 | 2026-01-15 16:44:07.333505 | PLAY [all:!appliance*] 2026-01-15 16:44:07.356182 | 2026-01-15 16:44:07.356289 | TASK [unregister the node] 2026-01-15 16:44:09.742959 | [controller] Waiting on logger 2026-01-15 16:44:30.640646 | controller | skipping: Conditional result was False 2026-01-15 16:44:30.654449 | 2026-01-15 16:44:30.654621 | TASK [include_role : fetch-output] 2026-01-15 16:44:30.702066 | controller | ok 2026-01-15 16:44:30.729545 | 2026-01-15 16:44:30.729641 | TASK [fetch-output : Set log path for multiple nodes] 2026-01-15 16:44:30.795613 | controller | skipping: Conditional result was False 2026-01-15 16:44:30.810876 | 2026-01-15 16:44:30.811042 | TASK [fetch-output : Set log path for single node] 2026-01-15 16:44:30.873713 | controller | ok 2026-01-15 16:44:30.885861 | 2026-01-15 16:44:30.885999 | LOOP [fetch-output : Ensure local output dirs] 2026-01-15 16:44:31.375205 | controller -> localhost | ok: "/var/lib/zuul/builds/97b70da4204b4fe382e6b1ae032686fe/work/logs" 2026-01-15 16:44:31.679909 | controller -> localhost | changed: "/var/lib/zuul/builds/97b70da4204b4fe382e6b1ae032686fe/work/artifacts" 2026-01-15 16:44:31.934872 | controller -> localhost | changed: "/var/lib/zuul/builds/97b70da4204b4fe382e6b1ae032686fe/work/docs" 2026-01-15 16:44:31.949807 | 2026-01-15 16:44:31.950018 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-01-15 16:44:32.644741 | controller | changed: .d..t...... ./ 2026-01-15 16:44:32.645462 | controller | changed: All items complete 2026-01-15 16:44:32.645532 | 2026-01-15 16:44:33.238854 | controller | changed: .d..t...... ./ 2026-01-15 16:44:33.791924 | controller | changed: .d..t...... ./ 2026-01-15 16:44:33.818646 | 2026-01-15 16:44:33.818856 | TASK [include_role : fetch-output-openshift] 2026-01-15 16:44:33.844155 | controller | skipping: Conditional result was False 2026-01-15 16:44:33.857103 | 2026-01-15 16:44:33.857362 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-01-15 16:44:34.415448 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.015388 2026-01-15 16:44:34.736753 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.021307 2026-01-15 16:44:34.780581 | 2026-01-15 16:44:34.780752 | PLAY [localhost] 2026-01-15 16:44:34.793224 | 2026-01-15 16:44:34.793288 | TASK [Run Zuul manifest role] 2026-01-15 16:44:34.814330 | localhost | ok 2026-01-15 16:44:34.826959 | 2026-01-15 16:44:34.827023 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-01-15 16:44:35.330188 | localhost | changed 2026-01-15 16:44:35.341228 | 2026-01-15 16:44:35.341366 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-01-15 16:44:35.389858 | localhost | ok 2026-01-15 16:44:35.408971 | 2026-01-15 16:44:35.409093 | TASK [Set zuul-log-path fact] 2026-01-15 16:44:35.432966 | localhost | ok 2026-01-15 16:44:35.450649 | 2026-01-15 16:44:35.450770 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-01-15 16:44:35.491939 | localhost | ok 2026-01-15 16:44:35.502768 | 2026-01-15 16:44:35.502849 | LOOP [Run upload-logs-swift role] 2026-01-15 16:44:35.551950 | localhost | Output suppressed because no_log was given 2026-01-15 16:44:35.621845 | 2026-01-15 16:44:35.622007 | TASK [Set zuul-log-path fact] 2026-01-15 16:44:35.657802 | localhost | skipping: Conditional result was False 2026-01-15 16:44:35.663437 | 2026-01-15 16:44:35.663504 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2026-01-15 16:44:35.952142 | localhost -> localhost | ok: Runtime: 0:00:00.009486 2026-01-15 16:44:35.958089 | 2026-01-15 16:44:35.958152 | TASK [upload-logs-swift : Upload logs to swift]