2026-02-27 19:45:25.548595 | Job console starting... 2026-02-27 19:45:25.560520 | Updating repositories 2026-02-27 19:45:25.642778 | Preparing job workspace 2026-02-27 19:45:29.494897 | Running Ansible setup... 2026-02-27 19:45:33.832514 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-02-27 19:45:34.393642 | 2026-02-27 19:45:34.393845 | PLAY [localhost] 2026-02-27 19:45:34.403347 | 2026-02-27 19:45:34.403438 | TASK [Gathering Facts] 2026-02-27 19:45:35.374442 | localhost | ok 2026-02-27 19:45:35.393820 | 2026-02-27 19:45:35.393955 | TASK [Setup log path fact] 2026-02-27 19:45:35.411962 | localhost | ok 2026-02-27 19:45:35.424703 | 2026-02-27 19:45:35.424786 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-27 19:45:35.452671 | localhost | ok 2026-02-27 19:45:35.461534 | 2026-02-27 19:45:35.461601 | TASK [emit-job-header : Print job information] 2026-02-27 19:45:35.490839 | # Job Information 2026-02-27 19:45:35.490988 | Ansible Version: 2.15.12 2026-02-27 19:45:35.491031 | Job: ansible-galaxy-importer 2026-02-27 19:45:35.491060 | Pipeline: third-party-check 2026-02-27 19:45:35.491087 | Executor: ze02.softwarefactory-project.io 2026-02-27 19:45:35.491113 | Triggered by: https://github.com/ansible-collections/community.windows/pull/675 2026-02-27 19:45:35.491144 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/470/ansible/470de569b8d94884884f26dee739b425/ 2026-02-27 19:45:35.491171 | Event ID: f0d103c0-1413-11f1-88e9-1a8121db1b70 2026-02-27 19:45:35.496621 | 2026-02-27 19:45:35.496746 | LOOP [emit-job-header : Print node information] 2026-02-27 19:45:35.597923 | localhost | ok: 2026-02-27 19:45:35.598130 | localhost | # Node Information 2026-02-27 19:45:35.598157 | localhost | Inventory Hostname: controller 2026-02-27 19:45:35.598177 | localhost | Hostname: np0005633480 2026-02-27 19:45:35.598195 | localhost | Username: zuul 2026-02-27 19:45:35.598215 | localhost | Distro: Fedora 37 2026-02-27 19:45:35.598232 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2026-02-27 19:45:35.598249 | localhost | Region: ca-ymq-1 2026-02-27 19:45:35.598266 | localhost | Label: ansible-fedora-37-1vcpu 2026-02-27 19:45:35.598282 | localhost | Product Name: OpenStack Nova 2026-02-27 19:45:35.598298 | localhost | Interface IP: 162.253.55.12 2026-02-27 19:45:35.610326 | 2026-02-27 19:45:35.610435 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-02-27 19:45:35.961879 | localhost -> localhost | changed 2026-02-27 19:45:35.967673 | 2026-02-27 19:45:35.967752 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-02-27 19:45:36.731843 | localhost -> localhost | changed 2026-02-27 19:45:36.750958 | 2026-02-27 19:45:36.751011 | PLAY [all:!appliance*] 2026-02-27 19:45:36.766618 | 2026-02-27 19:45:36.766694 | TASK [include_role : start-zuul-console] 2026-02-27 19:45:36.786195 | controller | ok 2026-02-27 19:45:36.800649 | 2026-02-27 19:45:36.800744 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-02-27 19:45:37.174417 | controller | ok 2026-02-27 19:45:37.185193 | 2026-02-27 19:45:37.185270 | TASK [use-our-mirror : Retrieve the IP address] 2026-02-27 19:45:38.362521 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2026-02-27 19:45:38.376304 | 2026-02-27 19:45:38.376435 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2026-02-27 19:45:38.931012 | controller | skipping: Conditional result was False 2026-02-27 19:45:38.945592 | 2026-02-27 19:45:38.945781 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2026-02-27 19:45:38.972710 | controller | skipping: Conditional result was False 2026-02-27 19:45:38.986743 | 2026-02-27 19:45:38.986929 | TASK [use-our-mirror : Create the podman configuration directory] 2026-02-27 19:45:39.014472 | controller | skipping: Conditional result was False 2026-02-27 19:45:39.028189 | 2026-02-27 19:45:39.028328 | TASK [use-our-mirror : Copy the podman configuration] 2026-02-27 19:45:39.045095 | controller | skipping: Conditional result was False 2026-02-27 19:45:39.059179 | 2026-02-27 19:45:39.059330 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2026-02-27 19:45:39.075950 | controller | skipping: Conditional result was False 2026-02-27 19:45:39.089530 | 2026-02-27 19:45:39.089716 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2026-02-27 19:45:39.116384 | controller | skipping: Conditional result was False 2026-02-27 19:45:39.142092 | 2026-02-27 19:45:39.142220 | TASK [Disable Fedora Modular] 2026-02-27 19:45:39.406163 | controller | changed 2026-02-27 19:45:39.411940 | 2026-02-27 19:45:39.412004 | TASK [Enable EPEL] 2026-02-27 19:45:39.426717 | controller | skipping: Conditional result was False 2026-02-27 19:45:39.433162 | 2026-02-27 19:45:39.433225 | TASK [Register the RHEL node] 2026-02-27 19:45:39.983610 | 2026-02-27 19:45:39.983921 | TASK [Show the subscription-manager status] 2026-02-27 19:45:40.566703 | controller | skipping: Conditional result was False 2026-02-27 19:45:40.580230 | 2026-02-27 19:45:40.580362 | TASK [Enable EPEL on RHEL] 2026-02-27 19:45:41.136751 | controller | skipping: Conditional result was False 2026-02-27 19:45:41.149856 | 2026-02-27 19:45:41.149998 | TASK [Install git and tox] 2026-02-27 19:46:59.919436 | controller | changed 2026-02-27 19:46:59.929051 | 2026-02-27 19:46:59.929137 | TASK [include_role : prepare-workspace] 2026-02-27 19:46:59.959597 | controller | ok 2026-02-27 19:46:59.979972 | 2026-02-27 19:46:59.980042 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-02-27 19:47:00.219767 | controller | ok 2026-02-27 19:47:00.234198 | 2026-02-27 19:47:00.234332 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-02-27 19:47:02.130416 | controller | Output suppressed because no_log was given 2026-02-27 19:47:02.149792 | 2026-02-27 19:47:02.149872 | TASK [include_role : prepare-workspace-openshift] 2026-02-27 19:47:02.175281 | controller | skipping: Conditional result was False 2026-02-27 19:47:02.204647 | 2026-02-27 19:47:02.204739 | PLAY [all:!appliance] 2026-02-27 19:47:02.225481 | 2026-02-27 19:47:02.225563 | TASK [Run add-build-sshkey role (RSA)] 2026-02-27 19:47:02.264875 | controller | ok 2026-02-27 19:47:02.279982 | 2026-02-27 19:47:02.280046 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-27 19:47:02.496514 | controller -> localhost | ok 2026-02-27 19:47:02.502965 | 2026-02-27 19:47:02.503027 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-27 19:47:02.522490 | controller | ok 2026-02-27 19:47:02.535925 | controller | included: /var/lib/zuul/builds/470de569b8d94884884f26dee739b425/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-27 19:47:02.568806 | 2026-02-27 19:47:02.568932 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-27 19:47:03.052282 | controller -> localhost | Generating public/private rsa key pair. 2026-02-27 19:47:03.052442 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/470de569b8d94884884f26dee739b425/work/470de569b8d94884884f26dee739b425_id_rsa. 2026-02-27 19:47:03.052469 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/470de569b8d94884884f26dee739b425/work/470de569b8d94884884f26dee739b425_id_rsa.pub. 2026-02-27 19:47:03.052489 | controller -> localhost | The key fingerprint is: 2026-02-27 19:47:03.052508 | controller -> localhost | SHA256:AUPFwPwn8XvywmmbnbZCFuhaQrZGTOIyuZHY3t4yXDc zuul-build-sshkey 2026-02-27 19:47:03.052527 | controller -> localhost | The key's randomart image is: 2026-02-27 19:47:03.052545 | controller -> localhost | +---[RSA 2048]----+ 2026-02-27 19:47:03.052563 | controller -> localhost | | +=+. | 2026-02-27 19:47:03.052581 | controller -> localhost | | . +oo | 2026-02-27 19:47:03.052599 | controller -> localhost | | o + + ..+ | 2026-02-27 19:47:03.052616 | controller -> localhost | |. B . = +.+ | 2026-02-27 19:47:03.052633 | controller -> localhost | | . * + oSo o | 2026-02-27 19:47:03.052660 | controller -> localhost | | o . = E = . | 2026-02-27 19:47:03.052719 | controller -> localhost | | o + = = = | 2026-02-27 19:47:03.052740 | controller -> localhost | | = o *oo. | 2026-02-27 19:47:03.052758 | controller -> localhost | | o .o=+. | 2026-02-27 19:47:03.052778 | controller -> localhost | +----[SHA256]-----+ 2026-02-27 19:47:03.052824 | controller -> localhost | ok: Runtime: 0:00:00.035444 2026-02-27 19:47:03.059779 | 2026-02-27 19:47:03.059840 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-27 19:47:03.089048 | controller | ok 2026-02-27 19:47:03.098799 | controller | included: /var/lib/zuul/builds/470de569b8d94884884f26dee739b425/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-27 19:47:03.107565 | 2026-02-27 19:47:03.107629 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-27 19:47:03.131362 | controller | skipping: Conditional result was False 2026-02-27 19:47:03.138799 | 2026-02-27 19:47:03.138862 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-27 19:47:03.512051 | controller | changed 2026-02-27 19:47:03.518006 | 2026-02-27 19:47:03.518081 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-27 19:47:03.747846 | controller | ok 2026-02-27 19:47:03.760928 | 2026-02-27 19:47:03.761067 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-27 19:47:04.453010 | controller | changed 2026-02-27 19:47:04.473981 | 2026-02-27 19:47:04.474070 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-27 19:47:05.141895 | controller | changed 2026-02-27 19:47:05.147577 | 2026-02-27 19:47:05.147636 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-27 19:47:05.161631 | controller | skipping: Conditional result was False 2026-02-27 19:47:05.168354 | 2026-02-27 19:47:05.168416 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-27 19:47:05.488863 | controller -> localhost | changed 2026-02-27 19:47:05.499896 | 2026-02-27 19:47:05.499960 | TASK [add-build-sshkey : Add back temp key] 2026-02-27 19:47:05.748605 | controller -> localhost | Identity added: /var/lib/zuul/builds/470de569b8d94884884f26dee739b425/work/470de569b8d94884884f26dee739b425_id_rsa (zuul-build-sshkey) 2026-02-27 19:47:05.748865 | controller -> localhost | ok: Runtime: 0:00:00.010546 2026-02-27 19:47:05.757843 | 2026-02-27 19:47:05.757922 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-27 19:47:06.068849 | controller | ok 2026-02-27 19:47:06.080543 | 2026-02-27 19:47:06.080703 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-27 19:47:06.118821 | controller | skipping: Conditional result was False 2026-02-27 19:47:06.142529 | 2026-02-27 19:47:06.142613 | TASK [Run add-build-sshkey role (ECDSA)] 2026-02-27 19:47:06.164454 | controller | ok 2026-02-27 19:47:06.185868 | 2026-02-27 19:47:06.185954 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-02-27 19:47:06.395571 | controller -> localhost | ok 2026-02-27 19:47:06.405516 | 2026-02-27 19:47:06.405601 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-02-27 19:47:06.437753 | controller | ok 2026-02-27 19:47:06.451915 | controller | included: /var/lib/zuul/builds/470de569b8d94884884f26dee739b425/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-02-27 19:47:06.460032 | 2026-02-27 19:47:06.460112 | TASK [add-build-sshkey : Create Temp SSH key] 2026-02-27 19:47:06.709221 | controller -> localhost | Generating public/private ecdsa key pair. 2026-02-27 19:47:06.709460 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/470de569b8d94884884f26dee739b425/work/470de569b8d94884884f26dee739b425_id_ecdsa. 2026-02-27 19:47:06.709499 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/470de569b8d94884884f26dee739b425/work/470de569b8d94884884f26dee739b425_id_ecdsa.pub. 2026-02-27 19:47:06.709535 | controller -> localhost | The key fingerprint is: 2026-02-27 19:47:06.709564 | controller -> localhost | SHA256:1vxeQgieCKnFYstpvqu61K3D5GX6wTZkCVgYTyHW6+0 zuul-build-sshkey 2026-02-27 19:47:06.709591 | controller -> localhost | The key's randomart image is: 2026-02-27 19:47:06.709618 | controller -> localhost | +---[ECDSA 521]---+ 2026-02-27 19:47:06.709645 | controller -> localhost | | +++. | 2026-02-27 19:47:06.709696 | controller -> localhost | |..*o . | 2026-02-27 19:47:06.709724 | controller -> localhost | | .oo* . | 2026-02-27 19:47:06.709750 | controller -> localhost | | o B...o = . | 2026-02-27 19:47:06.709776 | controller -> localhost | | B .+. S + . | 2026-02-27 19:47:06.709801 | controller -> localhost | | o.o=+ . o | 2026-02-27 19:47:06.709826 | controller -> localhost | | .=.=* o . | 2026-02-27 19:47:06.709850 | controller -> localhost | |. *oEo . o | 2026-02-27 19:47:06.709875 | controller -> localhost | |=oooo. . | 2026-02-27 19:47:06.709900 | controller -> localhost | +----[SHA256]-----+ 2026-02-27 19:47:06.709965 | controller -> localhost | ok: Runtime: 0:00:00.010071 2026-02-27 19:47:06.718515 | 2026-02-27 19:47:06.718593 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-02-27 19:47:06.740348 | controller | ok 2026-02-27 19:47:06.751276 | controller | included: /var/lib/zuul/builds/470de569b8d94884884f26dee739b425/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-02-27 19:47:06.762897 | 2026-02-27 19:47:06.762979 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-02-27 19:47:06.777597 | controller | skipping: Conditional result was False 2026-02-27 19:47:06.786299 | 2026-02-27 19:47:06.786385 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-02-27 19:47:07.055311 | controller | changed 2026-02-27 19:47:07.067516 | 2026-02-27 19:47:07.067642 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-02-27 19:47:07.332469 | controller | ok 2026-02-27 19:47:07.344785 | 2026-02-27 19:47:07.344913 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-02-27 19:47:07.982973 | controller | changed 2026-02-27 19:47:07.990862 | 2026-02-27 19:47:07.990947 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-02-27 19:47:08.595485 | controller | changed 2026-02-27 19:47:08.601158 | 2026-02-27 19:47:08.601219 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-02-27 19:47:08.626407 | controller | skipping: Conditional result was False 2026-02-27 19:47:08.633470 | 2026-02-27 19:47:08.633534 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-02-27 19:47:08.891820 | controller -> localhost | changed 2026-02-27 19:47:08.918830 | 2026-02-27 19:47:08.918983 | TASK [add-build-sshkey : Add back temp key] 2026-02-27 19:47:09.211874 | controller -> localhost | Identity added: /var/lib/zuul/builds/470de569b8d94884884f26dee739b425/work/470de569b8d94884884f26dee739b425_id_ecdsa (zuul-build-sshkey) 2026-02-27 19:47:09.212054 | controller -> localhost | ok: Runtime: 0:00:00.011886 2026-02-27 19:47:09.218354 | 2026-02-27 19:47:09.218415 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-02-27 19:47:09.439119 | controller | ok 2026-02-27 19:47:09.451006 | 2026-02-27 19:47:09.451139 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-02-27 19:47:09.488177 | controller | skipping: Conditional result was False 2026-02-27 19:47:09.513081 | 2026-02-27 19:47:09.513211 | TASK [include_role : remove-zuul-sshkey] 2026-02-27 19:47:09.530264 | controller | skipping: Conditional result was False 2026-02-27 19:47:09.543932 | 2026-02-27 19:47:09.544073 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-02-27 19:47:09.802037 | controller | ok: "logs" 2026-02-27 19:47:09.802464 | controller | ok: All items complete 2026-02-27 19:47:09.802525 | 2026-02-27 19:47:10.011891 | controller | ok: "artifacts" 2026-02-27 19:47:10.210718 | controller | ok: "docs" 2026-02-27 19:47:10.226183 | 2026-02-27 19:47:10.226380 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-02-27 19:47:10.476969 | controller | changed: "logs" 2026-02-27 19:47:10.679407 | controller | changed: "artifacts" 2026-02-27 19:47:10.933152 | controller | changed: "docs" 2026-02-27 19:47:10.993721 | 2026-02-27 19:47:10.993846 | PLAY RECAP 2026-02-27 19:47:10.993901 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2026-02-27 19:47:10.993936 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-02-27 19:47:10.993961 | 2026-02-27 19:47:11.114974 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-02-27 19:47:11.116376 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master] 2026-02-27 19:47:11.758537 | 2026-02-27 19:47:11.758651 | PLAY [all] 2026-02-27 19:47:11.778728 | 2026-02-27 19:47:11.778803 | TASK [Setup ensure-tox role] 2026-02-27 19:47:11.798017 | controller | ok 2026-02-27 19:47:11.820154 | 2026-02-27 19:47:11.820237 | TASK [Install pip] 2026-02-27 19:47:11.838805 | controller | ok 2026-02-27 19:47:11.859643 | 2026-02-27 19:47:11.859737 | TASK [ensure-pip : Check if pip is installed] 2026-02-27 19:47:12.254272 | controller | /usr/bin/pip3 2026-02-27 19:47:12.270341 | controller | /usr/bin/python3: No module named wheel 2026-02-27 19:47:12.392288 | controller | ok: Runtime: 0:00:00.026083 2026-02-27 19:47:12.405108 | 2026-02-27 19:47:12.405246 | LOOP [ensure-pip : Install pip from packages] 2026-02-27 19:47:12.436923 | controller | ok: "/var/lib/zuul/builds/470de569b8d94884884f26dee739b425/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml" 2026-02-27 19:47:12.460181 | controller | included: /var/lib/zuul/builds/470de569b8d94884884f26dee739b425/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml 2026-02-27 19:47:12.479373 | 2026-02-27 19:47:12.479459 | TASK [ensure-pip : Install Python 3 pip] 2026-02-27 19:47:17.130065 | controller | changed 2026-02-27 19:47:17.142806 | 2026-02-27 19:47:17.142975 | TASK [ensure-pip : Check for EPEL repository] 2026-02-27 19:47:17.170870 | controller | skipping: Conditional result was False 2026-02-27 19:47:17.184625 | 2026-02-27 19:47:17.184819 | TASK [ensure-pip : Fail with instructions when EPEL is not installed] 2026-02-27 19:47:17.212617 | controller | skipping: Conditional result was False 2026-02-27 19:47:17.226576 | 2026-02-27 19:47:17.226812 | TASK [ensure-pip : Install Python 2 pip] 2026-02-27 19:47:17.254366 | controller | skipping: Conditional result was False 2026-02-27 19:47:17.268991 | 2026-02-27 19:47:17.269186 | TASK [ensure-pip : Ensure setuptools] 2026-02-27 19:47:17.297118 | controller | skipping: Conditional result was False 2026-02-27 19:47:17.312416 | 2026-02-27 19:47:17.312569 | TASK [ensure-pip : Check for ensurepip module] 2026-02-27 19:47:17.859564 | controller | skipping: Conditional result was False 2026-02-27 19:47:17.873655 | 2026-02-27 19:47:17.873836 | TASK [ensure-pip : Ensure python3-venv] 2026-02-27 19:47:17.901015 | controller | skipping: Conditional result was False 2026-02-27 19:47:17.914590 | 2026-02-27 19:47:17.914765 | TASK [ensure-pip : Install pip from source] 2026-02-27 19:47:17.941388 | controller | skipping: Conditional result was False 2026-02-27 19:47:17.955323 | 2026-02-27 19:47:17.955473 | TASK [ensure-pip : Probe for venv python full path] 2026-02-27 19:47:18.303712 | controller | /usr/bin/python3 2026-02-27 19:47:18.505161 | controller | ok: Runtime: 0:00:00.007118 2026-02-27 19:47:18.553060 | 2026-02-27 19:47:18.553231 | TASK [ensure-pip : Set host default] 2026-02-27 19:47:18.606901 | controller | ok 2026-02-27 19:47:18.614366 | 2026-02-27 19:47:18.614461 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2026-02-27 19:47:18.668769 | controller | ok 2026-02-27 19:47:18.682641 | 2026-02-27 19:47:18.682761 | TASK [ensure-tox : Check if tox is installed] 2026-02-27 19:47:18.961966 | controller | /usr/bin/tox 2026-02-27 19:47:19.224068 | controller | ok: Runtime: 0:00:00.003728 2026-02-27 19:47:19.237138 | 2026-02-27 19:47:19.237287 | TASK [ensure-tox : Export preinstalled tox_exectuable] 2026-02-27 19:47:19.288385 | controller | ok 2026-02-27 19:47:19.300075 | 2026-02-27 19:47:19.300230 | TASK [ensure-tox : Create local venv] 2026-02-27 19:47:19.858213 | controller | skipping: Conditional result was False 2026-02-27 19:47:19.872904 | 2026-02-27 19:47:19.873051 | TASK [ensure-tox : Install tox to local venv] 2026-02-27 19:47:20.435951 | controller | skipping: Conditional result was False 2026-02-27 19:47:20.449957 | 2026-02-27 19:47:20.450102 | TASK [ensure-tox : Export installed tox_executable path] 2026-02-27 19:47:20.476963 | controller | skipping: Conditional result was False 2026-02-27 19:47:20.490618 | 2026-02-27 19:47:20.490861 | TASK [ensure-tox : Output tox version] 2026-02-27 19:47:20.979826 | controller | 3.28.0 imported from /usr/lib/python3.11/site-packages/tox/__init__.py 2026-02-27 19:47:21.053819 | controller | ok: Runtime: 0:00:00.195610 2026-02-27 19:47:21.067289 | 2026-02-27 19:47:21.067458 | TASK [ensure-tox : Make global symlink] 2026-02-27 19:47:21.094221 | controller | skipping: Conditional result was False 2026-02-27 19:47:21.119104 | 2026-02-27 19:47:21.119265 | TASK [Setup tox role] 2026-02-27 19:47:21.148579 | controller | ok 2026-02-27 19:47:21.190366 | 2026-02-27 19:47:21.190456 | TASK [tox : Check to see if the constraints file exists] 2026-02-27 19:47:21.225307 | controller | skipping: Conditional result was False 2026-02-27 19:47:21.231331 | 2026-02-27 19:47:21.231396 | TASK [tox : Fail if constraints file is missing] 2026-02-27 19:47:21.265278 | controller | skipping: Conditional result was False 2026-02-27 19:47:21.271170 | 2026-02-27 19:47:21.271233 | TASK [tox : Record file location] 2026-02-27 19:47:21.295078 | controller | skipping: Conditional result was False 2026-02-27 19:47:21.301122 | 2026-02-27 19:47:21.301185 | TASK [tox : Install tox siblings] 2026-02-27 19:47:21.314388 | controller | skipping: Conditional result was False 2026-02-27 19:47:21.322394 | 2026-02-27 19:47:21.322463 | TASK [tox : Emit tox command] 2026-02-27 19:47:21.351152 | /usr/bin/tox -evenv -vv --notest 2026-02-27 19:47:21.356574 | 2026-02-27 19:47:21.356635 | TASK [tox : Run tox] 2026-02-27 19:47:21.760635 | controller | using tox.ini: /home/zuul/src/github.com/ansible-network/releases/tox.ini (pid 2295) 2026-02-27 19:47:21.768355 | controller | using tox-3.28.0 from /usr/lib/python3.11/site-packages/tox/__init__.py (pid 2295) 2026-02-27 19:47:21.790500 | controller | skipping sdist step 2026-02-27 19:47:21.790519 | controller | venv uses /usr/bin/python3 2026-02-27 19:47:21.790553 | controller | venv start: getenv /home/zuul/src/github.com/ansible-network/releases/.tox/venv 2026-02-27 19:47:21.790784 | controller | venv cannot reuse: no previous config /home/zuul/src/github.com/ansible-network/releases/.tox/venv/.tox-config1 2026-02-27 19:47:21.790797 | controller | venv create: /home/zuul/src/github.com/ansible-network/releases/.tox/venv 2026-02-27 19:47:21.790806 | 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-02-27 19:47:21.790816 | controller | [2303] /home/zuul/src/github.com/ansible-network/releases/.tox$ /usr/bin/python3 -m virtualenv --no-download --python /usr/bin/python3 venv 2026-02-27 19:47:22.347022 | controller | created virtual environment CPython3.11.0.final.0-64 in 474ms 2026-02-27 19:47:22.378500 | controller | creator CPython3Posix(dest=/home/zuul/src/github.com/ansible-network/releases/.tox/venv, clear=False, no_vcs_ignore=False, global=False) 2026-02-27 19:47:22.378556 | 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-02-27 19:47:22.378574 | controller | added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1 2026-02-27 19:47:22.378586 | controller | activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator 2026-02-27 19:47:22.378609 | 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-02-27 19:47:22.379153 | 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-02-27 19:47:22.379194 | controller | [2311] /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-02-27 19:47:23.796279 | controller | Collecting ruamel.yaml 2026-02-27 19:47:23.859713 | controller | Downloading ruamel_yaml-0.19.1-py3-none-any.whl (118 kB) 2026-02-27 19:47:23.886843 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 118.1/118.1 kB 4.6 MB/s eta 0:00:00 2026-02-27 19:47:23.936185 | controller | Collecting pbr 2026-02-27 19:47:23.948960 | controller | Downloading pbr-7.0.3-py2.py3-none-any.whl (131 kB) 2026-02-27 19:47:23.961587 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 131.9/131.9 kB 13.7 MB/s eta 0:00:00 2026-02-27 19:47:23.999421 | controller | Collecting tweepy 2026-02-27 19:47:24.012891 | controller | Downloading tweepy-4.16.0-py3-none-any.whl (98 kB) 2026-02-27 19:47:24.019788 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.8/98.8 kB 20.7 MB/s eta 0:00:00 2026-02-27 19:47:24.068266 | controller | Collecting galaxy-importer 2026-02-27 19:47:24.082082 | controller | Downloading galaxy_importer-0.4.37-py3-none-any.whl (64 kB) 2026-02-27 19:47:24.094486 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 64.9/64.9 kB 8.3 MB/s eta 0:00:00 2026-02-27 19:47:24.145439 | controller | Collecting flake8 2026-02-27 19:47:24.158015 | controller | Downloading flake8-7.3.0-py2.py3-none-any.whl (57 kB) 2026-02-27 19:47:24.167512 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 57.9/57.9 kB 7.0 MB/s eta 0:00:00 2026-02-27 19:47:24.181992 | 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-02-27 19:47:24.221163 | controller | Collecting oauthlib<4,>=3.2.0 2026-02-27 19:47:24.233774 | controller | Downloading oauthlib-3.3.1-py3-none-any.whl (160 kB) 2026-02-27 19:47:24.246446 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 160.1/160.1 kB 17.8 MB/s eta 0:00:00 2026-02-27 19:47:24.304419 | controller | Collecting requests<3,>=2.27.0 2026-02-27 19:47:24.316067 | controller | Downloading requests-2.32.5-py3-none-any.whl (64 kB) 2026-02-27 19:47:24.324264 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 64.7/64.7 kB 9.8 MB/s eta 0:00:00 2026-02-27 19:47:24.355264 | controller | Collecting requests-oauthlib<3,>=1.2.0 2026-02-27 19:47:24.367240 | controller | Downloading requests_oauthlib-2.0.0-py2.py3-none-any.whl (24 kB) 2026-02-27 19:47:24.514049 | controller | Collecting ansible-core 2026-02-27 19:47:24.527215 | controller | Downloading ansible_core-2.19.7-py3-none-any.whl (2.4 MB) 2026-02-27 19:47:24.569023 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.4/2.4 MB 62.3 MB/s eta 0:00:00 2026-02-27 19:47:24.612842 | controller | Collecting ansible-builder<4.0,>=1.2.0 2026-02-27 19:47:24.626104 | controller | Downloading ansible_builder-3.1.1-py3-none-any.whl (46 kB) 2026-02-27 19:47:24.634862 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 46.5/46.5 kB 6.1 MB/s eta 0:00:00 2026-02-27 19:47:24.752078 | controller | Collecting ansible-lint<=26.1.0,>=6.2.2 2026-02-27 19:47:24.764813 | controller | Downloading ansible_lint-26.1.0-py3-none-any.whl (324 kB) 2026-02-27 19:47:24.776139 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 324.6/324.6 kB 35.1 MB/s eta 0:00:00 2026-02-27 19:47:24.813915 | controller | Collecting attrs<23,>=21.4.0 2026-02-27 19:47:24.831109 | controller | Downloading attrs-22.2.0-py3-none-any.whl (60 kB) 2026-02-27 19:47:24.839948 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 60.0/60.0 kB 10.7 MB/s eta 0:00:00 2026-02-27 19:47:24.936306 | controller | Collecting nh3<3,>=0.2.18 2026-02-27 19:47:24.951722 | controller | Downloading nh3-0.3.3-cp38-abi3-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (811 kB) 2026-02-27 19:47:24.969504 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 811.5/811.5 kB 55.0 MB/s eta 0:00:00 2026-02-27 19:47:24.984358 | controller | Collecting flake8 2026-02-27 19:47:24.997317 | controller | Downloading flake8-6.1.0-py2.py3-none-any.whl (58 kB) 2026-02-27 19:47:25.008038 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 58.3/58.3 kB 5.9 MB/s eta 0:00:00 2026-02-27 19:47:25.050813 | controller | Collecting markdown<4,>=3.3.4 2026-02-27 19:47:25.063138 | controller | Downloading markdown-3.10.2-py3-none-any.whl (108 kB) 2026-02-27 19:47:25.077166 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 108.2/108.2 kB 12.8 MB/s eta 0:00:00 2026-02-27 19:47:25.224764 | controller | Collecting pyyaml<7,>=5.4.1 2026-02-27 19:47:25.237455 | 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-02-27 19:47:25.257670 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 806.6/806.6 kB 46.0 MB/s eta 0:00:00 2026-02-27 19:47:25.309768 | controller | Collecting semantic-version<3,>=2.9.0 2026-02-27 19:47:25.321676 | controller | Downloading semantic_version-2.10.0-py2.py3-none-any.whl (15 kB) 2026-02-27 19:47:25.374190 | controller | Collecting packaging<25.0,>=23.2 2026-02-27 19:47:25.387855 | controller | Downloading packaging-24.2-py3-none-any.whl (65 kB) 2026-02-27 19:47:25.398699 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 65.5/65.5 kB 7.3 MB/s eta 0:00:00 2026-02-27 19:47:25.434153 | controller | Collecting mccabe<0.8.0,>=0.7.0 2026-02-27 19:47:25.446435 | controller | Downloading mccabe-0.7.0-py2.py3-none-any.whl (7.3 kB) 2026-02-27 19:47:25.491933 | controller | Collecting pycodestyle<2.12.0,>=2.11.0 2026-02-27 19:47:25.505089 | controller | Downloading pycodestyle-2.11.1-py2.py3-none-any.whl (31 kB) 2026-02-27 19:47:25.548905 | controller | Collecting pyflakes<3.2.0,>=3.1.0 2026-02-27 19:47:25.561177 | controller | Downloading pyflakes-3.1.0-py2.py3-none-any.whl (62 kB) 2026-02-27 19:47:25.570267 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 62.6/62.6 kB 8.8 MB/s eta 0:00:00 2026-02-27 19:47:25.601956 | controller | Collecting bindep 2026-02-27 19:47:25.615166 | controller | Downloading bindep-2.13.0-py3-none-any.whl (34 kB) 2026-02-27 19:47:25.679044 | controller | Collecting jsonschema 2026-02-27 19:47:25.691045 | controller | Downloading jsonschema-4.26.0-py3-none-any.whl (90 kB) 2026-02-27 19:47:25.697390 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 90.6/90.6 kB 23.1 MB/s eta 0:00:00 2026-02-27 19:47:25.772363 | controller | Collecting ansible-compat>=25.8.2 2026-02-27 19:47:25.784661 | controller | Downloading ansible_compat-25.12.1-py3-none-any.whl (27 kB) 2026-02-27 19:47:25.939292 | controller | Collecting black>=24.3.0 2026-02-27 19:47:25.952892 | 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-02-27 19:47:25.980906 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.7/1.7 MB 74.0 MB/s eta 0:00:00 2026-02-27 19:47:26.270910 | controller | Collecting cffi>=1.15.1 2026-02-27 19:47:26.283884 | controller | Downloading cffi-2.0.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl (215 kB) 2026-02-27 19:47:26.295438 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 215.6/215.6 kB 25.0 MB/s eta 0:00:00 2026-02-27 19:52:31.804119 | controller | ERROR 2026-02-27 19:52:31.804360 | controller | { 2026-02-27 19:52:31.804424 | controller | "msg": "Data could not be sent to remote host \"162.253.55.12\". Make sure this host can be reached over ssh: ssh: connect to host 162.253.55.12 port 22: Connection timed out\r\n", 2026-02-27 19:52:31.804471 | controller | "unreachable": true 2026-02-27 19:52:31.804510 | controller | } unreachable 2026-02-27 19:52:31.806451 | 2026-02-27 19:52:31.806552 | PLAY RECAP 2026-02-27 19:52:31.806637 | controller | ok: 10 changed: 5 unreachable: 1 failed: 0 skipped: 15 rescued: 0 ignored: 0 2026-02-27 19:52:31.807269 | 2026-02-27 19:52:31.922907 | PRE-RUN END RESULT_UNREACHABLE: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master] 2026-02-27 19:52:31.924503 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2026-02-27 19:52:32.512736 | 2026-02-27 19:52:32.512851 | PLAY [all:!appliance*] 2026-02-27 19:52:32.534637 | 2026-02-27 19:52:32.534762 | TASK [unregister the node] 2026-02-27 19:52:33.067289 | controller | skipping: Conditional result was False 2026-02-27 19:52:33.080068 | 2026-02-27 19:52:33.080233 | TASK [include_role : fetch-output] 2026-02-27 19:52:33.129147 | controller | ok 2026-02-27 19:52:33.167778 | 2026-02-27 19:52:33.167921 | TASK [fetch-output : Set log path for multiple nodes] 2026-02-27 19:52:33.213598 | controller | skipping: Conditional result was False 2026-02-27 19:52:33.222182 | 2026-02-27 19:52:33.222278 | TASK [fetch-output : Set log path for single node] 2026-02-27 19:52:33.255357 | controller | ok 2026-02-27 19:52:33.263431 | 2026-02-27 19:52:33.263525 | LOOP [fetch-output : Ensure local output dirs] 2026-02-27 19:52:33.626807 | controller -> localhost | ok: "/var/lib/zuul/builds/470de569b8d94884884f26dee739b425/work/logs" 2026-02-27 19:52:33.888148 | controller -> localhost | changed: "/var/lib/zuul/builds/470de569b8d94884884f26dee739b425/work/artifacts" 2026-02-27 19:52:34.150465 | controller -> localhost | changed: "/var/lib/zuul/builds/470de569b8d94884884f26dee739b425/work/docs" 2026-02-27 19:52:34.176662 | 2026-02-27 19:52:34.176883 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-02-27 19:52:34.934288 | controller | ok 2026-02-27 19:52:34.934636 | controller | changed: All items complete 2026-02-27 19:52:34.934778 | 2026-02-27 19:52:35.439428 | controller | changed: .d..t...... ./ 2026-02-27 19:52:35.956821 | controller | changed: .d..t...... ./ 2026-02-27 19:52:35.970420 | 2026-02-27 19:52:35.970542 | TASK [include_role : fetch-output-openshift] 2026-02-27 19:52:35.994120 | controller | skipping: Conditional result was False 2026-02-27 19:52:36.000545 | 2026-02-27 19:52:36.000611 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-02-27 19:52:36.420313 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.012663 2026-02-27 19:52:36.666767 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.012264 2026-02-27 19:52:36.701212 | 2026-02-27 19:52:36.701316 | PLAY [localhost] 2026-02-27 19:52:36.713652 | 2026-02-27 19:52:36.713725 | TASK [Run Zuul manifest role] 2026-02-27 19:52:36.731237 | localhost | ok 2026-02-27 19:52:36.743413 | 2026-02-27 19:52:36.743472 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-02-27 19:52:37.162018 | localhost | changed 2026-02-27 19:52:37.172416 | 2026-02-27 19:52:37.172543 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-02-27 19:52:37.218400 | localhost | ok 2026-02-27 19:52:37.236472 | 2026-02-27 19:52:37.236594 | TASK [Set zuul-log-path fact] 2026-02-27 19:52:37.263884 | localhost | ok 2026-02-27 19:52:37.287868 | 2026-02-27 19:52:37.287952 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-02-27 19:52:37.328302 | localhost | ok 2026-02-27 19:52:37.338960 | 2026-02-27 19:52:37.339040 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)] 2026-02-27 19:52:37.382623 | localhost | ok: 2026-02-27 19:52:37.383077 | localhost | { 2026-02-27 19:52:37.383134 | localhost | "auth": { 2026-02-27 19:52:37.383175 | localhost | "password": "IonWCwcuOFib&&<}wp^:[2G/", 2026-02-27 19:52:37.383211 | localhost | "username": "9LF91O0RK7JU" 2026-02-27 19:52:37.383255 | localhost | }, 2026-02-27 19:52:37.383289 | localhost | "profile": "rackspace", 2026-02-27 19:52:37.383323 | localhost | "region_name": "IAD" 2026-02-27 19:52:37.383357 | localhost | } 2026-02-27 19:52:37.383425 | localhost | changed: All items complete 2026-02-27 19:52:37.383467 | 2026-02-27 19:52:37.391917 | 2026-02-27 19:52:37.392047 | TASK [Run upload-logs-failover role (S3 then Swift)] 2026-02-27 19:52:37.412091 | localhost | Output suppressed because no_log was given 2026-02-27 19:52:37.428526 | 2026-02-27 19:52:37.428613 | TASK [upload-logs-failover : Initialize control vars] 2026-02-27 19:52:37.487992 | localhost | ok 2026-02-27 19:52:37.493763 | 2026-02-27 19:52:37.493843 | LOOP [upload-logs-failover : Perform log upload] 2026-02-27 19:52:37.539511 | localhost | Output suppressed because no_log was given 2026-02-27 19:52:37.546085 | localhost | included: /var/lib/zuul/builds/470de569b8d94884884f26dee739b425/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml 2026-02-27 19:52:37.552587 | 2026-02-27 19:52:37.552695 | LOOP [upload-logs-failover : Unpack vars for swift upload] 2026-02-27 19:52:37.667540 | localhost | Output suppressed because no_log was given 2026-02-27 19:52:37.679998 | 2026-02-27 19:52:37.680143 | TASK [Upload logs to swift] 2026-02-27 19:52:37.716338 | localhost | ok 2026-02-27 19:52:37.762512 | 2026-02-27 19:52:37.762607 | TASK [Set zuul-log-path fact] 2026-02-27 19:52:37.797509 | localhost | skipping: Conditional result was False 2026-02-27 19:52:37.804533 | 2026-02-27 19:52:37.804617 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2026-02-27 19:52:38.103043 | localhost -> localhost | ok: Runtime: 0:00:00.006065 2026-02-27 19:52:38.110222 | 2026-02-27 19:52:38.110310 | TASK [upload-logs-swift : Upload logs to swift]