2025-11-15 22:15:31.711068 | Job console starting... 2025-11-15 22:15:31.722640 | Updating repositories 2025-11-15 22:15:31.769649 | Preparing job workspace 2025-11-15 22:15:35.610281 | Running Ansible setup... 2025-11-15 22:15:39.980596 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2025-11-15 22:15:40.585473 | 2025-11-15 22:15:40.585597 | PLAY [localhost] 2025-11-15 22:15:40.593752 | 2025-11-15 22:15:40.593829 | TASK [Gathering Facts] 2025-11-15 22:15:41.545003 | localhost | ok 2025-11-15 22:15:41.568099 | 2025-11-15 22:15:41.568239 | TASK [Setup log path fact] 2025-11-15 22:15:41.588537 | localhost | ok 2025-11-15 22:15:41.606530 | 2025-11-15 22:15:41.606634 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-15 22:15:41.646878 | localhost | ok 2025-11-15 22:15:41.657273 | 2025-11-15 22:15:41.657363 | TASK [emit-job-header : Print job information] 2025-11-15 22:15:41.712053 | # Job Information 2025-11-15 22:15:41.712328 | Ansible Version: 2.15.12 2025-11-15 22:15:41.712398 | Job: ansible-galaxy-importer 2025-11-15 22:15:41.712445 | Pipeline: third-party-check 2025-11-15 22:15:41.712487 | Executor: ze04.softwarefactory-project.io 2025-11-15 22:15:41.712527 | Triggered by: https://github.com/ansible-collections/community.vmware/pull/2346 2025-11-15 22:15:41.712574 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/caa/ansible/caa34fd872ea4962b9e9ef2c371d540a/ 2025-11-15 22:15:41.712616 | Event ID: 92c8b1b0-c26f-11f0-8bdb-dbebbb0552da 2025-11-15 22:15:41.720586 | 2025-11-15 22:15:41.720772 | LOOP [emit-job-header : Print node information] 2025-11-15 22:15:41.854433 | localhost | ok: 2025-11-15 22:15:41.854724 | localhost | # Node Information 2025-11-15 22:15:41.854791 | localhost | Inventory Hostname: controller 2025-11-15 22:15:41.854835 | localhost | Hostname: np0005523884 2025-11-15 22:15:41.854877 | localhost | Username: zuul 2025-11-15 22:15:41.854921 | localhost | Distro: Fedora 37 2025-11-15 22:15:41.854961 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2025-11-15 22:15:41.854999 | localhost | Region: ca-ymq-1 2025-11-15 22:15:41.855037 | localhost | Label: ansible-fedora-37-1vcpu 2025-11-15 22:15:41.855074 | localhost | Product Name: OpenStack Nova 2025-11-15 22:15:41.855110 | localhost | Interface IP: 162.253.55.195 2025-11-15 22:15:41.875298 | 2025-11-15 22:15:41.875501 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-15 22:15:42.278237 | localhost -> localhost | changed 2025-11-15 22:15:42.284054 | 2025-11-15 22:15:42.284120 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-15 22:15:43.261824 | localhost -> localhost | changed 2025-11-15 22:15:43.298133 | 2025-11-15 22:15:43.298209 | PLAY [all:!appliance*] 2025-11-15 22:15:43.319667 | 2025-11-15 22:15:43.319783 | TASK [include_role : start-zuul-console] 2025-11-15 22:15:43.341041 | controller | ok 2025-11-15 22:15:43.359194 | 2025-11-15 22:15:43.359278 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-15 22:15:43.747796 | controller | ok 2025-11-15 22:15:43.761959 | 2025-11-15 22:15:43.762047 | TASK [use-our-mirror : Retrieve the IP address] 2025-11-15 22:15:44.935775 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2025-11-15 22:15:44.948954 | 2025-11-15 22:15:44.949082 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2025-11-15 22:15:45.496011 | controller | skipping: Conditional result was False 2025-11-15 22:15:45.509007 | 2025-11-15 22:15:45.509142 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2025-11-15 22:15:45.535777 | controller | skipping: Conditional result was False 2025-11-15 22:15:45.548497 | 2025-11-15 22:15:45.548621 | TASK [use-our-mirror : Create the podman configuration directory] 2025-11-15 22:15:45.565026 | controller | skipping: Conditional result was False 2025-11-15 22:15:45.577709 | 2025-11-15 22:15:45.577847 | TASK [use-our-mirror : Copy the podman configuration] 2025-11-15 22:15:45.593393 | controller | skipping: Conditional result was False 2025-11-15 22:15:45.605756 | 2025-11-15 22:15:45.606070 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2025-11-15 22:15:45.623558 | controller | skipping: Conditional result was False 2025-11-15 22:15:45.635066 | 2025-11-15 22:15:45.635164 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2025-11-15 22:15:45.660233 | controller | skipping: Conditional result was False 2025-11-15 22:15:45.675147 | 2025-11-15 22:15:45.675229 | TASK [Disable Fedora Modular] 2025-11-15 22:15:45.925108 | controller | changed 2025-11-15 22:15:45.937191 | 2025-11-15 22:15:45.937347 | TASK [Enable EPEL] 2025-11-15 22:15:45.964024 | controller | skipping: Conditional result was False 2025-11-15 22:15:45.976140 | 2025-11-15 22:15:45.976269 | TASK [Register the RHEL node] 2025-11-15 22:15:46.538342 | 2025-11-15 22:15:46.538631 | TASK [Show the subscription-manager status] 2025-11-15 22:15:47.119876 | controller | skipping: Conditional result was False 2025-11-15 22:15:47.133233 | 2025-11-15 22:15:47.133367 | TASK [Enable EPEL on RHEL] 2025-11-15 22:15:47.685291 | controller | skipping: Conditional result was False 2025-11-15 22:15:47.697944 | 2025-11-15 22:15:47.698107 | TASK [Install git and tox] 2025-11-15 22:17:09.607017 | controller | changed 2025-11-15 22:17:09.620118 | 2025-11-15 22:17:09.620248 | TASK [include_role : prepare-workspace] 2025-11-15 22:17:09.657645 | controller | ok 2025-11-15 22:17:09.693329 | 2025-11-15 22:17:09.693422 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-11-15 22:17:09.944556 | controller | ok 2025-11-15 22:17:09.957946 | 2025-11-15 22:17:09.958080 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-11-15 22:17:11.552076 | controller | Output suppressed because no_log was given 2025-11-15 22:17:11.573850 | 2025-11-15 22:17:11.573980 | TASK [include_role : prepare-workspace-openshift] 2025-11-15 22:17:11.601134 | controller | skipping: Conditional result was False 2025-11-15 22:17:11.630315 | 2025-11-15 22:17:11.630384 | PLAY [all:!appliance] 2025-11-15 22:17:11.652709 | 2025-11-15 22:17:11.652798 | TASK [Run add-build-sshkey role (RSA)] 2025-11-15 22:17:11.684762 | controller | ok 2025-11-15 22:17:11.704626 | 2025-11-15 22:17:11.704730 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-15 22:17:12.012014 | controller -> localhost | ok 2025-11-15 22:17:12.024201 | 2025-11-15 22:17:12.024331 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-15 22:17:12.053017 | controller | ok 2025-11-15 22:17:12.080285 | controller | included: /var/lib/zuul/builds/caa34fd872ea4962b9e9ef2c371d540a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-15 22:17:12.088118 | 2025-11-15 22:17:12.088199 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-15 22:17:12.491170 | controller -> localhost | Generating public/private rsa key pair. 2025-11-15 22:17:12.491453 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/caa34fd872ea4962b9e9ef2c371d540a/work/caa34fd872ea4962b9e9ef2c371d540a_id_rsa. 2025-11-15 22:17:12.491513 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/caa34fd872ea4962b9e9ef2c371d540a/work/caa34fd872ea4962b9e9ef2c371d540a_id_rsa.pub. 2025-11-15 22:17:12.491560 | controller -> localhost | The key fingerprint is: 2025-11-15 22:17:12.491605 | controller -> localhost | SHA256:4vaGVan8mPO1PFYyFHsHxX2/wfVYdByaxJXLOm5uxGQ zuul-build-sshkey 2025-11-15 22:17:12.491649 | controller -> localhost | The key's randomart image is: 2025-11-15 22:17:12.491731 | controller -> localhost | +---[RSA 2048]----+ 2025-11-15 22:17:12.491777 | controller -> localhost | | ...BB| 2025-11-15 22:17:12.491819 | controller -> localhost | | o.+.O| 2025-11-15 22:17:12.491860 | controller -> localhost | | . =o+*| 2025-11-15 22:17:12.491900 | controller -> localhost | | o oEo=+| 2025-11-15 22:17:12.491939 | controller -> localhost | | ..So .+...o| 2025-11-15 22:17:12.491995 | controller -> localhost | | . .+ o=.. | 2025-11-15 22:17:12.492045 | controller -> localhost | | oo + ++. | 2025-11-15 22:17:12.492087 | controller -> localhost | | ...= .oo= | 2025-11-15 22:17:12.492126 | controller -> localhost | | ..o..*o | 2025-11-15 22:17:12.492171 | controller -> localhost | +----[SHA256]-----+ 2025-11-15 22:17:12.492251 | controller -> localhost | ok: Runtime: 0:00:00.033973 2025-11-15 22:17:12.507089 | 2025-11-15 22:17:12.507217 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-15 22:17:12.545902 | controller | ok 2025-11-15 22:17:12.566403 | controller | included: /var/lib/zuul/builds/caa34fd872ea4962b9e9ef2c371d540a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-15 22:17:12.579796 | 2025-11-15 22:17:12.579885 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-15 22:17:12.604822 | controller | skipping: Conditional result was False 2025-11-15 22:17:12.615180 | 2025-11-15 22:17:12.615267 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-15 22:17:13.008718 | controller | changed 2025-11-15 22:17:13.025732 | 2025-11-15 22:17:13.025863 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-15 22:17:13.258196 | controller | ok 2025-11-15 22:17:13.270539 | 2025-11-15 22:17:13.270669 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-15 22:17:13.909598 | controller | changed 2025-11-15 22:17:13.923237 | 2025-11-15 22:17:13.923369 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-15 22:17:14.563583 | controller | changed 2025-11-15 22:17:14.576008 | 2025-11-15 22:17:14.576158 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-15 22:17:14.603499 | controller | skipping: Conditional result was False 2025-11-15 22:17:14.618886 | 2025-11-15 22:17:14.619092 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-15 22:17:15.003669 | controller -> localhost | changed 2025-11-15 22:17:15.029259 | 2025-11-15 22:17:15.029394 | TASK [add-build-sshkey : Add back temp key] 2025-11-15 22:17:15.362439 | controller -> localhost | Identity added: /var/lib/zuul/builds/caa34fd872ea4962b9e9ef2c371d540a/work/caa34fd872ea4962b9e9ef2c371d540a_id_rsa (zuul-build-sshkey) 2025-11-15 22:17:15.362831 | controller -> localhost | ok: Runtime: 0:00:00.013144 2025-11-15 22:17:15.376164 | 2025-11-15 22:17:15.376291 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-15 22:17:15.711764 | controller | ok 2025-11-15 22:17:15.723290 | 2025-11-15 22:17:15.723450 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-15 22:17:15.759808 | controller | skipping: Conditional result was False 2025-11-15 22:17:15.784633 | 2025-11-15 22:17:15.784797 | TASK [Run add-build-sshkey role (ECDSA)] 2025-11-15 22:17:15.822068 | controller | ok 2025-11-15 22:17:15.851170 | 2025-11-15 22:17:15.851253 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-15 22:17:16.141877 | controller -> localhost | ok 2025-11-15 22:17:16.156836 | 2025-11-15 22:17:16.156982 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-15 22:17:16.197046 | controller | ok 2025-11-15 22:17:16.223484 | controller | included: /var/lib/zuul/builds/caa34fd872ea4962b9e9ef2c371d540a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-15 22:17:16.231900 | 2025-11-15 22:17:16.231984 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-15 22:17:16.564460 | controller -> localhost | Generating public/private ecdsa key pair. 2025-11-15 22:17:16.564887 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/caa34fd872ea4962b9e9ef2c371d540a/work/caa34fd872ea4962b9e9ef2c371d540a_id_ecdsa. 2025-11-15 22:17:16.564952 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/caa34fd872ea4962b9e9ef2c371d540a/work/caa34fd872ea4962b9e9ef2c371d540a_id_ecdsa.pub. 2025-11-15 22:17:16.565013 | controller -> localhost | The key fingerprint is: 2025-11-15 22:17:16.565060 | controller -> localhost | SHA256:+/MxLlkZzneKUH1rzksNDuhifQbfSfRSdpjVNh0YH4o zuul-build-sshkey 2025-11-15 22:17:16.565104 | controller -> localhost | The key's randomart image is: 2025-11-15 22:17:16.565147 | controller -> localhost | +---[ECDSA 521]---+ 2025-11-15 22:17:16.565190 | controller -> localhost | | .oo=| 2025-11-15 22:17:16.565247 | controller -> localhost | | ..o==| 2025-11-15 22:17:16.565309 | controller -> localhost | | E o+o=| 2025-11-15 22:17:16.565362 | controller -> localhost | | .o..+o| 2025-11-15 22:17:16.565405 | controller -> localhost | | S o+.o+.o| 2025-11-15 22:17:16.565446 | controller -> localhost | | +.o==.*o| 2025-11-15 22:17:16.565485 | controller -> localhost | | + o+*oB+.| 2025-11-15 22:17:16.565525 | controller -> localhost | | . o++.ooo | 2025-11-15 22:17:16.565565 | controller -> localhost | | .+o ..| 2025-11-15 22:17:16.565604 | controller -> localhost | +----[SHA256]-----+ 2025-11-15 22:17:16.565769 | controller -> localhost | ok: Runtime: 0:00:00.014726 2025-11-15 22:17:16.580108 | 2025-11-15 22:17:16.580277 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-15 22:17:16.621430 | controller | ok 2025-11-15 22:17:16.638190 | controller | included: /var/lib/zuul/builds/caa34fd872ea4962b9e9ef2c371d540a/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-15 22:17:16.655844 | 2025-11-15 22:17:16.655948 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-15 22:17:16.681659 | controller | skipping: Conditional result was False 2025-11-15 22:17:16.690797 | 2025-11-15 22:17:16.690886 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-15 22:17:16.962056 | controller | changed 2025-11-15 22:17:16.974311 | 2025-11-15 22:17:16.974444 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-15 22:17:17.197544 | controller | ok 2025-11-15 22:17:17.212245 | 2025-11-15 22:17:17.212386 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-15 22:17:17.832385 | controller | changed 2025-11-15 22:17:17.845153 | 2025-11-15 22:17:17.845288 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-15 22:17:18.477089 | controller | changed 2025-11-15 22:17:18.491133 | 2025-11-15 22:17:18.491265 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-15 22:17:18.518348 | controller | skipping: Conditional result was False 2025-11-15 22:17:18.532656 | 2025-11-15 22:17:18.532838 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-15 22:17:18.805282 | controller -> localhost | changed 2025-11-15 22:17:18.816803 | 2025-11-15 22:17:18.816869 | TASK [add-build-sshkey : Add back temp key] 2025-11-15 22:17:19.136153 | controller -> localhost | Identity added: /var/lib/zuul/builds/caa34fd872ea4962b9e9ef2c371d540a/work/caa34fd872ea4962b9e9ef2c371d540a_id_ecdsa (zuul-build-sshkey) 2025-11-15 22:17:19.136398 | controller -> localhost | ok: Runtime: 0:00:00.012062 2025-11-15 22:17:19.143652 | 2025-11-15 22:17:19.143757 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-15 22:17:19.358426 | controller | ok 2025-11-15 22:17:19.363672 | 2025-11-15 22:17:19.363757 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-15 22:17:19.398008 | controller | skipping: Conditional result was False 2025-11-15 22:17:19.409259 | 2025-11-15 22:17:19.409321 | TASK [include_role : remove-zuul-sshkey] 2025-11-15 22:17:19.433255 | controller | skipping: Conditional result was False 2025-11-15 22:17:19.439807 | 2025-11-15 22:17:19.439869 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2025-11-15 22:17:19.664929 | controller | ok: "logs" 2025-11-15 22:17:19.665194 | controller | ok: All items complete 2025-11-15 22:17:19.665222 | 2025-11-15 22:17:19.856490 | controller | ok: "artifacts" 2025-11-15 22:17:20.098928 | controller | ok: "docs" 2025-11-15 22:17:20.114939 | 2025-11-15 22:17:20.115025 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2025-11-15 22:17:20.372465 | controller | changed: "logs" 2025-11-15 22:17:20.569365 | controller | changed: "artifacts" 2025-11-15 22:17:20.771591 | controller | changed: "docs" 2025-11-15 22:17:20.826906 | 2025-11-15 22:17:20.826997 | PLAY RECAP 2025-11-15 22:17:20.827054 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2025-11-15 22:17:20.827091 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-11-15 22:17:20.827116 | 2025-11-15 22:17:20.937463 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2025-11-15 22:17:20.938441 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master] 2025-11-15 22:17:21.490024 | 2025-11-15 22:17:21.490168 | PLAY [all] 2025-11-15 22:17:21.509824 | 2025-11-15 22:17:21.509892 | TASK [Setup ensure-tox role] 2025-11-15 22:17:21.528933 | controller | ok 2025-11-15 22:17:21.551069 | 2025-11-15 22:17:21.551137 | TASK [Install pip] 2025-11-15 22:17:21.569646 | controller | ok 2025-11-15 22:17:21.590100 | 2025-11-15 22:17:21.590166 | TASK [ensure-pip : Check if pip is installed] 2025-11-15 22:17:21.975082 | controller | /usr/bin/pip3 2025-11-15 22:17:21.990174 | controller | /usr/bin/python3: No module named wheel 2025-11-15 22:17:22.121137 | controller | ok: Runtime: 0:00:00.023207 2025-11-15 22:17:22.133339 | 2025-11-15 22:17:22.133487 | LOOP [ensure-pip : Install pip from packages] 2025-11-15 22:17:22.183011 | controller | ok: "/var/lib/zuul/builds/caa34fd872ea4962b9e9ef2c371d540a/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml" 2025-11-15 22:17:22.200382 | controller | included: /var/lib/zuul/builds/caa34fd872ea4962b9e9ef2c371d540a/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml 2025-11-15 22:17:22.220450 | 2025-11-15 22:17:22.220583 | TASK [ensure-pip : Install Python 3 pip] 2025-11-15 22:17:27.248587 | controller | changed 2025-11-15 22:17:27.260906 | 2025-11-15 22:17:27.261036 | TASK [ensure-pip : Check for EPEL repository] 2025-11-15 22:17:27.287765 | controller | skipping: Conditional result was False 2025-11-15 22:17:27.301108 | 2025-11-15 22:17:27.301250 | TASK [ensure-pip : Fail with instructions when EPEL is not installed] 2025-11-15 22:17:27.328606 | controller | skipping: Conditional result was False 2025-11-15 22:17:27.342503 | 2025-11-15 22:17:27.342651 | TASK [ensure-pip : Install Python 2 pip] 2025-11-15 22:17:27.369330 | controller | skipping: Conditional result was False 2025-11-15 22:17:27.382013 | 2025-11-15 22:17:27.382147 | TASK [ensure-pip : Ensure setuptools] 2025-11-15 22:17:27.408583 | controller | skipping: Conditional result was False 2025-11-15 22:17:27.424656 | 2025-11-15 22:17:27.424816 | TASK [ensure-pip : Check for ensurepip module] 2025-11-15 22:17:27.969478 | controller | skipping: Conditional result was False 2025-11-15 22:17:27.983238 | 2025-11-15 22:17:27.983374 | TASK [ensure-pip : Ensure python3-venv] 2025-11-15 22:17:28.010767 | controller | skipping: Conditional result was False 2025-11-15 22:17:28.024437 | 2025-11-15 22:17:28.024585 | TASK [ensure-pip : Install pip from source] 2025-11-15 22:17:28.051979 | controller | skipping: Conditional result was False 2025-11-15 22:17:28.065178 | 2025-11-15 22:17:28.065313 | TASK [ensure-pip : Probe for venv python full path] 2025-11-15 22:17:28.464626 | controller | /usr/bin/python3 2025-11-15 22:17:28.613129 | controller | ok: Runtime: 0:00:00.003078 2025-11-15 22:17:28.627906 | 2025-11-15 22:17:28.628061 | TASK [ensure-pip : Set host default] 2025-11-15 22:17:28.718021 | controller | ok 2025-11-15 22:17:28.730254 | 2025-11-15 22:17:28.730379 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2025-11-15 22:17:28.801182 | controller | ok 2025-11-15 22:17:28.824015 | 2025-11-15 22:17:28.824143 | TASK [ensure-tox : Check if tox is installed] 2025-11-15 22:17:29.084939 | controller | /usr/bin/tox 2025-11-15 22:17:29.366516 | controller | ok: Runtime: 0:00:00.003352 2025-11-15 22:17:29.379790 | 2025-11-15 22:17:29.379926 | TASK [ensure-tox : Export preinstalled tox_exectuable] 2025-11-15 22:17:29.419858 | controller | ok 2025-11-15 22:17:29.431212 | 2025-11-15 22:17:29.431340 | TASK [ensure-tox : Create local venv] 2025-11-15 22:17:29.981996 | controller | skipping: Conditional result was False 2025-11-15 22:17:29.998713 | 2025-11-15 22:17:29.998957 | TASK [ensure-tox : Install tox to local venv] 2025-11-15 22:17:30.559656 | controller | skipping: Conditional result was False 2025-11-15 22:17:30.574457 | 2025-11-15 22:17:30.574611 | TASK [ensure-tox : Export installed tox_executable path] 2025-11-15 22:17:30.601905 | controller | skipping: Conditional result was False 2025-11-15 22:17:30.614570 | 2025-11-15 22:17:30.614739 | TASK [ensure-tox : Output tox version] 2025-11-15 22:17:30.999265 | controller | 3.28.0 imported from /usr/lib/python3.11/site-packages/tox/__init__.py 2025-11-15 22:17:31.177665 | controller | ok: Runtime: 0:00:00.139800 2025-11-15 22:17:31.191575 | 2025-11-15 22:17:31.191744 | TASK [ensure-tox : Make global symlink] 2025-11-15 22:17:31.219189 | controller | skipping: Conditional result was False 2025-11-15 22:17:31.243334 | 2025-11-15 22:17:31.243535 | TASK [Setup tox role] 2025-11-15 22:17:31.274668 | controller | ok 2025-11-15 22:17:31.320776 | 2025-11-15 22:17:31.320924 | TASK [tox : Check to see if the constraints file exists] 2025-11-15 22:17:31.357183 | controller | skipping: Conditional result was False 2025-11-15 22:17:31.370794 | 2025-11-15 22:17:31.370955 | TASK [tox : Fail if constraints file is missing] 2025-11-15 22:17:31.398119 | controller | skipping: Conditional result was False 2025-11-15 22:17:31.412228 | 2025-11-15 22:17:31.412373 | TASK [tox : Record file location] 2025-11-15 22:17:31.449143 | controller | skipping: Conditional result was False 2025-11-15 22:17:31.462908 | 2025-11-15 22:17:31.463067 | TASK [tox : Install tox siblings] 2025-11-15 22:17:31.490076 | controller | skipping: Conditional result was False 2025-11-15 22:17:31.506908 | 2025-11-15 22:17:31.507050 | TASK [tox : Emit tox command] 2025-11-15 22:17:31.565803 | /usr/bin/tox -evenv -vv --notest 2025-11-15 22:17:31.577880 | 2025-11-15 22:17:31.578015 | TASK [tox : Run tox] 2025-11-15 22:17:31.977630 | controller | using tox.ini: /home/zuul/src/github.com/ansible-network/releases/tox.ini (pid 2287) 2025-11-15 22:17:31.984725 | controller | using tox-3.28.0 from /usr/lib/python3.11/site-packages/tox/__init__.py (pid 2287) 2025-11-15 22:17:32.005899 | controller | skipping sdist step 2025-11-15 22:17:32.005919 | controller | venv uses /usr/bin/python3 2025-11-15 22:17:32.005936 | controller | venv start: getenv /home/zuul/src/github.com/ansible-network/releases/.tox/venv 2025-11-15 22:17:32.006278 | controller | venv cannot reuse: no previous config /home/zuul/src/github.com/ansible-network/releases/.tox/venv/.tox-config1 2025-11-15 22:17:32.006292 | controller | venv create: /home/zuul/src/github.com/ansible-network/releases/.tox/venv 2025-11-15 22:17:32.006300 | 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-15 22:17:32.006309 | controller | [2295] /home/zuul/src/github.com/ansible-network/releases/.tox$ /usr/bin/python3 -m virtualenv --no-download --python /usr/bin/python3 venv 2025-11-15 22:17:32.505643 | controller | created virtual environment CPython3.11.0.final.0-64 in 418ms 2025-11-15 22:17:32.523123 | controller | creator CPython3Posix(dest=/home/zuul/src/github.com/ansible-network/releases/.tox/venv, clear=False, no_vcs_ignore=False, global=False) 2025-11-15 22:17:32.523152 | 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-15 22:17:32.523161 | controller | added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1 2025-11-15 22:17:32.523166 | controller | activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator 2025-11-15 22:17:32.523175 | 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-15 22:17:32.523498 | 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-15 22:17:32.523515 | controller | [2303] /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-15 22:22:09.741428 | [Zuul] Log Stream did not terminate 2025-11-15 22:22:09.741765 | controller | ERROR 2025-11-15 22:22:09.741919 | controller | { 2025-11-15 22:22:09.741974 | controller | "msg": "Data could not be sent to remote host \"162.253.55.195\". Make sure this host can be reached over ssh: ssh: connect to host 162.253.55.195 port 22: No route to host\r\n", 2025-11-15 22:22:09.742017 | controller | "unreachable": true 2025-11-15 22:22:09.742054 | controller | } unreachable 2025-11-15 22:22:09.745926 | 2025-11-15 22:22:09.746023 | PLAY RECAP 2025-11-15 22:22:09.746102 | controller | ok: 10 changed: 5 unreachable: 1 failed: 0 skipped: 15 rescued: 0 ignored: 0 2025-11-15 22:22:09.746148 | 2025-11-15 22:22:09.860619 | PRE-RUN END RESULT_UNREACHABLE: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master] 2025-11-15 22:22:09.861400 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2025-11-15 22:22:10.411312 | 2025-11-15 22:22:10.411415 | PLAY [all:!appliance*] 2025-11-15 22:22:10.432797 | 2025-11-15 22:22:10.432874 | TASK [unregister the node] 2025-11-15 22:22:12.937349 | [controller] Waiting on logger 2025-11-15 22:22:33.404654 | controller | skipping: Conditional result was False 2025-11-15 22:22:33.416505 | 2025-11-15 22:22:33.416658 | TASK [include_role : fetch-output] 2025-11-15 22:22:33.464518 | controller | ok 2025-11-15 22:22:33.501845 | 2025-11-15 22:22:33.501938 | TASK [fetch-output : Set log path for multiple nodes] 2025-11-15 22:22:33.567461 | controller | skipping: Conditional result was False 2025-11-15 22:22:33.580431 | 2025-11-15 22:22:33.580571 | TASK [fetch-output : Set log path for single node] 2025-11-15 22:22:33.617528 | controller | ok 2025-11-15 22:22:33.628909 | 2025-11-15 22:22:33.629038 | LOOP [fetch-output : Ensure local output dirs] 2025-11-15 22:22:34.054164 | controller -> localhost | ok: "/var/lib/zuul/builds/caa34fd872ea4962b9e9ef2c371d540a/work/logs" 2025-11-15 22:22:34.279862 | controller -> localhost | changed: "/var/lib/zuul/builds/caa34fd872ea4962b9e9ef2c371d540a/work/artifacts" 2025-11-15 22:22:34.475265 | controller -> localhost | changed: "/var/lib/zuul/builds/caa34fd872ea4962b9e9ef2c371d540a/work/docs" 2025-11-15 22:22:34.488325 | 2025-11-15 22:22:34.488446 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-11-15 22:22:35.179769 | controller | ok 2025-11-15 22:22:35.179968 | controller | changed: All items complete 2025-11-15 22:22:35.179993 | 2025-11-15 22:22:35.730620 | controller | changed: .d..t...... ./ 2025-11-15 22:22:36.271428 | controller | changed: .d..t...... ./ 2025-11-15 22:22:36.298592 | 2025-11-15 22:22:36.298832 | TASK [include_role : fetch-output-openshift] 2025-11-15 22:22:36.326609 | controller | skipping: Conditional result was False 2025-11-15 22:22:36.340175 | 2025-11-15 22:22:36.340312 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2025-11-15 22:22:36.802134 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.012945 2025-11-15 22:22:37.085124 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.012922 2025-11-15 22:22:37.145925 | 2025-11-15 22:22:37.146067 | PLAY [localhost] 2025-11-15 22:22:37.163117 | 2025-11-15 22:22:37.163252 | TASK [Run Zuul manifest role] 2025-11-15 22:22:37.185921 | localhost | ok 2025-11-15 22:22:37.204492 | 2025-11-15 22:22:37.204639 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-11-15 22:22:37.625715 | localhost | changed 2025-11-15 22:22:37.635136 | 2025-11-15 22:22:37.635275 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-11-15 22:22:37.681321 | localhost | ok 2025-11-15 22:22:37.698445 | 2025-11-15 22:22:37.698623 | TASK [Set zuul-log-path fact] 2025-11-15 22:22:37.724365 | localhost | ok 2025-11-15 22:22:37.751351 | 2025-11-15 22:22:37.751502 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-15 22:22:37.796555 | localhost | ok 2025-11-15 22:22:37.813432 | 2025-11-15 22:22:37.813547 | LOOP [Run upload-logs-swift role] 2025-11-15 22:22:37.851548 | localhost | Output suppressed because no_log was given 2025-11-15 22:22:37.896742 | 2025-11-15 22:22:37.896846 | TASK [Set zuul-log-path fact] 2025-11-15 22:22:37.932310 | localhost | skipping: Conditional result was False 2025-11-15 22:22:37.946497 | 2025-11-15 22:22:37.946714 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2025-11-15 22:22:38.287871 | localhost -> localhost | ok: Runtime: 0:00:00.008025 2025-11-15 22:22:38.292870 | 2025-11-15 22:22:38.292934 | TASK [upload-logs-swift : Upload logs to swift]