2026-03-16 19:50:47.568085 | Job console starting... 2026-03-16 19:50:47.579421 | Updating repositories 2026-03-16 19:50:48.537714 | Preparing job workspace 2026-03-16 19:50:50.516250 | Running Ansible setup... 2026-03-16 19:50:55.556189 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-03-16 19:50:56.201128 | 2026-03-16 19:50:56.201247 | PLAY [localhost] 2026-03-16 19:50:56.209986 | 2026-03-16 19:50:56.210075 | TASK [Gathering Facts] 2026-03-16 19:50:57.273579 | localhost | ok 2026-03-16 19:50:57.302790 | 2026-03-16 19:50:57.303016 | TASK [Setup log path fact] 2026-03-16 19:50:57.330274 | localhost | ok 2026-03-16 19:50:57.357980 | 2026-03-16 19:50:57.358129 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-16 19:50:57.412034 | localhost | ok 2026-03-16 19:50:57.430166 | 2026-03-16 19:50:57.430319 | TASK [emit-job-header : Print job information] 2026-03-16 19:50:57.483537 | # Job Information 2026-03-16 19:50:57.483826 | Ansible Version: 2.15.12 2026-03-16 19:50:57.483900 | Job: release-ansible-collection-automation-hub 2026-03-16 19:50:57.483951 | Pipeline: release 2026-03-16 19:50:57.483993 | Executor: ze03.softwarefactory-project.io 2026-03-16 19:50:57.484033 | Triggered by: https://github.com/ansible-collections/amazon.aws/releases/tag/10.3.0 2026-03-16 19:50:57.484079 | Log URL (when completed): https://ansible.softwarefactory-project.io/logs/4aa/ansible/4aa0d4e3f14f49c09841890baedaff7b/ 2026-03-16 19:50:57.484120 | Event ID: 57458486-2171-11f1-8882-7766e1ea773c 2026-03-16 19:50:57.492575 | 2026-03-16 19:50:57.492764 | LOOP [emit-job-header : Print node information] 2026-03-16 19:50:57.611326 | localhost | ok: 2026-03-16 19:50:57.611602 | localhost | # Node Information 2026-03-16 19:50:57.611661 | localhost | Inventory Hostname: controller 2026-03-16 19:50:57.611706 | localhost | Hostname: np0005649111 2026-03-16 19:50:57.611841 | localhost | Username: zuul 2026-03-16 19:50:57.611901 | localhost | Distro: Fedora 37 2026-03-16 19:50:57.611944 | localhost | Provider: ansible-vexxhost-ca-ymq-1 2026-03-16 19:50:57.611984 | localhost | Region: ca-ymq-1 2026-03-16 19:50:57.612023 | localhost | Label: ansible-fedora-37-1vcpu 2026-03-16 19:50:57.612066 | localhost | Product Name: OpenStack Nova 2026-03-16 19:50:57.612105 | localhost | Interface IP: 162.253.55.204 2026-03-16 19:50:57.630869 | 2026-03-16 19:50:57.631048 | TASK [log-inventory : Ensure Zuul Ansible directory exists] 2026-03-16 19:50:58.076257 | localhost -> localhost | changed 2026-03-16 19:50:58.083860 | 2026-03-16 19:50:58.083955 | TASK [log-inventory : Copy ansible inventory to logs dir] 2026-03-16 19:50:58.945109 | localhost -> localhost | changed 2026-03-16 19:50:58.964484 | 2026-03-16 19:50:58.964542 | PLAY [all:!appliance*] 2026-03-16 19:50:58.980243 | 2026-03-16 19:50:58.980304 | TASK [include_role : start-zuul-console] 2026-03-16 19:50:58.999584 | controller | ok 2026-03-16 19:50:59.012984 | 2026-03-16 19:50:59.013046 | TASK [start-zuul-console : Start zuul_console daemon.] 2026-03-16 19:50:59.381372 | controller | ok 2026-03-16 19:50:59.395170 | 2026-03-16 19:50:59.395294 | TASK [use-our-mirror : Retrieve the IP address] 2026-03-16 19:51:00.182023 | controller | ok: Status code was 404 and not [200]: HTTP Error 404: Not Found 2026-03-16 19:51:00.190798 | 2026-03-16 19:51:00.190920 | TASK [use-our-mirror : Ensure the registry service is running on the mirror] 2026-03-16 19:51:00.736488 | controller | skipping: Conditional result was False 2026-03-16 19:51:00.745025 | 2026-03-16 19:51:00.745116 | TASK [use-our-mirror : Write the IP in /etc/hosts] 2026-03-16 19:51:00.770366 | controller | skipping: Conditional result was False 2026-03-16 19:51:00.779600 | 2026-03-16 19:51:00.779705 | TASK [use-our-mirror : Create the podman configuration directory] 2026-03-16 19:51:00.805349 | controller | skipping: Conditional result was False 2026-03-16 19:51:00.814054 | 2026-03-16 19:51:00.814178 | TASK [use-our-mirror : Copy the podman configuration] 2026-03-16 19:51:00.840696 | controller | skipping: Conditional result was False 2026-03-16 19:51:00.847303 | 2026-03-16 19:51:00.847368 | TASK [use-our-mirror : Copy the Yum configuration (main)] 2026-03-16 19:51:00.871275 | controller | skipping: Conditional result was False 2026-03-16 19:51:00.877920 | 2026-03-16 19:51:00.877996 | TASK [use-our-mirror : Copy the Yum configuration (update)] 2026-03-16 19:51:00.901996 | controller | skipping: Conditional result was False 2026-03-16 19:51:00.919474 | 2026-03-16 19:51:00.919583 | TASK [Disable Fedora Modular] 2026-03-16 19:51:01.166132 | controller | changed 2026-03-16 19:51:01.174110 | 2026-03-16 19:51:01.174195 | TASK [Enable EPEL] 2026-03-16 19:51:01.209747 | controller | skipping: Conditional result was False 2026-03-16 19:51:01.225231 | 2026-03-16 19:51:01.225495 | TASK [Register the RHEL node] 2026-03-16 19:51:01.785124 | 2026-03-16 19:51:01.785318 | TASK [Show the subscription-manager status] 2026-03-16 19:51:02.351898 | controller | skipping: Conditional result was False 2026-03-16 19:51:02.365872 | 2026-03-16 19:51:02.366050 | TASK [Enable EPEL on RHEL] 2026-03-16 19:51:02.919633 | controller | skipping: Conditional result was False 2026-03-16 19:51:02.934072 | 2026-03-16 19:51:02.934234 | TASK [Install git and tox] 2026-03-16 19:52:22.612344 | controller | changed 2026-03-16 19:52:22.625680 | 2026-03-16 19:52:22.625892 | TASK [include_role : prepare-workspace] 2026-03-16 19:52:22.664567 | controller | ok 2026-03-16 19:52:22.702124 | 2026-03-16 19:52:22.702229 | TASK [prepare-workspace : Start zuul_console daemon.] 2026-03-16 19:52:22.961923 | controller | ok 2026-03-16 19:52:22.976035 | 2026-03-16 19:52:22.976182 | TASK [prepare-workspace : Synchronize src repos to workspace directory.] 2026-03-16 19:52:28.477975 | controller | Output suppressed because no_log was given 2026-03-16 19:52:28.500115 | 2026-03-16 19:52:28.500245 | TASK [include_role : prepare-workspace-openshift] 2026-03-16 19:52:28.527445 | controller | skipping: Conditional result was False 2026-03-16 19:52:28.569555 | 2026-03-16 19:52:28.569864 | PLAY [all:!appliance] 2026-03-16 19:52:28.591830 | 2026-03-16 19:52:28.591916 | TASK [Run add-build-sshkey role (RSA)] 2026-03-16 19:52:28.623900 | controller | ok 2026-03-16 19:52:28.643966 | 2026-03-16 19:52:28.644100 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-16 19:52:28.903705 | controller -> localhost | ok 2026-03-16 19:52:28.910502 | 2026-03-16 19:52:28.910607 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-16 19:52:28.949969 | controller | ok 2026-03-16 19:52:28.975252 | controller | included: /var/lib/zuul/builds/4aa0d4e3f14f49c09841890baedaff7b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-16 19:52:28.984127 | 2026-03-16 19:52:28.984218 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-16 19:52:29.549634 | controller -> localhost | Generating public/private rsa key pair. 2026-03-16 19:52:29.550075 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/4aa0d4e3f14f49c09841890baedaff7b/work/4aa0d4e3f14f49c09841890baedaff7b_id_rsa. 2026-03-16 19:52:29.550145 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/4aa0d4e3f14f49c09841890baedaff7b/work/4aa0d4e3f14f49c09841890baedaff7b_id_rsa.pub. 2026-03-16 19:52:29.550194 | controller -> localhost | The key fingerprint is: 2026-03-16 19:52:29.550241 | controller -> localhost | SHA256:MOOsaNDr9OezCXyCNId+BvF5RKKvhQxe/J3ypnZuWiQ zuul-build-sshkey 2026-03-16 19:52:29.550286 | controller -> localhost | The key's randomart image is: 2026-03-16 19:52:29.550331 | controller -> localhost | +---[RSA 2048]----+ 2026-03-16 19:52:29.550375 | controller -> localhost | | . . | 2026-03-16 19:52:29.550420 | controller -> localhost | | .. o | 2026-03-16 19:52:29.550467 | controller -> localhost | |. oo = | 2026-03-16 19:52:29.550558 | controller -> localhost | |.+.*.=.+. | 2026-03-16 19:52:29.550621 | controller -> localhost | |..O *E++S | 2026-03-16 19:52:29.550685 | controller -> localhost | | + @ o= | 2026-03-16 19:52:29.550803 | controller -> localhost | | O B .+ | 2026-03-16 19:52:29.550868 | controller -> localhost | | + + =*+ | 2026-03-16 19:52:29.550919 | controller -> localhost | | . o=O+ | 2026-03-16 19:52:29.550973 | controller -> localhost | +----[SHA256]-----+ 2026-03-16 19:52:29.551082 | controller -> localhost | ok: Runtime: 0:00:00.138729 2026-03-16 19:52:29.563819 | 2026-03-16 19:52:29.563934 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-16 19:52:29.597999 | controller | ok 2026-03-16 19:52:29.650107 | controller | included: /var/lib/zuul/builds/4aa0d4e3f14f49c09841890baedaff7b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-16 19:52:29.659531 | 2026-03-16 19:52:29.659621 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-16 19:52:29.673413 | controller | skipping: Conditional result was False 2026-03-16 19:52:29.680265 | 2026-03-16 19:52:29.680353 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-16 19:52:30.061718 | controller | changed 2026-03-16 19:52:30.078416 | 2026-03-16 19:52:30.078644 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-16 19:52:30.322272 | controller | ok 2026-03-16 19:52:30.330196 | 2026-03-16 19:52:30.330284 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-16 19:52:31.000260 | controller | changed 2026-03-16 19:52:31.013476 | 2026-03-16 19:52:31.013648 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-16 19:52:31.680571 | controller | changed 2026-03-16 19:52:31.694179 | 2026-03-16 19:52:31.694368 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-16 19:52:31.722451 | controller | skipping: Conditional result was False 2026-03-16 19:52:31.737947 | 2026-03-16 19:52:31.738088 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-16 19:52:32.102373 | controller -> localhost | changed 2026-03-16 19:52:32.114045 | 2026-03-16 19:52:32.114130 | TASK [add-build-sshkey : Add back temp key] 2026-03-16 19:52:32.383103 | controller -> localhost | Identity added: /var/lib/zuul/builds/4aa0d4e3f14f49c09841890baedaff7b/work/4aa0d4e3f14f49c09841890baedaff7b_id_rsa (zuul-build-sshkey) 2026-03-16 19:52:32.383331 | controller -> localhost | ok: Runtime: 0:00:00.007919 2026-03-16 19:52:32.391294 | 2026-03-16 19:52:32.391423 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-16 19:52:32.689950 | controller | ok 2026-03-16 19:52:32.697501 | 2026-03-16 19:52:32.697644 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-16 19:52:32.733504 | controller | skipping: Conditional result was False 2026-03-16 19:52:32.749326 | 2026-03-16 19:52:32.749463 | TASK [Run add-build-sshkey role (ECDSA)] 2026-03-16 19:52:32.792951 | controller | ok 2026-03-16 19:52:32.816316 | 2026-03-16 19:52:32.816447 | TASK [add-build-sshkey : Check to see if ssh key was already created for this build] 2026-03-16 19:52:33.065804 | controller -> localhost | ok 2026-03-16 19:52:33.079906 | 2026-03-16 19:52:33.080053 | TASK [add-build-sshkey : Create a new key in workspace based on build UUID] 2026-03-16 19:52:33.119511 | controller | ok 2026-03-16 19:52:33.142975 | controller | included: /var/lib/zuul/builds/4aa0d4e3f14f49c09841890baedaff7b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/create-key-and-replace.yaml 2026-03-16 19:52:33.154478 | 2026-03-16 19:52:33.154583 | TASK [add-build-sshkey : Create Temp SSH key] 2026-03-16 19:52:33.457518 | controller -> localhost | Generating public/private ecdsa key pair. 2026-03-16 19:52:33.457946 | controller -> localhost | Your identification has been saved in /var/lib/zuul/builds/4aa0d4e3f14f49c09841890baedaff7b/work/4aa0d4e3f14f49c09841890baedaff7b_id_ecdsa. 2026-03-16 19:52:33.458017 | controller -> localhost | Your public key has been saved in /var/lib/zuul/builds/4aa0d4e3f14f49c09841890baedaff7b/work/4aa0d4e3f14f49c09841890baedaff7b_id_ecdsa.pub. 2026-03-16 19:52:33.458079 | controller -> localhost | The key fingerprint is: 2026-03-16 19:52:33.458165 | controller -> localhost | SHA256:JQ6YSBKDGddwhtpvuXzLCmGNeXnXzz1SsgDvBh/D5IE zuul-build-sshkey 2026-03-16 19:52:33.458253 | controller -> localhost | The key's randomart image is: 2026-03-16 19:52:33.458309 | controller -> localhost | +---[ECDSA 521]---+ 2026-03-16 19:52:33.458354 | controller -> localhost | |*+++o | 2026-03-16 19:52:33.458395 | controller -> localhost | |o=.+.o . | 2026-03-16 19:52:33.458436 | controller -> localhost | | o. o . E + | 2026-03-16 19:52:33.458475 | controller -> localhost | |. .+ . o X . | 2026-03-16 19:52:33.458514 | controller -> localhost | | =.+.. S O . . | 2026-03-16 19:52:33.458554 | controller -> localhost | | . o+. . + * = | 2026-03-16 19:52:33.458592 | controller -> localhost | | .o . + = o | 2026-03-16 19:52:33.458630 | controller -> localhost | | .o.. . . . | 2026-03-16 19:52:33.458721 | controller -> localhost | | .oo. | 2026-03-16 19:52:33.458851 | controller -> localhost | +----[SHA256]-----+ 2026-03-16 19:52:33.458984 | controller -> localhost | ok: Runtime: 0:00:00.014445 2026-03-16 19:52:33.473992 | 2026-03-16 19:52:33.474160 | TASK [add-build-sshkey : Remote setup ssh keys (linux)] 2026-03-16 19:52:33.510719 | controller | ok 2026-03-16 19:52:33.521069 | controller | included: /var/lib/zuul/builds/4aa0d4e3f14f49c09841890baedaff7b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/add-build-sshkey/tasks/remote-linux.yaml 2026-03-16 19:52:33.534854 | 2026-03-16 19:52:33.535009 | TASK [add-build-sshkey : Remove previously added zuul-build-sshkey] 2026-03-16 19:52:33.561417 | controller | skipping: Conditional result was False 2026-03-16 19:52:33.571875 | 2026-03-16 19:52:33.571980 | TASK [add-build-sshkey : Enable access via build key on all nodes] 2026-03-16 19:52:33.867660 | controller | changed 2026-03-16 19:52:33.881938 | 2026-03-16 19:52:33.882071 | TASK [add-build-sshkey : Make sure user has a .ssh] 2026-03-16 19:52:34.115695 | controller | ok 2026-03-16 19:52:34.129130 | 2026-03-16 19:52:34.129319 | TASK [add-build-sshkey : Install build private key as SSH key on all nodes] 2026-03-16 19:52:34.774604 | controller | changed 2026-03-16 19:52:34.789204 | 2026-03-16 19:52:34.789347 | TASK [add-build-sshkey : Install build public key as SSH key on all nodes] 2026-03-16 19:52:35.429027 | controller | changed 2026-03-16 19:52:35.437630 | 2026-03-16 19:52:35.437754 | TASK [add-build-sshkey : Remote setup ssh keys (windows)] 2026-03-16 19:52:35.463857 | controller | skipping: Conditional result was False 2026-03-16 19:52:35.474151 | 2026-03-16 19:52:35.474287 | TASK [remove-zuul-sshkey : Remove master key from local agent] 2026-03-16 19:52:35.759923 | controller -> localhost | changed 2026-03-16 19:52:35.800830 | 2026-03-16 19:52:35.800965 | TASK [add-build-sshkey : Add back temp key] 2026-03-16 19:52:36.118829 | controller -> localhost | Identity added: /var/lib/zuul/builds/4aa0d4e3f14f49c09841890baedaff7b/work/4aa0d4e3f14f49c09841890baedaff7b_id_ecdsa (zuul-build-sshkey) 2026-03-16 19:52:36.119216 | controller -> localhost | ok: Runtime: 0:00:00.013895 2026-03-16 19:52:36.133559 | 2026-03-16 19:52:36.133696 | TASK [add-build-sshkey : Verify we can still SSH to all nodes] 2026-03-16 19:52:36.357149 | controller | ok 2026-03-16 19:52:36.368843 | 2026-03-16 19:52:36.368975 | TASK [add-build-sshkey : Verify we can still SSH to all nodes (windows)] 2026-03-16 19:52:36.405857 | controller | skipping: Conditional result was False 2026-03-16 19:52:36.431130 | 2026-03-16 19:52:36.431478 | TASK [include_role : remove-zuul-sshkey] 2026-03-16 19:52:36.449679 | controller | skipping: Conditional result was False 2026-03-16 19:52:36.462787 | 2026-03-16 19:52:36.462951 | LOOP [ensure-output-dirs : Empty Zuul Output directories by removing them] 2026-03-16 19:52:36.668890 | controller | ok: "logs" 2026-03-16 19:52:36.669125 | controller | ok: All items complete 2026-03-16 19:52:36.669154 | 2026-03-16 19:52:36.869650 | controller | ok: "artifacts" 2026-03-16 19:52:37.080034 | controller | ok: "docs" 2026-03-16 19:52:37.096274 | 2026-03-16 19:52:37.096395 | LOOP [ensure-output-dirs : Ensure Zuul Output directories exist] 2026-03-16 19:52:37.338798 | controller | changed: "logs" 2026-03-16 19:52:37.530510 | controller | changed: "artifacts" 2026-03-16 19:52:37.727465 | controller | changed: "docs" 2026-03-16 19:52:37.794237 | 2026-03-16 19:52:37.794351 | PLAY RECAP 2026-03-16 19:52:37.794395 | controller | ok: 30 changed: 16 unreachable: 0 failed: 0 skipped: 18 rescued: 0 ignored: 0 2026-03-16 19:52:37.794425 | localhost | ok: 6 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-16 19:52:37.794451 | 2026-03-16 19:52:37.896790 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/base/pre.yaml@master] 2026-03-16 19:52:37.897535 | PRE-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/ansible-collection/pre.yaml@master] 2026-03-16 19:52:38.489499 | 2026-03-16 19:52:38.489609 | PLAY [controller] 2026-03-16 19:52:38.510840 | 2026-03-16 19:52:38.510979 | TASK [Run bindep role] 2026-03-16 19:52:38.530366 | controller | ok 2026-03-16 19:52:38.550296 | 2026-03-16 19:52:38.550411 | TASK [bindep : Include find tasks] 2026-03-16 19:52:38.589506 | controller | ok 2026-03-16 19:52:38.597151 | controller | included: /var/lib/zuul/builds/4aa0d4e3f14f49c09841890baedaff7b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find.yaml 2026-03-16 19:52:38.603877 | 2026-03-16 19:52:38.603954 | TASK [bindep : Look for bindep.txt] 2026-03-16 19:52:39.018627 | controller | ok 2026-03-16 19:52:39.032014 | 2026-03-16 19:52:39.032166 | TASK [bindep : Define bindep_file fact] 2026-03-16 19:52:39.082054 | controller | ok 2026-03-16 19:52:39.094504 | 2026-03-16 19:52:39.094661 | TASK [bindep : Look for other-requirements.txt] 2026-03-16 19:52:39.121901 | controller | skipping: Conditional result was False 2026-03-16 19:52:39.135418 | 2026-03-16 19:52:39.135572 | TASK [bindep : Define bindep_file fact] 2026-03-16 19:52:39.173267 | controller | skipping: Conditional result was False 2026-03-16 19:52:39.186799 | 2026-03-16 19:52:39.186944 | TASK [bindep : Look for bindep fallback file] 2026-03-16 19:52:39.224357 | controller | skipping: Conditional result was False 2026-03-16 19:52:39.239809 | 2026-03-16 19:52:39.239966 | TASK [bindep : Define bindep_file fact] 2026-03-16 19:52:39.277709 | controller | skipping: Conditional result was False 2026-03-16 19:52:39.291185 | 2026-03-16 19:52:39.291322 | TASK [bindep : Include bindep tasks] 2026-03-16 19:52:39.341541 | controller | ok 2026-03-16 19:52:39.357866 | controller | included: /var/lib/zuul/builds/4aa0d4e3f14f49c09841890baedaff7b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/find-bindep.yaml 2026-03-16 19:52:39.372702 | 2026-03-16 19:52:39.372807 | TASK [bindep : Look for bindep command] 2026-03-16 19:52:39.408282 | controller | skipping: Conditional result was False 2026-03-16 19:52:39.417442 | 2026-03-16 19:52:39.417531 | TASK [bindep : Check for system bindep] 2026-03-16 19:52:39.959884 | controller | ok: Runtime: 0:00:00.004772 2026-03-16 19:52:39.973695 | 2026-03-16 19:52:39.973869 | TASK [bindep : Define bindep_command fact] 2026-03-16 19:52:40.011883 | controller | skipping: Conditional result was False 2026-03-16 19:52:40.020649 | 2026-03-16 19:52:40.020771 | TASK [bindep : Include install tasks] 2026-03-16 19:52:40.068364 | controller | ok 2026-03-16 19:52:40.084551 | controller | included: /var/lib/zuul/builds/4aa0d4e3f14f49c09841890baedaff7b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/install.yaml 2026-03-16 19:52:40.105789 | 2026-03-16 19:52:40.105929 | TASK [bindep : Create temp dir for bindep] 2026-03-16 19:52:40.452246 | controller | changed 2026-03-16 19:52:40.466986 | 2026-03-16 19:52:40.467145 | TASK [Ensure we have pip dependencies] 2026-03-16 19:52:40.496571 | controller | ok 2026-03-16 19:52:40.537121 | 2026-03-16 19:52:40.537230 | TASK [ensure-pip : Check if pip is installed] 2026-03-16 19:52:40.794369 | controller | /usr/bin/pip3 2026-03-16 19:52:40.803324 | controller | /usr/bin/python3: No module named wheel 2026-03-16 19:52:41.071923 | controller | ok: Runtime: 0:00:00.018392 2026-03-16 19:52:41.086220 | 2026-03-16 19:52:41.086385 | LOOP [ensure-pip : Install pip from packages] 2026-03-16 19:52:41.139249 | controller | ok: "/var/lib/zuul/builds/4aa0d4e3f14f49c09841890baedaff7b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml" 2026-03-16 19:52:41.158335 | controller | included: /var/lib/zuul/builds/4aa0d4e3f14f49c09841890baedaff7b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/ensure-pip/tasks/RedHat.yaml 2026-03-16 19:52:41.208866 | 2026-03-16 19:52:41.208996 | TASK [ensure-pip : Install Python 3 pip] 2026-03-16 19:52:45.297426 | controller | ok: Nothing to do 2026-03-16 19:52:45.311762 | 2026-03-16 19:52:45.311959 | TASK [ensure-pip : Install Python3-wheel on older CentOS] 2026-03-16 19:52:45.360625 | controller | skipping: Conditional result was False 2026-03-16 19:52:45.375097 | 2026-03-16 19:52:45.375223 | TASK [ensure-pip : Check for EPEL repository] 2026-03-16 19:52:45.442282 | controller | skipping: Conditional result was False 2026-03-16 19:52:45.453232 | 2026-03-16 19:52:45.453387 | TASK [ensure-pip : Fail with instructions when EPEL is not installed] 2026-03-16 19:52:45.512861 | controller | skipping: Conditional result was False 2026-03-16 19:52:45.524582 | 2026-03-16 19:52:45.524754 | TASK [ensure-pip : Install Python 2 pip] 2026-03-16 19:52:45.580234 | controller | skipping: Conditional result was False 2026-03-16 19:52:45.595453 | 2026-03-16 19:52:45.595611 | TASK [ensure-pip : Ensure setuptools] 2026-03-16 19:52:45.612517 | controller | skipping: Conditional result was False 2026-03-16 19:52:45.622485 | 2026-03-16 19:52:45.622636 | TASK [ensure-pip : Check for ensurepip module] 2026-03-16 19:52:46.174431 | controller | skipping: Conditional result was False 2026-03-16 19:52:46.191472 | 2026-03-16 19:52:46.191804 | TASK [ensure-pip : Ensure python3-venv] 2026-03-16 19:52:46.220830 | controller | skipping: Conditional result was False 2026-03-16 19:52:46.233024 | 2026-03-16 19:52:46.233236 | TASK [ensure-pip : Install pip from source] 2026-03-16 19:52:46.261937 | controller | skipping: Conditional result was False 2026-03-16 19:52:46.278114 | 2026-03-16 19:52:46.278369 | TASK [ensure-pip : Probe for venv python full path] 2026-03-16 19:52:46.554970 | controller | /usr/bin/python3 2026-03-16 19:52:46.833975 | controller | ok: Runtime: 0:00:00.002911 2026-03-16 19:52:46.847883 | 2026-03-16 19:52:46.848085 | TASK [ensure-pip : Set host default] 2026-03-16 19:52:46.928087 | controller | ok 2026-03-16 19:52:46.941584 | 2026-03-16 19:52:46.941803 | TASK [ensure-pip : Set ensure_pip_virtualenv_command] 2026-03-16 19:52:47.025476 | controller | ok 2026-03-16 19:52:47.048915 | 2026-03-16 19:52:47.049076 | TASK [bindep : Install bindep into temporary venv] 2026-03-16 19:53:45.805001 | controller | changed 2026-03-16 19:53:45.817905 | 2026-03-16 19:53:45.818092 | TASK [bindep : Define bindep_command] 2026-03-16 19:53:45.867141 | controller | ok 2026-03-16 19:53:45.880004 | 2026-03-16 19:53:45.880172 | LOOP [bindep : Include package tasks] 2026-03-16 19:53:45.946251 | controller | ok: "src/github.com/ansible-collections/amazon.aws/bindep.txt" 2026-03-16 19:53:45.946618 | controller | ok: All items complete 2026-03-16 19:53:45.946684 | 2026-03-16 19:53:45.965091 | controller | included: /var/lib/zuul/builds/4aa0d4e3f14f49c09841890baedaff7b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/bindep/tasks/packages.yaml 2026-03-16 19:53:45.990908 | 2026-03-16 19:53:45.991127 | TASK [bindep : Define bindep_run fact] 2026-03-16 19:53:46.117644 | controller | ok 2026-03-16 19:53:46.124872 | 2026-03-16 19:53:46.124958 | TASK [bindep : Get list of packages to install from bindep] 2026-03-16 19:53:46.839538 | controller | gcc 2026-03-16 19:53:47.160083 | controller | ok: Runtime: 0:00:00.639925 2026-03-16 19:53:47.166234 | 2026-03-16 19:53:47.166310 | TASK [bindep : Install distro packages from bindep] 2026-03-16 19:53:56.561031 | controller | changed 2026-03-16 19:53:56.574283 | 2026-03-16 19:53:56.574446 | TASK [bindep : Check that packages are installed] 2026-03-16 19:53:57.627938 | controller | ok: Runtime: 0:00:00.595127 2026-03-16 19:53:57.641178 | 2026-03-16 19:53:57.641315 | TASK [bindep : Fail if we cannot install all packages] 2026-03-16 19:53:57.679018 | controller | skipping: Conditional result was False 2026-03-16 19:53:57.705221 | 2026-03-16 19:53:57.705426 | TASK [Ensure ansible-core is installed on the controller] 2026-03-16 19:54:02.354033 | controller | changed 2026-03-16 19:54:02.362608 | 2026-03-16 19:54:02.362772 | TASK [Run revoke-sudo role] 2026-03-16 19:54:02.388885 | controller | ok 2026-03-16 19:54:02.418032 | 2026-03-16 19:54:02.418186 | TASK [revoke-sudo : Check if zuul is sudoer] 2026-03-16 19:54:02.955836 | controller | ok: Runtime: 0:00:00.013978 2026-03-16 19:54:02.970959 | 2026-03-16 19:54:02.971153 | TASK [revoke-sudo : Remove sudo access for zuul user.] 2026-03-16 19:54:03.525973 | controller | ok: Runtime: 0:00:00.002817 2026-03-16 19:54:03.540404 | 2026-03-16 19:54:03.540606 | TASK [revoke-sudo : Prove that general sudo access is actually revoked.] 2026-03-16 19:54:03.794221 | controller | sudo: a password is required 2026-03-16 19:54:04.097166 | controller | ok: Runtime: 0:00:00.009005 2026-03-16 19:54:04.142394 | 2026-03-16 19:54:04.142568 | TASK [bindep : Remove bindep temp dir] 2026-03-16 19:54:04.542792 | controller | ok 2026-03-16 19:54:04.589904 | 2026-03-16 19:54:04.590081 | PLAY RECAP 2026-03-16 19:54:04.590143 | controller | ok: 25 changed: 9 unreachable: 0 failed: 0 skipped: 15 rescued: 0 ignored: 0 2026-03-16 19:54:04.590171 | 2026-03-16 19:54:04.680882 | PRE-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/ansible-collection/pre.yaml@master] 2026-03-16 19:54:04.681663 | RUN START: [trusted : github.com/ansible/zuul-config/playbooks/ansible-collection/run-pre.yaml@master] 2026-03-16 19:54:05.313215 | 2026-03-16 19:54:05.313368 | PLAY [all] 2026-03-16 19:54:05.335193 | 2026-03-16 19:54:05.335286 | TASK [Setup tox role] 2026-03-16 19:54:05.356779 | controller | ok 2026-03-16 19:54:05.378619 | 2026-03-16 19:54:05.378772 | TASK [tox : Check to see if the constraints file exists] 2026-03-16 19:54:05.423408 | controller | skipping: Conditional result was False 2026-03-16 19:54:05.433450 | 2026-03-16 19:54:05.433570 | TASK [tox : Fail if constraints file is missing] 2026-03-16 19:54:05.459780 | controller | skipping: Conditional result was False 2026-03-16 19:54:05.470395 | 2026-03-16 19:54:05.470497 | TASK [tox : Record file location] 2026-03-16 19:54:05.494755 | controller | skipping: Conditional result was False 2026-03-16 19:54:05.500928 | 2026-03-16 19:54:05.501001 | TASK [tox : Install tox siblings] 2026-03-16 19:54:05.516503 | controller | skipping: Conditional result was False 2026-03-16 19:54:05.525051 | 2026-03-16 19:54:05.525122 | TASK [tox : Emit tox command] 2026-03-16 19:54:05.557295 | tox -egenerate_collection_version -vv --notest 2026-03-16 19:54:05.565964 | 2026-03-16 19:54:05.566070 | TASK [tox : Run tox] 2026-03-16 19:54:06.049097 | controller | using tox.ini: /home/zuul/src/github.com/ansible-network/releases/tox.ini (pid 2834) 2026-03-16 19:54:06.056340 | controller | using tox-3.28.0 from /usr/lib/python3.11/site-packages/tox/__init__.py (pid 2834) 2026-03-16 19:54:06.056731 | controller | skipping sdist step 2026-03-16 19:54:06.056747 | controller | generate_collection_version uses /usr/bin/python3 2026-03-16 19:54:06.078787 | controller | generate_collection_version start: getenv /home/zuul/src/github.com/ansible-network/releases/.tox/generate_collection_version 2026-03-16 19:54:06.078958 | controller | generate_collection_version cannot reuse: no previous config /home/zuul/src/github.com/ansible-network/releases/.tox/generate_collection_version/.tox-config1 2026-03-16 19:54:06.078970 | controller | generate_collection_version create: /home/zuul/src/github.com/ansible-network/releases/.tox/generate_collection_version 2026-03-16 19:54:06.078978 | controller | setting PATH=/home/zuul/src/github.com/ansible-network/releases/.tox/generate_collection_version/bin:/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin 2026-03-16 19:54:06.078988 | controller | [2842] /home/zuul/src/github.com/ansible-network/releases/.tox$ /usr/bin/python3 -m virtualenv --no-download --python /usr/bin/python3 generate_collection_version 2026-03-16 19:54:06.592509 | controller | created virtual environment CPython3.11.0.final.0-64 in 434ms 2026-03-16 19:54:06.608346 | controller | creator CPython3Posix(dest=/home/zuul/src/github.com/ansible-network/releases/.tox/generate_collection_version, clear=False, no_vcs_ignore=False, global=False) 2026-03-16 19:54:06.608375 | controller | seeder FromAppData(extra_search_dir=/usr/share/python-wheels,download=False, pip=bundle, setuptools=bundle, wheel=bundle, via=copy, app_data_dir=/home/zuul/.local/share/virtualenv) 2026-03-16 19:54:06.608380 | controller | added seed packages: pip==22.2.2, setuptools==62.6.0, wheel==0.37.1 2026-03-16 19:54:06.608388 | controller | activators BashActivator,CShellActivator,FishActivator,NushellActivator,PowerShellActivator,PythonActivator 2026-03-16 19:54:06.608398 | controller | generate_collection_version installdeps: ansible-core, pbr, ruamel.yaml 2026-03-16 19:54:06.608795 | controller | setting PATH=/home/zuul/src/github.com/ansible-network/releases/.tox/generate_collection_version/bin:/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin 2026-03-16 19:54:06.609083 | controller | [2850] /home/zuul/src/github.com/ansible-network/releases$ /home/zuul/src/github.com/ansible-network/releases/.tox/generate_collection_version/bin/pip install ansible-core pbr ruamel.yaml 2026-03-16 19:54:20.013905 | controller | Collecting ansible-core 2026-03-16 19:54:32.151663 | controller | Downloading ansible_core-2.19.7-py3-none-any.whl (2.4 MB) 2026-03-16 19:54:32.224970 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 2.4/2.4 MB 34.7 MB/s eta 0:00:00 2026-03-16 19:54:32.290799 | controller | Collecting pbr 2026-03-16 19:54:32.292037 | controller | Using cached pbr-7.0.3-py2.py3-none-any.whl (131 kB) 2026-03-16 19:54:32.666525 | controller | Collecting ruamel.yaml 2026-03-16 19:54:32.670128 | controller | Downloading ruamel_yaml-0.19.1-py3-none-any.whl (118 kB) 2026-03-16 19:54:32.680691 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 118.1/118.1 kB 18.5 MB/s eta 0:00:00 2026-03-16 19:54:32.721010 | controller | Collecting jinja2>=3.1.0 2026-03-16 19:54:32.724672 | controller | Downloading jinja2-3.1.6-py3-none-any.whl (134 kB) 2026-03-16 19:54:32.732399 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 134.9/134.9 kB 24.7 MB/s eta 0:00:00 2026-03-16 19:54:32.835072 | controller | Collecting PyYAML>=5.1 2026-03-16 19:54:32.839541 | controller | Downloading pyyaml-6.0.3-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (806 kB) 2026-03-16 19:54:32.857459 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 806.6/806.6 kB 52.7 MB/s eta 0:00:00 2026-03-16 19:54:33.378565 | controller | Collecting cryptography 2026-03-16 19:54:33.383487 | controller | Downloading cryptography-46.0.5-cp311-abi3-manylinux_2_34_x86_64.whl (4.5 MB) 2026-03-16 19:54:33.434150 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 4.5/4.5 MB 92.9 MB/s eta 0:00:00 2026-03-16 19:54:33.482216 | controller | Collecting packaging 2026-03-16 19:54:33.483327 | controller | Using cached packaging-26.0-py3-none-any.whl (74 kB) 2026-03-16 19:54:33.509491 | controller | Collecting resolvelib<2.0.0,>=0.5.3 2026-03-16 19:54:33.514331 | controller | Downloading resolvelib-1.2.1-py3-none-any.whl (18 kB) 2026-03-16 19:54:33.525608 | controller | Requirement already satisfied: setuptools in ./.tox/generate_collection_version/lib/python3.11/site-packages (from pbr) (62.6.0) 2026-03-16 19:54:33.677297 | controller | Collecting MarkupSafe>=2.0 2026-03-16 19:54:33.680523 | controller | Downloading markupsafe-3.0.3-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (22 kB) 2026-03-16 19:54:34.032740 | controller | Collecting cffi>=2.0.0 2026-03-16 19:54:34.037072 | controller | Downloading cffi-2.0.0-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.whl (215 kB) 2026-03-16 19:54:34.046044 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 215.6/215.6 kB 32.0 MB/s eta 0:00:00 2026-03-16 19:54:34.068648 | controller | Collecting pycparser 2026-03-16 19:54:34.071897 | controller | Downloading pycparser-3.0-py3-none-any.whl (48 kB) 2026-03-16 19:54:34.076461 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 48.2/48.2 kB 14.4 MB/s eta 0:00:00 2026-03-16 19:54:34.199004 | controller | Installing collected packages: ruamel.yaml, resolvelib, PyYAML, pycparser, pbr, packaging, MarkupSafe, jinja2, cffi, cryptography, ansible-core 2026-03-16 19:54:36.166942 | controller | Successfully installed MarkupSafe-3.0.3 PyYAML-6.0.3 ansible-core-2.19.7 cffi-2.0.0 cryptography-46.0.5 jinja2-3.1.6 packaging-26.0 pbr-7.0.3 pycparser-3.0 resolvelib-1.2.1 ruamel.yaml-0.19.1 2026-03-16 19:54:46.570853 | controller | 2026-03-16 19:54:46.735535 | controller | [notice] A new release of pip available: 22.2.2 -> 26.0.1 2026-03-16 19:54:46.735578 | controller | [notice] To update, run: pip install --upgrade pip 2026-03-16 19:54:46.735604 | controller | generate_collection_version finish: getenv /home/zuul/src/github.com/ansible-network/releases/.tox/generate_collection_version after 40.66 seconds 2026-03-16 19:54:46.738889 | controller | generate_collection_version start: developpkg /home/zuul/src/github.com/ansible-network/releases 2026-03-16 19:54:46.738908 | controller | generate_collection_version develop-inst: /home/zuul/src/github.com/ansible-network/releases 2026-03-16 19:54:46.738922 | controller | write config to /home/zuul/src/github.com/ansible-network/releases/.tox/generate_collection_version/.tox-config1 as '9a414b33f86621a975414472b7b34d2b36210a3017dd988b50f2da89f7d8fd1c /usr/bin/python3\n3.28.0 0 1 0\n00000000000000000000000000000000 ansible-core\n00000000000000000000000000000000 pbr\n00000000000000000000000000000000 ruamel.yaml' 2026-03-16 19:54:46.739119 | controller | setting PATH=/home/zuul/src/github.com/ansible-network/releases/.tox/generate_collection_version/bin:/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin 2026-03-16 19:54:46.739747 | controller | [2865] /home/zuul/src/github.com/ansible-network/releases$ /home/zuul/src/github.com/ansible-network/releases/.tox/generate_collection_version/bin/pip install --exists-action w -e . 2026-03-16 19:54:47.036435 | controller | Obtaining file:///home/zuul/src/github.com/ansible-network/releases 2026-03-16 19:54:47.037088 | controller | Preparing metadata (setup.py): started 2026-03-16 19:54:48.743906 | controller | Preparing metadata (setup.py): finished with status 'done' 2026-03-16 19:54:48.754738 | controller | Requirement already satisfied: ruamel.yaml in ./.tox/generate_collection_version/lib/python3.11/site-packages (from ansible-releases==0.0.1.dev36) (0.19.1) 2026-03-16 19:54:48.755602 | controller | Requirement already satisfied: pbr in ./.tox/generate_collection_version/lib/python3.11/site-packages (from ansible-releases==0.0.1.dev36) (7.0.3) 2026-03-16 19:54:58.816566 | controller | Collecting tweepy 2026-03-16 19:55:23.013655 | controller | Downloading tweepy-4.16.0-py3-none-any.whl (98 kB) 2026-03-16 19:55:23.041005 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 98.8/98.8 kB 4.1 MB/s eta 0:00:00 2026-03-16 19:55:23.047769 | controller | Requirement already satisfied: setuptools in ./.tox/generate_collection_version/lib/python3.11/site-packages (from pbr->ansible-releases==0.0.1.dev36) (62.6.0) 2026-03-16 19:55:23.093412 | controller | Collecting oauthlib<4,>=3.2.0 2026-03-16 19:55:23.097568 | controller | Downloading oauthlib-3.3.1-py3-none-any.whl (160 kB) 2026-03-16 19:55:23.109265 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 160.1/160.1 kB 17.7 MB/s eta 0:00:00 2026-03-16 19:55:23.178076 | controller | Collecting requests<3,>=2.27.0 2026-03-16 19:55:23.181769 | controller | Downloading requests-2.32.5-py3-none-any.whl (64 kB) 2026-03-16 19:55:23.188927 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 64.7/64.7 kB 12.3 MB/s eta 0:00:00 2026-03-16 19:55:23.216809 | controller | Collecting requests-oauthlib<3,>=1.2.0 2026-03-16 19:55:23.220128 | controller | Downloading requests_oauthlib-2.0.0-py2.py3-none-any.whl (24 kB) 2026-03-16 19:55:23.495545 | controller | Collecting charset_normalizer<4,>=2 2026-03-16 19:55:23.499182 | controller | Downloading charset_normalizer-3.4.6-cp311-cp311-manylinux2014_x86_64.manylinux_2_17_x86_64.manylinux_2_28_x86_64.whl (204 kB) 2026-03-16 19:55:23.510208 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 204.7/204.7 kB 26.3 MB/s eta 0:00:00 2026-03-16 19:55:23.541905 | controller | Collecting idna<4,>=2.5 2026-03-16 19:55:23.545169 | controller | Downloading idna-3.11-py3-none-any.whl (71 kB) 2026-03-16 19:55:23.551575 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 71.0/71.0 kB 14.5 MB/s eta 0:00:00 2026-03-16 19:55:23.617718 | controller | Collecting urllib3<3,>=1.21.1 2026-03-16 19:55:23.621056 | controller | Downloading urllib3-2.6.3-py3-none-any.whl (131 kB) 2026-03-16 19:55:23.628906 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 131.6/131.6 kB 24.9 MB/s eta 0:00:00 2026-03-16 19:55:23.672722 | controller | Collecting certifi>=2017.4.17 2026-03-16 19:55:23.676004 | controller | Downloading certifi-2026.2.25-py3-none-any.whl (153 kB) 2026-03-16 19:55:23.683718 | controller | ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ 153.7/153.7 kB 29.2 MB/s eta 0:00:00 2026-03-16 19:55:23.884926 | controller | Installing collected packages: urllib3, oauthlib, idna, charset_normalizer, certifi, requests, requests-oauthlib, tweepy, ansible-releases 2026-03-16 19:55:24.287178 | controller | Running setup.py develop for ansible-releases 2026-03-16 19:55:25.899414 | controller | Successfully installed ansible-releases-0.0.1.dev36 certifi-2026.2.25 charset_normalizer-3.4.6 idna-3.11 oauthlib-3.3.1 requests-2.32.5 requests-oauthlib-2.0.0 tweepy-4.16.0 urllib3-2.6.3 2026-03-16 19:55:25.913123 | controller | 2026-03-16 19:55:25.991721 | controller | [notice] A new release of pip available: 22.2.2 -> 26.0.1 2026-03-16 19:55:25.991767 | controller | [notice] To update, run: pip install --upgrade pip 2026-03-16 19:55:25.991782 | controller | generate_collection_version finish: developpkg /home/zuul/src/github.com/ansible-network/releases after 39.26 seconds 2026-03-16 19:55:25.992019 | controller | generate_collection_version start: envreport 2026-03-16 19:55:25.992028 | controller | setting PATH=/home/zuul/src/github.com/ansible-network/releases/.tox/generate_collection_version/bin:/home/zuul/.local/bin:/home/zuul/bin:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin 2026-03-16 19:55:25.994100 | controller | [2901] /home/zuul/src/github.com/ansible-network/releases$ /home/zuul/src/github.com/ansible-network/releases/.tox/generate_collection_version/bin/python -m pip freeze >.tox/generate_collection_version/log/generate_collection_version-0.log 2026-03-16 19:55:26.354056 | controller | generate_collection_version finish: envreport after 0.36 seconds 2026-03-16 19:55:26.354239 | controller | generate_collection_version installed: ansible-core==2.19.7,-e git+file:///dev/null@646b310655c531e4904be07f4ff8fc3a29addd09#egg=ansible_releases,certifi==2026.2.25,cffi==2.0.0,charset-normalizer==3.4.6,cryptography==46.0.5,idna==3.11,Jinja2==3.1.6,MarkupSafe==3.0.3,oauthlib==3.3.1,packaging==26.0,pbr==7.0.3,pycparser==3.0,PyYAML==6.0.3,requests==2.32.5,requests-oauthlib==2.0.0,resolvelib==1.2.1,ruamel.yaml==0.19.1,tweepy==4.16.0,urllib3==2.6.3 2026-03-16 19:55:26.354250 | controller | ___________________________________ summary ____________________________________ 2026-03-16 19:55:26.354267 | controller | generate_collection_version: skipped tests 2026-03-16 19:55:26.354274 | controller | congratulations :) 2026-03-16 19:55:26.635444 | controller | ok: Runtime: 0:01:20.452240 2026-03-16 19:55:26.650908 | 2026-03-16 19:55:26.651104 | TASK [tox : Look for output] 2026-03-16 19:55:27.042788 | controller | ok 2026-03-16 19:55:27.058825 | 2026-03-16 19:55:27.059077 | TASK [tox : Return file comments to Zuul] 2026-03-16 19:55:27.118592 | controller | skipping: Conditional result was False 2026-03-16 19:55:27.134689 | 2026-03-16 19:55:27.134854 | TASK [Generate version number for ansible collection.] 2026-03-16 19:55:27.619488 | controller | amazon-aws-10.3.0.tar.gz 2026-03-16 19:55:27.685820 | controller | ok: Runtime: 0:00:00.291280 2026-03-16 19:55:27.716851 | 2026-03-16 19:55:27.716966 | PLAY RECAP 2026-03-16 19:55:27.717023 | controller | ok: 4 changed: 2 unreachable: 0 failed: 0 skipped: 5 rescued: 0 ignored: 0 2026-03-16 19:55:27.717054 | 2026-03-16 19:55:27.815386 | RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/ansible-collection/run-pre.yaml@master] 2026-03-16 19:55:27.816905 | RUN START: [trusted : github.com/ansible/zuul-config/playbooks/ansible-collection/run.yaml@master] 2026-03-16 19:55:28.374635 | 2026-03-16 19:55:28.374768 | PLAY [all] 2026-03-16 19:55:28.397913 | 2026-03-16 19:55:28.398048 | TASK [Run build-ansible-collection role] 2026-03-16 19:55:28.418433 | controller | ok 2026-03-16 19:55:28.436542 | 2026-03-16 19:55:28.436654 | TASK [build-ansible-collection : Check if galaxy.yml exists] 2026-03-16 19:55:28.852162 | controller | ok 2026-03-16 19:55:28.866500 | 2026-03-16 19:55:28.866683 | TASK [build-ansible-collection : Build an ansible collection] 2026-03-16 19:55:30.965197 | controller | Created collection for amazon.aws at /home/zuul/artifacts/amazon-aws-10.3.0.tar.gz 2026-03-16 19:55:31.424101 | controller | ok: Runtime: 0:00:01.687155 2026-03-16 19:55:31.459941 | 2026-03-16 19:55:31.460068 | PLAY RECAP 2026-03-16 19:55:31.460127 | controller | ok: 2 changed: 1 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-16 19:55:31.460157 | 2026-03-16 19:55:31.560149 | RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/ansible-collection/run.yaml@master] 2026-03-16 19:55:31.560925 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/ansible-collection/post.yaml@master] 2026-03-16 19:55:32.146832 | 2026-03-16 19:55:32.146961 | PLAY [all] 2026-03-16 19:55:32.172364 | 2026-03-16 19:55:32.172569 | TASK [Find tarballs in folder] 2026-03-16 19:55:32.518228 | controller | ok: All paths examined 2026-03-16 19:55:32.532827 | 2026-03-16 19:55:32.533058 | LOOP [Display stat for tarballs] 2026-03-16 19:55:32.874867 | controller | ok: 2026-03-16 19:55:32.875172 | controller | { 2026-03-16 19:55:32.875234 | controller | "atime": 1773690930.9627194, 2026-03-16 19:55:32.875301 | controller | "ctime": 1773690930.9637194, 2026-03-16 19:55:32.875343 | controller | "dev": 38, 2026-03-16 19:55:32.875385 | controller | "gid": 1001, 2026-03-16 19:55:32.875423 | controller | "gr_name": "zuul", 2026-03-16 19:55:32.875467 | controller | "inode": 10581, 2026-03-16 19:55:32.875505 | controller | "isblk": false, 2026-03-16 19:55:32.875541 | controller | "ischr": false, 2026-03-16 19:55:32.875576 | controller | "isdir": false, 2026-03-16 19:55:32.875611 | controller | "isfifo": false, 2026-03-16 19:55:32.875648 | controller | "isgid": false, 2026-03-16 19:55:32.875684 | controller | "islnk": false, 2026-03-16 19:55:32.875718 | controller | "isreg": true, 2026-03-16 19:55:32.875791 | controller | "issock": false, 2026-03-16 19:55:32.875827 | controller | "isuid": false, 2026-03-16 19:55:32.875861 | controller | "mode": "0644", 2026-03-16 19:55:32.875894 | controller | "mtime": 1773690930.9637194, 2026-03-16 19:55:32.875929 | controller | "nlink": 1, 2026-03-16 19:55:32.875965 | controller | "path": "/home/zuul/artifacts/amazon-aws-10.3.0.tar.gz", 2026-03-16 19:55:32.876023 | controller | "pw_name": "zuul", 2026-03-16 19:55:32.876059 | controller | "rgrp": true, 2026-03-16 19:55:32.876093 | controller | "roth": true, 2026-03-16 19:55:32.876127 | controller | "rusr": true, 2026-03-16 19:55:32.876160 | controller | "size": 1297443, 2026-03-16 19:55:32.876194 | controller | "uid": 1001, 2026-03-16 19:55:32.876231 | controller | "wgrp": false, 2026-03-16 19:55:32.876265 | controller | "woth": false, 2026-03-16 19:55:32.876299 | controller | "wusr": true, 2026-03-16 19:55:32.876332 | controller | "xgrp": false, 2026-03-16 19:55:32.876365 | controller | "xoth": false, 2026-03-16 19:55:32.876398 | controller | "xusr": false 2026-03-16 19:55:32.876431 | controller | } 2026-03-16 19:55:32.897218 | 2026-03-16 19:55:32.897380 | TASK [Ensure artifacts directory exists] 2026-03-16 19:55:33.334917 | controller -> localhost | changed 2026-03-16 19:55:33.353367 | 2026-03-16 19:55:33.353536 | LOOP [Collect tarball artifacts] 2026-03-16 19:55:34.079979 | controller | changed: >f+++++++++ amazon-aws-10.3.0.tar.gz 2026-03-16 19:55:34.080290 | controller | ok: All items complete 2026-03-16 19:55:34.080349 | 2026-03-16 19:55:34.100756 | 2026-03-16 19:55:34.100897 | LOOP [Return collection artifacts to Zuul] 2026-03-16 19:55:34.196103 | controller | ok: 2026-03-16 19:55:34.196381 | controller | { 2026-03-16 19:55:34.196439 | controller | "atime": 1773690930.9627194, 2026-03-16 19:55:34.196482 | controller | "ctime": 1773690930.9637194, 2026-03-16 19:55:34.196521 | controller | "dev": 38, 2026-03-16 19:55:34.196560 | controller | "gid": 1001, 2026-03-16 19:55:34.196604 | controller | "gr_name": "zuul", 2026-03-16 19:55:34.196644 | controller | "inode": 10581, 2026-03-16 19:55:34.196685 | controller | "isblk": false, 2026-03-16 19:55:34.196756 | controller | "ischr": false, 2026-03-16 19:55:34.196806 | controller | "isdir": false, 2026-03-16 19:55:34.196845 | controller | "isfifo": false, 2026-03-16 19:55:34.196883 | controller | "isgid": false, 2026-03-16 19:55:34.196922 | controller | "islnk": false, 2026-03-16 19:55:34.196967 | controller | "isreg": true, 2026-03-16 19:55:34.197008 | controller | "issock": false, 2026-03-16 19:55:34.197046 | controller | "isuid": false, 2026-03-16 19:55:34.197085 | controller | "mode": "0644", 2026-03-16 19:55:34.197124 | controller | "mtime": 1773690930.9637194, 2026-03-16 19:55:34.197162 | controller | "nlink": 1, 2026-03-16 19:55:34.197200 | controller | "path": "/home/zuul/artifacts/amazon-aws-10.3.0.tar.gz", 2026-03-16 19:55:34.197239 | controller | "pw_name": "zuul", 2026-03-16 19:55:34.197277 | controller | "rgrp": true, 2026-03-16 19:55:34.197314 | controller | "roth": true, 2026-03-16 19:55:34.197351 | controller | "rusr": true, 2026-03-16 19:55:34.197386 | controller | "size": 1297443, 2026-03-16 19:55:34.197421 | controller | "uid": 1001, 2026-03-16 19:55:34.197484 | controller | "wgrp": false, 2026-03-16 19:55:34.197560 | controller | "woth": false, 2026-03-16 19:55:34.197599 | controller | "wusr": true, 2026-03-16 19:55:34.197635 | controller | "xgrp": false, 2026-03-16 19:55:34.197670 | controller | "xoth": false, 2026-03-16 19:55:34.197705 | controller | "xusr": false 2026-03-16 19:55:34.197809 | controller | } 2026-03-16 19:55:34.250966 | 2026-03-16 19:55:34.251093 | PLAY RECAP 2026-03-16 19:55:34.251154 | controller | ok: 5 changed: 2 unreachable: 0 failed: 0 skipped: 0 rescued: 0 ignored: 0 2026-03-16 19:55:34.251182 | 2026-03-16 19:55:34.350372 | POST-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/ansible-collection/post.yaml@master] 2026-03-16 19:55:34.351149 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/publish/ansible-automation-hub.yaml@master] 2026-03-16 19:55:35.003052 | 2026-03-16 19:55:35.003187 | PLAY [controller] 2026-03-16 19:55:35.025819 | 2026-03-16 19:55:35.025949 | TASK [Run upload-ansible-collection-fork] 2026-03-16 19:55:35.077641 | controller | ok 2026-03-16 19:55:35.106889 | 2026-03-16 19:55:35.107052 | TASK [upload-ansible-collection-fork : Create ansible.cfg configuration file tempfile] 2026-03-16 19:55:35.460143 | controller | changed 2026-03-16 19:55:35.473585 | 2026-03-16 19:55:35.473796 | TASK [upload-ansible-collection-fork : Create ansible.cfg configuration file] 2026-03-16 19:55:36.346329 | controller | changed 2026-03-16 19:55:36.360432 | 2026-03-16 19:55:36.360641 | TASK [upload-ansible-collection-fork : Find tarballs to upload] 2026-03-16 19:55:36.738114 | controller | ok: All paths examined 2026-03-16 19:55:36.752070 | 2026-03-16 19:55:36.752274 | TASK [upload-ansible-collection-fork : debug] 2026-03-16 19:55:36.822115 | controller | ok: 2026-03-16 19:55:36.822366 | controller | { 2026-03-16 19:55:36.822422 | controller | "ansible_galaxy_collection_tarballs": { 2026-03-16 19:55:36.822470 | controller | "changed": false, 2026-03-16 19:55:36.822519 | controller | "examined": 1, 2026-03-16 19:55:36.822559 | controller | "failed": false, 2026-03-16 19:55:36.822595 | controller | "files": [ 2026-03-16 19:55:36.822630 | controller | { 2026-03-16 19:55:36.822664 | controller | "atime": 1773690932.8257632, 2026-03-16 19:55:36.822698 | controller | "ctime": 1773690930.9637194, 2026-03-16 19:55:36.822768 | controller | "dev": 38, 2026-03-16 19:55:36.822808 | controller | "gid": 1001, 2026-03-16 19:55:36.822844 | controller | "gr_name": "zuul", 2026-03-16 19:55:36.822879 | controller | "inode": 10581, 2026-03-16 19:55:36.822914 | controller | "isblk": false, 2026-03-16 19:55:36.822948 | controller | "ischr": false, 2026-03-16 19:55:36.822982 | controller | "isdir": false, 2026-03-16 19:55:36.823015 | controller | "isfifo": false, 2026-03-16 19:55:36.823053 | controller | "isgid": false, 2026-03-16 19:55:36.823088 | controller | "islnk": false, 2026-03-16 19:55:36.823123 | controller | "isreg": true, 2026-03-16 19:55:36.823157 | controller | "issock": false, 2026-03-16 19:55:36.823191 | controller | "isuid": false, 2026-03-16 19:55:36.823224 | controller | "mode": "0644", 2026-03-16 19:55:36.823257 | controller | "mtime": 1773690930.9637194, 2026-03-16 19:55:36.823291 | controller | "nlink": 1, 2026-03-16 19:55:36.823324 | controller | "path": "/home/zuul/artifacts/amazon-aws-10.3.0.tar.gz", 2026-03-16 19:55:36.823359 | controller | "pw_name": "zuul", 2026-03-16 19:55:36.823393 | controller | "rgrp": true, 2026-03-16 19:55:36.823428 | controller | "roth": true, 2026-03-16 19:55:36.823462 | controller | "rusr": true, 2026-03-16 19:55:36.823495 | controller | "size": 1297443, 2026-03-16 19:55:36.823529 | controller | "uid": 1001, 2026-03-16 19:55:36.823561 | controller | "wgrp": false, 2026-03-16 19:55:36.823607 | controller | "woth": false, 2026-03-16 19:55:36.823641 | controller | "wusr": true, 2026-03-16 19:55:36.823673 | controller | "xgrp": false, 2026-03-16 19:55:36.823706 | controller | "xoth": false, 2026-03-16 19:55:36.823771 | controller | "xusr": false 2026-03-16 19:55:36.823808 | controller | } 2026-03-16 19:55:36.823841 | controller | ], 2026-03-16 19:55:36.823882 | controller | "matched": 1, 2026-03-16 19:55:36.823917 | controller | "msg": "All paths examined", 2026-03-16 19:55:36.823951 | controller | "skipped_paths": {} 2026-03-16 19:55:36.823987 | controller | } 2026-03-16 19:55:36.824022 | controller | } 2026-03-16 19:55:36.838028 | 2026-03-16 19:55:36.838188 | LOOP [upload-ansible-collection-fork : Publish collection to Ansible Galaxy / Automation Hub] 2026-03-16 19:56:29.237333 | controller | [ERROR]: Error when publishing collection to automation_hub (https://cloud.redhat.com/api/automation-hub/) (HTTP Code: 403, Message: You do not have permission to perform this action. Code: permission_denied) 2026-03-16 19:56:29.237647 | controller | Publishing collection artifact '/home/zuul/artifacts/amazon-aws-10.3.0.tar.gz' to automation_hub https://cloud.redhat.com/api/automation-hub/ 2026-03-16 19:56:29.237780 | controller | ok: Item: {'path': '/home/zuul/artifacts/amazon-aws-10.3.0.tar.gz', 'mode': '0644', 'isdir': False, 'ischr': False, 'isblk': False, 'isreg': True, 'isfifo': False, 'islnk': False, 'issock': False, 'uid': 1001, 'gid': 1001, 'size': 1297443, 'inode': 10581, 'dev': 38, 'nlink': 1, 'atime': 1773690932.8257632, 'mtime': 1773690930.9637194, 'ctime': 1773690930.9637194, 'gr_name': 'zuul', 'pw_name': 'zuul', 'wusr': True, 'rusr': True, 'xusr': False, 'wgrp': False, 'rgrp': True, 'xgrp': False, 'woth': False, 'roth': True, 'xoth': False, 'isuid': False, 'isgid': False} Result: 1 failure 2026-03-16 19:56:29.263948 | 2026-03-16 19:56:29.264310 | TASK [upload-ansible-collection-fork : Shred ansible-galaxy credentials] 2026-03-16 19:56:29.808508 | controller | ok: Runtime: 0:00:00.004501 2026-03-16 19:56:29.811387 | 2026-03-16 19:56:29.811490 | PLAY RECAP 2026-03-16 19:56:29.811577 | controller | ok: 5 changed: 3 unreachable: 0 failed: 1 skipped: 0 rescued: 0 ignored: 0 2026-03-16 19:56:29.811622 | 2026-03-16 19:56:29.918937 | POST-RUN END RESULT_NORMAL: [trusted : github.com/ansible/zuul-config/playbooks/publish/ansible-automation-hub.yaml@master] 2026-03-16 19:56:29.919653 | POST-RUN START: [trusted : github.com/ansible/zuul-config/playbooks/base/post.yaml@master] 2026-03-16 19:56:30.498685 | 2026-03-16 19:56:30.498841 | PLAY [all:!appliance*] 2026-03-16 19:56:30.521969 | 2026-03-16 19:56:30.522101 | TASK [unregister the node] 2026-03-16 19:56:31.601444 | controller | skipping: Conditional result was False 2026-03-16 19:56:31.607921 | 2026-03-16 19:56:31.608028 | TASK [include_role : fetch-output] 2026-03-16 19:56:31.639249 | controller | ok 2026-03-16 19:56:31.663640 | 2026-03-16 19:56:31.663794 | TASK [fetch-output : Set log path for multiple nodes] 2026-03-16 19:56:31.708243 | controller | skipping: Conditional result was False 2026-03-16 19:56:31.714821 | 2026-03-16 19:56:31.714928 | TASK [fetch-output : Set log path for single node] 2026-03-16 19:56:31.755298 | controller | ok 2026-03-16 19:56:31.761160 | 2026-03-16 19:56:31.761228 | LOOP [fetch-output : Ensure local output dirs] 2026-03-16 19:56:32.189763 | controller -> localhost | ok: "/var/lib/zuul/builds/4aa0d4e3f14f49c09841890baedaff7b/work/logs" 2026-03-16 19:56:32.430865 | controller -> localhost | changed: "/var/lib/zuul/builds/4aa0d4e3f14f49c09841890baedaff7b/work/artifacts" 2026-03-16 19:56:32.665082 | controller -> localhost | changed: "/var/lib/zuul/builds/4aa0d4e3f14f49c09841890baedaff7b/work/docs" 2026-03-16 19:56:32.678569 | 2026-03-16 19:56:32.678719 | LOOP [fetch-output : Collect logs, artifacts and docs] 2026-03-16 19:56:33.435276 | controller | changed: .d..t...... ./ 2026-03-16 19:56:33.435642 | controller | changed: All items complete 2026-03-16 19:56:33.436039 | 2026-03-16 19:56:33.920766 | controller | changed: .d..t...... ./ 2026-03-16 19:56:34.465822 | controller | changed: .d..t...... ./ 2026-03-16 19:56:34.497704 | 2026-03-16 19:56:34.497900 | TASK [include_role : fetch-output-openshift] 2026-03-16 19:56:34.524773 | controller | skipping: Conditional result was False 2026-03-16 19:56:34.538560 | 2026-03-16 19:56:34.538768 | LOOP [merge-output-to-logs : Move artifacts and docs to logs dir] 2026-03-16 19:56:34.563519 | controller | skipping: Conditional result was False 2026-03-16 19:56:34.573354 | controller | skipping: Conditional result was False 2026-03-16 19:56:34.602421 | 2026-03-16 19:56:34.602522 | PLAY [localhost] 2026-03-16 19:56:34.615259 | 2026-03-16 19:56:34.615345 | TASK [Run Zuul manifest role] 2026-03-16 19:56:34.633393 | localhost | ok 2026-03-16 19:56:34.647605 | 2026-03-16 19:56:34.647701 | TASK [generate-zuul-manifest : Generate Zuul manifest] 2026-03-16 19:56:35.047282 | localhost | changed 2026-03-16 19:56:35.056157 | 2026-03-16 19:56:35.056269 | TASK [generate-zuul-manifest : Return Zuul manifest URL to Zuul] 2026-03-16 19:56:35.090506 | localhost | ok 2026-03-16 19:56:35.100329 | 2026-03-16 19:56:35.100407 | TASK [Set zuul-log-path fact] 2026-03-16 19:56:35.117809 | localhost | ok 2026-03-16 19:56:35.132097 | 2026-03-16 19:56:35.132202 | TASK [set-zuul-log-path-fact : Set log path for a build] 2026-03-16 19:56:35.170389 | localhost | ok 2026-03-16 19:56:35.178441 | 2026-03-16 19:56:35.178512 | LOOP [Set zuul_log_targets (Swift with random Rackspace region)] 2026-03-16 19:56:35.210026 | localhost | ok: 2026-03-16 19:56:35.210437 | localhost | { 2026-03-16 19:56:35.210495 | localhost | "auth": { 2026-03-16 19:56:35.210539 | localhost | "password": "IonWCwcuOFib&&<}wp^:[2G/", 2026-03-16 19:56:35.210579 | localhost | "username": "9LF91O0RK7JU" 2026-03-16 19:56:35.210628 | localhost | }, 2026-03-16 19:56:35.210666 | localhost | "profile": "rackspace", 2026-03-16 19:56:35.210704 | localhost | "project_name": "1251317", 2026-03-16 19:56:35.210781 | localhost | "region_name": "DFW" 2026-03-16 19:56:35.210821 | localhost | } 2026-03-16 19:56:35.210876 | 2026-03-16 19:56:35.226652 | 2026-03-16 19:56:35.226773 | TASK [Run upload-logs-failover role (S3 then Swift)] 2026-03-16 19:56:35.244016 | localhost | Output suppressed because no_log was given 2026-03-16 19:56:35.256886 | 2026-03-16 19:56:35.256988 | TASK [upload-logs-failover : Initialize control vars] 2026-03-16 19:56:35.286295 | localhost | ok 2026-03-16 19:56:35.292550 | 2026-03-16 19:56:35.292643 | LOOP [upload-logs-failover : Perform log upload] 2026-03-16 19:56:35.329894 | localhost | Output suppressed because no_log was given 2026-03-16 19:56:35.366345 | localhost | included: /var/lib/zuul/builds/4aa0d4e3f14f49c09841890baedaff7b/trusted/project_1/opendev.org/zuul/zuul-jobs/roles/upload-logs-failover/tasks/upload.yaml 2026-03-16 19:56:35.375582 | 2026-03-16 19:56:35.375696 | LOOP [upload-logs-failover : Unpack vars for swift upload] 2026-03-16 19:56:35.472826 | localhost | Output suppressed because no_log was given 2026-03-16 19:56:35.480140 | 2026-03-16 19:56:35.480243 | TASK [Upload logs to swift] 2026-03-16 19:56:35.501862 | localhost | ok 2026-03-16 19:56:35.539774 | 2026-03-16 19:56:35.539914 | TASK [Set zuul-log-path fact] 2026-03-16 19:56:35.565086 | localhost | skipping: Conditional result was False 2026-03-16 19:56:35.573721 | 2026-03-16 19:56:35.573882 | TASK [upload-logs-swift : Ensure logs are readable before uploading] 2026-03-16 19:56:35.977715 | localhost -> localhost | ok: Runtime: 0:00:00.008019 2026-03-16 19:56:35.983128 | 2026-03-16 19:56:35.983193 | TASK [upload-logs-swift : Upload logs to swift]