2025-10-19 12:07:41.428634 | Job console starting...
2025-10-19 12:07:41.440037 | Updating repositories
2025-10-19 12:07:41.499655 | Preparing job workspace
2025-10-19 12:07:45.604830 | Running Ansible setup...
2025-10-19 12:07:53.397316 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2025-10-19 12:07:53.990419 | 
2025-10-19 12:07:53.990544 | PLAY [localhost]
2025-10-19 12:07:53.999153 | 
2025-10-19 12:07:53.999228 | TASK [Gathering Facts]
2025-10-19 12:07:55.009371 | localhost | ok
2025-10-19 12:07:55.028162 | 
2025-10-19 12:07:55.028289 | TASK [Setup log path fact]
2025-10-19 12:07:55.049703 | localhost | ok
2025-10-19 12:07:55.066140 | 
2025-10-19 12:07:55.066231 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-10-19 12:07:55.097450 | localhost | ok
2025-10-19 12:07:55.107882 | 
2025-10-19 12:07:55.107972 | TASK [emit-job-header : Print job information]
2025-10-19 12:07:55.158043 | # Job Information
2025-10-19 12:07:55.158191 | Ansible Version: 2.15.12
2025-10-19 12:07:55.158234 | Job: ansible-galaxy-importer
2025-10-19 12:07:55.158262 | Pipeline: third-party-check
2025-10-19 12:07:55.158287 | Executor: ze04.softwarefactory-project.io
2025-10-19 12:07:55.158311 | Triggered by: https://github.com/ansible-collections/community.vmware/pull/2503
2025-10-19 12:07:55.158340 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/66c/ansible/66cdaaf2d17047f2a99b500807e6302f/
2025-10-19 12:07:55.158365 | Event ID: 2ac850d0-ace3-11f0-9f68-080fc459cd8b
2025-10-19 12:07:55.163231 | 
2025-10-19 12:07:55.163313 | LOOP [emit-job-header : Print node information]
2025-10-19 12:07:55.272492 | localhost | ok:
2025-10-19 12:07:55.272883 | localhost | # Node Information
2025-10-19 12:07:55.272946 | localhost | Inventory Hostname: controller
2025-10-19 12:07:55.272990 | localhost | Hostname: np0005494743
2025-10-19 12:07:55.273054 | localhost | Username: zuul
2025-10-19 12:07:55.273100 | localhost | Distro: Fedora 37
2025-10-19 12:07:55.273140 | localhost | Provider: ansible-vexxhost-ams1
2025-10-19 12:07:55.273180 | localhost | Region: ams1
2025-10-19 12:07:55.273218 | localhost | Label: ansible-fedora-37-1vcpu
2025-10-19 12:07:55.273255 | localhost | Product Name: OpenStack Nova
2025-10-19 12:07:55.273292 | localhost | Interface IP: 38.129.16.108
2025-10-19 12:07:55.286815 | 
2025-10-19 12:07:55.286932 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2025-10-19 12:07:55.676035 | localhost -> localhost | changed
2025-10-19 12:07:55.681567 | 
2025-10-19 12:07:55.681631 | TASK [log-inventory : Copy ansible inventory to logs dir]
2025-10-19 12:07:56.533816 | localhost -> localhost | changed
2025-10-19 12:07:56.553422 | 
2025-10-19 12:07:56.553474 | PLAY [all:!appliance*]
2025-10-19 12:07:56.568969 | 
2025-10-19 12:07:56.569034 | TASK [include_role : start-zuul-console]
2025-10-19 12:07:56.588659 | controller | ok
2025-10-19 12:07:56.601766 | 
2025-10-19 12:07:56.601823 | TASK [start-zuul-console : Start zuul_console daemon.]
2025-10-19 12:07:57.622162 | controller | ok
2025-10-19 12:07:57.645762 | 
2025-10-19 12:07:57.645897 | TASK [use-our-mirror : Retrieve the IP address]
2025-10-19 12:08:00.265216 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found
2025-10-19 12:08:00.279672 | 
2025-10-19 12:08:00.279836 | TASK [use-our-mirror : Ensure the registry service is running on the mirror]
2025-10-19 12:08:00.653640 | controller | skipping: Conditional result was False
2025-10-19 12:08:00.666827 | 
2025-10-19 12:08:00.666968 | TASK [use-our-mirror : Write the IP in /etc/hosts]
2025-10-19 12:08:00.697145 | controller | skipping: Conditional result was False
2025-10-19 12:08:00.711616 | 
2025-10-19 12:08:00.711788 | TASK [use-our-mirror : Create the podman configuration directory]
2025-10-19 12:08:00.738848 | controller | skipping: Conditional result was False
2025-10-19 12:08:00.752260 | 
2025-10-19 12:08:00.752396 | TASK [use-our-mirror : Copy the podman configuration]
2025-10-19 12:08:00.779059 | controller | skipping: Conditional result was False
2025-10-19 12:08:00.792435 | 
2025-10-19 12:08:00.792570 | TASK [use-our-mirror : Copy the Yum configuration (main)]
2025-10-19 12:08:00.819497 | controller | skipping: Conditional result was False
2025-10-19 12:08:00.832511 | 
2025-10-19 12:08:00.832642 | TASK [use-our-mirror : Copy the Yum configuration (update)]
2025-10-19 12:08:00.859843 | controller | skipping: Conditional result was False
2025-10-19 12:08:00.883970 | 
2025-10-19 12:08:00.884121 | TASK [Disable Fedora Modular]
2025-10-19 12:08:01.979386 | controller | changed
2025-10-19 12:08:01.991393 | 
2025-10-19 12:08:01.991517 | TASK [Enable EPEL]
2025-10-19 12:08:02.018607 | controller | skipping: Conditional result was False
2025-10-19 12:08:02.031141 | 
2025-10-19 12:08:02.031269 | TASK [Register the RHEL node]
2025-10-19 12:08:02.445339 | 
2025-10-19 12:08:02.445721 | TASK [Show the subscription-manager status]
2025-10-19 12:08:02.829519 | controller | skipping: Conditional result was False
2025-10-19 12:08:02.836107 | 
2025-10-19 12:08:02.836170 | TASK [Enable EPEL on RHEL]
2025-10-19 12:08:03.206438 | controller | skipping: Conditional result was False
2025-10-19 12:08:03.212640 | 
2025-10-19 12:08:03.212718 | TASK [Install git and tox]
2025-10-19 12:10:44.634199 | controller | changed
2025-10-19 12:10:44.647450 | 
2025-10-19 12:10:44.647581 | TASK [include_role : prepare-workspace]
2025-10-19 12:10:44.685601 | controller | ok
2025-10-19 12:10:44.721611 | 
2025-10-19 12:10:44.721773 | TASK [prepare-workspace : Start zuul_console daemon.]
2025-10-19 12:10:45.529849 | controller | ok
2025-10-19 12:10:45.543107 | 
2025-10-19 12:10:45.543237 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2025-10-19 12:10:49.128472 | controller | Output suppressed because no_log was given
2025-10-19 12:10:49.152201 | 
2025-10-19 12:10:49.152326 | TASK [include_role : prepare-workspace-openshift]
2025-10-19 12:10:49.178177 | controller | skipping: Conditional result was False
2025-10-19 12:10:49.206781 | 
2025-10-19 12:10:49.206848 | PLAY [all:!appliance]
2025-10-19 12:10:49.227244 | 
2025-10-19 12:10:49.227321 | TASK [Run add-build-sshkey role (RSA)]
2025-10-19 12:10:49.259671 | controller | ok
2025-10-19 12:10:49.303952 | 
2025-10-19 12:10:49.304056 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2025-10-19 12:10:49.582339 | controller -> localhost | ok
2025-10-19 12:10:49.588925 | 
2025-10-19 12:10:49.588989 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2025-10-19 12:10:49.619183 | controller | ok
2025-10-19 12:10:49.633110 | controller | included: /var/lib/zuul/builds/66cdaaf2d17047f2a99b500807e6302f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2025-10-19 12:10:49.639895 | 
2025-10-19 12:10:49.639952 | TASK [add-build-sshkey : Create Temp SSH key]
2025-10-19 12:10:50.214163 | controller -> localhost | Generating public/private rsa key pair.
2025-10-19 12:10:50.214566 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/66cdaaf2d17047f2a99b500807e6302f/work/66cdaaf2d17047f2a99b500807e6302f_id_rsa.
2025-10-19 12:10:50.214627 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/66cdaaf2d17047f2a99b500807e6302f/work/66cdaaf2d17047f2a99b500807e6302f_id_rsa.pub.
2025-10-19 12:10:50.214669 | controller -> localhost | The key fingerprint is:
2025-10-19 12:10:50.214749 | controller -> localhost | SHA256:N/h0lFyd2C0TJp3rcnR5EepP5tS0sM3RN4qycXoCnPQ zuul-build-sshkey
2025-10-19 12:10:50.214791 | controller -> localhost | The key's randomart image is:
2025-10-19 12:10:50.214829 | controller -> localhost | +---[RSA 2048]----+
2025-10-19 12:10:50.214866 | controller -> localhost | |            ..*=+|
2025-10-19 12:10:50.214906 | controller -> localhost | |           . **++|
2025-10-19 12:10:50.214944 | controller -> localhost | |       .    +o **|
2025-10-19 12:10:50.214981 | controller -> localhost | |      o o. .o OoO|
2025-10-19 12:10:50.215017 | controller -> localhost | |       +SE+o.* Oo|
2025-10-19 12:10:50.215068 | controller -> localhost | |        .+*o. O  |
2025-10-19 12:10:50.215120 | controller -> localhost | |         +.. o o |
2025-10-19 12:10:50.215161 | controller -> localhost | |          o      |
2025-10-19 12:10:50.215200 | controller -> localhost | |                 |
2025-10-19 12:10:50.215242 | controller -> localhost | +----[SHA256]-----+
2025-10-19 12:10:50.215331 | controller -> localhost | ok: Runtime: 0:00:00.153549
2025-10-19 12:10:50.228926 | 
2025-10-19 12:10:50.229056 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2025-10-19 12:10:50.267817 | controller | ok
2025-10-19 12:10:50.288587 | controller | included: /var/lib/zuul/builds/66cdaaf2d17047f2a99b500807e6302f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2025-10-19 12:10:50.301750 | 
2025-10-19 12:10:50.301830 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2025-10-19 12:10:50.326566 | controller | skipping: Conditional result was False
2025-10-19 12:10:50.336557 | 
2025-10-19 12:10:50.336638 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2025-10-19 12:10:51.322646 | controller | changed
2025-10-19 12:10:51.335368 | 
2025-10-19 12:10:51.335516 | TASK [add-build-sshkey : Make sure user has a .ssh]
2025-10-19 12:10:51.977543 | controller | ok
2025-10-19 12:10:51.989894 | 
2025-10-19 12:10:51.990029 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2025-10-19 12:10:54.954391 | controller | changed
2025-10-19 12:10:54.966639 | 
2025-10-19 12:10:54.966797 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2025-10-19 12:10:57.989545 | controller | changed
2025-10-19 12:10:58.001763 | 
2025-10-19 12:10:58.001891 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2025-10-19 12:10:58.028441 | controller | skipping: Conditional result was False
2025-10-19 12:10:58.041505 | 
2025-10-19 12:10:58.041637 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2025-10-19 12:10:58.466251 | controller -> localhost | changed
2025-10-19 12:10:58.477384 | 
2025-10-19 12:10:58.477450 | TASK [add-build-sshkey : Add back temp key]
2025-10-19 12:10:58.801746 | controller -> localhost | Identity added: /var/lib/zuul/builds/66cdaaf2d17047f2a99b500807e6302f/work/66cdaaf2d17047f2a99b500807e6302f_id_rsa (zuul-build-sshkey)
2025-10-19 12:10:58.802138 | controller -> localhost | ok: Runtime: 0:00:00.012282
2025-10-19 12:10:58.815012 | 
2025-10-19 12:10:58.815154 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2025-10-19 12:10:59.697864 | controller | ok
2025-10-19 12:10:59.709447 | 
2025-10-19 12:10:59.709579 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2025-10-19 12:10:59.746391 | controller | skipping: Conditional result was False
2025-10-19 12:10:59.771305 | 
2025-10-19 12:10:59.771435 | TASK [Run add-build-sshkey role (ECDSA)]
2025-10-19 12:10:59.808264 | controller | ok
2025-10-19 12:10:59.837003 | 
2025-10-19 12:10:59.837087 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2025-10-19 12:11:00.114888 | controller -> localhost | ok
2025-10-19 12:11:00.121044 | 
2025-10-19 12:11:00.121115 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2025-10-19 12:11:00.149669 | controller | ok
2025-10-19 12:11:00.160813 | controller | included: /var/lib/zuul/builds/66cdaaf2d17047f2a99b500807e6302f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2025-10-19 12:11:00.166850 | 
2025-10-19 12:11:00.166911 | TASK [add-build-sshkey : Create Temp SSH key]
2025-10-19 12:11:00.484452 | controller -> localhost | Generating public/private ecdsa key pair.
2025-10-19 12:11:00.484623 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/66cdaaf2d17047f2a99b500807e6302f/work/66cdaaf2d17047f2a99b500807e6302f_id_ecdsa.
2025-10-19 12:11:00.484650 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/66cdaaf2d17047f2a99b500807e6302f/work/66cdaaf2d17047f2a99b500807e6302f_id_ecdsa.pub.
2025-10-19 12:11:00.484693 | controller -> localhost | The key fingerprint is:
2025-10-19 12:11:00.484717 | controller -> localhost | SHA256:/NGS9zHFUzw5oC2btvnE74K4JWxZIBYJ9kpgXAotRsU zuul-build-sshkey
2025-10-19 12:11:00.484736 | controller -> localhost | The key's randomart image is:
2025-10-19 12:11:00.484753 | controller -> localhost | +---[ECDSA 521]---+
2025-10-19 12:11:00.484770 | controller -> localhost | |.o=+.+...    ...o|
2025-10-19 12:11:00.484787 | controller -> localhost | | ooE+ ...   o  =o|
2025-10-19 12:11:00.484803 | controller -> localhost | |. .. . + . o . .=|
2025-10-19 12:11:00.484820 | controller -> localhost | |    . o.. .o+  ..|
2025-10-19 12:11:00.484836 | controller -> localhost | |     .  S +=o o  |
2025-10-19 12:11:00.484852 | controller -> localhost | |        ..+++. o |
2025-10-19 12:11:00.484868 | controller -> localhost | |         =o+.o.  |
2025-10-19 12:11:00.484884 | controller -> localhost | |        ..o.o..  |
2025-10-19 12:11:00.484900 | controller -> localhost | |         ..  .oo |
2025-10-19 12:11:00.484916 | controller -> localhost | +----[SHA256]-----+
2025-10-19 12:11:00.484957 | controller -> localhost | ok: Runtime: 0:00:00.012869
2025-10-19 12:11:00.491218 | 
2025-10-19 12:11:00.491277 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2025-10-19 12:11:00.519501 | controller | ok
2025-10-19 12:11:00.526565 | controller | included: /var/lib/zuul/builds/66cdaaf2d17047f2a99b500807e6302f/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2025-10-19 12:11:00.535428 | 
2025-10-19 12:11:00.535490 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2025-10-19 12:11:00.558543 | controller | skipping: Conditional result was False
2025-10-19 12:11:00.564537 | 
2025-10-19 12:11:00.564600 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2025-10-19 12:11:01.436166 | controller | changed
2025-10-19 12:11:01.449105 | 
2025-10-19 12:11:01.449238 | TASK [add-build-sshkey : Make sure user has a .ssh]
2025-10-19 12:11:02.079347 | controller | ok
2025-10-19 12:11:02.091546 | 
2025-10-19 12:11:02.091834 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2025-10-19 12:11:05.085159 | controller | changed
2025-10-19 12:11:05.092627 | 
2025-10-19 12:11:05.092726 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2025-10-19 12:11:08.032352 | controller | changed
2025-10-19 12:11:08.045001 | 
2025-10-19 12:11:08.045174 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2025-10-19 12:11:08.072621 | controller | skipping: Conditional result was False
2025-10-19 12:11:08.086184 | 
2025-10-19 12:11:08.086322 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2025-10-19 12:11:08.357781 | controller -> localhost | changed
2025-10-19 12:11:08.381895 | 
2025-10-19 12:11:08.382045 | TASK [add-build-sshkey : Add back temp key]
2025-10-19 12:11:08.696503 | controller -> localhost | Identity added: /var/lib/zuul/builds/66cdaaf2d17047f2a99b500807e6302f/work/66cdaaf2d17047f2a99b500807e6302f_id_ecdsa (zuul-build-sshkey)
2025-10-19 12:11:08.696870 | controller -> localhost | ok: Runtime: 0:00:00.012264
2025-10-19 12:11:08.712703 | 
2025-10-19 12:11:08.712832 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2025-10-19 12:11:09.415446 | controller | ok
2025-10-19 12:11:09.427163 | 
2025-10-19 12:11:09.427290 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2025-10-19 12:11:09.464482 | controller | skipping: Conditional result was False
2025-10-19 12:11:09.488441 | 
2025-10-19 12:11:09.488585 | TASK [include_role : remove-zuul-sshkey]
2025-10-19 12:11:09.515653 | controller | skipping: Conditional result was False
2025-10-19 12:11:09.531126 | 
2025-10-19 12:11:09.531254 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2025-10-19 12:11:10.222642 | controller | ok: "logs"
2025-10-19 12:11:10.223296 | controller | ok: All items complete
2025-10-19 12:11:10.223367 | 
2025-10-19 12:11:10.882101 | controller | ok: "artifacts"
2025-10-19 12:11:11.494572 | controller | ok: "docs"
2025-10-19 12:11:11.517457 | 
2025-10-19 12:11:11.517729 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2025-10-19 12:11:12.170537 | controller | changed: "logs"
2025-10-19 12:11:12.787935 | controller | changed: "artifacts"
2025-10-19 12:11:13.391263 | controller | changed: "docs"
2025-10-19 12:11:13.453368 | 
2025-10-19 12:11:13.453504 | PLAY RECAP
2025-10-19 12:11:13.453561 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0
2025-10-19 12:11:13.453594 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-10-19 12:11:13.453618 | 
2025-10-19 12:11:13.563003 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2025-10-19 12:11:13.563671 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master]
2025-10-19 12:11:14.127099 | 
2025-10-19 12:11:14.127197 | PLAY [all]
2025-10-19 12:11:14.146743 | 
2025-10-19 12:11:14.146813 | TASK [Setup ensure-tox role]
2025-10-19 12:11:14.165087 | controller | ok
2025-10-19 12:11:14.186813 | 
2025-10-19 12:11:14.186882 | TASK [Install pip]
2025-10-19 12:11:14.205073 | controller | ok
2025-10-19 12:11:14.225379 | 
2025-10-19 12:11:14.225443 | TASK [ensure-pip : Check if pip is installed]
2025-10-19 12:11:15.101999 | controller | /usr/bin/pip3
2025-10-19 12:11:15.120510 | controller | /usr/bin/python3: No module named wheel
2025-10-19 12:11:15.584532 | controller | ok: Runtime: 0:00:00.030416
2025-10-19 12:11:15.598281 | 
2025-10-19 12:11:15.598443 | LOOP [ensure-pip : Install pip from packages]
2025-10-19 12:11:15.646549 | controller | ok: "/var/lib/zuul/builds/66cdaaf2d17047f2a99b500807e6302f/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml"
2025-10-19 12:11:15.664864 | controller | included: /var/lib/zuul/builds/66cdaaf2d17047f2a99b500807e6302f/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml
2025-10-19 12:11:15.685322 | 
2025-10-19 12:11:15.685460 | TASK [ensure-pip : Install Python 3 pip]
2025-10-19 12:11:24.681619 | controller | changed
2025-10-19 12:11:24.694876 | 
2025-10-19 12:11:24.695041 | TASK [ensure-pip : Check for EPEL repository]
2025-10-19 12:11:24.722902 | controller | skipping: Conditional result was False
2025-10-19 12:11:24.739649 | 
2025-10-19 12:11:24.739846 | TASK [ensure-pip : Fail with instructions when EPEL is not installed]
2025-10-19 12:11:24.767653 | controller | skipping: Conditional result was False
2025-10-19 12:11:24.781750 | 
2025-10-19 12:11:24.781899 | TASK [ensure-pip : Install Python 2 pip]
2025-10-19 12:11:24.808760 | controller | skipping: Conditional result was False
2025-10-19 12:11:24.823246 | 
2025-10-19 12:11:24.823394 | TASK [ensure-pip : Ensure setuptools]
2025-10-19 12:11:24.850170 | controller | skipping: Conditional result was False
2025-10-19 12:11:24.864913 | 
2025-10-19 12:11:24.865055 | TASK [ensure-pip : Check for ensurepip module]
2025-10-19 12:11:25.231231 | controller | skipping: Conditional result was False
2025-10-19 12:11:25.284911 | 
2025-10-19 12:11:25.285057 | TASK [ensure-pip : Ensure python3-venv]
2025-10-19 12:11:25.310188 | controller | skipping: Conditional result was False
2025-10-19 12:11:25.323870 | 
2025-10-19 12:11:25.324015 | TASK [ensure-pip : Install pip from source]
2025-10-19 12:11:25.351058 | controller | skipping: Conditional result was False
2025-10-19 12:11:25.364290 | 
2025-10-19 12:11:25.364427 | TASK [ensure-pip : Probe for venv python full path]
2025-10-19 12:11:26.146950 | controller | /usr/bin/python3
2025-10-19 12:11:26.731515 | controller | ok: Runtime: 0:00:00.005822
2025-10-19 12:11:26.746174 | 
2025-10-19 12:11:26.746313 | TASK [ensure-pip : Set host default]
2025-10-19 12:11:26.825972 | controller | ok
2025-10-19 12:11:26.838302 | 
2025-10-19 12:11:26.838492 | TASK [ensure-pip : Set ensure_pip_virtualenv_command]
2025-10-19 12:11:26.921635 | controller | ok
2025-10-19 12:11:26.945269 | 
2025-10-19 12:11:26.945398 | TASK [ensure-tox : Check if tox is installed]
2025-10-19 12:11:27.811214 | controller | /usr/bin/tox
2025-10-19 12:11:28.317129 | controller | ok: Runtime: 0:00:00.004938
2025-10-19 12:11:28.329037 | 
2025-10-19 12:11:28.329171 | TASK [ensure-tox : Export preinstalled tox_exectuable]
2025-10-19 12:11:28.378799 | controller | ok
2025-10-19 12:11:28.390052 | 
2025-10-19 12:11:28.390184 | TASK [ensure-tox : Create local venv]
2025-10-19 12:11:28.757372 | controller | skipping: Conditional result was False
2025-10-19 12:11:28.771223 | 
2025-10-19 12:11:28.771367 | TASK [ensure-tox : Install tox to local venv]
2025-10-19 12:11:29.167926 | controller | skipping: Conditional result was False
2025-10-19 12:11:29.181468 | 
2025-10-19 12:11:29.181627 | TASK [ensure-tox : Export installed tox_executable path]
2025-10-19 12:11:29.206754 | controller | skipping: Conditional result was False
2025-10-19 12:11:29.231707 | 
2025-10-19 12:11:29.231908 | TASK [ensure-tox : Output tox version]
2025-10-19 12:11:30.179075 | controller | 3.28.0 imported from /usr/lib/python3.11/site-packages/tox/__init__.py
2025-10-19 12:11:30.602432 | controller | ok: Runtime: 0:00:00.249318
2025-10-19 12:11:30.610650 | 
2025-10-19 12:11:30.610750 | TASK [ensure-tox : Make global symlink]
2025-10-19 12:11:30.635925 | controller | skipping: Conditional result was False
2025-10-19 12:11:30.650567 | 
2025-10-19 12:11:30.650648 | TASK [Setup tox role]
2025-10-19 12:11:30.672727 | controller | ok
2025-10-19 12:11:30.708247 | 
2025-10-19 12:11:30.708343 | TASK [tox : Check to see if the constraints file exists]
2025-10-19 12:11:30.742149 | controller | skipping: Conditional result was False
2025-10-19 12:11:30.748243 | 
2025-10-19 12:11:30.748307 | TASK [tox : Fail if constraints file is missing]
2025-10-19 12:11:30.782201 | controller | skipping: Conditional result was False
2025-10-19 12:11:30.788249 | 
2025-10-19 12:11:30.788311 | TASK [tox : Record file location]
2025-10-19 12:11:30.812061 | controller | skipping: Conditional result was False
2025-10-19 12:11:30.817924 | 
2025-10-19 12:11:30.817984 | TASK [tox : Install tox siblings]
2025-10-19 12:11:30.841608 | controller | skipping: Conditional result was False
2025-10-19 12:11:30.847825 | 
2025-10-19 12:11:30.847890 | TASK [tox : Emit tox command]
2025-10-19 12:11:30.886353 | /usr/bin/tox   -evenv  -vv --notest
2025-10-19 12:11:30.893119 | 
2025-10-19 12:11:30.893184 | TASK [tox : Run tox]
2025-10-19 12:11:31.831653 | controller | using tox.ini: /home/zuul/src/github.com/ansible-network/releases/tox.ini (pid 2493)
2025-10-19 12:11:31.841764 | controller | using tox-3.28.0 from /usr/lib/python3.11/site-packages/tox/__init__.py (pid 2493)
2025-10-19 12:11:31.880050 | controller | skipping sdist step
2025-10-19 12:11:31.880092 | controller | venv uses /usr/bin/python3
2025-10-19 12:11:31.880120 | controller | venv start: getenv /home/zuul/src/github.com/ansible-network/releases/.tox/venv
2025-10-19 12:11:31.880449 | controller | venv cannot reuse: no previous config /home/zuul/src/github.com/ansible-network/releases/.tox/venv/.tox-config1
2025-10-19 12:11:31.880465 | controller | venv create: /home/zuul/src/github.com/ansible-network/releases/.tox/venv
2025-10-19 12:11:31.880477 | 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-10-19 12:11:31.880490 | controller | [2501] /home/zuul/src/github.com/ansible-network/releases/.tox$ /usr/bin/python3 -m virtualenv --no-download --python /usr/bin/python3 venv
2025-10-19 12:11:32.678581 | controller | created virtual environment CPython3.11.0.final.0-64 in 668ms
2025-10-19 12:11:32.724408 | controller |   creator CPython3Posix(dest=/home/zuul/src/github.com/ansible-network/releases/.tox/venv, clear=False, no_vcs_ignore=False, global=False)
2025-10-19 12:11:32.724451 | 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-10-19 12:11:32.724477 | controller |     added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1
2025-10-19 12:11:32.724486 | controller |   activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator
2025-10-19 12:11:32.724501 | 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-10-19 12:11:32.724884 | 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-10-19 12:11:32.724909 | controller | [2509] /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-10-19 12:11:35.162302 | controller | Collecting ruamel.yaml
2025-10-19 12:11:35.218202 | controller |   Downloading ruamel.yaml-0.18.15-py3-none-any.whl (119 kB)
2025-10-19 12:11:35.251425 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 119.7/119.7 kB 3.8 MB/s eta 0:00:00
2025-10-19 12:11:35.317348 | controller | Collecting pbr
2025-10-19 12:11:35.321918 | controller |   Downloading pbr-7.0.1-py2.py3-none-any.whl (126 kB)
2025-10-19 12:11:35.334739 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 126.1/126.1 kB 12.3 MB/s eta 0:00:00
2025-10-19 12:11:35.385257 | controller | Collecting tweepy
2025-10-19 12:11:35.390691 | controller |   Downloading tweepy-4.16.0-py3-none-any.whl (98 kB)
2025-10-19 12:11:35.402127 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.8/98.8 kB 11.3 MB/s eta 0:00:00
2025-10-19 12:11:35.552228 | controller | Collecting galaxy-importer
2025-10-19 12:11:35.639697 | controller |   Downloading galaxy_importer-0.4.34-py3-none-any.whl (64 kB)
2025-10-19 12:11:35.648973 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 64.8/64.8 kB 9.5 MB/s eta 0:00:00
2025-10-19 12:11:35.742724 | controller | Collecting flake8
2025-10-19 12:11:35.747216 | controller |   Downloading flake8-7.3.0-py2.py3-none-any.whl (57 kB)
2025-10-19 12:11:35.758117 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 57.9/57.9 kB 6.1 MB/s eta 0:00:00
2025-10-19 12:11:35.909744 | controller | Collecting ruamel.yaml.clib>=0.2.7
2025-10-19 12:11:35.920565 | controller |   Downloading ruamel.yaml.clib-0.2.14-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (738 kB)
2025-10-19 12:11:35.944446 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 738.1/738.1 kB 38.8 MB/s eta 0:00:00
2025-10-19 12:11:35.951974 | 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)
2025-10-19 12:11:36.007952 | controller | Collecting oauthlib<4,>=3.2.0
2025-10-19 12:11:36.012668 | controller |   Downloading oauthlib-3.3.1-py3-none-any.whl (160 kB)
2025-10-19 12:11:36.021752 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 160.1/160.1 kB 27.4 MB/s eta 0:00:00
2025-10-19 12:11:36.104044 | controller | Collecting requests<3,>=2.27.0
2025-10-19 12:11:36.108999 | controller |   Downloading requests-2.32.5-py3-none-any.whl (64 kB)
2025-10-19 12:11:36.117693 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 64.7/64.7 kB 10.7 MB/s eta 0:00:00
2025-10-19 12:11:36.159885 | controller | Collecting requests-oauthlib<3,>=1.2.0
2025-10-19 12:11:36.164594 | controller |   Downloading requests_oauthlib-2.0.0-py2.py3-none-any.whl (24 kB)
2025-10-19 12:11:36.375216 | controller | Collecting ansible-core
2025-10-19 12:11:36.381771 | controller |   Downloading ansible_core-2.19.3-py3-none-any.whl (2.4 MB)
2025-10-19 12:11:36.428929 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.4/2.4 MB 57.5 MB/s eta 0:00:00
2025-10-19 12:11:36.489964 | controller | Collecting ansible-builder<4.0,>=1.2.0
2025-10-19 12:11:36.498317 | controller |   Downloading ansible_builder-3.1.0-py3-none-any.whl (46 kB)
2025-10-19 12:11:36.515545 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 46.3/46.3 kB 3.0 MB/s eta 0:00:00
2025-10-19 12:11:36.678493 | controller | Collecting ansible-lint<=25.8.2,>=6.2.2
2025-10-19 12:11:36.684767 | controller |   Downloading ansible_lint-25.8.2-py3-none-any.whl (328 kB)
2025-10-19 12:11:36.704016 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 328.7/328.7 kB 26.6 MB/s eta 0:00:00
2025-10-19 12:11:36.763126 | controller | Collecting attrs<23,>=21.4.0
2025-10-19 12:11:36.768936 | controller |   Downloading attrs-22.2.0-py3-none-any.whl (60 kB)
2025-10-19 12:11:36.778211 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 60.0/60.0 kB 8.8 MB/s eta 0:00:00
2025-10-19 12:11:36.917751 | controller | Collecting nh3<3,>=0.2.18
2025-10-19 12:11:36.922785 | controller |   Downloading nh3-0.3.1-cp38-abi3-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (796 kB)
2025-10-19 12:11:36.941553 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 796.9/796.9 kB 55.9 MB/s eta 0:00:00
2025-10-19 12:11:36.967151 | controller | Collecting flake8
2025-10-19 12:11:36.972877 | controller |   Downloading flake8-6.1.0-py2.py3-none-any.whl (58 kB)
2025-10-19 12:11:36.985412 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 58.3/58.3 kB 6.1 MB/s eta 0:00:00
2025-10-19 12:11:37.045998 | controller | Collecting markdown<4,>=3.3.4
2025-10-19 12:11:37.053816 | controller |   Downloading markdown-3.9-py3-none-any.whl (107 kB)
2025-10-19 12:11:37.066699 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 107.4/107.4 kB 10.9 MB/s eta 0:00:00
2025-10-19 12:11:37.349771 | controller | Collecting pyyaml<7,>=5.4.1
2025-10-19 12:11:37.358529 | controller |   Downloading pyyaml-6.0.3-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (806 kB)
2025-10-19 12:11:37.377036 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 806.6/806.6 kB 56.1 MB/s eta 0:00:00
2025-10-19 12:11:37.441235 | controller | Collecting semantic-version<3,>=2.9.0
2025-10-19 12:11:37.445036 | controller |   Downloading semantic_version-2.10.0-py2.py3-none-any.whl (15 kB)
2025-10-19 12:11:37.518192 | controller | Collecting packaging<25.0,>=23.2
2025-10-19 12:11:37.523724 | controller |   Downloading packaging-24.2-py3-none-any.whl (65 kB)
2025-10-19 12:11:37.533942 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 65.5/65.5 kB 8.2 MB/s eta 0:00:00
2025-10-19 12:11:37.577616 | controller | Collecting mccabe<0.8.0,>=0.7.0
2025-10-19 12:11:37.582771 | controller |   Downloading mccabe-0.7.0-py2.py3-none-any.whl (7.3 kB)
2025-10-19 12:11:37.632224 | controller | Collecting pycodestyle<2.12.0,>=2.11.0
2025-10-19 12:11:37.637373 | controller |   Downloading pycodestyle-2.11.1-py2.py3-none-any.whl (31 kB)
2025-10-19 12:11:37.687988 | controller | Collecting pyflakes<3.2.0,>=3.1.0
2025-10-19 12:11:37.694726 | controller |   Downloading pyflakes-3.1.0-py2.py3-none-any.whl (62 kB)
2025-10-19 12:11:37.709480 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 62.6/62.6 kB 5.8 MB/s eta 0:00:00
2025-10-19 12:11:37.836781 | controller | Collecting bindep
2025-10-19 12:11:37.842473 | controller |   Downloading bindep-2.13.0-py3-none-any.whl (34 kB)
2025-10-19 12:11:37.930447 | controller | Collecting jsonschema
2025-10-19 12:11:37.935841 | controller |   Downloading jsonschema-4.25.1-py3-none-any.whl (90 kB)
2025-10-19 12:11:37.946552 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 90.0/90.0 kB 11.3 MB/s eta 0:00:00
2025-10-19 12:11:38.121172 | controller | Collecting ansible-compat>=25.8.0
2025-10-19 12:11:38.127494 | controller |   Downloading ansible_compat-25.8.2-py3-none-any.whl (27 kB)
2025-10-19 12:11:38.334714 | controller | Collecting black>=24.3.0
2025-10-19 12:11:38.342045 | controller |   Downloading black-25.9.0-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.manylinux_2_28_x86_64.whl (1.6 MB)
2025-10-19 12:11:38.369665 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.6/1.6 MB 69.8 MB/s eta 0:00:00
2025-10-19 12:11:38.441674 | controller | Collecting filelock>=3.8.2
2025-10-19 12:11:38.448948 | controller |   Downloading filelock-3.20.0-py3-none-any.whl (16 kB)
2025-10-19 12:11:38.580882 | controller | Collecting importlib-metadata
2025-10-19 12:11:38.586431 | controller |   Downloading importlib_metadata-8.7.0-py3-none-any.whl (27 kB)
2025-10-19 12:11:38.656974 | controller | Collecting pathspec>=0.10.3
2025-10-19 12:11:38.661569 | controller |   Downloading pathspec-0.12.1-py3-none-any.whl (31 kB)
2025-10-19 12:11:38.789723 | controller | Collecting referencing>=0.36.2
2025-10-19 12:11:38.795183 | controller |   Downloading referencing-0.37.0-py3-none-any.whl (26 kB)
2025-10-19 12:11:38.839649 | controller | Collecting subprocess-tee>=0.4.1
2025-10-19 12:11:38.846959 | controller |   Downloading subprocess_tee-0.4.2-py3-none-any.whl (5.2 kB)
2025-10-19 12:11:38.914374 | controller | Collecting yamllint>=1.34.0
2025-10-19 12:11:38.919260 | controller |   Downloading yamllint-1.37.1-py3-none-any.whl (68 kB)
2025-10-19 12:11:38.933247 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 68.8/68.8 kB 6.1 MB/s eta 0:00:00
2025-10-19 12:11:39.012755 | controller | Collecting wcmatch>=8.1.2
2025-10-19 12:11:39.020720 | controller |   Downloading wcmatch-10.1-py3-none-any.whl (39 kB)
2025-10-19 12:11:39.094532 | controller | Collecting jinja2>=3.1.0
2025-10-19 12:11:39.100314 | controller |   Downloading jinja2-3.1.6-py3-none-any.whl (134 kB)
2025-10-19 12:11:39.112712 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 134.9/134.9 kB 14.6 MB/s eta 0:00:00
2025-10-19 12:11:40.113582 | controller | Collecting cryptography
2025-10-19 12:11:40.119609 | controller |   Downloading cryptography-46.0.3-cp311-abi3-manylinux_2_34_x86_64.whl (4.5 MB)
2025-10-19 12:11:40.182706 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.5/4.5 MB 76.1 MB/s eta 0:00:00
2025-10-19 12:11:40.232960 | controller | Collecting resolvelib<2.0.0,>=0.5.3
2025-10-19 12:11:40.238171 | controller |   Downloading resolvelib-1.2.1-py3-none-any.whl (18 kB)
2025-10-19 12:11:40.710433 | controller | Collecting charset_normalizer<4,>=2
2025-10-19 12:11:40.716006 | controller |   Downloading charset_normalizer-3.4.4-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (151 kB)
2025-10-19 12:11:40.730261 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 151.6/151.6 kB 14.2 MB/s eta 0:00:00
2025-10-19 12:11:40.779696 | controller | Collecting idna<4,>=2.5
2025-10-19 12:11:40.785548 | controller |   Downloading idna-3.11-py3-none-any.whl (71 kB)
2025-10-19 12:11:40.795730 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 71.0/71.0 kB 9.4 MB/s eta 0:00:00
2025-10-19 12:11:40.899991 | controller | Collecting urllib3<3,>=1.21.1
2025-10-19 12:11:40.905307 | controller |   Downloading urllib3-2.5.0-py3-none-any.whl (129 kB)
2025-10-19 12:11:40.916534 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 129.8/129.8 kB 17.1 MB/s eta 0:00:00
2025-10-19 12:11:40.980091 | controller | Collecting certifi>=2017.4.17
2025-10-19 12:11:40.985327 | controller |   Downloading certifi-2025.10.5-py3-none-any.whl (163 kB)
2025-10-19 12:11:40.997067 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 163.3/163.3 kB 20.1 MB/s eta 0:00:00
2025-10-19 12:11:41.123721 | controller | Collecting ansible-compat>=25.8.0
2025-10-19 12:11:41.130713 | controller |   Downloading ansible_compat-25.8.1-py3-none-any.whl (27 kB)
2025-10-19 12:11:41.239585 | controller | Collecting click>=8.0.0
2025-10-19 12:11:41.244628 | controller |   Downloading click-8.3.0-py3-none-any.whl (107 kB)
2025-10-19 12:11:41.257033 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 107.3/107.3 kB 13.6 MB/s eta 0:00:00
2025-10-19 12:11:41.287371 | controller | Collecting mypy-extensions>=0.4.3
2025-10-19 12:11:41.292370 | controller |   Downloading mypy_extensions-1.1.0-py3-none-any.whl (5.0 kB)
2025-10-19 12:11:41.366084 | controller | Collecting platformdirs>=2
2025-10-19 12:11:41.371054 | controller |   Downloading platformdirs-4.5.0-py3-none-any.whl (18 kB)
2025-10-19 12:11:41.410804 | controller | Collecting pytokens>=0.1.10
2025-10-19 12:11:41.417836 | controller |   Downloading pytokens-0.2.0-py3-none-any.whl (12 kB)
2025-10-19 12:11:41.686617 | controller | Collecting MarkupSafe>=2.0
2025-10-19 12:11:41.715128 | controller |   Downloading markupsafe-3.0.3-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (22 kB)
2025-10-19 12:11:41.802446 | controller | Collecting jsonschema-specifications>=2023.03.6
2025-10-19 12:11:41.808010 | controller |   Downloading jsonschema_specifications-2025.9.1-py3-none-any.whl (18 kB)
2025-10-19 12:11:43.229444 | controller | Collecting rpds-py>=0.7.1
2025-10-19 12:11:43.236704 | controller |   Downloading rpds_py-0.27.1-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (384 kB)
2025-10-19 12:11:43.256908 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 384.1/384.1 kB 23.7 MB/s eta 0:00:00
2025-10-19 12:11:43.350909 | controller | Collecting typing-extensions>=4.4.0
2025-10-19 12:11:43.356391 | controller |   Downloading typing_extensions-4.15.0-py3-none-any.whl (44 kB)
2025-10-19 12:11:43.371474 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 44.6/44.6 kB 4.3 MB/s eta 0:00:00
2025-10-19 12:11:43.485241 | controller | Collecting bracex>=2.1.1
2025-10-19 12:11:43.491011 | controller |   Downloading bracex-2.6-py3-none-any.whl (11 kB)
2025-10-19 12:11:43.579692 | controller | Collecting distro>=1.7
2025-10-19 12:11:43.585065 | controller |   Downloading distro-1.9.0-py3-none-any.whl (20 kB)
2025-10-19 12:11:43.707978 | controller | Collecting Parsley
2025-10-19 12:11:43.715443 | controller |   Downloading Parsley-1.3-py2.py3-none-any.whl (88 kB)
2025-10-19 12:11:43.725303 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 88.9/88.9 kB 12.9 MB/s eta 0:00:00
2025-10-19 12:11:44.248750 | controller | Collecting cffi>=2.0.0
2025-10-19 12:11:44.254205 | controller |   Downloading cffi-2.0.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl (215 kB)
2025-10-19 12:11:44.267730 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 215.6/215.6 kB 23.2 MB/s eta 0:00:00
2025-10-19 12:11:44.517147 | controller | Collecting zipp>=3.20
2025-10-19 12:11:44.522892 | controller |   Downloading zipp-3.23.0-py3-none-any.whl (10 kB)
2025-10-19 12:11:44.580897 | controller | Collecting pycparser
2025-10-19 12:11:44.585757 | controller |   Downloading pycparser-2.23-py3-none-any.whl (118 kB)
2025-10-19 12:11:44.595596 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 118.1/118.1 kB 18.0 MB/s eta 0:00:00
2025-10-19 12:11:45.443809 | controller | Installing collected packages: Parsley, zipp, urllib3, typing-extensions, subprocess-tee, semantic-version, ruamel.yaml.clib, rpds-py, resolvelib, pyyaml, pytokens, pyflakes, pycparser, pycodestyle, platformdirs, pbr, pathspec, packaging, oauthlib, nh3, mypy-extensions, mccabe, MarkupSafe, markdown, idna, filelock, distro, click, charset_normalizer, certifi, bracex, attrs, yamllint, wcmatch, ruamel.yaml, requests, referencing, jinja2, importlib-metadata, flake8, cffi, black, bindep, requests-oauthlib, jsonschema-specifications, cryptography, tweepy, jsonschema, ansible-core, ansible-compat, ansible-builder, ansible-lint, galaxy-importer
2025-10-19 12:11:53.053892 | controller | Successfully installed MarkupSafe-3.0.3 Parsley-1.3 ansible-builder-3.1.0 ansible-compat-25.8.1 ansible-core-2.19.3 ansible-lint-25.8.2 attrs-22.2.0 bindep-2.13.0 black-25.9.0 bracex-2.6 certifi-2025.10.5 cffi-2.0.0 charset_normalizer-3.4.4 click-8.3.0 cryptography-46.0.3 distro-1.9.0 filelock-3.20.0 flake8-6.1.0 galaxy-importer-0.4.34 idna-3.11 importlib-metadata-8.7.0 jinja2-3.1.6 jsonschema-4.25.1 jsonschema-specifications-2025.9.1 markdown-3.9 mccabe-0.7.0 mypy-extensions-1.1.0 nh3-0.3.1 oauthlib-3.3.1 packaging-24.2 pathspec-0.12.1 pbr-7.0.1 platformdirs-4.5.0 pycodestyle-2.11.1 pycparser-2.23 pyflakes-3.1.0 pytokens-0.2.0 pyyaml-6.0.3 referencing-0.37.0 requests-2.32.5 requests-oauthlib-2.0.0 resolvelib-1.2.1 rpds-py-0.27.1 ruamel.yaml-0.18.15 ruamel.yaml.clib-0.2.14 semantic-version-2.10.0 subprocess-tee-0.4.2 tweepy-4.16.0 typing-extensions-4.15.0 urllib3-2.5.0 wcmatch-10.1 yamllint-1.37.1 zipp-3.23.0
2025-10-19 12:11:53.257289 | controller |
2025-10-19 12:11:54.535772 | controller | [notice] A new release of pip available: 22.2.2 -> 25.2
2025-10-19 12:11:54.535821 | controller | [notice] To update, run: pip install --upgrade pip
2025-10-19 12:11:54.535837 | controller | venv finish: getenv /home/zuul/src/github.com/ansible-network/releases/.tox/venv after 22.66 seconds
2025-10-19 12:11:54.536041 | controller | venv start: developpkg /home/zuul/src/github.com/ansible-network/releases
2025-10-19 12:11:54.536061 | controller | venv develop-inst: /home/zuul/src/github.com/ansible-network/releases
2025-10-19 12:11:54.541654 | controller | write config to /home/zuul/src/github.com/ansible-network/releases/.tox/venv/.tox-config1 as '9a414b33f86621a975414472b7b34d2b36210a3017dd988b50f2da89f7d8fd1c /usr/bin/python3\n3.28.0 0 1 0\n00000000000000000000000000000000 -r/home/zuul/src/github.com/ansible-network/releases/requirements.txt\n00000000000000000000000000000000 -r/home/zuul/src/github.com/ansible-network/releases/test-requirements.txt'
2025-10-19 12:11:54.541886 | 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-10-19 12:11:54.542638 | controller | [2546] /home/zuul/src/github.com/ansible-network/releases$ /home/zuul/src/github.com/ansible-network/releases/.tox/venv/bin/pip install --exists-action w -e .
2025-10-19 12:11:55.171391 | controller | Obtaining file:///home/zuul/src/github.com/ansible-network/releases
2025-10-19 12:11:55.172627 | controller |   Preparing metadata (setup.py): started
2025-10-19 12:11:57.990495 | controller |   Preparing metadata (setup.py): finished with status 'done'
2025-10-19 12:11:58.024909 | controller | Requirement already satisfied: ruamel.yaml in ./.tox/venv/lib/python3.11/site-packages (from ansible-releases==0.0.1.dev36) (0.18.15)
2025-10-19 12:11:58.025950 | controller | Requirement already satisfied: pbr in ./.tox/venv/lib/python3.11/site-packages (from ansible-releases==0.0.1.dev36) (7.0.1)
2025-10-19 12:11:58.027043 | controller | Requirement already satisfied: tweepy in ./.tox/venv/lib/python3.11/site-packages (from ansible-releases==0.0.1.dev36) (4.16.0)
2025-10-19 12:11:58.029630 | controller | Requirement already satisfied: setuptools in ./.tox/venv/lib/python3.11/site-packages (from pbr->ansible-releases==0.0.1.dev36) (62.6.0)
2025-10-19 12:11:58.044097 | controller | Requirement already satisfied: ruamel.yaml.clib>=0.2.7 in ./.tox/venv/lib64/python3.11/site-packages (from ruamel.yaml->ansible-releases==0.0.1.dev36) (0.2.14)
2025-10-19 12:11:58.061945 | controller | Requirement already satisfied: oauthlib<4,>=3.2.0 in ./.tox/venv/lib/python3.11/site-packages (from tweepy->ansible-releases==0.0.1.dev36) (3.3.1)
2025-10-19 12:11:58.063778 | controller | Requirement already satisfied: requests<3,>=2.27.0 in ./.tox/venv/lib/python3.11/site-packages (from tweepy->ansible-releases==0.0.1.dev36) (2.32.5)
2025-10-19 12:11:58.065841 | controller | Requirement already satisfied: requests-oauthlib<3,>=1.2.0 in ./.tox/venv/lib/python3.11/site-packages (from tweepy->ansible-releases==0.0.1.dev36) (2.0.0)
2025-10-19 12:11:58.087424 | controller | Requirement already satisfied: charset_normalizer<4,>=2 in ./.tox/venv/lib64/python3.11/site-packages (from requests<3,>=2.27.0->tweepy->ansible-releases==0.0.1.dev36) (3.4.4)
2025-10-19 12:11:58.089314 | controller | Requirement already satisfied: idna<4,>=2.5 in ./.tox/venv/lib/python3.11/site-packages (from requests<3,>=2.27.0->tweepy->ansible-releases==0.0.1.dev36) (3.11)
2025-10-19 12:11:58.090936 | controller | Requirement already satisfied: urllib3<3,>=1.21.1 in ./.tox/venv/lib/python3.11/site-packages (from requests<3,>=2.27.0->tweepy->ansible-releases==0.0.1.dev36) (2.5.0)
2025-10-19 12:11:58.092326 | controller | Requirement already satisfied: certifi>=2017.4.17 in ./.tox/venv/lib/python3.11/site-packages (from requests<3,>=2.27.0->tweepy->ansible-releases==0.0.1.dev36) (2025.10.5)
2025-10-19 12:11:58.742079 | controller | Installing collected packages: ansible-releases
2025-10-19 12:11:58.742762 | controller |   Running setup.py develop for ansible-releases
2025-10-19 12:12:01.472217 | controller | Successfully installed ansible-releases-0.0.1.dev36
2025-10-19 12:12:01.514859 | controller |
2025-10-19 12:12:01.825594 | controller | [notice] A new release of pip available: 22.2.2 -> 25.2
2025-10-19 12:12:01.825647 | controller | [notice] To update, run: pip install --upgrade pip
2025-10-19 12:12:01.825662 | controller | venv finish: developpkg /home/zuul/src/github.com/ansible-network/releases after 7.29 seconds
2025-10-19 12:12:01.825818 | controller | venv start: envreport
2025-10-19 12:12:01.826044 | 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-10-19 12:12:01.827844 | controller | [2575] /home/zuul/src/github.com/ansible-network/releases$ /home/zuul/src/github.com/ansible-network/releases/.tox/venv/bin/python -m pip freeze >.tox/venv/log/venv-0.log
2025-10-19 12:12:02.756796 | controller | venv finish: envreport  after 0.93 seconds
2025-10-19 12:12:02.756971 | controller | venv installed: ansible-builder==3.1.0,ansible-compat==25.8.1,ansible-core==2.19.3,ansible-lint==25.8.2,-e git+file:///dev/null@646b310655c531e4904be07f4ff8fc3a29addd09#egg=ansible_releases,attrs==22.2.0,bindep==2.13.0,black==25.9.0,bracex==2.6,certifi==2025.10.5,cffi==2.0.0,charset-normalizer==3.4.4,click==8.3.0,cryptography==46.0.3,distro==1.9.0,filelock==3.20.0,flake8==6.1.0,galaxy_importer==0.4.34,idna==3.11,importlib_metadata==8.7.0,Jinja2==3.1.6,jsonschema==4.25.1,jsonschema-specifications==2025.9.1,Markdown==3.9,MarkupSafe==3.0.3,mccabe==0.7.0,mypy_extensions==1.1.0,nh3==0.3.1,oauthlib==3.3.1,packaging==24.2,Parsley==1.3,pathspec==0.12.1,pbr==7.0.1,platformdirs==4.5.0,pycodestyle==2.11.1,pycparser==2.23,pyflakes==3.1.0,pytokens==0.2.0,PyYAML==6.0.3,referencing==0.37.0,requests==2.32.5,requests-oauthlib==2.0.0,resolvelib==1.2.1,rpds-py==0.27.1,ruamel.yaml==0.18.15,ruamel.yaml.clib==0.2.14,semantic-version==2.10.0,subprocess-tee==0.4.2,tweepy==4.16.0,typing_extensions==4.15.0,urllib3==2.5.0,wcmatch==10.1,yamllint==1.37.1,zipp==3.23.0
2025-10-19 12:12:02.756996 | controller | ___________________________________ summary ____________________________________
2025-10-19 12:12:02.757005 | controller |   venv: skipped tests
2025-10-19 12:12:02.757014 | controller |   congratulations :)
2025-10-19 12:12:03.334215 | controller | ok: Runtime: 0:00:31.214276
2025-10-19 12:12:03.350276 | 
2025-10-19 12:12:03.350405 | TASK [tox : Look for output]
2025-10-19 12:12:04.378146 | controller | ok
2025-10-19 12:12:04.390409 | 
2025-10-19 12:12:04.390705 | TASK [tox : Return file comments to Zuul]
2025-10-19 12:12:04.450472 | controller | skipping: Conditional result was False
2025-10-19 12:12:04.475013 | 
2025-10-19 12:12:04.475194 | TASK [Setup download-artifact-fork role]
2025-10-19 12:12:04.504634 | controller | ok
2025-10-19 12:12:04.536224 | 
2025-10-19 12:12:04.536311 | TASK [download-artifact-fork : Parse inventory response]
2025-10-19 12:12:04.593107 | controller | ok
2025-10-19 12:12:04.605849 | 
2025-10-19 12:12:04.605991 | TASK [download-artifact-fork : Fetch info from Zuul API]
2025-10-19 12:12:04.643090 | controller | skipping: Conditional result was False
2025-10-19 12:12:04.651782 | 
2025-10-19 12:12:04.651870 | TASK [download-artifact-fork : Parse build response]
2025-10-19 12:12:04.688215 | controller | skipping: Conditional result was False
2025-10-19 12:12:04.702570 | 
2025-10-19 12:12:04.702745 | TASK [download-artifact-fork : Ensure artifacts directory exists]
2025-10-19 12:12:05.570479 | controller | changed
2025-10-19 12:12:05.582770 | 
2025-10-19 12:12:05.582907 | LOOP [download-artifact-fork : Download archive by type]
2025-10-19 12:12:05.650415 | controller | skipping: Conditional result was False
2025-10-19 12:12:05.650933 | controller | ok: All items complete
2025-10-19 12:12:05.650993 | 
2025-10-19 12:12:08.659030 | controller | changed: OK (671904 bytes)
2025-10-19 12:12:08.692045 | 
2025-10-19 12:12:08.692246 | TASK [deploy-artifacts : define __collections]
2025-10-19 12:12:08.731418 | controller | ok
2025-10-19 12:12:08.744009 | 
2025-10-19 12:12:08.744146 | LOOP [deploy-artifacts : Create list of collections]
2025-10-19 12:12:08.780133 | controller | skipping: Conditional result was False
2025-10-19 12:12:08.833892 | controller | ok:
2025-10-19 12:12:08.834055 | controller | {
2025-10-19 12:12:08.834119 | controller |   "branch": "main",
2025-10-19 12:12:08.834170 | controller |   "change": "2503",
2025-10-19 12:12:08.834230 | controller |   "job": "build-ansible-collection",
2025-10-19 12:12:08.834275 | controller |   "metadata": {
2025-10-19 12:12:08.834322 | controller |     "type": "ansible_collection",
2025-10-19 12:12:08.834367 | controller |     "version": "6.1.0"
2025-10-19 12:12:08.834409 | controller |   },
2025-10-19 12:12:08.834450 | controller |   "name": "community.vmware",
2025-10-19 12:12:08.834765 | controller |   "patchset": "a8109ff7e07667d5c83462b3d0db49b4dcb23e17",
2025-10-19 12:12:08.834859 | controller |   "project": "ansible-collections/community.vmware",
2025-10-19 12:12:08.834918 | controller |   "url": "https://b6f5a760d1f0d76dad2d-8c72cc448e0e6bc348b468deac1eb71c.ssl.cf1.rackcdn.com/ansible/b87f5cb8b0114bf3b293fdb8cc1ba9bd/artifacts/community-vmware-6.1.0.tar.gz"
2025-10-19 12:12:08.834972 | controller | }
2025-10-19 12:12:08.858999 | 
2025-10-19 12:12:08.859205 | TASK [deploy-artifacts : Install require-project collection using ansible-galaxy]
2025-10-19 12:12:12.004288 | controller | [ERROR]: Failed to resolve the requested dependencies map. Could not satisfy the following requirements:
2025-10-19 12:12:12.004377 | controller | * vmware.vmware:>=2.5.0 (dependency of community.vmware:6.1.0)
2025-10-19 12:12:12.004393 | controller | Hint: Pre-releases hosted on Galaxy or Automation Hub are not installed by default unless a specific version is requested. To enable pre-releases globally, use --pre: [RequirementInformation(requirement=<vmware.vmware:>=2.5.0 of type 'galaxy' from Galaxy>, parent=<community.vmware:6.1.0 of type 'file' from community-vmware-6.1.0.tar.gz>)]
2025-10-19 12:12:12.004402 | controller |
2025-10-19 12:12:12.004426 | controller | Starting galaxy collection install process
2025-10-19 12:12:12.313809 | controller | Process install dependency map
2025-10-19 12:12:12.313901 | controller | ansible-galaxy is looking at multiple versions of community.vmware to determine which version is compatible with other requirements. This could take a while.
2025-10-19 12:12:12.737363 | controller | ERROR
2025-10-19 12:12:12.737728 | controller | {
2025-10-19 12:12:12.737800 | controller |   "delta": "0:00:02.648290",
2025-10-19 12:12:12.737841 | controller |   "end": "2025-10-19 12:12:12.314727",
2025-10-19 12:12:12.737879 | controller |   "msg": "non-zero return code",
2025-10-19 12:12:12.737914 | controller |   "rc": 1,
2025-10-19 12:12:12.737948 | controller |   "start": "2025-10-19 12:12:09.666437"
2025-10-19 12:12:12.737981 | controller | }
failure
2025-10-19 12:12:12.741484 | 
2025-10-19 12:12:12.741594 | PLAY RECAP
2025-10-19 12:12:12.741719 | controller | ok: 17 changed: 8 unreachable: 0 failed: 1 skipped: 18 rescued: 0 ignored: 0
2025-10-19 12:12:12.741778 | 
2025-10-19 12:12:12.864148 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master]
2025-10-19 12:12:12.867016 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master]
2025-10-19 12:12:13.456603 | 
2025-10-19 12:12:13.456740 | PLAY [all:!appliance*]
2025-10-19 12:12:13.478935 | 
2025-10-19 12:12:13.479010 | TASK [unregister the node]
2025-10-19 12:12:13.830044 | controller | skipping: Conditional result was False
2025-10-19 12:12:13.842247 | 
2025-10-19 12:12:13.842406 | TASK [include_role : fetch-output]
2025-10-19 12:12:13.893200 | controller | ok
2025-10-19 12:12:13.931993 | 
2025-10-19 12:12:13.932120 | TASK [fetch-output : Set log path for multiple nodes]
2025-10-19 12:12:14.008310 | controller | skipping: Conditional result was False
2025-10-19 12:12:14.022394 | 
2025-10-19 12:12:14.022555 | TASK [fetch-output : Set log path for single node]
2025-10-19 12:12:14.083108 | controller | ok
2025-10-19 12:12:14.095046 | 
2025-10-19 12:12:14.095183 | LOOP [fetch-output : Ensure local output dirs]
2025-10-19 12:12:14.580450 | controller -> localhost | ok: "/var/lib/zuul/builds/66cdaaf2d17047f2a99b500807e6302f/work/logs"
2025-10-19 12:12:14.836439 | controller -> localhost | changed: "/var/lib/zuul/builds/66cdaaf2d17047f2a99b500807e6302f/work/artifacts"
2025-10-19 12:12:15.064104 | controller -> localhost | changed: "/var/lib/zuul/builds/66cdaaf2d17047f2a99b500807e6302f/work/docs"
2025-10-19 12:12:15.080138 | 
2025-10-19 12:12:15.080212 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-10-19 12:12:17.265865 | controller | changed: .d..t...... ./
2025-10-19 12:12:17.266183 | controller | changed: All items complete
2025-10-19 12:12:17.266250 | 
2025-10-19 12:12:19.256062 | controller | changed: .d..t...... ./
2025-10-19 12:12:21.272156 | controller | changed: .d..t...... ./
2025-10-19 12:12:21.304947 | 
2025-10-19 12:12:21.305146 | TASK [include_role : fetch-output-openshift]
2025-10-19 12:12:21.334252 | controller | skipping: Conditional result was False
2025-10-19 12:12:21.349782 | 
2025-10-19 12:12:21.349931 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2025-10-19 12:12:21.810790 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.012173
2025-10-19 12:12:22.087412 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.014010
2025-10-19 12:12:22.120971 | 
2025-10-19 12:12:22.121037 | PLAY [localhost]
2025-10-19 12:12:22.133191 | 
2025-10-19 12:12:22.133266 | TASK [Run Zuul manifest role]
2025-10-19 12:12:22.153466 | localhost | ok
2025-10-19 12:12:22.166074 | 
2025-10-19 12:12:22.166134 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2025-10-19 12:12:22.576276 | localhost | changed
2025-10-19 12:12:22.586034 | 
2025-10-19 12:12:22.586165 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2025-10-19 12:12:22.632227 | localhost | ok
2025-10-19 12:12:22.683662 | 
2025-10-19 12:12:22.683850 | TASK [Set zuul-log-path fact]
2025-10-19 12:12:22.717674 | localhost | ok
2025-10-19 12:12:22.742172 | 
2025-10-19 12:12:22.742259 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-10-19 12:12:22.788551 | localhost | ok
2025-10-19 12:12:22.807512 | 
2025-10-19 12:12:22.807595 | LOOP [Run upload-logs-swift role]
2025-10-19 12:12:22.855588 | localhost | Output suppressed because no_log was given
2025-10-19 12:12:22.902717 | 
2025-10-19 12:12:22.902798 | TASK [Set zuul-log-path fact]
2025-10-19 12:12:22.939411 | localhost | skipping: Conditional result was False
2025-10-19 12:12:22.950293 | 
2025-10-19 12:12:22.950432 | TASK [upload-logs-swift : Ensure logs are readable before uploading]
2025-10-19 12:12:23.324491 | localhost -> localhost | ok: Runtime: 0:00:00.008775
2025-10-19 12:12:23.339440 | 
2025-10-19 12:12:23.339541 | TASK [upload-logs-swift : Upload logs to swift]