2025-10-19 12:13:00.414763 | Job console starting...
2025-10-19 12:13:00.422884 | Updating repositories
2025-10-19 12:13:00.475108 | Preparing job workspace
2025-10-19 12:13:04.261125 | Running Ansible setup...
2025-10-19 12:13:10.501474 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2025-10-19 12:13:11.078913 | 
2025-10-19 12:13:11.079038 | PLAY [localhost]
2025-10-19 12:13:11.087212 | 
2025-10-19 12:13:11.087278 | TASK [Gathering Facts]
2025-10-19 12:13:12.063101 | localhost | ok
2025-10-19 12:13:12.094295 | 
2025-10-19 12:13:12.094457 | TASK [Setup log path fact]
2025-10-19 12:13:12.119613 | localhost | ok
2025-10-19 12:13:12.148350 | 
2025-10-19 12:13:12.148436 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-10-19 12:13:12.177124 | localhost | ok
2025-10-19 12:13:12.187497 | 
2025-10-19 12:13:12.187583 | TASK [emit-job-header : Print job information]
2025-10-19 12:13:12.226762 | # Job Information
2025-10-19 12:13:12.226943 | Ansible Version: 2.15.12
2025-10-19 12:13:12.226985 | Job: ansible-galaxy-importer
2025-10-19 12:13:12.227013 | Pipeline: third-party-check
2025-10-19 12:13:12.227038 | Executor: ze04.softwarefactory-project.io
2025-10-19 12:13:12.227064 | Triggered by: https://github.com/ansible-collections/community.vmware/pull/2503
2025-10-19 12:13:12.227093 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/192/ansible/19205daf00634a998eb1c2e5b17efb6e/
2025-10-19 12:13:12.227119 | Event ID: 2ac850d0-ace3-11f0-9f68-080fc459cd8b
2025-10-19 12:13:12.231981 | 
2025-10-19 12:13:12.232062 | LOOP [emit-job-header : Print node information]
2025-10-19 12:13:12.335421 | localhost | ok:
2025-10-19 12:13:12.335803 | localhost | # Node Information
2025-10-19 12:13:12.335864 | localhost | Inventory Hostname: controller
2025-10-19 12:13:12.335907 | localhost | Hostname: ip-172-16-11-16
2025-10-19 12:13:12.335948 | localhost | Username: zuul-worker
2025-10-19 12:13:12.335993 | localhost | Distro: Fedora 37
2025-10-19 12:13:12.336032 | localhost | Provider: ansible-us-east-2
2025-10-19 12:13:12.336069 | localhost | Region: us-east-2
2025-10-19 12:13:12.336104 | localhost | Label: ansible-fedora-37-1vcpu
2025-10-19 12:13:12.336140 | localhost | Product Name: t3.small
2025-10-19 12:13:12.336176 | localhost | Interface IP: 3.133.94.187
2025-10-19 12:13:12.354015 | 
2025-10-19 12:13:12.354211 | TASK [log-inventory : Ensure Zuul Ansible directory exists]
2025-10-19 12:13:12.757220 | localhost -> localhost | changed
2025-10-19 12:13:12.768165 | 
2025-10-19 12:13:12.768292 | TASK [log-inventory : Copy ansible inventory to logs dir]
2025-10-19 12:13:13.673123 | localhost -> localhost | changed
2025-10-19 12:13:13.714435 | 
2025-10-19 12:13:13.714551 | PLAY [all:!appliance*]
2025-10-19 12:13:13.745965 | 
2025-10-19 12:13:13.746047 | TASK [include_role : start-zuul-console]
2025-10-19 12:13:13.771148 | controller | ok
2025-10-19 12:13:13.791730 | 
2025-10-19 12:13:13.791811 | TASK [start-zuul-console : Start zuul_console daemon.]
2025-10-19 12:13:14.474491 | controller | ok
2025-10-19 12:13:14.484790 | 
2025-10-19 12:13:14.484896 | TASK [use-our-mirror : Retrieve the IP address]
2025-10-19 12:13:16.004959 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found
2025-10-19 12:13:16.017924 | 
2025-10-19 12:13:16.018050 | TASK [use-our-mirror : Ensure the registry service is running on the mirror]
2025-10-19 12:13:16.175240 | controller | skipping: Conditional result was False
2025-10-19 12:13:16.183586 | 
2025-10-19 12:13:16.183675 | TASK [use-our-mirror : Write the IP in /etc/hosts]
2025-10-19 12:13:16.208766 | controller | skipping: Conditional result was False
2025-10-19 12:13:16.217319 | 
2025-10-19 12:13:16.217405 | TASK [use-our-mirror : Create the podman configuration directory]
2025-10-19 12:13:16.252623 | controller | skipping: Conditional result was False
2025-10-19 12:13:16.260574 | 
2025-10-19 12:13:16.260672 | TASK [use-our-mirror : Copy the podman configuration]
2025-10-19 12:13:16.285614 | controller | skipping: Conditional result was False
2025-10-19 12:13:16.294030 | 
2025-10-19 12:13:16.294117 | TASK [use-our-mirror : Copy the Yum configuration (main)]
2025-10-19 12:13:16.318961 | controller | skipping: Conditional result was False
2025-10-19 12:13:16.327117 | 
2025-10-19 12:13:16.327204 | TASK [use-our-mirror : Copy the Yum configuration (update)]
2025-10-19 12:13:16.352277 | controller | skipping: Conditional result was False
2025-10-19 12:13:16.369008 | 
2025-10-19 12:13:16.369096 | TASK [Disable Fedora Modular]
2025-10-19 12:13:17.111883 | controller | changed
2025-10-19 12:13:17.124300 | 
2025-10-19 12:13:17.124432 | TASK [Enable EPEL]
2025-10-19 12:13:17.151370 | controller | skipping: Conditional result was False
2025-10-19 12:13:17.163666 | 
2025-10-19 12:13:17.163858 | TASK [Register the RHEL node]
2025-10-19 12:13:17.339920 | 
2025-10-19 12:13:17.340124 | TASK [Show the subscription-manager status]
2025-10-19 12:13:17.488477 | controller | skipping: Conditional result was False
2025-10-19 12:13:17.524997 | 
2025-10-19 12:13:17.525139 | TASK [Enable EPEL on RHEL]
2025-10-19 12:13:17.680727 | controller | skipping: Conditional result was False
2025-10-19 12:13:17.692995 | 
2025-10-19 12:13:17.693120 | TASK [Install git and tox]
2025-10-19 12:14:53.680426 | controller | changed
2025-10-19 12:14:53.693809 | 
2025-10-19 12:14:53.693969 | TASK [include_role : prepare-workspace]
2025-10-19 12:14:53.732553 | controller | ok
2025-10-19 12:14:53.769526 | 
2025-10-19 12:14:53.769725 | TASK [prepare-workspace : Start zuul_console daemon.]
2025-10-19 12:14:54.295762 | controller | ok
2025-10-19 12:14:54.309038 | 
2025-10-19 12:14:54.309169 | TASK [prepare-workspace : Synchronize src repos to workspace directory.]
2025-10-19 12:14:56.548076 | controller | Output suppressed because no_log was given
2025-10-19 12:14:56.568901 | 
2025-10-19 12:14:56.569044 | TASK [include_role : prepare-workspace-openshift]
2025-10-19 12:14:56.596177 | controller | skipping: Conditional result was False
2025-10-19 12:14:56.637020 | 
2025-10-19 12:14:56.637095 | PLAY [all:!appliance]
2025-10-19 12:14:56.657060 | 
2025-10-19 12:14:56.657139 | TASK [Run add-build-sshkey role (RSA)]
2025-10-19 12:14:56.688706 | controller | ok
2025-10-19 12:14:56.709280 | 
2025-10-19 12:14:56.709365 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2025-10-19 12:14:56.977453 | controller -> localhost | ok
2025-10-19 12:14:56.985588 | 
2025-10-19 12:14:56.985672 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2025-10-19 12:14:57.011671 | controller | ok
2025-10-19 12:14:57.029507 | controller | included: /var/lib/zuul/builds/19205daf00634a998eb1c2e5b17efb6e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2025-10-19 12:14:57.037267 | 
2025-10-19 12:14:57.037347 | TASK [add-build-sshkey : Create Temp SSH key]
2025-10-19 12:14:57.537727 | controller -> localhost | Generating public/private rsa key pair.
2025-10-19 12:14:57.537932 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/19205daf00634a998eb1c2e5b17efb6e/work/19205daf00634a998eb1c2e5b17efb6e_id_rsa.
2025-10-19 12:14:57.537959 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/19205daf00634a998eb1c2e5b17efb6e/work/19205daf00634a998eb1c2e5b17efb6e_id_rsa.pub.
2025-10-19 12:14:57.537979 | controller -> localhost | The key fingerprint is:
2025-10-19 12:14:57.537998 | controller -> localhost | SHA256:4xIS022iPmbY92JCQK96tCa9rtK7+M0Mg+R2rJDzndU zuul-build-sshkey
2025-10-19 12:14:57.538016 | controller -> localhost | The key's randomart image is:
2025-10-19 12:14:57.538034 | controller -> localhost | +---[RSA 2048]----+
2025-10-19 12:14:57.538052 | controller -> localhost | |                 |
2025-10-19 12:14:57.538070 | controller -> localhost | |  .  . .         |
2025-10-19 12:14:57.538087 | controller -> localhost | | . .o o o        |
2025-10-19 12:14:57.538103 | controller -> localhost | |  . .+ o         |
2025-10-19 12:14:57.538120 | controller -> localhost | | . oo . S        |
2025-10-19 12:14:57.538142 | controller -> localhost | |oo++.. + .       |
2025-10-19 12:14:57.538164 | controller -> localhost | |=B+=* + E        |
2025-10-19 12:14:57.538183 | controller -> localhost | |*+OX.=oo         |
2025-10-19 12:14:57.538200 | controller -> localhost | |+OB+*o ..        |
2025-10-19 12:14:57.538220 | controller -> localhost | +----[SHA256]-----+
2025-10-19 12:14:57.538266 | controller -> localhost | ok: Runtime: 0:00:00.067805
2025-10-19 12:14:57.544431 | 
2025-10-19 12:14:57.544491 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2025-10-19 12:14:57.574311 | controller | ok
2025-10-19 12:14:57.583664 | controller | included: /var/lib/zuul/builds/19205daf00634a998eb1c2e5b17efb6e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2025-10-19 12:14:57.592479 | 
2025-10-19 12:14:57.592539 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2025-10-19 12:14:57.616727 | controller | skipping: Conditional result was False
2025-10-19 12:14:57.623122 | 
2025-10-19 12:14:57.623182 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2025-10-19 12:14:58.270814 | controller | changed
2025-10-19 12:14:58.283802 | 
2025-10-19 12:14:58.283935 | TASK [add-build-sshkey : Make sure user has a .ssh]
2025-10-19 12:14:58.627493 | controller | ok
2025-10-19 12:14:58.639291 | 
2025-10-19 12:14:58.639422 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2025-10-19 12:14:59.930086 | controller | changed
2025-10-19 12:14:59.977808 | 
2025-10-19 12:14:59.977960 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2025-10-19 12:15:02.536058 | controller | changed
2025-10-19 12:15:02.548665 | 
2025-10-19 12:15:02.548826 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2025-10-19 12:15:02.577255 | controller | skipping: Conditional result was False
2025-10-19 12:15:02.590896 | 
2025-10-19 12:15:02.591030 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2025-10-19 12:15:02.973057 | controller -> localhost | changed
2025-10-19 12:15:02.983758 | 
2025-10-19 12:15:02.983827 | TASK [add-build-sshkey : Add back temp key]
2025-10-19 12:15:03.259765 | controller -> localhost | Identity added: /var/lib/zuul/builds/19205daf00634a998eb1c2e5b17efb6e/work/19205daf00634a998eb1c2e5b17efb6e_id_rsa (zuul-build-sshkey)
2025-10-19 12:15:03.259954 | controller -> localhost | ok: Runtime: 0:00:00.012164
2025-10-19 12:15:03.265918 | 
2025-10-19 12:15:03.265979 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2025-10-19 12:15:03.981632 | controller | ok
2025-10-19 12:15:03.992325 | 
2025-10-19 12:15:03.992448 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2025-10-19 12:15:04.018155 | controller | skipping: Conditional result was False
2025-10-19 12:15:04.041766 | 
2025-10-19 12:15:04.041894 | TASK [Run add-build-sshkey role (ECDSA)]
2025-10-19 12:15:04.069224 | controller | ok
2025-10-19 12:15:04.098112 | 
2025-10-19 12:15:04.098197 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build]
2025-10-19 12:15:04.316524 | controller -> localhost | ok
2025-10-19 12:15:04.322487 | 
2025-10-19 12:15:04.322557 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID]
2025-10-19 12:15:04.350540 | controller | ok
2025-10-19 12:15:04.362376 | controller | included: /var/lib/zuul/builds/19205daf00634a998eb1c2e5b17efb6e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml
2025-10-19 12:15:04.367934 | 
2025-10-19 12:15:04.367994 | TASK [add-build-sshkey : Create Temp SSH key]
2025-10-19 12:15:04.664319 | controller -> localhost | Generating public/private ecdsa key pair.
2025-10-19 12:15:04.664474 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/19205daf00634a998eb1c2e5b17efb6e/work/19205daf00634a998eb1c2e5b17efb6e_id_ecdsa.
2025-10-19 12:15:04.664501 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/19205daf00634a998eb1c2e5b17efb6e/work/19205daf00634a998eb1c2e5b17efb6e_id_ecdsa.pub.
2025-10-19 12:15:04.664532 | controller -> localhost | The key fingerprint is:
2025-10-19 12:15:04.664553 | controller -> localhost | SHA256:5AOEE4EDC4KgOEROWGDkQfDW0QQlP7XKVPXod83WZow zuul-build-sshkey
2025-10-19 12:15:04.664572 | controller -> localhost | The key's randomart image is:
2025-10-19 12:15:04.664590 | controller -> localhost | +---[ECDSA 521]---+
2025-10-19 12:15:04.664608 | controller -> localhost | |/%..*O+ o..      |
2025-10-19 12:15:04.664626 | controller -> localhost | |&o+.o=.o . o     |
2025-10-19 12:15:04.664643 | controller -> localhost | |=oo...= o . .    |
2025-10-19 12:15:04.664661 | controller -> localhost | | o   o * .     =.|
2025-10-19 12:15:04.664696 | controller -> localhost | |      o S . . E O|
2025-10-19 12:15:04.664718 | controller -> localhost | |         . . . + |
2025-10-19 12:15:04.664736 | controller -> localhost | |                 |
2025-10-19 12:15:04.664753 | controller -> localhost | |                 |
2025-10-19 12:15:04.664770 | controller -> localhost | |                 |
2025-10-19 12:15:04.664788 | controller -> localhost | +----[SHA256]-----+
2025-10-19 12:15:04.664831 | controller -> localhost | ok: Runtime: 0:00:00.006853
2025-10-19 12:15:04.670775 | 
2025-10-19 12:15:04.670836 | TASK [add-build-sshkey : Remote setup ssh keys (linux)]
2025-10-19 12:15:04.689508 | controller | ok
2025-10-19 12:15:04.696184 | controller | included: /var/lib/zuul/builds/19205daf00634a998eb1c2e5b17efb6e/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml
2025-10-19 12:15:04.704443 | 
2025-10-19 12:15:04.704503 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey]
2025-10-19 12:15:04.727550 | controller | skipping: Conditional result was False
2025-10-19 12:15:04.733344 | 
2025-10-19 12:15:04.733404 | TASK [add-build-sshkey : Enable access via build key on all nodes]
2025-10-19 12:15:05.195736 | controller | changed
2025-10-19 12:15:05.201012 | 
2025-10-19 12:15:05.201069 | TASK [add-build-sshkey : Make sure user has a .ssh]
2025-10-19 12:15:05.552909 | controller | ok
2025-10-19 12:15:05.564797 | 
2025-10-19 12:15:05.564930 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes]
2025-10-19 12:15:06.857367 | controller | changed
2025-10-19 12:15:06.869537 | 
2025-10-19 12:15:06.869702 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes]
2025-10-19 12:15:08.160479 | controller | changed
2025-10-19 12:15:08.172632 | 
2025-10-19 12:15:08.172791 | TASK [add-build-sshkey : Remote setup ssh keys (windows)]
2025-10-19 12:15:08.198758 | controller | skipping: Conditional result was False
2025-10-19 12:15:08.212127 | 
2025-10-19 12:15:08.212286 | TASK [remove-zuul-sshkey : Remove master key from local agent]
2025-10-19 12:15:08.484502 | controller -> localhost | changed
2025-10-19 12:15:08.507877 | 
2025-10-19 12:15:08.508060 | TASK [add-build-sshkey : Add back temp key]
2025-10-19 12:15:08.834967 | controller -> localhost | Identity added: /var/lib/zuul/builds/19205daf00634a998eb1c2e5b17efb6e/work/19205daf00634a998eb1c2e5b17efb6e_id_ecdsa (zuul-build-sshkey)
2025-10-19 12:15:08.835268 | controller -> localhost | ok: Runtime: 0:00:00.012835
2025-10-19 12:15:08.841566 | 
2025-10-19 12:15:08.841626 | TASK [add-build-sshkey : Verify we can still SSH to all nodes]
2025-10-19 12:15:09.203147 | controller | ok
2025-10-19 12:15:09.214249 | 
2025-10-19 12:15:09.214376 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)]
2025-10-19 12:15:09.251386 | controller | skipping: Conditional result was False
2025-10-19 12:15:09.274046 | 
2025-10-19 12:15:09.274172 | TASK [include_role : remove-zuul-sshkey]
2025-10-19 12:15:09.300794 | controller | skipping: Conditional result was False
2025-10-19 12:15:09.312889 | 
2025-10-19 12:15:09.313015 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them]
2025-10-19 12:15:09.648851 | controller | ok: "logs"
2025-10-19 12:15:09.649431 | controller | ok: All items complete
2025-10-19 12:15:09.649500 | 
2025-10-19 12:15:09.928348 | controller | ok: "artifacts"
2025-10-19 12:15:10.208375 | controller | ok: "docs"
2025-10-19 12:15:10.225156 | 
2025-10-19 12:15:10.225357 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist]
2025-10-19 12:15:10.554773 | controller | changed: "logs"
2025-10-19 12:15:10.845153 | controller | changed: "artifacts"
2025-10-19 12:15:11.132198 | controller | changed: "docs"
2025-10-19 12:15:11.166974 | 
2025-10-19 12:15:11.167086 | PLAY RECAP
2025-10-19 12:15:11.167127 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0
2025-10-19 12:15:11.167152 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0
2025-10-19 12:15:11.167169 | 
2025-10-19 12:15:11.270566 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master]
2025-10-19 12:15:11.271974 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master]
2025-10-19 12:15:11.847657 | 
2025-10-19 12:15:11.847832 | PLAY [all]
2025-10-19 12:15:11.867090 | 
2025-10-19 12:15:11.867186 | TASK [Setup ensure-tox role]
2025-10-19 12:15:11.885962 | controller | ok
2025-10-19 12:15:11.908082 | 
2025-10-19 12:15:11.908174 | TASK [Install pip]
2025-10-19 12:15:11.926636 | controller | ok
2025-10-19 12:15:11.947087 | 
2025-10-19 12:15:11.947167 | TASK [ensure-pip : Check if pip is installed]
2025-10-19 12:15:12.470463 | controller | /usr/bin/pip3
2025-10-19 12:15:12.485478 | controller | /usr/bin/python3: No module named wheel
2025-10-19 12:15:12.583127 | controller | ok: Runtime: 0:00:00.022733
2025-10-19 12:15:12.594970 | 
2025-10-19 12:15:12.595102 | LOOP [ensure-pip : Install pip from packages]
2025-10-19 12:15:12.642367 | controller | ok: "/var/lib/zuul/builds/19205daf00634a998eb1c2e5b17efb6e/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml"
2025-10-19 12:15:12.669258 | controller | included: /var/lib/zuul/builds/19205daf00634a998eb1c2e5b17efb6e/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml
2025-10-19 12:15:12.688775 | 
2025-10-19 12:15:12.688911 | TASK [ensure-pip : Install Python 3 pip]
2025-10-19 12:15:21.369557 | controller | changed
2025-10-19 12:15:21.382349 | 
2025-10-19 12:15:21.382539 | TASK [ensure-pip : Check for EPEL repository]
2025-10-19 12:15:21.399841 | controller | skipping: Conditional result was False
2025-10-19 12:15:21.412734 | 
2025-10-19 12:15:21.412886 | TASK [ensure-pip : Fail with instructions when EPEL is not installed]
2025-10-19 12:15:21.430290 | controller | skipping: Conditional result was False
2025-10-19 12:15:21.444881 | 
2025-10-19 12:15:21.445029 | TASK [ensure-pip : Install Python 2 pip]
2025-10-19 12:15:21.461283 | controller | skipping: Conditional result was False
2025-10-19 12:15:21.473501 | 
2025-10-19 12:15:21.473637 | TASK [ensure-pip : Ensure setuptools]
2025-10-19 12:15:21.490712 | controller | skipping: Conditional result was False
2025-10-19 12:15:21.504574 | 
2025-10-19 12:15:21.504738 | TASK [ensure-pip : Check for ensurepip module]
2025-10-19 12:15:21.650415 | controller | skipping: Conditional result was False
2025-10-19 12:15:21.662833 | 
2025-10-19 12:15:21.662968 | TASK [ensure-pip : Ensure python3-venv]
2025-10-19 12:15:21.689554 | controller | skipping: Conditional result was False
2025-10-19 12:15:21.701799 | 
2025-10-19 12:15:21.701928 | TASK [ensure-pip : Install pip from source]
2025-10-19 12:15:21.728172 | controller | skipping: Conditional result was False
2025-10-19 12:15:21.740029 | 
2025-10-19 12:15:21.740166 | TASK [ensure-pip : Probe for venv python full path]
2025-10-19 12:15:22.314805 | controller | /usr/bin/python3
2025-10-19 12:15:22.423036 | controller | ok: Runtime: 0:00:00.007091
2025-10-19 12:15:22.435149 | 
2025-10-19 12:15:22.435277 | TASK [ensure-pip : Set host default]
2025-10-19 12:15:22.514091 | controller | ok
2025-10-19 12:15:22.525175 | 
2025-10-19 12:15:22.525325 | TASK [ensure-pip : Set ensure_pip_virtualenv_command]
2025-10-19 12:15:22.606176 | controller | ok
2025-10-19 12:15:22.627979 | 
2025-10-19 12:15:22.628120 | TASK [ensure-tox : Check if tox is installed]
2025-10-19 12:15:23.135665 | controller | /usr/bin/tox
2025-10-19 12:15:23.278787 | controller | ok: Runtime: 0:00:00.006998
2025-10-19 12:15:23.290316 | 
2025-10-19 12:15:23.290446 | TASK [ensure-tox : Export preinstalled tox_exectuable]
2025-10-19 12:15:23.340182 | controller | ok
2025-10-19 12:15:23.350975 | 
2025-10-19 12:15:23.351100 | TASK [ensure-tox : Create local venv]
2025-10-19 12:15:23.507200 | controller | skipping: Conditional result was False
2025-10-19 12:15:23.515096 | 
2025-10-19 12:15:23.515180 | TASK [ensure-tox : Install tox to local venv]
2025-10-19 12:15:23.667324 | controller | skipping: Conditional result was False
2025-10-19 12:15:23.675318 | 
2025-10-19 12:15:23.675405 | TASK [ensure-tox : Export installed tox_executable path]
2025-10-19 12:15:23.699914 | controller | skipping: Conditional result was False
2025-10-19 12:15:23.707789 | 
2025-10-19 12:15:23.707874 | TASK [ensure-tox : Output tox version]
2025-10-19 12:15:24.449702 | controller | 3.28.0 imported from /usr/lib/python3.11/site-packages/tox/__init__.py
2025-10-19 12:15:24.862076 | controller | ok: Runtime: 0:00:00.323572
2025-10-19 12:15:24.874195 | 
2025-10-19 12:15:24.874340 | TASK [ensure-tox : Make global symlink]
2025-10-19 12:15:24.900870 | controller | skipping: Conditional result was False
2025-10-19 12:15:24.922576 | 
2025-10-19 12:15:24.922754 | TASK [Setup tox role]
2025-10-19 12:15:24.949772 | controller | ok
2025-10-19 12:15:25.000152 | 
2025-10-19 12:15:25.000427 | TASK [tox : Check to see if the constraints file exists]
2025-10-19 12:15:25.057898 | controller | skipping: Conditional result was False
2025-10-19 12:15:25.070430 | 
2025-10-19 12:15:25.070583 | TASK [tox : Fail if constraints file is missing]
2025-10-19 12:15:25.107363 | controller | skipping: Conditional result was False
2025-10-19 12:15:25.119449 | 
2025-10-19 12:15:25.119577 | TASK [tox : Record file location]
2025-10-19 12:15:25.156116 | controller | skipping: Conditional result was False
2025-10-19 12:15:25.168414 | 
2025-10-19 12:15:25.168543 | TASK [tox : Install tox siblings]
2025-10-19 12:15:25.194736 | controller | skipping: Conditional result was False
2025-10-19 12:15:25.207474 | 
2025-10-19 12:15:25.207609 | TASK [tox : Emit tox command]
2025-10-19 12:15:25.268036 | /usr/bin/tox   -evenv  -vv --notest
2025-10-19 12:15:25.278643 | 
2025-10-19 12:15:25.278806 | TASK [tox : Run tox]
2025-10-19 12:15:26.053664 | controller | using tox.ini: /home/zuul-worker/src/github.com/ansible-network/releases/tox.ini (pid 2209)
2025-10-19 12:15:26.068051 | controller | using tox-3.28.0 from /usr/lib/python3.11/site-packages/tox/__init__.py (pid 2209)
2025-10-19 12:15:26.111438 | controller | skipping sdist step
2025-10-19 12:15:26.111487 | controller | venv uses /usr/bin/python3
2025-10-19 12:15:26.111520 | controller | venv start: getenv /home/zuul-worker/src/github.com/ansible-network/releases/.tox/venv
2025-10-19 12:15:26.111906 | controller | venv cannot reuse: no previous config /home/zuul-worker/src/github.com/ansible-network/releases/.tox/venv/.tox-config1
2025-10-19 12:15:26.111925 | controller | venv create: /home/zuul-worker/src/github.com/ansible-network/releases/.tox/venv
2025-10-19 12:15:26.111940 | controller | setting PATH=/home/zuul-worker/src/github.com/ansible-network/releases/.tox/venv/bin:/home/zuul-worker/.local/bin:/home/zuul-worker/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2025-10-19 12:15:26.111960 | controller | [2217] /home/zuul-worker/src/github.com/ansible-network/releases/.tox$ /usr/bin/python3 -m virtualenv --no-download --python /usr/bin/python3 venv
2025-10-19 12:15:27.004163 | controller | created virtual environment CPython3.11.0.final.0-64 in 714ms
2025-10-19 12:15:27.046509 | controller |   creator CPython3Posix(dest=/home/zuul-worker/src/github.com/ansible-network/releases/.tox/venv, clear=False, no_vcs_ignore=False, global=False)
2025-10-19 12:15:27.046551 | 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-worker/.local/share/virtualenv)
2025-10-19 12:15:27.046562 | controller |     added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1
2025-10-19 12:15:27.046572 | controller |   activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator
2025-10-19 12:15:27.046590 | controller | venv installdeps: -r/home/zuul-worker/src/github.com/ansible-network/releases/requirements.txt, -r/home/zuul-worker/src/github.com/ansible-network/releases/test-requirements.txt
2025-10-19 12:15:27.047017 | controller | setting PATH=/home/zuul-worker/src/github.com/ansible-network/releases/.tox/venv/bin:/home/zuul-worker/.local/bin:/home/zuul-worker/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2025-10-19 12:15:27.047049 | controller | [2225] /home/zuul-worker/src/github.com/ansible-network/releases$ /home/zuul-worker/src/github.com/ansible-network/releases/.tox/venv/bin/pip install -r/home/zuul-worker/src/github.com/ansible-network/releases/requirements.txt -r/home/zuul-worker/src/github.com/ansible-network/releases/test-requirements.txt
2025-10-19 12:15:29.878254 | controller | Collecting ruamel.yaml
2025-10-19 12:15:29.961813 | controller |   Downloading ruamel.yaml-0.18.15-py3-none-any.whl (119 kB)
2025-10-19 12:15:29.998407 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 119.7/119.7 kB 3.6 MB/s eta 0:00:00
2025-10-19 12:15:30.072474 | controller | Collecting pbr
2025-10-19 12:15:30.084388 | controller |   Downloading pbr-7.0.1-py2.py3-none-any.whl (126 kB)
2025-10-19 12:15:30.103047 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 126.1/126.1 kB 8.0 MB/s eta 0:00:00
2025-10-19 12:15:30.160184 | controller | Collecting tweepy
2025-10-19 12:15:30.172208 | controller |   Downloading tweepy-4.16.0-py3-none-any.whl (98 kB)
2025-10-19 12:15:30.186978 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.8/98.8 kB 8.1 MB/s eta 0:00:00
2025-10-19 12:15:30.258889 | controller | Collecting galaxy-importer
2025-10-19 12:15:30.271976 | controller |   Downloading galaxy_importer-0.4.34-py3-none-any.whl (64 kB)
2025-10-19 12:15:30.282777 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 64.8/64.8 kB 7.6 MB/s eta 0:00:00
2025-10-19 12:15:30.365812 | controller | Collecting flake8
2025-10-19 12:15:30.377594 | controller |   Downloading flake8-7.3.0-py2.py3-none-any.whl (57 kB)
2025-10-19 12:15:30.388883 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 57.9/57.9 kB 5.9 MB/s eta 0:00:00
2025-10-19 12:15:30.563923 | controller | Collecting ruamel.yaml.clib>=0.2.7
2025-10-19 12:15:30.575881 | 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:15:30.633303 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 738.1/738.1 kB 13.7 MB/s eta 0:00:00
2025-10-19 12:15:30.643608 | controller | Requirement already satisfied: setuptools in ./.tox/venv/lib/python3.11/site-packages (from pbr->-r /home/zuul-worker/src/github.com/ansible-network/releases/requirements.txt (line 2)) (62.6.0)
2025-10-19 12:15:30.705764 | controller | Collecting oauthlib<4,>=3.2.0
2025-10-19 12:15:30.717326 | controller |   Downloading oauthlib-3.3.1-py3-none-any.whl (160 kB)
2025-10-19 12:15:30.735604 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 160.1/160.1 kB 10.5 MB/s eta 0:00:00
2025-10-19 12:15:30.836099 | controller | Collecting requests<3,>=2.27.0
2025-10-19 12:15:30.847894 | controller |   Downloading requests-2.32.5-py3-none-any.whl (64 kB)
2025-10-19 12:15:30.857295 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 64.7/64.7 kB 9.4 MB/s eta 0:00:00
2025-10-19 12:15:30.898972 | controller | Collecting requests-oauthlib<3,>=1.2.0
2025-10-19 12:15:30.910295 | controller |   Downloading requests_oauthlib-2.0.0-py2.py3-none-any.whl (24 kB)
2025-10-19 12:15:31.139887 | controller | Collecting ansible-core
2025-10-19 12:15:31.151710 | controller |   Downloading ansible_core-2.19.3-py3-none-any.whl (2.4 MB)
2025-10-19 12:15:31.270809 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.4/2.4 MB 20.8 MB/s eta 0:00:00
2025-10-19 12:15:31.342256 | controller | Collecting ansible-builder<4.0,>=1.2.0
2025-10-19 12:15:31.356657 | controller |   Downloading ansible_builder-3.1.0-py3-none-any.whl (46 kB)
2025-10-19 12:15:31.365651 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 46.3/46.3 kB 6.4 MB/s eta 0:00:00
2025-10-19 12:15:31.559349 | controller | Collecting ansible-lint<=25.8.2,>=6.2.2
2025-10-19 12:15:31.571733 | controller |   Downloading ansible_lint-25.8.2-py3-none-any.whl (328 kB)
2025-10-19 12:15:31.591182 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 328.7/328.7 kB 20.4 MB/s eta 0:00:00
2025-10-19 12:15:31.648000 | controller | Collecting attrs<23,>=21.4.0
2025-10-19 12:15:31.661043 | controller |   Downloading attrs-22.2.0-py3-none-any.whl (60 kB)
2025-10-19 12:15:31.668981 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 60.0/60.0 kB 9.8 MB/s eta 0:00:00
2025-10-19 12:15:31.871293 | controller | Collecting nh3<3,>=0.2.18
2025-10-19 12:15:31.883041 | controller |   Downloading nh3-0.3.1-cp38-abi3-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (796 kB)
2025-10-19 12:15:31.912399 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 796.9/796.9 kB 29.9 MB/s eta 0:00:00
2025-10-19 12:15:31.941485 | controller | Collecting flake8
2025-10-19 12:15:31.952945 | controller |   Downloading flake8-6.1.0-py2.py3-none-any.whl (58 kB)
2025-10-19 12:15:31.962070 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 58.3/58.3 kB 8.5 MB/s eta 0:00:00
2025-10-19 12:15:32.025380 | controller | Collecting markdown<4,>=3.3.4
2025-10-19 12:15:32.037136 | controller |   Downloading markdown-3.9-py3-none-any.whl (107 kB)
2025-10-19 12:15:32.046552 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 107.4/107.4 kB 15.6 MB/s eta 0:00:00
2025-10-19 12:15:32.274405 | controller | Collecting pyyaml<7,>=5.4.1
2025-10-19 12:15:32.286318 | 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:15:32.316187 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 806.6/806.6 kB 30.6 MB/s eta 0:00:00
2025-10-19 12:15:32.385720 | controller | Collecting semantic-version<3,>=2.9.0
2025-10-19 12:15:32.397285 | controller |   Downloading semantic_version-2.10.0-py2.py3-none-any.whl (15 kB)
2025-10-19 12:15:32.464811 | controller | Collecting packaging<25.0,>=23.2
2025-10-19 12:15:32.476793 | controller |   Downloading packaging-24.2-py3-none-any.whl (65 kB)
2025-10-19 12:15:32.486474 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 65.5/65.5 kB 9.2 MB/s eta 0:00:00
2025-10-19 12:15:32.525463 | controller | Collecting mccabe<0.8.0,>=0.7.0
2025-10-19 12:15:32.536659 | controller |   Downloading mccabe-0.7.0-py2.py3-none-any.whl (7.3 kB)
2025-10-19 12:15:32.583132 | controller | Collecting pycodestyle<2.12.0,>=2.11.0
2025-10-19 12:15:32.594769 | controller |   Downloading pycodestyle-2.11.1-py2.py3-none-any.whl (31 kB)
2025-10-19 12:15:32.646094 | controller | Collecting pyflakes<3.2.0,>=3.1.0
2025-10-19 12:15:32.658057 | controller |   Downloading pyflakes-3.1.0-py2.py3-none-any.whl (62 kB)
2025-10-19 12:15:32.666879 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 62.6/62.6 kB 9.3 MB/s eta 0:00:00
2025-10-19 12:15:32.711271 | controller | Collecting bindep
2025-10-19 12:15:32.724234 | controller |   Downloading bindep-2.13.0-py3-none-any.whl (34 kB)
2025-10-19 12:15:32.821017 | controller | Collecting jsonschema
2025-10-19 12:15:32.832819 | controller |   Downloading jsonschema-4.25.1-py3-none-any.whl (90 kB)
2025-10-19 12:15:32.842723 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 90.0/90.0 kB 12.6 MB/s eta 0:00:00
2025-10-19 12:15:33.054673 | controller | Collecting ansible-compat>=25.8.0
2025-10-19 12:15:33.067429 | controller |   Downloading ansible_compat-25.8.2-py3-none-any.whl (27 kB)
2025-10-19 12:15:33.288615 | controller | Collecting black>=24.3.0
2025-10-19 12:15:33.305330 | 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:15:33.353401 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.6/1.6 MB 37.0 MB/s eta 0:00:00
2025-10-19 12:15:33.440045 | controller | Collecting filelock>=3.8.2
2025-10-19 12:15:33.451829 | controller |   Downloading filelock-3.20.0-py3-none-any.whl (16 kB)
2025-10-19 12:15:33.637068 | controller | Collecting importlib-metadata
2025-10-19 12:15:33.648688 | controller |   Downloading importlib_metadata-8.7.0-py3-none-any.whl (27 kB)
2025-10-19 12:15:33.718749 | controller | Collecting pathspec>=0.10.3
2025-10-19 12:15:33.730458 | controller |   Downloading pathspec-0.12.1-py3-none-any.whl (31 kB)
2025-10-19 12:15:33.856251 | controller | Collecting referencing>=0.36.2
2025-10-19 12:15:33.867791 | controller |   Downloading referencing-0.37.0-py3-none-any.whl (26 kB)
2025-10-19 12:15:33.912596 | controller | Collecting subprocess-tee>=0.4.1
2025-10-19 12:15:33.925368 | controller |   Downloading subprocess_tee-0.4.2-py3-none-any.whl (5.2 kB)
2025-10-19 12:15:33.987555 | controller | Collecting yamllint>=1.34.0
2025-10-19 12:15:33.999239 | controller |   Downloading yamllint-1.37.1-py3-none-any.whl (68 kB)
2025-10-19 12:15:34.012411 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 68.8/68.8 kB 10.0 MB/s eta 0:00:00
2025-10-19 12:15:34.072704 | controller | Collecting wcmatch>=8.1.2
2025-10-19 12:15:34.084310 | controller |   Downloading wcmatch-10.1-py3-none-any.whl (39 kB)
2025-10-19 12:15:34.150529 | controller | Collecting jinja2>=3.1.0
2025-10-19 12:15:34.162248 | controller |   Downloading jinja2-3.1.6-py3-none-any.whl (134 kB)
2025-10-19 12:15:34.173201 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 134.9/134.9 kB 17.5 MB/s eta 0:00:00
2025-10-19 12:15:35.031187 | controller | Collecting cryptography
2025-10-19 12:15:35.042410 | controller |   Downloading cryptography-46.0.3-cp311-abi3-manylinux_2_34_x86_64.whl (4.5 MB)
2025-10-19 12:15:35.134412 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.5/4.5 MB 50.2 MB/s eta 0:00:00
2025-10-19 12:15:35.174573 | controller | Collecting resolvelib<2.0.0,>=0.5.3
2025-10-19 12:15:35.185317 | controller |   Downloading resolvelib-1.2.1-py3-none-any.whl (18 kB)
2025-10-19 12:15:35.466120 | controller | Collecting charset_normalizer<4,>=2
2025-10-19 12:15:35.477107 | 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:15:35.483805 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 151.6/151.6 kB 34.4 MB/s eta 0:00:00
2025-10-19 12:15:35.512246 | controller | Collecting idna<4,>=2.5
2025-10-19 12:15:35.522909 | controller |   Downloading idna-3.11-py3-none-any.whl (71 kB)
2025-10-19 12:15:35.529210 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 71.0/71.0 kB 15.7 MB/s eta 0:00:00
2025-10-19 12:15:35.589559 | controller | Collecting urllib3<3,>=1.21.1
2025-10-19 12:15:35.600202 | controller |   Downloading urllib3-2.5.0-py3-none-any.whl (129 kB)
2025-10-19 12:15:35.608067 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 129.8/129.8 kB 23.1 MB/s eta 0:00:00
2025-10-19 12:15:35.645289 | controller | Collecting certifi>=2017.4.17
2025-10-19 12:15:35.655893 | controller |   Downloading certifi-2025.10.5-py3-none-any.whl (163 kB)
2025-10-19 12:15:35.665185 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 163.3/163.3 kB 23.8 MB/s eta 0:00:00
2025-10-19 12:15:35.741590 | controller | Collecting ansible-compat>=25.8.0
2025-10-19 12:15:35.756005 | controller |   Downloading ansible_compat-25.8.1-py3-none-any.whl (27 kB)
2025-10-19 12:15:35.823229 | controller | Collecting click>=8.0.0
2025-10-19 12:15:35.833859 | controller |   Downloading click-8.3.0-py3-none-any.whl (107 kB)
2025-10-19 12:15:35.842280 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 107.3/107.3 kB 16.9 MB/s eta 0:00:00
2025-10-19 12:15:35.861589 | controller | Collecting mypy-extensions>=0.4.3
2025-10-19 12:15:35.872601 | controller |   Downloading mypy_extensions-1.1.0-py3-none-any.whl (5.0 kB)
2025-10-19 12:15:35.918987 | controller | Collecting platformdirs>=2
2025-10-19 12:15:35.929744 | controller |   Downloading platformdirs-4.5.0-py3-none-any.whl (18 kB)
2025-10-19 12:15:35.956212 | controller | Collecting pytokens>=0.1.10
2025-10-19 12:15:35.966827 | controller |   Downloading pytokens-0.2.0-py3-none-any.whl (12 kB)
2025-10-19 12:15:36.132009 | controller | Collecting MarkupSafe>=2.0
2025-10-19 12:15:36.142768 | 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:15:36.252203 | controller | Collecting jsonschema-specifications>=2023.03.6
2025-10-19 12:15:36.262697 | controller |   Downloading jsonschema_specifications-2025.9.1-py3-none-any.whl (18 kB)
2025-10-19 12:15:36.958096 | controller | Collecting rpds-py>=0.7.1
2025-10-19 12:15:36.968589 | controller |   Downloading rpds_py-0.27.1-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (384 kB)
2025-10-19 12:15:36.980002 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 384.1/384.1 kB 42.6 MB/s eta 0:00:00
2025-10-19 12:15:37.037121 | controller | Collecting typing-extensions>=4.4.0
2025-10-19 12:15:37.047782 | controller |   Downloading typing_extensions-4.15.0-py3-none-any.whl (44 kB)
2025-10-19 12:15:37.055223 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 44.6/44.6 kB 6.8 MB/s eta 0:00:00
2025-10-19 12:15:37.127590 | controller | Collecting bracex>=2.1.1
2025-10-19 12:15:37.138407 | controller |   Downloading bracex-2.6-py3-none-any.whl (11 kB)
2025-10-19 12:15:37.192953 | controller | Collecting distro>=1.7
2025-10-19 12:15:37.204226 | controller |   Downloading distro-1.9.0-py3-none-any.whl (20 kB)
2025-10-19 12:15:37.228094 | controller | Collecting Parsley
2025-10-19 12:15:37.239647 | controller |   Downloading Parsley-1.3-py2.py3-none-any.whl (88 kB)
2025-10-19 12:15:37.247965 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 88.9/88.9 kB 13.2 MB/s eta 0:00:00
2025-10-19 12:15:37.553250 | controller | Collecting cffi>=2.0.0
2025-10-19 12:15:37.563899 | controller |   Downloading cffi-2.0.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl (215 kB)
2025-10-19 12:15:37.574108 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 215.6/215.6 kB 28.1 MB/s eta 0:00:00
2025-10-19 12:15:37.701163 | controller | Collecting zipp>=3.20
2025-10-19 12:15:37.711604 | controller |   Downloading zipp-3.23.0-py3-none-any.whl (10 kB)
2025-10-19 12:15:37.747463 | controller | Collecting pycparser
2025-10-19 12:15:37.758018 | controller |   Downloading pycparser-2.23-py3-none-any.whl (118 kB)
2025-10-19 12:15:37.766817 | controller |      ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 118.1/118.1 kB 17.2 MB/s eta 0:00:00
2025-10-19 12:15:38.321326 | 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:15:43.258976 | 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:15:43.392531 | controller |
2025-10-19 12:15:43.826965 | controller | [notice] A new release of pip available: 22.2.2 -> 25.2
2025-10-19 12:15:43.827001 | controller | [notice] To update, run: pip install --upgrade pip
2025-10-19 12:15:43.827015 | controller | venv finish: getenv /home/zuul-worker/src/github.com/ansible-network/releases/.tox/venv after 17.72 seconds
2025-10-19 12:15:43.827140 | controller | venv start: developpkg /home/zuul-worker/src/github.com/ansible-network/releases
2025-10-19 12:15:43.827158 | controller | venv develop-inst: /home/zuul-worker/src/github.com/ansible-network/releases
2025-10-19 12:15:43.831181 | controller | write config to /home/zuul-worker/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-worker/src/github.com/ansible-network/releases/requirements.txt\n00000000000000000000000000000000 -r/home/zuul-worker/src/github.com/ansible-network/releases/test-requirements.txt'
2025-10-19 12:15:43.831355 | controller | setting PATH=/home/zuul-worker/src/github.com/ansible-network/releases/.tox/venv/bin:/home/zuul-worker/.local/bin:/home/zuul-worker/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2025-10-19 12:15:43.831916 | controller | [2262] /home/zuul-worker/src/github.com/ansible-network/releases$ /home/zuul-worker/src/github.com/ansible-network/releases/.tox/venv/bin/pip install --exists-action w -e .
2025-10-19 12:15:44.255226 | controller | Obtaining file:///home/zuul-worker/src/github.com/ansible-network/releases
2025-10-19 12:15:44.256106 | controller |   Preparing metadata (setup.py): started
2025-10-19 12:15:46.203302 | controller |   Preparing metadata (setup.py): finished with status 'done'
2025-10-19 12:15:46.228286 | 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:15:46.229341 | 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:15:46.230329 | 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:15:46.232640 | 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:15:46.242216 | 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:15:46.255544 | 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:15:46.257114 | 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:15:46.258940 | 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:15:46.275027 | 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:15:46.276757 | 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:15:46.278151 | 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:15:46.279340 | 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:15:46.743409 | controller | Installing collected packages: ansible-releases
2025-10-19 12:15:46.743939 | controller |   Running setup.py develop for ansible-releases
2025-10-19 12:15:48.454052 | controller | Successfully installed ansible-releases-0.0.1.dev36
2025-10-19 12:15:48.480032 | controller |
2025-10-19 12:15:48.592152 | controller | [notice] A new release of pip available: 22.2.2 -> 25.2
2025-10-19 12:15:48.592189 | controller | [notice] To update, run: pip install --upgrade pip
2025-10-19 12:15:48.592206 | controller | venv finish: developpkg /home/zuul-worker/src/github.com/ansible-network/releases after 4.76 seconds
2025-10-19 12:15:48.593205 | controller | venv start: envreport
2025-10-19 12:15:48.593237 | controller | setting PATH=/home/zuul-worker/src/github.com/ansible-network/releases/.tox/venv/bin:/home/zuul-worker/.local/bin:/home/zuul-worker/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin
2025-10-19 12:15:48.593252 | controller | [2291] /home/zuul-worker/src/github.com/ansible-network/releases$ /home/zuul-worker/src/github.com/ansible-network/releases/.tox/venv/bin/python -m pip freeze >.tox/venv/log/venv-0.log
2025-10-19 12:15:49.109847 | controller | venv finish: envreport  after 0.52 seconds
2025-10-19 12:15:49.137251 | 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:15:49.137386 | controller | ___________________________________ summary ____________________________________
2025-10-19 12:15:49.137401 | controller |   venv: skipped tests
2025-10-19 12:15:49.137408 | controller |   congratulations :)
2025-10-19 12:15:49.510292 | controller | ok: Runtime: 0:00:23.332457
2025-10-19 12:15:49.519807 | 
2025-10-19 12:15:49.519882 | TASK [tox : Look for output]
2025-10-19 12:15:50.066643 | controller | ok
2025-10-19 12:15:50.079935 | 
2025-10-19 12:15:50.080074 | TASK [tox : Return file comments to Zuul]
2025-10-19 12:15:50.119258 | controller | skipping: Conditional result was False
2025-10-19 12:15:50.178361 | 
2025-10-19 12:15:50.178497 | TASK [Setup download-artifact-fork role]
2025-10-19 12:15:50.201878 | controller | ok
2025-10-19 12:15:50.225552 | 
2025-10-19 12:15:50.225645 | TASK [download-artifact-fork : Parse inventory response]
2025-10-19 12:15:50.281071 | controller | ok
2025-10-19 12:15:50.293101 | 
2025-10-19 12:15:50.293237 | TASK [download-artifact-fork : Fetch info from Zuul API]
2025-10-19 12:15:50.329780 | controller | skipping: Conditional result was False
2025-10-19 12:15:50.344077 | 
2025-10-19 12:15:50.344216 | TASK [download-artifact-fork : Parse build response]
2025-10-19 12:15:50.381893 | controller | skipping: Conditional result was False
2025-10-19 12:15:50.395331 | 
2025-10-19 12:15:50.395472 | TASK [download-artifact-fork : Ensure artifacts directory exists]
2025-10-19 12:15:50.993793 | controller | changed
2025-10-19 12:15:51.005414 | 
2025-10-19 12:15:51.005547 | LOOP [download-artifact-fork : Download archive by type]
2025-10-19 12:15:51.076663 | controller | skipping: Conditional result was False
2025-10-19 12:15:51.077189 | controller | ok: All items complete
2025-10-19 12:15:51.077249 | 
2025-10-19 12:15:52.753413 | controller | changed: OK (671904 bytes)
2025-10-19 12:15:52.787754 | 
2025-10-19 12:15:52.787896 | TASK [deploy-artifacts : define __collections]
2025-10-19 12:15:52.825460 | controller | ok
2025-10-19 12:15:52.836415 | 
2025-10-19 12:15:52.836547 | LOOP [deploy-artifacts : Create list of collections]
2025-10-19 12:15:52.872935 | controller | skipping: Conditional result was False
2025-10-19 12:15:52.924271 | controller | ok:
2025-10-19 12:15:52.924576 | controller | {
2025-10-19 12:15:52.924646 | controller |   "branch": "main",
2025-10-19 12:15:52.924732 | controller |   "change": "2503",
2025-10-19 12:15:52.924777 | controller |   "job": "build-ansible-collection",
2025-10-19 12:15:52.924818 | controller |   "metadata": {
2025-10-19 12:15:52.924874 | controller |     "type": "ansible_collection",
2025-10-19 12:15:52.924918 | controller |     "version": "6.1.0"
2025-10-19 12:15:52.924967 | controller |   },
2025-10-19 12:15:52.925006 | controller |   "name": "community.vmware",
2025-10-19 12:15:52.925043 | controller |   "patchset": "a8109ff7e07667d5c83462b3d0db49b4dcb23e17",
2025-10-19 12:15:52.925081 | controller |   "project": "ansible-collections/community.vmware",
2025-10-19 12:15:52.925119 | controller |   "url": "https://b6f5a760d1f0d76dad2d-8c72cc448e0e6bc348b468deac1eb71c.ssl.cf1.rackcdn.com/ansible/b87f5cb8b0114bf3b293fdb8cc1ba9bd/artifacts/community-vmware-6.1.0.tar.gz"
2025-10-19 12:15:52.925170 | controller | }
2025-10-19 12:15:52.946532 | 
2025-10-19 12:15:52.946668 | TASK [deploy-artifacts : Install require-project collection using ansible-galaxy]
2025-10-19 12:15:55.871286 | controller | [ERROR]: Failed to resolve the requested dependencies map. Could not satisfy the following requirements:
2025-10-19 12:15:55.871463 | controller | * vmware.vmware:>=2.5.0 (dependency of community.vmware:6.1.0)
2025-10-19 12:15:55.871486 | 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:15:55.871502 | controller |
2025-10-19 12:15:55.871527 | controller | Starting galaxy collection install process
2025-10-19 12:15:56.025135 | controller | Process install dependency map
2025-10-19 12:15:56.025192 | 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:15:56.109896 | controller | ERROR
2025-10-19 12:15:56.110100 | controller | {
2025-10-19 12:15:56.110138 | controller |   "delta": "0:00:02.553181",
2025-10-19 12:15:56.110164 | controller |   "end": "2025-10-19 12:15:56.025798",
2025-10-19 12:15:56.110188 | controller |   "msg": "non-zero return code",
2025-10-19 12:15:56.110210 | controller |   "rc": 1,
2025-10-19 12:15:56.110232 | controller |   "start": "2025-10-19 12:15:53.472617"
2025-10-19 12:15:56.110252 | controller | }
failure
2025-10-19 12:15:56.112260 | 
2025-10-19 12:15:56.112321 | PLAY RECAP
2025-10-19 12:15:56.112372 | controller | ok: 17 changed: 8 unreachable: 0 failed: 1 skipped: 18 rescued: 0 ignored: 0
2025-10-19 12:15:56.112399 | 
2025-10-19 12:15:56.214420 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master]
2025-10-19 12:15:56.215205 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master]
2025-10-19 12:15:56.785615 | 
2025-10-19 12:15:56.785741 | PLAY [all:!appliance*]
2025-10-19 12:15:56.806163 | 
2025-10-19 12:15:56.806247 | TASK [unregister the node]
2025-10-19 12:15:56.948026 | controller | skipping: Conditional result was False
2025-10-19 12:15:56.960766 | 
2025-10-19 12:15:56.960932 | TASK [include_role : fetch-output]
2025-10-19 12:15:57.008824 | controller | ok
2025-10-19 12:15:57.045880 | 
2025-10-19 12:15:57.045972 | TASK [fetch-output : Set log path for multiple nodes]
2025-10-19 12:15:57.121653 | controller | skipping: Conditional result was False
2025-10-19 12:15:57.134893 | 
2025-10-19 12:15:57.135043 | TASK [fetch-output : Set log path for single node]
2025-10-19 12:15:57.183047 | controller | ok
2025-10-19 12:15:57.194788 | 
2025-10-19 12:15:57.194963 | LOOP [fetch-output : Ensure local output dirs]
2025-10-19 12:15:57.656408 | controller -> localhost | ok: "/var/lib/zuul/builds/19205daf00634a998eb1c2e5b17efb6e/work/logs"
2025-10-19 12:15:57.918371 | controller -> localhost | changed: "/var/lib/zuul/builds/19205daf00634a998eb1c2e5b17efb6e/work/artifacts"
2025-10-19 12:15:58.181110 | controller -> localhost | changed: "/var/lib/zuul/builds/19205daf00634a998eb1c2e5b17efb6e/work/docs"
2025-10-19 12:15:58.206913 | 
2025-10-19 12:15:58.207111 | LOOP [fetch-output : Collect logs, artifacts and docs]
2025-10-19 12:15:59.451125 | controller | changed: .d..t...... ./
2025-10-19 12:15:59.451610 | controller | changed: All items complete
2025-10-19 12:15:59.451730 | 
2025-10-19 12:16:00.493102 | controller | changed: .d..t...... ./
2025-10-19 12:16:01.551138 | controller | changed: .d..t...... ./
2025-10-19 12:16:01.569736 | 
2025-10-19 12:16:01.569870 | TASK [include_role : fetch-output-openshift]
2025-10-19 12:16:01.594329 | controller | skipping: Conditional result was False
2025-10-19 12:16:01.600328 | 
2025-10-19 12:16:01.600392 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir]
2025-10-19 12:16:02.051899 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.012536
2025-10-19 12:16:02.271649 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.008038
2025-10-19 12:16:02.327639 | 
2025-10-19 12:16:02.327791 | PLAY [localhost]
2025-10-19 12:16:02.344001 | 
2025-10-19 12:16:02.344089 | TASK [Run Zuul manifest role]
2025-10-19 12:16:02.363777 | localhost | ok
2025-10-19 12:16:02.382143 | 
2025-10-19 12:16:02.382229 | TASK [generate-zuul-manifest : Generate Zuul manifest]
2025-10-19 12:16:02.756340 | localhost | changed
2025-10-19 12:16:02.760980 | 
2025-10-19 12:16:02.761043 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul]
2025-10-19 12:16:02.790219 | localhost | ok
2025-10-19 12:16:02.800836 | 
2025-10-19 12:16:02.800914 | TASK [Set zuul-log-path fact]
2025-10-19 12:16:02.820396 | localhost | ok
2025-10-19 12:16:02.838586 | 
2025-10-19 12:16:02.838689 | TASK [set-zuul-log-path-fact : Set log path for a build]
2025-10-19 12:16:02.868279 | localhost | ok
2025-10-19 12:16:02.879040 | 
2025-10-19 12:16:02.879122 | LOOP [Run upload-logs-swift role]
2025-10-19 12:16:02.916397 | localhost | Output suppressed because no_log was given
2025-10-19 12:16:02.958538 | 
2025-10-19 12:16:02.958658 | TASK [Set zuul-log-path fact]
2025-10-19 12:16:02.983361 | localhost | skipping: Conditional result was False
2025-10-19 12:16:02.989650 | 
2025-10-19 12:16:02.989753 | TASK [upload-logs-swift : Ensure logs are readable before uploading]
2025-10-19 12:16:03.302302 | localhost -> localhost | ok: Runtime: 0:00:00.008284
2025-10-19 12:16:03.346043 | 
2025-10-19 12:16:03.346189 | TASK [upload-logs-swift : Upload logs to swift]