2026-03-05 18:51:54.412449 | Job console starting... 2026-03-05 18:51:54.424209 | Updating repositories 2026-03-05 18:51:54.466335 | Preparing job workspace 2026-03-05 18:51:58.352194 | Running Ansible setup... 2026-03-05 18:52:03.204452 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-03-05 18:52:03.835407 | 2026-03-05 18:52:03.835542 | PLAY [localhost] 2026-03-05 18:52:03.844055 | 2026-03-05 18:52:03.844131 | TASK [Gathering Facts] 2026-03-05 18:52:04.881036 | localhost | ok 2026-03-05 18:52:04.909962 | 2026-03-05 18:52:04.910139 | TASK [Setup log path fact] 2026-03-05 18:52:04.935895 | localhost | ok 2026-03-05 18:52:04.961009 | 2026-03-05 18:52:04.961110 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-05 18:52:05.000722 | localhost | ok 2026-03-05 18:52:05.011082 | 2026-03-05 18:52:05.011171 | TASK [emit-job-header : Print job information] 2026-03-05 18:52:05.063366 | # Job Information 2026-03-05 18:52:05.063591 | Ansible Version: 2.15.12 2026-03-05 18:52:05.063656 | Job: ansible-galaxy-importer 2026-03-05 18:52:05.063737 | Pipeline: third-party-check 2026-03-05 18:52:05.063780 | Executor: ze02.softwarefactory-project.io 2026-03-05 18:52:05.063820 | Triggered by: https://github.com/ansible-collections/hetzner.hcloud/pull/804 2026-03-05 18:52:05.063870 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/26d/ansible/26d67a15176a437396d931757e809080/ 2026-03-05 18:52:05.063912 | Event ID: 6e951770-18c3-11f1-92c8-e7e746e572ac 2026-03-05 18:52:05.071814 | 2026-03-05 18:52:05.071946 | LOOP [emit-job-header : Print node information] 2026-03-05 18:52:05.189378 | localhost | ok: 2026-03-05 18:52:05.189747 | localhost | # Node Information 2026-03-05 18:52:05.189786 | localhost | Inventory Hostname: controller 2026-03-05 18:52:05.189814 | localhost | Hostname: np0005639183 2026-03-05 18:52:05.189833 | localhost | Username: zuul 2026-03-05 18:52:05.189856 | localhost | Distro: Fedora 37 2026-03-05 18:52:05.189874 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2026-03-05 18:52:05.189891 | localhost | Region: ca-ymq-1 2026-03-05 18:52:05.189908 | localhost | Label: ansible-fedora-37-1vcpu 2026-03-05 18:52:05.189924 | localhost | Product Name: OpenStack Nova 2026-03-05 18:52:05.189941 | localhost | Interface IP: 162.253.55.43 2026-03-05 18:52:05.210830 | 2026-03-05 18:52:05.210974 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-05 18:52:05.602807 | localhost -> localhost | changed 2026-03-05 18:52:05.616251 | 2026-03-05 18:52:05.616401 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-05 18:52:06.538998 | localhost -> localhost | changed 2026-03-05 18:52:06.557885 | 2026-03-05 18:52:06.557939 | PLAY [all:!appliance*] 2026-03-05 18:52:06.573291 | 2026-03-05 18:52:06.573353 | TASK [include_role : start-zuul-console] 2026-03-05 18:52:06.591993 | controller | ok 2026-03-05 18:52:06.604981 | 2026-03-05 18:52:06.605040 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-05 18:52:06.976471 | controller | ok 2026-03-05 18:52:07.000753 | 2026-03-05 18:52:07.000899 | TASK [use-our-mirror : Retrieve the IP address] 2026-03-05 18:52:08.349027 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2026-03-05 18:52:08.362786 | 2026-03-05 18:52:08.362915 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2026-03-05 18:52:08.905909 | controller | skipping: Conditional result was False 2026-03-05 18:52:08.919627 | 2026-03-05 18:52:08.919875 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2026-03-05 18:52:08.948088 | controller | skipping: Conditional result was False 2026-03-05 18:52:08.957395 | 2026-03-05 18:52:08.957497 | TASK [use-our-mirror : Create the podman configuration directory] 2026-03-05 18:52:08.992257 | controller | skipping: Conditional result was False 2026-03-05 18:52:09.001992 | 2026-03-05 18:52:09.002123 | TASK [use-our-mirror : Copy the podman configuration] 2026-03-05 18:52:09.024383 | controller | skipping: Conditional result was False 2026-03-05 18:52:09.033280 | 2026-03-05 18:52:09.033374 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2026-03-05 18:52:09.048097 | controller | skipping: Conditional result was False 2026-03-05 18:52:09.058605 | 2026-03-05 18:52:09.058751 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2026-03-05 18:52:09.083546 | controller | skipping: Conditional result was False 2026-03-05 18:52:09.099060 | 2026-03-05 18:52:09.099160 | TASK [Disable Fedora Modular] 2026-03-05 18:52:09.355388 | controller | changed 2026-03-05 18:52:09.363794 | 2026-03-05 18:52:09.363885 | TASK [Enable EPEL] 2026-03-05 18:52:09.389470 | controller | skipping: Conditional result was False 2026-03-05 18:52:09.408772 | 2026-03-05 18:52:09.408912 | TASK [Register the RHEL node] 2026-03-05 18:52:09.955461 | 2026-03-05 18:52:09.955739 | TASK [Show the subscription-manager status] 2026-03-05 18:52:10.552487 | controller | skipping: Conditional result was False 2026-03-05 18:52:10.565979 | 2026-03-05 18:52:10.566115 | TASK [Enable EPEL on RHEL] 2026-03-05 18:52:11.128631 | controller | skipping: Conditional result was False 2026-03-05 18:52:11.141491 | 2026-03-05 18:52:11.141631 | TASK [Install git and tox] 2026-03-05 18:53:29.314603 | controller | changed 2026-03-05 18:53:29.320602 | 2026-03-05 18:53:29.320712 | TASK [include_role : prepare-workspace] 2026-03-05 18:53:29.350776 | controller | ok 2026-03-05 18:53:29.370780 | 2026-03-05 18:53:29.370847 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-05 18:53:29.593352 | controller | ok 2026-03-05 18:53:29.599397 | 2026-03-05 18:53:29.599464 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-05 18:53:30.789391 | controller | Output suppressed because no_log was given 2026-03-05 18:53:30.811637 | 2026-03-05 18:53:30.811752 | TASK [include_role : prepare-workspace-openshift] 2026-03-05 18:53:30.826841 | controller | skipping: Conditional result was False 2026-03-05 18:53:30.857172 | 2026-03-05 18:53:30.857248 | PLAY [all:!appliance] 2026-03-05 18:53:30.876571 | 2026-03-05 18:53:30.876630 | TASK [Run add-build-sshkey role (RSA)] 2026-03-05 18:53:30.906153 | controller | ok 2026-03-05 18:53:30.920264 | 2026-03-05 18:53:30.920340 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-05 18:53:31.150114 | controller -> localhost | ok 2026-03-05 18:53:31.163853 | 2026-03-05 18:53:31.163989 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-05 18:53:31.194008 | controller | ok 2026-03-05 18:53:31.217927 | controller | included: /var/lib/zuul/builds/26d67a15176a437396d931757e809080/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-05 18:53:31.225852 | 2026-03-05 18:53:31.225932 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-05 18:53:31.821902 | controller -> localhost | Generating public/private rsa key pair. 2026-03-05 18:53:31.822258 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/26d67a15176a437396d931757e809080/work/26d67a15176a437396d931757e809080_id_rsa. 2026-03-05 18:53:31.822321 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/26d67a15176a437396d931757e809080/work/26d67a15176a437396d931757e809080_id_rsa.pub. 2026-03-05 18:53:31.822368 | controller -> localhost | The key fingerprint is: 2026-03-05 18:53:31.822409 | controller -> localhost | SHA256:D3RmcYRJBWYHmV595Vh1Zpf6+Ta69P5VM8J7d6LzyVQ zuul-build-sshkey 2026-03-05 18:53:31.822450 | controller -> localhost | The key's randomart image is: 2026-03-05 18:53:31.822491 | controller -> localhost | +---[RSA 2048]----+ 2026-03-05 18:53:31.822530 | controller -> localhost | | .BX=. %| 2026-03-05 18:53:31.822571 | controller -> localhost | | o=+. .B+| 2026-03-05 18:53:31.822610 | controller -> localhost | | ..+. o..| 2026-03-05 18:53:31.822647 | controller -> localhost | | . +. .. | 2026-03-05 18:53:31.822722 | controller -> localhost | | S o.oE| 2026-03-05 18:53:31.822780 | controller -> localhost | | o o++| 2026-03-05 18:53:31.822833 | controller -> localhost | | . oo.=| 2026-03-05 18:53:31.822877 | controller -> localhost | | o+o+*| 2026-03-05 18:53:31.822917 | controller -> localhost | | .=B++| 2026-03-05 18:53:31.822961 | controller -> localhost | +----[SHA256]-----+ 2026-03-05 18:53:31.823092 | controller -> localhost | ok: Runtime: 0:00:00.150717 2026-03-05 18:53:31.876898 | 2026-03-05 18:53:31.877039 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-05 18:53:31.910326 | controller | ok 2026-03-05 18:53:31.923720 | controller | included: /var/lib/zuul/builds/26d67a15176a437396d931757e809080/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-05 18:53:31.936081 | 2026-03-05 18:53:31.936166 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-05 18:53:31.961372 | controller | skipping: Conditional result was False 2026-03-05 18:53:31.970708 | 2026-03-05 18:53:31.970803 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-05 18:53:32.341054 | controller | changed 2026-03-05 18:53:32.359414 | 2026-03-05 18:53:32.359580 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-05 18:53:32.593400 | controller | ok 2026-03-05 18:53:32.606191 | 2026-03-05 18:53:32.606485 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-05 18:53:33.250367 | controller | changed 2026-03-05 18:53:33.256094 | 2026-03-05 18:53:33.256159 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-05 18:53:33.894885 | controller | changed 2026-03-05 18:53:33.908262 | 2026-03-05 18:53:33.908403 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-05 18:53:33.937601 | controller | skipping: Conditional result was False 2026-03-05 18:53:33.953214 | 2026-03-05 18:53:33.953366 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-05 18:53:34.358774 | controller -> localhost | changed 2026-03-05 18:53:34.370549 | 2026-03-05 18:53:34.370613 | TASK [add-build-sshkey : Add back temp key] 2026-03-05 18:53:34.639574 | controller -> localhost | Identity added: /var/lib/zuul/builds/26d67a15176a437396d931757e809080/work/26d67a15176a437396d931757e809080_id_rsa (zuul-build-sshkey) 2026-03-05 18:53:34.639797 | controller -> localhost | ok: Runtime: 0:00:00.010144 2026-03-05 18:53:34.647069 | 2026-03-05 18:53:34.647132 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-05 18:53:34.936438 | controller | ok 2026-03-05 18:53:34.948070 | 2026-03-05 18:53:34.948200 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-05 18:53:34.985540 | controller | skipping: Conditional result was False 2026-03-05 18:53:35.009088 | 2026-03-05 18:53:35.009222 | TASK [Run add-build-sshkey role (ECDSA)] 2026-03-05 18:53:35.049574 | controller | ok 2026-03-05 18:53:35.078085 | 2026-03-05 18:53:35.078210 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-05 18:53:35.368154 | controller -> localhost | ok 2026-03-05 18:53:35.374429 | 2026-03-05 18:53:35.374490 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-05 18:53:35.401800 | controller | ok 2026-03-05 18:53:35.418980 | controller | included: /var/lib/zuul/builds/26d67a15176a437396d931757e809080/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-05 18:53:35.427284 | 2026-03-05 18:53:35.427367 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-05 18:53:35.675848 | controller -> localhost | Generating public/private ecdsa key pair. 2026-03-05 18:53:35.676006 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/26d67a15176a437396d931757e809080/work/26d67a15176a437396d931757e809080_id_ecdsa. 2026-03-05 18:53:35.676033 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/26d67a15176a437396d931757e809080/work/26d67a15176a437396d931757e809080_id_ecdsa.pub. 2026-03-05 18:53:35.676061 | controller -> localhost | The key fingerprint is: 2026-03-05 18:53:35.676081 | controller -> localhost | SHA256:vWU+I+J74tXiqtbll3v/Zs+6x1n61PPtShp3q3m2kfk zuul-build-sshkey 2026-03-05 18:53:35.676101 | controller -> localhost | The key's randomart image is: 2026-03-05 18:53:35.676119 | controller -> localhost | +---[ECDSA 521]---+ 2026-03-05 18:53:35.676137 | controller -> localhost | | | 2026-03-05 18:53:35.676154 | controller -> localhost | | | 2026-03-05 18:53:35.676172 | controller -> localhost | | | 2026-03-05 18:53:35.676189 | controller -> localhost | | . | 2026-03-05 18:53:35.676207 | controller -> localhost | | S . o | 2026-03-05 18:53:35.676223 | controller -> localhost | | .* =| 2026-03-05 18:53:35.676240 | controller -> localhost | | ..o= *.oB*| 2026-03-05 18:53:35.676257 | controller -> localhost | | ..o+oooB+B%| 2026-03-05 18:53:35.676274 | controller -> localhost | | ..o==..o=B&E| 2026-03-05 18:53:35.676291 | controller -> localhost | +----[SHA256]-----+ 2026-03-05 18:53:35.676336 | controller -> localhost | ok: Runtime: 0:00:00.007770 2026-03-05 18:53:35.682960 | 2026-03-05 18:53:35.683022 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-05 18:53:35.713617 | controller | ok 2026-03-05 18:53:35.723628 | controller | included: /var/lib/zuul/builds/26d67a15176a437396d931757e809080/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-05 18:53:35.738944 | 2026-03-05 18:53:35.739105 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-05 18:53:35.764984 | controller | skipping: Conditional result was False 2026-03-05 18:53:35.773329 | 2026-03-05 18:53:35.773393 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-05 18:53:36.055619 | controller | changed 2026-03-05 18:53:36.061370 | 2026-03-05 18:53:36.061429 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-05 18:53:36.298364 | controller | ok 2026-03-05 18:53:36.304493 | 2026-03-05 18:53:36.304564 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-05 18:53:36.884693 | controller | changed 2026-03-05 18:53:36.892639 | 2026-03-05 18:53:36.892808 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-05 18:53:37.494870 | controller | changed 2026-03-05 18:53:37.506635 | 2026-03-05 18:53:37.506764 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-05 18:53:37.532499 | controller | skipping: Conditional result was False 2026-03-05 18:53:37.543105 | 2026-03-05 18:53:37.543216 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-05 18:53:37.768931 | controller -> localhost | changed 2026-03-05 18:53:37.786162 | 2026-03-05 18:53:37.786254 | TASK [add-build-sshkey : Add back temp key] 2026-03-05 18:53:38.076930 | controller -> localhost | Identity added: /var/lib/zuul/builds/26d67a15176a437396d931757e809080/work/26d67a15176a437396d931757e809080_id_ecdsa (zuul-build-sshkey) 2026-03-05 18:53:38.077267 | controller -> localhost | ok: Runtime: 0:00:00.013048 2026-03-05 18:53:38.087642 | 2026-03-05 18:53:38.088076 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-05 18:53:38.286583 | controller | ok 2026-03-05 18:53:38.294401 | 2026-03-05 18:53:38.294497 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-05 18:53:38.319975 | controller | skipping: Conditional result was False 2026-03-05 18:53:38.338322 | 2026-03-05 18:53:38.338441 | TASK [include_role : remove-zuul-sshkey] 2026-03-05 18:53:38.355772 | controller | skipping: Conditional result was False 2026-03-05 18:53:38.368844 | 2026-03-05 18:53:38.368998 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-05 18:53:38.583439 | controller | ok: "logs" 2026-03-05 18:53:38.583764 | controller | ok: All items complete 2026-03-05 18:53:38.583803 | 2026-03-05 18:53:38.779844 | controller | ok: "artifacts" 2026-03-05 18:53:38.976931 | controller | ok: "docs" 2026-03-05 18:53:38.991456 | 2026-03-05 18:53:38.991580 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-05 18:53:39.222215 | controller | changed: "logs" 2026-03-05 18:53:39.409949 | controller | changed: "artifacts" 2026-03-05 18:53:39.605874 | controller | changed: "docs" 2026-03-05 18:53:39.701499 | 2026-03-05 18:53:39.701598 | PLAY RECAP 2026-03-05 18:53:39.701638 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2026-03-05 18:53:39.701683 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-05 18:53:39.701706 | 2026-03-05 18:53:39.816969 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-03-05 18:53:39.817697 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master] 2026-03-05 18:53:40.410845 | 2026-03-05 18:53:40.410958 | PLAY [all] 2026-03-05 18:53:40.432661 | 2026-03-05 18:53:40.432767 | TASK [Setup ensure-tox role] 2026-03-05 18:53:40.453364 | controller | ok 2026-03-05 18:53:40.478242 | 2026-03-05 18:53:40.478346 | TASK [Install pip] 2026-03-05 18:53:40.498762 | controller | ok 2026-03-05 18:53:40.523494 | 2026-03-05 18:53:40.523580 | TASK [ensure-pip : Check if pip is installed] 2026-03-05 18:53:40.874178 | controller | /usr/bin/pip3 2026-03-05 18:53:40.888534 | controller | /usr/bin/python3: No module named wheel 2026-03-05 18:53:41.058318 | controller | ok: Runtime: 0:00:00.021089 2026-03-05 18:53:41.074808 | 2026-03-05 18:53:41.074960 | LOOP [ensure-pip : Install pip from packages] 2026-03-05 18:53:41.115263 | controller | ok: "/var/lib/zuul/builds/26d67a15176a437396d931757e809080/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml" 2026-03-05 18:53:41.133816 | controller | included: /var/lib/zuul/builds/26d67a15176a437396d931757e809080/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml 2026-03-05 18:53:41.153182 | 2026-03-05 18:53:41.153319 | TASK [ensure-pip : Install Python 3 pip] 2026-03-05 18:53:45.742487 | controller | changed 2026-03-05 18:53:45.756130 | 2026-03-05 18:53:45.756291 | TASK [ensure-pip : Check for EPEL repository] 2026-03-05 18:53:45.773983 | controller | skipping: Conditional result was False 2026-03-05 18:53:45.788747 | 2026-03-05 18:53:45.788890 | TASK [ensure-pip : Fail with instructions when EPEL is not installed] 2026-03-05 18:53:45.806616 | controller | skipping: Conditional result was False 2026-03-05 18:53:45.821806 | 2026-03-05 18:53:45.821950 | TASK [ensure-pip : Install Python 2 pip] 2026-03-05 18:53:45.839025 | controller | skipping: Conditional result was False 2026-03-05 18:53:45.853348 | 2026-03-05 18:53:45.853487 | TASK [ensure-pip : Ensure setuptools] 2026-03-05 18:53:45.880006 | controller | skipping: Conditional result was False 2026-03-05 18:53:45.894747 | 2026-03-05 18:53:45.894880 | TASK [ensure-pip : Check for ensurepip module] 2026-03-05 18:53:46.440493 | controller | skipping: Conditional result was False 2026-03-05 18:53:46.454772 | 2026-03-05 18:53:46.454923 | TASK [ensure-pip : Ensure python3-venv] 2026-03-05 18:53:46.481605 | controller | skipping: Conditional result was False 2026-03-05 18:53:46.496076 | 2026-03-05 18:53:46.496209 | TASK [ensure-pip : Install pip from source] 2026-03-05 18:53:46.525285 | controller | skipping: Conditional result was False 2026-03-05 18:53:46.538272 | 2026-03-05 18:53:46.538360 | TASK [ensure-pip : Probe for venv python full path] 2026-03-05 18:53:46.798749 | controller | /usr/bin/python3 2026-03-05 18:53:47.081860 | controller | ok: Runtime: 0:00:00.003401 2026-03-05 18:53:47.131530 | 2026-03-05 18:53:47.131690 | TASK [ensure-pip : Set host default] 2026-03-05 18:53:47.204135 | controller | ok 2026-03-05 18:53:47.211556 | 2026-03-05 18:53:47.211668 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2026-03-05 18:53:47.277984 | controller | ok 2026-03-05 18:53:47.292078 | 2026-03-05 18:53:47.292161 | TASK [ensure-tox : Check if tox is installed] 2026-03-05 18:53:47.535532 | controller | /usr/bin/tox 2026-03-05 18:53:47.835792 | controller | ok: Runtime: 0:00:00.003296 2026-03-05 18:53:47.841814 | 2026-03-05 18:53:47.841882 | TASK [ensure-tox : Export preinstalled tox_exectuable] 2026-03-05 18:53:47.882652 | controller | ok 2026-03-05 18:53:47.887804 | 2026-03-05 18:53:47.887864 | TASK [ensure-tox : Create local venv] 2026-03-05 18:53:48.418594 | controller | skipping: Conditional result was False 2026-03-05 18:53:48.432326 | 2026-03-05 18:53:48.432470 | TASK [ensure-tox : Install tox to local venv] 2026-03-05 18:53:48.999228 | controller | skipping: Conditional result was False 2026-03-05 18:53:49.012565 | 2026-03-05 18:53:49.014892 | TASK [ensure-tox : Export installed tox_executable path] 2026-03-05 18:53:49.041508 | controller | skipping: Conditional result was False 2026-03-05 18:53:49.055615 | 2026-03-05 18:53:49.055799 | TASK [ensure-tox : Output tox version] 2026-03-05 18:53:49.413449 | controller | 3.28.0 imported from /usr/lib/python3.11/site-packages/tox/__init__.py 2026-03-05 18:53:49.608172 | controller | ok: Runtime: 0:00:00.143985 2026-03-05 18:53:49.621442 | 2026-03-05 18:53:49.621593 | TASK [ensure-tox : Make global symlink] 2026-03-05 18:53:49.639119 | controller | skipping: Conditional result was False 2026-03-05 18:53:49.664708 | 2026-03-05 18:53:49.664846 | TASK [Setup tox role] 2026-03-05 18:53:49.688501 | controller | ok 2026-03-05 18:53:49.726937 | 2026-03-05 18:53:49.727066 | TASK [tox : Check to see if the constraints file exists] 2026-03-05 18:53:49.751896 | controller | skipping: Conditional result was False 2026-03-05 18:53:49.758491 | 2026-03-05 18:53:49.758555 | TASK [tox : Fail if constraints file is missing] 2026-03-05 18:53:49.782525 | controller | skipping: Conditional result was False 2026-03-05 18:53:49.788773 | 2026-03-05 18:53:49.788837 | TASK [tox : Record file location] 2026-03-05 18:53:49.812609 | controller | skipping: Conditional result was False 2026-03-05 18:53:49.818745 | 2026-03-05 18:53:49.818812 | TASK [tox : Install tox siblings] 2026-03-05 18:53:49.833021 | controller | skipping: Conditional result was False 2026-03-05 18:53:49.840242 | 2026-03-05 18:53:49.840323 | TASK [tox : Emit tox command] 2026-03-05 18:53:49.885350 | /usr/bin/tox -evenv -vv --notest 2026-03-05 18:53:49.896793 | 2026-03-05 18:53:49.896917 | TASK [tox : Run tox] 2026-03-05 18:53:50.237210 | controller | using tox.ini: /home/zuul/src/github.com/ansible-network/releases/tox.ini (pid 2535) 2026-03-05 18:53:50.244788 | controller | using tox-3.28.0 from /usr/lib/python3.11/site-packages/tox/__init__.py (pid 2535) 2026-03-05 18:53:50.266541 | controller | skipping sdist step 2026-03-05 18:53:50.266558 | controller | venv uses /usr/bin/python3 2026-03-05 18:53:50.266575 | controller | venv start: getenv /home/zuul/src/github.com/ansible-network/releases/.tox/venv 2026-03-05 18:53:50.266771 | controller | venv cannot reuse: no previous config /home/zuul/src/github.com/ansible-network/releases/.tox/venv/.tox-config1 2026-03-05 18:53:50.266783 | controller | venv create: /home/zuul/src/github.com/ansible-network/releases/.tox/venv 2026-03-05 18:53:50.266791 | 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-05 18:53:50.266801 | controller | [2543] /home/zuul/src/github.com/ansible-network/releases/.tox$ /usr/bin/python3 -m virtualenv --no-download --python /usr/bin/python3 venv 2026-03-05 18:53:50.777374 | controller | created virtual environment CPython3.11.0.final.0-64 in 429ms 2026-03-05 18:53:50.817545 | controller | creator CPython3Posix(dest=/home/zuul/src/github.com/ansible-network/releases/.tox/venv, clear=False, no_vcs_ignore=False, global=False) 2026-03-05 18:53:50.817588 | 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-05 18:53:50.817617 | controller | added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1 2026-03-05 18:53:50.817627 | controller | activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator 2026-03-05 18:53:50.817646 | 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-05 18:53:50.818288 | 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-05 18:53:50.818325 | controller | [2551] /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-05 18:53:52.197855 | controller | Collecting ruamel.yaml 2026-03-05 18:53:52.630899 | controller | Downloading ruamel_yaml-0.19.1-py3-none-any.whl (118 kB) 2026-03-05 18:53:52.652530 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 118.1/118.1 kB 5.7 MB/s eta 0:00:00 2026-03-05 18:53:52.698671 | controller | Collecting pbr 2026-03-05 18:53:52.702585 | controller | Downloading pbr-7.0.3-py2.py3-none-any.whl (131 kB) 2026-03-05 18:53:52.714310 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 131.9/131.9 kB 14.1 MB/s eta 0:00:00 2026-03-05 18:53:52.761646 | controller | Collecting tweepy 2026-03-05 18:53:52.766121 | controller | Downloading tweepy-4.16.0-py3-none-any.whl (98 kB) 2026-03-05 18:53:52.776110 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.8/98.8 kB 11.7 MB/s eta 0:00:00 2026-03-05 18:53:52.834845 | controller | Collecting galaxy-importer 2026-03-05 18:53:52.839669 | controller | Downloading galaxy_importer-0.4.37-py3-none-any.whl (64 kB) 2026-03-05 18:53:52.848924 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 64.9/64.9 kB 7.8 MB/s eta 0:00:00 2026-03-05 18:53:52.902761 | controller | Collecting flake8 2026-03-05 18:53:52.907235 | controller | Downloading flake8-7.3.0-py2.py3-none-any.whl (57 kB) 2026-03-05 18:53:52.916313 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 57.9/57.9 kB 7.4 MB/s eta 0:00:00 2026-03-05 18:53:52.928287 | controller | Requirement already satisfied: setuptools in ./.tox/venv/lib/python3.11/site-packages (from pbr->-r /home/zuul/src/github.com/ansible-network/releases/requirements.txt (line 2)) (62.6.0) 2026-03-05 18:53:52.966617 | controller | Collecting oauthlib<4,>=3.2.0 2026-03-05 18:53:52.970079 | controller | Downloading oauthlib-3.3.1-py3-none-any.whl (160 kB) 2026-03-05 18:53:52.976780 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 160.1/160.1 kB 37.0 MB/s eta 0:00:00 2026-03-05 18:53:53.037840 | controller | Collecting requests<3,>=2.27.0 2026-03-05 18:53:53.041158 | controller | Downloading requests-2.32.5-py3-none-any.whl (64 kB) 2026-03-05 18:53:53.049100 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 64.7/64.7 kB 9.5 MB/s eta 0:00:00 2026-03-05 18:53:53.078107 | controller | Collecting requests-oauthlib<3,>=1.2.0 2026-03-05 18:53:53.081499 | controller | Downloading requests_oauthlib-2.0.0-py2.py3-none-any.whl (24 kB) 2026-03-05 18:53:53.229766 | controller | Collecting ansible-core 2026-03-05 18:53:53.233984 | controller | Downloading ansible_core-2.19.7-py3-none-any.whl (2.4 MB) 2026-03-05 18:53:53.264953 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.4/2.4 MB 85.0 MB/s eta 0:00:00 2026-03-05 18:53:53.305714 | controller | Collecting ansible-builder<4.0,>=1.2.0 2026-03-05 18:53:53.309572 | controller | Downloading ansible_builder-3.1.1-py3-none-any.whl (46 kB) 2026-03-05 18:53:53.314870 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 46.5/46.5 kB 12.9 MB/s eta 0:00:00 2026-03-05 18:53:53.431671 | controller | Collecting ansible-lint<=26.1.0,>=6.2.2 2026-03-05 18:53:53.436532 | controller | Downloading ansible_lint-26.1.0-py3-none-any.whl (324 kB) 2026-03-05 18:53:53.447021 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 324.6/324.6 kB 39.6 MB/s eta 0:00:00 2026-03-05 18:53:53.485885 | controller | Collecting attrs<23,>=21.4.0 2026-03-05 18:53:53.490188 | controller | Downloading attrs-22.2.0-py3-none-any.whl (60 kB) 2026-03-05 18:53:53.498993 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 60.0/60.0 kB 7.7 MB/s eta 0:00:00 2026-03-05 18:53:53.610053 | controller | Collecting nh3<3,>=0.2.18 2026-03-05 18:53:53.616326 | controller | Downloading nh3-0.3.3-cp38-abi3-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (811 kB) 2026-03-05 18:53:53.631022 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 811.5/811.5 kB 67.5 MB/s eta 0:00:00 2026-03-05 18:53:53.647328 | controller | Collecting flake8 2026-03-05 18:53:53.652013 | controller | Downloading flake8-6.1.0-py2.py3-none-any.whl (58 kB) 2026-03-05 18:53:53.660503 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 58.3/58.3 kB 8.0 MB/s eta 0:00:00 2026-03-05 18:53:53.710639 | controller | Collecting markdown<4,>=3.3.4 2026-03-05 18:53:53.714448 | controller | Downloading markdown-3.10.2-py3-none-any.whl (108 kB) 2026-03-05 18:53:53.723253 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 108.2/108.2 kB 15.8 MB/s eta 0:00:00 2026-03-05 18:53:53.851990 | controller | Collecting pyyaml<7,>=5.4.1 2026-03-05 18:53:53.858793 | controller | Downloading pyyaml-6.0.3-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (806 kB) 2026-03-05 18:53:53.873591 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 806.6/806.6 kB 66.5 MB/s eta 0:00:00 2026-03-05 18:53:53.920232 | controller | Collecting semantic-version<3,>=2.9.0 2026-03-05 18:53:53.924781 | controller | Downloading semantic_version-2.10.0-py2.py3-none-any.whl (15 kB) 2026-03-05 18:53:53.973236 | controller | Collecting packaging<25.0,>=23.2 2026-03-05 18:53:53.976573 | controller | Downloading packaging-24.2-py3-none-any.whl (65 kB) 2026-03-05 18:53:53.984851 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 65.5/65.5 kB 9.3 MB/s eta 0:00:00 2026-03-05 18:53:54.011847 | controller | Collecting mccabe<0.8.0,>=0.7.0 2026-03-05 18:53:54.015779 | controller | Downloading mccabe-0.7.0-py2.py3-none-any.whl (7.3 kB) 2026-03-05 18:53:54.055169 | controller | Collecting pycodestyle<2.12.0,>=2.11.0 2026-03-05 18:53:54.059641 | controller | Downloading pycodestyle-2.11.1-py2.py3-none-any.whl (31 kB) 2026-03-05 18:53:54.095727 | controller | Collecting pyflakes<3.2.0,>=3.1.0 2026-03-05 18:53:54.100127 | controller | Downloading pyflakes-3.1.0-py2.py3-none-any.whl (62 kB) 2026-03-05 18:53:54.110558 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 62.6/62.6 kB 8.0 MB/s eta 0:00:00 2026-03-05 18:53:54.141804 | controller | Collecting bindep 2026-03-05 18:53:54.146125 | controller | Downloading bindep-2.13.0-py3-none-any.whl (34 kB) 2026-03-05 18:53:54.207609 | controller | Collecting jsonschema 2026-03-05 18:53:54.210893 | controller | Downloading jsonschema-4.26.0-py3-none-any.whl (90 kB) 2026-03-05 18:53:54.220295 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 90.6/90.6 kB 11.9 MB/s eta 0:00:00 2026-03-05 18:53:54.291430 | controller | Collecting ansible-compat>=25.8.2 2026-03-05 18:53:54.296436 | controller | Downloading ansible_compat-25.12.1-py3-none-any.whl (27 kB) 2026-03-05 18:53:54.451990 | controller | Collecting black>=24.3.0 2026-03-05 18:53:54.457438 | controller | Downloading black-26.1.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (1.7 MB) 2026-03-05 18:53:54.480917 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.7/1.7 MB 83.3 MB/s eta 0:00:00 2026-03-05 18:53:54.770702 | controller | Collecting cffi>=1.15.1 2026-03-05 18:53:54.774627 | controller | Downloading cffi-2.0.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl (215 kB) 2026-03-05 18:53:54.784316 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 215.6/215.6 kB 30.6 MB/s eta 0:00:00 2026-03-05 18:58:57.378637 | controller | ERROR 2026-03-05 18:58:57.379000 | controller | { 2026-03-05 18:58:57.379085 | controller | "msg": "Data could not be sent to remote host \"162.253.55.43\". Make sure this host can be reached over ssh: ssh: connect to host 162.253.55.43 port 22: Connection timed out\r\n", 2026-03-05 18:58:57.379134 | controller | "unreachable": true 2026-03-05 18:58:57.379175 | controller | } unreachable 2026-03-05 18:58:57.381507 | 2026-03-05 18:58:57.381608 | PLAY RECAP 2026-03-05 18:58:57.381770 | controller | ok: 10 changed: 5 unreachable: 1 failed: 0 skipped: 15 rescued: 0 ignored: 0 2026-03-05 18:58:57.381830 | 2026-03-05 18:58:57.502287 | PRE-RUN END RESULT_UNREACHABLE: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master] 2026-03-05 18:58:57.503106 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2026-03-05 18:58:58.064694 | 2026-03-05 18:58:58.064802 | PLAY [all:!appliance*] 2026-03-05 18:58:58.085318 | 2026-03-05 18:58:58.085397 | TASK [unregister the node] 2026-03-05 18:58:58.616911 | controller | skipping: Conditional result was False 2026-03-05 18:58:58.629060 | 2026-03-05 18:58:58.629220 | TASK [include_role : fetch-output] 2026-03-05 18:58:58.686781 | controller | ok 2026-03-05 18:58:58.725867 | 2026-03-05 18:58:58.725983 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-05 18:58:58.801653 | controller | skipping: Conditional result was False 2026-03-05 18:58:58.814007 | 2026-03-05 18:58:58.814146 | TASK [fetch-output : Set log path for single node] 2026-03-05 18:58:58.871611 | controller | ok 2026-03-05 18:58:58.883154 | 2026-03-05 18:58:58.883290 | LOOP [fetch-output : Ensure local output dirs] 2026-03-05 18:58:59.314819 | controller -> localhost | ok: "/var/lib/zuul/builds/26d67a15176a437396d931757e809080/work/logs" 2026-03-05 18:58:59.592757 | controller -> localhost | changed: "/var/lib/zuul/builds/26d67a15176a437396d931757e809080/work/artifacts" 2026-03-05 18:58:59.852523 | controller -> localhost | changed: "/var/lib/zuul/builds/26d67a15176a437396d931757e809080/work/docs" 2026-03-05 18:58:59.864636 | 2026-03-05 18:58:59.864765 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-05 18:59:00.475693 | controller | ok 2026-03-05 18:59:00.480957 | controller | changed: All items complete 2026-03-05 18:59:00.481052 | 2026-03-05 18:59:01.003067 | controller | changed: .d..t...... ./ 2026-03-05 18:59:01.527186 | controller | changed: .d..t...... ./ 2026-03-05 18:59:01.559973 | 2026-03-05 18:59:01.560155 | TASK [include_role : fetch-output-openshift] 2026-03-05 18:59:01.587232 | controller | skipping: Conditional result was False 2026-03-05 18:59:01.601118 | 2026-03-05 18:59:01.601286 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-05 18:59:02.039209 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.013446 2026-03-05 18:59:02.286456 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.014162 2026-03-05 18:59:02.350277 | 2026-03-05 18:59:02.350456 | PLAY [localhost] 2026-03-05 18:59:02.368102 | 2026-03-05 18:59:02.368185 | TASK [Run Zuul manifest role] 2026-03-05 18:59:02.389094 | localhost | ok 2026-03-05 18:59:02.409582 | 2026-03-05 18:59:02.409780 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-05 18:59:02.846229 | localhost | changed 2026-03-05 18:59:02.850811 | 2026-03-05 18:59:02.850872 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-05 18:59:02.888841 | localhost | ok 2026-03-05 18:59:02.896844 | 2026-03-05 18:59:02.896917 | TASK [Set zuul-log-path fact] 2026-03-05 18:59:02.915442 | localhost | ok 2026-03-05 18:59:02.928178 | 2026-03-05 18:59:02.928245 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-05 18:59:02.965993 | localhost | ok 2026-03-05 18:59:02.973731 | 2026-03-05 18:59:02.973792 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)] 2026-03-05 18:59:03.014300 | localhost | ok: 2026-03-05 18:59:03.014825 | localhost | { 2026-03-05 18:59:03.014887 | localhost | "auth": { 2026-03-05 18:59:03.014927 | localhost | "password": "IonWCwcuOFib&&<}wp^:[2G/", 2026-03-05 18:59:03.014965 | localhost | "username": "9LF91O0RK7JU" 2026-03-05 18:59:03.015017 | localhost | }, 2026-03-05 18:59:03.015055 | localhost | "profile": "rackspace", 2026-03-05 18:59:03.015091 | localhost | "project_name": "1251317", 2026-03-05 18:59:03.015127 | localhost | "region_name": "DFW" 2026-03-05 18:59:03.015162 | localhost | } 2026-03-05 18:59:03.015240 | localhost | changed: All items complete 2026-03-05 18:59:03.015283 | 2026-03-05 18:59:03.022725 | 2026-03-05 18:59:03.022840 | TASK [Run upload-logs-failover role (S3 then Swift)] 2026-03-05 18:59:03.039932 | localhost | Output suppressed because no_log was given 2026-03-05 18:59:03.052569 | 2026-03-05 18:59:03.052631 | TASK [upload-logs-failover : Initialize control vars] 2026-03-05 18:59:03.105500 | localhost | ok 2026-03-05 18:59:03.109707 | 2026-03-05 18:59:03.109768 | LOOP [upload-logs-failover : Perform log upload] 2026-03-05 18:59:03.153957 | localhost | Output suppressed because no_log was given 2026-03-05 18:59:03.160784 | localhost | included: /var/lib/zuul/builds/26d67a15176a437396d931757e809080/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml 2026-03-05 18:59:03.167280 | 2026-03-05 18:59:03.167350 | LOOP [upload-logs-failover : Unpack vars for swift upload] 2026-03-05 18:59:03.275066 | localhost | Output suppressed because no_log was given 2026-03-05 18:59:03.280887 | 2026-03-05 18:59:03.280957 | TASK [Upload logs to swift] 2026-03-05 18:59:03.309707 | localhost | ok 2026-03-05 18:59:03.334265 | 2026-03-05 18:59:03.334334 | TASK [Set zuul-log-path fact] 2026-03-05 18:59:03.378010 | localhost | skipping: Conditional result was False 2026-03-05 18:59:03.383133 | 2026-03-05 18:59:03.383198 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2026-03-05 18:59:03.682657 | localhost -> localhost | ok: Runtime: 0:00:00.008488 2026-03-05 18:59:03.687942 | 2026-03-05 18:59:03.688017 | TASK [upload-logs-swift : Upload logs to swift]