2025-11-18 17:15:20.649671 | Job console starting... 2025-11-18 17:15:20.660261 | Updating repositories 2025-11-18 17:15:20.697652 | Preparing job workspace 2025-11-18 17:15:24.845747 | Running Ansible setup... 2025-11-18 17:15:29.558935 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2025-11-18 17:15:30.132495 | 2025-11-18 17:15:30.132604 | PLAY [localhost] 2025-11-18 17:15:30.140563 | 2025-11-18 17:15:30.140631 | TASK [Gathering Facts] 2025-11-18 17:15:31.105003 | localhost | ok 2025-11-18 17:15:31.134016 | 2025-11-18 17:15:31.134168 | TASK [Setup log path fact] 2025-11-18 17:15:31.158611 | localhost | ok 2025-11-18 17:15:31.183839 | 2025-11-18 17:15:31.183926 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-18 17:15:31.216053 | localhost | ok 2025-11-18 17:15:31.232899 | 2025-11-18 17:15:31.233040 | TASK [emit-job-header : Print job information] 2025-11-18 17:15:31.265834 | # Job Information 2025-11-18 17:15:31.266042 | Ansible Version: 2.15.12 2025-11-18 17:15:31.266108 | Job: ansible-galaxy-importer 2025-11-18 17:15:31.266152 | Pipeline: third-party-check 2025-11-18 17:15:31.266194 | Executor: ze04.softwarefactory-project.io 2025-11-18 17:15:31.266233 | Triggered by: https://github.com/ansible-collections/hetzner.hcloud/pull/745 2025-11-18 17:15:31.266279 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/707/ansible/70791bec920e4984938ca28c63647555/ 2025-11-18 17:15:31.266320 | Event ID: 40915350-c4a1-11f0-99d9-e0e1900da737 2025-11-18 17:15:31.274179 | 2025-11-18 17:15:31.274305 | LOOP [emit-job-header : Print node information] 2025-11-18 17:15:31.371939 | localhost | ok: 2025-11-18 17:15:31.372392 | localhost | # Node Information 2025-11-18 17:15:31.372470 | localhost | Inventory Hostname: controller 2025-11-18 17:15:31.372524 | localhost | Hostname: np0005527080 2025-11-18 17:15:31.372567 | localhost | Username: zuul 2025-11-18 17:15:31.372612 | localhost | Distro: Fedora 37 2025-11-18 17:15:31.372654 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2025-11-18 17:15:31.372737 | localhost | Region: ca-ymq-1 2025-11-18 17:15:31.372781 | localhost | Label: ansible-fedora-37-1vcpu 2025-11-18 17:15:31.372820 | localhost | Product Name: OpenStack Nova 2025-11-18 17:15:31.372857 | localhost | Interface IP: 162.253.55.145 2025-11-18 17:15:31.400230 | 2025-11-18 17:15:31.400400 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-11-18 17:15:31.804779 | localhost -> localhost | changed 2025-11-18 17:15:31.816081 | 2025-11-18 17:15:31.816220 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-11-18 17:15:32.678982 | localhost -> localhost | changed 2025-11-18 17:15:32.698764 | 2025-11-18 17:15:32.698846 | PLAY [all:!appliance*] 2025-11-18 17:15:32.714292 | 2025-11-18 17:15:32.714364 | TASK [include_role : start-zuul-console] 2025-11-18 17:15:32.733765 | controller | ok 2025-11-18 17:15:32.747261 | 2025-11-18 17:15:32.747323 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-11-18 17:15:33.118631 | controller | ok 2025-11-18 17:15:33.134518 | 2025-11-18 17:15:33.134615 | TASK [use-our-mirror : Retrieve the IP address] 2025-11-18 17:15:34.141138 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2025-11-18 17:15:34.159430 | 2025-11-18 17:15:34.159642 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2025-11-18 17:15:34.715310 | controller | skipping: Conditional result was False 2025-11-18 17:15:34.728426 | 2025-11-18 17:15:34.728569 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2025-11-18 17:15:34.756092 | controller | skipping: Conditional result was False 2025-11-18 17:15:34.770508 | 2025-11-18 17:15:34.770642 | TASK [use-our-mirror : Create the podman configuration directory] 2025-11-18 17:15:34.787511 | controller | skipping: Conditional result was False 2025-11-18 17:15:34.800942 | 2025-11-18 17:15:34.801083 | TASK [use-our-mirror : Copy the podman configuration] 2025-11-18 17:15:34.827941 | controller | skipping: Conditional result was False 2025-11-18 17:15:34.840402 | 2025-11-18 17:15:34.840705 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2025-11-18 17:15:34.867523 | controller | skipping: Conditional result was False 2025-11-18 17:15:34.879954 | 2025-11-18 17:15:34.880097 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2025-11-18 17:15:34.906944 | controller | skipping: Conditional result was False 2025-11-18 17:15:34.931493 | 2025-11-18 17:15:34.931620 | TASK [Disable Fedora Modular] 2025-11-18 17:15:35.182258 | controller | changed 2025-11-18 17:15:35.193939 | 2025-11-18 17:15:35.194066 | TASK [Enable EPEL] 2025-11-18 17:15:35.221227 | controller | skipping: Conditional result was False 2025-11-18 17:15:35.234145 | 2025-11-18 17:15:35.234273 | TASK [Register the RHEL node] 2025-11-18 17:15:35.796798 | 2025-11-18 17:15:35.797034 | TASK [Show the subscription-manager status] 2025-11-18 17:15:36.376149 | controller | skipping: Conditional result was False 2025-11-18 17:15:36.389077 | 2025-11-18 17:15:36.389213 | TASK [Enable EPEL on RHEL] 2025-11-18 17:15:36.950811 | controller | skipping: Conditional result was False 2025-11-18 17:15:36.962961 | 2025-11-18 17:15:36.963086 | TASK [Install git and tox] 2025-11-18 17:16:58.415434 | controller | changed 2025-11-18 17:16:58.430282 | 2025-11-18 17:16:58.430422 | TASK [include_role : prepare-workspace] 2025-11-18 17:16:58.469990 | controller | ok 2025-11-18 17:16:58.509196 | 2025-11-18 17:16:58.509352 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-11-18 17:16:58.750419 | controller | ok 2025-11-18 17:16:58.764093 | 2025-11-18 17:16:58.764268 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-11-18 17:16:59.792933 | controller | Output suppressed because no_log was given 2025-11-18 17:16:59.815101 | 2025-11-18 17:16:59.815238 | TASK [include_role : prepare-workspace-openshift] 2025-11-18 17:16:59.841944 | controller | skipping: Conditional result was False 2025-11-18 17:16:59.882308 | 2025-11-18 17:16:59.882380 | PLAY [all:!appliance] 2025-11-18 17:16:59.903389 | 2025-11-18 17:16:59.903471 | TASK [Run add-build-sshkey role (RSA)] 2025-11-18 17:16:59.934847 | controller | ok 2025-11-18 17:16:59.954481 | 2025-11-18 17:16:59.954564 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-18 17:17:00.233616 | controller -> localhost | ok 2025-11-18 17:17:00.247084 | 2025-11-18 17:17:00.247216 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-18 17:17:00.287051 | controller | ok 2025-11-18 17:17:00.315088 | controller | included: /var/lib/zuul/builds/70791bec920e4984938ca28c63647555/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-18 17:17:00.322920 | 2025-11-18 17:17:00.323002 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-18 17:17:00.921605 | controller -> localhost | Generating public/private rsa key pair. 2025-11-18 17:17:00.921978 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/70791bec920e4984938ca28c63647555/work/70791bec920e4984938ca28c63647555_id_rsa. 2025-11-18 17:17:00.922041 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/70791bec920e4984938ca28c63647555/work/70791bec920e4984938ca28c63647555_id_rsa.pub. 2025-11-18 17:17:00.922085 | controller -> localhost | The key fingerprint is: 2025-11-18 17:17:00.922128 | controller -> localhost | SHA256:ECXujpaEF/ePailOsFQ0HVP9bDK9SsKG7vgGbmQgqYM zuul-build-sshkey 2025-11-18 17:17:00.922173 | controller -> localhost | The key's randomart image is: 2025-11-18 17:17:00.922213 | controller -> localhost | +---[RSA 2048]----+ 2025-11-18 17:17:00.922251 | controller -> localhost | | o.=+o. | 2025-11-18 17:17:00.922292 | controller -> localhost | | . o.+ . | 2025-11-18 17:17:00.922330 | controller -> localhost | | . o + + | 2025-11-18 17:17:00.922369 | controller -> localhost | |o .o + o o = | 2025-11-18 17:17:00.922407 | controller -> localhost | |o.+.o .oS + . | 2025-11-18 17:17:00.922460 | controller -> localhost | |E. =++. +o. . | 2025-11-18 17:17:00.922508 | controller -> localhost | | ..+=o.o.o.. | 2025-11-18 17:17:00.922549 | controller -> localhost | | o+.=. . | 2025-11-18 17:17:00.922590 | controller -> localhost | | oo*+ | 2025-11-18 17:17:00.922634 | controller -> localhost | +----[SHA256]-----+ 2025-11-18 17:17:00.922753 | controller -> localhost | ok: Runtime: 0:00:00.141997 2025-11-18 17:17:00.936158 | 2025-11-18 17:17:00.936292 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-18 17:17:00.974476 | controller | ok 2025-11-18 17:17:01.026321 | controller | included: /var/lib/zuul/builds/70791bec920e4984938ca28c63647555/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-18 17:17:01.037277 | 2025-11-18 17:17:01.037336 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-18 17:17:01.061407 | controller | skipping: Conditional result was False 2025-11-18 17:17:01.067806 | 2025-11-18 17:17:01.067867 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-18 17:17:01.450265 | controller | changed 2025-11-18 17:17:01.462312 | 2025-11-18 17:17:01.462445 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-18 17:17:01.686196 | controller | ok 2025-11-18 17:17:01.698054 | 2025-11-18 17:17:01.698183 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-18 17:17:02.336946 | controller | changed 2025-11-18 17:17:02.349764 | 2025-11-18 17:17:02.349901 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-18 17:17:03.010094 | controller | changed 2025-11-18 17:17:03.023051 | 2025-11-18 17:17:03.023191 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-18 17:17:03.051011 | controller | skipping: Conditional result was False 2025-11-18 17:17:03.064952 | 2025-11-18 17:17:03.065093 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-18 17:17:03.462160 | controller -> localhost | changed 2025-11-18 17:17:03.486881 | 2025-11-18 17:17:03.487013 | TASK [add-build-sshkey : Add back temp key] 2025-11-18 17:17:03.777896 | controller -> localhost | Identity added: /var/lib/zuul/builds/70791bec920e4984938ca28c63647555/work/70791bec920e4984938ca28c63647555_id_rsa (zuul-build-sshkey) 2025-11-18 17:17:03.778132 | controller -> localhost | ok: Runtime: 0:00:00.012311 2025-11-18 17:17:03.788588 | 2025-11-18 17:17:03.788695 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-18 17:17:04.077620 | controller | ok 2025-11-18 17:17:04.088875 | 2025-11-18 17:17:04.089006 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-18 17:17:04.125854 | controller | skipping: Conditional result was False 2025-11-18 17:17:04.152082 | 2025-11-18 17:17:04.152245 | TASK [Run add-build-sshkey role (ECDSA)] 2025-11-18 17:17:04.189797 | controller | ok 2025-11-18 17:17:04.221231 | 2025-11-18 17:17:04.221369 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-11-18 17:17:04.500731 | controller -> localhost | ok 2025-11-18 17:17:04.507231 | 2025-11-18 17:17:04.507295 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-11-18 17:17:04.539580 | controller | ok 2025-11-18 17:17:04.555429 | controller | included: /var/lib/zuul/builds/70791bec920e4984938ca28c63647555/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-11-18 17:17:04.563974 | 2025-11-18 17:17:04.564059 | TASK [add-build-sshkey : Create Temp SSH key] 2025-11-18 17:17:04.897790 | controller -> localhost | Generating public/private ecdsa key pair. 2025-11-18 17:17:04.897983 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/70791bec920e4984938ca28c63647555/work/70791bec920e4984938ca28c63647555_id_ecdsa. 2025-11-18 17:17:04.898011 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/70791bec920e4984938ca28c63647555/work/70791bec920e4984938ca28c63647555_id_ecdsa.pub. 2025-11-18 17:17:04.898039 | controller -> localhost | The key fingerprint is: 2025-11-18 17:17:04.898059 | controller -> localhost | SHA256:/akt5vml8r5UvArShCmiVmQgHqkhQFj5cGPyGjQJwFI zuul-build-sshkey 2025-11-18 17:17:04.898078 | controller -> localhost | The key's randomart image is: 2025-11-18 17:17:04.898097 | controller -> localhost | +---[ECDSA 521]---+ 2025-11-18 17:17:04.898115 | controller -> localhost | |@*Eo | 2025-11-18 17:17:04.898132 | controller -> localhost | |*+O.+ | 2025-11-18 17:17:04.898150 | controller -> localhost | |++ Oo. | 2025-11-18 17:17:04.898167 | controller -> localhost | |. .oo + . | 2025-11-18 17:17:04.898184 | controller -> localhost | | oo . S o o | 2025-11-18 17:17:04.898202 | controller -> localhost | | .o . . o . o . | 2025-11-18 17:17:04.898220 | controller -> localhost | | o . o + o | 2025-11-18 17:17:04.898240 | controller -> localhost | | . .+* + | 2025-11-18 17:17:04.898257 | controller -> localhost | | o+*O. | 2025-11-18 17:17:04.898275 | controller -> localhost | +----[SHA256]-----+ 2025-11-18 17:17:04.898328 | controller -> localhost | ok: Runtime: 0:00:00.014048 2025-11-18 17:17:04.904791 | 2025-11-18 17:17:04.904852 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-11-18 17:17:04.934447 | controller | ok 2025-11-18 17:17:04.941846 | controller | included: /var/lib/zuul/builds/70791bec920e4984938ca28c63647555/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-11-18 17:17:04.950315 | 2025-11-18 17:17:04.950378 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-11-18 17:17:04.974138 | controller | skipping: Conditional result was False 2025-11-18 17:17:04.980535 | 2025-11-18 17:17:04.980599 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-11-18 17:17:05.261593 | controller | changed 2025-11-18 17:17:05.273425 | 2025-11-18 17:17:05.273556 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-11-18 17:17:05.504637 | controller | ok 2025-11-18 17:17:05.516706 | 2025-11-18 17:17:05.516851 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-11-18 17:17:06.165391 | controller | changed 2025-11-18 17:17:06.177373 | 2025-11-18 17:17:06.177507 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-11-18 17:17:06.828473 | controller | changed 2025-11-18 17:17:06.841010 | 2025-11-18 17:17:06.841142 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-11-18 17:17:06.867651 | controller | skipping: Conditional result was False 2025-11-18 17:17:06.881197 | 2025-11-18 17:17:06.881338 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-11-18 17:17:07.161929 | controller -> localhost | changed 2025-11-18 17:17:07.178965 | 2025-11-18 17:17:07.179060 | TASK [add-build-sshkey : Add back temp key] 2025-11-18 17:17:07.487756 | controller -> localhost | Identity added: /var/lib/zuul/builds/70791bec920e4984938ca28c63647555/work/70791bec920e4984938ca28c63647555_id_ecdsa (zuul-build-sshkey) 2025-11-18 17:17:07.487992 | controller -> localhost | ok: Runtime: 0:00:00.012558 2025-11-18 17:17:07.496476 | 2025-11-18 17:17:07.496560 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-11-18 17:17:07.716385 | controller | ok 2025-11-18 17:17:07.728035 | 2025-11-18 17:17:07.728183 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-11-18 17:17:07.765122 | controller | skipping: Conditional result was False 2025-11-18 17:17:07.790904 | 2025-11-18 17:17:07.791034 | TASK [include_role : remove-zuul-sshkey] 2025-11-18 17:17:07.817308 | controller | skipping: Conditional result was False 2025-11-18 17:17:07.825484 | 2025-11-18 17:17:07.825569 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2025-11-18 17:17:08.080407 | controller | ok: "logs" 2025-11-18 17:17:08.080877 | controller | ok: All items complete 2025-11-18 17:17:08.080938 | 2025-11-18 17:17:08.281673 | controller | ok: "artifacts" 2025-11-18 17:17:08.475656 | controller | ok: "docs" 2025-11-18 17:17:08.500933 | 2025-11-18 17:17:08.501068 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2025-11-18 17:17:08.752708 | controller | changed: "logs" 2025-11-18 17:17:08.960122 | controller | changed: "artifacts" 2025-11-18 17:17:09.153664 | controller | changed: "docs" 2025-11-18 17:17:09.246831 | 2025-11-18 17:17:09.246942 | PLAY RECAP 2025-11-18 17:17:09.246982 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2025-11-18 17:17:09.247007 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-11-18 17:17:09.247024 | 2025-11-18 17:17:09.347830 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2025-11-18 17:17:09.349315 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master] 2025-11-18 17:17:09.934377 | 2025-11-18 17:17:09.934490 | PLAY [all] 2025-11-18 17:17:09.954262 | 2025-11-18 17:17:09.954335 | TASK [Setup ensure-tox role] 2025-11-18 17:17:09.973663 | controller | ok 2025-11-18 17:17:09.996784 | 2025-11-18 17:17:09.996864 | TASK [Install pip] 2025-11-18 17:17:10.016060 | controller | ok 2025-11-18 17:17:10.036923 | 2025-11-18 17:17:10.036987 | TASK [ensure-pip : Check if pip is installed] 2025-11-18 17:17:10.411482 | controller | /usr/bin/pip3 2025-11-18 17:17:10.427534 | controller | /usr/bin/python3: No module named wheel 2025-11-18 17:17:10.567761 | controller | ok: Runtime: 0:00:00.025094 2025-11-18 17:17:10.580505 | 2025-11-18 17:17:10.580638 | LOOP [ensure-pip : Install pip from packages] 2025-11-18 17:17:10.630476 | controller | ok: "/var/lib/zuul/builds/70791bec920e4984938ca28c63647555/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml" 2025-11-18 17:17:10.650169 | controller | included: /var/lib/zuul/builds/70791bec920e4984938ca28c63647555/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml 2025-11-18 17:17:10.675228 | 2025-11-18 17:17:10.675573 | TASK [ensure-pip : Install Python 3 pip] 2025-11-18 17:17:15.256113 | controller | changed 2025-11-18 17:17:15.268626 | 2025-11-18 17:17:15.268791 | TASK [ensure-pip : Check for EPEL repository] 2025-11-18 17:17:15.296269 | controller | skipping: Conditional result was False 2025-11-18 17:17:15.310146 | 2025-11-18 17:17:15.310285 | TASK [ensure-pip : Fail with instructions when EPEL is not installed] 2025-11-18 17:17:15.328172 | controller | skipping: Conditional result was False 2025-11-18 17:17:15.342394 | 2025-11-18 17:17:15.342534 | TASK [ensure-pip : Install Python 2 pip] 2025-11-18 17:17:15.368973 | controller | skipping: Conditional result was False 2025-11-18 17:17:15.381586 | 2025-11-18 17:17:15.381754 | TASK [ensure-pip : Ensure setuptools] 2025-11-18 17:17:15.408028 | controller | skipping: Conditional result was False 2025-11-18 17:17:15.421848 | 2025-11-18 17:17:15.421981 | TASK [ensure-pip : Check for ensurepip module] 2025-11-18 17:17:15.968867 | controller | skipping: Conditional result was False 2025-11-18 17:17:15.981617 | 2025-11-18 17:17:15.981782 | TASK [ensure-pip : Ensure python3-venv] 2025-11-18 17:17:16.008146 | controller | skipping: Conditional result was False 2025-11-18 17:17:16.020818 | 2025-11-18 17:17:16.020952 | TASK [ensure-pip : Install pip from source] 2025-11-18 17:17:16.047269 | controller | skipping: Conditional result was False 2025-11-18 17:17:16.060235 | 2025-11-18 17:17:16.060377 | TASK [ensure-pip : Probe for venv python full path] 2025-11-18 17:17:16.404123 | controller | /usr/bin/python3 2025-11-18 17:17:16.609322 | controller | ok: Runtime: 0:00:00.003894 2025-11-18 17:17:16.658317 | 2025-11-18 17:17:16.658464 | TASK [ensure-pip : Set host default] 2025-11-18 17:17:16.733296 | controller | ok 2025-11-18 17:17:16.740545 | 2025-11-18 17:17:16.740637 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2025-11-18 17:17:16.801506 | controller | ok 2025-11-18 17:17:16.819279 | 2025-11-18 17:17:16.819374 | TASK [ensure-tox : Check if tox is installed] 2025-11-18 17:17:17.080703 | controller | /usr/bin/tox 2025-11-18 17:17:17.357478 | controller | ok: Runtime: 0:00:00.003135 2025-11-18 17:17:17.369330 | 2025-11-18 17:17:17.369457 | TASK [ensure-tox : Export preinstalled tox_exectuable] 2025-11-18 17:17:17.419303 | controller | ok 2025-11-18 17:17:17.430501 | 2025-11-18 17:17:17.430627 | TASK [ensure-tox : Create local venv] 2025-11-18 17:17:17.979632 | controller | skipping: Conditional result was False 2025-11-18 17:17:17.992332 | 2025-11-18 17:17:17.992461 | TASK [ensure-tox : Install tox to local venv] 2025-11-18 17:17:18.546229 | controller | skipping: Conditional result was False 2025-11-18 17:17:18.559086 | 2025-11-18 17:17:18.559226 | TASK [ensure-tox : Export installed tox_executable path] 2025-11-18 17:17:18.585828 | controller | skipping: Conditional result was False 2025-11-18 17:17:18.597911 | 2025-11-18 17:17:18.598044 | TASK [ensure-tox : Output tox version] 2025-11-18 17:17:18.982459 | controller | 3.28.0 imported from /usr/lib/python3.11/site-packages/tox/__init__.py 2025-11-18 17:17:19.147635 | controller | ok: Runtime: 0:00:00.136256 2025-11-18 17:17:19.159338 | 2025-11-18 17:17:19.159466 | TASK [ensure-tox : Make global symlink] 2025-11-18 17:17:19.186268 | controller | skipping: Conditional result was False 2025-11-18 17:17:19.210168 | 2025-11-18 17:17:19.210295 | TASK [Setup tox role] 2025-11-18 17:17:19.238362 | controller | ok 2025-11-18 17:17:19.280901 | 2025-11-18 17:17:19.280984 | TASK [tox : Check to see if the constraints file exists] 2025-11-18 17:17:19.315706 | controller | skipping: Conditional result was False 2025-11-18 17:17:19.323442 | 2025-11-18 17:17:19.323523 | TASK [tox : Fail if constraints file is missing] 2025-11-18 17:17:19.358338 | controller | skipping: Conditional result was False 2025-11-18 17:17:19.370636 | 2025-11-18 17:17:19.370831 | TASK [tox : Record file location] 2025-11-18 17:17:19.407477 | controller | skipping: Conditional result was False 2025-11-18 17:17:19.419874 | 2025-11-18 17:17:19.420010 | TASK [tox : Install tox siblings] 2025-11-18 17:17:19.446564 | controller | skipping: Conditional result was False 2025-11-18 17:17:19.459377 | 2025-11-18 17:17:19.459510 | TASK [tox : Emit tox command] 2025-11-18 17:17:19.519973 | /usr/bin/tox -evenv -vv --notest 2025-11-18 17:17:19.530983 | 2025-11-18 17:17:19.531112 | TASK [tox : Run tox] 2025-11-18 17:17:19.908910 | controller | using tox.ini: /home/zuul/src/github.com/ansible-network/releases/tox.ini (pid 2300) 2025-11-18 17:17:19.915596 | controller | using tox-3.28.0 from /usr/lib/python3.11/site-packages/tox/__init__.py (pid 2300) 2025-11-18 17:17:19.915783 | controller | skipping sdist step 2025-11-18 17:17:19.915798 | controller | venv uses /usr/bin/python3 2025-11-18 17:17:19.936799 | controller | venv start: getenv /home/zuul/src/github.com/ansible-network/releases/.tox/venv 2025-11-18 17:17:19.936974 | controller | venv cannot reuse: no previous config /home/zuul/src/github.com/ansible-network/releases/.tox/venv/.tox-config1 2025-11-18 17:17:19.936986 | controller | venv create: /home/zuul/src/github.com/ansible-network/releases/.tox/venv 2025-11-18 17:17:19.936994 | 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-18 17:17:19.937002 | controller | [2308] /home/zuul/src/github.com/ansible-network/releases/.tox$ /usr/bin/python3 -m virtualenv --no-download --python /usr/bin/python3 venv 2025-11-18 17:17:20.450987 | controller | created virtual environment CPython3.11.0.final.0-64 in 436ms 2025-11-18 17:17:20.467667 | controller | creator CPython3Posix(dest=/home/zuul/src/github.com/ansible-network/releases/.tox/venv, clear=False, no_vcs_ignore=False, global=False) 2025-11-18 17:17:20.467703 | 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-18 17:17:20.467713 | controller | added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1 2025-11-18 17:17:20.467718 | controller | activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator 2025-11-18 17:17:20.467730 | 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-18 17:17:20.468009 | 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-18 17:17:20.468021 | controller | [2316] /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-18 17:17:21.812691 | controller | Collecting ruamel.yaml 2025-11-18 17:17:21.850821 | controller | Downloading ruamel.yaml-0.18.16-py3-none-any.whl (119 kB) 2025-11-18 17:17:21.876659 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 119.9/119.9 kB 4.9 MB/s eta 0:00:00 2025-11-18 17:17:21.925052 | controller | Collecting pbr 2025-11-18 17:17:21.928258 | controller | Downloading pbr-7.0.3-py2.py3-none-any.whl (131 kB) 2025-11-18 17:17:21.934317 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 131.9/131.9 kB 30.9 MB/s eta 0:00:00 2025-11-18 17:17:21.969169 | controller | Collecting tweepy 2025-11-18 17:17:21.972116 | controller | Downloading tweepy-4.16.0-py3-none-any.whl (98 kB) 2025-11-18 17:17:21.976954 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.8/98.8 kB 31.7 MB/s eta 0:00:00 2025-11-18 17:17:22.022720 | controller | Collecting galaxy-importer 2025-11-18 17:17:22.026672 | controller | Downloading galaxy_importer-0.4.34-py3-none-any.whl (64 kB) 2025-11-18 17:17:22.033653 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 64.8/64.8 kB 12.0 MB/s eta 0:00:00 2025-11-18 17:17:22.085372 | controller | Collecting flake8 2025-11-18 17:21:58.027792 | [Zuul] Log Stream did not terminate 2025-11-18 17:21:58.028052 | controller | ERROR 2025-11-18 17:21:58.028175 | controller | { 2025-11-18 17:21:58.028220 | controller | "msg": "Data could not be sent to remote host \"162.253.55.145\". Make sure this host can be reached over ssh: ssh: connect to host 162.253.55.145 port 22: No route to host\r\n", 2025-11-18 17:21:58.028259 | controller | "unreachable": true 2025-11-18 17:21:58.028291 | controller | } unreachable 2025-11-18 17:21:58.031176 | 2025-11-18 17:21:58.031241 | PLAY RECAP 2025-11-18 17:21:58.031295 | controller | ok: 10 changed: 5 unreachable: 1 failed: 0 skipped: 15 rescued: 0 ignored: 0 2025-11-18 17:21:58.031322 | 2025-11-18 17:21:58.128532 | PRE-RUN END RESULT_UNREACHABLE: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master] 2025-11-18 17:21:58.130162 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2025-11-18 17:21:58.725091 | 2025-11-18 17:21:58.725206 | PLAY [all:!appliance*] 2025-11-18 17:21:58.746338 | 2025-11-18 17:21:58.746409 | TASK [unregister the node] 2025-11-18 17:22:01.193161 | [controller] Waiting on logger 2025-11-18 17:22:22.802357 | controller | skipping: Conditional result was False 2025-11-18 17:22:22.810241 | 2025-11-18 17:22:22.810342 | TASK [include_role : fetch-output] 2025-11-18 17:22:22.854459 | controller | ok 2025-11-18 17:22:22.890626 | 2025-11-18 17:22:22.890738 | TASK [fetch-output : Set log path for multiple nodes] 2025-11-18 17:22:22.956808 | controller | skipping: Conditional result was False 2025-11-18 17:22:22.969327 | 2025-11-18 17:22:22.969467 | TASK [fetch-output : Set log path for single node] 2025-11-18 17:22:23.017214 | controller | ok 2025-11-18 17:22:23.028581 | 2025-11-18 17:22:23.028748 | LOOP [fetch-output : Ensure local output dirs] 2025-11-18 17:22:23.466165 | controller -> localhost | ok: "/var/lib/zuul/builds/70791bec920e4984938ca28c63647555/work/logs" 2025-11-18 17:22:23.728318 | controller -> localhost | changed: "/var/lib/zuul/builds/70791bec920e4984938ca28c63647555/work/artifacts" 2025-11-18 17:22:23.958764 | controller -> localhost | changed: "/var/lib/zuul/builds/70791bec920e4984938ca28c63647555/work/docs" 2025-11-18 17:22:24.009893 | 2025-11-18 17:22:24.010358 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-11-18 17:22:24.682172 | controller | changed: .d..t...... ./ 2025-11-18 17:22:24.682519 | controller | changed: All items complete 2025-11-18 17:22:24.682576 | 2025-11-18 17:22:25.212189 | controller | changed: .d..t...... ./ 2025-11-18 17:22:25.701073 | controller | changed: .d..t...... ./ 2025-11-18 17:22:25.726788 | 2025-11-18 17:22:25.726966 | TASK [include_role : fetch-output-openshift] 2025-11-18 17:22:25.753754 | controller | skipping: Conditional result was False 2025-11-18 17:22:25.762037 | 2025-11-18 17:22:25.762126 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2025-11-18 17:22:26.217370 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.007944 2025-11-18 17:22:26.423036 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.007820 2025-11-18 17:22:26.477170 | 2025-11-18 17:22:26.477309 | PLAY [localhost] 2025-11-18 17:22:26.493914 | 2025-11-18 17:22:26.493991 | TASK [Run Zuul manifest role] 2025-11-18 17:22:26.514178 | localhost | ok 2025-11-18 17:22:26.531169 | 2025-11-18 17:22:26.531260 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-11-18 17:22:26.890493 | localhost | changed 2025-11-18 17:22:26.900192 | 2025-11-18 17:22:26.900323 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-11-18 17:22:26.946251 | localhost | ok 2025-11-18 17:22:26.963118 | 2025-11-18 17:22:26.963245 | TASK [Set zuul-log-path fact] 2025-11-18 17:22:26.989707 | localhost | ok 2025-11-18 17:22:27.012730 | 2025-11-18 17:22:27.012840 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-11-18 17:22:27.052581 | localhost | ok 2025-11-18 17:22:27.063390 | 2025-11-18 17:22:27.063473 | LOOP [Run upload-logs-swift role] 2025-11-18 17:22:27.097786 | localhost | Output suppressed because no_log was given 2025-11-18 17:22:27.140584 | 2025-11-18 17:22:27.140700 | TASK [Set zuul-log-path fact] 2025-11-18 17:22:27.177796 | localhost | skipping: Conditional result was False 2025-11-18 17:22:27.221931 | 2025-11-18 17:22:27.222077 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2025-11-18 17:22:27.492518 | localhost -> localhost | ok: Runtime: 0:00:00.008282 2025-11-18 17:22:27.503337 | 2025-11-18 17:22:27.503476 | TASK [upload-logs-swift : Upload logs to swift]