2025-10-19 12:16:36.977846 | Job console starting... 2025-10-19 12:16:36.993717 | Updating repositories 2025-10-19 12:16:37.052640 | Preparing job workspace 2025-10-19 12:16:41.342135 | Running Ansible setup... 2025-10-19 12:16:47.110322 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2025-10-19 12:16:47.656567 | 2025-10-19 12:16:47.656693 | PLAY [localhost] 2025-10-19 12:16:47.665216 | 2025-10-19 12:16:47.665289 | TASK [Gathering Facts] 2025-10-19 12:16:48.671260 | localhost | ok 2025-10-19 12:16:48.708039 | 2025-10-19 12:16:48.708196 | TASK [Setup log path fact] 2025-10-19 12:16:48.730913 | localhost | ok 2025-10-19 12:16:48.747149 | 2025-10-19 12:16:48.747241 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-19 12:16:48.777909 | localhost | ok 2025-10-19 12:16:48.788001 | 2025-10-19 12:16:48.788109 | TASK [emit-job-header : Print job information] 2025-10-19 12:16:48.842774 | # Job Information 2025-10-19 12:16:48.843011 | Ansible Version: 2.15.12 2025-10-19 12:16:48.843113 | Job: ansible-galaxy-importer 2025-10-19 12:16:48.843158 | Pipeline: third-party-check 2025-10-19 12:16:48.843198 | Executor: ze01.softwarefactory-project.io 2025-10-19 12:16:48.843236 | Triggered by: https://github.com/ansible-collections/community.vmware/pull/2503 2025-10-19 12:16:48.843282 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/3ec/ansible/3ec050a863734a49839ebd2549881155/ 2025-10-19 12:16:48.843340 | Event ID: 2ac850d0-ace3-11f0-9f68-080fc459cd8b 2025-10-19 12:16:48.851259 | 2025-10-19 12:16:48.851412 | LOOP [emit-job-header : Print node information] 2025-10-19 12:16:48.963579 | localhost | ok: 2025-10-19 12:16:48.963823 | localhost | # Node Information 2025-10-19 12:16:48.963850 | localhost | Inventory Hostname: controller 2025-10-19 12:16:48.963869 | localhost | Hostname: ip-172-16-149-228 2025-10-19 12:16:48.963887 | localhost | Username: zuul-worker 2025-10-19 12:16:48.963911 | localhost | Distro: Fedora 37 2025-10-19 12:16:48.963930 | localhost | Provider: ansible-us-east-2 2025-10-19 12:16:48.963946 | localhost | Region: us-east-2 2025-10-19 12:16:48.963963 | localhost | Label: ansible-fedora-37-1vcpu 2025-10-19 12:16:48.963978 | localhost | Product Name: t3.small 2025-10-19 12:16:48.963994 | localhost | Interface IP: 3.20.222.39 2025-10-19 12:16:48.985888 | 2025-10-19 12:16:48.986076 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2025-10-19 12:16:49.383237 | localhost -> localhost | changed 2025-10-19 12:16:49.394564 | 2025-10-19 12:16:49.394740 | TASK [log-inventory : Copy ansible inventory to logs dir] 2025-10-19 12:16:50.290808 | localhost -> localhost | changed 2025-10-19 12:16:50.310442 | 2025-10-19 12:16:50.310543 | PLAY [all:!appliance*] 2025-10-19 12:16:50.325865 | 2025-10-19 12:16:50.325999 | TASK [include_role : start-zuul-console] 2025-10-19 12:16:50.346611 | controller | ok 2025-10-19 12:16:50.359996 | 2025-10-19 12:16:50.360138 | TASK [start-zuul-console : Start zuul_console daemon.] 2025-10-19 12:16:51.066771 | controller | ok 2025-10-19 12:16:51.088324 | 2025-10-19 12:16:51.088508 | TASK [use-our-mirror : Retrieve the IP address] 2025-10-19 12:16:52.618910 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2025-10-19 12:16:52.627116 | 2025-10-19 12:16:52.627200 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2025-10-19 12:16:52.767495 | controller | skipping: Conditional result was False 2025-10-19 12:16:52.779874 | 2025-10-19 12:16:52.780070 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2025-10-19 12:16:52.806991 | controller | skipping: Conditional result was False 2025-10-19 12:16:52.819518 | 2025-10-19 12:16:52.819657 | TASK [use-our-mirror : Create the podman configuration directory] 2025-10-19 12:16:52.846258 | controller | skipping: Conditional result was False 2025-10-19 12:16:52.858386 | 2025-10-19 12:16:52.858549 | TASK [use-our-mirror : Copy the podman configuration] 2025-10-19 12:16:52.885453 | controller | skipping: Conditional result was False 2025-10-19 12:16:52.897612 | 2025-10-19 12:16:52.897765 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2025-10-19 12:16:52.924258 | controller | skipping: Conditional result was False 2025-10-19 12:16:52.936385 | 2025-10-19 12:16:52.936533 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2025-10-19 12:16:52.963818 | controller | skipping: Conditional result was False 2025-10-19 12:16:52.987667 | 2025-10-19 12:16:52.987827 | TASK [Disable Fedora Modular] 2025-10-19 12:16:53.698854 | controller | changed 2025-10-19 12:16:53.710589 | 2025-10-19 12:16:53.710751 | TASK [Enable EPEL] 2025-10-19 12:16:53.737748 | controller | skipping: Conditional result was False 2025-10-19 12:16:53.750349 | 2025-10-19 12:16:53.750492 | TASK [Register the RHEL node] 2025-10-19 12:16:53.919526 | 2025-10-19 12:16:53.919810 | TASK [Show the subscription-manager status] 2025-10-19 12:16:54.094525 | controller | skipping: Conditional result was False 2025-10-19 12:16:54.146123 | 2025-10-19 12:16:54.146313 | TASK [Enable EPEL on RHEL] 2025-10-19 12:16:54.311724 | controller | skipping: Conditional result was False 2025-10-19 12:16:54.323869 | 2025-10-19 12:16:54.324089 | TASK [Install git and tox] 2025-10-19 12:18:27.036106 | controller | changed 2025-10-19 12:18:27.048931 | 2025-10-19 12:18:27.049099 | TASK [include_role : prepare-workspace] 2025-10-19 12:18:27.088508 | controller | ok 2025-10-19 12:18:27.124639 | 2025-10-19 12:18:27.124769 | TASK [prepare-workspace : Start zuul_console daemon.] 2025-10-19 12:18:27.629628 | controller | ok 2025-10-19 12:18:27.643248 | 2025-10-19 12:18:27.643450 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2025-10-19 12:18:29.747135 | controller | Output suppressed because no_log was given 2025-10-19 12:18:29.762252 | 2025-10-19 12:18:29.762361 | TASK [include_role : prepare-workspace-openshift] 2025-10-19 12:18:29.787802 | controller | skipping: Conditional result was False 2025-10-19 12:18:29.818409 | 2025-10-19 12:18:29.818496 | PLAY [all:!appliance] 2025-10-19 12:18:29.833089 | 2025-10-19 12:18:29.833147 | TASK [Run add-build-sshkey role (RSA)] 2025-10-19 12:18:29.864057 | controller | ok 2025-10-19 12:18:29.883932 | 2025-10-19 12:18:29.884038 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-19 12:18:30.163178 | controller -> localhost | ok 2025-10-19 12:18:30.176137 | 2025-10-19 12:18:30.176266 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-19 12:18:30.214731 | controller | ok 2025-10-19 12:18:30.242958 | controller | included: /var/lib/zuul/builds/3ec050a863734a49839ebd2549881155/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-19 12:18:30.251265 | 2025-10-19 12:18:30.251346 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-19 12:18:30.811784 | controller -> localhost | Generating public/private rsa key pair. 2025-10-19 12:18:30.812189 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/3ec050a863734a49839ebd2549881155/work/3ec050a863734a49839ebd2549881155_id_rsa. 2025-10-19 12:18:30.812256 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/3ec050a863734a49839ebd2549881155/work/3ec050a863734a49839ebd2549881155_id_rsa.pub. 2025-10-19 12:18:30.812302 | controller -> localhost | The key fingerprint is: 2025-10-19 12:18:30.812344 | controller -> localhost | SHA256:W2mrqdbw9X16Kvcio2wi9xhstDNzeDCri0k0P3FJIyk zuul-build-sshkey 2025-10-19 12:18:30.812385 | controller -> localhost | The key's randomart image is: 2025-10-19 12:18:30.812424 | controller -> localhost | +---[RSA 2048]----+ 2025-10-19 12:18:30.812462 | controller -> localhost | | | 2025-10-19 12:18:30.812501 | controller -> localhost | | . | 2025-10-19 12:18:30.812539 | controller -> localhost | | E o o | 2025-10-19 12:18:30.812577 | controller -> localhost | | . o o . | 2025-10-19 12:18:30.812614 | controller -> localhost | | o . S + | 2025-10-19 12:18:30.812671 | controller -> localhost | | . o.= X.. | 2025-10-19 12:18:30.812720 | controller -> localhost | | . o+%.+. . | 2025-10-19 12:18:30.812761 | controller -> localhost | | . oo+=%. = + o| 2025-10-19 12:18:30.812800 | controller -> localhost | | o.+=+++. =oB.| 2025-10-19 12:18:30.812846 | controller -> localhost | +----[SHA256]-----+ 2025-10-19 12:18:30.812977 | controller -> localhost | ok: Runtime: 0:00:00.141333 2025-10-19 12:18:30.826238 | 2025-10-19 12:18:30.826372 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-19 12:18:30.854299 | controller | ok 2025-10-19 12:18:30.875744 | controller | included: /var/lib/zuul/builds/3ec050a863734a49839ebd2549881155/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-19 12:18:30.889078 | 2025-10-19 12:18:30.889159 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-19 12:18:30.913701 | controller | skipping: Conditional result was False 2025-10-19 12:18:30.922643 | 2025-10-19 12:18:30.922749 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-19 12:18:31.534602 | controller | changed 2025-10-19 12:18:31.541919 | 2025-10-19 12:18:31.542006 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-19 12:18:31.882694 | controller | ok 2025-10-19 12:18:31.894822 | 2025-10-19 12:18:31.894954 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-19 12:18:33.166190 | controller | changed 2025-10-19 12:18:33.177855 | 2025-10-19 12:18:33.177990 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-19 12:18:34.449944 | controller | changed 2025-10-19 12:18:34.461838 | 2025-10-19 12:18:34.461972 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-19 12:18:34.489938 | controller | skipping: Conditional result was False 2025-10-19 12:18:34.504870 | 2025-10-19 12:18:34.505043 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-19 12:18:34.918119 | controller -> localhost | changed 2025-10-19 12:18:34.940068 | 2025-10-19 12:18:34.940235 | TASK [add-build-sshkey : Add back temp key] 2025-10-19 12:18:35.272919 | controller -> localhost | Identity added: /var/lib/zuul/builds/3ec050a863734a49839ebd2549881155/work/3ec050a863734a49839ebd2549881155_id_rsa (zuul-build-sshkey) 2025-10-19 12:18:35.273265 | controller -> localhost | ok: Runtime: 0:00:00.014339 2025-10-19 12:18:35.286200 | 2025-10-19 12:18:35.286339 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-19 12:18:35.772659 | controller | ok 2025-10-19 12:18:35.784000 | 2025-10-19 12:18:35.784194 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-19 12:18:35.820811 | controller | skipping: Conditional result was False 2025-10-19 12:18:35.845530 | 2025-10-19 12:18:35.845674 | TASK [Run add-build-sshkey role (ECDSA)] 2025-10-19 12:18:35.882645 | controller | ok 2025-10-19 12:18:35.911894 | 2025-10-19 12:18:35.911982 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2025-10-19 12:18:36.192525 | controller -> localhost | ok 2025-10-19 12:18:36.206764 | 2025-10-19 12:18:36.206903 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2025-10-19 12:18:36.245889 | controller | ok 2025-10-19 12:18:36.268594 | controller | included: /var/lib/zuul/builds/3ec050a863734a49839ebd2549881155/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2025-10-19 12:18:36.277856 | 2025-10-19 12:18:36.277936 | TASK [add-build-sshkey : Create Temp SSH key] 2025-10-19 12:18:36.587576 | controller -> localhost | Generating public/private ecdsa key pair. 2025-10-19 12:18:36.588063 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/3ec050a863734a49839ebd2549881155/work/3ec050a863734a49839ebd2549881155_id_ecdsa. 2025-10-19 12:18:36.588150 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/3ec050a863734a49839ebd2549881155/work/3ec050a863734a49839ebd2549881155_id_ecdsa.pub. 2025-10-19 12:18:36.588223 | controller -> localhost | The key fingerprint is: 2025-10-19 12:18:36.588282 | controller -> localhost | SHA256:nTpns2vQDmPNNlEyU+Fg5zIvP4hZQtkq2QfnSj02saA zuul-build-sshkey 2025-10-19 12:18:36.588335 | controller -> localhost | The key's randomart image is: 2025-10-19 12:18:36.588386 | controller -> localhost | +---[ECDSA 521]---+ 2025-10-19 12:18:36.588436 | controller -> localhost | | o.+. | 2025-10-19 12:18:36.588484 | controller -> localhost | | ++=. | 2025-10-19 12:18:36.588565 | controller -> localhost | | = *=o | 2025-10-19 12:18:36.588616 | controller -> localhost | | = O.B | 2025-10-19 12:18:36.588665 | controller -> localhost | | E S+&.. | 2025-10-19 12:18:36.588713 | controller -> localhost | | o=X** | 2025-10-19 12:18:36.588763 | controller -> localhost | | .**=.o | 2025-10-19 12:18:36.588811 | controller -> localhost | | +oo . | 2025-10-19 12:18:36.588858 | controller -> localhost | | .o. | 2025-10-19 12:18:36.588905 | controller -> localhost | +----[SHA256]-----+ 2025-10-19 12:18:36.589056 | controller -> localhost | ok: Runtime: 0:00:00.014190 2025-10-19 12:18:36.603728 | 2025-10-19 12:18:36.603864 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2025-10-19 12:18:36.642744 | controller | ok 2025-10-19 12:18:36.658703 | controller | included: /var/lib/zuul/builds/3ec050a863734a49839ebd2549881155/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2025-10-19 12:18:36.675668 | 2025-10-19 12:18:36.675766 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2025-10-19 12:18:36.700482 | controller | skipping: Conditional result was False 2025-10-19 12:18:36.708708 | 2025-10-19 12:18:36.708793 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2025-10-19 12:18:37.161831 | controller | changed 2025-10-19 12:18:37.173519 | 2025-10-19 12:18:37.173794 | TASK [add-build-sshkey : Make sure user has a .ssh] 2025-10-19 12:18:37.517393 | controller | ok 2025-10-19 12:18:37.530212 | 2025-10-19 12:18:37.530354 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2025-10-19 12:18:38.815785 | controller | changed 2025-10-19 12:18:38.828388 | 2025-10-19 12:18:38.828526 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2025-10-19 12:18:40.115997 | controller | changed 2025-10-19 12:18:40.129987 | 2025-10-19 12:18:40.130170 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2025-10-19 12:18:40.158850 | controller | skipping: Conditional result was False 2025-10-19 12:18:40.174106 | 2025-10-19 12:18:40.174272 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2025-10-19 12:18:40.459302 | controller -> localhost | changed 2025-10-19 12:18:40.484544 | 2025-10-19 12:18:40.484722 | TASK [add-build-sshkey : Add back temp key] 2025-10-19 12:18:40.792618 | controller -> localhost | Identity added: /var/lib/zuul/builds/3ec050a863734a49839ebd2549881155/work/3ec050a863734a49839ebd2549881155_id_ecdsa (zuul-build-sshkey) 2025-10-19 12:18:40.793175 | controller -> localhost | ok: Runtime: 0:00:00.012441 2025-10-19 12:18:40.807049 | 2025-10-19 12:18:40.807208 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2025-10-19 12:18:41.156887 | controller | ok 2025-10-19 12:18:41.165245 | 2025-10-19 12:18:41.165440 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2025-10-19 12:18:41.194093 | controller | skipping: Conditional result was False 2025-10-19 12:18:41.211301 | 2025-10-19 12:18:41.211540 | TASK [include_role : remove-zuul-sshkey] 2025-10-19 12:18:41.240343 | controller | skipping: Conditional result was False 2025-10-19 12:18:41.250226 | 2025-10-19 12:18:41.250408 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2025-10-19 12:18:41.570898 | controller | ok: "logs" 2025-10-19 12:18:41.571387 | controller | ok: All items complete 2025-10-19 12:18:41.571449 | 2025-10-19 12:18:41.857310 | controller | ok: "artifacts" 2025-10-19 12:18:42.136380 | controller | ok: "docs" 2025-10-19 12:18:42.149348 | 2025-10-19 12:18:42.149586 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2025-10-19 12:18:42.494757 | controller | changed: "logs" 2025-10-19 12:18:42.777284 | controller | changed: "artifacts" 2025-10-19 12:18:43.071630 | controller | changed: "docs" 2025-10-19 12:18:43.130823 | 2025-10-19 12:18:43.130938 | PLAY RECAP 2025-10-19 12:18:43.130994 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2025-10-19 12:18:43.131076 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2025-10-19 12:18:43.131105 | 2025-10-19 12:18:43.240748 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2025-10-19 12:18:43.241456 | PRE-RUN START: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master] 2025-10-19 12:18:43.807249 | 2025-10-19 12:18:43.807355 | PLAY [all] 2025-10-19 12:18:43.826663 | 2025-10-19 12:18:43.826733 | TASK [Setup ensure-tox role] 2025-10-19 12:18:43.846109 | controller | ok 2025-10-19 12:18:43.867737 | 2025-10-19 12:18:43.867810 | TASK [Install pip] 2025-10-19 12:18:43.886982 | controller | ok 2025-10-19 12:18:43.907247 | 2025-10-19 12:18:43.907334 | TASK [ensure-pip : Check if pip is installed] 2025-10-19 12:18:44.441386 | controller | /usr/bin/pip3 2025-10-19 12:18:44.457002 | controller | /usr/bin/python3: No module named wheel 2025-10-19 12:18:44.548906 | controller | ok: Runtime: 0:00:00.023467 2025-10-19 12:18:44.561194 | 2025-10-19 12:18:44.561326 | LOOP [ensure-pip : Install pip from packages] 2025-10-19 12:18:44.610680 | controller | ok: "/var/lib/zuul/builds/3ec050a863734a49839ebd2549881155/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml" 2025-10-19 12:18:44.628823 | controller | included: /var/lib/zuul/builds/3ec050a863734a49839ebd2549881155/untrusted/project_2/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml 2025-10-19 12:18:44.648659 | 2025-10-19 12:18:44.648793 | TASK [ensure-pip : Install Python 3 pip] 2025-10-19 12:18:53.674639 | controller | changed 2025-10-19 12:18:53.687737 | 2025-10-19 12:18:53.687882 | TASK [ensure-pip : Check for EPEL repository] 2025-10-19 12:18:53.715090 | controller | skipping: Conditional result was False 2025-10-19 12:18:53.729461 | 2025-10-19 12:18:53.729603 | TASK [ensure-pip : Fail with instructions when EPEL is not installed] 2025-10-19 12:18:53.756856 | controller | skipping: Conditional result was False 2025-10-19 12:18:53.769646 | 2025-10-19 12:18:53.769792 | TASK [ensure-pip : Install Python 2 pip] 2025-10-19 12:18:53.796414 | controller | skipping: Conditional result was False 2025-10-19 12:18:53.808617 | 2025-10-19 12:18:53.808756 | TASK [ensure-pip : Ensure setuptools] 2025-10-19 12:18:53.835622 | controller | skipping: Conditional result was False 2025-10-19 12:18:53.851211 | 2025-10-19 12:18:53.851344 | TASK [ensure-pip : Check for ensurepip module] 2025-10-19 12:18:54.007815 | controller | skipping: Conditional result was False 2025-10-19 12:18:54.020218 | 2025-10-19 12:18:54.020356 | TASK [ensure-pip : Ensure python3-venv] 2025-10-19 12:18:54.047120 | controller | skipping: Conditional result was False 2025-10-19 12:18:54.059555 | 2025-10-19 12:18:54.059695 | TASK [ensure-pip : Install pip from source] 2025-10-19 12:18:54.086138 | controller | skipping: Conditional result was False 2025-10-19 12:18:54.098336 | 2025-10-19 12:18:54.098480 | TASK [ensure-pip : Probe for venv python full path] 2025-10-19 12:18:54.670542 | controller | /usr/bin/python3 2025-10-19 12:18:54.784882 | controller | ok: Runtime: 0:00:00.006159 2025-10-19 12:18:54.791353 | 2025-10-19 12:18:54.791446 | TASK [ensure-pip : Set host default] 2025-10-19 12:18:54.868795 | controller | ok 2025-10-19 12:18:54.880048 | 2025-10-19 12:18:54.880232 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2025-10-19 12:18:54.952780 | controller | ok 2025-10-19 12:18:54.974378 | 2025-10-19 12:18:54.974559 | TASK [ensure-tox : Check if tox is installed] 2025-10-19 12:18:55.503668 | controller | /usr/bin/tox 2025-10-19 12:18:55.626331 | controller | ok: Runtime: 0:00:00.006585 2025-10-19 12:18:55.634410 | 2025-10-19 12:18:55.634525 | TASK [ensure-tox : Export preinstalled tox_exectuable] 2025-10-19 12:18:55.680411 | controller | ok 2025-10-19 12:18:55.687306 | 2025-10-19 12:18:55.687405 | TASK [ensure-tox : Create local venv] 2025-10-19 12:18:55.836200 | controller | skipping: Conditional result was False 2025-10-19 12:18:55.843939 | 2025-10-19 12:18:55.844135 | TASK [ensure-tox : Install tox to local venv] 2025-10-19 12:18:56.003681 | controller | skipping: Conditional result was False 2025-10-19 12:18:56.016433 | 2025-10-19 12:18:56.016619 | TASK [ensure-tox : Export installed tox_executable path] 2025-10-19 12:18:56.044160 | controller | skipping: Conditional result was False 2025-10-19 12:18:56.056420 | 2025-10-19 12:18:56.056562 | TASK [ensure-tox : Output tox version] 2025-10-19 12:18:56.820563 | controller | 3.28.0 imported from /usr/lib/python3.11/site-packages/tox/__init__.py 2025-10-19 12:18:57.218716 | controller | ok: Runtime: 0:00:00.320550 2025-10-19 12:18:57.231294 | 2025-10-19 12:18:57.231441 | TASK [ensure-tox : Make global symlink] 2025-10-19 12:18:57.258748 | controller | skipping: Conditional result was False 2025-10-19 12:18:57.280420 | 2025-10-19 12:18:57.280570 | TASK [Setup tox role] 2025-10-19 12:18:57.309325 | controller | ok 2025-10-19 12:18:57.351717 | 2025-10-19 12:18:57.351807 | TASK [tox : Check to see if the constraints file exists] 2025-10-19 12:18:57.387555 | controller | skipping: Conditional result was False 2025-10-19 12:18:57.395962 | 2025-10-19 12:18:57.396071 | TASK [tox : Fail if constraints file is missing] 2025-10-19 12:18:57.421220 | controller | skipping: Conditional result was False 2025-10-19 12:18:57.430423 | 2025-10-19 12:18:57.430531 | TASK [tox : Record file location] 2025-10-19 12:18:57.455663 | controller | skipping: Conditional result was False 2025-10-19 12:18:57.463484 | 2025-10-19 12:18:57.463567 | TASK [tox : Install tox siblings] 2025-10-19 12:18:57.478486 | controller | skipping: Conditional result was False 2025-10-19 12:18:57.486812 | 2025-10-19 12:18:57.486899 | TASK [tox : Emit tox command] 2025-10-19 12:18:57.521701 | /usr/bin/tox -evenv -vv --notest 2025-10-19 12:18:57.528408 | 2025-10-19 12:18:57.528494 | TASK [tox : Run tox] 2025-10-19 12:18:58.284849 | controller | using tox.ini: /home/zuul-worker/src/github.com/ansible-network/releases/tox.ini (pid 2163) 2025-10-19 12:18:58.299150 | controller | using tox-3.28.0 from /usr/lib/python3.11/site-packages/tox/__init__.py (pid 2163) 2025-10-19 12:18:58.342003 | controller | skipping sdist step 2025-10-19 12:18:58.342046 | controller | venv uses /usr/bin/python3 2025-10-19 12:18:58.342078 | controller | venv start: getenv /home/zuul-worker/src/github.com/ansible-network/releases/.tox/venv 2025-10-19 12:18:58.342443 | controller | venv cannot reuse: no previous config /home/zuul-worker/src/github.com/ansible-network/releases/.tox/venv/.tox-config1 2025-10-19 12:18:58.342462 | controller | venv create: /home/zuul-worker/src/github.com/ansible-network/releases/.tox/venv 2025-10-19 12:18:58.342478 | 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:18:58.342498 | controller | [2171] /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:18:59.276617 | controller | created virtual environment CPython3.11.0.final.0-64 in 752ms 2025-10-19 12:18:59.321802 | 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:18:59.321842 | 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:18:59.321853 | controller | added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1 2025-10-19 12:18:59.321863 | controller | activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator 2025-10-19 12:18:59.321881 | 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:18:59.322304 | 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:18:59.322333 | controller | [2179] /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:19:02.224671 | controller | Collecting ruamel.yaml 2025-10-19 12:19:02.332403 | controller | Downloading ruamel.yaml-0.18.15-py3-none-any.whl (119 kB) 2025-10-19 12:19:02.376700 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 119.7/119.7 kB 3.1 MB/s eta 0:00:00 2025-10-19 12:19:02.454002 | controller | Collecting pbr 2025-10-19 12:19:02.466014 | controller | Downloading pbr-7.0.1-py2.py3-none-any.whl (126 kB) 2025-10-19 12:19:02.498931 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 126.1/126.1 kB 4.1 MB/s eta 0:00:00 2025-10-19 12:19:02.557217 | controller | Collecting tweepy 2025-10-19 12:19:02.570478 | controller | Downloading tweepy-4.16.0-py3-none-any.whl (98 kB) 2025-10-19 12:19:02.583574 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.8/98.8 kB 11.3 MB/s eta 0:00:00 2025-10-19 12:19:02.661327 | controller | Collecting galaxy-importer 2025-10-19 12:19:02.674542 | controller | Downloading galaxy_importer-0.4.34-py3-none-any.whl (64 kB) 2025-10-19 12:19:02.686466 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 64.8/64.8 kB 7.7 MB/s eta 0:00:00 2025-10-19 12:19:02.774862 | controller | Collecting flake8 2025-10-19 12:19:02.786902 | controller | Downloading flake8-7.3.0-py2.py3-none-any.whl (57 kB) 2025-10-19 12:19:02.796447 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 57.9/57.9 kB 8.3 MB/s eta 0:00:00 2025-10-19 12:19:02.984147 | controller | Collecting ruamel.yaml.clib>=0.2.7 2025-10-19 12:19:02.996084 | 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:19:03.025522 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 738.1/738.1 kB 29.4 MB/s eta 0:00:00 2025-10-19 12:19:03.036081 | 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:19:03.095794 | controller | Collecting oauthlib<4,>=3.2.0 2025-10-19 12:19:03.108310 | controller | Downloading oauthlib-3.3.1-py3-none-any.whl (160 kB) 2025-10-19 12:19:03.120824 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 160.1/160.1 kB 18.1 MB/s eta 0:00:00 2025-10-19 12:19:03.216480 | controller | Collecting requests<3,>=2.27.0 2025-10-19 12:19:03.228761 | controller | Downloading requests-2.32.5-py3-none-any.whl (64 kB) 2025-10-19 12:19:03.238439 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 64.7/64.7 kB 9.3 MB/s eta 0:00:00 2025-10-19 12:19:03.279045 | controller | Collecting requests-oauthlib<3,>=1.2.0 2025-10-19 12:19:03.290610 | controller | Downloading requests_oauthlib-2.0.0-py2.py3-none-any.whl (24 kB) 2025-10-19 12:19:03.524269 | controller | Collecting ansible-core 2025-10-19 12:19:03.536379 | controller | Downloading ansible_core-2.19.3-py3-none-any.whl (2.4 MB) 2025-10-19 12:19:03.571223 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.4/2.4 MB 77.5 MB/s eta 0:00:00 2025-10-19 12:19:03.639118 | controller | Collecting ansible-builder<4.0,>=1.2.0 2025-10-19 12:19:03.653197 | controller | Downloading ansible_builder-3.1.0-py3-none-any.whl (46 kB) 2025-10-19 12:19:03.662462 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 46.3/46.3 kB 6.3 MB/s eta 0:00:00 2025-10-19 12:19:03.855188 | controller | Collecting ansible-lint<=25.8.2,>=6.2.2 2025-10-19 12:19:03.869750 | controller | Downloading ansible_lint-25.8.2-py3-none-any.whl (328 kB) 2025-10-19 12:19:03.883848 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 328.7/328.7 kB 32.1 MB/s eta 0:00:00 2025-10-19 12:19:03.941224 | controller | Collecting attrs<23,>=21.4.0 2025-10-19 12:19:03.952740 | controller | Downloading attrs-22.2.0-py3-none-any.whl (60 kB) 2025-10-19 12:19:03.962246 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 60.0/60.0 kB 8.5 MB/s eta 0:00:00 2025-10-19 12:19:04.118428 | controller | Collecting nh3<3,>=0.2.18 2025-10-19 12:19:04.130206 | controller | Downloading nh3-0.3.1-cp38-abi3-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (796 kB) 2025-10-19 12:19:04.148779 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 796.9/796.9 kB 55.4 MB/s eta 0:00:00 2025-10-19 12:19:04.175810 | controller | Collecting flake8 2025-10-19 12:19:04.187389 | controller | Downloading flake8-6.1.0-py2.py3-none-any.whl (58 kB) 2025-10-19 12:19:04.196649 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 58.3/58.3 kB 8.5 MB/s eta 0:00:00 2025-10-19 12:19:04.254999 | controller | Collecting markdown<4,>=3.3.4 2025-10-19 12:19:04.266386 | controller | Downloading markdown-3.9-py3-none-any.whl (107 kB) 2025-10-19 12:19:04.277283 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 107.4/107.4 kB 15.0 MB/s eta 0:00:00 2025-10-19 12:19:04.506648 | controller | Collecting pyyaml<7,>=5.4.1 2025-10-19 12:19:04.518568 | 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:19:04.535447 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 806.6/806.6 kB 58.1 MB/s eta 0:00:00 2025-10-19 12:19:04.596671 | controller | Collecting semantic-version<3,>=2.9.0 2025-10-19 12:19:04.608308 | controller | Downloading semantic_version-2.10.0-py2.py3-none-any.whl (15 kB) 2025-10-19 12:19:04.675438 | controller | Collecting packaging<25.0,>=23.2 2025-10-19 12:19:04.687195 | controller | Downloading packaging-24.2-py3-none-any.whl (65 kB) 2025-10-19 12:19:04.695902 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 65.5/65.5 kB 9.3 MB/s eta 0:00:00 2025-10-19 12:19:04.744594 | controller | Collecting mccabe<0.8.0,>=0.7.0 2025-10-19 12:19:04.756963 | controller | Downloading mccabe-0.7.0-py2.py3-none-any.whl (7.3 kB) 2025-10-19 12:19:04.805597 | controller | Collecting pycodestyle<2.12.0,>=2.11.0 2025-10-19 12:19:04.817328 | controller | Downloading pycodestyle-2.11.1-py2.py3-none-any.whl (31 kB) 2025-10-19 12:19:04.870950 | controller | Collecting pyflakes<3.2.0,>=3.1.0 2025-10-19 12:19:04.882750 | controller | Downloading pyflakes-3.1.0-py2.py3-none-any.whl (62 kB) 2025-10-19 12:19:04.891991 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 62.6/62.6 kB 9.0 MB/s eta 0:00:00 2025-10-19 12:19:04.934512 | controller | Collecting bindep 2025-10-19 12:19:04.946868 | controller | Downloading bindep-2.13.0-py3-none-any.whl (34 kB) 2025-10-19 12:19:05.042650 | controller | Collecting jsonschema 2025-10-19 12:19:05.054230 | controller | Downloading jsonschema-4.25.1-py3-none-any.whl (90 kB) 2025-10-19 12:19:05.064504 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 90.0/90.0 kB 11.1 MB/s eta 0:00:00 2025-10-19 12:19:05.272324 | controller | Collecting ansible-compat>=25.8.0 2025-10-19 12:19:05.283917 | controller | Downloading ansible_compat-25.8.2-py3-none-any.whl (27 kB) 2025-10-19 12:19:05.504307 | controller | Collecting black>=24.3.0 2025-10-19 12:19:05.517044 | 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:19:05.542319 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 1.6/1.6 MB 74.3 MB/s eta 0:00:00 2025-10-19 12:19:05.625733 | controller | Collecting filelock>=3.8.2 2025-10-19 12:19:05.636970 | controller | Downloading filelock-3.20.0-py3-none-any.whl (16 kB) 2025-10-19 12:19:05.780451 | controller | Collecting importlib-metadata 2025-10-19 12:19:05.793857 | controller | Downloading importlib_metadata-8.7.0-py3-none-any.whl (27 kB) 2025-10-19 12:19:05.857441 | controller | Collecting pathspec>=0.10.3 2025-10-19 12:19:05.868916 | controller | Downloading pathspec-0.12.1-py3-none-any.whl (31 kB) 2025-10-19 12:19:05.994313 | controller | Collecting referencing>=0.36.2 2025-10-19 12:19:06.005991 | controller | Downloading referencing-0.37.0-py3-none-any.whl (26 kB) 2025-10-19 12:19:06.050161 | controller | Collecting subprocess-tee>=0.4.1 2025-10-19 12:19:06.063757 | controller | Downloading subprocess_tee-0.4.2-py3-none-any.whl (5.2 kB) 2025-10-19 12:19:06.124208 | controller | Collecting yamllint>=1.34.0 2025-10-19 12:19:06.135847 | controller | Downloading yamllint-1.37.1-py3-none-any.whl (68 kB) 2025-10-19 12:19:06.147771 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 68.8/68.8 kB 10.3 MB/s eta 0:00:00 2025-10-19 12:19:06.207474 | controller | Collecting wcmatch>=8.1.2 2025-10-19 12:19:06.219105 | controller | Downloading wcmatch-10.1-py3-none-any.whl (39 kB) 2025-10-19 12:19:06.286314 | controller | Collecting jinja2>=3.1.0 2025-10-19 12:19:06.298278 | controller | Downloading jinja2-3.1.6-py3-none-any.whl (134 kB) 2025-10-19 12:19:06.309131 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 134.9/134.9 kB 18.2 MB/s eta 0:00:00 2025-10-19 12:19:07.273264 | controller | Collecting cryptography 2025-10-19 12:19:07.283937 | controller | Downloading cryptography-46.0.3-cp311-abi3-manylinux_2_34_x86_64.whl (4.5 MB) 2025-10-19 12:19:07.331334 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.5/4.5 MB 100.3 MB/s eta 0:00:00 2025-10-19 12:19:07.372242 | controller | Collecting resolvelib<2.0.0,>=0.5.3 2025-10-19 12:19:07.382735 | controller | Downloading resolvelib-1.2.1-py3-none-any.whl (18 kB) 2025-10-19 12:19:07.667738 | controller | Collecting charset_normalizer<4,>=2 2025-10-19 12:19:07.678470 | 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:19:07.687873 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 151.6/151.6 kB 21.7 MB/s eta 0:00:00 2025-10-19 12:19:07.716910 | controller | Collecting idna<4,>=2.5 2025-10-19 12:19:07.727622 | controller | Downloading idna-3.11-py3-none-any.whl (71 kB) 2025-10-19 12:19:07.735693 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 71.0/71.0 kB 10.9 MB/s eta 0:00:00 2025-10-19 12:19:07.806335 | controller | Collecting urllib3<3,>=1.21.1 2025-10-19 12:19:07.816810 | controller | Downloading urllib3-2.5.0-py3-none-any.whl (129 kB) 2025-10-19 12:19:07.825519 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 129.8/129.8 kB 19.1 MB/s eta 0:00:00 2025-10-19 12:19:07.865308 | controller | Collecting certifi>=2017.4.17 2025-10-19 12:19:07.876079 | controller | Downloading certifi-2025.10.5-py3-none-any.whl (163 kB) 2025-10-19 12:19:07.885634 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 163.3/163.3 kB 23.0 MB/s eta 0:00:00 2025-10-19 12:19:07.967197 | controller | Collecting ansible-compat>=25.8.0 2025-10-19 12:19:07.978670 | controller | Downloading ansible_compat-25.8.1-py3-none-any.whl (27 kB) 2025-10-19 12:19:08.046107 | controller | Collecting click>=8.0.0 2025-10-19 12:19:08.056546 | controller | Downloading click-8.3.0-py3-none-any.whl (107 kB) 2025-10-19 12:19:08.065459 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 107.3/107.3 kB 15.6 MB/s eta 0:00:00 2025-10-19 12:19:08.088116 | controller | Collecting mypy-extensions>=0.4.3 2025-10-19 12:19:08.098770 | controller | Downloading mypy_extensions-1.1.0-py3-none-any.whl (5.0 kB) 2025-10-19 12:19:08.145856 | controller | Collecting platformdirs>=2 2025-10-19 12:19:08.156415 | controller | Downloading platformdirs-4.5.0-py3-none-any.whl (18 kB) 2025-10-19 12:19:08.184061 | controller | Collecting pytokens>=0.1.10 2025-10-19 12:19:08.196116 | controller | Downloading pytokens-0.2.0-py3-none-any.whl (12 kB) 2025-10-19 12:19:08.355032 | controller | Collecting MarkupSafe>=2.0 2025-10-19 12:19:08.365788 | 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:19:08.421774 | controller | Collecting jsonschema-specifications>=2023.03.6 2025-10-19 12:19:08.432279 | controller | Downloading jsonschema_specifications-2025.9.1-py3-none-any.whl (18 kB) 2025-10-19 12:19:09.196617 | controller | Collecting rpds-py>=0.7.1 2025-10-19 12:19:09.208179 | controller | Downloading rpds_py-0.27.1-cp311-cp311-manylinux_2_17_x86_64.manylinux2014_x86_64.whl (384 kB) 2025-10-19 12:19:09.220746 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 384.1/384.1 kB 40.9 MB/s eta 0:00:00 2025-10-19 12:19:09.281386 | controller | Collecting typing-extensions>=4.4.0 2025-10-19 12:19:09.292101 | controller | Downloading typing_extensions-4.15.0-py3-none-any.whl (44 kB) 2025-10-19 12:19:09.300218 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 44.6/44.6 kB 6.8 MB/s eta 0:00:00 2025-10-19 12:19:09.374626 | controller | Collecting bracex>=2.1.1 2025-10-19 12:19:09.385184 | controller | Downloading bracex-2.6-py3-none-any.whl (11 kB) 2025-10-19 12:19:09.453125 | controller | Collecting distro>=1.7 2025-10-19 12:19:09.465743 | controller | Downloading distro-1.9.0-py3-none-any.whl (20 kB) 2025-10-19 12:19:09.493136 | controller | Collecting Parsley 2025-10-19 12:19:09.504462 | controller | Downloading Parsley-1.3-py2.py3-none-any.whl (88 kB) 2025-10-19 12:19:09.515953 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 88.9/88.9 kB 12.5 MB/s eta 0:00:00 2025-10-19 12:19:09.871001 | controller | Collecting cffi>=2.0.0 2025-10-19 12:19:09.881892 | controller | Downloading cffi-2.0.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl (215 kB) 2025-10-19 12:19:09.892828 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 215.6/215.6 kB 25.6 MB/s eta 0:00:00 2025-10-19 12:19:09.961675 | controller | Collecting zipp>=3.20 2025-10-19 12:19:09.972110 | controller | Downloading zipp-3.23.0-py3-none-any.whl (10 kB) 2025-10-19 12:19:10.009107 | controller | Collecting pycparser 2025-10-19 12:19:10.019841 | controller | Downloading pycparser-2.23-py3-none-any.whl (118 kB) 2025-10-19 12:19:10.029078 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 118.1/118.1 kB 17.7 MB/s eta 0:00:00 2025-10-19 12:19:10.659770 | 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:19:15.765047 | 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:19:15.898629 | controller | 2025-10-19 12:19:16.344590 | controller | [notice] A new release of pip available: 22.2.2 -> 25.2 2025-10-19 12:19:16.344635 | controller | [notice] To update, run: pip install --upgrade pip 2025-10-19 12:19:16.344649 | controller | venv finish: getenv /home/zuul-worker/src/github.com/ansible-network/releases/.tox/venv after 18.00 seconds 2025-10-19 12:19:16.344763 | controller | venv start: developpkg /home/zuul-worker/src/github.com/ansible-network/releases 2025-10-19 12:19:16.344806 | controller | venv develop-inst: /home/zuul-worker/src/github.com/ansible-network/releases 2025-10-19 12:19:16.348969 | 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:19:16.349120 | 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:19:16.349670 | controller | [2216] /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:19:16.802226 | controller | Obtaining file:///home/zuul-worker/src/github.com/ansible-network/releases 2025-10-19 12:19:16.803171 | controller | Preparing metadata (setup.py): started 2025-10-19 12:19:18.825781 | controller | Preparing metadata (setup.py): finished with status 'done' 2025-10-19 12:19:18.851634 | 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:19:18.852669 | 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:19:18.853682 | 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:19:18.856036 | 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:19:18.865589 | 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:19:18.879292 | 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:19:18.880884 | 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:19:18.882628 | 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:19:18.899406 | 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:19:18.901279 | 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:19:18.902786 | 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:19:18.904279 | 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:19:19.376990 | controller | Installing collected packages: ansible-releases 2025-10-19 12:19:19.377529 | controller | Running setup.py develop for ansible-releases 2025-10-19 12:19:21.119064 | controller | Successfully installed ansible-releases-0.0.1.dev36 2025-10-19 12:19:21.144240 | controller | 2025-10-19 12:19:21.269382 | controller | [notice] A new release of pip available: 22.2.2 -> 25.2 2025-10-19 12:19:21.269421 | controller | [notice] To update, run: pip install --upgrade pip 2025-10-19 12:19:21.269439 | controller | venv finish: developpkg /home/zuul-worker/src/github.com/ansible-network/releases after 4.92 seconds 2025-10-19 12:19:21.269552 | controller | venv start: envreport 2025-10-19 12:19:21.269571 | 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:19:21.271037 | controller | [2246] /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:19:21.799648 | controller | venv finish: envreport after 0.53 seconds 2025-10-19 12:19:21.827605 | 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:19:21.827748 | controller | ___________________________________ summary ____________________________________ 2025-10-19 12:19:21.827764 | controller | venv: skipped tests 2025-10-19 12:19:21.827770 | controller | congratulations :) 2025-10-19 12:19:22.201436 | controller | ok: Runtime: 0:00:23.788358 2025-10-19 12:19:22.217634 | 2025-10-19 12:19:22.217890 | TASK [tox : Look for output] 2025-10-19 12:19:22.872809 | controller | ok 2025-10-19 12:19:22.885385 | 2025-10-19 12:19:22.885557 | TASK [tox : Return file comments to Zuul] 2025-10-19 12:19:22.974818 | controller | skipping: Conditional result was False 2025-10-19 12:19:23.033476 | 2025-10-19 12:19:23.033612 | TASK [Setup download-artifact-fork role] 2025-10-19 12:19:23.056884 | controller | ok 2025-10-19 12:19:23.082373 | 2025-10-19 12:19:23.082538 | TASK [download-artifact-fork : Parse inventory response] 2025-10-19 12:19:23.136306 | controller | ok 2025-10-19 12:19:23.146199 | 2025-10-19 12:19:23.146336 | TASK [download-artifact-fork : Fetch info from Zuul API] 2025-10-19 12:19:23.182620 | controller | skipping: Conditional result was False 2025-10-19 12:19:23.195215 | 2025-10-19 12:19:23.195397 | TASK [download-artifact-fork : Parse build response] 2025-10-19 12:19:23.222639 | controller | skipping: Conditional result was False 2025-10-19 12:19:23.235378 | 2025-10-19 12:19:23.235583 | TASK [download-artifact-fork : Ensure artifacts directory exists] 2025-10-19 12:19:23.817477 | controller | changed 2025-10-19 12:19:23.830075 | 2025-10-19 12:19:23.830246 | LOOP [download-artifact-fork : Download archive by type] 2025-10-19 12:19:23.901401 | controller | skipping: Conditional result was False 2025-10-19 12:19:23.901812 | controller | ok: All items complete 2025-10-19 12:19:23.901869 | 2025-10-19 12:19:25.365894 | controller | changed: OK (671904 bytes) 2025-10-19 12:19:25.392525 | 2025-10-19 12:19:25.392751 | TASK [deploy-artifacts : define __collections] 2025-10-19 12:19:25.430675 | controller | ok 2025-10-19 12:19:25.438443 | 2025-10-19 12:19:25.438535 | LOOP [deploy-artifacts : Create list of collections] 2025-10-19 12:19:25.480711 | controller | skipping: Conditional result was False 2025-10-19 12:19:25.531833 | controller | ok: 2025-10-19 12:19:25.531975 | controller | { 2025-10-19 12:19:25.532062 | controller | "branch": "main", 2025-10-19 12:19:25.532107 | controller | "change": "2503", 2025-10-19 12:19:25.532145 | controller | "job": "build-ansible-collection", 2025-10-19 12:19:25.532181 | controller | "metadata": { 2025-10-19 12:19:25.532245 | controller | "type": "ansible_collection", 2025-10-19 12:19:25.532283 | controller | "version": "6.1.0" 2025-10-19 12:19:25.532320 | controller | }, 2025-10-19 12:19:25.532353 | controller | "name": "community.vmware", 2025-10-19 12:19:25.532386 | controller | "patchset": "a8109ff7e07667d5c83462b3d0db49b4dcb23e17", 2025-10-19 12:19:25.532420 | controller | "project": "ansible-collections/community.vmware", 2025-10-19 12:19:25.532454 | controller | "url": "https://b6f5a760d1f0d76dad2d-8c72cc448e0e6bc348b468deac1eb71c.ssl.cf1.rackcdn.com/ansible/b87f5cb8b0114bf3b293fdb8cc1ba9bd/artifacts/community-vmware-6.1.0.tar.gz" 2025-10-19 12:19:25.532499 | controller | } 2025-10-19 12:19:25.551093 | 2025-10-19 12:19:25.551237 | TASK [deploy-artifacts : Install require-project collection using ansible-galaxy] 2025-10-19 12:19:28.550474 | controller | [ERROR]: Failed to resolve the requested dependencies map. Could not satisfy the following requirements: 2025-10-19 12:19:28.550637 | controller | * vmware.vmware:>=2.5.0 (dependency of community.vmware:6.1.0) 2025-10-19 12:19:28.550659 | 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==2.5.0 of type 'galaxy' from Galaxy>, parent=)] 2025-10-19 12:19:28.550674 | controller | 2025-10-19 12:19:28.550701 | controller | Starting galaxy collection install process 2025-10-19 12:19:28.716990 | controller | Process install dependency map 2025-10-19 12:19:28.717040 | 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:19:29.210737 | controller | ERROR 2025-10-19 12:19:29.211264 | controller | { 2025-10-19 12:19:29.211340 | controller | "delta": "0:00:02.644718", 2025-10-19 12:19:29.211386 | controller | "end": "2025-10-19 12:19:28.717474", 2025-10-19 12:19:29.211424 | controller | "msg": "non-zero return code", 2025-10-19 12:19:29.211459 | controller | "rc": 1, 2025-10-19 12:19:29.211494 | controller | "start": "2025-10-19 12:19:26.072756" 2025-10-19 12:19:29.211527 | controller | } failure 2025-10-19 12:19:29.215837 | 2025-10-19 12:19:29.215940 | PLAY RECAP 2025-10-19 12:19:29.216105 | controller | ok: 17 changed: 8 unreachable: 0 failed: 1 skipped: 18 rescued: 0 ignored: 0 2025-10-19 12:19:29.216173 | 2025-10-19 12:19:29.387600 | PRE-RUN END RESULT_NORMAL: [untrusted : github.com/ansible/ansible-zuul-jobs/playbooks/ansible-galaxy-importer/pre.yaml@master] 2025-10-19 12:19:29.388722 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2025-10-19 12:19:30.026172 | 2025-10-19 12:19:30.026430 | PLAY [all:!appliance*] 2025-10-19 12:19:30.048176 | 2025-10-19 12:19:30.048258 | TASK [unregister the node] 2025-10-19 12:19:30.189479 | controller | skipping: Conditional result was False 2025-10-19 12:19:30.203814 | 2025-10-19 12:19:30.203992 | TASK [include_role : fetch-output] 2025-10-19 12:19:30.257202 | controller | ok 2025-10-19 12:19:30.287148 | 2025-10-19 12:19:30.287453 | TASK [fetch-output : Set log path for multiple nodes] 2025-10-19 12:19:30.356619 | controller | skipping: Conditional result was False 2025-10-19 12:19:30.370732 | 2025-10-19 12:19:30.370932 | TASK [fetch-output : Set log path for single node] 2025-10-19 12:19:30.433331 | controller | ok 2025-10-19 12:19:30.444859 | 2025-10-19 12:19:30.445106 | LOOP [fetch-output : Ensure local output dirs] 2025-10-19 12:19:30.901633 | controller -> localhost | ok: "/var/lib/zuul/builds/3ec050a863734a49839ebd2549881155/work/logs" 2025-10-19 12:19:31.173729 | controller -> localhost | changed: "/var/lib/zuul/builds/3ec050a863734a49839ebd2549881155/work/artifacts" 2025-10-19 12:19:31.426304 | controller -> localhost | changed: "/var/lib/zuul/builds/3ec050a863734a49839ebd2549881155/work/docs" 2025-10-19 12:19:31.441764 | 2025-10-19 12:19:31.441939 | LOOP [fetch-output : Collect logs, artifacts and docs] 2025-10-19 12:19:32.699069 | controller | changed: .d..t...... ./ 2025-10-19 12:19:32.699421 | controller | changed: All items complete 2025-10-19 12:19:32.699478 | 2025-10-19 12:19:33.755120 | controller | changed: .d..t...... ./ 2025-10-19 12:19:34.801552 | controller | changed: .d..t...... ./ 2025-10-19 12:19:34.833257 | 2025-10-19 12:19:34.833454 | TASK [include_role : fetch-output-openshift] 2025-10-19 12:19:34.860605 | controller | skipping: Conditional result was False 2025-10-19 12:19:34.874127 | 2025-10-19 12:19:34.874270 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2025-10-19 12:19:35.371217 | controller -> localhost | ok: Item: artifacts Runtime: 0:00:00.014260 2025-10-19 12:19:35.658661 | controller -> localhost | ok: Item: docs Runtime: 0:00:00.012248 2025-10-19 12:19:35.690886 | 2025-10-19 12:19:35.690973 | PLAY [localhost] 2025-10-19 12:19:35.702385 | 2025-10-19 12:19:35.702444 | TASK [Run Zuul manifest role] 2025-10-19 12:19:35.720779 | localhost | ok 2025-10-19 12:19:35.732950 | 2025-10-19 12:19:35.733036 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2025-10-19 12:19:36.104816 | localhost | changed 2025-10-19 12:19:36.109331 | 2025-10-19 12:19:36.109396 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2025-10-19 12:19:36.148846 | localhost | ok 2025-10-19 12:19:36.156382 | 2025-10-19 12:19:36.156440 | TASK [Set zuul-log-path fact] 2025-10-19 12:19:36.173472 | localhost | ok 2025-10-19 12:19:36.186444 | 2025-10-19 12:19:36.186509 | TASK [set-zuul-log-path-fact : Set log path for a build] 2025-10-19 12:19:36.223553 | localhost | ok 2025-10-19 12:19:36.231179 | 2025-10-19 12:19:36.231235 | LOOP [Run upload-logs-swift role] 2025-10-19 12:19:36.275620 | localhost | Output suppressed because no_log was given 2025-10-19 12:19:36.298268 | 2025-10-19 12:19:36.298338 | TASK [Set zuul-log-path fact] 2025-10-19 12:19:36.331714 | localhost | skipping: Conditional result was False 2025-10-19 12:19:36.337838 | 2025-10-19 12:19:36.337911 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2025-10-19 12:19:36.651776 | localhost -> localhost | ok: Runtime: 0:00:00.004616 2025-10-19 12:19:36.656415 | 2025-10-19 12:19:36.656475 | TASK [upload-logs-swift : Upload logs to swift]