2026-03-12 15:38:29.073867 | Job console starting... 2026-03-12 15:38:29.084659 | Updating repositories 2026-03-12 15:38:29.116969 | Preparing job workspace 2026-03-12 15:38:32.662863 | Running Ansible setup... 2026-03-12 15:38:37.473455 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-03-12 15:38:38.096028 | 2026-03-12 15:38:38.096154 | PLAY [localhost] 2026-03-12 15:38:38.104311 | 2026-03-12 15:38:38.104376 | TASK [Gathering Facts] 2026-03-12 15:38:39.130926 | localhost | ok 2026-03-12 15:38:39.159282 | 2026-03-12 15:38:39.159424 | TASK [Setup log path fact] 2026-03-12 15:38:39.179530 | localhost | ok 2026-03-12 15:38:39.195720 | 2026-03-12 15:38:39.195812 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-12 15:38:39.230008 | localhost | ok 2026-03-12 15:38:39.248552 | 2026-03-12 15:38:39.248791 | TASK [emit-job-header : Print job information] 2026-03-12 15:38:39.304614 | # Job Information 2026-03-12 15:38:39.305029 | Ansible Version: 2.15.12 2026-03-12 15:38:39.305100 | Job: ansible-galaxy-importer 2026-03-12 15:38:39.305144 | Pipeline: third-party-check 2026-03-12 15:38:39.305183 | Executor: ze02.softwarefactory-project.io 2026-03-12 15:38:39.305222 | Triggered by: https://github.com/openshift/community.okd/pull/274 2026-03-12 15:38:39.305271 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/26e/ansible/26ee52bd4242461ca13bef6c7d2f89b2/ 2026-03-12 15:38:39.305313 | Event ID: 7c7cf2f0-1e26-11f1-8ad0-08c2344e8256 2026-03-12 15:38:39.314748 | 2026-03-12 15:38:39.315077 | LOOP [emit-job-header : Print node information] 2026-03-12 15:38:39.441376 | localhost | ok: 2026-03-12 15:38:39.442043 | localhost | # Node Information 2026-03-12 15:38:39.442116 | localhost | Inventory Hostname: controller 2026-03-12 15:38:39.442162 | localhost | Hostname: np0005645559 2026-03-12 15:38:39.442203 | localhost | Username: zuul 2026-03-12 15:38:39.442248 | localhost | Distro: Fedora 37 2026-03-12 15:38:39.442287 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2026-03-12 15:38:39.442325 | localhost | Region: ca-ymq-1 2026-03-12 15:38:39.442363 | localhost | Label: ansible-fedora-37-1vcpu 2026-03-12 15:38:39.442399 | localhost | Product Name: OpenStack Nova 2026-03-12 15:38:39.442436 | localhost | Interface IP: 199.204.45.162 2026-03-12 15:38:39.463469 | 2026-03-12 15:38:39.463710 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-12 15:38:39.891788 | localhost -> localhost | changed 2026-03-12 15:38:39.904549 | 2026-03-12 15:38:39.904762 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-12 15:38:40.799154 | localhost -> localhost | changed 2026-03-12 15:38:40.819494 | 2026-03-12 15:38:40.819552 | PLAY [all:!appliance*] 2026-03-12 15:38:40.836150 | 2026-03-12 15:38:40.836217 | TASK [include_role : start-zuul-console] 2026-03-12 15:38:40.857313 | controller | ok 2026-03-12 15:38:40.872345 | 2026-03-12 15:38:40.872435 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-12 15:38:41.257088 | controller | ok 2026-03-12 15:38:41.280786 | 2026-03-12 15:38:41.280928 | TASK [use-our-mirror : Retrieve the IP address] 2026-03-12 15:38:42.208065 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2026-03-12 15:38:42.222267 | 2026-03-12 15:38:42.222431 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2026-03-12 15:38:42.771563 | controller | skipping: Conditional result was False 2026-03-12 15:38:42.785075 | 2026-03-12 15:38:42.785213 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2026-03-12 15:38:42.812088 | controller | skipping: Conditional result was False 2026-03-12 15:38:42.826235 | 2026-03-12 15:38:42.826384 | TASK [use-our-mirror : Create the podman configuration directory] 2026-03-12 15:38:42.853440 | controller | skipping: Conditional result was False 2026-03-12 15:38:42.867194 | 2026-03-12 15:38:42.867332 | TASK [use-our-mirror : Copy the podman configuration] 2026-03-12 15:38:42.894494 | controller | skipping: Conditional result was False 2026-03-12 15:38:42.908486 | 2026-03-12 15:38:42.908622 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2026-03-12 15:38:42.945989 | controller | skipping: Conditional result was False 2026-03-12 15:38:42.960121 | 2026-03-12 15:38:42.960262 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2026-03-12 15:38:42.987346 | controller | skipping: Conditional result was False 2026-03-12 15:38:43.013968 | 2026-03-12 15:38:43.014099 | TASK [Disable Fedora Modular] 2026-03-12 15:38:43.262783 | controller | changed 2026-03-12 15:38:43.270851 | 2026-03-12 15:38:43.270936 | TASK [Enable EPEL] 2026-03-12 15:38:43.296149 | controller | skipping: Conditional result was False 2026-03-12 15:38:43.304673 | 2026-03-12 15:38:43.304797 | TASK [Register the RHEL node] 2026-03-12 15:38:43.861174 | 2026-03-12 15:38:43.861448 | TASK [Show the subscription-manager status] 2026-03-12 15:38:44.446513 | controller | skipping: Conditional result was False 2026-03-12 15:38:44.461370 | 2026-03-12 15:38:44.461508 | TASK [Enable EPEL on RHEL] 2026-03-12 15:38:45.017269 | controller | skipping: Conditional result was False 2026-03-12 15:38:45.030381 | 2026-03-12 15:38:45.030516 | TASK [Install git and tox] 2026-03-12 15:40:10.381289 | controller | changed 2026-03-12 15:40:10.398161 | 2026-03-12 15:40:10.398309 | TASK [include_role : prepare-workspace] 2026-03-12 15:40:10.438228 | controller | ok 2026-03-12 15:40:10.477248 | 2026-03-12 15:40:10.477385 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-12 15:40:10.727813 | controller | ok 2026-03-12 15:40:10.744988 | 2026-03-12 15:40:10.745134 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-12 15:40:11.624194 | controller | Output suppressed because no_log was given 2026-03-12 15:40:11.637751 | 2026-03-12 15:40:11.637833 | TASK [include_role : prepare-workspace-openshift] 2026-03-12 15:40:11.652480 | controller | skipping: Conditional result was False 2026-03-12 15:40:11.681954 | 2026-03-12 15:40:11.682051 | PLAY [all:!appliance] 2026-03-12 15:40:11.702549 | 2026-03-12 15:40:11.702611 | TASK [Run add-build-sshkey role (RSA)] 2026-03-12 15:40:11.731795 | controller | ok 2026-03-12 15:40:11.745809 | 2026-03-12 15:40:11.745871 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-12 15:40:11.973305 | controller -> localhost | ok 2026-03-12 15:40:11.980006 | 2026-03-12 15:40:11.980067 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-12 15:40:12.001768 | controller | ok 2026-03-12 15:40:12.018035 | controller | included: /var/lib/zuul/builds/26ee52bd4242461ca13bef6c7d2f89b2/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-12 15:40:12.023650 | 2026-03-12 15:40:12.023723 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-12 15:40:12.627433 | controller -> localhost | Generating public/private rsa key pair. 2026-03-12 15:40:12.627923 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/26ee52bd4242461ca13bef6c7d2f89b2/work/26ee52bd4242461ca13bef6c7d2f89b2_id_rsa. 2026-03-12 15:40:12.627992 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/26ee52bd4242461ca13bef6c7d2f89b2/work/26ee52bd4242461ca13bef6c7d2f89b2_id_rsa.pub. 2026-03-12 15:40:12.628040 | controller -> localhost | The key fingerprint is: 2026-03-12 15:40:12.628083 | controller -> localhost | SHA256:xaIi0r3qFDZtZ6qifYoMqcGE5gYzqmbIXi6kp/9P574 zuul-build-sshkey 2026-03-12 15:40:12.628128 | controller -> localhost | The key's randomart image is: 2026-03-12 15:40:12.628169 | controller -> localhost | +---[RSA 2048]----+ 2026-03-12 15:40:12.628209 | controller -> localhost | | | 2026-03-12 15:40:12.628250 | controller -> localhost | | . | 2026-03-12 15:40:12.628290 | controller -> localhost | | . o | 2026-03-12 15:40:12.628328 | controller -> localhost | |.. o . o | 2026-03-12 15:40:12.628366 | controller -> localhost | |*o* = + S | 2026-03-12 15:40:12.628419 | controller -> localhost | |BB = * | 2026-03-12 15:40:12.628466 | controller -> localhost | |X+..o . . | 2026-03-12 15:40:12.628507 | controller -> localhost | |XX+o.. o | 2026-03-12 15:40:12.628547 | controller -> localhost | |@OO=....E. | 2026-03-12 15:40:12.628592 | controller -> localhost | +----[SHA256]-----+ 2026-03-12 15:40:12.628718 | controller -> localhost | ok: Runtime: 0:00:00.182253 2026-03-12 15:40:12.642366 | 2026-03-12 15:40:12.642497 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-12 15:40:12.670885 | controller | ok 2026-03-12 15:40:12.689316 | controller | included: /var/lib/zuul/builds/26ee52bd4242461ca13bef6c7d2f89b2/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-12 15:40:12.730015 | 2026-03-12 15:40:12.730149 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-12 15:40:12.744301 | controller | skipping: Conditional result was False 2026-03-12 15:40:12.750935 | 2026-03-12 15:40:12.750995 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-12 15:40:13.131716 | controller | changed 2026-03-12 15:40:13.144099 | 2026-03-12 15:40:13.144242 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-12 15:40:13.395596 | controller | ok 2026-03-12 15:40:13.404827 | 2026-03-12 15:40:13.404911 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-12 15:40:14.025292 | controller | changed 2026-03-12 15:40:14.032417 | 2026-03-12 15:40:14.032496 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-12 15:40:14.692096 | controller | changed 2026-03-12 15:40:14.706104 | 2026-03-12 15:40:14.706245 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-12 15:40:14.733862 | controller | skipping: Conditional result was False 2026-03-12 15:40:14.743829 | 2026-03-12 15:40:14.743926 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-12 15:40:15.145435 | controller -> localhost | changed 2026-03-12 15:40:15.169887 | 2026-03-12 15:40:15.170032 | TASK [add-build-sshkey : Add back temp key] 2026-03-12 15:40:15.471967 | controller -> localhost | Identity added: /var/lib/zuul/builds/26ee52bd4242461ca13bef6c7d2f89b2/work/26ee52bd4242461ca13bef6c7d2f89b2_id_rsa (zuul-build-sshkey) 2026-03-12 15:40:15.472289 | controller -> localhost | ok: Runtime: 0:00:00.012674 2026-03-12 15:40:15.485806 | 2026-03-12 15:40:15.485939 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-12 15:40:15.779411 | controller | ok 2026-03-12 15:40:15.791293 | 2026-03-12 15:40:15.791424 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-12 15:40:15.828738 | controller | skipping: Conditional result was False 2026-03-12 15:40:15.853764 | 2026-03-12 15:40:15.854488 | TASK [Run add-build-sshkey role (ECDSA)] 2026-03-12 15:40:15.882089 | controller | ok 2026-03-12 15:40:15.910472 | 2026-03-12 15:40:15.910559 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-12 15:40:16.169079 | controller -> localhost | ok 2026-03-12 15:40:16.175594 | 2026-03-12 15:40:16.175655 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-12 15:40:16.195074 | controller | ok 2026-03-12 15:40:16.205475 | controller | included: /var/lib/zuul/builds/26ee52bd4242461ca13bef6c7d2f89b2/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-12 15:40:16.211458 | 2026-03-12 15:40:16.211520 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-12 15:40:16.458458 | controller -> localhost | Generating public/private ecdsa key pair. 2026-03-12 15:40:16.458647 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/26ee52bd4242461ca13bef6c7d2f89b2/work/26ee52bd4242461ca13bef6c7d2f89b2_id_ecdsa. 2026-03-12 15:40:16.458694 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/26ee52bd4242461ca13bef6c7d2f89b2/work/26ee52bd4242461ca13bef6c7d2f89b2_id_ecdsa.pub. 2026-03-12 15:40:16.458725 | controller -> localhost | The key fingerprint is: 2026-03-12 15:40:16.458745 | controller -> localhost | SHA256:bi6t28xY21+fqI9iZr3jQGU0uy+R0lZSYHQmWA185Mk zuul-build-sshkey 2026-03-12 15:40:16.458764 | controller -> localhost | The key's randomart image is: 2026-03-12 15:40:16.458782 | controller -> localhost | +---[ECDSA 521]---+ 2026-03-12 15:40:16.458799 | controller -> localhost | | =X== | 2026-03-12 15:40:16.458816 | controller -> localhost | | .o.Xo. | 2026-03-12 15:40:16.458833 | controller -> localhost | | =.E | 2026-03-12 15:40:16.458849 | controller -> localhost | | + = | 2026-03-12 15:40:16.458866 | controller -> localhost | | So * | 2026-03-12 15:40:16.458882 | controller -> localhost | | .. o o | 2026-03-12 15:40:16.458898 | controller -> localhost | | .+... .. | 2026-03-12 15:40:16.458915 | controller -> localhost | | .O.B.oo....| 2026-03-12 15:40:16.458931 | controller -> localhost | | ++X +**o ..| 2026-03-12 15:40:16.458947 | controller -> localhost | +----[SHA256]-----+ 2026-03-12 15:40:16.458994 | controller -> localhost | ok: Runtime: 0:00:00.014058 2026-03-12 15:40:16.466704 | 2026-03-12 15:40:16.466768 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-12 15:40:16.496379 | controller | ok 2026-03-12 15:40:16.503616 | controller | included: /var/lib/zuul/builds/26ee52bd4242461ca13bef6c7d2f89b2/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-12 15:40:16.512165 | 2026-03-12 15:40:16.512227 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-12 15:40:16.536083 | controller | skipping: Conditional result was False 2026-03-12 15:40:16.542671 | 2026-03-12 15:40:16.542747 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-12 15:40:16.807006 | controller | changed 2026-03-12 15:40:16.812723 | 2026-03-12 15:40:16.812796 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-12 15:40:17.053212 | controller | ok 2026-03-12 15:40:17.065605 | 2026-03-12 15:40:17.065775 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-12 15:40:17.717534 | controller | changed 2026-03-12 15:40:17.731131 | 2026-03-12 15:40:17.731268 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-12 15:40:18.384838 | controller | changed 2026-03-12 15:40:18.397555 | 2026-03-12 15:40:18.397739 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-12 15:40:18.425910 | controller | skipping: Conditional result was False 2026-03-12 15:40:18.440555 | 2026-03-12 15:40:18.440780 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-12 15:40:18.765501 | controller -> localhost | changed 2026-03-12 15:40:18.793450 | 2026-03-12 15:40:18.793641 | TASK [add-build-sshkey : Add back temp key] 2026-03-12 15:40:19.158015 | controller -> localhost | Identity added: /var/lib/zuul/builds/26ee52bd4242461ca13bef6c7d2f89b2/work/26ee52bd4242461ca13bef6c7d2f89b2_id_ecdsa (zuul-build-sshkey) 2026-03-12 15:40:19.158448 | controller -> localhost | ok: Runtime: 0:00:00.015384 2026-03-12 15:40:19.172857 | 2026-03-12 15:40:19.172990 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-12 15:40:19.388648 | controller | ok 2026-03-12 15:40:19.394203 | 2026-03-12 15:40:19.394266 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-12 15:40:19.418184 | controller | skipping: Conditional result was False 2026-03-12 15:40:19.430021 | 2026-03-12 15:40:19.430083 | TASK [include_role : remove-zuul-sshkey] 2026-03-12 15:40:19.454016 | controller | skipping: Conditional result was False 2026-03-12 15:40:19.460299 | 2026-03-12 15:40:19.460359 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-12 15:40:19.697947 | controller | ok: "logs" 2026-03-12 15:40:19.698242 | controller | ok: All items complete 2026-03-12 15:40:19.698277 | 2026-03-12 15:40:19.907187 | controller | ok: "artifacts" 2026-03-12 15:40:20.102970 | controller | ok: "docs" 2026-03-12 15:40:20.122096 | 2026-03-12 15:40:20.122271 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-12 15:40:20.379216 | controller | changed: "logs" 2026-03-12 15:40:20.584654 | controller | changed: "artifacts" 2026-03-12 15:40:20.800419 | controller | changed: "docs" 2026-03-12 15:40:20.889172 | 2026-03-12 15:40:20.889281 | PLAY RECAP 2026-03-12 15:40:20.889320 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2026-03-12 15:40:20.889345 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-12 15:40:20.889362 | 2026-03-12 15:40:20.985628 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-03-12 15:40:20.986374 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master] 2026-03-12 15:40:21.588960 | 2026-03-12 15:40:21.589085 | PLAY [all] 2026-03-12 15:40:21.608807 | 2026-03-12 15:40:21.608876 | TASK [Setup ensure-tox role] 2026-03-12 15:40:21.628451 | controller | ok 2026-03-12 15:40:21.650557 | 2026-03-12 15:40:21.650628 | TASK [Install pip] 2026-03-12 15:40:21.670638 | controller | ok 2026-03-12 15:40:21.691496 | 2026-03-12 15:40:21.691562 | TASK [ensure-pip : Check if pip is installed] 2026-03-12 15:40:22.085122 | controller | /usr/bin/pip3 2026-03-12 15:40:22.100131 | controller | /usr/bin/python3: No module named wheel 2026-03-12 15:40:22.221727 | controller | ok: Runtime: 0:00:00.023772 2026-03-12 15:40:22.234259 | 2026-03-12 15:40:22.234400 | LOOP [ensure-pip : Install pip from packages] 2026-03-12 15:40:22.261689 | controller | ok: "/var/lib/zuul/builds/26ee52bd4242461ca13bef6c7d2f89b2/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml" 2026-03-12 15:40:22.289945 | controller | included: /var/lib/zuul/builds/26ee52bd4242461ca13bef6c7d2f89b2/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml 2026-03-12 15:40:22.309940 | 2026-03-12 15:40:22.310046 | TASK [ensure-pip : Install Python 3 pip] 2026-03-12 15:40:26.175472 | controller | ok: Nothing to do 2026-03-12 15:40:26.187884 | 2026-03-12 15:40:26.188025 | TASK [ensure-pip : Install Python3-wheel on older CentOS] 2026-03-12 15:40:26.255182 | controller | skipping: Conditional result was False 2026-03-12 15:40:26.269331 | 2026-03-12 15:40:26.269474 | TASK [ensure-pip : Check for EPEL repository] 2026-03-12 15:40:26.296008 | controller | skipping: Conditional result was False 2026-03-12 15:40:26.309576 | 2026-03-12 15:40:26.309765 | TASK [ensure-pip : Fail with instructions when EPEL is not installed] 2026-03-12 15:40:26.336199 | controller | skipping: Conditional result was False 2026-03-12 15:40:26.350233 | 2026-03-12 15:40:26.350370 | TASK [ensure-pip : Install Python 2 pip] 2026-03-12 15:40:26.376485 | controller | skipping: Conditional result was False 2026-03-12 15:40:26.389304 | 2026-03-12 15:40:26.389444 | TASK [ensure-pip : Ensure setuptools] 2026-03-12 15:40:26.415296 | controller | skipping: Conditional result was False 2026-03-12 15:40:26.429464 | 2026-03-12 15:40:26.429595 | TASK [ensure-pip : Check for ensurepip module] 2026-03-12 15:40:26.976261 | controller | skipping: Conditional result was False 2026-03-12 15:40:26.989466 | 2026-03-12 15:40:26.989606 | TASK [ensure-pip : Ensure python3-venv] 2026-03-12 15:40:27.016018 | controller | skipping: Conditional result was False 2026-03-12 15:40:27.029039 | 2026-03-12 15:40:27.029181 | TASK [ensure-pip : Install pip from source] 2026-03-12 15:40:27.055528 | controller | skipping: Conditional result was False 2026-03-12 15:40:27.069791 | 2026-03-12 15:40:27.069928 | TASK [ensure-pip : Probe for venv python full path] 2026-03-12 15:40:27.393104 | controller | /usr/bin/python3 2026-03-12 15:40:27.615840 | controller | ok: Runtime: 0:00:00.004122 2026-03-12 15:40:27.651096 | 2026-03-12 15:40:27.651239 | TASK [ensure-pip : Set host default] 2026-03-12 15:40:27.723800 | controller | ok 2026-03-12 15:40:27.731078 | 2026-03-12 15:40:27.731166 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2026-03-12 15:40:27.794333 | controller | ok 2026-03-12 15:40:27.808088 | 2026-03-12 15:40:27.808175 | TASK [ensure-tox : Check if tox is installed] 2026-03-12 15:40:28.046777 | controller | /usr/bin/tox 2026-03-12 15:40:28.351105 | controller | ok: Runtime: 0:00:00.003191 2026-03-12 15:40:28.363340 | 2026-03-12 15:40:28.363481 | TASK [ensure-tox : Export preinstalled tox_exectuable] 2026-03-12 15:40:28.403715 | controller | ok 2026-03-12 15:40:28.415194 | 2026-03-12 15:40:28.415320 | TASK [ensure-tox : Create local venv] 2026-03-12 15:40:28.963803 | controller | skipping: Conditional result was False 2026-03-12 15:40:28.977741 | 2026-03-12 15:40:28.977893 | TASK [ensure-tox : Install tox to local venv] 2026-03-12 15:40:29.540632 | controller | skipping: Conditional result was False 2026-03-12 15:40:29.553833 | 2026-03-12 15:40:29.553983 | TASK [ensure-tox : Export installed tox_executable path] 2026-03-12 15:40:29.580864 | controller | skipping: Conditional result was False 2026-03-12 15:40:29.594569 | 2026-03-12 15:40:29.594764 | TASK [ensure-tox : Output tox version] 2026-03-12 15:40:29.983576 | controller | 3.28.0 imported from /usr/lib/python3.11/site-packages/tox/__init__.py 2026-03-12 15:40:30.148232 | controller | ok: Runtime: 0:00:00.141271 2026-03-12 15:40:30.161412 | 2026-03-12 15:40:30.161553 | TASK [ensure-tox : Make global symlink] 2026-03-12 15:40:30.188913 | controller | skipping: Conditional result was False 2026-03-12 15:40:30.212135 | 2026-03-12 15:40:30.212281 | TASK [Setup tox role] 2026-03-12 15:40:30.241491 | controller | ok 2026-03-12 15:40:30.286557 | 2026-03-12 15:40:30.286649 | TASK [tox : Check to see if the constraints file exists] 2026-03-12 15:40:30.321840 | controller | skipping: Conditional result was False 2026-03-12 15:40:30.328124 | 2026-03-12 15:40:30.328188 | TASK [tox : Fail if constraints file is missing] 2026-03-12 15:40:30.362265 | controller | skipping: Conditional result was False 2026-03-12 15:40:30.368356 | 2026-03-12 15:40:30.368433 | TASK [tox : Record file location] 2026-03-12 15:40:30.402646 | controller | skipping: Conditional result was False 2026-03-12 15:40:30.408456 | 2026-03-12 15:40:30.408531 | TASK [tox : Install tox siblings] 2026-03-12 15:40:30.432322 | controller | skipping: Conditional result was False 2026-03-12 15:40:30.438330 | 2026-03-12 15:40:30.438390 | TASK [tox : Emit tox command] 2026-03-12 15:40:30.479005 | /usr/bin/tox -evenv -vv --notest 2026-03-12 15:40:30.484142 | 2026-03-12 15:40:30.484203 | TASK [tox : Run tox] 2026-03-12 15:40:30.866863 | controller | using tox.ini: /home/zuul/src/github.com/ansible-network/releases/tox.ini (pid 2273) 2026-03-12 15:40:30.874087 | controller | using tox-3.28.0 from /usr/lib/python3.11/site-packages/tox/__init__.py (pid 2273) 2026-03-12 15:40:30.896303 | controller | skipping sdist step 2026-03-12 15:40:30.896322 | controller | venv uses /usr/bin/python3 2026-03-12 15:40:30.896338 | controller | venv start: getenv /home/zuul/src/github.com/ansible-network/releases/.tox/venv 2026-03-12 15:40:30.896671 | controller | venv cannot reuse: no previous config /home/zuul/src/github.com/ansible-network/releases/.tox/venv/.tox-config1 2026-03-12 15:40:30.896684 | controller | venv create: /home/zuul/src/github.com/ansible-network/releases/.tox/venv 2026-03-12 15:40:30.896696 | 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-03-12 15:40:30.896865 | controller | [2281] /home/zuul/src/github.com/ansible-network/releases/.tox$ /usr/bin/python3 -m virtualenv --no-download --python /usr/bin/python3 venv 2026-03-12 15:40:31.446991 | controller | created virtual environment CPython3.11.0.final.0-64 in 469ms 2026-03-12 15:40:31.465856 | controller | creator CPython3Posix(dest=/home/zuul/src/github.com/ansible-network/releases/.tox/venv, clear=False, no_vcs_ignore=False, global=False) 2026-03-12 15:40:31.465885 | 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-03-12 15:40:31.465894 | controller | added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1 2026-03-12 15:40:31.465899 | controller | activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator 2026-03-12 15:40:31.465908 | 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-03-12 15:40:31.466143 | 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-03-12 15:40:31.466159 | controller | [2289] /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-03-12 15:45:33.605043 | controller | ERROR 2026-03-12 15:45:33.605251 | controller | { 2026-03-12 15:45:33.605280 | controller | "msg": "Data could not be sent to remote host \"199.204.45.162\". Make sure this host can be reached over ssh: ssh: connect to host 199.204.45.162 port 22: Connection timed out\r\n", 2026-03-12 15:45:33.605301 | controller | "unreachable": true 2026-03-12 15:45:33.605318 | controller | } unreachable 2026-03-12 15:45:33.608063 | 2026-03-12 15:45:33.608114 | PLAY RECAP 2026-03-12 15:45:33.608157 | controller | ok: 10 changed: 4 unreachable: 1 failed: 0 skipped: 16 rescued: 0 ignored: 0 2026-03-12 15:45:33.608178 | 2026-03-12 15:45:33.703923 | PRE-RUN END RESULT_UNREACHABLE: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master] 2026-03-12 15:45:33.705542 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2026-03-12 15:45:34.298333 | 2026-03-12 15:45:34.298455 | PLAY [all:!appliance*] 2026-03-12 15:45:34.320656 | 2026-03-12 15:45:34.320770 | TASK [unregister the node] 2026-03-12 15:45:34.854259 | controller | skipping: Conditional result was False 2026-03-12 15:45:34.867097 | 2026-03-12 15:45:34.867265 | TASK [include_role : fetch-output] 2026-03-12 15:45:34.917424 | controller | ok 2026-03-12 15:45:34.955135 | 2026-03-12 15:45:34.955231 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-12 15:45:35.031783 | controller | skipping: Conditional result was False 2026-03-12 15:45:35.046270 | 2026-03-12 15:45:35.046485 | TASK [fetch-output : Set log path for single node] 2026-03-12 15:45:35.108278 | controller | ok 2026-03-12 15:45:35.120565 | 2026-03-12 15:45:35.120735 | LOOP [fetch-output : Ensure local output dirs] 2026-03-12 15:45:35.622523 | controller -> localhost | ok: "/var/lib/zuul/builds/26ee52bd4242461ca13bef6c7d2f89b2/work/logs" 2026-03-12 15:45:35.855201 | controller -> localhost | changed: "/var/lib/zuul/builds/26ee52bd4242461ca13bef6c7d2f89b2/work/artifacts" 2026-03-12 15:45:36.099028 | controller -> localhost | changed: "/var/lib/zuul/builds/26ee52bd4242461ca13bef6c7d2f89b2/work/docs" 2026-03-12 15:45:36.112401 | 2026-03-12 15:45:36.112518 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-12 15:45:36.796504 | controller | ok 2026-03-12 15:45:36.796777 | controller | changed: All items complete 2026-03-12 15:45:36.796808 | 2026-03-12 15:45:37.257880 | controller | changed: .d..t...... ./ 2026-03-12 15:45:37.783116 | controller | changed: .d..t...... ./ 2026-03-12 15:45:37.810049 | 2026-03-12 15:45:37.810191 | TASK [include_role : fetch-output-openshift] 2026-03-12 15:45:37.840553 | controller | skipping: Conditional result was False 2026-03-12 15:45:37.852470 | 2026-03-12 15:45:37.852580 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-12 15:45:38.334912 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.008402 2026-03-12 15:45:38.553510 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.012884 2026-03-12 15:45:38.598646 | 2026-03-12 15:45:38.598771 | PLAY [localhost] 2026-03-12 15:45:38.617596 | 2026-03-12 15:45:38.617701 | TASK [Run Zuul manifest role] 2026-03-12 15:45:38.638794 | localhost | ok 2026-03-12 15:45:38.655625 | 2026-03-12 15:45:38.655688 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-12 15:45:39.036916 | localhost | changed 2026-03-12 15:45:39.048668 | 2026-03-12 15:45:39.048989 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-12 15:45:39.085521 | localhost | ok 2026-03-12 15:45:39.099669 | 2026-03-12 15:45:39.099771 | TASK [Set zuul-log-path fact] 2026-03-12 15:45:39.131033 | localhost | ok 2026-03-12 15:45:39.151994 | 2026-03-12 15:45:39.152068 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-12 15:45:39.186072 | localhost | ok 2026-03-12 15:45:39.195193 | 2026-03-12 15:45:39.195255 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)] 2026-03-12 15:45:39.231283 | localhost | ok: 2026-03-12 15:45:39.231715 | localhost | { 2026-03-12 15:45:39.231758 | localhost | "auth": { 2026-03-12 15:45:39.231783 | localhost | "password": "IonWCwcuOFib&&<}wp^:[2G/", 2026-03-12 15:45:39.231806 | localhost | "username": "9LF91O0RK7JU" 2026-03-12 15:45:39.231838 | localhost | }, 2026-03-12 15:45:39.231861 | localhost | "profile": "rackspace", 2026-03-12 15:45:39.231883 | localhost | "region_name": "ORD" 2026-03-12 15:45:39.231904 | localhost | } 2026-03-12 15:45:39.231947 | localhost | changed: All items complete 2026-03-12 15:45:39.231973 | 2026-03-12 15:45:39.249402 | 2026-03-12 15:45:39.249521 | TASK [Run upload-logs-failover role (S3 then Swift)] 2026-03-12 15:45:39.272732 | localhost | Output suppressed because no_log was given 2026-03-12 15:45:39.290152 | 2026-03-12 15:45:39.290220 | TASK [upload-logs-failover : Initialize control vars] 2026-03-12 15:45:39.384124 | localhost | ok 2026-03-12 15:45:39.390219 | 2026-03-12 15:45:39.390283 | LOOP [upload-logs-failover : Perform log upload] 2026-03-12 15:45:39.428787 | localhost | Output suppressed because no_log was given 2026-03-12 15:45:39.438135 | localhost | included: /var/lib/zuul/builds/26ee52bd4242461ca13bef6c7d2f89b2/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml 2026-03-12 15:45:39.446623 | 2026-03-12 15:45:39.446712 | LOOP [upload-logs-failover : Unpack vars for swift upload] 2026-03-12 15:45:39.535572 | localhost | Output suppressed because no_log was given 2026-03-12 15:45:39.546371 | 2026-03-12 15:45:39.546474 | TASK [Upload logs to swift] 2026-03-12 15:45:39.571950 | localhost | ok 2026-03-12 15:45:39.613804 | 2026-03-12 15:45:39.613923 | TASK [Set zuul-log-path fact] 2026-03-12 15:45:39.639490 | localhost | skipping: Conditional result was False 2026-03-12 15:45:39.645517 | 2026-03-12 15:45:39.645581 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2026-03-12 15:45:39.935134 | localhost -> localhost | ok: Runtime: 0:00:00.006155 2026-03-12 15:45:39.943247 | 2026-03-12 15:45:39.943316 | TASK [upload-logs-swift : Upload logs to swift]